[42.747095] Initializing watchdogs
[42.747141]   /dev/watchdog0
[42.753632] [001/144] (960s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf)
[48.049071] Starting subtest: overlay-plane-move-continuous-exceed-fully-sf
[48.051761] Starting dynamic subtest: pipe-A-eDP-1
[65.330599] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.279s)
[65.343037] Starting dynamic subtest: pipe-B-eDP-1
[82.613812] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.281s)
[82.616268] Subtest overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.564s)
[83.517162] [002/144] (919s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[83.612537] Starting subtest: nonblocking-crc-frame-sequence
[83.615203] Starting dynamic subtest: pipe-A-eDP-1
[84.437941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[84.449949] Starting dynamic subtest: pipe-B-eDP-1
[86.028502] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.588s)
[86.041925] Starting dynamic subtest: pipe-C-eDP-1
[87.541086] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[87.554150] Starting dynamic subtest: pipe-D-eDP-1
[89.003656] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.459s)
[89.006603] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.392s)
[89.903874] [003/144] (913s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[90.022137] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[90.026820] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[90.098758] [004/144] (913s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[90.165525] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[90.179122] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.013s)
[90.237957] [005/144] (913s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-rc-ccs)
[90.676516] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-rc-ccs
[91.485259] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.808s)
[92.659906] [006/144] (910s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-mc-ccs)
[93.093875] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-mc-ccs
[93.099657] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[93.933950] [007/144] (909s left) kms_flip (flip-vs-panning-vs-hang)
[94.026410] Starting subtest: flip-vs-panning-vs-hang
[94.031660] Starting dynamic subtest: A-eDP1
[132.952355] Dynamic subtest A-eDP1: SUCCESS (38.921s)
[132.961823] Starting dynamic subtest: D-eDP1
[173.050192] Dynamic subtest D-eDP1: SUCCESS (40.098s)
[173.053270] Subtest flip-vs-panning-vs-hang: SUCCESS (79.026s)
[174.338196] [008/144] (829s left) kms_plane_scaling (invalid-parameters)
[174.438842] Starting subtest: invalid-parameters
[174.441450] Starting dynamic subtest: less-than-1-height-src
[174.443980] Dynamic subtest less-than-1-height-src: SUCCESS (0.007s)
[174.453205] Starting dynamic subtest: less-than-1-width-src
[174.455200] Dynamic subtest less-than-1-width-src: SUCCESS (0.007s)
[174.457189] Subtest invalid-parameters: SUCCESS (0.014s)
[174.542615] [009/144] (828s left) kms_dsc (dsc-with-formats)
[174.647945] Starting subtest: dsc-with-formats
[174.652034] Subtest dsc-with-formats: SKIP (0.001s)
[174.711940] [010/144] (828s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[174.783201] Starting subtest: etime-multi-wait-all-submitted-signaled
[174.888921] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[174.957405] [011/144] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[175.045350] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[175.049433] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[175.125365] [012/144] (828s left) gem_userptr_blits (invalid-null-pointer)
[175.236386] Starting subtest: invalid-null-pointer
[175.238828] Subtest invalid-null-pointer: SUCCESS (0.002s)
[175.362286] [013/144] (828s left) kms_getfb (getfb2-handle-zero)
[175.433375] Starting subtest: getfb2-handle-zero
[175.435849] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[175.516253] [014/144] (828s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[177.560073] Starting subtest: dpms-mode-unset-lpsp
[185.909037] Subtest dpms-mode-unset-lpsp: SUCCESS (8.350s)
[186.718595] [015/144] (816s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[187.136131] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs
[187.139364] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[188.017296] [016/144] (815s left) gem_workarounds (basic-read-context)
[188.123888] Starting subtest: basic-read-context
[188.137889] Subtest basic-read-context: SUCCESS (0.013s)
[188.241066] [017/144] (815s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[188.354059] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[188.356527] Starting dynamic subtest: pipe-A-default-mode
[188.645038] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[188.650383] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.289s)
[189.551664] [018/144] (814s left) gem_lmem_swapping (heavy-verify-random-ccs)
[189.617689] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[189.641941] [019/144] (814s left) sysfs_defaults (readonly)
[189.717284] Starting subtest: readonly
[189.720279] Starting dynamic subtest: vecs0
[189.723146] Dynamic subtest vecs0: SUCCESS (0.001s)
[189.731774] Starting dynamic subtest: ccs0
[189.734820] Dynamic subtest ccs0: SUCCESS (0.001s)
[189.743267] Starting dynamic subtest: vcs0
[189.746333] Dynamic subtest vcs0: SUCCESS (0.001s)
[189.754677] Starting dynamic subtest: bcs0
[189.757303] Dynamic subtest bcs0: SUCCESS (0.001s)
[189.765138] Starting dynamic subtest: rcs0
[189.767216] Dynamic subtest rcs0: SUCCESS (0.000s)
[189.773930] Starting dynamic subtest: vcs1
[189.776071] Dynamic subtest vcs1: SUCCESS (0.000s)
[189.778298] Subtest readonly: SUCCESS (0.007s)
[189.804499] [020/144] (813s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[189.883273] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[189.975321] [021/144] (813s left) kms_psr (fbc-psr2-sprite-plane-move)
[190.069390] Starting subtest: fbc-psr2-sprite-plane-move
[190.071898] Starting dynamic subtest: eDP-1
[190.076752] Dynamic subtest eDP-1: SKIP (0.000s)
[190.081411] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[190.175268] [022/144] (813s left) api_intel_bb (reset-flags)
[190.249296] Starting subtest: reset-flags
[190.268368] Subtest reset-flags: SUCCESS (0.022s)
[190.363865] [023/144] (813s left) gem_exec_params (invalid-fence-in)
[190.444861] Starting subtest: invalid-fence-in
[190.447601] Subtest invalid-fence-in: SUCCESS (0.000s)
[190.530782] [024/144] (813s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-rc-ccs)
[190.925718] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs
[190.931218] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[191.785399] [025/144] (812s left) gem_mmap (short-mmap)
[191.869489] Subtest short-mmap: SKIP (0.000s)
[191.918099] [026/144] (811s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-ccs)
[192.341213] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-ccs
[192.347571] Subtest pipe-D-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[193.198884] [027/144] (810s left) gem_exec_schedule (submit-late-slice)
[193.298659] Starting subtest: submit-late-slice
[193.301274] Starting dynamic subtest: rcs0
[193.345207] Dynamic subtest rcs0: SUCCESS (0.048s)
[193.356703] Starting dynamic subtest: bcs0
[193.427306] Dynamic subtest bcs0: SUCCESS (0.081s)
[193.441363] Starting dynamic subtest: vcs0
[193.486945] Dynamic subtest vcs0: SUCCESS (0.059s)
[193.500743] Starting dynamic subtest: vcs1
[193.523681] Dynamic subtest vcs1: SUCCESS (0.036s)
[193.538180] Starting dynamic subtest: vecs0
[193.554658] Dynamic subtest vecs0: SUCCESS (0.031s)
[193.569320] Starting dynamic subtest: ccs0
[193.595918] Dynamic subtest ccs0: SUCCESS (0.041s)
[193.598423] Subtest submit-late-slice: SUCCESS (0.299s)
[194.487610] [028/144] (809s left) gem_reg_read (bad-register)
[194.546275] Starting subtest: bad-register
[194.548238] Subtest bad-register: SUCCESS (0.000s)
[194.619458] [029/144] (809s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[194.688916] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[194.690947] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[194.755909] [030/144] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[194.818978] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[199.657746] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.843s)
[199.786348] [031/144] (804s left) kms_ccs (pipe-c-random-ccs-data-y-tiled-ccs)
[200.219089] Starting subtest: pipe-C-random-ccs-data-y-tiled-ccs
[200.228255] Subtest pipe-C-random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[201.043958] [032/144] (803s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[201.174700] Starting subtest: cursorA-vs-flipA-toggle
[212.350446] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.174s)
[213.225060] [033/144] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[213.327225] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[213.331233] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[213.412707] [034/144] (790s left) prime_vgem (basic-fence-flip)
[213.549182] Starting subtest: basic-fence-flip
[213.829621] Subtest basic-fence-flip: SUCCESS (0.280s)
[213.935747] [035/144] (790s left) i915_pm_rc6_residency (media-rc6-accuracy)
[213.989688] Starting subtest: media-rc6-accuracy
[213.994594] Subtest media-rc6-accuracy: SKIP (0.000s)
[214.066587] [036/144] (790s left) drm_fdinfo (virtual-busy-hang)
[214.138310] Starting subtest: virtual-busy-hang
[214.143874] Subtest virtual-busy-hang: SKIP (0.000s)
[214.194762] [037/144] (790s left) perf_pmu (interrupts)
[214.253412] Starting subtest: interrupts
[215.338359] Subtest interrupts: SUCCESS (1.084s)
[215.440449] [038/144] (788s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[215.531645] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[215.534246] Starting dynamic subtest: pipe-A-eDP-1
[216.071837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[216.087342] Starting dynamic subtest: pipe-B-eDP-1
[217.782184] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.708s)
[217.805694] Starting dynamic subtest: pipe-C-eDP-1
[219.816716] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.030s)
[219.838248] Starting dynamic subtest: pipe-D-eDP-1
[221.529580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.710s)
[221.532049] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (6.002s)
[222.790108] [039/144] (781s left) kms_big_fb (linear-8bpp-rotate-90)
[222.903388] Starting subtest: linear-8bpp-rotate-90
[222.923312] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[223.015918] [040/144] (781s left) vgem_basic (busy-fence)
[223.090680] Starting subtest: busy-fence
[223.092772] Subtest busy-fence: SUCCESS (0.000s)
[223.137383] [041/144] (781s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[223.255863] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[224.258914] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.002s)
[224.379258] [042/144] (779s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[224.485249] Starting subtest: y-tiled-32bpp-rotate-0
[224.489480] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[224.575671] [043/144] (779s left) kms_feature_discovery (display-4x)
[224.643047] Starting subtest: display-4x
[224.646967] Subtest display-4x: SKIP (0.000s)
[224.701309] [044/144] (779s left) gem_ctx_exec (basic)
[224.791497] Starting subtest: basic
[224.801075] Subtest basic: SUCCESS (0.011s)
[224.892056] [045/144] (779s left) gem_mmap_wc (fault-concurrent)
[224.943055] Subtest fault-concurrent: SKIP (0.000s)
[224.984602] [046/144] (779s left) gem_exec_async (forked-writes)
[225.060473] Starting subtest: forked-writes
[225.063086] Starting dynamic subtest: rcs0
[225.101147] Dynamic subtest rcs0: SUCCESS (0.040s)
[225.121553] Starting dynamic subtest: bcs0
[225.140400] Dynamic subtest bcs0: SUCCESS (0.038s)
[225.148599] Starting dynamic subtest: vcs0
[225.177637] Dynamic subtest vcs0: SUCCESS (0.036s)
[225.193768] Starting dynamic subtest: vcs1
[225.214514] Dynamic subtest vcs1: SUCCESS (0.036s)
[225.225791] Starting dynamic subtest: vecs0
[225.240025] Dynamic subtest vecs0: SUCCESS (0.025s)
[225.251328] Starting dynamic subtest: ccs0
[225.266304] Dynamic subtest ccs0: SUCCESS (0.026s)
[225.268519] Subtest forked-writes: SUCCESS (0.206s)
[225.491541] [047/144] (778s left) perf (stress-open-close)
[225.623680] Starting subtest: stress-open-close
[225.626124] Starting dynamic subtest: 0-rcs0
[227.802498] Dynamic subtest 0-rcs0: SUCCESS (2.180s)
[227.820053] Starting dynamic subtest: 1-vcs0
[229.975946] Dynamic subtest 1-vcs0: SUCCESS (2.173s)
[229.978052] Subtest stress-open-close: SUCCESS (4.355s)
[230.001067] [048/144] (774s left) gem_pread (bench)
[230.066123] Subtest bench: SKIP (0.000s)
[230.122999] [049/144] (774s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[230.179822] Starting subtest: etime-single-wait-all-for-submit-submitted
[230.287053] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[230.366804] [050/144] (774s left) drm_fdinfo (all-busy-idle-check-all)
[230.431918] Starting subtest: all-busy-idle-check-all
[230.439399] Subtest all-busy-idle-check-all: SKIP (0.008s)
[230.493457] [051/144] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[230.616357] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[233.655549] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (3.043s)
[233.790990] [052/144] (770s left) kms_vrr (flipline)
[233.873854] Starting subtest: flipline
[233.878588] Subtest flipline: SKIP (0.000s)
[233.931581] [053/144] (770s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[234.040682] Starting subtest: cursorA-vs-flipA-legacy
[245.207159] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.164s)
[246.133527] [054/144] (758s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[246.242684] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[251.081026] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (4.844s)
[251.189527] [055/144] (753s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[251.283364] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[251.286188] Starting dynamic subtest: pipe-A-eDP-1
[251.291369] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[251.308575] Starting dynamic subtest: pipe-B-eDP-1
[251.313790] Dynamic subtest pipe-B-eDP-1: SKIP (0.015s)
[251.328441] Starting dynamic subtest: pipe-C-eDP-1
[251.333606] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s)
[251.345909] Starting dynamic subtest: pipe-D-eDP-1
[251.350885] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s)
[251.355523] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.057s)
[251.425263] [056/144] (753s left) gem_ctx_persistence (userptr)
[251.480196] Starting subtest: userptr
[251.604068] Subtest userptr: SUCCESS (0.124s)
[251.701179] [057/144] (753s left) api_intel_allocator (reopen-fork)
[251.768893] Starting subtest: reopen-fork
[255.162101] Subtest reopen-fork: SUCCESS (3.392s)
[255.239154] [058/144] (749s left) sysfs_heartbeat_interval (precise)
[255.322883] Starting subtest: precise
[255.325473] Starting dynamic subtest: vecs0
[262.449522] Dynamic subtest vecs0: SUCCESS (7.122s)
[262.467102] Starting dynamic subtest: ccs0
[263.609884] Dynamic subtest ccs0: SUCCESS (1.162s)
[263.626375] Starting dynamic subtest: vcs0
[271.467156] Dynamic subtest vcs0: SUCCESS (7.855s)
[271.484306] Starting dynamic subtest: bcs0
[272.677846] Dynamic subtest bcs0: SUCCESS (1.210s)
[272.697133] Starting dynamic subtest: rcs0
[275.002685] Dynamic subtest rcs0: SUCCESS (2.323s)
[275.020545] Starting dynamic subtest: vcs1
[282.413243] Dynamic subtest vcs1: SUCCESS (7.408s)
[282.416125] Subtest precise: SUCCESS (27.089s)
[282.489693] [059/144] (722s left) kms_sequence (queue-idle)
[282.591790] Starting subtest: queue-idle
[282.594618] Starting dynamic subtest: pipe-A-eDP-1
[284.447870] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.856s)
[284.464719] Starting dynamic subtest: pipe-B-eDP-1
[287.033099] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[287.050485] Starting dynamic subtest: pipe-C-eDP-1
[289.622245] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.586s)
[289.639394] Starting dynamic subtest: pipe-D-eDP-1
[292.214493] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[292.217164] Subtest queue-idle: SUCCESS (9.626s)
[293.106240] [060/144] (711s left) gem_exec_reloc (basic-cpu)
[293.174731] Subtest basic-cpu: SKIP (0.000s)
[293.216893] [061/144] (711s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[293.320040] Starting subtest: psr-rgb101010-draw-mmap-cpu
[298.237897] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (4.926s)
[298.347786] [062/144] (706s left) gem_exec_schedule (pi-ringfull)
[298.571350] Starting subtest: pi-ringfull
[298.573654] Starting dynamic subtest: rcs0
[298.665213] Dynamic subtest rcs0: SUCCESS (0.095s)
[298.696667] Starting dynamic subtest: bcs0
[298.754141] Dynamic subtest bcs0: SUCCESS (0.087s)
[298.781076] Starting dynamic subtest: vcs0
[298.842676] Dynamic subtest vcs0: SUCCESS (0.086s)
[298.869890] Starting dynamic subtest: vcs1
[298.930548] Dynamic subtest vcs1: SUCCESS (0.086s)
[298.955466] Starting dynamic subtest: vecs0
[299.015822] Dynamic subtest vecs0: SUCCESS (0.083s)
[299.043053] Starting dynamic subtest: ccs0
[299.103586] Dynamic subtest ccs0: SUCCESS (0.086s)
[299.106688] Subtest pi-ringfull: SUCCESS (0.536s)
[299.329271] [063/144] (705s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[299.439994] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[304.216769] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.781s)
[304.312353] [064/144] (700s left) kms_prop_blob (invalid-set-prop)
[304.386169] Starting subtest: invalid-set-prop
[304.388415] Subtest invalid-set-prop: SUCCESS (0.000s)
[304.468317] [065/144] (700s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[304.555655] Subtest access-purged-bo-mem: SKIP (0.000s)
[304.593126] [066/144] (700s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[304.691909] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[304.696619] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[304.773872] [067/144] (700s left) gem_exec_reloc (basic-cpu-active)
[304.843139] Subtest basic-cpu-active: SKIP (0.000s)
[304.892658] [068/144] (700s left) kms_cursor_crc (cursor-offscreen-max-size)
[305.194505] Starting subtest: cursor-offscreen-max-size
[305.201290] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[305.306279] [069/144] (699s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-ccs)
[305.738701] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-ccs
[305.745244] Subtest pipe-C-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[306.613642] [070/144] (698s left) perf (gen12-group-exclusive-stream-sample-oa)
[306.726251] Starting subtest: gen12-group-exclusive-stream-sample-oa
[306.747053] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[306.779503] [071/144] (698s left) gem_create (create-size-update)
[306.851738] Starting subtest: create-size-update
[306.853859] Subtest create-size-update: SUCCESS (0.000s)
[307.066950] [072/144] (698s left) gem_render_copy (yf-tiled)
[307.131128] Starting subtest: yf-tiled
[307.136053] Subtest yf-tiled: SKIP (0.000s)
[307.318254] [073/144] (697s left) kms_psr (pr-no-drrs)
[307.398810] Starting subtest: pr-no-drrs
[307.404149] Subtest pr-no-drrs: SKIP (0.000s)
[307.503305] [074/144] (697s left) v3d/v3d_submit_csd (multisync-out-syncs)
[307.584133] Subtest multisync-out-syncs: SKIP (0.000s)
[307.631450] [075/144] (697s left) kms_psr (psr-sprite-mmap-cpu)
[307.715948] Starting subtest: psr-sprite-mmap-cpu
[307.718354] Starting dynamic subtest: eDP-1
[309.563752] Dynamic subtest eDP-1: SUCCESS (1.847s)
[309.566500] Subtest psr-sprite-mmap-cpu: SUCCESS (1.849s)
[310.450294] [076/144] (694s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[310.573483] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[315.789638] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.219s)
[315.897290] [077/144] (689s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-mtl-rc-ccs)
[316.327929] Starting subtest: pipe-B-crc-primary-basic-4-tiled-mtl-rc-ccs
[317.393771] Subtest pipe-B-crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (1.060s)
[318.582308] [078/144] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[318.689139] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[318.693802] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[318.770677] [079/144] (686s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[318.852878] Starting subtest: multiplane-rotation-cropping-bottom
[327.044479] Subtest multiplane-rotation-cropping-bottom: SUCCESS (8.193s)
[327.141052] [080/144] (678s left) syncobj_wait (single-wait-signaled)
[327.219252] Starting subtest: single-wait-signaled
[327.221601] Subtest single-wait-signaled: SUCCESS (0.000s)
[327.306057] [081/144] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[327.405921] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[327.409769] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[327.493688] [082/144] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[327.579021] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[327.583046] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[327.656893] [083/144] (677s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[327.755010] Starting subtest: cursor-vs-flip-toggle
[357.201248] Subtest cursor-vs-flip-toggle: SUCCESS (29.443s)
[358.135058] [084/144] (647s left) gem_exec_fence (syncobj-invalid-flags)
[358.626426] Starting subtest: syncobj-invalid-flags
[358.629532] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[360.509350] [085/144] (645s left) i915_query (query-topology-known-pci-ids)
[360.601276] Starting subtest: query-topology-known-pci-ids
[360.606590] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[360.691979] [086/144] (644s left) gem_spin_batch (engines)
[360.776478] Starting subtest: engines
[360.779506] Starting dynamic subtest: rcs0
[364.073192] Dynamic subtest rcs0: SUCCESS (3.237s)
[364.090749] Starting dynamic subtest: bcs0
[367.259487] Dynamic subtest bcs0: SUCCESS (3.238s)
[367.277365] Starting dynamic subtest: vcs0
[370.550727] Dynamic subtest vcs0: SUCCESS (3.237s)
[370.567689] Starting dynamic subtest: vcs1
[373.792415] Dynamic subtest vcs1: SUCCESS (3.240s)
[373.810351] Starting dynamic subtest: vecs0
[376.980742] Dynamic subtest vecs0: SUCCESS (3.238s)
[376.998409] Starting dynamic subtest: ccs0
[380.274232] Dynamic subtest ccs0: SUCCESS (3.239s)
[380.277691] Subtest engines: SUCCESS (19.441s)
[380.442534] [087/144] (625s left) v3d/v3d_perfmon (create-perfmon-0)
[380.558583] Subtest create-perfmon-0: SKIP (0.000s)
[380.606995] [088/144] (625s left) kms_cursor_crc (cursor-offscreen-256x85)
[380.851104] Starting subtest: cursor-offscreen-256x85
[380.881642] Subtest cursor-offscreen-256x85: SKIP (0.025s)
[381.009448] [089/144] (624s left) gem_busy (semaphore)
[381.239131] Subtest semaphore: SKIP (0.000s)
[381.455461] [090/144] (624s left) syncobj_timeline (multi-wait-all-signaled)
[381.526353] Starting subtest: multi-wait-all-signaled
[381.528919] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[381.602688] [091/144] (624s left) perf (create-destroy-userspace-config)
[381.672870] Starting subtest: create-destroy-userspace-config
[381.693333] Subtest create-destroy-userspace-config: SUCCESS (0.024s)
[381.710014] [092/144] (624s left) gem_exec_capture (userptr)
[381.793247] Starting subtest: userptr
[382.640449] Subtest userptr: SUCCESS (0.848s)
[382.728225] [093/144] (623s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[382.845289] Starting subtest: basic-flip-after-cursor-atomic
[383.789299] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.942s)
[384.694244] [094/144] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[384.793115] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[384.797838] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[384.876955] [095/144] (620s left) prime_self_import (basic-with_one_bo_two_files)
[384.945166] Starting subtest: basic-with_one_bo_two_files
[384.961700] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[385.053653] [096/144] (620s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[385.462338] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[386.325405] [097/144] (619s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[386.395919] Starting subtest: 4-tiled-16bpp-rotate-180
[387.707835] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.314s)
[387.845954] [098/144] (618s left) gem_exec_reloc (basic-active)
[387.929365] Subtest basic-active: SKIP (0.000s)
[387.972927] [099/144] (617s left) prime_busy (before-wait)
[388.042178] Starting subtest: before-wait
[388.047616] Starting dynamic subtest: rcs0
[388.069442] Dynamic subtest rcs0: SUCCESS (0.024s)
[388.086325] Starting dynamic subtest: bcs0
[388.111771] Dynamic subtest bcs0: SUCCESS (0.042s)
[388.128912] Starting dynamic subtest: vcs0
[388.157435] Dynamic subtest vcs0: SUCCESS (0.044s)
[388.169914] Starting dynamic subtest: vcs1
[388.201050] Dynamic subtest vcs1: SUCCESS (0.042s)
[388.212931] Starting dynamic subtest: vecs0
[388.245781] Dynamic subtest vecs0: SUCCESS (0.043s)
[388.257901] Starting dynamic subtest: ccs0
[388.290414] Dynamic subtest ccs0: SUCCESS (0.043s)
[388.403983] Subtest before-wait: SUCCESS (0.360s)
[388.471832] [100/144] (617s left) kms_async_flips (crc)
[388.592954] Starting subtest: crc
[388.990440] Starting dynamic subtest: pipe-A-eDP-1
[391.880683] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.888s)
[392.275385] Starting dynamic subtest: pipe-B-eDP-1
[395.196405] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.938s)
[395.575633] Starting dynamic subtest: pipe-C-eDP-1
[398.480849] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.916s)
[398.844990] Starting dynamic subtest: pipe-D-eDP-1
[401.754805] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.921s)
[401.757427] Subtest crc: SUCCESS (13.162s)
[403.012897] [101/144] (602s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[403.094375] Starting subtest: fbc-pr-sprite-mmap-cpu
[403.099021] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[403.196214] [102/144] (602s left) v3d/v3d_wait_bo (used-bo-0ns)
[403.301441] Subtest used-bo-0ns: SKIP (0.000s)
[403.354600] [103/144] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[403.457759] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[407.923826] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.472s)
[408.049838] [104/144] (598s left) gem_mmap_gtt (cpuset-medium-copy)
[408.138605] Subtest cpuset-medium-copy: SKIP (0.000s)
[408.192826] [105/144] (597s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-ccs)
[408.581098] Starting subtest: pipe-A-bad-rotation-90-y-tiled-ccs
[408.586690] Subtest pipe-A-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[409.458999] [106/144] (596s left) perf_pmu (invalid-init)
[409.505909] Starting subtest: invalid-init
[409.508458] Subtest invalid-init: SUCCESS (0.000s)
[409.605861] [107/144] (596s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[409.667911] Starting subtest: primary-yf-tiled-reflect-x-180
[409.729352] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[409.842593] [108/144] (596s left) gem_fence_thrash (bo-write-verify-y)
[409.898033] Starting subtest: bo-write-verify-y
[409.912672] Subtest bo-write-verify-y: SKIP (0.014s)
[409.968996] [109/144] (596s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[410.053561] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[410.057508] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[410.143752] [110/144] (596s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf-tiled-ccs)
[410.546072] Starting subtest: pipe-A-crc-sprite-planes-basic-yf-tiled-ccs
[410.551320] Subtest pipe-A-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.001s)
[411.444914] [111/144] (594s left) gem_tiled_partial_pwrite_pread (reads)
[411.521934] Subtest reads: SKIP (0.000s)
[411.576175] [112/144] (594s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[411.670148] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[412.783748] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.951s)
[412.811458] [113/144] (593s left) kms_getfb (getfb-handle-not-fb)
[412.886360] Starting subtest: getfb-handle-not-fb
[412.918345] Subtest getfb-handle-not-fb: SUCCESS (0.031s)
[412.994812] [114/144] (593s left) kms_addfb_basic (unused-offsets)
[413.077963] Starting subtest: unused-offsets
[413.080282] Subtest unused-offsets: SUCCESS (0.000s)
[413.176326] [115/144] (593s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[413.637488] Starting subtest: pipe-D-missing-ccs-buffer-4-tiled-mtl-mc-ccs
[413.671221] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.034s)
[414.444795] [116/144] (592s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[414.536498] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[414.541770] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[414.617350] [117/144] (591s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[415.040660] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[415.043561] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[415.924626] [118/144] (590s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[416.035776] Starting subtest: basic-busy-flip-before-cursor-varying-size
[416.040636] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[416.126650] [119/144] (590s left) gem_ctx_param (invalid-get-no-zeromap)
[416.186937] Starting subtest: invalid-get-no-zeromap
[416.189432] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[416.266040] [120/144] (590s left) kms_flip (busy-flip)
[416.332835] Starting subtest: busy-flip
[416.335394] Starting dynamic subtest: A-eDP1
[418.151474] Dynamic subtest A-eDP1: SUCCESS (1.825s)
[418.170273] Starting dynamic subtest: B-eDP1
[419.940848] Dynamic subtest B-eDP1: SUCCESS (1.787s)
[419.957692] Starting dynamic subtest: C-eDP1
[421.724869] Dynamic subtest C-eDP1: SUCCESS (1.782s)
[421.740781] Starting dynamic subtest: D-eDP1
[423.511146] Dynamic subtest D-eDP1: SUCCESS (1.786s)
[423.519848] Subtest busy-flip: SUCCESS (7.196s)
[424.836524] [121/144] (581s left) kms_chamelium_hpd (common-hpd-after-suspend)
[425.222747] Subtest common-hpd-after-suspend: SKIP (0.000s)
[426.071508] [122/144] (580s left) gen9_exec_parse (bb-start-param)
[426.168091] Subtest bb-start-param: SKIP (0.000s)
[426.223801] [123/144] (580s left) kms_lease (lease-get)
[426.339342] Starting subtest: lease-get
[426.341839] Starting dynamic subtest: pipe-A-eDP-1
[426.343870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[426.360043] Starting dynamic subtest: pipe-B-eDP-1
[426.361993] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[426.370282] Starting dynamic subtest: pipe-C-eDP-1
[426.372222] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[426.379184] Starting dynamic subtest: pipe-D-eDP-1
[426.381110] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[426.383070] Subtest lease-get: SUCCESS (0.016s)
[426.463172] [124/144] (580s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[426.558834] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[426.563789] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[427.762447] [125/144] (578s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[427.855746] Starting subtest: psr-2p-pri-indfb-multidraw
[427.860450] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[427.939423] [126/144] (578s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[428.026487] Starting subtest: yf-tiled-64bpp-rotate-180
[428.031316] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[428.114628] [127/144] (578s left) i915_module_load (resize-bar)
[428.171031] Starting subtest: resize-bar
[428.178733] Subtest resize-bar: SKIP (0.005s)
[428.218246] [128/144] (578s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[428.308209] Starting subtest: flip-vs-dpms-off-vs-modeset
[428.310720] Starting dynamic subtest: A-eDP1
[432.199426] Dynamic subtest A-eDP1: SUCCESS (3.886s)
[432.217794] Starting dynamic subtest: B-eDP1
[435.775545] Dynamic subtest B-eDP1: SUCCESS (3.574s)
[435.793309] Starting dynamic subtest: C-eDP1
[439.209417] Dynamic subtest C-eDP1: SUCCESS (3.432s)
[439.224724] Starting dynamic subtest: D-eDP1
[442.674180] Dynamic subtest D-eDP1: SUCCESS (3.464s)
[442.679851] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (14.375s)
[443.557959] [129/144] (563s left) i915_suspend (fence-restore-untiled)
[443.621586] Starting subtest: fence-restore-untiled
[443.626066] Subtest fence-restore-untiled: SKIP (0.000s)
[443.688248] [130/144] (563s left) gem_set_tiling_vs_pwrite
[443.778119] [131/144] (563s left) kms_psr (fbc-psr-primary-page-flip)
[443.879017] Starting subtest: fbc-psr-primary-page-flip
[443.881542] Starting dynamic subtest: eDP-1
[443.886424] Dynamic subtest eDP-1: SKIP (0.000s)
[443.891044] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[443.985793] [132/144] (562s left) gem_eio (hibernate)
[444.224571] Starting subtest: hibernate
[463.596644] Subtest hibernate: SUCCESS (19.372s)
[468.719281] [133/144] (543s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[468.838834] Starting subtest: yf-tiled-to-vebox-y-tiled
[468.844143] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[469.032952] [134/144] (542s left) gem_exec_balancer (individual)
[469.093632] Starting subtest: individual
[470.425956] Subtest individual: SUCCESS (1.331s)
[470.720266] [135/144] (541s left) gem_exec_whisper (basic-fds-forked-all)
[470.768857] Starting subtest: basic-fds-forked-all
[513.622730] Subtest basic-fds-forked-all: SUCCESS (42.852s)
[513.808708] [136/144] (498s left) kms_color (ctm-red-to-blue)
[513.899722] Starting subtest: ctm-red-to-blue
[513.901976] Starting dynamic subtest: pipe-A
[514.702038] Dynamic subtest pipe-A: SUCCESS (0.803s)
[514.723327] Starting dynamic subtest: pipe-B
[516.240890] Dynamic subtest pipe-B: SUCCESS (1.532s)
[516.262923] Starting dynamic subtest: pipe-C
[517.740599] Dynamic subtest pipe-C: SUCCESS (1.502s)
[517.753472] Starting dynamic subtest: pipe-D
[519.199535] Dynamic subtest pipe-D: SUCCESS (1.460s)
[519.202322] Subtest ctm-red-to-blue: SUCCESS (5.301s)
[520.118940] [137/144] (491s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-mtl-mc-ccs)
[520.501641] Starting subtest: pipe-A-crc-primary-basic-4-tiled-mtl-mc-ccs
[523.046380] Subtest pipe-A-crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (2.546s)
[524.283203] [138/144] (487s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[524.410659] Starting subtest: cursorA-vs-flipB-toggle
[524.415387] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[524.507144] [139/144] (487s left) kms_ccs (pipe-d-ccs-on-another-bo-yf-tiled-ccs)
[524.945104] Starting subtest: pipe-D-ccs-on-another-bo-yf-tiled-ccs
[524.950935] Subtest pipe-D-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[525.818162] [140/144] (486s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[526.024072] Starting subtest: cursor-rapid-movement-128x42
[526.078281] Subtest cursor-rapid-movement-128x42: SKIP (0.048s)
[526.283116] [141/144] (485s left) gem_exec_reloc (basic-write-cpu-noreloc)
[526.357813] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[526.404673] [142/144] (485s left) gem_exec_fair (basic-pace-share)
[526.511040] Subtest basic-pace-share: SKIP (0.000s)
[526.568061] [143/144] (485s left) gem_lmem_swapping (heavy-multi)
[526.640192] Subtest heavy-multi: SKIP (0.000s)
[526.683349] [144/144] (485s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[526.801499] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[529.552551] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.754s)
[529.676320] Closing watchdogs
Done.