Closed Bug 1574598 Opened 6 years ago Closed 5 years ago

Intermittent raptor-output Error: no raptor test results found for raptor-tp6m-wikipedia-geckoview-cold

Categories

(Testing :: Raptor, defect, P5)

Product:
Testing
Component:
Raptor
Version:
Version 3
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

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

[task 2019-08-16T18:35:03.218Z] 18:35:00 INFO - WaitTime: 666
[task 2019-08-16T18:35:03.218Z] 18:35:00 INFO - Complete
[task 2019-08-16T18:35:03.218Z] 18:35:00 INFO - adb shell_output: adb -s ZY322HQZLX wait-for-device shell pidof org.mozilla.geckoview_example, timeout: None, root: False, timedout: None, exitcode: 0, output: 6776
[task 2019-08-16T18:35:03.218Z] 18:35:03 INFO - raptor-control-server Info: received webext_status: raptor runner.js is loaded!
[task 2019-08-16T18:35:03.218Z] 18:35:03 INFO - raptor-control-server Info: reading test settings from json/raptor-tp6m-wikipedia-geckoview-cold.json
[task 2019-08-16T18:37:49.408Z] 18:35:03 INFO - raptor-control-server Info: sent test settings to web ext runner
[task 2019-08-16T18:37:49.408Z] 18:37:47 INFO - adb shell_output: adb -s ZY322HQZLX wait-for-device shell am force-stop org.mozilla.geckoview_example, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:47 CRITICAL - raptor-main Critical: Tests failed to finish! Application timed out.
[task 2019-08-16T18:37:49.408Z] 18:37:47 ERROR - raptor-main Error: Test failed to finish. Application timed out after 170 seconds
[task 2019-08-16T18:37:49.408Z] 18:37:47 INFO - raptor-main Info: removing reverse socket connections
[task 2019-08-16T18:37:49.408Z] 18:37:47 INFO - adb command_output: adb -s ZY322HQZLX wait-for-device reverse --remove-all, timeout: None, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb shell_bool: adb -s ZY322HQZLX wait-for-device shell test -d /sdcard/raptor/profile/minidumps, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb shell_output: adb -s ZY322HQZLX wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb shell_bool: adb -s ZY322HQZLX wait-for-device shell test -d /sdcard/raptor/profile/minidumps, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb command_output: adb -s ZY322HQZLX wait-for-device pull /sdcard/raptor/profile/minidumps /tmp/tmpWPAHBs/minidumps, timeout: None, timedout: None, exitcode: 0, output: /sdcard/raptor/profile/minidumps/: 0 files pulled.
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - mozproxy Stopping mitmproxy playback, killing process 770
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - mozproxy Successfully killed the mitmproxy playback process
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - raptor-main Info: removing webext /builds/task_1565980311/workspace/build/tests/raptor/raptor/../webext/raptor
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - raptor-results-handler Info: summarizing raptor test results
[task 2019-08-16T18:37:49.408Z] 18:37:48 ERROR - raptor-output Error: no raptor test results found for raptor-tp6m-wikipedia-geckoview-cold
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - raptor-output Info: error: no raptor test results found, so no need to combine browser cycles
[task 2019-08-16T18:37:49.408Z] 18:37:48 ERROR - raptor-output Error: no summarized raptor results found for raptor-tp6m-wikipedia-geckoview-cold
[task 2019-08-16T18:37:49.408Z] 18:37:48 CRITICAL - raptor-results-handler Critical: PERFHERDER_DATA was seen 0 times, expected 1.
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - raptor-main Info: removing test folder for raptor: /sdcard/raptor
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb shell_output: adb -s ZY322HQZLX wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb shell_output: adb -s ZY322HQZLX wait-for-device shell rm -r /sdcard/raptor, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb shell_output: adb -s ZY322HQZLX wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - adb shell_bool: adb -s ZY322HQZLX wait-for-device shell test -e /sdcard/raptor, timeout: None, root: False, timedout: None, exitcode: 1, output:
[task 2019-08-16T18:37:49.408Z] 18:37:48 INFO - raptor-control-server Info: shutting down control server
[task 2019-08-16T18:37:49.408Z] 18:37:49 INFO - raptor-main Info: finished
[task 2019-08-16T18:37:49.408Z] 18:37:49 ERROR - raptor-main Critical: TEST-UNEXPECTED-FAIL: no raptor test results were found for raptor-tp6m-wikipedia-geckoview-cold
[task 2019-08-16T18:37:49.408Z] 18:37:49 ERROR - Return code: 1
[task 2019-08-16T18:37:49.408Z] 18:37:49 WARNING - setting return code to 1
[task 2019-08-16T18:37:49.408Z] 18:37:49 INFO - Killing logcat pid 536.
[task 2019-08-16T18:37:49.408Z] 18:37:49 INFO - copying raptor results to upload dir:
[task 2019-08-16T18:37:49.408Z] 18:37:49 INFO - /builds/task_1565980311/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2019-08-16T18:37:49.408Z] 18:37:49 INFO - copying raptor results from /builds/task_1565980311/workspace/build/raptor.json to /builds/task_1565980311/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2019-08-16T18:37:49.408Z] 18:37:49 CRITICAL - Error copying results /builds/task_1565980311/workspace/build/raptor.json to upload dir /builds/task_1565980311/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2019-08-16T18:37:49.408Z] 18:37:49 INFO - [Errno 2] No such file or directory: u'/builds/task_1565980311/workspace/build/raptor.json'
[task 2019-08-16T18:37:49.408Z] 18:37:49 INFO - Running post-action listener: _package_coverage_data

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=272079559&repo=autoland&lineNumber=1549

