[61.547817] Initializing watchdogs
[61.547966]   /dev/watchdog0
[61.563339] [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]
[61.567526] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.569729] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.573013] [001/132] (960s left) drm_buddy (drm_buddy)
[61.625585] Starting subtest: drm_buddy
[61.630393] Subtest drm_buddy: SKIP (0.000s)
[61.683193] [002/132] (960s left) gen9_exec_parse (secure-batches)
[61.739338] Subtest secure-batches: SKIP (0.000s)
[61.792553] [003/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[61.897600] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[61.901929] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[61.992400] [004/132] (960s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[62.109771] Starting subtest: 2x-flip-vs-cursor-legacy
[62.114343] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[62.264322] [005/132] (959s left) perf_pmu (interrupts-sync)
[62.308924] Starting subtest: interrupts-sync
[63.429566] Subtest interrupts-sync: SUCCESS (1.119s)
[63.548766] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[63.552063] [006/132] (958s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[63.612794] Starting subtest: yf-tiled-ccs-to-x-tiled
[63.617505] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[63.799180] [007/132] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[63.902372] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[63.907028] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[64.010220] [008/132] (958s left) gem_exec_params (no-bsd)
[64.080209] Starting subtest: no-bsd
[64.082526] Subtest no-bsd: SUCCESS (0.002s)
[65.945667] [009/132] (956s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[66.057109] Starting subtest: 4-tiled-8bpp-rotate-180
[67.304372] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[67.627144] [010/132] (954s left) kms_vblank (query-forked-busy-hang)
[67.764327] Starting subtest: query-forked-busy-hang
[67.766381] Starting dynamic subtest: pipe-A-eDP-1
[94.691079] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.924s)
[94.708737] Starting dynamic subtest: pipe-D-eDP-1
[109.656458] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.964s)
[109.658839] Subtest query-forked-busy-hang: SUCCESS (41.892s)
[110.528796] [011/132] (911s left) gem_mmap_offset (isolation)
[110.576807] Starting subtest: isolation
[110.593779] Subtest isolation: SUCCESS (0.006s)
[110.677446] [012/132] (911s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[110.779417] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[110.781707] Starting dynamic subtest: pipe-A-eDP-1
[110.804601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[110.814754] Starting dynamic subtest: pipe-B-eDP-1
[110.836379] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[110.844479] Starting dynamic subtest: pipe-C-eDP-1
[110.865362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[110.874431] Starting dynamic subtest: pipe-D-eDP-1
[110.896410] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[110.900676] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[113.098231] [013/132] (909s left) gem_workarounds (reset)
[113.162713] Starting subtest: reset
[113.286348] Subtest reset: SUCCESS (0.123s)
[113.395963] [014/132] (909s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[113.507133] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[113.511764] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[113.647731] [015/132] (908s left) gem_ctx_persistence (heartbeat-many)
[113.702310] Starting subtest: heartbeat-many
[113.706739] Subtest heartbeat-many: SKIP (0.000s)
[113.793440] [016/132] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[113.887849] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[113.891892] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[113.990051] [017/132] (908s left) gem_exec_reloc (basic-gtt-active)
[114.064470] Subtest basic-gtt-active: SKIP (0.000s)
[114.139078] [018/132] (908s left) gem_exec_reloc (basic-wc)
[114.192937] Subtest basic-wc: SKIP (0.000s)
[114.258859] [019/132] (908s left) api_intel_bb (intel-bb-blit-x)
[114.315067] Starting subtest: intel-bb-blit-x
[117.753603] Subtest intel-bb-blit-x: SUCCESS (3.438s)
[117.863020] [020/132] (904s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[117.964989] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[117.969254] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[118.098989] [021/132] (904s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[118.228921] Starting subtest: cursorA-vs-flipB-toggle
[118.233316] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[118.370873] [022/132] (904s left) i915_hangman (engine-engine-hang)
[118.430806] Starting subtest: engine-engine-hang
[118.433033] Starting dynamic subtest: rcs0
[119.861253] Dynamic subtest rcs0: SUCCESS (1.429s)
[119.872928] Starting dynamic subtest: bcs0
[121.843221] Dynamic subtest bcs0: SUCCESS (1.981s)
[121.853968] Starting dynamic subtest: vcs0
[123.893246] Dynamic subtest vcs0: SUCCESS (2.049s)
[123.904828] Starting dynamic subtest: vcs1
[125.877490] Dynamic subtest vcs1: SUCCESS (1.983s)
[125.889298] Starting dynamic subtest: vecs0
[127.860770] Dynamic subtest vecs0: SUCCESS (1.982s)
[127.872391] Starting dynamic subtest: ccs0
[129.844387] Dynamic subtest ccs0: SUCCESS (1.982s)
[129.847406] Subtest engine-engine-hang: SUCCESS (11.413s)
[129.930712] [023/132] (893s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[130.035077] Starting subtest: y-tiled-64bpp-rotate-180
[130.039333] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[130.120238] [024/132] (892s left) perf (missing-sample-flags)
[130.266029] Starting subtest: missing-sample-flags
[130.268276] Subtest missing-sample-flags: SUCCESS (0.000s)
[130.306539] [025/132] (892s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[130.402238] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[136.964947] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.568s)
[137.079938] [026/132] (886s left) syncobj_timeline (invalid-transfer-illegal-handle)
[137.141672] Starting subtest: invalid-transfer-illegal-handle
[137.143996] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[137.248236] [027/132] (885s left) kms_cursor_crc (cursor-offscreen-64x21)
[137.445558] Starting subtest: cursor-offscreen-64x21
[137.495562] Subtest cursor-offscreen-64x21: SKIP (0.048s)
[137.737741] [028/132] (885s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[137.840558] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[137.845039] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[137.942380] [029/132] (885s left) kms_plane (pixel-format-y-tiled-modifier)
[138.028108] Starting subtest: pixel-format-y-tiled-modifier
[138.031396] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[138.096122] [030/132] (885s left) kms_async_flips (test-cursor-atomic)
[138.176969] Starting subtest: test-cursor-atomic
[138.554933] Starting dynamic subtest: pipe-A-eDP-1
[139.319588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s)
[139.704480] Starting dynamic subtest: pipe-B-eDP-1
[140.445641] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.747s)
[140.847850] Starting dynamic subtest: pipe-C-eDP-1
[141.587170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.754s)
[141.952985] Starting dynamic subtest: pipe-D-eDP-1
[142.713471] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[142.715899] Subtest test-cursor-atomic: SUCCESS (4.537s)
[143.882694] [031/132] (879s left) gem_mmap_gtt (big-copy)
[143.949952] Subtest big-copy: SKIP (0.000s)
[144.008159] [032/132] (879s left) gem_exec_reloc (basic-cpu-read-noreloc)
[144.062946] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[144.129453] [033/132] (879s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[144.223982] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[144.226213] Starting dynamic subtest: pipe-A-eDP-1
[160.762834] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.515s)
[160.774103] Starting dynamic subtest: pipe-B-eDP-1
[177.733145] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.420s)
[177.746260] Starting dynamic subtest: pipe-C-eDP-1
[194.730095] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.359s)
[194.740624] Starting dynamic subtest: pipe-D-eDP-1
[211.719769] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.356s)
[211.721807] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.653s)
[212.872254] [034/132] (810s left) gem_eio (in-flight-1us)
[213.095506] Starting subtest: in-flight-1us
[221.313255] Subtest in-flight-1us: SUCCESS (8.206s)
[221.486243] [035/132] (801s left) gem_watchdog (default-virtual)
[221.566667] Starting subtest: default-virtual
[227.844019] Subtest default-virtual: SUCCESS (6.281s)
[227.933630] [036/132] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[228.025064] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[228.029220] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[228.126275] [037/132] (795s left) gem_close (basic)
[228.195086] Starting subtest: basic
[228.197491] Subtest basic: SUCCESS (0.000s)
[228.286669] [038/132] (795s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[228.411056] Starting subtest: flip-vs-dpms-on-nop-interruptible
[228.413274] Starting dynamic subtest: A-eDP1
[230.280971] Dynamic subtest A-eDP1: SUCCESS (1.867s)
[230.292346] Starting dynamic subtest: B-eDP1
[232.104824] Dynamic subtest B-eDP1: SUCCESS (1.822s)
[232.116124] Starting dynamic subtest: C-eDP1
[233.920166] Dynamic subtest C-eDP1: SUCCESS (1.812s)
[233.931346] Starting dynamic subtest: D-eDP1
[235.741466] Dynamic subtest D-eDP1: SUCCESS (1.819s)
[235.743763] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.329s)
[236.929053] [039/132] (786s left) kms_universal_plane (universal-plane-sanity)
[237.029610] Starting subtest: universal-plane-sanity
[237.031592] Starting dynamic subtest: pipe-A-eDP-1
[237.633592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[237.642732] Starting dynamic subtest: pipe-B-eDP-1
[238.830657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[238.841050] Starting dynamic subtest: pipe-C-eDP-1
[240.051491] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s)
[240.064771] Starting dynamic subtest: pipe-D-eDP-1
[241.295274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[241.297664] Subtest universal-plane-sanity: SUCCESS (4.265s)
[242.169912] [040/132] (781s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[242.272575] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[242.274824] Starting dynamic subtest: pipe-A
[242.292552] Dynamic subtest pipe-A: SKIP (0.017s)
[242.308158] Starting dynamic subtest: pipe-B
[242.323343] Dynamic subtest pipe-B: SKIP (0.029s)
[242.332843] Starting dynamic subtest: pipe-C
[242.353413] Dynamic subtest pipe-C: SKIP (0.030s)
[242.362440] Starting dynamic subtest: pipe-D
[242.382811] Dynamic subtest pipe-D: SKIP (0.030s)
[242.387247] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.107s)
[242.487526] [041/132] (781s left) gem_exec_reloc (basic-write-cpu)
[242.544196] Subtest basic-write-cpu: SKIP (0.000s)
[242.620291] [042/132] (781s left) vgem_basic (dmabuf-mmap)
[242.662537] Starting subtest: dmabuf-mmap
[242.668181] Subtest dmabuf-mmap: SUCCESS (0.010s)
[242.729959] [043/132] (781s left) i915_pm_rps (engine-order)
[242.783806] Starting subtest: engine-order
[247.891079] Subtest engine-order: SUCCESS (5.103s)
[248.021140] [044/132] (775s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[248.137878] Starting subtest: flip-vs-cursor-crc-atomic
[248.791842] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.653s)
[249.583733] [045/132] (774s left) kms_rotation_crc (primary-rotation-90)
[249.710571] Starting subtest: primary-rotation-90
[249.714987] Subtest primary-rotation-90: SKIP (0.001s)
[249.786653] [046/132] (774s left) core_setmaster_vs_auth
[249.933976] [047/132] (774s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[249.984779] Starting subtest: yf-tiled-ccs-to-y-tiled
[249.989455] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[250.173319] [048/132] (773s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[250.267010] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[250.269119] Starting dynamic subtest: pipe-A-eDP-1
[256.160598] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.891s)
[256.170661] Starting dynamic subtest: pipe-B-eDP-1
[262.816346] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.652s)
[262.818723] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.546s)
[263.688430] [049/132] (760s left) kms_color (ctm-0-75)
[263.794529] Starting subtest: ctm-0-75
[263.796437] Starting dynamic subtest: pipe-A-eDP-1
[268.816173] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.018s)
[268.825964] Starting dynamic subtest: pipe-B-eDP-1
[274.545238] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.727s)
[274.555000] Starting dynamic subtest: pipe-C-eDP-1
[279.902271] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.355s)
[279.912704] Starting dynamic subtest: pipe-D-eDP-1
[285.265428] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.357s)
[285.267647] Subtest ctm-0-75: SUCCESS (21.460s)
[286.091254] [050/132] (738s left) kms_lease (lease-invalid-plane)
[286.195472] Starting subtest: lease-invalid-plane
[286.197732] Starting dynamic subtest: pipe-A-eDP-1
[286.200121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[286.209404] Starting dynamic subtest: pipe-B-eDP-1
[286.211673] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[286.219861] Starting dynamic subtest: pipe-C-eDP-1
[286.222246] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[286.230757] Starting dynamic subtest: pipe-D-eDP-1
[286.232981] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[286.235150] Subtest lease-invalid-plane: SUCCESS (0.004s)
[286.271784] [051/132] (737s left) kms_flip (wf_vblank-ts-check-interruptible)
[286.367282] Starting subtest: wf_vblank-ts-check-interruptible
[286.372196] Starting dynamic subtest: A-eDP1
[295.320257] Dynamic subtest A-eDP1: SUCCESS (8.946s)
[295.334494] Starting dynamic subtest: B-eDP1
[304.242828] Dynamic subtest B-eDP1: SUCCESS (8.915s)
[304.253720] Starting dynamic subtest: C-eDP1
[313.160464] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[313.171023] Starting dynamic subtest: D-eDP1
[322.085314] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[322.090651] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.725s)
[323.314066] [052/132] (700s left) gem_exec_schedule (promotion)
[323.410401] Starting subtest: promotion
[323.412337] Starting dynamic subtest: rcs0
[323.518522] Dynamic subtest rcs0: SUCCESS (0.110s)
[323.530554] Starting dynamic subtest: vcs0
[323.602595] Dynamic subtest vcs0: SUCCESS (0.084s)
[323.613708] Starting dynamic subtest: vcs1
[323.700699] Dynamic subtest vcs1: SUCCESS (0.098s)
[323.710456] Starting dynamic subtest: vecs0
[323.796232] Dynamic subtest vecs0: SUCCESS (0.094s)
[323.808069] Starting dynamic subtest: ccs0
[323.898936] Dynamic subtest ccs0: SUCCESS (0.102s)
[323.901604] Subtest promotion: SUCCESS (0.492s)
[324.814412] [053/132] (699s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[324.904142] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[331.057356] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.158s)
[332.208818] [054/132] (692s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[332.325745] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[338.942428] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.620s)
[339.059895] [055/132] (685s left) gem_exec_schedule (preempt-hang)
[339.250428] Starting subtest: preempt-hang
[339.253166] Starting dynamic subtest: rcs0
[339.483783] Dynamic subtest rcs0: SUCCESS (0.232s)
[339.494455] Starting dynamic subtest: bcs0
[339.716124] Dynamic subtest bcs0: SUCCESS (0.231s)
[339.728795] Starting dynamic subtest: vcs0
[339.945019] Dynamic subtest vcs0: SUCCESS (0.227s)
[339.954906] Starting dynamic subtest: vcs1
[340.175071] Dynamic subtest vcs1: SUCCESS (0.230s)
[340.186225] Starting dynamic subtest: vecs0
[340.398523] Dynamic subtest vecs0: SUCCESS (0.222s)
[340.409144] Starting dynamic subtest: ccs0
[340.624419] Dynamic subtest ccs0: SUCCESS (0.225s)
[340.626333] Subtest preempt-hang: SUCCESS (1.375s)
[341.842633] [056/132] (682s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[341.933557] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[341.937845] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[342.021720] [057/132] (682s left) gem_exec_fence (submit3)
[342.199465] Starting subtest: submit3
[342.203569] Subtest submit3: SKIP (0.000s)
[343.816821] [058/132] (680s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[343.870362] Starting subtest: etime-single-wait-for-submit-unsubmitted
[343.972666] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[344.067304] [059/132] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[344.172995] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[344.177064] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[344.274183] [060/132] (680s left) gem_userptr_blits (invalid-null-pointer)
[344.331576] Starting subtest: invalid-null-pointer
[344.333439] Subtest invalid-null-pointer: SUCCESS (0.001s)
[344.454840] [061/132] (680s left) kms_properties (connector-properties-legacy)
[344.541654] Starting subtest: connector-properties-legacy
[344.543965] Starting dynamic subtest: pipe-A-eDP-1
[352.383595] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.842s)
[352.394192] Starting dynamic subtest: pipe-None-DP-1
[352.398617] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[352.407453] Starting dynamic subtest: pipe-None-HDMI-A-1
[352.411804] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[352.420332] Starting dynamic subtest: pipe-None-DP-2
[352.424525] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[352.432974] Starting dynamic subtest: pipe-None-HDMI-A-2
[352.437036] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[352.445336] Starting dynamic subtest: pipe-None-DP-3
[352.449438] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[352.458207] Starting dynamic subtest: pipe-None-DP-4
[352.462762] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[352.465009] Subtest connector-properties-legacy: SUCCESS (7.853s)
[353.261946] [062/132] (671s left) kms_psr (psr2-sprite-render)
[353.349683] Starting subtest: psr2-sprite-render
[353.351981] Starting dynamic subtest: eDP-1
[355.037761] Dynamic subtest eDP-1: SUCCESS (1.688s)
[355.040065] Subtest psr2-sprite-render: SUCCESS (1.689s)
[355.922438] [063/132] (668s left) prime_udl
[356.021732] [064/132] (668s left) gem_ctx_persistence (engines-cleanup)
[356.074663] Starting subtest: engines-cleanup
[356.077075] Starting dynamic subtest: rcs0
[356.150708] Dynamic subtest rcs0: SUCCESS (0.076s)
[356.163551] Starting dynamic subtest: bcs0
[356.197906] Dynamic subtest bcs0: SUCCESS (0.045s)
[356.208277] Starting dynamic subtest: vcs0
[356.234043] Dynamic subtest vcs0: SUCCESS (0.034s)
[356.249652] Starting dynamic subtest: vcs1
[356.282127] Dynamic subtest vcs1: SUCCESS (0.047s)
[356.293857] Starting dynamic subtest: vecs0
[356.317842] Dynamic subtest vecs0: SUCCESS (0.034s)
[356.327645] Starting dynamic subtest: ccs0
[356.351942] Dynamic subtest ccs0: SUCCESS (0.032s)
[356.354188] Subtest engines-cleanup: SUCCESS (0.278s)
[356.446314] [065/132] (668s left) gem_exec_fence (concurrent)
[356.617021] Starting subtest: concurrent
[356.621453] Subtest concurrent: SKIP (0.000s)
[358.825126] [066/132] (665s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[358.920753] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[358.925129] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[359.015640] [067/132] (665s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[359.079473] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[359.081652] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[359.170410] [068/132] (665s left) gem_exec_balancer (bonded-dual)
[359.223898] Starting subtest: bonded-dual
[359.228415] Subtest bonded-dual: SKIP (0.000s)
[359.512081] [069/132] (665s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[359.566801] Starting subtest: wait-all-for-submit-delayed-submit
[359.667770] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[359.746951] [070/132] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[359.843672] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[359.847640] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[359.951981] [071/132] (665s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[360.039541] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[367.188526] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.151s)
[367.311068] [072/132] (657s left) sysfs_timeslice_duration (idempotent)
[367.392244] Starting subtest: idempotent
[367.394546] Starting dynamic subtest: vecs0
[367.396753] Dynamic subtest vecs0: SUCCESS (0.001s)
[367.406823] Starting dynamic subtest: ccs0
[367.408998] Dynamic subtest ccs0: SUCCESS (0.000s)
[367.417820] Starting dynamic subtest: vcs0
[367.419694] Dynamic subtest vcs0: SUCCESS (0.000s)
[367.428436] Starting dynamic subtest: bcs0
[367.430582] Dynamic subtest bcs0: SUCCESS (0.000s)
[367.439210] Starting dynamic subtest: rcs0
[367.441438] Dynamic subtest rcs0: SUCCESS (0.000s)
[367.450011] Starting dynamic subtest: vcs1
[367.452147] Dynamic subtest vcs1: SUCCESS (0.000s)
[367.454320] Subtest idempotent: SUCCESS (0.007s)
[367.491395] [073/132] (657s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[367.589603] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[367.591758] Starting dynamic subtest: pipe-A-eDP-1
[368.305165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[368.314183] Starting dynamic subtest: pipe-B-eDP-1
[370.043306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.736s)
[370.053201] Starting dynamic subtest: pipe-C-eDP-1
[371.787076] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.742s)
[371.797449] Starting dynamic subtest: pipe-D-eDP-1
[373.534779] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.745s)
[373.537133] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.937s)
[374.684581] [074/132] (650s left) gem_ctx_shared (single-timeline)
[374.757910] Starting subtest: single-timeline
[374.778192] Subtest single-timeline: SUCCESS (0.013s)
[375.006012] [075/132] (650s left) kms_prop_blob (blob-prop-lifetime)
[375.052840] Starting subtest: blob-prop-lifetime
[375.055134] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[375.145902] [076/132] (650s left) syncobj_timeline (single-wait-for-submit-signaled)
[375.191992] Starting subtest: single-wait-for-submit-signaled
[375.193951] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[375.274785] [077/132] (649s left) gem_mmap_gtt (cpuset-big-copy)
[375.341986] Subtest cpuset-big-copy: SKIP (0.000s)
[375.406735] [078/132] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[375.504653] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[375.508870] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[375.596270] [079/132] (649s left) kms_psr (fbc-psr2-primary-render)
[375.701075] Starting subtest: fbc-psr2-primary-render
[375.703749] Starting dynamic subtest: eDP-1
[375.708588] Dynamic subtest eDP-1: SKIP (0.000s)
[375.713106] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[375.777312] [080/132] (649s left) gem_create (hog-create)
[375.839413] Starting subtest: hog-create
[375.841351] Starting dynamic subtest: smem0
[409.769480] Dynamic subtest smem0: SUCCESS (33.923s)
[409.772124] Subtest hog-create: SUCCESS (33.925s)
[409.952837] [081/132] (615s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[410.048312] Starting subtest: 2x-flip-vs-rmfb-interruptible
[410.059812] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[410.136414] [082/132] (615s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[410.236601] Starting subtest: basic-modeset-with-all-modifiers-formats
[410.614470] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[411.362231] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.748s)
[411.371475] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[411.384427] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[411.393457] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[411.406745] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[411.415505] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[411.551474] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[411.560844] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[411.573511] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[411.582533] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[411.595583] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[411.605952] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[411.617848] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.020s)
[411.627117] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[411.639943] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[411.649007] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[411.662459] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[411.671207] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[411.684626] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[411.693400] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[411.706507] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[411.715282] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[411.728879] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[411.737954] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[411.884828] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[411.894179] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[411.906985] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[411.916189] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[411.932991] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[411.953608] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[411.956121] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.019s)
[411.975605] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[411.978103] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[411.998216] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[412.000568] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[412.010082] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[412.018182] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[412.027462] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[412.040458] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[412.049660] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[412.062730] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[412.071941] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[412.218663] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[412.228611] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[412.240828] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[412.250087] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[412.263033] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[412.272001] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[412.285152] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[412.293979] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[412.306990] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[412.315602] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[412.329291] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[412.337921] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[412.351353] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[412.360128] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[412.373872] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[412.382540] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[412.396101] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[412.790469] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.554s)
[413.568894] [083/132] (611s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[413.671432] Starting subtest: bad-rotation-90-yf-tiled-ccs
[413.675948] Starting dynamic subtest: pipe-A-eDP-1
[413.699339] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.712204] Starting dynamic subtest: pipe-B-eDP-1
[413.734415] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.743436] Starting dynamic subtest: pipe-C-eDP-1
[413.764635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.773651] Starting dynamic subtest: pipe-D-eDP-1
[413.795991] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.800001] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[415.854491] [084/132] (609s left) gem_mmap_wc (bad-offset)
[415.910259] Subtest bad-offset: SKIP (0.000s)
[415.973765] [085/132] (609s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[416.053641] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[416.055925] Starting dynamic subtest: pipe-A-eDP-1
[416.075951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[416.087243] Starting dynamic subtest: pipe-B-eDP-1
[416.106437] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[416.115316] Starting dynamic subtest: pipe-C-eDP-1
[416.134087] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[416.143201] Starting dynamic subtest: pipe-D-eDP-1
[416.162083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[416.163944] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[418.306184] [086/132] (607s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[418.404585] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[418.408575] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[418.478806] [087/132] (607s left) perf_pmu (idle)
[418.521542] Starting subtest: idle
[418.523851] Starting dynamic subtest: rcs0
[419.070737] Dynamic subtest rcs0: SUCCESS (0.548s)
[419.082524] Starting dynamic subtest: bcs0
[419.587754] Dynamic subtest bcs0: SUCCESS (0.514s)
[419.597875] Starting dynamic subtest: vcs0
[420.103322] Dynamic subtest vcs0: SUCCESS (0.513s)
[420.115449] Starting dynamic subtest: vcs1
[420.624356] Dynamic subtest vcs1: SUCCESS (0.517s)
[420.639129] Starting dynamic subtest: vecs0
[421.144456] Dynamic subtest vecs0: SUCCESS (0.518s)
[421.156589] Starting dynamic subtest: ccs0
[421.659929] Dynamic subtest ccs0: SUCCESS (0.513s)
[421.662714] Subtest idle: SUCCESS (3.140s)
[421.762268] [088/132] (603s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[422.175990] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[423.002117] [089/132] (602s left) kms_pm_rpm (modeset-lpsp)
[424.851019] Starting subtest: modeset-lpsp
[426.325984] Subtest modeset-lpsp: SUCCESS (1.477s)
[426.415776] [090/132] (599s left) kms_psr (pr-sprite-blt)
[426.505129] Starting subtest: pr-sprite-blt
[426.509481] Subtest pr-sprite-blt: SKIP (0.000s)
[426.578044] [091/132] (599s left) kms_cursor_crc (cursor-sliding-64x64)
[426.740050] Starting subtest: cursor-sliding-64x64
[426.745002] Starting dynamic subtest: pipe-A-eDP-1
[429.943827] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.200s)
[429.975479] Starting dynamic subtest: pipe-D-eDP-1
[433.853227] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.885s)
[433.855551] Subtest cursor-sliding-64x64: SUCCESS (7.111s)
[434.729147] [092/132] (591s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[434.827501] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[434.831641] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[434.903704] [093/132] (591s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[435.011638] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[435.015528] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[435.113389] [094/132] (590s left) gem_lmem_swapping (heavy-verify-multi)
[435.155898] Subtest heavy-verify-multi: SKIP (0.000s)
[435.201426] [095/132] (590s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[435.303328] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[435.307762] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[435.391045] [096/132] (590s left) gem_spin_batch (user-each)
[435.455370] Starting subtest: user-each
[438.728209] Subtest user-each: SUCCESS (3.266s)
[440.762678] [097/132] (585s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[440.864062] Starting subtest: primary-4-tiled-reflect-x-180
[447.794666] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.935s)
[448.993452] [098/132] (577s left) gem_exec_parallel (contexts)
[449.066823] Starting subtest: contexts
[449.069316] Starting dynamic subtest: rcs0
[451.919455] Dynamic subtest rcs0: SUCCESS (2.852s)
[451.929757] Starting dynamic subtest: bcs0
[455.917396] Dynamic subtest bcs0: SUCCESS (3.996s)
[455.929629] Starting dynamic subtest: vcs0
[460.179732] Dynamic subtest vcs0: SUCCESS (4.261s)
[460.192913] Starting dynamic subtest: vcs1
[464.279787] Dynamic subtest vcs1: SUCCESS (4.097s)
[464.292715] Starting dynamic subtest: vecs0
[468.289214] Dynamic subtest vecs0: SUCCESS (4.007s)
[468.301852] Starting dynamic subtest: ccs0
[472.119702] Dynamic subtest ccs0: SUCCESS (3.830s)
[472.122420] Subtest contexts: SUCCESS (23.058s)
[472.327931] [099/132] (553s left) kms_chamelium_hpd (vga-hpd-fast)
[472.705497] Subtest vga-hpd-fast: SKIP (0.000s)
[473.474648] [100/132] (552s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[473.583017] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[473.587504] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[473.689617] [101/132] (552s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[473.791606] Starting subtest: compare-crc-sanitycheck-nv12
[473.793877] Starting dynamic subtest: pipe-A-eDP-1
[474.476142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[474.488089] Starting dynamic subtest: pipe-B-eDP-1
[475.776520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.299s)
[475.789326] Starting dynamic subtest: pipe-C-eDP-1
[477.042680] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.262s)
[477.053521] Starting dynamic subtest: pipe-D-eDP-1
[478.259033] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[478.261430] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.471s)
[479.116108] [102/132] (547s left) kms_dsc (dsc-with-output-formats-with-bpc)
[479.222702] Starting subtest: dsc-with-output-formats-with-bpc
[479.281147] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[479.323825] [103/132] (547s left) kms_cursor_crc (cursor-random-256x85)
[479.581077] Starting subtest: cursor-random-256x85
[479.627729] Subtest cursor-random-256x85: SKIP (0.042s)
[479.824968] [104/132] (546s left) i915_drm_fdinfo (busy-idle)
[479.873089] Starting subtest: busy-idle
[479.874905] Starting dynamic subtest: rcs0
[479.887872] Dynamic subtest rcs0: SKIP (0.014s)
[479.897579] Starting dynamic subtest: bcs0
[479.904240] Dynamic subtest bcs0: SKIP (0.014s)
[479.913045] Starting dynamic subtest: vcs0
[479.916890] Dynamic subtest vcs0: SKIP (0.000s)
[479.925847] Starting dynamic subtest: vcs1
[479.930020] Dynamic subtest vcs1: SKIP (0.000s)
[479.938661] Starting dynamic subtest: vecs0
[479.942579] Dynamic subtest vecs0: SKIP (0.000s)
[479.950988] Starting dynamic subtest: ccs0
[479.954906] Dynamic subtest ccs0: SKIP (0.000s)
[479.958850] Subtest busy-idle: SKIP (0.033s)
[479.996705] [105/132] (546s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[480.100604] Starting subtest: fbcpsr-tiling-y
[480.104007] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[480.209964] [106/132] (546s left) i915_query (query-regions-unallocated)
[480.260392] Starting subtest: query-regions-unallocated
[480.262344] Subtest query-regions-unallocated: SUCCESS (0.000s)
[480.346444] [107/132] (546s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[480.473458] Starting subtest: flip-vs-cursor-legacy
[487.564437] Subtest flip-vs-cursor-legacy: SUCCESS (7.091s)
[488.451177] [108/132] (538s left) kms_pm_backlight (brightness-with-dpms)
[488.552484] Starting subtest: brightness-with-dpms
[488.603964] Starting dynamic subtest: eDP-1
[491.047130] Dynamic subtest eDP-1: SUCCESS (2.443s)
[491.049477] Subtest brightness-with-dpms: SUCCESS (2.494s)
[491.902195] [109/132] (534s left) gem_exec_whisper (basic-contexts-priority)
[491.969449] Starting subtest: basic-contexts-priority
[515.314366] Subtest basic-contexts-priority: SUCCESS (23.343s)
[515.497210] [110/132] (511s left) gem_exec_reloc (basic-wc-read-active)
[515.564914] Subtest basic-wc-read-active: SKIP (0.000s)
[515.645592] [111/132] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[515.741675] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[515.745682] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[515.857462] [112/132] (510s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[515.964692] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[515.966991] Starting dynamic subtest: pipe-A-eDP-1
[515.992270] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[516.002126] Starting dynamic subtest: pipe-B-eDP-1
[516.026861] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[516.038345] Starting dynamic subtest: pipe-C-eDP-1
[516.062683] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[516.074471] Starting dynamic subtest: pipe-D-eDP-1
[516.099073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[516.103186] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[518.276431] [113/132] (508s left) kms_psr (fbc-psr-cursor-render)
[518.382607] Starting subtest: fbc-psr-cursor-render
[518.384495] Starting dynamic subtest: eDP-1
[518.388565] Dynamic subtest eDP-1: SKIP (0.000s)
[518.392674] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[518.467291] [114/132] (508s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[518.574168] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[518.576462] Starting dynamic subtest: pipe-A-eDP-1
[518.669434] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[518.680453] Starting dynamic subtest: pipe-B-eDP-1
[519.842234] Dynamic subtest pipe-B-eDP-1: SKIP (1.169s)
[519.846558] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.271s)
[521.027347] [115/132] (505s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[521.077587] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[521.079787] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[521.187794] [116/132] (505s left) gem_mmap_gtt (basic-read)
[521.248886] Subtest basic-read: SKIP (0.000s)
[521.353938] [117/132] (505s left) gem_mmap_gtt (basic)
[521.409518] Subtest basic: SKIP (0.000s)
[521.471944] [118/132] (505s left) prime_vgem (fence-read-hang)
[521.537586] Subtest fence-read-hang: SKIP (0.000s)
[521.647833] [119/132] (505s left) kms_big_fb (linear-64bpp-rotate-270)
[521.741355] Starting subtest: linear-64bpp-rotate-270
[521.761032] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[521.866262] [120/132] (505s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[521.918995] Starting subtest: invalid-bsd2-flag-on-blt
[521.921202] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[522.014092] [121/132] (505s left) gem_exec_gttfill (all-engines)
[522.071837] Starting subtest: all-engines
[545.286825] Subtest all-engines: SUCCESS (23.212s)
[545.489550] [122/132] (481s left) syncobj_timeline (device-submit-unordered)
[545.601645] Starting subtest: device-submit-unordered
[545.604206] Subtest device-submit-unordered: SUCCESS (0.001s)
[545.677876] [123/132] (481s left) prime_vgem (busy)
[545.756240] Starting subtest: busy
[545.758659] Starting dynamic subtest: rcs0
[545.835434] Dynamic subtest rcs0: SUCCESS (0.080s)
[545.847454] Starting dynamic subtest: bcs0
[545.913447] Dynamic subtest bcs0: SUCCESS (0.077s)
[545.923622] Starting dynamic subtest: vcs0
[545.960560] Dynamic subtest vcs0: SUCCESS (0.046s)
[545.970950] Starting dynamic subtest: vcs1
[546.007814] Dynamic subtest vcs1: SUCCESS (0.046s)
[546.018296] Starting dynamic subtest: vecs0
[546.055611] Dynamic subtest vecs0: SUCCESS (0.047s)
[546.065466] Starting dynamic subtest: ccs0
[546.104449] Dynamic subtest ccs0: SUCCESS (0.047s)
[546.107130] Subtest busy: SUCCESS (0.349s)
[546.241484] [124/132] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[546.352910] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[546.356969] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[546.446958] [125/132] (480s left) fbdev (unaligned-read)
[546.496428] Starting subtest: unaligned-read
[546.510910] Subtest unaligned-read: SUCCESS (0.014s)
[546.565362] [126/132] (480s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[546.658335] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[547.361215] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[547.549603] [127/132] (479s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[547.645759] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[547.649999] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[547.761389] [128/132] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[547.860090] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[554.824356] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.967s)
[554.959049] [129/132] (472s left) kms_content_protection (atomic-hdcp14)
[555.098097] Starting subtest: atomic-hdcp14
[555.102473] Subtest atomic-hdcp14: SKIP (0.000s)
[555.212159] [130/132] (472s left) kms_hdr (static-toggle)
[555.301398] Starting subtest: static-toggle
[555.307515] Subtest static-toggle: SKIP (0.000s)
[555.375352] [131/132] (472s left) kms_flip (dpms-off-confusion)
[555.466963] Starting subtest: dpms-off-confusion
[555.469297] Starting dynamic subtest: A-eDP1
[564.159290] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[564.172918] Starting dynamic subtest: B-eDP1
[572.797819] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[572.807887] Starting dynamic subtest: C-eDP1
[581.411188] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[581.422848] Starting dynamic subtest: D-eDP1
[590.043040] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[590.048132] Subtest dpms-off-confusion: SUCCESS (34.578s)
[591.220318] [132/132] (436s left) perf_pmu (busy-hang)
[591.265865] Starting subtest: busy-hang
[591.268153] Starting dynamic subtest: rcs0
[592.535871] Dynamic subtest rcs0: SUCCESS (1.267s)
[592.547159] Starting dynamic subtest: bcs0
[593.775175] Dynamic subtest bcs0: SUCCESS (1.241s)
[593.786950] Starting dynamic subtest: vcs0
[596.260334] Dynamic subtest vcs0: SUCCESS (2.479s)
[596.271944] Starting dynamic subtest: vcs1
[598.243643] Dynamic subtest vcs1: SUCCESS (1.981s)
[598.254357] Starting dynamic subtest: vecs0
[600.227692] Dynamic subtest vecs0: SUCCESS (1.982s)
[600.239217] Starting dynamic subtest: ccs0
[601.457836] Dynamic subtest ccs0: SUCCESS (1.231s)
[601.460474] Subtest busy-hang: SUCCESS (10.192s)
[601.558889] Closing watchdogs
results: parsing output: 0/ for test: drm_buddy
results: parsing output: 1/ for test: gen9_exec_parse
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_workarounds
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: i915_hangman
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_async_flips
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: gem_watchdog
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_close
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_universal_plane
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: vgem_basic
results: parsing output: 42/ for test: i915_pm_rps
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: core_setmaster_vs_auth
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: kms_lease
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_properties
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: prime_udl
results: parsing output: 63/ for test: gem_ctx_persistence
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: sysfs_timeslice_duration
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_prop_blob
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_create
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_chamelium_edid
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_spin_batch
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: gem_exec_parallel
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pipe_crc_basic
results: parsing output: 101/ for test: kms_dsc
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_pm_backlight
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: prime_vgem
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: gem_exec_gttfill
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: prime_vgem
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: fbdev
results: parsing output: 125/ for test: kms_big_fb
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_hdr
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: perf_pmu
Done.