[49.691511] Initializing watchdogs
[49.691742]   /dev/watchdog0
[49.724036] [001/137] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[50.186853] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[50.228285] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[50.325628] [002/137] (959s left) perf_pmu (most-busy-check-all)
[50.627778] Starting subtest: most-busy-check-all
[50.646230] Starting dynamic subtest: rcs0
[51.170103] Dynamic subtest rcs0: SUCCESS (0.545s)
[51.211209] Starting dynamic subtest: bcs0
[51.693723] Dynamic subtest bcs0: SUCCESS (0.533s)
[51.726113] Starting dynamic subtest: vcs0
[52.231579] Dynamic subtest vcs0: SUCCESS (0.530s)
[52.265123] Starting dynamic subtest: vecs0
[52.752720] Dynamic subtest vecs0: SUCCESS (0.525s)
[52.771916] Subtest most-busy-check-all: SUCCESS (2.135s)
[52.855395] [003/137] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[53.263731] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[53.303835] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[53.405772] [004/137] (957s left) gem_exec_params (invalid-ring)
[53.657971] Starting subtest: invalid-ring
[53.678897] Subtest invalid-ring: SUCCESS (0.001s)
[53.761350] [005/137] (956s left) gem_exec_reloc (basic-wc-gtt-active)
[54.014854] Starting subtest: basic-wc-gtt-active
[54.153310] Subtest basic-wc-gtt-active: SUCCESS (0.143s)
[54.366419] [006/137] (956s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[54.777214] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[57.508320] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.691s)
[57.592444] [007/137] (953s left) gem_exec_whisper (basic-sync-all)
[57.888406] Starting subtest: basic-sync-all
[66.607230] Subtest basic-sync-all: SUCCESS (8.725s)
[66.797339] [008/137] (944s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[67.055876] Starting subtest: cpuset-medium-copy-odd
[79.596070] Subtest cpuset-medium-copy-odd: SUCCESS (12.557s)
[79.706458] [009/137] (931s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[80.284835] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[80.324783] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.008s)
[80.429140] [010/137] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[80.829850] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[80.872130] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[80.975041] [011/137] (930s left) gem_mmap_gtt (basic-write-read-distinct)
[81.224648] Starting subtest: basic-write-read-distinct
[81.243875] Subtest basic-write-read-distinct: SUCCESS (0.033s)
[81.383336] [012/137] (929s left) gem_mmap (basic-small-bo)
[81.626787] Starting subtest: basic-small-bo
[82.484411] Subtest basic-small-bo: SUCCESS (0.867s)
[82.623361] [013/137] (928s left) i915_pm_rpm (gem-execbuf)
[84.824679] Starting subtest: gem-execbuf
[84.845954] Starting dynamic subtest: smem0
[86.543885] Dynamic subtest smem0: SUCCESS (1.714s)
[86.563453] Subtest gem-execbuf: SUCCESS (1.717s)
[87.058056] [014/137] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[87.470826] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[87.507627] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[87.617990] [015/137] (923s left) perf_pmu (frequency)
[87.865891] Starting subtest: frequency
[89.983802] Subtest frequency: SUCCESS (2.077s)
[90.088061] [016/137] (921s left) kms_writeback (writeback-pixel-formats)
[90.552894] Subtest writeback-pixel-formats: SKIP (0.000s)
[90.654195] [017/137] (920s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[90.925846] Starting subtest: yf-tiled-to-vebox-yf-tiled
[90.963570] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[91.148448] [018/137] (920s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[91.571725] Starting subtest: y-tiled-8bpp-rotate-90
[91.647815] Subtest y-tiled-8bpp-rotate-90: SKIP (0.075s)
[91.779038] [019/137] (920s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[92.105073] Starting subtest: etime-multi-wait-all-submitted-signaled
[92.195037] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[92.332218] [020/137] (919s left) gem_vm_create (invalid-destroy)
[92.580222] Starting subtest: invalid-destroy
[92.601534] Subtest invalid-destroy: SUCCESS (0.001s)
[92.707220] [021/137] (919s left) gem_exec_params (dr4-dirt)
[92.960592] Starting subtest: DR4-dirt
[92.981220] Subtest DR4-dirt: SUCCESS (0.001s)
[93.070452] [022/137] (918s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[93.487777] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[95.457467] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.044s)
[95.618761] [023/137] (916s left) gem_mmap_offset (open-flood)
[95.888954] Starting subtest: open-flood
[117.427140] Subtest open-flood: SUCCESS (21.538s)
[117.530190] [024/137] (894s left) kms_chamelium_color (ctm-blue-to-red)
[117.919034] Subtest ctm-blue-to-red: SKIP (0.000s)
[118.043824] [025/137] (894s left) gem_exec_fence (syncobj-timeline-repeat)
[118.991584] Starting subtest: syncobj-timeline-repeat
[120.146847] Subtest syncobj-timeline-repeat: SUCCESS (1.156s)
[120.392552] [026/137] (892s left) vgem_slow (nohang)
[120.636689] Starting subtest: nohang
[131.237596] Subtest nohang: SUCCESS (10.431s)
[131.326405] [027/137] (881s left) kms_content_protection (atomic)
[131.703782] Starting subtest: atomic
[131.745551] Starting dynamic subtest: pipe-A-DP-1
[252.779994] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[259.609943] Closing watchdogs
[259.620759] Initializing watchdogs
[259.620937]   /dev/watchdog0
[259.679484] [028/137] (752s left) gem_ctx_persistence (legacy-engines-hang)
[259.955675] Starting subtest: legacy-engines-hang
[259.976160] Starting dynamic subtest: render
[259.996947] Dynamic subtest render: SUCCESS (0.043s)
[260.032698] Starting dynamic subtest: bsd
[260.051637] Dynamic subtest bsd: SUCCESS (0.037s)
[260.087840] Starting dynamic subtest: blt
[260.128445] Dynamic subtest blt: SKIP (0.004s)
[260.165528] Starting dynamic subtest: vebox
[260.185859] Dynamic subtest vebox: SUCCESS (0.036s)
[260.206307] Subtest legacy-engines-hang: SUCCESS (0.125s)
[260.307120] [029/137] (752s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[260.973799] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[261.011442] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.004s)
[261.360647] [030/137] (751s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[261.807370] Starting subtest: psr-2p-primscrn-spr-indfb-move
[261.860941] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[261.988223] [031/137] (750s left) gem_exec_reloc (basic-gtt-cpu)
[262.378455] Starting subtest: basic-gtt-cpu
[262.407779] Subtest basic-gtt-cpu: SUCCESS (0.023s)
[262.547241] [032/137] (750s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[262.984980] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[263.036037] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[263.160608] [033/137] (750s left) sw_sync (sync_merge_invalid)
[263.425779] Starting subtest: sync_merge_invalid
[263.448742] Subtest sync_merge_invalid: SUCCESS (0.010s)
[263.582368] [034/137] (749s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[263.964792] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[265.493103] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.552s)
[265.736427] [035/137] (747s left) kms_cursor_crc (cursor-sliding-128x128)
[266.096711] Starting subtest: cursor-sliding-128x128
[266.115557] Starting dynamic subtest: pipe-A-DP-1
[269.787846] Dynamic subtest pipe-A-DP-1: SUCCESS (3.673s)
[269.851033] Starting dynamic subtest: pipe-B-DP-1
[273.708400] Dynamic subtest pipe-B-DP-1: SUCCESS (3.867s)
[273.799194] Starting dynamic subtest: pipe-C-DP-1
[277.756489] Dynamic subtest pipe-C-DP-1: SUCCESS (3.982s)
[277.776907] Subtest cursor-sliding-128x128: SUCCESS (11.654s)
[278.136644] [036/137] (735s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[278.752763] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[278.795671] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[279.154458] [037/137] (734s left) v3d/v3d_perfmon (create-two-perfmon)
[279.481115] Subtest create-two-perfmon: SKIP (0.000s)
[279.588307] [038/137] (734s left) kms_getfb (getfb2-handle-protection)
[279.844405] Starting subtest: getfb2-handle-protection
[279.865608] Subtest getfb2-handle-protection: SUCCESS (0.026s)
[279.968870] [039/137] (733s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[280.335093] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[280.356135] Starting dynamic subtest: pipe-A-valid-mode
[280.490723] Dynamic subtest pipe-A-valid-mode: SKIP (0.162s)
[280.535492] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.164s)
[280.852545] [040/137] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[281.264887] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[281.304739] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[281.409565] [041/137] (732s left) i915_pm_rpm (system-suspend-execbuf)
[283.214866] Starting subtest: system-suspend-execbuf
[305.380050] Subtest system-suspend-execbuf: SUCCESS (6.106s)
[308.129247] [042/137] (724s left) vc4/vc4_tiling (get-after-free)
[308.482318] Subtest get-after-free: SKIP (0.000s)
[308.596412] [043/137] (723s left) kms_prop_blob (blob-multiple)
[308.845741] Starting subtest: blob-multiple
[308.867341] Subtest blob-multiple: SUCCESS (0.003s)
[308.981541] [044/137] (723s left) vgem_basic (bad-pad)
[309.233190] Starting subtest: bad-pad
[309.254054] Subtest bad-pad: SUCCESS (0.000s)
[309.364054] [045/137] (723s left) kms_universal_plane (disable-primary-vs-flip-pipe-d)
[309.721981] Subtest disable-primary-vs-flip-pipe-D: SKIP (0.000s)
[309.877889] [046/137] (722s left) syncobj_timeline (wait-all-for-submit-complex)
[310.126758] Starting subtest: wait-all-for-submit-complex
[310.329717] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[310.465952] [047/137] (722s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[310.807990] Starting subtest: sprite-rotation-90-pos-100-0
[316.802431] Subtest sprite-rotation-90-pos-100-0: SUCCESS (6.003s)
[317.273473] [048/137] (715s left) perf_pmu (busy-start)
[317.516942] Starting subtest: busy-start
[317.535474] Starting dynamic subtest: rcs0
[320.234400] Dynamic subtest rcs0: SUCCESS (2.520s)
[320.274274] Starting dynamic subtest: bcs0
[322.568344] Dynamic subtest bcs0: SUCCESS (2.522s)
[322.607183] Starting dynamic subtest: vcs0
[325.268526] Dynamic subtest vcs0: SUCCESS (2.521s)
[325.306363] Starting dynamic subtest: vecs0
[327.615827] Dynamic subtest vecs0: SUCCESS (2.520s)
[327.636430] Subtest busy-start: SUCCESS (10.088s)
[327.727746] [049/137] (705s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[328.056353] Starting subtest: map-fixed-invalidate-overlap
[328.075064] Starting dynamic subtest: gtt
[328.322391] Dynamic subtest gtt: SUCCESS (0.321s)
[328.363380] Starting dynamic subtest: wb
[328.550837] Dynamic subtest wb: SUCCESS (0.229s)
[328.590354] Starting dynamic subtest: wc
[328.777009] Dynamic subtest wc: SUCCESS (0.225s)
[328.819281] Starting dynamic subtest: uc
[329.008969] Dynamic subtest uc: SUCCESS (0.229s)
[329.030034] Subtest map-fixed-invalidate-overlap: SUCCESS (1.010s)
[329.166565] [050/137] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[329.577333] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[331.734991] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.236s)
[331.919070] [051/137] (701s left) gem_exec_reloc (basic-wc-read-noreloc)
[332.178400] Starting subtest: basic-wc-read-noreloc
[332.206643] Subtest basic-wc-read-noreloc: SUCCESS (0.008s)
[332.425048] [052/137] (700s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[332.807166] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[333.930010] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.118s)
[334.295634] [053/137] (699s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[334.624736] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[335.489359] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (0.861s)
[335.839368] [054/137] (697s left) syncobj_timeline (wait-any-snapshot)
[336.076481] Starting subtest: wait-any-snapshot
[336.151781] Subtest wait-any-snapshot: SUCCESS (0.082s)
[336.283224] [055/137] (697s left) kms_vblank (pipe-a-ts-continuation-modeset-hang)
[336.603364] Starting subtest: pipe-A-ts-continuation-modeset-hang
[343.619834] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (7.012s)
[344.001823] [056/137] (689s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[344.333254] Starting subtest: 2x-long-cursor-vs-flip-atomic
[344.374838] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.003s)
[344.485459] [057/137] (689s left) core_auth (many-magics)
[344.733792] Starting subtest: many-magics
[345.883433] Subtest many-magics: SUCCESS (1.161s)
[346.020367] [058/137] (687s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_mc_ccs)
[346.490375] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_mc_ccs
[346.533362] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[347.042766] [059/137] (686s left) kms_scaling_modes (scaling-mode-center)
[347.383142] Starting subtest: scaling-mode-center
[347.426390] Subtest scaling-mode-center: SKIP (0.001s)
[347.539841] [060/137] (686s left) i915_pm_dc (dc5-dpms)
[348.900876] Starting subtest: dc5-dpms
[350.323140] Subtest dc5-dpms: SUCCESS (1.435s)
[350.580588] [061/137] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[350.983295] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[351.020287] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[351.136959] [062/137] (683s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[351.521538] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[351.564089] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[351.680218] [063/137] (682s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_mc_ccs)
[352.182620] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs
[352.226623] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[352.704288] [064/137] (681s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[352.943387] Starting subtest: invalid-signal-one-illegal-handle
[352.965749] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[353.075713] [065/137] (681s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[353.449231] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[353.491588] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[353.604717] [066/137] (681s left) kms_atomic_transition (modeset-transition-nonblocking)
[353.967645] Starting subtest: modeset-transition-nonblocking
[353.988958] Starting dynamic subtest: 1x-outputs
[358.630007] Dynamic subtest 1x-outputs: SUCCESS (4.674s)
[358.774837] Subtest modeset-transition-nonblocking: SUCCESS (4.798s)
[359.127666] [067/137] (675s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs)
[359.844173] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[360.175854] [068/137] (674s left) prime_mmap (test_aperture_limit)
[360.430071] Starting subtest: test_aperture_limit
[360.448904] Starting dynamic subtest: test_aperture_limit-smem
[360.467656] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.026s)
[360.486403] Subtest test_aperture_limit: SUCCESS (0.028s)
[360.603380] [069/137] (674s left) kms_lease (multimaster-lease)
[360.942716] Starting subtest: multimaster-lease
[360.961738] Subtest multimaster-lease: SUCCESS (0.007s)
[361.076878] [070/137] (674s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[361.414742] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[361.435668] Starting dynamic subtest: pipe-A-DP-1
[361.828504] Dynamic subtest pipe-A-DP-1: SUCCESS (0.397s)
[361.894338] Starting dynamic subtest: pipe-B-DP-1
[362.214445] Dynamic subtest pipe-B-DP-1: SUCCESS (0.386s)
[362.277478] Starting dynamic subtest: pipe-C-DP-1
[362.350382] Dynamic subtest pipe-C-DP-1: SKIP (0.119s)
[362.369697] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.912s)
[362.778047] [071/137] (672s left) kms_content_protection (uevent)
[363.155412] Starting subtest: uevent
[363.175644] Starting dynamic subtest: pipe-A-DP-1
[399.272043] Dynamic subtest pipe-A-DP-1: FAIL (34.996s)
[399.290664] Subtest uevent: FAIL (35.176s)
[399.422790] [072/137] (635s left) gen9_exec_parse (unaligned-jump)
[399.693399] Starting subtest: unaligned-jump
[399.927386] Subtest unaligned-jump: SUCCESS (0.247s)
[400.162894] [073/137] (635s left) gem_exec_suspend (basic-s3-devices)
[400.428228] Starting subtest: basic-S3-devices
[400.446457] Starting dynamic subtest: smem
[410.361502] Dynamic subtest smem: SUCCESS (9.931s)
[410.380124] Subtest basic-S3-devices: SUCCESS (9.933s)
[415.775249] [074/137] (624s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_mc_ccs)
[416.295263] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs
[416.357319] Subtest pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[416.804255] [075/137] (624s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[417.295627] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[417.335506] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[417.830824] [076/137] (623s left) gem_mmap_wc (copy)
[418.074197] Starting subtest: copy
[418.394635] Subtest copy: SUCCESS (0.332s)
[418.532654] [077/137] (622s left) kms_frontbuffer_tracking (fbc-1p-rte)
[418.945089] Starting subtest: fbc-1p-rte
[422.529250] Subtest fbc-1p-rte: SUCCESS (3.665s)
[422.726898] [078/137] (618s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[423.075504] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[423.099878] Starting dynamic subtest: pipe-A-valid-mode
[423.542112] Dynamic subtest pipe-A-valid-mode: SKIP (0.417s)
[423.591133] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.419s)
[423.920830] [079/137] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[424.339715] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[424.389120] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[424.527991] [080/137] (616s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[425.014540] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[425.354539] [081/137] (616s left) kms_flip (2x-flip-vs-wf_vblank)
[425.712425] Starting subtest: 2x-flip-vs-wf_vblank
[425.753602] Subtest 2x-flip-vs-wf_vblank: SKIP (0.003s)
[425.861907] [082/137] (615s left) kms_cursor_legacy (forked-move)
[426.188732] Starting subtest: forked-move
[426.210113] Starting dynamic subtest: pipe-A
[447.782027] Dynamic subtest pipe-A: SUCCESS (21.546s)
[447.832822] Starting dynamic subtest: pipe-B
[469.329879] Dynamic subtest pipe-B: SUCCESS (21.572s)
[469.408319] Starting dynamic subtest: pipe-C
[490.905639] Dynamic subtest pipe-C: SUCCESS (21.575s)
[490.993731] Starting dynamic subtest: all-pipes
[512.456190] Dynamic subtest all-pipes: SUCCESS (21.552s)
[512.474956] Subtest forked-move: SUCCESS (86.250s)
[512.570681] [083/137] (529s left) gem_exec_schedule (noreorder-priority)
[512.959985] Starting subtest: noreorder-priority
[512.978819] Starting dynamic subtest: rcs0
[514.070661] Dynamic subtest rcs0: SUCCESS (1.128s)
[514.117190] Starting dynamic subtest: bcs0
[515.198123] Dynamic subtest bcs0: SUCCESS (1.128s)
[515.243161] Starting dynamic subtest: vcs0
[516.333222] Dynamic subtest vcs0: SUCCESS (1.131s)
[516.377764] Starting dynamic subtest: vecs0
[517.458344] Dynamic subtest vecs0: SUCCESS (1.125s)
[517.477052] Subtest noreorder-priority: SUCCESS (4.520s)
[517.687702] [084/137] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[518.056971] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[518.094005] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[518.215049] [085/137] (523s left) core_setmaster (master-drop-set-root)
[520.108407] Starting subtest: master-drop-set-root
[520.129142] Subtest master-drop-set-root: SUCCESS (0.011s)
[520.219853] [086/137] (521s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[520.464070] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[520.483170] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.000s)
[520.574317] [087/137] (521s left) dumb_buffer (map-invalid-size)
[520.803744] Starting subtest: map-invalid-size
[520.822593] Subtest map-invalid-size: SUCCESS (0.000s)
[520.916873] [088/137] (521s left) gem_close (basic)
[521.156446] Starting subtest: basic
[521.175292] Subtest basic: SUCCESS (0.000s)
[521.291178] [089/137] (520s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[521.763282] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[521.805767] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.005s)
[522.311697] [090/137] (520s left) kms_atomic_transition (plane-all-transition)
[522.643024] Starting subtest: plane-all-transition
[522.664836] Starting dynamic subtest: pipe-A-DP-1
[526.538279] Dynamic subtest pipe-A-DP-1: SUCCESS (3.898s)
[526.678572] Starting dynamic subtest: pipe-B-DP-1
[530.912275] Dynamic subtest pipe-B-DP-1: SUCCESS (4.270s)
[531.007899] Subtest plane-all-transition: SUCCESS (8.369s)
[531.390952] [091/137] (511s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[531.858061] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[531.897334] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[532.420712] [092/137] (510s left) gem_exec_fair (basic-none-solo)
[532.850577] Starting subtest: basic-none-solo
[532.872602] Starting dynamic subtest: rcs0
[541.197185] Dynamic subtest rcs0: SUCCESS (8.518s)
[541.217976] Subtest basic-none-solo: SUCCESS (8.520s)
[541.457785] [093/137] (501s left) syncobj_basic (bad-handle-to-fd)
[541.708996] Starting subtest: bad-handle-to-fd
[541.730521] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[541.844384] [094/137] (500s left) syncobj_wait (reset-unsignaled)
[542.104382] Starting subtest: reset-unsignaled
[542.124492] Subtest reset-unsignaled: SUCCESS (0.000s)
[542.241088] [095/137] (500s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[542.638305] Starting subtest: fbc-2p-pri-indfb-multidraw
[542.676698] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[542.801147] [096/137] (500s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[543.040547] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[543.062401] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[543.181563] [097/137] (499s left) kms_vblank (pipe-c-wait-forked-busy)
[543.525384] Starting subtest: pipe-C-wait-forked-busy
[546.451677] Subtest pipe-C-wait-forked-busy: SUCCESS (2.934s)
[546.804858] [098/137] (496s left) gem_exec_whisper (basic-normal-all)
[547.091429] Starting subtest: basic-normal-all
[556.254427] Subtest basic-normal-all: SUCCESS (9.157s)
[556.470455] [099/137] (486s left) gem_pxp (display-protected-crc)
[559.469833] Subtest display-protected-crc: SKIP (0.000s)
[559.587723] [100/137] (483s left) gem_spin_batch (resubmit-all)
[559.859869] Starting subtest: resubmit-all
[559.881192] Starting dynamic subtest: rcs0
[559.901792] Dynamic subtest rcs0: SUCCESS (0.010s)
[559.942062] Starting dynamic subtest: bcs0
[559.960809] Dynamic subtest bcs0: SUCCESS (0.007s)
[560.002035] Starting dynamic subtest: vcs0
[560.020804] Dynamic subtest vcs0: SUCCESS (0.006s)
[560.062234] Starting dynamic subtest: vecs0
[560.084262] Dynamic subtest vecs0: SUCCESS (0.006s)
[560.105676] Subtest resubmit-all: SUCCESS (0.036s)
[560.216880] [101/137] (483s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs)
[560.906830] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[561.243437] [102/137] (482s left) gem_ctx_engines (independent)
[561.517222] Starting subtest: independent
[561.538479] Starting dynamic subtest: rcs0
[561.719808] Dynamic subtest rcs0: SUCCESS (0.218s)
[561.762179] Starting dynamic subtest: bcs0
[561.984792] Dynamic subtest bcs0: SUCCESS (0.261s)
[562.029036] Starting dynamic subtest: vcs0
[562.183476] Dynamic subtest vcs0: SUCCESS (0.197s)
[562.227718] Starting dynamic subtest: vecs0
[562.386054] Dynamic subtest vecs0: SUCCESS (0.201s)
[562.431789] Starting dynamic subtest: all-engines
[562.908893] Dynamic subtest all-engines: SUCCESS (0.522s)
[562.930607] Subtest independent: SUCCESS (1.407s)
[563.170285] [103/137] (480s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[563.502447] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[563.524861] Starting dynamic subtest: pipe-A-valid-mode
[563.661273] Dynamic subtest pipe-A-valid-mode: SKIP (0.120s)
[563.703856] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.123s)
[564.019457] [104/137] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[564.414350] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[564.456616] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[564.568547] [105/137] (479s left) kms_vblank (pipe-a-wait-forked-hang)
[564.899664] Starting subtest: pipe-A-wait-forked-hang
[571.737741] Subtest pipe-A-wait-forked-hang: SUCCESS (6.694s)
[571.978716] [106/137] (472s left) v3d/v3d_submit_cl (bad-multisync-in-sync)
[572.324874] Subtest bad-multisync-in-sync: SKIP (0.000s)
[572.469330] [107/137] (471s left) gem_exec_flush (basic-wb-prw-default)
[572.797480] Starting subtest: basic-wb-prw-default
[578.436935] Subtest basic-wb-prw-default: SUCCESS (5.449s)
[578.567745] [108/137] (465s left) gem_exec_params (larger-than-life-batch)
[578.829411] Starting subtest: larger-than-life-batch
[580.055507] Subtest larger-than-life-batch: SKIP (1.016s)
[580.193784] [109/137] (464s left) api_intel_bb (blit-noreloc-keep-cache)
[580.588938] Starting subtest: blit-noreloc-keep-cache
[580.610524] Subtest blit-noreloc-keep-cache: SUCCESS (0.017s)
[580.728425] [110/137] (463s left) kms_fbcon_fbt (psr-suspend)
[580.979203] Starting subtest: psr-suspend
[581.020989] Subtest psr-suspend: SKIP (0.016s)
[581.132480] [111/137] (463s left) drm_buddy (all-tests)
[581.413082] Starting subtest: all-tests
[581.452100] Subtest all-tests: SKIP (0.000s)
[581.569895] [112/137] (463s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[582.007720] Starting subtest: x-tiled-64bpp-rotate-0
[589.472652] Subtest x-tiled-64bpp-rotate-0: SUCCESS (7.504s)
[590.429193] [113/137] (454s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[590.859319] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[590.899575] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[591.011561] [114/137] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[591.424086] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[591.461175] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[591.579593] [115/137] (453s left) gem_exec_schedule (u-semaphore-codependency)
[591.989248] Starting subtest: u-semaphore-codependency
[592.010385] Subtest u-semaphore-codependency: SUCCESS (0.022s)
[592.354676] [116/137] (452s left) gem_ccs (suspend-resume)
[592.627631] Subtest suspend-resume: SKIP (0.000s)
[592.716896] [117/137] (452s left) kms_chamelium_edid (hdmi-edid-read)
[593.181748] Subtest hdmi-edid-read: SKIP (0.000s)
[593.495457] [118/137] (451s left) gem_ctx_shared (q-smoketest-all)
[593.766430] Starting subtest: Q-smoketest-all
[626.147709] Subtest Q-smoketest-all: SUCCESS (32.305s)
[626.315185] [119/137] (418s left) gem_ringfill (basic-all)
[626.814512] Starting subtest: basic-all
[627.978794] Subtest basic-all: SUCCESS (1.184s)
[628.131406] [120/137] (417s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[628.499371] Starting subtest: yf-tiled-addfb-size-offset-overflow
[628.542783] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[628.661440] [121/137] (416s left) kms_cursor_crc (cursor-random-128x42)
[629.028618] Starting subtest: cursor-random-128x42
[629.050707] Starting dynamic subtest: pipe-A-DP-1
[632.820433] Dynamic subtest pipe-A-DP-1: SUCCESS (3.792s)
[632.915017] Starting dynamic subtest: pipe-B-DP-1
[636.893258] Dynamic subtest pipe-B-DP-1: SUCCESS (4.008s)
[636.961015] Starting dynamic subtest: pipe-C-DP-1
[641.073584] Dynamic subtest pipe-C-DP-1: SUCCESS (4.129s)
[641.100719] Subtest cursor-random-128x42: SUCCESS (12.057s)
[641.484672] [122/137] (404s left) gem_exec_balancer (bonded-pair)
[641.782152] Starting subtest: bonded-pair
[645.670725] Subtest bonded-pair: SUCCESS (3.726s)
[649.516891] [123/137] (396s left) kms_async_flips (test-time-stamp)
[649.857239] Starting subtest: test-time-stamp
[649.876075] Starting dynamic subtest: pipe-A-DP-1
[650.642051] Dynamic subtest pipe-A-DP-1: SUCCESS (0.771s)
[650.685597] Starting dynamic subtest: pipe-B-DP-1
[651.366336] Dynamic subtest pipe-B-DP-1: SUCCESS (0.720s)
[651.408334] Starting dynamic subtest: pipe-C-DP-1
[651.996008] Dynamic subtest pipe-C-DP-1: SUCCESS (0.629s)
[652.014907] Subtest test-time-stamp: SUCCESS (2.127s)
[652.584079] [124/137] (393s left) kms_flip (2x-blocking-absolute-wf_vblank)
[652.947115] Starting subtest: 2x-blocking-absolute-wf_vblank
[652.989145] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.003s)
[653.101290] [125/137] (392s left) v3d/v3d_wait_bo (unused-bo-1ns)
[653.417875] Subtest unused-bo-1ns: SKIP (0.000s)
[653.532163] [126/137] (392s left) kms_psr (primary_page_flip)
[653.799615] Subtest primary_page_flip: SKIP (0.000s)
[653.916043] [127/137] (392s left) syncobj_basic (bad-flags-handle-to-fd)
[654.154983] Starting subtest: bad-flags-handle-to-fd
[654.183604] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[654.350464] [128/137] (391s left) syncobj_wait (wait-any-complex)
[654.602789] Starting subtest: wait-any-complex
[654.654891] Subtest wait-any-complex: SUCCESS (0.063s)
[654.800280] [129/137] (391s left) i915_pm_sseu (full-enable)
[655.558428] Starting subtest: full-enable
[655.579741] Subtest full-enable: SUCCESS (0.018s)
[655.712172] [130/137] (390s left) gem_exec_balancer (parallel-out-fence)
[659.896471] Subtest parallel-out-fence: SKIP (0.000s)
[659.997588] [131/137] (386s left) gem_userptr_blits (unsync-unmap-after-close)
[660.332002] Subtest unsync-unmap-after-close: SKIP (0.000s)
[660.425251] [132/137] (386s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[660.701326] Subtest overlay-plane-update-continuous-sf: SKIP (0.000s)
[660.793421] [133/137] (385s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[661.204770] Starting subtest: psr-rgb101010-draw-blt
[661.242194] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[661.360502] [134/137] (385s left) kms_vblank (pipe-a-query-busy)
[661.676386] Starting subtest: pipe-A-query-busy
[664.130695] Subtest pipe-A-query-busy: SUCCESS (2.451s)
[664.491756] [135/137] (382s left) kms_plane_lowres (tiling-4)
[664.830675] Starting subtest: tiling-4
[664.870105] Subtest tiling-4: SKIP (0.000s)
[664.990762] [136/137] (382s left) kms_flip (blocking-absolute-wf_vblank)
[665.317068] Starting subtest: blocking-absolute-wf_vblank
[665.336007] Starting dynamic subtest: A-DP1
[676.003691] Dynamic subtest A-DP1: SUCCESS (10.518s)
[676.057775] Starting dynamic subtest: B-DP1
[686.447435] Dynamic subtest B-DP1: SUCCESS (10.438s)
[686.502266] Starting dynamic subtest: C-DP1
[696.905427] Dynamic subtest C-DP1: SUCCESS (10.456s)
[696.926011] Subtest blocking-absolute-wf_vblank: SUCCESS (31.422s)
[697.156615] [137/137] (350s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-75)
[697.497774] Starting subtest: plane-downscale-with-pixel-format-factor-0-75
[697.517088] Starting dynamic subtest: pipe-A-DP-1
[699.817234] Dynamic subtest pipe-A-DP-1: SUCCESS (2.301s)
[699.871642] Starting dynamic subtest: pipe-B-DP-1
[702.401483] Dynamic subtest pipe-B-DP-1: SUCCESS (2.583s)
[702.455545] Starting dynamic subtest: pipe-C-DP-1
[702.752176] Dynamic subtest pipe-C-DP-1: SUCCESS (0.364s)
[702.774995] Subtest plane-downscale-with-pixel-format-factor-0-75: SUCCESS (5.258s)
[703.159760] Closing watchdogs
Done.