[58.829115] Initializing watchdogs
[58.829164]   /dev/watchdog0
[58.844481] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.849083] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.851584] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.853376] [001/155] (960s left) syncobj_timeline (wait-for-submit-complex)
[58.910923] Starting subtest: wait-for-submit-complex
[58.973947] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[59.054905] [002/155] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[59.149510] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[59.150583] Starting dynamic subtest: pipe-A-eDP-1
[59.160090] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.167542] Starting dynamic subtest: pipe-B-eDP-1
[59.176251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.184265] Starting dynamic subtest: pipe-C-eDP-1
[59.192050] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.197753] Starting dynamic subtest: pipe-D-eDP-1
[59.205564] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.207326] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[61.459208] [003/155] (957s left) kms_cursor_crc (cursor-size-change)
[61.549385] Starting subtest: cursor-size-change
[61.550559] Starting dynamic subtest: pipe-A-eDP-1
[62.369753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[62.376766] Starting dynamic subtest: pipe-D-eDP-1
[63.817979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.453s)
[63.819099] Subtest cursor-size-change: SUCCESS (2.279s)
[64.719531] [004/155] (954s left) gem_ctx_isolation (nonpriv-switch)
[64.782656] Starting subtest: nonpriv-switch
[64.783688] Starting dynamic subtest: rcs0
[65.079202] Dynamic subtest rcs0: SUCCESS (0.298s)
[65.086970] Starting dynamic subtest: bcs0
[65.362163] Dynamic subtest bcs0: SUCCESS (0.283s)
[65.369965] Starting dynamic subtest: vcs0
[65.654101] Dynamic subtest vcs0: SUCCESS (0.292s)
[65.662902] Starting dynamic subtest: vcs1
[67.661273] Dynamic subtest vcs1: SUCCESS (2.012s)
[67.668156] Starting dynamic subtest: vecs0
[69.560569] Dynamic subtest vecs0: SUCCESS (1.902s)
[69.568811] Starting dynamic subtest: ccs0
[71.654944] Dynamic subtest ccs0: SUCCESS (2.097s)
[71.656376] Subtest nonpriv-switch: SUCCESS (6.887s)
[71.901554] [005/155] (947s left) gem_fence_thrash (bo-write-verify-x)
[71.931082] Starting subtest: bo-write-verify-x
[71.953414] Subtest bo-write-verify-x: SKIP (0.022s)
[72.008449] [006/155] (947s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt)
[72.107926] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt
[72.109578] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[72.190606] [007/155] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[72.316735] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[72.317786] Starting dynamic subtest: pipe-A-eDP-1
[72.382793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[72.389731] Starting dynamic subtest: pipe-B-eDP-1
[72.457347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.074s)
[72.465583] Starting dynamic subtest: pipe-C-eDP-1
[72.534492] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.076s)
[72.545283] Starting dynamic subtest: pipe-D-eDP-1
[72.621607] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.085s)
[72.623017] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.306s)
[74.975935] [008/155] (944s left) kms_psr (pr-sprite-render)
[75.059700] Starting subtest: pr-sprite-render
[75.061679] Subtest pr-sprite-render: SKIP (0.000s)
[75.127529] [009/155] (944s left) kms_chamelium_frames (dp-crc-single)
[75.500914] Subtest dp-crc-single: SKIP (0.000s)
[76.354292] [010/155] (943s left) syncobj_wait (multi-wait-all-submitted-signaled)
[76.412119] Starting subtest: multi-wait-all-submitted-signaled
[76.532798] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[76.598269] [011/155] (943s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[76.699925] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[76.702354] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[76.804395] [012/155] (942s left) drm_read (fault-buffer)
[76.935416] Starting subtest: fault-buffer
[76.936412] Subtest fault-buffer: SUCCESS (0.000s)
[77.046441] [013/155] (942s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[77.154317] Starting subtest: x-tiled-16bpp-rotate-0
[78.509949] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.357s)
[78.613534] [014/155] (941s left) kms_chamelium_hpd (vga-hpd-fast)
[79.001112] Subtest vga-hpd-fast: SKIP (0.000s)
[79.780079] [015/155] (940s left) prime_vgem (basic-blt)
[79.900498] Starting subtest: basic-blt
[79.924856] Subtest basic-blt: SUCCESS (0.024s)
[80.035517] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[80.037307] [016/155] (939s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[80.088500] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[80.090510] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[80.272992] [017/155] (939s left) gem_pxp (reject-modify-context-protection-off-1)
[80.405993] Starting subtest: reject-modify-context-protection-off-1
[80.407510] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[80.509630] [018/155] (939s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[80.608597] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[80.610643] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[80.720193] [019/155] (939s left) gem_ctx_shared (q-in-order)
[80.773966] Starting subtest: Q-in-order
[80.775227] Starting dynamic subtest: rcs0
[80.859595] Dynamic subtest rcs0: SUCCESS (0.085s)
[80.874666] Starting dynamic subtest: vcs0
[80.938594] Dynamic subtest vcs0: SUCCESS (0.078s)
[80.953625] Starting dynamic subtest: vcs1
[81.017472] Dynamic subtest vcs1: SUCCESS (0.080s)
[81.024772] Starting dynamic subtest: vecs0
[81.096334] Dynamic subtest vecs0: SUCCESS (0.078s)
[81.112161] Starting dynamic subtest: ccs0
[81.181646] Dynamic subtest ccs0: SUCCESS (0.086s)
[81.182750] Subtest Q-in-order: SUCCESS (0.408s)
[82.421497] [020/155] (937s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[82.511857] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[82.513608] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[82.601160] [021/155] (937s left) kms_getfb (getfb-handle-closed)
[82.691252] Starting subtest: getfb-handle-closed
[82.692071] Subtest getfb-handle-closed: SUCCESS (0.000s)
[82.777419] [022/155] (937s left) i915_drm_fdinfo (busy-check-all)
[82.811382] Starting subtest: busy-check-all
[82.812214] Starting dynamic subtest: rcs0
[82.815346] Dynamic subtest rcs0: SKIP (0.005s)
[82.826047] Starting dynamic subtest: bcs0
[82.827861] Dynamic subtest bcs0: SKIP (0.000s)
[82.834882] Starting dynamic subtest: vcs0
[82.836329] Dynamic subtest vcs0: SKIP (0.000s)
[82.843230] Starting dynamic subtest: vcs1
[82.844656] Dynamic subtest vcs1: SKIP (0.000s)
[82.851390] Starting dynamic subtest: vecs0
[82.852902] Dynamic subtest vecs0: SKIP (0.000s)
[82.859473] Starting dynamic subtest: ccs0
[82.860911] Dynamic subtest ccs0: SKIP (0.000s)
[82.862342] Subtest busy-check-all: SKIP (0.007s)
[82.890501] [023/155] (937s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[83.024211] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[83.025211] Starting dynamic subtest: pipe-A-eDP-1
[83.035044] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.046913] Starting dynamic subtest: pipe-B-eDP-1
[83.056460] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.064854] Starting dynamic subtest: pipe-C-eDP-1
[83.073061] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.079693] Starting dynamic subtest: pipe-D-eDP-1
[83.088587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.090422] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[85.257555] [024/155] (934s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[85.378789] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[96.534677] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.162s)
[97.392947] [025/155] (922s left) syncobj_eventfd (invalid-illegal-eventfd)
[97.457081] Starting subtest: invalid-illegal-eventfd
[97.458281] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[97.569933] [026/155] (922s left) kms_lease (master-vs-lease)
[97.661671] Starting subtest: master-vs-lease
[97.663922] Subtest master-vs-lease: SUCCESS (0.003s)
[97.756105] [027/155] (922s left) gem_flink_basic (basic)
[97.802159] Starting subtest: basic
[97.803064] Subtest basic: SUCCESS (0.000s)
[97.899983] [028/155] (922s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[97.988654] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[97.989624] Starting dynamic subtest: pipe-A
[98.008967] Dynamic subtest pipe-A: SKIP (0.019s)
[98.016470] Starting dynamic subtest: pipe-B
[98.047122] Dynamic subtest pipe-B: SKIP (0.038s)
[98.054290] Starting dynamic subtest: pipe-C
[98.085296] Dynamic subtest pipe-C: SKIP (0.038s)
[98.098647] Starting dynamic subtest: pipe-D
[98.120266] Dynamic subtest pipe-D: SKIP (0.035s)
[98.121819] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.132s)
[98.235146] [029/155] (922s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[98.332043] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[98.333717] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[98.440899] [030/155] (921s left) kms_getfb (getfb-handle-not-fb)
[98.517931] Starting subtest: getfb-handle-not-fb
[98.518773] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[98.599888] [031/155] (921s left) core_setmaster_vs_auth
[98.742488] [032/155] (921s left) syncobj_wait (invalid-wait-illegal-handle)
[98.795511] Starting subtest: invalid-wait-illegal-handle
[98.797049] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[98.890798] [033/155] (921s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[98.940632] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[99.058854] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[99.119921] [034/155] (921s left) kms_vrr (max-min)
[99.210141] Starting subtest: max-min
[99.212652] Subtest max-min: SKIP (0.000s)
[99.278799] [035/155] (921s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[99.370632] Starting subtest: fbcpsr-rgb101010-draw-blt
[104.196587] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.826s)
[104.318233] [036/155] (916s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[104.415031] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[108.839735] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.427s)
[110.042749] [037/155] (910s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[110.132451] Starting subtest: 4-tiled-64bpp-rotate-0
[111.868437] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.736s)
[112.030899] [038/155] (908s left) vgem_basic (bad-fence)
[112.064802] Starting subtest: bad-fence
[112.065691] Subtest bad-fence: SUCCESS (0.000s)
[112.133882] [039/155] (908s left) kms_joiner (basic-force-big-joiner)
[112.214170] Starting subtest: basic-force-big-joiner
[112.216122] Subtest basic-force-big-joiner: SKIP (0.000s)
[112.280656] [040/155] (908s left) gem_exec_whisper (basic-normal)
[112.333437] Starting subtest: basic-normal
[115.832682] Subtest basic-normal: SUCCESS (3.498s)
[116.011957] [041/155] (904s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[116.115911] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[116.118234] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[116.219812] [042/155] (904s left) kms_properties (connector-properties-atomic)
[116.303457] Starting subtest: connector-properties-atomic
[116.304485] Starting dynamic subtest: pipe-A-eDP-1
[124.450176] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.146s)
[124.458217] Starting dynamic subtest: pipe-None-DP-1
[124.460207] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[124.467360] Starting dynamic subtest: pipe-None-HDMI-A-1
[124.468951] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[124.476089] Starting dynamic subtest: pipe-None-DP-2
[124.477836] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[124.485261] Starting dynamic subtest: pipe-None-HDMI-A-2
[124.487042] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[124.494296] Starting dynamic subtest: pipe-None-DP-3
[124.495976] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[124.503351] Starting dynamic subtest: pipe-None-DP-4
[124.505059] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[124.506054] Subtest connector-properties-atomic: SUCCESS (8.157s)
[125.321538] [043/155] (895s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[125.412174] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[125.413936] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[125.506347] [044/155] (895s left) gem_ccs (block-multicopy-compressed)
[125.565826] Starting subtest: block-multicopy-compressed
[125.567553] Subtest block-multicopy-compressed: SKIP (0.000s)
[125.656365] [045/155] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[125.748193] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[125.749944] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[125.841545] [046/155] (895s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[125.923160] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[125.924045] Starting dynamic subtest: pipe-A-eDP-1
[126.197865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.261s)
[126.208031] Starting dynamic subtest: pipe-B-eDP-1
[127.486057] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s)
[127.494414] Starting dynamic subtest: pipe-C-eDP-1
[128.781624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.295s)
[128.790201] Starting dynamic subtest: pipe-D-eDP-1
[130.009183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[130.009980] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.075s)
[131.226742] [047/155] (889s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[131.315339] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[131.317178] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[131.443295] [048/155] (889s left) kms_flip (basic-flip-vs-wf_vblank)
[131.541355] Starting subtest: basic-flip-vs-wf_vblank
[131.544425] Starting dynamic subtest: A-eDP1
[133.486784] Dynamic subtest A-eDP1: SUCCESS (1.944s)
[133.496668] Starting dynamic subtest: B-eDP1
[135.415575] Dynamic subtest B-eDP1: SUCCESS (1.925s)
[135.424909] Starting dynamic subtest: C-eDP1
[137.338726] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[137.347499] Starting dynamic subtest: D-eDP1
[139.268315] Dynamic subtest D-eDP1: SUCCESS (1.929s)
[139.271436] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.729s)
[140.484905] [049/155] (880s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[140.566320] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[140.567186] Starting dynamic subtest: pipe-A-eDP-1
[141.476116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.907s)
[141.483989] Starting dynamic subtest: pipe-B-eDP-1
[143.156480] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.679s)
[143.164645] Starting dynamic subtest: pipe-C-eDP-1
[144.756045] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.597s)
[144.769424] Starting dynamic subtest: pipe-D-eDP-1
[146.317262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.561s)
[146.318108] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.748s)
[147.531778] [050/155] (873s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[147.587569] Starting subtest: multi-wait-all-for-submit-signaled
[147.588618] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[147.691809] [051/155] (873s left) kms_flip (2x-absolute-wf_vblank)
[147.774333] Starting subtest: 2x-absolute-wf_vblank
[147.784735] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[147.865671] [052/155] (873s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[147.962706] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[147.964448] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[148.063119] [053/155] (873s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[148.150296] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[148.151236] Starting dynamic subtest: pipe-A-default-mode
[149.301851] Dynamic subtest pipe-A-default-mode: SKIP (1.150s)
[149.303485] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.151s)
[149.453944] [054/155] (871s left) kms_pm_backlight (fade-with-suspend)
[149.543583] Starting subtest: fade-with-suspend
[166.330605] Starting dynamic subtest: eDP-1
[169.353973] Dynamic subtest eDP-1: SUCCESS (3.026s)
[169.354878] Subtest fade-with-suspend: SUCCESS (4.764s)
[179.278534] [055/155] (850s left) gem_mmap_gtt (hang)
[179.339787] Subtest hang: SKIP (0.000s)
[179.404525] [056/155] (850s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[179.501326] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[179.503542] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[179.605673] [057/155] (850s left) gem_lmem_swapping (parallel-random-verify)
[179.641093] Subtest parallel-random-verify: SKIP (0.000s)
[179.675617] [058/155] (850s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[179.764902] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[179.766626] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[179.830745] [059/155] (850s left) gem_mmap_offset (mmap-boundaries)
[179.879101] Starting subtest: mmap-boundaries
[179.880057] Starting dynamic subtest: smem0
[180.165412] Dynamic subtest smem0: SUCCESS (0.281s)
[180.167362] Subtest mmap-boundaries: SUCCESS (0.282s)
[180.262140] [060/155] (850s left) gem_ctx_engines (independent)
[180.319561] Starting subtest: independent
[180.320674] Starting dynamic subtest: rcs0
[180.462147] Dynamic subtest rcs0: SUCCESS (0.135s)
[180.471716] Starting dynamic subtest: bcs0
[180.562610] Dynamic subtest bcs0: SUCCESS (0.110s)
[180.571551] Starting dynamic subtest: vcs0
[180.696806] Dynamic subtest vcs0: SUCCESS (0.126s)
[180.707629] Starting dynamic subtest: vcs1
[180.812778] Dynamic subtest vcs1: SUCCESS (0.125s)
[180.822545] Starting dynamic subtest: vecs0
[180.924034] Dynamic subtest vecs0: SUCCESS (0.111s)
[180.933818] Starting dynamic subtest: ccs0
[181.058793] Dynamic subtest ccs0: SUCCESS (0.127s)
[181.068701] Starting dynamic subtest: all-engines
[181.509605] Dynamic subtest all-engines: SUCCESS (0.455s)
[181.510641] Subtest independent: SUCCESS (1.197s)
[182.513253] [061/155] (847s left) perf (disabled-read-error)
[182.646320] Starting subtest: disabled-read-error
[182.662218] Subtest disabled-read-error: SUCCESS (0.016s)
[182.707623] [062/155] (847s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[182.816334] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[183.447074] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[183.607779] [063/155] (846s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[183.675162] Starting subtest: basic-batch-kernel-default-cmd
[183.676898] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[183.854141] [064/155] (846s left) kms_cdclk (plane-scaling)
[183.941703] Starting subtest: plane-scaling
[183.942593] Starting dynamic subtest: pipe-A-eDP-1
[184.230953] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[184.240158] Starting dynamic subtest: pipe-B-eDP-1
[184.241930] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[184.250486] Starting dynamic subtest: pipe-C-eDP-1
[184.252229] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[184.263543] Starting dynamic subtest: pipe-D-eDP-1
[184.265417] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[184.267890] Subtest plane-scaling: SKIP (0.297s)
[185.108376] [065/155] (845s left) kms_big_fb (linear-16bpp-rotate-270)
[185.210715] Starting subtest: linear-16bpp-rotate-270
[185.230318] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[185.342730] [066/155] (845s left) gem_exec_balancer (nohangcheck)
[185.612997] Starting subtest: nohangcheck
[186.600271] Subtest nohangcheck: SUCCESS (0.991s)
[186.712489] [067/155] (843s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[187.267199] Starting subtest: syncobj-timeline-multiple-ext-nodes
[187.268594] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[188.406177] [068/155] (842s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[188.498900] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[188.500478] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[188.599779] [069/155] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[188.685975] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[188.687517] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[188.790566] [070/155] (841s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[188.877710] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[194.433088] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.575s)
[195.577981] [071/155] (835s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[195.673638] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[195.675266] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[195.764832] [072/155] (835s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[195.846935] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[195.847828] Starting dynamic subtest: pipe-A-eDP-1
[195.927594] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[195.937239] Starting dynamic subtest: pipe-B-eDP-1
[197.043582] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[197.045196] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.200s)
[198.328275] [073/155] (832s left) gem_exec_suspend (basic-s3)
[198.382990] Starting subtest: basic-S3
[198.384196] Starting dynamic subtest: smem
[218.813923] Dynamic subtest smem: SUCCESS (6.972s)
[218.815384] Subtest basic-S3: SUCCESS (6.975s)
[225.008319] [074/155] (811s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[225.107735] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[225.109420] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[225.202627] [075/155] (811s left) gem_exec_fence (syncobj-timeline-unused-fence)
[225.779367] Starting subtest: syncobj-timeline-unused-fence
[225.780459] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[226.898075] [076/155] (810s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[227.024178] Starting subtest: flip-vs-cursor-busy-crc-atomic
[227.776219] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.752s)
[228.620805] [077/155] (808s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[228.717016] Starting subtest: fbc-rgb565-draw-render
[232.956663] Subtest fbc-rgb565-draw-render: SUCCESS (4.243s)
[234.129132] [078/155] (802s left) kms_psr (fbc-psr-cursor-plane-move)
[234.225749] Starting subtest: fbc-psr-cursor-plane-move
[234.226714] Starting dynamic subtest: eDP-1
[234.228664] Dynamic subtest eDP-1: SKIP (0.000s)
[234.230318] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[234.298800] [079/155] (802s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[234.391474] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[234.393194] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[234.499935] [080/155] (802s left) gem_exec_reloc (basic-write-read)
[234.550700] Subtest basic-write-read: SKIP (0.000s)
[234.629439] [081/155] (802s left) gem_softpin (evict-prime-sanity-check)
[234.672737] Starting subtest: evict-prime-sanity-check
[234.673882] Starting dynamic subtest: rcs0
[235.838058] Dynamic subtest rcs0: SUCCESS (1.165s)
[235.851720] Starting dynamic subtest: bcs0
[236.958023] Dynamic subtest bcs0: SUCCESS (1.118s)
[236.969406] Starting dynamic subtest: vcs0
[238.844805] Dynamic subtest vcs0: SUCCESS (1.877s)
[238.857111] Starting dynamic subtest: vcs1
[240.823976] Dynamic subtest vcs1: SUCCESS (1.978s)
[240.834120] Starting dynamic subtest: vecs0
[242.786439] Dynamic subtest vecs0: SUCCESS (1.961s)
[242.796335] Starting dynamic subtest: ccs0
[243.915987] Dynamic subtest ccs0: SUCCESS (1.136s)
[243.928869] Starting dynamic subtest: all
[245.032330] Dynamic subtest all: SUCCESS (1.115s)
[245.036616] Subtest evict-prime-sanity-check: SUCCESS (10.366s)
[245.112916] [082/155] (792s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[245.365252] Starting subtest: cursor-rapid-movement-256x85
[245.410478] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[245.594151] [083/155] (791s left) gem_exec_params (batch-first)
[245.645564] Starting subtest: batch-first
[245.651810] Subtest batch-first: SUCCESS (0.006s)
[245.767261] [084/155] (791s left) gem_exec_fence (basic-busy-all)
[245.819788] Starting subtest: basic-busy-all
[245.923178] Subtest basic-busy-all: SUCCESS (0.104s)
[247.929873] [085/155] (789s left) perf_pmu (semaphore-wait-idle)
[247.965889] Starting subtest: semaphore-wait-idle
[247.966759] Starting dynamic subtest: rcs0
[248.494183] Dynamic subtest rcs0: SUCCESS (0.519s)
[248.504070] Starting dynamic subtest: bcs0
[249.011908] Dynamic subtest bcs0: SUCCESS (0.515s)
[249.022015] Starting dynamic subtest: vcs0
[249.526079] Dynamic subtest vcs0: SUCCESS (0.512s)
[249.537593] Starting dynamic subtest: vcs1
[250.040553] Dynamic subtest vcs1: SUCCESS (0.512s)
[250.050292] Starting dynamic subtest: vecs0
[250.555807] Dynamic subtest vecs0: SUCCESS (0.512s)
[250.567143] Starting dynamic subtest: ccs0
[251.071660] Dynamic subtest ccs0: SUCCESS (0.513s)
[251.072785] Subtest semaphore-wait-idle: SUCCESS (3.100s)
[251.188848] [086/155] (786s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[251.291800] Starting subtest: psr-farfromfence-mmap-gtt
[251.293688] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[251.401465] [087/155] (785s left) i915_pm_rps (fence-order)
[251.463066] Starting subtest: fence-order
[254.960577] Subtest fence-order: SUCCESS (3.493s)
[255.074386] [088/155] (782s left) gem_ctx_persistence (legacy-engines-hostile)
[255.123768] Starting subtest: legacy-engines-hostile
[255.124674] Starting dynamic subtest: render
[255.262116] Dynamic subtest render: SUCCESS (0.137s)
[255.274241] Starting dynamic subtest: bsd1
[255.361827] Dynamic subtest bsd1: SUCCESS (0.097s)
[255.375760] Starting dynamic subtest: bsd2
[255.458217] Dynamic subtest bsd2: SUCCESS (0.094s)
[255.471916] Starting dynamic subtest: blt
[255.556024] Dynamic subtest blt: SUCCESS (0.096s)
[255.569552] Starting dynamic subtest: vebox
[255.648096] Dynamic subtest vebox: SUCCESS (0.090s)
[255.649680] Subtest legacy-engines-hostile: SUCCESS (0.528s)
[255.722896] [089/155] (781s left) gen7_exec_parse (basic-rejected)
[255.780073] Subtest basic-rejected: SKIP (0.000s)
[255.847517] [090/155] (781s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[255.943397] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[255.945356] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[256.063363] [091/155] (781s left) kms_dp_link_training (non-uhbr-sst)
[256.141859] Starting subtest: non-uhbr-sst
[256.145268] Subtest non-uhbr-sst: SKIP (0.000s)
[256.209191] [092/155] (781s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[256.255219] Subtest no-spare-fences-busy: SKIP (0.000s)
[256.322767] [093/155] (781s left) kms_cursor_crc (cursor-sliding-64x64)
[256.496347] Starting subtest: cursor-sliding-64x64
[256.498769] Starting dynamic subtest: pipe-A-eDP-1
[259.704804] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.231s)
[259.734380] Starting dynamic subtest: pipe-D-eDP-1
[263.629350] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.924s)
[263.630246] Subtest cursor-sliding-64x64: SUCCESS (7.182s)
[264.493207] [094/155] (773s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[264.579708] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[264.581499] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[264.651018] [095/155] (773s left) kms_rotation_crc (primary-rotation-90)
[264.736953] Starting subtest: primary-rotation-90
[264.738611] Subtest primary-rotation-90: SKIP (0.001s)
[264.818132] [096/155] (772s left) gem_flink_basic (bad-open)
[264.875621] Starting subtest: bad-open
[264.876539] Subtest bad-open: SUCCESS (0.000s)
[264.964272] [097/155] (772s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[265.064048] Starting subtest: fbcpsrhdr-modesetfrombusy
[265.065842] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[265.157981] [098/155] (772s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[265.245218] Starting subtest: fbcpsr-tiling-4
[272.409466] Subtest fbcpsr-tiling-4: SUCCESS (7.183s)
[272.531410] [099/155] (765s left) gem_fenced_exec_thrash (2-spare-fences)
[272.577116] Subtest 2-spare-fences: SKIP (0.000s)
[272.654566] [100/155] (765s left) syncobj_wait (wait-delayed-signal)
[272.709866] Starting subtest: wait-delayed-signal
[272.813710] Subtest wait-delayed-signal: SUCCESS (0.103s)
[272.885567] [101/155] (764s left) perf_pmu (busy)
[272.918251] Starting subtest: busy
[272.919255] Starting dynamic subtest: rcs0
[273.506589] Dynamic subtest rcs0: SUCCESS (0.588s)
[273.520290] Starting dynamic subtest: bcs0
[274.080062] Dynamic subtest bcs0: SUCCESS (0.572s)
[274.094280] Starting dynamic subtest: vcs0
[275.836740] Dynamic subtest vcs0: SUCCESS (1.747s)
[275.849541] Starting dynamic subtest: vcs1
[277.820884] Dynamic subtest vcs1: SUCCESS (1.984s)
[277.832924] Starting dynamic subtest: vecs0
[279.804041] Dynamic subtest vecs0: SUCCESS (1.983s)
[279.816024] Starting dynamic subtest: ccs0
[280.363202] Dynamic subtest ccs0: SUCCESS (0.566s)
[280.366518] Subtest busy: SUCCESS (7.455s)
[280.481426] [102/155] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[280.587089] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[280.588858] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[280.684254] [103/155] (757s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[280.791849] Starting subtest: y-tiled-8bpp-rotate-0
[280.793669] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[280.887781] [104/155] (757s left) api_intel_bb (bb-with-allocator)
[280.940909] Starting subtest: bb-with-allocator
[280.949496] Subtest bb-with-allocator: SUCCESS (0.009s)
[281.037703] [105/155] (756s left) kms_color (ctm-0-50)
[281.123558] Starting subtest: ctm-0-50
[281.124373] Starting dynamic subtest: pipe-A-eDP-1
[284.719810] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.599s)
[284.731347] Starting dynamic subtest: pipe-B-eDP-1
[289.015270] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.295s)
[289.029227] Starting dynamic subtest: pipe-C-eDP-1
[293.090887] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.074s)
[293.100549] Starting dynamic subtest: pipe-D-eDP-1
[297.090172] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.997s)
[297.091184] Subtest ctm-0-50: SUCCESS (15.968s)
[297.906206] [106/155] (740s left) i915_suspend (basic-s3-without-i915)
[297.936327] Starting subtest: basic-s3-without-i915
[301.278291] Subtest basic-s3-without-i915: SKIP (3.331s)
[302.902848] [107/155] (735s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[303.011062] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[303.012741] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[303.111467] [108/155] (735s left) gem_mmap_gtt (cpuset-big-copy-odd)
[303.165265] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[303.228880] [109/155] (734s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[303.319785] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[303.321536] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[303.412773] [110/155] (734s left) kms_pwrite_crc (basic)
[303.503521] Starting subtest: basic
[304.227985] Subtest basic: SUCCESS (0.725s)
[305.115035] [111/155] (733s left) kms_hdr (static-swap)
[305.209653] Starting subtest: static-swap
[305.210484] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[305.212073] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[305.220672] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[305.222374] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[305.223890] Subtest static-swap: SKIP (0.003s)
[305.281688] [112/155] (732s left) gem_userptr_blits (process-exit-busy)
[305.353627] Starting subtest: process-exit-busy
[305.368498] Subtest process-exit-busy: SUCCESS (0.016s)
[305.492687] [113/155] (732s left) kms_psr (psr2-primary-page-flip)
[305.587480] Starting subtest: psr2-primary-page-flip
[305.588433] Starting dynamic subtest: eDP-1
[307.321265] Dynamic subtest eDP-1: SUCCESS (1.734s)
[307.322232] Subtest psr2-primary-page-flip: SUCCESS (1.735s)
[308.191448] [114/155] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[308.286386] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[308.288009] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[308.374708] [115/155] (729s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[308.499971] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[340.680077] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.189s)
[341.518525] [116/155] (696s left) kms_plane_lowres (tiling-4)
[341.609621] Starting subtest: tiling-4
[341.610530] Starting dynamic subtest: pipe-A-eDP-1
[341.612122] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[341.919769] Starting dynamic subtest: pipe-B-eDP-1
[341.921612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[341.929849] Starting dynamic subtest: pipe-C-eDP-1
[341.931861] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[341.940359] Starting dynamic subtest: pipe-D-eDP-1
[341.942069] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[341.943659] Subtest tiling-4: SKIP (0.309s)
[342.751785] [117/155] (695s left) gem_madvise (dontneed-before-mmap)
[342.779489] Starting subtest: dontneed-before-mmap
[342.795912] Subtest dontneed-before-mmap: SUCCESS (0.016s)
[342.884712] [118/155] (695s left) kms_flip (flip-vs-rmfb-interruptible)
[342.969367] Starting subtest: flip-vs-rmfb-interruptible
[342.970717] Starting dynamic subtest: A-eDP1
[351.643227] Dynamic subtest A-eDP1: SUCCESS (8.675s)
[351.656045] Starting dynamic subtest: B-eDP1
[360.276627] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[360.290894] Starting dynamic subtest: C-eDP1
[368.894038] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[368.906905] Starting dynamic subtest: D-eDP1
[377.527500] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[377.530568] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.554s)
[378.709787] [119/155] (659s left) dumb_buffer (map-invalid-size)
[378.755145] Starting subtest: map-invalid-size
[378.756242] Subtest map-invalid-size: SUCCESS (0.000s)
[378.848899] [120/155] (659s left) gem_exec_reloc (basic-gtt-read-active)
[378.898002] Subtest basic-gtt-read-active: SKIP (0.000s)
[378.978456] [121/155] (659s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[379.067924] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[379.069681] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[379.158569] [122/155] (659s left) gem_wait (write-busy)
[379.214968] Starting subtest: write-busy
[379.215989] Starting dynamic subtest: all-engines
[379.832199] Dynamic subtest all-engines: SUCCESS (0.616s)
[379.851019] Starting dynamic subtest: rcs0
[380.382353] Dynamic subtest rcs0: SUCCESS (0.548s)
[380.400665] Starting dynamic subtest: bcs0
[380.932024] Dynamic subtest bcs0: SUCCESS (0.548s)
[380.948988] Starting dynamic subtest: vcs0
[382.849562] Dynamic subtest vcs0: SUCCESS (1.902s)
[382.859100] Starting dynamic subtest: vcs1
[384.832395] Dynamic subtest vcs1: SUCCESS (1.981s)
[384.841351] Starting dynamic subtest: vecs0
[386.816806] Dynamic subtest vecs0: SUCCESS (1.981s)
[386.826680] Starting dynamic subtest: ccs0
[387.354444] Dynamic subtest ccs0: SUCCESS (0.548s)
[387.355778] Subtest write-busy: SUCCESS (8.139s)
[387.549259] [123/155] (651s left) gem_readwrite (new-obj)
[387.604287] Subtest new-obj: SKIP (0.000s)
[387.669543] [124/155] (651s left) kms_draw_crc (draw-method-mmap-gtt)
[387.767036] Starting subtest: draw-method-mmap-gtt
[387.768831] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[387.855293] [125/155] (650s left) gem_exec_capture (pi)
[387.902677] Starting subtest: pi
[387.903614] Starting dynamic subtest: rcs0
[392.537037] Dynamic subtest rcs0: SUCCESS (4.633s)
[392.547523] Starting dynamic subtest: bcs0
[396.819995] Dynamic subtest bcs0: SUCCESS (4.283s)
[396.831567] Starting dynamic subtest: vcs0
[401.070952] Dynamic subtest vcs0: SUCCESS (4.251s)
[401.085207] Starting dynamic subtest: vcs1
[405.370713] Dynamic subtest vcs1: SUCCESS (4.299s)
[405.383907] Starting dynamic subtest: vecs0
[409.671541] Dynamic subtest vecs0: SUCCESS (4.300s)
[409.682365] Starting dynamic subtest: ccs0
[413.955605] Dynamic subtest ccs0: SUCCESS (4.284s)
[413.956748] Subtest pi: SUCCESS (26.056s)
[414.039530] [126/155] (624s left) i915_drm_fdinfo (virtual-busy-idle)
[414.126700] Starting subtest: virtual-busy-idle
[414.128702] Subtest virtual-busy-idle: SKIP (0.000s)
[414.201380] [127/155] (624s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[414.300689] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[414.302424] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[414.396647] [128/155] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[414.486177] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[414.487951] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[414.597148] [129/155] (624s left) kms_content_protection (lic-type-1)
[414.744661] Starting subtest: lic-type-1
[414.746607] Subtest lic-type-1: SKIP (0.000s)
[414.864648] [130/155] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[414.955218] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[421.524180] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.579s)
[421.646548] [131/155] (617s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[421.743404] Starting subtest: psr-rgb565-draw-blt
[428.926846] Subtest psr-rgb565-draw-blt: SUCCESS (7.186s)
[429.075742] [132/155] (609s left) gem_pxp (hw-rejects-pxp-buffer)
[429.194715] Starting subtest: hw-rejects-pxp-buffer
[429.197123] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[429.310903] [133/155] (609s left) kms_big_fb (yf-tiled-addfb)
[429.404125] Starting subtest: yf-tiled-addfb
[429.406081] Subtest yf-tiled-addfb: SKIP (0.000s)
[429.496833] [134/155] (609s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[429.589471] Starting subtest: fbchdr-rgb101010-draw-render
[429.591123] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[429.685746] [135/155] (609s left) kms_plane (pixel-format-x-tiled-modifier)
[429.771998] Starting subtest: pixel-format-x-tiled-modifier
[429.798606] Starting dynamic subtest: pipe-A-plane-0
[430.198215] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[430.210407] Starting dynamic subtest: pipe-A-plane-3
[430.509255] Dynamic subtest pipe-A-plane-3: SUCCESS (0.310s)
[430.519372] Starting dynamic subtest: pipe-A-plane-5
[430.522104] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[431.590808] Starting dynamic subtest: pipe-B-plane-0
[431.981059] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[431.991030] Starting dynamic subtest: pipe-B-plane-3
[432.292051] Dynamic subtest pipe-B-plane-3: SUCCESS (0.310s)
[432.302036] Starting dynamic subtest: pipe-B-plane-5
[432.303915] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[432.610395] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.839s)
[433.471159] [136/155] (605s left) kms_pm_dc (dc5-dpms-negative)
[434.593015] Starting subtest: dc5-dpms-negative
[434.595102] Subtest dc5-dpms-negative: SKIP (0.000s)
[434.667771] [137/155] (604s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[434.754682] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[434.755768] Starting dynamic subtest: pipe-A-default-mode
[437.502711] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[437.503920] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.748s)
[438.344636] [138/155] (600s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[438.435853] Starting subtest: fbc-pr-sprite-mmap-cpu
[438.437723] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[438.518937] [139/155] (600s left) kms_cursor_crc (cursor-random-128x128)
[438.723559] Starting subtest: cursor-random-128x128
[438.735176] Starting dynamic subtest: pipe-A-eDP-1
[442.090905] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.364s)
[442.123421] Starting dynamic subtest: pipe-D-eDP-1
[446.156336] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.044s)
[446.157253] Subtest cursor-random-128x128: SUCCESS (7.434s)
[447.041057] [140/155] (592s left) kms_sequence (get-busy)
[447.144791] Starting subtest: get-busy
[447.145702] Starting dynamic subtest: pipe-A-eDP-1
[449.078208] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[449.089105] Starting dynamic subtest: pipe-B-eDP-1
[451.722608] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s)
[451.736224] Starting dynamic subtest: pipe-C-eDP-1
[454.320143] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.596s)
[454.331730] Starting dynamic subtest: pipe-D-eDP-1
[456.971389] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.651s)
[456.972154] Subtest get-busy: SUCCESS (9.830s)
[457.847357] [141/155] (581s left) gem_exec_schedule (preemptive-hang)
[458.035604] Starting subtest: preemptive-hang
[458.036824] Starting dynamic subtest: rcs0
[466.978998] Dynamic subtest rcs0: SUCCESS (8.949s)
[466.990178] Starting dynamic subtest: bcs0
[475.934623] Dynamic subtest bcs0: SUCCESS (8.956s)
[475.951853] Starting dynamic subtest: vcs0
[484.954823] Dynamic subtest vcs0: SUCCESS (9.017s)
[484.966885] Starting dynamic subtest: vcs1
[493.916348] Dynamic subtest vcs1: SUCCESS (8.957s)
[493.928948] Starting dynamic subtest: vecs0
[502.939154] Dynamic subtest vecs0: SUCCESS (9.018s)
[502.950245] Starting dynamic subtest: ccs0
[511.965526] Dynamic subtest ccs0: SUCCESS (9.022s)
[511.966682] Subtest preemptive-hang: SUCCESS (53.929s)
[512.196199] [142/155] (527s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[512.294184] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[512.670434] Starting dynamic subtest: pipe-A-eDP-1
[515.438291] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.757s)
[515.807117] Starting dynamic subtest: pipe-B-eDP-1
[518.574470] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[518.941557] Starting dynamic subtest: pipe-C-eDP-1
[521.717272] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[522.062951] Starting dynamic subtest: pipe-D-eDP-1
[524.840056] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[524.841261] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.536s)
[526.017461] [143/155] (513s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[526.117770] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[526.119442] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[526.209102] [144/155] (513s left) api_intel_bb (destroy-bb)
[526.263202] Starting subtest: destroy-bb
[526.269909] Subtest destroy-bb: SUCCESS (0.008s)
[526.366190] [145/155] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[526.451844] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[533.463534] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.004s)
[533.591760] [146/155] (505s left) gem_exec_schedule (u-lateslice)
[533.657751] Starting subtest: u-lateslice
[533.658642] Starting dynamic subtest: rcs0
[533.679981] Dynamic subtest rcs0: SUCCESS (0.022s)
[533.690101] Starting dynamic subtest: bcs0
[533.698395] Dynamic subtest bcs0: SUCCESS (0.018s)
[533.708261] Starting dynamic subtest: vcs0
[533.716555] Dynamic subtest vcs0: SUCCESS (0.017s)
[533.725903] Starting dynamic subtest: vcs1
[533.734346] Dynamic subtest vcs1: SUCCESS (0.017s)
[533.743662] Starting dynamic subtest: vecs0
[533.751879] Dynamic subtest vecs0: SUCCESS (0.017s)
[533.762228] Starting dynamic subtest: ccs0
[533.768091] Dynamic subtest ccs0: SUCCESS (0.015s)
[533.768993] Subtest u-lateslice: SUCCESS (0.111s)
[534.904581] [147/155] (504s left) kms_atomic (plane-invalid-params-fence)
[535.010781] Starting subtest: plane-invalid-params-fence
[535.011743] Starting dynamic subtest: pipe-A-eDP-1
[535.367979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[535.368918] Subtest plane-invalid-params-fence: SUCCESS (0.357s)
[536.188331] [148/155] (503s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[536.285846] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[536.287499] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[536.378713] [149/155] (503s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[536.436084] Starting subtest: multi-wait-available-submitted-signaled
[536.437056] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[536.526334] [150/155] (503s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[536.613768] Starting subtest: primary-yf-tiled-reflect-x-90
[536.615684] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[536.695954] [151/155] (503s left) gem_exec_reloc (basic-wc-gtt)
[536.746549] Subtest basic-wc-gtt: SKIP (0.000s)
[536.818473] [152/155] (502s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[536.908123] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[536.909958] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[536.998829] [153/155] (502s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[537.081911] Starting subtest: fbc-psr2-sprite-mmap-gtt
[537.082867] Starting dynamic subtest: eDP-1
[537.084669] Dynamic subtest eDP-1: SKIP (0.000s)
[537.086414] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[537.152574] [154/155] (502s left) prime_vgem (basic-gtt)
[537.235680] Starting subtest: basic-gtt
[537.237366] Subtest basic-gtt: SKIP (0.000s)
[537.342176] [155/155] (502s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[537.437072] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[537.438735] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[537.534153] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: gem_ctx_isolation
results: parsing output: 4/ for test: gem_fence_thrash
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_chamelium_frames
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_shared
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_getfb
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: syncobj_eventfd
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gem_flink_basic
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_getfb
results: parsing output: 30/ for test: core_setmaster_vs_auth
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_vrr
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: vgem_basic
results: parsing output: 38/ for test: kms_joiner
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_properties
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_pm_backlight
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: gem_ctx_engines
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_exec_flush
results: parsing output: 63/ for test: kms_cdclk
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: gem_exec_suspend
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_pm_rps
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: gen7_exec_parse
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_dp_link_training
results: parsing output: 91/ for test: gem_fenced_exec_thrash
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: gem_flink_basic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_fenced_exec_thrash
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_color
results: parsing output: 105/ for test: i915_suspend
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_pwrite_crc
results: parsing output: 110/ for test: kms_hdr
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: gem_madvise
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: dumb_buffer
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: gem_readwrite
results: parsing output: 123/ for test: kms_draw_crc
results: parsing output: 124/ for test: gem_exec_capture
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_plane
results: parsing output: 135/ for test: kms_pm_dc
results: parsing output: 136/ for test: kms_flip_scaled_crc
results: parsing output: 137/ for test: kms_psr
results: parsing output: 138/ for test: kms_cursor_crc
results: parsing output: 139/ for test: kms_sequence
results: parsing output: 140/ for test: gem_exec_schedule
results: parsing output: 141/ for test: kms_async_flips
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: api_intel_bb
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_schedule
results: parsing output: 146/ for test: kms_atomic
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: syncobj_timeline
results: parsing output: 149/ for test: kms_rotation_crc
results: parsing output: 150/ for test: gem_exec_reloc
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_psr
results: parsing output: 153/ for test: prime_vgem
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.