Closed Bug 1617343 Opened 5 years ago Closed 5 years ago

Intermittent raptor-main Critical: TEST-UNEXPECTED-FAIL: test 'raptor-tp6m-google-maps-fennec68' timed out loading test page: https://www.google.com/maps?force=pwa pending metrics: fnb paint

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)

References

Details

(Keywords: intermittent-failure)

Filed by: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=290004974&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MCnoRFbWQwOWMfGhTJfb2w/runs/0/artifacts/public/logs/live_backing.log

[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - raptor-mitmproxy Info: Successfully killed the mitmproxy playback process
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - raptor-webext Info: removing webext /builds/task_1582347846/workspace/build/tests/raptor/raptor/webextension/../../webext/raptor
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-results-handler Info: summarizing raptor test results
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-output Info: ignoring the first dcf value due to initial pageload noise
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-output Info: ignoring the first fnbpaint value due to initial pageload noise
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-output Info: ignoring the first loadtime value due to initial pageload noise
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-output Info: turning on subtest alerting for measurement type: loadtime
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-output Info: screen captures can be found locally at: /builds/task_1582347846/workspace/build/screenshots.html
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-output Info: PERFHERDER_DATA: {"framework": {"name": "raptor"}, "application": {"version": "68.6a1", "name": "fennec"}, "suites": [{"value": 450.63, "extraOptions": [], "name": "raptor-tp6m-google-restaurants-fennec68", "tags": ["pageload", "warm"], "lowerIsBetter": true, "subtests": [{"name": "dcf", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 357.5, "replicates": [500, 386, 361, 355, 323, 360, 322, 373, 357, 389, 337, 358, 338, 372, 349], "unit": "ms"}, {"name": "fnbpaint", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 364.0, "replicates": [558, 391, 366, 360, 328, 365, 326, 378, 362, 394, 341, 363, 382, 376, 354], "unit": "ms"}, {"name": "loadtime", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 703.0, "shouldAlert": true, "replicates": [1164, 796, 691, 694, 672, 703, 708, 727, 679, 761, 690, 703, 728, 704, 680], "unit": "ms"}], "type": "pageload", "alertThreshold": 2.0, "unit": "ms"}]}
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-output Info: results can also be found locally at: /builds/task_1582347846/workspace/build/raptor.json
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - perftest-results-handler Info: Validating PERFHERDER_DATA against /builds/task_1582347846/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - raptor-webext-android Info: removing test folder for raptor: /sdcard/raptor
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - adb shell_output: adb -s ZY322HN78D wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - adb shell_output: adb -s ZY322HN78D wait-for-device shell rm -r /sdcard/raptor, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - adb shell_output: adb -s ZY322HN78D wait-for-device shell sync, timeout: None, root: False, timedout: None, exitcode: 0, output:
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - adb shell_bool: adb -s ZY322HN78D wait-for-device shell test -e /sdcard/raptor, timeout: None, root: False, timedout: None, exitcode: 1, output:
[task 2020-02-22T05:10:54.811Z] 05:10:34 INFO - raptor-control-server Info: shutting down control server
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - raptor-webext Info: finished
[task 2020-02-22T05:10:54.811Z] 05:10:35 ERROR - raptor-main Critical: TEST-UNEXPECTED-FAIL: test 'raptor-tp6m-google-maps-fennec68' timed out loading test page: https://www.google.com/maps?force=pwa pending metrics: fnb paint
[task 2020-02-22T05:10:54.811Z] 05:10:35 ERROR - Return code: 1
[task 2020-02-22T05:10:54.811Z] 05:10:35 WARNING - setting return code to 1
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Killing logcat pid 597.
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Copying Raptor results to upload dir:
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - /builds/task_1582347846/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Copying raptor results from /builds/task_1582347846/workspace/build/raptor.json to /builds/task_1582347846/workspace/build/blobber_upload_dir/perfherder-data.json
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - /builds/task_1582347846/workspace/build/blobber_upload_dir/screenshots.html
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Copying raptor results from /builds/task_1582347846/workspace/build/screenshots.html to /builds/task_1582347846/workspace/build/blobber_upload_dir/screenshots.html
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Running post-action listener: _package_coverage_data
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Running post-action listener: _resource_record_post_action
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Running post-action listener: process_java_coverage_data
[task 2020-02-22T05:10:54.811Z] 05:10:35 INFO - Running post-action listener: stop_device
[task 2020-02-22T05:10:54.811Z] 05:10:42 INFO - /data/anr/traces.txt deleted
[task 2020-02-22T05:10:54.811Z] 05:10:48 INFO - /data/tombstones/dsps deleted
[task 2020-02-22T05:10:54.811Z] 05:10:50 INFO - /data/tombstones/lpass deleted
[task 2020-02-22T05:10:54.811Z] 05:10:52 INFO - /data/tombstones/modem deleted
[task 2020-02-22T05:10:54.811Z] 05:10:54 INFO - /data/tombstones/wcnss deleted
[task 2020-02-22T05:10:54.811Z] 05:10:54 INFO - Killing logcat pid 597.
[task 2020-02-22T05:10:54.811Z] 05:10:54 INFO - [mozharness: 2020-02-22 05:10:54.796572Z] Finished run-tests step (success)
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - Running post-run listener: _resource_record_post_run
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - Total resource usage - Wall time: 337s; CPU: 100.0%; Read bytes: 7573504; Write bytes: 5886431232; Read time: 14988; Write time: 6176080
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - TinderboxPrint: CPU usage<br/>99.7%
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - TinderboxPrint: I/O read bytes / time<br/>7,573,504 / 14,988
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - TinderboxPrint: I/O write bytes / time<br/>5,886,431,232 / 6,176,080
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - TinderboxPrint: CPU system<br/>189.4 (14.0%)
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - TinderboxPrint: CPU user<br/>1,153.3 (85.5%)
[task 2020-02-22T05:10:55.500Z] 05:10:54 INFO - TinderboxPrint: Swap in / out<br/>0 / 0

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

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