1439167 - Intermittent cubeb.stream_position | Value of: last_position < position

Status: RESOLVED INCOMPLETE

(Core :: Audio/Video: cubeb, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: apavel [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=162846864&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/EqZOaTKsR9aZjNoRuezpBw/runs/0/artifacts/public/logs/live_backing.log

23:22:42     INFO -  TEST-START | cubeb.stream_position
23:22:46  WARNING -  TEST-UNEXPECTED-FAIL | cubeb.stream_position | Value of: last_position < position
23:22:46     INFO -    Actual: false
23:22:46     INFO -  Expected: true @ z:/build/build/src/media/libcubeb/gtest/test_sanity.cpp:520
23:22:46  WARNING -  TEST-UNEXPECTED-FAIL | cubeb.stream_position | test completed (time: 4012ms)
23:22:46     INFO -  TEST-START | cubeb.drain
23:27:46    ERROR -  gtest TEST-UNEXPECTED-FAIL | gtest | timed out after 300 seconds without output
23:27:46    ERROR - Return code: 1
23:27:46    ERROR - No tests run or test summary not found
23:27:46     INFO - TinderboxPrint: gtest-gtest<br/><em class="testfail">T-FAIL</em>
23:27:46    ERROR - # TBPL FAILURE #
23:27:46  WARNING - setting return code to 2
23:27:46    ERROR - The gtest suite: gtest ran with return status: FAILURE
23:27:46     INFO - Running post-action listener: _package_coverage_data
23:27:46     INFO - Running post-action listener: _resource_record_post_action
23:27:46     INFO - [mozharness: 2018-02-17 23:27:46.264000Z] Finished run-tests step (success)
23:27:46     INFO - Running post-run listener: _resource_record_post_run
23:27:46     INFO - Validating Perfherder data against Z:\task_1518909519\mozharness\external_tools\performance-artifact-schema.json
23:27:46     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 1.6248229461756374}, {"name": "io_write_bytes", "value": 302515712}, {"name": "io.read_bytes", "value": 761055744}, {"name": "io_write_time", "value": 21}, {"name": "io_read_time", "value": 181}], "extraOptions": ["taskcluster-c4.2xlarge"], "name": "gtest.gtest.gtest.overall"}, {"subtests": [{"name": "time", "value": 1.873000144958496}, {"name": "cpu_percent", "value": 13.837499999999999}], "name": "gtest.gtest.gtest.install"}, {"subtests": [{"name": "time", "value": 0.10599994659423828}], "name": "gtest.gtest.gtest.stage-files"}, {"subtests": [{"name": "time", "value": 352.7890000343323}, {"name": "cpu_percent", "value": 1.5475071225071224}], "name": "gtest.gtest.gtest.run-tests"}]}
23:27:46     INFO - Total resource usage - Wall time: 354s; CPU: 2.0%; Read bytes: 761055744; Write bytes: 302515712; Read time: 181; Write time: 21
23:27:46     INFO - TinderboxPrint: CPU usage<br/>1.5%
23:27:46     INFO - TinderboxPrint: I/O read bytes / time<br/>761,055,744 / 181
23:27:46     INFO - TinderboxPrint: I/O write bytes / time<br/>302,515,712 / 21
23:27:46     INFO - TinderboxPrint: CPU idle<br/>2,790.4 (98.4%)
23:27:46     INFO - install - Wall time: 2s; CPU: 14.0%; Read bytes: 0; Write bytes: 6069248; Read time: 0; Write time: 0
23:27:46     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
23:27:46     INFO - run-tests - Wall time: 353s; CPU: 2.0%; Read bytes: 760702976; Write bytes: 277993472; Read time: 181; Write time: 20
23:27:46     INFO - Running post-run listener: _upload_blobber_files
23:27:46  WARNING - Blob upload gear skipped. Missing cmdline options.
23:27:46     INFO - Running post-run listener: copy_logs_to_upload_dir
23:27:46     INFO - Copying logs to upload dir...
23:27:46     INFO - mkdir: Z:\task_1518909519\build\upload\logs
23:27:46     INFO - Copying logs to upload dir...
23:27:46     INFO - Using _rmtree_windows ...
23:27:46     INFO - Running command: del /F /Q "Z:\task_1518909519\build\upload\logs\localconfig.json"
23:27:46     INFO - Return code: 0
23:27:46     INFO - Using _rmtree_windows ...
23:27:46     INFO - Running command: del /F /Q "Z:\task_1518909519\build\upload\logs\log_info.log"
23:27:46     INFO - Return code: 0
23:27:46     INFO - Using _rmtree_windows ...
23:27:46     INFO - Running command: del /F /Q "Z:\task_1518909519\build\upload\logs\log_raw.log"
23:27:46     INFO - Return code: 0
23:27:46     INFO - Using _rmtree_windows ...
23:27:46     INFO - Running command: del /F /Q "Z:\task_1518909519\build\upload\logs\log_warning.log"
23:27:46     INFO - Return code: 0
23:27:46     INFO - Using _rmtree_windows ...
23:27:46     INFO - Running command: del /F /Q "Z:\task_1518909519\build\upload\logs\log_critical.log"
23:27:46     INFO - Return code: 0
23:27:46     INFO - Using _rmtree_windows ...
23:27:46     INFO - Running command: del /F /Q "Z:\task_1518909519\build\upload\logs\log_error.log"
23:27:46     INFO - Return code: 0
23:27:46     INFO - Using _rmtree_windows ...
23:27:46     INFO - Running command: del /F /Q "Z:\task_1518909519\build\upload\logs\log_fatal.log"
23:27:46     INFO - Return code: 0
23:27:46  WARNING - returning nonzero exit status 2
[taskcluster 2018-02-17T23:27:46.516Z]   Exit Code: 2
[taskcluster 2018-02-17T23:27:46.516Z]   User Time: 0s
[taskcluster 2018-02-17T23:27:46.516Z] Kernel Time: 15.625ms
[taskcluster 2018-02-17T23:27:46.516Z]   Wall Time: 9m3.7557895s
[taskcluster 2018-02-17T23:27:46.516Z] Peak Memory: 4874240
[taskcluster 2018-02-17T23:27:46.516Z]      Result: FAILED
[taskcluster 2018-02-17T23:27:46.516Z] === Task Finished ===
[taskcluster 2018-02-17T23:27:46.517Z] Task Duration: 9m3.7849703s

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1439167&startday=2018-02-12&endday=2018-02-18&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1439167&startday=2018-02-26&endday=2018-03-04&tree=all

