[56.395006] Initializing watchdogs
[56.395050]   /dev/watchdog0
[56.408815] [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]
[56.412940] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.415261] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.418640] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[56.554948] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[63.324663] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.871s)
[63.452199] [002/133] (953s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[63.551292] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[63.555591] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[63.638879] [003/133] (953s left) gem_eio (banned)
[63.772895] Starting subtest: banned
[64.116421] Subtest banned: SUCCESS (0.345s)
[64.267206] [004/133] (952s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[64.662499] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[65.493764] [005/133] (951s left) drm_read (empty-nonblock)
[65.657884] Starting subtest: empty-nonblock
[65.660444] Subtest empty-nonblock: SUCCESS (0.000s)
[65.780339] [006/133] (951s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[65.867641] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[65.893316] Starting dynamic subtest: pipe-A-plane-0
[66.544394] Dynamic subtest pipe-A-plane-0: SUCCESS (0.656s)
[66.553280] Starting dynamic subtest: pipe-A-plane-3
[66.975382] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[68.082259] Starting dynamic subtest: pipe-B-plane-0
[68.716563] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[68.725929] Starting dynamic subtest: pipe-B-plane-3
[69.158822] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[69.467204] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.617s)
[70.375912] [007/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[70.496391] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[70.500812] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[70.592902] [008/133] (946s left) gem_eio (in-flight-internal-10ms)
[70.782796] Starting subtest: in-flight-internal-10ms
[72.364063] Subtest in-flight-internal-10ms: SUCCESS (1.585s)
[73.007940] [009/133] (944s left) kms_pm_rpm (package-g7)
[74.547222] Starting subtest: package-g7
[74.552547] Subtest package-g7: SKIP (0.000s)
[75.274303] [010/133] (942s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[75.374115] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[76.063455] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[76.224329] [011/133] (941s left) sw_sync (sync_multi_producer_single_consumer)
[76.261685] Starting subtest: sync_multi_producer_single_consumer
[77.334933] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[77.394711] [012/133] (940s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[77.450383] Starting subtest: y-tiled-ccs-to-x-tiled
[77.454925] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[77.625228] [013/133] (939s left) gem_wait (invalid-buf)
[77.680115] Starting subtest: invalid-buf
[77.682477] Subtest invalid-buf: SUCCESS (0.000s)
[77.899441] [014/133] (939s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[77.951923] Subtest tiled-to-untiled: SKIP (0.000s)
[78.025596] [015/133] (939s left) kms_draw_crc (draw-method-render)
[78.124136] Starting subtest: draw-method-render
[78.126367] Starting dynamic subtest: xrgb8888-untiled
[78.387160] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[78.395122] Starting dynamic subtest: rgb565-untiled
[78.620753] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[78.630116] Starting dynamic subtest: xrgb2101010-untiled
[78.842195] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[78.851135] Starting dynamic subtest: xbgr16161616f-untiled
[79.064061] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[79.073749] Starting dynamic subtest: xrgb8888-xtiled
[79.186508] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[79.196325] Starting dynamic subtest: rgb565-xtiled
[79.297161] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[79.306067] Starting dynamic subtest: xrgb2101010-xtiled
[79.408499] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[79.417167] Starting dynamic subtest: xbgr16161616f-xtiled
[79.541501] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[79.549736] Starting dynamic subtest: xrgb8888-4tiled
[79.663612] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[79.673787] Starting dynamic subtest: rgb565-4tiled
[79.786311] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[79.795107] Starting dynamic subtest: xrgb2101010-4tiled
[79.896812] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[79.906489] Starting dynamic subtest: xbgr16161616f-4tiled
[80.019073] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[80.020930] Subtest draw-method-render: SUCCESS (1.900s)
[80.131746] [016/133] (937s left) perf (non-system-wide-paranoid)
[80.271963] Starting subtest: non-system-wide-paranoid
[80.296987] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[80.345186] [017/133] (937s left) kms_dp_linktrain_fallback (dp-fallback)
[80.439287] Starting subtest: dp-fallback
[80.445369] Subtest dp-fallback: SKIP (0.000s)
[80.509248] [018/133] (937s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[80.608159] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[80.610040] Starting dynamic subtest: pipe-A-eDP-1
[81.415305] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[81.422813] Starting dynamic subtest: pipe-B-eDP-1
[83.101203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.684s)
[83.109768] Starting dynamic subtest: pipe-C-eDP-1
[84.618258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.516s)
[84.626981] Starting dynamic subtest: pipe-D-eDP-1
[86.109908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.489s)
[86.112080] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.495s)
[87.296692] [019/133] (930s left) gem_exec_schedule (pi-userfault)
[87.478734] Starting subtest: pi-userfault
[87.481273] Starting dynamic subtest: rcs0
[87.486998] Dynamic subtest rcs0: SUCCESS (0.011s)
[87.498730] Starting dynamic subtest: bcs0
[87.501085] Dynamic subtest bcs0: SUCCESS (0.008s)
[87.510157] Starting dynamic subtest: vcs0
[87.512695] Dynamic subtest vcs0: SUCCESS (0.008s)
[87.521075] Starting dynamic subtest: vcs1
[87.523068] Dynamic subtest vcs1: SUCCESS (0.009s)
[87.531534] Starting dynamic subtest: vecs0
[87.533866] Dynamic subtest vecs0: SUCCESS (0.007s)
[87.542140] Starting dynamic subtest: ccs0
[87.544472] Dynamic subtest ccs0: SUCCESS (0.008s)
[87.546791] Subtest pi-userfault: SUCCESS (0.054s)
[87.715032] [020/133] (930s left) i915_drm_fdinfo (basics)
[87.766234] Starting subtest: basics
[87.768513] Subtest basics: SUCCESS (0.000s)
[87.835084] [021/133] (929s left) kms_chamelium_hpd (hdmi-hpd-storm)
[88.224771] Subtest hdmi-hpd-storm: SKIP (0.000s)
[89.011106] [022/133] (928s left) perf (invalid-open-flags)
[89.088686] Starting subtest: invalid-open-flags
[89.091062] Subtest invalid-open-flags: SUCCESS (0.000s)
[89.131923] [023/133] (928s left) sw_sync (alloc_merge_fence)
[89.164861] Starting subtest: alloc_merge_fence
[89.167108] Subtest alloc_merge_fence: SUCCESS (0.000s)
[89.233274] [024/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[89.338527] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[89.342849] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[89.434336] [025/133] (928s left) gem_exec_params (no-bsd)
[89.503553] Starting subtest: no-bsd
[89.505807] Subtest no-bsd: SUCCESS (0.002s)
[91.329944] [026/133] (926s left) kms_chamelium_color (ctm-limited-range)
[91.422384] Subtest ctm-limited-range: SKIP (0.000s)
[91.463280] [027/133] (926s left) kms_plane (plane-panning-bottom-right)
[91.549832] Starting subtest: plane-panning-bottom-right
[91.551731] Starting dynamic subtest: pipe-A
[93.200747] Dynamic subtest pipe-A: SUCCESS (1.648s)
[93.214429] Starting dynamic subtest: pipe-B
[95.495343] Dynamic subtest pipe-B: SUCCESS (2.294s)
[95.497577] Subtest plane-panning-bottom-right: SUCCESS (3.945s)
[96.365179] [028/133] (921s left) perf (global-sseu-config-invalid)
[96.465466] Starting subtest: global-sseu-config-invalid
[96.470120] Subtest global-sseu-config-invalid: SKIP (0.000s)
[96.510301] [029/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[96.611096] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[100.973017] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.365s)
[102.182353] [030/133] (915s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[102.238058] Starting subtest: yf-tiled-to-vebox-yf-tiled
[102.242556] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[102.414030] [031/133] (915s left) gem_exec_balancer (bonded-chain)
[102.485291] Starting subtest: bonded-chain
[109.456480] Subtest bonded-chain: SUCCESS (6.972s)
[110.316237] [032/133] (907s left) kms_color (ctm-blue-to-red)
[110.422167] Starting subtest: ctm-blue-to-red
[110.424340] Starting dynamic subtest: pipe-A-eDP-1
[111.104261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[111.117683] Starting dynamic subtest: pipe-B-eDP-1
[112.486203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[112.495281] Starting dynamic subtest: pipe-C-eDP-1
[113.803563] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.315s)
[113.812491] Starting dynamic subtest: pipe-D-eDP-1
[115.154040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[115.156337] Subtest ctm-blue-to-red: SUCCESS (4.731s)
[115.986698] [033/133] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[116.097590] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[123.148911] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.055s)
[123.236546] [034/133] (895s left) kms_3d (basic)
[123.287761] Starting subtest: basic
[125.260275] Subtest basic: SUCCESS (1.973s)
[125.716628] [035/133] (892s left) kms_psr (fbc-psr-cursor-plane-move)
[125.806146] Starting subtest: fbc-psr-cursor-plane-move
[125.808495] Starting dynamic subtest: eDP-1
[125.813035] Dynamic subtest eDP-1: SKIP (0.000s)
[125.817513] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[125.878768] [036/133] (892s left) gem_eio (create-ext)
[126.092178] Starting subtest: create-ext
[126.399379] Subtest create-ext: SUCCESS (0.306s)
[126.529942] [037/133] (891s left) i915_power (sanity)
[126.594207] Starting subtest: sanity
[130.643664] Subtest sanity: SUCCESS (4.042s)
[132.363835] [038/133] (886s left) gem_linear_blits (normal)
[132.718555] Starting subtest: normal
[137.746465] Subtest normal: SUCCESS (5.029s)
[137.927987] [039/133] (880s left) syncobj_timeline (wait-all-complex)
[138.019075] Starting subtest: wait-all-complex
[138.258248] Subtest wait-all-complex: SUCCESS (0.214s)
[138.309501] [040/133] (880s left) kms_busy (extended-pageflip-hang-newfb)
[138.438693] Starting subtest: extended-pageflip-hang-newfb
[138.441081] Starting dynamic subtest: pipe-A
[165.091073] Dynamic subtest pipe-A: SUCCESS (26.647s)
[165.102195] Starting dynamic subtest: pipe-D
[191.072818] Dynamic subtest pipe-D: SUCCESS (25.980s)
[191.075281] Subtest extended-pageflip-hang-newfb: SUCCESS (52.632s)
[191.943975] [041/133] (826s left) prime_vgem (basic-fence-flip)
[192.111942] Starting subtest: basic-fence-flip
[192.397196] Subtest basic-fence-flip: SUCCESS (0.286s)
[192.517548] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[192.521575] [042/133] (826s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[192.621855] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[192.626100] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[192.701103] [043/133] (825s left) kms_vblank (wait-busy-hang)
[192.793038] Starting subtest: wait-busy-hang
[192.794932] Starting dynamic subtest: pipe-A-eDP-1
[219.087575] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.294s)
[219.102029] Starting dynamic subtest: pipe-D-eDP-1
[244.043785] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.949s)
[244.045754] Subtest wait-busy-hang: SUCCESS (51.250s)
[244.831901] [044/133] (773s left) gem_ctx_param (invalid-param-get)
[244.904691] Starting subtest: invalid-param-get
[244.906700] Subtest invalid-param-get: SUCCESS (0.001s)
[244.995491] [045/133] (773s left) perf (polling-parameterized)
[245.121509] Starting subtest: polling-parameterized
[265.142638] Subtest polling-parameterized: SUCCESS (20.018s)
[265.193131] [046/133] (753s left) gem_ctx_param (invalid-get-ringsize)
[265.257980] Starting subtest: invalid-get-ringsize
[265.260439] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[265.353487] [047/133] (753s left) kms_cursor_crc (cursor-onscreen-128x42)
[265.590775] Starting subtest: cursor-onscreen-128x42
[265.641733] Subtest cursor-onscreen-128x42: SKIP (0.047s)
[265.850364] [048/133] (752s left) i915_pm_rc6_residency (media-rc6-accuracy)
[265.899494] Starting subtest: media-rc6-accuracy
[265.903619] Subtest media-rc6-accuracy: SKIP (0.000s)
[265.988954] [049/133] (752s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[266.100297] Starting subtest: fbc-1p-pri-indfb-multidraw
[278.919626] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.822s)
[280.265670] [050/133] (738s left) perf_pmu (rc6)
[280.308582] Starting subtest: rc6
[280.310958] Starting dynamic subtest: gt0
[286.677824] Dynamic subtest gt0: SUCCESS (6.367s)
[286.690047] Starting dynamic subtest: runtime-pm-gt0
[294.452125] Dynamic subtest runtime-pm-gt0: SUCCESS (7.772s)
[294.464312] Starting dynamic subtest: runtime-pm-long-gt0
[306.958059] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.503s)
[306.968649] Starting dynamic subtest: other-idle-gt0
[313.302059] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[313.314627] Starting dynamic subtest: gt1
[319.644351] Dynamic subtest gt1: SUCCESS (6.340s)
[319.664780] Starting dynamic subtest: runtime-pm-gt1
[327.108550] Dynamic subtest runtime-pm-gt1: SUCCESS (7.461s)
[327.121052] Starting dynamic subtest: runtime-pm-long-gt1
[339.544418] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.433s)
[339.555683] Starting dynamic subtest: other-idle-gt1
[345.888068] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[345.891061] Subtest rc6: SUCCESS (65.577s)
[347.032135] [051/133] (671s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[347.099817] Starting subtest: wait-all-for-submit-delayed-submit
[347.202534] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[347.258270] [052/133] (671s left) kms_flip (flip-vs-rmfb)
[347.359409] Starting subtest: flip-vs-rmfb
[347.361632] Starting dynamic subtest: A-eDP1
[355.996263] Dynamic subtest A-eDP1: SUCCESS (8.639s)
[356.009074] Starting dynamic subtest: B-eDP1
[364.692227] Dynamic subtest B-eDP1: SUCCESS (8.693s)
[364.704609] Starting dynamic subtest: C-eDP1
[373.372524] Dynamic subtest C-eDP1: SUCCESS (8.677s)
[373.384783] Starting dynamic subtest: D-eDP1
[381.972060] Dynamic subtest D-eDP1: SUCCESS (8.596s)
[381.976369] Subtest flip-vs-rmfb: SUCCESS (34.619s)
[383.114358] [053/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[383.220878] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[383.225452] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[383.294262] [054/133] (635s left) kms_big_fb (linear-32bpp-rotate-90)
[383.398186] Starting subtest: linear-32bpp-rotate-90
[383.420078] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[383.500538] [055/133] (635s left) gem_exec_balancer (parallel-keep-submit-fence)
[383.755850] Starting subtest: parallel-keep-submit-fence
[384.952388] Subtest parallel-keep-submit-fence: SUCCESS (1.196s)
[385.037565] [056/133] (634s left) gen9_exec_parse (basic-rejected)
[385.111645] Subtest basic-rejected: SKIP (0.000s)
[385.180390] [057/133] (634s left) gem_lmem_swapping (verify-random-ccs)
[385.229410] Subtest verify-random-ccs: SKIP (0.000s)
[385.276322] [058/133] (633s left) kms_psr2_su (frontbuffer-xrgb8888)
[385.339482] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[385.403420] [059/133] (633s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[385.493256] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[385.495557] Starting dynamic subtest: pipe-A-eDP-1
[385.518407] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.530553] Starting dynamic subtest: pipe-B-eDP-1
[385.552046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[385.560860] Starting dynamic subtest: pipe-C-eDP-1
[385.582096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[385.590957] Starting dynamic subtest: pipe-D-eDP-1
[385.614230] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.618581] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[387.709361] [060/133] (631s left) gem_exec_store (dword)
[387.767706] Starting subtest: dword
[387.769633] Starting dynamic subtest: rcs0
[387.823482] Dynamic subtest rcs0: SUCCESS (0.057s)
[387.836661] Starting dynamic subtest: bcs0
[387.865761] Dynamic subtest bcs0: SUCCESS (0.040s)
[387.875949] Starting dynamic subtest: vcs0
[387.907421] Dynamic subtest vcs0: SUCCESS (0.040s)
[387.918300] Starting dynamic subtest: vcs1
[387.949528] Dynamic subtest vcs1: SUCCESS (0.040s)
[387.960106] Starting dynamic subtest: vecs0
[387.991756] Dynamic subtest vecs0: SUCCESS (0.040s)
[388.002410] Starting dynamic subtest: ccs0
[388.033719] Dynamic subtest ccs0: SUCCESS (0.040s)
[388.036069] Subtest dword: SUCCESS (0.269s)
[388.196287] [061/133] (631s left) gen7_exec_parse (basic-allocation)
[388.264998] Subtest basic-allocation: SKIP (0.000s)
[388.344908] [062/133] (631s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[388.433843] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[388.436018] Starting dynamic subtest: pipe-A-eDP-1
[388.856382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[388.868562] Starting dynamic subtest: pipe-B-eDP-1
[388.889235] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[388.902954] Starting dynamic subtest: pipe-C-eDP-1
[388.922506] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[388.931143] Starting dynamic subtest: pipe-D-eDP-1
[388.950228] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[388.952379] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.437s)
[391.111426] [063/133] (628s left) kms_psr (psr-cursor-mmap-gtt)
[391.210870] Starting subtest: psr-cursor-mmap-gtt
[391.213218] Starting dynamic subtest: eDP-1
[392.891632] Dynamic subtest eDP-1: SUCCESS (1.680s)
[392.893823] Subtest psr-cursor-mmap-gtt: SUCCESS (1.681s)
[393.700030] [064/133] (625s left) syncobj_timeline (multi-wait-all-signaled)
[393.750780] Starting subtest: multi-wait-all-signaled
[393.753058] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[393.829422] [065/133] (625s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[395.456353] Starting subtest: dpms-mode-unset-lpsp
[399.556041] Subtest dpms-mode-unset-lpsp: SUCCESS (4.102s)
[399.917910] [066/133] (619s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[400.010041] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[400.012308] Starting dynamic subtest: pipe-A-default-mode
[402.748224] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[402.750505] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.737s)
[403.602196] [067/133] (616s left) gem_create (create-ext-set-pat)
[403.777164] Starting subtest: create-ext-set-pat
[403.779658] Subtest create-ext-set-pat: SUCCESS (0.001s)
[403.846404] [068/133] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[403.939806] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[410.355319] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.418s)
[410.456723] [069/133] (609s left) gem_render_tiled_blits (basic)
[410.520678] Subtest basic: SKIP (0.000s)
[410.580483] [070/133] (609s left) kms_legacy_colorkey (basic)
[410.670208] Starting subtest: basic
[410.672087] Starting dynamic subtest: pipe-A
[410.713978] Dynamic subtest pipe-A: SUCCESS (0.045s)
[410.724768] Starting dynamic subtest: pipe-B
[410.726983] Dynamic subtest pipe-B: SUCCESS (0.001s)
[410.735641] Starting dynamic subtest: pipe-C
[410.737521] Dynamic subtest pipe-C: SUCCESS (0.000s)
[410.746247] Starting dynamic subtest: pipe-D
[410.748077] Dynamic subtest pipe-D: SUCCESS (0.000s)
[410.749911] Subtest basic: SUCCESS (0.051s)
[410.787035] [071/133] (608s left) kms_flip (flip-vs-expired-vblank)
[410.877293] Starting subtest: flip-vs-expired-vblank
[410.879686] Starting dynamic subtest: A-eDP1
[419.596294] Dynamic subtest A-eDP1: SUCCESS (8.718s)
[419.609250] Starting dynamic subtest: B-eDP1
[428.303751] Dynamic subtest B-eDP1: SUCCESS (8.704s)
[428.315692] Starting dynamic subtest: C-eDP1
[436.977043] Dynamic subtest C-eDP1: SUCCESS (8.671s)
[436.986672] Starting dynamic subtest: D-eDP1
[445.586064] Dynamic subtest D-eDP1: SUCCESS (8.607s)
[445.590836] Subtest flip-vs-expired-vblank: SUCCESS (34.714s)
[446.807218] [072/133] (573s left) kms_flip (bo-too-big-interruptible)
[446.908471] Starting subtest: bo-too-big-interruptible
[446.910735] Starting dynamic subtest: A-eDP1
[448.231123] Dynamic subtest A-eDP1: SUCCESS (1.322s)
[448.243180] Starting dynamic subtest: B-eDP1
[449.537366] Dynamic subtest B-eDP1: SUCCESS (1.303s)
[449.551062] Starting dynamic subtest: C-eDP1
[450.853731] Dynamic subtest C-eDP1: SUCCESS (1.313s)
[450.865561] Starting dynamic subtest: D-eDP1
[452.154618] Dynamic subtest D-eDP1: SUCCESS (1.300s)
[452.160262] Subtest bo-too-big-interruptible: SUCCESS (5.252s)
[453.302485] [073/133] (566s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[453.420158] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[453.424175] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[453.492654] [074/133] (566s left) kms_flip (flip-vs-dpms-on-nop)
[453.598083] Starting subtest: flip-vs-dpms-on-nop
[453.600248] Starting dynamic subtest: A-eDP1
[455.493499] Dynamic subtest A-eDP1: SUCCESS (1.894s)
[455.508054] Starting dynamic subtest: B-eDP1
[457.385225] Dynamic subtest B-eDP1: SUCCESS (1.888s)
[457.400339] Starting dynamic subtest: C-eDP1
[459.271035] Dynamic subtest C-eDP1: SUCCESS (1.884s)
[459.284813] Starting dynamic subtest: D-eDP1
[461.180616] Dynamic subtest D-eDP1: SUCCESS (1.908s)
[461.185938] Subtest flip-vs-dpms-on-nop: SUCCESS (7.588s)
[462.399933] [075/133] (557s left) gem_ctx_persistence (smoketest)
[462.468531] Starting subtest: smoketest
[502.242523] Subtest smoketest: SUCCESS (39.771s)
[502.296015] [076/133] (517s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[502.407421] Starting subtest: y-tiled-16bpp-rotate-270
[502.411952] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[502.473263] [077/133] (517s left) kms_fence_pin_leak
[502.645150] [078/133] (517s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[502.735068] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[509.386026] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.653s)
[509.501538] [079/133] (510s left) kms_psr (psr2-basic)
[509.595072] Starting subtest: psr2-basic
[509.597452] Starting dynamic subtest: eDP-1
[511.146848] Dynamic subtest eDP-1: SUCCESS (1.550s)
[511.148722] Subtest psr2-basic: SUCCESS (1.551s)
[512.002523] [080/133] (508s left) syncobj_timeline (host-signal-points)
[512.066513] Starting subtest: host-signal-points
[512.071586] Subtest host-signal-points: SUCCESS (0.004s)
[512.140428] [081/133] (508s left) api_intel_allocator (alloc-simple)
[512.198043] Starting subtest: alloc-simple
[512.200655] Subtest alloc-simple: SUCCESS (0.004s)
[512.297623] [082/133] (507s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[512.395113] Starting subtest: psr-rgb565-draw-render
[519.357222] Subtest psr-rgb565-draw-render: SUCCESS (6.965s)
[519.450415] [083/133] (500s left) kms_addfb_basic (too-high)
[519.554865] Starting subtest: too-high
[519.557121] Subtest too-high: SUCCESS (0.001s)
[519.620334] [084/133] (500s left) kms_content_protection (uevent)
[519.763383] Starting subtest: uevent
[519.768077] Subtest uevent: SKIP (0.000s)
[519.868427] [085/133] (500s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[519.957960] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[519.962178] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[520.006027] [086/133] (500s left) api_intel_bb (object-noreloc-keep-cache-simple)
[520.066051] Starting subtest: object-noreloc-keep-cache-simple
[520.071672] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[520.179068] [087/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[520.280068] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[520.283759] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[520.361286] [088/133] (500s left) kms_flip (blocking-absolute-wf_vblank)
[520.443937] Starting subtest: blocking-absolute-wf_vblank
[520.445772] Starting dynamic subtest: A-eDP1
[529.134558] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[529.154138] Starting dynamic subtest: B-eDP1
[537.950179] Dynamic subtest B-eDP1: SUCCESS (8.812s)
[537.969609] Starting dynamic subtest: C-eDP1
[546.732146] Dynamic subtest C-eDP1: SUCCESS (8.778s)
[546.745968] Starting dynamic subtest: D-eDP1
[555.428620] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[555.431104] Subtest blocking-absolute-wf_vblank: SUCCESS (34.987s)
[556.597817] [089/133] (463s left) gem_exec_flush (basic-wb-ro-default)
[556.657321] Starting subtest: basic-wb-ro-default
[562.109597] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[562.273191] [090/133] (458s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[562.362445] Starting subtest: fbc-indfb-scaledprimary
[565.338716] Subtest fbc-indfb-scaledprimary: SUCCESS (2.979s)
[566.500571] [091/133] (454s left) kms_pipe_crc_basic (nonblocking-crc)
[566.588354] Starting subtest: nonblocking-crc
[566.590881] Starting dynamic subtest: pipe-A-eDP-1
[567.323066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[567.332658] Starting dynamic subtest: pipe-B-eDP-1
[568.685677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.361s)
[568.696682] Starting dynamic subtest: pipe-C-eDP-1
[570.042801] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[570.053340] Starting dynamic subtest: pipe-D-eDP-1
[571.434662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.387s)
[571.437218] Subtest nonblocking-crc: SUCCESS (4.845s)
[572.291495] [092/133] (448s left) syncobj_timeline (invalid-query-one-illegal-handle)
[572.347457] Starting subtest: invalid-query-one-illegal-handle
[572.349839] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[572.406114] [093/133] (448s left) syncobj_wait (wait-for-submit-complex)
[572.457302] Starting subtest: wait-for-submit-complex
[572.518938] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[572.573204] [094/133] (448s left) kms_psr (psr-sprite-plane-onoff)
[572.668811] Starting subtest: psr-sprite-plane-onoff
[572.671117] Starting dynamic subtest: eDP-1
[574.421734] Dynamic subtest eDP-1: SUCCESS (1.753s)
[574.424175] Subtest psr-sprite-plane-onoff: SUCCESS (1.754s)
[575.207981] [095/133] (445s left) gem_mmap_offset (open-flood)
[575.263030] Starting subtest: open-flood
[596.751530] Subtest open-flood: SUCCESS (21.490s)
[596.826280] [096/133] (423s left) gem_lmem_swapping (heavy-verify-random)
[596.870068] Subtest heavy-verify-random: SKIP (0.000s)
[596.918134] [097/133] (423s left) kms_rotation_crc (cursor-rotation-180)
[597.008128] Starting subtest: cursor-rotation-180
[598.550974] Subtest cursor-rotation-180: SUCCESS (1.543s)
[599.704861] [098/133] (421s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[599.808882] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[599.811240] Starting dynamic subtest: pipe-A
[599.829207] Dynamic subtest pipe-A: SKIP (0.017s)
[599.840061] Starting dynamic subtest: pipe-B
[599.857559] Dynamic subtest pipe-B: SKIP (0.029s)
[599.867520] Starting dynamic subtest: pipe-C
[599.887625] Dynamic subtest pipe-C: SKIP (0.029s)
[599.897678] Starting dynamic subtest: pipe-D
[599.915389] Dynamic subtest pipe-D: SKIP (0.029s)
[599.919283] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.105s)
[600.003035] [099/133] (420s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[600.102038] Starting subtest: modeset-transition-nonblocking-fencing
[600.104241] Starting dynamic subtest: 1x-outputs
[611.169458] Dynamic subtest 1x-outputs: SUCCESS (11.065s)
[611.172019] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.068s)
[611.988865] [100/133] (408s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[612.084424] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[612.088731] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[612.161393] [101/133] (408s left) kms_plane_multiple (2x-tiling-y)
[612.250109] Starting subtest: 2x-tiling-y
[612.254089] Subtest 2x-tiling-y: SKIP (0.000s)
[612.298139] [102/133] (408s left) gem_exec_params (mmapped)
[612.365275] Starting subtest: mmapped
[612.370518] Subtest mmapped: SUCCESS (0.002s)
[612.466816] [103/133] (408s left) gem_pread (self)
[612.534869] Subtest self: SKIP (0.000s)
[612.606053] [104/133] (408s left) kms_cursor_edge_walk (256x256-top-edge)
[612.696732] Starting subtest: 256x256-top-edge
[612.698958] Starting dynamic subtest: pipe-A-eDP-1
[616.154080] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[616.164421] Starting dynamic subtest: pipe-D-eDP-1
[619.352841] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.199s)
[619.355223] Subtest 256x256-top-edge: SUCCESS (6.657s)
[620.192079] [105/133] (400s left) syncobj_wait (wait-any-snapshot)
[620.255516] Starting subtest: wait-any-snapshot
[620.334464] Subtest wait-any-snapshot: SUCCESS (0.081s)
[620.390483] [106/133] (400s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[620.486976] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[620.491319] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[620.566113] [107/133] (400s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[620.624673] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[620.629233] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[620.786292] [108/133] (400s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[621.350331] Starting subtest: syncobj-timeline-invalid-wait
[621.352809] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[622.335613] [109/133] (399s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[622.422890] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[622.425178] Starting dynamic subtest: pipe-A-eDP-1
[622.449312] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[622.459464] Starting dynamic subtest: pipe-B-eDP-1
[622.483356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[622.492899] Starting dynamic subtest: pipe-C-eDP-1
[622.516820] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[622.528490] Starting dynamic subtest: pipe-D-eDP-1
[622.552515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[622.556911] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[624.690522] [110/133] (396s left) kms_getfb (getfb2-handle-not-fb)
[624.781623] Starting subtest: getfb2-handle-not-fb
[624.783893] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[624.866317] [111/133] (396s left) vgem_basic (dmabuf-mmap)
[624.912332] Starting subtest: dmabuf-mmap
[624.915463] Subtest dmabuf-mmap: SUCCESS (0.009s)
[624.955944] [112/133] (396s left) gem_softpin (allocator-nopin)
[625.020618] Starting subtest: allocator-nopin
[625.128631] Subtest allocator-nopin: SUCCESS (0.108s)
[625.203077] [113/133] (396s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[625.305685] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[625.310145] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[625.363653] [114/133] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[625.460890] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[625.465044] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[625.527455] [115/133] (396s left) kms_joiner (basic-force-ultra-joiner)
[625.636609] Starting subtest: basic-force-ultra-joiner
[625.641224] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[625.680933] [116/133] (395s left) syncobj_eventfd (invalid-bad-pad)
[625.745390] Starting subtest: invalid-bad-pad
[625.747346] Subtest invalid-bad-pad: SUCCESS (0.000s)
[625.816474] [117/133] (395s left) kms_psr (fbc-pr-sprite-plane-move)
[625.902943] Starting subtest: fbc-pr-sprite-plane-move
[625.907040] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[625.950166] [118/133] (395s left) drm_buddy (drm_buddy)
[625.986727] Starting subtest: drm_buddy
[625.991154] Subtest drm_buddy: SKIP (0.001s)
[626.040226] [119/133] (395s left) syncobj_basic (bad-pad-fd-to-handle)
[626.103502] Starting subtest: bad-pad-fd-to-handle
[626.105832] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[626.180169] [120/133] (395s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[626.279567] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[626.283104] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[626.339032] [121/133] (395s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[626.388945] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[626.459344] [122/133] (395s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[626.549286] Starting subtest: psr-rgb101010-draw-mmap-wc
[633.524103] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.979s)
[633.607607] [123/133] (388s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[633.722623] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[634.546639] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.825s)
[634.685544] [124/133] (387s left) sysfs_timeslice_duration (idempotent)
[634.754042] Starting subtest: idempotent
[634.756333] Starting dynamic subtest: vecs0
[634.758590] Dynamic subtest vecs0: SUCCESS (0.000s)
[634.768726] Starting dynamic subtest: ccs0
[634.770610] Dynamic subtest ccs0: SUCCESS (0.000s)
[634.780693] Starting dynamic subtest: vcs0
[634.782562] Dynamic subtest vcs0: SUCCESS (0.000s)
[634.791682] Starting dynamic subtest: bcs0
[634.793496] Dynamic subtest bcs0: SUCCESS (0.000s)
[634.802607] Starting dynamic subtest: rcs0
[634.804603] Dynamic subtest rcs0: SUCCESS (0.000s)
[634.813401] Starting dynamic subtest: vcs1
[634.815285] Dynamic subtest vcs1: SUCCESS (0.000s)
[634.817390] Subtest idempotent: SUCCESS (0.006s)
[634.854813] [125/133] (387s left) kms_vblank (query-busy-hang)
[634.952367] Starting subtest: query-busy-hang
[634.954667] Starting dynamic subtest: pipe-A-eDP-1
[662.081730] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.127s)
[662.097755] Starting dynamic subtest: pipe-D-eDP-1
[687.039045] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.955s)
[687.041445] Subtest query-busy-hang: SUCCESS (52.086s)
[687.878506] [126/133] (334s left) perf_pmu (init-sema)
[687.916499] Starting subtest: init-sema
[687.918749] Starting dynamic subtest: rcs0
[687.920926] Dynamic subtest rcs0: SUCCESS (0.002s)
[687.930471] Starting dynamic subtest: bcs0
[687.932652] Dynamic subtest bcs0: SUCCESS (0.000s)
[687.941704] Starting dynamic subtest: vcs0
[687.943828] Dynamic subtest vcs0: SUCCESS (0.000s)
[687.952975] Starting dynamic subtest: vcs1
[687.954844] Dynamic subtest vcs1: SUCCESS (0.001s)
[687.964110] Starting dynamic subtest: vecs0
[687.966303] Dynamic subtest vecs0: SUCCESS (0.001s)
[687.975198] Starting dynamic subtest: ccs0
[687.977355] Dynamic subtest ccs0: SUCCESS (0.000s)
[687.979530] Subtest init-sema: SUCCESS (0.008s)
[688.018234] [127/133] (334s left) gem_ccs (ctrl-surf-copy)
[688.076927] Starting subtest: ctrl-surf-copy
[688.081376] Subtest ctrl-surf-copy: SKIP (0.000s)
[688.150179] [128/133] (333s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[688.278958] Starting subtest: cursorA-vs-flipB-atomic-transitions
[688.283405] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[688.399323] [129/133] (333s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[688.608978] Starting subtest: cursor-rapid-movement-64x21
[688.674594] Subtest cursor-rapid-movement-64x21: SKIP (0.061s)
[688.899169] [130/133] (333s left) gem_exec_schedule (thriceslice)
[688.968268] Starting subtest: thriceslice
[688.969947] Starting dynamic subtest: rcs0
[688.989580] Dynamic subtest rcs0: SUCCESS (0.029s)
[689.001901] Starting dynamic subtest: bcs0
[689.020055] Dynamic subtest bcs0: SUCCESS (0.030s)
[689.029595] Starting dynamic subtest: vcs0
[689.074090] Dynamic subtest vcs0: SUCCESS (0.053s)
[689.088086] Starting dynamic subtest: vcs1
[689.104997] Dynamic subtest vcs1: SUCCESS (0.029s)
[689.114582] Starting dynamic subtest: vecs0
[689.156888] Dynamic subtest vecs0: SUCCESS (0.050s)
[689.168350] Starting dynamic subtest: ccs0
[689.192072] Dynamic subtest ccs0: SUCCESS (0.033s)
[689.194452] Subtest thriceslice: SUCCESS (0.233s)
[689.475367] [131/133] (332s left) i915_pm_freq_api (freq-basic-api)
[689.534389] Starting subtest: freq-basic-api
[689.536630] Starting dynamic subtest: gt0
[689.538954] Dynamic subtest gt0: SUCCESS (0.003s)
[689.553924] Starting dynamic subtest: gt1
[689.555748] Dynamic subtest gt1: SUCCESS (0.003s)
[689.557678] Subtest freq-basic-api: SUCCESS (0.007s)
[689.622381] [132/133] (332s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[689.725804] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[689.729811] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[689.775640] [133/133] (332s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[689.872098] Starting subtest: fbc-2p-pri-indfb-multidraw
[689.876277] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[689.939973] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_chamelium_edid
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: gem_set_tiling_vs_blt
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_dp_linktrain_fallback
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_chamelium_color
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_3d
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: i915_power
results: parsing output: 37/ for test: gem_linear_blits
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_busy
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: i915_pm_rc6_residency
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_psr2_su
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_exec_store
results: parsing output: 60/ for test: gen7_exec_parse
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: gem_create
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_render_tiled_blits
results: parsing output: 69/ for test: kms_legacy_colorkey
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_fence_pin_leak
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_mmap_offset
results: parsing output: 95/ for test: gem_lmem_swapping
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_pread
results: parsing output: 103/ for test: kms_cursor_edge_walk
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_getfb
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_joiner
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: drm_buddy
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: gem_ccs
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: i915_pm_freq_api
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.