[58.197395] Initializing watchdogs
[58.197444]   /dev/watchdog0
[58.212461] [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.217142] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.219477] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.221939] [001/156] (960s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[58.331614] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[58.333350] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[58.431239] [002/156] (960s left) perf (gen12-group-exclusive-stream-ctx-handle)
[58.560361] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[58.585923] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[58.625566] [003/156] (960s left) i915_pm_freq_api (freq-basic-api)
[60.304309] Starting subtest: freq-basic-api
[60.305390] Starting dynamic subtest: gt0
[60.308033] Dynamic subtest gt0: SUCCESS (0.004s)
[60.316386] Starting dynamic subtest: gt1
[60.317183] Dynamic subtest gt1: SUCCESS (0.002s)
[60.317921] Subtest freq-basic-api: SUCCESS (0.007s)
[60.404562] [004/156] (958s left) i915_suspend (basic-s2idle-without-i915)
[60.434704] Starting subtest: basic-s2idle-without-i915
[81.530408] Subtest basic-s2idle-without-i915: SUCCESS (6.214s)
[86.704882] [005/156] (937s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[86.799076] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[86.837007] Starting dynamic subtest: pipe-A-plane-0
[87.146730] Dynamic subtest pipe-A-plane-0: SUCCESS (0.322s)
[87.155225] Starting dynamic subtest: pipe-A-plane-3
[87.382617] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[87.395437] Starting dynamic subtest: pipe-A-plane-5
[87.398598] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[88.507155] Starting dynamic subtest: pipe-B-plane-0
[88.789524] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[88.798144] Starting dynamic subtest: pipe-B-plane-3
[89.015340] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[89.023037] Starting dynamic subtest: pipe-B-plane-5
[89.024658] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[89.330661] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.620s)
[90.125774] [006/156] (933s left) gem_flink_basic (double-flink)
[90.187042] Starting subtest: double-flink
[90.188109] Subtest double-flink: SUCCESS (0.000s)
[90.287867] [007/156] (933s left) kms_vrr (max-min)
[90.381699] Starting subtest: max-min
[90.384284] Subtest max-min: SKIP (0.000s)
[90.445000] [008/156] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[90.539769] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[90.542148] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[90.630051] [009/156] (933s left) sysfs_heartbeat_interval (invalid)
[90.681363] Starting subtest: invalid
[90.682353] Starting dynamic subtest: vecs0
[90.683244] Dynamic subtest vecs0: SUCCESS (0.000s)
[90.692790] Starting dynamic subtest: ccs0
[90.693596] Dynamic subtest ccs0: SUCCESS (0.000s)
[90.700509] Starting dynamic subtest: vcs0
[90.701303] Dynamic subtest vcs0: SUCCESS (0.000s)
[90.708122] Starting dynamic subtest: bcs0
[90.708873] Dynamic subtest bcs0: SUCCESS (0.000s)
[90.715705] Starting dynamic subtest: rcs0
[90.716559] Dynamic subtest rcs0: SUCCESS (0.000s)
[90.723854] Starting dynamic subtest: vcs1
[90.724776] Dynamic subtest vcs1: SUCCESS (0.000s)
[90.725636] Subtest invalid: SUCCESS (0.003s)
[90.798841] [010/156] (933s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[91.355909] Starting subtest: syncobj-timeline-multiple-ext-nodes
[91.357040] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[92.359131] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[92.360612] [011/156] (931s left) kms_invalid_mode (zero-hdisplay)
[92.440267] Starting subtest: zero-hdisplay
[92.441209] Starting dynamic subtest: pipe-A-eDP-1
[92.731883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[92.740160] Starting dynamic subtest: pipe-B-eDP-1
[92.741049] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[92.748092] Starting dynamic subtest: pipe-C-eDP-1
[92.748921] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[92.755920] Starting dynamic subtest: pipe-D-eDP-1
[92.756708] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[92.757525] Subtest zero-hdisplay: SUCCESS (0.302s)
[93.591454] [012/156] (930s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[93.703039] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[93.704920] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[93.779827] [013/156] (930s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[93.869367] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[93.871106] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[93.988638] [014/156] (930s left) prime_vgem (basic-fence-flip)
[94.054678] Starting subtest: basic-fence-flip
[94.339940] Subtest basic-fence-flip: SUCCESS (0.289s)
[94.449875] [015/156] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[94.536391] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[94.538074] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[94.619065] [016/156] (929s left) gem_readwrite (read-write)
[94.669906] Subtest read-write: SKIP (0.000s)
[94.725956] [017/156] (929s left) perf (per-context-mode-unprivileged)
[94.842615] Starting subtest: per-context-mode-unprivileged
[94.844211] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[94.880643] [018/156] (929s left) gem_softpin (reverse)
[94.939051] Starting subtest: reverse
[94.946611] Subtest reverse: SUCCESS (0.008s)
[95.053849] [019/156] (929s left) gem_render_copy (y-tiled-to-vebox-linear)
[95.108990] Starting subtest: y-tiled-to-vebox-linear
[95.110873] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[95.296335] [020/156] (929s left) gem_exec_suspend (basic-s3)
[95.357266] Starting subtest: basic-S3
[95.358392] Starting dynamic subtest: smem
[116.869383] Dynamic subtest smem: SUCCESS (8.008s)
[116.870741] Subtest basic-S3: SUCCESS (8.009s)
[122.110364] [021/156] (907s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[122.211130] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[122.212913] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[122.293072] [022/156] (907s left) gem_exec_whisper (basic-fds-all)
[122.354963] Starting subtest: basic-fds-all
[133.795286] Subtest basic-fds-all: SUCCESS (11.449s)
[133.978780] [023/156] (895s left) kms_pipe_crc_basic (nonblocking-crc)
[134.060840] Starting subtest: nonblocking-crc
[134.061877] Starting dynamic subtest: pipe-A-eDP-1
[134.820815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s)
[134.829803] Starting dynamic subtest: pipe-B-eDP-1
[136.241545] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s)
[136.252167] Starting dynamic subtest: pipe-C-eDP-1
[137.620192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[137.630338] Starting dynamic subtest: pipe-D-eDP-1
[138.977208] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[138.978276] Subtest nonblocking-crc: SUCCESS (4.920s)
[139.853617] [024/156] (889s left) api_intel_bb (blit-noreloc-keep-cache)
[139.899957] Starting subtest: blit-noreloc-keep-cache
[139.910741] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[140.023581] [025/156] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[140.122918] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[140.125202] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[140.213894] [026/156] (889s left) kms_psr (pr-primary-mmap-cpu)
[140.299234] Starting subtest: pr-primary-mmap-cpu
[140.301128] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[140.369213] [027/156] (889s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[140.482352] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[140.484251] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[140.623423] [028/156] (889s left) gem_mmap_gtt (close-race)
[140.672204] Subtest close-race: SKIP (0.000s)
[140.725801] [029/156] (889s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[140.775879] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[140.778811] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[140.968031] [030/156] (888s left) kms_addfb_basic (basic)
[141.017363] Starting subtest: basic
[141.018427] Subtest basic: SUCCESS (0.000s)
[141.162426] [031/156] (888s left) gem_mmap_wc (write-read)
[141.212670] Subtest write-read: SKIP (0.000s)
[141.274426] [032/156] (888s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[141.323034] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[141.432354] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.109s)
[141.502549] [033/156] (888s left) kms_frontbuffer_tracking (fbc-tiling-4)
[141.586911] Starting subtest: fbc-tiling-4
[146.125960] Subtest fbc-tiling-4: SUCCESS (4.543s)
[147.281938] [034/156] (882s left) kms_universal_plane (universal-plane-functional)
[147.370466] Starting subtest: universal-plane-functional
[147.371446] Starting dynamic subtest: pipe-A-eDP-1
[151.250150] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.881s)
[151.259482] Starting dynamic subtest: pipe-B-eDP-1
[155.652025] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.520s)
[155.662339] Starting dynamic subtest: pipe-C-eDP-1
[159.851070] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.279s)
[159.861273] Starting dynamic subtest: pipe-D-eDP-1
[164.041316] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.238s)
[164.042243] Subtest universal-plane-functional: SUCCESS (16.923s)
[164.837437] [035/156] (865s left) perf_pmu (init-wait)
[164.876199] Starting subtest: init-wait
[164.876961] Starting dynamic subtest: rcs0
[164.878677] Dynamic subtest rcs0: SUCCESS (0.002s)
[164.887701] Starting dynamic subtest: bcs0
[164.888473] Dynamic subtest bcs0: SUCCESS (0.000s)
[164.896325] Starting dynamic subtest: vcs0
[164.897147] Dynamic subtest vcs0: SUCCESS (0.001s)
[164.904737] Starting dynamic subtest: vcs1
[164.905620] Dynamic subtest vcs1: SUCCESS (0.001s)
[164.913216] Starting dynamic subtest: vecs0
[164.914266] Dynamic subtest vecs0: SUCCESS (0.001s)
[164.922120] Starting dynamic subtest: ccs0
[164.922955] Dynamic subtest ccs0: SUCCESS (0.000s)
[164.923782] Subtest init-wait: SUCCESS (0.008s)
[164.989144] [036/156] (865s left) gem_exec_flush (basic-batch-kernel-default-uc)
[165.058207] Starting subtest: basic-batch-kernel-default-uc
[172.165919] Subtest basic-batch-kernel-default-uc: SUCCESS (7.144s)
[172.350176] [037/156] (857s left) gem_userptr_blits (coherency-unsync)
[172.409326] Subtest coherency-unsync: SKIP (0.000s)
[172.526461] [038/156] (857s left) kms_chamelium_hpd (hdmi-hpd)
[172.908117] Subtest hdmi-hpd: SKIP (0.000s)
[173.704171] [039/156] (856s left) kms_prop_blob (blob-prop-core)
[173.759773] Starting subtest: blob-prop-core
[173.760698] Subtest blob-prop-core: SUCCESS (0.000s)
[173.844936] [040/156] (856s left) gem_partial_pwrite_pread (write-uncached)
[173.899764] Subtest write-uncached: SKIP (0.000s)
[173.963661] [041/156] (856s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[174.048971] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[174.050536] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[174.142741] [042/156] (856s left) kms_legacy_colorkey (basic)
[174.231560] Starting subtest: basic
[174.232474] Starting dynamic subtest: pipe-A
[174.276097] Dynamic subtest pipe-A: SUCCESS (0.045s)
[174.287217] Starting dynamic subtest: pipe-B
[174.288124] Dynamic subtest pipe-B: SUCCESS (0.001s)
[174.295923] Starting dynamic subtest: pipe-C
[174.296796] Dynamic subtest pipe-C: SUCCESS (0.000s)
[174.304667] Starting dynamic subtest: pipe-D
[174.305630] Dynamic subtest pipe-D: SUCCESS (0.000s)
[174.306768] Subtest basic: SUCCESS (0.050s)
[174.339787] [043/156] (855s left) gem_request_retire (retire-vma-not-inactive)
[174.393181] Starting subtest: retire-vma-not-inactive
[174.454400] Subtest retire-vma-not-inactive: SUCCESS (0.059s)
[174.574977] [044/156] (855s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[174.623189] Starting subtest: stress-mm-invalidate-close-overlap
[176.767187] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[176.889553] [045/156] (853s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[176.933356] Starting subtest: invalid-single-wait-all-unsubmitted
[176.934296] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[177.036843] [046/156] (853s left) kms_big_fb (linear-8bpp-rotate-270)
[177.136923] Starting subtest: linear-8bpp-rotate-270
[177.158118] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[177.266810] [047/156] (853s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[177.360956] Starting subtest: 4-tiled-64bpp-rotate-0
[178.960158] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.602s)
[179.122103] [048/156] (851s left) kms_flip (dpms-vs-vblank-race-interruptible)
[179.211355] Starting subtest: dpms-vs-vblank-race-interruptible
[179.212529] Starting dynamic subtest: A-eDP1
[183.171879] Dynamic subtest A-eDP1: SUCCESS (3.964s)
[183.182416] Starting dynamic subtest: B-eDP1
[186.689325] Dynamic subtest B-eDP1: SUCCESS (3.516s)
[186.699538] Starting dynamic subtest: C-eDP1
[190.196834] Dynamic subtest C-eDP1: SUCCESS (3.502s)
[190.206434] Starting dynamic subtest: D-eDP1
[193.797523] Dynamic subtest D-eDP1: SUCCESS (3.597s)
[193.800079] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.590s)
[194.676633] [049/156] (835s left) kms_flip (blocking-absolute-wf_vblank)
[194.767775] Starting subtest: blocking-absolute-wf_vblank
[194.769741] Starting dynamic subtest: A-eDP1
[203.569370] Dynamic subtest A-eDP1: SUCCESS (8.771s)
[203.580802] Starting dynamic subtest: B-eDP1
[212.294356] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[212.304668] Starting dynamic subtest: C-eDP1
[221.022732] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[221.033587] Starting dynamic subtest: D-eDP1
[229.751388] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[229.752329] Subtest blocking-absolute-wf_vblank: SUCCESS (34.953s)
[230.929565] [050/156] (799s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[231.017351] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[231.019100] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[231.086451] [051/156] (799s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[231.176105] Starting subtest: async-flip-with-page-flip-events-linear
[231.557242] Starting dynamic subtest: pipe-A-eDP-1
[234.313064] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.746s)
[234.665893] Starting dynamic subtest: pipe-B-eDP-1
[237.440613] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[237.792319] Starting dynamic subtest: pipe-C-eDP-1
[240.567952] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[240.932595] Starting dynamic subtest: pipe-D-eDP-1
[243.701844] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[243.703529] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.520s)
[244.873597] [052/156] (785s left) gem_partial_pwrite_pread (writes-after-reads-display)
[244.928045] Subtest writes-after-reads-display: SKIP (0.000s)
[244.983505] [053/156] (785s left) core_setmaster (master-drop-set-user)
[245.067555] Starting subtest: master-drop-set-user
[245.078677] Subtest master-drop-set-user: SUCCESS (0.013s)
[245.111313] [054/156] (785s left) gem_exec_schedule (submit-early-slice)
[245.177001] Starting subtest: submit-early-slice
[245.178195] Starting dynamic subtest: rcs0
[245.220778] Dynamic subtest rcs0: SUCCESS (0.043s)
[245.231911] Starting dynamic subtest: bcs0
[245.258161] Dynamic subtest bcs0: SUCCESS (0.037s)
[245.268381] Starting dynamic subtest: vcs0
[245.301652] Dynamic subtest vcs0: SUCCESS (0.042s)
[245.313805] Starting dynamic subtest: vcs1
[245.341198] Dynamic subtest vcs1: SUCCESS (0.038s)
[245.351719] Starting dynamic subtest: vecs0
[245.380564] Dynamic subtest vecs0: SUCCESS (0.038s)
[245.394433] Starting dynamic subtest: ccs0
[245.428401] Dynamic subtest ccs0: SUCCESS (0.047s)
[245.429394] Subtest submit-early-slice: SUCCESS (0.252s)
[246.936064] [055/156] (783s left) gem_ctx_persistence (legacy-engines-hang)
[247.002188] Starting subtest: legacy-engines-hang
[247.003118] Starting dynamic subtest: render
[247.126571] Dynamic subtest render: SUCCESS (0.123s)
[247.139136] Starting dynamic subtest: bsd1
[247.235850] Dynamic subtest bsd1: SUCCESS (0.106s)
[247.249225] Starting dynamic subtest: bsd2
[247.333758] Dynamic subtest bsd2: SUCCESS (0.095s)
[247.345668] Starting dynamic subtest: blt
[247.423779] Dynamic subtest blt: SUCCESS (0.087s)
[247.435762] Starting dynamic subtest: vebox
[247.519275] Dynamic subtest vebox: SUCCESS (0.093s)
[247.520492] Subtest legacy-engines-hang: SUCCESS (0.518s)
[247.596754] [056/156] (783s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[247.687826] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[247.689524] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[247.804879] [057/156] (782s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[247.895704] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[247.897256] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[247.984252] [058/156] (782s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[248.076380] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[248.078093] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[248.193413] [059/156] (782s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[248.289605] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[248.290455] Starting dynamic subtest: pipe-A
[249.509443] Dynamic subtest pipe-A: SUCCESS (1.220s)
[249.517752] Starting dynamic subtest: pipe-B
[251.800573] Dynamic subtest pipe-B: SUCCESS (2.289s)
[251.815041] Starting dynamic subtest: pipe-C
[252.986898] Dynamic subtest pipe-C: SUCCESS (1.184s)
[252.995482] Starting dynamic subtest: pipe-D
[254.231525] Dynamic subtest pipe-D: SUCCESS (1.243s)
[254.232443] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.941s)
[255.434824] [060/156] (775s left) kms_cursor_crc (cursor-offscreen-64x64)
[255.614257] Starting subtest: cursor-offscreen-64x64
[255.618379] Starting dynamic subtest: pipe-A-eDP-1
[257.550303] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[257.581942] Starting dynamic subtest: pipe-D-eDP-1
[260.142374] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[260.143413] Subtest cursor-offscreen-64x64: SUCCESS (4.527s)
[261.007594] [061/156] (769s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[261.096223] Starting subtest: fbc-psr2-sprite-mmap-gtt
[261.097064] Starting dynamic subtest: eDP-1
[261.098849] Dynamic subtest eDP-1: SKIP (0.000s)
[261.100544] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[261.165676] [062/156] (769s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[261.255186] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[261.257141] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[261.349753] [063/156] (769s left) api_intel_bb (reset-bb)
[261.402252] Starting subtest: reset-bb
[261.404652] Subtest reset-bb: SUCCESS (0.003s)
[261.508525] [064/156] (769s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[261.589365] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[261.591186] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[261.671099] [065/156] (769s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[261.751343] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[261.752265] Starting dynamic subtest: pipe-A-default-mode
[264.563679] Dynamic subtest pipe-A-default-mode: SUCCESS (2.811s)
[264.564649] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.812s)
[265.404207] [066/156] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[265.491433] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[269.231623] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.741s)
[270.412730] [067/156] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[270.508630] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[277.570809] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.063s)
[277.714713] [068/156] (753s left) kms_chamelium_audio (dp-audio-edid)
[278.110926] Subtest dp-audio-edid: SKIP (0.000s)
[278.951052] [069/156] (752s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[279.034164] Starting subtest: bad-pixel-format-yf-tiled-ccs
[279.034918] Starting dynamic subtest: pipe-A-eDP-1
[279.043210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.051838] Starting dynamic subtest: pipe-B-eDP-1
[279.059997] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.068478] Starting dynamic subtest: pipe-C-eDP-1
[279.077190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.085223] Starting dynamic subtest: pipe-D-eDP-1
[279.093577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.095272] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[281.356124] [070/156] (749s left) syncobj_timeline (wait-for-submit-snapshot)
[281.412697] Starting subtest: wait-for-submit-snapshot
[281.487217] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[281.559749] [071/156] (749s left) kms_cursor_crc (cursor-sliding-64x64)
[281.728895] Starting subtest: cursor-sliding-64x64
[281.730935] Starting dynamic subtest: pipe-A-eDP-1
[284.970144] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.239s)
[285.003485] Starting dynamic subtest: pipe-D-eDP-1
[288.878141] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.883s)
[288.879103] Subtest cursor-sliding-64x64: SUCCESS (7.149s)
[289.728369] [072/156] (741s left) gem_userptr_blits (vma-merge)
[289.803182] Starting subtest: vma-merge
[289.849567] Subtest vma-merge: SUCCESS (0.046s)
[289.948402] [073/156] (741s left) gem_exec_params (invalid-bsd-ring)
[290.004341] Starting subtest: invalid-bsd-ring
[290.005431] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[290.115246] [074/156] (741s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[290.220146] Starting subtest: yf-tiled-64bpp-rotate-180
[290.222309] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[290.302286] [075/156] (741s left) kms_psr (psr-sprite-render)
[290.390534] Starting subtest: psr-sprite-render
[290.391620] Starting dynamic subtest: eDP-1
[292.139734] Dynamic subtest eDP-1: SUCCESS (1.748s)
[292.141021] Subtest psr-sprite-render: SUCCESS (1.750s)
[292.979072] [076/156] (738s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[293.075295] Starting subtest: fbcpsr-stridechange
[299.353929] Subtest fbcpsr-stridechange: SUCCESS (6.280s)
[299.498159] [077/156] (731s left) gem_mmap_offset (pf-nonblock)
[299.544930] Starting subtest: pf-nonblock
[299.550556] Subtest pf-nonblock: SUCCESS (0.007s)
[299.664235] [078/156] (731s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[299.747537] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[306.380099] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.634s)
[307.765905] [079/156] (723s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[307.857059] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[307.858798] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.952960] [080/156] (723s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[308.042656] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[308.044326] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[308.141068] [081/156] (723s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.239937] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[308.241468] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[308.337331] [082/156] (723s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[308.427628] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[308.429229] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[308.521826] [083/156] (723s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[308.610087] Starting subtest: psr-2p-pri-indfb-multidraw
[308.611777] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[308.703747] [084/156] (722s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[308.787026] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[308.788727] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[308.892346] [085/156] (722s left) gem_exec_reloc (basic-cpu-wc-active)
[308.941428] Subtest basic-cpu-wc-active: SKIP (0.000s)
[309.004834] [086/156] (722s left) kms_properties (colorop-properties-legacy)
[309.084383] Starting subtest: colorop-properties-legacy
[309.085275] Starting dynamic subtest: pipe-A-eDP-1
[309.440084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[309.450624] Starting dynamic subtest: pipe-B-eDP-1
[310.507894] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.066s)
[310.517346] Starting dynamic subtest: pipe-C-eDP-1
[311.556686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.048s)
[311.565603] Starting dynamic subtest: pipe-D-eDP-1
[312.601056] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.044s)
[312.602016] Subtest colorop-properties-legacy: SUCCESS (3.518s)
[313.406372] [087/156] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[313.494947] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[313.496688] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[313.592821] [088/156] (718s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[313.690924] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[313.692658] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[313.792202] [089/156] (718s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[313.881032] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[313.882657] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[315.037023] [090/156] (716s left) gem_flink_basic (flink-lifetime)
[315.081316] Starting subtest: flink-lifetime
[315.083478] Subtest flink-lifetime: SUCCESS (0.002s)
[315.186662] [091/156] (716s left) kms_panel_fitting (atomic-fastset)
[315.270547] Starting subtest: atomic-fastset
[315.271653] Starting dynamic subtest: pipe-A-eDP-1
[315.404640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[315.415493] Starting dynamic subtest: pipe-B-eDP-1
[316.612743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[316.623706] Starting dynamic subtest: pipe-C-eDP-1
[317.800785] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[317.809823] Starting dynamic subtest: pipe-D-eDP-1
[319.036928] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[319.038100] Subtest atomic-fastset: SUCCESS (3.769s)
[320.289402] [092/156] (711s left) kms_psr (psr-cursor-blt)
[320.389075] Starting subtest: psr-cursor-blt
[320.389894] Starting dynamic subtest: eDP-1
[322.076372] Dynamic subtest eDP-1: SUCCESS (1.687s)
[322.077337] Subtest psr-cursor-blt: SUCCESS (1.688s)
[322.943090] [093/156] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[323.044844] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[323.046434] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[323.153102] [094/156] (708s left) kms_plane (pixel-format-4-tiled-modifier)
[323.241001] Starting subtest: pixel-format-4-tiled-modifier
[323.268281] Starting dynamic subtest: pipe-A-plane-0
[323.656584] Dynamic subtest pipe-A-plane-0: SUCCESS (0.388s)
[323.666207] Starting dynamic subtest: pipe-A-plane-3
[323.967688] Dynamic subtest pipe-A-plane-3: SUCCESS (0.310s)
[323.976715] Starting dynamic subtest: pipe-A-plane-5
[323.978536] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[325.123953] Starting dynamic subtest: pipe-B-plane-0
[325.537520] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[325.546631] Starting dynamic subtest: pipe-B-plane-3
[325.859990] Dynamic subtest pipe-B-plane-3: SUCCESS (0.321s)
[325.869896] Starting dynamic subtest: pipe-B-plane-5
[325.871923] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[326.187260] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.947s)
[327.021202] [095/156] (705s left) gem_mmap_wc (write-read-distinct)
[327.067822] Subtest write-read-distinct: SKIP (0.000s)
[327.131502] [096/156] (704s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[327.220796] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[327.222477] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[327.304298] [097/156] (704s left) gen7_exec_parse (load-register-reg)
[327.352701] Subtest load-register-reg: SKIP (0.000s)
[327.411227] [098/156] (704s left) gem_create (create-ext-set-pat)
[327.576554] Starting subtest: create-ext-set-pat
[327.577584] Subtest create-ext-set-pat: SUCCESS (0.001s)
[327.644090] [099/156] (704s left) kms_flip (2x-nonexisting-fb)
[327.737921] Starting subtest: 2x-nonexisting-fb
[327.748917] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[327.836838] [100/156] (704s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[327.940742] Starting subtest: yf-tiled-16bpp-rotate-180
[327.942579] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[328.042761] [101/156] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[328.141500] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[328.143213] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[328.240787] [102/156] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[328.341573] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[328.343364] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[328.451622] [103/156] (703s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[328.547916] Starting subtest: psrhdr-rgb565-draw-render
[328.549696] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[328.650146] [104/156] (703s left) kms_psr (fbc-pr-primary-render)
[328.736900] Starting subtest: fbc-pr-primary-render
[328.738823] Subtest fbc-pr-primary-render: SKIP (0.000s)
[328.805650] [105/156] (703s left) gem_exec_parallel (contexts)
[328.856649] Starting subtest: contexts
[328.857636] Starting dynamic subtest: rcs0
[331.489538] Dynamic subtest rcs0: SUCCESS (2.624s)
[331.498635] Starting dynamic subtest: bcs0
[334.920785] Dynamic subtest bcs0: SUCCESS (3.431s)
[334.931946] Starting dynamic subtest: vcs0
[339.215746] Dynamic subtest vcs0: SUCCESS (4.293s)
[339.225044] Starting dynamic subtest: vcs1
[343.217813] Dynamic subtest vcs1: SUCCESS (4.010s)
[343.227999] Starting dynamic subtest: vecs0
[347.287318] Dynamic subtest vecs0: SUCCESS (4.061s)
[347.300570] Starting dynamic subtest: ccs0
[350.793680] Dynamic subtest ccs0: SUCCESS (3.503s)
[350.795168] Subtest contexts: SUCCESS (21.933s)
[350.987141] [106/156] (681s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[351.082099] Starting subtest: hdr-shrfb-scaledprimary
[351.083882] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[351.191911] [107/156] (681s left) gem_eio (unwedge-stress)
[351.427078] Starting subtest: unwedge-stress
[351.428196] Starting dynamic subtest: render
[356.466772] Dynamic subtest render: SUCCESS (5.039s)
[356.477920] Starting dynamic subtest: bsd1
[384.353797] Dynamic subtest bsd1: SUCCESS (27.887s)
[384.372334] Starting dynamic subtest: bsd2
[408.374948] Dynamic subtest bsd2: SUCCESS (24.014s)
[408.392288] Starting dynamic subtest: blt
[408.393815] Dynamic subtest blt: SKIP (0.000s)
[408.402233] Starting dynamic subtest: vebox
[434.341664] Dynamic subtest vebox: SUCCESS (25.962s)
[434.342792] Subtest unwedge-stress: SUCCESS (82.907s)
[435.883159] [108/156] (596s left) i915_drm_fdinfo (virtual-busy-all)
[435.920449] Starting subtest: virtual-busy-all
[435.922130] Subtest virtual-busy-all: SKIP (0.000s)
[435.985573] [109/156] (596s left) vgem_basic (dmabuf-fence-before)
[436.025813] Starting subtest: dmabuf-fence-before
[436.026909] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[436.078276] [110/156] (596s left) kms_atomic_transition (modeset-transition)
[436.161465] Starting subtest: modeset-transition
[436.162390] Starting dynamic subtest: 1x-outputs
[447.237678] Dynamic subtest 1x-outputs: SUCCESS (11.076s)
[447.241106] Subtest modeset-transition: SUCCESS (11.078s)
[448.096734] [111/156] (584s left) kms_flip (2x-plain-flip-fb-recreate)
[448.185145] Starting subtest: 2x-plain-flip-fb-recreate
[448.196268] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s)
[448.270324] [112/156] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[448.357078] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[448.358765] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[448.453125] [113/156] (584s left) i915_pm_rps (engine-order)
[448.507125] Starting subtest: engine-order
[454.875966] Subtest engine-order: SUCCESS (6.363s)
[454.973389] [114/156] (577s left) gem_exec_schedule (in-order)
[455.037387] Starting subtest: in-order
[455.038442] Starting dynamic subtest: rcs0
[455.216843] Dynamic subtest rcs0: SUCCESS (0.179s)
[455.229221] Starting dynamic subtest: vcs0
[455.326165] Dynamic subtest vcs0: SUCCESS (0.109s)
[455.338653] Starting dynamic subtest: vcs1
[455.438122] Dynamic subtest vcs1: SUCCESS (0.112s)
[455.451910] Starting dynamic subtest: vecs0
[455.553938] Dynamic subtest vecs0: SUCCESS (0.114s)
[455.565688] Starting dynamic subtest: ccs0
[455.692529] Dynamic subtest ccs0: SUCCESS (0.138s)
[455.693766] Subtest in-order: SUCCESS (0.655s)
[456.922914] [115/156] (575s left) kms_psr (fbc-psr-primary-mmap-cpu)
[457.014195] Starting subtest: fbc-psr-primary-mmap-cpu
[457.015233] Starting dynamic subtest: eDP-1
[457.017197] Dynamic subtest eDP-1: SKIP (0.000s)
[457.018956] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[457.082815] [116/156] (575s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[457.134752] Starting subtest: framebuffer-vs-set-tiling
[457.136607] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[457.284248] [117/156] (575s left) perf (invalid-oa-format-id)
[457.372100] Starting subtest: invalid-oa-format-id
[457.383122] Subtest invalid-oa-format-id: SUCCESS (0.010s)
[457.421700] [118/156] (575s left) gem_exercise_blt (fast-copy)
[457.481830] Starting subtest: fast-copy
[457.482934] Starting dynamic subtest: linear-smem-smem
[457.506789] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[457.518311] Starting dynamic subtest: xmajor-smem-smem
[457.525143] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[457.534439] Starting dynamic subtest: tile4-smem-smem
[457.543828] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[457.553042] Starting dynamic subtest: tile64-smem-smem
[457.561430] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[457.562606] Subtest fast-copy: SUCCESS (0.080s)
[457.687754] [119/156] (575s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[457.784106] Starting subtest: hdr-1p-pri-indfb-multidraw
[457.786054] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[457.879709] [120/156] (575s left) kms_color (ctm-0-50)
[457.959599] Starting subtest: ctm-0-50
[457.960672] Starting dynamic subtest: pipe-A-eDP-1
[461.521665] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.563s)
[461.532110] Starting dynamic subtest: pipe-B-eDP-1
[465.810819] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.288s)
[465.820131] Starting dynamic subtest: pipe-C-eDP-1
[469.953716] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.142s)
[469.963268] Starting dynamic subtest: pipe-D-eDP-1
[473.985191] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.031s)
[473.986130] Subtest ctm-0-50: SUCCESS (16.027s)
[474.795537] [121/156] (558s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render)
[474.900598] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render
[474.902407] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[474.981679] [122/156] (558s left) kms_content_protection (atomic-dpms)
[475.113330] Starting subtest: atomic-dpms
[475.115195] Subtest atomic-dpms: SKIP (0.000s)
[475.240845] [123/156] (557s left) kms_pm_rpm (cursor)
[476.969622] Starting subtest: cursor
[476.972344] Subtest cursor: SKIP (0.000s)
[477.547192] [124/156] (555s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[477.637208] Starting subtest: y-tiled-32bpp-rotate-180
[477.639302] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[477.742972] [125/156] (555s left) kms_dsc (dsc-with-bpc)
[477.832136] Starting subtest: dsc-with-bpc
[477.843385] Subtest dsc-with-bpc: SKIP (0.001s)
[477.902159] [126/156] (555s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[477.985509] Starting subtest: fbchdr-rgb101010-draw-pwrite
[477.987326] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[478.074678] [127/156] (555s left) kms_cursor_crc (cursor-sliding-256x256)
[478.319320] Starting subtest: cursor-sliding-256x256
[478.322965] Starting dynamic subtest: pipe-A-eDP-1
[481.543338] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.219s)
[481.574364] Starting dynamic subtest: pipe-D-eDP-1
[485.410484] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.845s)
[485.411254] Subtest cursor-sliding-256x256: SUCCESS (7.092s)
[486.279700] [128/156] (546s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[486.364827] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[486.366738] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[486.475696] [129/156] (546s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[486.570317] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[491.332563] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.763s)
[491.433606] [130/156] (541s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[491.811677] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[492.643390] [131/156] (540s left) fbdev (write)
[492.678288] Starting subtest: write
[493.052064] Subtest write: SUCCESS (0.363s)
[493.113796] [132/156] (540s left) gem_ctx_param (non-root-set)
[493.154420] Starting subtest: non-root-set
[493.186393] Subtest non-root-set: SUCCESS (0.032s)
[493.268140] [133/156] (540s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[493.330439] Subtest tiled-to-tiled: SKIP (0.000s)
[493.391901] [134/156] (540s left) gem_ctx_param (root-set)
[493.435498] Starting subtest: root-set
[493.436600] Subtest root-set: SUCCESS (0.001s)
[493.526518] [135/156] (539s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[493.622005] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[493.623748] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[493.710838] [136/156] (539s left) gem_exec_balancer (parallel-balancer)
[493.985605] Starting subtest: parallel-balancer
[494.991439] Subtest parallel-balancer: SUCCESS (1.006s)
[495.097004] [137/156] (538s left) syncobj_timeline (reset-unsignaled)
[495.150059] Starting subtest: reset-unsignaled
[495.150975] Subtest reset-unsignaled: SUCCESS (0.000s)
[495.260802] [138/156] (538s left) gem_eio (create-ext)
[495.479359] Starting subtest: create-ext
[495.826951] Subtest create-ext: SUCCESS (0.347s)
[495.958991] [139/156] (537s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[496.055725] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[496.056636] Starting dynamic subtest: pipe-A-eDP-1
[496.065289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[496.075548] Starting dynamic subtest: pipe-B-eDP-1
[496.084341] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[496.095144] Starting dynamic subtest: pipe-C-eDP-1
[496.103101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[496.112239] Starting dynamic subtest: pipe-D-eDP-1
[496.120686] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[496.122301] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[498.318282] [140/156] (535s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[498.404400] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[498.405965] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[498.522364] [141/156] (535s left) prime_mmap (test_reprime)
[498.580632] Starting subtest: test_reprime
[498.581795] Starting dynamic subtest: test_reprime-smem
[498.614310] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[498.615668] Subtest test_reprime: SUCCESS (0.034s)
[498.717478] [142/156] (535s left) perf (enable-disable)
[498.817350] Starting subtest: enable-disable
[498.818546] Starting dynamic subtest: 0-rcs0
[501.100825] Dynamic subtest 0-rcs0: SUCCESS (2.274s)
[501.112936] Starting dynamic subtest: 1-vcs1
[505.581292] Dynamic subtest 1-vcs1: SUCCESS (4.480s)
[505.582100] Subtest enable-disable: SUCCESS (6.756s)
[505.620439] [143/156] (528s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[505.665403] Starting subtest: etime-single-wait-for-submit-unsubmitted
[505.767248] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[505.844114] [144/156] (527s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[505.946243] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[505.948119] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[506.048652] [145/156] (527s left) gem_ctx_persistence (engines-cleanup)
[506.113680] Starting subtest: engines-cleanup
[506.114747] Starting dynamic subtest: rcs0
[506.185217] Dynamic subtest rcs0: SUCCESS (0.071s)
[506.199285] Starting dynamic subtest: bcs0
[506.233005] Dynamic subtest bcs0: SUCCESS (0.046s)
[506.244657] Starting dynamic subtest: vcs0
[506.273086] Dynamic subtest vcs0: SUCCESS (0.038s)
[506.286958] Starting dynamic subtest: vcs1
[506.320017] Dynamic subtest vcs1: SUCCESS (0.044s)
[506.331653] Starting dynamic subtest: vecs0
[506.362089] Dynamic subtest vecs0: SUCCESS (0.040s)
[506.373246] Starting dynamic subtest: ccs0
[506.398963] Dynamic subtest ccs0: SUCCESS (0.035s)
[506.401643] Subtest engines-cleanup: SUCCESS (0.287s)
[506.476372] [146/156] (527s left) gem_exec_reloc (basic-wc-cpu)
[506.533927] Subtest basic-wc-cpu: SKIP (0.000s)
[506.598682] [147/156] (527s left) sriov_basic (bind-unbind-vf)
[506.642595] Starting subtest: bind-unbind-vf
[506.643577] Starting dynamic subtest: vf-1
[506.676137] Dynamic subtest vf-1: FAIL (0.016s)
[506.687544] Starting dynamic subtest: vf-2
[506.714328] Dynamic subtest vf-2: FAIL (0.004s)
[506.724082] Starting dynamic subtest: vf-3
[506.749986] Dynamic subtest vf-3: FAIL (0.004s)
[506.759644] Starting dynamic subtest: vf-4
[506.784745] Dynamic subtest vf-4: FAIL (0.004s)
[506.796283] Starting dynamic subtest: vf-5
[506.824203] Dynamic subtest vf-5: FAIL (0.004s)
[506.833159] Starting dynamic subtest: vf-6
[506.861642] Dynamic subtest vf-6: FAIL (0.004s)
[506.871919] Starting dynamic subtest: vf-7
[506.899606] Dynamic subtest vf-7: FAIL (0.004s)
[506.908972] Starting dynamic subtest: vf-random
[506.935766] Dynamic subtest vf-random: FAIL (0.004s)
[506.944940] Starting dynamic subtest: vf-last
[506.971675] Dynamic subtest vf-last: FAIL (0.004s)
[506.972547] Subtest bind-unbind-vf: FAIL (0.056s)
[507.005246] [148/156] (526s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[507.112525] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[508.303055] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.190s)
[508.422141] [149/156] (525s left) gem_exec_parallel (userptr)
[508.473295] Starting subtest: userptr
[508.474326] Starting dynamic subtest: rcs0
[509.930826] Dynamic subtest rcs0: SUCCESS (1.457s)
[509.943922] Starting dynamic subtest: bcs0
[511.415937] Dynamic subtest bcs0: SUCCESS (1.484s)
[511.429962] Starting dynamic subtest: vcs0
[512.869417] Dynamic subtest vcs0: SUCCESS (1.450s)
[512.882800] Starting dynamic subtest: vcs1
[514.833028] Dynamic subtest vcs1: SUCCESS (1.951s)
[514.843143] Starting dynamic subtest: vecs0
[516.815522] Dynamic subtest vecs0: SUCCESS (1.980s)
[516.828142] Starting dynamic subtest: ccs0
[518.313824] Dynamic subtest ccs0: SUCCESS (1.504s)
[518.317571] Subtest userptr: SUCCESS (9.843s)
[518.516017] [150/156] (515s left) gem_exec_balancer (parallel-out-fence)
[518.793598] Starting subtest: parallel-out-fence
[520.097256] Subtest parallel-out-fence: SUCCESS (1.304s)
[520.191408] [151/156] (513s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render)
[520.288193] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render
[520.289944] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[520.392974] [152/156] (513s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[520.489012] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[525.169754] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.682s)
[526.317685] [153/156] (507s left) gem_mmap (pf-nonblock)
[526.377779] Subtest pf-nonblock: SKIP (0.000s)
[526.436805] [154/156] (507s left) gem_userptr_blits (readonly-pwrite-unsync)
[526.498054] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[526.615324] [155/156] (507s left) kms_plane_scaling (planes-upscale-factor-0-25)
[526.709557] Starting subtest: planes-upscale-factor-0-25
[526.710629] Starting dynamic subtest: pipe-A
[526.762756] Dynamic subtest pipe-A: SUCCESS (0.062s)
[526.776354] Starting dynamic subtest: pipe-B
[527.941454] Dynamic subtest pipe-B: SUCCESS (1.177s)
[527.956408] Starting dynamic subtest: pipe-C
[529.044060] Dynamic subtest pipe-C: SUCCESS (1.101s)
[529.055515] Starting dynamic subtest: pipe-D
[530.178353] Dynamic subtest pipe-D: SUCCESS (1.134s)
[530.179364] Subtest planes-upscale-factor-0-25: SUCCESS (3.479s)
[531.339780] [156/156] (502s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[531.429247] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[531.431158] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[532.560491] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: i915_pm_freq_api
results: parsing output: 3/ for test: i915_suspend
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: gem_flink_basic
results: parsing output: 6/ for test: kms_vrr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: sysfs_heartbeat_interval
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_invalid_mode
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_readwrite
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: gem_exec_suspend
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_pipe_crc_basic
results: parsing output: 23/ for test: api_intel_bb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: kms_prop_blob
results: parsing output: 39/ for test: gem_partial_pwrite_pread
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_legacy_colorkey
results: parsing output: 42/ for test: gem_request_retire
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: core_setmaster
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_properties
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_panel_fitting
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gen7_exec_parse
results: parsing output: 97/ for test: gem_create
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: i915_drm_fdinfo
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: kms_atomic_transition
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_pm_rps
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gem_exercise_blt
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_dsc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_chamelium_frames
results: parsing output: 130/ for test: fbdev
results: parsing output: 131/ for test: gem_ctx_param
results: parsing output: 132/ for test: gem_set_tiling_vs_blt
results: parsing output: 133/ for test: gem_ctx_param
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_exec_balancer
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: gem_eio
results: parsing output: 138/ for test: kms_ccs
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: prime_mmap
results: parsing output: 141/ for test: perf
results: parsing output: 142/ for test: syncobj_timeline
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gem_ctx_persistence
results: parsing output: 145/ for test: gem_exec_reloc
results: parsing output: 146/ for test: sriov_basic
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: gem_exec_parallel
results: parsing output: 149/ for test: gem_exec_balancer
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_mmap
results: parsing output: 153/ for test: gem_userptr_blits
results: parsing output: 154/ for test: kms_plane_scaling
results: parsing output: 155/ for test: kms_ccs
Done.