[59.801660] Initializing watchdogs
[59.801705]   /dev/watchdog0
[59.816607] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.821458] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.824456] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.826427] [001/131] (960s left) kms_psr (psr2-sprite-mmap-cpu)
[59.923345] Starting subtest: psr2-sprite-mmap-cpu
[59.924427] Starting dynamic subtest: eDP-1
[61.629135] Dynamic subtest eDP-1: SUCCESS (1.705s)
[61.630120] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.706s)
[62.488586] [002/131] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[62.597064] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[62.598819] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[62.683036] [003/131] (957s left) kms_atomic_interruptible (universal-setplane-primary)
[62.776334] Starting subtest: universal-setplane-primary
[62.777294] Starting dynamic subtest: pipe-A-eDP-1
[70.220063] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.443s)
[70.221062] Subtest universal-setplane-primary: SUCCESS (7.444s)
[71.049041] [004/131] (949s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[71.092189] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[71.201081] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[71.279663] [005/131] (949s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[71.329261] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[71.381631] [006/131] (949s left) kms_busy (extended-pageflip-hang-oldfb)
[71.479888] Starting subtest: extended-pageflip-hang-oldfb
[71.480715] Starting dynamic subtest: pipe-A
[71.909055] Dynamic subtest pipe-A: SUCCESS (0.428s)
[71.917539] Starting dynamic subtest: pipe-D
[73.061371] Dynamic subtest pipe-D: SUCCESS (1.150s)
[73.063391] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.583s)
[73.903552] [007/131] (946s left) gem_render_linear_blits (basic)
[73.965862] Starting subtest: basic
[73.989599] Subtest basic: SUCCESS (0.025s)
[74.071847] [008/131] (946s left) syncobj_timeline (multi-wait-available-submitted)
[74.133724] Starting subtest: multi-wait-available-submitted
[74.135199] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[74.238855] [009/131] (946s left) kms_flip (flip-vs-expired-vblank-interruptible)
[74.336385] Starting subtest: flip-vs-expired-vblank-interruptible
[74.338472] Starting dynamic subtest: A-eDP1
[83.038317] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[83.047738] Starting dynamic subtest: B-eDP1
[91.673789] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[91.685217] Starting dynamic subtest: C-eDP1
[100.297441] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[100.306552] Starting dynamic subtest: D-eDP1
[108.930966] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[108.931907] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.562s)
[110.069143] [010/131] (910s left) kms_psr (fbc-psr-primary-page-flip)
[110.155296] Starting subtest: fbc-psr-primary-page-flip
[110.156159] Starting dynamic subtest: eDP-1
[110.158118] Dynamic subtest eDP-1: SKIP (0.000s)
[110.159626] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[110.227594] [011/131] (910s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[110.310583] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[110.312094] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[110.395821] [012/131] (910s left) gem_ctx_shared (q-in-order)
[110.443620] Starting subtest: Q-in-order
[110.444572] Starting dynamic subtest: rcs0
[110.565606] Dynamic subtest rcs0: SUCCESS (0.122s)
[110.580876] Starting dynamic subtest: vcs0
[110.643844] Dynamic subtest vcs0: SUCCESS (0.078s)
[110.657162] Starting dynamic subtest: vcs1
[110.720589] Dynamic subtest vcs1: SUCCESS (0.076s)
[110.734611] Starting dynamic subtest: vecs0
[110.799484] Dynamic subtest vecs0: SUCCESS (0.079s)
[110.813797] Starting dynamic subtest: ccs0
[110.879226] Dynamic subtest ccs0: SUCCESS (0.079s)
[110.880662] Subtest Q-in-order: SUCCESS (0.435s)
[111.960956] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[111.962783] [013/131] (908s left) kms_atomic_transition (modeset-transition)
[112.046033] Starting subtest: modeset-transition
[112.046880] Starting dynamic subtest: 1x-outputs
[122.837521] Dynamic subtest 1x-outputs: SUCCESS (10.791s)
[122.839372] Subtest modeset-transition: SUCCESS (10.792s)
[123.710702] [014/131] (897s left) kms_sequence (queue-idle)
[123.801416] Starting subtest: queue-idle
[123.802400] Starting dynamic subtest: pipe-A-eDP-1
[125.604704] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[125.612214] Starting dynamic subtest: pipe-B-eDP-1
[128.081498] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.475s)
[128.088836] Starting dynamic subtest: pipe-C-eDP-1
[130.590906] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.508s)
[130.598232] Starting dynamic subtest: pipe-D-eDP-1
[133.001296] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.410s)
[133.002232] Subtest queue-idle: SUCCESS (9.200s)
[133.812532] [015/131] (886s left) syncobj_timeline (wait-any-complex)
[133.874479] Starting subtest: wait-any-complex
[133.937928] Subtest wait-any-complex: SUCCESS (0.062s)
[134.011625] [016/131] (886s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[134.102213] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[134.103202] Starting dynamic subtest: pipe-A
[134.122452] Dynamic subtest pipe-A: SKIP (0.018s)
[134.128931] Starting dynamic subtest: pipe-B
[134.154679] Dynamic subtest pipe-B: SKIP (0.032s)
[134.161426] Starting dynamic subtest: pipe-C
[134.187230] Dynamic subtest pipe-C: SKIP (0.032s)
[134.193443] Starting dynamic subtest: pipe-D
[134.220092] Dynamic subtest pipe-D: SKIP (0.032s)
[134.221664] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.116s)
[134.326998] [017/131] (886s left) kms_addfb_basic (bad-pitch-0)
[134.380909] Starting subtest: bad-pitch-0
[134.381838] Subtest bad-pitch-0: SUCCESS (0.000s)
[134.514612] [018/131] (886s left) gem_exec_whisper (basic-queues)
[134.574763] Starting subtest: basic-queues
[139.940215] Subtest basic-queues: SUCCESS (5.358s)
[140.127134] [019/131] (880s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[140.243164] Starting subtest: y-tiled-8bpp-rotate-0
[140.245051] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[140.337582] [020/131] (880s left) kms_chamelium_frames (hdmi-frame-dump)
[140.707409] Subtest hdmi-frame-dump: SKIP (0.000s)
[141.512875] [021/131] (879s left) kms_lease (cursor-implicit-plane)
[141.608383] Starting subtest: cursor-implicit-plane
[141.609489] Starting dynamic subtest: pipe-A-eDP-1
[142.086195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[142.094712] Starting dynamic subtest: pipe-B-eDP-1
[143.176968] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s)
[143.186319] Starting dynamic subtest: pipe-C-eDP-1
[144.283104] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[144.293632] Starting dynamic subtest: pipe-D-eDP-1
[145.412977] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[145.413870] Subtest cursor-implicit-plane: SUCCESS (3.804s)
[146.272751] [022/131] (874s left) i915_drm_fdinfo (all-busy-check-all)
[146.309957] Starting subtest: all-busy-check-all
[146.313494] Subtest all-busy-check-all: SKIP (0.003s)
[146.373598] [023/131] (874s left) gem_exec_reloc (basic-wc-read-active)
[146.466414] Subtest basic-wc-read-active: SKIP (0.000s)
[146.532220] [024/131] (874s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[146.646365] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[146.649110] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[146.787817] [025/131] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[146.873528] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[146.875332] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[146.965016] [026/131] (874s left) kms_vrr (flip-basic)
[147.053215] Starting subtest: flip-basic
[147.055899] Subtest flip-basic: SKIP (0.000s)
[147.122040] [027/131] (874s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[147.217676] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[151.718500] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.500s)
[152.883317] [028/131] (868s left) i915_pm_rps (waitboost)
[152.947032] Starting subtest: waitboost
[159.290596] Subtest waitboost: SUCCESS (6.332s)
[159.353464] [029/131] (861s left) i915_hangman (gt-engine-error)
[159.414369] Starting subtest: gt-engine-error
[159.415353] Starting dynamic subtest: rcs0
[160.892504] Dynamic subtest rcs0: SUCCESS (1.468s)
[160.904660] Starting dynamic subtest: bcs0
[162.874483] Dynamic subtest bcs0: SUCCESS (1.980s)
[162.884759] Starting dynamic subtest: vcs0
[164.859487] Dynamic subtest vcs0: SUCCESS (1.983s)
[164.869345] Starting dynamic subtest: vcs1
[166.907700] Dynamic subtest vcs1: SUCCESS (2.048s)
[166.921805] Starting dynamic subtest: vecs0
[168.827927] Dynamic subtest vecs0: SUCCESS (1.918s)
[168.840359] Starting dynamic subtest: ccs0
[170.875701] Dynamic subtest ccs0: SUCCESS (2.047s)
[170.876912] Subtest gt-engine-error: SUCCESS (11.453s)
[170.986830] [030/131] (850s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[171.102898] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[175.141752] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.040s)
[176.285014] [031/131] (845s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[176.366285] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[176.367134] Starting dynamic subtest: pipe-A-eDP-1
[176.375144] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[176.382493] Starting dynamic subtest: pipe-B-eDP-1
[176.390434] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[176.396887] Starting dynamic subtest: pipe-C-eDP-1
[176.404518] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[176.411018] Starting dynamic subtest: pipe-D-eDP-1
[176.420386] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[176.422106] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[178.652639] [032/131] (842s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[178.719360] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[178.799694] [033/131] (842s left) gem_exec_fence (submit)
[178.974768] Starting subtest: submit
[178.977307] Subtest submit: SKIP (0.000s)
[180.936654] [034/131] (840s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[180.984346] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[180.985494] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[181.081137] [035/131] (840s left) perf_pmu (busy-idle-check-all)
[181.117792] Starting subtest: busy-idle-check-all
[181.118770] Starting dynamic subtest: rcs0
[181.780573] Dynamic subtest rcs0: SUCCESS (0.663s)
[181.790716] Starting dynamic subtest: bcs0
[182.438337] Dynamic subtest bcs0: SUCCESS (0.656s)
[182.448567] Starting dynamic subtest: vcs0
[183.901283] Dynamic subtest vcs0: SUCCESS (1.453s)
[183.910805] Starting dynamic subtest: vcs1
[185.885916] Dynamic subtest vcs1: SUCCESS (1.983s)
[185.897049] Starting dynamic subtest: vecs0
[187.932815] Dynamic subtest vecs0: SUCCESS (2.046s)
[187.941842] Starting dynamic subtest: ccs0
[188.581095] Dynamic subtest ccs0: SUCCESS (0.656s)
[188.582508] Subtest busy-idle-check-all: SUCCESS (7.465s)
[188.680072] [036/131] (832s left) gem_pxp (create-regular-context-1)
[188.798743] Starting subtest: create-regular-context-1
[188.801544] Subtest create-regular-context-1: SUCCESS (0.003s)
[188.914213] [037/131] (832s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[188.962995] Starting subtest: multi-wait-all-for-submit-signaled
[188.964258] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[189.051511] [038/131] (832s left) device_reset (unbind-cold-reset-rebind)
[189.121911] Starting subtest: unbind-cold-reset-rebind
[189.124360] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[189.187222] [039/131] (832s left) kms_frontbuffer_tracking (fbc-suspend)
[189.282826] Starting subtest: fbc-suspend
[227.862924] Subtest fbc-suspend: SUCCESS (8.350s)
[232.102505] [040/131] (792s left) gem_mmap_gtt (basic-write-gtt)
[232.169941] Subtest basic-write-gtt: SKIP (0.000s)
[232.229890] [041/131] (792s left) gem_ctx_isolation (dirty-switch)
[232.293186] Starting subtest: dirty-switch
[232.294243] Starting dynamic subtest: rcs0
[232.540127] Dynamic subtest rcs0: SUCCESS (0.247s)
[232.550927] Starting dynamic subtest: bcs0
[232.813211] Dynamic subtest bcs0: SUCCESS (0.272s)
[232.827104] Starting dynamic subtest: vcs0
[233.075389] Dynamic subtest vcs0: SUCCESS (0.261s)
[233.085171] Starting dynamic subtest: vcs1
[234.384808] Dynamic subtest vcs1: SUCCESS (1.307s)
[234.395216] Starting dynamic subtest: vecs0
[236.341677] Dynamic subtest vecs0: SUCCESS (1.955s)
[236.352112] Starting dynamic subtest: ccs0
[238.351309] Dynamic subtest ccs0: SUCCESS (2.008s)
[238.352350] Subtest dirty-switch: SUCCESS (6.053s)
[238.592498] [042/131] (786s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[238.684570] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[238.686529] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[238.751904] [043/131] (786s left) kms_draw_crc (draw-method-pwrite)
[238.831882] Starting subtest: draw-method-pwrite
[238.832831] Starting dynamic subtest: xrgb8888-untiled
[239.398452] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s)
[239.407127] Starting dynamic subtest: rgb565-untiled
[239.881145] Dynamic subtest rgb565-untiled: SUCCESS (0.477s)
[239.891075] Starting dynamic subtest: xrgb2101010-untiled
[240.443426] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.565s)
[240.451929] Starting dynamic subtest: xbgr16161616f-untiled
[241.243806] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s)
[241.252892] Starting dynamic subtest: xrgb8888-xtiled
[243.111182] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.865s)
[243.120269] Starting dynamic subtest: rgb565-xtiled
[244.267203] Dynamic subtest rgb565-xtiled: SUCCESS (1.154s)
[244.277298] Starting dynamic subtest: xrgb2101010-xtiled
[246.168113] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.900s)
[246.178875] Starting dynamic subtest: xbgr16161616f-xtiled
[249.635557] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.465s)
[249.646653] Starting dynamic subtest: xrgb8888-4tiled
[250.791187] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.155s)
[250.800597] Starting dynamic subtest: rgb565-4tiled
[251.380422] Dynamic subtest rgb565-4tiled: SUCCESS (0.587s)
[251.389818] Starting dynamic subtest: xrgb2101010-4tiled
[252.547132] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.165s)
[252.555122] Starting dynamic subtest: xbgr16161616f-4tiled
[255.714464] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.166s)
[255.715387] Subtest draw-method-pwrite: SUCCESS (16.878s)
[255.803042] [044/131] (769s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[256.174406] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[256.978615] [045/131] (767s left) gem_pxp (regular-baseline-src-copy-readible)
[257.081937] Starting subtest: regular-baseline-src-copy-readible
[257.142686] Subtest regular-baseline-src-copy-readible: SUCCESS (0.062s)
[257.248694] [046/131] (767s left) kms_plane_scaling (2x-scaler-multi-pipe)
[257.348711] Starting subtest: 2x-scaler-multi-pipe
[257.350350] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[257.429936] [047/131] (767s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[257.516298] Starting subtest: 2x-plain-flip-ts-check-interruptible
[257.528100] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[257.615590] [048/131] (767s left) kms_flip (2x-modeset-vs-vblank-race)
[257.708766] Starting subtest: 2x-modeset-vs-vblank-race
[257.712495] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[257.801026] [049/131] (767s left) gem_wait (write-busy)
[257.854194] Starting subtest: write-busy
[257.855354] Starting dynamic subtest: all-engines
[258.435644] Dynamic subtest all-engines: SUCCESS (0.581s)
[258.450559] Starting dynamic subtest: rcs0
[258.984845] Dynamic subtest rcs0: SUCCESS (0.548s)
[258.999416] Starting dynamic subtest: bcs0
[259.542063] Dynamic subtest bcs0: SUCCESS (0.556s)
[259.558777] Starting dynamic subtest: vcs0
[261.175257] Dynamic subtest vcs0: SUCCESS (1.619s)
[261.183268] Starting dynamic subtest: vcs1
[263.158988] Dynamic subtest vcs1: SUCCESS (1.981s)
[263.166919] Starting dynamic subtest: vecs0
[265.143941] Dynamic subtest vecs0: SUCCESS (1.983s)
[265.151807] Starting dynamic subtest: ccs0
[265.682381] Dynamic subtest ccs0: SUCCESS (0.549s)
[265.683927] Subtest write-busy: SUCCESS (7.828s)
[265.867750] [050/131] (759s left) i915_pm_rc6_residency (rc6-accuracy)
[265.915455] Starting subtest: rc6-accuracy
[265.916424] Starting dynamic subtest: gt0
[269.132808] Dynamic subtest gt0: SUCCESS (3.169s)
[269.143645] Starting dynamic subtest: gt1
[272.304079] Dynamic subtest gt1: SUCCESS (3.169s)
[272.305215] Subtest rc6-accuracy: SUCCESS (6.343s)
[272.335981] [051/131] (752s left) gem_lmem_swapping (heavy-multi)
[272.373805] Subtest heavy-multi: SKIP (0.000s)
[272.418426] [052/131] (752s left) kms_psr (fbc-pr-cursor-plane-onoff)
[272.515354] Starting subtest: fbc-pr-cursor-plane-onoff
[272.517183] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[272.609781] [053/131] (752s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[272.693849] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[272.694715] Starting dynamic subtest: pipe-A-eDP-1
[272.702331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[272.710401] Starting dynamic subtest: pipe-B-eDP-1
[272.718338] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[272.726070] Starting dynamic subtest: pipe-C-eDP-1
[272.733325] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[272.740686] Starting dynamic subtest: pipe-D-eDP-1
[272.747664] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[272.748401] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[274.853785] [054/131] (750s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[274.941829] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[274.942831] Starting dynamic subtest: pipe-A-eDP-1
[274.951106] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[274.959454] Starting dynamic subtest: pipe-B-eDP-1
[274.970958] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[274.979220] Starting dynamic subtest: pipe-C-eDP-1
[274.987631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[274.995302] Starting dynamic subtest: pipe-D-eDP-1
[275.003579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[275.005126] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[277.221604] [055/131] (748s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[277.302821] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[277.303756] Starting dynamic subtest: pipe-A-default-mode
[280.091095] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s)
[280.092215] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.788s)
[280.928785] [056/131] (744s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[281.021744] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[281.022706] Starting dynamic subtest: pipe-A-eDP-1
[281.031999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.040305] Starting dynamic subtest: pipe-B-eDP-1
[281.049606] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.057452] Starting dynamic subtest: pipe-C-eDP-1
[281.066288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.074151] Starting dynamic subtest: pipe-D-eDP-1
[281.083554] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.085137] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[283.287509] [057/131] (742s left) gem_exec_schedule (implicit-write-read)
[283.358676] Starting subtest: implicit-write-read
[283.359544] Starting dynamic subtest: rcs0
[283.469888] Dynamic subtest rcs0: SUCCESS (0.111s)
[283.479782] Starting dynamic subtest: vcs0
[283.549997] Dynamic subtest vcs0: SUCCESS (0.080s)
[283.561119] Starting dynamic subtest: vcs1
[283.628492] Dynamic subtest vcs1: SUCCESS (0.077s)
[283.640457] Starting dynamic subtest: vecs0
[283.709685] Dynamic subtest vecs0: SUCCESS (0.080s)
[283.721705] Starting dynamic subtest: ccs0
[283.802296] Dynamic subtest ccs0: SUCCESS (0.092s)
[283.803753] Subtest implicit-write-read: SUCCESS (0.445s)
[285.248614] [058/131] (740s left) kms_flip (flip-vs-rmfb-interruptible)
[285.335505] Starting subtest: flip-vs-rmfb-interruptible
[285.337824] Starting dynamic subtest: A-eDP1
[293.984126] Dynamic subtest A-eDP1: SUCCESS (8.646s)
[293.993658] Starting dynamic subtest: B-eDP1
[302.613067] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[302.623258] Starting dynamic subtest: C-eDP1
[311.226749] Dynamic subtest C-eDP1: SUCCESS (8.611s)
[311.237385] Starting dynamic subtest: D-eDP1
[319.859774] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[319.864373] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.526s)
[321.044347] [059/131] (704s left) kms_plane_multiple (tiling-x)
[321.134585] Starting subtest: tiling-x
[321.135408] Starting dynamic subtest: pipe-A-eDP-1
[324.887318] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.752s)
[324.895306] Starting dynamic subtest: pipe-B-eDP-1
[329.390838] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.502s)
[329.398625] Starting dynamic subtest: pipe-C-eDP-1
[333.722293] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.330s)
[333.730061] Starting dynamic subtest: pipe-D-eDP-1
[338.094336] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.372s)
[338.095216] Subtest tiling-x: SUCCESS (16.960s)
[338.904171] [060/131] (686s left) gem_userptr_blits (sync-unmap)
[338.966090] Starting subtest: sync-unmap
[338.979816] Subtest sync-unmap: SUCCESS (0.013s)
[339.086602] [061/131] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[339.189790] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[339.191388] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[339.278380] [062/131] (686s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[339.363170] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[339.364075] Starting dynamic subtest: pipe-A-eDP-1
[339.373589] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[339.383900] Starting dynamic subtest: pipe-B-eDP-1
[339.393582] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[339.401396] Starting dynamic subtest: pipe-C-eDP-1
[339.410679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[339.417957] Starting dynamic subtest: pipe-D-eDP-1
[339.427249] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[339.428805] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[341.650558] [063/131] (683s left) gem_mmap_wc (write-cpu-read-wc)
[341.694298] Subtest write-cpu-read-wc: SKIP (0.000s)
[341.748407] [064/131] (683s left) sriov_basic (enable-vfs-autoprobe-off)
[341.803421] Starting subtest: enable-vfs-autoprobe-off
[341.804278] Starting dynamic subtest: numvfs-1
[341.831537] Dynamic subtest numvfs-1: FAIL (0.008s)
[341.841670] Starting dynamic subtest: numvfs-2
[341.877717] Dynamic subtest numvfs-2: FAIL (0.004s)
[341.885314] Starting dynamic subtest: numvfs-3
[341.911181] Dynamic subtest numvfs-3: FAIL (0.004s)
[341.918331] Starting dynamic subtest: numvfs-4
[341.943758] Dynamic subtest numvfs-4: FAIL (0.004s)
[341.951452] Starting dynamic subtest: numvfs-5
[341.976457] Dynamic subtest numvfs-5: FAIL (0.004s)
[341.983847] Starting dynamic subtest: numvfs-6
[342.009286] Dynamic subtest numvfs-6: FAIL (0.005s)
[342.016355] Starting dynamic subtest: numvfs-7
[342.041737] Dynamic subtest numvfs-7: FAIL (0.005s)
[342.048755] Starting dynamic subtest: numvfs-random
[342.073454] Dynamic subtest numvfs-random: FAIL (0.003s)
[342.080579] Starting dynamic subtest: numvfs-all
[342.105906] Dynamic subtest numvfs-all: FAIL (0.004s)
[342.106652] Subtest enable-vfs-autoprobe-off: FAIL (0.048s)
[342.136617] [065/131] (683s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[342.236537] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[342.246424] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[342.325701] [066/131] (683s left) kms_color (invalid-degamma-lut-sizes)
[342.417948] Starting subtest: invalid-degamma-lut-sizes
[342.418778] Starting dynamic subtest: pipe-A
[342.716735] Dynamic subtest pipe-A: SUCCESS (0.300s)
[342.724451] Starting dynamic subtest: pipe-B
[342.725294] Dynamic subtest pipe-B: SUCCESS (0.000s)
[342.732847] Starting dynamic subtest: pipe-C
[342.733810] Dynamic subtest pipe-C: SUCCESS (0.000s)
[342.741157] Starting dynamic subtest: pipe-D
[342.742062] Dynamic subtest pipe-D: SUCCESS (0.000s)
[342.742828] Subtest invalid-degamma-lut-sizes: SUCCESS (0.303s)
[343.593414] [067/131] (682s left) kms_psr (pr-cursor-blt)
[343.682088] Starting subtest: pr-cursor-blt
[343.683725] Subtest pr-cursor-blt: SKIP (0.000s)
[343.752899] [068/131] (681s left) kms_hdr (static-toggle-suspend)
[343.842794] Starting subtest: static-toggle-suspend
[343.845066] Subtest static-toggle-suspend: SKIP (0.000s)
[343.909519] [069/131] (681s left) syncobj_timeline (invalid-signal-illegal-handle)
[343.949960] Starting subtest: invalid-signal-illegal-handle
[343.950834] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[344.034812] [070/131] (681s left) kms_cursor_crc (cursor-suspend)
[344.157121] Starting subtest: cursor-suspend
[344.160549] Starting dynamic subtest: pipe-A-eDP-1
[378.892005] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.998s)
[378.899726] Starting dynamic subtest: pipe-D-eDP-1
[413.862643] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.610s)
[413.863809] Subtest cursor-suspend: SUCCESS (8.613s)
[419.741631] [071/131] (611s left) kms_big_fb (linear-addfb)
[419.852917] Starting subtest: linear-addfb
[419.853699] Subtest linear-addfb: SUCCESS (0.000s)
[419.947893] [072/131] (610s left) syncobj_eventfd (timeline-wait-before-signal)
[419.992910] Starting subtest: timeline-wait-before-signal
[420.023458] Subtest timeline-wait-before-signal: SUCCESS (0.030s)
[420.093801] [073/131] (610s left) kms_cursor_crc (cursor-onscreen-512x170)
[420.377812] Starting subtest: cursor-onscreen-512x170
[420.379538] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[420.511329] [074/131] (610s left) gem_spin_batch (engines)
[420.559472] Starting subtest: engines
[420.560775] Starting dynamic subtest: rcs0
[423.808505] Dynamic subtest rcs0: SUCCESS (3.235s)
[423.818650] Starting dynamic subtest: bcs0
[427.085064] Dynamic subtest bcs0: SUCCESS (3.234s)
[427.095457] Starting dynamic subtest: vcs0
[430.324049] Dynamic subtest vcs0: SUCCESS (3.235s)
[430.334451] Starting dynamic subtest: vcs1
[433.563084] Dynamic subtest vcs1: SUCCESS (3.235s)
[433.572995] Starting dynamic subtest: vecs0
[436.802016] Dynamic subtest vecs0: SUCCESS (3.235s)
[436.812089] Starting dynamic subtest: ccs0
[440.041701] Dynamic subtest ccs0: SUCCESS (3.237s)
[440.043130] Subtest engines: SUCCESS (19.426s)
[440.252742] [075/131] (590s left) gem_mmap_offset (close-race)
[440.311988] Starting subtest: close-race
[460.458067] Subtest close-race: SUCCESS (20.100s)
[460.527376] [076/131] (570s left) gem_exec_balancer (parallel-bb-first)
[460.801416] Starting subtest: parallel-bb-first
[461.819258] Subtest parallel-bb-first: SUCCESS (1.018s)
[462.257354] [077/131] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[462.360526] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[462.362333] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[462.447822] [078/131] (568s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[462.548647] Starting subtest: pr-overlay-plane-move-continuous-sf
[462.550395] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[462.638330] [079/131] (568s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[462.729352] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[462.740848] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[462.825582] [080/131] (568s left) gem_ctx_persistence (legacy-engines-mixed-process)
[462.891333] Starting subtest: legacy-engines-mixed-process
[462.892452] Starting dynamic subtest: render
[464.219204] Dynamic subtest render: SUCCESS (1.327s)
[464.231003] Starting dynamic subtest: bsd1
[466.177810] Dynamic subtest bsd1: SUCCESS (1.955s)
[466.186783] Starting dynamic subtest: bsd2
[468.180352] Dynamic subtest bsd2: SUCCESS (2.001s)
[468.192170] Starting dynamic subtest: blt
[470.232636] Dynamic subtest blt: SUCCESS (2.050s)
[470.244243] Starting dynamic subtest: vebox
[472.216921] Dynamic subtest vebox: SUCCESS (1.982s)
[472.218392] Subtest legacy-engines-mixed-process: SUCCESS (9.326s)
[472.328790] [081/131] (558s left) gem_mmap_gtt (coherency)
[472.377816] Subtest coherency: SKIP (0.000s)
[472.434148] [082/131] (558s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[472.527250] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[472.528894] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[472.613979] [083/131] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[472.702513] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[480.409901] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.707s)
[480.512037] [084/131] (550s left) gem_exec_params (sol-reset-invalid)
[480.562604] Starting subtest: sol-reset-invalid
[480.565885] Subtest sol-reset-invalid: SUCCESS (0.003s)
[482.320259] [085/131] (549s left) kms_flip (dpms-vs-vblank-race)
[482.422769] Starting subtest: dpms-vs-vblank-race
[482.426351] Starting dynamic subtest: A-eDP1
[486.335419] Dynamic subtest A-eDP1: SUCCESS (3.908s)
[486.345298] Starting dynamic subtest: B-eDP1
[490.958335] Dynamic subtest B-eDP1: SUCCESS (4.619s)
[490.966675] Starting dynamic subtest: C-eDP1
[495.601653] Dynamic subtest C-eDP1: SUCCESS (4.643s)
[495.611471] Starting dynamic subtest: D-eDP1
[500.221882] Dynamic subtest D-eDP1: SUCCESS (4.616s)
[500.225264] Subtest dpms-vs-vblank-race: SUCCESS (17.800s)
[501.101191] [086/131] (530s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[501.158901] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[501.160814] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[501.341230] [087/131] (530s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[501.493739] Starting subtest: cursor-rapid-movement-32x32
[501.536775] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[501.812746] [088/131] (529s left) gem_ccs (large-ctrl-surf-copy)
[501.870323] Starting subtest: large-ctrl-surf-copy
[501.872065] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[501.962179] [089/131] (529s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[502.058111] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[502.060197] Starting dynamic subtest: A-eDP1
[505.671328] Dynamic subtest A-eDP1: SUCCESS (3.611s)
[505.680830] Starting dynamic subtest: B-eDP1
[508.875871] Dynamic subtest B-eDP1: SUCCESS (3.202s)
[508.884434] Starting dynamic subtest: C-eDP1
[511.975489] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[511.983542] Starting dynamic subtest: D-eDP1
[515.077971] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[515.078799] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.019s)
[515.892589] [090/131] (515s left) kms_psr (fbc-pr-primary-page-flip)
[515.983332] Starting subtest: fbc-pr-primary-page-flip
[515.985287] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[516.052691] [091/131] (515s left) kms_pm_lpsp (screens-disabled)
[517.140570] Starting subtest: screens-disabled
[517.142221] Subtest screens-disabled: SKIP (0.000s)
[517.221405] [092/131] (514s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[517.288881] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[517.394549] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[517.470013] [093/131] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[517.560125] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[517.561807] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[517.657219] [094/131] (514s left) kms_content_protection (dp-mst-type-0-hdcp14)
[517.790525] Starting subtest: dp-mst-type-0-hdcp14
[517.792549] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[517.898220] [095/131] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[517.990721] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[517.992435] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[518.072726] [096/131] (513s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[518.163649] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[518.165293] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[518.245779] [097/131] (513s left) syncobj_timeline (wait-any-snapshot)
[518.293130] Starting subtest: wait-any-snapshot
[518.376286] Subtest wait-any-snapshot: SUCCESS (0.083s)
[518.448231] [098/131] (513s left) kms_psr (psr-sprite-plane-onoff)
[518.529245] Starting subtest: psr-sprite-plane-onoff
[518.530264] Starting dynamic subtest: eDP-1
[520.307558] Dynamic subtest eDP-1: SUCCESS (1.778s)
[520.308457] Subtest psr-sprite-plane-onoff: SUCCESS (1.779s)
[521.144235] [099/131] (510s left) gem_exec_balancer (smoke)
[521.213757] Starting subtest: smoke
[543.895394] Subtest smoke: SUCCESS (22.637s)
[545.344467] [100/131] (486s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[545.435095] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[552.534595] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.100s)
[552.632711] [101/131] (479s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[552.699277] Starting subtest: stress-mm-invalidate-close-overlap
[554.893009] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[554.959509] [102/131] (477s left) drm_read (empty-block)
[555.094893] Starting subtest: empty-block
[556.095460] Subtest empty-block: SUCCESS (1.000s)
[556.223356] [103/131] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[556.310127] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[556.311863] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[556.389227] [104/131] (475s left) kms_plane (pixel-format-linear-modifier)
[556.484187] Starting subtest: pixel-format-linear-modifier
[556.512406] Starting dynamic subtest: pipe-A-plane-0
[560.156943] Dynamic subtest pipe-A-plane-0: SUCCESS (3.644s)
[560.166467] Starting dynamic subtest: pipe-A-plane-3
[561.879455] Dynamic subtest pipe-A-plane-3: SUCCESS (1.720s)
[561.891802] Starting dynamic subtest: pipe-A-plane-5
[562.090453] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[563.153401] Starting dynamic subtest: pipe-B-plane-0
[566.656631] Dynamic subtest pipe-B-plane-0: SUCCESS (3.511s)
[566.665459] Starting dynamic subtest: pipe-B-plane-3
[568.305895] Dynamic subtest pipe-B-plane-3: SUCCESS (1.644s)
[568.314547] Starting dynamic subtest: pipe-B-plane-5
[568.512364] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[568.829776] Subtest pixel-format-linear-modifier: SUCCESS (12.344s)
[569.626686] [105/131] (462s left) gem_exec_schedule (u-independent)
[569.690408] Starting subtest: u-independent
[569.691620] Starting dynamic subtest: rcs0
[571.225768] Dynamic subtest rcs0: SUCCESS (1.524s)
[571.236674] Starting dynamic subtest: vcs0
[573.221190] Dynamic subtest vcs0: SUCCESS (1.993s)
[573.237157] Starting dynamic subtest: vcs1
[575.267390] Dynamic subtest vcs1: SUCCESS (2.044s)
[575.277598] Starting dynamic subtest: vecs0
[577.249383] Dynamic subtest vecs0: SUCCESS (1.979s)
[577.260573] Starting dynamic subtest: ccs0
[579.224864] Dynamic subtest ccs0: SUCCESS (1.973s)
[579.226295] Subtest u-independent: SUCCESS (9.524s)
[579.510609] [106/131] (452s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[579.607076] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[579.608667] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[579.700412] [107/131] (452s left) perf (whitelisted-registers-userspace-config)
[579.823231] Starting subtest: whitelisted-registers-userspace-config
[579.824117] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[579.862276] [108/131] (452s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[579.953439] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[586.666363] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.712s)
[586.777298] [109/131] (445s left) kms_getfb (getfb-handle-closed)
[586.864020] Starting subtest: getfb-handle-closed
[586.864986] Subtest getfb-handle-closed: SUCCESS (0.000s)
[586.957326] [110/131] (445s left) kms_async_flips (alternate-sync-async-flip)
[587.038168] Starting subtest: alternate-sync-async-flip
[587.424101] Starting dynamic subtest: pipe-A-eDP-1
[590.174854] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.750s)
[590.543157] Starting dynamic subtest: pipe-B-eDP-1
[593.309132] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[593.688885] Starting dynamic subtest: pipe-C-eDP-1
[596.442610] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[596.838446] Starting dynamic subtest: pipe-D-eDP-1
[599.576127] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.750s)
[599.577053] Subtest alternate-sync-async-flip: SUCCESS (12.538s)
[600.750468] [111/131] (431s left) api_intel_bb (render)
[600.802851] Starting subtest: render
[600.803871] Starting dynamic subtest: render-none-512
[600.903181] Dynamic subtest render-none-512: SUCCESS (0.100s)
[600.914116] Starting dynamic subtest: render-none-1024
[601.302035] Dynamic subtest render-none-1024: SUCCESS (0.389s)
[601.312598] Starting dynamic subtest: render-x-512
[601.396835] Dynamic subtest render-x-512: SUCCESS (0.102s)
[601.407870] Starting dynamic subtest: render-x-1024
[601.759183] Dynamic subtest render-x-1024: SUCCESS (0.352s)
[601.770216] Starting dynamic subtest: render-y-512
[601.838832] Dynamic subtest render-y-512: SUCCESS (0.087s)
[601.849678] Starting dynamic subtest: render-y-1024
[602.234802] Dynamic subtest render-y-1024: SUCCESS (0.386s)
[602.236486] Subtest render: SUCCESS (1.424s)
[602.348470] [112/131] (430s left) gem_pread (uncached)
[602.390898] Subtest uncached: SKIP (0.000s)
[602.441679] [113/131] (429s left) gem_exec_gttfill (all-engines)
[602.494637] Starting subtest: all-engines
[626.278166] Subtest all-engines: SUCCESS (23.779s)
[626.466880] [114/131] (405s left) gem_exec_params (invalid-bsd1-flag-on-render)
[626.581754] Starting subtest: invalid-bsd1-flag-on-render
[626.582754] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[626.687464] [115/131] (405s left) kms_panel_fitting (legacy)
[626.780927] Starting subtest: legacy
[626.781758] Starting dynamic subtest: pipe-A-eDP-1
[627.355384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[627.381384] Starting dynamic subtest: pipe-B-eDP-1
[628.896807] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.523s)
[628.924527] Starting dynamic subtest: pipe-C-eDP-1
[630.423866] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s)
[630.451282] Starting dynamic subtest: pipe-D-eDP-1
[631.948070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[631.948917] Subtest legacy: SUCCESS (5.168s)
[633.180341] [116/131] (399s left) gen7_exec_parse (oacontrol-tracking)
[633.247238] Subtest oacontrol-tracking: SKIP (0.000s)
[633.314023] [117/131] (399s left) api_intel_allocator (reloc-allocator)
[633.366725] Starting subtest: reloc-allocator
[633.367735] Starting dynamic subtest: basic
[633.371076] Dynamic subtest basic: SUCCESS (0.003s)
[633.380234] Starting dynamic subtest: parallel-one
[633.381113] Dynamic subtest parallel-one: SUCCESS (0.008s)
[633.389397] Starting dynamic subtest: print
[633.390271] Dynamic subtest print: SUCCESS (0.000s)
[633.398473] Starting dynamic subtest: reuse
[633.399346] Dynamic subtest reuse: SUCCESS (0.000s)
[633.407558] Starting dynamic subtest: fork-reopen-allocator
[633.408553] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[633.409447] Subtest reloc-allocator: SUCCESS (0.026s)
[633.518948] [118/131] (399s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[633.619182] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[634.300739] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[634.461193] [119/131] (398s left) gem_busy (busy)
[634.526429] Starting subtest: busy
[634.527457] Starting dynamic subtest: all-engines
[634.590045] Dynamic subtest all-engines: SUCCESS (0.063s)
[634.602094] Starting dynamic subtest: rcs0
[636.250639] Dynamic subtest rcs0: SUCCESS (1.654s)
[636.267637] Starting dynamic subtest: bcs0
[636.287852] Dynamic subtest bcs0: SUCCESS (0.040s)
[636.298047] Starting dynamic subtest: vcs0
[636.328717] Dynamic subtest vcs0: SUCCESS (0.039s)
[636.338958] Starting dynamic subtest: vcs1
[638.234285] Dynamic subtest vcs1: SUCCESS (1.896s)
[638.244907] Starting dynamic subtest: vecs0
[640.218396] Dynamic subtest vecs0: SUCCESS (1.983s)
[640.229142] Starting dynamic subtest: ccs0
[642.266345] Dynamic subtest ccs0: SUCCESS (2.046s)
[642.267510] Subtest busy: SUCCESS (7.731s)
[642.612797] [120/131] (390s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[642.703873] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[642.704761] Starting dynamic subtest: pipe-A
[643.041741] Dynamic subtest pipe-A: SUCCESS (0.339s)
[643.052690] Starting dynamic subtest: pipe-B
[644.471190] Dynamic subtest pipe-B: SUCCESS (1.429s)
[644.481186] Starting dynamic subtest: pipe-C
[645.895322] Dynamic subtest pipe-C: SUCCESS (1.423s)
[645.905699] Starting dynamic subtest: pipe-D
[647.320222] Dynamic subtest pipe-D: SUCCESS (1.424s)
[647.321223] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.619s)
[648.497969] [121/131] (384s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[648.595492] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[648.596376] Starting dynamic subtest: pipe-A-eDP-1
[648.677621] Dynamic subtest pipe-A-eDP-1: SKIP (0.081s)
[648.687624] Starting dynamic subtest: pipe-B-eDP-1
[649.768697] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[649.770448] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.174s)
[650.960853] [122/131] (381s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[651.511726] Starting subtest: single-wait-for-submit-unsubmitted
[651.618486] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[651.692773] [123/131] (381s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[651.805412] Starting subtest: 4-tiled-64bpp-rotate-90
[651.824711] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[651.958114] [124/131] (380s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[652.056202] Starting subtest: fb-8bpc-vs-panel-8bpc
[652.057310] Starting dynamic subtest: pipe-A-eDP-1
[653.446211] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.390s)
[653.447311] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.391s)
[654.255768] [125/131] (378s left) perf (non-zero-reason)
[654.366996] Starting subtest: non-zero-reason
[654.367903] Starting dynamic subtest: 0-rcs0
[660.092084] Dynamic subtest 0-rcs0: SUCCESS (5.681s)
[660.103810] Starting dynamic subtest: 1-vecs0
[664.097600] Dynamic subtest 1-vecs0: SUCCESS (4.040s)
[664.098799] Subtest non-zero-reason: SUCCESS (9.723s)
[664.131069] [126/131] (368s left) kms_flip (2x-flip-vs-modeset)
[664.238694] Starting subtest: 2x-flip-vs-modeset
[664.249183] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[664.324200] [127/131] (368s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[664.415693] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[664.417346] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[664.503233] [128/131] (368s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[664.600705] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[664.602548] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[664.709624] [129/131] (368s left) gem_exec_flush (basic-wb-rw-before-default)
[664.765242] Starting subtest: basic-wb-rw-before-default
[670.215809] Subtest basic-wb-rw-before-default: SUCCESS (5.451s)
[670.398007] [130/131] (362s left) kms_pipe_stress (stress-xrgb8888-untiled)
[670.497929] Starting subtest: stress-xrgb8888-untiled
[676.377933] Subtest stress-xrgb8888-untiled: SUCCESS (5.880s)
[676.426429] [131/131] (356s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[676.516901] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[676.518727] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[676.608662] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_busy
results: parsing output: 6/ for test: gem_render_linear_blits
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_ctx_shared
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: kms_sequence
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: i915_hangman
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: gem_pxp
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: device_reset
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_ctx_isolation
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_draw_crc
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: gem_pxp
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: i915_pm_rc6_residency
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_plane_multiple
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: sriov_basic
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_color
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_hdr
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: syncobj_eventfd
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: gem_mmap_offset
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: gem_ccs
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_pm_lpsp
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_content_protection
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_exec_balancer
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: drm_read
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_getfb
results: parsing output: 109/ for test: kms_async_flips
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_pread
results: parsing output: 112/ for test: gem_exec_gttfill
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_panel_fitting
results: parsing output: 115/ for test: gen7_exec_parse
results: parsing output: 116/ for test: api_intel_allocator
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_busy
results: parsing output: 119/ for test: kms_plane_scaling
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: kms_pipe_stress
results: parsing output: 130/ for test: kms_big_fb
Done.