Back to build
Raw log | Switch to full mode | Login

Set PYTHONPATH: /b/swarming/w/ir/kitchen-checkout/build/scripts:/b/swarming/w/ir/kitchen-checkout/build/site_config:/b/swarming/w/ir/kitchen-checkout/build/third_party:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/swarming/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/swarming/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/swarming/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/swarming/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/swarming/w/ir/kitchen-checkout/build/third_party/jinja2:/b/swarming/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/swarming/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/swarming/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/swarming/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/swarming/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/swarming/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/swarming/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/swarming/w/ir/kitchen-checkout/build/third_party/site-packages 2019-05-23 18:21:11,809 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmpVOsaJx' 2019-05-23 18:21:11,809 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmpVOsaJx' already exists! 2019-05-23 18:21:11,809 - root: [WARNING] task_output_dir existing content: [] 2019-05-23 18:21:11,809 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpTj39gW.json -output-dir /b/swarming/w/ir/tmp/t/tmpVOsaJx -task-summary-json /b/swarming/w/ir/tmp/t/tmpsGZBih.json [D2019-05-23T18:21:11.819798-07:00 20571 0 auth.go:1265] Minting a new token {"key":"luci_ctx/99a2443721184a7671ca63861cb8f801f5519f21d7e0d85146d5caaa5ee70c6c", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-23T18:21:11.819860-07:00 20571 0 luci_ctx.go:138] POST http://127.0.0.1:42509/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/99a2443721184a7671ca63861cb8f801f5519f21d7e0d85146d5caaa5ee70c6c", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-23T18:21:11.821375-07:00 20571 0 auth.go:1222] Token expires in 41m58.17864209s {"key":"luci_ctx/99a2443721184a7671ca63861cb8f801f5519f21d7e0d85146d5caaa5ee70c6c", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 45003d639cb1c210: exit 0 Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: bin/run_latency_unittests --test-launcher-summary-output=/b/s/w/ioXl5n3x/output.json INFO:root:Running the following command on the device: INFO:root: #!/bin/sh export HOME=/tmp ./latency_unittests --test-launcher-shard-index=0 --test-launcher-total-shards=1 --test-launcher-summary-output=/tmp/output.json INFO:root:Running the following command on the device: INFO:root:/b/s/w/ir/third_party/chromite/bin/cros_run_test --board amd64-generic --cache-dir /b/s/w/ir/build/cros_cache --start --copy-on-write --device localhost --results-src /tmp/output.json --results-dest-dir /b/s/w/ioXl5n3x --as-chronos --remote-cmd --cwd out_amd64-generic/Release --files out_amd64-generic/Release/tmpl0tJ4i.sh --files out_amd64-generic/Release/latency_unittests --files out_amd64-generic/Release/gen.runtime/ui/latency/latency_unittests/latency_unittests.runtime_deps --files out_amd64-generic/Release/icudtl.dat --files out_amd64-generic/Release/test_fonts/LICENSE --files out_amd64-generic/Release/test_fonts/Ahem.ttf --files out_amd64-generic/Release/test_fonts/Arimo-Bold.ttf --files out_amd64-generic/Release/test_fonts/Arimo-BoldItalic.ttf --files out_amd64-generic/Release/test_fonts/Arimo-Italic.ttf --files out_amd64-generic/Release/test_fonts/Arimo-Regular.ttf --files out_amd64-generic/Release/test_fonts/Cousine-Bold.ttf --files out_amd64-generic/Release/test_fonts/Cousine-BoldItalic.ttf --files out_amd64-generic/Release/test_fonts/Cousine-Italic.ttf --files out_amd64-generic/Release/test_fonts/Cousine-Regular.ttf --files out_amd64-generic/Release/test_fonts/DejaVuSans-Bold.ttf --files out_amd64-generic/Release/test_fonts/DejaVuSans.ttf --files out_amd64-generic/Release/test_fonts/GardinerModBug.ttf --files out_amd64-generic/Release/test_fonts/GardinerModCat.ttf --files out_amd64-generic/Release/test_fonts/Garuda.ttf --files out_amd64-generic/Release/test_fonts/Gelasio-Bold.ttf --files out_amd64-generic/Release/test_fonts/Gelasio-BoldItalic.ttf --files out_amd64-generic/Release/test_fonts/Gelasio-Italic.ttf --files out_amd64-generic/Release/test_fonts/Gelasio-Regular.ttf --files out_amd64-generic/Release/test_fonts/Lohit-Devanagari.ttf --files out_amd64-generic/Release/test_fonts/Lohit-Gurmukhi.ttf --files out_amd64-generic/Release/test_fonts/Lohit-Tamil.ttf --files out_amd64-generic/Release/test_fonts/MuktiNarrow.ttf --files out_amd64-generic/Release/test_fonts/NotoSansCJKjp-Regular.otf --files out_amd64-generic/Release/test_fonts/NotoSansKhmer-Regular.ttf --files out_amd64-generic/Release/test_fonts/Tinos-Bold.ttf --files out_amd64-generic/Release/test_fonts/Tinos-BoldItalic.ttf --files out_amd64-generic/Release/test_fonts/Tinos-Italic.ttf --files out_amd64-generic/Release/test_fonts/Tinos-Regular.ttf --files out_amd64-generic/Release/etc/fonts/fonts.conf --files out_amd64-generic/Release/bin/run_latency_unittests --files chromeos/CHROMEOS_LKGM --files testing/buildbot/filters/chromeos.base_unittests.filter --files testing/buildbot/filters/chromeos.media_unittests.filter --files testing/buildbot/filters/chromeos.services_unittests.filter -- ./tmpl0tJ4i.sh INFO:root:######################################## INFO:root:Test attempt #0 INFO:root:######################################## 04:29:19: INFO: /b/s/w/itvr2YU7/cros_vm_9222/kvm.pid does not exist. 04:29:19: INFO: /b/s/w/itvr2YU7/cros_vm_9222/kvm.pid does not exist. 04:29:19: INFO: RunCommand: /b/s/w/ir/build/cros_cache/chrome-sdk/tarballs/amd64-generic+12219.0.0+app-emulation/qemu/usr/bin/qemu-system-x86_64 --version 04:29:19: INFO: QEMU version 3.0.0 04:29:19: INFO: RunCommand: /b/s/w/ir/build/cros_cache/chrome-sdk/tarballs/amd64-generic+12219.0.0+app-emulation/qemu/usr/bin/qemu-img create -f qcow2 -o 'backing_file=/b/s/w/ir/build/cros_cache/chrome-sdk/tarballs/amd64-generic+12219.0.0+chromiumos_qemu_image.tar.xz/chromiumos_qemu_image.bin' /b/s/w/itvr2YU7/cros_vm_9222/qcow2.img Formatting '/b/s/w/itvr2YU7/cros_vm_9222/qcow2.img', fmt=qcow2 size=8952822272 backing_file=/b/s/w/ir/build/cros_cache/chrome-sdk/tarballs/amd64-generic+12219.0.0+chromiumos_qemu_image.tar.xz/chromiumos_qemu_image.bin cluster_size=65536 lazy_refcounts=off refcount_bits=16 04:29:19: INFO: qcow2 image created at /b/s/w/itvr2YU7/cros_vm_9222/qcow2.img. 04:29:19: INFO: Pid file: /b/s/w/itvr2YU7/cros_vm_9222/kvm.pid 04:29:19: INFO: RunCommand: /b/s/w/ir/build/cros_cache/chrome-sdk/tarballs/amd64-generic+12219.0.0+app-emulation/qemu/usr/bin/qemu-system-x86_64 -m 8G -smp 8 -vga virtio -daemonize -usbdevice tablet -pidfile /b/s/w/itvr2YU7/cros_vm_9222/kvm.pid -chardev 'pipe,id=control_pipe,path=/b/s/w/itvr2YU7/cros_vm_9222/kvm.monitor' -serial file:/b/s/w/itvr2YU7/cros_vm_9222/kvm.monitor.serial -mon 'chardev=control_pipe' -cpu SandyBridge,-invpcid,-tsc-deadline,check -device 'virtio-net,netdev=eth0' -device 'virtio-scsi-pci,id=scsi' -device 'scsi-hd,drive=hd' -drive 'if=none,id=hd,file=/b/s/w/itvr2YU7/cros_vm_9222/qcow2.img,cache=unsafe,format=qcow2' -netdev 'user,id=eth0,net=10.0.2.0/27,hostfwd=tcp:127.0.0.1:9222-:22' -enable-kvm qemu-system-x86_64: -usbdevice tablet: '-usbdevice' is deprecated, please use '-device usb-...' instead VNC server running on 127.0.0.1:5900 04:29:19: INFO: RunCommand: ssh -p 9222 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/s/w/itvr2YU7/ssh-tmp4GF3sZ/testing_rsa root@localhost -- true 04:29:49: INFO: (stdout): Connection timed out during banner exchange 04:29:49: ERROR: Error connecting to device localhost 04:29:54: INFO: RunCommand: ssh -p 9222 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/s/w/itvr2YU7/ssh-tmp4GF3sZ/testing_rsa root@localhost -- true 04:29:56: INFO: (stdout): Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. 04:29:57: INFO: [mode:rsync] copy: /b/s/w/itvr2YU7/tmplRzPoe/ -> localhost:/usr/local/cros_test 04:29:58: INFO: Using rsync compression: True Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. sending incremental file list created directory /usr/local/cros_test ./ chromeos/ chromeos/CHROMEOS_LKGM out_amd64-generic/ out_amd64-generic/Release/ out_amd64-generic/Release/icudtl.dat out_amd64-generic/Release/latency_unittests out_amd64-generic/Release/tmpl0tJ4i.sh out_amd64-generic/Release/bin/ out_amd64-generic/Release/bin/run_latency_unittests out_amd64-generic/Release/etc/ out_amd64-generic/Release/etc/fonts/ out_amd64-generic/Release/etc/fonts/fonts.conf out_amd64-generic/Release/gen.runtime/ out_amd64-generic/Release/gen.runtime/ui/ out_amd64-generic/Release/gen.runtime/ui/latency/ out_amd64-generic/Release/gen.runtime/ui/latency/latency_unittests/ out_amd64-generic/Release/gen.runtime/ui/latency/latency_unittests/latency_unittests.runtime_deps out_amd64-generic/Release/test_fonts/ out_amd64-generic/Release/test_fonts/Ahem.ttf out_amd64-generic/Release/test_fonts/Arimo-Bold.ttf out_amd64-generic/Release/test_fonts/Arimo-BoldItalic.ttf out_amd64-generic/Release/test_fonts/Arimo-Italic.ttf out_amd64-generic/Release/test_fonts/Arimo-Regular.ttf out_amd64-generic/Release/test_fonts/Cousine-Bold.ttf out_amd64-generic/Release/test_fonts/Cousine-BoldItalic.ttf out_amd64-generic/Release/test_fonts/Cousine-Italic.ttf out_amd64-generic/Release/test_fonts/Cousine-Regular.ttf out_amd64-generic/Release/test_fonts/DejaVuSans-Bold.ttf out_amd64-generic/Release/test_fonts/DejaVuSans.ttf out_amd64-generic/Release/test_fonts/GardinerModBug.ttf out_amd64-generic/Release/test_fonts/GardinerModCat.ttf out_amd64-generic/Release/test_fonts/Garuda.ttf out_amd64-generic/Release/test_fonts/Gelasio-Bold.ttf out_amd64-generic/Release/test_fonts/Gelasio-BoldItalic.ttf out_amd64-generic/Release/test_fonts/Gelasio-Italic.ttf out_amd64-generic/Release/test_fonts/Gelasio-Regular.ttf out_amd64-generic/Release/test_fonts/LICENSE out_amd64-generic/Release/test_fonts/Lohit-Devanagari.ttf out_amd64-generic/Release/test_fonts/Lohit-Gurmukhi.ttf out_amd64-generic/Release/test_fonts/Lohit-Tamil.ttf out_amd64-generic/Release/test_fonts/MuktiNarrow.ttf out_amd64-generic/Release/test_fonts/NotoSansCJKjp-Regular.otf out_amd64-generic/Release/test_fonts/NotoSansKhmer-Regular.ttf out_amd64-generic/Release/test_fonts/Tinos-Bold.ttf out_amd64-generic/Release/test_fonts/Tinos-BoldItalic.ttf out_amd64-generic/Release/test_fonts/Tinos-Italic.ttf out_amd64-generic/Release/test_fonts/Tinos-Regular.ttf plugins/ testing/ testing/buildbot/ testing/buildbot/filters/ testing/buildbot/filters/chromeos.base_unittests.filter testing/buildbot/filters/chromeos.media_unittests.filter testing/buildbot/filters/chromeos.services_unittests.filter sent 23,164,842 bytes received 875 bytes 5,147,937.11 bytes/sec total size is 37,006,085 speedup is 1.60 04:30:02: INFO: RunCommand: ssh -p 9222 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/s/w/itvr2YU7/ssh-tmp4GF3sZ/testing_rsa root@localhost -- mkdir -p /usr/local/cros_test/out_amd64-generic/Release 04:30:02: INFO: (stdout): Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. 04:30:02: INFO: RunCommand: ssh -p 9222 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/s/w/itvr2YU7/ssh-tmp4GF3sZ/testing_rsa root@localhost -- cp -r /root/.ssh/ /home/chronos/user/ 04:30:02: INFO: (stdout): Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. 04:30:02: INFO: RunCommand: ssh -p 9222 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/s/w/itvr2YU7/ssh-tmp4GF3sZ/testing_rsa root@localhost -- chown -R chronos: /usr/local/cros_test 04:30:02: INFO: (stdout): Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. 04:30:02: INFO: RunCommand: /bin/bash -c 'ssh -p 9222 -oConnectionAttempts=4 -oUserKnownHostsFile=/dev/null -oProtocol=2 -oConnectTimeout=30 -oServerAliveCountMax=3 -oStrictHostKeyChecking=no -oServerAliveInterval=10 -oNumberOfPasswordPrompts=0 -oIdentitiesOnly=yes -i /b/s/w/itvr2YU7/ssh-tmp4GF3sZ/testing_rsa chronos@localhost -- "cd /usr/local/cros_test/out_amd64-generic/Release && ./tmpl0tJ4i.sh"' Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. IMPORTANT DEBUGGING NOTE: batches of tests are run inside their own process. For debugging a test inside a debugger, use the --gtest_filter=<your_test_name> flag along with --single-process-tests. Using sharding settings from command line. This is shard 0/1 Using 8 parallel jobs. [1/81] AverageLagTrackerTest.OneSecondInterval (0 ms) [2/81] AverageLagTrackerTest.LargerLatency (0 ms) [3/81] AverageLagTrackerTest.TwoLatencyInfoInSameFrame (0 ms) [4/81] AverageLagTrackerTest.ChangeDirectionInFrame (0 ms) [5/81] AverageLagTrackerTest.NoScrollPrediction (1 ms) [6/81] AverageLagTrackerTest.ScrollPrediction (0 ms) [7/81] AverageLagTrackerTest.ImperfectScrollPrediction (0 ms) [8/81] AverageLagTrackerTest.NegativePredictionEffect (0 ms) [9/81] AverageLagTrackerTest.NoPredictionEffect (0 ms) [10/81] FrameMetricsFixedPointTest.kFixedPointMultiplier (0 ms) [11/81] FrameMetricsTest.WorstWindowsRangesUpdateCorrectly (1 ms) [12/81] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSkips (0 ms) [13/81] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForLatency (7 ms) [14/81] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSpeed (4 ms) [15/81] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForAcceleration (4 ms) [16/81] FrameMetricsTest.SquareRootApproximation (1 ms) [17/81] FrameMetricsHistogramsTest.RatioBoundariesDirect (0 ms) [18/81] FrameMetricsHistogramsTest.VSyncBoundariesDirect (0 ms) [19/81] FrameMetricsHistogramsTest.ResultsAreZeroWithoutSamples (1 ms) [20/81] FrameMetricsHistogramsTest.ResultsAreNonZeroWithSamplesOfZero (0 ms) [21/81] FrameMetricsHistogramsTest.RatioBoundaries (1 ms) [22/81] FrameMetricsHistogramsTest.VSyncBoundaries (2 ms) [23/81] FrameMetricsHistogramsTest.RatioPercentiles50th (0 ms) [24/81] FrameMetricsHistogramsTest.RatioPercentiles99th (1 ms) [25/81] FrameMetricsHistogramsTest.VSyncPercentiles50th (0 ms) [26/81] FrameMetricsHistogramsTest.VSyncPercentiles99th (1 ms) [27/81] LatencyInfoTest.AddTwoSeparateEvent (0 ms) [28/81] LatencyInfoTest.CoalesceTwoGSU (1 ms) [29/81] SkippedFrameTrackerTest.NoSkips_BeginThenWill (0 ms) [30/81] SkippedFrameTrackerTest.NoSkips_WillThenBegin (0 ms) [31/81] FrameMetricsFixedPointTest.kFixedPointRootMultiplier (0 ms) [32/81] FrameMetricsFixedPointTest.kFixedPointRootMultiplierSqrt (0 ms) [33/81] FrameMetricsFixedPointTest.kFixedPointRootShift (0 ms) [34/81] FrameMetricsFixedPointTest.Accumulator96bConstructor (1 ms) [35/81] FrameMetricsFixedPointTest.Accumulator96bAddSub (0 ms) [36/81] FrameMetricsFixedPointTest.Accumulator96bPrecision (0 ms) [37/81] FrameMetricsTest.PerfectSmoothnessScores (4 ms) [38/81] FrameMetricsTest.PerfectLatencyScores (2 ms) [39/81] FrameMetricsTest.SawToothShapedSkips (7 ms) [40/81] FrameMetricsTest.SawToothShapedLatency (2 ms) [41/81] SkippedFrameTrackerTest.Skips_ProducedOverMultipleBeginFrames (0 ms) [42/81] SkippedFrameTrackerTest.Skips_DroppedBeginFrames (0 ms) [43/81] SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsDown (0 ms) [44/81] SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsUp (0 ms) [45/81] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_WillThenBegin (0 ms) [46/81] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_BeginThenWill (0 ms) [47/81] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_JumpInIdle (0 ms) [48/81] SkippedFrameTrackerTest.WillNotProduceFrame (0 ms) [49/81] SkippedFrameTrackerTest.WillNotProduceFrame2 (1 ms) [50/81] SkippedFrameTrackerTest.PulledFramesNotRecorded (0 ms) [51/81] StructTraitsTest.LatencyInfo (1 ms) [52/81] FrameMetricsWindowedAnalyzerTest.AllResultsTheSame (8 ms) [53/81] FrameMetricsWindowedAnalyzerTest.AllResultsDifferent (0 ms) [54/81] FrameMetricsWindowedAnalyzerTest.SmallSampleSize (0 ms) [55/81] FrameMetricsWindowedAnalyzerTest.BadFirstSamples (0 ms) [56/81] FrameMetricsWindowedAnalyzerTest.ResetWorstValues (0 ms) [57/81] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBasic (1 ms) [58/81] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBig (0 ms) [59/81] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBigger (1 ms) [60/81] LatencyInfoParamTraitsTest.Basic (0 ms) [61/81] LatencyInfoParamTraitsTest.InvalidData (0 ms) [62/81] FrameMetricsTest.SkipSaturatesOnOverflow (3 ms) [63/81] FrameMetricsTest.LatencySaturatesOnOverflow (3 ms) [64/81] FrameMetricsTest.LatencySpeedSaturatesOnOverflow (15 ms) [65/81] FrameMetricsTest.LatencyAccelerationSaturatesOnOverflow (5 ms) [66/81] FrameMetricsTest.SkipThresholds (11 ms) [67/81] FrameMetricsTest.LatencyThresholds (17 ms) [68/81] FrameMetricsTest.SpeedThresholds (37 ms) [69/81] FrameMetricsTest.AccelerationThresholds (25 ms) [70/81] FrameMetricsTest.PercentilesSkipBasic (1 ms) [71/81] FrameMetricsTest.PercentilesLatencyBasic (0 ms) [72/81] SkippedFrameTrackerTest.MultipleWillProduceBeforeDidProduce (1 ms) [73/81] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledBeforeBF (0 ms) [74/81] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledAfterPush (0 ms) [75/81] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledIsPush (0 ms) [76/81] SkippedFrameTrackerTest.NoFrameProduced (0 ms) [77/81] StreamAnalyzerTest.AllResultsTheSame (49 ms) [78/81] StreamAnalyzerTest.AllResultsDifferent (5 ms) [79/81] StreamAnalyzerTest.SamplesForwardedToHistogram (0 ms) [80/81] StreamAnalyzerTest.PercentilesModifiedByClient (0 ms) [81/81] StreamAnalyzerTest.Precision (41 ms) SUCCESS: all tests passed. Tests took 0 seconds. 04:30:02: INFO: RunCommand: ssh -p 9222 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/s/w/itvr2YU7/ssh-tmp4GF3sZ/testing_rsa root@localhost -- rm -rf /usr/local/cros_test 04:30:03: INFO: (stdout): Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. 04:30:03: INFO: ./tmpl0tJ4i.sh exited with status code 0. 04:30:03: INFO: Fetching /tmp/output.json to /b/s/w/ioXl5n3x Warning: Permanently added '[localhost]:9222' (ED25519) to the list of known hosts. 04:30:03: INFO: RunCommand: kill -9 3471 04:30:03: INFO: SSH port 9222 in use... 04:30:08: INFO: Time elapsed: 0:00:48.491534 INFO:root:Test exitted with 0. 2019-05-23 18:21:13,044 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmpVOsaJx/45003d639cb1c210'] 2019-05-23 18:21:13,044 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmpVOsaJx/45003d639cb1c210/output.json'] 2019-05-23 18:21:13,044 - root: [INFO] merge_cmd: /b/swarming/w/ir/cache/vpython/ba947a/bin/python /b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py --build-properties {"blamelist": ["kbr@chromium.org"], "bot_id": "swarm1617-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1558659787522556, "id": "8912620470597322160", "project": "chromium", "tags": ["build_address:luci.chromium.try/chromeos-amd64-generic-rel/271739", "builder:chromeos-amd64-generic-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1628391/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-amd64-generic-rel", "buildnumber": 271739, "category": "cq", "got_angle_revision": "d2683459da1d6e5907fc54dc1f98398397b59841", "got_dawn_revision": "eea2091068037c41e52164f100802302768b674d", "got_nacl_revision": "0ddc033406886a709b901e0c312872529f9705e8", "got_revision": "160c911fed69af9395d8a03327b47f750f8b3f50", "got_revision_cp": "refs/heads/master@{#662927}", "got_swarming_client_revision": "779c4f0f8488c64587b75dbb001d18c3c0c4cda9", "got_v8_revision": "bffe9927669b41ad07e1a14bba243c4d4599e9c2", "got_v8_revision_cp": "refs/heads/7.6.267@{#1}", "got_webrtc_revision": "c1c0d6d8ad7471043631f6b4b006eba9801d9241", "got_webrtc_revision_cp": "refs/heads/master@{#28046}", "mastername": "tryserver.chromium.chromiumos", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1628391, "patch_project": "chromium/src", "patch_ref": "refs/changes/91/1628391/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"} --summary-json /b/swarming/w/ir/tmp/t/tmpsGZBih.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpVOsaJx -o /b/swarming/w/ir/tmp/t/tmphYOPn0.json /b/swarming/w/ir/tmp/t/tmpVOsaJx/45003d639cb1c210/output.json Running ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--build-properties', '{"blamelist": ["kbr@chromium.org"], "bot_id": "swarm1617-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1558659787522556, "id": "8912620470597322160", "project": "chromium", "tags": ["build_address:luci.chromium.try/chromeos-amd64-generic-rel/271739", "builder:chromeos-amd64-generic-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1628391/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-amd64-generic-rel", "buildnumber": 271739, "category": "cq", "got_angle_revision": "d2683459da1d6e5907fc54dc1f98398397b59841", "got_dawn_revision": "eea2091068037c41e52164f100802302768b674d", "got_nacl_revision": "0ddc033406886a709b901e0c312872529f9705e8", "got_revision": "160c911fed69af9395d8a03327b47f750f8b3f50", "got_revision_cp": "refs/heads/master@{#662927}", "got_swarming_client_revision": "779c4f0f8488c64587b75dbb001d18c3c0c4cda9", "got_v8_revision": "bffe9927669b41ad07e1a14bba243c4d4599e9c2", "got_v8_revision_cp": "refs/heads/7.6.267@{#1}", "got_webrtc_revision": "c1c0d6d8ad7471043631f6b4b006eba9801d9241", "got_webrtc_revision_cp": "refs/heads/master@{#28046}", "mastername": "tryserver.chromium.chromiumos", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1628391, "patch_project": "chromium/src", "patch_ref": "refs/changes/91/1628391/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpsGZBih.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpVOsaJx', '-o', '/b/swarming/w/ir/tmp/t/tmphYOPn0.json', '/b/swarming/w/ir/tmp/t/tmpVOsaJx/45003d639cb1c210/output.json'] in None (env: None) Command ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--build-properties', '{"blamelist": ["kbr@chromium.org"], "bot_id": "swarm1617-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1558659787522556, "id": "8912620470597322160", "project": "chromium", "tags": ["build_address:luci.chromium.try/chromeos-amd64-generic-rel/271739", "builder:chromeos-amd64-generic-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1628391/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-amd64-generic-rel", "buildnumber": 271739, "category": "cq", "got_angle_revision": "d2683459da1d6e5907fc54dc1f98398397b59841", "got_dawn_revision": "eea2091068037c41e52164f100802302768b674d", "got_nacl_revision": "0ddc033406886a709b901e0c312872529f9705e8", "got_revision": "160c911fed69af9395d8a03327b47f750f8b3f50", "got_revision_cp": "refs/heads/master@{#662927}", "got_swarming_client_revision": "779c4f0f8488c64587b75dbb001d18c3c0c4cda9", "got_v8_revision": "bffe9927669b41ad07e1a14bba243c4d4599e9c2", "got_v8_revision_cp": "refs/heads/7.6.267@{#1}", "got_webrtc_revision": "c1c0d6d8ad7471043631f6b4b006eba9801d9241", "got_webrtc_revision_cp": "refs/heads/master@{#28046}", "mastername": "tryserver.chromium.chromiumos", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1628391, "patch_project": "chromium/src", "patch_ref": "refs/changes/91/1628391/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpsGZBih.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpVOsaJx', '-o', '/b/swarming/w/ir/tmp/t/tmphYOPn0.json', '/b/swarming/w/ir/tmp/t/tmpVOsaJx/45003d639cb1c210/output.json'] returned exit code 0