[47.508056] Initializing watchdogs
[47.508117]   /dev/watchdog0
[47.524187] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.529483] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.532344] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.534124] [001/133] (960s left) kms_color (ctm-blue-to-red)
[47.624187] Starting subtest: ctm-blue-to-red
[47.624874] Starting dynamic subtest: pipe-A-HDMI-A-1
[47.949080] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.325s)
[47.956285] Starting dynamic subtest: pipe-B-HDMI-A-1
[48.242070] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.292s)
[48.248455] Starting dynamic subtest: pipe-C-HDMI-A-1
[48.542145] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.300s)
[48.547772] Starting dynamic subtest: pipe-D-HDMI-A-1
[48.836850] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.295s)
[48.837769] Subtest ctm-blue-to-red: SUCCESS (1.213s)
[48.980697] [002/133] (959s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[49.022234] Starting subtest: yf-tiled-to-vebox-y-tiled
[49.022943] Starting dynamic subtest: smem
[49.120826] Dynamic subtest smem: SUCCESS (0.098s)
[49.121512] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.099s)
[49.299508] [003/133] (958s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[49.385604] Starting subtest: crc-primary-basic-y-tiled-ccs
[49.386314] Starting dynamic subtest: pipe-A-HDMI-A-1
[49.392983] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[49.398504] Starting dynamic subtest: pipe-B-HDMI-A-1
[49.405277] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[49.410739] Starting dynamic subtest: pipe-C-HDMI-A-1
[49.417412] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[49.422837] Starting dynamic subtest: pipe-D-HDMI-A-1
[49.429614] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[49.430956] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[49.614276] [004/133] (958s left) gem_mmap_gtt (basic-small-copy-odd)
[49.649720] Starting subtest: basic-small-copy-odd
[51.514829] Subtest basic-small-copy-odd: SUCCESS (1.865s)
[51.582123] [005/133] (956s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[51.729986] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[52.316700] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.587s)
[52.434797] [006/133] (955s left) kms_chamelium_frames (vga-frame-dump)
[52.576071] Subtest vga-frame-dump: SKIP (0.000s)
[52.662105] [007/133] (955s left) gem_eio (wait-wedge-10ms)
[52.710731] Starting subtest: wait-wedge-10ms
[52.973261] Subtest wait-wedge-10ms: SUCCESS (0.263s)
[53.081310] [008/133] (955s left) gem_tiled_blits (normal)
[53.167446] Starting subtest: normal
[63.003609] Subtest normal: SUCCESS (9.827s)
[63.096479] [009/133] (945s left) kms_plane_alpha_blend (alpha-transparent-fb)
[63.227496] Starting subtest: alpha-transparent-fb
[63.298403] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.580989] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.282s)
[63.587487] Starting dynamic subtest: pipe-D-HDMI-A-1
[63.868928] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.286s)
[63.869639] Subtest alpha-transparent-fb: SUCCESS (0.641s)
[64.007445] [010/133] (944s left) gem_exec_fence (syncobj-import)
[64.369277] Starting subtest: syncobj-import
[64.372106] Subtest syncobj-import: SUCCESS (0.003s)
[64.689466] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[64.701396] [011/133] (943s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[64.783256] Starting subtest: etime-multi-wait-for-submit-submitted
[64.867715] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[64.984057] [012/133] (943s left) kms_big_fb (y-tiled-addfb-size-overflow)
[65.080350] Starting subtest: y-tiled-addfb-size-overflow
[65.081050] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s)
[65.165471] [013/133] (943s left) gem_create (create-ext-cpu-access-sanity-check)
[65.331791] Starting subtest: create-ext-cpu-access-sanity-check
[65.342073] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[65.394371] [014/133] (943s left) gem_lmem_swapping (heavy-multi)
[65.431588] Subtest heavy-multi: SKIP (0.000s)
[65.468564] [015/133] (943s left) kms_psr (fbc-pr-cursor-render)
[65.553445] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[65.593657] [016/133] (943s left) gem_ctx_persistence (engines-mixed)
[65.632168] Starting subtest: engines-mixed
[65.632900] Starting dynamic subtest: rcs0
[65.680604] Dynamic subtest rcs0: SUCCESS (0.048s)
[65.693945] Starting dynamic subtest: bcs0
[65.733650] Dynamic subtest bcs0: SUCCESS (0.052s)
[65.750370] Starting dynamic subtest: vcs0
[65.793632] Dynamic subtest vcs0: SUCCESS (0.059s)
[65.807685] Starting dynamic subtest: vcs1
[65.840668] Dynamic subtest vcs1: SUCCESS (0.046s)
[65.854971] Starting dynamic subtest: vecs0
[65.884466] Dynamic subtest vecs0: SUCCESS (0.043s)
[65.885511] Subtest engines-mixed: SUCCESS (0.252s)
[65.960427] [017/133] (942s left) syncobj_wait (multi-wait-all-submitted)
[65.994025] Starting subtest: multi-wait-all-submitted
[66.095520] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[66.168885] [018/133] (942s left) dumb_buffer (map-valid)
[66.200271] Starting subtest: map-valid
[66.200958] Subtest map-valid: SUCCESS (0.000s)
[66.282161] [019/133] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[66.370380] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[66.371687] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[66.457266] [020/133] (942s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[66.541654] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[66.542338] Starting dynamic subtest: pipe-A-valid-mode
[67.597502] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.054s)
[67.601505] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (1.056s)
[67.810495] [021/133] (941s left) kms_pm_rpm (modeset-non-lpsp-stress)
[69.230612] Starting subtest: modeset-non-lpsp-stress
[70.429042] Subtest modeset-non-lpsp-stress: SKIP (1.197s)
[70.597358] [022/133] (938s left) gem_exec_alignment (many)
[70.636612] Starting subtest: many
[103.187599] Subtest many: SUCCESS (32.542s)
[103.952615] [023/133] (904s left) kms_psr (fbc-psr2-primary-blt)
[104.103082] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[104.191762] [024/133] (904s left) kms_chamelium_audio (hdmi-audio-edid)
[104.329365] Subtest hdmi-audio-edid: SKIP (0.000s)
[104.424802] [025/133] (904s left) kms_psr (pr-primary-mmap-cpu)
[104.512467] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[104.557704] [026/133] (904s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[104.600486] Starting subtest: multi-wait-available-unsubmitted-submitted
[104.601241] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[104.660931] [027/133] (904s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[104.745036] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[104.783810] [028/133] (904s left) sysfs_heartbeat_interval (invalid)
[104.821999] Starting subtest: invalid
[104.822686] Starting dynamic subtest: vecs0
[104.823350] Dynamic subtest vecs0: SUCCESS (0.000s)
[104.830367] Starting dynamic subtest: vcs0
[104.831043] Dynamic subtest vcs0: SUCCESS (0.000s)
[104.837617] Starting dynamic subtest: bcs0
[104.838285] Dynamic subtest bcs0: SUCCESS (0.000s)
[104.844752] Starting dynamic subtest: rcs0
[104.845409] Dynamic subtest rcs0: SUCCESS (0.000s)
[104.851746] Starting dynamic subtest: vcs1
[104.852423] Dynamic subtest vcs1: SUCCESS (0.000s)
[104.853124] Subtest invalid: SUCCESS (0.003s)
[104.885853] [029/133] (904s left) kms_sequence (queue-busy)
[104.969810] Starting subtest: queue-busy
[104.970536] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.277837] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.308s)
[106.288105] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.545841] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.267s)
[107.554661] Starting dynamic subtest: pipe-C-HDMI-A-1
[108.815690] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.269s)
[108.825962] Starting dynamic subtest: pipe-D-HDMI-A-1
[110.090526] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.273s)
[110.091224] Subtest queue-busy: SUCCESS (5.122s)
[110.198078] [030/133] (899s left) kms_vrr (flip-basic-fastset)
[110.288526] Starting subtest: flip-basic-fastset
[110.290488] Subtest flip-basic-fastset: SKIP (0.000s)
[110.345781] [031/133] (898s left) gem_userptr_blits (stress-mm-invalidate-close)
[110.391100] Starting subtest: stress-mm-invalidate-close
[112.548228] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[112.649285] [032/133] (896s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[112.747046] Starting subtest: 4-tiled-32bpp-rotate-0
[112.748472] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[112.838267] [033/133] (896s left) gem_userptr_blits (set-cache-level)
[112.876707] Starting subtest: set-cache-level
[112.877391] Subtest set-cache-level: SUCCESS (0.000s)
[113.019065] [034/133] (896s left) kms_async_flips (async-flip-dpms)
[113.104517] Starting subtest: async-flip-dpms
[113.230636] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.658090] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.424s)
[115.807714] Starting dynamic subtest: pipe-B-HDMI-A-1
[118.188754] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.389s)
[118.342610] Starting dynamic subtest: pipe-C-HDMI-A-1
[120.747119] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.411s)
[120.895075] Starting dynamic subtest: pipe-D-HDMI-A-1
[123.277887] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.389s)
[123.282720] Subtest async-flip-dpms: SUCCESS (10.179s)
[123.516894] [035/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[123.612439] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[126.090334] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.478s)
[126.194111] [036/133] (883s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[126.284649] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[126.286044] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[126.375649] [037/133] (883s left) gem_mmap_gtt (hang)
[126.409568] Starting subtest: hang
[131.851057] Subtest hang: SUCCESS (5.440s)
[131.946750] [038/133] (877s left) gem_media_fill (media-fill)
[131.991068] Starting subtest: media-fill
[131.991799] Starting dynamic subtest: smem
[131.996199] Dynamic subtest smem: SUCCESS (0.005s)
[131.996910] Subtest media-fill: SUCCESS (0.006s)
[132.204700] [039/133] (877s left) perf_pmu (semaphore-busy)
[132.245659] Starting subtest: semaphore-busy
[132.246359] Starting dynamic subtest: rcs0
[133.810870] Dynamic subtest rcs0: SUCCESS (1.556s)
[133.827022] Starting dynamic subtest: bcs0
[135.364527] Dynamic subtest bcs0: SUCCESS (1.552s)
[135.380778] Starting dynamic subtest: vcs0
[136.909975] Dynamic subtest vcs0: SUCCESS (1.553s)
[136.917990] Starting dynamic subtest: vcs1
[138.470755] Dynamic subtest vcs1: SUCCESS (1.551s)
[138.486445] Starting dynamic subtest: vecs0
[140.024602] Dynamic subtest vecs0: SUCCESS (1.552s)
[140.025578] Subtest semaphore-busy: SUCCESS (7.771s)
[140.107947] [040/133] (869s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[140.195695] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[140.197066] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[140.252537] [041/133] (869s left) i915_query (query-topology-kernel-writes)
[140.285462] Starting subtest: query-topology-kernel-writes
[140.286155] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[140.344754] [042/133] (869s left) i915_query (query-garbage)
[140.377525] Starting subtest: query-garbage
[140.378246] Subtest query-garbage: SUCCESS (0.000s)
[140.437274] [043/133] (869s left) kms_dsc (dsc-with-output-formats)
[140.521632] Starting subtest: dsc-with-output-formats
[140.528191] Subtest dsc-with-output-formats: SKIP (0.001s)
[140.588816] [044/133] (869s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[140.672853] Starting subtest: bad-aux-stride-y-tiled-ccs
[140.673533] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.679953] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[140.687395] Starting dynamic subtest: pipe-B-HDMI-A-1
[140.693916] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[140.701235] Starting dynamic subtest: pipe-C-HDMI-A-1
[140.707703] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[140.714910] Starting dynamic subtest: pipe-D-HDMI-A-1
[140.721482] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[140.722769] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[140.918680] [045/133] (868s left) gem_mmap_gtt (hang-user)
[140.954495] Starting subtest: hang-user
[177.276274] Subtest hang-user: SUCCESS (36.309s)
[177.393054] [046/133] (832s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[177.483266] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[177.484712] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[177.594490] [047/133] (832s left) kms_atomic_transition (modeset-transition-nonblocking)
[177.679158] Starting subtest: modeset-transition-nonblocking
[177.679923] Starting dynamic subtest: 1x-outputs
[178.885206] Dynamic subtest 1x-outputs: SUCCESS (1.207s)
[178.885952] Subtest modeset-transition-nonblocking: SUCCESS (1.207s)
[179.035104] [048/133] (830s left) kms_rotation_crc (primary-rotation-90)
[179.128679] Starting subtest: primary-rotation-90
[183.812027] Subtest primary-rotation-90: SUCCESS (4.683s)
[183.997554] [049/133] (826s left) kms_addfb_basic (bad-pitch-1024)
[184.032040] Starting subtest: bad-pitch-1024
[184.032763] Subtest bad-pitch-1024: SUCCESS (0.000s)
[184.190580] [050/133] (825s left) sw_sync (sync_multi_consumer)
[184.223113] Starting subtest: sync_multi_consumer
[184.762053] Subtest sync_multi_consumer: SUCCESS (0.530s)
[184.816743] [051/133] (825s left) syncobj_wait (invalid-reset-zero-handles)
[184.850433] Starting subtest: invalid-reset-zero-handles
[184.851131] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[184.915915] [052/133] (825s left) kms_hdr (static-toggle-suspend)
[184.999971] Starting subtest: static-toggle-suspend
[185.002048] Subtest static-toggle-suspend: SKIP (0.000s)
[185.062684] [053/133] (825s left) gem_softpin (allocator-fork)
[185.101424] Starting subtest: allocator-fork
[187.338983] Subtest allocator-fork: SUCCESS (2.229s)
[187.451359] [054/133] (822s left) gem_exec_params (no-bsd)
[187.487417] Starting subtest: no-bsd
[187.489043] Subtest no-bsd: SUCCESS (0.001s)
[187.581657] [055/133] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[187.671703] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[187.673101] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[187.763909] [056/133] (822s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[187.848143] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[187.849565] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[187.913519] [057/133] (822s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[187.999831] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[188.001192] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[188.053602] [058/133] (822s left) i915_hangman (engine-error-state-capture)
[188.095380] Starting subtest: engine-error-state-capture
[188.096125] Starting dynamic subtest: rcs0
[192.383602] Dynamic subtest rcs0: SUCCESS (4.288s)
[192.395112] Starting dynamic subtest: bcs0
[196.418594] Dynamic subtest bcs0: SUCCESS (4.033s)
[196.430062] Starting dynamic subtest: vcs0
[200.392736] Dynamic subtest vcs0: SUCCESS (3.972s)
[200.406621] Starting dynamic subtest: vcs1
[204.418755] Dynamic subtest vcs1: SUCCESS (4.024s)
[204.431122] Starting dynamic subtest: vecs0
[208.384664] Dynamic subtest vecs0: SUCCESS (3.964s)
[208.385612] Subtest engine-error-state-capture: SUCCESS (20.289s)
[208.456255] [059/133] (801s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[208.546517] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[208.547840] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[208.634716] [060/133] (801s left) gem_exec_schedule (manyslice)
[208.678147] Starting subtest: manyslice
[208.678889] Starting dynamic subtest: rcs0
[208.937103] Dynamic subtest rcs0: SUCCESS (0.250s)
[208.945567] Starting dynamic subtest: bcs0
[209.244877] Dynamic subtest bcs0: SUCCESS (0.306s)
[209.254229] Starting dynamic subtest: vcs0
[209.576726] Dynamic subtest vcs0: SUCCESS (0.340s)
[209.585711] Starting dynamic subtest: vcs1
[209.922288] Dynamic subtest vcs1: SUCCESS (0.336s)
[209.930197] Starting dynamic subtest: vecs0
[210.267104] Dynamic subtest vecs0: SUCCESS (0.344s)
[210.267800] Subtest manyslice: SUCCESS (1.581s)
[210.551823] [061/133] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[210.641323] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[210.642710] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[210.745907] [062/133] (799s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[210.840073] Starting subtest: x-tiled-64bpp-rotate-180
[212.191914] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.352s)
[212.315061] [063/133] (798s left) kms_atomic_interruptible (legacy-setmode)
[212.403588] Starting subtest: legacy-setmode
[212.405518] Starting dynamic subtest: pipe-A-HDMI-A-1
[218.624759] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.219s)
[218.625435] Subtest legacy-setmode: SUCCESS (6.221s)
[218.777960] [064/133] (791s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[218.868693] Starting subtest: cursor-vs-flip-legacy
[248.527755] Subtest cursor-vs-flip-legacy: SUCCESS (29.657s)
[248.654640] [065/133] (761s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[248.750706] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[248.752108] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[248.856561] [066/133] (761s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[248.891267] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[248.892289] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[248.962393] [067/133] (761s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[249.047866] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[249.067831] Starting dynamic subtest: pipe-A-plane-0
[249.551403] Dynamic subtest pipe-A-plane-0: SUCCESS (0.483s)
[249.567341] Starting dynamic subtest: pipe-A-plane-3
[249.984718] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[249.998417] Starting dynamic subtest: pipe-A-plane-5
[250.293143] Dynamic subtest pipe-A-plane-5: SUCCESS (0.307s)
[250.424918] Starting dynamic subtest: pipe-B-plane-0
[250.884882] Dynamic subtest pipe-B-plane-0: SUCCESS (0.467s)
[250.898406] Starting dynamic subtest: pipe-B-plane-3
[251.301558] Dynamic subtest pipe-B-plane-3: SUCCESS (0.415s)
[251.317172] Starting dynamic subtest: pipe-B-plane-5
[251.610154] Dynamic subtest pipe-B-plane-5: SUCCESS (0.307s)
[251.666623] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (2.617s)
[251.835462] [068/133] (758s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[251.927362] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[251.972604] [069/133] (758s left) kms_cursor_crc (cursor-offscreen-32x10)
[252.060957] Starting subtest: cursor-offscreen-32x10
[252.114150] Subtest cursor-offscreen-32x10: SKIP (0.051s)
[252.190608] [070/133] (758s left) drm_read (short-buffer-nonblock)
[252.298564] Starting subtest: short-buffer-nonblock
[252.299281] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[252.410210] [071/133] (758s left) kms_flip (dpms-vs-vblank-race-interruptible)
[252.501246] Starting subtest: dpms-vs-vblank-race-interruptible
[252.504045] Starting dynamic subtest: A-HDMI-A1
[255.282805] Dynamic subtest A-HDMI-A1: SUCCESS (2.778s)
[255.291715] Starting dynamic subtest: B-HDMI-A1
[258.063835] Dynamic subtest B-HDMI-A1: SUCCESS (2.780s)
[258.075629] Starting dynamic subtest: C-HDMI-A1
[260.884415] Dynamic subtest C-HDMI-A1: SUCCESS (2.818s)
[260.894643] Starting dynamic subtest: D-HDMI-A1
[263.726503] Dynamic subtest D-HDMI-A1: SUCCESS (2.842s)
[263.728658] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.227s)
[263.883990] [072/133] (747s left) kms_chamelium_edid (hdmi-edid-read)
[264.040411] Subtest hdmi-edid-read: SKIP (0.000s)
[264.130336] [073/133] (746s left) syncobj_timeline (invalid-signal-illegal-handle)
[264.168870] Starting subtest: invalid-signal-illegal-handle
[264.169576] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[264.231627] [074/133] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[264.323740] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[264.325109] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[264.423320] [075/133] (746s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[264.514707] Starting subtest: psr-2p-pri-indfb-multidraw
[264.516047] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[264.603992] [076/133] (746s left) syncobj_timeline (wait-any-interrupted)
[264.639706] Starting subtest: wait-any-interrupted
[264.740706] Subtest wait-any-interrupted: SUCCESS (0.101s)
[264.815647] [077/133] (746s left) kms_psr (psr-sprite-plane-move)
[264.901798] Subtest psr-sprite-plane-move: SKIP (0.000s)
[264.941864] [078/133] (746s left) gem_exec_balancer (parallel-bb-first)
[265.098755] Subtest parallel-bb-first: SKIP (0.000s)
[265.164746] [079/133] (746s left) sw_sync (sync_multi_producer_single_consumer)
[265.196170] Starting subtest: sync_multi_producer_single_consumer
[266.278665] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[266.320054] [080/133] (744s left) syncobj_timeline (device-signal-unordered)
[266.353253] Starting subtest: device-signal-unordered
[266.355140] Subtest device-signal-unordered: SUCCESS (0.001s)
[266.430100] [081/133] (744s left) core_auth (getclient-master-drop)
[266.462031] Starting subtest: getclient-master-drop
[266.463522] Subtest getclient-master-drop: SUCCESS (0.002s)
[266.521726] [082/133] (744s left) gem_mmap_gtt (basic-copy)
[266.555463] Starting subtest: basic-copy
[267.029777] Subtest basic-copy: SUCCESS (0.467s)
[267.099959] [083/133] (744s left) kms_addfb_basic (bad-pitch-65536)
[267.133854] Starting subtest: bad-pitch-65536
[267.134544] Subtest bad-pitch-65536: SUCCESS (0.000s)
[267.280040] [084/133] (744s left) gem_exec_whisper (basic-fds)
[267.322183] Starting subtest: basic-fds
[270.228009] Subtest basic-fds: SUCCESS (2.905s)
[270.408630] [085/133] (741s left) gem_exec_reloc (basic-concurrent0)
[270.446619] Starting subtest: basic-concurrent0
[275.877185] Subtest basic-concurrent0: SUCCESS (5.400s)
[275.964485] [086/133] (735s left) gen7_exec_parse (chained-batch)
[276.001931] Subtest chained-batch: SKIP (0.000s)
[276.042417] [087/133] (735s left) gem_exec_fence (basic-busy-all)
[276.084125] Starting subtest: basic-busy-all
[276.122445] Subtest basic-busy-all: SUCCESS (0.038s)
[276.725739] [088/133] (734s left) kms_cursor_crc (cursor-random-128x128)
[276.814164] Starting subtest: cursor-random-128x128
[276.818755] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.722437] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.903s)
[278.758322] Starting dynamic subtest: pipe-D-HDMI-A-1
[280.628470] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.877s)
[280.629220] Subtest cursor-random-128x128: SUCCESS (3.815s)
[280.779713] [089/133] (730s left) vgem_basic (dmabuf-export)
[280.823559] Starting subtest: dmabuf-export
[280.844810] Subtest dmabuf-export: SUCCESS (0.022s)
[280.953263] [090/133] (730s left) i915_pm_rpm (gem-evict-pwrite)
[282.352229] Starting subtest: gem-evict-pwrite
[283.634367] Subtest gem-evict-pwrite: SUCCESS (1.283s)
[283.814231] [091/133] (727s left) syncobj_wait (wait-all-complex)
[283.851245] Starting subtest: wait-all-complex
[284.074560] Subtest wait-all-complex: SUCCESS (0.215s)
[284.141557] [092/133] (727s left) kms_busy (extended-pageflip-hang-oldfb)
[284.231538] Starting subtest: extended-pageflip-hang-oldfb
[284.233833] Starting dynamic subtest: pipe-A
[284.357972] Dynamic subtest pipe-A: SUCCESS (0.124s)
[284.370378] Starting dynamic subtest: pipe-D
[284.502943] Dynamic subtest pipe-D: SUCCESS (0.142s)
[284.503765] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.272s)
[284.624692] [093/133] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[284.716712] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[284.718079] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[284.825828] [094/133] (726s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[284.920261] Starting subtest: yf-tiled-addfb-size-overflow
[284.921663] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[285.014111] [095/133] (726s left) gem_ctx_create (basic)
[285.054864] Starting subtest: basic
[285.055537] Subtest basic: SUCCESS (0.000s)
[285.241610] [096/133] (726s left) gem_exec_reloc (basic-write-read)
[285.279137] Starting subtest: basic-write-read
[285.285021] Subtest basic-write-read: SUCCESS (0.006s)
[285.396537] [097/133] (726s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[285.484271] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[285.526952] [098/133] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[285.617591] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[285.618919] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[285.705453] [099/133] (726s left) kms_cursor_crc (cursor-tearing-position-change)
[285.792992] Starting subtest: cursor-tearing-position-change
[285.793687] Starting dynamic subtest: pipe-A-HDMI-A-1
[286.043476] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.249s)
[286.052900] Starting dynamic subtest: pipe-D-HDMI-A-1
[286.271383] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.226s)
[286.273173] Subtest cursor-tearing-position-change: SUCCESS (0.480s)
[286.437720] [100/133] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[286.529116] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[286.530514] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[286.613593] [101/133] (725s left) kms_big_fb (linear-64bpp-rotate-270)
[286.709264] Starting subtest: linear-64bpp-rotate-270
[286.756208] Subtest linear-64bpp-rotate-270: SKIP (0.046s)
[286.859625] [102/133] (725s left) gem_ctx_persistence (smoketest)
[286.901933] Starting subtest: smoketest
[325.216441] Subtest smoketest: SUCCESS (38.314s)
[325.300901] [103/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[325.398280] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[325.399713] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[325.483467] [104/133] (686s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[325.575661] Starting subtest: psr-rgb565-draw-pwrite
[325.576979] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[325.664034] [105/133] (686s left) template (b)
[325.696980] Starting subtest: B
[325.697717] Subtest B: SUCCESS (0.000s)
[325.771467] [106/133] (686s left) kms_lease (simple-lease)
[325.859172] Starting subtest: simple-lease
[325.861398] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.086167] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.225s)
[326.097319] Starting dynamic subtest: pipe-B-HDMI-A-1
[326.283428] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.194s)
[326.292428] Starting dynamic subtest: pipe-C-HDMI-A-1
[326.485641] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.199s)
[326.524147] Starting dynamic subtest: pipe-D-HDMI-A-1
[326.684856] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.197s)
[326.685566] Subtest simple-lease: SUCCESS (0.826s)
[326.795507] [107/133] (685s left) gem_exec_params (sol-reset-invalid)
[326.835873] Starting subtest: sol-reset-invalid
[326.838166] Subtest sol-reset-invalid: SUCCESS (0.001s)
[326.940991] [108/133] (685s left) gem_pxp (create-regular-context-2)
[327.043032] Starting subtest: create-regular-context-2
[327.043962] Subtest create-regular-context-2: SUCCESS (0.001s)
[327.116162] [109/133] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[327.205769] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[327.207135] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[327.300725] [110/133] (685s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[327.385981] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[327.387760] Starting dynamic subtest: pipe-A-valid-mode
[328.527466] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.140s)
[328.529275] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.143s)
[328.678552] [111/133] (683s left) gem_reg_read (timestamp-moving)
[328.718931] Starting subtest: timestamp-moving
[329.728581] Subtest timestamp-moving: SUCCESS (1.001s)
[329.797796] [112/133] (682s left) kms_flip (absolute-wf_vblank)
[329.887077] Starting subtest: absolute-wf_vblank
[329.889191] Starting dynamic subtest: A-HDMI-A1
[337.578523] Dynamic subtest A-HDMI-A1: SUCCESS (7.683s)
[337.596949] Starting dynamic subtest: B-HDMI-A1
[345.257530] Dynamic subtest B-HDMI-A1: SUCCESS (7.652s)
[345.264915] Starting dynamic subtest: C-HDMI-A1
[352.911721] Dynamic subtest C-HDMI-A1: SUCCESS (7.652s)
[352.924467] Starting dynamic subtest: D-HDMI-A1
[360.574680] Dynamic subtest D-HDMI-A1: SUCCESS (7.669s)
[360.575578] Subtest absolute-wf_vblank: SUCCESS (30.666s)
[360.722405] [113/133] (651s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[360.817737] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[362.076636] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.259s)
[362.189367] [114/133] (650s left) perf_pmu (faulting-read)
[362.226445] Starting subtest: faulting-read
[362.227176] Starting dynamic subtest: gtt
[362.229175] Dynamic subtest gtt: SUCCESS (0.001s)
[362.237225] Starting dynamic subtest: wb
[362.237903] Dynamic subtest wb: SUCCESS (0.001s)
[362.245973] Starting dynamic subtest: wc
[362.246707] Dynamic subtest wc: SUCCESS (0.000s)
[362.254239] Starting dynamic subtest: uc
[362.254902] Dynamic subtest uc: SUCCESS (0.000s)
[362.255575] Subtest faulting-read: SUCCESS (0.007s)
[362.317721] [115/133] (650s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[362.406357] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[362.407093] Starting dynamic subtest: pipe-A
[362.527855] Dynamic subtest pipe-A: SUCCESS (0.122s)
[362.544932] Starting dynamic subtest: pipe-B
[362.670264] Dynamic subtest pipe-B: SUCCESS (0.141s)
[362.687427] Starting dynamic subtest: pipe-C
[362.803902] Dynamic subtest pipe-C: SUCCESS (0.132s)
[362.813507] Starting dynamic subtest: pipe-D
[362.955381] Dynamic subtest pipe-D: SUCCESS (0.150s)
[362.957118] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.551s)
[363.135100] [116/133] (649s left) gem_exec_balancer (parallel-out-fence)
[363.297717] Subtest parallel-out-fence: SKIP (0.000s)
[363.363053] [117/133] (649s left) perf_pmu (busy-double-start)
[363.398421] Starting subtest: busy-double-start
[363.399119] Starting dynamic subtest: rcs0
[366.939662] Dynamic subtest rcs0: SUCCESS (3.540s)
[366.950746] Starting dynamic subtest: bcs0
[370.485596] Dynamic subtest bcs0: SUCCESS (3.544s)
[370.497732] Starting dynamic subtest: vcs0
[374.027549] Dynamic subtest vcs0: SUCCESS (3.540s)
[374.038755] Starting dynamic subtest: vcs1
[377.578661] Dynamic subtest vcs1: SUCCESS (3.549s)
[377.590888] Starting dynamic subtest: vecs0
[381.123462] Dynamic subtest vecs0: SUCCESS (3.542s)
[381.124456] Subtest busy-double-start: SUCCESS (17.725s)
[381.193686] [118/133] (631s left) i915_suspend (basic-s3-without-i915)
[381.226078] Starting subtest: basic-s3-without-i915