[59.632848] Initializing watchdogs
[59.632896]   /dev/watchdog0
[59.647986] [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]
[59.652526] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.654873] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.656947] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[59.755127] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[59.757240] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[59.837599] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[59.930408] Starting subtest: bo-too-small
[59.931430] Subtest bo-too-small: SUCCESS (0.000s)
[60.018935] [003/133] (960s left) syncobj_basic (bad-destroy-pad)
[60.063840] Starting subtest: bad-destroy-pad
[60.065197] Subtest bad-destroy-pad: SUCCESS (0.000s)
[60.141590] [004/133] (960s left) kms_pm_backlight (basic-brightness)
[60.219179] Starting subtest: basic-brightness
[60.322553] Starting dynamic subtest: eDP-1
[60.624412] Dynamic subtest eDP-1: SUCCESS (0.299s)
[60.625510] Subtest basic-brightness: SUCCESS (0.402s)
[61.414820] [005/133] (958s left) prime_mmap_kms (buffer-sharing)
[61.517975] Starting subtest: buffer-sharing
[61.971753] Subtest buffer-sharing: SUCCESS (0.452s)
[62.757707] [006/133] (957s left) kms_dsc (dsc-with-bpc-formats)
[62.848106] Starting subtest: dsc-with-bpc-formats
[62.886156] Subtest dsc-with-bpc-formats: SKIP (0.005s)
[62.915646] [007/133] (957s left) gem_pread (snoop)
[62.963055] Subtest snoop: SKIP (0.000s)
[63.019888] [008/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[63.104146] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[63.105242] Starting dynamic subtest: pipe-A
[63.446846] Dynamic subtest pipe-A: SUCCESS (0.342s)
[63.455551] Starting dynamic subtest: pipe-B
[64.890870] Dynamic subtest pipe-B: SUCCESS (1.438s)
[64.897925] Starting dynamic subtest: pipe-C
[66.309530] Dynamic subtest pipe-C: SUCCESS (1.414s)
[66.317363] Starting dynamic subtest: pipe-D
[67.804436] Dynamic subtest pipe-D: SUCCESS (1.491s)
[67.805450] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.686s)
[69.016982] [009/133] (951s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[69.100299] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[69.102090] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[69.174273] [010/133] (951s left) gem_mmap_gtt (hang)
[69.222312] Subtest hang: SKIP (0.000s)
[69.283558] [011/133] (951s left) gem_exec_store (basic)
[69.345624] Starting subtest: basic
[69.447321] Subtest basic: SUCCESS (0.101s)
[69.633040] [012/133] (950s left) gem_ctx_exec (basic)
[69.697521] Starting subtest: basic
[69.704465] Subtest basic: SUCCESS (0.007s)
[69.824082] [013/133] (950s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[69.912973] Starting subtest: primary-4-tiled-reflect-x-180
[76.959360] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.039s)
[78.181565] [014/133] (942s left) gem_readwrite (read-write)
[78.235882] Subtest read-write: SKIP (0.000s)
[78.286959] [015/133] (942s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[78.375370] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[78.377064] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[78.470358] [016/133] (942s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[78.580404] Starting subtest: 2x-long-flip-vs-cursor-atomic
[78.583371] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[78.733419] [017/133] (941s left) kms_psr (fbc-psr-cursor-blt)
[78.831330] Starting subtest: fbc-psr-cursor-blt
[78.832266] Starting dynamic subtest: eDP-1
[78.833993] Dynamic subtest eDP-1: SKIP (0.000s)
[78.835572] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[78.894384] [018/133] (941s left) gen9_exec_parse (bb-large)
[78.955253] Subtest bb-large: SKIP (0.000s)
[79.009223] [019/133] (941s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[79.114299] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[79.115251] Starting dynamic subtest: pipe-A-eDP-1
[79.955842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.838s)
[79.962434] Starting dynamic subtest: pipe-B-eDP-1
[81.577658] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.619s)
[81.585024] Starting dynamic subtest: pipe-C-eDP-1
[83.120972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s)
[83.127575] Starting dynamic subtest: pipe-D-eDP-1
[84.636098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.514s)
[84.636991] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.516s)
[85.805620] [020/133] (934s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[85.892212] Starting subtest: fbc-tiling-linear
[89.662221] Subtest fbc-tiling-linear: SUCCESS (3.769s)
[90.800124] [021/133] (929s left) i915_drm_fdinfo (memory-info-shared)
[90.840164] Starting subtest: memory-info-shared
[90.841162] Starting dynamic subtest: smem0
[90.906815] Dynamic subtest smem0: SUCCESS (0.066s)
[90.908277] Subtest memory-info-shared: SUCCESS (0.066s)
[90.983079] [022/133] (929s left) gem_workarounds (reset-context)
[91.054391] Starting subtest: reset-context
[91.240162] Subtest reset-context: SUCCESS (0.186s)
[91.355148] [023/133] (929s left) i915_query (query-regions-garbage-items)
[91.407120] Starting subtest: query-regions-garbage-items
[91.408056] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[91.517097] [024/133] (929s left) kms_lease (lease-get)
[91.599517] Starting subtest: lease-get
[91.600459] Starting dynamic subtest: pipe-A-eDP-1
[91.601482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[91.609378] Starting dynamic subtest: pipe-B-eDP-1
[91.610278] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.616556] Starting dynamic subtest: pipe-C-eDP-1
[91.617437] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[91.623739] Starting dynamic subtest: pipe-D-eDP-1
[91.624616] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[91.625478] Subtest lease-get: SUCCESS (0.008s)
[91.711041] [025/133] (929s left) gem_exec_balancer (bonded-sync)
[91.775146] Starting subtest: bonded-sync
[91.777045] Subtest bonded-sync: SKIP (0.000s)
[92.065664] [026/133] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[92.117030] Starting subtest: etime-multi-wait-all-for-submit-submitted
[92.225940] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[92.295071] [027/133] (928s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[92.401715] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[92.404871] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[92.538738] [028/133] (928s left) kms_properties (connector-properties-atomic)
[92.626079] Starting subtest: connector-properties-atomic
[92.627016] Starting dynamic subtest: pipe-A-eDP-1
[100.390924] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.761s)
[100.397976] Starting dynamic subtest: pipe-None-DP-1
[100.399690] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[100.405795] Starting dynamic subtest: pipe-None-HDMI-A-1
[100.407450] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[100.413533] Starting dynamic subtest: pipe-None-DP-2
[100.415254] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[100.421606] Starting dynamic subtest: pipe-None-HDMI-A-2
[100.423327] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[100.430434] Starting dynamic subtest: pipe-None-DP-3
[100.432344] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[100.438709] Starting dynamic subtest: pipe-None-DP-4
[100.440410] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[100.441286] Subtest connector-properties-atomic: SUCCESS (7.771s)
[101.259786] [029/133] (919s left) kms_cursor_crc (cursor-random-256x85)
[101.520874] Starting subtest: cursor-random-256x85
[101.564663] Subtest cursor-random-256x85: SKIP (0.041s)
[101.729692] [030/133] (919s left) gem_close_race (multigpu-basic-process)
[101.796536] Starting subtest: multigpu-basic-process
[101.798316] Subtest multigpu-basic-process: SKIP (0.000s)
[102.039777] [031/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[102.128127] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[102.129849] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[102.238415] [032/133] (918s left) gem_pwrite (basic-self)
[102.292076] Subtest basic-self: SKIP (0.000s)
[102.343477] [033/133] (918s left) gem_exec_params (larger-than-life-batch)
[102.396539] Starting subtest: larger-than-life-batch
[104.739882] Subtest larger-than-life-batch: SUCCESS (2.342s)
[104.962548] [034/133] (916s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[105.056446] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[105.057599] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[105.156496] [035/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[105.250555] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[105.252244] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[105.346451] [036/133] (915s left) gem_exec_schedule (semaphore-noskip)
[105.416149] Starting subtest: semaphore-noskip
[105.861613] Subtest semaphore-noskip: SUCCESS (0.435s)
[106.175593] [037/133] (915s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[106.233440] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[106.282791] [038/133] (915s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[106.371981] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[106.373018] Starting dynamic subtest: pipe-A-eDP-1
[106.394858] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[106.407080] Starting dynamic subtest: pipe-B-eDP-1
[106.427889] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[106.434665] Starting dynamic subtest: pipe-C-eDP-1
[106.455256] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[106.461975] Starting dynamic subtest: pipe-D-eDP-1
[106.482484] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[106.484065] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[108.635942] [039/133] (912s left) kms_prop_blob (blob-multiple)
[108.691274] Starting subtest: blob-multiple
[108.693397] Subtest blob-multiple: SUCCESS (0.002s)
[108.791022] [040/133] (912s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[108.886394] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[108.888180] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[108.976779] [041/133] (912s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[109.055141] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[109.056024] Starting dynamic subtest: pipe-A-default-mode
[111.758469] Dynamic subtest pipe-A-default-mode: SUCCESS (2.701s)
[111.759366] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.702s)
[112.622959] [042/133] (908s left) kms_chamelium_frames (vga-frame-dump)
[113.012633] Subtest vga-frame-dump: SKIP (0.000s)
[113.844902] [043/133] (907s left) vgem_basic (create)
[113.955755] Starting subtest: create
[113.956744] Subtest create: SUCCESS (0.000s)
[114.007050] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[114.008822] [044/133] (907s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[114.057338] Starting subtest: wait-all-for-submit-delayed-submit
[114.160989] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[114.255744] [045/133] (907s left) gem_exec_params (sol-reset-invalid)
[114.313338] Starting subtest: sol-reset-invalid
[114.316057] Subtest sol-reset-invalid: SUCCESS (0.002s)
[115.968428] [046/133] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[116.061757] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[122.647450] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.586s)
[122.778586] [047/133] (898s left) kms_busy (basic-hang)
[122.883430] Starting subtest: basic-hang
[122.884447] Starting dynamic subtest: flip-pipe-A
[123.509956] Dynamic subtest flip-pipe-A: SUCCESS (0.625s)
[123.517561] Starting dynamic subtest: modeset-pipe-A
[126.896055] Dynamic subtest modeset-pipe-A: SUCCESS (3.384s)
[126.904514] Starting dynamic subtest: flip-pipe-D
[128.084497] Dynamic subtest flip-pipe-D: SUCCESS (1.186s)
[128.092359] Starting dynamic subtest: modeset-pipe-D
[131.507902] Dynamic subtest modeset-pipe-D: SUCCESS (3.422s)
[131.508809] Subtest basic-hang: SUCCESS (8.624s)
[132.311327] [048/133] (889s left) kms_plane_multiple (2x-tiling-4)
[132.400293] Starting subtest: 2x-tiling-4
[132.401965] Subtest 2x-tiling-4: SKIP (0.000s)
[132.493838] [049/133] (889s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[132.597092] Starting subtest: x-tiled-64bpp-rotate-180
[134.132058] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.535s)
[134.292942] [050/133] (887s left) i915_pm_freq_api (freq-suspend)
[134.348965] Starting subtest: freq-suspend
[134.350061] Starting dynamic subtest: gt0
[151.081648] Dynamic subtest gt0: SUCCESS (2.571s)
[151.092557] Starting dynamic subtest: gt1
[168.055216] Dynamic subtest gt1: SUCCESS (1.617s)
[168.056231] Subtest freq-suspend: SUCCESS (4.190s)
[175.154011] [051/133] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[175.246201] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[175.247937] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[175.337776] [052/133] (853s left) sw_sync (alloc_merge_fence)
[175.370189] Starting subtest: alloc_merge_fence
[175.371123] Subtest alloc_merge_fence: SUCCESS (0.000s)
[175.424893] [053/133] (853s left) gem_exec_fence (submit3)
[175.599861] Starting subtest: submit3
[175.601754] Subtest submit3: SKIP (0.000s)
[177.524087] [054/133] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[177.621872] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[182.229450] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.513s)
[183.361981] [055/133] (845s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[183.463046] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[183.463951] Starting dynamic subtest: pipe-A-eDP-1
[183.472172] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[183.480665] Starting dynamic subtest: pipe-B-eDP-1
[183.488781] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[183.499305] Starting dynamic subtest: pipe-C-eDP-1
[183.507265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[183.514785] Starting dynamic subtest: pipe-D-eDP-1
[183.523012] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[183.524679] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[185.740216] [056/133] (843s left) gem_ctx_param (invalid-ctx-set)
[185.783993] Starting subtest: invalid-ctx-set
[185.784935] Subtest invalid-ctx-set: SUCCESS (0.001s)
[185.872497] [057/133] (843s left) sw_sync (sync_multi_timeline_wait)
[185.903234] Starting subtest: sync_multi_timeline_wait
[185.904152] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[185.950999] [058/133] (843s left) dumb_buffer (invalid-bpp)
[185.999918] Starting subtest: invalid-bpp
[186.000886] Subtest invalid-bpp: SUCCESS (0.000s)
[186.077935] [059/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[186.173776] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[186.175582] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[186.277781] [060/133] (842s left) gem_fence_thrash (bo-write-verify-threaded-y)
[186.321295] Starting subtest: bo-write-verify-threaded-y
[186.336128] Subtest bo-write-verify-threaded-y: SKIP (0.015s)
[186.399441] [061/133] (842s left) kms_flip (absolute-wf_vblank-interruptible)
[186.493471] Starting subtest: absolute-wf_vblank-interruptible
[186.494894] Starting dynamic subtest: A-eDP1
[195.268013] Dynamic subtest A-eDP1: SUCCESS (8.699s)
[195.277627] Starting dynamic subtest: B-eDP1
[204.015765] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[204.026257] Starting dynamic subtest: C-eDP1
[212.752520] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[212.762934] Starting dynamic subtest: D-eDP1
[221.484020] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[221.484899] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.883s)
[222.670670] [062/133] (806s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[222.762614] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[222.763578] Starting dynamic subtest: pipe-A-eDP-1
[222.767342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.776498] Starting dynamic subtest: pipe-B-eDP-1
[222.780402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.788361] Starting dynamic subtest: pipe-C-eDP-1
[222.792174] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.800227] Starting dynamic subtest: pipe-D-eDP-1
[222.803877] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.805672] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[225.016845] [063/133] (804s left) kms_psr (psr2-cursor-mmap-gtt)
[225.098063] Starting subtest: psr2-cursor-mmap-gtt
[225.098914] Starting dynamic subtest: eDP-1
[227.055221] Dynamic subtest eDP-1: SUCCESS (1.956s)
[227.056111] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.957s)
[227.862069] [064/133] (801s left) kms_big_fb (linear-8bpp-rotate-0)
[227.948749] Starting subtest: linear-8bpp-rotate-0
[229.185021] Subtest linear-8bpp-rotate-0: SUCCESS (1.235s)
[229.292287] [065/133] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[229.397903] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[236.492565] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.091s)
[236.637397] [066/133] (792s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[236.731031] Starting subtest: 2x-plain-flip-ts-check-interruptible
[236.742633] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[236.831688] [067/133] (792s left) kms_vblank (ts-continuation-suspend)
[236.923744] Starting subtest: ts-continuation-suspend
[236.924545] Starting dynamic subtest: pipe-A-eDP-1
[253.349680] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s)
[253.359632] Starting dynamic subtest: pipe-D-eDP-1
[271.346578] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s)
[271.347525] Subtest ts-continuation-suspend: SUCCESS (4.515s)
[278.179268] [068/133] (757s left) gem_exec_schedule (preempt-hang)
[278.363042] Starting subtest: preempt-hang
[278.364711] Starting dynamic subtest: rcs0
[278.619272] Dynamic subtest rcs0: SUCCESS (0.257s)
[278.627987] Starting dynamic subtest: bcs0
[278.862446] Dynamic subtest bcs0: SUCCESS (0.235s)
[278.871213] Starting dynamic subtest: vcs0
[279.102265] Dynamic subtest vcs0: SUCCESS (0.230s)
[279.110702] Starting dynamic subtest: vcs1
[279.338527] Dynamic subtest vcs1: SUCCESS (0.230s)
[279.346918] Starting dynamic subtest: vecs0
[279.607437] Dynamic subtest vecs0: SUCCESS (0.258s)
[279.622465] Starting dynamic subtest: ccs0
[279.888731] Dynamic subtest ccs0: SUCCESS (0.274s)
[279.890142] Subtest preempt-hang: SUCCESS (1.490s)
[280.460194] [069/133] (755s left) i915_pm_rc6_residency (rc6-fence)
[280.515062] Starting subtest: rc6-fence
[280.528773] Starting dynamic subtest: gt0
[292.996423] Dynamic subtest gt0: SUCCESS (12.310s)
[293.009402] Starting dynamic subtest: gt1
[309.308096] Dynamic subtest gt1: SUCCESS (16.260s)
[309.309341] Subtest rc6-fence: SUCCESS (28.589s)
[309.373790] [070/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[309.464954] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[309.466765] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[309.566504] [071/133] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[309.659441] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[309.661165] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[309.745102] [072/133] (725s left) kms_cdclk (mode-transition)
[309.837334] Starting subtest: mode-transition
[309.838276] Starting dynamic subtest: pipe-A-eDP-1
[310.129830] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[310.139449] Starting dynamic subtest: pipe-B-eDP-1
[310.141387] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[310.152779] Starting dynamic subtest: pipe-C-eDP-1
[310.154895] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[310.163912] Starting dynamic subtest: pipe-D-eDP-1
[310.166297] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[310.168348] Subtest mode-transition: SKIP (0.298s)
[310.939428] [073/133] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[311.030599] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[314.666902] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.636s)
[315.839207] [074/133] (719s left) gem_ctx_isolation (nonpriv)
[315.905306] Starting subtest: nonpriv
[315.906381] Starting dynamic subtest: rcs0
[316.139428] Dynamic subtest rcs0: SUCCESS (0.236s)
[316.150548] Starting dynamic subtest: bcs0
[316.390271] Dynamic subtest bcs0: SUCCESS (0.250s)
[316.401258] Starting dynamic subtest: vcs0
[316.633840] Dynamic subtest vcs0: SUCCESS (0.242s)
[316.644613] Starting dynamic subtest: vcs1
[318.546918] Dynamic subtest vcs1: SUCCESS (1.911s)
[318.555284] Starting dynamic subtest: vecs0
[320.565610] Dynamic subtest vecs0: SUCCESS (2.017s)
[320.576252] Starting dynamic subtest: ccs0
[322.617363] Dynamic subtest ccs0: SUCCESS (2.050s)
[322.618442] Subtest nonpriv: SUCCESS (6.713s)
[322.856965] [075/133] (712s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[322.911383] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[322.912300] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[323.018511] [076/133] (712s left) kms_psr (pr-suspend)
[323.111542] Starting subtest: pr-suspend
[323.113441] Subtest pr-suspend: SKIP (0.000s)
[323.193252] [077/133] (712s left) kms_plane_scaling (2x-scaler-multi-pipe)
[323.271684] Starting subtest: 2x-scaler-multi-pipe
[323.273459] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[323.358698] [078/133] (712s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[323.449340] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[323.834123] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[326.624624] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[326.636092] Starting dynamic subtest: pipe-A-eDP-1-4
[328.811260] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[328.821766] Starting dynamic subtest: pipe-A-eDP-1-4
[330.821398] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[330.830520] Starting dynamic subtest: pipe-A-eDP-1-x
[333.013402] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[333.373400] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[336.159482] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[336.170981] Starting dynamic subtest: pipe-B-eDP-1-4
[338.345922] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[338.356825] Starting dynamic subtest: pipe-B-eDP-1-4
[340.355794] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[340.364169] Starting dynamic subtest: pipe-B-eDP-1-x
[342.536260] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[342.894577] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[345.688412] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[345.703484] Starting dynamic subtest: pipe-C-eDP-1-4
[347.864152] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[347.877949] Starting dynamic subtest: pipe-C-eDP-1-4
[349.875268] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[349.884124] Starting dynamic subtest: pipe-C-eDP-1-x
[352.054462] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[352.429623] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[355.226171] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[355.239090] Starting dynamic subtest: pipe-D-eDP-1-4
[357.401347] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[357.412120] Starting dynamic subtest: pipe-D-eDP-1-4
[359.411644] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[359.425129] Starting dynamic subtest: pipe-D-eDP-1-x
[361.591841] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.176s)
[361.593099] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.120s)
[362.810409] [079/133] (673s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[362.865673] Starting subtest: y-tiled-ccs-to-x-tiled
[362.867311] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[363.042513] [080/133] (672s left) kms_flip (modeset-vs-vblank-race-interruptible)
[363.128610] Starting subtest: modeset-vs-vblank-race-interruptible
[363.132422] Starting dynamic subtest: A-eDP1
[367.818328] Dynamic subtest A-eDP1: SUCCESS (4.683s)
[367.830902] Starting dynamic subtest: B-eDP1
[372.443874] Dynamic subtest B-eDP1: SUCCESS (4.621s)
[372.454829] Starting dynamic subtest: C-eDP1
[377.038194] Dynamic subtest C-eDP1: SUCCESS (4.592s)
[377.046701] Starting dynamic subtest: D-eDP1
[381.657940] Dynamic subtest D-eDP1: SUCCESS (4.622s)
[381.661832] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.533s)
[382.825364] [081/133] (653s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[382.879287] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[382.880836] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[383.071640] [082/133] (652s left) perf_pmu (semaphore-busy)
[383.108150] Starting subtest: semaphore-busy
[383.109161] Starting dynamic subtest: rcs0
[384.757398] Dynamic subtest rcs0: SUCCESS (1.640s)
[384.769463] Starting dynamic subtest: bcs0
[386.388602] Dynamic subtest bcs0: SUCCESS (1.629s)
[386.399490] Starting dynamic subtest: vcs0
[390.834391] Dynamic subtest vcs0: SUCCESS (4.445s)
[390.843934] Starting dynamic subtest: vcs1
[396.851465] Dynamic subtest vcs1: SUCCESS (6.015s)
[396.862761] Starting dynamic subtest: vecs0
[402.867165] Dynamic subtest vecs0: SUCCESS (6.014s)
[402.878230] Starting dynamic subtest: ccs0
[405.944455] Dynamic subtest ccs0: SUCCESS (3.075s)
[405.945558] Subtest semaphore-busy: SUCCESS (22.836s)
[406.052329] [083/133] (629s left) kms_joiner (basic-max-non-joiner)
[406.137450] Starting subtest: basic-max-non-joiner
[406.139051] Subtest basic-max-non-joiner: SKIP (0.000s)
[406.220139] [084/133] (629s left) gem_eio (wait-wedge-immediate)
[406.393418] Starting subtest: wait-wedge-immediate
[408.359799] Subtest wait-wedge-immediate: SUCCESS (1.966s)
[408.492356] [085/133] (627s left) kms_flip (flip-vs-dpms-on-nop)
[408.581137] Starting subtest: flip-vs-dpms-on-nop
[408.583302] Starting dynamic subtest: A-eDP1
[410.422280] Dynamic subtest A-eDP1: SUCCESS (1.840s)
[410.434649] Starting dynamic subtest: B-eDP1
[412.257079] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[412.268592] Starting dynamic subtest: C-eDP1
[414.094464] Dynamic subtest C-eDP1: SUCCESS (1.833s)
[414.104857] Starting dynamic subtest: D-eDP1
[415.923019] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[415.925875] Subtest flip-vs-dpms-on-nop: SUCCESS (7.346s)
[417.105665] [086/133] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[417.204493] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[417.206108] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.318647] [087/133] (618s left) gem_vm_create (invalid-create)
[417.369344] Starting subtest: invalid-create
[417.371661] Subtest invalid-create: SUCCESS (0.001s)
[417.478104] [088/133] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[417.574315] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[424.950095] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.376s)
[425.093283] [089/133] (611s left) gem_fence_thrash (bo-copy)
[425.127818] Starting subtest: bo-copy
[425.146723] Subtest bo-copy: SKIP (0.017s)
[425.213483] [090/133] (610s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[425.307703] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[432.666951] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.359s)
[432.803449] [091/133] (603s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[432.912821] Starting subtest: short-busy-flip-before-cursor-toggle
[432.914594] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[433.066927] [092/133] (603s left) gem_caching (writes)
[433.128880] Subtest writes: SKIP (0.000s)
[433.191181] [093/133] (603s left) gem_exec_whisper (basic-queues-forked-all)
[433.248136] Starting subtest: basic-queues-forked-all
[455.591441] Subtest basic-queues-forked-all: SUCCESS (22.330s)
[455.759767] [094/133] (580s left) syncobj_wait (wait-for-submit-delayed-submit)
[455.819443] Starting subtest: wait-for-submit-delayed-submit
[455.922944] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[455.998654] [095/133] (580s left) api_intel_allocator (reserve-simple)
[456.057154] Starting subtest: reserve-simple
[456.063206] Subtest reserve-simple: SUCCESS (0.007s)
[456.201755] [096/133] (580s left) gem_exec_balancer (parallel-out-fence)
[456.467424] Starting subtest: parallel-out-fence
[457.801110] Subtest parallel-out-fence: SUCCESS (1.334s)
[457.904135] [097/133] (578s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[458.001872] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[458.003718] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[458.099539] [098/133] (578s left) kms_pm_dc (dc5-dpms)
[459.188301] Starting subtest: dc5-dpms
[461.262885] Subtest dc5-dpms: SUCCESS (2.064s)
[461.325666] [099/133] (575s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[461.413105] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[461.414999] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[461.508295] [100/133] (575s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[461.607308] Starting subtest: 4-tiled-64bpp-rotate-0
[463.242981] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.635s)
[463.417955] [101/133] (573s left) syncobj_basic (bad-handle-to-fd)
[463.470173] Starting subtest: bad-handle-to-fd
[463.471011] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[463.574308] [102/133] (573s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[463.656841] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[463.658734] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[463.739962] [103/133] (572s left) gem_ctx_persistence (legacy-engines-hostile)
[463.798208] Starting subtest: legacy-engines-hostile
[463.799135] Starting dynamic subtest: render
[463.906794] Dynamic subtest render: SUCCESS (0.109s)
[463.921659] Starting dynamic subtest: bsd1
[464.001551] Dynamic subtest bsd1: SUCCESS (0.093s)
[464.013583] Starting dynamic subtest: bsd2
[464.097357] Dynamic subtest bsd2: SUCCESS (0.093s)
[464.110629] Starting dynamic subtest: blt
[464.198786] Dynamic subtest blt: SUCCESS (0.098s)
[464.211681] Starting dynamic subtest: vebox
[464.286595] Dynamic subtest vebox: SUCCESS (0.085s)
[464.288237] Subtest legacy-engines-hostile: SUCCESS (0.491s)
[464.377197] [104/133] (572s left) kms_atomic_interruptible (universal-setplane-primary)
[464.472468] Starting subtest: universal-setplane-primary
[464.473329] Starting dynamic subtest: pipe-A-eDP-1
[471.910219] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.436s)
[471.912094] Subtest universal-setplane-primary: SUCCESS (7.438s)
[472.774972] [105/133] (563s left) kms_cursor_crc (cursor-offscreen-256x256)
[473.016469] Starting subtest: cursor-offscreen-256x256
[473.020841] Starting dynamic subtest: pipe-A-eDP-1
[474.976405] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.954s)
[475.005452] Starting dynamic subtest: pipe-D-eDP-1
[477.591876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.594s)
[477.592886] Subtest cursor-offscreen-256x256: SUCCESS (4.574s)
[478.423432] [106/133] (558s left) gem_mmap_gtt (pf-nonblock)
[478.479964] Subtest pf-nonblock: SKIP (0.000s)
[478.542316] [107/133] (558s left) kms_chamelium_color (gamma)
[478.629501] Subtest gamma: SKIP (0.000s)
[478.669946] [108/133] (558s left) gem_ccs (block-copy-uncompressed)
[478.728536] Starting subtest: block-copy-uncompressed
[478.729597] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[478.751578] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[478.760692] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[478.770519] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[478.779150] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[478.787437] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[478.795961] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[478.804446] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[478.805374] Subtest block-copy-uncompressed: SUCCESS (0.076s)
[478.932163] [109/133] (557s left) gem_softpin (evict-active-interruptible)
[478.988200] Starting subtest: evict-active-interruptible
[478.993590] Subtest evict-active-interruptible: SUCCESS (0.006s)
[479.114418] [110/133] (557s left) sw_sync (sync_multi_consumer)
[479.161097] Starting subtest: sync_multi_consumer
[479.576032] Subtest sync_multi_consumer: SUCCESS (0.415s)
[479.624752] [111/133] (557s left) kms_cursor_crc (cursor-sliding-256x85)
[479.865454] Starting subtest: cursor-sliding-256x85
[479.910448] Subtest cursor-sliding-256x85: SKIP (0.043s)
[480.081483] [112/133] (556s left) gem_ctx_sseu (mmap-args)
[480.150368] Subtest mmap-args: SKIP (0.000s)
[480.215885] [113/133] (556s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[480.310948] Starting subtest: yf-tiled-32bpp-rotate-270
[480.312886] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[480.402408] [114/133] (556s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[480.505114] Starting subtest: yf-tiled-64bpp-rotate-180
[480.506869] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[480.595018] [115/133] (556s left) kms_atomic_transition (plane-toggle-modeset-transition)
[480.676298] Starting subtest: plane-toggle-modeset-transition
[480.677066] Starting dynamic subtest: pipe-A-eDP-1
[493.433281] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.751s)
[493.447309] Starting dynamic subtest: pipe-B-eDP-1
[505.846952] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.408s)
[505.850548] Subtest plane-toggle-modeset-transition: SUCCESS (25.167s)
[506.667439] [116/133] (530s left) kms_content_protection (dp-mst-lic-type-0)
[506.800049] Starting subtest: dp-mst-lic-type-0
[506.801983] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[506.910915] [117/133] (530s left) kms_vrr (seamless-rr-switch-virtual)
[506.998195] Starting subtest: seamless-rr-switch-virtual
[507.001166] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[507.080712] [118/133] (530s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[507.161459] Starting subtest: stress-xrgb8888-xtiled
[512.922802] Subtest stress-xrgb8888-xtiled: SUCCESS (5.761s)
[512.974695] [119/133] (524s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[513.096327] Starting subtest: protected-encrypted-src-copy-not-readible
[513.220775] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.121s)
[513.343237] [120/133] (523s left) prime_busy (before)
[513.406116] Starting subtest: before
[513.409109] Starting dynamic subtest: rcs0
[513.445601] Dynamic subtest rcs0: SUCCESS (0.036s)
[513.454471] Starting dynamic subtest: bcs0
[513.513975] Dynamic subtest bcs0: SUCCESS (0.067s)
[513.526810] Starting dynamic subtest: vcs0
[513.554165] Dynamic subtest vcs0: SUCCESS (0.040s)
[513.563170] Starting dynamic subtest: vcs1
[513.596421] Dynamic subtest vcs1: SUCCESS (0.041s)
[513.605713] Starting dynamic subtest: vecs0
[513.637473] Dynamic subtest vecs0: SUCCESS (0.041s)
[513.646653] Starting dynamic subtest: ccs0
[513.677534] Dynamic subtest ccs0: SUCCESS (0.039s)
[513.795992] Subtest before: SUCCESS (0.381s)
[513.858394] [121/133] (523s left) kms_psr (fbc-psr2-cursor-render)
[513.940575] Starting subtest: fbc-psr2-cursor-render
[513.941389] Starting dynamic subtest: eDP-1
[513.943055] Dynamic subtest eDP-1: SKIP (0.000s)
[513.944664] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[514.012331] [122/133] (523s left) kms_async_flips (test-cursor-atomic)
[514.103106] Starting subtest: test-cursor-atomic
[514.104969] Subtest test-cursor-atomic: SKIP (0.000s)
[515.302759] [123/133] (522s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[515.391783] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[515.393529] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[515.485254] [124/133] (521s left) sysfs_timeslice_duration (idempotent)
[515.545147] Starting subtest: idempotent
[515.546032] Starting dynamic subtest: vecs0
[515.546944] Dynamic subtest vecs0: SUCCESS (0.001s)
[515.556156] Starting dynamic subtest: ccs0
[515.556901] Dynamic subtest ccs0: SUCCESS (0.000s)
[515.568455] Starting dynamic subtest: vcs0
[515.569248] Dynamic subtest vcs0: SUCCESS (0.000s)
[515.577548] Starting dynamic subtest: bcs0
[515.578271] Dynamic subtest bcs0: SUCCESS (0.000s)
[515.586725] Starting dynamic subtest: rcs0
[515.587450] Dynamic subtest rcs0: SUCCESS (0.000s)
[515.595898] Starting dynamic subtest: vcs1
[515.596728] Dynamic subtest vcs1: SUCCESS (0.000s)
[515.597692] Subtest idempotent: SUCCESS (0.007s)
[515.645361] [125/133] (521s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[515.735684] Starting subtest: primary-yf-tiled-reflect-x-90
[515.737613] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[515.801871] [126/133] (521s left) gem_softpin (evict-single-offset)
[515.860430] Starting subtest: evict-single-offset
[541.306393] Subtest evict-single-offset: SUCCESS (25.437s)
[541.381877] [127/133] (496s left) kms_psr (fbc-pr-cursor-plane-onoff)
[541.517334] Starting subtest: fbc-pr-cursor-plane-onoff
[541.519138] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[541.588657] [128/133] (495s left) kms_color (ctm-negative)
[541.684166] Starting subtest: ctm-negative
[541.684927] Starting dynamic subtest: pipe-A-eDP-1
[542.394389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[542.402989] Starting dynamic subtest: pipe-B-eDP-1
[543.824267] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s)
[543.833358] Starting dynamic subtest: pipe-C-eDP-1
[545.184704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[545.193947] Starting dynamic subtest: pipe-D-eDP-1
[546.529860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[546.530767] Subtest ctm-negative: SUCCESS (4.845s)
[547.341451] [129/133] (490s left) kms_sequence (get-forked)
[547.431091] Starting subtest: get-forked
[547.432020] Starting dynamic subtest: pipe-A-eDP-1
[549.346728] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.915s)
[549.356286] Starting dynamic subtest: pipe-B-eDP-1
[551.873502] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.526s)
[551.884186] Starting dynamic subtest: pipe-C-eDP-1
[554.421081] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.545s)
[554.429741] Starting dynamic subtest: pipe-D-eDP-1
[556.928699] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.506s)
[556.929632] Subtest get-forked: SUCCESS (9.497s)
[557.747073] [130/133] (479s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[557.802282] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[557.803434] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[557.890655] [131/133] (479s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[557.994683] Starting subtest: y-tiled-64bpp-rotate-90
[557.996516] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[558.077355] [132/133] (479s left) syncobj_wait (reset-multiple-signaled)
[558.121249] Starting subtest: reset-multiple-signaled
[558.122033] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[558.208404] [133/133] (479s left) core_auth (getclient-master-drop)
[558.246736] Starting subtest: getclient-master-drop
[558.272882] Subtest getclient-master-drop: SUCCESS (0.026s)
[558.365061] 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.