[58.374391] Initializing watchdogs
[58.374437]   /dev/watchdog0
[58.389044] [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.393807] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.396268] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.398757] [001/133] (960s left) kms_fb_coherency (memset-crc)
[58.510840] Starting subtest: memset-crc
[58.512027] Starting dynamic subtest: mmap-offset-wc
[58.943465] Dynamic subtest mmap-offset-wc: SUCCESS (0.437s)
[59.249305] Starting dynamic subtest: mmap-offset-uc
[65.365611] Dynamic subtest mmap-offset-uc: SUCCESS (6.154s)
[65.657075] Subtest memset-crc: SUCCESS (7.185s)
[66.534931] [002/133] (952s left) gem_exec_reloc (basic-write-wc)
[66.588683] Subtest basic-write-wc: SKIP (0.000s)
[66.644894] [003/133] (952s left) gem_exec_params (invalid-bsd2-flag-on-render)
[66.763551] Starting subtest: invalid-bsd2-flag-on-render
[66.764529] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[66.945350] [004/133] (952s left) gem_render_copy (linear)
[67.312555] Starting subtest: linear
[67.313497] Starting dynamic subtest: smem
[67.365744] Dynamic subtest smem: SUCCESS (0.056s)
[67.366742] Subtest linear: SUCCESS (0.056s)
[67.906702] [005/133] (951s left) core_auth (basic-auth)
[68.043075] Starting subtest: basic-auth
[68.044098] Subtest basic-auth: SUCCESS (0.001s)
[68.138904] [006/133] (950s left) kms_flip (flip-vs-modeset-vs-hang)
[68.228796] Starting subtest: flip-vs-modeset-vs-hang
[68.229699] Starting dynamic subtest: A-eDP1
[119.407873] Dynamic subtest A-eDP1: SUCCESS (51.181s)
[119.417459] Starting dynamic subtest: D-eDP1
[169.391647] Dynamic subtest D-eDP1: SUCCESS (49.978s)
[169.393023] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.162s)
[169.732791] [007/133] (849s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[169.829556] Starting subtest: plane-primary-toggle-with-vblank-wait
[169.830404] Starting dynamic subtest: pipe-A-eDP-1
[170.003575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[170.316845] Starting dynamic subtest: pipe-B-eDP-1
[171.244176] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.933s)
[171.551631] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.722s)
[172.405639] [008/133] (846s left) kms_frontbuffer_tracking (fbc-1p-rte)
[172.507998] Starting subtest: fbc-1p-rte
[177.981792] Subtest fbc-1p-rte: SUCCESS (5.475s)
[179.115355] [009/133] (840s left) prime_vgem (basic-fence-flip)
[179.217891] Starting subtest: basic-fence-flip
[179.511507] Subtest basic-fence-flip: SUCCESS (0.293s)
[179.622225] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[179.623892] [010/133] (839s left) gem_ctx_shared (q-independent)
[179.677135] Starting subtest: Q-independent
[179.678080] Starting dynamic subtest: rcs0
[179.745845] Dynamic subtest rcs0: SUCCESS (0.068s)
[179.755085] Starting dynamic subtest: vcs0
[179.786207] Dynamic subtest vcs0: SUCCESS (0.041s)
[179.794023] Starting dynamic subtest: vcs1
[179.831967] Dynamic subtest vcs1: SUCCESS (0.045s)
[179.838107] Starting dynamic subtest: vecs0
[179.870957] Dynamic subtest vecs0: SUCCESS (0.039s)
[179.878666] Starting dynamic subtest: ccs0
[179.914380] Dynamic subtest ccs0: SUCCESS (0.043s)
[179.915465] Subtest Q-independent: SUCCESS (0.237s)
[180.963109] [011/133] (838s left) kms_color_pipeline (plane-lut1d)
[181.058304] Starting subtest: plane-lut1d
[181.206602] Starting dynamic subtest: pipe-A-plane-0
[181.394537] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[181.402679] Starting dynamic subtest: pipe-A-plane-1
[181.561062] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[181.567938] Starting dynamic subtest: pipe-A-plane-2
[181.716832] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[182.898725] Starting dynamic subtest: pipe-B-plane-0
[183.069617] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[183.077332] Starting dynamic subtest: pipe-B-plane-1
[183.236117] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[183.243173] Starting dynamic subtest: pipe-B-plane-2
[183.391939] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[185.631259] Starting dynamic subtest: pipe-C-plane-0
[185.792724] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[185.799183] Starting dynamic subtest: pipe-C-plane-1
[185.937387] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[185.944418] Starting dynamic subtest: pipe-C-plane-2
[186.092836] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[187.289935] Starting dynamic subtest: pipe-D-plane-0
[187.439358] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[187.446270] Starting dynamic subtest: pipe-D-plane-1
[187.605959] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[187.612360] Starting dynamic subtest: pipe-D-plane-2
[187.750227] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[188.035576] Subtest plane-lut1d: SUCCESS (6.977s)
[188.851697] [012/133] (830s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[188.902718] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[188.955031] [013/133] (830s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[189.031133] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[189.032089] Starting dynamic subtest: pipe-A-eDP-1
[189.173778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[189.181599] Starting dynamic subtest: pipe-B-eDP-1
[189.188348] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[189.194443] Starting dynamic subtest: pipe-C-eDP-1
[189.201342] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[189.207285] Starting dynamic subtest: pipe-D-eDP-1
[189.213958] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[189.214728] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.147s)
[191.418625] [014/133] (827s left) kms_psr (pr-sprite-plane-move)
[191.518838] Starting subtest: pr-sprite-plane-move
[191.520655] Subtest pr-sprite-plane-move: SKIP (0.000s)
[191.600172] [015/133] (827s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[191.683929] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[191.685110] Starting dynamic subtest: pipe-A-eDP-1
[191.707548] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[191.714390] Starting dynamic subtest: pipe-B-eDP-1
[191.735404] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[191.741606] Starting dynamic subtest: pipe-C-eDP-1
[191.762167] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[191.768133] Starting dynamic subtest: pipe-D-eDP-1
[191.790177] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[191.791896] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[193.981334] [016/133] (825s left) gem_mmap_gtt (basic-small-copy-xy)
[194.027965] Subtest basic-small-copy-XY: SKIP (0.000s)
[194.083718] [017/133] (825s left) gem_ctx_persistence (saturated-hostile)
[194.138933] Starting subtest: saturated-hostile
[194.139888] Starting dynamic subtest: rcs0
[194.947608] Dynamic subtest rcs0: SUCCESS (0.808s)
[194.957774] Starting dynamic subtest: bcs0
[195.728043] Dynamic subtest bcs0: SUCCESS (0.779s)
[195.737566] Starting dynamic subtest: vcs0
[196.503801] Dynamic subtest vcs0: SUCCESS (0.774s)
[196.512542] Starting dynamic subtest: vcs1
[197.278466] Dynamic subtest vcs1: SUCCESS (0.774s)
[197.288512] Starting dynamic subtest: vecs0
[198.075762] Dynamic subtest vecs0: SUCCESS (0.796s)
[198.085287] Starting dynamic subtest: ccs0
[198.884847] Dynamic subtest ccs0: SUCCESS (0.808s)
[198.886522] Subtest saturated-hostile: SUCCESS (4.746s)
[198.973621] [018/133] (820s left) kms_getfb (getfb2-handle-protection)
[199.070084] Starting subtest: getfb2-handle-protection
[199.094399] Subtest getfb2-handle-protection: SUCCESS (0.025s)
[199.202408] [019/133] (820s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[199.302898] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[199.304614] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[199.388688] [020/133] (820s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[199.475396] Starting subtest: async-flip-with-page-flip-events-tiled
[199.857191] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[202.671737] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[202.680315] Starting dynamic subtest: pipe-A-eDP-1-4
[204.845767] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[204.855054] Starting dynamic subtest: pipe-A-eDP-1-4
[206.856229] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[206.864364] Starting dynamic subtest: pipe-A-eDP-1-x
[209.034849] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[209.409066] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[212.212668] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[212.221076] Starting dynamic subtest: pipe-B-eDP-1-4
[214.409288] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[214.416012] Starting dynamic subtest: pipe-B-eDP-1-4
[216.419537] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[216.426078] Starting dynamic subtest: pipe-B-eDP-1-x
[218.621077] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[218.979197] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[221.734098] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[221.740578] Starting dynamic subtest: pipe-C-eDP-1-4
[223.897102] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[223.903315] Starting dynamic subtest: pipe-C-eDP-1-4
[225.908021] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[225.914712] Starting dynamic subtest: pipe-C-eDP-1-x
[228.086803] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[228.446836] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[231.265578] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.815s)
[231.276540] Starting dynamic subtest: pipe-D-eDP-1-4
[233.439266] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[233.447410] Starting dynamic subtest: pipe-D-eDP-1-4
[235.449300] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[235.457311] Starting dynamic subtest: pipe-D-eDP-1-x
[237.627908] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[237.629418] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.143s)
[238.836134] [021/133] (780s left) perf_pmu (semaphore-wait-idle)
[238.880349] Starting subtest: semaphore-wait-idle
[238.881258] Starting dynamic subtest: rcs0
[239.403950] Dynamic subtest rcs0: SUCCESS (0.513s)
[239.412439] Starting dynamic subtest: bcs0
[239.916966] Dynamic subtest bcs0: SUCCESS (0.511s)
[239.924697] Starting dynamic subtest: vcs0
[240.428826] Dynamic subtest vcs0: SUCCESS (0.510s)
[240.436553] Starting dynamic subtest: vcs1
[240.940967] Dynamic subtest vcs1: SUCCESS (0.510s)
[240.950440] Starting dynamic subtest: vecs0
[241.443853] Dynamic subtest vecs0: SUCCESS (0.510s)
[241.453835] Starting dynamic subtest: ccs0
[241.969752] Dynamic subtest ccs0: SUCCESS (0.515s)
[241.971344] Subtest semaphore-wait-idle: SUCCESS (3.080s)
[242.086125] [022/133] (777s left) syncobj_wait (wait-for-submit-snapshot)
[242.134355] Starting subtest: wait-for-submit-snapshot
[242.216245] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[242.287753] [023/133] (777s left) vgem_basic (setversion)
[242.323090] Starting subtest: setversion
[242.324969] Subtest setversion: SUCCESS (0.000s)
[242.376709] [024/133] (777s left) gem_exec_schedule (u-independent)
[242.435459] Starting subtest: u-independent
[242.436434] Starting dynamic subtest: rcs0
[243.933821] Dynamic subtest rcs0: SUCCESS (1.489s)
[243.944072] Starting dynamic subtest: vcs0
[245.925934] Dynamic subtest vcs0: SUCCESS (1.990s)
[245.935593] Starting dynamic subtest: vcs1
[247.912116] Dynamic subtest vcs1: SUCCESS (1.985s)
[247.921602] Starting dynamic subtest: vecs0
[249.961987] Dynamic subtest vecs0: SUCCESS (2.048s)
[249.970127] Starting dynamic subtest: ccs0
[251.933816] Dynamic subtest ccs0: SUCCESS (1.970s)
[251.934993] Subtest u-independent: SUCCESS (9.490s)
[252.221873] [025/133] (767s left) kms_vblank (wait-forked-busy)
[252.321186] Starting subtest: wait-forked-busy
[252.322073] Starting dynamic subtest: pipe-A-eDP-1
[254.198425] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[254.206940] Starting dynamic subtest: pipe-D-eDP-1
[256.802385] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[256.803277] Subtest wait-forked-busy: SUCCESS (4.481s)
[257.590956] [026/133] (762s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[257.983537] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[258.795739] [027/133] (760s left) gem_softpin (noreloc)
[258.848505] Starting subtest: noreloc
[264.280846] Subtest noreloc: SUCCESS (5.423s)
[264.383452] [028/133] (755s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[264.480932] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[264.481856] Starting dynamic subtest: pipe-A-eDP-1
[275.815029] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.333s)
[275.822072] Starting dynamic subtest: pipe-B-eDP-1
[287.854215] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.038s)
[287.855129] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.373s)
[288.697301] [029/133] (731s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[288.860818] Starting subtest: cursor-rapid-movement-32x10
[288.904671] Subtest cursor-rapid-movement-32x10: SKIP (0.041s)
[289.136908] [030/133] (730s left) sysfs_heartbeat_interval (nopreempt)
[289.191580] Starting subtest: nopreempt
[289.192529] Starting dynamic subtest: vecs0
[298.905227] Dynamic subtest vecs0: SUCCESS (9.703s)
[298.914640] Starting dynamic subtest: ccs0
[302.930637] Dynamic subtest ccs0: SUCCESS (4.033s)
[302.941599] Starting dynamic subtest: vcs0
[312.922520] Dynamic subtest vcs0: SUCCESS (9.981s)
[312.931479] Starting dynamic subtest: bcs0
[316.874496] Dynamic subtest bcs0: SUCCESS (3.956s)
[316.882397] Starting dynamic subtest: rcs0
[320.911331] Dynamic subtest rcs0: SUCCESS (4.036s)
[320.921212] Starting dynamic subtest: vcs1
[329.887241] Dynamic subtest vcs1: SUCCESS (8.965s)
[329.888394] Subtest nopreempt: SUCCESS (40.685s)
[329.967228] [031/133] (689s left) kms_plane (plane-panning-top-left)
[330.065304] Starting subtest: plane-panning-top-left
[330.066163] Starting dynamic subtest: pipe-A
[331.750847] Dynamic subtest pipe-A: SUCCESS (1.684s)
[331.758433] Starting dynamic subtest: pipe-B
[334.140096] Dynamic subtest pipe-B: SUCCESS (2.389s)
[334.140978] Subtest plane-panning-top-left: SUCCESS (4.075s)
[334.943272] [032/133] (684s left) kms_cursor_crc (cursor-sliding-32x10)
[335.092192] Starting subtest: cursor-sliding-32x10
[335.139467] Subtest cursor-sliding-32x10: SKIP (0.045s)
[335.410169] [033/133] (684s left) gem_exec_suspend (basic-s4-devices)
[335.462271] Starting subtest: basic-S4-devices
[335.463246] Starting dynamic subtest: smem
[346.911874] Dynamic subtest smem: SUCCESS (11.438s)
[346.913337] Subtest basic-S4-devices: SUCCESS (11.440s)
[352.159614] [034/133] (672s left) gem_exec_suspend (basic)
[352.233854] Starting subtest: basic
[352.234863] Starting dynamic subtest: smem
[353.951488] Dynamic subtest smem: SUCCESS (1.706s)
[353.952706] Subtest basic: SUCCESS (1.709s)
[354.126040] [035/133] (670s left) kms_lease (empty-lease)
[354.223486] Starting subtest: empty-lease
[354.224339] Starting dynamic subtest: pipe-A-eDP-1
[354.225198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[354.234649] Starting dynamic subtest: pipe-B-eDP-1
[354.235507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[354.243281] Starting dynamic subtest: pipe-C-eDP-1
[354.244100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[354.251788] Starting dynamic subtest: pipe-D-eDP-1
[354.252685] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[354.253559] Subtest empty-lease: SUCCESS (0.010s)
[354.338224] [036/133] (670s left) gem_exec_params (rs-invalid)
[354.411831] Starting subtest: rs-invalid
[354.415919] Subtest rs-invalid: SUCCESS (0.004s)
[354.543101] [037/133] (670s left) gem_mmap_wc (write-gtt-read-wc)
[354.598265] Subtest write-gtt-read-wc: SKIP (0.000s)
[354.662190] [038/133] (670s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[354.765838] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[354.767486] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[354.856836] [039/133] (670s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[354.915827] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[354.917744] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[355.096853] [040/133] (670s left) gen7_exec_parse (oacontrol-tracking)
[355.161728] Subtest oacontrol-tracking: SKIP (0.000s)
[355.226089] [041/133] (670s left) perf (gen12-mi-rpc)
[355.350369] Starting subtest: gen12-mi-rpc
[355.351242] Starting dynamic subtest: rcs0
[355.369202] Dynamic subtest rcs0: SUCCESS (0.019s)
[355.370090] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[355.415033] [042/133] (669s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[355.552945] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[355.691221] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.140s)
[355.802698] [043/133] (669s left) gem_mmap_offset (isolation)
[355.852153] Starting subtest: isolation
[355.858809] Subtest isolation: SUCCESS (0.006s)
[355.954227] [044/133] (669s left) kms_properties (colorop-properties-legacy)
[356.039287] Starting subtest: colorop-properties-legacy
[356.040123] Starting dynamic subtest: pipe-A-eDP-1
[356.375916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[356.385099] Starting dynamic subtest: pipe-B-eDP-1
[357.434139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.056s)
[357.442467] Starting dynamic subtest: pipe-C-eDP-1
[358.475043] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.039s)
[358.483044] Starting dynamic subtest: pipe-D-eDP-1
[359.507077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.031s)
[359.508038] Subtest colorop-properties-legacy: SUCCESS (3.469s)
[360.296829] [045/133] (665s left) gem_ccs (block-multicopy-compressed)
[360.366955] Starting subtest: block-multicopy-compressed
[360.369344] Subtest block-multicopy-compressed: SKIP (0.000s)
[360.482611] [046/133] (664s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[360.533143] Starting subtest: invalid-signal-one-illegal-handle
[360.533966] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[360.667955] [047/133] (664s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[360.777440] Starting subtest: yf-tiled-32bpp-rotate-270
[360.779343] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[360.883248] [048/133] (664s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[361.013554] Starting subtest: dp-mst-type-0-suspend-resume
[361.015459] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[361.136480] [049/133] (664s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[361.187056] Starting subtest: multi-wait-available-unsubmitted-submitted
[361.187988] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[361.282225] [050/133] (664s left) i915_module_load (reload)
[361.320375] Starting subtest: reload
[364.533935] Subtest reload: SUCCESS (3.216s)
[364.567667] [051/133] (661s left) i915_pm_freq_mult (media-freq)
[365.881040] Starting subtest: media-freq
[365.882450] Starting dynamic subtest: gt0
[365.884759] Dynamic subtest gt0: SKIP (0.000s)
[365.895969] Starting dynamic subtest: gt1
[365.898044] Dynamic subtest gt1: SKIP (0.000s)
[365.900020] Subtest media-freq: SKIP (0.002s)
[365.986136] [052/133] (659s left) kms_big_fb (linear-16bpp-rotate-90)
[366.079581] Starting subtest: linear-16bpp-rotate-90
[366.112204] Subtest linear-16bpp-rotate-90: SKIP (0.032s)
[366.232864] [053/133] (659s left) perf_pmu (interrupts-sync)
[366.278950] Starting subtest: interrupts-sync
[367.360781] Subtest interrupts-sync: SUCCESS (1.072s)
[367.460833] [054/133] (658s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[367.547363] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[367.548204] Starting dynamic subtest: pipe-A-eDP-1
[367.556805] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.564670] Starting dynamic subtest: pipe-B-eDP-1
[367.581795] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.589833] Starting dynamic subtest: pipe-C-eDP-1
[367.603652] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.610915] Starting dynamic subtest: pipe-D-eDP-1
[367.619674] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.621361] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[369.747392] [055/133] (656s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[369.840126] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[369.842076] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[369.908438] [056/133] (655s left) gem_exec_parallel (contexts)
[369.963696] Starting subtest: contexts
[369.964655] Starting dynamic subtest: rcs0
[372.901602] Dynamic subtest rcs0: SUCCESS (2.928s)
[372.912315] Starting dynamic subtest: bcs0
[376.383038] Dynamic subtest bcs0: SUCCESS (3.480s)
[376.394874] Starting dynamic subtest: vcs0
[380.388054] Dynamic subtest vcs0: SUCCESS (4.004s)
[380.397709] Starting dynamic subtest: vcs1
[384.411045] Dynamic subtest vcs1: SUCCESS (4.019s)
[384.421495] Starting dynamic subtest: vecs0
[388.456923] Dynamic subtest vecs0: SUCCESS (4.043s)
[388.465685] Starting dynamic subtest: ccs0
[392.146236] Dynamic subtest ccs0: SUCCESS (3.686s)
[392.147527] Subtest contexts: SUCCESS (22.175s)
[392.326953] [057/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[392.420220] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[392.422166] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[392.534574] [058/133] (633s left) kms_addfb_basic (unused-handle)
[392.596502] Starting subtest: unused-handle
[392.597387] Subtest unused-handle: SUCCESS (0.000s)
[392.722294] [059/133] (633s left) kms_joiner (invalid-modeset-big-joiner)
[392.816532] Starting subtest: invalid-modeset-big-joiner
[392.818078] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[392.887049] [060/133] (633s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[392.994884] Starting subtest: cursor-vs-flip-varying-size
[424.497523] Subtest cursor-vs-flip-varying-size: SUCCESS (31.502s)
[425.373849] [061/133] (600s left) gem_exec_schedule (independent)
[425.429439] Starting subtest: independent
[425.430609] Starting dynamic subtest: rcs0
[426.910519] Dynamic subtest rcs0: SUCCESS (1.471s)
[426.918464] Starting dynamic subtest: vcs0
[428.900565] Dynamic subtest vcs0: SUCCESS (1.987s)
[428.908624] Starting dynamic subtest: vcs1
[430.956665] Dynamic subtest vcs1: SUCCESS (2.053s)
[430.967375] Starting dynamic subtest: vecs0
[432.877401] Dynamic subtest vecs0: SUCCESS (1.917s)
[432.888450] Starting dynamic subtest: ccs0
[434.910647] Dynamic subtest ccs0: SUCCESS (2.031s)
[434.912069] Subtest independent: SUCCESS (9.473s)
[435.203412] [062/133] (590s left) kms_plane_scaling (planes-scaler-unity-scaling)
[435.301484] Starting subtest: planes-scaler-unity-scaling
[435.302428] Starting dynamic subtest: pipe-A
[435.365782] Dynamic subtest pipe-A: SUCCESS (0.064s)
[435.377142] Starting dynamic subtest: pipe-B
[436.500189] Dynamic subtest pipe-B: SUCCESS (1.133s)
[436.511200] Starting dynamic subtest: pipe-C
[437.610117] Dynamic subtest pipe-C: SUCCESS (1.108s)
[437.618841] Starting dynamic subtest: pipe-D
[438.764168] Dynamic subtest pipe-D: SUCCESS (1.151s)
[438.765221] Subtest planes-scaler-unity-scaling: SUCCESS (3.462s)
[439.934219] [063/133] (586s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[439.983172] Starting subtest: multi-wait-for-submit-submitted-signaled
[439.984207] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[440.069514] [064/133] (586s left) syncobj_wait (invalid-signal-one-illegal-handle)
[440.125604] Starting subtest: invalid-signal-one-illegal-handle
[440.126532] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[440.218698] [065/133] (585s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[440.309383] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[440.310283] Starting dynamic subtest: pipe-A-default-mode
[441.485630] Dynamic subtest pipe-A-default-mode: SKIP (1.174s)
[441.487553] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.176s)
[441.618318] [066/133] (584s left) gem_basic (create-close)
[441.687198] Starting subtest: create-close
[441.688870] Subtest create-close: SUCCESS (0.000s)
[441.766482] [067/133] (584s left) gem_ctx_param (invalid-get-ringsize)
[441.811466] Starting subtest: invalid-get-ringsize
[441.812434] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[441.900383] [068/133] (584s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[442.011445] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[474.148322] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.134s)
[474.999131] [069/133] (551s left) kms_frontbuffer_tracking (fbc-tiling-y)
[475.087385] Starting subtest: fbc-tiling-y
[475.089349] Subtest fbc-tiling-y: SKIP (0.000s)
[475.176732] [070/133] (551s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[475.270033] Starting subtest: extended-modeset-hang-newfb-with-reset
[475.270918] Starting dynamic subtest: pipe-A
[489.114689] Dynamic subtest pipe-A: SUCCESS (13.842s)
[489.124185] Starting dynamic subtest: pipe-D
[505.001106] Dynamic subtest pipe-D: SUCCESS (15.884s)
[505.001868] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.730s)
[505.793164] [071/133] (520s left) gem_pxp (hw-rejects-pxp-buffer)
[505.918234] Starting subtest: hw-rejects-pxp-buffer
[505.920186] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[506.020494] [072/133] (520s left) api_intel_bb (reset-bb)
[506.065612] Starting subtest: reset-bb
[506.068023] Subtest reset-bb: SUCCESS (0.003s)
[506.178957] [073/133] (520s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[506.287285] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[506.288931] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[506.427955] [074/133] (520s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[506.536431] Starting subtest: basic-flip-after-cursor-legacy
[507.450028] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.913s)
[508.330221] [075/133] (518s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[508.455984] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[518.151606] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.695s)
[518.955999] [076/133] (507s left) kms_cursor_crc (cursor-offscreen-128x128)
[519.156390] Starting subtest: cursor-offscreen-128x128
[519.162526] Starting dynamic subtest: pipe-A-eDP-1
[521.095131] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[521.129495] Starting dynamic subtest: pipe-D-eDP-1
[523.675511] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[523.676330] Subtest cursor-offscreen-128x128: SUCCESS (4.519s)
[524.513407] [077/133] (502s left) kms_prime (basic-crc-hybrid)
[524.600745] Subtest basic-crc-hybrid: SKIP (0.000s)
[524.703177] [078/133] (501s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[524.784209] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[524.785814] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.881667] [079/133] (501s left) i915_suspend (fence-restore-untiled)
[524.934440] Starting subtest: fence-restore-untiled
[524.935932] Subtest fence-restore-untiled: SKIP (0.000s)
[525.018932] [080/133] (501s left) kms_pm_dc (dc3co-vpb-simulation)
[526.110221] Starting subtest: dc3co-vpb-simulation
[535.326640] Subtest dc3co-vpb-simulation: SKIP (9.169s)
[535.397954] [081/133] (491s left) gem_wait (write-wait)
[535.455829] Starting subtest: write-wait
[535.456682] Starting dynamic subtest: all-engines
[536.587190] Dynamic subtest all-engines: SUCCESS (1.131s)
[536.598115] Starting dynamic subtest: rcs0
[537.651291] Dynamic subtest rcs0: SUCCESS (1.061s)
[537.669082] Starting dynamic subtest: bcs0
[538.710896] Dynamic subtest bcs0: SUCCESS (1.057s)
[538.729932] Starting dynamic subtest: vcs0
[539.766716] Dynamic subtest vcs0: SUCCESS (1.054s)
[539.786390] Starting dynamic subtest: vcs1
[540.822542] Dynamic subtest vcs1: SUCCESS (1.053s)
[540.840084] Starting dynamic subtest: vecs0
[541.876100] Dynamic subtest vecs0: SUCCESS (1.051s)
[541.893489] Starting dynamic subtest: ccs0
[542.932991] Dynamic subtest ccs0: SUCCESS (1.054s)
[542.936236] Subtest write-wait: SUCCESS (7.478s)
[543.132585] [082/133] (483s left) gem_mmap_gtt (big-bo-tiledx)
[543.184645] Subtest big-bo-tiledX: SKIP (0.000s)
[543.248590] [083/133] (483s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[543.876061] Starting subtest: syncobj-timeline-invalid-wait
[543.877119] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.008s)
[544.977118] [084/133] (481s left) kms_chamelium_audio (dp-audio)
[545.365976] Subtest dp-audio: SKIP (0.000s)
[546.132207] [085/133] (480s left) syncobj_wait (wait-delayed-signal)
[546.181792] Starting subtest: wait-delayed-signal
[546.285648] Subtest wait-delayed-signal: SUCCESS (0.103s)
[546.365020] [086/133] (480s left) template (b)
[546.411606] Starting subtest: B
[546.412565] Subtest B: SUCCESS (0.000s)
[546.497663] [087/133] (480s left) gem_exec_nop (basic-parallel)
[546.546760] Starting subtest: basic-parallel
[562.849657] Subtest basic-parallel: SUCCESS (16.293s)
[563.069877] [088/133] (463s left) syncobj_timeline (signal-point-0)
[563.119626] Starting subtest: signal-point-0
[563.120443] Subtest signal-point-0: SUCCESS (0.000s)
[563.208893] [089/133] (463s left) kms_sequence (queue-busy)
[563.309097] Starting subtest: queue-busy
[563.311186] Starting dynamic subtest: pipe-A-eDP-1
[565.252218] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[565.262814] Starting dynamic subtest: pipe-B-eDP-1
[567.878122] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s)
[567.887237] Starting dynamic subtest: pipe-C-eDP-1
[570.478420] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[570.487211] Starting dynamic subtest: pipe-D-eDP-1
[573.029672] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[573.030607] Subtest queue-busy: SUCCESS (9.720s)
[573.844978] [090/133] (453s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[573.931206] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[573.932256] Starting dynamic subtest: pipe-A-eDP-1
[573.941109] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[573.949951] Starting dynamic subtest: pipe-B-eDP-1
[573.958876] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[573.967678] Starting dynamic subtest: pipe-C-eDP-1
[573.975470] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[573.984029] Starting dynamic subtest: pipe-D-eDP-1
[573.992327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.994051] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[576.184668] [091/133] (450s left) gem_create (create-ext-placement-sanity-check)
[576.367235] Starting subtest: create-ext-placement-sanity-check
[576.368193] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[576.446304] [092/133] (450s left) gem_exec_params (dr4-dirt)
[576.497784] Starting subtest: DR4-dirt
[576.498716] Subtest DR4-dirt: SUCCESS (0.000s)
[576.618205] [093/133] (450s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[576.703127] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[580.980564] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.277s)
[582.098793] [094/133] (445s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[582.229353] Starting subtest: cursorA-vs-flipB-atomic
[582.231138] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[582.380671] [095/133] (444s left) vgem_basic (dmabuf-fence)
[582.435943] Starting subtest: dmabuf-fence
[582.436856] Subtest dmabuf-fence: SUCCESS (0.001s)
[582.522237] [096/133] (444s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[582.606560] Starting subtest: pr-primary-plane-update-sf-dmg-area
[582.608248] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[582.675308] [097/133] (444s left) kms_flip (2x-flip-vs-dpms-on-nop)
[582.761999] Starting subtest: 2x-flip-vs-dpms-on-nop
[582.786019] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.024s)
[582.871890] [098/133] (444s left) gem_exec_balancer (parallel-bb-first)
[583.145862] Starting subtest: parallel-bb-first
[584.188552] Subtest parallel-bb-first: SUCCESS (1.042s)
[584.951164] [099/133] (442s left) i915_drm_fdinfo (memory-info-resident)
[584.991073] Starting subtest: memory-info-resident
[584.991947] Starting dynamic subtest: smem0
[587.779501] Dynamic subtest smem0: SUCCESS (2.788s)
[587.781664] Subtest memory-info-resident: SUCCESS (2.789s)
[587.859314] [100/133] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[587.951594] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[594.703473] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.752s)
[594.836196] [101/133] (432s left) gem_softpin (safe-alignment)
[594.895587] Starting subtest: safe-alignment
[594.938952] Subtest safe-alignment: SUCCESS (0.043s)
[596.926946] [102/133] (430s left) gem_softpin (evict-snoop)
[596.989701] Starting subtest: evict-snoop
[596.991526] Subtest evict-snoop: SKIP (0.000s)
[597.095357] [103/133] (430s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[597.200268] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[597.201967] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[597.288517] [104/133] (430s left) kms_psr (psr2-dpms)
[597.388686] Starting subtest: psr2-dpms
[597.389776] Starting dynamic subtest: eDP-1
[600.268913] Dynamic subtest eDP-1: SUCCESS (2.881s)
[600.269802] Subtest psr2-dpms: SUCCESS (2.882s)
[601.138264] [105/133] (426s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[601.186122] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[601.187153] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[601.270441] [106/133] (426s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[601.324347] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[601.425495] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[601.499958] [107/133] (426s left) gem_exec_balancer (parallel-out-fence)
[601.767289] Starting subtest: parallel-out-fence
[603.055431] Subtest parallel-out-fence: SUCCESS (1.288s)
[603.145538] [108/133] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[603.245033] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[603.247368] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[603.343462] [109/133] (424s left) api_intel_allocator (fork-simple-stress)
[603.389383] Starting subtest: fork-simple-stress
[608.832084] Subtest fork-simple-stress: SUCCESS (5.397s)
[608.903110] [110/133] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[609.002949] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[609.004824] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[609.119821] [111/133] (418s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[609.218941] Starting subtest: 4-tiled-8bpp-rotate-90
[609.240939] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[609.391519] [112/133] (418s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[609.493984] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[609.496603] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[609.614946] [113/133] (418s left) dmabuf_sync_file (import-multiple-read-only)
[609.655382] Starting subtest: import-multiple-read-only
[609.658193] Subtest import-multiple-read-only: SUCCESS (0.003s)
[609.713666] [114/133] (418s left) kms_async_flips (test-time-stamp-atomic)
[609.812739] Starting subtest: test-time-stamp-atomic
[610.199839] Starting dynamic subtest: pipe-A-eDP-1
[611.040499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s)
[611.432513] Starting dynamic subtest: pipe-B-eDP-1
[612.182469] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[612.574695] Starting dynamic subtest: pipe-C-eDP-1
[613.334279] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[613.701101] Starting dynamic subtest: pipe-D-eDP-1
[614.468894] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[614.469922] Subtest test-time-stamp-atomic: SUCCESS (4.656s)
[615.629986] [115/133] (412s left) kms_psr (psr-sprite-mmap-cpu)
[615.724792] Starting subtest: psr-sprite-mmap-cpu
[615.725833] Starting dynamic subtest: eDP-1
[617.437813] Dynamic subtest eDP-1: SUCCESS (1.712s)
[617.438975] Subtest psr-sprite-mmap-cpu: SUCCESS (1.713s)
[618.281848] [116/133] (409s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[618.369505] Starting subtest: psr-rgb101010-draw-mmap-gtt
[618.371103] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[618.471789] [117/133] (409s left) perf_pmu (rc6-suspend)
[618.511881] Starting subtest: rc6-suspend
[641.229518] Subtest rc6-suspend: SUCCESS (7.941s)
[642.555361] [118/133] (386s left) gem_exec_whisper (basic-queues-forked)
[642.611959] Starting subtest: basic-queues-forked
[665.989379] Subtest basic-queues-forked: SUCCESS (23.708s)
[666.164215] [119/133] (362s left) gem_exec_store (dword)
[666.230018] Starting subtest: dword
[666.230929] Starting dynamic subtest: rcs0
[666.316601] Dynamic subtest rcs0: SUCCESS (0.087s)
[666.330910] Starting dynamic subtest: bcs0
[666.360164] Dynamic subtest bcs0: SUCCESS (0.042s)
[666.370939] Starting dynamic subtest: vcs0
[666.402941] Dynamic subtest vcs0: SUCCESS (0.042s)
[666.413964] Starting dynamic subtest: vcs1
[666.445369] Dynamic subtest vcs1: SUCCESS (0.041s)
[666.455804] Starting dynamic subtest: vecs0
[666.488586] Dynamic subtest vecs0: SUCCESS (0.041s)
[666.499904] Starting dynamic subtest: ccs0
[666.536296] Dynamic subtest ccs0: SUCCESS (0.046s)
[666.538889] Subtest dword: SUCCESS (0.310s)
[666.718561] [120/133] (362s left) kms_psr (fbc-pr-primary-mmap-gtt)
[666.806073] Starting subtest: fbc-pr-primary-mmap-gtt
[666.807975] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[666.886458] [121/133] (362s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[666.939465] Starting subtest: etime-multi-wait-all-for-submit-submitted
[667.040685] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[667.112821] [122/133] (362s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[667.234022] Starting subtest: cursorA-vs-flipA-atomic-transitions
[678.400819] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.176s)
[679.223392] [123/133] (350s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[679.330275] Starting subtest: fbc-psr2-sprite-mmap-gtt
[679.331263] Starting dynamic subtest: eDP-1
[679.333179] Dynamic subtest eDP-1: SKIP (0.000s)
[679.335097] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[679.405870] [124/133] (349s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[679.493544] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[679.495217] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[679.590346] [125/133] (349s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[679.681367] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[688.654272] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.970s)
[688.785509] [126/133] (340s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[689.160587] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[689.968218] [127/133] (339s left) kms_plane_alpha_blend (alpha-basic)
[690.060996] Starting subtest: alpha-basic
[690.369810] Starting dynamic subtest: pipe-A-eDP-1
[692.304136] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[692.332138] Starting dynamic subtest: pipe-D-eDP-1
[694.963690] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.640s)
[694.964559] Subtest alpha-basic: SUCCESS (4.903s)
[695.761396] [128/133] (333s left) kms_plane_multiple (tiling-none)
[695.853819] Starting subtest: tiling-none
[695.854649] Starting dynamic subtest: pipe-A-eDP-1
[699.548861] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.695s)
[699.558063] Starting dynamic subtest: pipe-B-eDP-1
[704.069436] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.519s)
[704.078713] Starting dynamic subtest: pipe-C-eDP-1
[708.386300] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.317s)
[708.396476] Starting dynamic subtest: pipe-D-eDP-1
[712.732597] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.345s)
[712.733654] Subtest tiling-none: SUCCESS (16.882s)
[713.525945] [129/133] (315s left) gem_userptr_blits (stress-mm)
[713.605938] Starting subtest: stress-mm
[719.017900] Subtest stress-mm: SUCCESS (5.369s)
[719.084523] [130/133] (310s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[719.184066] Starting subtest: fbc-rgb101010-draw-mmap-wc
[723.740329] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.550s)
[724.854145] [131/133] (304s left) kms_properties (plane-properties-legacy)
[724.941866] Starting subtest: plane-properties-legacy
[724.942713] Starting dynamic subtest: pipe-A-eDP-1
[725.502214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[725.511525] Starting dynamic subtest: pipe-B-eDP-1
[726.805936] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[726.816840] Starting dynamic subtest: pipe-C-eDP-1
[728.053641] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.247s)
[728.064734] Starting dynamic subtest: pipe-D-eDP-1
[729.301411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[729.302287] Subtest plane-properties-legacy: SUCCESS (4.361s)
[730.097238] [132/133] (299s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[730.192690] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[736.980810] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.791s)
[737.090152] [133/133] (292s left) gem_mmap_gtt (bad-object)
[737.142409] Subtest bad-object: SKIP (0.000s)
[737.196354] 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.