[58.618577] Initializing watchdogs
[58.618663]   /dev/watchdog0
[58.633743] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.638349] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.640586] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.644052] [001/133] (960s left) kms_fb_coherency (memset-crc)
[58.792253] Starting subtest: memset-crc
[58.794442] Starting dynamic subtest: mmap-offset-wc
[59.256372] Dynamic subtest mmap-offset-wc: SUCCESS (0.460s)
[59.552354] Starting dynamic subtest: mmap-offset-uc
[65.780079] Dynamic subtest mmap-offset-uc: SUCCESS (6.214s)
[66.071569] Subtest memset-crc: SUCCESS (7.253s)
[66.866489] [002/133] (952s left) gem_exec_reloc (basic-write-wc)
[67.118910] Subtest basic-write-wc: SKIP (0.000s)
[67.416068] [003/133] (951s left) gem_exec_params (invalid-bsd2-flag-on-render)
[67.559833] Starting subtest: invalid-bsd2-flag-on-render
[67.561854] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[67.737138] [004/133] (951s left) gem_render_copy (linear)
[67.839882] Starting subtest: linear
[67.841847] Starting dynamic subtest: smem
[67.882064] Dynamic subtest smem: SUCCESS (0.044s)
[67.884603] Subtest linear: SUCCESS (0.045s)
[68.173702] [005/133] (951s left) core_auth (basic-auth)
[68.239057] Starting subtest: basic-auth
[68.241343] Subtest basic-auth: SUCCESS (0.001s)
[68.337223] [006/133] (951s left) kms_flip (flip-vs-modeset-vs-hang)
[68.433527] Starting subtest: flip-vs-modeset-vs-hang
[68.435749] Starting dynamic subtest: A-eDP1
[119.406131] Dynamic subtest A-eDP1: SUCCESS (50.957s)
[119.416305] Starting dynamic subtest: D-eDP1
[169.391081] Dynamic subtest D-eDP1: SUCCESS (49.983s)
[169.393889] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.945s)
[169.783069] [007/133] (849s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[169.872400] Starting subtest: plane-primary-toggle-with-vblank-wait
[169.874850] Starting dynamic subtest: pipe-A-eDP-1
[170.046496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[170.362379] Starting dynamic subtest: pipe-B-eDP-1
[171.288182] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.932s)
[171.585043] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.713s)
[172.435923] [008/133] (847s left) kms_frontbuffer_tracking (fbc-1p-rte)
[172.550376] Starting subtest: fbc-1p-rte
[178.012068] Subtest fbc-1p-rte: SUCCESS (5.465s)
[179.143972] [009/133] (840s left) prime_vgem (basic-fence-flip)
[179.249949] Starting subtest: basic-fence-flip
[179.539889] Subtest basic-fence-flip: SUCCESS (0.290s)
[179.652178] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[179.655187] [010/133] (839s left) gem_ctx_shared (q-independent)
[179.714819] Starting subtest: Q-independent
[179.717159] Starting dynamic subtest: rcs0
[179.780723] Dynamic subtest rcs0: SUCCESS (0.065s)
[179.794650] Starting dynamic subtest: vcs0
[179.825143] Dynamic subtest vcs0: SUCCESS (0.044s)
[179.834363] Starting dynamic subtest: vcs1
[179.861605] Dynamic subtest vcs1: SUCCESS (0.036s)
[179.868921] Starting dynamic subtest: vecs0
[179.897633] Dynamic subtest vecs0: SUCCESS (0.036s)
[179.908704] Starting dynamic subtest: ccs0
[179.947403] Dynamic subtest ccs0: SUCCESS (0.049s)
[179.949775] Subtest Q-independent: SUCCESS (0.233s)
[180.993374] [011/133] (838s left) kms_color_pipeline (plane-lut1d)
[181.101147] Starting subtest: plane-lut1d
[181.244627] Starting dynamic subtest: pipe-A-plane-0
[181.411559] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[181.420745] Starting dynamic subtest: pipe-A-plane-1
[181.566840] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[181.579108] Starting dynamic subtest: pipe-A-plane-2
[181.722339] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[182.945080] Starting dynamic subtest: pipe-B-plane-0
[183.103256] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[183.111133] Starting dynamic subtest: pipe-B-plane-1
[183.270047] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[183.281428] Starting dynamic subtest: pipe-B-plane-2
[183.436508] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s)
[184.668495] Starting dynamic subtest: pipe-C-plane-0
[184.795292] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[184.804547] Starting dynamic subtest: pipe-C-plane-1
[184.928592] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[184.937306] Starting dynamic subtest: pipe-C-plane-2
[185.073957] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[186.300696] Starting dynamic subtest: pipe-D-plane-0
[186.460630] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[186.469570] Starting dynamic subtest: pipe-D-plane-1
[186.616128] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[186.625305] Starting dynamic subtest: pipe-D-plane-2
[186.782701] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[187.069780] Subtest plane-lut1d: SUCCESS (5.971s)
[187.884953] [012/133] (831s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[187.958366] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[188.023845] [013/133] (831s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[188.115328] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[188.117257] Starting dynamic subtest: pipe-A-eDP-1
[188.262085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[188.272299] Starting dynamic subtest: pipe-B-eDP-1
[188.291308] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[188.299214] Starting dynamic subtest: pipe-C-eDP-1
[188.318679] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[188.325799] Starting dynamic subtest: pipe-D-eDP-1
[188.345218] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[188.347190] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.146s)
[190.549504] [014/133] (829s left) kms_psr (pr-sprite-plane-move)
[190.641071] Starting subtest: pr-sprite-plane-move
[190.645475] Subtest pr-sprite-plane-move: SKIP (0.000s)
[190.726234] [015/133] (829s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[190.818208] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[190.820465] Starting dynamic subtest: pipe-A-eDP-1
[190.878678] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[190.887634] Starting dynamic subtest: pipe-B-eDP-1
[190.945800] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[190.955133] Starting dynamic subtest: pipe-C-eDP-1
[191.012251] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[191.021425] Starting dynamic subtest: pipe-D-eDP-1
[191.079754] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[191.084237] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[193.093178] [016/133] (826s left) gem_mmap_gtt (basic-small-copy-xy)
[193.156573] Subtest basic-small-copy-XY: SKIP (0.000s)
[193.209284] [017/133] (826s left) gem_ctx_persistence (saturated-hostile)
[193.260828] Starting subtest: saturated-hostile
[193.263246] Starting dynamic subtest: rcs0
[194.071459] Dynamic subtest rcs0: SUCCESS (0.810s)
[194.080365] Starting dynamic subtest: bcs0
[194.859259] Dynamic subtest bcs0: SUCCESS (0.787s)
[194.870128] Starting dynamic subtest: vcs0
[195.644454] Dynamic subtest vcs0: SUCCESS (0.783s)
[195.655037] Starting dynamic subtest: vcs1
[196.447461] Dynamic subtest vcs1: SUCCESS (0.802s)
[196.458608] Starting dynamic subtest: vecs0
[197.249071] Dynamic subtest vecs0: SUCCESS (0.800s)
[197.260140] Starting dynamic subtest: ccs0
[198.074065] Dynamic subtest ccs0: SUCCESS (0.824s)
[198.076848] Subtest saturated-hostile: SUCCESS (4.813s)
[198.167276] [018/133] (821s left) kms_getfb (getfb2-handle-protection)
[198.266880] Starting subtest: getfb2-handle-protection
[198.280283] Subtest getfb2-handle-protection: SUCCESS (0.014s)
[198.400806] [019/133] (821s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[198.500687] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[198.504671] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[198.602917] [020/133] (821s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[198.692049] Starting subtest: async-flip-with-page-flip-events-tiled
[199.078788] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[201.878487] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[201.889443] Starting dynamic subtest: pipe-A-eDP-1-4
[204.051083] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[204.062644] Starting dynamic subtest: pipe-A-eDP-1-4
[206.061111] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[206.068775] Starting dynamic subtest: pipe-A-eDP-1-x
[208.240071] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[208.607619] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[211.407037] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[211.417117] Starting dynamic subtest: pipe-B-eDP-1-4
[213.593614] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[213.601526] Starting dynamic subtest: pipe-B-eDP-1-4
[215.602798] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[215.610809] Starting dynamic subtest: pipe-B-eDP-1-x
[217.781482] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[218.175226] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[220.938892] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.769s)
[220.950110] Starting dynamic subtest: pipe-C-eDP-1-4
[223.113087] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[223.120945] Starting dynamic subtest: pipe-C-eDP-1-4
[225.123950] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[225.131843] Starting dynamic subtest: pipe-C-eDP-1-x
[227.314115] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[227.684734] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[230.479081] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[230.489755] Starting dynamic subtest: pipe-D-eDP-1-4
[232.651715] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[232.659931] Starting dynamic subtest: pipe-D-eDP-1-4
[234.661780] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[234.669591] Starting dynamic subtest: pipe-D-eDP-1-x
[236.840480] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[236.842978] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.147s)
[238.080065] [021/133] (781s left) perf_pmu (semaphore-wait-idle)
[238.131156] Starting subtest: semaphore-wait-idle
[238.133112] Starting dynamic subtest: rcs0
[238.643818] Dynamic subtest rcs0: SUCCESS (0.513s)
[238.653759] Starting dynamic subtest: bcs0
[239.157739] Dynamic subtest bcs0: SUCCESS (0.511s)
[239.167540] Starting dynamic subtest: vcs0
[239.671056] Dynamic subtest vcs0: SUCCESS (0.511s)
[239.681080] Starting dynamic subtest: vcs1
[240.184759] Dynamic subtest vcs1: SUCCESS (0.511s)
[240.195260] Starting dynamic subtest: vecs0
[240.698796] Dynamic subtest vecs0: SUCCESS (0.513s)
[240.709635] Starting dynamic subtest: ccs0
[241.214296] Dynamic subtest ccs0: SUCCESS (0.514s)
[241.217212] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[241.328923] [022/133] (778s left) syncobj_wait (wait-for-submit-snapshot)
[241.394887] Starting subtest: wait-for-submit-snapshot
[241.476833] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[241.570797] [023/133] (778s left) vgem_basic (setversion)
[241.618792] Starting subtest: setversion
[241.623055] Subtest setversion: SUCCESS (0.000s)
[241.673919] [024/133] (778s left) gem_exec_schedule (u-independent)
[241.749715] Starting subtest: u-independent
[241.751969] Starting dynamic subtest: rcs0
[242.901247] Dynamic subtest rcs0: SUCCESS (1.161s)
[242.912630] Starting dynamic subtest: vcs0
[244.896261] Dynamic subtest vcs0: SUCCESS (1.994s)
[244.908633] Starting dynamic subtest: vcs1
[246.945337] Dynamic subtest vcs1: SUCCESS (2.048s)
[246.960830] Starting dynamic subtest: vecs0
[248.929978] Dynamic subtest vecs0: SUCCESS (1.983s)
[248.941742] Starting dynamic subtest: ccs0
[250.901741] Dynamic subtest ccs0: SUCCESS (1.970s)
[250.904737] Subtest u-independent: SUCCESS (9.162s)
[251.201090] [025/133] (768s left) kms_vblank (wait-forked-busy)
[251.303938] Starting subtest: wait-forked-busy
[251.306395] Starting dynamic subtest: pipe-A-eDP-1
[253.181487] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[253.196055] Starting dynamic subtest: pipe-D-eDP-1
[255.739555] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[255.741798] Subtest wait-forked-busy: SUCCESS (4.435s)
[256.550824] [026/133] (763s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[256.956090] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[257.754574] [027/133] (762s left) gem_softpin (noreloc)
[257.824565] Starting subtest: noreloc
[263.246278] Subtest noreloc: SUCCESS (5.422s)
[263.363297] [028/133] (756s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[263.475858] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[263.478231] Starting dynamic subtest: pipe-A-eDP-1
[274.802509] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.330s)
[274.812352] Starting dynamic subtest: pipe-B-eDP-1
[286.792260] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.989s)
[286.794702] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.322s)
[287.648047] [029/133] (732s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[287.821682] Starting subtest: cursor-rapid-movement-32x10
[287.875569] Subtest cursor-rapid-movement-32x10: SKIP (0.048s)
[288.127063] [030/133] (732s left) sysfs_heartbeat_interval (nopreempt)
[288.193413] Starting subtest: nopreempt
[288.195805] Starting dynamic subtest: vecs0
[296.920553] Dynamic subtest vecs0: SUCCESS (8.722s)
[296.931643] Starting dynamic subtest: ccs0
[300.937476] Dynamic subtest ccs0: SUCCESS (4.017s)
[300.950700] Starting dynamic subtest: vcs0
[310.934992] Dynamic subtest vcs0: SUCCESS (9.994s)
[310.946368] Starting dynamic subtest: bcs0
[314.893612] Dynamic subtest bcs0: SUCCESS (3.957s)
[314.904778] Starting dynamic subtest: rcs0
[318.929290] Dynamic subtest rcs0: SUCCESS (4.035s)
[318.939575] Starting dynamic subtest: vcs1
[328.908256] Dynamic subtest vcs1: SUCCESS (9.979s)
[328.910748] Subtest nopreempt: SUCCESS (40.714s)
[328.991540] [031/133] (691s left) kms_plane (plane-panning-top-left)
[329.098149] Starting subtest: plane-panning-top-left
[329.100524] Starting dynamic subtest: pipe-A
[330.807023] Dynamic subtest pipe-A: SUCCESS (1.710s)
[330.822698] Starting dynamic subtest: pipe-B
[333.166430] Dynamic subtest pipe-B: SUCCESS (2.357s)
[333.168418] Subtest plane-panning-top-left: SUCCESS (4.069s)
[333.981138] [032/133] (686s left) kms_cursor_crc (cursor-sliding-32x10)
[334.143335] Starting subtest: cursor-sliding-32x10
[334.187864] Subtest cursor-sliding-32x10: SKIP (0.042s)
[334.479647] [033/133] (685s left) gem_exec_suspend (basic-s4-devices)
[334.543722] Starting subtest: basic-S4-devices
[334.546051] Starting dynamic subtest: smem
[345.877603] Dynamic subtest smem: SUCCESS (11.331s)
[345.880778] Subtest basic-S4-devices: SUCCESS (11.333s)
[352.080016] [034/133] (674s left) gem_exec_suspend (basic)
[352.168232] Starting subtest: basic
[352.170806] Starting dynamic subtest: smem
[353.878514] Dynamic subtest smem: SUCCESS (1.708s)
[353.881583] Subtest basic: SUCCESS (1.711s)
[354.079862] [035/133] (672s left) kms_lease (empty-lease)
[354.171352] Starting subtest: empty-lease
[354.173666] Starting dynamic subtest: pipe-A-eDP-1
[354.175845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[354.186675] Starting dynamic subtest: pipe-B-eDP-1
[354.188874] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[354.198241] Starting dynamic subtest: pipe-C-eDP-1
[354.200503] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[354.209845] Starting dynamic subtest: pipe-D-eDP-1
[354.212153] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[354.214410] Subtest empty-lease: SUCCESS (0.009s)
[354.288581] [036/133] (672s left) gem_exec_params (rs-invalid)
[354.348361] Starting subtest: rs-invalid
[354.353306] Subtest rs-invalid: SUCCESS (0.003s)
[354.484293] [037/133] (672s left) gem_mmap_wc (write-gtt-read-wc)
[354.541278] Subtest write-gtt-read-wc: SKIP (0.000s)
[354.599101] [038/133] (672s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[354.704260] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[354.708129] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[354.822821] [039/133] (671s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[354.890589] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[354.895051] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[355.078510] [040/133] (671s left) gen7_exec_parse (oacontrol-tracking)
[355.139672] Subtest oacontrol-tracking: SKIP (0.000s)
[355.205097] [041/133] (671s left) perf (gen12-mi-rpc)
[355.336371] Starting subtest: gen12-mi-rpc
[355.338611] Starting dynamic subtest: rcs0
[355.356780] Dynamic subtest rcs0: SUCCESS (0.019s)
[355.358916] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[355.406807] [042/133] (671s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[355.571549] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[355.703470] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s)
[355.851454] [043/133] (671s left) gem_mmap_offset (isolation)
[355.912691] Starting subtest: isolation
[355.930901] Subtest isolation: SUCCESS (0.006s)
[356.042879] [044/133] (670s left) kms_properties (colorop-properties-legacy)
[356.145990] Starting subtest: colorop-properties-legacy
[356.147805] Starting dynamic subtest: pipe-A-eDP-1
[356.484183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[356.494682] Starting dynamic subtest: pipe-B-eDP-1
[357.624596] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[357.639021] Starting dynamic subtest: pipe-C-eDP-1
[358.730535] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[358.743212] Starting dynamic subtest: pipe-D-eDP-1
[359.763267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.032s)
[359.765572] Subtest colorop-properties-legacy: SUCCESS (3.618s)
[360.564648] [045/133] (666s left) gem_ccs (block-multicopy-compressed)
[360.627023] Starting subtest: block-multicopy-compressed
[360.631078] Subtest block-multicopy-compressed: SKIP (0.000s)
[360.726619] [046/133] (666s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[360.793740] Starting subtest: invalid-signal-one-illegal-handle
[360.796068] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[360.891500] [047/133] (666s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[360.987628] Starting subtest: yf-tiled-32bpp-rotate-270
[360.991792] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[361.110690] [048/133] (666s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[361.255781] Starting subtest: dp-mst-type-0-suspend-resume
[361.260351] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[361.372558] [049/133] (665s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[361.425738] Starting subtest: multi-wait-available-unsubmitted-submitted
[361.427703] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[361.530129] [050/133] (665s left) i915_module_load (reload)
[361.572078] Starting subtest: reload
[366.360932] Subtest reload: SUCCESS (4.790s)
[366.421825] [051/133] (660s left) i915_pm_freq_mult (media-freq)
[367.868993] Starting subtest: media-freq
[367.871400] Starting dynamic subtest: gt0
[367.875682] Dynamic subtest gt0: SKIP (0.000s)
[367.885795] Starting dynamic subtest: gt1
[367.889857] Dynamic subtest gt1: SKIP (0.000s)
[367.893950] Subtest media-freq: SKIP (0.002s)
[368.004415] [052/133] (659s left) kms_big_fb (linear-16bpp-rotate-90)
[368.095415] Starting subtest: linear-16bpp-rotate-90
[368.128278] Subtest linear-16bpp-rotate-90: SKIP (0.032s)
[368.250302] [053/133] (659s left) perf_pmu (interrupts-sync)
[368.293501] Starting subtest: interrupts-sync
[369.377637] Subtest interrupts-sync: SUCCESS (1.082s)
[369.504582] [054/133] (657s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[369.601718] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[369.603984] Starting dynamic subtest: pipe-A-eDP-1
[369.626633] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[369.638201] Starting dynamic subtest: pipe-B-eDP-1
[369.659264] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[369.668423] Starting dynamic subtest: pipe-C-eDP-1
[369.689420] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[369.698109] Starting dynamic subtest: pipe-D-eDP-1
[369.720176] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[369.724235] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[371.929964] [055/133] (655s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[372.021753] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[372.026131] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[372.098242] [056/133] (655s left) gem_exec_parallel (contexts)
[372.156481] Starting subtest: contexts
[372.158844] Starting dynamic subtest: rcs0
[374.876392] Dynamic subtest rcs0: SUCCESS (2.717s)
[374.889198] Starting dynamic subtest: bcs0
[378.232299] Dynamic subtest bcs0: SUCCESS (3.352s)
[378.244589] Starting dynamic subtest: vcs0
[382.348805] Dynamic subtest vcs0: SUCCESS (4.113s)
[382.359651] Starting dynamic subtest: vcs1
[386.598627] Dynamic subtest vcs1: SUCCESS (4.248s)
[386.610216] Starting dynamic subtest: vecs0
[390.388545] Dynamic subtest vecs0: SUCCESS (3.787s)
[390.398093] Starting dynamic subtest: ccs0
[393.912475] Dynamic subtest ccs0: SUCCESS (3.521s)
[393.915508] Subtest contexts: SUCCESS (21.754s)
[394.100317] [057/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[394.204384] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[394.208747] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[394.317846] [058/133] (633s left) kms_addfb_basic (unused-handle)
[394.380954] Starting subtest: unused-handle
[394.383247] Subtest unused-handle: SUCCESS (0.000s)
[394.509140] [059/133] (633s left) kms_joiner (invalid-modeset-big-joiner)
[394.609249] Starting subtest: invalid-modeset-big-joiner
[394.613394] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[394.710639] [060/133] (632s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[394.831738] Starting subtest: cursor-vs-flip-varying-size
[426.983727] Subtest cursor-vs-flip-varying-size: SUCCESS (32.149s)
[427.352708] [061/133] (600s left) gem_exec_schedule (independent)
[427.423548] Starting subtest: independent
[427.425818] Starting dynamic subtest: rcs0
[428.886078] Dynamic subtest rcs0: SUCCESS (1.470s)
[428.898805] Starting dynamic subtest: vcs0
[430.874171] Dynamic subtest vcs0: SUCCESS (1.986s)
[430.885752] Starting dynamic subtest: vcs1
[432.864933] Dynamic subtest vcs1: SUCCESS (1.987s)
[432.877164] Starting dynamic subtest: vecs0
[434.914437] Dynamic subtest vecs0: SUCCESS (2.047s)
[434.926861] Starting dynamic subtest: ccs0
[436.884461] Dynamic subtest ccs0: SUCCESS (1.967s)
[436.887294] Subtest independent: SUCCESS (9.470s)
[437.207840] [062/133] (590s left) kms_plane_scaling (planes-scaler-unity-scaling)
[437.300628] Starting subtest: planes-scaler-unity-scaling
[437.303756] Starting dynamic subtest: pipe-A
[437.363027] Dynamic subtest pipe-A: SUCCESS (0.066s)
[437.374243] Starting dynamic subtest: pipe-B
[438.472891] Dynamic subtest pipe-B: SUCCESS (1.109s)
[438.484549] Starting dynamic subtest: pipe-C
[439.593820] Dynamic subtest pipe-C: SUCCESS (1.119s)
[439.610036] Starting dynamic subtest: pipe-D
[440.719591] Dynamic subtest pipe-D: SUCCESS (1.125s)
[440.721947] Subtest planes-scaler-unity-scaling: SUCCESS (3.423s)
[441.884899] [063/133] (585s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[441.940291] Starting subtest: multi-wait-for-submit-submitted-signaled
[441.942187] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[442.035732] [064/133] (585s left) syncobj_wait (invalid-signal-one-illegal-handle)
[442.094726] Starting subtest: invalid-signal-one-illegal-handle
[442.096892] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[442.190963] [065/133] (585s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[442.275547] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[442.277834] Starting dynamic subtest: pipe-A-default-mode
[443.440188] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[443.444617] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.161s)
[443.574912] [066/133] (584s left) gem_basic (create-close)
[443.635166] Starting subtest: create-close
[443.639734] Subtest create-close: SUCCESS (0.000s)
[443.729566] [067/133] (584s left) gem_ctx_param (invalid-get-ringsize)
[443.795380] Starting subtest: invalid-get-ringsize
[443.797319] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[443.891100] [068/133] (584s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[444.011691] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[475.961392] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.946s)
[476.752815] [069/133] (551s left) kms_frontbuffer_tracking (fbc-tiling-y)
[476.862471] Starting subtest: fbc-tiling-y
[476.866990] Subtest fbc-tiling-y: SKIP (0.000s)
[476.946267] [070/133] (551s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[477.058186] Starting subtest: extended-modeset-hang-newfb-with-reset
[477.060459] Starting dynamic subtest: pipe-A
[490.969815] Dynamic subtest pipe-A: SUCCESS (13.909s)
[490.983858] Starting dynamic subtest: pipe-D
[506.541798] Dynamic subtest pipe-D: SUCCESS (15.570s)
[506.543951] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.484s)
[507.345669] [071/133] (520s left) gem_pxp (hw-rejects-pxp-buffer)
[507.474062] Starting subtest: hw-rejects-pxp-buffer
[507.479108] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[507.593715] [072/133] (520s left) api_intel_bb (reset-bb)
[507.650109] Starting subtest: reset-bb
[507.652469] Subtest reset-bb: SUCCESS (0.003s)
[507.770913] [073/133] (520s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[507.889370] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[507.893807] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[508.039478] [074/133] (520s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[508.168715] Starting subtest: basic-flip-after-cursor-legacy
[509.087330] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.916s)
[509.951318] [075/133] (518s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[510.068280] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[519.574904] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.506s)
[520.384692] [076/133] (507s left) kms_cursor_crc (cursor-offscreen-128x128)
[520.602261] Starting subtest: cursor-offscreen-128x128
[520.607114] Starting dynamic subtest: pipe-A-eDP-1
[522.541702] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[522.572807] Starting dynamic subtest: pipe-D-eDP-1
[525.188938] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[525.191165] Subtest cursor-offscreen-128x128: SUCCESS (4.584s)
[526.069383] [077/133] (502s left) kms_prime (basic-crc-hybrid)
[526.157254] Subtest basic-crc-hybrid: SKIP (0.000s)
[526.266685] [078/133] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[526.362225] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[526.366137] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[526.457894] [079/133] (502s left) i915_suspend (fence-restore-untiled)
[526.518459] Starting subtest: fence-restore-untiled
[526.522653] Subtest fence-restore-untiled: SKIP (0.000s)
[526.640227] [080/133] (501s left) kms_pm_dc (dc3co-vpb-simulation)
[527.745875] Starting subtest: dc3co-vpb-simulation
[536.972073] Subtest dc3co-vpb-simulation: SKIP (9.223s)
[537.122831] [081/133] (491s left) gem_wait (write-wait)
[537.195089] Starting subtest: write-wait
[537.197485] Starting dynamic subtest: all-engines
[538.344796] Dynamic subtest all-engines: SUCCESS (1.149s)
[538.363979] Starting dynamic subtest: rcs0
[539.423860] Dynamic subtest rcs0: SUCCESS (1.076s)
[539.441852] Starting dynamic subtest: bcs0
[540.485332] Dynamic subtest bcs0: SUCCESS (1.059s)
[540.501949] Starting dynamic subtest: vcs0
[541.541219] Dynamic subtest vcs0: SUCCESS (1.053s)
[541.558043] Starting dynamic subtest: vcs1
[542.595198] Dynamic subtest vcs1: SUCCESS (1.052s)
[542.614119] Starting dynamic subtest: vecs0
[543.648378] Dynamic subtest vecs0: SUCCESS (1.051s)
[543.666582] Starting dynamic subtest: ccs0
[544.705063] Dynamic subtest ccs0: SUCCESS (1.054s)
[544.707557] Subtest write-wait: SUCCESS (7.511s)
[544.906567] [082/133] (483s left) gem_mmap_gtt (big-bo-tiledx)
[544.969810] Subtest big-bo-tiledX: SKIP (0.000s)
[545.029756] [083/133] (483s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[545.577441] Starting subtest: syncobj-timeline-invalid-wait
[545.583872] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s)
[546.958167] [084/133] (481s left) kms_chamelium_audio (dp-audio)
[547.344042] Subtest dp-audio: SKIP (0.000s)
[548.173808] [085/133] (480s left) syncobj_wait (wait-delayed-signal)
[548.220442] Starting subtest: wait-delayed-signal
[548.321787] Subtest wait-delayed-signal: SUCCESS (0.102s)
[548.420557] [086/133] (480s left) template (b)
[548.487136] Starting subtest: B
[548.489361] Subtest B: SUCCESS (0.000s)
[548.609780] [087/133] (480s left) gem_exec_nop (basic-parallel)
[548.692479] Starting subtest: basic-parallel
[564.886077] Subtest basic-parallel: SUCCESS (16.204s)
[565.116874] [088/133] (463s left) syncobj_timeline (signal-point-0)
[565.180622] Starting subtest: signal-point-0
[565.183045] Subtest signal-point-0: SUCCESS (0.000s)
[565.281058] [089/133] (463s left) kms_sequence (queue-busy)
[565.378822] Starting subtest: queue-busy
[565.381501] Starting dynamic subtest: pipe-A-eDP-1
[567.316167] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[567.326484] Starting dynamic subtest: pipe-B-eDP-1
[569.882313] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.567s)
[569.893839] Starting dynamic subtest: pipe-C-eDP-1
[572.475927] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.590s)
[572.486778] Starting dynamic subtest: pipe-D-eDP-1
[575.026775] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[575.029085] Subtest queue-busy: SUCCESS (9.646s)
[575.824841] [090/133] (453s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[575.919706] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[575.922048] Starting dynamic subtest: pipe-A-eDP-1
[575.944903] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[575.956963] Starting dynamic subtest: pipe-B-eDP-1
[575.978933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[575.989987] Starting dynamic subtest: pipe-C-eDP-1
[576.015664] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[576.025377] Starting dynamic subtest: pipe-D-eDP-1
[576.046296] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[576.050593] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[578.199638] [091/133] (450s left) gem_create (create-ext-placement-sanity-check)
[578.369642] Starting subtest: create-ext-placement-sanity-check
[578.376338] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[578.474859] [092/133] (450s left) gem_exec_params (dr4-dirt)
[578.533061] Starting subtest: DR4-dirt
[578.534877] Subtest DR4-dirt: SUCCESS (0.000s)
[578.625233] [093/133] (450s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[578.733223] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[582.826467] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.096s)
[584.014112] [094/133] (445s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[584.132494] Starting subtest: cursorA-vs-flipB-atomic
[584.137118] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[584.280206] [095/133] (444s left) vgem_basic (dmabuf-fence)
[584.329592] Starting subtest: dmabuf-fence
[584.331624] Subtest dmabuf-fence: SUCCESS (0.001s)
[584.392249] [096/133] (444s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[584.483733] Starting subtest: pr-primary-plane-update-sf-dmg-area
[584.487921] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[584.559296] [097/133] (444s left) kms_flip (2x-flip-vs-dpms-on-nop)
[584.658560] Starting subtest: 2x-flip-vs-dpms-on-nop
[584.670056] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[584.754393] [098/133] (444s left) gem_exec_balancer (parallel-bb-first)
[585.021948] Starting subtest: parallel-bb-first
[585.987370] Subtest parallel-bb-first: SUCCESS (0.968s)
[586.942798] [099/133] (442s left) i915_drm_fdinfo (memory-info-resident)
[586.978959] Starting subtest: memory-info-resident
[586.981234] Starting dynamic subtest: smem0
[590.047697] Dynamic subtest smem0: SUCCESS (3.069s)
[590.050061] Subtest memory-info-resident: SUCCESS (3.070s)
[590.138393] [100/133] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[590.252054] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[596.882836] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.633s)
[597.007455] [101/133] (432s left) gem_softpin (safe-alignment)
[597.064461] Starting subtest: safe-alignment
[597.090729] Subtest safe-alignment: SUCCESS (0.027s)
[598.988565] [102/133] (430s left) gem_softpin (evict-snoop)
[599.057732] Starting subtest: evict-snoop
[599.062480] Subtest evict-snoop: SKIP (0.000s)
[599.177794] [103/133] (430s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[599.271187] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[599.275482] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[599.370719] [104/133] (430s left) kms_psr (psr2-dpms)
[599.463765] Starting subtest: psr2-dpms
[599.466096] Starting dynamic subtest: eDP-1
[602.348163] Dynamic subtest eDP-1: SUCCESS (2.884s)
[602.350464] Subtest psr2-dpms: SUCCESS (2.885s)
[603.232048] [105/133] (426s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[603.292917] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[603.295515] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[603.393180] [106/133] (426s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[603.460452] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[603.568741] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[603.649178] [107/133] (426s left) gem_exec_balancer (parallel-out-fence)
[603.915404] Starting subtest: parallel-out-fence
[605.124334] Subtest parallel-out-fence: SUCCESS (1.208s)
[605.251328] [108/133] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[605.352647] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[605.357061] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[605.454472] [109/133] (424s left) api_intel_allocator (fork-simple-stress)
[605.514385] Starting subtest: fork-simple-stress
[610.911557] Subtest fork-simple-stress: SUCCESS (5.398s)
[611.078769] [110/133] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[611.188609] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[611.192528] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[611.323155] [111/133] (418s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[611.446177] Starting subtest: 4-tiled-8bpp-rotate-90
[611.467753] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[611.608198] [112/133] (418s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[611.719958] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[611.724655] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[611.884938] [113/133] (418s left) dmabuf_sync_file (import-multiple-read-only)
[611.946267] Starting subtest: import-multiple-read-only
[611.950826] Subtest import-multiple-read-only: SUCCESS (0.004s)
[612.043045] [114/133] (418s left) kms_async_flips (test-time-stamp-atomic)
[612.149096] Starting subtest: test-time-stamp-atomic
[612.537691] Starting dynamic subtest: pipe-A-eDP-1
[613.335288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s)
[613.716747] Starting dynamic subtest: pipe-B-eDP-1
[614.459773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.750s)
[614.843776] Starting dynamic subtest: pipe-C-eDP-1
[615.589277] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[615.963652] Starting dynamic subtest: pipe-D-eDP-1
[616.724209] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[616.726926] Subtest test-time-stamp-atomic: SUCCESS (4.574s)
[617.878671] [115/133] (412s left) kms_psr (psr-sprite-mmap-cpu)
[617.966137] Starting subtest: psr-sprite-mmap-cpu
[617.968375] Starting dynamic subtest: eDP-1
[619.701475] Dynamic subtest eDP-1: SUCCESS (1.736s)
[619.703950] Subtest psr-sprite-mmap-cpu: SUCCESS (1.737s)
[620.545283] [116/133] (409s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[620.640128] Starting subtest: psr-rgb101010-draw-mmap-gtt
[620.644137] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[620.737652] [117/133] (409s left) perf_pmu (rc6-suspend)
[620.783577] Starting subtest: rc6-suspend
[643.479064] Subtest rc6-suspend: SUCCESS (8.272s)
[644.385813] [118/133] (386s left) gem_exec_whisper (basic-queues-forked)
[644.465947] Starting subtest: basic-queues-forked
[667.644538] Subtest basic-queues-forked: SUCCESS (23.067s)
[667.829725] [119/133] (362s left) gem_exec_store (dword)
[667.897300] Starting subtest: dword
[667.899663] Starting dynamic subtest: rcs0
[667.979756] Dynamic subtest rcs0: SUCCESS (0.083s)
[667.994299] Starting dynamic subtest: bcs0
[668.025115] Dynamic subtest bcs0: SUCCESS (0.043s)
[668.036647] Starting dynamic subtest: vcs0
[668.068273] Dynamic subtest vcs0: SUCCESS (0.041s)
[668.080920] Starting dynamic subtest: vcs1
[668.111005] Dynamic subtest vcs1: SUCCESS (0.041s)
[668.124027] Starting dynamic subtest: vecs0
[668.154991] Dynamic subtest vecs0: SUCCESS (0.041s)
[668.166333] Starting dynamic subtest: ccs0
[668.201254] Dynamic subtest ccs0: SUCCESS (0.045s)
[668.203961] Subtest dword: SUCCESS (0.306s)
[668.393444] [120/133] (362s left) kms_psr (fbc-pr-primary-mmap-gtt)
[668.508985] Starting subtest: fbc-pr-primary-mmap-gtt
[668.513386] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[668.588230] [121/133] (361s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[668.645195] Starting subtest: etime-multi-wait-all-for-submit-submitted
[668.749359] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[668.833255] [122/133] (361s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[668.955191] Starting subtest: cursorA-vs-flipA-atomic-transitions
[680.144667] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.185s)
[680.957637] [123/133] (349s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[681.056423] Starting subtest: fbc-psr2-sprite-mmap-gtt
[681.058768] Starting dynamic subtest: eDP-1
[681.063399] Dynamic subtest eDP-1: SKIP (0.000s)
[681.067956] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[681.133868] [124/133] (349s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[681.229399] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[681.233681] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[681.327327] [125/133] (349s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[681.417710] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[690.135347] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.719s)
[690.291880] [126/133] (340s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[690.677202] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[691.509962] [127/133] (339s left) kms_plane_alpha_blend (alpha-basic)
[691.607690] Starting subtest: alpha-basic
[691.898907] Starting dynamic subtest: pipe-A-eDP-1
[693.831368] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[693.863455] Starting dynamic subtest: pipe-D-eDP-1
[696.516182] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.664s)
[696.518462] Subtest alpha-basic: SUCCESS (4.910s)
[697.399858] [128/133] (333s left) kms_plane_multiple (tiling-none)
[697.493885] Starting subtest: tiling-none
[697.496190] Starting dynamic subtest: pipe-A-eDP-1
[701.234234] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.737s)
[701.248234] Starting dynamic subtest: pipe-B-eDP-1
[705.684729] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.449s)
[705.696326] Starting dynamic subtest: pipe-C-eDP-1
[710.008513] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[710.020202] Starting dynamic subtest: pipe-D-eDP-1
[714.335378] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.326s)
[714.337231] Subtest tiling-none: SUCCESS (16.837s)
[715.138853] [129/133] (315s left) gem_userptr_blits (stress-mm)
[715.220194] Starting subtest: stress-mm
[720.590930] Subtest stress-mm: SUCCESS (5.369s)
[720.693152] [130/133] (310s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[720.798120] Starting subtest: fbc-rgb101010-draw-mmap-wc
[725.411889] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.614s)
[726.546834] [131/133] (304s left) kms_properties (plane-properties-legacy)
[726.648703] Starting subtest: plane-properties-legacy
[726.650816] Starting dynamic subtest: pipe-A-eDP-1
[727.210454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[727.221880] Starting dynamic subtest: pipe-B-eDP-1
[728.503428] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s)
[728.514488] Starting dynamic subtest: pipe-C-eDP-1
[729.737980] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[729.749384] Starting dynamic subtest: pipe-D-eDP-1
[730.976812] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[730.979302] Subtest plane-properties-legacy: SUCCESS (4.328s)
[731.791596] [132/133] (299s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[731.883581] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[738.649329] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.767s)
[738.774212] [133/133] (292s left) gem_mmap_gtt (bad-object)
[738.826802] Subtest bad-object: SKIP (0.000s)
[738.882297] Closing watchdogs
results: parsing output: 0/ for test: kms_fb_coherency
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: core_auth
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_vgem
results: parsing output: 9/ for test: gem_ctx_shared
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: sysfs_heartbeat_interval
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: gem_exec_suspend
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: gen7_exec_parse
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: kms_properties
results: parsing output: 44/ for test: gem_ccs
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: i915_module_load
results: parsing output: 50/ for test: i915_pm_freq_mult
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: gem_exec_parallel
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_joiner
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_basic
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_prime
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_suspend
results: parsing output: 79/ for test: kms_pm_dc
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_chamelium_audio
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: template
results: parsing output: 86/ for test: gem_exec_nop
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_create
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_legacy
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_exec_balancer
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: gem_exec_store
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_edid
results: parsing output: 126/ for test: kms_plane_alpha_blend
results: parsing output: 127/ for test: kms_plane_multiple
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_gtt
Done.