[58.311514] Initializing watchdogs
[58.311560]   /dev/watchdog0
[58.326659] [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]
[58.331271] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.333535] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.337163] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[58.463518] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[58.468047] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[58.532406] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[58.630142] Starting subtest: bo-too-small
[58.632084] Subtest bo-too-small: SUCCESS (0.000s)
[58.729375] [003/133] (960s left) syncobj_basic (bad-destroy-pad)
[58.785597] Starting subtest: bad-destroy-pad
[58.787465] Subtest bad-destroy-pad: SUCCESS (0.000s)
[58.877871] [004/133] (960s left) kms_pm_backlight (basic-brightness)
[58.962782] Starting subtest: basic-brightness
[59.057663] Starting dynamic subtest: eDP-1
[59.359379] Dynamic subtest eDP-1: SUCCESS (0.299s)
[59.361779] Subtest basic-brightness: SUCCESS (0.396s)
[60.199243] [005/133] (958s left) prime_mmap_kms (buffer-sharing)
[60.291957] Starting subtest: buffer-sharing
[60.741074] Subtest buffer-sharing: SUCCESS (0.449s)
[61.614546] [006/133] (957s left) kms_dsc (dsc-with-bpc-formats)
[61.713448] Starting subtest: dsc-with-bpc-formats
[61.829293] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[61.864196] [007/133] (957s left) gem_pread (snoop)
[61.923061] Subtest snoop: SKIP (0.000s)
[61.986251] [008/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[62.085692] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[62.087971] Starting dynamic subtest: pipe-A
[62.445280] Dynamic subtest pipe-A: SUCCESS (0.364s)
[62.452515] Starting dynamic subtest: pipe-B
[63.838759] Dynamic subtest pipe-B: SUCCESS (1.392s)
[63.848724] Starting dynamic subtest: pipe-C
[65.257902] Dynamic subtest pipe-C: SUCCESS (1.418s)
[65.266417] Starting dynamic subtest: pipe-D
[66.698790] Dynamic subtest pipe-D: SUCCESS (1.439s)
[66.701101] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.615s)
[67.880203] [009/133] (951s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[68.079381] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[68.083532] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[68.148045] [010/133] (951s left) gem_mmap_gtt (hang)
[68.206058] Subtest hang: SKIP (0.000s)
[68.259660] [011/133] (950s left) gem_exec_store (basic)
[68.321744] Starting subtest: basic
[68.409246] Subtest basic: SUCCESS (0.089s)
[68.602860] [012/133] (950s left) gem_ctx_exec (basic)
[68.656967] Starting subtest: basic
[68.661943] Subtest basic: SUCCESS (0.007s)
[68.783228] [013/133] (950s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[68.871729] Starting subtest: primary-4-tiled-reflect-x-180
[75.793739] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.920s)
[76.961849] [014/133] (942s left) gem_readwrite (read-write)
[77.023297] Subtest read-write: SKIP (0.000s)
[77.085807] [015/133] (942s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[77.192798] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[77.197437] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[77.264095] [016/133] (942s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[77.408564] Starting subtest: 2x-long-flip-vs-cursor-atomic
[77.413104] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[77.560208] [017/133] (941s left) kms_psr (fbc-psr-cursor-blt)
[77.652193] Starting subtest: fbc-psr-cursor-blt
[77.654493] Starting dynamic subtest: eDP-1
[77.658781] Dynamic subtest eDP-1: SKIP (0.000s)
[77.663591] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[77.726170] [018/133] (941s left) gen9_exec_parse (bb-large)
[77.801357] Subtest bb-large: SKIP (0.000s)
[77.862726] [019/133] (941s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[77.959136] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[77.961114] Starting dynamic subtest: pipe-A-eDP-1
[78.794881] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[78.804240] Starting dynamic subtest: pipe-B-eDP-1
[80.422339] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.625s)
[80.433833] Starting dynamic subtest: pipe-C-eDP-1
[81.906222] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[81.913773] Starting dynamic subtest: pipe-D-eDP-1
[83.406889] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.498s)
[83.408877] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.436s)
[84.587262] [020/133] (935s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[84.688257] Starting subtest: fbc-tiling-linear
[88.401791] Subtest fbc-tiling-linear: SUCCESS (3.716s)
[89.626197] [021/133] (930s left) i915_drm_fdinfo (memory-info-shared)
[89.687761] Starting subtest: memory-info-shared
[89.690262] Starting dynamic subtest: smem0
[89.735242] Dynamic subtest smem0: SUCCESS (0.050s)
[89.738054] Subtest memory-info-shared: SUCCESS (0.050s)
[89.805953] [022/133] (929s left) gem_workarounds (reset-context)
[89.880383] Starting subtest: reset-context
[90.069800] Subtest reset-context: SUCCESS (0.189s)
[90.199794] [023/133] (929s left) i915_query (query-regions-garbage-items)
[90.261312] Starting subtest: query-regions-garbage-items
[90.263630] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[90.368618] [024/133] (929s left) kms_lease (lease-get)
[90.453044] Starting subtest: lease-get
[90.455371] Starting dynamic subtest: pipe-A-eDP-1
[90.457686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[90.466236] Starting dynamic subtest: pipe-B-eDP-1
[90.468442] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[90.476311] Starting dynamic subtest: pipe-C-eDP-1
[90.478524] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[90.486283] Starting dynamic subtest: pipe-D-eDP-1
[90.488481] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[90.490731] Subtest lease-get: SUCCESS (0.008s)
[90.576972] [025/133] (929s left) gem_exec_balancer (bonded-sync)
[90.639026] Starting subtest: bonded-sync
[90.642996] Subtest bonded-sync: SKIP (0.000s)
[90.940667] [026/133] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[90.989308] Starting subtest: etime-multi-wait-all-for-submit-submitted
[91.098063] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[91.170240] [027/133] (928s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[91.287105] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[91.291658] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[91.445307] [028/133] (928s left) kms_properties (connector-properties-atomic)
[91.527383] Starting subtest: connector-properties-atomic
[91.529681] Starting dynamic subtest: pipe-A-eDP-1
[99.297194] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.766s)
[99.308852] Starting dynamic subtest: pipe-None-DP-1
[99.313111] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[99.322720] Starting dynamic subtest: pipe-None-HDMI-A-1
[99.327067] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[99.334516] Starting dynamic subtest: pipe-None-DP-2
[99.338540] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[99.346071] Starting dynamic subtest: pipe-None-HDMI-A-2
[99.350076] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[99.357336] Starting dynamic subtest: pipe-None-DP-3
[99.364610] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[99.372750] Starting dynamic subtest: pipe-None-DP-4
[99.378597] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[99.381650] Subtest connector-properties-atomic: SUCCESS (7.777s)
[100.151164] [029/133] (919s left) kms_cursor_crc (cursor-random-256x85)
[100.431841] Starting subtest: cursor-random-256x85
[100.481046] Subtest cursor-random-256x85: SKIP (0.043s)
[100.631536] [030/133] (919s left) gem_close_race (multigpu-basic-process)
[100.691025] Starting subtest: multigpu-basic-process
[100.695349] Subtest multigpu-basic-process: SKIP (0.000s)
[100.913669] [031/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[101.008487] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[101.012828] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.088631] [032/133] (918s left) gem_pwrite (basic-self)
[101.139064] Subtest basic-self: SKIP (0.000s)
[101.190410] [033/133] (918s left) gem_exec_params (larger-than-life-batch)
[101.249747] Starting subtest: larger-than-life-batch
[103.541612] Subtest larger-than-life-batch: SUCCESS (2.293s)
[103.952413] [034/133] (916s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[104.063929] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[104.066401] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[104.177293] [035/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[104.282633] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[104.287211] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[104.379407] [036/133] (915s left) gem_exec_schedule (semaphore-noskip)
[104.453096] Starting subtest: semaphore-noskip
[104.875351] Subtest semaphore-noskip: SUCCESS (0.426s)
[105.222626] [037/133] (915s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[105.279287] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[105.334957] [038/133] (914s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[105.427123] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[105.429450] Starting dynamic subtest: pipe-A-eDP-1
[105.489085] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[105.499819] Starting dynamic subtest: pipe-B-eDP-1
[105.558211] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[105.567915] Starting dynamic subtest: pipe-C-eDP-1
[105.625277] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[105.633828] Starting dynamic subtest: pipe-D-eDP-1
[105.688586] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[105.692762] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[107.716853] [039/133] (912s left) kms_prop_blob (blob-multiple)
[107.778401] Starting subtest: blob-multiple
[107.780954] Subtest blob-multiple: SUCCESS (0.002s)
[107.887335] [040/133] (912s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[107.983359] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[107.987828] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[108.101491] [041/133] (912s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[108.197734] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[108.200018] Starting dynamic subtest: pipe-A-default-mode
[110.938594] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[110.941066] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.742s)
[111.811506] [042/133] (908s left) kms_chamelium_frames (vga-frame-dump)
[112.213446] Subtest vga-frame-dump: SKIP (0.000s)
[113.024808] [043/133] (907s left) vgem_basic (create)
[113.156636] Starting subtest: create
[113.158948] Subtest create: SUCCESS (0.000s)
[113.208439] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[113.212928] [044/133] (907s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[113.271690] Starting subtest: wait-all-for-submit-delayed-submit
[113.375113] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[113.454313] [045/133] (907s left) gem_exec_params (sol-reset-invalid)
[113.514904] Starting subtest: sol-reset-invalid
[113.517429] Subtest sol-reset-invalid: SUCCESS (0.003s)
[115.003019] [046/133] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[115.119373] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[121.772114] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.655s)
[121.906030] [047/133] (898s left) kms_busy (basic-hang)
[122.004663] Starting subtest: basic-hang
[122.006908] Starting dynamic subtest: flip-pipe-A
[122.628037] Dynamic subtest flip-pipe-A: SUCCESS (0.623s)
[122.638184] Starting dynamic subtest: modeset-pipe-A
[126.038415] Dynamic subtest modeset-pipe-A: SUCCESS (3.408s)
[126.047890] Starting dynamic subtest: flip-pipe-D
[127.218815] Dynamic subtest flip-pipe-D: SUCCESS (1.180s)
[127.231341] Starting dynamic subtest: modeset-pipe-D
[130.662194] Dynamic subtest modeset-pipe-D: SUCCESS (3.440s)
[130.664364] Subtest basic-hang: SUCCESS (8.657s)
[131.463862] [048/133] (889s left) kms_plane_multiple (2x-tiling-4)
[131.564625] Starting subtest: 2x-tiling-4
[131.568985] Subtest 2x-tiling-4: SKIP (0.000s)
[131.637918] [049/133] (889s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[131.735187] Starting subtest: x-tiled-64bpp-rotate-180
[133.349335] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.615s)
[133.526678] [050/133] (887s left) i915_pm_freq_api (freq-suspend)
[133.591814] Starting subtest: freq-suspend
[133.594172] Starting dynamic subtest: gt0
[149.502664] Dynamic subtest gt0: SUCCESS (1.366s)
[149.514494] Starting dynamic subtest: gt1
[165.515806] Dynamic subtest gt1: SUCCESS (1.245s)
[165.517745] Subtest freq-suspend: SUCCESS (2.616s)
[165.603557] [051/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[165.702200] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[165.706733] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[165.796131] [052/133] (855s left) sw_sync (alloc_merge_fence)
[165.841159] Starting subtest: alloc_merge_fence
[165.843435] Subtest alloc_merge_fence: SUCCESS (0.000s)
[165.897224] [053/133] (855s left) gem_exec_fence (submit3)
[166.071098] Starting subtest: submit3
[166.075709] Subtest submit3: SKIP (0.000s)
[168.276509] [054/133] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[168.393035] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[172.820373] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.412s)
[174.015852] [055/133] (847s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[174.112315] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[174.114622] Starting dynamic subtest: pipe-A-eDP-1
[174.137241] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.149519] Starting dynamic subtest: pipe-B-eDP-1
[174.170913] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.180215] Starting dynamic subtest: pipe-C-eDP-1
[174.201686] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.210498] Starting dynamic subtest: pipe-D-eDP-1
[174.232137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.236481] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[176.344303] [056/133] (844s left) gem_ctx_param (invalid-ctx-set)
[176.408183] Starting subtest: invalid-ctx-set
[176.410655] Subtest invalid-ctx-set: SUCCESS (0.001s)
[176.505545] [057/133] (844s left) sw_sync (sync_multi_timeline_wait)
[176.542950] Starting subtest: sync_multi_timeline_wait
[176.545105] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[176.599554] [058/133] (844s left) dumb_buffer (invalid-bpp)
[176.663736] Starting subtest: invalid-bpp
[176.665995] Subtest invalid-bpp: SUCCESS (0.000s)
[176.778201] [059/133] (844s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[176.867813] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[176.871862] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[176.971861] [060/133] (844s left) gem_fence_thrash (bo-write-verify-threaded-y)
[177.005894] Starting subtest: bo-write-verify-threaded-y
[177.033005] Subtest bo-write-verify-threaded-y: SKIP (0.025s)
[177.108856] [061/133] (844s left) kms_flip (absolute-wf_vblank-interruptible)
[177.206745] Starting subtest: absolute-wf_vblank-interruptible
[177.209095] Starting dynamic subtest: A-eDP1
[185.917202] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[185.930039] Starting dynamic subtest: B-eDP1
[194.643613] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[194.654734] Starting dynamic subtest: C-eDP1
[203.368042] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[203.378127] Starting dynamic subtest: D-eDP1
[212.099481] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[212.104347] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.884s)
[213.325118] [062/133] (808s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[213.421240] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[213.423543] Starting dynamic subtest: pipe-A-eDP-1
[213.432202] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.442171] Starting dynamic subtest: pipe-B-eDP-1
[213.450863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.460434] Starting dynamic subtest: pipe-C-eDP-1
[213.468588] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.477695] Starting dynamic subtest: pipe-D-eDP-1
[213.486060] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.490249] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[215.674642] [063/133] (805s left) kms_psr (psr2-cursor-mmap-gtt)
[215.765532] Starting subtest: psr2-cursor-mmap-gtt
[215.767868] Starting dynamic subtest: eDP-1
[217.436313] Dynamic subtest eDP-1: SUCCESS (1.669s)
[217.438520] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.670s)
[218.226745] [064/133] (803s left) kms_big_fb (linear-8bpp-rotate-0)
[218.325343] Starting subtest: linear-8bpp-rotate-0
[219.572682] Subtest linear-8bpp-rotate-0: SUCCESS (1.247s)
[219.684996] [065/133] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[219.779137] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[226.885677] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.109s)
[227.034442] [066/133] (794s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[227.138468] Starting subtest: 2x-plain-flip-ts-check-interruptible
[227.150852] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[227.244855] [067/133] (794s left) kms_vblank (ts-continuation-suspend)
[227.345518] Starting subtest: ts-continuation-suspend
[227.347433] Starting dynamic subtest: pipe-A-eDP-1
[243.796053] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.516s)
[243.812975] Starting dynamic subtest: pipe-D-eDP-1
[260.797344] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.181s)
[260.799585] Subtest ts-continuation-suspend: SUCCESS (3.701s)
[261.616240] [068/133] (760s left) gem_exec_schedule (preempt-hang)
[261.806537] Starting subtest: preempt-hang
[261.809003] Starting dynamic subtest: rcs0
[262.044052] Dynamic subtest rcs0: SUCCESS (0.236s)
[262.061542] Starting dynamic subtest: bcs0
[262.274946] Dynamic subtest bcs0: SUCCESS (0.230s)
[262.284560] Starting dynamic subtest: vcs0
[262.503706] Dynamic subtest vcs0: SUCCESS (0.228s)
[262.515127] Starting dynamic subtest: vcs1
[262.732076] Dynamic subtest vcs1: SUCCESS (0.226s)
[262.744068] Starting dynamic subtest: vecs0
[262.962729] Dynamic subtest vecs0: SUCCESS (0.228s)
[262.975085] Starting dynamic subtest: ccs0
[263.192985] Dynamic subtest ccs0: SUCCESS (0.229s)
[263.194931] Subtest preempt-hang: SUCCESS (1.383s)
[264.019647] [069/133] (757s left) i915_pm_rc6_residency (rc6-fence)
[264.079585] Starting subtest: rc6-fence
[264.104558] Starting dynamic subtest: gt0
[276.448969] Dynamic subtest gt0: SUCCESS (12.316s)
[276.461170] Starting dynamic subtest: gt1
[291.889741] Dynamic subtest gt1: SUCCESS (15.424s)
[291.892566] Subtest rc6-fence: SUCCESS (27.772s)
[291.969870] [070/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[292.087657] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[292.091643] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[292.189810] [071/133] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[292.295782] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[292.300066] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[292.446334] [072/133] (729s left) kms_cdclk (mode-transition)
[292.550443] Starting subtest: mode-transition
[292.552756] Starting dynamic subtest: pipe-A-eDP-1
[292.842128] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[292.852761] Starting dynamic subtest: pipe-B-eDP-1
[292.857340] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[292.867732] Starting dynamic subtest: pipe-C-eDP-1
[292.872311] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[292.882234] Starting dynamic subtest: pipe-D-eDP-1
[292.886539] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[292.890725] Subtest mode-transition: SKIP (0.297s)
[293.700480] [073/133] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[293.804374] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[297.401782] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.603s)
[298.608915] [074/133] (723s left) gem_ctx_isolation (nonpriv)
[298.680756] Starting subtest: nonpriv
[298.683250] Starting dynamic subtest: rcs0
[298.926065] Dynamic subtest rcs0: SUCCESS (0.243s)
[298.938627] Starting dynamic subtest: bcs0
[299.259140] Dynamic subtest bcs0: SUCCESS (0.334s)
[299.272644] Starting dynamic subtest: vcs0
[299.510272] Dynamic subtest vcs0: SUCCESS (0.251s)
[299.520150] Starting dynamic subtest: vcs1
[301.198177] Dynamic subtest vcs1: SUCCESS (1.687s)
[301.210805] Starting dynamic subtest: vecs0
[303.202684] Dynamic subtest vecs0: SUCCESS (2.004s)
[303.217794] Starting dynamic subtest: ccs0
[305.220508] Dynamic subtest ccs0: SUCCESS (2.017s)
[305.223133] Subtest nonpriv: SUCCESS (6.541s)
[305.466741] [075/133] (716s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[305.521588] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[305.523924] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[305.626184] [076/133] (716s left) kms_psr (pr-suspend)
[305.723543] Starting subtest: pr-suspend
[305.727676] Subtest pr-suspend: SKIP (0.000s)
[305.800941] [077/133] (716s left) kms_plane_scaling (2x-scaler-multi-pipe)
[305.890284] Starting subtest: 2x-scaler-multi-pipe
[305.894700] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[305.985708] [078/133] (716s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[306.078328] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[306.450090] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[309.245826] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[309.260566] Starting dynamic subtest: pipe-A-eDP-1-4
[311.431797] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[311.443948] Starting dynamic subtest: pipe-A-eDP-1-4
[313.442235] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[313.452211] Starting dynamic subtest: pipe-A-eDP-1-x
[315.620944] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[315.989773] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[318.770516] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[318.783667] Starting dynamic subtest: pipe-B-eDP-1-4
[320.967723] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[320.979652] Starting dynamic subtest: pipe-B-eDP-1-4
[322.978575] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[322.992257] Starting dynamic subtest: pipe-B-eDP-1-x
[325.168832] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[325.537729] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[328.298291] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[328.310850] Starting dynamic subtest: pipe-C-eDP-1-4
[330.472994] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[330.489228] Starting dynamic subtest: pipe-C-eDP-1-4
[332.484297] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[332.495995] Starting dynamic subtest: pipe-C-eDP-1-x
[334.663276] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[335.031632] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[337.834222] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.808s)
[337.846673] Starting dynamic subtest: pipe-D-eDP-1-4
[340.008923] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[340.018802] Starting dynamic subtest: pipe-D-eDP-1-4
[342.020092] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[342.030267] Starting dynamic subtest: pipe-D-eDP-1-x
[344.199819] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[344.202853] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.114s)
[345.421770] [079/133] (676s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[345.479206] Starting subtest: y-tiled-ccs-to-x-tiled
[345.483798] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[345.671245] [080/133] (676s left) kms_flip (modeset-vs-vblank-race-interruptible)
[345.773948] Starting subtest: modeset-vs-vblank-race-interruptible
[345.776286] Starting dynamic subtest: A-eDP1
[350.448392] Dynamic subtest A-eDP1: SUCCESS (4.671s)
[350.463292] Starting dynamic subtest: B-eDP1
[355.087328] Dynamic subtest B-eDP1: SUCCESS (4.634s)
[355.099997] Starting dynamic subtest: C-eDP1
[359.694131] Dynamic subtest C-eDP1: SUCCESS (4.604s)
[359.704446] Starting dynamic subtest: D-eDP1
[364.310914] Dynamic subtest D-eDP1: SUCCESS (4.617s)
[364.315905] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.540s)
[365.482842] [081/133] (656s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[365.538148] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[365.542929] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[365.726874] [082/133] (656s left) perf_pmu (semaphore-busy)
[365.773038] Starting subtest: semaphore-busy
[365.775246] Starting dynamic subtest: rcs0
[367.380476] Dynamic subtest rcs0: SUCCESS (1.604s)
[367.392592] Starting dynamic subtest: bcs0
[369.012095] Dynamic subtest bcs0: SUCCESS (1.629s)
[369.023954] Starting dynamic subtest: vcs0
[373.420446] Dynamic subtest vcs0: SUCCESS (4.407s)
[373.432516] Starting dynamic subtest: vcs1
[379.436455] Dynamic subtest vcs1: SUCCESS (6.014s)
[379.448388] Starting dynamic subtest: vecs0
[385.453136] Dynamic subtest vecs0: SUCCESS (6.012s)
[385.464273] Starting dynamic subtest: ccs0
[388.527186] Dynamic subtest ccs0: SUCCESS (3.069s)
[388.529829] Subtest semaphore-busy: SUCCESS (22.755s)
[388.644687] [083/133] (633s left) kms_joiner (basic-max-non-joiner)
[388.772859] Starting subtest: basic-max-non-joiner
[388.777142] Subtest basic-max-non-joiner: SKIP (0.000s)
[388.878785] [084/133] (633s left) gem_eio (wait-wedge-immediate)
[389.064338] Starting subtest: wait-wedge-immediate
[391.017367] Subtest wait-wedge-immediate: SUCCESS (1.952s)
[391.142800] [085/133] (631s left) kms_flip (flip-vs-dpms-on-nop)
[391.233628] Starting subtest: flip-vs-dpms-on-nop
[391.235941] Starting dynamic subtest: A-eDP1
[393.091369] Dynamic subtest A-eDP1: SUCCESS (1.857s)
[393.102525] Starting dynamic subtest: B-eDP1
[394.937281] Dynamic subtest B-eDP1: SUCCESS (1.844s)
[394.949246] Starting dynamic subtest: C-eDP1
[396.759126] Dynamic subtest C-eDP1: SUCCESS (1.820s)
[396.770702] Starting dynamic subtest: D-eDP1
[398.599547] Dynamic subtest D-eDP1: SUCCESS (1.837s)
[398.604801] Subtest flip-vs-dpms-on-nop: SUCCESS (7.371s)
[399.782405] [086/133] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[399.898735] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[399.902649] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[400.000575] [087/133] (622s left) gem_vm_create (invalid-create)
[400.068051] Starting subtest: invalid-create
[400.070219] Subtest invalid-create: SUCCESS (0.001s)
[400.188607] [088/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[400.288938] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[407.601908] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.315s)
[407.703776] [089/133] (614s left) gem_fence_thrash (bo-copy)
[407.744055] Starting subtest: bo-copy
[407.762334] Subtest bo-copy: SKIP (0.017s)
[407.829544] [090/133] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[407.923255] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[415.242614] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.320s)
[415.369897] [091/133] (607s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[415.505926] Starting subtest: short-busy-flip-before-cursor-toggle
[415.510356] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[415.666103] [092/133] (607s left) gem_caching (writes)
[415.733668] Subtest writes: SKIP (0.000s)
[415.832654] [093/133] (607s left) gem_exec_whisper (basic-queues-forked-all)
[415.891917] Starting subtest: basic-queues-forked-all
[438.120351] Subtest basic-queues-forked-all: SUCCESS (22.222s)
[438.302885] [094/133] (584s left) syncobj_wait (wait-for-submit-delayed-submit)
[438.367227] Starting subtest: wait-for-submit-delayed-submit
[438.468118] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[438.548281] [095/133] (584s left) api_intel_allocator (reserve-simple)
[438.606122] Starting subtest: reserve-simple
[438.608576] Subtest reserve-simple: SUCCESS (0.005s)
[438.720811] [096/133] (584s left) gem_exec_balancer (parallel-out-fence)
[438.970017] Starting subtest: parallel-out-fence
[440.209616] Subtest parallel-out-fence: SUCCESS (1.243s)
[440.329743] [097/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[440.420917] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[440.425217] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[440.518727] [098/133] (582s left) kms_pm_dc (dc5-dpms)
[441.622184] Starting subtest: dc5-dpms
[443.696564] Subtest dc5-dpms: SUCCESS (2.074s)
[443.774076] [099/133] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[443.869923] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[443.874301] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[443.962562] [100/133] (579s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[444.069948] Starting subtest: 4-tiled-64bpp-rotate-0
[445.605103] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.535s)
[445.784482] [101/133] (577s left) syncobj_basic (bad-handle-to-fd)
[445.839755] Starting subtest: bad-handle-to-fd
[445.842070] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[445.948358] [102/133] (577s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[446.056298] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[446.060713] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[446.130783] [103/133] (577s left) gem_ctx_persistence (legacy-engines-hostile)
[446.191027] Starting subtest: legacy-engines-hostile
[446.193399] Starting dynamic subtest: render
[446.254913] Dynamic subtest render: SUCCESS (0.063s)
[446.268630] Starting dynamic subtest: bsd1
[446.350088] Dynamic subtest bsd1: SUCCESS (0.093s)
[446.363202] Starting dynamic subtest: bsd2
[446.461838] Dynamic subtest bsd2: SUCCESS (0.108s)
[446.474514] Starting dynamic subtest: blt
[446.552293] Dynamic subtest blt: SUCCESS (0.088s)
[446.565195] Starting dynamic subtest: vebox
[446.632177] Dynamic subtest vebox: SUCCESS (0.077s)
[446.634562] Subtest legacy-engines-hostile: SUCCESS (0.443s)
[446.772793] [104/133] (576s left) kms_atomic_interruptible (universal-setplane-primary)
[446.867249] Starting subtest: universal-setplane-primary
[446.869090] Starting dynamic subtest: pipe-A-eDP-1
[454.255127] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.386s)
[454.257598] Subtest universal-setplane-primary: SUCCESS (7.387s)
[455.104233] [105/133] (568s left) kms_cursor_crc (cursor-offscreen-256x256)
[455.340167] Starting subtest: cursor-offscreen-256x256
[455.342349] Starting dynamic subtest: pipe-A-eDP-1
[457.284594] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[457.316573] Starting dynamic subtest: pipe-D-eDP-1
[459.916569] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[459.919038] Subtest cursor-offscreen-256x256: SUCCESS (4.576s)
[460.787113] [106/133] (562s left) gem_mmap_gtt (pf-nonblock)
[460.845907] Subtest pf-nonblock: SKIP (0.000s)
[460.912148] [107/133] (562s left) kms_chamelium_color (gamma)
[461.009131] Subtest gamma: SKIP (0.000s)
[461.059734] [108/133] (562s left) gem_ccs (block-copy-uncompressed)
[461.112727] Starting subtest: block-copy-uncompressed
[461.115068] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[461.135908] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[461.148213] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[461.153024] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[461.163175] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[461.170095] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[461.180392] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[461.187085] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[461.189318] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[461.315399] [109/133] (562s left) gem_softpin (evict-active-interruptible)
[461.372583] Starting subtest: evict-active-interruptible
[461.379682] Subtest evict-active-interruptible: SUCCESS (0.007s)
[461.502410] [110/133] (562s left) sw_sync (sync_multi_consumer)
[461.538004] Starting subtest: sync_multi_consumer
[461.992873] Subtest sync_multi_consumer: SUCCESS (0.454s)
[462.063121] [111/133] (561s left) kms_cursor_crc (cursor-sliding-256x85)
[462.313087] Starting subtest: cursor-sliding-256x85
[462.360421] Subtest cursor-sliding-256x85: SKIP (0.043s)
[462.531331] [112/133] (561s left) gem_ctx_sseu (mmap-args)
[462.585129] Subtest mmap-args: SKIP (0.000s)
[462.643863] [113/133] (561s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[462.735325] Starting subtest: yf-tiled-32bpp-rotate-270
[462.739607] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[462.834294] [114/133] (560s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[462.926881] Starting subtest: yf-tiled-64bpp-rotate-180
[462.931119] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[463.033363] [115/133] (560s left) kms_atomic_transition (plane-toggle-modeset-transition)
[463.122545] Starting subtest: plane-toggle-modeset-transition
[463.124329] Starting dynamic subtest: pipe-A-eDP-1
[475.799658] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.673s)
[475.812034] Starting dynamic subtest: pipe-B-eDP-1
[488.221224] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.416s)
[488.224152] Subtest plane-toggle-modeset-transition: SUCCESS (25.095s)
[489.044201] [116/133] (534s left) kms_content_protection (dp-mst-lic-type-0)
[489.174692] Starting subtest: dp-mst-lic-type-0
[489.179358] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[489.309398] [117/133] (534s left) kms_vrr (seamless-rr-switch-virtual)
[489.409375] Starting subtest: seamless-rr-switch-virtual
[489.416320] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[489.482529] [118/133] (534s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[489.569240] Starting subtest: stress-xrgb8888-xtiled
[495.431859] Subtest stress-xrgb8888-xtiled: SUCCESS (5.864s)
[495.483550] [119/133] (528s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[495.606852] Starting subtest: protected-encrypted-src-copy-not-readible
[495.716975] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[495.864189] [120/133] (528s left) prime_busy (before)
[495.929600] Starting subtest: before
[495.935199] Starting dynamic subtest: rcs0
[495.961810] Dynamic subtest rcs0: SUCCESS (0.029s)
[495.974371] Starting dynamic subtest: bcs0
[496.010490] Dynamic subtest bcs0: SUCCESS (0.048s)
[496.023028] Starting dynamic subtest: vcs0
[496.051036] Dynamic subtest vcs0: SUCCESS (0.040s)
[496.062799] Starting dynamic subtest: vcs1
[496.090842] Dynamic subtest vcs1: SUCCESS (0.040s)
[496.101081] Starting dynamic subtest: vecs0
[496.131863] Dynamic subtest vecs0: SUCCESS (0.040s)
[496.141987] Starting dynamic subtest: ccs0
[496.173894] Dynamic subtest ccs0: SUCCESS (0.041s)
[496.284388] Subtest before: SUCCESS (0.353s)
[496.367171] [121/133] (527s left) kms_psr (fbc-psr2-cursor-render)
[496.460516] Starting subtest: fbc-psr2-cursor-render
[496.462703] Starting dynamic subtest: eDP-1
[496.466767] Dynamic subtest eDP-1: SKIP (0.000s)
[496.470823] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[496.536556] [122/133] (527s left) kms_async_flips (test-cursor-atomic)
[496.627418] Starting subtest: test-cursor-atomic
[496.631908] Subtest test-cursor-atomic: SKIP (0.000s)
[497.869235] [123/133] (526s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[497.966353] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[497.970679] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[498.103076] [124/133] (526s left) sysfs_timeslice_duration (idempotent)
[498.160862] Starting subtest: idempotent
[498.163267] Starting dynamic subtest: vecs0
[498.165585] Dynamic subtest vecs0: SUCCESS (0.000s)
[498.176451] Starting dynamic subtest: ccs0
[498.178673] Dynamic subtest ccs0: SUCCESS (0.000s)
[498.188700] Starting dynamic subtest: vcs0
[498.191092] Dynamic subtest vcs0: SUCCESS (0.000s)
[498.201558] Starting dynamic subtest: bcs0
[498.203662] Dynamic subtest bcs0: SUCCESS (0.000s)
[498.213627] Starting dynamic subtest: rcs0
[498.215743] Dynamic subtest rcs0: SUCCESS (0.000s)
[498.229916] Starting dynamic subtest: vcs1
[498.232088] Dynamic subtest vcs1: SUCCESS (0.000s)
[498.234178] Subtest idempotent: SUCCESS (0.006s)
[498.279219] [125/133] (526s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[498.366229] Starting subtest: primary-yf-tiled-reflect-x-90
[498.370540] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[498.448942] [126/133] (525s left) gem_softpin (evict-single-offset)
[498.528816] Starting subtest: evict-single-offset
[523.953591] Subtest evict-single-offset: SUCCESS (25.429s)
[524.048728] [127/133] (500s left) kms_psr (fbc-pr-cursor-plane-onoff)
[524.196514] Starting subtest: fbc-pr-cursor-plane-onoff
[524.200923] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[524.275128] [128/133] (500s left) kms_color (ctm-negative)
[524.376201] Starting subtest: ctm-negative
[524.378379] Starting dynamic subtest: pipe-A-eDP-1
[525.087755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[525.098292] Starting dynamic subtest: pipe-B-eDP-1
[526.477862] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[526.489074] Starting dynamic subtest: pipe-C-eDP-1
[527.860660] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[527.871838] Starting dynamic subtest: pipe-D-eDP-1
[529.184868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[529.187256] Subtest ctm-negative: SUCCESS (4.811s)
[529.988651] [129/133] (494s left) kms_sequence (get-forked)
[530.081532] Starting subtest: get-forked
[530.083849] Starting dynamic subtest: pipe-A-eDP-1
[531.982231] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[531.994158] Starting dynamic subtest: pipe-B-eDP-1
[534.518792] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.533s)
[534.529783] Starting dynamic subtest: pipe-C-eDP-1
[537.040732] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.520s)
[537.051599] Starting dynamic subtest: pipe-D-eDP-1
[539.570317] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.528s)
[539.572179] Subtest get-forked: SUCCESS (9.488s)
[540.400385] [130/133] (484s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[540.463172] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[540.465510] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[540.557614] [131/133] (483s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[540.652743] Starting subtest: y-tiled-64bpp-rotate-90
[540.657171] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[540.745197] [132/133] (483s left) syncobj_wait (reset-multiple-signaled)
[540.791081] Starting subtest: reset-multiple-signaled
[540.793272] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[540.894736] [133/133] (483s left) core_auth (getclient-master-drop)
[540.933117] Starting subtest: getclient-master-drop
[540.951306] Subtest getclient-master-drop: SUCCESS (0.017s)
[541.063564] 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.