[61.149389] Initializing watchdogs
[61.149442]   /dev/watchdog0
[61.164419] [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]
[61.169007] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.172398] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.175872] [001/132] (960s left) perf_pmu (busy-accuracy-2)
[61.241861] Starting subtest: busy-accuracy-2
[61.244287] Starting dynamic subtest: rcs0
[64.299420] Dynamic subtest rcs0: SUCCESS (3.049s)
[64.309163] Starting dynamic subtest: bcs0
[67.406577] Dynamic subtest bcs0: SUCCESS (3.056s)
[67.416206] Starting dynamic subtest: vcs0
[70.460132] Dynamic subtest vcs0: SUCCESS (3.049s)
[70.468443] Starting dynamic subtest: vcs1
[73.509395] Dynamic subtest vcs1: SUCCESS (3.047s)
[73.518682] Starting dynamic subtest: vecs0
[76.556567] Dynamic subtest vecs0: SUCCESS (3.045s)
[76.565450] Starting dynamic subtest: ccs0
[79.568709] Dynamic subtest ccs0: SUCCESS (3.057s)
[79.570907] Subtest busy-accuracy-2: SUCCESS (18.310s)
[79.754568] [002/132] (941s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[79.872829] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[79.875105] Starting dynamic subtest: pipe-A-eDP-1
[79.898384] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.908641] Starting dynamic subtest: pipe-B-eDP-1
[79.930309] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.937591] Starting dynamic subtest: pipe-C-eDP-1
[79.959083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.966085] Starting dynamic subtest: pipe-D-eDP-1
[79.988732] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.992774] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[82.196480] [003/132] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[82.306952] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[82.311263] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[82.436178] [004/132] (939s left) gem_userptr_blits (process-exit-busy)
[82.506597] Starting subtest: process-exit-busy
[82.519646] Subtest process-exit-busy: SUCCESS (0.015s)
[82.657689] [005/132] (939s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[82.756080] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[82.768480] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[82.894928] [006/132] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[82.995781] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[83.000089] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[83.110476] [007/132] (938s left) gem_close_race (multigpu-basic-threads)
[83.170974] Starting subtest: multigpu-basic-threads
[83.174731] Subtest multigpu-basic-threads: SKIP (0.000s)
[83.451717] [008/132] (938s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[83.508941] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[83.617750] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[83.710626] [009/132] (938s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[83.816258] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[83.818493] Starting dynamic subtest: pipe-A-eDP-1
[83.840099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[83.849708] Starting dynamic subtest: pipe-B-eDP-1
[83.868657] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.875327] Starting dynamic subtest: pipe-C-eDP-1
[83.894607] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.901293] Starting dynamic subtest: pipe-D-eDP-1
[83.920291] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.922137] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[86.153044] [010/132] (935s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[86.258229] Starting subtest: plane-primary-overlay-mutable-zpos
[89.701178] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.441s)
[90.900915] [011/132] (931s left) gem_userptr_blits (forbidden-operations)
[90.981840] Starting subtest: forbidden-operations
[90.986125] Subtest forbidden-operations: SKIP (0.000s)
[91.156073] [012/132] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[91.264448] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[91.268609] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.381852] [013/132] (930s left) kms_flip (flip-vs-expired-vblank-interruptible)
[91.492545] Starting subtest: flip-vs-expired-vblank-interruptible
[91.494930] Starting dynamic subtest: A-eDP1
[100.216255] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[100.225759] Starting dynamic subtest: B-eDP1
[108.936173] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[108.947875] Starting dynamic subtest: C-eDP1
[117.574517] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[117.588510] Starting dynamic subtest: D-eDP1
[126.208878] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[126.211354] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.673s)
[127.374613] [014/132] (894s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[127.501177] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[127.505242] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[127.620493] [015/132] (894s left) gem_eio (unwedge-stress)
[127.814941] Starting subtest: unwedge-stress
[127.817257] Starting dynamic subtest: render
[132.233045] Dynamic subtest render: SUCCESS (4.415s)
[132.247296] Starting dynamic subtest: bsd1
[150.397319] Dynamic subtest bsd1: SUCCESS (18.160s)
[150.412576] Starting dynamic subtest: bsd2
[168.341425] Dynamic subtest bsd2: SUCCESS (17.943s)
[168.356675] Starting dynamic subtest: blt
[168.360997] Dynamic subtest blt: SKIP (0.000s)
[168.368676] Starting dynamic subtest: vebox
[186.327097] Dynamic subtest vebox: SUCCESS (17.983s)
[186.329586] Subtest unwedge-stress: SUCCESS (58.507s)
[187.988756] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[187.992236] [016/132] (834s left) dumb_buffer (map-invalid-size)
[188.054045] Starting subtest: map-invalid-size
[188.056484] Subtest map-invalid-size: SUCCESS (0.000s)
[188.184184] [017/132] (834s left) perf (missing-sample-flags)
[188.333857] Starting subtest: missing-sample-flags
[188.336103] Subtest missing-sample-flags: SUCCESS (0.000s)
[188.381584] [018/132] (833s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[188.494328] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[188.496530] Starting dynamic subtest: pipe-A
[188.878626] Dynamic subtest pipe-A: SUCCESS (0.384s)
[188.886738] Starting dynamic subtest: pipe-B
[190.322626] Dynamic subtest pipe-B: SUCCESS (1.444s)
[190.330741] Starting dynamic subtest: pipe-C
[191.778705] Dynamic subtest pipe-C: SUCCESS (1.455s)
[191.797319] Starting dynamic subtest: pipe-D
[193.221262] Dynamic subtest pipe-D: SUCCESS (1.442s)
[193.223582] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.727s)
[194.402463] [019/132] (828s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[194.503365] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[194.505738] Starting dynamic subtest: pipe-A-eDP-1
[194.531750] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.542109] Starting dynamic subtest: pipe-B-eDP-1
[194.565383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.573131] Starting dynamic subtest: pipe-C-eDP-1
[194.596611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.604051] Starting dynamic subtest: pipe-D-eDP-1
[194.627875] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.632163] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[196.750013] [020/132] (825s left) kms_dsc (dsc-with-formats)
[196.843854] Starting subtest: dsc-with-formats
[196.883587] Subtest dsc-with-formats: SKIP (0.001s)
[196.940655] [021/132] (825s left) syncobj_timeline (invalid-signal-illegal-point)
[196.989724] Starting subtest: invalid-signal-illegal-point
[196.992053] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[197.120049] [022/132] (825s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[197.175662] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[197.178053] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[197.318140] [023/132] (825s left) kms_addfb_basic (unused-offsets)
[197.378842] Starting subtest: unused-offsets
[197.380803] Subtest unused-offsets: SUCCESS (0.000s)
[197.523222] [024/132] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[197.637408] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[204.738253] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.105s)
[204.908915] [025/132] (817s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[205.026020] Starting subtest: 4-tiled-64bpp-rotate-0
[206.571085] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.545s)
[206.794617] [026/132] (815s left) gem_exec_balancer (parallel-contexts)
[207.047214] Starting subtest: parallel-contexts
[209.966794] Subtest parallel-contexts: SUCCESS (2.919s)
[211.087779] [027/132] (811s left) gem_softpin (reverse)
[211.153614] Starting subtest: reverse
[211.162749] Subtest reverse: SUCCESS (0.009s)
[211.329490] [028/132] (811s left) perf_pmu (init-wait)
[211.370700] Starting subtest: init-wait
[211.373048] Starting dynamic subtest: rcs0
[211.375790] Dynamic subtest rcs0: SUCCESS (0.002s)
[211.385889] Starting dynamic subtest: bcs0
[211.388040] Dynamic subtest bcs0: SUCCESS (0.000s)
[211.395822] Starting dynamic subtest: vcs0
[211.397633] Dynamic subtest vcs0: SUCCESS (0.001s)
[211.405095] Starting dynamic subtest: vcs1
[211.406946] Dynamic subtest vcs1: SUCCESS (0.001s)
[211.414470] Starting dynamic subtest: vecs0
[211.416335] Dynamic subtest vecs0: SUCCESS (0.000s)
[211.423775] Starting dynamic subtest: ccs0
[211.426039] Dynamic subtest ccs0: SUCCESS (0.000s)
[211.428210] Subtest init-wait: SUCCESS (0.006s)
[211.520781] [029/132] (811s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[211.634292] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[211.638482] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[211.769387] [030/132] (811s left) kms_color (ctm-0-75)
[211.857271] Starting subtest: ctm-0-75
[211.859441] Starting dynamic subtest: pipe-A-eDP-1
[216.781861] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.922s)
[216.791056] Starting dynamic subtest: pipe-B-eDP-1
[222.508116] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.726s)
[222.517339] Starting dynamic subtest: pipe-C-eDP-1
[227.872225] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.363s)
[227.881646] Starting dynamic subtest: pipe-D-eDP-1
[233.188825] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.315s)
[233.191127] Subtest ctm-0-75: SUCCESS (21.329s)
[234.036890] [031/132] (788s left) sysfs_heartbeat_interval (idempotent)
[234.103599] Starting subtest: idempotent
[234.105779] Starting dynamic subtest: vecs0
[234.108073] Dynamic subtest vecs0: SUCCESS (0.001s)
[234.116416] Starting dynamic subtest: ccs0
[234.118277] Dynamic subtest ccs0: SUCCESS (0.001s)
[234.125859] Starting dynamic subtest: vcs0
[234.127685] Dynamic subtest vcs0: SUCCESS (0.000s)
[234.135405] Starting dynamic subtest: bcs0
[234.137278] Dynamic subtest bcs0: SUCCESS (0.001s)
[234.144778] Starting dynamic subtest: rcs0
[234.146600] Dynamic subtest rcs0: SUCCESS (0.000s)
[234.154058] Starting dynamic subtest: vcs1
[234.156481] Dynamic subtest vcs1: SUCCESS (0.000s)
[234.158660] Subtest idempotent: SUCCESS (0.007s)
[234.241772] [032/132] (788s left) gem_ctx_shared (q-in-order)
[234.308202] Starting subtest: Q-in-order
[234.310636] Starting dynamic subtest: rcs0
[234.423551] Dynamic subtest rcs0: SUCCESS (0.113s)
[234.434723] Starting dynamic subtest: vcs0
[234.519935] Dynamic subtest vcs0: SUCCESS (0.097s)
[234.536515] Starting dynamic subtest: vcs1
[234.603480] Dynamic subtest vcs1: SUCCESS (0.083s)
[234.619326] Starting dynamic subtest: vecs0
[234.687453] Dynamic subtest vecs0: SUCCESS (0.083s)
[234.703618] Starting dynamic subtest: ccs0
[234.780957] Dynamic subtest ccs0: SUCCESS (0.092s)
[234.783535] Subtest Q-in-order: SUCCESS (0.472s)
[236.060673] [033/132] (786s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[236.164958] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[237.152382] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.989s)
[237.333298] [034/132] (785s left) gen9_exec_parse (batch-invalid-length)
[237.405499] Subtest batch-invalid-length: SKIP (0.000s)
[237.485317] [035/132] (785s left) gem_workarounds (suspend-resume-fd)
[237.551095] Starting subtest: suspend-resume-fd
[253.592391] Subtest suspend-resume-fd: SUCCESS (5.284s)
[260.764966] [036/132] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[260.903499] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[260.907832] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[261.043083] [037/132] (769s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[261.165068] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[261.819745] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[262.029347] [038/132] (768s left) gem_lmem_swapping (parallel-multi)
[262.075985] Subtest parallel-multi: SKIP (0.000s)
[262.116949] [039/132] (768s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[262.206003] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[262.208326] Starting dynamic subtest: pipe-A-eDP-1
[262.217743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.227894] Starting dynamic subtest: pipe-B-eDP-1
[262.237090] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.245801] Starting dynamic subtest: pipe-C-eDP-1
[262.254089] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.262778] Starting dynamic subtest: pipe-D-eDP-1
[262.271126] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.275295] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[264.391035] [040/132] (765s left) gem_eio (wait-1us)
[264.646022] Starting subtest: wait-1us
[265.058075] Subtest wait-1us: SUCCESS (0.409s)
[265.245486] [041/132] (765s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[265.365026] Starting subtest: cursorA-vs-flipB-atomic
[265.369544] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[265.536335] [042/132] (764s left) gem_userptr_blits (access-control)
[265.623781] Starting subtest: access-control
[265.628356] Subtest access-control: SKIP (0.000s)
[265.792880] [043/132] (764s left) prime_vgem (basic-fence-blt)
[265.871659] Starting subtest: basic-fence-blt
[265.947742] Subtest basic-fence-blt: SUCCESS (0.078s)
[266.107680] [044/132] (764s left) gem_exec_fence (submit-chain)
[266.300388] Starting subtest: submit-chain
[266.318061] Subtest submit-chain: SUCCESS (0.018s)
[267.810875] [045/132] (762s left) kms_pm_dc (dc6-psr)
[268.929685] Starting subtest: dc6-psr
[271.818215] Subtest dc6-psr: SUCCESS (2.876s)
[272.666652] [046/132] (757s left) i915_suspend (debugfs-reader)
[272.731234] Starting subtest: debugfs-reader
[291.589459] Subtest debugfs-reader: SUCCESS (3.561s)
[297.657615] [047/132] (738s left) gem_ctx_persistence (legacy-engines-cleanup)
[297.735156] Starting subtest: legacy-engines-cleanup
[297.737653] Starting dynamic subtest: render
[297.810095] Dynamic subtest render: SUCCESS (0.078s)
[297.822275] Starting dynamic subtest: bsd1
[297.902760] Dynamic subtest bsd1: SUCCESS (0.090s)
[297.914731] Starting dynamic subtest: bsd2
[297.953728] Dynamic subtest bsd2: SUCCESS (0.048s)
[297.968634] Starting dynamic subtest: blt
[297.982622] Dynamic subtest blt: SUCCESS (0.025s)
[297.998242] Starting dynamic subtest: vebox
[298.083256] Dynamic subtest vebox: SUCCESS (0.098s)
[298.086299] Subtest legacy-engines-cleanup: SUCCESS (0.349s)
[298.198347] [048/132] (738s left) core_getclient (basic)
[298.252458] Starting subtest: basic
[298.255204] Subtest basic: SUCCESS (0.000s)
[298.375367] [049/132] (738s left) gem_exec_whisper (basic-fds-priority-all)
[298.434799] Starting subtest: basic-fds-priority-all
[322.690869] Subtest basic-fds-priority-all: SUCCESS (24.167s)
[322.905775] [050/132] (713s left) gem_exec_schedule (preempt-queue-chain)
[322.994229] Subtest preempt-queue-chain: SKIP (0.000s)
[323.309662] [051/132] (713s left) kms_invalid_mode (zero-vdisplay)
[323.416430] Starting subtest: zero-vdisplay
[323.419201] Starting dynamic subtest: pipe-A-eDP-1
[323.701137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[323.711595] Starting dynamic subtest: pipe-B-eDP-1
[323.714039] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[323.723925] Starting dynamic subtest: pipe-C-eDP-1
[323.726455] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[323.736405] Starting dynamic subtest: pipe-D-eDP-1
[323.739448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[323.742592] Subtest zero-vdisplay: SUCCESS (0.294s)
[324.527652] [052/132] (712s left) gem_ctx_param (invalid-get-ringsize)
[324.588919] Starting subtest: invalid-get-ringsize
[324.591630] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[324.716843] [053/132] (712s left) kms_cursor_crc (cursor-onscreen-128x42)
[324.955969] Starting subtest: cursor-onscreen-128x42
[325.005024] Subtest cursor-onscreen-128x42: SKIP (0.044s)
[325.261335] [054/132] (711s left) gem_exec_async (forked-writes)
[325.336584] Starting subtest: forked-writes
[325.339240] Starting dynamic subtest: rcs0
[325.366335] Dynamic subtest rcs0: SUCCESS (0.029s)
[325.383506] Starting dynamic subtest: bcs0
[325.389180] Dynamic subtest bcs0: SUCCESS (0.021s)
[325.400108] Starting dynamic subtest: vcs0
[325.411432] Dynamic subtest vcs0: SUCCESS (0.022s)
[325.422548] Starting dynamic subtest: vcs1
[325.433878] Dynamic subtest vcs1: SUCCESS (0.022s)
[325.443544] Starting dynamic subtest: vecs0
[325.455997] Dynamic subtest vecs0: SUCCESS (0.021s)
[325.466291] Starting dynamic subtest: ccs0
[325.479846] Dynamic subtest ccs0: SUCCESS (0.023s)
[325.481896] Subtest forked-writes: SUCCESS (0.144s)
[325.749150] [055/132] (711s left) kms_pm_rpm (universal-planes)
[327.275431] Starting subtest: universal-planes
[327.278177] Starting dynamic subtest: plane-33
[335.604871] Dynamic subtest plane-33: SUCCESS (8.331s)
[335.619208] Starting dynamic subtest: plane-63
[343.907374] Dynamic subtest plane-63: SUCCESS (8.301s)
[343.919428] Starting dynamic subtest: plane-93
[352.197323] Dynamic subtest plane-93: SUCCESS (8.286s)
[352.210277] Starting dynamic subtest: plane-123
[360.813435] Dynamic subtest plane-123: SUCCESS (8.612s)
[360.825941] Starting dynamic subtest: plane-133
[369.414773] Dynamic subtest plane-133: SUCCESS (8.597s)
[369.431595] Starting dynamic subtest: plane-143
[378.012670] Dynamic subtest plane-143: SUCCESS (8.591s)
[378.015603] Subtest universal-planes: SUCCESS (50.736s)
[378.400462] [056/132] (658s left) kms_lease (lease-unleased-crtc)
[378.495058] Starting subtest: lease-unleased-crtc
[378.497643] Starting dynamic subtest: pipe-A-eDP-1
[378.781805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[378.793459] Starting dynamic subtest: pipe-B-eDP-1
[379.524561] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.740s)
[379.539703] Starting dynamic subtest: pipe-C-eDP-1
[379.541971] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[379.556346] Starting dynamic subtest: pipe-D-eDP-1
[379.558718] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[379.561063] Subtest lease-unleased-crtc: SUCCESS (1.043s)
[379.921748] [057/132] (657s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[380.049899] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[380.863627] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.815s)
[381.085755] [058/132] (655s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[381.147419] Starting subtest: wait-all-for-submit-delayed-submit
[381.248409] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[381.360816] [059/132] (655s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[386.375281] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[386.378112] Starting dynamic subtest: pipe-A-eDP-1
[387.170669] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[387.180411] Starting dynamic subtest: pipe-B-eDP-1
[388.303663] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[388.309072] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.924s)
[389.531598] [060/132] (647s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[389.641307] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[389.646451] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[389.771228] [061/132] (647s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[389.873431] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[389.878230] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[389.992837] [062/132] (647s left) gem_mmap (bad-offset)
[390.051262] Subtest bad-offset: SKIP (0.000s)
[390.108517] [063/132] (647s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[390.206429] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[390.211811] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[390.318322] [064/132] (647s left) kms_chamelium_color (ctm-0-25)
[390.435820] Subtest ctm-0-25: SKIP (0.000s)
[390.481829] [065/132] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[390.577438] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[390.581308] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[390.710582] [066/132] (646s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[390.809013] Starting subtest: psr-2p-primscrn-cur-indfb-move
[390.813340] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[390.933267] [067/132] (646s left) gem_softpin (noreloc-s3)
[390.999834] Starting subtest: noreloc-S3
[411.354788] Subtest noreloc-S3: SUCCESS (5.431s)
[418.595219] [068/132] (625s left) gem_exec_schedule (thriceslice)
[418.687657] Starting subtest: thriceslice
[418.690048] Starting dynamic subtest: rcs0
[418.711754] Dynamic subtest rcs0: SUCCESS (0.033s)
[418.723932] Starting dynamic subtest: bcs0
[418.769037] Dynamic subtest bcs0: SUCCESS (0.055s)
[418.780650] Starting dynamic subtest: vcs0
[418.803135] Dynamic subtest vcs0: SUCCESS (0.032s)
[418.812769] Starting dynamic subtest: vcs1
[418.833274] Dynamic subtest vcs1: SUCCESS (0.029s)
[418.842596] Starting dynamic subtest: vecs0
[418.864036] Dynamic subtest vecs0: SUCCESS (0.030s)
[418.873443] Starting dynamic subtest: ccs0
[418.921791] Dynamic subtest ccs0: SUCCESS (0.056s)
[418.924219] Subtest thriceslice: SUCCESS (0.241s)
[419.248354] [069/132] (625s left) sriov_basic (enable-vfs-autoprobe-on)
[419.320509] Starting subtest: enable-vfs-autoprobe-on
[419.322965] Starting dynamic subtest: numvfs-1
[419.400473] Dynamic subtest numvfs-1: FAIL (0.031s)
[419.410770] Starting dynamic subtest: numvfs-2
[419.484553] Dynamic subtest numvfs-2: FAIL (0.004s)
[419.495700] Starting dynamic subtest: numvfs-3
[419.570280] Dynamic subtest numvfs-3: FAIL (0.003s)
[419.581317] Starting dynamic subtest: numvfs-4
[419.655234] Dynamic subtest numvfs-4: FAIL (0.003s)
[419.666312] Starting dynamic subtest: numvfs-5
[419.741118] Dynamic subtest numvfs-5: FAIL (0.003s)
[419.752021] Starting dynamic subtest: numvfs-6
[419.825500] Dynamic subtest numvfs-6: FAIL (0.003s)
[419.836038] Starting dynamic subtest: numvfs-7
[419.909676] Dynamic subtest numvfs-7: FAIL (0.003s)
[419.918935] Starting dynamic subtest: numvfs-random
[419.991351] Dynamic subtest numvfs-random: FAIL (0.004s)
[420.002292] Starting dynamic subtest: numvfs-all
[420.076048] Dynamic subtest numvfs-all: FAIL (0.515s)
[420.078098] Subtest enable-vfs-autoprobe-on: FAIL (0.577s)
[420.119493] [070/132] (624s left) api_intel_bb (blit-noreloc-purge-cache)
[420.182496] Starting subtest: blit-noreloc-purge-cache
[420.191006] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[420.358801] [071/132] (624s left) kms_hdr (bpc-switch-dpms)
[420.458053] Starting subtest: bpc-switch-dpms
[421.567440] Starting dynamic subtest: pipe-A-eDP-1
[426.132813] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.533s)
[426.135087] Subtest bpc-switch-dpms: SUCCESS (5.630s)
[426.292570] [072/132] (618s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[426.406842] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[426.411283] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[426.546303] [073/132] (618s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[426.607435] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[426.681837] [074/132] (618s left) perf_pmu (rc6)
[426.715344] Starting subtest: rc6
[426.717514] Starting dynamic subtest: gt0
[433.172893] Dynamic subtest gt0: SUCCESS (6.381s)
[433.184750] Starting dynamic subtest: runtime-pm-gt0
[440.864133] Dynamic subtest runtime-pm-gt0: SUCCESS (7.729s)
[440.876562] Starting dynamic subtest: runtime-pm-long-gt0
[453.313498] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.439s)
[453.326055] Starting dynamic subtest: other-idle-gt0
[459.657311] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[459.667540] Starting dynamic subtest: gt1
[465.999136] Dynamic subtest gt1: SUCCESS (6.338s)
[466.011526] Starting dynamic subtest: runtime-pm-gt1
[473.438276] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s)
[473.450584] Starting dynamic subtest: runtime-pm-long-gt1
[485.862571] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.419s)
[485.874986] Starting dynamic subtest: other-idle-gt1
[492.258112] Dynamic subtest other-idle-gt1: SUCCESS (6.339s)
[492.260731] Subtest rc6: SUCCESS (65.443s)
[493.330432] [075/132] (551s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[493.432928] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[493.434976] Starting dynamic subtest: pipe-A-default-mode
[493.729371] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[493.734133] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.294s)
[494.618532] [076/132] (550s left) intel_hwmon (hwmon-read)
[494.671410] Subtest hwmon-read: SKIP (0.000s)
[494.747042] [077/132] (550s left) gem_sync (basic-many-each)
[494.827617] Starting subtest: basic-many-each
[497.151688] Subtest basic-many-each: SUCCESS (2.323s)
[497.307154] [078/132] (547s left) gen9_exec_parse (unaligned-access)
[497.372703] Subtest unaligned-access: SKIP (0.000s)
[497.466925] [079/132] (547s left) kms_flip (bo-too-big-interruptible)
[497.562288] Starting subtest: bo-too-big-interruptible
[497.564644] Starting dynamic subtest: A-eDP1
[498.861061] Dynamic subtest A-eDP1: SUCCESS (1.297s)
[498.871778] Starting dynamic subtest: B-eDP1
[500.085420] Dynamic subtest B-eDP1: SUCCESS (1.222s)
[500.096415] Starting dynamic subtest: C-eDP1
[501.318417] Dynamic subtest C-eDP1: SUCCESS (1.231s)
[501.331101] Starting dynamic subtest: D-eDP1
[502.541193] Dynamic subtest D-eDP1: SUCCESS (1.221s)
[502.547237] Subtest bo-too-big-interruptible: SUCCESS (4.982s)
[503.721395] [080/132] (541s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[503.821470] Starting subtest: stress-xrgb8888-yftiled
[503.825877] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[503.927387] [081/132] (541s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[503.991546] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[504.097464] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[504.150570] [082/132] (541s left) syncobj_wait (wait-for-submit-delayed-submit)
[504.203486] Starting subtest: wait-for-submit-delayed-submit
[504.306910] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[504.363907] [083/132] (540s left) i915_pm_rc6_residency (rc6-accuracy)
[504.423669] Starting subtest: rc6-accuracy
[504.425501] Starting dynamic subtest: gt0
[507.595874] Dynamic subtest gt0: SUCCESS (3.168s)
[507.606092] Starting dynamic subtest: gt1
[510.821134] Dynamic subtest gt1: SUCCESS (3.168s)
[510.823478] Subtest rc6-accuracy: SUCCESS (6.342s)
[510.863245] [084/132] (534s left) kms_properties (connector-properties-legacy)
[510.952754] Starting subtest: connector-properties-legacy
[510.954937] Starting dynamic subtest: pipe-A-eDP-1
[518.827024] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.875s)
[518.838477] Starting dynamic subtest: pipe-None-DP-1
[518.842930] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[518.851872] Starting dynamic subtest: pipe-None-HDMI-A-1
[518.856095] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[518.865255] Starting dynamic subtest: pipe-None-DP-2
[518.869311] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[518.879717] Starting dynamic subtest: pipe-None-HDMI-A-2
[518.883684] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[518.893011] Starting dynamic subtest: pipe-None-DP-3
[518.897468] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[518.906803] Starting dynamic subtest: pipe-None-DP-4
[518.911216] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[518.913458] Subtest connector-properties-legacy: SUCCESS (7.887s)
[519.683240] [085/132] (525s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[519.790848] Starting subtest: cursorB-vs-flipB-toggle
[519.795346] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[519.915539] [086/132] (525s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[524.887343] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[524.891806] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[525.702531] [087/132] (519s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[530.726392] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[530.730738] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s)
[531.550184] [088/132] (513s left) gem_mmap_gtt (basic-small-bo-tiledx)
[531.614621] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[531.686760] [089/132] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[531.796534] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[531.800502] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[531.886212] [090/132] (513s left) i915_hangman (gt-error-state-capture)
[531.947615] Starting subtest: gt-error-state-capture
[531.949465] Starting dynamic subtest: rcs0
[543.868040] Dynamic subtest rcs0: SUCCESS (11.921s)
[543.879992] Starting dynamic subtest: bcs0
[555.836498] Dynamic subtest bcs0: SUCCESS (11.965s)
[555.853032] Starting dynamic subtest: vcs0
[567.803995] Dynamic subtest vcs0: SUCCESS (11.964s)
[567.817449] Starting dynamic subtest: vcs1
[579.771875] Dynamic subtest vcs1: SUCCESS (11.963s)
[579.784500] Starting dynamic subtest: vecs0
[590.895285] Dynamic subtest vecs0: SUCCESS (11.067s)
[590.907488] Starting dynamic subtest: ccs0
[602.812355] Dynamic subtest ccs0: SUCCESS (11.962s)
[602.815303] Subtest gt-error-state-capture: SUCCESS (70.856s)
[602.874902] [091/132] (442s left) kms_psr (psr2-sprite-mmap-cpu)
[602.975125] Starting subtest: psr2-sprite-mmap-cpu
[602.977472] Starting dynamic subtest: eDP-1
[604.655145] Dynamic subtest eDP-1: SUCCESS (1.679s)
[604.657427] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.680s)
[605.514455] [092/132] (440s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[605.898714] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[606.746346] [093/132] (438s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[606.843993] Starting subtest: fbcpsr-slowdraw
[632.080439] Subtest fbcpsr-slowdraw: SUCCESS (25.233s)
[632.231900] [094/132] (413s left) kms_cursor_crc (cursor-sliding-128x128)
[632.465603] Starting subtest: cursor-sliding-128x128
[632.470389] Starting dynamic subtest: pipe-A-eDP-1
[635.804340] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.334s)
[635.847877] Starting dynamic subtest: pipe-D-eDP-1
[639.715690] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.875s)
[639.718496] Subtest cursor-sliding-128x128: SUCCESS (7.246s)
[640.552324] [095/132] (405s left) kms_content_protection (legacy)
[640.705729] Starting subtest: legacy
[640.710170] Subtest legacy: SKIP (0.000s)
[640.832652] [096/132] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[640.940161] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[640.944382] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[641.009209] [097/132] (404s left) kms_universal_plane (universal-plane-pageflip-windowed)
[641.104518] Starting subtest: universal-plane-pageflip-windowed
[641.106632] Starting dynamic subtest: pipe-A-eDP-1
[641.700265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s)
[641.710550] Starting dynamic subtest: pipe-B-eDP-1
[642.908135] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[642.918523] Starting dynamic subtest: pipe-C-eDP-1
[644.118358] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[644.127982] Starting dynamic subtest: pipe-D-eDP-1
[645.338180] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[645.340566] Subtest universal-plane-pageflip-windowed: SUCCESS (4.235s)
[646.168068] [098/132] (399s left) kms_psr (fbc-psr-primary-mmap-cpu)
[646.259311] Starting subtest: fbc-psr-primary-mmap-cpu
[646.261643] Starting dynamic subtest: eDP-1
[646.266111] Dynamic subtest eDP-1: SKIP (0.000s)
[646.270573] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[646.310470] [099/132] (399s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[646.410077] Starting subtest: fbc-pr-sprite-mmap-gtt
[646.414104] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[646.458902] [100/132] (399s left) gem_mmap (basic)
[646.518119] Subtest basic: SKIP (0.000s)
[646.603722] [101/132] (399s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[646.682321] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[646.778697] [102/132] (399s left) syncobj_wait (signal)
[646.842232] Starting subtest: signal
[646.844468] Subtest signal: SUCCESS (0.000s)
[646.919994] [103/132] (399s left) vgem_basic (bad-flag)
[646.969993] Starting subtest: bad-flag
[646.972320] Subtest bad-flag: SUCCESS (0.000s)
[647.013914] [104/132] (399s left) kms_plane (plane-position-hole)
[647.108224] Starting subtest: plane-position-hole
[647.616856] Starting dynamic subtest: pipe-A-plane-1
[648.884959] Dynamic subtest pipe-A-plane-1: SUCCESS (1.266s)
[648.896045] Starting dynamic subtest: pipe-A-plane-2
[650.190662] Dynamic subtest pipe-A-plane-2: SUCCESS (1.305s)
[650.201347] Starting dynamic subtest: pipe-A-plane-3
[651.517010] Dynamic subtest pipe-A-plane-3: SUCCESS (1.328s)
[651.528578] Starting dynamic subtest: pipe-A-plane-4
[652.845608] Dynamic subtest pipe-A-plane-4: SUCCESS (1.328s)
[652.856956] Starting dynamic subtest: pipe-A-plane-5
[652.871617] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[654.102732] Starting dynamic subtest: pipe-B-plane-1
[655.414787] Dynamic subtest pipe-B-plane-1: SUCCESS (1.320s)
[655.425070] Starting dynamic subtest: pipe-B-plane-2
[656.728643] Dynamic subtest pipe-B-plane-2: SUCCESS (1.313s)
[656.739008] Starting dynamic subtest: pipe-B-plane-3
[657.982134] Dynamic subtest pipe-B-plane-3: SUCCESS (1.257s)
[657.993049] Starting dynamic subtest: pipe-B-plane-4
[659.296156] Dynamic subtest pipe-B-plane-4: SUCCESS (1.313s)
[659.307084] Starting dynamic subtest: pipe-B-plane-5
[659.323607] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[659.326090] Subtest plane-position-hole: SUCCESS (12.219s)
[660.153618] [105/132] (386s left) kms_fbcon_fbt (psr)
[660.221375] Starting subtest: psr
[667.516924] Subtest psr: SUCCESS (7.294s)
[667.598244] [106/132] (378s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[667.697011] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[667.699460] Starting dynamic subtest: A-eDP1
[676.566575] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[676.577391] Starting dynamic subtest: B-eDP1
[685.489670] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[685.500738] Starting dynamic subtest: C-eDP1
[694.453384] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[694.463552] Starting dynamic subtest: D-eDP1
[703.398131] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[703.400206] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.653s)
[704.557491] [107/132] (341s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[704.666401] Starting subtest: fbcpsr-1p-rte
[711.681092] Subtest fbcpsr-1p-rte: SUCCESS (7.017s)
[711.830033] [108/132] (334s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[711.945592] Starting subtest: protected-encrypted-src-copy-not-readible
[712.055122] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[712.175946] [109/132] (334s left) kms_psr (fbc-psr-suspend)
[712.275888] Starting subtest: fbc-psr-suspend
[712.278158] Starting dynamic subtest: eDP-1
[712.282419] Dynamic subtest eDP-1: SKIP (0.000s)
[712.286730] Subtest fbc-psr-suspend: SKIP (0.001s)
[712.326856] [110/132] (334s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[712.439144] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[719.273969] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.839s)
[719.402189] [111/132] (327s left) kms_flip (basic-flip-vs-dpms)
[719.505913] Starting subtest: basic-flip-vs-dpms
[719.507946] Starting dynamic subtest: A-eDP1
[722.148627] Dynamic subtest A-eDP1: SUCCESS (2.642s)
[722.159271] Starting dynamic subtest: B-eDP1
[724.325402] Dynamic subtest B-eDP1: SUCCESS (2.174s)
[724.335729] Starting dynamic subtest: C-eDP1
[726.390474] Dynamic subtest C-eDP1: SUCCESS (2.067s)
[726.400939] Starting dynamic subtest: D-eDP1
[728.447063] Dynamic subtest D-eDP1: SUCCESS (2.056s)
[728.449489] Subtest basic-flip-vs-dpms: SUCCESS (8.948s)
[729.232763] [112/132] (317s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[729.359304] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[729.363912] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[729.479140] [113/132] (317s left) perf (oa-formats)
[729.547803] Starting subtest: oa-formats
[729.550171] Starting dynamic subtest: 0-rcs0
[729.564075] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[729.575146] Starting dynamic subtest: 1-vecs0
[729.586857] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[729.589195] Subtest oa-formats: SUCCESS (0.040s)
[729.639570] [114/132] (316s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[729.737909] Starting subtest: plane-lut1d-ctm3x4
[729.751118] Starting dynamic subtest: pipe-A-eDP-1
[730.397495] Dynamic subtest pipe-A-eDP-1: FAIL (0.294s)
[731.126932] Starting dynamic subtest: pipe-B-eDP-1
[731.945916] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[732.456107] Starting dynamic subtest: pipe-C-eDP-1
[733.292408] Dynamic subtest pipe-C-eDP-1: FAIL (0.260s)
[733.792607] Starting dynamic subtest: pipe-D-eDP-1
[734.646341] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[734.648362] Subtest plane-lut1d-ctm3x4: FAIL (4.605s)
[735.189623] [115/132] (311s left) kms_psr (psr-cursor-mmap-gtt)
[735.323900] Starting subtest: psr-cursor-mmap-gtt
[735.326240] Starting dynamic subtest: eDP-1
[737.053459] Dynamic subtest eDP-1: SUCCESS (1.728s)
[737.055586] Subtest psr-cursor-mmap-gtt: SUCCESS (1.730s)
[737.914984] [116/132] (308s left) gem_ctx_param (invalid-size-set)
[737.975874] Starting subtest: invalid-size-set
[737.978244] Subtest invalid-size-set: SUCCESS (0.001s)
[738.069845] [117/132] (308s left) gem_mmap_offset (close-race)
[738.132923] Starting subtest: close-race
[758.231289] Subtest close-race: SUCCESS (20.096s)
[758.318092] [118/132] (288s left) kms_dirtyfb (default-dirtyfb-ioctl)
[758.417013] Starting subtest: default-dirtyfb-ioctl
[758.418950] Starting dynamic subtest: A-eDP-1
[759.994891] Dynamic subtest A-eDP-1: SUCCESS (1.578s)
[759.997227] Subtest default-dirtyfb-ioctl: SUCCESS (1.580s)
[760.843851] [119/132] (285s left) gem_wait (write-wait)
[760.915118] Starting subtest: write-wait
[760.917444] Starting dynamic subtest: all-engines
[762.051062] Dynamic subtest all-engines: SUCCESS (1.136s)
[762.069911] Starting dynamic subtest: rcs0
[763.112477] Dynamic subtest rcs0: SUCCESS (1.059s)
[763.129636] Starting dynamic subtest: bcs0
[764.174140] Dynamic subtest bcs0: SUCCESS (1.059s)
[764.192833] Starting dynamic subtest: vcs0
[765.228177] Dynamic subtest vcs0: SUCCESS (1.052s)
[765.245753] Starting dynamic subtest: vcs1
[766.281803] Dynamic subtest vcs1: SUCCESS (1.051s)
[766.299783] Starting dynamic subtest: vecs0
[767.335019] Dynamic subtest vecs0: SUCCESS (1.051s)
[767.353126] Starting dynamic subtest: ccs0
[768.392121] Dynamic subtest ccs0: SUCCESS (1.055s)
[768.394675] Subtest write-wait: SUCCESS (7.477s)
[768.566559] [120/132] (278s left) i915_query (query-topology-matches-eu-total)
[768.615940] Starting subtest: query-topology-matches-eu-total
[768.617918] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[768.712408] [121/132] (278s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[768.812894] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[768.815130] Starting dynamic subtest: pipe-A-default-mode
[769.114642] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[769.119350] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.299s)
[769.892661] [122/132] (277s left) gem_exec_params (invalid-bsd-ring)
[769.956768] Starting subtest: invalid-bsd-ring
[769.959206] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[770.037328] [123/132] (276s left) kms_frontbuffer_tracking (psr-slowdraw)
[770.148329] Starting subtest: psr-slowdraw
[795.312122] Subtest psr-slowdraw: SUCCESS (25.162s)
[795.414242] [124/132] (251s left) gem_caching (reads)
[795.486895] Subtest reads: SKIP (0.000s)
[795.574550] [125/132] (251s left) gem_userptr_blits (invalid-null-pointer)
[795.636280] Starting subtest: invalid-null-pointer
[795.638232] Subtest invalid-null-pointer: SUCCESS (0.001s)
[795.749715] [126/132] (251s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[795.846514] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[800.117867] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.274s)
[801.218425] [127/132] (245s left) gem_render_copy (yf-tiled-to-vebox-linear)
[801.286709] Starting subtest: yf-tiled-to-vebox-linear
[801.291413] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[801.449568] [128/132] (245s left) gem_exec_reloc (basic-scanout)
[801.511095] Subtest basic-scanout: SKIP (0.000s)
[801.589388] [129/132] (245s left) kms_vblank (ts-continuation-idle-hang)
[801.683770] Starting subtest: ts-continuation-idle-hang
[801.685681] Starting dynamic subtest: pipe-A-eDP-1
[828.637886] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.946s)
[828.655380] Starting dynamic subtest: pipe-D-eDP-1
[853.669498] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[853.671439] Subtest ts-continuation-idle-hang: SUCCESS (51.975s)
[854.492951] [130/132] (192s left) syncobj_wait (invalid-wait-bad-flags)
[854.544585] Starting subtest: invalid-wait-bad-flags
[854.546870] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[854.626390] [131/132] (192s left) dmabuf_sync_file (export-basic)
[854.673435] Starting subtest: export-basic
[854.675348] Subtest export-basic: SUCCESS (0.001s)
[854.713640] [132/132] (192s left) gem_pread (bench)
[854.774814] Subtest bench: SKIP (0.000s)
[854.845118] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_close_race
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_atomic
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: dumb_buffer
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_dsc
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_workarounds
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_pm_dc
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_invalid_mode
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_exec_async
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: sriov_basic
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_hdr
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: intel_hwmon
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_pipe_stress
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: i915_pm_rc6_residency
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_chamelium_edid
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_universal_plane
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_mmap
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_fbcon_fbt
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: kms_dirtyfb
results: parsing output: 118/ for test: gem_wait
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: dmabuf_sync_file
results: parsing output: 131/ for test: gem_pread
Done.