[57.023555] Initializing watchdogs
[57.023605]   /dev/watchdog0
[57.040510] [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]
[57.045372] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.047695] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.051497] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[57.166718] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[57.170730] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[57.276891] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[57.385598] Starting subtest: bo-too-small
[57.387869] Subtest bo-too-small: SUCCESS (0.000s)
[57.479268] [003/133] (960s left) syncobj_basic (bad-destroy-pad)
[57.536984] Starting subtest: bad-destroy-pad
[57.538907] Subtest bad-destroy-pad: SUCCESS (0.000s)
[57.645607] [004/133] (960s left) kms_pm_backlight (basic-brightness)
[57.739128] Starting subtest: basic-brightness
[57.829014] Starting dynamic subtest: eDP-1
[58.126923] Dynamic subtest eDP-1: SUCCESS (0.296s)
[58.129344] Subtest basic-brightness: SUCCESS (0.389s)
[58.922048] [005/133] (958s left) prime_mmap_kms (buffer-sharing)
[59.021302] Starting subtest: buffer-sharing
[59.467587] Subtest buffer-sharing: SUCCESS (0.446s)
[60.335853] [006/133] (957s left) kms_dsc (dsc-with-bpc-formats)
[60.441555] Starting subtest: dsc-with-bpc-formats
[60.555479] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[60.592648] [007/133] (957s left) gem_pread (snoop)
[60.650213] Subtest snoop: SKIP (0.000s)
[60.711161] [008/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[60.805029] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[60.807301] Starting dynamic subtest: pipe-A
[61.179636] Dynamic subtest pipe-A: SUCCESS (0.375s)
[61.188374] Starting dynamic subtest: pipe-B
[62.628178] Dynamic subtest pipe-B: SUCCESS (1.450s)
[62.636665] Starting dynamic subtest: pipe-C
[64.090720] Dynamic subtest pipe-C: SUCCESS (1.463s)
[64.099692] Starting dynamic subtest: pipe-D
[65.515426] Dynamic subtest pipe-D: SUCCESS (1.425s)
[65.517816] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.714s)
[66.676394] [009/133] (951s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[66.801811] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[66.805759] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[66.942403] [010/133] (951s left) gem_mmap_gtt (hang)
[67.122555] Subtest hang: SKIP (0.000s)
[67.287711] [011/133] (950s left) gem_exec_store (basic)
[67.491894] Starting subtest: basic
[67.723259] Subtest basic: SUCCESS (0.232s)
[67.919524] [012/133] (950s left) gem_ctx_exec (basic)
[68.038337] Starting subtest: basic
[68.045116] Subtest basic: SUCCESS (0.007s)
[68.159905] [013/133] (949s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[68.245382] Starting subtest: primary-4-tiled-reflect-x-180
[75.201573] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.959s)
[76.443906] [014/133] (941s left) gem_readwrite (read-write)
[76.506216] Subtest read-write: SKIP (0.000s)
[76.561054] [015/133] (941s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[76.657728] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[76.662308] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[76.738929] [016/133] (941s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[76.866285] Starting subtest: 2x-long-flip-vs-cursor-atomic
[76.871194] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[77.022769] [017/133] (941s left) kms_psr (fbc-psr-cursor-blt)
[77.113702] Starting subtest: fbc-psr-cursor-blt
[77.116056] Starting dynamic subtest: eDP-1
[77.120367] Dynamic subtest eDP-1: SKIP (0.000s)
[77.124770] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[77.183985] [018/133] (941s left) gen9_exec_parse (bb-large)
[77.246529] Subtest bb-large: SKIP (0.000s)
[77.316504] [019/133] (941s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[77.405220] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[77.407038] Starting dynamic subtest: pipe-A-eDP-1
[78.295883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.884s)
[78.305465] Starting dynamic subtest: pipe-B-eDP-1
[79.891595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.592s)
[79.900461] Starting dynamic subtest: pipe-C-eDP-1
[81.401677] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s)
[81.410808] Starting dynamic subtest: pipe-D-eDP-1
[82.901203] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.499s)
[82.903496] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.487s)
[84.062700] [020/133] (934s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[84.160673] Starting subtest: fbc-tiling-linear
[88.141994] Subtest fbc-tiling-linear: SUCCESS (3.987s)
[89.291286] [021/133] (929s left) i915_drm_fdinfo (memory-info-shared)
[89.333257] Starting subtest: memory-info-shared
[89.335652] Starting dynamic subtest: smem0
[89.388598] Dynamic subtest smem0: SUCCESS (0.058s)
[89.391433] Subtest memory-info-shared: SUCCESS (0.058s)
[89.461771] [022/133] (928s left) gem_workarounds (reset-context)
[89.519776] Starting subtest: reset-context
[89.710797] Subtest reset-context: SUCCESS (0.191s)
[89.825441] [023/133] (928s left) i915_query (query-regions-garbage-items)
[89.888037] Starting subtest: query-regions-garbage-items
[89.890457] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[89.997450] [024/133] (928s left) kms_lease (lease-get)
[90.086129] Starting subtest: lease-get
[90.088412] Starting dynamic subtest: pipe-A-eDP-1
[90.090613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[90.100383] Starting dynamic subtest: pipe-B-eDP-1
[90.102572] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[90.110575] Starting dynamic subtest: pipe-C-eDP-1
[90.112698] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[90.120713] Starting dynamic subtest: pipe-D-eDP-1
[90.122837] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[90.124944] Subtest lease-get: SUCCESS (0.008s)
[90.191279] [025/133] (928s left) gem_exec_balancer (bonded-sync)
[90.255369] Starting subtest: bonded-sync
[90.258870] Subtest bonded-sync: SKIP (0.000s)
[90.588950] [026/133] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[90.658248] Starting subtest: etime-multi-wait-all-for-submit-submitted
[90.760818] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[90.839848] [027/133] (927s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[90.972039] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[90.976420] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[91.112878] [028/133] (927s left) kms_properties (connector-properties-atomic)
[91.208360] Starting subtest: connector-properties-atomic
[91.210536] Starting dynamic subtest: pipe-A-eDP-1
[99.096337] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.887s)
[99.105083] Starting dynamic subtest: pipe-None-DP-1
[99.109620] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[99.117216] Starting dynamic subtest: pipe-None-HDMI-A-1
[99.121299] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[99.129195] Starting dynamic subtest: pipe-None-DP-2
[99.133509] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[99.141370] Starting dynamic subtest: pipe-None-HDMI-A-2
[99.145744] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[99.153591] Starting dynamic subtest: pipe-None-DP-3
[99.158218] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[99.166119] Starting dynamic subtest: pipe-None-DP-4
[99.170728] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[99.173047] Subtest connector-properties-atomic: SUCCESS (7.897s)
[99.965824] [029/133] (918s left) kms_cursor_crc (cursor-random-256x85)
[100.226560] Starting subtest: cursor-random-256x85
[100.272827] Subtest cursor-random-256x85: SKIP (0.042s)
[100.451732] [030/133] (918s left) gem_close_race (multigpu-basic-process)
[100.523702] Starting subtest: multigpu-basic-process
[100.527801] Subtest multigpu-basic-process: SKIP (0.000s)
[100.736954] [031/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[100.846822] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[100.851320] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.939146] [032/133] (917s left) gem_pwrite (basic-self)
[100.999589] Subtest basic-self: SKIP (0.000s)
[101.065872] [033/133] (917s left) gem_exec_params (larger-than-life-batch)
[101.115747] Starting subtest: larger-than-life-batch
[103.383051] Subtest larger-than-life-batch: SUCCESS (2.266s)
[103.938877] [034/133] (914s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[104.033468] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[104.035959] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[104.104799] [035/133] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[104.205376] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[104.209736] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[104.303622] [036/133] (914s left) gem_exec_schedule (semaphore-noskip)
[104.375229] Starting subtest: semaphore-noskip
[104.795887] Subtest semaphore-noskip: SUCCESS (0.427s)
[105.166284] [037/133] (913s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[105.233305] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[105.291243] [038/133] (913s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[105.379354] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[105.381556] Starting dynamic subtest: pipe-A-eDP-1
[105.436583] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[105.447770] Starting dynamic subtest: pipe-B-eDP-1
[105.503562] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[105.513054] Starting dynamic subtest: pipe-C-eDP-1
[105.569025] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[105.578523] Starting dynamic subtest: pipe-D-eDP-1
[105.634800] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[105.639259] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.010s)
[107.623482] [039/133] (911s left) kms_prop_blob (blob-multiple)
[107.694472] Starting subtest: blob-multiple
[107.696818] Subtest blob-multiple: SUCCESS (0.002s)
[107.800889] [040/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[107.892025] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[107.896208] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[107.984885] [041/133] (911s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[108.077724] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[108.079971] Starting dynamic subtest: pipe-A-default-mode
[110.752382] Dynamic subtest pipe-A-default-mode: SUCCESS (2.675s)
[110.754750] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.677s)
[111.630831] [042/133] (907s left) kms_chamelium_frames (vga-frame-dump)
[112.023377] Subtest vga-frame-dump: SKIP (0.000s)
[112.822206] [043/133] (906s left) vgem_basic (create)
[112.928979] Starting subtest: create
[112.931181] Subtest create: SUCCESS (0.000s)
[112.985679] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[112.988943] [044/133] (906s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[113.050821] Starting subtest: wait-all-for-submit-delayed-submit
[113.153910] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[113.247441] [045/133] (906s left) gem_exec_params (sol-reset-invalid)
[113.298957] Starting subtest: sol-reset-invalid
[113.304353] Subtest sol-reset-invalid: SUCCESS (0.003s)
[114.977915] [046/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[115.077691] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[121.629187] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.555s)
[121.769240] [047/133] (897s left) kms_busy (basic-hang)
[121.870146] Starting subtest: basic-hang
[121.872500] Starting dynamic subtest: flip-pipe-A
[122.471651] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[122.480342] Starting dynamic subtest: modeset-pipe-A
[125.912721] Dynamic subtest modeset-pipe-A: SUCCESS (3.442s)
[125.923705] Starting dynamic subtest: flip-pipe-D
[127.120422] Dynamic subtest flip-pipe-D: SUCCESS (1.204s)
[127.129494] Starting dynamic subtest: modeset-pipe-D
[130.556888] Dynamic subtest modeset-pipe-D: SUCCESS (3.435s)
[130.559103] Subtest basic-hang: SUCCESS (8.689s)
[131.356806] [048/133] (888s left) kms_plane_multiple (2x-tiling-4)
[131.464512] Starting subtest: 2x-tiling-4
[131.468649] Subtest 2x-tiling-4: SKIP (0.000s)
[131.551570] [049/133] (887s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[131.655137] Starting subtest: x-tiled-64bpp-rotate-180
[133.200928] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.545s)
[133.403589] [050/133] (886s left) i915_pm_freq_api (freq-suspend)
[133.476895] Starting subtest: freq-suspend
[133.479177] Starting dynamic subtest: gt0
[150.295480] Dynamic subtest gt0: SUCCESS (1.579s)
[150.312429] Starting dynamic subtest: gt1
[166.088164] Dynamic subtest gt1: SUCCESS (1.224s)
[166.090205] Subtest freq-suspend: SUCCESS (2.805s)
[166.157168] [051/133] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[166.260394] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[166.264849] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[166.365406] [052/133] (853s left) sw_sync (alloc_merge_fence)
[166.406743] Starting subtest: alloc_merge_fence
[166.409044] Subtest alloc_merge_fence: SUCCESS (0.000s)
[166.459879] [053/133] (853s left) gem_exec_fence (submit3)
[166.642416] Starting subtest: submit3
[166.646847] Subtest submit3: SKIP (0.000s)
[168.760539] [054/133] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[168.882324] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[173.365356] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.507s)
[174.504244] [055/133] (845s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[174.600324] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[174.602606] Starting dynamic subtest: pipe-A-eDP-1
[174.626084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.640582] Starting dynamic subtest: pipe-B-eDP-1
[174.662139] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.671630] Starting dynamic subtest: pipe-C-eDP-1
[174.692548] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.701916] Starting dynamic subtest: pipe-D-eDP-1
[174.722854] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.726843] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[176.848140] [056/133] (843s left) gem_ctx_param (invalid-ctx-set)
[176.914415] Starting subtest: invalid-ctx-set
[176.916768] Subtest invalid-ctx-set: SUCCESS (0.001s)
[177.027660] [057/133] (842s left) sw_sync (sync_multi_timeline_wait)
[177.060180] Starting subtest: sync_multi_timeline_wait
[177.062578] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[177.127999] [058/133] (842s left) dumb_buffer (invalid-bpp)
[177.185627] Starting subtest: invalid-bpp
[177.187928] Subtest invalid-bpp: SUCCESS (0.000s)
[177.277308] [059/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[177.372042] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[177.376357] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[177.465065] [060/133] (842s left) gem_fence_thrash (bo-write-verify-threaded-y)
[177.504005] Starting subtest: bo-write-verify-threaded-y
[177.525883] Subtest bo-write-verify-threaded-y: SKIP (0.020s)
[177.582950] [061/133] (842s left) kms_flip (absolute-wf_vblank-interruptible)
[177.691246] Starting subtest: absolute-wf_vblank-interruptible
[177.696089] Starting dynamic subtest: A-eDP1
[186.394029] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[186.403325] Starting dynamic subtest: B-eDP1
[195.115954] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[195.127615] Starting dynamic subtest: C-eDP1
[203.824612] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[203.834164] Starting dynamic subtest: D-eDP1
[212.545773] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[212.551383] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.887s)
[213.764510] [062/133] (806s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[213.867383] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[213.869754] Starting dynamic subtest: pipe-A-eDP-1
[213.878811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.888548] Starting dynamic subtest: pipe-B-eDP-1
[213.897658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.906981] Starting dynamic subtest: pipe-C-eDP-1
[213.915426] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.924837] Starting dynamic subtest: pipe-D-eDP-1
[213.932919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.936943] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[216.115154] [063/133] (804s left) kms_psr (psr2-cursor-mmap-gtt)
[216.222912] Starting subtest: psr2-cursor-mmap-gtt
[216.225202] Starting dynamic subtest: eDP-1
[218.012680] Dynamic subtest eDP-1: SUCCESS (1.790s)
[218.015039] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.792s)
[218.905026] [064/133] (801s left) kms_big_fb (linear-8bpp-rotate-0)
[219.009471] Starting subtest: linear-8bpp-rotate-0
[220.225869] Subtest linear-8bpp-rotate-0: SUCCESS (1.215s)
[220.337836] [065/133] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[220.435312] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[227.515408] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.085s)
[227.654224] [066/133] (792s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[227.749944] Starting subtest: 2x-plain-flip-ts-check-interruptible
[227.762080] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[227.841519] [067/133] (792s left) kms_vblank (ts-continuation-suspend)
[227.944045] Starting subtest: ts-continuation-suspend
[227.945953] Starting dynamic subtest: pipe-A-eDP-1
[244.496797] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.681s)
[244.511713] Starting dynamic subtest: pipe-D-eDP-1
[261.353747] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.188s)
[261.355735] Subtest ts-continuation-suspend: SUCCESS (3.872s)
[262.152297] [068/133] (758s left) gem_exec_schedule (preempt-hang)
[262.340336] Starting subtest: preempt-hang
[262.342368] Starting dynamic subtest: rcs0
[262.583439] Dynamic subtest rcs0: SUCCESS (0.246s)
[262.592689] Starting dynamic subtest: bcs0
[262.821513] Dynamic subtest bcs0: SUCCESS (0.238s)
[262.832126] Starting dynamic subtest: vcs0
[263.048501] Dynamic subtest vcs0: SUCCESS (0.228s)
[263.058688] Starting dynamic subtest: vcs1
[263.272879] Dynamic subtest vcs1: SUCCESS (0.226s)
[263.282480] Starting dynamic subtest: vecs0
[263.501527] Dynamic subtest vecs0: SUCCESS (0.229s)
[263.512202] Starting dynamic subtest: ccs0
[263.743463] Dynamic subtest ccs0: SUCCESS (0.241s)
[263.745866] Subtest preempt-hang: SUCCESS (1.415s)
[264.341020] [069/133] (756s left) i915_pm_rc6_residency (rc6-fence)
[264.400831] Starting subtest: rc6-fence
[264.416805] Starting dynamic subtest: gt0
[276.733979] Dynamic subtest gt0: SUCCESS (12.349s)
[276.745907] Starting dynamic subtest: gt1
[291.168650] Dynamic subtest gt1: SUCCESS (14.443s)
[291.171825] Subtest rc6-fence: SUCCESS (26.815s)
[291.246677] [070/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[291.346408] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[291.350378] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[291.450168] [071/133] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[291.560498] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[291.564856] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[291.666897] [072/133] (728s left) kms_cdclk (mode-transition)
[291.772221] Starting subtest: mode-transition
[291.774482] Starting dynamic subtest: pipe-A-eDP-1
[292.065672] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s)
[292.078472] Starting dynamic subtest: pipe-B-eDP-1
[292.083112] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[292.093439] Starting dynamic subtest: pipe-C-eDP-1
[292.098217] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[292.108814] Starting dynamic subtest: pipe-D-eDP-1
[292.113313] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[292.117846] Subtest mode-transition: SKIP (0.300s)
[292.924753] [073/133] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[293.026861] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[296.595918] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.572s)
[297.726266] [074/133] (722s left) gem_ctx_isolation (nonpriv)
[297.793882] Starting subtest: nonpriv
[297.796069] Starting dynamic subtest: rcs0
[298.028491] Dynamic subtest rcs0: SUCCESS (0.234s)
[298.041003] Starting dynamic subtest: bcs0
[298.303040] Dynamic subtest bcs0: SUCCESS (0.274s)
[298.317631] Starting dynamic subtest: vcs0
[298.546530] Dynamic subtest vcs0: SUCCESS (0.242s)
[298.559909] Starting dynamic subtest: vcs1
[300.486633] Dynamic subtest vcs1: SUCCESS (1.938s)
[300.498484] Starting dynamic subtest: vecs0
[302.476312] Dynamic subtest vecs0: SUCCESS (1.988s)
[302.488548] Starting dynamic subtest: ccs0
[304.492568] Dynamic subtest ccs0: SUCCESS (2.014s)
[304.494981] Subtest nonpriv: SUCCESS (6.696s)
[304.737743] [075/133] (715s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[304.802645] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[304.805152] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[304.918964] [076/133] (715s left) kms_psr (pr-suspend)
[305.018249] Starting subtest: pr-suspend
[305.022650] Subtest pr-suspend: SKIP (0.000s)
[305.108500] [077/133] (715s left) kms_plane_scaling (2x-scaler-multi-pipe)
[305.202179] Starting subtest: 2x-scaler-multi-pipe
[305.206500] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[305.300131] [078/133] (715s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[305.403672] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[305.775337] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[308.588839] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.812s)
[308.599867] Starting dynamic subtest: pipe-A-eDP-1-4
[310.764343] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[310.776665] Starting dynamic subtest: pipe-A-eDP-1-4
[312.773722] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[312.792171] Starting dynamic subtest: pipe-A-eDP-1-x
[314.964856] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[315.337329] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[318.119776] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[318.131958] Starting dynamic subtest: pipe-B-eDP-1-4
[320.317184] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[320.329472] Starting dynamic subtest: pipe-B-eDP-1-4
[322.326780] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[322.339873] Starting dynamic subtest: pipe-B-eDP-1-x
[324.527227] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[324.896331] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[327.645902] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.756s)
[327.658829] Starting dynamic subtest: pipe-C-eDP-1-4
[329.819973] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[329.832548] Starting dynamic subtest: pipe-C-eDP-1-4
[331.829681] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[331.843803] Starting dynamic subtest: pipe-C-eDP-1-x
[334.019305] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[334.383879] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[337.169305] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[337.182049] Starting dynamic subtest: pipe-D-eDP-1-4
[339.343692] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[339.356340] Starting dynamic subtest: pipe-D-eDP-1-4
[341.353416] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[341.367078] Starting dynamic subtest: pipe-D-eDP-1-x
[343.531395] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[343.534199] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.134s)
[344.752524] [079/133] (676s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[344.825016] Starting subtest: y-tiled-ccs-to-x-tiled
[344.829675] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[345.012951] [080/133] (675s left) kms_flip (modeset-vs-vblank-race-interruptible)
[345.117109] Starting subtest: modeset-vs-vblank-race-interruptible
[345.119128] Starting dynamic subtest: A-eDP1
[349.768575] Dynamic subtest A-eDP1: SUCCESS (4.651s)
[349.783312] Starting dynamic subtest: B-eDP1
[354.503543] Dynamic subtest B-eDP1: SUCCESS (4.733s)
[354.516317] Starting dynamic subtest: C-eDP1
[358.961521] Dynamic subtest C-eDP1: SUCCESS (4.457s)
[358.974885] Starting dynamic subtest: D-eDP1
[363.504030] Dynamic subtest D-eDP1: SUCCESS (4.538s)
[363.509193] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.393s)
[364.670241] [081/133] (656s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[364.732848] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[364.737176] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[364.929176] [082/133] (656s left) perf_pmu (semaphore-busy)
[364.973308] Starting subtest: semaphore-busy
[364.975337] Starting dynamic subtest: rcs0
[366.618527] Dynamic subtest rcs0: SUCCESS (1.643s)
[366.630540] Starting dynamic subtest: bcs0
[368.254727] Dynamic subtest bcs0: SUCCESS (1.632s)
[368.265201] Starting dynamic subtest: vcs0
[372.760700] Dynamic subtest vcs0: SUCCESS (4.504s)
[372.773224] Starting dynamic subtest: vcs1
[378.780491] Dynamic subtest vcs1: SUCCESS (6.014s)
[378.792925] Starting dynamic subtest: vecs0
[384.732376] Dynamic subtest vecs0: SUCCESS (5.948s)
[384.743782] Starting dynamic subtest: ccs0
[387.868360] Dynamic subtest ccs0: SUCCESS (3.132s)
[387.870946] Subtest semaphore-busy: SUCCESS (22.891s)
[387.985600] [083/133] (633s left) kms_joiner (basic-max-non-joiner)
[388.094105] Starting subtest: basic-max-non-joiner
[388.098246] Subtest basic-max-non-joiner: SKIP (0.000s)
[388.177775] [084/133] (632s left) gem_eio (wait-wedge-immediate)
[388.352689] Starting subtest: wait-wedge-immediate
[390.293533] Subtest wait-wedge-immediate: SUCCESS (1.940s)
[390.439826] [085/133] (630s left) kms_flip (flip-vs-dpms-on-nop)
[390.530071] Starting subtest: flip-vs-dpms-on-nop
[390.532839] Starting dynamic subtest: A-eDP1
[392.358254] Dynamic subtest A-eDP1: SUCCESS (1.831s)
[392.378388] Starting dynamic subtest: B-eDP1
[394.201872] Dynamic subtest B-eDP1: SUCCESS (1.840s)
[394.215365] Starting dynamic subtest: C-eDP1
[396.021525] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[396.031823] Starting dynamic subtest: D-eDP1
[397.859724] Dynamic subtest D-eDP1: SUCCESS (1.835s)
[397.864522] Subtest flip-vs-dpms-on-nop: SUCCESS (7.339s)
[399.053062] [086/133] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[399.156833] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[399.161090] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[399.256242] [087/133] (621s left) gem_vm_create (invalid-create)
[399.314084] Starting subtest: invalid-create
[399.316528] Subtest invalid-create: SUCCESS (0.002s)
[399.435785] [088/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[399.533712] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[406.858965] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.329s)
[406.994799] [089/133] (614s left) gem_fence_thrash (bo-copy)
[407.033673] Starting subtest: bo-copy
[407.057507] Subtest bo-copy: SKIP (0.023s)
[407.125844] [090/133] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[407.229080] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[414.466504] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.244s)
[414.585637] [091/133] (606s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[414.715620] Starting subtest: short-busy-flip-before-cursor-toggle
[414.720132] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[414.862880] [092/133] (606s left) gem_caching (writes)
[414.916153] Subtest writes: SKIP (0.000s)
[414.988740] [093/133] (606s left) gem_exec_whisper (basic-queues-forked-all)
[415.051158] Starting subtest: basic-queues-forked-all
[436.561487] Subtest basic-queues-forked-all: SUCCESS (21.509s)
[436.762213] [094/133] (584s left) syncobj_wait (wait-for-submit-delayed-submit)
[436.822913] Starting subtest: wait-for-submit-delayed-submit
[436.924588] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[437.021944] [095/133] (584s left) api_intel_allocator (reserve-simple)
[437.084197] Starting subtest: reserve-simple
[437.087565] Subtest reserve-simple: SUCCESS (0.006s)
[437.207473] [096/133] (584s left) gem_exec_balancer (parallel-out-fence)
[437.462945] Starting subtest: parallel-out-fence
[438.694234] Subtest parallel-out-fence: SUCCESS (1.232s)
[438.823799] [097/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[438.919893] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[438.923989] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[439.034758] [098/133] (582s left) kms_pm_dc (dc5-dpms)
[440.134026] Starting subtest: dc5-dpms
[442.180700] Subtest dc5-dpms: SUCCESS (2.048s)
[442.258901] [099/133] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[442.352908] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[442.357246] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[442.455897] [100/133] (579s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[442.543303] Starting subtest: 4-tiled-64bpp-rotate-0
[444.200356] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.657s)
[444.356061] [101/133] (577s left) syncobj_basic (bad-handle-to-fd)
[444.415109] Starting subtest: bad-handle-to-fd
[444.416967] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[444.537225] [102/133] (577s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[444.633837] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[444.637291] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[444.716428] [103/133] (577s left) gem_ctx_persistence (legacy-engines-hostile)
[444.778365] Starting subtest: legacy-engines-hostile
[444.780230] Starting dynamic subtest: render
[444.890918] Dynamic subtest render: SUCCESS (0.111s)
[444.906502] Starting dynamic subtest: bsd1
[444.986938] Dynamic subtest bsd1: SUCCESS (0.093s)
[445.002017] Starting dynamic subtest: bsd2
[445.086804] Dynamic subtest bsd2: SUCCESS (0.097s)
[445.101427] Starting dynamic subtest: blt
[445.190493] Dynamic subtest blt: SUCCESS (0.101s)
[445.205729] Starting dynamic subtest: vebox
[445.287445] Dynamic subtest vebox: SUCCESS (0.093s)
[445.289528] Subtest legacy-engines-hostile: SUCCESS (0.510s)
[445.365105] [104/133] (576s left) kms_atomic_interruptible (universal-setplane-primary)
[445.468322] Starting subtest: universal-setplane-primary
[445.470228] Starting dynamic subtest: pipe-A-eDP-1
[452.872743] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.404s)
[452.875003] Subtest universal-setplane-primary: SUCCESS (7.406s)
[453.712378] [105/133] (568s left) kms_cursor_crc (cursor-offscreen-256x256)
[453.952725] Starting subtest: cursor-offscreen-256x256
[453.958095] Starting dynamic subtest: pipe-A-eDP-1
[455.888185] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[455.920628] Starting dynamic subtest: pipe-D-eDP-1
[458.513114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.603s)
[458.515511] Subtest cursor-offscreen-256x256: SUCCESS (4.562s)
[459.360555] [106/133] (562s left) gem_mmap_gtt (pf-nonblock)
[459.423123] Subtest pf-nonblock: SKIP (0.000s)
[459.488257] [107/133] (562s left) kms_chamelium_color (gamma)
[459.584354] Subtest gamma: SKIP (0.000s)
[459.629144] [108/133] (562s left) gem_ccs (block-copy-uncompressed)
[459.702369] Starting subtest: block-copy-uncompressed
[459.704720] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[459.725344] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[459.741811] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[459.744879] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[459.755102] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[459.762101] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[459.773725] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[459.782557] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[459.785259] Subtest block-copy-uncompressed: SUCCESS (0.079s)
[459.912631] [109/133] (562s left) gem_softpin (evict-active-interruptible)
[459.972777] Starting subtest: evict-active-interruptible
[459.978525] Subtest evict-active-interruptible: SUCCESS (0.004s)
[460.087391] [110/133] (562s left) sw_sync (sync_multi_consumer)
[460.124966] Starting subtest: sync_multi_consumer
[460.563101] Subtest sync_multi_consumer: SUCCESS (0.437s)
[460.629205] [111/133] (561s left) kms_cursor_crc (cursor-sliding-256x85)
[460.884831] Starting subtest: cursor-sliding-256x85
[460.937156] Subtest cursor-sliding-256x85: SKIP (0.047s)
[461.114791] [112/133] (561s left) gem_ctx_sseu (mmap-args)
[461.193236] Subtest mmap-args: SKIP (0.000s)
[461.267411] [113/133] (561s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[461.374647] Starting subtest: yf-tiled-32bpp-rotate-270
[461.378768] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[461.475034] [114/133] (560s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[461.568987] Starting subtest: yf-tiled-64bpp-rotate-180
[461.573481] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[461.677083] [115/133] (560s left) kms_atomic_transition (plane-toggle-modeset-transition)
[461.770506] Starting subtest: plane-toggle-modeset-transition
[461.772248] Starting dynamic subtest: pipe-A-eDP-1
[474.474119] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.704s)
[474.485928] Starting dynamic subtest: pipe-B-eDP-1
[486.863000] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.391s)
[486.866046] Subtest plane-toggle-modeset-transition: SUCCESS (25.101s)
[487.674633] [116/133] (534s left) kms_content_protection (dp-mst-lic-type-0)
[487.824874] Starting subtest: dp-mst-lic-type-0
[487.829289] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[487.956164] [117/133] (534s left) kms_vrr (seamless-rr-switch-virtual)
[488.054242] Starting subtest: seamless-rr-switch-virtual
[488.060338] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[488.128244] [118/133] (534s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[488.217980] Starting subtest: stress-xrgb8888-xtiled
[494.105833] Subtest stress-xrgb8888-xtiled: SUCCESS (5.886s)
[494.157939] [119/133] (528s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[494.274893] Starting subtest: protected-encrypted-src-copy-not-readible
[494.388378] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s)
[494.524065] [120/133] (528s left) prime_busy (before)
[494.589810] Starting subtest: before
[494.594701] Starting dynamic subtest: rcs0
[494.635164] Dynamic subtest rcs0: SUCCESS (0.042s)
[494.647357] Starting dynamic subtest: bcs0
[494.674493] Dynamic subtest bcs0: SUCCESS (0.038s)
[494.690754] Starting dynamic subtest: vcs0
[494.717444] Dynamic subtest vcs0: SUCCESS (0.041s)
[494.729820] Starting dynamic subtest: vcs1
[494.759787] Dynamic subtest vcs1: SUCCESS (0.041s)
[494.770490] Starting dynamic subtest: vecs0
[494.800324] Dynamic subtest vecs0: SUCCESS (0.039s)
[494.810464] Starting dynamic subtest: ccs0
[494.841215] Dynamic subtest ccs0: SUCCESS (0.040s)
[494.949893] Subtest before: SUCCESS (0.358s)
[495.025709] [121/133] (527s left) kms_psr (fbc-psr2-cursor-render)
[495.125432] Starting subtest: fbc-psr2-cursor-render
[495.127696] Starting dynamic subtest: eDP-1
[495.132004] Dynamic subtest eDP-1: SKIP (0.000s)
[495.136291] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[495.199977] [122/133] (527s left) kms_async_flips (test-cursor-atomic)
[495.292164] Starting subtest: test-cursor-atomic
[495.296343] Subtest test-cursor-atomic: SKIP (0.000s)
[496.503941] [123/133] (526s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[496.589283] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[496.593437] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[496.679135] [124/133] (526s left) sysfs_timeslice_duration (idempotent)
[496.743951] Starting subtest: idempotent
[496.746343] Starting dynamic subtest: vecs0
[496.748695] Dynamic subtest vecs0: SUCCESS (0.000s)
[496.760586] Starting dynamic subtest: ccs0
[496.762468] Dynamic subtest ccs0: SUCCESS (0.000s)
[496.771991] Starting dynamic subtest: vcs0
[496.773868] Dynamic subtest vcs0: SUCCESS (0.000s)
[496.783535] Starting dynamic subtest: bcs0
[496.785319] Dynamic subtest bcs0: SUCCESS (0.000s)
[496.795447] Starting dynamic subtest: rcs0
[496.797579] Dynamic subtest rcs0: SUCCESS (0.000s)
[496.807393] Starting dynamic subtest: vcs1
[496.809216] Dynamic subtest vcs1: SUCCESS (0.000s)
[496.811094] Subtest idempotent: SUCCESS (0.006s)
[496.853998] [125/133] (525s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[496.958073] Starting subtest: primary-yf-tiled-reflect-x-90
[496.962434] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[497.048905] [126/133] (525s left) gem_softpin (evict-single-offset)
[497.111598] Starting subtest: evict-single-offset
[522.209470] Subtest evict-single-offset: SUCCESS (25.089s)
[522.292472] [127/133] (500s left) kms_psr (fbc-pr-cursor-plane-onoff)
[522.449073] Starting subtest: fbc-pr-cursor-plane-onoff
[522.453387] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[522.524909] [128/133] (500s left) kms_color (ctm-negative)
[522.614981] Starting subtest: ctm-negative
[522.617105] Starting dynamic subtest: pipe-A-eDP-1
[523.345109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[523.355863] Starting dynamic subtest: pipe-B-eDP-1
[524.731343] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[524.741779] Starting dynamic subtest: pipe-C-eDP-1
[526.096471] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[526.106871] Starting dynamic subtest: pipe-D-eDP-1
[527.429486] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[527.431879] Subtest ctm-negative: SUCCESS (4.815s)
[528.229142] [129/133] (494s left) kms_sequence (get-forked)
[528.332528] Starting subtest: get-forked
[528.334479] Starting dynamic subtest: pipe-A-eDP-1
[530.256008] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[530.267104] Starting dynamic subtest: pipe-B-eDP-1
[532.772719] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.515s)
[532.784434] Starting dynamic subtest: pipe-C-eDP-1
[535.290064] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.518s)
[535.300599] Starting dynamic subtest: pipe-D-eDP-1
[537.833636] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[537.835796] Subtest get-forked: SUCCESS (9.500s)
[538.656194] [130/133] (484s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[538.723603] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[538.725972] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[538.799116] [131/133] (484s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[538.913818] Starting subtest: y-tiled-64bpp-rotate-90
[538.918146] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[539.011360] [132/133] (484s left) syncobj_wait (reset-multiple-signaled)
[539.059936] Starting subtest: reset-multiple-signaled
[539.062207] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[539.154480] [133/133] (483s left) core_auth (getclient-master-drop)
[539.193229] Starting subtest: getclient-master-drop
[539.208414] Subtest getclient-master-drop: SUCCESS (0.015s)
[539.301695] 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.