[56.477566] Initializing watchdogs
[56.477684]   /dev/watchdog0
[56.492718] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.497170] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.499711] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.502440] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[56.633295] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[56.637576] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[56.713638] [002/133] (960s left) gem_flink_basic (double-flink)
[56.768656] Starting subtest: double-flink
[56.771211] Subtest double-flink: SUCCESS (0.000s)
[56.867897] [003/133] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[57.427121] Starting subtest: invalid-timeline-fence-array
[57.433497] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[59.355581] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[59.358661] [004/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[59.457576] Starting subtest: invalid-modeset-ultra-joiner
[59.461969] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[59.519304] [005/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[59.605477] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[63.978314] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.405s)
[65.112284] [006/133] (952s left) gem_exec_schedule (semaphore-codependency)
[65.187583] Starting subtest: semaphore-codependency
[65.192894] Subtest semaphore-codependency: SUCCESS (0.013s)
[65.540150] [007/133] (951s left) kms_cursor_edge_walk (64x64-right-edge)
[65.638274] Starting subtest: 64x64-right-edge
[65.640535] Starting dynamic subtest: pipe-A-eDP-1
[69.073485] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[69.082785] Starting dynamic subtest: pipe-D-eDP-1
[72.190190] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[72.192599] Subtest 64x64-right-edge: SUCCESS (6.571s)
[73.000799] [008/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[73.131880] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[73.136059] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[73.312664] [009/133] (944s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[73.484023] Starting subtest: cursorA-vs-flipA-toggle
[84.614546] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.138s)
[85.405718] [010/133] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[85.507356] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[85.512038] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[85.606496] [011/133] (931s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[85.664431] Subtest writes-after-reads-uncached: SKIP (0.000s)
[85.735812] [012/133] (931s left) kms_hdr (invalid-metadata-sizes)
[85.826566] Starting subtest: invalid-metadata-sizes
[85.833258] Subtest invalid-metadata-sizes: SKIP (0.000s)
[85.897671] [013/133] (931s left) gem_tiled_partial_pwrite_pread (reads)
[85.947314] Subtest reads: SKIP (0.000s)
[86.015763] [014/133] (931s left) kms_async_flips (test-cursor-atomic)
[86.109351] Starting subtest: test-cursor-atomic
[86.487471] Starting dynamic subtest: pipe-A-eDP-1
[87.298892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.812s)
[87.681653] Starting dynamic subtest: pipe-B-eDP-1
[88.430848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[88.798625] Starting dynamic subtest: pipe-C-eDP-1
[89.570093] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.780s)
[89.938155] Starting dynamic subtest: pipe-D-eDP-1
[90.697617] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[90.700080] Subtest test-cursor-atomic: SUCCESS (4.590s)
[91.881715] [015/133] (925s left) kms_busy (extended-modeset-hang-newfb)
[91.978997] Starting subtest: extended-modeset-hang-newfb
[91.981856] Starting dynamic subtest: pipe-A
[126.223793] Dynamic subtest pipe-A: SUCCESS (34.243s)
[126.232974] Starting dynamic subtest: pipe-D
[149.185704] Dynamic subtest pipe-D: SUCCESS (22.959s)
[149.188122] Subtest extended-modeset-hang-newfb: SUCCESS (57.206s)
[149.985295] [016/133] (867s left) syncobj_timeline (wait-all-delayed-signal)
[150.041794] Starting subtest: wait-all-delayed-signal
[150.147086] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[150.225332] [017/133] (867s left) kms_pm_dc (dc5-psr)
[151.323129] Starting subtest: dc5-psr
[154.212102] Subtest dc5-psr: SUCCESS (2.888s)
[155.028757] [018/133] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[155.124515] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[155.128681] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[155.219955] [019/133] (862s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[155.323993] Starting subtest: y-tiled-16bpp-rotate-270
[155.328163] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[155.415816] [020/133] (862s left) kms_psr (fbc-psr2-suspend)
[155.512105] Starting subtest: fbc-psr2-suspend
[155.514296] Starting dynamic subtest: eDP-1
[155.518715] Dynamic subtest eDP-1: SKIP (0.000s)
[155.523335] Subtest fbc-psr2-suspend: SKIP (0.001s)
[155.605734] [021/133] (862s left) gem_exec_basic (basic)
[155.658043] Starting subtest: basic
[155.660285] Starting dynamic subtest: rcs0-smem
[155.664472] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[155.672563] Starting dynamic subtest: bcs0-smem
[155.674873] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[155.682856] Starting dynamic subtest: vcs0-smem
[155.685139] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[155.692787] Starting dynamic subtest: vcs1-smem
[155.695071] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[155.702635] Starting dynamic subtest: vecs0-smem
[155.704867] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[155.712719] Starting dynamic subtest: ccs0-smem
[155.715044] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[155.717242] Subtest basic: SUCCESS (0.016s)
[157.352755] [022/133] (860s left) gem_ctx_persistence (heartbeat-many)
[157.401944] Starting subtest: heartbeat-many
[157.406544] Subtest heartbeat-many: SKIP (0.000s)
[157.515448] [023/133] (860s left) api_intel_allocator (reloc-allocator)
[157.571136] Starting subtest: reloc-allocator
[157.572960] Starting dynamic subtest: basic
[157.574918] Dynamic subtest basic: SUCCESS (0.005s)
[157.583412] Starting dynamic subtest: parallel-one
[157.585547] Dynamic subtest parallel-one: SUCCESS (0.009s)
[157.593610] Starting dynamic subtest: print
[157.595755] Dynamic subtest print: SUCCESS (0.000s)
[157.603469] Starting dynamic subtest: reuse
[157.605284] Dynamic subtest reuse: SUCCESS (0.000s)
[157.612872] Starting dynamic subtest: fork-reopen-allocator
[157.614705] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[157.616589] Subtest reloc-allocator: SUCCESS (0.027s)
[157.728547] [024/133] (860s left) kms_flip (flip-vs-panning-vs-hang)
[157.824513] Starting subtest: flip-vs-panning-vs-hang
[157.826818] Starting dynamic subtest: A-eDP1
[208.750688] Dynamic subtest A-eDP1: SUCCESS (50.925s)
[208.761909] Starting dynamic subtest: D-eDP1
[258.799292] Dynamic subtest D-eDP1: SUCCESS (50.047s)
[258.801666] Subtest flip-vs-panning-vs-hang: SUCCESS (100.976s)
[260.005543] [025/133] (758s left) kms_chamelium_frames (vga-frame-dump)
[260.396668] Subtest vga-frame-dump: SKIP (0.000s)
[261.216296] [026/133] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[261.317667] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[261.321821] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[261.417879] [027/133] (756s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[261.730466] Starting subtest: cursor-rapid-movement-max-size
[261.736946] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[261.867996] [028/133] (756s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[261.922120] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[262.030038] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[262.106515] [029/133] (756s left) kms_psr (fbc-psr2-dpms)
[262.206752] Starting subtest: fbc-psr2-dpms
[262.208727] Starting dynamic subtest: eDP-1
[262.212971] Dynamic subtest eDP-1: SKIP (0.000s)
[262.217277] Subtest fbc-psr2-dpms: SKIP (0.001s)
[262.277710] [030/133] (755s left) kms_flip (flip-vs-rmfb-interruptible)
[262.367857] Starting subtest: flip-vs-rmfb-interruptible
[262.370371] Starting dynamic subtest: A-eDP1
[271.030202] Dynamic subtest A-eDP1: SUCCESS (8.662s)
[271.041466] Starting dynamic subtest: B-eDP1
[279.665952] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[279.675587] Starting dynamic subtest: C-eDP1
[288.279268] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[288.288546] Starting dynamic subtest: D-eDP1
[296.916159] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[296.921292] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.551s)
[298.095417] [031/133] (720s left) i915_suspend (fence-restore-untiled)
[298.151044] Starting subtest: fence-restore-untiled
[298.155741] Subtest fence-restore-untiled: SKIP (0.000s)
[298.243873] [032/133] (720s left) gem_ctx_bad_destroy (invalid-default-ctx)
[298.304741] Starting subtest: invalid-default-ctx
[298.306760] Subtest invalid-default-ctx: SUCCESS (0.000s)
[298.380576] [033/133] (719s left) kms_flip (2x-modeset-vs-vblank-race)
[298.475170] Starting subtest: 2x-modeset-vs-vblank-race
[298.483829] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[298.597204] [034/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[298.692791] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[298.697195] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.797510] [035/133] (719s left) vgem_basic (bad-flag)
[298.836068] Starting subtest: bad-flag
[298.838245] Subtest bad-flag: SUCCESS (0.000s)
[298.895143] [036/133] (719s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[299.001318] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[299.005353] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[299.082407] [037/133] (719s left) i915_drm_fdinfo (basics)
[299.117404] Starting subtest: basics
[299.119079] Subtest basics: SUCCESS (0.000s)
[299.186763] [038/133] (719s left) gem_workarounds (basic-read-fd)
[299.239292] Starting subtest: basic-read-fd
[299.250833] Subtest basic-read-fd: SUCCESS (0.014s)
[299.361172] [039/133] (719s left) kms_prop_blob (invalid-set-prop-any)
[299.413052] Starting subtest: invalid-set-prop-any
[299.414606] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[299.518117] [040/133] (719s left) i915_pm_rpm (gem-execbuf)
[301.439866] Starting subtest: gem-execbuf
[301.441933] Starting dynamic subtest: smem0
[303.174772] Dynamic subtest smem0: SUCCESS (1.734s)
[303.177201] Subtest gem-execbuf: SUCCESS (1.736s)
[303.275145] [041/133] (715s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[303.367390] Starting subtest: plane-lut1d-pre-ctm3x4
[303.537607] Starting dynamic subtest: pipe-A-plane-0
[303.703854] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[303.713064] Starting dynamic subtest: pipe-A-plane-1
[303.871082] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[303.882456] Starting dynamic subtest: pipe-A-plane-2
[304.026189] Dynamic subtest pipe-A-plane-2: SUCCESS (0.154s)
[305.204445] Starting dynamic subtest: pipe-B-plane-0
[305.364033] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[305.377589] Starting dynamic subtest: pipe-B-plane-1
[305.529661] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[305.538206] Starting dynamic subtest: pipe-B-plane-2
[305.663628] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[306.855976] Starting dynamic subtest: pipe-C-plane-0
[306.978259] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[306.987149] Starting dynamic subtest: pipe-C-plane-1
[307.144751] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[307.153507] Starting dynamic subtest: pipe-C-plane-2
[307.300926] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[308.457201] Starting dynamic subtest: pipe-D-plane-0
[308.593853] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[308.602915] Starting dynamic subtest: pipe-D-plane-1
[308.782583] Dynamic subtest pipe-D-plane-1: SUCCESS (0.188s)
[308.794770] Starting dynamic subtest: pipe-D-plane-2
[308.916476] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[309.202823] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.834s)
[310.020979] [042/133] (708s left) kms_async_flips (crc)
[310.112387] Starting subtest: crc
[310.487948] Starting dynamic subtest: pipe-A-eDP-1
[313.441548] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.953s)
[313.819267] Starting dynamic subtest: pipe-B-eDP-1
[316.772894] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.962s)
[317.147077] Starting dynamic subtest: pipe-C-eDP-1
[320.073505] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.936s)
[320.437848] Starting dynamic subtest: pipe-D-eDP-1
[323.299137] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s)
[323.301697] Subtest crc: SUCCESS (13.188s)
[324.464954] [043/133] (694s left) gem_mmap_wc (bad-offset)
[324.533045] Subtest bad-offset: SKIP (0.000s)
[324.593816] [044/133] (694s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[324.973747] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[325.772285] [045/133] (693s left) gem_ctx_create (basic)
[325.828186] Starting subtest: basic
[325.830508] Subtest basic: SUCCESS (0.000s)
[326.008066] [046/133] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[326.107569] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[326.111605] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[326.210975] [047/133] (692s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[326.269621] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[326.331703] [048/133] (692s left) gem_exec_reloc (basic-cpu)
[326.393578] Subtest basic-cpu: SKIP (0.000s)
[326.458253] [049/133] (692s left) gem_mmap_offset (mmap-boundaries)
[326.510566] Starting subtest: mmap-boundaries
[326.512853] Starting dynamic subtest: smem0
[326.792483] Dynamic subtest smem0: SUCCESS (0.284s)
[326.795050] Subtest mmap-boundaries: SUCCESS (0.285s)
[326.929930] [050/133] (692s left) gem_eio (in-flight-contexts-10ms)
[327.155728] Starting subtest: in-flight-contexts-10ms
[340.328923] Subtest in-flight-contexts-10ms: SUCCESS (13.171s)
[340.459192] [051/133] (678s left) gem_exec_whisper (basic-contexts-priority-all)
[340.525073] Starting subtest: basic-contexts-priority-all
[363.470797] Subtest basic-contexts-priority-all: SUCCESS (22.944s)
[363.657126] [052/133] (655s left) kms_big_fb (linear-8bpp-rotate-180)
[363.759088] Starting subtest: linear-8bpp-rotate-180
[365.029684] Subtest linear-8bpp-rotate-180: SUCCESS (1.271s)
[365.115962] [053/133] (654s left) sw_sync (sync_busy_fork)
[365.153591] Starting subtest: sync_busy_fork
[366.163668] Subtest sync_busy_fork: SUCCESS (1.011s)
[366.227927] [054/133] (652s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[366.319208] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[366.321438] Starting dynamic subtest: pipe-A-default-mode
[369.041419] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[369.043366] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.722s)
[369.900573] [055/133] (649s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[369.996493] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[370.000690] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[370.109708] [056/133] (649s left) gem_gpgpu_fill (offset-16x16)
[370.164146] Starting subtest: offset-16x16
[370.172359] Subtest offset-16x16: SUCCESS (0.009s)
[370.307670] [057/133] (649s left) dmabuf_sync_file (import-basic)
[370.341821] Starting subtest: import-basic
[370.344412] Subtest import-basic: SUCCESS (0.002s)
[370.444681] [058/133] (648s left) gem_ctx_bad_destroy (invalid-pad)
[370.492838] Starting subtest: invalid-pad
[370.495315] Subtest invalid-pad: SUCCESS (0.000s)
[370.569731] [059/133] (648s left) core_auth (basic-auth)
[370.618616] Starting subtest: basic-auth
[370.620868] Subtest basic-auth: SUCCESS (0.001s)
[370.717910] [060/133] (648s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[370.807816] Starting subtest: yf-tiled-16bpp-rotate-90
[370.812062] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[370.896459] [061/133] (648s left) kms_dp_link_training (non-uhbr-mst)
[370.981705] Starting subtest: non-uhbr-mst
[370.989070] Subtest non-uhbr-mst: SKIP (0.000s)
[371.051937] [062/133] (648s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[371.141624] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[371.143637] Starting dynamic subtest: pipe-A-eDP-1
[372.053682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.904s)
[372.063880] Starting dynamic subtest: pipe-B-eDP-1
[373.629540] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.575s)
[373.642430] Starting dynamic subtest: pipe-C-eDP-1
[375.120590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[375.131242] Starting dynamic subtest: pipe-D-eDP-1
[376.711468] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.590s)
[376.713699] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.563s)
[377.889921] [063/133] (641s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[377.991155] Starting subtest: yf-tiled-8bpp-rotate-0
[377.995688] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[378.079155] [064/133] (641s left) gem_basic (multigpu-create-close)
[378.130553] Starting subtest: multigpu-create-close
[378.134710] Subtest multigpu-create-close: SKIP (0.000s)
[378.227355] [065/133] (641s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[378.316171] Starting subtest: flip-vs-dpms-off-vs-modeset
[378.318539] Starting dynamic subtest: A-eDP1
[381.899812] Dynamic subtest A-eDP1: SUCCESS (3.582s)
[381.910751] Starting dynamic subtest: B-eDP1
[385.118719] Dynamic subtest B-eDP1: SUCCESS (3.213s)
[385.130180] Starting dynamic subtest: C-eDP1
[388.226290] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[388.236120] Starting dynamic subtest: D-eDP1
[391.345331] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[391.347792] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.030s)
[392.146177] [066/133] (627s left) gem_exec_balancer (full)
[392.215511] Starting subtest: full
[397.126756] Subtest full: SUCCESS (4.914s)
[397.432982] [067/133] (622s left) i915_hangman (engine-engine-error)
[397.485351] Starting subtest: engine-engine-error
[397.487597] Starting dynamic subtest: rcs0
[399.266928] Dynamic subtest rcs0: SUCCESS (1.780s)
[399.280806] Starting dynamic subtest: bcs0
[401.249805] Dynamic subtest bcs0: SUCCESS (1.981s)
[401.263563] Starting dynamic subtest: vcs0
[403.232663] Dynamic subtest vcs0: SUCCESS (1.980s)
[403.245945] Starting dynamic subtest: vcs1
[405.280729] Dynamic subtest vcs1: SUCCESS (2.045s)
[405.293828] Starting dynamic subtest: vecs0
[407.264556] Dynamic subtest vecs0: SUCCESS (1.981s)
[407.278966] Starting dynamic subtest: ccs0
[409.249180] Dynamic subtest ccs0: SUCCESS (1.982s)
[409.251873] Subtest engine-engine-error: SUCCESS (11.764s)
[409.382401] [068/133] (610s left) gem_mmap_gtt (basic-small-bo-tiledy)
[409.443062] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[409.506591] [069/133] (610s left) kms_frontbuffer_tracking (basic)
[409.605547] Starting subtest: basic
[412.946169] Subtest basic: SUCCESS (3.344s)
[413.063607] [070/133] (606s left) api_intel_bb (reset-flags)
[413.116524] Starting subtest: reset-flags
[413.121368] Subtest reset-flags: SUCCESS (0.006s)
[413.258950] [071/133] (606s left) kms_flip (flip-vs-absolute-wf_vblank)
[413.350252] Starting subtest: flip-vs-absolute-wf_vblank
[413.352185] Starting dynamic subtest: A-eDP1
[422.288986] Dynamic subtest A-eDP1: SUCCESS (8.939s)
[422.301192] Starting dynamic subtest: B-eDP1
[431.222150] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[431.234012] Starting dynamic subtest: C-eDP1
[440.142150] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[440.151991] Starting dynamic subtest: D-eDP1
[449.062795] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[449.067862] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.718s)
[450.288844] [072/133] (569s left) kms_plane_scaling (planes-upscale-20x20)
[450.381689] Starting subtest: planes-upscale-20x20
[450.384067] Starting dynamic subtest: pipe-A
[450.441684] Dynamic subtest pipe-A: SUCCESS (0.062s)
[450.451108] Starting dynamic subtest: pipe-B
[451.620890] Dynamic subtest pipe-B: SUCCESS (1.178s)
[451.633451] Starting dynamic subtest: pipe-C
[452.732201] Dynamic subtest pipe-C: SUCCESS (1.110s)
[452.742762] Starting dynamic subtest: pipe-D
[453.866739] Dynamic subtest pipe-D: SUCCESS (1.134s)
[453.869117] Subtest planes-upscale-20x20: SUCCESS (3.488s)
[455.040008] [073/133] (564s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[455.136177] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[455.140534] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[455.222042] [074/133] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[455.318953] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[455.323033] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[455.440760] [075/133] (564s left) kms_sequence (get-busy)
[455.535468] Starting subtest: get-busy
[455.537605] Starting dynamic subtest: pipe-A-eDP-1
[457.460115] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s)
[457.471746] Starting dynamic subtest: pipe-B-eDP-1
[460.043100] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[460.053718] Starting dynamic subtest: pipe-C-eDP-1
[462.639095] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.591s)
[462.648815] Starting dynamic subtest: pipe-D-eDP-1
[465.190525] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[465.192760] Subtest get-busy: SUCCESS (9.656s)
[466.000140] [076/133] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[466.095910] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[466.099997] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[466.197821] [077/133] (553s left) gem_vm_create (execbuf)
[466.249961] Starting subtest: execbuf
[466.257997] Subtest execbuf: SUCCESS (0.008s)
[466.368444] [078/133] (553s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[466.464854] Starting subtest: 4-tiled-32bpp-rotate-90
[466.485185] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[466.612649] [079/133] (553s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[466.667979] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[466.749984] [080/133] (553s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[466.801984] Starting subtest: single-wait-all-for-submit-unsubmitted
[466.909468] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[466.993178] [081/133] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[467.092887] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[467.097394] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[467.197939] [082/133] (553s left) gen7_exec_parse (oacontrol-tracking)
[467.254326] Subtest oacontrol-tracking: SKIP (0.000s)
[467.323567] [083/133] (553s left) kms_vrr (negative-basic)
[467.416359] Starting subtest: negative-basic
[467.422832] Starting dynamic subtest: pipe-A-eDP-1
[472.836412] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[473.116493] Subtest negative-basic: SUCCESS (5.701s)
[473.915457] [084/133] (546s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[474.015692] Starting subtest: stress-xrgb8888-4tiled
[479.897925] Subtest stress-xrgb8888-4tiled: SUCCESS (5.885s)
[479.950517] [085/133] (540s left) kms_addfb_basic (no-handle)
[480.001318] Starting subtest: no-handle
[480.003146] Subtest no-handle: SUCCESS (0.000s)
[480.132732] [086/133] (540s left) kms_psr (psr2-dpms)
[480.212512] Starting subtest: psr2-dpms
[480.214424] Starting dynamic subtest: eDP-1
[483.052456] Dynamic subtest eDP-1: SUCCESS (2.838s)
[483.054744] Subtest psr2-dpms: SUCCESS (2.839s)
[483.922652] [087/133] (536s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[483.972651] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[484.033980] [088/133] (536s left) gem_exec_params (no-bsd)
[484.084776] Starting subtest: no-bsd
[484.086980] Subtest no-bsd: SUCCESS (0.002s)
[485.363134] [089/133] (535s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[485.451703] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[485.456272] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[485.548772] [090/133] (535s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[485.645022] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[485.670814] Starting dynamic subtest: pipe-A-plane-0
[486.115677] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[486.127951] Starting dynamic subtest: pipe-A-plane-3
[486.370147] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[487.516403] Starting dynamic subtest: pipe-B-plane-0
[487.941937] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[487.952038] Starting dynamic subtest: pipe-B-plane-3
[488.208054] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[488.528871] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.884s)
[489.401370] [091/133] (531s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[489.545511] Starting subtest: dp-mst-type-1-suspend-resume
[489.549895] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[489.678456] [092/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[489.775613] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[496.627465] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.856s)
[496.767435] [093/133] (524s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[496.853108] Starting subtest: plane-use-after-nonblocking-unbind
[496.855425] Starting dynamic subtest: pipe-A-eDP-1
[496.913237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[497.208948] Starting dynamic subtest: pipe-B-eDP-1
[498.035583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.837s)
[498.328541] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.476s)
[499.190623] [094/133] (521s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[499.255493] Starting subtest: etime-multi-wait-all-for-submit-submitted
[499.358082] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[499.434390] [095/133] (521s left) kms_psr (psr-sprite-plane-onoff)
[499.521469] Starting subtest: psr-sprite-plane-onoff
[499.523764] Starting dynamic subtest: eDP-1
[501.333256] Dynamic subtest eDP-1: SUCCESS (1.811s)
[501.335699] Subtest psr-sprite-plane-onoff: SUCCESS (1.812s)
[502.159519] [096/133] (518s left) perf_pmu (busy-no-semaphores)
[502.196176] Starting subtest: busy-no-semaphores
[502.198781] Starting dynamic subtest: rcs0
[502.746901] Dynamic subtest rcs0: SUCCESS (0.549s)
[502.758205] Starting dynamic subtest: bcs0
[503.297097] Dynamic subtest bcs0: SUCCESS (0.548s)
[503.310886] Starting dynamic subtest: vcs0
[503.848665] Dynamic subtest vcs0: SUCCESS (0.548s)
[503.863032] Starting dynamic subtest: vcs1
[505.799995] Dynamic subtest vcs1: SUCCESS (1.948s)
[505.816777] Starting dynamic subtest: vecs0
[507.783250] Dynamic subtest vecs0: SUCCESS (1.980s)
[507.796530] Starting dynamic subtest: ccs0
[509.831248] Dynamic subtest ccs0: SUCCESS (2.045s)
[509.834371] Subtest busy-no-semaphores: SUCCESS (7.637s)
[509.962293] [097/133] (511s left) kms_vblank (wait-forked)
[510.065185] Starting subtest: wait-forked
[510.067441] Starting dynamic subtest: pipe-A-eDP-1
[511.880527] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[511.895703] Starting dynamic subtest: pipe-D-eDP-1
[514.351556] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.468s)
[514.353928] Subtest wait-forked: SUCCESS (4.289s)
[515.212426] [098/133] (505s left) gem_mmap_gtt (basic-write-read-distinct)
[515.265920] Subtest basic-write-read-distinct: SKIP (0.000s)
[515.322314] [099/133] (505s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[515.416582] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[519.666721] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.254s)
[520.808240] [100/133] (500s left) kms_psr (pr-dpms)
[520.892690] Starting subtest: pr-dpms
[520.897059] Subtest pr-dpms: SKIP (0.000s)
[520.964675] [101/133] (500s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[521.057633] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[521.061885] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[521.152565] [102/133] (500s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[521.241286] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[521.243459] Starting dynamic subtest: pipe-A-eDP-1
[532.564829] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.328s)
[532.574585] Starting dynamic subtest: pipe-B-eDP-1
[544.599857] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.031s)
[544.602140] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.362s)
[545.464303] [103/133] (475s left) syncobj_basic (bad-flags-handle-to-fd)
[545.529790] Starting subtest: bad-flags-handle-to-fd
[545.531727] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[545.648165] [104/133] (475s left) syncobj_timeline (multi-wait-all-available-signaled)
[545.693421] Starting subtest: multi-wait-all-available-signaled
[545.695805] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[545.788949] [105/133] (475s left) gem_spin_batch (resubmit-new-all)
[545.854539] Starting subtest: resubmit-new-all
[545.856975] Starting dynamic subtest: rcs0
[545.866742] Dynamic subtest rcs0: SUCCESS (0.012s)
[545.878817] Starting dynamic subtest: bcs0
[545.881151] Dynamic subtest bcs0: SUCCESS (0.010s)
[545.893776] Starting dynamic subtest: vcs0
[545.895744] Dynamic subtest vcs0: SUCCESS (0.010s)
[545.906292] Starting dynamic subtest: vcs1
[545.908751] Dynamic subtest vcs1: SUCCESS (0.014s)
[545.918429] Starting dynamic subtest: vecs0
[545.920667] Dynamic subtest vecs0: SUCCESS (0.012s)
[545.930105] Starting dynamic subtest: ccs0
[545.932404] Dynamic subtest ccs0: SUCCESS (0.013s)
[545.934329] Subtest resubmit-new-all: SUCCESS (0.077s)
[547.305563] [106/133] (474s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[547.404476] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[547.408572] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.499547] [107/133] (473s left) gem_ctx_engines (execute-one)
[547.555332] Starting subtest: execute-one
[550.188315] Subtest execute-one: SUCCESS (2.633s)
[550.372538] [108/133] (471s left) kms_pm_rpm (modeset-stress-extra-wait)
[552.513749] Starting subtest: modeset-stress-extra-wait
[606.837126] Subtest modeset-stress-extra-wait: SUCCESS (54.324s)
[606.925127] [109/133] (414s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[607.048672] Starting subtest: flip-vs-cursor-crc-legacy
[607.700706] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.650s)
[608.525473] [110/133] (413s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[608.616370] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[608.618744] Starting dynamic subtest: pipe-A-eDP-1
[609.467363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[609.477086] Starting dynamic subtest: pipe-B-eDP-1
[611.041870] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.571s)
[611.052123] Starting dynamic subtest: pipe-C-eDP-1
[612.539605] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.495s)
[612.550072] Starting dynamic subtest: pipe-D-eDP-1
[614.087298] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.548s)
[614.089793] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.466s)
[615.246350] [111/133] (406s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[615.291058] Starting subtest: single-wait-for-submit-unsubmitted
[615.397938] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[615.487240] [112/133] (406s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[615.535753] Starting subtest: y-tiled-to-vebox-y-tiled
[615.540105] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[615.729890] [113/133] (405s left) kms_plane_multiple (tiling-x)
[615.836306] Starting subtest: tiling-x
[615.838541] Starting dynamic subtest: pipe-A-eDP-1
[619.475631] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.639s)
[619.486958] Starting dynamic subtest: pipe-B-eDP-1
[623.925925] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.448s)
[623.936840] Starting dynamic subtest: pipe-C-eDP-1
[628.254837] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.329s)
[628.265718] Starting dynamic subtest: pipe-D-eDP-1
[632.588100] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.329s)
[632.590593] Subtest tiling-x: SUCCESS (16.751s)
[633.385981] [114/133] (388s left) gem_render_copy (yf-tiled)
[633.455092] Starting subtest: yf-tiled
[633.459798] Subtest yf-tiled: SKIP (0.000s)
[633.638400] [115/133] (388s left) gem_ctx_shared (q-smoketest-all)
[633.694050] Starting subtest: Q-smoketest-all
[666.066723] Subtest Q-smoketest-all: SUCCESS (32.324s)
[667.427048] [116/133] (354s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[667.559881] Starting subtest: multiplane-atomic-fence-wait
[667.885411] Subtest multiplane-atomic-fence-wait: SUCCESS (0.325s)
[669.008625] [117/133] (352s left) gem_shrink (reclaim)
[669.076795] Starting subtest: reclaim
[671.448025] Subtest reclaim: SUCCESS (2.371s)
[671.588012] [118/133] (350s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[671.678360] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[671.682455] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[671.788900] [119/133] (350s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[671.883245] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[671.885139] Starting dynamic subtest: pipe-A-eDP-1
[672.035353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[672.045796] Starting dynamic subtest: pipe-B-eDP-1
[672.065480] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[672.075464] Starting dynamic subtest: pipe-C-eDP-1
[672.095586] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[672.104983] Starting dynamic subtest: pipe-D-eDP-1
[672.123443] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[672.125309] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.179s)
[674.363274] [120/133] (347s left) gem_exec_parallel (userptr)
[674.433282] Starting subtest: userptr
[674.435730] Starting dynamic subtest: rcs0
[675.877771] Dynamic subtest rcs0: SUCCESS (1.444s)
[675.888907] Starting dynamic subtest: bcs0
[677.386881] Dynamic subtest bcs0: SUCCESS (1.508s)
[677.398104] Starting dynamic subtest: vcs0
[679.253490] Dynamic subtest vcs0: SUCCESS (1.864s)
[679.263527] Starting dynamic subtest: vcs1
[681.281438] Dynamic subtest vcs1: SUCCESS (2.025s)
[681.294351] Starting dynamic subtest: vecs0
[683.266080] Dynamic subtest vecs0: SUCCESS (1.982s)
[683.276575] Starting dynamic subtest: ccs0
[684.755327] Dynamic subtest ccs0: SUCCESS (1.488s)
[684.757807] Subtest userptr: SUCCESS (10.323s)
[684.943905] [121/133] (337s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[685.051859] Starting subtest: x-tiled-16bpp-rotate-0
[686.431527] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.381s)
[686.552238] [122/133] (335s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[686.638561] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[686.640590] Starting dynamic subtest: pipe-A-eDP-1
[686.661969] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[686.673506] Starting dynamic subtest: pipe-B-eDP-1
[686.693084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[686.703047] Starting dynamic subtest: pipe-C-eDP-1
[686.723680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[686.733048] Starting dynamic subtest: pipe-D-eDP-1
[686.753536] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[686.756842] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[688.924412] [123/133] (333s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[689.011895] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[689.014129] Starting dynamic subtest: pipe-A
[689.260236] Dynamic subtest pipe-A: SUCCESS (0.251s)
[689.270606] Starting dynamic subtest: pipe-B
[690.603887] Dynamic subtest pipe-B: SUCCESS (1.341s)
[690.614712] Starting dynamic subtest: pipe-C
[691.930738] Dynamic subtest pipe-C: SUCCESS (1.326s)
[691.940638] Starting dynamic subtest: pipe-D
[693.265023] Dynamic subtest pipe-D: SUCCESS (1.333s)
[693.267410] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.256s)
[694.452154] [124/133] (327s left) gem_exec_params (cliprects_ptr-dirt)
[694.507060] Starting subtest: cliprects_ptr-dirt
[694.509510] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[694.632983] [125/133] (327s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[694.681644] Starting subtest: multi-wait-available-unsubmitted-signaled
[694.683928] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[694.799871] [126/133] (327s left) kms_lease (cursor-implicit-plane)
[694.949371] Starting subtest: cursor-implicit-plane
[694.951859] Starting dynamic subtest: pipe-A-eDP-1
[695.407426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[695.423091] Starting dynamic subtest: pipe-B-eDP-1
[696.572447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s)
[696.585815] Starting dynamic subtest: pipe-C-eDP-1
[697.674948] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[697.688394] Starting dynamic subtest: pipe-D-eDP-1
[698.812927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[698.815371] Subtest cursor-implicit-plane: SUCCESS (3.865s)
[699.680255] [127/133] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[699.774146] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[699.778475] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[699.878795] [128/133] (322s left) gem_ctx_isolation (nonpriv)
[699.932796] Starting subtest: nonpriv
[699.934945] Starting dynamic subtest: rcs0
[700.158017] Dynamic subtest rcs0: SUCCESS (0.225s)
[700.171295] Starting dynamic subtest: bcs0
[700.399819] Dynamic subtest bcs0: SUCCESS (0.241s)
[700.411480] Starting dynamic subtest: vcs0
[700.654113] Dynamic subtest vcs0: SUCCESS (0.254s)
[700.663915] Starting dynamic subtest: vcs1
[702.504881] Dynamic subtest vcs1: SUCCESS (1.849s)
[702.514991] Starting dynamic subtest: vecs0
[704.579072] Dynamic subtest vecs0: SUCCESS (2.073s)
[704.591239] Starting dynamic subtest: ccs0
[706.551134] Dynamic subtest ccs0: SUCCESS (1.971s)
[706.553583] Subtest nonpriv: SUCCESS (6.619s)
[706.804969] [129/133] (315s left) kms_cursor_crc (cursor-offscreen-32x10)
[706.981483] Starting subtest: cursor-offscreen-32x10
[707.027645] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[707.308451] [130/133] (315s left) gem_exec_schedule (manyslice)
[707.375316] Starting subtest: manyslice
[707.377217] Starting dynamic subtest: rcs0
[712.496545] Dynamic subtest rcs0: SUCCESS (5.129s)
[712.512845] Starting dynamic subtest: bcs0
[719.642777] Dynamic subtest bcs0: SUCCESS (7.144s)
[719.656704] Starting dynamic subtest: vcs0
[725.732744] Dynamic subtest vcs0: SUCCESS (6.087s)
[725.745284] Starting dynamic subtest: vcs1
[731.311622] Dynamic subtest vcs1: SUCCESS (5.577s)
[731.326485] Starting dynamic subtest: vecs0
[737.903385] Dynamic subtest vecs0: SUCCESS (6.588s)
[737.921247] Starting dynamic subtest: ccs0
[744.602419] Dynamic subtest ccs0: SUCCESS (6.699s)
[744.604908] Subtest manyslice: SUCCESS (37.237s)
[744.900321] [131/133] (277s left) kms_chamelium_audio (dp-audio-edid)
[745.286618] Subtest dp-audio-edid: SKIP (0.000s)
[746.085866] [132/133] (276s left) prime_busy (before-wait)
[746.159756] Starting subtest: before-wait
[746.165338] Starting dynamic subtest: rcs0
[746.206873] Dynamic subtest rcs0: SUCCESS (0.044s)
[746.218651] Starting dynamic subtest: bcs0
[746.257099] Dynamic subtest bcs0: SUCCESS (0.050s)
[746.266745] Starting dynamic subtest: vcs0
[746.295266] Dynamic subtest vcs0: SUCCESS (0.037s)
[746.304664] Starting dynamic subtest: vcs1
[746.333644] Dynamic subtest vcs1: SUCCESS (0.038s)
[746.343057] Starting dynamic subtest: vecs0
[746.374223] Dynamic subtest vecs0: SUCCESS (0.040s)
[746.383639] Starting dynamic subtest: ccs0
[746.416986] Dynamic subtest ccs0: SUCCESS (0.041s)
[746.526472] Subtest before-wait: SUCCESS (0.365s)
[746.602608] [133/133] (275s left) gem_softpin (invalid)
[746.659073] Starting subtest: invalid
[746.665360] Subtest invalid: SUCCESS (0.006s)
[746.785754] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_flink_basic
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_hdr
results: parsing output: 12/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 13/ for test: kms_async_flips
results: parsing output: 14/ for test: kms_busy
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_pm_dc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_basic
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: i915_suspend
results: parsing output: 31/ for test: gem_ctx_bad_destroy
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: gem_workarounds
results: parsing output: 38/ for test: kms_prop_blob
results: parsing output: 39/ for test: i915_pm_rpm
results: parsing output: 40/ for test: kms_color_pipeline
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: gem_ctx_create
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: gem_exec_whisper
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_gpgpu_fill
results: parsing output: 56/ for test: dmabuf_sync_file
results: parsing output: 57/ for test: gem_ctx_bad_destroy
results: parsing output: 58/ for test: core_auth
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_dp_link_training
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_basic
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: i915_hangman
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_sequence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_vm_create
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gen7_exec_parse
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: kms_pipe_stress
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_pipe_b_c_ivb
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_atomic_transition
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_engines
results: parsing output: 107/ for test: kms_pm_rpm
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: kms_explicit_fence
results: parsing output: 116/ for test: gem_shrink
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_exec_parallel
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_ctx_isolation
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_chamelium_audio
results: parsing output: 131/ for test: prime_busy
results: parsing output: 132/ for test: gem_softpin
Done.