[58.485471] Initializing watchdogs
[58.485515]   /dev/watchdog0
[58.499235] [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.503772] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.506309] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.509748] [001/133] (960s left) kms_fb_coherency (memset-crc)
[58.628123] Starting subtest: memset-crc
[58.630621] Starting dynamic subtest: mmap-offset-wc
[59.064151] Dynamic subtest mmap-offset-wc: SUCCESS (0.435s)
[59.365741] Starting dynamic subtest: mmap-offset-uc
[65.331272] Dynamic subtest mmap-offset-uc: SUCCESS (5.949s)
[65.615996] Subtest memset-crc: SUCCESS (6.963s)
[66.437071] [002/133] (952s left) gem_exec_reloc (basic-write-wc)
[66.502319] Subtest basic-write-wc: SKIP (0.000s)
[66.575173] [003/133] (952s left) gem_exec_params (invalid-bsd2-flag-on-render)
[66.625676] Starting subtest: invalid-bsd2-flag-on-render
[66.628099] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[66.719876] [004/133] (952s left) gem_render_copy (linear)
[66.795228] Starting subtest: linear
[66.797646] Starting dynamic subtest: smem
[66.835738] Dynamic subtest smem: SUCCESS (0.040s)
[66.838479] Subtest linear: SUCCESS (0.041s)
[67.397817] [005/133] (951s left) core_auth (basic-auth)
[67.503095] Starting subtest: basic-auth
[67.505555] Subtest basic-auth: SUCCESS (0.002s)
[67.705207] [006/133] (951s left) kms_flip (flip-vs-modeset-vs-hang)
[67.830788] Starting subtest: flip-vs-modeset-vs-hang
[67.833267] Starting dynamic subtest: A-eDP1
[119.345932] Dynamic subtest A-eDP1: SUCCESS (51.496s)
[119.356736] Starting dynamic subtest: D-eDP1
[169.452800] Dynamic subtest D-eDP1: SUCCESS (50.101s)
[169.455352] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.604s)
[169.851906] [007/133] (849s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[169.949145] Starting subtest: plane-primary-toggle-with-vblank-wait
[169.951438] Starting dynamic subtest: pipe-A-eDP-1
[170.124864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s)
[170.431965] Starting dynamic subtest: pipe-B-eDP-1
[171.359717] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.935s)
[171.676421] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.726s)
[172.529255] [008/133] (846s left) kms_frontbuffer_tracking (fbc-1p-rte)
[172.623120] Starting subtest: fbc-1p-rte
[178.089685] Subtest fbc-1p-rte: SUCCESS (5.470s)
[179.227300] [009/133] (840s left) prime_vgem (basic-fence-flip)
[179.344898] Starting subtest: basic-fence-flip
[179.630992] Subtest basic-fence-flip: SUCCESS (0.286s)
[179.739925] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[179.743325] [010/133] (839s left) gem_ctx_shared (q-independent)
[179.807380] Starting subtest: Q-independent
[179.809871] Starting dynamic subtest: rcs0
[179.873091] Dynamic subtest rcs0: SUCCESS (0.065s)
[179.883071] Starting dynamic subtest: vcs0
[179.914054] Dynamic subtest vcs0: SUCCESS (0.042s)
[179.924075] Starting dynamic subtest: vcs1
[179.950295] Dynamic subtest vcs1: SUCCESS (0.036s)
[179.958575] Starting dynamic subtest: vecs0
[179.991854] Dynamic subtest vecs0: SUCCESS (0.041s)
[180.001278] Starting dynamic subtest: ccs0
[180.036066] Dynamic subtest ccs0: SUCCESS (0.044s)
[180.038343] Subtest Q-independent: SUCCESS (0.230s)
[181.995340] [011/133] (837s left) kms_color_pipeline (plane-lut1d)
[182.103128] Starting subtest: plane-lut1d
[182.273806] Starting dynamic subtest: pipe-A-plane-0
[182.415593] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[182.423782] Starting dynamic subtest: pipe-A-plane-1
[182.548809] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[182.557676] Starting dynamic subtest: pipe-A-plane-2
[182.682318] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[183.910953] Starting dynamic subtest: pipe-B-plane-0
[184.048581] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[184.057338] Starting dynamic subtest: pipe-B-plane-1
[184.182131] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[184.189760] Starting dynamic subtest: pipe-B-plane-2
[184.315652] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[185.533800] Starting dynamic subtest: pipe-C-plane-0
[185.659478] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[185.668318] Starting dynamic subtest: pipe-C-plane-1
[185.793111] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[185.803195] Starting dynamic subtest: pipe-C-plane-2
[185.937192] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[187.165343] Starting dynamic subtest: pipe-D-plane-0
[187.302184] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[187.311734] Starting dynamic subtest: pipe-D-plane-1
[187.436040] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[187.444734] Starting dynamic subtest: pipe-D-plane-2
[187.602712] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[187.890488] Subtest plane-lut1d: SUCCESS (5.786s)
[188.752040] [012/133] (830s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[188.807770] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[188.867271] [013/133] (830s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[188.961329] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[188.963659] Starting dynamic subtest: pipe-A-eDP-1
[189.105407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.133s)
[189.115058] Starting dynamic subtest: pipe-B-eDP-1
[189.135080] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[189.142162] Starting dynamic subtest: pipe-C-eDP-1
[189.161208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[189.170124] Starting dynamic subtest: pipe-D-eDP-1
[189.189543] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[189.191770] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.140s)
[191.436514] [014/133] (828s left) kms_psr (pr-sprite-plane-move)
[191.524296] Starting subtest: pr-sprite-plane-move
[191.528672] Subtest pr-sprite-plane-move: SKIP (0.000s)
[191.610050] [015/133] (827s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[191.709843] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[191.712155] Starting dynamic subtest: pipe-A-eDP-1
[191.774227] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[191.782521] Starting dynamic subtest: pipe-B-eDP-1
[191.841696] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[191.850234] Starting dynamic subtest: pipe-C-eDP-1
[191.908633] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[191.917482] Starting dynamic subtest: pipe-D-eDP-1
[191.975064] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[191.979437] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[193.970140] [016/133] (825s left) gem_mmap_gtt (basic-small-copy-xy)
[194.044376] Subtest basic-small-copy-XY: SKIP (0.000s)
[194.110639] [017/133] (825s left) gem_ctx_persistence (saturated-hostile)
[194.184820] Starting subtest: saturated-hostile
[194.187185] Starting dynamic subtest: rcs0
[195.004843] Dynamic subtest rcs0: SUCCESS (0.819s)
[195.018864] Starting dynamic subtest: bcs0
[195.794311] Dynamic subtest bcs0: SUCCESS (0.789s)
[195.804691] Starting dynamic subtest: vcs0
[196.564407] Dynamic subtest vcs0: SUCCESS (0.768s)
[196.574466] Starting dynamic subtest: vcs1
[197.366643] Dynamic subtest vcs1: SUCCESS (0.801s)
[197.376575] Starting dynamic subtest: vecs0
[198.160615] Dynamic subtest vecs0: SUCCESS (0.792s)
[198.171189] Starting dynamic subtest: ccs0
[199.010246] Dynamic subtest ccs0: SUCCESS (0.849s)
[199.012988] Subtest saturated-hostile: SUCCESS (4.825s)
[199.094215] [018/133] (820s left) kms_getfb (getfb2-handle-protection)
[199.191943] Starting subtest: getfb2-handle-protection
[199.216851] Subtest getfb2-handle-protection: SUCCESS (0.025s)
[199.323838] [019/133] (820s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[199.423327] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[199.427768] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[199.520670] [020/133] (820s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[199.616101] Starting subtest: async-flip-with-page-flip-events-tiled
[199.986941] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[202.740276] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[202.748087] Starting dynamic subtest: pipe-A-eDP-1-4
[204.914514] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[204.922877] Starting dynamic subtest: pipe-A-eDP-1-4
[206.924884] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[206.932908] Starting dynamic subtest: pipe-A-eDP-1-x
[209.103649] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[209.497817] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[212.278192] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[212.285928] Starting dynamic subtest: pipe-B-eDP-1-4
[214.462902] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[214.470669] Starting dynamic subtest: pipe-B-eDP-1-4
[216.473093] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[216.480773] Starting dynamic subtest: pipe-B-eDP-1-x
[218.663571] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[219.029740] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[221.806956] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[221.815687] Starting dynamic subtest: pipe-C-eDP-1-4
[223.982088] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[223.992333] Starting dynamic subtest: pipe-C-eDP-1-4
[225.991815] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[226.000667] Starting dynamic subtest: pipe-C-eDP-1-x
[228.170386] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[228.546698] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[231.340054] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[231.350774] Starting dynamic subtest: pipe-D-eDP-1-4
[233.514546] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[233.522431] Starting dynamic subtest: pipe-D-eDP-1-4
[235.525470] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[235.533072] Starting dynamic subtest: pipe-D-eDP-1-x
[237.703897] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[237.706498] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.086s)
[238.937264] [021/133] (780s left) perf_pmu (semaphore-wait-idle)
[238.973190] Starting subtest: semaphore-wait-idle
[238.975507] Starting dynamic subtest: rcs0
[239.486370] Dynamic subtest rcs0: SUCCESS (0.513s)
[239.496846] Starting dynamic subtest: bcs0
[240.001718] Dynamic subtest bcs0: SUCCESS (0.512s)
[240.013087] Starting dynamic subtest: vcs0
[240.515239] Dynamic subtest vcs0: SUCCESS (0.511s)
[240.525882] Starting dynamic subtest: vcs1
[241.027045] Dynamic subtest vcs1: SUCCESS (0.511s)
[241.038241] Starting dynamic subtest: vecs0
[241.540211] Dynamic subtest vecs0: SUCCESS (0.511s)
[241.550044] Starting dynamic subtest: ccs0
[242.054037] Dynamic subtest ccs0: SUCCESS (0.513s)
[242.056932] Subtest semaphore-wait-idle: SUCCESS (3.081s)
[242.170804] [022/133] (777s left) syncobj_wait (wait-for-submit-snapshot)
[242.220852] Starting subtest: wait-for-submit-snapshot
[242.301862] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[242.396353] [023/133] (777s left) vgem_basic (setversion)
[242.445495] Starting subtest: setversion
[242.450095] Subtest setversion: SUCCESS (0.000s)
[242.501109] [024/133] (777s left) gem_exec_schedule (u-independent)
[242.585805] Starting subtest: u-independent
[242.588121] Starting dynamic subtest: rcs0
[243.927779] Dynamic subtest rcs0: SUCCESS (1.348s)
[243.938757] Starting dynamic subtest: vcs0
[245.922383] Dynamic subtest vcs0: SUCCESS (1.993s)
[245.935203] Starting dynamic subtest: vcs1
[247.904593] Dynamic subtest vcs1: SUCCESS (1.981s)
[247.915142] Starting dynamic subtest: vecs0
[249.952722] Dynamic subtest vecs0: SUCCESS (2.047s)
[249.963382] Starting dynamic subtest: ccs0
[251.928447] Dynamic subtest ccs0: SUCCESS (1.974s)
[251.931266] Subtest u-independent: SUCCESS (9.350s)
[252.225547] [025/133] (767s left) kms_vblank (wait-forked-busy)
[252.327746] Starting subtest: wait-forked-busy
[252.329683] Starting dynamic subtest: pipe-A-eDP-1
[254.206114] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[254.221279] Starting dynamic subtest: pipe-D-eDP-1
[256.781562] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.572s)
[256.783909] Subtest wait-forked-busy: SUCCESS (4.453s)
[257.584070] [026/133] (762s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[257.964781] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[258.785201] [027/133] (761s left) gem_softpin (noreloc)
[258.862904] Starting subtest: noreloc
[264.272524] Subtest noreloc: SUCCESS (5.408s)
[264.399939] [028/133] (755s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[264.504204] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[264.506412] Starting dynamic subtest: pipe-A-eDP-1
[275.816419] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.316s)
[275.824359] Starting dynamic subtest: pipe-B-eDP-1
[287.816844] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.998s)
[287.819056] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.317s)
[288.661421] [029/133] (731s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[288.827156] Starting subtest: cursor-rapid-movement-32x10
[288.872435] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[289.140614] [030/133] (731s left) sysfs_heartbeat_interval (nopreempt)
[289.214598] Starting subtest: nopreempt
[289.216948] Starting dynamic subtest: vecs0
[298.904688] Dynamic subtest vecs0: SUCCESS (9.685s)
[298.913088] Starting dynamic subtest: ccs0
[302.919736] Dynamic subtest ccs0: SUCCESS (4.017s)
[302.930481] Starting dynamic subtest: vcs0
[312.914845] Dynamic subtest vcs0: SUCCESS (9.989s)
[312.925890] Starting dynamic subtest: bcs0
[316.828027] Dynamic subtest bcs0: SUCCESS (3.913s)
[316.838712] Starting dynamic subtest: rcs0
[320.910159] Dynamic subtest rcs0: SUCCESS (4.080s)
[320.920663] Starting dynamic subtest: vcs1
[330.902528] Dynamic subtest vcs1: SUCCESS (9.989s)
[330.905065] Subtest nopreempt: SUCCESS (41.684s)
[330.976761] [031/133] (689s left) kms_plane (plane-panning-top-left)
[331.086252] Starting subtest: plane-panning-top-left
[331.088550] Starting dynamic subtest: pipe-A
[332.805428] Dynamic subtest pipe-A: SUCCESS (1.719s)
[332.814159] Starting dynamic subtest: pipe-B
[335.192234] Dynamic subtest pipe-B: SUCCESS (2.385s)
[335.194550] Subtest plane-panning-top-left: SUCCESS (4.106s)
[336.071390] [032/133] (684s left) kms_cursor_crc (cursor-sliding-32x10)
[336.246707] Starting subtest: cursor-sliding-32x10
[336.309694] Subtest cursor-sliding-32x10: SKIP (0.056s)
[336.589593] [033/133] (683s left) gem_exec_suspend (basic-s4-devices)
[336.666454] Starting subtest: basic-S4-devices
[336.668889] Starting dynamic subtest: smem
[347.926749] Dynamic subtest smem: SUCCESS (11.257s)
[347.929895] Subtest basic-S4-devices: SUCCESS (11.259s)
[355.126176] [034/133] (672s left) gem_exec_suspend (basic)
[355.204110] Starting subtest: basic
[355.206475] Starting dynamic subtest: smem
[356.886714] Dynamic subtest smem: SUCCESS (1.680s)
[356.889606] Subtest basic: SUCCESS (1.682s)
[357.074130] [035/133] (670s left) kms_lease (empty-lease)
[357.164208] Starting subtest: empty-lease
[357.166599] Starting dynamic subtest: pipe-A-eDP-1
[357.168911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[357.183565] Starting dynamic subtest: pipe-B-eDP-1
[357.185897] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[357.198079] Starting dynamic subtest: pipe-C-eDP-1
[357.200168] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[357.208579] Starting dynamic subtest: pipe-D-eDP-1
[357.210447] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[357.212324] Subtest empty-lease: SUCCESS (0.008s)
[357.267623] [036/133] (670s left) gem_exec_params (rs-invalid)
[357.323245] Starting subtest: rs-invalid
[357.329135] Subtest rs-invalid: SUCCESS (0.003s)
[357.460549] [037/133] (670s left) gem_mmap_wc (write-gtt-read-wc)
[357.517299] Subtest write-gtt-read-wc: SKIP (0.000s)
[357.576465] [038/133] (669s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[357.669439] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[357.673685] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[357.769251] [039/133] (669s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[357.839269] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[357.843800] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[358.022918] [040/133] (669s left) gen7_exec_parse (oacontrol-tracking)
[358.076681] Subtest oacontrol-tracking: SKIP (0.000s)
[358.143373] [041/133] (669s left) perf (gen12-mi-rpc)
[358.263634] Starting subtest: gen12-mi-rpc
[358.265990] Starting dynamic subtest: rcs0
[358.283977] Dynamic subtest rcs0: SUCCESS (0.019s)
[358.285879] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[358.331391] [042/133] (669s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[358.459913] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[358.591848] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s)
[358.710139] [043/133] (669s left) gem_mmap_offset (isolation)
[358.764766] Starting subtest: isolation
[358.782593] Subtest isolation: SUCCESS (0.012s)
[358.909353] [044/133] (668s left) kms_properties (colorop-properties-legacy)
[359.006088] Starting subtest: colorop-properties-legacy
[359.008137] Starting dynamic subtest: pipe-A-eDP-1
[359.377225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s)
[359.387460] Starting dynamic subtest: pipe-B-eDP-1
[360.489415] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.114s)
[360.500147] Starting dynamic subtest: pipe-C-eDP-1
[361.527670] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[361.537466] Starting dynamic subtest: pipe-D-eDP-1
[362.562290] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s)
[362.564658] Subtest colorop-properties-legacy: SUCCESS (3.559s)
[363.374067] [045/133] (664s left) gem_ccs (block-multicopy-compressed)
[363.428044] Starting subtest: block-multicopy-compressed
[363.432420] Subtest block-multicopy-compressed: SKIP (0.000s)
[363.537491] [046/133] (664s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[363.593965] Starting subtest: invalid-signal-one-illegal-handle
[363.596304] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[363.699916] [047/133] (664s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[363.784510] Starting subtest: yf-tiled-32bpp-rotate-270
[363.788774] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[363.878410] [048/133] (664s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[364.004727] Starting subtest: dp-mst-type-0-suspend-resume
[364.009305] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[364.119290] [049/133] (663s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[364.185504] Starting subtest: multi-wait-available-unsubmitted-submitted
[364.187878] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[364.300732] [050/133] (663s left) i915_module_load (reload)
[364.337899] Starting subtest: reload
[369.062862] Subtest reload: SUCCESS (4.723s)
[369.103421] [051/133] (659s left) i915_pm_freq_mult (media-freq)
[370.878252] Starting subtest: media-freq
[370.880599] Starting dynamic subtest: gt0
[370.885265] Dynamic subtest gt0: SKIP (0.000s)
[370.895324] Starting dynamic subtest: gt1
[370.899897] Dynamic subtest gt1: SKIP (0.000s)
[370.904294] Subtest media-freq: SKIP (0.002s)
[370.994463] [052/133] (657s left) kms_big_fb (linear-16bpp-rotate-90)
[371.094644] Starting subtest: linear-16bpp-rotate-90
[371.127231] Subtest linear-16bpp-rotate-90: SKIP (0.032s)
[371.250132] [053/133] (656s left) perf_pmu (interrupts-sync)
[371.298643] Starting subtest: interrupts-sync
[372.393582] Subtest interrupts-sync: SUCCESS (1.093s)
[372.512384] [054/133] (655s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[372.613182] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[372.615426] Starting dynamic subtest: pipe-A-eDP-1
[372.637293] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[372.649127] Starting dynamic subtest: pipe-B-eDP-1
[372.669559] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[372.677435] Starting dynamic subtest: pipe-C-eDP-1
[372.698608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[372.706633] Starting dynamic subtest: pipe-D-eDP-1
[372.727896] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[372.732125] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[374.798393] [055/133] (653s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[374.892148] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[374.896248] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[374.967670] [056/133] (653s left) gem_exec_parallel (contexts)
[375.029279] Starting subtest: contexts
[375.031735] Starting dynamic subtest: rcs0
[377.774593] Dynamic subtest rcs0: SUCCESS (2.742s)
[377.786439] Starting dynamic subtest: bcs0
[381.086262] Dynamic subtest bcs0: SUCCESS (3.311s)
[381.098434] Starting dynamic subtest: vcs0
[385.358234] Dynamic subtest vcs0: SUCCESS (4.269s)
[385.370610] Starting dynamic subtest: vcs1
[389.530617] Dynamic subtest vcs1: SUCCESS (4.169s)
[389.542844] Starting dynamic subtest: vecs0
[393.394804] Dynamic subtest vecs0: SUCCESS (3.861s)
[393.404048] Starting dynamic subtest: ccs0
[396.956516] Dynamic subtest ccs0: SUCCESS (3.558s)
[396.958939] Subtest contexts: SUCCESS (21.925s)
[397.161303] [057/133] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[397.269435] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[397.273718] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[397.358706] [058/133] (631s left) kms_addfb_basic (unused-handle)
[397.413069] Starting subtest: unused-handle
[397.414944] Subtest unused-handle: SUCCESS (0.000s)
[397.536676] [059/133] (630s left) kms_joiner (invalid-modeset-big-joiner)
[397.645461] Starting subtest: invalid-modeset-big-joiner
[397.649546] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[397.710244] [060/133] (630s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[397.834502] Starting subtest: cursor-vs-flip-varying-size
[429.014440] Subtest cursor-vs-flip-varying-size: SUCCESS (31.179s)
[429.824550] [061/133] (598s left) gem_exec_schedule (independent)
[429.904768] Starting subtest: independent
[429.907098] Starting dynamic subtest: rcs0
[431.895266] Dynamic subtest rcs0: SUCCESS (2.000s)
[431.907729] Starting dynamic subtest: vcs0
[433.970469] Dynamic subtest vcs0: SUCCESS (2.072s)
[433.984425] Starting dynamic subtest: vcs1
[435.925027] Dynamic subtest vcs1: SUCCESS (1.952s)
[435.936752] Starting dynamic subtest: vecs0
[437.920526] Dynamic subtest vecs0: SUCCESS (1.993s)
[437.930449] Starting dynamic subtest: ccs0
[439.894435] Dynamic subtest ccs0: SUCCESS (1.971s)
[439.897268] Subtest independent: SUCCESS (10.000s)
[440.195932] [062/133] (588s left) kms_plane_scaling (planes-scaler-unity-scaling)
[440.294686] Starting subtest: planes-scaler-unity-scaling
[440.296804] Starting dynamic subtest: pipe-A
[440.356368] Dynamic subtest pipe-A: SUCCESS (0.064s)
[440.365085] Starting dynamic subtest: pipe-B
[441.552983] Dynamic subtest pipe-B: SUCCESS (1.195s)
[441.564661] Starting dynamic subtest: pipe-C
[442.664656] Dynamic subtest pipe-C: SUCCESS (1.110s)
[442.674590] Starting dynamic subtest: pipe-D
[443.796213] Dynamic subtest pipe-D: SUCCESS (1.131s)
[443.798506] Subtest planes-scaler-unity-scaling: SUCCESS (3.504s)
[444.959425] [063/133] (583s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[445.021770] Starting subtest: multi-wait-for-submit-submitted-signaled
[445.023718] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[445.124978] [064/133] (583s left) syncobj_wait (invalid-signal-one-illegal-handle)
[445.183636] Starting subtest: invalid-signal-one-illegal-handle
[445.185598] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[445.280839] [065/133] (583s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[445.368058] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[445.370289] Starting dynamic subtest: pipe-A-default-mode
[446.523364] Dynamic subtest pipe-A-default-mode: SKIP (1.152s)
[446.527448] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.154s)
[446.665412] [066/133] (582s left) gem_basic (create-close)
[446.728630] Starting subtest: create-close
[446.733193] Subtest create-close: SUCCESS (0.000s)
[446.827103] [067/133] (581s left) gem_ctx_param (invalid-get-ringsize)
[446.889056] Starting subtest: invalid-get-ringsize
[446.891506] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[447.005404] [068/133] (581s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[447.119602] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[478.994662] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.874s)
[479.818568] [069/133] (549s left) kms_frontbuffer_tracking (fbc-tiling-y)
[479.934699] Starting subtest: fbc-tiling-y
[479.939260] Subtest fbc-tiling-y: SKIP (0.000s)
[480.032147] [070/133] (548s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[480.146155] Starting subtest: extended-modeset-hang-newfb-with-reset
[480.148490] Starting dynamic subtest: pipe-A
[495.154553] Dynamic subtest pipe-A: SUCCESS (15.007s)
[495.164935] Starting dynamic subtest: pipe-D
[510.727182] Dynamic subtest pipe-D: SUCCESS (15.568s)
[510.729980] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.580s)
[511.533262] [071/133] (517s left) gem_pxp (hw-rejects-pxp-buffer)
[511.653559] Starting subtest: hw-rejects-pxp-buffer
[511.658206] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[511.773248] [072/133] (517s left) api_intel_bb (reset-bb)
[511.820259] Starting subtest: reset-bb
[511.824988] Subtest reset-bb: SUCCESS (0.006s)
[511.936587] [073/133] (517s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[512.052646] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[512.057084] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[512.198202] [074/133] (516s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[512.307310] Starting subtest: basic-flip-after-cursor-legacy
[513.234609] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.925s)
[514.066698] [075/133] (515s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[514.187212] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[523.581677] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.391s)
[524.396592] [076/133] (504s left) kms_cursor_crc (cursor-offscreen-128x128)
[524.612608] Starting subtest: cursor-offscreen-128x128
[524.617605] Starting dynamic subtest: pipe-A-eDP-1
[526.548265] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[526.577224] Starting dynamic subtest: pipe-D-eDP-1
[529.196431] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s)
[529.198610] Subtest cursor-offscreen-128x128: SUCCESS (4.583s)
[530.064104] [077/133] (499s left) kms_prime (basic-crc-hybrid)
[530.156632] Subtest basic-crc-hybrid: SKIP (0.000s)
[530.263768] [078/133] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[530.361927] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[530.366320] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.456118] [079/133] (498s left) i915_suspend (fence-restore-untiled)
[530.512474] Starting subtest: fence-restore-untiled
[530.516606] Subtest fence-restore-untiled: SKIP (0.000s)
[530.612069] [080/133] (498s left) kms_pm_dc (dc3co-vpb-simulation)
[531.712033] Starting subtest: dc3co-vpb-simulation
[540.978864] Subtest dc3co-vpb-simulation: SKIP (9.264s)
[541.109965] [081/133] (488s left) gem_wait (write-wait)
[541.180909] Starting subtest: write-wait
[541.183301] Starting dynamic subtest: all-engines
[542.298270] Dynamic subtest all-engines: SUCCESS (1.116s)
[542.309049] Starting dynamic subtest: rcs0
[543.365544] Dynamic subtest rcs0: SUCCESS (1.065s)
[543.381647] Starting dynamic subtest: bcs0
[544.425739] Dynamic subtest bcs0: SUCCESS (1.058s)
[544.444681] Starting dynamic subtest: vcs0
[545.481841] Dynamic subtest vcs0: SUCCESS (1.054s)
[545.499225] Starting dynamic subtest: vcs1
[546.536818] Dynamic subtest vcs1: SUCCESS (1.053s)
[546.555066] Starting dynamic subtest: vecs0
[547.591591] Dynamic subtest vecs0: SUCCESS (1.053s)
[547.610056] Starting dynamic subtest: ccs0
[548.649727] Dynamic subtest ccs0: SUCCESS (1.056s)
[548.652844] Subtest write-wait: SUCCESS (7.469s)
[548.851981] [082/133] (480s left) gem_mmap_gtt (big-bo-tiledx)
[548.909118] Subtest big-bo-tiledX: SKIP (0.000s)
[548.968100] [083/133] (480s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[549.506521] Starting subtest: syncobj-timeline-invalid-wait
[549.508921] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s)
[550.992600] [084/133] (478s left) kms_chamelium_audio (dp-audio)
[551.389355] Subtest dp-audio: SKIP (0.000s)
[552.164082] [085/133] (477s left) syncobj_wait (wait-delayed-signal)
[552.219606] Starting subtest: wait-delayed-signal
[552.322190] Subtest wait-delayed-signal: SUCCESS (0.103s)
[552.412276] [086/133] (477s left) template (b)
[552.467663] Starting subtest: B
[552.469917] Subtest B: SUCCESS (0.000s)
[552.571453] [087/133] (477s left) gem_exec_nop (basic-parallel)
[552.645744] Starting subtest: basic-parallel
[567.896265] Subtest basic-parallel: SUCCESS (15.258s)
[568.131227] [088/133] (461s left) syncobj_timeline (signal-point-0)
[568.183261] Starting subtest: signal-point-0
[568.185378] Subtest signal-point-0: SUCCESS (0.000s)
[568.285325] [089/133] (461s left) kms_sequence (queue-busy)
[568.382964] Starting subtest: queue-busy
[568.385212] Starting dynamic subtest: pipe-A-eDP-1
[570.319319] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[570.329692] Starting dynamic subtest: pipe-B-eDP-1
[572.896419] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.574s)
[572.906578] Starting dynamic subtest: pipe-C-eDP-1
[575.494861] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[575.504395] Starting dynamic subtest: pipe-D-eDP-1
[578.036765] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[578.039047] Subtest queue-busy: SUCCESS (9.656s)
[578.929758] [090/133] (450s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[579.034880] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[579.037129] Starting dynamic subtest: pipe-A-eDP-1
[579.058674] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[579.070323] Starting dynamic subtest: pipe-B-eDP-1
[579.090094] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[579.099380] Starting dynamic subtest: pipe-C-eDP-1
[579.119692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[579.128786] Starting dynamic subtest: pipe-D-eDP-1
[579.150346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[579.154981] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[581.204874] [091/133] (448s left) gem_create (create-ext-placement-sanity-check)
[581.389144] Starting subtest: create-ext-placement-sanity-check
[581.395532] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[581.504196] [092/133] (448s left) gem_exec_params (dr4-dirt)
[581.572769] Starting subtest: DR4-dirt
[581.575128] Subtest DR4-dirt: SUCCESS (0.000s)
[581.682016] [093/133] (448s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[581.779379] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[585.946800] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.171s)
[587.098982] [094/133] (442s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[587.213486] Starting subtest: cursorA-vs-flipB-atomic
[587.218193] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[587.360220] [095/133] (442s left) vgem_basic (dmabuf-fence)
[587.410822] Starting subtest: dmabuf-fence
[587.413070] Subtest dmabuf-fence: SUCCESS (0.001s)
[587.470297] [096/133] (442s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[587.577982] Starting subtest: pr-primary-plane-update-sf-dmg-area
[587.582475] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[587.648651] [097/133] (442s left) kms_flip (2x-flip-vs-dpms-on-nop)
[587.744262] Starting subtest: 2x-flip-vs-dpms-on-nop
[587.752393] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[587.832922] [098/133] (442s left) gem_exec_balancer (parallel-bb-first)
[588.093759] Starting subtest: parallel-bb-first
[589.035834] Subtest parallel-bb-first: SUCCESS (0.943s)
[589.965232] [099/133] (440s left) i915_drm_fdinfo (memory-info-resident)
[590.010854] Starting subtest: memory-info-resident
[590.013263] Starting dynamic subtest: smem0
[592.862803] Dynamic subtest smem0: SUCCESS (2.852s)
[592.865190] Subtest memory-info-resident: SUCCESS (2.853s)
[592.947685] [100/133] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[593.046463] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[599.701994] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.657s)
[599.835819] [101/133] (430s left) gem_softpin (safe-alignment)
[599.900628] Starting subtest: safe-alignment
[599.927699] Subtest safe-alignment: SUCCESS (0.027s)
[601.916372] [102/133] (428s left) gem_softpin (evict-snoop)
[601.976428] Starting subtest: evict-snoop
[601.981109] Subtest evict-snoop: SKIP (0.000s)
[602.095984] [103/133] (428s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[602.193327] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[602.197572] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[602.302787] [104/133] (428s left) kms_psr (psr2-dpms)
[602.402237] Starting subtest: psr2-dpms
[602.404552] Starting dynamic subtest: eDP-1
[605.233450] Dynamic subtest eDP-1: SUCCESS (2.830s)
[605.235740] Subtest psr2-dpms: SUCCESS (2.831s)
[606.099284] [105/133] (424s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[606.156138] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[606.158455] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[606.255119] [106/133] (424s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[606.302107] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[606.409954] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[606.500628] [107/133] (423s left) gem_exec_balancer (parallel-out-fence)
[606.754793] Starting subtest: parallel-out-fence
[607.922706] Subtest parallel-out-fence: SUCCESS (1.168s)
[608.040871] [108/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[608.142240] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[608.146128] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[608.253238] [109/133] (422s left) api_intel_allocator (fork-simple-stress)
[608.315186] Starting subtest: fork-simple-stress
[613.709768] Subtest fork-simple-stress: SUCCESS (5.395s)
[613.851347] [110/133] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[613.963818] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[613.967993] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[614.087087] [111/133] (416s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[614.188241] Starting subtest: 4-tiled-8bpp-rotate-90
[614.214449] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[614.342775] [112/133] (416s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[614.448182] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[614.452685] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[614.555340] [113/133] (416s left) dmabuf_sync_file (import-multiple-read-only)
[614.599738] Starting subtest: import-multiple-read-only
[614.601677] Subtest import-multiple-read-only: SUCCESS (0.003s)
[614.677924] [114/133] (416s left) kms_async_flips (test-time-stamp-atomic)
[614.773071] Starting subtest: test-time-stamp-atomic
[615.158744] Starting dynamic subtest: pipe-A-eDP-1
[615.911277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s)
[616.304954] Starting dynamic subtest: pipe-B-eDP-1
[617.057756] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[617.433419] Starting dynamic subtest: pipe-C-eDP-1
[618.184331] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.757s)
[618.557125] Starting dynamic subtest: pipe-D-eDP-1
[619.311618] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.759s)
[619.314193] Subtest test-time-stamp-atomic: SUCCESS (4.538s)
[620.485157] [115/133] (410s left) kms_psr (psr-sprite-mmap-cpu)
[620.592910] Starting subtest: psr-sprite-mmap-cpu
[620.595192] Starting dynamic subtest: eDP-1
[622.386829] Dynamic subtest eDP-1: SUCCESS (1.793s)
[622.388698] Subtest psr-sprite-mmap-cpu: SUCCESS (1.795s)
[623.225742] [116/133] (407s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[623.321618] Starting subtest: psr-rgb101010-draw-mmap-gtt
[623.325744] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[623.419868] [117/133] (407s left) perf_pmu (rc6-suspend)
[623.464506] Starting subtest: rc6-suspend
[645.656325] Subtest rc6-suspend: SUCCESS (7.634s)
[646.558741] [118/133] (384s left) gem_exec_whisper (basic-queues-forked)
[646.625816] Starting subtest: basic-queues-forked
[670.605463] Subtest basic-queues-forked: SUCCESS (23.872s)
[670.791338] [119/133] (360s left) gem_exec_store (dword)
[670.858657] Starting subtest: dword
[670.861143] Starting dynamic subtest: rcs0
[670.945150] Dynamic subtest rcs0: SUCCESS (0.086s)
[670.960648] Starting dynamic subtest: bcs0
[670.990110] Dynamic subtest bcs0: SUCCESS (0.043s)
[671.000907] Starting dynamic subtest: vcs0
[671.033746] Dynamic subtest vcs0: SUCCESS (0.041s)
[671.046655] Starting dynamic subtest: vcs1
[671.077718] Dynamic subtest vcs1: SUCCESS (0.042s)
[671.088801] Starting dynamic subtest: vecs0
[671.123853] Dynamic subtest vecs0: SUCCESS (0.044s)
[671.137478] Starting dynamic subtest: ccs0
[671.171738] Dynamic subtest ccs0: SUCCESS (0.046s)
[671.174238] Subtest dword: SUCCESS (0.314s)
[671.361122] [120/133] (359s left) kms_psr (fbc-pr-primary-mmap-gtt)
[671.459042] Starting subtest: fbc-pr-primary-mmap-gtt
[671.463517] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[671.535404] [121/133] (359s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[671.595821] Starting subtest: etime-multi-wait-all-for-submit-submitted
[671.696174] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[671.816382] [122/133] (359s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[671.947485] Starting subtest: cursorA-vs-flipA-atomic-transitions
[683.139097] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.188s)
[684.035854] [123/133] (347s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[684.130107] Starting subtest: fbc-psr2-sprite-mmap-gtt
[684.132357] Starting dynamic subtest: eDP-1
[684.136631] Dynamic subtest eDP-1: SKIP (0.000s)
[684.140990] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[684.238013] [124/133] (347s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[684.343589] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[684.348065] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[684.470423] [125/133] (346s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[684.561327] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[693.133053] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.573s)
[693.276130] [126/133] (338s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[693.662225] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[694.494999] [127/133] (336s left) kms_plane_alpha_blend (alpha-basic)
[694.605424] Starting subtest: alpha-basic
[694.892350] Starting dynamic subtest: pipe-A-eDP-1
[696.826918] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[696.856533] Starting dynamic subtest: pipe-D-eDP-1
[699.489506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.639s)
[699.491842] Subtest alpha-basic: SUCCESS (4.881s)
[700.290806] [128/133] (331s left) kms_plane_multiple (tiling-none)
[700.382755] Starting subtest: tiling-none
[700.384803] Starting dynamic subtest: pipe-A-eDP-1
[704.139391] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.755s)
[704.151589] Starting dynamic subtest: pipe-B-eDP-1
[708.621009] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.478s)
[708.637763] Starting dynamic subtest: pipe-C-eDP-1
[713.124121] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.501s)
[713.135256] Starting dynamic subtest: pipe-D-eDP-1
[717.448308] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.318s)
[717.450218] Subtest tiling-none: SUCCESS (17.060s)
[718.306649] [129/133] (313s left) gem_userptr_blits (stress-mm)
[718.372638] Starting subtest: stress-mm
[723.744995] Subtest stress-mm: SUCCESS (5.369s)
[723.863957] [130/133] (307s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[723.967608] Starting subtest: fbc-rgb101010-draw-mmap-wc
[728.533895] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.567s)
[729.681458] [131/133] (301s left) kms_properties (plane-properties-legacy)
[729.789617] Starting subtest: plane-properties-legacy
[729.791842] Starting dynamic subtest: pipe-A-eDP-1
[730.349677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[730.360396] Starting dynamic subtest: pipe-B-eDP-1
[731.626860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.275s)
[731.639882] Starting dynamic subtest: pipe-C-eDP-1
[732.860193] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[732.870753] Starting dynamic subtest: pipe-D-eDP-1
[734.112246] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[734.114822] Subtest plane-properties-legacy: SUCCESS (4.323s)
[734.913516] [132/133] (296s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[735.015573] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[741.727520] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.713s)
[741.845634] [133/133] (289s left) gem_mmap_gtt (bad-object)
[741.897761] Subtest bad-object: SKIP (0.000s)
[741.956988] 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.