[61.543244] Initializing watchdogs
[61.543290]   /dev/watchdog0
[61.558494] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.562970] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.566126] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.569409] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[61.684888] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[61.689240] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[61.764337] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[61.858103] Starting subtest: bo-too-small
[61.860383] Subtest bo-too-small: SUCCESS (0.000s)
[61.955947] [003/133] (960s left) syncobj_basic (bad-destroy-pad)
[62.004915] Starting subtest: bad-destroy-pad
[62.006939] Subtest bad-destroy-pad: SUCCESS (0.000s)
[62.089648] [004/133] (960s left) kms_pm_backlight (basic-brightness)
[62.184818] Starting subtest: basic-brightness
[62.275953] Starting dynamic subtest: eDP-1
[62.573637] Dynamic subtest eDP-1: SUCCESS (0.297s)
[62.575810] Subtest basic-brightness: SUCCESS (0.390s)
[63.435953] [005/133] (958s left) prime_mmap_kms (buffer-sharing)
[63.534395] Starting subtest: buffer-sharing
[63.976068] Subtest buffer-sharing: SUCCESS (0.444s)
[64.774855] [006/133] (957s left) kms_dsc (dsc-with-bpc-formats)
[64.867476] Starting subtest: dsc-with-bpc-formats
[64.983108] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[65.019507] [007/133] (957s left) gem_pread (snoop)
[65.089271] Subtest snoop: SKIP (0.000s)
[65.158797] [008/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[65.260272] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[65.262540] Starting dynamic subtest: pipe-A
[65.632112] Dynamic subtest pipe-A: SUCCESS (0.375s)
[65.640783] Starting dynamic subtest: pipe-B
[67.086967] Dynamic subtest pipe-B: SUCCESS (1.458s)
[67.098563] Starting dynamic subtest: pipe-C
[68.502437] Dynamic subtest pipe-C: SUCCESS (1.418s)
[68.511570] Starting dynamic subtest: pipe-D
[69.908442] Dynamic subtest pipe-D: SUCCESS (1.408s)
[69.910747] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.661s)
[71.088694] [009/133] (951s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[71.185844] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[71.190626] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[71.248467] [010/133] (951s left) gem_mmap_gtt (hang)
[71.309260] Subtest hang: SKIP (0.000s)
[71.369060] [011/133] (951s left) gem_exec_store (basic)
[71.436342] Starting subtest: basic
[71.553887] Subtest basic: SUCCESS (0.119s)
[71.742204] [012/133] (950s left) gem_ctx_exec (basic)
[71.801956] Starting subtest: basic
[71.807058] Subtest basic: SUCCESS (0.007s)
[71.922956] [013/133] (950s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[72.010286] Starting subtest: primary-4-tiled-reflect-x-180
[78.974359] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.972s)
[80.137026] [014/133] (942s left) gem_readwrite (read-write)
[80.193209] Subtest read-write: SKIP (0.000s)
[80.244575] [015/133] (942s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[80.339463] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[80.344036] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[80.400915] [016/133] (942s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[80.516756] Starting subtest: 2x-long-flip-vs-cursor-atomic
[80.521142] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[80.657459] [017/133] (942s left) kms_psr (fbc-psr-cursor-blt)
[80.765815] Starting subtest: fbc-psr-cursor-blt
[80.768148] Starting dynamic subtest: eDP-1
[80.772335] Dynamic subtest eDP-1: SKIP (0.000s)
[80.776659] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[80.837059] [018/133] (941s left) gen9_exec_parse (bb-large)
[80.896830] Subtest bb-large: SKIP (0.000s)
[80.968206] [019/133] (941s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[81.051106] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[81.053472] Starting dynamic subtest: pipe-A-eDP-1
[81.878345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s)
[81.886200] Starting dynamic subtest: pipe-B-eDP-1
[83.474476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.592s)
[83.483041] Starting dynamic subtest: pipe-C-eDP-1
[84.976152] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[84.985841] Starting dynamic subtest: pipe-D-eDP-1
[86.511359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.532s)
[86.513321] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.450s)
[87.696276] [020/133] (935s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[87.805849] Starting subtest: fbc-tiling-linear
[91.506967] Subtest fbc-tiling-linear: SUCCESS (3.704s)
[92.694330] [021/133] (930s left) i915_drm_fdinfo (memory-info-shared)
[92.733614] Starting subtest: memory-info-shared
[92.735970] Starting dynamic subtest: smem0
[92.794918] Dynamic subtest smem0: SUCCESS (0.061s)
[92.797674] Subtest memory-info-shared: SUCCESS (0.062s)
[92.866914] [022/133] (929s left) gem_workarounds (reset-context)
[92.941885] Starting subtest: reset-context
[93.122655] Subtest reset-context: SUCCESS (0.181s)
[93.238939] [023/133] (929s left) i915_query (query-regions-garbage-items)
[93.299614] Starting subtest: query-regions-garbage-items
[93.301761] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[93.409440] [024/133] (929s left) kms_lease (lease-get)
[93.501797] Starting subtest: lease-get
[93.504114] Starting dynamic subtest: pipe-A-eDP-1
[93.506311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[93.514061] Starting dynamic subtest: pipe-B-eDP-1
[93.516327] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[93.523564] Starting dynamic subtest: pipe-C-eDP-1
[93.525769] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[93.533243] Starting dynamic subtest: pipe-D-eDP-1
[93.535448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[93.537673] Subtest lease-get: SUCCESS (0.007s)
[93.619202] [025/133] (929s left) gem_exec_balancer (bonded-sync)
[93.678310] Starting subtest: bonded-sync
[93.682035] Subtest bonded-sync: SKIP (0.000s)
[93.982510] [026/133] (929s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[94.025374] Starting subtest: etime-multi-wait-all-for-submit-submitted
[94.129506] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[94.217273] [027/133] (928s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[94.330145] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[94.334625] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[94.473950] [028/133] (928s left) kms_properties (connector-properties-atomic)
[94.570697] Starting subtest: connector-properties-atomic
[94.572992] Starting dynamic subtest: pipe-A-eDP-1
[102.356069] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.785s)
[102.365433] Starting dynamic subtest: pipe-None-DP-1
[102.369727] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[102.377421] Starting dynamic subtest: pipe-None-HDMI-A-1
[102.381843] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[102.389161] Starting dynamic subtest: pipe-None-DP-2
[102.393195] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[102.400039] Starting dynamic subtest: pipe-None-HDMI-A-2
[102.404106] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[102.410958] Starting dynamic subtest: pipe-None-DP-3
[102.415063] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[102.422424] Starting dynamic subtest: pipe-None-DP-4
[102.426927] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[102.429199] Subtest connector-properties-atomic: SUCCESS (7.795s)
[103.221732] [029/133] (919s left) kms_cursor_crc (cursor-random-256x85)
[103.481398] Starting subtest: cursor-random-256x85
[103.527086] Subtest cursor-random-256x85: SKIP (0.040s)
[103.701495] [030/133] (919s left) gem_close_race (multigpu-basic-process)
[103.762862] Starting subtest: multigpu-basic-process
[103.767313] Subtest multigpu-basic-process: SKIP (0.000s)
[103.996810] [031/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[104.089442] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[104.093638] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[104.190326] [032/133] (919s left) gem_pwrite (basic-self)
[104.248267] Subtest basic-self: SKIP (0.000s)
[104.299959] [033/133] (918s left) gem_exec_params (larger-than-life-batch)
[104.359878] Starting subtest: larger-than-life-batch
[106.553519] Subtest larger-than-life-batch: SUCCESS (2.194s)
[106.946923] [034/133] (916s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[107.041915] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[107.044262] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[107.147049] [035/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[107.263689] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[107.267822] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[107.354959] [036/133] (916s left) gem_exec_schedule (semaphore-noskip)
[107.433088] Starting subtest: semaphore-noskip
[107.885545] Subtest semaphore-noskip: SUCCESS (0.452s)
[108.219102] [037/133] (915s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[108.282131] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[108.341970] [038/133] (915s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[108.422520] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[108.424681] Starting dynamic subtest: pipe-A-eDP-1
[108.482970] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[108.493052] Starting dynamic subtest: pipe-B-eDP-1
[108.551264] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[108.560817] Starting dynamic subtest: pipe-C-eDP-1
[108.618430] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[108.629465] Starting dynamic subtest: pipe-D-eDP-1
[108.684791] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[108.689205] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[110.587026] [039/133] (912s left) kms_prop_blob (blob-multiple)
[110.645930] Starting subtest: blob-multiple
[110.648160] Subtest blob-multiple: SUCCESS (0.002s)
[110.740916] [040/133] (912s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[110.840421] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[110.844820] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[110.919463] [041/133] (912s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[111.012621] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[111.014736] Starting dynamic subtest: pipe-A-default-mode
[113.717372] Dynamic subtest pipe-A-default-mode: SUCCESS (2.703s)
[113.719730] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.704s)
[114.579195] [042/133] (909s left) kms_chamelium_frames (vga-frame-dump)
[114.967202] Subtest vga-frame-dump: SKIP (0.000s)
[115.797741] [043/133] (907s left) vgem_basic (create)
[115.916637] Starting subtest: create
[115.918988] Subtest create: SUCCESS (0.000s)
[115.982754] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[115.986260] [044/133] (907s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[116.052395] Starting subtest: wait-all-for-submit-delayed-submit
[116.155951] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[116.245274] [045/133] (907s left) gem_exec_params (sol-reset-invalid)
[116.303785] Starting subtest: sol-reset-invalid
[116.309081] Subtest sol-reset-invalid: SUCCESS (0.003s)
[117.990311] [046/133] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[118.089191] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[124.626239] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.540s)
[124.754972] [047/133] (899s left) kms_busy (basic-hang)
[124.848269] Starting subtest: basic-hang
[124.850820] Starting dynamic subtest: flip-pipe-A
[125.451143] Dynamic subtest flip-pipe-A: SUCCESS (0.603s)
[125.463584] Starting dynamic subtest: modeset-pipe-A
[128.862709] Dynamic subtest modeset-pipe-A: SUCCESS (3.409s)
[128.871263] Starting dynamic subtest: flip-pipe-D
[130.057504] Dynamic subtest flip-pipe-D: SUCCESS (1.191s)
[130.066885] Starting dynamic subtest: modeset-pipe-D
[133.480645] Dynamic subtest modeset-pipe-D: SUCCESS (3.425s)
[133.483128] Subtest basic-hang: SUCCESS (8.635s)
[134.303637] [048/133] (889s left) kms_plane_multiple (2x-tiling-4)
[134.394861] Starting subtest: 2x-tiling-4
[134.399214] Subtest 2x-tiling-4: SKIP (0.000s)
[134.469933] [049/133] (889s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[134.570855] Starting subtest: x-tiled-64bpp-rotate-180
[136.154782] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.583s)
[136.300836] [050/133] (887s left) i915_pm_freq_api (freq-suspend)
[136.360018] Starting subtest: freq-suspend
[136.362260] Starting dynamic subtest: gt0
[153.394021] Dynamic subtest gt0: SUCCESS (1.388s)
[153.403807] Starting dynamic subtest: gt1
[169.367556] Dynamic subtest gt1: SUCCESS (1.211s)
[169.371883] Subtest freq-suspend: SUCCESS (2.602s)
[170.446176] [051/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[170.560524] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[170.564592] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[170.648484] [052/133] (854s left) sw_sync (alloc_merge_fence)
[170.685318] Starting subtest: alloc_merge_fence
[170.687550] Subtest alloc_merge_fence: SUCCESS (0.000s)
[170.742292] [053/133] (854s left) gem_exec_fence (submit3)
[170.908287] Starting subtest: submit3
[170.912827] Subtest submit3: SKIP (0.000s)
[172.372902] [054/133] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[172.469279] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[176.783063] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.412s)
[177.937393] [055/133] (847s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[178.024665] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[178.027007] Starting dynamic subtest: pipe-A-eDP-1
[178.050181] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[178.060063] Starting dynamic subtest: pipe-B-eDP-1
[178.081235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[178.090169] Starting dynamic subtest: pipe-C-eDP-1
[178.110658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[178.118866] Starting dynamic subtest: pipe-D-eDP-1
[178.139754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[178.144061] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[180.255283] [056/133] (844s left) gem_ctx_param (invalid-ctx-set)
[180.311346] Starting subtest: invalid-ctx-set
[180.313745] Subtest invalid-ctx-set: SUCCESS (0.001s)
[180.421961] [057/133] (844s left) sw_sync (sync_multi_timeline_wait)
[180.461236] Starting subtest: sync_multi_timeline_wait
[180.463436] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[180.517533] [058/133] (844s left) dumb_buffer (invalid-bpp)
[180.576695] Starting subtest: invalid-bpp
[180.578970] Subtest invalid-bpp: SUCCESS (0.000s)
[180.658102] [059/133] (844s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[180.755397] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[180.759604] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[180.861101] [060/133] (844s left) gem_fence_thrash (bo-write-verify-threaded-y)
[180.901697] Starting subtest: bo-write-verify-threaded-y
[180.929041] Subtest bo-write-verify-threaded-y: SKIP (0.024s)
[180.991929] [061/133] (844s left) kms_flip (absolute-wf_vblank-interruptible)
[181.077340] Starting subtest: absolute-wf_vblank-interruptible
[181.079680] Starting dynamic subtest: A-eDP1
[189.754963] Dynamic subtest A-eDP1: SUCCESS (8.726s)
[189.766515] Starting dynamic subtest: B-eDP1
[198.471932] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[198.482125] Starting dynamic subtest: C-eDP1
[207.188742] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[207.199357] Starting dynamic subtest: D-eDP1
[215.924615] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[215.929897] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.923s)
[217.142242] [062/133] (808s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[217.254984] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[217.257167] Starting dynamic subtest: pipe-A-eDP-1
[217.265894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[217.275054] Starting dynamic subtest: pipe-B-eDP-1
[217.283885] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[217.292761] Starting dynamic subtest: pipe-C-eDP-1
[217.301215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[217.309880] Starting dynamic subtest: pipe-D-eDP-1
[217.318196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[217.322243] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[219.501693] [063/133] (806s left) kms_psr (psr2-cursor-mmap-gtt)
[219.595968] Starting subtest: psr2-cursor-mmap-gtt
[219.598071] Starting dynamic subtest: eDP-1
[221.285882] Dynamic subtest eDP-1: SUCCESS (1.689s)
[221.288298] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.690s)
[222.080989] [064/133] (803s left) kms_big_fb (linear-8bpp-rotate-0)
[222.177604] Starting subtest: linear-8bpp-rotate-0
[223.460542] Subtest linear-8bpp-rotate-0: SUCCESS (1.283s)
[223.573499] [065/133] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[223.676388] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[230.773750] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.101s)
[230.899335] [066/133] (794s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[231.004077] Starting subtest: 2x-plain-flip-ts-check-interruptible
[231.016753] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[231.092047] [067/133] (794s left) kms_vblank (ts-continuation-suspend)
[231.183770] Starting subtest: ts-continuation-suspend
[231.186036] Starting dynamic subtest: pipe-A-eDP-1
[247.663444] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.518s)
[247.678388] Starting dynamic subtest: pipe-D-eDP-1
[264.633833] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.193s)
[264.636599] Subtest ts-continuation-suspend: SUCCESS (3.715s)
[265.423292] [068/133] (760s left) gem_exec_schedule (preempt-hang)
[265.597580] Starting subtest: preempt-hang
[265.601638] Starting dynamic subtest: rcs0
[265.829629] Dynamic subtest rcs0: SUCCESS (0.238s)
[265.838418] Starting dynamic subtest: bcs0
[266.048849] Dynamic subtest bcs0: SUCCESS (0.226s)
[266.058548] Starting dynamic subtest: vcs0
[266.266715] Dynamic subtest vcs0: SUCCESS (0.225s)
[266.275847] Starting dynamic subtest: vcs1
[266.490321] Dynamic subtest vcs1: SUCCESS (0.229s)
[266.501154] Starting dynamic subtest: vecs0
[266.709190] Dynamic subtest vecs0: SUCCESS (0.225s)
[266.718120] Starting dynamic subtest: ccs0
[266.930366] Dynamic subtest ccs0: SUCCESS (0.227s)
[266.932556] Subtest preempt-hang: SUCCESS (1.375s)
[268.208116] [069/133] (757s left) i915_pm_rc6_residency (rc6-fence)
[268.260351] Starting subtest: rc6-fence
[268.292868] Starting dynamic subtest: gt0
[280.620196] Dynamic subtest gt0: SUCCESS (12.478s)
[280.632882] Starting dynamic subtest: gt1
[295.113602] Dynamic subtest gt1: SUCCESS (14.524s)
[295.116514] Subtest rc6-fence: SUCCESS (27.043s)
[295.192658] [070/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[295.295452] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[295.300131] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[295.378833] [071/133] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[295.475592] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[295.479969] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[295.578388] [072/133] (730s left) kms_cdclk (mode-transition)
[295.674780] Starting subtest: mode-transition
[295.677553] Starting dynamic subtest: pipe-A-eDP-1
[295.971711] Dynamic subtest pipe-A-eDP-1: SKIP (0.295s)
[295.981316] Starting dynamic subtest: pipe-B-eDP-1
[295.986015] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[295.994833] Starting dynamic subtest: pipe-C-eDP-1
[295.999587] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[296.009083] Starting dynamic subtest: pipe-D-eDP-1
[296.013726] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[296.018642] Subtest mode-transition: SKIP (0.303s)
[296.785716] [073/133] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[296.881566] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[300.456705] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.574s)
[301.588370] [074/133] (724s left) gem_ctx_isolation (nonpriv)
[301.647610] Starting subtest: nonpriv
[301.650019] Starting dynamic subtest: rcs0
[301.874835] Dynamic subtest rcs0: SUCCESS (0.227s)
[301.886577] Starting dynamic subtest: bcs0
[302.120744] Dynamic subtest bcs0: SUCCESS (0.245s)
[302.131111] Starting dynamic subtest: vcs0
[302.386880] Dynamic subtest vcs0: SUCCESS (0.264s)
[302.397703] Starting dynamic subtest: vcs1
[304.398278] Dynamic subtest vcs1: SUCCESS (2.009s)
[304.410695] Starting dynamic subtest: vecs0
[306.382995] Dynamic subtest vecs0: SUCCESS (1.982s)
[306.394100] Starting dynamic subtest: ccs0
[308.380784] Dynamic subtest ccs0: SUCCESS (1.995s)
[308.383830] Subtest nonpriv: SUCCESS (6.728s)
[308.640561] [075/133] (717s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[308.701461] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[308.704766] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[308.838352] [076/133] (717s left) kms_psr (pr-suspend)
[308.945553] Starting subtest: pr-suspend
[308.950644] Subtest pr-suspend: SKIP (0.000s)
[309.021329] [077/133] (717s left) kms_plane_scaling (2x-scaler-multi-pipe)
[309.111174] Starting subtest: 2x-scaler-multi-pipe
[309.116254] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[309.205464] [078/133] (716s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[309.302698] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[309.676685] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[312.457366] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.779s)
[312.470110] Starting dynamic subtest: pipe-A-eDP-1-4
[314.642517] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.183s)
[314.655136] Starting dynamic subtest: pipe-A-eDP-1-4
[316.651865] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[316.662103] Starting dynamic subtest: pipe-A-eDP-1-x
[318.843064] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[319.233201] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[321.989618] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[322.003516] Starting dynamic subtest: pipe-B-eDP-1-4
[324.175861] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[324.188891] Starting dynamic subtest: pipe-B-eDP-1-4
[326.185643] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[326.198853] Starting dynamic subtest: pipe-B-eDP-1-x
[328.431197] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.244s)
[328.812526] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[331.527073] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.722s)
[331.539469] Starting dynamic subtest: pipe-C-eDP-1-4
[333.702444] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[333.713677] Starting dynamic subtest: pipe-C-eDP-1-4
[335.713181] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[335.724912] Starting dynamic subtest: pipe-C-eDP-1-x
[337.901158] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[338.267463] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[341.056746] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[341.066864] Starting dynamic subtest: pipe-D-eDP-1-4
[343.253799] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.195s)
[343.270524] Starting dynamic subtest: pipe-D-eDP-1-4
[345.263560] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[345.279182] Starting dynamic subtest: pipe-D-eDP-1-x
[347.464144] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.199s)
[347.466839] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.162s)
[348.638000] [079/133] (677s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[348.707850] Starting subtest: y-tiled-ccs-to-x-tiled
[348.713656] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[348.905607] [080/133] (677s left) kms_flip (modeset-vs-vblank-race-interruptible)
[349.003375] Starting subtest: modeset-vs-vblank-race-interruptible
[349.006174] Starting dynamic subtest: A-eDP1
[353.651202] Dynamic subtest A-eDP1: SUCCESS (4.649s)
[353.668429] Starting dynamic subtest: B-eDP1
[358.322843] Dynamic subtest B-eDP1: SUCCESS (4.669s)
[358.335298] Starting dynamic subtest: C-eDP1
[362.931235] Dynamic subtest C-eDP1: SUCCESS (4.605s)
[362.941066] Starting dynamic subtest: D-eDP1
[367.473381] Dynamic subtest D-eDP1: SUCCESS (4.540s)
[367.475861] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.473s)
[368.648331] [081/133] (657s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[368.707775] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[368.713495] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[368.894187] [082/133] (657s left) perf_pmu (semaphore-busy)
[368.934680] Starting subtest: semaphore-busy
[368.937572] Starting dynamic subtest: rcs0
[370.567722] Dynamic subtest rcs0: SUCCESS (1.629s)
[370.578477] Starting dynamic subtest: bcs0
[372.202375] Dynamic subtest bcs0: SUCCESS (1.631s)
[372.212773] Starting dynamic subtest: vcs0
[376.644610] Dynamic subtest vcs0: SUCCESS (4.439s)
[376.657160] Starting dynamic subtest: vcs1
[382.661550] Dynamic subtest vcs1: SUCCESS (6.013s)
[382.673828] Starting dynamic subtest: vecs0
[388.613575] Dynamic subtest vecs0: SUCCESS (5.948s)
[388.625821] Starting dynamic subtest: ccs0
[391.752439] Dynamic subtest ccs0: SUCCESS (3.136s)
[391.755402] Subtest semaphore-busy: SUCCESS (22.813s)
[391.866245] [083/133] (634s left) kms_joiner (basic-max-non-joiner)
[391.980712] Starting subtest: basic-max-non-joiner
[391.985843] Subtest basic-max-non-joiner: SKIP (0.000s)
[392.048513] [084/133] (634s left) gem_eio (wait-wedge-immediate)
[392.232141] Starting subtest: wait-wedge-immediate
[394.181387] Subtest wait-wedge-immediate: SUCCESS (1.949s)
[394.309669] [085/133] (632s left) kms_flip (flip-vs-dpms-on-nop)
[394.397687] Starting subtest: flip-vs-dpms-on-nop
[394.400136] Starting dynamic subtest: A-eDP1
[396.229847] Dynamic subtest A-eDP1: SUCCESS (1.831s)
[396.242600] Starting dynamic subtest: B-eDP1
[398.061537] Dynamic subtest B-eDP1: SUCCESS (1.830s)
[398.071626] Starting dynamic subtest: C-eDP1
[399.887144] Dynamic subtest C-eDP1: SUCCESS (1.823s)
[399.897350] Starting dynamic subtest: D-eDP1
[401.719842] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[401.722638] Subtest flip-vs-dpms-on-nop: SUCCESS (7.326s)
[402.909095] [086/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[403.000675] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[403.005675] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[403.098376] [087/133] (623s left) gem_vm_create (invalid-create)
[403.153465] Starting subtest: invalid-create
[403.156084] Subtest invalid-create: SUCCESS (0.001s)
[403.249578] [088/133] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[403.343521] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[410.525724] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.186s)
[410.649238] [089/133] (615s left) gem_fence_thrash (bo-copy)
[410.692261] Starting subtest: bo-copy
[410.717663] Subtest bo-copy: SKIP (0.022s)
[410.773942] [090/133] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[410.865886] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[418.132564] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.270s)
[418.246271] [091/133] (608s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[418.357854] Starting subtest: short-busy-flip-before-cursor-toggle
[418.362464] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[418.503209] [092/133] (608s left) gem_caching (writes)
[418.567647] Subtest writes: SKIP (0.000s)
[418.641022] [093/133] (608s left) gem_exec_whisper (basic-queues-forked-all)
[418.700481] Starting subtest: basic-queues-forked-all
[442.382868] Subtest basic-queues-forked-all: SUCCESS (23.682s)
[442.563981] [094/133] (584s left) syncobj_wait (wait-for-submit-delayed-submit)
[442.623767] Starting subtest: wait-for-submit-delayed-submit
[442.724830] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[442.808012] [095/133] (584s left) api_intel_allocator (reserve-simple)
[442.859850] Starting subtest: reserve-simple
[442.862406] Subtest reserve-simple: SUCCESS (0.005s)
[442.985067] [096/133] (583s left) gem_exec_balancer (parallel-out-fence)
[443.239449] Starting subtest: parallel-out-fence
[444.640377] Subtest parallel-out-fence: SUCCESS (1.401s)
[444.751079] [097/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[444.843649] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[444.848860] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[444.939487] [098/133] (582s left) kms_pm_dc (dc5-dpms)
[446.041370] Starting subtest: dc5-dpms
[448.106231] Subtest dc5-dpms: SUCCESS (2.063s)
[448.183532] [099/133] (578s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[448.281707] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[448.286830] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[448.380387] [100/133] (578s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[448.476629] Starting subtest: 4-tiled-64bpp-rotate-0
[449.966269] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.490s)
[450.143084] [101/133] (576s left) syncobj_basic (bad-handle-to-fd)
[450.198755] Starting subtest: bad-handle-to-fd
[450.201579] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[450.314430] [102/133] (576s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[450.421576] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[450.425986] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[450.493354] [103/133] (576s left) gem_ctx_persistence (legacy-engines-hostile)
[450.549360] Starting subtest: legacy-engines-hostile
[450.551699] Starting dynamic subtest: render
[450.631698] Dynamic subtest render: SUCCESS (0.082s)
[450.645882] Starting dynamic subtest: bsd1
[450.729032] Dynamic subtest bsd1: SUCCESS (0.094s)
[450.742666] Starting dynamic subtest: bsd2
[450.829040] Dynamic subtest bsd2: SUCCESS (0.097s)
[450.841884] Starting dynamic subtest: blt
[450.923265] Dynamic subtest blt: SUCCESS (0.091s)
[450.935861] Starting dynamic subtest: vebox
[451.016755] Dynamic subtest vebox: SUCCESS (0.091s)
[451.019443] Subtest legacy-engines-hostile: SUCCESS (0.469s)
[451.097739] [104/133] (576s left) kms_atomic_interruptible (universal-setplane-primary)
[451.192545] Starting subtest: universal-setplane-primary
[451.194569] Starting dynamic subtest: pipe-A-eDP-1
[458.592151] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.399s)
[458.595105] Subtest universal-setplane-primary: SUCCESS (7.400s)
[459.426978] [105/133] (567s left) kms_cursor_crc (cursor-offscreen-256x256)
[459.669390] Starting subtest: cursor-offscreen-256x256
[459.671989] Starting dynamic subtest: pipe-A-eDP-1
[461.620497] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[461.651531] Starting dynamic subtest: pipe-D-eDP-1
[464.222847] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.578s)
[464.225223] Subtest cursor-offscreen-256x256: SUCCESS (4.555s)
[465.074585] [106/133] (562s left) gem_mmap_gtt (pf-nonblock)
[465.127131] Subtest pf-nonblock: SKIP (0.000s)
[465.191066] [107/133] (562s left) kms_chamelium_color (gamma)
[465.285425] Subtest gamma: SKIP (0.000s)
[465.333087] [108/133] (562s left) gem_ccs (block-copy-uncompressed)
[465.383376] Starting subtest: block-copy-uncompressed
[465.385986] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[465.404955] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[465.416850] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[465.422168] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[465.432075] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[465.438340] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[465.448737] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[465.456248] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[465.458906] Subtest block-copy-uncompressed: SUCCESS (0.073s)
[465.581964] [109/133] (561s left) gem_softpin (evict-active-interruptible)
[465.643303] Starting subtest: evict-active-interruptible
[465.649713] Subtest evict-active-interruptible: SUCCESS (0.006s)
[465.771335] [110/133] (561s left) sw_sync (sync_multi_consumer)
[465.811538] Starting subtest: sync_multi_consumer
[466.364224] Subtest sync_multi_consumer: SUCCESS (0.561s)
[466.427312] [111/133] (561s left) kms_cursor_crc (cursor-sliding-256x85)
[466.679781] Starting subtest: cursor-sliding-256x85
[466.735100] Subtest cursor-sliding-256x85: SKIP (0.048s)
[466.895498] [112/133] (560s left) gem_ctx_sseu (mmap-args)
[466.951541] Subtest mmap-args: SKIP (0.000s)
[467.033317] [113/133] (560s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[467.131114] Starting subtest: yf-tiled-32bpp-rotate-270
[467.136333] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[467.226434] [114/133] (560s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[467.319464] Starting subtest: yf-tiled-64bpp-rotate-180
[467.324434] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[467.423659] [115/133] (560s left) kms_atomic_transition (plane-toggle-modeset-transition)
[467.507498] Starting subtest: plane-toggle-modeset-transition
[467.509665] Starting dynamic subtest: pipe-A-eDP-1
[480.224761] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.720s)
[480.236452] Starting dynamic subtest: pipe-B-eDP-1
[492.650763] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.421s)
[492.653570] Subtest plane-toggle-modeset-transition: SUCCESS (25.147s)
[493.468085] [116/133] (534s left) kms_content_protection (dp-mst-lic-type-0)
[493.609629] Starting subtest: dp-mst-lic-type-0
[493.614819] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[493.734868] [117/133] (534s left) kms_vrr (seamless-rr-switch-virtual)
[493.830525] Starting subtest: seamless-rr-switch-virtual
[493.837874] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[493.905748] [118/133] (533s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[493.999712] Starting subtest: stress-xrgb8888-xtiled
[499.928383] Subtest stress-xrgb8888-xtiled: SUCCESS (5.930s)
[499.986522] [119/133] (527s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[500.102544] Starting subtest: protected-encrypted-src-copy-not-readible
[500.216333] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s)
[500.332338] [120/133] (527s left) prime_busy (before)
[500.389034] Starting subtest: before
[500.391558] Starting dynamic subtest: rcs0
[500.420385] Dynamic subtest rcs0: SUCCESS (0.031s)
[500.431865] Starting dynamic subtest: bcs0
[500.460533] Dynamic subtest bcs0: SUCCESS (0.039s)
[500.470609] Starting dynamic subtest: vcs0
[500.500893] Dynamic subtest vcs0: SUCCESS (0.039s)
[500.523378] Starting dynamic subtest: vcs1
[500.541834] Dynamic subtest vcs1: SUCCESS (0.040s)
[500.554770] Starting dynamic subtest: vecs0
[500.583890] Dynamic subtest vecs0: SUCCESS (0.042s)
[500.594876] Starting dynamic subtest: ccs0
[500.626870] Dynamic subtest ccs0: SUCCESS (0.042s)
[500.735826] Subtest before: SUCCESS (0.347s)
[500.814182] [121/133] (527s left) kms_psr (fbc-psr2-cursor-render)
[500.912753] Starting subtest: fbc-psr2-cursor-render
[500.915116] Starting dynamic subtest: eDP-1
[500.919612] Dynamic subtest eDP-1: SKIP (0.000s)
[500.925892] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[500.986412] [122/133] (527s left) kms_async_flips (test-cursor-atomic)
[501.071873] Starting subtest: test-cursor-atomic
[501.076861] Subtest test-cursor-atomic: SKIP (0.000s)
[502.301236] [123/133] (525s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[502.397622] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[502.402846] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[502.492240] [124/133] (525s left) sysfs_timeslice_duration (idempotent)
[502.554468] Starting subtest: idempotent
[502.557002] Starting dynamic subtest: vecs0
[502.559626] Dynamic subtest vecs0: SUCCESS (0.000s)
[502.571021] Starting dynamic subtest: ccs0
[502.573724] Dynamic subtest ccs0: SUCCESS (0.000s)
[502.584762] Starting dynamic subtest: vcs0
[502.587115] Dynamic subtest vcs0: SUCCESS (0.000s)
[502.598188] Starting dynamic subtest: bcs0
[502.600425] Dynamic subtest bcs0: SUCCESS (0.000s)
[502.609856] Starting dynamic subtest: rcs0
[502.612233] Dynamic subtest rcs0: SUCCESS (0.000s)
[502.621603] Starting dynamic subtest: vcs1
[502.623822] Dynamic subtest vcs1: SUCCESS (0.000s)
[502.626196] Subtest idempotent: SUCCESS (0.006s)
[502.664622] [125/133] (525s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[502.752668] Starting subtest: primary-yf-tiled-reflect-x-90
[502.757706] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[502.824800] [126/133] (525s left) gem_softpin (evict-single-offset)
[502.884870] Starting subtest: evict-single-offset
[528.137637] Subtest evict-single-offset: SUCCESS (25.246s)
[528.226937] [127/133] (499s left) kms_psr (fbc-pr-cursor-plane-onoff)
[528.380783] Starting subtest: fbc-pr-cursor-plane-onoff
[528.386367] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[528.467853] [128/133] (499s left) kms_color (ctm-negative)
[528.575525] Starting subtest: ctm-negative
[528.577873] Starting dynamic subtest: pipe-A-eDP-1
[529.318125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[529.330641] Starting dynamic subtest: pipe-B-eDP-1
[530.727154] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[530.738365] Starting dynamic subtest: pipe-C-eDP-1
[532.093703] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[532.103689] Starting dynamic subtest: pipe-D-eDP-1
[533.416775] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[533.419838] Subtest ctm-negative: SUCCESS (4.842s)
[534.222208] [129/133] (494s left) kms_sequence (get-forked)
[534.319595] Starting subtest: get-forked
[534.321778] Starting dynamic subtest: pipe-A-eDP-1
[536.195980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[536.209578] Starting dynamic subtest: pipe-B-eDP-1
[538.774641] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.578s)
[538.785443] Starting dynamic subtest: pipe-C-eDP-1
[541.305493] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.528s)
[541.317310] Starting dynamic subtest: pipe-D-eDP-1
[543.837420] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.533s)
[543.840408] Subtest get-forked: SUCCESS (9.520s)
[544.656681] [130/133] (483s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[544.729664] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[544.732707] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[544.805088] [131/133] (483s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[544.904456] Starting subtest: y-tiled-64bpp-rotate-90
[544.909041] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[545.001740] [132/133] (483s left) syncobj_wait (reset-multiple-signaled)
[545.063869] Starting subtest: reset-multiple-signaled
[545.066636] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[545.164137] [133/133] (483s left) core_auth (getclient-master-drop)
[545.201852] Starting subtest: getclient-master-drop
[545.222703] Subtest getclient-master-drop: SUCCESS (0.021s)
[545.339284] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: syncobj_basic
results: parsing output: 3/ for test: kms_pm_backlight
results: parsing output: 4/ for test: prime_mmap_kms
results: parsing output: 5/ for test: kms_dsc
results: parsing output: 6/ for test: gem_pread
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: gem_exec_store
results: parsing output: 11/ for test: gem_ctx_exec
results: parsing output: 12/ for test: kms_rotation_crc
results: parsing output: 13/ for test: gem_readwrite
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: gem_workarounds
results: parsing output: 22/ for test: i915_query
results: parsing output: 23/ for test: kms_lease
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: gem_close_race
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_pwrite
results: parsing output: 32/ for test: gem_exec_params
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_prop_blob
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: vgem_basic
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_busy
results: parsing output: 47/ for test: kms_plane_multiple
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_pm_freq_api
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_ctx_param
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: dumb_buffer
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_fence_thrash
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_vblank
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: i915_pm_rc6_residency
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_cdclk
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_ctx_isolation
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: kms_joiner
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_fence_thrash
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_caching
results: parsing output: 92/ for test: gem_exec_whisper
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_pm_dc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_atomic_interruptible
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_chamelium_color
results: parsing output: 107/ for test: gem_ccs
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_ctx_sseu
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_atomic_transition
results: parsing output: 115/ for test: kms_content_protection
results: parsing output: 116/ for test: kms_vrr
results: parsing output: 117/ for test: kms_pipe_stress
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_color
results: parsing output: 128/ for test: kms_sequence
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: core_auth
Done.