[58.661378] Initializing watchdogs
[58.661422]   /dev/watchdog0
[58.675769] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.680207] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.683105] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.686731] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[58.809669] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[58.814288] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[58.891144] [002/133] (960s left) kms_addfb_basic (bo-too-small)
[58.994084] Starting subtest: bo-too-small
[58.995946] Subtest bo-too-small: SUCCESS (0.000s)
[59.074199] [003/133] (960s left) syncobj_basic (bad-destroy-pad)
[59.138308] Starting subtest: bad-destroy-pad
[59.140585] Subtest bad-destroy-pad: SUCCESS (0.000s)
[59.271959] [004/133] (960s left) kms_pm_backlight (basic-brightness)
[59.374725] Starting subtest: basic-brightness
[59.468589] Starting dynamic subtest: eDP-1
[59.764300] Dynamic subtest eDP-1: SUCCESS (0.293s)
[59.766728] Subtest basic-brightness: SUCCESS (0.388s)
[60.645626] [005/133] (958s left) prime_mmap_kms (buffer-sharing)
[60.764053] Starting subtest: buffer-sharing
[61.210051] Subtest buffer-sharing: SUCCESS (0.444s)
[62.079845] [006/133] (957s left) kms_dsc (dsc-with-bpc-formats)
[62.170753] Starting subtest: dsc-with-bpc-formats
[62.286074] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[62.320939] [007/133] (957s left) gem_pread (snoop)
[62.384969] Subtest snoop: SKIP (0.000s)
[62.469835] [008/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[62.577493] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[62.579785] Starting dynamic subtest: pipe-A
[62.915525] Dynamic subtest pipe-A: SUCCESS (0.342s)
[62.923998] Starting dynamic subtest: pipe-B
[64.385904] Dynamic subtest pipe-B: SUCCESS (1.468s)
[64.393170] Starting dynamic subtest: pipe-C
[65.834157] Dynamic subtest pipe-C: SUCCESS (1.446s)
[65.844390] Starting dynamic subtest: pipe-D
[67.295239] Dynamic subtest pipe-D: SUCCESS (1.459s)
[67.297545] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.717s)
[68.608509] [009/133] (950s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[68.708635] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[68.712831] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[68.772481] [010/133] (950s left) gem_mmap_gtt (hang)
[68.822889] Subtest hang: SKIP (0.000s)
[68.876205] [011/133] (950s left) gem_exec_store (basic)
[68.936070] Starting subtest: basic
[69.025482] Subtest basic: SUCCESS (0.092s)
[69.204666] [012/133] (950s left) gem_ctx_exec (basic)
[69.254817] Starting subtest: basic
[69.262632] Subtest basic: SUCCESS (0.009s)
[69.383593] [013/133] (950s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[69.474122] Starting subtest: primary-4-tiled-reflect-x-180
[76.459259] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.985s)
[77.694971] [014/133] (942s left) gem_readwrite (read-write)
[77.756327] Subtest read-write: SKIP (0.000s)
[77.818194] [015/133] (941s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[77.915708] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[77.920138] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[77.979979] [016/133] (941s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[78.095810] Starting subtest: 2x-long-flip-vs-cursor-atomic
[78.100491] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[78.252195] [017/133] (941s left) kms_psr (fbc-psr-cursor-blt)
[78.338570] Starting subtest: fbc-psr-cursor-blt
[78.340875] Starting dynamic subtest: eDP-1
[78.344852] Dynamic subtest eDP-1: SKIP (0.000s)
[78.348941] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[78.407848] [018/133] (941s left) gen9_exec_parse (bb-large)
[78.478637] Subtest bb-large: SKIP (0.000s)
[78.550781] [019/133] (941s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[78.644947] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[78.647018] Starting dynamic subtest: pipe-A-eDP-1
[79.523736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[79.531845] Starting dynamic subtest: pipe-B-eDP-1
[81.090605] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.562s)
[81.100130] Starting dynamic subtest: pipe-C-eDP-1
[82.686040] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.595s)
[82.695442] Starting dynamic subtest: pipe-D-eDP-1
[84.156028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.467s)
[84.157967] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.500s)
[85.334774] [020/133] (934s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[85.442708] Starting subtest: fbc-tiling-linear
[89.136235] Subtest fbc-tiling-linear: SUCCESS (3.697s)
[90.337245] [021/133] (929s left) i915_drm_fdinfo (memory-info-shared)
[90.382214] Starting subtest: memory-info-shared
[90.385109] Starting dynamic subtest: smem0
[90.432833] Dynamic subtest smem0: SUCCESS (0.051s)
[90.435651] Subtest memory-info-shared: SUCCESS (0.051s)
[90.504498] [022/133] (929s left) gem_workarounds (reset-context)
[90.582879] Starting subtest: reset-context
[90.772783] Subtest reset-context: SUCCESS (0.189s)
[90.883652] [023/133] (929s left) i915_query (query-regions-garbage-items)
[90.947055] Starting subtest: query-regions-garbage-items
[90.949254] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[91.030350] [024/133] (929s left) kms_lease (lease-get)
[91.132499] Starting subtest: lease-get
[91.134827] Starting dynamic subtest: pipe-A-eDP-1
[91.137057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[91.149402] Starting dynamic subtest: pipe-B-eDP-1
[91.151598] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.159662] Starting dynamic subtest: pipe-C-eDP-1
[91.161821] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[91.169540] Starting dynamic subtest: pipe-D-eDP-1
[91.171640] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[91.173762] Subtest lease-get: SUCCESS (0.008s)
[91.246131] [025/133] (928s left) gem_exec_balancer (bonded-sync)
[91.302649] Starting subtest: bonded-sync
[91.306443] Subtest bonded-sync: SKIP (0.000s)
[91.596119] [026/133] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[91.654408] Starting subtest: etime-multi-wait-all-for-submit-submitted
[91.762063] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[91.845459] [027/133] (928s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[91.964195] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[91.968673] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[92.109817] [028/133] (928s left) kms_properties (connector-properties-atomic)
[92.199232] Starting subtest: connector-properties-atomic
[92.201595] Starting dynamic subtest: pipe-A-eDP-1
[100.055372] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.857s)
[100.064373] Starting dynamic subtest: pipe-None-DP-1
[100.068818] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[100.076295] Starting dynamic subtest: pipe-None-HDMI-A-1
[100.080325] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[100.088184] Starting dynamic subtest: pipe-None-DP-2
[100.092562] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[100.100287] Starting dynamic subtest: pipe-None-HDMI-A-2
[100.104727] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[100.112522] Starting dynamic subtest: pipe-None-DP-3
[100.117051] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[100.128522] Starting dynamic subtest: pipe-None-DP-4
[100.133784] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[100.135934] Subtest connector-properties-atomic: SUCCESS (7.867s)
[100.911043] [029/133] (919s left) kms_cursor_crc (cursor-random-256x85)
[101.198828] Starting subtest: cursor-random-256x85
[101.243658] Subtest cursor-random-256x85: SKIP (0.043s)
[101.412793] [030/133] (918s left) gem_close_race (multigpu-basic-process)
[101.471474] Starting subtest: multigpu-basic-process
[101.475850] Subtest multigpu-basic-process: SKIP (0.000s)
[101.683325] [031/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[101.776173] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[101.780381] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.867079] [032/133] (918s left) gem_pwrite (basic-self)
[101.924966] Subtest basic-self: SKIP (0.000s)
[101.985748] [033/133] (918s left) gem_exec_params (larger-than-life-batch)
[102.041392] Starting subtest: larger-than-life-batch
[104.366733] Subtest larger-than-life-batch: SUCCESS (2.325s)
[104.968369] [034/133] (915s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[105.072340] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[105.074763] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[105.165078] [035/133] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[105.265181] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[105.269188] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[105.356191] [036/133] (915s left) gem_exec_schedule (semaphore-noskip)
[105.424947] Starting subtest: semaphore-noskip
[105.848729] Subtest semaphore-noskip: SUCCESS (0.428s)
[106.181514] [037/133] (914s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[106.240213] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[106.297522] [038/133] (914s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[106.398047] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[106.400336] Starting dynamic subtest: pipe-A-eDP-1
[106.459854] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[106.471622] Starting dynamic subtest: pipe-B-eDP-1
[106.528774] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[106.538536] Starting dynamic subtest: pipe-C-eDP-1
[106.595554] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[106.604797] Starting dynamic subtest: pipe-D-eDP-1
[106.661504] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[106.665694] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[108.595562] [039/133] (912s left) kms_prop_blob (blob-multiple)
[108.654167] Starting subtest: blob-multiple
[108.656479] Subtest blob-multiple: SUCCESS (0.002s)
[108.754392] [040/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[108.854036] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[108.858242] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[108.936064] [041/133] (911s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[109.027642] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[109.029872] Starting dynamic subtest: pipe-A-default-mode
[111.764594] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[111.766829] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.737s)
[112.623337] [042/133] (908s left) kms_chamelium_frames (vga-frame-dump)
[113.011246] Subtest vga-frame-dump: SKIP (0.000s)
[113.834325] [043/133] (907s left) vgem_basic (create)
[113.963302] Starting subtest: create
[113.965330] Subtest create: SUCCESS (0.000s)
[114.019438] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[114.023511] [044/133] (906s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[114.084148] Starting subtest: wait-all-for-submit-delayed-submit
[114.187956] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[114.267063] [045/133] (906s left) gem_exec_params (sol-reset-invalid)
[114.328528] Starting subtest: sol-reset-invalid
[114.333755] Subtest sol-reset-invalid: SUCCESS (0.002s)
[116.004256] [046/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[116.109922] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[122.647872] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.543s)
[122.783948] [047/133] (898s left) kms_busy (basic-hang)
[122.879894] Starting subtest: basic-hang
[122.882178] Starting dynamic subtest: flip-pipe-A
[123.485086] Dynamic subtest flip-pipe-A: SUCCESS (0.604s)
[123.493877] Starting dynamic subtest: modeset-pipe-A
[126.931954] Dynamic subtest modeset-pipe-A: SUCCESS (3.448s)
[126.945375] Starting dynamic subtest: flip-pipe-D
[128.140799] Dynamic subtest flip-pipe-D: SUCCESS (1.206s)
[128.150290] Starting dynamic subtest: modeset-pipe-D
[131.571416] Dynamic subtest modeset-pipe-D: SUCCESS (3.428s)
[131.573684] Subtest basic-hang: SUCCESS (8.691s)
[132.361888] [048/133] (888s left) kms_plane_multiple (2x-tiling-4)
[132.457911] Starting subtest: 2x-tiling-4
[132.461861] Subtest 2x-tiling-4: SKIP (0.000s)
[132.530265] [049/133] (888s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[132.641651] Starting subtest: x-tiled-64bpp-rotate-180
[134.323488] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.682s)
[134.470546] [050/133] (886s left) i915_pm_freq_api (freq-suspend)
[134.536675] Starting subtest: freq-suspend
[134.539465] Starting dynamic subtest: gt0
[150.481381] Dynamic subtest gt0: SUCCESS (1.514s)
[150.491722] Starting dynamic subtest: gt1
[166.374160] Dynamic subtest gt1: SUCCESS (1.288s)
[166.377503] Subtest freq-suspend: SUCCESS (2.804s)
[166.475235] [051/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[166.576072] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[166.580904] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[166.681371] [052/133] (854s left) sw_sync (alloc_merge_fence)
[166.727212] Starting subtest: alloc_merge_fence
[166.729494] Subtest alloc_merge_fence: SUCCESS (0.000s)
[166.800653] [053/133] (854s left) gem_exec_fence (submit3)
[166.976306] Starting subtest: submit3
[166.981859] Subtest submit3: SKIP (0.000s)
[169.015352] [054/133] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[169.112891] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[173.544663] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.395s)
[174.721828] [055/133] (846s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[174.817474] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[174.820327] Starting dynamic subtest: pipe-A-eDP-1
[174.849081] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.859866] Starting dynamic subtest: pipe-B-eDP-1
[174.886793] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.896283] Starting dynamic subtest: pipe-C-eDP-1
[174.921951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.931021] Starting dynamic subtest: pipe-D-eDP-1
[174.956809] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.961622] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[177.088517] [056/133] (844s left) gem_ctx_param (invalid-ctx-set)
[177.149950] Starting subtest: invalid-ctx-set
[177.152811] Subtest invalid-ctx-set: SUCCESS (0.002s)
[177.250028] [057/133] (844s left) sw_sync (sync_multi_timeline_wait)
[177.291039] Starting subtest: sync_multi_timeline_wait
[177.293877] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[177.345711] [058/133] (844s left) dumb_buffer (invalid-bpp)
[177.409813] Starting subtest: invalid-bpp
[177.412751] Subtest invalid-bpp: SUCCESS (0.000s)
[177.498139] [059/133] (844s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[177.591553] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[177.596825] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[177.704665] [060/133] (843s left) gem_fence_thrash (bo-write-verify-threaded-y)
[177.747138] Starting subtest: bo-write-verify-threaded-y
[177.770291] Subtest bo-write-verify-threaded-y: SKIP (0.019s)
[177.831400] [061/133] (843s left) kms_flip (absolute-wf_vblank-interruptible)
[177.922030] Starting subtest: absolute-wf_vblank-interruptible
[177.924856] Starting dynamic subtest: A-eDP1
[186.678058] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[186.689050] Starting dynamic subtest: B-eDP1
[195.430176] Dynamic subtest B-eDP1: SUCCESS (8.740s)
[195.444759] Starting dynamic subtest: C-eDP1
[204.161370] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[204.174911] Starting dynamic subtest: D-eDP1
[212.894202] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[212.899525] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.935s)
[214.140237] [062/133] (807s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[214.232592] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[214.235047] Starting dynamic subtest: pipe-A-eDP-1
[214.244966] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.257575] Starting dynamic subtest: pipe-B-eDP-1
[214.267882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.277328] Starting dynamic subtest: pipe-C-eDP-1
[214.288583] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.297889] Starting dynamic subtest: pipe-D-eDP-1
[214.308487] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.313821] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[216.426385] [063/133] (805s left) kms_psr (psr2-cursor-mmap-gtt)
[216.529900] Starting subtest: psr2-cursor-mmap-gtt
[216.532741] Starting dynamic subtest: eDP-1
[218.284937] Dynamic subtest eDP-1: SUCCESS (1.752s)
[218.287434] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.753s)
[219.083381] [064/133] (802s left) kms_big_fb (linear-8bpp-rotate-0)
[219.182472] Starting subtest: linear-8bpp-rotate-0
[220.498790] Subtest linear-8bpp-rotate-0: SUCCESS (1.315s)
[220.612433] [065/133] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[220.713028] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[227.774374] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.058s)
[227.897103] [066/133] (793s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[228.001614] Starting subtest: 2x-plain-flip-ts-check-interruptible
[228.012519] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[228.088566] [067/133] (793s left) kms_vblank (ts-continuation-suspend)
[228.175943] Starting subtest: ts-continuation-suspend
[228.178812] Starting dynamic subtest: pipe-A-eDP-1
[244.639533] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.554s)
[244.656313] Starting dynamic subtest: pipe-D-eDP-1
[261.624166] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s)
[261.627168] Subtest ts-continuation-suspend: SUCCESS (3.717s)
[262.427191] [068/133] (759s left) gem_exec_schedule (preempt-hang)
[262.612411] Starting subtest: preempt-hang
[262.614542] Starting dynamic subtest: rcs0
[262.858620] Dynamic subtest rcs0: SUCCESS (0.244s)
[262.868154] Starting dynamic subtest: bcs0
[263.106232] Dynamic subtest bcs0: SUCCESS (0.244s)
[263.116055] Starting dynamic subtest: vcs0
[263.342939] Dynamic subtest vcs0: SUCCESS (0.232s)
[263.352614] Starting dynamic subtest: vcs1
[263.573243] Dynamic subtest vcs1: SUCCESS (0.225s)
[263.583022] Starting dynamic subtest: vecs0
[263.802077] Dynamic subtest vecs0: SUCCESS (0.225s)
[263.812467] Starting dynamic subtest: ccs0
[264.034525] Dynamic subtest ccs0: SUCCESS (0.232s)
[264.036930] Subtest preempt-hang: SUCCESS (1.409s)
[264.740854] [069/133] (757s left) i915_pm_rc6_residency (rc6-fence)
[264.798143] Starting subtest: rc6-fence
[264.809227] Starting dynamic subtest: gt0
[277.194410] Dynamic subtest gt0: SUCCESS (12.321s)
[277.208285] Starting dynamic subtest: gt1
[291.586251] Dynamic subtest gt1: SUCCESS (14.369s)
[291.589267] Subtest rc6-fence: SUCCESS (26.709s)
[291.666623] [070/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[291.769252] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[291.774257] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[291.872478] [071/133] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[291.963999] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[291.969002] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[292.085266] [072/133] (729s left) kms_cdclk (mode-transition)
[292.181212] Starting subtest: mode-transition
[292.183587] Starting dynamic subtest: pipe-A-eDP-1
[292.473027] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[292.483834] Starting dynamic subtest: pipe-B-eDP-1
[292.489116] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[292.499224] Starting dynamic subtest: pipe-C-eDP-1
[292.503984] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[292.514181] Starting dynamic subtest: pipe-D-eDP-1
[292.519011] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[292.523696] Subtest mode-transition: SKIP (0.297s)
[293.267631] [073/133] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[293.369151] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[297.034081] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.674s)
[298.179344] [074/133] (723s left) gem_ctx_isolation (nonpriv)
[298.236085] Starting subtest: nonpriv
[298.239218] Starting dynamic subtest: rcs0
[298.470886] Dynamic subtest rcs0: SUCCESS (0.235s)
[298.481126] Starting dynamic subtest: bcs0
[298.728480] Dynamic subtest bcs0: SUCCESS (0.256s)
[298.739008] Starting dynamic subtest: vcs0
[298.974830] Dynamic subtest vcs0: SUCCESS (0.245s)
[298.987531] Starting dynamic subtest: vcs1
[300.862935] Dynamic subtest vcs1: SUCCESS (1.889s)
[300.873313] Starting dynamic subtest: vecs0
[302.974327] Dynamic subtest vecs0: SUCCESS (2.112s)
[302.984577] Starting dynamic subtest: ccs0
[304.923910] Dynamic subtest ccs0: SUCCESS (1.949s)
[304.926499] Subtest nonpriv: SUCCESS (6.692s)
[305.178187] [075/133] (717s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[305.240447] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[305.242836] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[305.332642] [076/133] (716s left) kms_psr (pr-suspend)
[305.424976] Starting subtest: pr-suspend
[305.429415] Subtest pr-suspend: SKIP (0.000s)
[305.496230] [077/133] (716s left) kms_plane_scaling (2x-scaler-multi-pipe)
[305.596783] Starting subtest: 2x-scaler-multi-pipe
[305.602125] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[305.706123] [078/133] (716s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[305.801511] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[306.188149] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[308.938779] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[308.951398] Starting dynamic subtest: pipe-A-eDP-1-4
[311.123618] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[311.136143] Starting dynamic subtest: pipe-A-eDP-1-4
[313.133035] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[313.144597] Starting dynamic subtest: pipe-A-eDP-1-x
[315.334056] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[315.706025] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[318.458522] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[318.469099] Starting dynamic subtest: pipe-B-eDP-1-4
[320.644981] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[320.657843] Starting dynamic subtest: pipe-B-eDP-1-4
[322.655255] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[322.669248] Starting dynamic subtest: pipe-B-eDP-1-x
[324.845781] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[325.233250] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[327.986274] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[327.998762] Starting dynamic subtest: pipe-C-eDP-1-4
[330.161801] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[330.174501] Starting dynamic subtest: pipe-C-eDP-1-4
[332.171835] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[332.183160] Starting dynamic subtest: pipe-C-eDP-1-x
[334.362426] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[334.738165] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[337.526025] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[337.538238] Starting dynamic subtest: pipe-D-eDP-1-4
[339.701123] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[339.714076] Starting dynamic subtest: pipe-D-eDP-1-4
[341.711393] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[341.726246] Starting dynamic subtest: pipe-D-eDP-1-x
[343.913130] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[343.915935] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.111s)
[345.114965] [079/133] (677s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[345.172067] Starting subtest: y-tiled-ccs-to-x-tiled
[345.177775] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[345.367843] [080/133] (677s left) kms_flip (modeset-vs-vblank-race-interruptible)
[345.460040] Starting subtest: modeset-vs-vblank-race-interruptible
[345.462689] Starting dynamic subtest: A-eDP1
[350.133522] Dynamic subtest A-eDP1: SUCCESS (4.670s)
[350.150851] Starting dynamic subtest: B-eDP1
[354.791875] Dynamic subtest B-eDP1: SUCCESS (4.654s)
[354.803854] Starting dynamic subtest: C-eDP1
[359.306764] Dynamic subtest C-eDP1: SUCCESS (4.513s)
[359.317797] Starting dynamic subtest: D-eDP1
[363.861056] Dynamic subtest D-eDP1: SUCCESS (4.552s)
[363.863999] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.400s)
[365.024753] [081/133] (657s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[365.087484] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[365.093035] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[365.272480] [082/133] (657s left) perf_pmu (semaphore-busy)
[365.317574] Starting subtest: semaphore-busy
[365.320010] Starting dynamic subtest: rcs0
[366.949267] Dynamic subtest rcs0: SUCCESS (1.631s)
[366.963271] Starting dynamic subtest: bcs0
[368.585004] Dynamic subtest bcs0: SUCCESS (1.632s)
[368.598132] Starting dynamic subtest: vcs0
[373.119798] Dynamic subtest vcs0: SUCCESS (4.530s)
[373.130808] Starting dynamic subtest: vcs1
[379.132145] Dynamic subtest vcs1: SUCCESS (6.008s)
[379.145407] Starting dynamic subtest: vecs0
[385.148160] Dynamic subtest vecs0: SUCCESS (6.012s)
[385.160785] Starting dynamic subtest: ccs0
[388.224546] Dynamic subtest ccs0: SUCCESS (3.073s)
[388.227041] Subtest semaphore-busy: SUCCESS (22.905s)
[388.345271] [083/133] (634s left) kms_joiner (basic-max-non-joiner)
[388.448887] Starting subtest: basic-max-non-joiner
[388.453969] Subtest basic-max-non-joiner: SKIP (0.000s)
[388.559327] [084/133] (634s left) gem_eio (wait-wedge-immediate)
[388.760843] Starting subtest: wait-wedge-immediate
[390.712032] Subtest wait-wedge-immediate: SUCCESS (1.949s)
[390.842454] [085/133] (631s left) kms_flip (flip-vs-dpms-on-nop)
[390.939862] Starting subtest: flip-vs-dpms-on-nop
[390.942313] Starting dynamic subtest: A-eDP1
[392.828724] Dynamic subtest A-eDP1: SUCCESS (1.890s)
[392.843061] Starting dynamic subtest: B-eDP1
[394.766989] Dynamic subtest B-eDP1: SUCCESS (1.934s)
[394.780259] Starting dynamic subtest: C-eDP1
[396.585864] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[396.596003] Starting dynamic subtest: D-eDP1
[398.423808] Dynamic subtest D-eDP1: SUCCESS (1.836s)
[398.430261] Subtest flip-vs-dpms-on-nop: SUCCESS (7.491s)
[399.611571] [086/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[399.712111] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[399.717245] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[399.803084] [087/133] (622s left) gem_vm_create (invalid-create)
[399.860945] Starting subtest: invalid-create
[399.863879] Subtest invalid-create: SUCCESS (0.001s)
[399.968222] [088/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[400.066052] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[408.010527] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.947s)
[408.136506] [089/133] (614s left) gem_fence_thrash (bo-copy)
[408.180490] Starting subtest: bo-copy
[408.194222] Subtest bo-copy: SKIP (0.014s)
[408.264078] [090/133] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[408.360274] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[415.664000] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.305s)
[415.766536] [091/133] (607s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[415.888840] Starting subtest: short-busy-flip-before-cursor-toggle
[415.893453] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[416.034455] [092/133] (606s left) gem_caching (writes)
[416.097524] Subtest writes: SKIP (0.000s)
[416.171031] [093/133] (606s left) gem_exec_whisper (basic-queues-forked-all)
[416.228458] Starting subtest: basic-queues-forked-all
[439.958101] Subtest basic-queues-forked-all: SUCCESS (23.722s)
[440.142537] [094/133] (582s left) syncobj_wait (wait-for-submit-delayed-submit)
[440.194828] Starting subtest: wait-for-submit-delayed-submit
[440.295586] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[440.376659] [095/133] (582s left) api_intel_allocator (reserve-simple)
[440.431496] Starting subtest: reserve-simple
[440.440120] Subtest reserve-simple: SUCCESS (0.010s)
[440.573516] [096/133] (582s left) gem_exec_balancer (parallel-out-fence)
[440.834286] Starting subtest: parallel-out-fence
[442.303972] Subtest parallel-out-fence: SUCCESS (1.469s)
[442.403785] [097/133] (580s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[442.504001] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[442.509014] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[442.597670] [098/133] (580s left) kms_pm_dc (dc5-dpms)
[443.696237] Starting subtest: dc5-dpms
[445.739814] Subtest dc5-dpms: SUCCESS (2.043s)
[445.820624] [099/133] (577s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[445.915121] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[445.920963] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[446.006995] [100/133] (577s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[446.111394] Starting subtest: 4-tiled-64bpp-rotate-0
[447.622524] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.514s)
[447.793405] [101/133] (575s left) syncobj_basic (bad-handle-to-fd)
[447.855103] Starting subtest: bad-handle-to-fd
[447.858065] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[447.969661] [102/133] (575s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[448.057076] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[448.061859] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[448.130484] [103/133] (575s left) gem_ctx_persistence (legacy-engines-hostile)
[448.192153] Starting subtest: legacy-engines-hostile
[448.194494] Starting dynamic subtest: render
[448.244131] Dynamic subtest render: SUCCESS (0.054s)
[448.256866] Starting dynamic subtest: bsd1
[448.337918] Dynamic subtest bsd1: SUCCESS (0.092s)
[448.351661] Starting dynamic subtest: bsd2
[448.430163] Dynamic subtest bsd2: SUCCESS (0.089s)
[448.443626] Starting dynamic subtest: blt
[448.522288] Dynamic subtest blt: SUCCESS (0.090s)
[448.535233] Starting dynamic subtest: vebox
[448.613123] Dynamic subtest vebox: SUCCESS (0.088s)
[448.615733] Subtest legacy-engines-hostile: SUCCESS (0.425s)
[448.708693] [104/133] (574s left) kms_atomic_interruptible (universal-setplane-primary)
[448.790675] Starting subtest: universal-setplane-primary
[448.792765] Starting dynamic subtest: pipe-A-eDP-1
[456.205782] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.413s)
[456.208758] Subtest universal-setplane-primary: SUCCESS (7.415s)
[457.056626] [105/133] (566s left) kms_cursor_crc (cursor-offscreen-256x256)
[457.309538] Starting subtest: cursor-offscreen-256x256
[457.312251] Starting dynamic subtest: pipe-A-eDP-1
[459.253250] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[459.285494] Starting dynamic subtest: pipe-D-eDP-1
[461.872896] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.597s)
[461.875582] Subtest cursor-offscreen-256x256: SUCCESS (4.565s)
[462.736500] [106/133] (560s left) gem_mmap_gtt (pf-nonblock)
[462.786895] Subtest pf-nonblock: SKIP (0.000s)
[462.847106] [107/133] (560s left) kms_chamelium_color (gamma)
[462.942260] Subtest gamma: SKIP (0.000s)
[463.025831] [108/133] (560s left) gem_ccs (block-copy-uncompressed)
[463.095234] Starting subtest: block-copy-uncompressed
[463.097668] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[463.115962] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[463.128535] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[463.133999] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[463.146860] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[463.154138] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[463.166977] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[463.172186] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[463.174787] Subtest block-copy-uncompressed: SUCCESS (0.080s)
[463.298463] [109/133] (560s left) gem_softpin (evict-active-interruptible)
[463.361506] Starting subtest: evict-active-interruptible
[463.364499] Subtest evict-active-interruptible: SUCCESS (0.006s)
[463.479638] [110/133] (560s left) sw_sync (sync_multi_consumer)
[463.515132] Starting subtest: sync_multi_consumer
[464.380984] Subtest sync_multi_consumer: SUCCESS (0.868s)
[464.447758] [111/133] (559s left) kms_cursor_crc (cursor-sliding-256x85)
[464.708800] Starting subtest: cursor-sliding-256x85
[464.754221] Subtest cursor-sliding-256x85: SKIP (0.041s)
[464.918900] [112/133] (559s left) gem_ctx_sseu (mmap-args)
[464.980238] Subtest mmap-args: SKIP (0.000s)
[465.042566] [113/133] (558s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[465.145940] Starting subtest: yf-tiled-32bpp-rotate-270
[465.150963] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[465.231326] [114/133] (558s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[465.337350] Starting subtest: yf-tiled-64bpp-rotate-180
[465.342044] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[465.432924] [115/133] (558s left) kms_atomic_transition (plane-toggle-modeset-transition)
[465.527097] Starting subtest: plane-toggle-modeset-transition
[465.529215] Starting dynamic subtest: pipe-A-eDP-1
[478.256733] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.726s)
[478.269395] Starting dynamic subtest: pipe-B-eDP-1
[490.671006] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.408s)
[490.674034] Subtest plane-toggle-modeset-transition: SUCCESS (25.140s)
[491.497591] [116/133] (532s left) kms_content_protection (dp-mst-lic-type-0)
[491.642156] Starting subtest: dp-mst-lic-type-0
[491.648123] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[491.762211] [117/133] (532s left) kms_vrr (seamless-rr-switch-virtual)
[491.863940] Starting subtest: seamless-rr-switch-virtual
[491.871507] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[491.949040] [118/133] (532s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[492.048747] Starting subtest: stress-xrgb8888-xtiled
[498.075544] Subtest stress-xrgb8888-xtiled: SUCCESS (6.029s)
[498.133419] [119/133] (526s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[498.264010] Starting subtest: protected-encrypted-src-copy-not-readible
[498.394824] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.131s)
[498.515571] [120/133] (525s left) prime_busy (before)
[498.570938] Starting subtest: before
[498.573891] Starting dynamic subtest: rcs0
[498.606994] Dynamic subtest rcs0: SUCCESS (0.034s)
[498.621255] Starting dynamic subtest: bcs0
[498.657017] Dynamic subtest bcs0: SUCCESS (0.049s)
[498.668252] Starting dynamic subtest: vcs0
[498.698005] Dynamic subtest vcs0: SUCCESS (0.039s)
[498.708831] Starting dynamic subtest: vcs1
[498.738219] Dynamic subtest vcs1: SUCCESS (0.040s)
[498.750256] Starting dynamic subtest: vecs0
[498.785668] Dynamic subtest vecs0: SUCCESS (0.041s)
[498.797265] Starting dynamic subtest: ccs0
[498.821058] Dynamic subtest ccs0: SUCCESS (0.040s)
[498.929986] Subtest before: SUCCESS (0.359s)
[499.009779] [121/133] (525s left) kms_psr (fbc-psr2-cursor-render)
[499.098466] Starting subtest: fbc-psr2-cursor-render
[499.101068] Starting dynamic subtest: eDP-1
[499.106253] Dynamic subtest eDP-1: SKIP (0.000s)
[499.112085] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[499.183925] [122/133] (525s left) kms_async_flips (test-cursor-atomic)
[499.279478] Starting subtest: test-cursor-atomic
[499.284066] Subtest test-cursor-atomic: SKIP (0.000s)
[500.523603] [123/133] (523s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[500.621397] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[500.626486] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[500.730159] [124/133] (523s left) sysfs_timeslice_duration (idempotent)
[500.788528] Starting subtest: idempotent
[500.791175] Starting dynamic subtest: vecs0
[500.793920] Dynamic subtest vecs0: SUCCESS (0.000s)
[500.806064] Starting dynamic subtest: ccs0
[500.808273] Dynamic subtest ccs0: SUCCESS (0.000s)
[500.818641] Starting dynamic subtest: vcs0
[500.821002] Dynamic subtest vcs0: SUCCESS (0.000s)
[500.831859] Starting dynamic subtest: bcs0
[500.834088] Dynamic subtest bcs0: SUCCESS (0.000s)
[500.844291] Starting dynamic subtest: rcs0
[500.847096] Dynamic subtest rcs0: SUCCESS (0.000s)
[500.857661] Starting dynamic subtest: vcs1
[500.859776] Dynamic subtest vcs1: SUCCESS (0.000s)
[500.862007] Subtest idempotent: SUCCESS (0.006s)
[500.908607] [125/133] (523s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[500.999929] Starting subtest: primary-yf-tiled-reflect-x-90
[501.004862] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[501.075110] [126/133] (523s left) gem_softpin (evict-single-offset)
[501.130232] Starting subtest: evict-single-offset
[527.618398] Subtest evict-single-offset: SUCCESS (26.489s)
[527.718115] [127/133] (496s left) kms_psr (fbc-pr-cursor-plane-onoff)
[527.874014] Starting subtest: fbc-pr-cursor-plane-onoff
[527.878943] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[527.948251] [128/133] (496s left) kms_color (ctm-negative)
[528.049973] Starting subtest: ctm-negative
[528.052565] Starting dynamic subtest: pipe-A-eDP-1
[528.776761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[528.786967] Starting dynamic subtest: pipe-B-eDP-1
[530.223403] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[530.234245] Starting dynamic subtest: pipe-C-eDP-1
[531.602999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[531.617456] Starting dynamic subtest: pipe-D-eDP-1
[532.935278] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[532.937879] Subtest ctm-negative: SUCCESS (4.888s)
[533.764067] [129/133] (490s left) kms_sequence (get-forked)
[533.860895] Starting subtest: get-forked
[533.863379] Starting dynamic subtest: pipe-A-eDP-1
[535.776112] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.915s)
[535.788113] Starting dynamic subtest: pipe-B-eDP-1
[538.289487] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.513s)
[538.301181] Starting dynamic subtest: pipe-C-eDP-1
[540.816399] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.523s)
[540.828222] Starting dynamic subtest: pipe-D-eDP-1
[543.319302] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.500s)
[543.321766] Subtest get-forked: SUCCESS (9.458s)
[544.177585] [130/133] (480s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[544.236988] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[544.240006] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[544.328853] [131/133] (480s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[544.435240] Starting subtest: y-tiled-64bpp-rotate-90
[544.440229] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[544.539099] [132/133] (480s left) syncobj_wait (reset-multiple-signaled)
[544.594030] Starting subtest: reset-multiple-signaled
[544.596462] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[544.695167] [133/133] (480s left) core_auth (getclient-master-drop)
[544.735533] Starting subtest: getclient-master-drop
[544.756048] Subtest getclient-master-drop: SUCCESS (0.020s)
[544.855998] 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.