[43.407505] Initializing watchdogs
[43.407791]   /dev/watchdog0
[43.425345] [001/137] (960s left) syncobj_timeline (wait-for-submit-complex)
[43.626189] Starting subtest: wait-for-submit-complex
[43.689366] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[43.775913] [002/137] (960s left) syncobj_basic (create-signaled)
[43.952027] Starting subtest: create-signaled
[43.954142] Subtest create-signaled: SUCCESS (0.002s)
[44.023580] [003/137] (959s left) gem_exec_schedule (preempt-queue-contexts)
[44.252752] Starting subtest: preempt-queue-contexts
[44.255475] Starting dynamic subtest: rcs0
[45.249817] Dynamic subtest rcs0: SUCCESS (0.997s)
[45.267470] Starting dynamic subtest: bcs0
[46.190818] Dynamic subtest bcs0: SUCCESS (0.938s)
[46.209866] Starting dynamic subtest: vcs0
[47.124226] Dynamic subtest vcs0: SUCCESS (0.937s)
[47.140997] Starting dynamic subtest: vecs0
[48.047406] Dynamic subtest vecs0: SUCCESS (0.923s)
[48.049328] Subtest preempt-queue-contexts: SUCCESS (3.795s)
[48.390052] [004/137] (955s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[48.666980] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[48.677066] Starting dynamic subtest: pipe-A-DP-1
[49.276300] Dynamic subtest pipe-A-DP-1: SUCCESS (0.606s)
[49.291354] Starting dynamic subtest: pipe-B-DP-1
[49.665081] Dynamic subtest pipe-B-DP-1: SUCCESS (0.387s)
[49.681221] Starting dynamic subtest: pipe-C-DP-1
[49.796321] Dynamic subtest pipe-C-DP-1: SKIP (0.125s)
[49.798274] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (1.127s)
[50.169548] [005/137] (953s left) kms_atomic_transition (plane-all-transition-fencing)
[50.453867] Starting subtest: plane-all-transition-fencing
[50.456168] Starting dynamic subtest: pipe-A-DP-1
[54.817582] Dynamic subtest pipe-A-DP-1: SUCCESS (4.366s)
[54.948927] Starting dynamic subtest: pipe-B-DP-1
[59.317163] Dynamic subtest pipe-B-DP-1: SUCCESS (4.398s)
[59.418517] Subtest plane-all-transition-fencing: SUCCESS (8.965s)
[59.734845] [006/137] (944s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[60.033081] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[62.701277] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.671s)
[62.818253] [007/137] (941s left) i915_pm_rpm (legacy-planes)
[64.687946] Starting subtest: legacy-planes
[64.691027] Starting dynamic subtest: plane-39
[67.681173] Dynamic subtest plane-39: SUCCESS (2.993s)
[67.696218] Starting dynamic subtest: plane-47
[70.465261] Dynamic subtest plane-47: SUCCESS (2.783s)
[70.468541] Subtest legacy-planes: SUCCESS (5.777s)
[70.903678] [008/137] (933s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[71.092703] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[71.095298] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[71.169395] [009/137] (933s left) kms_frontbuffer_tracking (fbc-badstride)
[71.453596] Starting subtest: fbc-badstride
[79.369295] Subtest fbc-badstride: SUCCESS (7.921s)
[79.485637] [010/137] (924s left) kms_big_fb (linear-64bpp-rotate-180)
[79.786493] Starting subtest: linear-64bpp-rotate-180
[88.151266] Subtest linear-64bpp-rotate-180: SUCCESS (8.365s)
[89.071374] [011/137] (915s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[89.379219] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[92.318692] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.945s)
[92.452343] [012/137] (911s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[92.734957] Starting subtest: fbc-rgb565-draw-mmap-cpu
[94.868115] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.137s)
[94.985702] [013/137] (909s left) gem_lmem_swapping (verify)
[95.172734] Subtest verify: SKIP (0.000s)
[95.221439] [014/137] (909s left) kms_plane (plane-position-hole)
[95.493328] Starting subtest: plane-position-hole
[95.495407] Starting dynamic subtest: pipe-A-planes
[96.973663] Dynamic subtest pipe-A-planes: SUCCESS (1.478s)
[96.988992] Starting dynamic subtest: pipe-B-planes
[98.615306] Dynamic subtest pipe-B-planes: SUCCESS (1.642s)
[98.617553] Subtest plane-position-hole: SUCCESS (3.126s)
[98.950629] [015/137] (905s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[99.317676] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[99.599186] [016/137] (904s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[99.871496] Starting subtest: 2x-long-cursor-vs-flip-legacy
[99.880524] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.003s)
[99.956705] [017/137] (904s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[100.456054] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[100.758730] [018/137] (903s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[101.036292] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[101.038352] Starting dynamic subtest: pipe-A-valid-mode
[101.715863] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.681s)
[101.718746] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.683s)
[102.050577] [019/137] (902s left) gem_userptr_blits (nohangcheck)
[102.282907] Starting subtest: nohangcheck
[102.598271] Subtest nohangcheck: SUCCESS (0.316s)
[102.701335] [020/137] (901s left) gem_ctx_isolation (clean)
[102.901856] Starting subtest: clean
[102.903871] Starting dynamic subtest: rcs0
[103.113824] Dynamic subtest rcs0: SUCCESS (0.212s)
[103.129508] Starting dynamic subtest: bcs0
[103.389245] Dynamic subtest bcs0: SUCCESS (0.275s)
[103.409840] Starting dynamic subtest: vcs0
[103.635438] Dynamic subtest vcs0: SUCCESS (0.245s)
[103.651180] Starting dynamic subtest: vecs0
[103.869722] Dynamic subtest vecs0: SUCCESS (0.235s)
[103.871806] Subtest clean: SUCCESS (0.971s)
[104.068989] [021/137] (900s left) perf_pmu (init-busy)
[104.256619] Starting subtest: init-busy
[104.259543] Starting dynamic subtest: rcs0
[104.261765] Dynamic subtest rcs0: SUCCESS (0.004s)
[104.278640] Starting dynamic subtest: bcs0
[104.280948] Dynamic subtest bcs0: SUCCESS (0.002s)
[104.296613] Starting dynamic subtest: vcs0
[104.298613] Dynamic subtest vcs0: SUCCESS (0.001s)
[104.313954] Starting dynamic subtest: vecs0
[104.316462] Dynamic subtest vecs0: SUCCESS (0.001s)
[104.318538] Subtest init-busy: SUCCESS (0.012s)
[104.352379] [022/137] (900s left) gem_create (create-size-update)
[104.526473] Starting subtest: create-size-update
[104.528528] Subtest create-size-update: SUCCESS (0.000s)
[104.751353] [023/137] (899s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[105.020069] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[105.023314] Starting dynamic subtest: pipe-A-valid-mode
[105.132491] Dynamic subtest pipe-A-valid-mode: SKIP (0.115s)
[105.136708] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.117s)
[105.462758] [024/137] (899s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[105.743938] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[107.646498] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (1.908s)
[107.796655] [025/137] (896s left) gem_exec_big (single)
[107.984719] Starting subtest: single
[145.368890] Subtest single: SUCCESS (37.384s)
[148.143810] [026/137] (856s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[148.545391] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[148.549201] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.003s)
[148.698434] [027/137] (856s left) gem_pwrite (basic-exhaustion)
[148.877224] Starting subtest: basic-exhaustion
[168.439445] Subtest basic-exhaustion: SUCCESS (19.562s)
[168.550346] [028/137] (836s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[168.839891] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[168.844097] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[168.915325] [029/137] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[169.203542] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[169.207341] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[169.298637] [030/137] (835s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs)
[169.766356] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs
[169.770394] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.001s)
[170.111620] [031/137] (834s left) i915_pm_rps (basic-api)
[170.309621] Starting subtest: basic-api
[170.312086] Subtest basic-api: SUCCESS (0.007s)
[170.395364] [032/137] (834s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[170.584905] Starting subtest: yf-tiled-ccs-to-x-tiled
[170.587079] Starting dynamic subtest: smem
[170.898114] Dynamic subtest smem: SUCCESS (0.312s)
[170.900073] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.313s)
[171.096218] [033/137] (833s left) kms_addfb_basic (bad-pitch-999)
[171.272304] Starting subtest: bad-pitch-999
[171.274414] Subtest bad-pitch-999: SUCCESS (0.000s)
[171.662150] [034/137] (833s left) perf_pmu (frequency-idle)
[171.845814] Starting subtest: frequency-idle
[172.354673] Subtest frequency-idle: SUCCESS (0.506s)
[172.445314] [035/137] (832s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_ccs)
[172.941896] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.000s)
[173.255971] [036/137] (831s left) gem_exec_params (rsvd2-dirt)
[173.441250] Starting subtest: rsvd2-dirt
[173.445309] Subtest rsvd2-dirt: SKIP (0.000s)
[173.537786] [037/137] (831s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[173.847208] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[173.888629] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.037s)
[174.004470] [038/137] (831s left) core_getversion
[174.254769] [039/137] (830s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[174.552461] Starting subtest: y-tiled-16bpp-rotate-180
[178.450109] Subtest y-tiled-16bpp-rotate-180: SUCCESS (3.897s)
[178.754110] [040/137] (826s left) kms_invalid_mode (zero-vdisplay)
[179.033716] Starting subtest: zero-vdisplay
[179.037387] Starting dynamic subtest: DP-1-pipe-A
[179.138260] Dynamic subtest DP-1-pipe-A: SUCCESS (0.100s)
[179.158128] Starting dynamic subtest: DP-1-pipe-B
[179.160046] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[179.178097] Starting dynamic subtest: DP-1-pipe-C
[179.180048] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[179.181976] Subtest zero-vdisplay: SUCCESS (0.111s)
[179.523674] [041/137] (825s left) kms_psr2_sf (primary-plane-update-sf-dmg-area)
[179.704370] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s)
[179.761587] [042/137] (825s left) gen9_exec_parse (bb-chained)
[179.956204] Starting subtest: bb-chained
[179.968562] Subtest bb-chained: SUCCESS (0.011s)
[180.190533] [043/137] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[180.469775] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[180.473628] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[180.572892] [044/137] (824s left) gem_exec_flush (basic-wb-ro-default)
[180.769314] Starting subtest: basic-wb-ro-default
[186.225914] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[186.420885] [045/137] (819s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[186.926335] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[186.977985] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[187.317581] [046/137] (818s left) kms_vblank (pipe-c-ts-continuation-idle-hang)
[187.682147] Starting subtest: pipe-C-ts-continuation-idle-hang
[194.553044] Subtest pipe-C-ts-continuation-idle-hang: SUCCESS (6.896s)
[194.892312] [047/137] (810s left) perf (mi-rpc)
[195.176375] Starting subtest: mi-rpc
[195.244983] Subtest mi-rpc: SUCCESS (0.070s)
[195.292233] [048/137] (810s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[195.569788] Starting subtest: psr-rgb565-draw-pwrite
[195.573755] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[195.659328] [049/137] (809s left) gen7_exec_parse (bitmasks)
[195.844644] Subtest bitmasks: SKIP (0.000s)
[195.895377] [050/137] (809s left) vgem_basic (bad-handle)
[196.070972] Starting subtest: bad-handle
[196.073170] Subtest bad-handle: SUCCESS (0.000s)
[196.142511] [051/137] (809s left) gem_exec_reloc (basic-cpu-read-active)
[196.329293] Starting subtest: basic-cpu-read-active
[196.467157] Subtest basic-cpu-read-active: SUCCESS (0.137s)
[196.660969] [052/137] (809s left) kms_content_protection (type1)
[196.976721] Starting subtest: type1
[197.646819] Subtest type1: SKIP (0.667s)
[198.057870] [053/137] (807s left) kms_rotation_crc (cursor-rotation-180)
[198.333935] Starting subtest: cursor-rotation-180
[199.124779] Subtest cursor-rotation-180: SUCCESS (0.790s)
[199.530105] [054/137] (806s left) v3d/v3d_perfmon (create-perfmon-exceed)
[199.776783] Subtest create-perfmon-exceed: SKIP (0.000s)
[199.845943] [055/137] (806s left) gem_ctx_persistence (processes)
[200.031667] Starting subtest: processes
[200.463669] Subtest processes: SUCCESS (0.400s)
[200.514490] [056/137] (805s left) syncobj_wait (wait-all-delayed-signal)
[200.694387] Starting subtest: wait-all-delayed-signal
[200.799067] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[200.878440] [057/137] (805s left) i915_pipe_stress (stress-xrgb8888-ytiled)
[201.167240] Starting subtest: stress-xrgb8888-ytiled
[205.816296] Subtest stress-xrgb8888-ytiled: FAIL (3.948s)
[206.498937] [058/137] (799s left) gem_lmem_swapping (massive-random)
[206.686865] Subtest massive-random: SKIP (0.000s)
[206.746855] [059/137] (799s left) kms_force_connector_basic (prune-stale-modes)
[206.921076] Subtest prune-stale-modes: SKIP (0.000s)
[206.963856] [060/137] (799s left) api_intel_bb (intel-bb-blit-none)
[207.137178] Starting subtest: intel-bb-blit-none
[210.771526] Subtest intel-bb-blit-none: SUCCESS (3.634s)
[210.875337] [061/137] (795s left) kms_chamelium_audio (dp-audio-edid)
[211.257163] Subtest dp-audio-edid: SKIP (0.000s)
[211.542189] [062/137] (794s left) v3d/v3d_submit_csd (valid-multisync-submission)
[211.779390] Subtest valid-multisync-submission: SKIP (0.000s)
[211.849615] [063/137] (794s left) kms_vblank (pipe-b-query-idle)
[212.129337] Starting subtest: pipe-B-query-idle
[214.709347] Subtest pipe-B-query-idle: SUCCESS (2.584s)
[215.034999] [064/137] (791s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[215.318541] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[215.322402] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[215.418348] [065/137] (790s left) feature_discovery (psr1)
[215.689371] Starting subtest: psr1
[215.693353] Subtest psr1: SKIP (0.000s)
[215.768947] [066/137] (790s left) prime_mmap_coherency (read)
[215.953537] Starting subtest: read
[221.354876] Subtest read: SUCCESS (5.400s)
[221.464466] [067/137] (784s left) gem_exec_gttfill (all-engines)
[221.663769] Starting subtest: all-engines
[261.973226] Subtest all-engines: SUCCESS (40.311s)
[262.168183] [068/137] (744s left) gem_softpin (allocator-nopin)
[262.472376] Starting subtest: allocator-nopin
[262.704253] Subtest allocator-nopin: SUCCESS (0.232s)
[262.899488] [069/137] (743s left) kms_atomic (plane-invalid-params)
[263.520777] Starting subtest: plane-invalid-params
[263.679827] Subtest plane-invalid-params: SUCCESS (0.161s)
[264.123098] [070/137] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[264.408964] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[264.412798] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[264.508293] [071/137] (741s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[264.882854] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[264.886783] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[265.325926] [072/137] (741s left) gem_ctx_param (basic)
[265.503456] Starting subtest: basic
[265.505654] Subtest basic: SUCCESS (0.000s)
[265.591797] [073/137] (740s left) gem_exec_schedule (smoketest)
[265.935802] Starting subtest: smoketest
[265.937961] Starting dynamic subtest: rcs0
[271.395737] Dynamic subtest rcs0: SUCCESS (5.450s)
[271.416609] Starting dynamic subtest: bcs0
[276.840888] Dynamic subtest bcs0: SUCCESS (5.445s)
[276.865030] Starting dynamic subtest: vcs0
[282.294657] Dynamic subtest vcs0: SUCCESS (5.451s)
[282.317761] Starting dynamic subtest: vecs0
[287.743131] Dynamic subtest vecs0: SUCCESS (5.448s)
[287.745170] Subtest smoketest: SUCCESS (21.800s)
[287.925324] [074/137] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[288.212795] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[288.216700] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[288.309229] [075/137] (718s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[288.490205] Starting subtest: single-wait-for-submit-available-submitted
[288.492489] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[288.575732] [076/137] (718s left) gem_mmap_wc (write-wc-read-gtt)
[288.752408] Starting subtest: write-wc-read-gtt
[289.286491] Subtest write-wc-read-gtt: SUCCESS (0.533s)
[289.400659] [077/137] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[289.708528] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[289.712436] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[289.808836] [078/137] (716s left) kms_vblank (pipe-c-query-forked-busy-hang)
[290.089408] Starting subtest: pipe-C-query-forked-busy-hang
[297.528064] Subtest pipe-C-query-forked-busy-hang: SUCCESS (7.440s)
[297.873801] [079/137] (708s left) kms_universal_plane (disable-primary-vs-flip-pipe-d)
[298.156981] Subtest disable-primary-vs-flip-pipe-D: SKIP (0.000s)
[298.240523] [080/137] (708s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[298.515910] Starting subtest: addfb25-x-tiled-mismatch-legacy
[298.518026] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[298.823788] [081/137] (708s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[299.094106] Starting subtest: blocking-absolute-wf_vblank-interruptible
[299.100280] Starting dynamic subtest: A-DP1
[309.604230] Dynamic subtest A-DP1: SUCCESS (10.497s)
[309.629856] Starting dynamic subtest: B-DP1
[320.227761] Dynamic subtest B-DP1: SUCCESS (10.627s)
[320.249819] Starting dynamic subtest: C-DP1
[330.645968] Dynamic subtest C-DP1: SUCCESS (10.418s)
[330.648160] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.554s)
[331.076821] [082/137] (675s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[331.446406] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[331.450528] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.002s)
[331.879849] [083/137] (675s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[332.163487] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[332.167329] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[332.263724] [084/137] (674s left) gem_ctx_param (invalid-set-ringsize)
[332.441453] Starting subtest: invalid-set-ringsize
[332.443454] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[332.529096] [085/137] (674s left) v3d/v3d_submit_cl (bad-pad)
[332.759940] Subtest bad-pad: SKIP (0.000s)
[332.829653] [086/137] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[333.119857] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[333.123787] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[333.213402] [087/137] (673s left) kms_color (ctm-0-25)
[333.495460] Starting subtest: ctm-0-25
[333.497632] Starting dynamic subtest: pipe-A-DP-1
[334.654291] Dynamic subtest pipe-A-DP-1: SUCCESS (1.159s)
[334.679243] Starting dynamic subtest: pipe-B-DP-1
[335.959956] Dynamic subtest pipe-B-DP-1: SUCCESS (1.300s)
[335.984834] Starting dynamic subtest: pipe-C-DP-1
[337.281962] Dynamic subtest pipe-C-DP-1: SUCCESS (1.318s)
[337.283885] Subtest ctm-0-25: SUCCESS (3.791s)
[337.614080] [088/137] (669s left) gem_render_linear_blits (basic)
[337.802741] Starting subtest: basic
[337.885221] Subtest basic: SUCCESS (0.083s)
[337.949864] [089/137] (669s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[338.694079] Starting subtest: syncobj-stationary-timeline-chain-engines
[338.821223] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.127s)
[339.033282] [090/137] (668s left) syncobj_timeline (etime-single-wait-submitted)
[339.210391] Starting subtest: etime-single-wait-submitted
[339.315141] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[339.397374] [091/137] (667s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[339.672900] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[339.680810] Starting dynamic subtest: pipe-A-DP-1
[340.094129] Dynamic subtest pipe-A-DP-1: SUCCESS (0.417s)
[340.116935] Starting dynamic subtest: pipe-B-DP-1
[340.516216] Dynamic subtest pipe-B-DP-1: SUCCESS (0.419s)
[340.540200] Starting dynamic subtest: pipe-C-DP-1
[340.930473] Dynamic subtest pipe-C-DP-1: SUCCESS (0.410s)
[340.932940] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (1.257s)
[341.322744] [092/137] (665s left) gem_exec_reloc (basic-write-read-noreloc)
[341.513041] Starting subtest: basic-write-read-noreloc
[341.520757] Subtest basic-write-read-noreloc: SUCCESS (0.006s)
[341.722142] [093/137] (665s left) kms_flip (2x-busy-flip)
[341.985318] Starting subtest: 2x-busy-flip
[341.989393] Subtest 2x-busy-flip: SKIP (0.003s)
[342.088491] [094/137] (665s left) kms_psr (primary_mmap_cpu)
[342.267784] Subtest primary_mmap_cpu: SKIP (0.000s)
[342.323316] [095/137] (665s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[342.599077] Starting subtest: flip-vs-cursor-busy-crc-legacy
[343.381187] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.786s)
[343.726381] [096/137] (663s left) kms_cursor_crc (cursor-sliding-128x128)
[344.010791] Starting subtest: cursor-sliding-128x128
[344.020268] Starting dynamic subtest: pipe-A-DP-1
[347.700355] Dynamic subtest pipe-A-DP-1: SUCCESS (3.678s)
[347.779628] Starting dynamic subtest: pipe-B-DP-1
[351.496279] Dynamic subtest pipe-B-DP-1: SUCCESS (3.741s)
[351.578172] Starting dynamic subtest: pipe-C-DP-1
[355.329807] Dynamic subtest pipe-C-DP-1: SUCCESS (3.775s)
[355.331835] Subtest cursor-sliding-128x128: SUCCESS (11.320s)
[355.694406] [097/137] (651s left) dmabuf_sync_file (import-multiple-read-only)
[355.884209] Starting subtest: import-multiple-read-only
[355.897491] Subtest import-multiple-read-only: SUCCESS (0.013s)
[355.974125] [098/137] (651s left) vc4/vc4_perfmon (create-perfmon-0)
[356.202419] Subtest create-perfmon-0: SKIP (0.000s)
[356.273709] [099/137] (651s left) syncobj_wait (reset-multiple-signaled)
[356.450919] Starting subtest: reset-multiple-signaled
[356.453854] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[356.538757] [100/137] (651s left) kms_getfb (getfb-handle-not-fb)
[356.717574] Starting subtest: getfb-handle-not-fb
[356.808466] Subtest getfb-handle-not-fb: SUCCESS (0.093s)
[356.893953] [101/137] (650s left) vgem_basic (dmabuf-fence)
[357.084191] Starting subtest: dmabuf-fence
[357.086776] Subtest dmabuf-fence: SUCCESS (0.002s)
[357.157703] [102/137] (650s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[357.434140] Starting subtest: coverage-vs-premult-vs-constant
[357.744715] Starting dynamic subtest: pipe-A-DP-1
[358.165514] Dynamic subtest pipe-A-DP-1: SUCCESS (0.423s)
[358.192752] Starting dynamic subtest: pipe-C-DP-1
[358.818106] Dynamic subtest pipe-C-DP-1: SUCCESS (0.647s)
[358.820352] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.384s)
[359.179109] [103/137] (648s left) gem_exec_reloc (basic-gtt-cpu-active)
[359.367862] Starting subtest: basic-gtt-cpu-active
[359.509766] Subtest basic-gtt-cpu-active: SUCCESS (0.141s)
[359.695925] [104/137] (648s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs)
[360.125931] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs
[360.128047] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SUCCESS (0.001s)
[360.508948] [105/137] (647s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[360.888036] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[360.892193] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[361.319907] [106/137] (646s left) prime_busy (hang-wait)
[361.505451] Starting subtest: hang-wait
[361.507930] Starting dynamic subtest: rcs0
[368.426233] Dynamic subtest rcs0: SUCCESS (6.914s)
[368.447021] Starting dynamic subtest: bcs0
[375.466286] Dynamic subtest bcs0: SUCCESS (7.038s)
[375.487382] Starting dynamic subtest: vcs0
[382.440732] Dynamic subtest vcs0: SUCCESS (6.973s)
[382.461040] Starting dynamic subtest: vecs0
[389.481435] Dynamic subtest vecs0: SUCCESS (7.038s)
[389.483357] Subtest hang-wait: SUCCESS (27.973s)
[389.601581] [107/137] (618s left) gem_exec_fair (basic-none-vip)
[389.804411] Starting subtest: basic-none-vip
[389.806699] Starting dynamic subtest: rcs0
[395.564915] Dynamic subtest rcs0: SUCCESS (5.758s)
[395.567057] Subtest basic-none-vip: SUCCESS (5.760s)
[395.769503] [108/137] (612s left) kms_cursor_crc (cursor-random-256x85)
[396.059337] Starting subtest: cursor-random-256x85
[396.070160] Starting dynamic subtest: pipe-A-DP-1
[399.871101] Dynamic subtest pipe-A-DP-1: SUCCESS (3.790s)
[399.964552] Starting dynamic subtest: pipe-B-DP-1
[403.800526] Dynamic subtest pipe-B-DP-1: SUCCESS (3.877s)
[403.881672] Starting dynamic subtest: pipe-C-DP-1
[407.768847] Dynamic subtest pipe-C-DP-1: SUCCESS (3.900s)
[407.771340] Subtest cursor-random-256x85: SUCCESS (11.702s)
[408.114326] [109/137] (599s left) gem_mmap_gtt (coherency)
[408.291977] Starting subtest: coherency
[408.295876] Subtest coherency: SKIP (0.000s)
[408.376745] [110/137] (599s left) gem_exec_whisper (basic-fds)
[408.577878] Starting subtest: basic-fds
[424.841615] Subtest basic-fds: SUCCESS (16.261s)
[425.043282] [111/137] (583s left) vgem_basic (second-client)
[425.220135] Starting subtest: second-client
[425.269639] Subtest second-client: SUCCESS (0.049s)
[425.342469] [112/137] (582s left) kms_rmfb (rmfb-ioctl)
[425.620490] Starting subtest: rmfb-ioctl
[425.622682] Starting dynamic subtest: pipe-A-DP-1
[425.736202] Dynamic subtest pipe-A-DP-1: SUCCESS (0.119s)
[425.762876] Starting dynamic subtest: pipe-B-DP-1
[426.178954] Dynamic subtest pipe-B-DP-1: SUCCESS (0.440s)
[426.206202] Starting dynamic subtest: pipe-C-DP-1
[426.570430] Dynamic subtest pipe-C-DP-1: SUCCESS (0.389s)
[426.572782] Subtest rmfb-ioctl: SUCCESS (0.955s)
[426.961334] [113/137] (581s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_mc_ccs)
[427.366700] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs
[427.370972] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[427.769693] [114/137] (580s left) gem_mmap_gtt (medium-copy)
[427.945418] Starting subtest: medium-copy
[433.462702] Subtest medium-copy: SUCCESS (5.515s)
[433.585208] [115/137] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[434.005700] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[434.009814] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[434.103580] [116/137] (574s left) gem_exec_balancer (full-late-pulse)
[434.310093] Starting subtest: full-late-pulse
[438.319723] Subtest full-late-pulse: SUCCESS (4.011s)
[442.269526] [117/137] (566s left) gem_workarounds (reset-fd)
[442.487828] Starting subtest: reset-fd
[442.516926] Subtest reset-fd: SUCCESS (0.030s)
[442.640298] [118/137] (565s left) kms_vblank (pipe-a-wait-forked)
[442.918757] Starting subtest: pipe-A-wait-forked
[445.227409] Subtest pipe-A-wait-forked: SUCCESS (2.311s)
[445.558855] [119/137] (562s left) kms_chamelium_edid (dp-edid-read)
[445.917908] Subtest dp-edid-read: SKIP (0.000s)
[446.209207] [120/137] (562s left) kms_ccs (pipe-b-random-ccs-data-yf_tiled_ccs)
[446.635626] Starting subtest: pipe-B-random-ccs-data-yf_tiled_ccs
[447.073103] Subtest pipe-B-random-ccs-data-yf_tiled_ccs: SUCCESS (0.438s)
[447.591272] [121/137] (560s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[447.896493] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[447.900922] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[448.007870] [122/137] (560s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[448.309410] Starting subtest: x-tiled-64bpp-rotate-270
[448.383764] Subtest x-tiled-64bpp-rotate-270: SKIP (0.070s)
[448.491317] [123/137] (560s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[448.793386] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[448.802665] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[448.891454] [124/137] (559s left) kms_vblank (pipe-d-wait-forked-busy)
[449.167792] Subtest pipe-D-wait-forked-busy: SKIP (0.000s)
[449.257901] [125/137] (559s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[449.437584] Starting subtest: multi-wait-available-submitted-signaled
[449.439966] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[449.524611] [126/137] (559s left) kms_lease (possible-crtcs-filtering)
[449.811266] Starting subtest: possible-crtcs-filtering
[449.813710] Subtest possible-crtcs-filtering: SUCCESS (0.009s)
[449.891261] [127/137] (558s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[450.179392] Starting subtest: psr-1p-primscrn-cur-indfb-move
[450.183535] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[450.275410] [128/137] (558s left) kms_flip (dpms-off-confusion)
[450.528441] Starting subtest: dpms-off-confusion
[450.538060] Starting dynamic subtest: A-DP1
[461.258395] Dynamic subtest A-DP1: SUCCESS (10.725s)
[461.281321] Starting dynamic subtest: B-DP1
[471.714088] Dynamic subtest B-DP1: SUCCESS (10.452s)
[471.735401] Starting dynamic subtest: C-DP1
[482.152740] Dynamic subtest C-DP1: SUCCESS (10.439s)
[482.154856] Subtest dpms-off-confusion: SUCCESS (31.626s)
[482.567498] [129/137] (526s left) i915_pm_rpm (gem-evict-pwrite)
[484.338931] Starting subtest: gem-evict-pwrite
[485.428649] Subtest gem-evict-pwrite: SUCCESS (1.089s)
[485.883905] [130/137] (522s left) kms_psr (psr2_sprite_plane_onoff)
[486.064058] Subtest psr2_sprite_plane_onoff: SKIP (0.000s)
[486.117791] [131/137] (522s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[486.393156] Starting subtest: cursorA-vs-flipA-varying-size
[497.448078] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.014s)
[497.807350] [132/137] (511s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[498.243500] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[498.288937] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[498.410334] [133/137] (510s left) kms_vblank (invalid)
[498.685302] Starting subtest: invalid
[498.931787] Subtest invalid: SUCCESS (0.249s)
[499.262586] [134/137] (509s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[499.548809] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[499.552811] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[499.646100] [135/137] (509s left) device_reset (unbind-reset-rebind)
[499.859294] Starting subtest: unbind-reset-rebind
[500.767477] Subtest unbind-reset-rebind: SUCCESS (0.908s)
[501.292583] [136/137] (507s left) syncobj_wait (invalid-signal-bad-pad)
[501.490034] Starting subtest: invalid-signal-bad-pad
[501.492119] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[501.577687] [137/137] (507s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[501.873955] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[501.877843] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[501.954994] Closing watchdogs
Done.