[57.337599] Initializing watchdogs
[57.337671]   /dev/watchdog0
[57.352841] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.357954] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.360924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.364501] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[57.481846] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[57.486072] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[57.566932] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[57.653296] Starting subtest: bo-too-small
[57.655625] Subtest bo-too-small: SUCCESS (0.000s)
[57.752824] [003/133] (960s left) syncobj_basic (bad-destroy-pad)
[57.815898] Starting subtest: bad-destroy-pad
[57.818366] Subtest bad-destroy-pad: SUCCESS (0.000s)
[57.923231] [004/133] (960s left) kms_pm_backlight (basic-brightness)
[58.017758] Starting subtest: basic-brightness
[58.111535] Starting dynamic subtest: eDP-1
[58.404205] Dynamic subtest eDP-1: SUCCESS (0.294s)
[58.406681] Subtest basic-brightness: SUCCESS (0.387s)
[59.240395] [005/133] (958s left) prime_mmap_kms (buffer-sharing)
[59.342060] Starting subtest: buffer-sharing
[59.791793] Subtest buffer-sharing: SUCCESS (0.451s)
[60.687414] [006/133] (957s left) kms_dsc (dsc-with-bpc-formats)
[60.779971] Starting subtest: dsc-with-bpc-formats
[60.893542] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[60.927183] [007/133] (957s left) gem_pread (snoop)
[60.981436] Subtest snoop: SKIP (0.000s)
[61.048874] [008/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[61.141230] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[61.143476] Starting dynamic subtest: pipe-A
[61.499755] Dynamic subtest pipe-A: SUCCESS (0.356s)
[61.509703] Starting dynamic subtest: pipe-B
[62.872658] Dynamic subtest pipe-B: SUCCESS (1.375s)
[62.882351] Starting dynamic subtest: pipe-C
[64.337291] Dynamic subtest pipe-C: SUCCESS (1.464s)
[64.346855] Starting dynamic subtest: pipe-D
[65.755866] Dynamic subtest pipe-D: SUCCESS (1.418s)
[65.758174] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.615s)
[66.914217] [009/133] (951s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[67.215544] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[67.219858] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[67.493763] [010/133] (950s left) gem_mmap_gtt (hang)
[67.628502] Subtest hang: SKIP (0.000s)
[67.728420] [011/133] (950s left) gem_exec_store (basic)
[67.869990] Starting subtest: basic
[68.149247] Subtest basic: SUCCESS (0.278s)
[68.324044] [012/133] (950s left) gem_ctx_exec (basic)
[68.371881] Starting subtest: basic
[68.382779] Subtest basic: SUCCESS (0.012s)
[68.497974] [013/133] (949s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[68.585262] Starting subtest: primary-4-tiled-reflect-x-180
[75.613226] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.030s)
[76.780372] [014/133] (941s left) gem_readwrite (read-write)
[76.848402] Subtest read-write: SKIP (0.000s)
[76.919367] [015/133] (941s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[77.022075] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[77.026600] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[77.089978] [016/133] (941s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[77.211497] Starting subtest: 2x-long-flip-vs-cursor-atomic
[77.216163] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[77.355617] [017/133] (941s left) kms_psr (fbc-psr-cursor-blt)
[77.459951] Starting subtest: fbc-psr-cursor-blt
[77.462045] Starting dynamic subtest: eDP-1
[77.466284] Dynamic subtest eDP-1: SKIP (0.000s)
[77.470221] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[77.528463] [018/133] (941s left) gen9_exec_parse (bb-large)
[77.585345] Subtest bb-large: SKIP (0.000s)
[77.660218] [019/133] (940s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[77.742860] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[77.744869] Starting dynamic subtest: pipe-A-eDP-1
[78.622497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[78.630863] Starting dynamic subtest: pipe-B-eDP-1
[80.319913] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.694s)
[80.328734] Starting dynamic subtest: pipe-C-eDP-1
[81.804463] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[81.813278] Starting dynamic subtest: pipe-D-eDP-1
[83.329020] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[83.331536] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.576s)
[84.491527] [020/133] (934s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[84.602752] Starting subtest: fbc-tiling-linear
[88.337485] Subtest fbc-tiling-linear: SUCCESS (3.736s)
[89.482097] [021/133] (929s left) i915_drm_fdinfo (memory-info-shared)
[89.530740] Starting subtest: memory-info-shared
[89.533239] Starting dynamic subtest: smem0
[89.587230] Dynamic subtest smem0: SUCCESS (0.056s)
[89.590237] Subtest memory-info-shared: SUCCESS (0.057s)
[89.657482] [022/133] (929s left) gem_workarounds (reset-context)
[89.726279] Starting subtest: reset-context
[89.911846] Subtest reset-context: SUCCESS (0.186s)
[90.040661] [023/133] (928s left) i915_query (query-regions-garbage-items)
[90.088085] Starting subtest: query-regions-garbage-items
[90.090440] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[90.195935] [024/133] (928s left) kms_lease (lease-get)
[90.289340] Starting subtest: lease-get
[90.291535] Starting dynamic subtest: pipe-A-eDP-1
[90.293791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[90.302236] Starting dynamic subtest: pipe-B-eDP-1
[90.304090] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[90.311857] Starting dynamic subtest: pipe-C-eDP-1
[90.313690] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[90.320959] Starting dynamic subtest: pipe-D-eDP-1
[90.322768] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[90.324612] Subtest lease-get: SUCCESS (0.008s)
[90.398228] [025/133] (928s left) gem_exec_balancer (bonded-sync)
[90.457317] Starting subtest: bonded-sync
[90.461173] Subtest bonded-sync: SKIP (0.000s)
[90.763179] [026/133] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[90.829330] Starting subtest: etime-multi-wait-all-for-submit-submitted
[90.936068] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[91.020683] [027/133] (927s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[91.140344] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[91.144851] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[91.298545] [028/133] (927s left) kms_properties (connector-properties-atomic)
[91.399106] Starting subtest: connector-properties-atomic
[91.401443] Starting dynamic subtest: pipe-A-eDP-1
[99.082228] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.683s)
[99.090190] Starting dynamic subtest: pipe-None-DP-1
[99.094711] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[99.102422] Starting dynamic subtest: pipe-None-HDMI-A-1
[99.106823] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[99.114610] Starting dynamic subtest: pipe-None-DP-2
[99.118698] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[99.126105] Starting dynamic subtest: pipe-None-HDMI-A-2
[99.130197] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[99.137509] Starting dynamic subtest: pipe-None-DP-3
[99.141579] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[99.149404] Starting dynamic subtest: pipe-None-DP-4
[99.153957] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[99.156205] Subtest connector-properties-atomic: SUCCESS (7.693s)
[99.933998] [029/133] (919s left) kms_cursor_crc (cursor-random-256x85)
[100.204357] Starting subtest: cursor-random-256x85
[100.253310] Subtest cursor-random-256x85: SKIP (0.045s)
[100.440820] [030/133] (918s left) gem_close_race (multigpu-basic-process)
[100.516841] Starting subtest: multigpu-basic-process
[100.521319] Subtest multigpu-basic-process: SKIP (0.000s)
[100.748349] [031/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[100.833587] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[100.837823] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.919152] [032/133] (918s left) gem_pwrite (basic-self)
[100.966484] Subtest basic-self: SKIP (0.000s)
[101.021586] [033/133] (918s left) gem_exec_params (larger-than-life-batch)
[101.085770] Starting subtest: larger-than-life-batch
[103.383691] Subtest larger-than-life-batch: SUCCESS (2.298s)
[103.941582] [034/133] (915s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[104.034706] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[104.037083] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[104.136925] [035/133] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[104.263919] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[104.268125] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[104.358255] [036/133] (914s left) gem_exec_schedule (semaphore-noskip)
[104.442089] Starting subtest: semaphore-noskip
[104.864112] Subtest semaphore-noskip: SUCCESS (0.422s)
[105.194376] [037/133] (914s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[105.261470] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[105.332770] [038/133] (914s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[105.451063] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[105.453326] Starting dynamic subtest: pipe-A-eDP-1
[105.511811] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[105.522058] Starting dynamic subtest: pipe-B-eDP-1
[105.580369] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[105.589801] Starting dynamic subtest: pipe-C-eDP-1
[105.647384] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[105.657735] Starting dynamic subtest: pipe-D-eDP-1
[105.714709] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[105.719265] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[107.689671] [039/133] (911s left) kms_prop_blob (blob-multiple)
[107.757541] Starting subtest: blob-multiple
[107.759886] Subtest blob-multiple: SUCCESS (0.002s)
[107.893116] [040/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[107.991851] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[107.995899] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[108.110216] [041/133] (911s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[108.206684] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[108.208851] Starting dynamic subtest: pipe-A-default-mode
[110.898449] Dynamic subtest pipe-A-default-mode: SUCCESS (2.692s)
[110.900789] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.693s)
[111.766917] [042/133] (907s left) kms_chamelium_frames (vga-frame-dump)
[112.145911] Subtest vga-frame-dump: SKIP (0.000s)
[112.980606] [043/133] (906s left) vgem_basic (create)
[113.099192] Starting subtest: create
[113.101085] Subtest create: SUCCESS (0.000s)
[113.163869] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[113.167106] [044/133] (906s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[113.235516] Starting subtest: wait-all-for-submit-delayed-submit
[113.340082] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[113.426136] [045/133] (906s left) gem_exec_params (sol-reset-invalid)
[113.484500] Starting subtest: sol-reset-invalid
[113.489870] Subtest sol-reset-invalid: SUCCESS (0.003s)
[114.958717] [046/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[115.051366] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[121.623242] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.575s)
[121.748187] [047/133] (898s left) kms_busy (basic-hang)
[121.844938] Starting subtest: basic-hang
[121.847262] Starting dynamic subtest: flip-pipe-A
[122.467491] Dynamic subtest flip-pipe-A: SUCCESS (0.622s)
[122.480802] Starting dynamic subtest: modeset-pipe-A
[125.877458] Dynamic subtest modeset-pipe-A: SUCCESS (3.409s)
[125.886459] Starting dynamic subtest: flip-pipe-D
[127.060410] Dynamic subtest flip-pipe-D: SUCCESS (1.180s)
[127.069809] Starting dynamic subtest: modeset-pipe-D
[130.500067] Dynamic subtest modeset-pipe-D: SUCCESS (3.439s)
[130.502332] Subtest basic-hang: SUCCESS (8.656s)
[131.299347] [048/133] (888s left) kms_plane_multiple (2x-tiling-4)
[131.399380] Starting subtest: 2x-tiling-4
[131.403563] Subtest 2x-tiling-4: SKIP (0.000s)
[131.471288] [049/133] (888s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[131.574423] Starting subtest: x-tiled-64bpp-rotate-180
[133.240559] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.668s)
[133.432318] [050/133] (886s left) i915_pm_freq_api (freq-suspend)
[133.492918] Starting subtest: freq-suspend
[133.494856] Starting dynamic subtest: gt0
[149.901487] Dynamic subtest gt0: SUCCESS (1.519s)
[149.913255] Starting dynamic subtest: gt1
[165.762443] Dynamic subtest gt1: SUCCESS (1.237s)
[165.764351] Subtest freq-suspend: SUCCESS (2.758s)
[166.851127] [051/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[166.954370] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[166.958628] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[167.064280] [052/133] (853s left) sw_sync (alloc_merge_fence)
[167.106576] Starting subtest: alloc_merge_fence
[167.108624] Subtest alloc_merge_fence: SUCCESS (0.001s)
[167.165619] [053/133] (853s left) gem_exec_fence (submit3)
[167.347113] Starting subtest: submit3
[167.351712] Subtest submit3: SKIP (0.000s)
[169.502883] [054/133] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[169.593096] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[174.061712] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.470s)
[175.207187] [055/133] (845s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[175.293977] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[175.296240] Starting dynamic subtest: pipe-A-eDP-1
[175.318231] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.329118] Starting dynamic subtest: pipe-B-eDP-1
[175.349794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.358666] Starting dynamic subtest: pipe-C-eDP-1
[175.379175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.387420] Starting dynamic subtest: pipe-D-eDP-1
[175.409247] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.413587] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[177.494262] [056/133] (843s left) gem_ctx_param (invalid-ctx-set)
[177.562036] Starting subtest: invalid-ctx-set
[177.564474] Subtest invalid-ctx-set: SUCCESS (0.001s)
[177.652648] [057/133] (843s left) sw_sync (sync_multi_timeline_wait)
[177.685641] Starting subtest: sync_multi_timeline_wait
[177.687757] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[177.741208] [058/133] (843s left) dumb_buffer (invalid-bpp)
[177.795084] Starting subtest: invalid-bpp
[177.797356] Subtest invalid-bpp: SUCCESS (0.000s)
[177.888515] [059/133] (843s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[177.972441] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[177.976847] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[178.068286] [060/133] (843s left) gem_fence_thrash (bo-write-verify-threaded-y)
[178.105356] Starting subtest: bo-write-verify-threaded-y
[178.133808] Subtest bo-write-verify-threaded-y: SKIP (0.025s)
[178.188306] [061/133] (843s left) kms_flip (absolute-wf_vblank-interruptible)
[178.283514] Starting subtest: absolute-wf_vblank-interruptible
[178.285913] Starting dynamic subtest: A-eDP1
[187.044937] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[187.062553] Starting dynamic subtest: B-eDP1
[195.778589] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[195.790227] Starting dynamic subtest: C-eDP1
[204.502151] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[204.515238] Starting dynamic subtest: D-eDP1
[213.236285] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[213.242642] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.953s)
[214.461669] [062/133] (806s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[214.558245] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[214.560551] Starting dynamic subtest: pipe-A-eDP-1
[214.569222] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.582155] Starting dynamic subtest: pipe-B-eDP-1
[214.590670] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.600177] Starting dynamic subtest: pipe-C-eDP-1
[214.608677] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.617724] Starting dynamic subtest: pipe-D-eDP-1
[214.625918] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.630154] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[216.816557] [063/133] (804s left) kms_psr (psr2-cursor-mmap-gtt)
[216.910817] Starting subtest: psr2-cursor-mmap-gtt
[216.913017] Starting dynamic subtest: eDP-1
[218.599576] Dynamic subtest eDP-1: SUCCESS (1.687s)
[218.601830] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.688s)
[219.481116] [064/133] (802s left) kms_big_fb (linear-8bpp-rotate-0)
[219.584679] Starting subtest: linear-8bpp-rotate-0
[220.819188] Subtest linear-8bpp-rotate-0: SUCCESS (1.236s)
[220.943471] [065/133] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[221.056694] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[228.218262] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.162s)
[228.357468] [066/133] (793s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[228.458950] Starting subtest: 2x-plain-flip-ts-check-interruptible
[228.470729] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[228.546669] [067/133] (793s left) kms_vblank (ts-continuation-suspend)
[228.640654] Starting subtest: ts-continuation-suspend
[228.642952] Starting dynamic subtest: pipe-A-eDP-1
[245.056082] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.570s)
[245.071307] Starting dynamic subtest: pipe-D-eDP-1
[262.012588] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.146s)
[262.015671] Subtest ts-continuation-suspend: SUCCESS (3.720s)
[262.814457] [068/133] (758s left) gem_exec_schedule (preempt-hang)
[262.988518] Starting subtest: preempt-hang
[262.990644] Starting dynamic subtest: rcs0
[263.227788] Dynamic subtest rcs0: SUCCESS (0.239s)
[263.239057] Starting dynamic subtest: bcs0
[263.458712] Dynamic subtest bcs0: SUCCESS (0.231s)
[263.469089] Starting dynamic subtest: vcs0
[263.685952] Dynamic subtest vcs0: SUCCESS (0.225s)
[263.696972] Starting dynamic subtest: vcs1
[263.915555] Dynamic subtest vcs1: SUCCESS (0.228s)
[263.926937] Starting dynamic subtest: vecs0
[264.148068] Dynamic subtest vecs0: SUCCESS (0.232s)
[264.158578] Starting dynamic subtest: ccs0
[264.373991] Dynamic subtest ccs0: SUCCESS (0.228s)
[264.377183] Subtest preempt-hang: SUCCESS (1.388s)
[265.167399] [069/133] (756s left) i915_pm_rc6_residency (rc6-fence)
[265.235807] Starting subtest: rc6-fence
[265.248494] Starting dynamic subtest: gt0
[277.575299] Dynamic subtest gt0: SUCCESS (12.321s)
[277.591913] Starting dynamic subtest: gt1
[292.067602] Dynamic subtest gt1: SUCCESS (14.484s)
[292.070870] Subtest rc6-fence: SUCCESS (26.827s)
[292.148283] [070/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[292.262917] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[292.268081] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[292.358356] [071/133] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[292.460783] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[292.465793] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[292.558898] [072/133] (729s left) kms_cdclk (mode-transition)
[292.649982] Starting subtest: mode-transition
[292.652785] Starting dynamic subtest: pipe-A-eDP-1
[292.939894] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[292.950736] Starting dynamic subtest: pipe-B-eDP-1
[292.956083] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[292.966048] Starting dynamic subtest: pipe-C-eDP-1
[292.971937] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[292.982024] Starting dynamic subtest: pipe-D-eDP-1
[292.987942] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[292.993856] Subtest mode-transition: SKIP (0.295s)
[293.744691] [073/133] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[293.863166] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[297.456226] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.597s)
[298.664894] [074/133] (723s left) gem_ctx_isolation (nonpriv)
[298.734954] Starting subtest: nonpriv
[298.737779] Starting dynamic subtest: rcs0
[298.962430] Dynamic subtest rcs0: SUCCESS (0.230s)
[298.974087] Starting dynamic subtest: bcs0
[299.207534] Dynamic subtest bcs0: SUCCESS (0.244s)
[299.219492] Starting dynamic subtest: vcs0
[299.465703] Dynamic subtest vcs0: SUCCESS (0.257s)
[299.477713] Starting dynamic subtest: vcs1
[301.357058] Dynamic subtest vcs1: SUCCESS (1.889s)
[301.372175] Starting dynamic subtest: vecs0
[303.271334] Dynamic subtest vecs0: SUCCESS (1.913s)
[303.283806] Starting dynamic subtest: ccs0
[305.330364] Dynamic subtest ccs0: SUCCESS (2.058s)
[305.333370] Subtest nonpriv: SUCCESS (6.597s)
[305.570042] [075/133] (716s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[305.618561] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[305.621100] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[305.721915] [076/133] (716s left) kms_psr (pr-suspend)
[305.826723] Starting subtest: pr-suspend
[305.831805] Subtest pr-suspend: SKIP (0.000s)
[305.913668] [077/133] (716s left) kms_plane_scaling (2x-scaler-multi-pipe)
[306.014429] Starting subtest: 2x-scaler-multi-pipe
[306.019260] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[306.112641] [078/133] (715s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[306.204887] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[306.588751] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[309.337865] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.746s)
[309.349872] Starting dynamic subtest: pipe-A-eDP-1-4
[311.523063] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[311.533059] Starting dynamic subtest: pipe-A-eDP-1-4
[313.532953] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[313.543059] Starting dynamic subtest: pipe-A-eDP-1-x
[315.735433] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.201s)
[316.135552] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[318.871974] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.743s)
[318.882963] Starting dynamic subtest: pipe-B-eDP-1-4
[321.069869] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[321.082900] Starting dynamic subtest: pipe-B-eDP-1-4
[323.079563] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[323.093069] Starting dynamic subtest: pipe-B-eDP-1-x
[325.270374] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[325.634038] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[328.395615] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[328.407196] Starting dynamic subtest: pipe-C-eDP-1-4
[330.570852] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[330.584529] Starting dynamic subtest: pipe-C-eDP-1-4
[332.581964] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[332.594868] Starting dynamic subtest: pipe-C-eDP-1-x
[334.794093] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.211s)
[335.154727] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[337.917902] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.769s)
[337.930095] Starting dynamic subtest: pipe-D-eDP-1-4
[340.115256] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.196s)
[340.127231] Starting dynamic subtest: pipe-D-eDP-1-4
[342.125610] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[342.138042] Starting dynamic subtest: pipe-D-eDP-1-x
[344.327383] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[344.330032] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.116s)
[345.501908] [079/133] (676s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[345.569076] Starting subtest: y-tiled-ccs-to-x-tiled
[345.574360] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[345.755473] [080/133] (676s left) kms_flip (modeset-vs-vblank-race-interruptible)
[345.847069] Starting subtest: modeset-vs-vblank-race-interruptible
[345.849505] Starting dynamic subtest: A-eDP1
[350.535235] Dynamic subtest A-eDP1: SUCCESS (4.685s)
[350.548689] Starting dynamic subtest: B-eDP1
[355.194348] Dynamic subtest B-eDP1: SUCCESS (4.655s)
[355.206863] Starting dynamic subtest: C-eDP1
[359.709479] Dynamic subtest C-eDP1: SUCCESS (4.514s)
[359.722478] Starting dynamic subtest: D-eDP1
[364.235953] Dynamic subtest D-eDP1: SUCCESS (4.525s)
[364.240924] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.393s)
[365.402707] [081/133] (656s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[365.462039] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[365.467899] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[365.673804] [082/133] (656s left) perf_pmu (semaphore-busy)
[365.717731] Starting subtest: semaphore-busy
[365.720468] Starting dynamic subtest: rcs0
[367.356728] Dynamic subtest rcs0: SUCCESS (1.640s)
[367.370237] Starting dynamic subtest: bcs0
[368.993898] Dynamic subtest bcs0: SUCCESS (1.634s)
[369.007062] Starting dynamic subtest: vcs0
[373.535521] Dynamic subtest vcs0: SUCCESS (4.538s)
[373.549074] Starting dynamic subtest: vcs1
[379.552055] Dynamic subtest vcs1: SUCCESS (6.015s)
[379.565044] Starting dynamic subtest: vecs0
[385.567922] Dynamic subtest vecs0: SUCCESS (6.013s)
[385.580959] Starting dynamic subtest: ccs0
[388.644509] Dynamic subtest ccs0: SUCCESS (3.074s)
[388.647697] Subtest semaphore-busy: SUCCESS (22.932s)
[388.774322] [083/133] (633s left) kms_joiner (basic-max-non-joiner)
[388.879611] Starting subtest: basic-max-non-joiner
[388.884338] Subtest basic-max-non-joiner: SKIP (0.000s)
[388.949409] [084/133] (633s left) gem_eio (wait-wedge-immediate)
[389.142222] Starting subtest: wait-wedge-immediate
[391.135827] Subtest wait-wedge-immediate: SUCCESS (1.993s)
[391.248094] [085/133] (631s left) kms_flip (flip-vs-dpms-on-nop)
[391.345904] Starting subtest: flip-vs-dpms-on-nop
[391.348664] Starting dynamic subtest: A-eDP1
[393.188293] Dynamic subtest A-eDP1: SUCCESS (1.842s)
[393.200420] Starting dynamic subtest: B-eDP1
[395.018355] Dynamic subtest B-eDP1: SUCCESS (1.828s)
[395.031112] Starting dynamic subtest: C-eDP1
[396.849581] Dynamic subtest C-eDP1: SUCCESS (1.829s)
[396.861328] Starting dynamic subtest: D-eDP1
[398.672696] Dynamic subtest D-eDP1: SUCCESS (1.821s)
[398.677817] Subtest flip-vs-dpms-on-nop: SUCCESS (7.332s)
[399.855951] [086/133] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[399.959921] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[399.965535] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[400.058247] [087/133] (622s left) gem_vm_create (invalid-create)
[400.115880] Starting subtest: invalid-create
[400.118351] Subtest invalid-create: SUCCESS (0.001s)
[400.217600] [088/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[400.306039] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[407.934702] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.633s)
[408.043074] [089/133] (614s left) gem_fence_thrash (bo-copy)
[408.080598] Starting subtest: bo-copy
[408.096766] Subtest bo-copy: SKIP (0.013s)
[408.159289] [090/133] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[408.257568] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[415.621580] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.367s)
[415.749084] [091/133] (606s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[415.871489] Starting subtest: short-busy-flip-before-cursor-toggle
[415.875984] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[416.017722] [092/133] (606s left) gem_caching (writes)
[416.076095] Subtest writes: SKIP (0.000s)
[416.146851] [093/133] (606s left) gem_exec_whisper (basic-queues-forked-all)
[416.206716] Starting subtest: basic-queues-forked-all
[438.391787] Subtest basic-queues-forked-all: SUCCESS (22.178s)
[438.579593] [094/133] (584s left) syncobj_wait (wait-for-submit-delayed-submit)
[438.641980] Starting subtest: wait-for-submit-delayed-submit
[438.742979] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[438.827567] [095/133] (583s left) api_intel_allocator (reserve-simple)
[438.878177] Starting subtest: reserve-simple
[438.884787] Subtest reserve-simple: SUCCESS (0.008s)
[439.010808] [096/133] (583s left) gem_exec_balancer (parallel-out-fence)
[439.269418] Starting subtest: parallel-out-fence
[440.761755] Subtest parallel-out-fence: SUCCESS (1.492s)
[440.872351] [097/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[440.968854] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[440.973871] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[441.060087] [098/133] (581s left) kms_pm_dc (dc5-dpms)
[442.160049] Starting subtest: dc5-dpms
[444.200108] Subtest dc5-dpms: SUCCESS (2.040s)
[444.280547] [099/133] (578s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[444.370759] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[444.375932] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[444.487753] [100/133] (578s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[444.586093] Starting subtest: 4-tiled-64bpp-rotate-0
[446.221363] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.636s)
[446.382302] [101/133] (576s left) syncobj_basic (bad-handle-to-fd)
[446.435773] Starting subtest: bad-handle-to-fd
[446.438541] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[446.565912] [102/133] (576s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[446.664771] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[446.669505] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[446.736638] [103/133] (576s left) gem_ctx_persistence (legacy-engines-hostile)
[446.784770] Starting subtest: legacy-engines-hostile
[446.787404] Starting dynamic subtest: render
[446.849331] Dynamic subtest render: SUCCESS (0.063s)
[446.862113] Starting dynamic subtest: bsd1
[446.984454] Dynamic subtest bsd1: SUCCESS (0.134s)
[446.998351] Starting dynamic subtest: bsd2
[447.062410] Dynamic subtest bsd2: SUCCESS (0.075s)
[447.074311] Starting dynamic subtest: blt
[447.181281] Dynamic subtest blt: SUCCESS (0.117s)
[447.196630] Starting dynamic subtest: vebox
[447.275375] Dynamic subtest vebox: SUCCESS (0.091s)
[447.277900] Subtest legacy-engines-hostile: SUCCESS (0.492s)
[447.367839] [104/133] (575s left) kms_atomic_interruptible (universal-setplane-primary)
[447.463591] Starting subtest: universal-setplane-primary
[447.465582] Starting dynamic subtest: pipe-A-eDP-1
[454.877608] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[454.880172] Subtest universal-setplane-primary: SUCCESS (7.410s)
[455.717684] [105/133] (567s left) kms_cursor_crc (cursor-offscreen-256x256)
[455.964987] Starting subtest: cursor-offscreen-256x256
[455.970965] Starting dynamic subtest: pipe-A-eDP-1
[457.919645] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[457.948589] Starting dynamic subtest: pipe-D-eDP-1
[460.533989] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.593s)
[460.536713] Subtest cursor-offscreen-256x256: SUCCESS (4.567s)
[461.377816] [106/133] (561s left) gem_mmap_gtt (pf-nonblock)
[461.454822] Subtest pf-nonblock: SKIP (0.000s)
[461.515000] [107/133] (561s left) kms_chamelium_color (gamma)
[461.613821] Subtest gamma: SKIP (0.000s)
[461.663170] [108/133] (561s left) gem_ccs (block-copy-uncompressed)
[461.727959] Starting subtest: block-copy-uncompressed
[461.730432] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[461.751357] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[461.762224] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[461.769034] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[461.778936] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[461.786407] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[461.796099] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[461.805066] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[461.807501] Subtest block-copy-uncompressed: SUCCESS (0.077s)
[461.931998] [109/133] (561s left) gem_softpin (evict-active-interruptible)
[461.993779] Starting subtest: evict-active-interruptible
[461.998929] Subtest evict-active-interruptible: SUCCESS (0.005s)
[462.118240] [110/133] (561s left) sw_sync (sync_multi_consumer)
[462.152870] Starting subtest: sync_multi_consumer
[462.864426] Subtest sync_multi_consumer: SUCCESS (0.711s)
[462.933417] [111/133] (560s left) kms_cursor_crc (cursor-sliding-256x85)
[463.210610] Starting subtest: cursor-sliding-256x85
[463.258467] Subtest cursor-sliding-256x85: SKIP (0.042s)
[463.431759] [112/133] (560s left) gem_ctx_sseu (mmap-args)
[463.490270] Subtest mmap-args: SKIP (0.000s)
[463.562322] [113/133] (560s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[463.655844] Starting subtest: yf-tiled-32bpp-rotate-270
[463.660795] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[463.746924] [114/133] (559s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[463.833640] Starting subtest: yf-tiled-64bpp-rotate-180
[463.838242] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[463.926933] [115/133] (559s left) kms_atomic_transition (plane-toggle-modeset-transition)
[464.020058] Starting subtest: plane-toggle-modeset-transition
[464.022083] Starting dynamic subtest: pipe-A-eDP-1
[476.707483] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.682s)
[476.719918] Starting dynamic subtest: pipe-B-eDP-1
[489.114076] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.401s)
[489.116927] Subtest plane-toggle-modeset-transition: SUCCESS (25.091s)
[489.927059] [116/133] (533s left) kms_content_protection (dp-mst-lic-type-0)
[490.079840] Starting subtest: dp-mst-lic-type-0
[490.084571] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[490.189537] [117/133] (533s left) kms_vrr (seamless-rr-switch-virtual)
[490.290477] Starting subtest: seamless-rr-switch-virtual
[490.298606] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[490.364203] [118/133] (533s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[490.468366] Starting subtest: stress-xrgb8888-xtiled
[496.390301] Subtest stress-xrgb8888-xtiled: SUCCESS (5.923s)
[496.444750] [119/133] (527s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[496.566354] Starting subtest: protected-encrypted-src-copy-not-readible
[496.680838] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.115s)
[496.802424] [120/133] (527s left) prime_busy (before)
[496.862444] Starting subtest: before
[496.865034] Starting dynamic subtest: rcs0
[496.895170] Dynamic subtest rcs0: SUCCESS (0.031s)
[496.905394] Starting dynamic subtest: bcs0
[496.942531] Dynamic subtest bcs0: SUCCESS (0.046s)
[496.953066] Starting dynamic subtest: vcs0
[496.983835] Dynamic subtest vcs0: SUCCESS (0.041s)
[496.994117] Starting dynamic subtest: vcs1
[497.025243] Dynamic subtest vcs1: SUCCESS (0.039s)
[497.035830] Starting dynamic subtest: vecs0
[497.068362] Dynamic subtest vecs0: SUCCESS (0.042s)
[497.079359] Starting dynamic subtest: ccs0
[497.109876] Dynamic subtest ccs0: SUCCESS (0.041s)
[497.218510] Subtest before: SUCCESS (0.356s)
[497.309984] [121/133] (526s left) kms_psr (fbc-psr2-cursor-render)
[497.396804] Starting subtest: fbc-psr2-cursor-render
[497.399527] Starting dynamic subtest: eDP-1
[497.404640] Dynamic subtest eDP-1: SKIP (0.000s)
[497.409932] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[497.471226] [122/133] (526s left) kms_async_flips (test-cursor-atomic)
[497.560407] Starting subtest: test-cursor-atomic
[497.564819] Subtest test-cursor-atomic: SKIP (0.000s)
[498.743753] [123/133] (525s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[498.848709] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[498.852775] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[498.943769] [124/133] (525s left) sysfs_timeslice_duration (idempotent)
[499.006308] Starting subtest: idempotent
[499.008672] Starting dynamic subtest: vecs0
[499.011232] Dynamic subtest vecs0: SUCCESS (0.000s)
[499.021711] Starting dynamic subtest: ccs0
[499.023782] Dynamic subtest ccs0: SUCCESS (0.000s)
[499.033562] Starting dynamic subtest: vcs0
[499.035579] Dynamic subtest vcs0: SUCCESS (0.000s)
[499.045759] Starting dynamic subtest: bcs0
[499.048001] Dynamic subtest bcs0: SUCCESS (0.000s)
[499.057950] Starting dynamic subtest: rcs0
[499.059964] Dynamic subtest rcs0: SUCCESS (0.000s)
[499.069698] Starting dynamic subtest: vcs1
[499.071864] Dynamic subtest vcs1: SUCCESS (0.000s)
[499.073931] Subtest idempotent: SUCCESS (0.007s)
[499.113846] [125/133] (524s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[499.205089] Starting subtest: primary-yf-tiled-reflect-x-90
[499.210424] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[499.282499] [126/133] (524s left) gem_softpin (evict-single-offset)
[499.330948] Starting subtest: evict-single-offset
[527.076578] Subtest evict-single-offset: SUCCESS (27.747s)
[527.195150] [127/133] (497s left) kms_psr (fbc-pr-cursor-plane-onoff)
[527.352818] Starting subtest: fbc-pr-cursor-plane-onoff
[527.357945] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[527.429876] [128/133] (496s left) kms_color (ctm-negative)
[527.522516] Starting subtest: ctm-negative
[527.524731] Starting dynamic subtest: pipe-A-eDP-1
[528.270249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[528.283046] Starting dynamic subtest: pipe-B-eDP-1
[529.649080] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[529.660098] Starting dynamic subtest: pipe-C-eDP-1
[531.043248] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[531.054057] Starting dynamic subtest: pipe-D-eDP-1
[532.359831] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[532.362947] Subtest ctm-negative: SUCCESS (4.839s)
[533.163979] [129/133] (491s left) kms_sequence (get-forked)
[533.248872] Starting subtest: get-forked
[533.251833] Starting dynamic subtest: pipe-A-eDP-1
[535.132846] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[535.144349] Starting dynamic subtest: pipe-B-eDP-1
[537.739552] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.605s)
[537.750557] Starting dynamic subtest: pipe-C-eDP-1
[540.306870] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.567s)
[540.319246] Starting dynamic subtest: pipe-D-eDP-1
[542.846935] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[542.849998] Subtest get-forked: SUCCESS (9.600s)
[543.688969] [130/133] (480s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[543.756502] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[543.759238] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[543.832885] [131/133] (480s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[543.935633] Starting subtest: y-tiled-64bpp-rotate-90
[543.939918] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[544.025543] [132/133] (480s left) syncobj_wait (reset-multiple-signaled)
[544.071832] Starting subtest: reset-multiple-signaled
[544.074480] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[544.165645] [133/133] (480s left) core_auth (getclient-master-drop)
[544.201362] Starting subtest: getclient-master-drop
[544.221560] Subtest getclient-master-drop: SUCCESS (0.021s)
[544.321191] 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.