1549342 - Intermittent mozdevice.adb.ADBTimeoutError: args: adb wait-for-device reverse --remove-all, exitcode: None, stdout:

Status: RESOLVED DUPLICATE of bug 1549313

(Firefox for Android Graveyard :: Testing, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: rmaries [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=244584425&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/U6VcHnxgTzit-FaN8ESZgw/runs/0/artifacts/public/logs/live_backing.log

---

22:15:39 INFO - mozdevice.adb.ADBTimeoutError: args: adb wait-for-device reverse --remove-all, exitcode: None, stdout:
22:15:39 ERROR - Return code: 1
22:15:39 WARNING - setting return code to 1
22:15:39 INFO - Killing logcat pid 465.
22:15:39 CRITICAL - PERFHERDER_DATA was seen 0 times, expected 1.
22:15:39 INFO - copying raptor results to upload dir:
22:15:39 INFO - /builds/task_1556920000/workspace/build/blobber_upload_dir/perfherder-data.json
22:15:39 INFO - copying raptor results from /builds/task_1556920000/workspace/build/raptor.json to /builds/task_1556920000/workspace/build/blobber_upload_dir/perfherder-data.json
22:15:39 CRITICAL - Error copying results /builds/task_1556920000/workspace/build/raptor.json to upload dir /builds/task_1556920000/workspace/build/blobber_upload_dir/perfherder-data.json
22:15:39 INFO - [Errno 2] No such file or directory: u'/builds/task_1556920000/workspace/build/raptor.json'
22:15:39 INFO - Running post-action listener: _package_coverage_data
22:15:39 INFO - Running post-action listener: _resource_record_post_action
22:15:39 INFO - Running post-action listener: process_java_coverage_data
22:15:39 INFO - Running post-action listener: stop_device
22:20:39 INFO - failed to pull /data/anr: ADBTimeoutError args: adb wait-for-device shell test -d /data/anr; echo adb_returncode=$?, exitcode: None, stdout:
22:25:39 INFO - failed to pull /data/tombstones: ADBTimeoutError args: adb wait-for-device shell test -d /data/tombstones; echo adb_returncode=$?, exitcode: None, stdout:
22:25:39 INFO - Killing logcat pid 465.
22:25:39 INFO - [mozharness: 2019-05-03 22:25:39.277567Z] Finished run-tests step (success)
22:25:39 INFO - Running post-run listener: _resource_record_post_run
22:25:39 INFO - Total resource usage - Wall time: 2288s; CPU: 4.0%; Read bytes: 0; Write bytes: 9987284992; Read time: 0; Write time: 73238864
22:25:39 INFO - TinderboxPrint: CPU usage<br/>4.3%
22:25:39 INFO - TinderboxPrint: I/O read bytes / time<br/>0 / 0
22:25:39 INFO - TinderboxPrint: I/O write bytes / time<br/>9,987,284,992 / 73,238,864
22:25:39 INFO - TinderboxPrint: CPU idle<br/>8,647.4 (95.2%)
22:25:39 INFO - TinderboxPrint: CPU system<br/>123.4 (1.4%)
22:25:39 INFO - TinderboxPrint: CPU user<br/>261.7 (2.9%)
22:25:39 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
22:25:39 INFO - install - Wall time: 12s; CPU: 5.0%; Read bytes: 0; Write bytes: 732729344; Read time: 0; Write time: 14867948
22:25:39 INFO - run-tests - Wall time: 1676s; CPU: 5.0%; Read bytes: 0; Write bytes: 8976338944; Read time: 0; Write time: 57815552
22:25:39 WARNING - returning nonzero exit status 1
cleanup

• cleanup
• local rv=1
• [[ -s /builds/worker/.xsession-errors ]]
• false
• exit 1

netstat -aop
Active Internet connections (servers and established)
Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name Timer
tcp 0 0 127.0.0.11:38603 : LISTEN - off (0.00/0/0)
tcp 0 0 :59119 : LISTEN 1753/mitmdump off (0.00/0/0)
tcp 0 0 :http-alt : LISTEN 1756/mitmdump off (0.00/0/0)
tcp 0 0 localhost:33469 localhost:5037 TIME_WAIT - timewait (59.28/0/0)
tcp 0 0 localhost:40426 localhost:60022 ESTABLISHED 23/generic-worker keepalive (12.64/0/0)
tcp 0 0 localhost:5037 localhost:56909 TIME_WAIT - timewait (59.89/0/0)
tcp6 0 0 [::]:60022 [::]: LISTEN 37/livelog off (0.00/0/0)
tcp6 0 0 [::]:60023 [::]: LISTEN 37/livelog off (0.00/0/0)
tcp6 0 0 localhost:60022 localhost:40426 ESTABLISHED 37/livelog keepalive (127.82/0/0)
udp 0 0 127.0.0.11:55298 : - off (0.00/0/0)
Active UNIX domain sockets (servers and established)
Proto RefCnt Flags Type State I-Node PID/Program name Path
unix 3 [ ] STREAM CONNECTED 3138427398 1753/mitmdump
unix 3 [ ] STREAM CONNECTED 3138427397 1753/mitmdump

script.py exitcode 1
[taskcluster 2019-05-03T22:25:40.014Z] Exit Code: 1
[taskcluster 2019-05-03T22:25:40.014Z] User Time: 1m11.961909s
[taskcluster 2019-05-03T22:25:40.014Z] Kernel Time: 26.589686s
[taskcluster 2019-05-03T22:25:40.014Z] Wall Time: 38m56.546404067s
[taskcluster 2019-05-03T22:25:40.014Z] Result: FAILED
[taskcluster 2019-05-03T22:25:40.015Z] === Task Finished ===
[taskcluster 2019-05-03T22:25:40.015Z] Task Duration: 38m56.546764266s
[taskcluster 2019-05-03T22:25:40.600Z] Uploading artifact public/logs/localconfig.json from file workspace/logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2020-05-02T20:08:05.403Z
[taskcluster 2019-05-03T22:25:41.067Z] Uploading artifact public/test_info/logcat-HT83K1A02572.log from file workspace/build/blobber_upload_dir/logcat-HT83K1A02572.log with content encoding "gzip", mime type "text/plain" and expiry 2020-05-02T20:08:05.403Z
[taskcluster 2019-05-03T22:25:41.841Z] Uploading artifact public/test_info/mitmproxy.log from file workspace/build/blobber_upload_dir/mitmproxy.log with content encoding "gzip", mime type "text/plain" and expiry 2020-05-02T20:08:05.403Z
[taskcluster 2019-05-03T22:25:42.218Z] Uploading artifact public/test_info/resource-usage.json from file workspace/build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2020-05-02T20:08:05.403Z
[taskcluster 2019-05-03T22:25:43.002Z] Uploading redirect artifact public/logs/live.log to URL https://queue.taskcluster.net/v1/task/U6VcHnxgTzit-FaN8ESZgw/runs/0/artifacts/public/logs/live_backing.log with mime type "text/plain; charset=utf-8" and expiry 2020-05-02T20:08:05.403Z
[taskcluster:error] exit status 1