[57.678276] Initializing watchdogs
[57.678321]   /dev/watchdog0
[57.693226] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.697552] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.699836] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.703200] [001/132] (960s left) kms_pm_dc (dc9-dpms)
[58.826923] Starting subtest: dc9-dpms
[60.263600] Subtest dc9-dpms: SUCCESS (1.436s)
[60.346760] [002/132] (957s left) gem_exec_schedule (semaphore-resolve)
[60.427540] Starting subtest: semaphore-resolve
[60.461770] Subtest semaphore-resolve: SUCCESS (0.038s)
[60.838046] [003/132] (957s left) gem_exec_params (mmapped)
[60.903715] Starting subtest: mmapped
[60.906075] Subtest mmapped: SUCCESS (0.002s)
[61.066733] [004/132] (957s left) kms_psr (psr-primary-page-flip)
[61.153655] Starting subtest: psr-primary-page-flip
[61.155984] Starting dynamic subtest: eDP-1
[62.903312] Dynamic subtest eDP-1: SUCCESS (1.749s)
[62.905726] Subtest psr-primary-page-flip: SUCCESS (1.749s)
[63.791134] [005/132] (954s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[63.858908] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[63.860835] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[63.997469] [006/132] (954s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[64.122995] Starting subtest: cursorA-vs-flipA-toggle
[75.287079] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.165s)
[76.118233] [007/132] (942s left) gem_exec_create (forked)
[76.183037] Starting subtest: forked
[76.185345] Starting dynamic subtest: smem
[97.942349] Dynamic subtest smem: SUCCESS (21.755s)
[97.944582] Subtest forked: SUCCESS (21.756s)
[98.147562] [008/132] (920s left) gem_exec_reloc (basic-gtt-cpu)
[98.212072] Subtest basic-gtt-cpu: SKIP (0.000s)
[98.289088] [009/132] (920s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[98.402031] Starting subtest: x-tiled-addfb-size-offset-overflow
[98.404217] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[98.525596] [010/132] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[98.621786] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[106.058213] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.440s)
[106.251743] [011/132] (912s left) perf_pmu (faulting-read)
[106.294202] Starting subtest: faulting-read
[106.296352] Starting dynamic subtest: wb
[106.298687] Dynamic subtest wb: SUCCESS (0.001s)
[106.306694] Starting dynamic subtest: wc
[106.308582] Dynamic subtest wc: SUCCESS (0.000s)
[106.315714] Starting dynamic subtest: uc
[106.317955] Dynamic subtest uc: SUCCESS (0.000s)
[106.320099] Subtest faulting-read: SUCCESS (0.003s)
[106.428033] [012/132] (912s left) gem_ctx_persistence (engines-persistence)
[106.496271] Starting subtest: engines-persistence
[106.498078] Starting dynamic subtest: rcs0
[107.378863] Dynamic subtest rcs0: SUCCESS (0.884s)
[107.389854] Starting dynamic subtest: bcs0
[108.189997] Dynamic subtest bcs0: SUCCESS (0.810s)
[108.200932] Starting dynamic subtest: vcs0
[108.965517] Dynamic subtest vcs0: SUCCESS (0.774s)
[108.976781] Starting dynamic subtest: vcs1
[109.727331] Dynamic subtest vcs1: SUCCESS (0.761s)
[109.738237] Starting dynamic subtest: vecs0
[110.498799] Dynamic subtest vecs0: SUCCESS (0.771s)
[110.509829] Starting dynamic subtest: ccs0
[111.268507] Dynamic subtest ccs0: SUCCESS (0.768s)
[111.271506] Subtest engines-persistence: SUCCESS (4.774s)
[111.373884] [013/132] (907s left) gem_mmap_gtt (ptrace)
[111.438330] Subtest ptrace: SKIP (0.000s)
[111.498903] [014/132] (907s left) kms_flip (dpms-off-confusion-interruptible)
[111.598305] Starting subtest: dpms-off-confusion-interruptible
[111.600593] Starting dynamic subtest: A-eDP1
[120.235889] Dynamic subtest A-eDP1: SUCCESS (8.636s)
[120.245652] Starting dynamic subtest: B-eDP1
[128.961750] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[128.972629] Starting dynamic subtest: C-eDP1
[137.577376] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[137.588941] Starting dynamic subtest: D-eDP1
[146.208472] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[146.210807] Subtest dpms-off-confusion-interruptible: SUCCESS (34.612s)
[147.412034] [015/132] (871s left) syncobj_wait (multi-wait-submitted-signaled)
[147.460210] Starting subtest: multi-wait-submitted-signaled
[147.462650] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[147.591048] [016/132] (871s left) kms_cursor_crc (cursor-sliding-512x170)
[147.889787] Starting subtest: cursor-sliding-512x170
[147.894217] Subtest cursor-sliding-512x170: SKIP (0.001s)
[148.072211] [017/132] (870s left) kms_big_fb (linear-8bpp-rotate-270)
[148.172792] Starting subtest: linear-8bpp-rotate-270
[148.195744] Subtest linear-8bpp-rotate-270: SKIP (0.023s)
[148.351765] [018/132] (870s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[148.447450] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[148.449443] Starting dynamic subtest: pipe-A
[148.509801] Dynamic subtest pipe-A: SUCCESS (0.064s)
[148.520601] Starting dynamic subtest: pipe-B
[149.622781] Dynamic subtest pipe-B: SUCCESS (1.111s)
[149.633526] Starting dynamic subtest: pipe-C
[150.725266] Dynamic subtest pipe-C: SUCCESS (1.102s)
[150.733282] Starting dynamic subtest: pipe-D
[151.867277] Dynamic subtest pipe-D: SUCCESS (1.142s)
[151.869584] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.422s)
[153.048310] [019/132] (865s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[158.007779] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[158.012330] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[158.869973] [020/132] (860s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[158.965891] Starting subtest: psr-rgb565-draw-pwrite
[165.942885] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.980s)
[166.077176] [021/132] (852s left) prime_busy (after-wait)
[166.143595] Starting subtest: after-wait
[166.148580] Starting dynamic subtest: rcs0
[166.201755] Dynamic subtest rcs0: SUCCESS (0.055s)
[166.211047] Starting dynamic subtest: bcs0
[166.278389] Dynamic subtest bcs0: SUCCESS (0.076s)
[166.288379] Starting dynamic subtest: vcs0
[166.318335] Dynamic subtest vcs0: SUCCESS (0.040s)
[166.327125] Starting dynamic subtest: vcs1
[166.359945] Dynamic subtest vcs1: SUCCESS (0.041s)
[166.368906] Starting dynamic subtest: vecs0
[166.400593] Dynamic subtest vecs0: SUCCESS (0.040s)
[166.409442] Starting dynamic subtest: ccs0
[166.441983] Dynamic subtest ccs0: SUCCESS (0.041s)
[166.550044] Subtest after-wait: SUCCESS (0.404s)
[166.645772] [022/132] (852s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[166.933357] Starting subtest: cursor-rapid-movement-max-size
[166.939781] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[167.094636] [023/132] (851s left) gem_exec_balancer (indices)
[167.155066] Starting subtest: indices
[169.844666] Subtest indices: SUCCESS (2.687s)
[170.189826] [024/132] (848s left) syncobj_wait (wait-any-interrupted)
[170.249324] Starting subtest: wait-any-interrupted
[170.350997] Subtest wait-any-interrupted: SUCCESS (0.101s)
[170.451302] [025/132] (848s left) kms_lease (lease-again)
[170.550060] Starting subtest: lease-again
[170.552452] Starting dynamic subtest: pipe-A-eDP-1
[170.554790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[170.567113] Starting dynamic subtest: pipe-B-eDP-1
[170.569341] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[170.577596] Starting dynamic subtest: pipe-C-eDP-1
[170.579767] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[170.587456] Starting dynamic subtest: pipe-D-eDP-1
[170.589705] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[170.591980] Subtest lease-again: SUCCESS (0.012s)
[170.691065] [026/132] (848s left) template (b)
[170.756322] Starting subtest: B
[170.758644] Subtest B: SUCCESS (0.000s)
[170.890912] [027/132] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[170.995325] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[170.999657] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[171.123420] [028/132] (848s left) gem_ctx_create (basic)
[171.182671] Starting subtest: basic
[171.184993] Subtest basic: SUCCESS (0.000s)
[171.386128] [029/132] (847s left) gem_reg_read (bad-register)
[171.446907] Starting subtest: bad-register
[171.449045] Subtest bad-register: SUCCESS (0.000s)
[171.582286] [030/132] (847s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[171.639768] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[171.745232] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[171.837689] [031/132] (847s left) syncobj_wait (invalid-signal-one-illegal-handle)
[171.903778] Starting subtest: invalid-signal-one-illegal-handle
[171.905978] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[172.034161] [032/132] (847s left) kms_plane (plane-panning-bottom-right)
[172.135132] Starting subtest: plane-panning-bottom-right
[172.137097] Starting dynamic subtest: pipe-A
[173.842318] Dynamic subtest pipe-A: SUCCESS (1.706s)
[173.851740] Starting dynamic subtest: pipe-B
[176.124235] Dynamic subtest pipe-B: SUCCESS (2.281s)
[176.126607] Subtest plane-panning-bottom-right: SUCCESS (3.990s)
[177.031653] [033/132] (842s left) kms_dirtyfb (default-dirtyfb-ioctl)
[177.129862] Starting subtest: default-dirtyfb-ioctl
[177.131706] Starting dynamic subtest: A-eDP-1
[178.783124] Dynamic subtest A-eDP-1: SUCCESS (1.654s)
[178.785687] Subtest default-dirtyfb-ioctl: SUCCESS (1.655s)
[179.697315] [034/132] (839s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[179.817280] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[186.544455] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.731s)
[186.706794] [035/132] (832s left) gen9_exec_parse (unaligned-access)
[186.788433] Subtest unaligned-access: SKIP (0.000s)
[186.865772] [036/132] (832s left) kms_atomic (plane-invalid-params-fence)
[186.958374] Starting subtest: plane-invalid-params-fence
[186.960616] Starting dynamic subtest: pipe-A-eDP-1
[187.312628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s)
[187.314935] Subtest plane-invalid-params-fence: SUCCESS (0.354s)
[188.134491] [037/132] (831s left) gem_exec_schedule (out-order)
[188.200810] Starting subtest: out-order
[188.203215] Starting dynamic subtest: rcs0
[188.296256] Dynamic subtest rcs0: SUCCESS (0.103s)
[188.308554] Starting dynamic subtest: vcs0
[188.376293] Dynamic subtest vcs0: SUCCESS (0.079s)
[188.387339] Starting dynamic subtest: vcs1
[188.451719] Dynamic subtest vcs1: SUCCESS (0.075s)
[188.462753] Starting dynamic subtest: vecs0
[188.525052] Dynamic subtest vecs0: SUCCESS (0.073s)
[188.537564] Starting dynamic subtest: ccs0
[188.609029] Dynamic subtest ccs0: SUCCESS (0.082s)
[188.611963] Subtest out-order: SUCCESS (0.416s)
[190.036166] [038/132] (829s left) gem_ctx_shared (exec-shared-gtt)
[190.094282] Starting subtest: exec-shared-gtt
[190.096512] Starting dynamic subtest: rcs0
[190.103386] Dynamic subtest rcs0: SUCCESS (0.009s)
[190.113158] Starting dynamic subtest: bcs0
[190.115302] Dynamic subtest bcs0: SUCCESS (0.005s)
[190.123440] Starting dynamic subtest: vcs0
[190.125335] Dynamic subtest vcs0: SUCCESS (0.006s)
[190.133598] Starting dynamic subtest: vcs1
[190.135829] Dynamic subtest vcs1: SUCCESS (0.006s)
[190.143421] Starting dynamic subtest: vecs0
[190.145320] Dynamic subtest vecs0: SUCCESS (0.005s)
[190.152919] Starting dynamic subtest: ccs0
[190.154855] Dynamic subtest ccs0: SUCCESS (0.004s)
[190.156769] Subtest exec-shared-gtt: SUCCESS (0.039s)
[190.338298] [039/132] (829s left) kms_getfb (getfb2-handle-zero)
[190.434120] Starting subtest: getfb2-handle-zero
[190.436412] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[190.558173] [040/132] (829s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[190.658749] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[190.660989] Starting dynamic subtest: pipe-A-default-mode
[191.781594] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[191.785699] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.122s)
[191.963647] [041/132] (827s left) gem_eio (wait-10ms)
[192.185032] Starting subtest: wait-10ms
[192.531194] Subtest wait-10ms: SUCCESS (0.346s)
[192.708273] [042/132] (827s left) kms_addfb_basic (basic)
[192.764126] Starting subtest: basic
[192.765922] Subtest basic: SUCCESS (0.000s)
[192.934864] [043/132] (826s left) gem_close_race (basic-threads)
[193.004329] Starting subtest: basic-threads
[194.462047] Subtest basic-threads: SUCCESS (1.456s)
[194.666941] [044/132] (825s left) gen9_exec_parse (secure-batches)
[194.741073] Subtest secure-batches: SKIP (0.000s)
[194.826733] [045/132] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[194.924960] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[199.270337] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.348s)
[200.468679] [046/132] (819s left) kms_psr (fbc-psr2-sprite-plane-move)
[200.565854] Starting subtest: fbc-psr2-sprite-plane-move
[200.568128] Starting dynamic subtest: eDP-1
[200.572180] Dynamic subtest eDP-1: SKIP (0.000s)
[200.576196] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[200.657756] [047/132] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[200.748506] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[200.752883] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[200.879981] [048/132] (819s left) api_intel_bb (full-batch)
[200.928775] Starting subtest: full-batch
[200.933239] Subtest full-batch: SUCCESS (0.004s)
[201.094074] [049/132] (818s left) gem_exec_create (basic)
[201.160708] Starting subtest: basic
[201.163099] Starting dynamic subtest: smem
[203.252071] Dynamic subtest smem: SUCCESS (2.091s)
[203.254394] Subtest basic: SUCCESS (2.092s)
[203.464494] [050/132] (816s left) kms_content_protection (suspend-resume)
[203.612778] Starting subtest: suspend-resume
[203.617476] Subtest suspend-resume: SKIP (0.000s)
[203.781388] [051/132] (816s left) kms_vblank (wait-forked)
[203.875968] Starting subtest: wait-forked
[203.877851] Starting dynamic subtest: pipe-A-eDP-1
[205.681505] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[205.696257] Starting dynamic subtest: pipe-D-eDP-1
[208.241640] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[208.243628] Subtest wait-forked: SUCCESS (4.365s)
[209.122330] [052/132] (811s left) gem_spin_batch (legacy-resubmit-new)
[209.192901] Starting subtest: legacy-resubmit-new
[209.195061] Starting dynamic subtest: default
[209.199699] Dynamic subtest default: SUCCESS (0.007s)
[209.208907] Starting dynamic subtest: render
[209.211078] Dynamic subtest render: SUCCESS (0.003s)
[209.219613] Starting dynamic subtest: bsd
[209.221720] Dynamic subtest bsd: SUCCESS (0.004s)
[209.229989] Starting dynamic subtest: bsd1
[209.232074] Dynamic subtest bsd1: SUCCESS (0.002s)
[209.240141] Starting dynamic subtest: bsd2
[209.242259] Dynamic subtest bsd2: SUCCESS (0.004s)
[209.250249] Starting dynamic subtest: blt
[209.252384] Dynamic subtest blt: SUCCESS (0.004s)
[209.260247] Starting dynamic subtest: vebox
[209.262331] Dynamic subtest vebox: SUCCESS (0.004s)
[209.264438] Subtest legacy-resubmit-new: SUCCESS (0.034s)
[210.962532] [053/132] (809s left) gem_eio (in-flight-contexts-10ms)
[211.214191] Starting subtest: in-flight-contexts-10ms
[224.944474] Subtest in-flight-contexts-10ms: SUCCESS (13.730s)
[225.151918] [054/132] (795s left) gem_exec_await (wide-all)
[225.398680] Starting subtest: wide-all
[248.809137] Subtest wide-all: SUCCESS (23.408s)
[249.020740] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[249.025506] [055/132] (771s left) kms_psr2_su (page_flip-xrgb8888)
[249.142741] Subtest page_flip-XRGB8888: SKIP (0.000s)
[249.210933] [056/132] (771s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[249.305566] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[249.307855] Starting dynamic subtest: pipe-A-eDP-1
[249.327768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[249.341216] Starting dynamic subtest: pipe-B-eDP-1
[249.360144] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[249.368934] Starting dynamic subtest: pipe-C-eDP-1
[249.387999] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[249.397931] Starting dynamic subtest: pipe-D-eDP-1
[249.416698] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[249.418563] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[251.588595] [057/132] (768s left) kms_chamelium_frames (hdmi-crc-single)
[251.978304] Subtest hdmi-crc-single: SKIP (0.000s)
[252.772761] [058/132] (767s left) kms_hdmi_inject (inject-4k)
[253.140980] Starting subtest: inject-4k
[253.454172] Subtest inject-4k: SUCCESS (0.315s)
[254.005863] [059/132] (766s left) core_sysfs (read-all-entries)
[254.066846] Starting subtest: read-all-entries
[254.071704] Subtest read-all-entries: SUCCESS (0.003s)
[254.200408] [060/132] (766s left) kms_color (deep-color)
[254.297051] Starting subtest: deep-color
[255.370683] Starting dynamic subtest: pipe-A-eDP-1-gamma
[256.084514] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.714s)
[256.093902] Starting dynamic subtest: pipe-A-eDP-1-degamma
[257.546678] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.460s)
[257.556813] Starting dynamic subtest: pipe-A-eDP-1-ctm
[259.035316] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.487s)
[259.781946] Starting dynamic subtest: pipe-B-eDP-1-gamma
[260.496720] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.722s)
[260.506409] Starting dynamic subtest: pipe-B-eDP-1-degamma
[261.939806] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.443s)
[261.950191] Starting dynamic subtest: pipe-B-eDP-1-ctm
[263.352609] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.411s)
[264.173149] Starting dynamic subtest: pipe-C-eDP-1-gamma
[264.882428] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.716s)
[264.893341] Starting dynamic subtest: pipe-C-eDP-1-degamma
[266.318621] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.435s)
[266.328033] Starting dynamic subtest: pipe-C-eDP-1-ctm
[267.694740] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.377s)
[268.469802] Starting dynamic subtest: pipe-D-eDP-1-gamma
[269.173391] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.711s)
[269.183059] Starting dynamic subtest: pipe-D-eDP-1-degamma
[270.607956] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.436s)
[270.618513] Starting dynamic subtest: pipe-D-eDP-1-ctm
[271.992370] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.380s)
[271.994341] Subtest deep-color: SUCCESS (17.694s)
[272.857663] [061/132] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[272.975470] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[272.979569] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[273.126703] [062/132] (747s left) gem_exec_create (legacy)
[273.182539] Starting subtest: legacy
[273.184887] Starting dynamic subtest: smem
[275.274387] Dynamic subtest smem: SUCCESS (2.091s)
[275.277066] Subtest legacy: SUCCESS (2.092s)
[275.483921] [063/132] (745s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[275.587818] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[275.590180] Starting dynamic subtest: pipe-A-eDP-1
[275.613165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[275.625547] Starting dynamic subtest: pipe-B-eDP-1
[275.646238] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[275.655248] Starting dynamic subtest: pipe-C-eDP-1
[275.676590] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[275.685547] Starting dynamic subtest: pipe-D-eDP-1
[275.707585] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[275.711648] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[277.848101] [064/132] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[277.944196] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[277.948122] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[278.073785] [065/132] (742s left) gem_pwrite (basic-self)
[278.127721] Subtest basic-self: SKIP (0.000s)
[278.188809] [066/132] (742s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[278.273794] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[278.276081] Starting dynamic subtest: pipe-A-eDP-1
[278.298756] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[278.311053] Starting dynamic subtest: pipe-B-eDP-1
[278.333841] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[278.345022] Starting dynamic subtest: pipe-C-eDP-1
[278.366487] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[278.375458] Starting dynamic subtest: pipe-D-eDP-1
[278.398097] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[278.402358] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[280.552488] [067/132] (740s left) gem_userptr_blits (create-destroy-unsync)
[280.629533] Subtest create-destroy-unsync: SKIP (0.000s)
[280.790835] [068/132] (740s left) kms_plane_cursor (primary)
[280.888620] Starting subtest: primary
[280.893104] Starting dynamic subtest: pipe-A-eDP-1-size-64
[283.481646] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.594s)
[283.511242] Starting dynamic subtest: pipe-A-eDP-1-size-128
[286.049038] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.548s)
[286.080371] Starting dynamic subtest: pipe-A-eDP-1-size-256
[288.627296] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.559s)
[288.942436] Starting dynamic subtest: pipe-B-eDP-1-size-64
[292.198959] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.266s)
[292.222749] Starting dynamic subtest: pipe-B-eDP-1-size-128
[294.754791] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[294.780965] Starting dynamic subtest: pipe-B-eDP-1-size-256
[297.312463] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.537s)
[297.634510] Starting dynamic subtest: pipe-C-eDP-1-size-64
[300.508904] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.883s)
[300.535911] Starting dynamic subtest: pipe-C-eDP-1-size-128
[302.764058] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[302.791783] Starting dynamic subtest: pipe-C-eDP-1-size-256
[304.964226] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[305.281414] Starting dynamic subtest: pipe-D-eDP-1-size-64
[308.255991] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.986s)
[308.281283] Starting dynamic subtest: pipe-D-eDP-1-size-128
[310.465717] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[310.493068] Starting dynamic subtest: pipe-D-eDP-1-size-256
[312.677407] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.190s)
[312.982463] Subtest primary: SUCCESS (32.093s)
[313.842654] [069/132] (707s left) syncobj_wait (invalid-reset-bad-pad)
[313.910305] Starting subtest: invalid-reset-bad-pad
[313.912698] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[314.052420] [070/132] (706s left) kms_pm_lpsp (kms-lpsp)
[315.150217] Starting subtest: kms-lpsp
[315.152066] Starting dynamic subtest: pipe-A-eDP-1
[315.319675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.172s)
[315.617271] Subtest kms-lpsp: SUCCESS (0.468s)
[316.448365] [071/132] (704s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[321.517895] Starting subtest: psr2-overlay-plane-update-continuous-sf
[321.520209] Starting dynamic subtest: pipe-A-eDP-1
[323.227072] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.710s)
[323.237944] Starting dynamic subtest: pipe-B-eDP-1
[324.930648] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.702s)
[324.932966] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.416s)
[325.755158] [072/132] (695s left) kms_joiner (basic-force-ultra-joiner)
[325.865988] Starting subtest: basic-force-ultra-joiner
[325.870264] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[325.954867] [073/132] (695s left) syncobj_timeline (device-submit-unordered)
[326.016432] Starting subtest: device-submit-unordered
[326.018765] Subtest device-submit-unordered: SUCCESS (0.000s)
[326.150275] [074/132] (694s left) kms_psr (fbc-psr-primary-blt)
[326.239948] Starting subtest: fbc-psr-primary-blt
[326.242158] Starting dynamic subtest: eDP-1
[326.246255] Dynamic subtest eDP-1: SKIP (0.000s)
[326.250470] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[326.343098] [075/132] (694s left) i915_power (sanity)
[326.409812] Starting subtest: sanity
[330.464725] Subtest sanity: SUCCESS (4.049s)
[331.004298] [076/132] (690s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[331.123184] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[331.127259] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[331.251060] [077/132] (689s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[331.317577] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[331.321748] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[331.526896] [078/132] (689s left) perf (enable-disable)
[331.679844] Starting subtest: enable-disable
[331.682094] Starting dynamic subtest: 0-rcs0
[333.951983] Dynamic subtest 0-rcs0: SUCCESS (2.271s)
[333.962110] Starting dynamic subtest: 1-vecs0
[338.452146] Dynamic subtest 1-vecs0: SUCCESS (4.499s)
[338.454903] Subtest enable-disable: SUCCESS (6.771s)
[338.492451] [079/132] (682s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[343.598580] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[343.603065] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[344.444344] [080/132] (676s left) i915_hangman (detector)
[344.515521] Starting subtest: detector
[344.517809] Starting dynamic subtest: rcs0
[355.892080] Dynamic subtest rcs0: SUCCESS (11.374s)
[355.904257] Starting dynamic subtest: bcs0
[365.876101] Dynamic subtest bcs0: SUCCESS (9.980s)
[365.887518] Starting dynamic subtest: vcs0
[377.845669] Dynamic subtest vcs0: SUCCESS (11.966s)
[377.860098] Starting dynamic subtest: vcs1
[389.876340] Dynamic subtest vcs1: SUCCESS (12.027s)
[389.887538] Starting dynamic subtest: vecs0
[401.908082] Dynamic subtest vecs0: SUCCESS (12.029s)
[401.920025] Starting dynamic subtest: ccs0
[413.876232] Dynamic subtest ccs0: SUCCESS (11.965s)
[413.878816] Subtest detector: SUCCESS (69.358s)
[413.991170] [081/132] (607s left) sysfs_preempt_timeout (invalid)
[414.057094] Starting subtest: invalid
[414.059398] Starting dynamic subtest: vecs0
[414.061742] Dynamic subtest vecs0: SUCCESS (0.000s)
[414.072776] Starting dynamic subtest: ccs0
[414.074737] Dynamic subtest ccs0: SUCCESS (0.000s)
[414.083769] Starting dynamic subtest: vcs0
[414.085611] Dynamic subtest vcs0: SUCCESS (0.000s)
[414.094374] Starting dynamic subtest: bcs0
[414.096277] Dynamic subtest bcs0: SUCCESS (0.000s)
[414.105075] Starting dynamic subtest: rcs0
[414.107772] Dynamic subtest rcs0: SUCCESS (0.000s)
[414.118363] Starting dynamic subtest: vcs1
[414.120632] Dynamic subtest vcs1: SUCCESS (0.000s)
[414.122793] Subtest invalid: SUCCESS (0.006s)
[414.206230] [082/132] (607s left) kms_addfb_basic (unused-modifier)
[414.264423] Starting subtest: unused-modifier
[414.266597] Subtest unused-modifier: SUCCESS (0.000s)
[414.430937] [083/132] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[414.531519] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[421.377893] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.848s)
[421.514157] [084/132] (600s left) kms_feature_discovery (display)
[421.618974] Starting subtest: display
[421.621201] Subtest display: SUCCESS (0.000s)
[421.718230] [085/132] (599s left) kms_getfb (getfb-handle-closed)
[421.814049] Starting subtest: getfb-handle-closed
[421.816352] Subtest getfb-handle-closed: SUCCESS (0.000s)
[421.954983] [086/132] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[422.066450] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[422.070488] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[422.215044] [087/132] (599s left) gem_create (create-size-update)
[422.274677] Starting subtest: create-size-update
[422.276618] Subtest create-size-update: SUCCESS (0.000s)
[422.514489] [088/132] (599s left) gem_userptr_blits (set-cache-level)
[422.589307] Starting subtest: set-cache-level
[422.593947] Subtest set-cache-level: SKIP (0.000s)
[422.752798] [089/132] (598s left) kms_psr (psr2-cursor-blt)
[422.840011] Starting subtest: psr2-cursor-blt
[422.842308] Starting dynamic subtest: eDP-1
[424.565927] Dynamic subtest eDP-1: SUCCESS (1.725s)
[424.568315] Subtest psr2-cursor-blt: SUCCESS (1.726s)
[425.440728] [090/132] (596s left) fbdev (write)
[425.486760] Starting subtest: write
[425.850909] Subtest write: SUCCESS (0.362s)
[425.938897] [091/132] (595s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[426.044386] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[426.048726] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[426.172584] [092/132] (595s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[426.240297] Starting subtest: invalid-bsd2-flag-on-vebox
[426.242597] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[426.380223] [093/132] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[426.489114] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[426.493291] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[426.630193] [094/132] (595s left) kms_cursor_crc (cursor-onscreen-128x128)
[426.850218] Starting subtest: cursor-onscreen-128x128
[426.855055] Starting dynamic subtest: pipe-A-eDP-1
[428.948934] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.093s)
[428.978507] Starting dynamic subtest: pipe-D-eDP-1
[431.739932] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[431.741930] Subtest cursor-onscreen-128x128: SUCCESS (4.887s)
[432.638665] [095/132] (589s left) gem_exercise_blt (fast-copy)
[432.710528] Starting subtest: fast-copy
[432.712544] Starting dynamic subtest: linear-smem-smem
[432.730426] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[432.742538] Starting dynamic subtest: xmajor-smem-smem
[432.751719] Dynamic subtest xmajor-smem-smem: SUCCESS (0.020s)
[432.762067] Starting dynamic subtest: tile4-smem-smem
[432.768725] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[432.777973] Starting dynamic subtest: tile64-smem-smem
[432.786212] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[432.788390] Subtest fast-copy: SUCCESS (0.078s)
[432.950901] [096/132] (589s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[433.065314] Starting subtest: yf-tiled-64bpp-rotate-180
[433.069556] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[433.196809] [097/132] (588s left) kms_flip (2x-flip-vs-suspend-interruptible)
[433.302904] Starting subtest: 2x-flip-vs-suspend-interruptible
[433.314294] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[433.467567] [098/132] (588s left) kms_flip (modeset-vs-vblank-race)
[433.576166] Starting subtest: modeset-vs-vblank-race
[433.578106] Starting dynamic subtest: A-eDP1
[438.310386] Dynamic subtest A-eDP1: SUCCESS (4.734s)
[438.322762] Starting dynamic subtest: B-eDP1
[443.002715] Dynamic subtest B-eDP1: SUCCESS (4.690s)
[443.017920] Starting dynamic subtest: C-eDP1
[447.689414] Dynamic subtest C-eDP1: SUCCESS (4.684s)
[447.700157] Starting dynamic subtest: D-eDP1
[452.379063] Dynamic subtest D-eDP1: SUCCESS (4.688s)
[452.381545] Subtest modeset-vs-vblank-race: SUCCESS (18.807s)
[453.636789] [099/132] (568s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[453.690784] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[453.692959] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[453.809995] [100/132] (568s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[453.910376] Starting subtest: y-tiled-16bpp-rotate-90
[453.914592] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[454.043667] [101/132] (568s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[454.143321] Starting subtest: psr-modesetfrombusy
[460.316965] Subtest psr-modesetfrombusy: SUCCESS (6.179s)
[460.511966] [102/132] (561s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[460.575312] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[460.646318] [103/132] (561s left) gem_ctx_persistence (heartbeat-stop)
[460.702267] Starting subtest: heartbeat-stop
[460.706288] Subtest heartbeat-stop: SKIP (0.000s)
[460.842421] [104/132] (561s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[460.939051] Starting subtest: extended-pageflip-modeset-hang-oldfb
[460.940819] Starting dynamic subtest: pipe-A
[468.837032] Dynamic subtest pipe-A: SUCCESS (7.895s)
[468.848850] Starting dynamic subtest: pipe-D
[477.484575] Dynamic subtest pipe-D: SUCCESS (8.647s)
[477.486791] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.545s)
[478.336145] [105/132] (544s left) kms_flip (dpms-vs-vblank-race)
[478.425244] Starting subtest: dpms-vs-vblank-race
[478.429819] Starting dynamic subtest: A-eDP1
[482.299652] Dynamic subtest A-eDP1: SUCCESS (3.868s)
[482.309862] Starting dynamic subtest: B-eDP1
[485.775913] Dynamic subtest B-eDP1: SUCCESS (3.476s)
[485.785877] Starting dynamic subtest: C-eDP1
[489.257931] Dynamic subtest C-eDP1: SUCCESS (3.481s)
[489.269098] Starting dynamic subtest: D-eDP1
[492.761713] Dynamic subtest D-eDP1: SUCCESS (3.503s)
[492.763740] Subtest dpms-vs-vblank-race: SUCCESS (14.340s)
[493.631845] [106/132] (528s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[493.749767] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[493.754178] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[493.884419] [107/132] (528s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[493.994371] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[493.998691] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[494.118223] [108/132] (528s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[494.230639] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[494.234742] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[494.381411] [109/132] (528s left) syncobj_timeline (wait-any-complex)
[494.445048] Starting subtest: wait-any-complex
[494.507945] Subtest wait-any-complex: SUCCESS (0.062s)
[494.609137] [110/132] (527s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[494.697549] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[494.699185] Starting dynamic subtest: pipe-A-eDP-1
[495.124483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[495.136486] Starting dynamic subtest: pipe-B-eDP-1
[495.153490] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[495.163108] Starting dynamic subtest: pipe-C-eDP-1
[495.179358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[495.187956] Starting dynamic subtest: pipe-D-eDP-1
[495.203741] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[495.205520] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.442s)
[497.433594] [111/132] (525s left) api_intel_allocator (fork-simple-once)
[497.496079] Starting subtest: fork-simple-once
[497.513976] Subtest fork-simple-once: SUCCESS (0.019s)
[497.669457] [112/132] (525s left) i915_pm_rc6_residency (rc6-idle)
[497.733496] Starting subtest: rc6-idle
[497.784432] Starting dynamic subtest: gt0-rcs0
[522.155902] Dynamic subtest gt0-rcs0: SUCCESS (24.371s)
[522.165331] Starting dynamic subtest: gt0-bcs0
[546.602065] Dynamic subtest gt0-bcs0: SUCCESS (24.443s)
[546.611778] Starting dynamic subtest: gt0-ccs0
[570.970858] Dynamic subtest gt0-ccs0: SUCCESS (24.365s)
[570.982469] Starting dynamic subtest: gt1-vcs0
[577.142220] Dynamic subtest gt1-vcs0: SUCCESS (6.168s)
[577.153820] Starting dynamic subtest: gt1-vecs0
[583.314402] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[583.317048] Subtest rc6-idle: SUCCESS (85.579s)
[583.421691] [113/132] (439s left) kms_chamelium_color (ctm-max)
[583.526085] Subtest ctm-max: SKIP (0.000s)
[583.572577] [114/132] (439s left) syncobj_timeline (multi-wait-all-available-signaled)
[583.640578] Starting subtest: multi-wait-all-available-signaled
[583.642960] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[583.775421] [115/132] (439s left) gem_close (many-handles-one-vma)
[583.841902] Starting subtest: many-handles-one-vma
[583.864044] Subtest many-handles-one-vma: SUCCESS (0.025s)
[583.984078] [116/132] (438s left) kms_selftest (drm_plane_helper)
[584.029312] Starting subtest: drm_plane_helper
[584.067149] Starting dynamic subtest: drm_test_check_plane_state
[584.212858] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.145s)
[584.222560] Starting dynamic subtest: drm_test_check_invalid_plane_state
[584.336108] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.121s)
[584.338478] Subtest drm_plane_helper: SUCCESS (0.305s)
[584.550501] [117/132] (438s left) kms_vblank (ts-continuation-dpms-rpm)
[584.652073] Starting subtest: ts-continuation-dpms-rpm
[584.654364] Starting dynamic subtest: pipe-A-eDP-1
[587.181117] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.528s)
[587.196039] Starting dynamic subtest: pipe-D-eDP-1
[589.346273] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.161s)
[589.348632] Subtest ts-continuation-dpms-rpm: SUCCESS (4.693s)
[590.231368] [118/132] (432s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[590.343333] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[591.034045] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[591.268237] [119/132] (431s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[591.396878] Starting subtest: verify-pxp-execution-after-suspend-resume
[602.175716] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (10.780s)
[611.397949] [120/132] (420s left) gem_exec_whisper (basic-contexts-priority-all)
[611.483804] Starting subtest: basic-contexts-priority-all
[635.650465] Subtest basic-contexts-priority-all: SUCCESS (24.160s)
[635.857564] [121/132] (396s left) kms_flip (bo-too-big-interruptible)
[635.953196] Starting subtest: bo-too-big-interruptible
[635.955482] Starting dynamic subtest: A-eDP1
[637.214283] Dynamic subtest A-eDP1: SUCCESS (1.260s)
[637.226343] Starting dynamic subtest: B-eDP1
[638.509650] Dynamic subtest B-eDP1: SUCCESS (1.294s)
[638.529321] Starting dynamic subtest: C-eDP1
[639.833590] Dynamic subtest C-eDP1: SUCCESS (1.321s)
[639.848092] Starting dynamic subtest: D-eDP1
[641.132350] Dynamic subtest D-eDP1: SUCCESS (1.295s)
[641.135051] Subtest bo-too-big-interruptible: SUCCESS (5.181s)
[642.327082] [122/132] (389s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[642.425183] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[642.429572] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[642.545817] [123/132] (389s left) kms_addfb_basic (invalid-get-prop-any)
[642.596586] Starting subtest: invalid-get-prop-any
[642.598530] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[642.767096] [124/132] (389s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[642.836173] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[642.935750] [125/132] (389s left) kms_chamelium_hpd (vga-hpd-fast)
[643.319902] Subtest vga-hpd-fast: SKIP (0.000s)
[644.180919] [126/132] (388s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[644.275126] Starting subtest: async-flip-with-page-flip-events-linear
[644.646507] Starting dynamic subtest: pipe-A-eDP-1
[647.443679] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.796s)
[647.807995] Starting dynamic subtest: pipe-B-eDP-1
[650.546939] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.747s)
[650.935713] Starting dynamic subtest: pipe-C-eDP-1
[653.742290] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.816s)
[654.110077] Starting dynamic subtest: pipe-D-eDP-1
[656.836179] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.733s)
[656.838692] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.563s)
[658.020348] [127/132] (374s left) gem_exec_fence (invalid-timeline-fence-array)
[658.679052] Starting subtest: invalid-timeline-fence-array
[658.685770] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[659.957722] [128/132] (372s left) kms_atomic_interruptible (universal-setplane-cursor)
[660.056739] Starting subtest: universal-setplane-cursor
[660.059034] Starting dynamic subtest: pipe-A-eDP-1
[667.476645] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s)
[667.478540] Subtest universal-setplane-cursor: SUCCESS (7.418s)
[668.323974] [129/132] (364s left) prime_vgem (basic-fence-read)
[668.407743] Starting subtest: basic-fence-read
[668.413815] Subtest basic-fence-read: SKIP (0.006s)
[668.548821] [130/132] (363s left) gem_eio (in-flight-suspend)
[668.770801] Starting subtest: in-flight-suspend
[711.240634] Subtest in-flight-suspend: SUCCESS (13.564s)
[721.424310] [131/132] (321s left) gem_exec_reloc (basic-wc-noreloc)
[721.500281] Subtest basic-wc-noreloc: SKIP (0.000s)
[721.575299] [132/132] (321s left) kms_properties (get_properties-sanity-non-atomic)
[721.669980] Starting subtest: get_properties-sanity-non-atomic
[721.672459] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[721.764676] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_exec_create
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: prime_busy
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: template
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_create
results: parsing output: 28/ for test: gem_reg_read
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: kms_dirtyfb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: kms_atomic
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_ctx_shared
results: parsing output: 38/ for test: kms_getfb
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_close_race
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: gem_exec_create
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_spin_batch
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: gem_exec_await
results: parsing output: 54/ for test: kms_psr2_su
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: kms_hdmi_inject
results: parsing output: 58/ for test: core_sysfs
results: parsing output: 59/ for test: kms_color
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_create
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_pwrite
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_plane_cursor
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_pm_lpsp
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_joiner
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: i915_power
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: i915_hangman
results: parsing output: 80/ for test: sysfs_preempt_timeout
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_feature_discovery
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: fbdev
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_exercise_blt
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: api_intel_allocator
results: parsing output: 111/ for test: i915_pm_rc6_residency
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_close
results: parsing output: 115/ for test: kms_selftest
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_fenced_exec_thrash
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_atomic_interruptible
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_properties
Done.