Comment 3

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 4

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

https://treeherder.mozilla.org/logviewer.html#?job_id=178404524&repo=autoland

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1439167&startday=2018-05-14&endday=2018-05-20&tree=trunk

Comment 6

[Emma Humphries ☕️🎸🧞‍♀️✨ (she/they) [:emceeaich] (Pacific Time) use needinfo]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 7

[Andreea Pavel [:apavel]]

Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=196900583&repo=mozilla-beta&lineNumber=873

14:03:52     INFO - Running post-action listener: _resource_record_post_action
14:03:52     INFO - [mozharness: 2018-08-31 14:03:52.957000Z] Finished install step (success)
14:03:52     INFO - [mozharness: 2018-08-31 14:03:52.957000Z] Running stage-files step.
14:03:52     INFO - Running pre-action listener: _resource_record_pre_action
14:03:52     INFO - Running main action method: stage_files
14:03:52     INFO - Moving Z:\task_1535723830\build\tests\bin\plugins\gmp-clearkey to Z:\task_1535723830\build\application\firefox
14:03:52    ERROR - shutil error: Destination path 'Z:\task_1535723830\build\application\firefox\gmp-clearkey' already exists
14:03:52     INFO - Moving Z:\task_1535723830\build\tests\bin\plugins\gmp-fake to Z:\task_1535723830\build\application\firefox
14:03:52     INFO - Moving Z:\task_1535723830\build\tests\bin\plugins\gmp-fakeopenh264 to Z:\task_1535723830\build\application\firefox
14:03:52     INFO - Moving Z:\task_1535723830\build\tests\gtest\dependentlibs.list.gtest to Z:\task_1535723830\build\application\firefox
14:03:52     INFO - copying tree: Z:\task_1535723830\build\tests\gtest\gtest_bin to Z:\task_1535723830\build\application\firefox
14:03:52     INFO - mkdir: Z:\task_1535723830\build\application\firefox\gtest
14:03:52     INFO - copying tree: Z:\task_1535723830\build\tests\gtest\gtest_bin\gtest to Z:\task_1535723830\build\application\firefox\gtest
14:03:52     INFO - rmtree: Z:\task_1535723830\build\application\firefox\gtest
14:03:52     INFO - Using _rmtree_windows ...
14:03:52     INFO - retry: Calling _rmtree_windows with args: ('Z:\\task_1535723830\\build\\application\\firefox\\gtest',), kwargs: {}, attempt #1
14:03:52     INFO - Running command: rmdir /S /Q "Z:\task_1535723830\build\application\firefox\gtest"
14:03:52     INFO - Return code: 0
14:03:53     INFO - Running post-action listener: _resource_record_post_action
14:03:53     INFO - [mozharness: 2018-08-31 14:03:53.126000Z] Finished stage-files step (success)
14:03:53     INFO - [mozharness: 2018-08-31 14:03:53.126000Z] Running run-tests step.
14:03:53     INFO - Running pre-action listener: _resource_record_pre_action
14:03:53     INFO - Running pre-action listener: _set_gcov_prefix
14:03:53     INFO - Running main action method: run_tests
14:03:53     INFO - Running pre test command run mouse & screen adjustment script with 'c:\mozilla-build\python\python.exe Z:\task_1535723830\mozharness\external_tools\mouse_and_screen_resolution.py --configuration-file Z:\task_1535723830\mozharness\external_tools\machine-configuration.json'
14:03:53     INFO - Running command: ('c:\\mozilla-build\\python\\python.exe', 'Z:\\task_1535723830\\mozharness\\external_tools\\mouse_and_screen_resolution.py', '--configuration-file', 'Z:\\task_1535723830\\mozharness\\external_tools\\machine-configuration.json') in Z:\task_1535723830\build
14:03:53     INFO - Copy/paste: c:\mozilla-build\python\python.exe Z:\task_1535723830\mozharness\external_tools\mouse_and_screen_resolution.py --configuration-file Z:\task_1535723830\mozharness\external_tools\machine-configuration.json
14:03:56     INFO -  Screen resolution (current): (1024, 768)
14:03:56     INFO -  Changing the screen resolution...
14:03:56     INFO -  Screen resolution (new): (1280, 1024)
14:03:56     INFO -  Mouse position (current): (640, 512)
14:03:56     INFO -  Mouse position (new): (1010, 10)
14:03:56     INFO - Return code: 0

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-beta: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1439167&startday=2018-08-27&endday=2018-09-02&tree=all

Comment 9

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup