kanga333 opened a new issue #15000:
URL: https://github.com/apache/airflow/issues/15000


   <!--
   
   Welcome to Apache Airflow!  For a smooth issue process, try to answer the 
following questions.
   Don't worry if they're not all applicable; just try to include what you can 
:-)
   
   If you need to include code snippets or logs, please put them in fenced code
   blocks.  If they're super-long, please use the details tag like
   <details><summary>super-long log</summary> lots of stuff </details>
   
   Please delete these comment blocks before submitting the issue.
   
   -->
   
   <!--
   
   IMPORTANT!!!
   
   PLEASE CHECK "SIMILAR TO X EXISTING ISSUES" OPTION IF VISIBLE
   NEXT TO "SUBMIT NEW ISSUE" BUTTON!!!
   
   PLEASE CHECK IF THIS ISSUE HAS BEEN REPORTED PREVIOUSLY USING SEARCH!!!
   
   Please complete the next sections or the issue will be closed.
   These questions are the first thing we need to know to understand the 
context.
   
   -->
   
   **Apache Airflow version**: 1.10.13
   
   **Environment**:
   
   - **Cloud provider or hardware configuration**:AWS
   - **OS** (e.g. from /etc/os-release): Amazon Linux 2
   - **Kernel** (e.g. `uname -a`):  4.14.209-160.339.amzn2.x86_64
   - **Install tools**: pip
   - **Others**:
   
   **What happened**:
   
   When an ECS Task exits with `stopCode: TaskFailedToStart`, the ECS Operator 
