[57.398534] Initializing watchdogs
[57.398578]   /dev/watchdog0
[57.418228] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.422669] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.424779] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.427941] [001/133] (960s left) kms_fb_coherency (memset-crc)
[57.547581] Starting subtest: memset-crc
[57.549752] Starting dynamic subtest: mmap-offset-wc
[57.949950] Dynamic subtest mmap-offset-wc: SUCCESS (0.401s)
[58.248302] Starting dynamic subtest: mmap-offset-uc
[64.272823] Dynamic subtest mmap-offset-uc: SUCCESS (6.015s)
[64.552215] Subtest memset-crc: SUCCESS (6.987s)
[65.369339] [002/133] (952s left) gem_exec_reloc (basic-write-wc)
[65.436558] Subtest basic-write-wc: SKIP (0.000s)
[65.503212] [003/133] (952s left) gem_exec_params (invalid-bsd2-flag-on-render)
[65.547104] Starting subtest: invalid-bsd2-flag-on-render
[65.549361] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[65.639265] [004/133] (952s left) gem_render_copy (linear)
[65.698446] Starting subtest: linear
[65.700792] Starting dynamic subtest: smem
[65.742062] Dynamic subtest smem: SUCCESS (0.043s)
[65.744641] Subtest linear: SUCCESS (0.043s)
[65.923015] [005/133] (952s left) core_auth (basic-auth)
[65.987917] Starting subtest: basic-auth
[65.990617] Subtest basic-auth: SUCCESS (0.001s)
[66.129570] [006/133] (952s left) kms_flip (flip-vs-modeset-vs-hang)
[66.235251] Starting subtest: flip-vs-modeset-vs-hang
[66.237831] Starting dynamic subtest: A-eDP1
[117.357739] Dynamic subtest A-eDP1: SUCCESS (51.117s)
[117.366435] Starting dynamic subtest: D-eDP1
[167.404641] Dynamic subtest D-eDP1: SUCCESS (50.040s)
[167.406941] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.160s)
[167.771180] [007/133] (850s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[167.873869] Starting subtest: plane-primary-toggle-with-vblank-wait
[167.876287] Starting dynamic subtest: pipe-A-eDP-1
[168.046581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[168.367258] Starting dynamic subtest: pipe-B-eDP-1
[169.286541] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.928s)
[169.595287] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.722s)
[170.460230] [008/133] (847s left) kms_frontbuffer_tracking (fbc-1p-rte)
[170.550289] Starting subtest: fbc-1p-rte
[176.054996] Subtest fbc-1p-rte: SUCCESS (5.507s)
[177.179056] [009/133] (841s left) prime_vgem (basic-fence-flip)
[177.280391] Starting subtest: basic-fence-flip
[177.567913] Subtest basic-fence-flip: SUCCESS (0.288s)
[177.680152] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[177.683438] [010/133] (840s left) gem_ctx_shared (q-independent)
[177.741772] Starting subtest: Q-independent
[177.743954] Starting dynamic subtest: rcs0
[177.804025] Dynamic subtest rcs0: SUCCESS (0.062s)
[177.815104] Starting dynamic subtest: vcs0
[177.843954] Dynamic subtest vcs0: SUCCESS (0.040s)
[177.851401] Starting dynamic subtest: vcs1
[177.882888] Dynamic subtest vcs1: SUCCESS (0.039s)
[177.890726] Starting dynamic subtest: vecs0
[177.921684] Dynamic subtest vecs0: SUCCESS (0.038s)
[177.928696] Starting dynamic subtest: ccs0
[177.973470] Dynamic subtest ccs0: SUCCESS (0.051s)
[177.975898] Subtest Q-independent: SUCCESS (0.232s)
[178.989622] [011/133] (839s left) kms_color_pipeline (plane-lut1d)
[179.090831] Starting subtest: plane-lut1d
[179.225932] Starting dynamic subtest: pipe-A-plane-0
[179.392757] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[179.401445] Starting dynamic subtest: pipe-A-plane-1
[179.526024] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[179.533520] Starting dynamic subtest: pipe-A-plane-2
[179.681402] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[180.872221] Starting dynamic subtest: pipe-B-plane-0
[181.009622] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[181.017375] Starting dynamic subtest: pipe-B-plane-1
[181.143416] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[181.151588] Starting dynamic subtest: pipe-B-plane-2
[181.276472] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[182.520398] Starting dynamic subtest: pipe-C-plane-0
[182.680275] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[182.688563] Starting dynamic subtest: pipe-C-plane-1
[182.813407] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[182.822262] Starting dynamic subtest: pipe-C-plane-2
[182.958033] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[184.127484] Starting dynamic subtest: pipe-D-plane-0
[184.262926] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[184.270444] Starting dynamic subtest: pipe-D-plane-1
[184.395867] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[184.403428] Starting dynamic subtest: pipe-D-plane-2
[184.529996] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[184.815658] Subtest plane-lut1d: SUCCESS (5.725s)
[185.607458] [012/133] (832s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[185.663774] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[185.721700] [013/133] (832s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[185.818055] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[185.820287] Starting dynamic subtest: pipe-A-eDP-1
[185.958186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.131s)
[185.968043] Starting dynamic subtest: pipe-B-eDP-1
[185.988149] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[185.995132] Starting dynamic subtest: pipe-C-eDP-1
[186.014282] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[186.021252] Starting dynamic subtest: pipe-D-eDP-1
[186.040950] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[186.043151] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.139s)
[188.283232] [014/133] (830s left) kms_psr (pr-sprite-plane-move)
[188.379368] Starting subtest: pr-sprite-plane-move
[188.383727] Subtest pr-sprite-plane-move: SKIP (0.000s)
[188.460363] [015/133] (830s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[188.561119] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[188.563448] Starting dynamic subtest: pipe-A-eDP-1
[188.623496] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[188.631344] Starting dynamic subtest: pipe-B-eDP-1
[188.690422] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[188.699032] Starting dynamic subtest: pipe-C-eDP-1
[188.755295] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[188.763840] Starting dynamic subtest: pipe-D-eDP-1
[188.819570] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[188.824071] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[190.773832] [016/133] (827s left) gem_mmap_gtt (basic-small-copy-xy)
[190.833692] Subtest basic-small-copy-XY: SKIP (0.000s)
[190.899985] [017/133] (827s left) gem_ctx_persistence (saturated-hostile)
[190.967517] Starting subtest: saturated-hostile
[190.969988] Starting dynamic subtest: rcs0
[191.777662] Dynamic subtest rcs0: SUCCESS (0.809s)
[191.787863] Starting dynamic subtest: bcs0
[192.569367] Dynamic subtest bcs0: SUCCESS (0.791s)
[192.578591] Starting dynamic subtest: vcs0
[193.339128] Dynamic subtest vcs0: SUCCESS (0.769s)
[193.349013] Starting dynamic subtest: vcs1
[194.148895] Dynamic subtest vcs1: SUCCESS (0.805s)
[194.158490] Starting dynamic subtest: vecs0
[194.957461] Dynamic subtest vecs0: SUCCESS (0.810s)
[194.967937] Starting dynamic subtest: ccs0
[195.800045] Dynamic subtest ccs0: SUCCESS (0.841s)
[195.802906] Subtest saturated-hostile: SUCCESS (4.832s)
[195.878594] [018/133] (822s left) kms_getfb (getfb2-handle-protection)
[195.987932] Starting subtest: getfb2-handle-protection
[196.004263] Subtest getfb2-handle-protection: SUCCESS (0.017s)
[196.124725] [019/133] (822s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[196.220299] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[196.224509] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[196.313076] [020/133] (822s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[196.408887] Starting subtest: async-flip-with-page-flip-events-tiled
[196.787246] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[199.541736] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.753s)
[199.552049] Starting dynamic subtest: pipe-A-eDP-1-4
[201.716599] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[201.724109] Starting dynamic subtest: pipe-A-eDP-1-4
[203.726551] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[203.734313] Starting dynamic subtest: pipe-A-eDP-1-x
[205.916591] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[206.281349] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[209.067946] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[209.078203] Starting dynamic subtest: pipe-B-eDP-1-4
[211.242646] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[211.252960] Starting dynamic subtest: pipe-B-eDP-1-4
[213.253470] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[213.262748] Starting dynamic subtest: pipe-B-eDP-1-x
[215.476043] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.222s)
[215.850328] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[218.598815] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[218.607177] Starting dynamic subtest: pipe-C-eDP-1-4
[220.762658] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[220.770075] Starting dynamic subtest: pipe-C-eDP-1-4
[222.773402] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[222.780814] Starting dynamic subtest: pipe-C-eDP-1-x
[224.940999] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[225.300192] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[228.029775] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.734s)
[228.037969] Starting dynamic subtest: pipe-D-eDP-1-4
[230.193615] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[230.203660] Starting dynamic subtest: pipe-D-eDP-1-4
[232.203851] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[232.211788] Starting dynamic subtest: pipe-D-eDP-1-x
[234.381899] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[234.384411] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.971s)
[235.611080] [021/133] (783s left) perf_pmu (semaphore-wait-idle)
[235.646868] Starting subtest: semaphore-wait-idle
[235.649319] Starting dynamic subtest: rcs0
[236.161738] Dynamic subtest rcs0: SUCCESS (0.513s)
[236.172940] Starting dynamic subtest: bcs0
[236.674485] Dynamic subtest bcs0: SUCCESS (0.511s)
[236.683338] Starting dynamic subtest: vcs0
[237.187041] Dynamic subtest vcs0: SUCCESS (0.510s)
[237.200698] Starting dynamic subtest: vcs1
[237.699357] Dynamic subtest vcs1: SUCCESS (0.511s)
[237.710238] Starting dynamic subtest: vecs0
[238.210927] Dynamic subtest vecs0: SUCCESS (0.510s)
[238.221215] Starting dynamic subtest: ccs0
[238.726090] Dynamic subtest ccs0: SUCCESS (0.513s)
[238.729084] Subtest semaphore-wait-idle: SUCCESS (3.078s)
[239.969448] [022/133] (778s left) syncobj_wait (wait-for-submit-snapshot)
[240.023329] Starting subtest: wait-for-submit-snapshot
[240.105322] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[240.186199] [023/133] (778s left) vgem_basic (setversion)
[240.233895] Starting subtest: setversion
[240.238027] Subtest setversion: SUCCESS (0.000s)
[240.292259] [024/133] (778s left) gem_exec_schedule (u-independent)
[240.369415] Starting subtest: u-independent
[240.371793] Starting dynamic subtest: rcs0
[241.880972] Dynamic subtest rcs0: SUCCESS (1.517s)
[241.892570] Starting dynamic subtest: vcs0
[243.934461] Dynamic subtest vcs0: SUCCESS (2.055s)
[243.951511] Starting dynamic subtest: vcs1
[245.920571] Dynamic subtest vcs1: SUCCESS (1.985s)
[245.932111] Starting dynamic subtest: vecs0
[247.906049] Dynamic subtest vecs0: SUCCESS (1.983s)
[247.920110] Starting dynamic subtest: ccs0
[249.878397] Dynamic subtest ccs0: SUCCESS (1.971s)
[249.881171] Subtest u-independent: SUCCESS (9.518s)
[250.221186] [025/133] (768s left) kms_vblank (wait-forked-busy)
[250.319128] Starting subtest: wait-forked-busy
[250.321028] Starting dynamic subtest: pipe-A-eDP-1
[252.211476] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s)
[252.226300] Starting dynamic subtest: pipe-D-eDP-1
[254.775904] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[254.778194] Subtest wait-forked-busy: SUCCESS (4.457s)
[255.581239] [026/133] (763s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[255.954796] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[256.781351] [027/133] (762s left) gem_softpin (noreloc)
[256.848832] Starting subtest: noreloc
[262.267934] Subtest noreloc: SUCCESS (5.418s)
[262.373449] [028/133] (756s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[262.469100] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[262.471333] Starting dynamic subtest: pipe-A-eDP-1
[273.768637] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.303s)
[273.778306] Starting dynamic subtest: pipe-B-eDP-1
[285.837626] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.067s)
[285.840100] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.372s)
[286.685372] [029/133] (732s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[286.854855] Starting subtest: cursor-rapid-movement-32x10
[286.900463] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[287.191530] [030/133] (731s left) sysfs_heartbeat_interval (nopreempt)
[287.248483] Starting subtest: nopreempt
[287.250784] Starting dynamic subtest: vecs0
[295.890043] Dynamic subtest vecs0: SUCCESS (8.637s)
[295.899907] Starting dynamic subtest: ccs0
[299.873294] Dynamic subtest ccs0: SUCCESS (3.983s)
[299.884459] Starting dynamic subtest: vcs0
[309.912061] Dynamic subtest vcs0: SUCCESS (10.037s)
[309.925454] Starting dynamic subtest: bcs0
[313.865438] Dynamic subtest bcs0: SUCCESS (3.950s)
[313.875466] Starting dynamic subtest: rcs0
[317.927143] Dynamic subtest rcs0: SUCCESS (4.059s)
[317.936872] Starting dynamic subtest: vcs1
[327.900317] Dynamic subtest vcs1: SUCCESS (9.973s)
[327.903075] Subtest nopreempt: SUCCESS (40.648s)
[327.981537] [031/133] (691s left) kms_plane (plane-panning-top-left)
[328.080169] Starting subtest: plane-panning-top-left
[328.082511] Starting dynamic subtest: pipe-A
[329.721714] Dynamic subtest pipe-A: SUCCESS (1.640s)
[329.735574] Starting dynamic subtest: pipe-B
[332.138769] Dynamic subtest pipe-B: SUCCESS (2.416s)
[332.140863] Subtest plane-panning-top-left: SUCCESS (4.059s)
[332.935585] [032/133] (686s left) kms_cursor_crc (cursor-sliding-32x10)
[333.103604] Starting subtest: cursor-sliding-32x10
[333.150955] Subtest cursor-sliding-32x10: SKIP (0.042s)
[333.428788] [033/133] (685s left) gem_exec_suspend (basic-s4-devices)
[333.502757] Starting subtest: basic-S4-devices
[333.504934] Starting dynamic subtest: smem
[344.918540] Dynamic subtest smem: SUCCESS (11.412s)
[344.921515] Subtest basic-S4-devices: SUCCESS (11.414s)
[350.124837] [034/133] (674s left) gem_exec_suspend (basic)
[350.219711] Starting subtest: basic
[350.222165] Starting dynamic subtest: smem
[351.894509] Dynamic subtest smem: SUCCESS (1.673s)
[351.897116] Subtest basic: SUCCESS (1.675s)
[352.078600] [035/133] (672s left) kms_lease (empty-lease)
[352.176798] Starting subtest: empty-lease
[352.178662] Starting dynamic subtest: pipe-A-eDP-1
[352.180869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[352.192534] Starting dynamic subtest: pipe-B-eDP-1
[352.194434] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[352.206102] Starting dynamic subtest: pipe-C-eDP-1
[352.208176] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[352.216687] Starting dynamic subtest: pipe-D-eDP-1
[352.218777] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[352.220864] Subtest empty-lease: SUCCESS (0.024s)
[352.310087] [036/133] (672s left) gem_exec_params (rs-invalid)
[352.374096] Starting subtest: rs-invalid
[352.382351] Subtest rs-invalid: SUCCESS (0.006s)
[352.500540] [037/133] (671s left) gem_mmap_wc (write-gtt-read-wc)
[352.552681] Subtest write-gtt-read-wc: SKIP (0.000s)
[352.611730] [038/133] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[352.711801] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[352.716153] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[352.832133] [039/133] (671s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[352.900857] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[352.905407] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[353.101357] [040/133] (671s left) gen7_exec_parse (oacontrol-tracking)
[353.168252] Subtest oacontrol-tracking: SKIP (0.000s)
[353.253876] [041/133] (671s left) perf (gen12-mi-rpc)
[353.376820] Starting subtest: gen12-mi-rpc
[353.379132] Starting dynamic subtest: rcs0
[353.398065] Dynamic subtest rcs0: SUCCESS (0.019s)
[353.400052] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[353.448083] [042/133] (671s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[353.590968] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[353.723385] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s)
[353.843857] [043/133] (670s left) gem_mmap_offset (isolation)
[353.911516] Starting subtest: isolation
[353.928670] Subtest isolation: SUCCESS (0.005s)
[354.034557] [044/133] (670s left) kms_properties (colorop-properties-legacy)
[354.114749] Starting subtest: colorop-properties-legacy
[354.116494] Starting dynamic subtest: pipe-A-eDP-1
[354.454235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.338s)
[354.463454] Starting dynamic subtest: pipe-B-eDP-1
[355.548320] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.092s)
[355.558311] Starting dynamic subtest: pipe-C-eDP-1
[356.579339] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.031s)
[356.590917] Starting dynamic subtest: pipe-D-eDP-1
[357.611781] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.031s)
[357.614220] Subtest colorop-properties-legacy: SUCCESS (3.498s)
[358.427774] [045/133] (666s left) gem_ccs (block-multicopy-compressed)
[358.485875] Starting subtest: block-multicopy-compressed
[358.489880] Subtest block-multicopy-compressed: SKIP (0.000s)
[358.591239] [046/133] (666s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[358.649835] Starting subtest: invalid-signal-one-illegal-handle
[358.651848] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[358.744162] [047/133] (666s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[358.837988] Starting subtest: yf-tiled-32bpp-rotate-270
[358.842546] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[358.924577] [048/133] (665s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[359.063289] Starting subtest: dp-mst-type-0-suspend-resume
[359.067647] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[359.192623] [049/133] (665s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[359.248145] Starting subtest: multi-wait-available-unsubmitted-submitted
[359.250462] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[359.342298] [050/133] (665s left) i915_module_load (reload)
[359.377644] Starting subtest: reload
[364.089249] Subtest reload: SUCCESS (4.712s)
[364.130681] [051/133] (660s left) i915_pm_freq_mult (media-freq)
[365.885489] Starting subtest: media-freq
[365.888238] Starting dynamic subtest: gt0
[365.893050] Dynamic subtest gt0: SKIP (0.000s)
[365.903913] Starting dynamic subtest: gt1
[365.908185] Dynamic subtest gt1: SKIP (0.000s)
[365.912400] Subtest media-freq: SKIP (0.002s)
[365.992242] [052/133] (659s left) kms_big_fb (linear-16bpp-rotate-90)
[366.099947] Starting subtest: linear-16bpp-rotate-90
[366.139859] Subtest linear-16bpp-rotate-90: SKIP (0.037s)
[366.236633] [053/133] (658s left) perf_pmu (interrupts-sync)
[366.281677] Starting subtest: interrupts-sync
[367.360946] Subtest interrupts-sync: SUCCESS (1.079s)
[367.469386] [054/133] (657s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[367.579217] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[367.581473] Starting dynamic subtest: pipe-A-eDP-1
[367.603185] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.612291] Starting dynamic subtest: pipe-B-eDP-1
[367.633620] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.642062] Starting dynamic subtest: pipe-C-eDP-1
[367.662096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.670225] Starting dynamic subtest: pipe-D-eDP-1
[367.691711] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.695741] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.015s)
[369.889325] [055/133] (655s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[369.981149] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[369.985205] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[370.052404] [056/133] (655s left) gem_exec_parallel (contexts)
[370.109163] Starting subtest: contexts
[370.111412] Starting dynamic subtest: rcs0
[372.946039] Dynamic subtest rcs0: SUCCESS (2.835s)
[372.958472] Starting dynamic subtest: bcs0
[376.465909] Dynamic subtest bcs0: SUCCESS (3.518s)
[376.478093] Starting dynamic subtest: vcs0
[380.401780] Dynamic subtest vcs0: SUCCESS (3.932s)
[380.411085] Starting dynamic subtest: vcs1
[384.387608] Dynamic subtest vcs1: SUCCESS (3.985s)
[384.397103] Starting dynamic subtest: vecs0
[388.412446] Dynamic subtest vecs0: SUCCESS (4.022s)
[388.424914] Starting dynamic subtest: ccs0
[392.149363] Dynamic subtest ccs0: SUCCESS (3.734s)
[392.151923] Subtest contexts: SUCCESS (22.039s)
[392.338279] [057/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[392.444133] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[392.448299] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[392.545714] [058/133] (632s left) kms_addfb_basic (unused-handle)
[392.597791] Starting subtest: unused-handle
[392.599777] Subtest unused-handle: SUCCESS (0.000s)
[392.741349] [059/133] (632s left) kms_joiner (invalid-modeset-big-joiner)
[392.845154] Starting subtest: invalid-modeset-big-joiner
[392.849328] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[392.908506] [060/133] (632s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[393.024255] Starting subtest: cursor-vs-flip-varying-size
[424.261556] Subtest cursor-vs-flip-varying-size: SUCCESS (31.235s)
[425.115820] [061/133] (600s left) gem_exec_schedule (independent)
[425.179216] Starting subtest: independent
[425.181389] Starting dynamic subtest: rcs0
[426.902555] Dynamic subtest rcs0: SUCCESS (1.729s)
[426.912940] Starting dynamic subtest: vcs0
[428.896437] Dynamic subtest vcs0: SUCCESS (1.991s)
[428.909127] Starting dynamic subtest: vcs1
[430.944754] Dynamic subtest vcs1: SUCCESS (2.046s)
[430.960052] Starting dynamic subtest: vecs0
[432.917600] Dynamic subtest vecs0: SUCCESS (1.970s)
[432.930303] Starting dynamic subtest: ccs0
[434.901523] Dynamic subtest ccs0: SUCCESS (1.981s)
[434.904378] Subtest independent: SUCCESS (9.729s)
[435.204297] [062/133] (590s left) kms_plane_scaling (planes-scaler-unity-scaling)
[435.315746] Starting subtest: planes-scaler-unity-scaling
[435.318113] Starting dynamic subtest: pipe-A
[435.376317] Dynamic subtest pipe-A: SUCCESS (0.064s)
[435.387471] Starting dynamic subtest: pipe-B
[436.543207] Dynamic subtest pipe-B: SUCCESS (1.166s)
[436.554056] Starting dynamic subtest: pipe-C
[437.646366] Dynamic subtest pipe-C: SUCCESS (1.102s)
[437.657375] Starting dynamic subtest: pipe-D
[438.772692] Dynamic subtest pipe-D: SUCCESS (1.126s)
[438.775037] Subtest planes-scaler-unity-scaling: SUCCESS (3.461s)
[439.937884] [063/133] (585s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[440.003575] Starting subtest: multi-wait-for-submit-submitted-signaled
[440.005849] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[440.104701] [064/133] (585s left) syncobj_wait (invalid-signal-one-illegal-handle)
[440.171895] Starting subtest: invalid-signal-one-illegal-handle
[440.174231] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[440.273800] [065/133] (585s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[440.373915] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[440.376086] Starting dynamic subtest: pipe-A-default-mode
[441.495809] Dynamic subtest pipe-A-default-mode: SKIP (1.118s)
[441.500092] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.120s)
[441.639500] [066/133] (584s left) gem_basic (create-close)
[441.694031] Starting subtest: create-close
[441.698168] Subtest create-close: SUCCESS (0.000s)
[441.811877] [067/133] (583s left) gem_ctx_param (invalid-get-ringsize)
[441.860022] Starting subtest: invalid-get-ringsize
[441.862474] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[441.951359] [068/133] (583s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[442.069600] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[473.919672] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.847s)
[474.797230] [069/133] (550s left) kms_frontbuffer_tracking (fbc-tiling-y)
[474.908487] Starting subtest: fbc-tiling-y
[474.912870] Subtest fbc-tiling-y: SKIP (0.000s)
[474.994750] [070/133] (550s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[475.098095] Starting subtest: extended-modeset-hang-newfb-with-reset
[475.100383] Starting dynamic subtest: pipe-A
[488.695232] Dynamic subtest pipe-A: SUCCESS (13.593s)
[488.705373] Starting dynamic subtest: pipe-D
[503.994208] Dynamic subtest pipe-D: SUCCESS (15.296s)
[503.996560] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (28.893s)
[504.796712] [071/133] (521s left) gem_pxp (hw-rejects-pxp-buffer)
[504.923829] Starting subtest: hw-rejects-pxp-buffer
[504.928799] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[505.039767] [072/133] (520s left) api_intel_bb (reset-bb)
[505.097710] Starting subtest: reset-bb
[505.100046] Subtest reset-bb: SUCCESS (0.003s)
[505.218216] [073/133] (520s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[505.334848] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[505.339370] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[505.512526] [074/133] (520s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[505.645600] Starting subtest: basic-flip-after-cursor-legacy
[506.562071] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.916s)
[507.427745] [075/133] (518s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[507.547484] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[517.055115] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.506s)
[517.856409] [076/133] (508s left) kms_cursor_crc (cursor-offscreen-128x128)
[518.059804] Starting subtest: cursor-offscreen-128x128
[518.064528] Starting dynamic subtest: pipe-A-eDP-1
[519.998094] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[520.026876] Starting dynamic subtest: pipe-D-eDP-1
[522.584881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[522.587276] Subtest cursor-offscreen-128x128: SUCCESS (4.523s)
[523.441234] [077/133] (502s left) kms_prime (basic-crc-hybrid)
[523.523891] Subtest basic-crc-hybrid: SKIP (0.000s)
[523.619501] [078/133] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[523.720295] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[523.724104] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[523.810068] [079/133] (502s left) i915_suspend (fence-restore-untiled)
[523.870934] Starting subtest: fence-restore-untiled
[523.875402] Subtest fence-restore-untiled: SKIP (0.000s)
[523.969581] [080/133] (502s left) kms_pm_dc (dc3co-vpb-simulation)
[525.067791] Starting subtest: dc3co-vpb-simulation
[533.935310] Subtest dc3co-vpb-simulation: SKIP (8.863s)
[534.090965] [081/133] (492s left) gem_wait (write-wait)
[534.178136] Starting subtest: write-wait
[534.180600] Starting dynamic subtest: all-engines
[535.313299] Dynamic subtest all-engines: SUCCESS (1.134s)
[535.329781] Starting dynamic subtest: rcs0
[536.372495] Dynamic subtest rcs0: SUCCESS (1.057s)
[536.392603] Starting dynamic subtest: bcs0
[537.431649] Dynamic subtest bcs0: SUCCESS (1.056s)
[537.455047] Starting dynamic subtest: vcs0
[538.487730] Dynamic subtest vcs0: SUCCESS (1.054s)
[538.504563] Starting dynamic subtest: vcs1
[539.541871] Dynamic subtest vcs1: SUCCESS (1.052s)
[539.560196] Starting dynamic subtest: vecs0
[540.595510] Dynamic subtest vecs0: SUCCESS (1.051s)
[540.613174] Starting dynamic subtest: ccs0
[541.653586] Dynamic subtest ccs0: SUCCESS (1.055s)
[541.656192] Subtest write-wait: SUCCESS (7.476s)
[541.859925] [082/133] (484s left) gem_mmap_gtt (big-bo-tiledx)
[541.915728] Subtest big-bo-tiledX: SKIP (0.000s)
[541.984866] [083/133] (484s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[542.528659] Starting subtest: syncobj-timeline-invalid-wait
[542.535188] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s)
[543.949563] [084/133] (482s left) kms_chamelium_audio (dp-audio)
[544.361703] Subtest dp-audio: SKIP (0.000s)
[545.151142] [085/133] (481s left) syncobj_wait (wait-delayed-signal)
[545.202160] Starting subtest: wait-delayed-signal
[545.304550] Subtest wait-delayed-signal: SUCCESS (0.102s)
[545.384856] [086/133] (481s left) template (b)
[545.447281] Starting subtest: B
[545.449284] Subtest B: SUCCESS (0.000s)
[545.561952] [087/133] (481s left) gem_exec_nop (basic-parallel)
[545.645437] Starting subtest: basic-parallel
[561.878984] Subtest basic-parallel: SUCCESS (16.243s)
[562.104686] [088/133] (464s left) syncobj_timeline (signal-point-0)
[562.159649] Starting subtest: signal-point-0
[562.161686] Subtest signal-point-0: SUCCESS (0.000s)
[562.285504] [089/133] (464s left) kms_sequence (queue-busy)
[562.380887] Starting subtest: queue-busy
[562.383198] Starting dynamic subtest: pipe-A-eDP-1
[564.325089] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[564.335284] Starting dynamic subtest: pipe-B-eDP-1
[566.875446] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.550s)
[566.886768] Starting dynamic subtest: pipe-C-eDP-1
[569.502080] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.624s)
[569.516206] Starting dynamic subtest: pipe-D-eDP-1
[572.053752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[572.056044] Subtest queue-busy: SUCCESS (9.674s)
[572.849570] [090/133] (453s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[572.946221] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[572.948410] Starting dynamic subtest: pipe-A-eDP-1
[572.971120] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[572.982742] Starting dynamic subtest: pipe-B-eDP-1
[573.004896] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[573.014287] Starting dynamic subtest: pipe-C-eDP-1
[573.035464] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[573.044998] Starting dynamic subtest: pipe-D-eDP-1
[573.066249] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.070576] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[575.216945] [091/133] (451s left) gem_create (create-ext-placement-sanity-check)
[575.385645] Starting subtest: create-ext-placement-sanity-check
[575.388083] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[575.479560] [092/133] (451s left) gem_exec_params (dr4-dirt)
[575.530579] Starting subtest: DR4-dirt
[575.533086] Subtest DR4-dirt: SUCCESS (0.000s)
[575.621550] [093/133] (451s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[575.728285] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[579.847694] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.122s)
[581.010354] [094/133] (445s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[581.124066] Starting subtest: cursorA-vs-flipB-atomic
[581.128789] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[581.272400] [095/133] (445s left) vgem_basic (dmabuf-fence)
[581.319743] Starting subtest: dmabuf-fence
[581.321978] Subtest dmabuf-fence: SUCCESS (0.001s)
[581.379712] [096/133] (445s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[581.468907] Starting subtest: pr-primary-plane-update-sf-dmg-area
[581.473091] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[581.538678] [097/133] (445s left) kms_flip (2x-flip-vs-dpms-on-nop)
[581.624256] Starting subtest: 2x-flip-vs-dpms-on-nop
[581.635687] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[581.727818] [098/133] (445s left) gem_exec_balancer (parallel-bb-first)
[581.996876] Starting subtest: parallel-bb-first
[582.910226] Subtest parallel-bb-first: SUCCESS (0.913s)
[583.934136] [099/133] (443s left) i915_drm_fdinfo (memory-info-resident)
[583.971076] Starting subtest: memory-info-resident
[583.973462] Starting dynamic subtest: smem0
[586.963344] Dynamic subtest smem0: SUCCESS (2.996s)
[586.965457] Subtest memory-info-resident: SUCCESS (2.997s)
[587.036444] [100/133] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[587.147941] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[593.713777] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.569s)
[593.852819] [101/133] (433s left) gem_softpin (safe-alignment)
[593.919449] Starting subtest: safe-alignment
[593.942031] Subtest safe-alignment: SUCCESS (0.022s)
[595.978590] [102/133] (431s left) gem_softpin (evict-snoop)
[596.041048] Starting subtest: evict-snoop
[596.045705] Subtest evict-snoop: SKIP (0.000s)
[596.156674] [103/133] (431s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[596.254743] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[596.259160] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[596.356554] [104/133] (430s left) kms_psr (psr2-dpms)
[596.450281] Starting subtest: psr2-dpms
[596.452586] Starting dynamic subtest: eDP-1
[599.361265] Dynamic subtest eDP-1: SUCCESS (2.909s)
[599.363104] Subtest psr2-dpms: SUCCESS (2.910s)
[600.260380] [105/133] (427s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[600.317821] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[600.320018] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[600.412440] [106/133] (427s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[600.460983] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[600.570064] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[600.646158] [107/133] (426s left) gem_exec_balancer (parallel-out-fence)
[600.908963] Starting subtest: parallel-out-fence
[602.024932] Subtest parallel-out-fence: SUCCESS (1.120s)
[602.137458] [108/133] (425s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[602.231567] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[602.235675] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[602.339318] [109/133] (425s left) api_intel_allocator (fork-simple-stress)
[602.396678] Starting subtest: fork-simple-stress
[607.793153] Subtest fork-simple-stress: SUCCESS (5.396s)
[607.919583] [110/133] (419s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[608.026689] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[608.031254] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[608.142800] [111/133] (419s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[608.243961] Starting subtest: 4-tiled-8bpp-rotate-90
[608.266590] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[608.415527] [112/133] (419s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[608.529252] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[608.533094] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[608.626816] [113/133] (419s left) dmabuf_sync_file (import-multiple-read-only)
[608.666084] Starting subtest: import-multiple-read-only
[608.668393] Subtest import-multiple-read-only: SUCCESS (0.003s)
[608.726974] [114/133] (419s left) kms_async_flips (test-time-stamp-atomic)
[608.817509] Starting subtest: test-time-stamp-atomic
[609.190067] Starting dynamic subtest: pipe-A-eDP-1
[610.033389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s)
[610.411861] Starting dynamic subtest: pipe-B-eDP-1
[611.162485] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[611.550623] Starting dynamic subtest: pipe-C-eDP-1
[612.307743] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[612.668782] Starting dynamic subtest: pipe-D-eDP-1
[613.429458] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[613.431955] Subtest test-time-stamp-atomic: SUCCESS (4.611s)
[614.582068] [115/133] (413s left) kms_psr (psr-sprite-mmap-cpu)
[614.674813] Starting subtest: psr-sprite-mmap-cpu
[614.677738] Starting dynamic subtest: eDP-1
[616.391377] Dynamic subtest eDP-1: SUCCESS (1.717s)
[616.393293] Subtest psr-sprite-mmap-cpu: SUCCESS (1.718s)
[617.232911] [116/133] (410s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[617.322401] Starting subtest: psr-rgb101010-draw-mmap-gtt
[617.326786] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[617.431275] [117/133] (410s left) perf_pmu (rc6-suspend)
[617.469317] Starting subtest: rc6-suspend
[639.456950] Subtest rc6-suspend: SUCCESS (7.562s)
[640.367963] [118/133] (387s left) gem_exec_whisper (basic-queues-forked)
[640.435999] Starting subtest: basic-queues-forked
[663.515644] Subtest basic-queues-forked: SUCCESS (22.989s)
[663.701096] [119/133] (364s left) gem_exec_store (dword)
[663.765543] Starting subtest: dword
[663.768055] Starting dynamic subtest: rcs0
[663.859401] Dynamic subtest rcs0: SUCCESS (0.094s)
[663.873011] Starting dynamic subtest: bcs0
[663.907271] Dynamic subtest bcs0: SUCCESS (0.045s)
[663.923723] Starting dynamic subtest: vcs0
[663.950858] Dynamic subtest vcs0: SUCCESS (0.041s)
[663.962800] Starting dynamic subtest: vcs1
[663.995091] Dynamic subtest vcs1: SUCCESS (0.042s)
[664.005798] Starting dynamic subtest: vecs0
[664.038619] Dynamic subtest vecs0: SUCCESS (0.043s)
[664.051937] Starting dynamic subtest: ccs0
[664.084616] Dynamic subtest ccs0: SUCCESS (0.044s)
[664.086991] Subtest dword: SUCCESS (0.320s)
[664.267848] [120/133] (363s left) kms_psr (fbc-pr-primary-mmap-gtt)
[664.360140] Starting subtest: fbc-pr-primary-mmap-gtt
[664.364088] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[664.445507] [121/133] (363s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[664.507497] Starting subtest: etime-multi-wait-all-for-submit-submitted
[664.615214] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[664.707971] [122/133] (363s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[664.825483] Starting subtest: cursorA-vs-flipA-atomic-transitions
[675.993135] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.168s)
[676.800960] [123/133] (351s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[676.898492] Starting subtest: fbc-psr2-sprite-mmap-gtt
[676.900737] Starting dynamic subtest: eDP-1
[676.905048] Dynamic subtest eDP-1: SKIP (0.000s)
[676.909342] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[676.971607] [124/133] (351s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[677.071099] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[677.075403] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[677.168359] [125/133] (351s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[677.264257] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[685.767745] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.508s)
[685.893472] [126/133] (342s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[686.282719] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[687.128625] [127/133] (341s left) kms_plane_alpha_blend (alpha-basic)
[687.225728] Starting subtest: alpha-basic
[687.512728] Starting dynamic subtest: pipe-A-eDP-1
[689.450068] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[689.479583] Starting dynamic subtest: pipe-D-eDP-1
[692.124600] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.654s)
[692.127008] Subtest alpha-basic: SUCCESS (4.900s)
[692.920234] [128/133] (335s left) kms_plane_multiple (tiling-none)
[693.023714] Starting subtest: tiling-none
[693.025963] Starting dynamic subtest: pipe-A-eDP-1
[696.663143] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.640s)
[696.676635] Starting dynamic subtest: pipe-B-eDP-1
[701.015452] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.348s)
[701.026483] Starting dynamic subtest: pipe-C-eDP-1
[705.341053] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.321s)
[705.354741] Starting dynamic subtest: pipe-D-eDP-1
[709.643038] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.301s)
[709.645256] Subtest tiling-none: SUCCESS (16.615s)
[710.456419] [129/133] (317s left) gem_userptr_blits (stress-mm)
[710.538125] Starting subtest: stress-mm
[715.911041] Subtest stress-mm: SUCCESS (5.370s)
[716.040785] [130/133] (312s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[716.137059] Starting subtest: fbc-rgb101010-draw-mmap-wc
[720.744908] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.609s)
[721.871491] [131/133] (306s left) kms_properties (plane-properties-legacy)
[721.966488] Starting subtest: plane-properties-legacy
[721.968335] Starting dynamic subtest: pipe-A-eDP-1
[722.530107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[722.545012] Starting dynamic subtest: pipe-B-eDP-1
[723.842825] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.312s)
[723.854445] Starting dynamic subtest: pipe-C-eDP-1
[725.082545] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[725.094908] Starting dynamic subtest: pipe-D-eDP-1
[726.329153] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[726.331470] Subtest plane-properties-legacy: SUCCESS (4.361s)
[727.150840] [132/133] (301s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[727.251016] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[734.003906] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.754s)
[734.121051] [133/133] (294s left) gem_mmap_gtt (bad-object)
[734.173182] Subtest bad-object: SKIP (0.000s)
[734.224339] 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.