[62.807598] Initializing watchdogs
[62.807664]   /dev/watchdog0
[62.826709] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.837140] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.841187] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.843610] [001/134] (960s left) gem_flink_basic (double-flink)
[62.916210] Starting subtest: double-flink
[62.917127] Subtest double-flink: SUCCESS (0.000s)
[63.086947] [002/134] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[63.281826] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[63.283439] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[63.457025] [003/134] (960s left) gem_pxp (regular-baseline-src-copy-readible)
[66.055846] Starting subtest: regular-baseline-src-copy-readible
[66.058896] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[66.195516] [004/134] (957s left) gem_create (create-size-update)
[66.261203] Starting subtest: create-size-update
[66.262146] Subtest create-size-update: SUCCESS (0.000s)
[66.562507] [005/134] (957s left) gem_mmap_gtt (close-race)
[66.629008] Subtest close-race: SKIP (0.000s)
[66.689917] [006/134] (956s left) syncobj_timeline (reset-signaled)
[66.825180] Starting subtest: reset-signaled
[66.826121] Subtest reset-signaled: SUCCESS (0.000s)
[67.213212] [007/134] (956s left) sw_sync (sync_multi_consumer)
[67.305699] Starting subtest: sync_multi_consumer
[67.938389] Subtest sync_multi_consumer: SUCCESS (0.635s)
[68.017706] [008/134] (955s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[68.206345] Starting subtest: fbc-rgb565-draw-mmap-gtt
[68.208028] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[68.392802] [009/134] (955s left) kms_cursor_crc (cursor-sliding-32x10)
[68.696540] Starting subtest: cursor-sliding-32x10
[68.746617] Subtest cursor-sliding-32x10: SKIP (0.048s)
[69.190331] [010/134] (954s left) kms_cursor_crc (cursor-onscreen-32x32)
[69.461543] Starting subtest: cursor-onscreen-32x32
[69.510978] Subtest cursor-onscreen-32x32: SKIP (0.047s)
[69.956255] [011/134] (954s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[70.138581] Starting subtest: psr-indfb-scaledprimary
[70.140268] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[70.294833] [012/134] (953s left) kms_pipe_crc_basic (bad-source)
[70.475008] Starting subtest: bad-source
[70.475937] Subtest bad-source: SUCCESS (0.000s)
[70.624992] [013/134] (953s left) kms_plane (plane-panning-bottom-right)
[70.801969] Starting subtest: plane-panning-bottom-right
[70.802921] Starting dynamic subtest: pipe-A
[71.603558] Dynamic subtest pipe-A: SUCCESS (0.801s)
[71.614659] Starting dynamic subtest: pipe-B
[72.264135] Dynamic subtest pipe-B: SUCCESS (0.660s)
[72.265084] Subtest plane-panning-bottom-right: SUCCESS (1.464s)
[72.545611] [014/134] (951s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[72.614936] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[72.615858] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[72.795575] [015/134] (951s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[72.976560] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[72.978201] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[73.123922] [016/134] (951s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[73.302220] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[73.303145] Starting dynamic subtest: pipe-A-DP-3
[73.311296] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[73.318804] Starting dynamic subtest: pipe-B-DP-3
[73.326995] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[73.334378] Starting dynamic subtest: pipe-C-DP-3
[73.342524] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[73.349876] Starting dynamic subtest: pipe-D-DP-3
[73.358514] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[73.360493] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[73.769977] [017/134] (950s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[73.949331] Starting subtest: basic-max-pipe-crc-check
[73.952950] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[73.996124] [018/134] (950s left) gem_exec_reloc (basic-cpu)
[74.070784] Subtest basic-cpu: SKIP (0.000s)
[74.150353] [019/134] (950s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[74.329358] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[74.330258] Starting dynamic subtest: pipe-A-DP-3
[74.338796] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[74.346368] Starting dynamic subtest: pipe-B-DP-3
[74.354702] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[74.362133] Starting dynamic subtest: pipe-C-DP-3
[74.370234] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[74.377398] Starting dynamic subtest: pipe-D-DP-3
[74.386057] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[74.388115] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[74.812933] [020/134] (949s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[75.076472] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[75.219237] [021/134] (949s left) gem_ctx_persistence (legacy-engines-hostile)
[75.302499] Starting subtest: legacy-engines-hostile
[75.303396] Starting dynamic subtest: render
[75.459727] Dynamic subtest render: SUCCESS (0.157s)
[75.481528] Starting dynamic subtest: bsd1
[75.510133] Dynamic subtest bsd1: SUCCESS (0.049s)
[75.542772] Starting dynamic subtest: bsd2
[75.575539] Dynamic subtest bsd2: SUCCESS (0.064s)
[75.596220] Starting dynamic subtest: blt
[75.632353] Dynamic subtest blt: SUCCESS (0.055s)
[75.665233] Starting dynamic subtest: vebox
[75.689581] Dynamic subtest vebox: SUCCESS (0.056s)
[75.691075] Subtest legacy-engines-hostile: SUCCESS (0.387s)
[75.895730] [022/134] (948s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[76.078875] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[76.079742] Starting dynamic subtest: pipe-A-DP-3
[76.087957] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[76.095507] Starting dynamic subtest: pipe-B-DP-3
[76.103867] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[76.111369] Starting dynamic subtest: pipe-C-DP-3
[76.119550] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[76.126959] Starting dynamic subtest: pipe-D-DP-3
[76.135296] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[76.137177] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[76.534736] [023/134] (948s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[76.708477] Starting subtest: plane-upscale-20x20-with-rotation
[76.709315] Starting dynamic subtest: pipe-A
[77.090839] Dynamic subtest pipe-A: SUCCESS (0.382s)
[77.105926] Starting dynamic subtest: pipe-B
[77.570425] Dynamic subtest pipe-B: SUCCESS (0.479s)
[77.580626] Starting dynamic subtest: pipe-C
[78.035729] Dynamic subtest pipe-C: SUCCESS (0.465s)
[78.048399] Starting dynamic subtest: pipe-D
[78.497773] Dynamic subtest pipe-D: SUCCESS (0.461s)
[78.498871] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.789s)
[78.856753] [024/134] (946s left) gem_exec_fence (syncobj-wait)
[79.404950] Starting subtest: syncobj-wait
[79.522696] Subtest syncobj-wait: SUCCESS (0.118s)
[79.972169] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[79.973836] [025/134] (945s left) gem_exec_fence (keep-in-fence)
[80.186102] Starting subtest: keep-in-fence
[80.187060] Starting dynamic subtest: rcs0
[80.285457] Dynamic subtest rcs0: SUCCESS (0.103s)
[80.296218] Starting dynamic subtest: bcs0
[80.339431] Dynamic subtest bcs0: SUCCESS (0.053s)
[80.354655] Starting dynamic subtest: vcs0
[80.399293] Dynamic subtest vcs0: SUCCESS (0.059s)
[80.411142] Starting dynamic subtest: vcs1
[80.457423] Dynamic subtest vcs1: SUCCESS (0.057s)
[80.469858] Starting dynamic subtest: vecs0
[80.511589] Dynamic subtest vecs0: SUCCESS (0.053s)
[80.545079] Starting dynamic subtest: vecs1
[80.588524] Dynamic subtest vecs1: SUCCESS (0.076s)
[80.605385] Starting dynamic subtest: ccs0
[80.812195] Dynamic subtest ccs0: SUCCESS (0.223s)
[80.813328] Subtest keep-in-fence: SUCCESS (0.630s)
[81.573194] [026/134] (943s left) gem_exec_reloc (basic-wc-read)
[81.656518] Subtest basic-wc-read: SKIP (0.000s)
[81.738534] [027/134] (943s left) kms_content_protection (content-type-change)
[81.990768] Starting subtest: content-type-change
[81.996450] Subtest content-type-change: SKIP (0.003s)
[82.206609] [028/134] (943s left) gem_exec_schedule (preemptive-hang)
[82.429216] Starting subtest: preemptive-hang
[82.430218] Starting dynamic subtest: rcs0
[92.145416] Dynamic subtest rcs0: SUCCESS (9.735s)
[92.153776] Starting dynamic subtest: bcs0
[101.102203] Dynamic subtest bcs0: SUCCESS (8.955s)
[101.110365] Starting dynamic subtest: vcs0
[110.132256] Dynamic subtest vcs0: SUCCESS (9.030s)
[110.140438] Starting dynamic subtest: vcs1
[119.159415] Dynamic subtest vcs1: SUCCESS (9.026s)
[119.167722] Starting dynamic subtest: vecs0
[128.126192] Dynamic subtest vecs0: SUCCESS (8.966s)
[128.134473] Starting dynamic subtest: vecs1
[137.141370] Dynamic subtest vecs1: SUCCESS (9.014s)
[137.149556] Starting dynamic subtest: ccs0
[146.164158] Dynamic subtest ccs0: SUCCESS (9.022s)
[146.164992] Subtest preemptive-hang: SUCCESS (63.751s)
[146.482591] [029/134] (878s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.666153] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.666983] Starting dynamic subtest: pipe-A-valid-mode
[148.517818] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.851s)
[148.519281] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.853s)
[148.820640] [030/134] (876s left) syncobj_timeline (wait-for-submit-snapshot)
[148.896404] Starting subtest: wait-for-submit-snapshot
[148.980641] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[149.116533] [031/134] (876s left) syncobj_wait (single-wait-all-submitted)
[149.193086] Starting subtest: single-wait-all-submitted
[149.301756] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[149.435380] [032/134] (876s left) gen9_exec_parse (unaligned-access)
[149.520417] Subtest unaligned-access: SKIP (0.000s)
[149.598130] [033/134] (875s left) gem_userptr_blits (unsync-overlap)
[149.694882] Subtest unsync-overlap: SKIP (0.000s)
[149.922605] [034/134] (875s left) kms_flip (dpms-vs-vblank-race-interruptible)
[150.110561] Starting subtest: dpms-vs-vblank-race-interruptible
[150.115048] Starting dynamic subtest: A-DP3
[153.350105] Dynamic subtest A-DP3: SUCCESS (3.234s)
[153.371027] Starting dynamic subtest: B-DP3
[156.379924] Dynamic subtest B-DP3: SUCCESS (3.027s)
[156.388514] Starting dynamic subtest: C-DP3
[159.427212] Dynamic subtest C-DP3: SUCCESS (3.046s)
[159.435648] Starting dynamic subtest: D-DP3
[162.392323] Dynamic subtest D-DP3: SUCCESS (2.964s)
[162.393214] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.282s)
[162.704696] [035/134] (863s left) kms_vblank (wait-busy)
[162.898590] Starting subtest: wait-busy
[162.900637] Starting dynamic subtest: pipe-A-DP-3
[165.398515] Dynamic subtest pipe-A-DP-3: SUCCESS (2.498s)
[165.415030] Starting dynamic subtest: pipe-D-DP-3
[167.830545] Dynamic subtest pipe-D-DP-3: SUCCESS (2.425s)
[167.831440] Subtest wait-busy: SUCCESS (4.931s)
[168.114265] [036/134] (857s left) gen9_exec_parse (bb-start-out)
[168.198109] Subtest bb-start-out: SKIP (0.000s)
[168.290975] [037/134] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[168.484887] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[168.486526] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[168.688358] [038/134] (857s left) i915_hangman (gt-engine-error)
[168.783964] Starting subtest: gt-engine-error
[168.784886] Starting dynamic subtest: rcs0
[169.644854] Dynamic subtest rcs0: SUCCESS (0.861s)
[169.658485] Starting dynamic subtest: bcs0
[170.455327] Dynamic subtest bcs0: SUCCESS (0.809s)
[170.463828] Starting dynamic subtest: vcs0
[171.260350] Dynamic subtest vcs0: SUCCESS (0.804s)
[171.268998] Starting dynamic subtest: vcs1
[172.092713] Dynamic subtest vcs1: SUCCESS (0.831s)
[172.105352] Starting dynamic subtest: vecs0
[172.930558] Dynamic subtest vecs0: SUCCESS (0.837s)
[172.942383] Starting dynamic subtest: vecs1
[173.770785] Dynamic subtest vecs1: SUCCESS (0.839s)
[173.783636] Starting dynamic subtest: ccs0
[174.611442] Dynamic subtest ccs0: SUCCESS (0.839s)
[174.612393] Subtest gt-engine-error: SUCCESS (5.829s)
[174.796529] [039/134] (851s left) perf (gen12-group-exclusive-stream-ctx-handle)
[175.169178] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[175.196166] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[175.244111] [040/134] (850s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[175.484999] Starting subtest: 4-tiled-16bpp-rotate-270
[175.549902] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.064s)
[175.777936] [041/134] (850s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[175.976925] Starting subtest: fbcpsr-suspend
[175.978704] Subtest fbcpsr-suspend: SKIP (0.000s)
[176.180533] [042/134] (850s left) i915_suspend (fence-restore-tiled2untiled)
[176.269257] Starting subtest: fence-restore-tiled2untiled
[176.271009] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[176.461539] [043/134] (849s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[176.538484] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[176.646038] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[176.816219] [044/134] (849s left) prime_self_import (basic-with_one_bo_two_files)
[176.861657] Starting subtest: basic-with_one_bo_two_files
[176.915171] Subtest basic-with_one_bo_two_files: SUCCESS (0.053s)
[177.116479] [045/134] (849s left) kms_pm_rpm (legacy-planes)
[179.028474] Starting subtest: legacy-planes
[179.029481] Starting dynamic subtest: plane-64
[181.852508] Dynamic subtest plane-64: SUCCESS (2.822s)
[181.891581] Starting dynamic subtest: plane-94
[184.678233] Dynamic subtest plane-94: SUCCESS (2.821s)
[184.718067] Starting dynamic subtest: plane-124
[187.508469] Dynamic subtest plane-124: SUCCESS (2.825s)
[187.547872] Starting dynamic subtest: plane-134
[190.302217] Dynamic subtest plane-134: SUCCESS (2.787s)
[190.304110] Subtest legacy-planes: SUCCESS (11.275s)
[190.759354] [046/134] (835s left) gem_mmap_gtt (fault-concurrent-y)
[190.836150] Subtest fault-concurrent-Y: SKIP (0.000s)
[190.901306] [047/134] (835s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[191.087300] Starting subtest: basic-busy-flip-before-cursor-atomic
[191.089061] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[191.207948] [048/134] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[191.399268] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[191.400993] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[191.589789] [049/134] (835s left) kms_psr (pr-sprite-blt)
[191.776290] Subtest pr-sprite-blt: SKIP (0.000s)
[191.835457] [050/134] (834s left) kms_plane_multiple (tiling-y)
[192.023963] Starting subtest: tiling-y
[192.025837] Subtest tiling-y: SKIP (0.000s)
[192.171854] [051/134] (834s left) gem_exec_params (rel-constants-invalid)
[192.251967] Starting subtest: rel-constants-invalid
[192.252904] Subtest rel-constants-invalid: SUCCESS (0.000s)
[192.456573] [052/134] (834s left) dmabuf_sync_file (export-basic)
[192.512251] Starting subtest: export-basic
[192.513206] Subtest export-basic: SUCCESS (0.001s)
[192.607943] [053/134] (834s left) gem_madvise (dontneed-before-mmap)
[192.656155] Starting subtest: dontneed-before-mmap
[192.702293] Subtest dontneed-before-mmap: SUCCESS (0.047s)
[192.858651] [054/134] (834s left) kms_flip (2x-blocking-absolute-wf_vblank)
[193.039659] Starting subtest: 2x-blocking-absolute-wf_vblank
[193.055248] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.015s)
[193.203515] [055/134] (833s left) kms_psr (fbc-psr-primary-mmap-gtt)
[193.389679] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[193.451710] [056/134] (833s left) kms_fbcon_fbt (psr-suspend)
[193.534288] Starting subtest: psr-suspend
[193.536026] Subtest psr-suspend: SKIP (0.000s)
[193.737541] [057/134] (833s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[193.924593] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[193.960650] Starting dynamic subtest: pipe-A-plane-0
[193.962412] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[193.971229] Starting dynamic subtest: pipe-A-plane-3
[193.973629] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[193.981997] Starting dynamic subtest: pipe-A-plane-5
[193.983827] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[194.187757] Starting dynamic subtest: pipe-B-plane-0
[194.190090] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[194.203499] Starting dynamic subtest: pipe-B-plane-3
[194.205490] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[194.218396] Starting dynamic subtest: pipe-B-plane-5
[194.220323] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[194.269333] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.343s)
[194.555836] [058/134] (832s left) api_intel_bb (object-noreloc-purge-cache-simple)
[194.633488] Starting subtest: object-noreloc-purge-cache-simple
[194.662085] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.029s)
[194.871520] [059/134] (832s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[195.056300] Starting subtest: psr-dirtyfb-ioctl
[195.061523] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[195.235632] [060/134] (832s left) kms_flip (flip-vs-panning-vs-hang)
[195.422703] Starting subtest: flip-vs-panning-vs-hang
[195.425389] Starting dynamic subtest: A-DP3
[246.529558] Dynamic subtest A-DP3: SUCCESS (51.103s)
[246.539764] Starting dynamic subtest: D-DP3
[296.498865] Dynamic subtest D-DP3: SUCCESS (49.966s)
[296.501206] Subtest flip-vs-panning-vs-hang: SUCCESS (101.074s)
[296.847105] [061/134] (730s left) kms_big_fb (linear-64bpp-rotate-270)
[297.041434] Starting subtest: linear-64bpp-rotate-270
[297.097063] Subtest linear-64bpp-rotate-270: SKIP (0.055s)
[297.332075] [062/134] (730s left) gem_mmap_wc (copy)
[297.411179] Subtest copy: SKIP (0.000s)
[297.494084] [063/134] (730s left) kms_flip (flip-vs-absolute-wf_vblank)
[297.681656] Starting subtest: flip-vs-absolute-wf_vblank
[297.685010] Starting dynamic subtest: A-DP3
[305.807949] Dynamic subtest A-DP3: SUCCESS (8.122s)
[305.819314] Starting dynamic subtest: B-DP3
[313.863122] Dynamic subtest B-DP3: SUCCESS (8.053s)
[313.874197] Starting dynamic subtest: C-DP3
[321.903110] Dynamic subtest C-DP3: SUCCESS (8.038s)
[321.913621] Starting dynamic subtest: D-DP3
[329.958931] Dynamic subtest D-DP3: SUCCESS (8.054s)
[329.961285] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.279s)
[330.307816] [064/134] (697s left) gem_exec_nop (basic-sequential)
[330.395763] Starting subtest: basic-sequential
[334.870387] Subtest basic-sequential: SUCCESS (4.473s)
[335.181058] [065/134] (692s left) gem_workarounds (suspend-resume)
[335.278371] Starting subtest: suspend-resume
[354.505707] Subtest suspend-resume: SUCCESS (3.783s)
[354.624491] [066/134] (673s left) gem_exec_reloc (basic-cpu-gtt-active)
[354.733219] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[354.829001] [067/134] (673s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[355.023774] Starting subtest: yf-tiled-8bpp-rotate-270
[355.025656] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[355.225931] [068/134] (672s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[355.420754] Starting subtest: fbc-rgb101010-draw-pwrite
[358.308760] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.888s)
[358.527197] [069/134] (669s left) gem_softpin (allocator-basic)
[358.612708] Starting subtest: allocator-basic
[358.842200] Subtest allocator-basic: SUCCESS (0.229s)
[359.076997] [070/134] (669s left) syncobj_basic (bad-fd-to-handle)
[359.152881] Starting subtest: bad-fd-to-handle
[359.153816] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[359.296133] [071/134] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[359.485818] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[359.487471] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[359.691515] [072/134] (668s left) gem_fenced_exec_thrash (2-spare-fences)
[359.773749] Subtest 2-spare-fences: SKIP (0.000s)
[359.887487] [073/134] (668s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[360.074642] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[360.076430] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[360.277457] [074/134] (668s left) gem_partial_pwrite_pread (reads)
[360.361930] Subtest reads: SKIP (0.000s)
[360.434453] [075/134] (668s left) kms_properties (invalid-properties-atomic)
[360.616202] Starting subtest: invalid-properties-atomic
[361.084172] Subtest invalid-properties-atomic: SUCCESS (0.468s)
[361.245693] [076/134] (667s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[361.438047] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[361.502762] [077/134] (667s left) i915_pm_rps (reset)
[361.592788] Starting subtest: reset
[366.392134] Subtest reset: SUCCESS (4.798s)
[366.627632] [078/134] (662s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[366.703935] Starting subtest: multi-wait-all-available-submitted-signaled
[366.704843] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[366.847751] [079/134] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[367.050740] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[367.052454] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[367.212144] [080/134] (661s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[367.406825] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[367.408574] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[367.593865] [081/134] (661s left) gem_exec_balancer (hang)
[367.936335] Starting subtest: hang
[371.415862] Subtest hang: SUCCESS (3.481s)
[371.625031] [082/134] (657s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[371.817944] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[371.822811] Starting dynamic subtest: A-DP3
[372.737108] Dynamic subtest A-DP3: SUCCESS (0.913s)
[372.749906] Starting dynamic subtest: B-DP3
[373.460525] Dynamic subtest B-DP3: SUCCESS (0.723s)
[373.472043] Starting dynamic subtest: C-DP3
[374.153587] Dynamic subtest C-DP3: SUCCESS (0.692s)
[374.165120] Starting dynamic subtest: D-DP3
[374.879279] Dynamic subtest D-DP3: SUCCESS (0.724s)
[374.881561] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.063s)
[375.170246] [083/134] (654s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[375.367961] Starting subtest: yf-tiled-16bpp-rotate-0
[375.369734] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[375.539946] [084/134] (653s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[375.732704] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[375.734856] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[375.931676] [085/134] (653s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[376.122520] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[376.124134] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[376.315253] [086/134] (653s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[376.504416] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[376.506694] Starting dynamic subtest: pipe-A-valid-mode
[376.638741] Dynamic subtest pipe-A-valid-mode: SKIP (0.132s)
[376.640470] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.134s)
[376.943534] [087/134] (652s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[377.135964] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[377.185099] [088/134] (652s left) gem_exec_await (wide-contexts)
[377.475947] Starting subtest: wide-contexts
[399.653166] Subtest wide-contexts: SUCCESS (22.180s)
[399.946100] [089/134] (629s left) perf_pmu (most-busy-idle-check-all)
[400.072532] Starting subtest: most-busy-idle-check-all
[400.073514] Starting dynamic subtest: rcs0
[400.759229] Dynamic subtest rcs0: SUCCESS (0.686s)
[400.776265] Starting dynamic subtest: bcs0
[401.413911] Dynamic subtest bcs0: SUCCESS (0.653s)
[401.428168] Starting dynamic subtest: vcs0
[402.067960] Dynamic subtest vcs0: SUCCESS (0.653s)
[402.081059] Starting dynamic subtest: vcs1
[402.723774] Dynamic subtest vcs1: SUCCESS (0.654s)
[402.742099] Starting dynamic subtest: vecs0
[403.381993] Dynamic subtest vecs0: SUCCESS (0.653s)
[403.399220] Starting dynamic subtest: vecs1
[404.042970] Dynamic subtest vecs1: SUCCESS (0.656s)
[404.064124] Starting dynamic subtest: ccs0
[404.705112] Dynamic subtest ccs0: SUCCESS (0.657s)
[404.710002] Subtest most-busy-idle-check-all: SUCCESS (4.635s)
[404.904154] [090/134] (624s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[405.097765] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[405.099484] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[405.288936] [091/134] (624s left) kms_scaling_modes (scaling-mode-full-aspect)
[405.472974] Starting subtest: scaling-mode-full-aspect
[405.478001] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[405.643907] [092/134] (624s left) kms_psr (fbc-pr-basic)
[405.830879] Subtest fbc-pr-basic: SKIP (0.000s)
[405.901689] [093/134] (624s left) kms_psr (psr2-sprite-mmap-cpu)
[406.085849] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[406.152044] [094/134] (623s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[406.340898] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[406.341791] Starting dynamic subtest: pipe-A-DP-3
[406.350839] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[406.363214] Starting dynamic subtest: pipe-B-DP-3
[406.372521] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[406.384722] Starting dynamic subtest: pipe-C-DP-3
[406.393689] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[406.406043] Starting dynamic subtest: pipe-D-DP-3
[406.417587] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[406.419609] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[406.834739] [095/134] (623s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[406.917985] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[407.031227] [096/134] (623s left) gem_ctx_sseu (invalid-args)
[407.118975] Subtest invalid-args: SKIP (0.000s)
[407.198135] [097/134] (623s left) kms_prop_blob (blob-multiple)
[407.271248] Starting subtest: blob-multiple
[407.302904] Subtest blob-multiple: SUCCESS (0.032s)
[407.441889] [098/134] (622s left) gem_exec_schedule (thriceslice)
[407.537168] Starting subtest: thriceslice
[407.538066] Starting dynamic subtest: rcs0
[407.589494] Dynamic subtest rcs0: SUCCESS (0.051s)
[407.607550] Starting dynamic subtest: bcs0
[407.646153] Dynamic subtest bcs0: SUCCESS (0.055s)
[407.665463] Starting dynamic subtest: vcs0
[407.682537] Dynamic subtest vcs0: SUCCESS (0.034s)
[407.696949] Starting dynamic subtest: vcs1
[407.736210] Dynamic subtest vcs1: SUCCESS (0.052s)
[407.760485] Starting dynamic subtest: vecs0
[407.776253] Dynamic subtest vecs0: SUCCESS (0.038s)
[407.801076] Starting dynamic subtest: vecs1
[407.813596] Dynamic subtest vecs1: SUCCESS (0.035s)
[407.838424] Starting dynamic subtest: ccs0
[407.852184] Dynamic subtest ccs0: SUCCESS (0.037s)
[407.853245] Subtest thriceslice: SUCCESS (0.316s)
[408.259132] [099/134] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[408.450992] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[408.452722] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[408.631597] [100/134] (621s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[408.833740] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[408.835565] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[409.006665] [101/134] (621s left) gem_exec_capture (pi)
[409.090404] Starting subtest: pi
[409.091316] Starting dynamic subtest: rcs0
[414.974745] Dynamic subtest rcs0: SUCCESS (5.883s)
[414.987365] Starting dynamic subtest: bcs0
[420.933120] Dynamic subtest bcs0: SUCCESS (5.958s)
[420.945740] Starting dynamic subtest: vcs0
[426.970034] Dynamic subtest vcs0: SUCCESS (6.036s)
[426.983430] Starting dynamic subtest: vcs1
[432.940009] Dynamic subtest vcs1: SUCCESS (5.969s)
[432.952616] Starting dynamic subtest: vecs0
[438.830507] Dynamic subtest vecs0: SUCCESS (5.889s)
[438.843070] Starting dynamic subtest: vecs1
[444.622955] Dynamic subtest vecs1: SUCCESS (5.791s)
[444.635716] Starting dynamic subtest: ccs0
[450.448141] Dynamic subtest ccs0: SUCCESS (5.824s)
[450.449091] Subtest pi: SUCCESS (41.358s)
[450.611644] [102/134] (580s left) gem_ctx_param (invalid-get-no-zeromap)
[450.733473] Starting subtest: invalid-get-no-zeromap
[450.735786] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[450.914028] [103/134] (579s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[451.107293] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[451.109739] Starting dynamic subtest: pipe-A-valid-mode
[451.196516] Dynamic subtest pipe-A-valid-mode: SKIP (0.087s)
[451.198517] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.089s)
[451.455101] [104/134] (579s left) kms_feature_discovery (dp-mst)
[451.647088] Starting subtest: dp-mst
[451.648852] Subtest dp-mst: SKIP (0.000s)
[451.774245] [105/134] (579s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[452.244391] Starting subtest: cursor-rapid-movement-512x512
[452.246126] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[452.494435] [106/134] (578s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[452.682742] Starting subtest: addfb25-y-tiled-legacy
[452.683655] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[452.889177] [107/134] (578s left) kms_universal_plane (disable-primary-vs-flip)
[453.074008] Starting subtest: disable-primary-vs-flip
[453.074900] Starting dynamic subtest: pipe-A-DP-3
[453.645976] Dynamic subtest pipe-A-DP-3: SUCCESS (0.570s)
[453.673968] Starting dynamic subtest: pipe-B-DP-3
[454.117572] Dynamic subtest pipe-B-DP-3: SUCCESS (0.468s)
[454.131779] Starting dynamic subtest: pipe-C-DP-3
[454.567337] Dynamic subtest pipe-C-DP-3: SUCCESS (0.448s)
[454.581812] Starting dynamic subtest: pipe-D-DP-3
[455.040110] Dynamic subtest pipe-D-DP-3: SUCCESS (0.470s)
[455.041095] Subtest disable-primary-vs-flip: SUCCESS (1.967s)
[455.352251] [108/134] (575s left) gem_exec_reloc (basic-cpu-read)
[455.440636] Subtest basic-cpu-read: SKIP (0.000s)
[455.532956] [109/134] (575s left) gem_mmap_offset (ptrace)
[455.611150] Starting subtest: ptrace
[455.615564] Starting dynamic subtest: lmem0-fixed
[455.751540] Dynamic subtest lmem0-fixed: SUCCESS (0.127s)
[455.763973] Starting dynamic subtest: smem0-fixed
[455.765078] Dynamic subtest smem0-fixed: SUCCESS (0.015s)
[455.766224] Subtest ptrace: SUCCESS (0.152s)
[455.907382] [110/134] (575s left) gem_close_race (basic-threads)
[456.029007] Starting subtest: basic-threads
[457.242975] Subtest basic-threads: SUCCESS (1.215s)
[457.605368] [111/134] (573s left) syncobj_timeline (wait-all-for-submit-complex)
[457.690106] Starting subtest: wait-all-for-submit-complex
[457.907613] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[458.037279] [112/134] (573s left) kms_addfb_basic (bad-pitch-128)
[458.112320] Starting subtest: bad-pitch-128
[458.113128] Subtest bad-pitch-128: SUCCESS (0.000s)
[458.389030] [113/134] (573s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[458.577106] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[458.579367] Starting dynamic subtest: pipe-A-DP-3
[458.588536] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[458.600954] Starting dynamic subtest: pipe-B-DP-3
[458.610110] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[458.622342] Starting dynamic subtest: pipe-C-DP-3
[458.631523] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[458.644057] Starting dynamic subtest: pipe-D-DP-3
[458.655588] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[458.657600] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[459.062341] [114/134] (572s left) prime_busy (before)
[459.151457] Starting subtest: before
[459.156314] Starting dynamic subtest: rcs0
[459.226754] Dynamic subtest rcs0: SUCCESS (0.070s)
[459.240548] Starting dynamic subtest: bcs0
[459.287430] Dynamic subtest bcs0: SUCCESS (0.059s)
[459.314521] Starting dynamic subtest: vcs0
[459.329052] Dynamic subtest vcs0: SUCCESS (0.040s)
[459.354984] Starting dynamic subtest: vcs1
[459.369106] Dynamic subtest vcs1: SUCCESS (0.038s)
[459.387212] Starting dynamic subtest: vecs0
[459.408758] Dynamic subtest vecs0: SUCCESS (0.038s)
[459.424909] Starting dynamic subtest: vecs1
[459.448630] Dynamic subtest vecs1: SUCCESS (0.039s)
[459.464984] Starting dynamic subtest: ccs0
[459.489510] Dynamic subtest ccs0: SUCCESS (0.040s)
[459.594418] Subtest before: SUCCESS (0.443s)
[459.786094] [115/134] (571s left) gen7_exec_parse (basic-allowed)
[459.871020] Subtest basic-allowed: SKIP (0.000s)
[459.958649] [116/134] (571s left) gem_exec_params (no-blt)
[460.042538] Starting subtest: no-blt
[460.046046] Subtest no-blt: SUCCESS (0.004s)
[460.242407] [117/134] (571s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[460.447794] Starting subtest: x-tiled-16bpp-rotate-90
[460.512733] Subtest x-tiled-16bpp-rotate-90: SKIP (0.064s)
[460.731902] [118/134] (571s left) kms_async_flips (invalid-async-flip)
[460.920064] Starting subtest: invalid-async-flip
[461.149223] Starting dynamic subtest: pipe-A-DP-3
[461.523227] Dynamic subtest pipe-A-DP-3: SUCCESS (0.374s)
[461.742330] Starting dynamic subtest: pipe-B-DP-3
[461.879275] Dynamic subtest pipe-B-DP-3: SUCCESS (0.156s)
[462.087140] Starting dynamic subtest: pipe-C-DP-3
[462.248800] Dynamic subtest pipe-C-DP-3: SUCCESS (0.175s)
[462.431181] Starting dynamic subtest: pipe-D-DP-3
[462.584011] Dynamic subtest pipe-D-DP-3: SUCCESS (0.169s)
[462.585030] Subtest invalid-async-flip: SUCCESS (1.666s)
[463.094454] [119/134] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[463.287633] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[463.289315] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[463.439632] [120/134] (568s left) api_intel_allocator (gem-pool)
[463.516024] Starting subtest: gem-pool
[463.552096] Subtest gem-pool: SUCCESS (0.037s)
[463.769513] [121/134] (568s left) gem_exec_whisper (basic-fds-priority-all)
[463.861352] Starting subtest: basic-fds-priority-all
[486.666135] Subtest basic-fds-priority-all: SUCCESS (22.802s)
[486.975430] [122/134] (545s left) gem_fence_thrash (bo-write-verify-y)
[487.022630] Starting subtest: bo-write-verify-y
[487.055764] Subtest bo-write-verify-y: SKIP (0.033s)
[487.134319] [123/134] (545s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[489.994644] Starting subtest: heavy-verify-multi-ccs
[489.995556] Starting dynamic subtest: lmem0
[501.517045] Dynamic subtest lmem0: SUCCESS (11.522s)
[501.517949] Subtest heavy-verify-multi-ccs: SUCCESS (11.524s)
[502.782934] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[502.783883] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[502.785697] [124/134] (529s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[504.379686] Starting subtest: yf-tiled-to-vebox-yf-tiled
[504.381422] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[504.572112] [FACT gem_render_copy (yf-tiled-to-vebox-yf-tiled)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[504.574436] [FACT gem_render_copy (yf-tiled-to-vebox-yf-tiled)] new: kernel.kmod_is_loaded.i915: true
[504.577089] [125/134] (527s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[504.843914] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[504.994675] [126/134] (527s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[505.072896] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[505.147196] [127/134] (527s left) gem_busy (busy)
[505.238017] Starting subtest: busy
[505.238870] Starting dynamic subtest: all-engines
[505.345991] Dynamic subtest all-engines: SUCCESS (0.107s)
[505.360184] Starting dynamic subtest: rcs0
[505.455620] Dynamic subtest rcs0: SUCCESS (0.108s)
[505.468714] Starting dynamic subtest: bcs0
[505.512260] Dynamic subtest bcs0: SUCCESS (0.055s)
[505.537741] Starting dynamic subtest: vcs0
[505.554266] Dynamic subtest vcs0: SUCCESS (0.040s)
[505.580643] Starting dynamic subtest: vcs1
[505.598224] Dynamic subtest vcs1: SUCCESS (0.042s)
[505.634201] Starting dynamic subtest: vecs0
[505.642358] Dynamic subtest vecs0: SUCCESS (0.042s)
[505.660301] Starting dynamic subtest: vecs1
[505.682952] Dynamic subtest vecs1: SUCCESS (0.039s)
[505.695209] Starting dynamic subtest: ccs0
[505.722075] Dynamic subtest ccs0: SUCCESS (0.038s)
[505.723067] Subtest busy: SUCCESS (0.484s)
[506.144471] [128/134] (526s left) kms_color_pipeline (plane-lut1d-lut1d)
[506.340007] Starting subtest: plane-lut1d-lut1d
[506.368446] Starting dynamic subtest: pipe-A-DP-3
[506.752407] Dynamic subtest pipe-A-DP-3: SUCCESS (0.383s)
[506.940213] Starting dynamic subtest: pipe-B-DP-3
[507.272177] Dynamic subtest pipe-B-DP-3: SUCCESS (0.347s)
[507.460450] Starting dynamic subtest: pipe-C-DP-3
[507.797122] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[507.972474] Starting dynamic subtest: pipe-D-DP-3
[508.311512] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[508.395869] Subtest plane-lut1d-lut1d: SUCCESS (2.054s)
[508.695555] [129/134] (523s left) kms_plane_cursor (primary)
[508.884761] Starting subtest: primary
[508.886439] Starting dynamic subtest: pipe-A-DP-3-size-64
[512.025330] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.139s)
[512.118361] Starting dynamic subtest: pipe-A-DP-3-size-128
[515.257922] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.181s)
[515.323488] Starting dynamic subtest: pipe-A-DP-3-size-256
[518.426020] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.115s)
[518.571972] Starting dynamic subtest: pipe-B-DP-3-size-64
[521.786127] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.231s)
[521.836387] Starting dynamic subtest: pipe-B-DP-3-size-128
[524.919689] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.098s)
[524.964493] Starting dynamic subtest: pipe-B-DP-3-size-256
[528.053238] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.100s)
[528.162818] Starting dynamic subtest: pipe-C-DP-3-size-64
[531.351226] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.203s)
[531.395083] Starting dynamic subtest: pipe-C-DP-3-size-128
[534.501243] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.116s)
[534.553801] Starting dynamic subtest: pipe-C-DP-3-size-256
[537.650815] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.116s)
[537.758025] Starting dynamic subtest: pipe-D-DP-3-size-64
[540.961199] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.216s)
[541.010645] Starting dynamic subtest: pipe-D-DP-3-size-128
[544.144822] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.148s)
[544.196003] Starting dynamic subtest: pipe-D-DP-3-size-256
[547.328354] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.148s)
[547.420595] Subtest primary: SUCCESS (38.535s)
[547.756272] [130/134] (484s left) gem_tiled_swapping (non-threaded)
[547.832636] Subtest non-threaded: SKIP (0.000s)
[547.920997] [131/134] (484s left) syncobj_wait (invalid-signal-zero-handles)
[547.999939] Starting subtest: invalid-signal-zero-handles
[548.000857] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[548.167833] [132/134] (484s left) kms_joiner (basic-force-ultra-joiner)
[548.358410] Starting subtest: basic-force-ultra-joiner
[548.360073] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[548.517315] [133/134] (484s left) kms_psr (fbc-psr2-sprite-blt)
[548.710091] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[548.762711] [134/134] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[548.955014] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[548.956702] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[549.123575] Closing watchdogs
results: parsing output: 0/ for test: gem_flink_basic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: gem_create
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_multipipe_modeset
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_chamelium_edid
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: gen9_exec_parse
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_hangman
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: i915_suspend
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: dmabuf_sync_file
results: parsing output: 52/ for test: gem_madvise
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_fbcon_fbt
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: kms_dirtyfb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_exec_nop
results: parsing output: 64/ for test: gem_workarounds
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_exec_await
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_scaling_modes
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gem_ctx_sseu
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_capture
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_feature_discovery
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_universal_plane
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: prime_busy
results: parsing output: 114/ for test: gen7_exec_parse
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: api_intel_allocator
results: parsing output: 120/ for test: gem_exec_whisper
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_pipe_b_c_ivb
results: parsing output: 126/ for test: gem_busy
results: parsing output: 127/ for test: kms_color_pipeline
results: parsing output: 128/ for test: kms_plane_cursor
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_joiner
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.