[57.322862] Initializing watchdogs
[57.322913]   /dev/watchdog0
[57.339585] [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.344115] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.346393] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.349660] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[57.468292] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[57.472784] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[57.551657] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[57.643753] Starting subtest: bo-too-small
[57.646070] Subtest bo-too-small: SUCCESS (0.000s)
[57.750479] [003/133] (960s left) syncobj_basic (bad-destroy-pad)
[57.820049] Starting subtest: bad-destroy-pad
[57.822113] Subtest bad-destroy-pad: SUCCESS (0.000s)
[57.924137] [004/133] (960s left) kms_pm_backlight (basic-brightness)
[58.005581] Starting subtest: basic-brightness
[58.095673] Starting dynamic subtest: eDP-1
[58.388149] Dynamic subtest eDP-1: SUCCESS (0.293s)
[58.390470] Subtest basic-brightness: SUCCESS (0.384s)
[59.191535] [005/133] (958s left) prime_mmap_kms (buffer-sharing)
[59.286247] Starting subtest: buffer-sharing
[59.718432] Subtest buffer-sharing: SUCCESS (0.434s)
[60.522043] [006/133] (957s left) kms_dsc (dsc-with-bpc-formats)
[60.620989] Starting subtest: dsc-with-bpc-formats
[60.729553] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[60.767389] [007/133] (957s left) gem_pread (snoop)
[60.825077] Subtest snoop: SKIP (0.000s)
[60.897888] [008/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[60.979775] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[60.982153] Starting dynamic subtest: pipe-A
[61.318304] Dynamic subtest pipe-A: SUCCESS (0.341s)
[61.326858] Starting dynamic subtest: pipe-B
[62.709085] Dynamic subtest pipe-B: SUCCESS (1.393s)
[62.716927] Starting dynamic subtest: pipe-C
[64.159436] Dynamic subtest pipe-C: SUCCESS (1.452s)
[64.167514] Starting dynamic subtest: pipe-D
[65.575688] Dynamic subtest pipe-D: SUCCESS (1.418s)
[65.578076] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.606s)
[66.727357] [009/133] (951s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[66.894069] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[66.899617] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[66.995864] [010/133] (951s left) gem_mmap_gtt (hang)
[67.248533] Subtest hang: SKIP (0.000s)
[67.530733] [011/133] (950s left) gem_exec_store (basic)
[67.630036] Starting subtest: basic
[67.999244] Subtest basic: SUCCESS (0.368s)
[68.187554] [012/133] (950s left) gem_ctx_exec (basic)
[68.244869] Starting subtest: basic
[68.249728] Subtest basic: SUCCESS (0.006s)
[68.350192] [013/133] (950s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[68.443926] Starting subtest: primary-4-tiled-reflect-x-180
[75.437506] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.000s)
[76.613105] [014/133] (941s left) gem_readwrite (read-write)
[76.664699] Subtest read-write: SKIP (0.000s)
[76.725623] [015/133] (941s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[76.818811] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[76.822954] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[76.887847] [016/133] (941s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[77.010990] Starting subtest: 2x-long-flip-vs-cursor-atomic
[77.015424] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[77.152420] [017/133] (941s left) kms_psr (fbc-psr-cursor-blt)
[77.249920] Starting subtest: fbc-psr-cursor-blt
[77.252264] Starting dynamic subtest: eDP-1
[77.256501] Dynamic subtest eDP-1: SKIP (0.000s)
[77.260765] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[77.318816] [018/133] (941s left) gen9_exec_parse (bb-large)
[77.369793] Subtest bb-large: SKIP (0.000s)
[77.436138] [019/133] (941s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[77.532105] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[77.534362] Starting dynamic subtest: pipe-A-eDP-1
[78.398943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s)
[78.408466] Starting dynamic subtest: pipe-B-eDP-1
[79.945804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.544s)
[79.955026] Starting dynamic subtest: pipe-C-eDP-1
[81.402192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s)
[81.411293] Starting dynamic subtest: pipe-D-eDP-1
[82.834744] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.434s)
[82.837068] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.296s)
[84.038072] [020/133] (934s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[84.139562] Starting subtest: fbc-tiling-linear
[87.879542] Subtest fbc-tiling-linear: SUCCESS (3.744s)
[89.026376] [021/133] (929s left) i915_drm_fdinfo (memory-info-shared)
[89.070149] Starting subtest: memory-info-shared
[89.072273] Starting dynamic subtest: smem0
[89.117323] Dynamic subtest smem0: SUCCESS (0.049s)
[89.119820] Subtest memory-info-shared: SUCCESS (0.049s)
[89.191276] [022/133] (929s left) gem_workarounds (reset-context)
[89.267797] Starting subtest: reset-context
[89.458984] Subtest reset-context: SUCCESS (0.191s)
[89.583623] [023/133] (929s left) i915_query (query-regions-garbage-items)
[89.632978] Starting subtest: query-regions-garbage-items
[89.635013] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[89.722261] [024/133] (929s left) kms_lease (lease-get)
[89.802055] Starting subtest: lease-get
[89.804306] Starting dynamic subtest: pipe-A-eDP-1
[89.806463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[89.815699] Starting dynamic subtest: pipe-B-eDP-1
[89.817773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[89.825799] Starting dynamic subtest: pipe-C-eDP-1
[89.827875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[89.835700] Starting dynamic subtest: pipe-D-eDP-1
[89.837783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[89.839914] Subtest lease-get: SUCCESS (0.008s)
[89.909616] [025/133] (928s left) gem_exec_balancer (bonded-sync)
[89.974722] Starting subtest: bonded-sync
[89.978428] Subtest bonded-sync: SKIP (0.000s)
[90.267631] [026/133] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[90.319823] Starting subtest: etime-multi-wait-all-for-submit-submitted
[90.424784] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[90.496347] [027/133] (928s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[90.623333] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[90.627849] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[90.767317] [028/133] (928s left) kms_properties (connector-properties-atomic)
[90.861937] Starting subtest: connector-properties-atomic
[90.864298] Starting dynamic subtest: pipe-A-eDP-1
[98.717301] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.854s)
[98.727068] Starting dynamic subtest: pipe-None-DP-1
[98.731798] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[98.739351] Starting dynamic subtest: pipe-None-HDMI-A-1
[98.743872] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[98.751628] Starting dynamic subtest: pipe-None-DP-2
[98.756319] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[98.764107] Starting dynamic subtest: pipe-None-HDMI-A-2
[98.768416] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[98.775839] Starting dynamic subtest: pipe-None-DP-3
[98.782718] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[98.793496] Starting dynamic subtest: pipe-None-DP-4
[98.798029] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[98.800166] Subtest connector-properties-atomic: SUCCESS (7.866s)
[99.587734] [029/133] (919s left) kms_cursor_crc (cursor-random-256x85)
[99.871315] Starting subtest: cursor-random-256x85
[99.922130] Subtest cursor-random-256x85: SKIP (0.045s)
[100.113944] [030/133] (918s left) gem_close_race (multigpu-basic-process)
[100.182657] Starting subtest: multigpu-basic-process
[100.187330] Subtest multigpu-basic-process: SKIP (0.000s)
[100.399210] [031/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[100.500174] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[100.504428] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.611544] [032/133] (918s left) gem_pwrite (basic-self)
[100.668549] Subtest basic-self: SKIP (0.000s)
[100.740643] [033/133] (918s left) gem_exec_params (larger-than-life-batch)
[100.799078] Starting subtest: larger-than-life-batch
[103.026323] Subtest larger-than-life-batch: SUCCESS (2.228s)
[103.940105] [034/133] (915s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[104.029488] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[104.031836] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[104.103140] [035/133] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[104.199644] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[104.203819] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[104.287661] [036/133] (915s left) gem_exec_schedule (semaphore-noskip)
[104.353597] Starting subtest: semaphore-noskip
[104.777230] Subtest semaphore-noskip: SUCCESS (0.425s)
[105.101873] [037/133] (914s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[105.165445] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[105.218231] [038/133] (914s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[105.305228] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[105.307493] Starting dynamic subtest: pipe-A-eDP-1
[105.361275] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[105.369886] Starting dynamic subtest: pipe-B-eDP-1
[105.425080] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[105.434848] Starting dynamic subtest: pipe-C-eDP-1
[105.493049] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[105.502864] Starting dynamic subtest: pipe-D-eDP-1
[105.559402] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[105.563389] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[107.444760] [039/133] (911s left) kms_prop_blob (blob-multiple)
[107.503988] Starting subtest: blob-multiple
[107.506499] Subtest blob-multiple: SUCCESS (0.002s)
[107.622442] [040/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[107.730698] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[107.735727] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[107.812347] [041/133] (911s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[107.909732] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[107.911975] Starting dynamic subtest: pipe-A-default-mode
[110.698948] Dynamic subtest pipe-A-default-mode: SUCCESS (2.788s)
[110.700998] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.789s)
[111.532953] [042/133] (908s left) kms_chamelium_frames (vga-frame-dump)
[111.914695] Subtest vga-frame-dump: SKIP (0.000s)
[112.741164] [043/133] (906s left) vgem_basic (create)
[112.862476] Starting subtest: create
[112.864539] Subtest create: SUCCESS (0.000s)
[112.919552] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[112.922689] [044/133] (906s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[112.982121] Starting subtest: wait-all-for-submit-delayed-submit
[113.085814] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[113.171369] [045/133] (906s left) gem_exec_params (sol-reset-invalid)
[113.232398] Starting subtest: sol-reset-invalid
[113.237264] Subtest sol-reset-invalid: SUCCESS (0.003s)
[114.969926] [046/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[115.077997] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[121.647095] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.572s)
[121.771058] [047/133] (897s left) kms_busy (basic-hang)
[121.869492] Starting subtest: basic-hang
[121.871627] Starting dynamic subtest: flip-pipe-A
[122.473884] Dynamic subtest flip-pipe-A: SUCCESS (0.602s)
[122.483629] Starting dynamic subtest: modeset-pipe-A
[125.921902] Dynamic subtest modeset-pipe-A: SUCCESS (3.448s)
[125.931230] Starting dynamic subtest: flip-pipe-D
[127.109466] Dynamic subtest flip-pipe-D: SUCCESS (1.185s)
[127.118833] Starting dynamic subtest: modeset-pipe-D
[130.543988] Dynamic subtest modeset-pipe-D: SUCCESS (3.436s)
[130.546419] Subtest basic-hang: SUCCESS (8.676s)
[131.350484] [048/133] (888s left) kms_plane_multiple (2x-tiling-4)
[131.443093] Starting subtest: 2x-tiling-4
[131.447038] Subtest 2x-tiling-4: SKIP (0.000s)
[131.513277] [049/133] (888s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[131.616360] Starting subtest: x-tiled-64bpp-rotate-180
[133.229073] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.612s)
[133.423430] [050/133] (886s left) i915_pm_freq_api (freq-suspend)
[133.494742] Starting subtest: freq-suspend
[133.497080] Starting dynamic subtest: gt0
[150.229749] Dynamic subtest gt0: SUCCESS (1.346s)
[150.241612] Starting dynamic subtest: gt1
[166.254615] Dynamic subtest gt1: SUCCESS (1.212s)
[166.256703] Subtest freq-suspend: SUCCESS (2.560s)
[166.335417] [051/133] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[166.432403] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[166.436832] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[166.524335] [052/133] (853s left) sw_sync (alloc_merge_fence)
[166.566740] Starting subtest: alloc_merge_fence
[166.568695] Subtest alloc_merge_fence: SUCCESS (0.000s)
[166.626187] [053/133] (853s left) gem_exec_fence (submit3)
[166.812305] Starting subtest: submit3
[166.816969] Subtest submit3: SKIP (0.000s)
[168.151003] [054/133] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[168.245062] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[173.693413] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.507s)
[174.868083] [055/133] (845s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[174.951153] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[174.953389] Starting dynamic subtest: pipe-A-eDP-1
[174.975242] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.984843] Starting dynamic subtest: pipe-B-eDP-1
[175.005516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.014626] Starting dynamic subtest: pipe-C-eDP-1
[175.035338] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.044002] Starting dynamic subtest: pipe-D-eDP-1
[175.065513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.069856] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[177.127489] [056/133] (843s left) gem_ctx_param (invalid-ctx-set)
[177.172521] Starting subtest: invalid-ctx-set
[177.174852] Subtest invalid-ctx-set: SUCCESS (0.001s)
[177.271191] [057/133] (842s left) sw_sync (sync_multi_timeline_wait)
[177.303793] Starting subtest: sync_multi_timeline_wait
[177.306004] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[177.357903] [058/133] (842s left) dumb_buffer (invalid-bpp)
[177.410360] Starting subtest: invalid-bpp
[177.412650] Subtest invalid-bpp: SUCCESS (0.000s)
[177.506175] [059/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[177.594643] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[177.598746] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[177.703484] [060/133] (842s left) gem_fence_thrash (bo-write-verify-threaded-y)
[177.747415] Starting subtest: bo-write-verify-threaded-y
[177.760265] Subtest bo-write-verify-threaded-y: SKIP (0.015s)
[177.826572] [061/133] (842s left) kms_flip (absolute-wf_vblank-interruptible)
[177.910185] Starting subtest: absolute-wf_vblank-interruptible
[177.912769] Starting dynamic subtest: A-eDP1
[186.569373] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[186.582438] Starting dynamic subtest: B-eDP1
[195.293225] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[195.303838] Starting dynamic subtest: C-eDP1
[204.012148] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[204.024204] Starting dynamic subtest: D-eDP1
[212.731610] Dynamic subtest D-eDP1: SUCCESS (8.718s)
[212.737516] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.861s)
[213.952585] [062/133] (806s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[214.039669] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[214.041866] Starting dynamic subtest: pipe-A-eDP-1
[214.050566] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.064323] Starting dynamic subtest: pipe-B-eDP-1
[214.073558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.083368] Starting dynamic subtest: pipe-C-eDP-1
[214.091910] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.100841] Starting dynamic subtest: pipe-D-eDP-1
[214.109401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.113817] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[216.232921] [063/133] (804s left) kms_psr (psr2-cursor-mmap-gtt)
[216.331829] Starting subtest: psr2-cursor-mmap-gtt
[216.333965] Starting dynamic subtest: eDP-1
[217.998689] Dynamic subtest eDP-1: SUCCESS (1.667s)
[218.000980] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.668s)
[218.791480] [064/133] (801s left) kms_big_fb (linear-8bpp-rotate-0)
[218.896609] Starting subtest: linear-8bpp-rotate-0
[220.109696] Subtest linear-8bpp-rotate-0: SUCCESS (1.213s)
[220.246104] [065/133] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[220.337868] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[227.358370] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.024s)
[227.516639] [066/133] (793s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[227.610738] Starting subtest: 2x-plain-flip-ts-check-interruptible
[227.622919] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[227.738052] [067/133] (792s left) kms_vblank (ts-continuation-suspend)
[227.837335] Starting subtest: ts-continuation-suspend
[227.839654] Starting dynamic subtest: pipe-A-eDP-1
[244.543458] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.531s)
[244.567052] Starting dynamic subtest: pipe-D-eDP-1
[261.530050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s)
[261.532307] Subtest ts-continuation-suspend: SUCCESS (3.712s)
[262.325399] [068/133] (758s left) gem_exec_schedule (preempt-hang)
[262.516551] Starting subtest: preempt-hang
[262.518602] Starting dynamic subtest: rcs0
[262.747575] Dynamic subtest rcs0: SUCCESS (0.237s)
[262.756884] Starting dynamic subtest: bcs0
[262.982802] Dynamic subtest bcs0: SUCCESS (0.237s)
[262.992300] Starting dynamic subtest: vcs0
[263.212393] Dynamic subtest vcs0: SUCCESS (0.230s)
[263.221100] Starting dynamic subtest: vcs1
[263.436041] Dynamic subtest vcs1: SUCCESS (0.224s)
[263.447491] Starting dynamic subtest: vecs0
[263.656471] Dynamic subtest vecs0: SUCCESS (0.223s)
[263.667226] Starting dynamic subtest: ccs0
[263.882207] Dynamic subtest ccs0: SUCCESS (0.228s)
[263.884357] Subtest preempt-hang: SUCCESS (1.387s)
[264.150705] [069/133] (756s left) i915_pm_rc6_residency (rc6-fence)
[264.213848] Starting subtest: rc6-fence
[264.255656] Starting dynamic subtest: gt0
[276.571948] Dynamic subtest gt0: SUCCESS (12.391s)
[276.584779] Starting dynamic subtest: gt1
[290.105431] Dynamic subtest gt1: SUCCESS (13.551s)
[290.108390] Subtest rc6-fence: SUCCESS (25.985s)
[290.229621] [070/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[290.347552] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[290.352016] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[290.463611] [071/133] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[290.566323] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[290.570768] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[290.666461] [072/133] (730s left) kms_cdclk (mode-transition)
[290.773031] Starting subtest: mode-transition
[290.775310] Starting dynamic subtest: pipe-A-eDP-1
[291.065056] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[291.077662] Starting dynamic subtest: pipe-B-eDP-1
[291.082453] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[291.091853] Starting dynamic subtest: pipe-C-eDP-1
[291.096505] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[291.105236] Starting dynamic subtest: pipe-D-eDP-1
[291.109349] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[291.113611] Subtest mode-transition: SKIP (0.296s)
[291.935332] [073/133] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[292.030804] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[295.619741] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.593s)
[296.850699] [074/133] (724s left) gem_ctx_isolation (nonpriv)
[296.929889] Starting subtest: nonpriv
[296.932322] Starting dynamic subtest: rcs0
[297.179103] Dynamic subtest rcs0: SUCCESS (0.251s)
[297.191652] Starting dynamic subtest: bcs0
[297.445465] Dynamic subtest bcs0: SUCCESS (0.265s)
[297.457563] Starting dynamic subtest: vcs0
[297.698339] Dynamic subtest vcs0: SUCCESS (0.252s)
[297.710764] Starting dynamic subtest: vcs1
[299.338247] Dynamic subtest vcs1: SUCCESS (1.638s)
[299.351036] Starting dynamic subtest: vecs0
[301.358543] Dynamic subtest vecs0: SUCCESS (2.018s)
[301.369216] Starting dynamic subtest: ccs0
[303.368084] Dynamic subtest ccs0: SUCCESS (2.008s)
[303.370290] Subtest nonpriv: SUCCESS (6.438s)
[303.628543] [075/133] (717s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[303.683448] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[303.685914] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[303.791627] [076/133] (717s left) kms_psr (pr-suspend)
[303.888914] Starting subtest: pr-suspend
[303.893471] Subtest pr-suspend: SKIP (0.000s)
[303.962393] [077/133] (717s left) kms_plane_scaling (2x-scaler-multi-pipe)
[304.053837] Starting subtest: 2x-scaler-multi-pipe
[304.058241] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[304.158672] [078/133] (716s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[304.244099] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[304.635962] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[307.409788] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[307.422309] Starting dynamic subtest: pipe-A-eDP-1-4
[309.596754] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[309.609555] Starting dynamic subtest: pipe-A-eDP-1-4
[311.606613] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[311.618589] Starting dynamic subtest: pipe-A-eDP-1-x
[313.807697] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[314.192779] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[316.941622] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.757s)
[316.951168] Starting dynamic subtest: pipe-B-eDP-1-4
[319.116837] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[319.129139] Starting dynamic subtest: pipe-B-eDP-1-4
[321.126562] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[321.136199] Starting dynamic subtest: pipe-B-eDP-1-x
[323.316119] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[323.685042] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[326.466910] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[326.479954] Starting dynamic subtest: pipe-C-eDP-1-4
[328.641778] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[328.654024] Starting dynamic subtest: pipe-C-eDP-1-4
[330.651006] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[330.667440] Starting dynamic subtest: pipe-C-eDP-1-x
[332.841026] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[333.214900] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[336.001092] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[336.019040] Starting dynamic subtest: pipe-D-eDP-1-4
[338.185914] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[338.202257] Starting dynamic subtest: pipe-D-eDP-1-4
[340.196161] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[340.210227] Starting dynamic subtest: pipe-D-eDP-1-x
[342.373950] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[342.376540] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.136s)
[343.584275] [079/133] (677s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[343.643618] Starting subtest: y-tiled-ccs-to-x-tiled
[343.648170] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[343.830619] [080/133] (677s left) kms_flip (modeset-vs-vblank-race-interruptible)
[343.925593] Starting subtest: modeset-vs-vblank-race-interruptible
[343.927942] Starting dynamic subtest: A-eDP1
[348.598920] Dynamic subtest A-eDP1: SUCCESS (4.674s)
[348.615480] Starting dynamic subtest: B-eDP1
[353.318123] Dynamic subtest B-eDP1: SUCCESS (4.718s)
[353.334231] Starting dynamic subtest: C-eDP1
[357.907651] Dynamic subtest C-eDP1: SUCCESS (4.588s)
[357.920074] Starting dynamic subtest: D-eDP1
[362.533460] Dynamic subtest D-eDP1: SUCCESS (4.621s)
[362.538138] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.617s)
[363.700850] [081/133] (657s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[363.786266] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[363.790779] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[363.971654] [082/133] (657s left) perf_pmu (semaphore-busy)
[364.016334] Starting subtest: semaphore-busy
[364.018748] Starting dynamic subtest: rcs0
[365.644903] Dynamic subtest rcs0: SUCCESS (1.624s)
[365.655395] Starting dynamic subtest: bcs0
[367.277577] Dynamic subtest bcs0: SUCCESS (1.629s)
[367.294104] Starting dynamic subtest: vcs0
[371.636725] Dynamic subtest vcs0: SUCCESS (4.355s)
[371.647063] Starting dynamic subtest: vcs1
[377.590066] Dynamic subtest vcs1: SUCCESS (5.949s)
[377.601728] Starting dynamic subtest: vecs0
[383.607166] Dynamic subtest vecs0: SUCCESS (6.013s)
[383.619665] Starting dynamic subtest: ccs0
[386.680263] Dynamic subtest ccs0: SUCCESS (3.070s)
[386.682531] Subtest semaphore-busy: SUCCESS (22.657s)
[386.797419] [083/133] (634s left) kms_joiner (basic-max-non-joiner)
[386.906781] Starting subtest: basic-max-non-joiner
[386.910878] Subtest basic-max-non-joiner: SKIP (0.000s)
[386.974971] [084/133] (634s left) gem_eio (wait-wedge-immediate)
[387.151802] Starting subtest: wait-wedge-immediate
[388.145013] Subtest wait-wedge-immediate: SUCCESS (0.992s)
[388.292174] [085/133] (633s left) kms_flip (flip-vs-dpms-on-nop)
[388.381349] Starting subtest: flip-vs-dpms-on-nop
[388.383682] Starting dynamic subtest: A-eDP1
[390.312372] Dynamic subtest A-eDP1: SUCCESS (1.932s)
[390.325622] Starting dynamic subtest: B-eDP1
[392.136698] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[392.149282] Starting dynamic subtest: C-eDP1
[393.956469] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[393.969329] Starting dynamic subtest: D-eDP1
[395.785768] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[395.791904] Subtest flip-vs-dpms-on-nop: SUCCESS (7.411s)
[396.960370] [086/133] (624s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[397.062759] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[397.067206] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[397.168417] [087/133] (624s left) gem_vm_create (invalid-create)
[397.221419] Starting subtest: invalid-create
[397.223736] Subtest invalid-create: SUCCESS (0.001s)
[397.325391] [088/133] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[397.415928] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[404.669730] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.257s)
[404.795708] [089/133] (616s left) gem_fence_thrash (bo-copy)
[404.832408] Starting subtest: bo-copy
[404.851922] Subtest bo-copy: SKIP (0.017s)
[404.914691] [090/133] (616s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[405.015372] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[412.176309] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.164s)
[412.306616] [091/133] (609s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[412.427027] Starting subtest: short-busy-flip-before-cursor-toggle
[412.431721] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[412.572247] [092/133] (609s left) gem_caching (writes)
[412.625321] Subtest writes: SKIP (0.000s)
[412.681607] [093/133] (609s left) gem_exec_whisper (basic-queues-forked-all)
[412.738785] Starting subtest: basic-queues-forked-all
[434.442564] Subtest basic-queues-forked-all: SUCCESS (21.702s)
[434.649523] [094/133] (587s left) syncobj_wait (wait-for-submit-delayed-submit)
[434.710433] Starting subtest: wait-for-submit-delayed-submit
[434.812999] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[434.894232] [095/133] (586s left) api_intel_allocator (reserve-simple)
[434.949909] Starting subtest: reserve-simple
[434.954537] Subtest reserve-simple: SUCCESS (0.006s)
[435.080022] [096/133] (586s left) gem_exec_balancer (parallel-out-fence)
[435.337777] Starting subtest: parallel-out-fence
[436.558825] Subtest parallel-out-fence: SUCCESS (1.221s)
[436.680166] [097/133] (585s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[436.776620] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[436.781019] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[436.870750] [098/133] (585s left) kms_pm_dc (dc5-dpms)
[437.985988] Starting subtest: dc5-dpms
[440.077035] Subtest dc5-dpms: SUCCESS (2.091s)
[440.155189] [099/133] (581s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[440.253282] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[440.257039] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[440.354859] [100/133] (581s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[440.459376] Starting subtest: 4-tiled-64bpp-rotate-0
[442.072478] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.615s)
[442.250305] [101/133] (579s left) syncobj_basic (bad-handle-to-fd)
[442.316473] Starting subtest: bad-handle-to-fd
[442.318395] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[442.439906] [102/133] (579s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[442.523810] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[442.527495] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[442.596562] [103/133] (579s left) gem_ctx_persistence (legacy-engines-hostile)
[442.654235] Starting subtest: legacy-engines-hostile
[442.656054] Starting dynamic subtest: render
[442.767107] Dynamic subtest render: SUCCESS (0.112s)
[442.781448] Starting dynamic subtest: bsd1
[442.862266] Dynamic subtest bsd1: SUCCESS (0.092s)
[442.875222] Starting dynamic subtest: bsd2
[442.968533] Dynamic subtest bsd2: SUCCESS (0.103s)
[442.982947] Starting dynamic subtest: blt
[442.986918] Dynamic subtest blt: SUCCESS (0.015s)
[442.996231] Starting dynamic subtest: vebox
[443.112287] Dynamic subtest vebox: SUCCESS (0.125s)
[443.114515] Subtest legacy-engines-hostile: SUCCESS (0.459s)
[443.191709] [104/133] (578s left) kms_atomic_interruptible (universal-setplane-primary)
[443.283017] Starting subtest: universal-setplane-primary
[443.284891] Starting dynamic subtest: pipe-A-eDP-1
[450.663544] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.377s)
[450.665499] Subtest universal-setplane-primary: SUCCESS (7.378s)
[451.506148] [105/133] (570s left) kms_cursor_crc (cursor-offscreen-256x256)
[451.752956] Starting subtest: cursor-offscreen-256x256
[451.758149] Starting dynamic subtest: pipe-A-eDP-1
[453.687293] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[453.719906] Starting dynamic subtest: pipe-D-eDP-1
[456.307540] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.597s)
[456.309536] Subtest cursor-offscreen-256x256: SUCCESS (4.553s)
[457.180571] [106/133] (565s left) gem_mmap_gtt (pf-nonblock)
[457.238684] Subtest pf-nonblock: SKIP (0.000s)
[457.299098] [107/133] (565s left) kms_chamelium_color (gamma)
[457.393640] Subtest gamma: SKIP (0.000s)
[457.439751] [108/133] (564s left) gem_ccs (block-copy-uncompressed)
[457.499797] Starting subtest: block-copy-uncompressed
[457.502103] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[457.521006] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[457.532953] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[457.537753] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[457.547352] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[457.554119] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[457.563612] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[457.570729] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[457.573037] Subtest block-copy-uncompressed: SUCCESS (0.071s)
[457.711446] [109/133] (564s left) gem_softpin (evict-active-interruptible)
[457.788741] Starting subtest: evict-active-interruptible
[457.794107] Subtest evict-active-interruptible: SUCCESS (0.005s)
[457.921088] [110/133] (564s left) sw_sync (sync_multi_consumer)
[457.951922] Starting subtest: sync_multi_consumer
[458.388331] Subtest sync_multi_consumer: SUCCESS (0.436s)
[458.450063] [111/133] (564s left) kms_cursor_crc (cursor-sliding-256x85)
[458.721572] Starting subtest: cursor-sliding-256x85
[458.772924] Subtest cursor-sliding-256x85: SKIP (0.047s)
[458.935247] [112/133] (563s left) gem_ctx_sseu (mmap-args)
[458.991592] Subtest mmap-args: SKIP (0.000s)
[459.056608] [113/133] (563s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[459.147041] Starting subtest: yf-tiled-32bpp-rotate-270
[459.151414] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[459.246820] [114/133] (563s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[459.353408] Starting subtest: yf-tiled-64bpp-rotate-180
[459.357748] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[459.438845] [115/133] (563s left) kms_atomic_transition (plane-toggle-modeset-transition)
[459.535496] Starting subtest: plane-toggle-modeset-transition
[459.537154] Starting dynamic subtest: pipe-A-eDP-1
[472.211370] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.676s)
[472.223415] Starting dynamic subtest: pipe-B-eDP-1
[484.637351] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.428s)
[484.640150] Subtest plane-toggle-modeset-transition: SUCCESS (25.111s)
[485.478105] [116/133] (537s left) kms_content_protection (dp-mst-lic-type-0)
[485.633223] Starting subtest: dp-mst-lic-type-0
[485.637612] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[485.754946] [117/133] (536s left) kms_vrr (seamless-rr-switch-virtual)
[485.842534] Starting subtest: seamless-rr-switch-virtual
[485.849031] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[485.929084] [118/133] (536s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[486.044855] Starting subtest: stress-xrgb8888-xtiled
[491.954060] Subtest stress-xrgb8888-xtiled: SUCCESS (5.907s)
[492.003082] [119/133] (530s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[492.125185] Starting subtest: protected-encrypted-src-copy-not-readible
[492.249043] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.125s)
[492.371922] [120/133] (530s left) prime_busy (before)
[492.429309] Starting subtest: before
[492.434074] Starting dynamic subtest: rcs0
[492.460674] Dynamic subtest rcs0: SUCCESS (0.029s)
[492.472305] Starting dynamic subtest: bcs0
[492.507565] Dynamic subtest bcs0: SUCCESS (0.046s)
[492.518102] Starting dynamic subtest: vcs0
[492.547267] Dynamic subtest vcs0: SUCCESS (0.039s)
[492.557404] Starting dynamic subtest: vcs1
[492.588497] Dynamic subtest vcs1: SUCCESS (0.040s)
[492.598674] Starting dynamic subtest: vecs0
[492.630302] Dynamic subtest vecs0: SUCCESS (0.041s)
[492.640077] Starting dynamic subtest: ccs0
[492.671038] Dynamic subtest ccs0: SUCCESS (0.040s)
[492.779171] Subtest before: SUCCESS (0.349s)
[492.855552] [121/133] (530s left) kms_psr (fbc-psr2-cursor-render)
[492.949150] Starting subtest: fbc-psr2-cursor-render
[492.951349] Starting dynamic subtest: eDP-1
[492.955456] Dynamic subtest eDP-1: SKIP (0.000s)
[492.959577] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[493.038638] [122/133] (529s left) kms_async_flips (test-cursor-atomic)
[493.135099] Starting subtest: test-cursor-atomic
[493.139434] Subtest test-cursor-atomic: SKIP (0.000s)
[494.291419] [123/133] (528s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[494.390491] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[494.394895] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[494.508294] [124/133] (528s left) sysfs_timeslice_duration (idempotent)
[494.569878] Starting subtest: idempotent
[494.572216] Starting dynamic subtest: vecs0
[494.574401] Dynamic subtest vecs0: SUCCESS (0.000s)
[494.585273] Starting dynamic subtest: ccs0
[494.587397] Dynamic subtest ccs0: SUCCESS (0.000s)
[494.596594] Starting dynamic subtest: vcs0
[494.598842] Dynamic subtest vcs0: SUCCESS (0.000s)
[494.608277] Starting dynamic subtest: bcs0
[494.610431] Dynamic subtest bcs0: SUCCESS (0.000s)
[494.619944] Starting dynamic subtest: rcs0
[494.622041] Dynamic subtest rcs0: SUCCESS (0.000s)
[494.631705] Starting dynamic subtest: vcs1
[494.633783] Dynamic subtest vcs1: SUCCESS (0.000s)
[494.635908] Subtest idempotent: SUCCESS (0.006s)
[494.674306] [125/133] (528s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[494.782746] Starting subtest: primary-yf-tiled-reflect-x-90
[494.787133] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[494.852800] [126/133] (528s left) gem_softpin (evict-single-offset)
[494.905470] Starting subtest: evict-single-offset
[521.083852] Subtest evict-single-offset: SUCCESS (26.169s)
[521.171324] [127/133] (501s left) kms_psr (fbc-pr-cursor-plane-onoff)
[521.310958] Starting subtest: fbc-pr-cursor-plane-onoff
[521.315257] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[521.386018] [128/133] (501s left) kms_color (ctm-negative)
[521.476245] Starting subtest: ctm-negative
[521.478170] Starting dynamic subtest: pipe-A-eDP-1
[522.190879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[522.202101] Starting dynamic subtest: pipe-B-eDP-1
[523.599743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[523.611708] Starting dynamic subtest: pipe-C-eDP-1
[524.986678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[524.997449] Starting dynamic subtest: pipe-D-eDP-1
[526.322537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[526.325041] Subtest ctm-negative: SUCCESS (4.848s)
[527.124615] [129/133] (496s left) kms_sequence (get-forked)
[527.227892] Starting subtest: get-forked
[527.230243] Starting dynamic subtest: pipe-A-eDP-1
[529.091774] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.864s)
[529.103509] Starting dynamic subtest: pipe-B-eDP-1
[531.668405] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[531.680439] Starting dynamic subtest: pipe-C-eDP-1
[534.185744] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.518s)
[534.196421] Starting dynamic subtest: pipe-D-eDP-1
[536.738936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[536.741376] Subtest get-forked: SUCCESS (9.510s)
[537.584652] [130/133] (485s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[537.655434] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[537.657860] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[537.753026] [131/133] (485s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[537.858577] Starting subtest: y-tiled-64bpp-rotate-90
[537.862759] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[537.965702] [132/133] (485s left) syncobj_wait (reset-multiple-signaled)
[538.029822] Starting subtest: reset-multiple-signaled
[538.032173] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[538.144196] [133/133] (485s left) core_auth (getclient-master-drop)
[538.181156] Starting subtest: getclient-master-drop
[538.199025] Subtest getclient-master-drop: SUCCESS (0.017s)
[538.297519] 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.