1896293 - Intermittent devtools/client/netmonitor/test/browser_net_cause_source_map.js | single tracking bug

Status: RESOLVED INCOMPLETE

(DevTools :: Netmonitor, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2024-05-12T11:48:08.392Z] 11:48:08     INFO - TEST-PASS | devtools/client/netmonitor/test/browser_net_cause_source_map.js | undefined assertion name - 
[task 2024-05-12T11:48:08.393Z] 11:48:08     INFO - Destroying the specified network monitor.
[task 2024-05-12T11:48:08.394Z] 11:48:08     INFO - Wait for completion of all NetworkUpdateEvents packets...
[task 2024-05-12T11:48:08.395Z] 11:48:08     INFO - All pending requests finished.
[task 2024-05-12T11:48:08.396Z] 11:48:08     INFO - Buffered messages finished
[task 2024-05-12T11:48:08.397Z] 11:48:08     INFO - TEST-UNEXPECTED-TIMEOUT | devtools/client/netmonitor/test/browser_net_cause_source_map.js | application timed out after 370 seconds with no output
[task 2024-05-12T11:48:08.398Z] 11:48:08     INFO - TEST-INFO took 372035ms
[task 2024-05-12T11:48:08.399Z] 11:48:08     INFO - Buffered messages finished
[task 2024-05-12T11:48:08.400Z] 11:48:08  WARNING - Force-terminating active process(es).
[task 2024-05-12T11:48:08.401Z] 11:48:08     INFO - Determining child pids from psutil...
[task 2024-05-12T11:48:08.402Z] 11:48:08     INFO - [10107, 10140, 10222, 10231, 10277, 11377, 11413]
[task 2024-05-12T11:48:08.403Z] 11:48:08     INFO - ==> process 10033 launched child process 10107
<...>
[task 2024-05-12T11:48:08.617Z] 11:48:08     INFO - Killing process: 10033
[task 2024-05-12T11:48:08.618Z] 11:48:08     INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-05-12T11:48:08.797Z] 11:48:08     INFO - psutil found pid 10033 dead
[task 2024-05-12T12:04:48.798Z] 12:04:48     INFO - Automation Error: mozharness timed out after 1000 seconds running ['/builds/worker/workspace/build/venv/bin/python', '-u', '/builds/worker/workspace/build/tests/mochitest/runtests.py', 'devtools/client/aboutdebugging/test/browser/browser.toml', 'devtools/client/dom/test/browser.toml', 'devtools/client/framework/test/allocations/browser_allocations_reload_netmonitor.toml', 'devtools/client/framework/test/browser-telemetry-startup.toml', 'devtools/client/framework/test/metrics/browser_metrics_netmonitor.toml', 'devtools/client/inspector/compatibility/test/browser/browser.toml', 'devtools/client/inspector/grids/test/browser.toml', 'devtools/client/inspector/test/browser.toml', 'devtools/client/netmonitor/test/browser.toml', 'devtools/client/shared/sourceeditor/test/browser.toml', 'devtools/client/webconsole/test/browser/_jsterm.toml', 'devtools/shared/commands/inspector/tests/browser.toml', 'devtools/shared/commands/target-configuration/tests/browser.toml', 'devtools/shared/tests/browser/browser.toml', '--setpref=layout.css.stylo-threads=4', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--appname=/builds/worker/workspace/build/application/firefox/firefox', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/X72g8apTS6uHdxJynJhVBw/artifacts/public/build/target.crashreporter-symbols.zip', '--certificate-path=tests/certs', '--setpref=webgl.force-enabled=true', '--quiet', '--log-errorsummary=/builds/worker/workspace/build/blobber_upload_dir/mochitest-devtools-chrome_errorsummary.log', '--use-test-media-devices', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=/builds/worker/workspace/build', '--log-raw=-', '--flavor=browser', '--subsuite=devtools', '--chunk-by-runtime']
[task 2024-05-12T12:04:48.800Z] 12:04:48     INFO - Return code: -9
[task 2024-05-12T12:04:48.801Z] 12:04:48  WARNING - Got 1 unexpected statuses
[task 2024-05-12T12:04:48.801Z] 12:04:48    ERROR - No suite end message was emitted by this harness.
[task 2024-05-12T12:04:48.801Z] 12:04:48     INFO - TinderboxPrint: mochitest-mochitest-devtools-chrome<br/>366/<em class="testfail">1</em>/0
[task 2024-05-12T12:04:48.801Z] 12:04:48  WARNING - setting return code to 2
[task 2024-05-12T12:04:48.801Z] 12:04:48     INFO - The mochitest suite: mochitest-devtools-chrome ran with return status: FAILURE
[task 2024-05-12T12:04:48.802Z] 12:04:48     INFO - Running post-action listener: _package_coverage_data
[task 2024-05-12T12:04:48.802Z] 12:04:48     INFO - Running post-action listener: _resource_record_post_action
[task 2024-05-12T12:04:48.802Z] 12:04:48     INFO - Running post-action listener: process_java_coverage_data
[task 2024-05-12T12:04:48.802Z] 12:04:48     INFO - [mozharness: 2024-05-12 12:04:48.802681Z] Finished run-tests step (success)
[task 2024-05-12T12:04:48.802Z] 12:04:48     INFO - [mozharness: 2024-05-12 12:04:48.802728Z] Running uninstall step.
[task 2024-05-12T12:04:48.803Z] 12:04:48     INFO - Running pre-action listener: _resource_record_pre_action
[task 2024-05-12T12:04:48.803Z] 12:04:48     INFO - Running main action method: uninstall
[task 2024-05-12T12:04:48.803Z] 12:04:48     INFO - Skipping uninstall for non-MSIX test
[task 2024-05-12T12:04:48.803Z] 12:04:48     INFO - Running post-action listener: _resource_record_post_action
[task 2024-05-12T12:04:48.803Z] 12:04:48     INFO - [mozharness: 2024-05-12 12:04:48.803727Z] Finished uninstall step (success)
[task 2024-05-12T12:04:48.804Z] 12:04:48     INFO - Running post-run listener: _resource_record_post_run
[task 2024-05-12T12:04:49.485Z] 12:04:49     INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2024-05-12T12:04:49.488Z] 12:04:49     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "mochitest.mochitest-devtools-chrome.overall", "extraOptions": ["e10s", "taskcluster-projects/887720501152/machineTypes/n2-standard-2"], "subtests": [{"name": "cpu_percent", "value": 33.095136642949655}, {"name": "io_write_bytes", "value": 927043584}, {"name": "io.read_bytes", "value": 7708672}, {"name": "io_write_time", "value": 364728}, {"name": "io_read_time", "value": 2988}]}, {"name": "mochitest.mochitest-devtools-chrome.start-pulseaudio", "subtests": [{"name": "time", "value": 0.022448761000021022}, {"name": "cpu_percent", "value": 0}]}, {"name": "mochitest.mochitest-devtools-chrome.install", "subtests": [{"name": "time", "value": 12.843204710000009}, {"name": "cpu_percent", "value": 50.96929133858268}]}, {"name": "mochitest.mochitest-devtools-chrome.stage-files", "subtests": [{"name": "time", "value": 0.0006676149999975678}, {"name": "cpu_percent", "value": 0}]}, {"name": "mochitest.mochitest-devtools-chrome.run-tests", "subtests": [{"name": "time", "value": 2460.510615946}, {"name": "cpu_percent", "value": 33.000568943796594}]}, {"name": "mochitest.mochitest-devtools-chrome.uninstall", "subtests": [{"name": "time", "value": 0.0006960659998185292}, {"name": "cpu_percent", "value": 0}]}]}
[task 2024-05-12T12:04:49.489Z] 12:04:49     INFO - Total resource usage - Wall time: 2474s; CPU: Can't collect data; Read bytes: 7708672; Write bytes: 927043584; Read time: 2988; Write time: 364728
[task 2024-05-12T12:04:49.489Z] 12:04:49     INFO - TinderboxPrint: I/O read bytes / time<br/>7,708,672 / 2,988
[task 2024-05-12T12:04:49.490Z] 12:04:49     INFO - TinderboxPrint: I/O write bytes / time<br/>927,043,584 / 364,728
[task 2024-05-12T12:04:49.490Z] 12:04:49     INFO - TinderboxPrint: CPU idle<br/>3,283.6 (66.7%)
[task 2024-05-12T12:04:49.491Z] 12:04:49     INFO - TinderboxPrint: CPU system<br/>163.7 (3.3%)
[task 2024-05-12T12:04:49.491Z] 12:04:49     INFO - TinderboxPrint: CPU user<br/>1,460.1 (29.7%)
[task 2024-05-12T12:04:49.492Z] 12:04:49     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2024-05-12T12:04:49.493Z] 12:04:49     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-05-12T12:04:49.496Z] 12:04:49     INFO - install - Wall time: 13s; CPU: 51%; Read bytes: 245760; Write bytes: 16707584; Read time: 116; Write time: 1644
[task 2024-05-12T12:04:49.499Z] 12:04:49     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-05-12T12:04:49.582Z] 12:04:49     INFO - run-tests - Wall time: 2461s; CPU: 33%; Read bytes: 7409664; Write bytes: 910336000; Read time: 2872; Write time: 363084
[task 2024-05-12T12:04:49.592Z] 12:04:49     INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-05-12T12:04:52.746Z] 12:04:52  WARNING - returning nonzero exit status 2
[task 2024-05-12T12:04:52.872Z] cleanup
[task 2024-05-12T12:04:52.873Z] + cleanup
[task 2024-05-12T12:04:52.873Z] + local rv=2
[task 2024-05-12T12:04:52.873Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2024-05-12T12:04:52.873Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2024-05-12T12:04:52.932Z] + '[' ']'
[task 2024-05-12T12:04:52.932Z] + true
[task 2024-05-12T12:04:52.932Z] + cleanup_xvfb
[task 2024-05-12T12:04:52.933Z] ++ pidof Xvfb
[task 2024-05-12T12:04:52.975Z] + local xvfb_pid=50
[task 2024-05-12T12:04:52.976Z] + local vnc=false
[task 2024-05-12T12:04:52.977Z] + local interactive=false
[task 2024-05-12T12:04:52.978Z] + '[' -n 50 ']'
[task 2024-05-12T12:04:52.978Z] + [[ false == false ]]
[task 2024-05-12T12:04:52.979Z] + [[ false == false ]]
[task 2024-05-12T12:04:52.979Z] + kill 50
[task 2024-05-12T12:04:52.980Z] + screen -XS xvfb quit
[task 2024-05-12T12:04:53.023Z] No screen session found.
[task 2024-05-12T12:04:53.023Z] + true
[task 2024-05-12T12:04:53.023Z] + exit 2
[taskcluster 2024-05-12 12:04:54.401Z] === Task Finished ===
[taskcluster 2024-05-12 12:04:56.806Z] Unsuccessful task run with exit code: 2 completed in 2831.017 seconds

Comment 1

[Intermittent Failures Robot]

1 failures in 3649 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1896293&startday=2024-05-06&endday=2024-05-12&tree=all

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

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