[62.050342] Initializing watchdogs
[62.050391]   /dev/watchdog0
[62.064663] [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]
[62.069035] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.071483] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.074911] [001/132] (960s left) gem_ctx_shared (q-independent)
[62.151443] Starting subtest: Q-independent
[62.153811] Starting dynamic subtest: rcs0
[62.250442] Dynamic subtest rcs0: SUCCESS (0.098s)
[62.261456] Starting dynamic subtest: vcs0
[62.318574] Dynamic subtest vcs0: SUCCESS (0.067s)
[62.329045] Starting dynamic subtest: vcs1
[62.388985] Dynamic subtest vcs1: SUCCESS (0.070s)
[62.396647] Starting dynamic subtest: vecs0
[62.451700] Dynamic subtest vecs0: SUCCESS (0.063s)
[62.458874] Starting dynamic subtest: ccs0
[62.529747] Dynamic subtest ccs0: SUCCESS (0.077s)
[62.532473] Subtest Q-independent: SUCCESS (0.378s)
[63.971946] [002/132] (958s left) perf_pmu (init-busy)
[64.010962] Starting subtest: init-busy
[64.013446] Starting dynamic subtest: rcs0
[64.015854] Dynamic subtest rcs0: SUCCESS (0.001s)
[64.022642] Starting dynamic subtest: bcs0
[64.024525] Dynamic subtest bcs0: SUCCESS (0.000s)
[64.031151] Starting dynamic subtest: vcs0
[64.033042] Dynamic subtest vcs0: SUCCESS (0.001s)
[64.039341] Starting dynamic subtest: vcs1
[64.041181] Dynamic subtest vcs1: SUCCESS (0.001s)
[64.047489] Starting dynamic subtest: vecs0
[64.049365] Dynamic subtest vecs0: SUCCESS (0.001s)
[64.057270] Starting dynamic subtest: ccs0
[64.059364] Dynamic subtest ccs0: SUCCESS (0.000s)
[64.061440] Subtest init-busy: SUCCESS (0.005s)
[64.121581] [003/132] (958s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[64.224937] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[64.227568] Starting dynamic subtest: pipe-A
[64.595685] Dynamic subtest pipe-A: SUCCESS (0.372s)
[64.604088] Starting dynamic subtest: pipe-B
[66.010953] Dynamic subtest pipe-B: SUCCESS (1.414s)
[66.019650] Starting dynamic subtest: pipe-C
[67.472786] Dynamic subtest pipe-C: SUCCESS (1.461s)
[67.481846] Starting dynamic subtest: pipe-D
[68.912380] Dynamic subtest pipe-D: SUCCESS (1.438s)
[68.914711] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.687s)
[70.059445] [004/132] (952s left) gen7_exec_parse (batch-without-end)
[70.115067] Subtest batch-without-end: SKIP (0.000s)
[70.183736] [005/132] (952s left) gem_ctx_persistence (engines-persistence)
[70.246698] Starting subtest: engines-persistence
[70.248873] Starting dynamic subtest: rcs0
[71.059773] Dynamic subtest rcs0: SUCCESS (0.815s)
[71.069812] Starting dynamic subtest: bcs0
[71.834630] Dynamic subtest bcs0: SUCCESS (0.774s)
[71.845021] Starting dynamic subtest: vcs0
[72.595049] Dynamic subtest vcs0: SUCCESS (0.759s)
[72.605248] Starting dynamic subtest: vcs1
[73.368269] Dynamic subtest vcs1: SUCCESS (0.772s)
[73.378556] Starting dynamic subtest: vecs0
[74.131424] Dynamic subtest vecs0: SUCCESS (0.762s)
[74.143571] Starting dynamic subtest: ccs0
[74.895895] Dynamic subtest ccs0: SUCCESS (0.764s)
[74.898728] Subtest engines-persistence: SUCCESS (4.651s)
[74.988260] [006/132] (947s left) gem_exec_reloc (basic-wc-gtt-active)
[75.042418] Subtest basic-wc-gtt-active: SKIP (0.000s)
[75.112066] [007/132] (947s left) gem_exec_reloc (basic-wc-read-noreloc)
[75.171886] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[75.233161] [008/132] (947s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[75.290761] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[75.345876] [009/132] (947s left) gem_softpin (allocator-fork)
[75.401245] Starting subtest: allocator-fork
[77.610912] Subtest allocator-fork: SUCCESS (2.208s)
[77.722617] [010/132] (945s left) gem_exec_params (no-blt)
[77.768040] Starting subtest: no-blt
[77.770492] Subtest no-blt: SUCCESS (0.002s)
[77.878280] [011/132] (945s left) kms_flip (basic-flip-vs-wf_vblank)
[77.983897] Starting subtest: basic-flip-vs-wf_vblank
[77.986089] Starting dynamic subtest: A-eDP1
[79.904248] Dynamic subtest A-eDP1: SUCCESS (1.921s)
[79.914862] Starting dynamic subtest: B-eDP1
[81.840238] Dynamic subtest B-eDP1: SUCCESS (1.936s)
[81.849637] Starting dynamic subtest: C-eDP1
[83.771624] Dynamic subtest C-eDP1: SUCCESS (1.931s)
[83.779121] Starting dynamic subtest: D-eDP1
[85.699640] Dynamic subtest D-eDP1: SUCCESS (1.928s)
[85.701979] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.724s)
[86.924268] [012/132] (936s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[86.989233] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[87.097241] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[87.167690] [013/132] (935s left) gem_set_tiling_vs_gtt
[87.278249] [014/132] (935s left) kms_lease (cursor-implicit-plane)
[87.374817] Starting subtest: cursor-implicit-plane
[87.377134] Starting dynamic subtest: pipe-A-eDP-1
[87.823807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[87.835268] Starting dynamic subtest: pipe-B-eDP-1
[88.926660] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.103s)
[88.936634] Starting dynamic subtest: pipe-C-eDP-1
[90.038608] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[90.049056] Starting dynamic subtest: pipe-D-eDP-1
[91.177987] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[91.180455] Subtest cursor-implicit-plane: SUCCESS (3.805s)
[92.036512] [015/132] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[92.139278] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[96.061392] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.927s)
[97.214855] [016/132] (925s left) kms_content_protection (atomic)
[97.346219] Starting subtest: atomic
[97.350954] Subtest atomic: SKIP (0.000s)
[97.472933] [017/132] (925s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[97.562115] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[97.564521] Starting dynamic subtest: pipe-A-eDP-1
[97.588176] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[97.600742] Starting dynamic subtest: pipe-B-eDP-1
[97.622411] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.631664] Starting dynamic subtest: pipe-C-eDP-1
[97.653313] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.660527] Starting dynamic subtest: pipe-D-eDP-1
[97.684252] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.688860] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[99.868682] [018/132] (923s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[99.956752] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[99.967846] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[100.075941] [019/132] (923s left) gem_lmem_swapping (verify-random)
[100.122878] Subtest verify-random: SKIP (0.000s)
[100.163781] [020/132] (923s left) gem_pread (snoop)
[100.225269] Subtest snoop: SKIP (0.000s)
[100.292829] [021/132] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[100.380903] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[100.385172] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[100.478273] [022/132] (922s left) gem_wait (invalid-flags)
[100.539653] Starting subtest: invalid-flags
[100.541659] Subtest invalid-flags: SUCCESS (0.000s)
[100.762134] [023/132] (922s left) i915_getparams_basic (basic-eu-total)
[100.818218] Starting subtest: basic-eu-total
[100.823046] Subtest basic-eu-total: SUCCESS (0.000s)
[100.907842] [024/132] (922s left) kms_flip (basic-flip-vs-dpms)
[100.994367] Starting subtest: basic-flip-vs-dpms
[100.996679] Starting dynamic subtest: A-eDP1
[103.582605] Dynamic subtest A-eDP1: SUCCESS (2.588s)
[103.589641] Starting dynamic subtest: B-eDP1
[105.811528] Dynamic subtest B-eDP1: SUCCESS (2.227s)
[105.819164] Starting dynamic subtest: C-eDP1
[107.890479] Dynamic subtest C-eDP1: SUCCESS (2.078s)
[107.898374] Starting dynamic subtest: D-eDP1
[109.956772] Dynamic subtest D-eDP1: SUCCESS (2.065s)
[109.959399] Subtest basic-flip-vs-dpms: SUCCESS (8.967s)
[110.761150] [025/132] (912s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[110.870200] Starting subtest: fbcpsr-rgb101010-draw-render
[117.609089] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.741s)
[117.740398] [026/132] (905s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[117.848755] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[117.852925] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[117.932184] [027/132] (905s left) gem_exec_schedule (semaphore-codependency)
[118.009957] Starting subtest: semaphore-codependency
[118.015373] Subtest semaphore-codependency: SUCCESS (0.013s)
[118.371023] [028/132] (905s left) kms_plane_alpha_blend (alpha-opaque-fb)
[118.459316] Starting subtest: alpha-opaque-fb
[118.728421] Starting dynamic subtest: pipe-A-eDP-1
[119.305459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[119.313947] Starting dynamic subtest: pipe-D-eDP-1
[120.631063] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[120.633517] Subtest alpha-opaque-fb: SUCCESS (2.169s)
[121.458371] [029/132] (902s left) gem_userptr_blits (dmabuf-unsync)
[121.526016] Subtest dmabuf-unsync: SKIP (0.000s)
[121.652716] [030/132] (902s left) gem_exec_flush (basic-wb-prw-default)
[121.708770] Starting subtest: basic-wb-prw-default
[127.172883] Subtest basic-wb-prw-default: SUCCESS (5.465s)
[127.359218] [031/132] (896s left) gem_exec_parallel (userptr)
[127.425316] Starting subtest: userptr
[127.427773] Starting dynamic subtest: rcs0
[128.941926] Dynamic subtest rcs0: SUCCESS (1.517s)
[128.949602] Starting dynamic subtest: bcs0
[130.429504] Dynamic subtest bcs0: SUCCESS (1.486s)
[130.438787] Starting dynamic subtest: vcs0
[131.965290] Dynamic subtest vcs0: SUCCESS (1.533s)
[131.975735] Starting dynamic subtest: vcs1
[133.844699] Dynamic subtest vcs1: SUCCESS (1.878s)
[133.853298] Starting dynamic subtest: vecs0
[135.893376] Dynamic subtest vecs0: SUCCESS (2.047s)
[135.901804] Starting dynamic subtest: ccs0
[137.376896] Dynamic subtest ccs0: SUCCESS (1.483s)
[137.379510] Subtest userptr: SUCCESS (9.953s)
[137.559999] [032/132] (886s left) kms_chamelium_audio (dp-audio-edid)
[137.950016] Subtest dp-audio-edid: SKIP (0.000s)
[138.763725] [033/132] (885s left) i915_pm_rps (min-max-config-idle)
[138.832116] Starting subtest: min-max-config-idle
[138.836431] Subtest min-max-config-idle: SKIP (0.001s)
[138.942791] [034/132] (884s left) kms_chamelium_frames (dp-frame-dump)
[139.333954] Subtest dp-frame-dump: SKIP (0.000s)
[140.102046] [035/132] (883s left) gem_linear_blits (basic)
[140.499817] Starting subtest: basic
[140.505042] Subtest basic: SUCCESS (0.006s)
[140.627345] [036/132] (883s left) kms_plane_scaling (planes-downscale-factor-0-75)
[140.762083] Starting subtest: planes-downscale-factor-0-75
[140.764677] Starting dynamic subtest: pipe-A
[140.785529] Dynamic subtest pipe-A: SKIP (0.018s)
[140.793817] Starting dynamic subtest: pipe-B
[140.816627] Dynamic subtest pipe-B: SKIP (0.029s)
[140.824889] Starting dynamic subtest: pipe-C
[140.845860] Dynamic subtest pipe-C: SKIP (0.030s)
[140.855122] Starting dynamic subtest: pipe-D
[140.875179] Dynamic subtest pipe-D: SKIP (0.029s)
[140.879213] Subtest planes-downscale-factor-0-75: SKIP (0.109s)
[140.983876] [037/132] (882s left) gem_exec_big (single)
[141.039617] Starting subtest: single
[145.536876] Subtest single: SUCCESS (4.494s)
[145.789407] [038/132] (878s left) kms_cursor_crc (cursor-suspend)
[145.950308] Starting subtest: cursor-suspend
[145.952510] Starting dynamic subtest: pipe-A-eDP-1
[178.826096] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.357s)
[178.835473] Starting dynamic subtest: pipe-D-eDP-1
[212.796464] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.694s)
[212.798980] Subtest cursor-suspend: SUCCESS (7.054s)
[213.624871] [039/132] (810s left) gem_exec_schedule (preempt-other)
[213.713045] Starting subtest: preempt-other
[213.715579] Starting dynamic subtest: rcs0
[213.775400] Dynamic subtest rcs0: SUCCESS (0.071s)
[213.790727] Starting dynamic subtest: bcs0
[213.842848] Dynamic subtest bcs0: SUCCESS (0.067s)
[213.856097] Starting dynamic subtest: vcs0
[213.906472] Dynamic subtest vcs0: SUCCESS (0.062s)
[213.917206] Starting dynamic subtest: vcs1
[213.976114] Dynamic subtest vcs1: SUCCESS (0.069s)
[213.991844] Starting dynamic subtest: vecs0
[214.040166] Dynamic subtest vecs0: SUCCESS (0.063s)
[214.052693] Starting dynamic subtest: ccs0
[214.106612] Dynamic subtest ccs0: SUCCESS (0.066s)
[214.109650] Subtest preempt-other: SUCCESS (0.401s)
[215.777811] [040/132] (808s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[215.873129] Starting subtest: plane-primary-overlay-mutable-zpos
[219.283410] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.393s)
[220.470131] [041/132] (803s left) i915_suspend (basic-s3-without-i915)
[220.512292] Starting subtest: basic-s3-without-i915
[222.253764] Subtest basic-s3-without-i915: SKIP (1.733s)
[224.700738] [042/132] (799s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[224.802863] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[224.805431] Starting dynamic subtest: pipe-A-eDP-1
[224.830828] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.841290] Starting dynamic subtest: pipe-B-eDP-1
[224.867160] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.875496] Starting dynamic subtest: pipe-C-eDP-1
[224.900658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.909281] Starting dynamic subtest: pipe-D-eDP-1
[224.935358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.940270] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[226.962917] [043/132] (797s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[227.067133] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[227.880776] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.814s)
[228.054782] [044/132] (796s left) gem_mmap_gtt (basic-copy)
[228.112076] Subtest basic-copy: SKIP (0.000s)
[228.190595] [045/132] (796s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[228.281965] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[228.286879] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[228.350407] [046/132] (795s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[228.463155] Starting subtest: fbc-psr2-cursor-plane-update-sf
[228.465714] Starting dynamic subtest: pipe-A-eDP-1
[228.540632] Dynamic subtest pipe-A-eDP-1: SKIP (0.081s)
[228.551661] Starting dynamic subtest: pipe-B-eDP-1
[229.661399] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[229.666329] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.202s)
[230.847204] [047/132] (793s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[230.933064] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[230.935536] Starting dynamic subtest: pipe-A-eDP-1
[230.964429] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.974714] Starting dynamic subtest: pipe-B-eDP-1
[231.000650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.009244] Starting dynamic subtest: pipe-C-eDP-1
[231.034828] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.043394] Starting dynamic subtest: pipe-D-eDP-1
[231.068706] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.074170] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[233.125630] [048/132] (791s left) kms_flip (flip-vs-suspend-interruptible)
[233.213983] Starting subtest: flip-vs-suspend-interruptible
[233.216513] Starting dynamic subtest: A-eDP1
[266.343506] Dynamic subtest A-eDP1: SUCCESS (4.133s)
[266.358306] Starting dynamic subtest: B-eDP1
[315.343338] Dynamic subtest B-eDP1: SUCCESS (4.557s)
[315.353224] Starting dynamic subtest: C-eDP1
[364.348169] Dynamic subtest C-eDP1: SUCCESS (4.598s)
[364.357836] Starting dynamic subtest: D-eDP1
[413.335578] Dynamic subtest D-eDP1: SUCCESS (4.579s)
[413.341369] Subtest flip-vs-suspend-interruptible: SUCCESS (17.880s)
[414.508802] [049/132] (609s left) kms_pwrite_crc
[416.148902] [050/132] (608s left) kms_getfb (getfb2-handle-zero)
[416.240323] Starting subtest: getfb2-handle-zero
[416.243434] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[416.340471] [051/132] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[416.455881] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[420.869025] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.386s)
[422.074458] [052/132] (602s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[422.175174] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[429.439425] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.243s)
[429.589688] [053/132] (595s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[429.991452] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[430.826853] [054/132] (593s left) prime_self_import (basic-llseek-bad)
[430.874076] Starting subtest: basic-llseek-bad
[430.890683] Subtest basic-llseek-bad: SUCCESS (0.019s)
[430.983920] [055/132] (593s left) gem_exec_parallel (basic)
[431.044140] Starting subtest: basic
[431.046755] Starting dynamic subtest: rcs0
[432.728021] Dynamic subtest rcs0: SUCCESS (1.680s)
[432.739420] Starting dynamic subtest: bcs0
[434.430595] Dynamic subtest bcs0: SUCCESS (1.699s)
[434.440451] Starting dynamic subtest: vcs0
[437.895490] Dynamic subtest vcs0: SUCCESS (3.458s)
[437.907278] Starting dynamic subtest: vcs1
[439.939272] Dynamic subtest vcs1: SUCCESS (2.039s)
[439.951485] Starting dynamic subtest: vecs0
[441.858425] Dynamic subtest vecs0: SUCCESS (1.914s)
[441.869281] Starting dynamic subtest: ccs0
[443.651077] Dynamic subtest ccs0: SUCCESS (1.790s)
[443.653503] Subtest basic: SUCCESS (12.593s)
[443.835458] [056/132] (580s left) gem_exec_reloc (basic-write-wc-active)
[443.897482] Subtest basic-write-wc-active: SKIP (0.000s)
[443.965239] [057/132] (580s left) perf (gen12-invalid-class-instance)
[444.117553] Starting subtest: gen12-invalid-class-instance
[444.126315] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[444.165304] [058/132] (580s left) gem_pxp (create-regular-buffer)
[444.293245] Starting subtest: create-regular-buffer
[444.296284] Subtest create-regular-buffer: SUCCESS (0.000s)
[444.417302] [059/132] (580s left) perf (invalid-oa-metric-set-id)
[444.509291] Starting subtest: invalid-oa-metric-set-id
[444.520442] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[444.562209] [060/132] (580s left) gem_userptr_blits (invalid-null-pointer)
[444.620081] Starting subtest: invalid-null-pointer
[444.622617] Subtest invalid-null-pointer: SUCCESS (0.001s)
[444.753287] [061/132] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[444.851194] Starting subtest: psr-1p-primscrn-cur-indfb-move
[452.211411] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.362s)
[452.348864] [062/132] (572s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[452.428958] Starting subtest: fbc-dirtyfb-ioctl
[452.431717] Starting dynamic subtest: A-eDP-1
[455.053213] Dynamic subtest A-eDP-1: SUCCESS (2.624s)
[455.055806] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.626s)
[455.931507] [063/132] (569s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[456.033917] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[456.036212] Starting dynamic subtest: pipe-A-eDP-1
[456.059191] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.071435] Starting dynamic subtest: pipe-B-eDP-1
[456.095805] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.104405] Starting dynamic subtest: pipe-C-eDP-1
[456.129354] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.138291] Starting dynamic subtest: pipe-D-eDP-1
[456.164199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.169207] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[458.208329] [064/132] (566s left) gem_exec_whisper (basic-queues-priority)
[458.267360] Starting subtest: basic-queues-priority
[481.494169] Subtest basic-queues-priority: SUCCESS (23.220s)
[481.694286] [065/132] (543s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[481.799424] Starting subtest: yf-tiled-8bpp-rotate-180
[481.804243] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[481.899215] [066/132] (543s left) gem_exec_balancer (bonded-true-hang)
[482.154433] Starting subtest: bonded-true-hang
[482.160229] Subtest bonded-true-hang: SKIP (0.000s)
[482.258369] [067/132] (542s left) core_getversion (all-cards)
[482.305311] Starting subtest: all-cards
[482.310230] Subtest all-cards: SUCCESS (0.009s)
[482.347921] [068/132] (542s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[482.435911] Starting subtest: plane-all-transition-nonblocking-fencing
[482.438420] Starting dynamic subtest: pipe-A-eDP-1
[484.929721] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[485.241648] Starting dynamic subtest: pipe-B-eDP-1
[488.449590] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.221s)
[488.755043] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.316s)
[489.586553] [069/132] (535s left) gem_exec_fence (basic-busy-all)
[489.649180] Starting subtest: basic-busy-all
[489.739326] Subtest basic-busy-all: SUCCESS (0.092s)
[492.000762] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[492.005679] [070/132] (533s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[492.098407] Starting subtest: extended-pageflip-modeset-hang-oldfb
[492.101326] Starting dynamic subtest: pipe-A
[500.002091] Dynamic subtest pipe-A: SUCCESS (7.902s)
[500.012326] Starting dynamic subtest: pipe-D
[508.591891] Dynamic subtest pipe-D: SUCCESS (8.584s)
[508.594439] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.490s)
[509.446805] [071/132] (515s left) kms_pm_rpm (modeset-non-lpsp-stress)
[511.101901] Starting subtest: modeset-non-lpsp-stress
[512.259059] Subtest modeset-non-lpsp-stress: SKIP (1.154s)
[512.649718] [072/132] (512s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[512.753871] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[513.389306] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[513.542057] [073/132] (511s left) gem_create (create-ext-placement-all)
[513.707678] Starting subtest: create-ext-placement-all
[513.710247] Subtest create-ext-placement-all: SUCCESS (0.000s)
[513.827038] [074/132] (511s left) kms_flip (2x-plain-flip-interruptible)
[513.925119] Starting subtest: 2x-plain-flip-interruptible
[513.936112] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[514.013062] [075/132] (511s left) kms_invalid_mode (bad-vsync-start)
[514.120297] Starting subtest: bad-vsync-start
[514.122942] Starting dynamic subtest: pipe-A-eDP-1
[514.404251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[514.414960] Starting dynamic subtest: pipe-B-eDP-1
[514.417012] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[514.427267] Starting dynamic subtest: pipe-C-eDP-1
[514.430045] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[514.439419] Starting dynamic subtest: pipe-D-eDP-1
[514.442209] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[514.444910] Subtest bad-vsync-start: SUCCESS (0.290s)
[515.247275] [076/132] (510s left) core_auth (getclient-master-drop)
[515.288096] Starting subtest: getclient-master-drop
[515.303668] Subtest getclient-master-drop: SUCCESS (0.018s)
[515.399747] [077/132] (510s left) kms_vrr (flip-dpms)
[515.498421] Starting subtest: flip-dpms
[515.505180] Subtest flip-dpms: SKIP (0.000s)
[515.570593] [078/132] (510s left) kms_pm_backlight (basic-brightness)
[515.662508] Starting subtest: basic-brightness
[515.713666] Starting dynamic subtest: eDP-1
[516.031961] Dynamic subtest eDP-1: SUCCESS (0.317s)
[516.034357] Subtest basic-brightness: SUCCESS (0.372s)
[516.892336] [079/132] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[516.983452] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[516.988452] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[517.084331] [080/132] (508s left) gem_busy (extended)
[517.262451] Starting subtest: extended
[517.265418] Starting dynamic subtest: rcs0
[517.351826] Dynamic subtest rcs0: SUCCESS (0.089s)
[517.365009] Starting dynamic subtest: bcs0
[517.397076] Dynamic subtest bcs0: SUCCESS (0.043s)
[517.412767] Starting dynamic subtest: vcs0
[518.850444] Dynamic subtest vcs0: SUCCESS (1.450s)
[518.868229] Starting dynamic subtest: vcs1
[520.898422] Dynamic subtest vcs1: SUCCESS (2.045s)
[520.916304] Starting dynamic subtest: vecs0
[522.883095] Dynamic subtest vecs0: SUCCESS (1.982s)
[522.900452] Starting dynamic subtest: ccs0
[522.930821] Dynamic subtest ccs0: SUCCESS (0.046s)
[522.934058] Subtest extended: SUCCESS (5.672s)
[523.179896] [081/132] (502s left) api_intel_bb (blit-reloc-purge-cache)
[523.233905] Starting subtest: blit-reloc-purge-cache
[523.238960] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[523.351398] [082/132] (502s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[523.456984] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[523.469179] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.016s)
[523.548471] [083/132] (502s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[523.646963] Starting subtest: plane-lut1d-pre-ctm3x4
[523.781439] Starting dynamic subtest: pipe-A-plane-0
[523.925828] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[523.936422] Starting dynamic subtest: pipe-A-plane-1
[524.058399] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[524.068366] Starting dynamic subtest: pipe-A-plane-2
[524.235544] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[525.394260] Starting dynamic subtest: pipe-B-plane-0
[525.528858] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[525.538440] Starting dynamic subtest: pipe-B-plane-1
[525.684236] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[525.694147] Starting dynamic subtest: pipe-B-plane-2
[525.841173] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[527.031409] Starting dynamic subtest: pipe-C-plane-0
[527.166619] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[527.177334] Starting dynamic subtest: pipe-C-plane-1
[527.310894] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[527.321732] Starting dynamic subtest: pipe-C-plane-2
[527.455308] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[528.641112] Starting dynamic subtest: pipe-D-plane-0
[528.776298] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[528.788309] Starting dynamic subtest: pipe-D-plane-1
[528.931227] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[528.942446] Starting dynamic subtest: pipe-D-plane-2
[529.076185] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[529.365976] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.720s)
[530.203060] [084/132] (495s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[530.260252] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[530.263187] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[530.360136] [085/132] (495s left) syncobj_basic (test-valid-cycle)
[530.421422] Starting subtest: test-valid-cycle
[530.424154] Subtest test-valid-cycle: SUCCESS (0.000s)
[530.515137] [086/132] (495s left) gem_ctx_persistence (legacy-engines-hang)
[530.582098] Starting subtest: legacy-engines-hang
[530.584952] Starting dynamic subtest: render
[530.645139] Dynamic subtest render: SUCCESS (0.063s)
[530.658188] Starting dynamic subtest: bsd1
[530.733145] Dynamic subtest bsd1: SUCCESS (0.086s)
[530.750009] Starting dynamic subtest: bsd2
[530.828351] Dynamic subtest bsd2: SUCCESS (0.092s)
[530.843682] Starting dynamic subtest: blt
[530.921486] Dynamic subtest blt: SUCCESS (0.090s)
[530.936358] Starting dynamic subtest: vebox
[531.014436] Dynamic subtest vebox: SUCCESS (0.090s)
[531.017253] Subtest legacy-engines-hang: SUCCESS (0.434s)
[531.096439] [087/132] (494s left) syncobj_timeline (invalid-wait-illegal-handle)
[531.144215] Starting subtest: invalid-wait-illegal-handle
[531.146674] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[531.252808] [088/132] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[531.349809] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[531.354206] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[531.440053] [089/132] (494s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[531.528298] Starting subtest: psr-rgb101010-draw-blt
[538.784450] Subtest psr-rgb101010-draw-blt: SUCCESS (7.258s)
[538.914476] [090/132] (487s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[539.005292] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[539.010212] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[539.102841] [091/132] (487s left) kms_cursor_crc (cursor-offscreen-max-size)
[539.439872] Starting subtest: cursor-offscreen-max-size
[539.447841] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[539.555623] [092/132] (486s left) vgem_basic (create)
[539.603306] Starting subtest: create
[539.606304] Subtest create: SUCCESS (0.000s)
[539.687741] [093/132] (486s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[539.784669] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[539.788666] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[539.852767] [094/132] (486s left) gem_flink_race (flink_close)
[539.892350] Starting subtest: flink_close
[544.975431] Subtest flink_close: SUCCESS (5.083s)
[545.052843] [095/132] (481s left) kms_flip (2x-blocking-wf_vblank)
[545.155838] Starting subtest: 2x-blocking-wf_vblank
[545.167319] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[545.253183] [096/132] (481s left) perf (polling-small-buf)
[545.345204] Starting subtest: polling-small-buf
[545.436115] Subtest polling-small-buf: SUCCESS (0.089s)
[545.487815] [097/132] (481s left) gem_mmap_wc (write)
[545.547092] Subtest write: SKIP (0.000s)
[545.619372] [098/132] (480s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[545.734573] Starting subtest: x-tiled-32bpp-rotate-270
[545.753693] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s)
[545.894474] [099/132] (480s left) kms_psr (pr-cursor-render)
[545.998963] Starting subtest: pr-cursor-render
[546.003003] Subtest pr-cursor-render: SKIP (0.000s)
[546.079742] [100/132] (480s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[546.206602] Starting subtest: psr2-overlay-plane-update-continuous-sf
[546.209017] Starting dynamic subtest: pipe-A-eDP-1
[547.337416] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.133s)
[547.348342] Starting dynamic subtest: pipe-B-eDP-1
[549.095427] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.757s)
[549.098268] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.893s)
[549.899715] [101/132] (476s left) gem_ringfill (legacy-basic)
[555.911461] Starting subtest: legacy-basic
[555.914457] Starting dynamic subtest: default
[555.972835] Dynamic subtest default: SUCCESS (0.061s)
[555.983373] Starting dynamic subtest: render
[556.015170] Dynamic subtest render: SUCCESS (0.040s)
[556.025802] Starting dynamic subtest: bsd
[556.059017] Dynamic subtest bsd: SUCCESS (0.041s)
[556.070469] Starting dynamic subtest: bsd1
[556.103628] Dynamic subtest bsd1: SUCCESS (0.042s)
[556.115224] Starting dynamic subtest: bsd2
[556.144769] Dynamic subtest bsd2: SUCCESS (0.039s)
[556.155658] Starting dynamic subtest: blt
[556.194161] Dynamic subtest blt: SUCCESS (0.047s)
[556.207444] Starting dynamic subtest: vebox
[556.237691] Dynamic subtest vebox: SUCCESS (0.041s)
[556.240364] Subtest legacy-basic: SUCCESS (0.328s)
[556.323593] [102/132] (470s left) syncobj_eventfd (timeline-wait-before-signal)
[556.378646] Starting subtest: timeline-wait-before-signal
[556.409879] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[556.489567] [103/132] (470s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[556.592552] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[556.597259] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[556.694555] [104/132] (470s left) kms_cursor_crc (cursor-sliding-128x128)
[556.905146] Starting subtest: cursor-sliding-128x128
[556.907629] Starting dynamic subtest: pipe-A-eDP-1
[560.137600] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.231s)
[560.168257] Starting dynamic subtest: pipe-D-eDP-1
[563.998273] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.840s)
[564.001260] Subtest cursor-sliding-128x128: SUCCESS (7.095s)
[564.888462] [105/132] (461s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[564.979056] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[571.484417] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.508s)
[571.621872] [106/132] (455s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[571.726855] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[571.731804] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[571.813848] [107/132] (455s left) sw_sync (sync_merge)
[571.851040] Starting subtest: sync_merge
[571.853798] Subtest sync_merge: SUCCESS (0.000s)
[571.904763] [108/132] (455s left) gem_mmap_gtt (isolation)
[571.970264] Subtest isolation: SKIP (0.000s)
[572.032584] [109/132] (455s left) kms_psr (fbc-pr-sprite-blt)
[572.122179] Starting subtest: fbc-pr-sprite-blt
[572.126659] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[572.195516] [110/132] (454s left) gem_exec_reloc (basic-write-gtt-active)
[572.249441] Subtest basic-write-gtt-active: SKIP (0.000s)
[572.320820] [111/132] (454s left) kms_plane_multiple (tiling-4)
[572.401338] Starting subtest: tiling-4
[572.404185] Starting dynamic subtest: pipe-A-eDP-1
[576.116116] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.713s)
[576.128712] Starting dynamic subtest: pipe-B-eDP-1
[580.466941] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.348s)
[580.478006] Starting dynamic subtest: pipe-C-eDP-1
[584.792111] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.324s)
[584.803826] Starting dynamic subtest: pipe-D-eDP-1
[589.135265] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.341s)
[589.138259] Subtest tiling-4: SUCCESS (16.732s)
[589.938501] [112/132] (437s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[590.045595] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[590.669457] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[590.820647] [113/132] (436s left) kms_dsc (dsc-basic)
[590.912694] Starting subtest: dsc-basic
[590.927697] Subtest dsc-basic: SKIP (0.000s)
[590.985330] [114/132] (436s left) sysfs_preempt_timeout (idempotent)
[591.041134] Starting subtest: idempotent
[591.043677] Starting dynamic subtest: vecs0
[591.046347] Dynamic subtest vecs0: SUCCESS (0.000s)
[591.057271] Starting dynamic subtest: ccs0
[591.059848] Dynamic subtest ccs0: SUCCESS (0.000s)
[591.069275] Starting dynamic subtest: vcs0
[591.072215] Dynamic subtest vcs0: SUCCESS (0.000s)
[591.081880] Starting dynamic subtest: bcs0
[591.084234] Dynamic subtest bcs0: SUCCESS (0.000s)
[591.094183] Starting dynamic subtest: rcs0
[591.096896] Dynamic subtest rcs0: SUCCESS (0.000s)
[591.106859] Starting dynamic subtest: vcs1
[591.109291] Dynamic subtest vcs1: SUCCESS (0.000s)
[591.112119] Subtest idempotent: SUCCESS (0.007s)
[591.152826] [115/132] (436s left) syncobj_timeline (transfer-timeline-point)
[591.215016] Starting subtest: transfer-timeline-point
[591.217436] Subtest transfer-timeline-point: SUCCESS (0.000s)
[591.314948] [116/132] (436s left) gem_exec_whisper (basic-fds-forked-all)
[591.378171] Starting subtest: basic-fds-forked-all
[614.135361] Subtest basic-fds-forked-all: SUCCESS (22.751s)
[614.323643] [117/132] (413s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[614.421175] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[614.450992] Starting dynamic subtest: pipe-A-plane-0
[614.750281] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[614.762259] Starting dynamic subtest: pipe-A-plane-3
[614.995200] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[615.005195] Starting dynamic subtest: pipe-A-plane-5
[615.010187] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[616.122233] Starting dynamic subtest: pipe-B-plane-0
[616.424660] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[616.436135] Starting dynamic subtest: pipe-B-plane-3
[616.681170] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[616.693579] Starting dynamic subtest: pipe-B-plane-5
[616.699128] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[617.005451] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.583s)
[617.805254] [118/132] (409s left) kms_selftest (drm_dp_mst_helper)
[617.842182] Starting subtest: drm_dp_mst_helper
[617.928353] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[618.051996] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.123s)
[618.064738] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[618.142835] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.088s)
[618.153821] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[618.250356] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.107s)
[618.253206] Subtest drm_dp_mst_helper: SUCCESS (0.407s)
[618.393739] [119/132] (409s left) kms_fbcon_fbt (psr-suspend)
[618.452259] Starting subtest: psr-suspend
[667.341367] Subtest psr-suspend: SUCCESS (19.581s)
[667.421203] [120/132] (360s left) gem_wait (write-wait)
[667.488412] Starting subtest: write-wait
[667.490830] Starting dynamic subtest: all-engines
[668.586437] Dynamic subtest all-engines: SUCCESS (1.092s)
[668.608832] Starting dynamic subtest: rcs0
[669.651805] Dynamic subtest rcs0: SUCCESS (1.056s)
[669.671186] Starting dynamic subtest: bcs0
[670.712681] Dynamic subtest bcs0: SUCCESS (1.054s)
[670.731410] Starting dynamic subtest: vcs0
[671.773059] Dynamic subtest vcs0: SUCCESS (1.054s)
[671.790168] Starting dynamic subtest: vcs1
[672.832866] Dynamic subtest vcs1: SUCCESS (1.054s)
[672.849628] Starting dynamic subtest: vecs0
[673.894561] Dynamic subtest vecs0: SUCCESS (1.056s)
[673.912551] Starting dynamic subtest: ccs0
[674.956497] Dynamic subtest ccs0: SUCCESS (1.057s)
[674.959310] Subtest write-wait: SUCCESS (7.440s)
[675.155779] [121/132] (352s left) kms_psr (psr-cursor-render)
[675.252447] Starting subtest: psr-cursor-render
[675.255182] Starting dynamic subtest: eDP-1
[676.957251] Dynamic subtest eDP-1: SUCCESS (1.700s)
[676.960219] Subtest psr-cursor-render: SUCCESS (1.701s)
[677.830429] [122/132] (349s left) i915_drm_fdinfo (virtual-busy)
[677.875401] Starting subtest: virtual-busy
[677.880757] Subtest virtual-busy: SKIP (0.000s)
[677.942416] [123/132] (349s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[678.055342] Starting subtest: verify-pxp-stale-buf-optout-execution
[679.119740] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.062s)
[679.247816] [124/132] (348s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[679.348504] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[683.569603] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.219s)
[684.740156] [125/132] (342s left) gem_exec_fence (keep-in-fence)
[684.908590] Starting subtest: keep-in-fence
[684.911383] Starting dynamic subtest: rcs0
[684.973756] Dynamic subtest rcs0: SUCCESS (0.064s)
[684.987288] Starting dynamic subtest: bcs0
[685.029426] Dynamic subtest bcs0: SUCCESS (0.053s)
[685.042568] Starting dynamic subtest: vcs0
[686.118928] Dynamic subtest vcs0: SUCCESS (1.085s)
[686.131890] Starting dynamic subtest: vcs1
[688.103191] Dynamic subtest vcs1: SUCCESS (1.980s)
[688.117880] Starting dynamic subtest: vecs0
[690.151503] Dynamic subtest vecs0: SUCCESS (2.044s)
[690.173573] Starting dynamic subtest: ccs0
[690.399893] Dynamic subtest ccs0: SUCCESS (0.246s)
[690.402582] Subtest keep-in-fence: SUCCESS (5.487s)
[692.201659] [126/132] (335s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[692.309196] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[692.314252] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[692.408158] [127/132] (335s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[692.461698] Starting subtest: invalid-multi-wait-all-unsubmitted
[692.464881] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[692.568169] [128/132] (335s left) kms_psr (fbc-psr-primary-blt)
[692.655418] Starting subtest: fbc-psr-primary-blt
[692.658143] Starting dynamic subtest: eDP-1
[692.663166] Dynamic subtest eDP-1: SKIP (0.000s)
[692.668075] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[692.728389] [129/132] (335s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[692.818558] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[699.437677] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.623s)
[699.563120] [130/132] (328s left) gem_sync (basic-each)
[699.637987] Starting subtest: basic-each
[701.916120] Subtest basic-each: SUCCESS (2.294s)
[702.107140] [131/132] (325s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[702.199826] Starting subtest: async-flip-with-page-flip-events-tiled
[702.570086] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[705.323771] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[705.338861] Starting dynamic subtest: pipe-A-eDP-1-4
[707.498854] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[707.509608] Starting dynamic subtest: pipe-A-eDP-1-4
[709.508876] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[709.522977] Starting dynamic subtest: pipe-A-eDP-1-x
[711.698924] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[712.087587] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[714.861363] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[714.875295] Starting dynamic subtest: pipe-B-eDP-1-4
[717.047437] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[717.059862] Starting dynamic subtest: pipe-B-eDP-1-4
[719.057439] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[719.068170] Starting dynamic subtest: pipe-B-eDP-1-x
[721.247437] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[721.643873] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[724.394287] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.760s)
[724.406740] Starting dynamic subtest: pipe-C-eDP-1-4
[726.580790] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[726.591739] Starting dynamic subtest: pipe-C-eDP-1-4
[728.590820] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[728.601357] Starting dynamic subtest: pipe-C-eDP-1-x
[730.771000] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[731.137269] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[733.935975] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[733.946894] Starting dynamic subtest: pipe-D-eDP-1-4
[736.109380] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.171s)
[736.122772] Starting dynamic subtest: pipe-D-eDP-1-4
[738.120202] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[738.133635] Starting dynamic subtest: pipe-D-eDP-1-x
[740.299901] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[740.303130] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.094s)
[741.518222] [132/132] (286s left) kms_psr (psr2-primary-mmap-gtt)
[741.604362] Starting subtest: psr2-primary-mmap-gtt
[741.606900] Starting dynamic subtest: eDP-1
[743.007769] Dynamic subtest eDP-1: SKIP (1.400s)
[743.013396] Subtest psr2-primary-mmap-gtt: SKIP (1.403s)
[743.159248] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_shared
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: kms_pipe_b_c_ivb
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_set_tiling_vs_gtt
results: parsing output: 13/ for test: kms_lease
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_lmem_swapping
results: parsing output: 19/ for test: gem_pread
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_wait
results: parsing output: 22/ for test: i915_getparams_basic
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_plane_alpha_blend
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: gem_exec_flush
results: parsing output: 30/ for test: gem_exec_parallel
results: parsing output: 31/ for test: kms_chamelium_audio
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: gem_linear_blits
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_exec_big
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_atomic
results: parsing output: 40/ for test: i915_suspend
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_pwrite_crc
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: prime_self_import
results: parsing output: 54/ for test: gem_exec_parallel
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_dirtyfb
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: core_getversion
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: kms_pm_rpm
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_create
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: core_auth
results: parsing output: 76/ for test: kms_vrr
results: parsing output: 77/ for test: kms_pm_backlight
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_color_pipeline
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: syncobj_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_flink_race
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: gem_ringfill
results: parsing output: 101/ for test: syncobj_eventfd
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_plane_multiple
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_dsc
results: parsing output: 113/ for test: sysfs_preempt_timeout
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_selftest
results: parsing output: 118/ for test: kms_fbcon_fbt
results: parsing output: 119/ for test: gem_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_sync
results: parsing output: 130/ for test: kms_async_flips
results: parsing output: 131/ for test: kms_psr
Done.