will exit with a ResourceNotFoundException for the GetLogEvents operation. This 
is because the task has failed to start, so no log is created.
   
   ```
   [2021-03-14 02:32:49,792] {ecs_operator.py:147} INFO - ECS Task started: 
{'tasks': [{'attachments': [], 'availabilityZone': 'ap-northeast-1c', 
'clusterArn': 'arn:aws:ecs:ap-northeast-1:xxxx:cluster/ecs-cluster', 
'containerInstanceArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:container-instance/ecs-cluster/xxxx', 
'containers': [{'containerArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:container/xxxx', 'taskArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:task/ecs-cluster/xxxx', 'name': 
'container_image', 'image': 
'xxxx.dkr.ecr.ap-northeast-1.amazonaws.com/ecr/container_image:latest', 
'lastStatus': 'PENDING', 'networkInterfaces': [], 'cpu': '128', 
'memoryReservation': '128'}], 'cpu': '128', 'createdAt': 
datetime.datetime(2021, 3, 14, 2, 32, 49, 770000, tzinfo=tzlocal()), 
'desiredStatus': 'RUNNING', 'group': 'family:task', 'lastStatus': 'PENDING', 
'launchType': 'EC2', 'memory': '128', 'overrides': {'containerOverrides': 
[{'name': 'container_image', 'command': ['/bin/bash', '-c', 'xxxx']}], 
'inferenceAccelera
 torOverrides': []}, 'startedBy': 'airflow', 'tags': [], 'taskArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:task/ecs-cluster/xxxx', 'taskDefinitionArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:task-definition/task:1', 'version': 1}], 
'failures': [], 'ResponseMetadata': {'RequestId': 'xxxx', 'HTTPStatusCode': 
200, 'HTTPHeaders': {'x-amzn-requestid': 'xxxx', 'content-type': 
'application/x-amz-json-1.1', 'content-length': '1471', 'date': 'Sun, 14 Mar 
2021 02:32:48 GMT'}, 'RetryAttempts': 0}}
   [2021-03-14 02:34:15,022] {ecs_operator.py:168} INFO - ECS Task stopped, 
check status: {'tasks': [{'attachments': [], 'availabilityZone': 
'ap-northeast-1c', 'clusterArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:cluster/ecs-cluster', 'connectivity': 
'CONNECTED', 'connectivityAt': datetime.datetime(2021, 3, 14, 2, 32, 49, 
770000, tzinfo=tzlocal()), 'containerInstanceArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:container-instance/ecs-cluster/xxxx', 
'containers': [{'containerArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:container/xxxx', 'taskArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:task/ecs-cluster/xxxx', 'name': 
'container_image', 'image': 
'xxxx.dkr.ecr.ap-northeast-1.amazonaws.com/ecr/container_image:latest', 
'lastStatus': 'STOPPED', 'reason': 'CannotPullContainerError: failed to 
register layer: Error processing tar file(exit status 1): write /var/lib/xxxx: 
no space left on device', 'networkInterfaces': [], 'healthStatus': 'UNKNOWN', 
'cpu': '128', 'memoryReservation': '128'}], 'cpu': '128', 'createdAt': 
 datetime.datetime(2021, 3, 14, 2, 32, 49, 770000, tzinfo=tzlocal()), 
'desiredStatus': 'STOPPED', 'executionStoppedAt': datetime.datetime(2021, 3, 
14, 2, 34, 12, 810000, tzinfo=tzlocal()), 'group': 'family:task', 
'healthStatus': 'UNKNOWN', 'lastStatus': 'STOPPED', 'launchType': 'EC2', 
'memory': '128', 'overrides': {'containerOverrides': [{'name': 
'container_image', 'command': ['/bin/bash', '-c', 'xxxx']}], 
'inferenceAcceleratorOverrides': []}, 'pullStartedAt': datetime.datetime(2021, 
3, 14, 2, 32, 51, 68000, tzinfo=tzlocal()), 'pullStoppedAt': 
datetime.datetime(2021, 3, 14, 2, 34, 13, 584000, tzinfo=tzlocal()), 
'startedBy': 'airflow', 'stopCode': 'TaskFailedToStart', 'stoppedAt': 
datetime.datetime(2021, 3, 14, 2, 34, 12, 821000, tzinfo=tzlocal()), 
'stoppedReason': 'Task failed to start', 'stoppingAt': datetime.datetime(2021, 
3, 14, 2, 34, 12, 821000, tzinfo=tzlocal()), 'tags': [], 'taskArn': 
'arn:aws:ecs:ap-northeast-1:xxxx:task/ecs-cluster/xxxx', 'taskDefinitionArn': 
'arn:aws:ecs:ap
 -northeast-1:xxxx:task-definition/task:1', 'version': 2}], 'failures': [], 
'ResponseMetadata': {'RequestId': 'xxxx', 'HTTPStatusCode': 200, 'HTTPHeaders': 
{'x-amzn-requestid': 'xxxx', 'content-type': 'application/x-amz-json-1.1', 
'content-length': '1988', 'date': 'Sun, 14 Mar 2021 02:34:14 GMT'}, 
'RetryAttempts': 0}}
   [2021-03-14 02:34:15,024] {ecs_operator.py:172} INFO - ECS Task logs output:
   [2021-03-14 02:34:15,111] {credentials.py:1094} INFO - Found credentials in 
environment variables.
   [2021-03-14 02:34:15,416] {taskinstance.py:1150} ERROR - An error occurred 
(ResourceNotFoundException) when calling the GetLogEvents operation: The 
specified log stream does not exist.
   Traceback (most recent call last):
     File 
"/usr/local/lib/python3.7/site-packages/airflow/models/taskinstance.py", line 
984, in _run_raw_task
       result = task_copy.execute(context=context)
     File 
"/usr/local/lib/python3.7/site-packages/airflow/contrib/operators/ecs_operator.py",
 line 152, in execute
       self._check_success_task()
     File 
"/usr/local/lib/python3.7/site-packages/airflow/contrib/operators/ecs_operator.py",
 line 175, in _check_success_task
       for event in self.get_logs_hook().get_log_events(self.awslogs_group, 
stream_name):
     File 
"/usr/local/lib/python3.7/site-packages/airflow/contrib/hooks/aws_logs_hook.py",
 line 85, in get_log_events
       **token_arg)
     File "/usr/local/lib/python3.7/site-packages/botocore/client.py", line 
357, in _api_call
       return self._make_api_call(operation_name, kwargs)
     File "/usr/local/lib/python3.7/site-packages/botocore/client.py", line 
676, in _make_api_call
       raise error_class(parsed_response, operation_name)
   botocore.errorfactory.ResourceNotFoundException: An error occurred 
(ResourceNotFoundException) when calling the GetLogEvents operation: The 
specified log stream does not exist.
   ```
   
   <!-- (please include exact error messages if you can) -->
   
   **What you expected to happen**:
   
   ResourceNotFoundException is misleading because it feels like a problem with 
CloudWatchLogs. Expect AirflowException to indicate that the task has failed.
   
   <!-- What do you think went wrong? -->
   
   **How to reproduce it**:
   <!---
   
   As minimally and precisely as possible. Keep in mind we do not have access 
to your cluster or dags.
   
   If you are using kubernetes, please attempt to recreate the issue using 
minikube or kind.
   
   ## Install minikube/kind
   
   - Minikube https://minikube.sigs.k8s.io/docs/start/
   - Kind https://kind.sigs.k8s.io/docs/user/quick-start/
   
   If this is a UI bug, please provide a screenshot of the bug or a link to a 
youtube video of the bug in action
   
   You can include images using the .md style of
   ![alt text](http://url/to/img.png)
   
   To record a screencast, mac users can use QuickTime and then create an 
unlisted youtube video with the resulting .mov file.
   
   --->
   
   This can be reproduced by running an ECS Task that fails to start, for 
example by specifying a non-existent entry_point.
   
   **Anything else we need to know**:
   
   <!--
   
   How often does this problem occur? Once? Every time etc?
   
   Any relevant logs to include? Put them here in side a detail tag:
   <details><summary>x.log</summary> lots of stuff </details>
   
   -->
   
   I suspect Issue #11663 has the same problem, i.e. it's not a CloudWatch 
issue, but a failure to start an ECS Task.
   


-- 
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.

For queries about this service, please contact Infrastructure at:
[email protected]


Reply via email to