[task 2019-10-20T13:56:30.744Z] 13:55:49 INFO - raptor-main Info: starting geckoview
[task 2019-10-20T13:56:30.744Z] 13:55:50 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell am force-stop org.mozilla.geckoview_example, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:56:30.744Z] 13:55:50 INFO - adb Granting important runtime permissions to org.mozilla.geckoview_example
[task 2019-10-20T13:56:30.744Z] 13:55:51 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell pm grant org.mozilla.geckoview_example android.permission.WRITE_EXTERNAL_STORAGE, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:56:30.744Z] 13:55:52 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell pm grant org.mozilla.geckoview_example android.permission.READ_EXTERNAL_STORAGE, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:56:30.744Z] 13:55:53 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell pm grant org.mozilla.geckoview_example android.permission.ACCESS_COARSE_LOCATION, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:56:30.744Z] 13:55:54 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell pm grant org.mozilla.geckoview_example android.permission.ACCESS_FINE_LOCATION, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:56:30.744Z] 13:55:55 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell pm grant org.mozilla.geckoview_example android.permission.CAMERA, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:56:30.744Z] 13:55:56 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell pm grant org.mozilla.geckoview_example android.permission.RECORD_AUDIO, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:56:30.744Z] 13:55:56 INFO - adb launch_application: am start -W -n org.mozilla.geckoview_example/org.mozilla.geckoview_example.GeckoViewActivity -a android.intent.action.MAIN -d about:blank
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell am start -W -n org.mozilla.geckoview_example/org.mozilla.geckoview_example.GeckoViewActivity -a android.intent.action.MAIN -d about:blank, timeout: None, root: False, timedout: None, exitcode: 0, output: Starting: Intent { act=android.intent.action.MAIN dat=about:blank cmp=org.mozilla.geckoview_example/.GeckoViewActivity }
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - Status: ok
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - Activity: org.mozilla.geckoview_example/.GeckoViewActivity
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - ThisTime: 665
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - TotalTime: 665
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - WaitTime: 681
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - Complete
[task 2019-10-20T13:56:30.744Z] 13:55:57 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell pidof org.mozilla.geckoview_example, timeout: None, root: False, timedout: None, exitcode: 0, output: 8176
[task 2019-10-20T13:56:30.744Z] 13:56:00 INFO - raptor-control-server Info: received webext_status: raptor runner.js is loaded!
[task 2019-10-20T13:56:30.744Z] 13:56:00 INFO - raptor-control-server Info: reading test settings from json/raptor-tp6m-wikipedia-geckoview-cold.json
[task 2019-10-20T13:56:30.744Z] 13:56:00 INFO - raptor-control-server Info: sent test settings to webext runner
[task 2019-10-20T13:56:30.744Z] 13:56:00 INFO - raptor-control-server Info: received webext_status: * pausing 30 seconds to let browser settle... *
[task 2019-10-20T13:57:37.450Z] 13:56:30 INFO - raptor-control-server Info: received webext_status: running 1 pagecycles of https://en.m.wikipedia.org/wiki/Main_Page
[task 2019-10-20T13:57:37.450Z] 13:56:31 INFO - raptor-control-server Info: received webext_status: begin pagecycle 1
[task 2019-10-20T13:57:37.450Z] 13:56:32 INFO - raptor-control-server Info: received webext_status: update tab: 0
[task 2019-10-20T13:57:37.450Z] 13:56:32 INFO - raptor-control-server Info: received webext_status: test tab updated: 0
[task 2019-10-20T13:57:37.450Z] 13:57:34 INFO - raptor-control-server Info: received webext_raptor-page-timeout: [u'raptor-tp6m-wikipedia-geckoview-cold', u'https://en.m.wikipedia.org/wiki/Main_Page', {u'fcp': True, u'hero': False, u'dcf': False, u'fnb paint': True, u'ttfi': False, u'load time': False}]
[task 2019-10-20T13:57:37.450Z] 13:57:34 INFO - raptor-control-server Info: received webext_screenshot
[task 2019-10-20T13:57:37.450Z] 13:57:34 INFO - perftest-results-handler Info: received screenshot
[task 2019-10-20T13:57:37.450Z] 13:57:34 INFO - raptor-control-server Info: received request to shutdown the browser
[task 2019-10-20T13:57:37.450Z] 13:57:34 INFO - raptor-control-server Info: shutting down android app org.mozilla.geckoview_example
[task 2019-10-20T13:57:37.450Z] 13:57:35 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell am force-stop org.mozilla.geckoview_example, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:35 INFO - raptor-main Info: removing reverse socket connections
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - adb command_output: adb -s ZY322LH8PW wait-for-device reverse --remove-all, timeout: None, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - adb shell_bool: adb -s ZY322LH8PW wait-for-device shell test -d /sdcard/raptor/profile/minidumps, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - adb shell_bool: adb -s ZY322LH8PW wait-for-device shell test -d /sdcard/raptor/profile/minidumps, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - adb command_output: adb -s ZY322LH8PW wait-for-device pull /sdcard/raptor/profile/minidumps /tmp/tmpVKtqvz/minidumps, timeout: None, timedout: None, exitcode: 0, output: /sdcard/raptor/profile/minidumps/: 0 files pulled.
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - raptor-mitmproxy Info: Stopping mitmproxy playback, killing process 827
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - raptor-mitmproxy Info: Successfully killed the mitmproxy playback process
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - raptor-main Info: removing webext /builds/task_1571579620/workspace/build/tests/raptor/raptor/../webext/raptor
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - perftest-results-handler Info: summarizing raptor test results
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - perftest-output Error: no raptor test results found for raptor-tp6m-wikipedia-geckoview-cold
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - perftest-output Info: error: no raptor test results found, so no need to combine browser cycles
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - perftest-output Error: no summarized raptor results found for raptor-tp6m-wikipedia-geckoview-cold
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - perftest-output Info: screen captures can be found locally at: /builds/task_1571579620/workspace/build/screenshots.html
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - perftest-results-handler Critical: PERFHERDER_DATA was seen 0 times, expected 1.
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - raptor-main Info: removing test folder for raptor: /sdcard/raptor
[task 2019-10-20T13:57:37.450Z] 13:57:36 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:37 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell rm -r /sdcard/raptor, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:37 INFO - adb shell_output: adb -s ZY322LH8PW wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2019-10-20T13:57:37.450Z] 13:57:37 INFO - adb shell_bool: adb -s ZY322LH8PW wait-for-device shell test -e /sdcard/raptor, timeout: None, root: False, timedout: None, exitcode: 1, output:
[task 2019-10-20T13:57:37.450Z] 13:57:37 INFO - raptor-control-server Info: shutting down control server
[task 2019-10-20T13:57:37.450Z] 13:57:37 INFO - raptor-main Info: finished
[task 2019-10-20T13:57:37.450Z] 13:57:37 ERROR - raptor-main Critical: TEST-UNEXPECTED-FAIL: no raptor test results were found for raptor-tp6m-wikipedia-geckoview-cold
[task 2019-10-20T13:57:56.570Z] 13:57:37 ERROR - Return code: 1
[task 2019-10-20T13:57:56.570Z] 13:57:37 WARNING - setting return code to 1
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Killing logcat pid 593.
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Copying Raptor results to upload dir:
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - /builds/task_1571579620/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Copying raptor results from /builds/task_1571579620/workspace/build/raptor.json to /builds/task_1571579620/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2019-10-20T13:57:56.570Z] 13:57:37 CRITICAL - Error copying results /builds/task_1571579620/workspace/build/raptor.json to upload dir /builds/task_1571579620/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - [Errno 2] No such file or directory: u'/builds/task_1571579620/workspace/build/raptor.json'
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - /builds/task_1571579620/workspace/build/blobber_upload_dir/screenshots.html
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Copying raptor results from /builds/task_1571579620/workspace/build/screenshots.html to /builds/task_1571579620/workspace/build/blobber_upload_dir/screenshots.html
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Running post-action listener: _package_coverage_data
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Running post-action listener: _resource_record_post_action
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Running post-action listener: process_java_coverage_data
[task 2019-10-20T13:57:56.570Z] 13:57:37 INFO - Running post-action listener: stop_device
[task 2019-10-20T13:57:56.570Z] 13:57:44 INFO - /data/anr/traces.txt deleted
[task 2019-10-20T13:57:56.570Z] 13:57:49 INFO - /data/tombstones/dsps deleted
[task 2019-10-20T13:57:56.570Z] 13:57:51 INFO - /data/tombstones/lpass deleted
[task 2019-10-20T13:57:56.570Z] 13:57:54 INFO - /data/tombstones/modem deleted
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - /data/tombstones/wcnss deleted
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - Killing logcat pid 593.
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - [mozharness: 2019-10-20 13:57:56.212222Z] Finished run-tests step (success)
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - Running post-run listener: _resource_record_post_run
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - Total resource usage - Wall time: 199s; CPU: 14.0%; Read bytes: 0; Write bytes: 4029693952; Read time: 0; Write time: 5046192
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - TinderboxPrint: CPU usage<br/>13.6%
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - TinderboxPrint: I/O read bytes / time<br/>0 / 0
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - TinderboxPrint: I/O write bytes / time<br/>4,029,693,952 / 5,046,192
[task 2019-10-20T13:57:56.570Z] 13:57:56 INFO - TinderboxPrint: CPU idle<br/>642.5 (80.7%)
[task 2019-10-20T13:57:56.571Z] 13:57:56 INFO - TinderboxPrint: CPU iowait<br/>43.9 (5.5%)
[task 2019-10-20T13:57:56.571Z] 13:57:56 INFO - TinderboxPrint: CPU system<br/>24.6 (3.1%)
[task 2019-10-20T13:57:56.571Z] 13:57:56 INFO - TinderboxPrint: CPU user<br/>80.0 (10.1%)
[task 2019-10-20T13:57:56.571Z] 13:57:56 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2019-10-20T13:57:56.571Z] 13:57:56 INFO - install - Wall time: 13s; CPU: 4.0%; Read bytes: 0; Write bytes: 384897024; Read time: 0; Write time: 449564
[task 2019-10-20T13:57:56.571Z] 13:57:56 INFO - run-tests - Wall time: 167s; CPU: 16.0%; Read bytes: 0; Write bytes: 3244830720; Read time: 0; Write time: 4198192
[task 2019-10-20T13:57:56.571Z] 13:57:56 WARNING - returning nonzero exit status 1

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: REOPENED → RESOLVED
Closed: 6 years ago → 5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.