[149.372676] Initializing watchdogs
[149.372850]   /dev/watchdog0
[149.410825] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[149.425063] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[149.432318] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[149.439760] [001/133] (960s left) kms_prop_blob (invalid-set-prop-any)
[149.561579] Starting subtest: invalid-set-prop-any
[149.564728] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[149.707424] [002/133] (960s left) gem_ctx_persistence (heartbeat-hang)
[149.826424] Starting subtest: heartbeat-hang
[150.986739] Subtest heartbeat-hang: SUCCESS (1.162s)
[151.140348] [003/133] (958s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[151.318571] Starting subtest: basic-flip-before-cursor-legacy
[152.730148] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.412s)
[153.044701] [004/133] (957s left) kms_flip (2x-flip-vs-panning-vs-hang)
[153.230738] Starting subtest: 2x-flip-vs-panning-vs-hang
[153.234217] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[166.226139] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (12.989s)
[166.229428] Subtest 2x-flip-vs-panning-vs-hang: SUCCESS (12.995s)
[166.673227] [005/133] (943s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[167.240220] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[167.507789] [006/133] (942s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[167.691773] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[167.695816] Starting dynamic subtest: pipe-A
[168.017105] Dynamic subtest pipe-A: SUCCESS (0.325s)
[168.037112] Starting dynamic subtest: pipe-B
[168.395365] Dynamic subtest pipe-B: SUCCESS (0.378s)
[168.425195] Starting dynamic subtest: pipe-C
[168.481628] Dynamic subtest pipe-C: SUCCESS (0.079s)
[168.486132] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.784s)
[168.942324] [007/133] (941s left) kms_psr (fbc-pr-sprite-plane-move)
[169.123992] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[169.226606] [008/133] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[169.433500] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[169.439588] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[169.590818] [009/133] (941s left) gem_exec_fence (syncobj-timeline-wait)
[170.333196] Starting subtest: syncobj-timeline-wait
[170.362322] Subtest syncobj-timeline-wait: SUCCESS (0.032s)
[170.647339] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[170.653858] [010/133] (940s left) kms_joiner (invalid-modeset-big-joiner)
[170.836314] Starting subtest: invalid-modeset-big-joiner
[170.842784] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[171.003241] [011/133] (939s left) gem_exec_schedule (thriceslice)
[171.136897] Starting subtest: thriceslice
[171.142263] Starting dynamic subtest: rcs0
[171.145289] Dynamic subtest rcs0: SUCCESS (0.012s)
[171.167963] Starting dynamic subtest: bcs0
[171.171453] Dynamic subtest bcs0: SUCCESS (0.021s)
[171.195991] Starting dynamic subtest: vcs0
[171.199973] Dynamic subtest vcs0: SUCCESS (0.025s)
[171.222085] Starting dynamic subtest: vecs0
[171.226286] Dynamic subtest vecs0: SUCCESS (0.011s)
[171.230080] Subtest thriceslice: SUCCESS (0.072s)
[171.618575] [012/133] (939s left) gem_mmap (bad-offset)
[171.719922] Starting subtest: bad-offset
[171.724531] Subtest bad-offset: SUCCESS (0.001s)
[171.868979] [013/133] (939s left) sysfs_preempt_timeout (idempotent)
[171.980293] Starting subtest: idempotent
[171.983562] Starting dynamic subtest: vecs0
[171.986902] Dynamic subtest vecs0: SUCCESS (0.002s)
[172.006208] Starting dynamic subtest: vcs0
[172.010045] Dynamic subtest vcs0: SUCCESS (0.003s)
[172.029451] Starting dynamic subtest: bcs0
[172.033232] Dynamic subtest bcs0: SUCCESS (0.002s)
[172.066553] Starting dynamic subtest: rcs0
[172.070442] Dynamic subtest rcs0: SUCCESS (0.002s)
[172.074705] Subtest idempotent: SUCCESS (0.013s)
[172.169173] [014/133] (938s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[172.362304] Starting subtest: cursorA-vs-flipB-atomic
[183.696542] Subtest cursorA-vs-flipB-atomic: SUCCESS (11.330s)
[184.004584] [015/133] (927s left) gem_ctx_persistence (engines-persistence)
[184.125592] Starting subtest: engines-persistence
[184.130511] Starting dynamic subtest: rcs0
[184.887965] Dynamic subtest rcs0: SUCCESS (0.760s)
[184.908710] Starting dynamic subtest: bcs0
[185.664729] Dynamic subtest bcs0: SUCCESS (0.775s)
[185.684267] Starting dynamic subtest: vcs0
[186.424741] Dynamic subtest vcs0: SUCCESS (0.758s)
[186.443759] Starting dynamic subtest: vecs0
[187.186365] Dynamic subtest vecs0: SUCCESS (0.754s)
[187.190300] Subtest engines-persistence: SUCCESS (3.055s)
[187.368232] [016/133] (923s left) gem_eio (banned)
[187.503146] Starting subtest: banned
[187.676743] Subtest banned: SUCCESS (0.174s)
[187.949659] [017/133] (923s left) kms_draw_crc (fill-fb)
[188.136882] Starting subtest: fill-fb
[188.692482] Subtest fill-fb: SUCCESS (0.562s)
[188.937244] [018/133] (922s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[189.120324] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[189.162183] Starting dynamic subtest: pipe-A-valid-mode
[190.031620] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.908s)
[190.036310] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.911s)
[190.329028] [019/133] (921s left) gem_watchdog (default-virtual)
[190.464962] Starting subtest: default-virtual
[191.482157] Subtest default-virtual: SUCCESS (1.027s)
[191.607079] [020/133] (920s left) kms_color (ctm-max)
[191.782094] Starting subtest: ctm-max
[191.785824] Starting dynamic subtest: pipe-A-HDMI-A-1
[192.720580] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.934s)
[192.758588] Starting dynamic subtest: pipe-A-HDMI-A-2
[193.368322] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.646s)
[193.402975] Starting dynamic subtest: pipe-B-HDMI-A-1
[194.005530] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.635s)
[194.027066] Starting dynamic subtest: pipe-B-HDMI-A-2
[194.660982] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.650s)
[194.706464] Starting dynamic subtest: pipe-C-HDMI-A-1
[195.320244] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.661s)
[195.360426] Starting dynamic subtest: pipe-C-HDMI-A-2
[195.952405] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.633s)
[195.955701] Subtest ctm-max: SUCCESS (4.170s)
[196.283775] [021/133] (915s left) kms_psr (psr-cursor-mmap-cpu)
[196.475986] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[196.582760] [022/133] (915s left) syncobj_timeline (invalid-signal-illegal-handle)
[196.690624] Starting subtest: invalid-signal-illegal-handle
[196.693986] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[196.870521] [023/133] (915s left) kms_cursor_edge_walk (256x256-top-bottom)
[197.091535] Starting subtest: 256x256-top-bottom
[197.097298] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.931518] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.876s)
[200.952735] Starting dynamic subtest: pipe-C-HDMI-A-1
[204.467176] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.457s)
[204.470417] Subtest 256x256-top-bottom: SUCCESS (7.341s)
[204.698533] [024/133] (907s left) gem_ctx_param (set-priority-range)
[204.809119] Starting subtest: set-priority-range
[204.861423] Subtest set-priority-range: SUCCESS (0.057s)
[205.046433] [025/133] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[205.234209] Starting subtest: basic-busy-flip-before-cursor-legacy
[205.242119] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[205.397279] [026/133] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[205.604061] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[205.611447] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[205.781418] [027/133] (906s left) kms_flip (flip-vs-expired-vblank-interruptible)
[205.977128] Starting subtest: flip-vs-expired-vblank-interruptible
[205.985732] Starting dynamic subtest: A-HDMI-A1
[211.622587] Dynamic subtest A-HDMI-A1: SUCCESS (5.638s)
[211.642302] Starting dynamic subtest: B-HDMI-A1
[216.979808] Dynamic subtest B-HDMI-A1: SUCCESS (5.355s)
[217.000263] Starting dynamic subtest: C-HDMI-A1
[222.334879] Dynamic subtest C-HDMI-A1: SUCCESS (5.353s)
[222.355718] Starting dynamic subtest: A-HDMI-A2
[227.708195] Dynamic subtest A-HDMI-A2: SUCCESS (5.369s)
[227.728566] Starting dynamic subtest: B-HDMI-A2
[233.059285] Dynamic subtest B-HDMI-A2: SUCCESS (5.346s)
[233.080050] Starting dynamic subtest: C-HDMI-A2
[238.419152] Dynamic subtest C-HDMI-A2: SUCCESS (5.357s)
[238.422418] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (32.442s)
[238.907254] [028/133] (873s left) gem_ctx_param (invalid-size-set)
[239.013625] Starting subtest: invalid-size-set
[239.016621] Subtest invalid-size-set: SUCCESS (0.000s)
[239.176795] [029/133] (873s left) gem_flink_race (flink_name)
[239.281233] Starting subtest: flink_name
[244.652711] Subtest flink_name: SUCCESS (5.374s)
[244.821203] [030/133] (867s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[245.027309] Starting subtest: y-tiled-64bpp-rotate-180
[250.045200] Subtest y-tiled-64bpp-rotate-180: SUCCESS (5.018s)
[250.573699] [031/133] (862s left) gem_exec_parallel (fds)
[250.701316] Starting subtest: fds
[250.704991] Starting dynamic subtest: rcs0
[262.166994] Dynamic subtest rcs0: SUCCESS (11.465s)
[262.189943] Starting dynamic subtest: bcs0
[267.330448] Dynamic subtest bcs0: SUCCESS (5.162s)
[267.350813] Starting dynamic subtest: vcs0
[271.893503] Dynamic subtest vcs0: SUCCESS (4.559s)
[271.915611] Starting dynamic subtest: vecs0
[276.418403] Dynamic subtest vecs0: SUCCESS (4.525s)
[276.422608] Subtest fds: SUCCESS (25.719s)
[276.698076] [032/133] (836s left) gem_mmap_wc (invalid-flags)
[276.803861] Starting subtest: invalid-flags
[276.807423] Subtest invalid-flags: SUCCESS (0.001s)
[276.972154] [033/133] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[277.173703] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[277.180047] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[277.357076] [034/133] (835s left) gem_exec_capture (userptr)
[277.479812] Starting subtest: userptr
[278.775173] Subtest userptr: SUCCESS (1.298s)
[278.955859] [035/133] (834s left) gem_lmem_swapping (parallel-multi)
[279.067458] Subtest parallel-multi: SKIP (0.000s)
[279.184051] [036/133] (834s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[279.289110] Starting subtest: no-spare-fences-interruptible
[281.463738] Subtest no-spare-fences-interruptible: SUCCESS (2.168s)
[281.642029] [037/133] (831s left) kms_psr (psr-dpms)
[281.825944] Subtest psr-dpms: SKIP (0.000s)
[281.938274] [038/133] (831s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[282.057949] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[282.066259] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[282.325290] [039/133] (831s left) gem_exec_fence (invalid-fence-array)
[282.897305] Starting subtest: invalid-fence-array
[282.906367] Subtest invalid-fence-array: SUCCESS (0.005s)
[283.321522] [040/133] (830s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[283.495095] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[283.512578] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[283.656973] [041/133] (830s left) kms_cursor_crc (cursor-onscreen-128x42)
[283.862507] Starting subtest: cursor-onscreen-128x42
[283.908238] Starting dynamic subtest: pipe-A-HDMI-A-1
[286.570648] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.660s)
[286.689215] Starting dynamic subtest: pipe-C-HDMI-A-1
[289.011957] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.377s)
[289.015669] Subtest cursor-onscreen-128x42: SUCCESS (5.149s)
[289.343030] [042/133] (824s left) kms_plane_lowres (tiling-4)
[289.532630] Starting subtest: tiling-4
[289.539491] Subtest tiling-4: SKIP (0.000s)
[289.707510] [043/133] (824s left) kms_pm_rpm (dpms-lpsp)
[291.640340] Starting subtest: dpms-lpsp
[291.651207] Subtest dpms-lpsp: SKIP (0.001s)
[292.056468] [044/133] (822s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[292.260101] Starting subtest: cursor-rapid-movement-512x170
[292.266720] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[292.459261] [045/133] (821s left) kms_sequence (get-forked)
[292.639436] Starting subtest: get-forked
[292.644060] Starting dynamic subtest: pipe-A-HDMI-A-1
[295.363330] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.716s)
[295.413087] Starting dynamic subtest: pipe-A-HDMI-A-2
[297.797576] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.433s)
[297.839426] Starting dynamic subtest: pipe-B-HDMI-A-1
[300.267616] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.463s)
[300.301219] Starting dynamic subtest: pipe-B-HDMI-A-2
[302.771343] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.492s)
[302.838406] Starting dynamic subtest: pipe-C-HDMI-A-1
[305.191558] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.404s)
[305.220120] Starting dynamic subtest: pipe-C-HDMI-A-2
[307.650841] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.414s)
[307.690824] Subtest get-forked: SUCCESS (14.959s)
[307.962900] [046/133] (806s left) gem_busy (parallel)
[308.286173] Starting subtest: parallel
[308.289505] Starting dynamic subtest: rcs0
[308.321371] Dynamic subtest rcs0: SUCCESS (0.032s)
[308.343582] Starting dynamic subtest: bcs0
[308.354305] Dynamic subtest bcs0: SUCCESS (0.028s)
[308.374569] Starting dynamic subtest: vcs0
[308.386052] Dynamic subtest vcs0: SUCCESS (0.034s)
[308.410368] Starting dynamic subtest: vecs0
[308.422574] Dynamic subtest vecs0: SUCCESS (0.032s)
[308.426325] Subtest parallel: SUCCESS (0.137s)
[308.700713] [047/133] (805s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[308.923569] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[308.933749] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[309.536663] [048/133] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[309.746224] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[309.752631] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[309.917315] [049/133] (804s left) gem_exec_whisper (basic-fds-priority)
[310.041116] Starting subtest: basic-fds-priority
[324.908433] Subtest basic-fds-priority: SUCCESS (14.863s)
[325.189239] [050/133] (789s left) kms_plane_alpha_blend (alpha-7efc)
[325.366020] Starting subtest: alpha-7efc
[325.572836] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.519257] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.941s)
[326.575583] Starting dynamic subtest: pipe-C-HDMI-A-1
[327.444675] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.885s)
[327.450286] Subtest alpha-7efc: SUCCESS (2.075s)
[327.759334] [051/133] (787s left) gem_exec_balancer (full-late)
[327.887762] Starting subtest: full-late
[332.324723] Subtest full-late: SUCCESS (4.434s)
[332.622802] [052/133] (782s left) gem_spin_batch (spin-all-new)
[332.747066] Starting subtest: spin-all-new
[332.772999] Subtest spin-all-new: SUCCESS (0.024s)
[333.113447] [053/133] (782s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[333.289761] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[333.293331] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.415124] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[333.438551] Starting dynamic subtest: pipe-A-HDMI-A-2
[333.471593] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[333.495212] Starting dynamic subtest: pipe-B-HDMI-A-1
[333.526945] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[333.549186] Starting dynamic subtest: pipe-B-HDMI-A-2
[333.581455] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[333.603368] Starting dynamic subtest: pipe-C-HDMI-A-1
[333.637279] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[333.659363] Starting dynamic subtest: pipe-C-HDMI-A-2
[333.691157] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[333.697441] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.030s)
[334.751366] [054/133] (780s left) kms_content_protection (atomic)
[335.236536] Starting subtest: atomic
[335.617339] Subtest atomic: SKIP (0.025s)
[335.717678] [055/133] (780s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[335.911599] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[335.925110] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[336.071313] [056/133] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[336.274702] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[336.281176] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[336.455227] [057/133] (779s left) kms_vrr (max-min)
[336.636502] Starting subtest: max-min
[336.652203] Subtest max-min: SKIP (0.000s)
[336.806454] [058/133] (779s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[337.010435] Starting subtest: cursor-vs-flip-toggle
[381.926101] Subtest cursor-vs-flip-toggle: SUCCESS (44.918s)
[382.244696] [059/133] (733s left) kms_chamelium_color (ctm-negative)
[382.429056] Subtest ctm-negative: SKIP (0.000s)
[382.556342] [060/133] (733s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[382.745727] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[382.857569] [061/133] (733s left) kms_prime (basic-crc-hybrid)
[383.071254] Subtest basic-crc-hybrid: SKIP (0.000s)
[383.274149] [062/133] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[383.482055] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[386.312363] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.835s)
[386.511554] [063/133] (730s left) kms_vblank (wait-idle)
[386.706349] Starting subtest: wait-idle
[386.709663] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.373911] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.664s)
[389.421180] Starting dynamic subtest: pipe-A-HDMI-A-2
[391.790075] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.410s)
[391.857703] Starting dynamic subtest: pipe-C-HDMI-A-1
[394.174834] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.374s)
[394.220226] Starting dynamic subtest: pipe-C-HDMI-A-2
[396.563308] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.380s)
[396.566742] Subtest wait-idle: SUCCESS (9.860s)
[396.897976] [064/133] (719s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[397.102966] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[398.314317] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.210s)
[398.662274] [065/133] (718s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[398.874607] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[401.253276] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (2.387s)
[401.560323] [066/133] (715s left) gem_exec_nop (basic-sequential)
[401.701593] Starting subtest: basic-sequential
[404.783381] Subtest basic-sequential: SUCCESS (3.088s)
[405.077231] [067/133] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[405.276269] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[405.282911] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[405.463872] [068/133] (711s left) i915_pm_rps (min-max-config-idle)
[405.586127] Starting subtest: min-max-config-idle
[405.956467] Subtest min-max-config-idle: SUCCESS (0.371s)
[406.144872] [069/133] (711s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[406.342793] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[406.463133] [070/133] (710s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[406.577099] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[406.580826] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[406.761830] [071/133] (710s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[406.955616] Starting subtest: x-tiled-32bpp-rotate-180
[410.647177] Subtest x-tiled-32bpp-rotate-180: SUCCESS (3.693s)
[411.111662] [072/133] (706s left) gem_basic (create-close)
[411.216751] Starting subtest: create-close
[411.224776] Subtest create-close: SUCCESS (0.000s)
[411.399778] [073/133] (706s left) gem_caching (reads)
[411.512834] Starting subtest: reads
[417.626179] Subtest reads: SUCCESS (6.108s)
[417.803524] [074/133] (699s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[417.986460] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[418.006283] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[418.679448] [075/133] (699s left) gem_ctx_shared (exec-shared-gtt)
[418.813334] Starting subtest: exec-shared-gtt
[418.816764] Starting dynamic subtest: rcs0
[418.829195] Dynamic subtest rcs0: SUCCESS (0.011s)
[418.866798] Starting dynamic subtest: bcs0
[418.872894] Dynamic subtest bcs0: SUCCESS (0.011s)
[418.910923] Starting dynamic subtest: vcs0
[418.914953] Dynamic subtest vcs0: SUCCESS (0.011s)
[418.952921] Starting dynamic subtest: vecs0
[418.957148] Dynamic subtest vecs0: SUCCESS (0.010s)
[418.961162] Subtest exec-shared-gtt: SUCCESS (0.057s)
[419.160396] [076/133] (698s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[419.366595] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[419.373502] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[419.560534] [077/133] (698s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[419.670234] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[419.787382] [078/133] (698s left) gen7_exec_parse (basic-offset)
[419.901521] Subtest basic-offset: SKIP (0.000s)
[420.022089] [079/133] (698s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[420.202264] Starting subtest: bad-pixel-format-y-tiled-ccs
[420.206137] Starting dynamic subtest: pipe-A-HDMI-A-1
[420.236569] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[420.301175] Starting dynamic subtest: pipe-A-HDMI-A-2
[420.352568] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[420.376237] Starting dynamic subtest: pipe-B-HDMI-A-1
[420.403257] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[420.427358] Starting dynamic subtest: pipe-B-HDMI-A-2
[420.452530] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[420.475671] Starting dynamic subtest: pipe-C-HDMI-A-1
[420.506720] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[420.529516] Starting dynamic subtest: pipe-C-HDMI-A-2
[420.559158] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[420.562096] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.038s)
[421.192635] [080/133] (697s left) kms_hdmi_inject (inject-4k)
[421.715875] Starting subtest: inject-4k
[421.961660] Subtest inject-4k: SUCCESS (0.248s)
[422.413083] [081/133] (696s left) kms_lease (implicit-plane-lease)
[422.607059] Starting subtest: implicit-plane-lease
[422.611097] Subtest implicit-plane-lease: SUCCESS (0.005s)
[422.776267] [082/133] (695s left) syncobj_wait (invalid-reset-one-illegal-handle)
[422.890991] Starting subtest: invalid-reset-one-illegal-handle
[422.894424] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.001s)
[423.078920] [083/133] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[423.296391] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[423.302243] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[423.475244] [084/133] (695s left) kms_psr (pr-cursor-mmap-gtt)
[423.673860] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[423.791787] [085/133] (695s left) gem_exec_params (no-bsd)
[423.911535] Starting subtest: no-bsd
[423.915365] Subtest no-bsd: SUCCESS (0.003s)
[424.108197] [086/133] (694s left) gem_pwrite_snooped
[424.434903] [087/133] (694s left) kms_psr (fbc-psr2-sprite-plane-move)
[424.624521] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[424.742446] [088/133] (694s left) api_intel_allocator (reloc-allocator)
[424.848095] Starting subtest: reloc-allocator
[424.851279] Starting dynamic subtest: basic
[424.854498] Dynamic subtest basic: SUCCESS (0.007s)
[424.877883] Starting dynamic subtest: parallel-one
[424.884050] Dynamic subtest parallel-one: SUCCESS (0.009s)
[424.916724] Starting dynamic subtest: print
[424.920217] Dynamic subtest print: SUCCESS (0.000s)
[424.952915] Starting dynamic subtest: reuse
[424.956665] Dynamic subtest reuse: SUCCESS (0.000s)
[424.988344] Starting dynamic subtest: fork-reopen-allocator
[424.992510] Dynamic subtest fork-reopen-allocator: SUCCESS (0.031s)
[424.996491] Subtest reloc-allocator: SUCCESS (0.062s)
[425.092262] [089/133] (694s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[425.301826] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[425.310038] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[425.495484] [090/133] (693s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[425.709266] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[426.929471] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.217s)
[427.276828] [091/133] (692s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[427.457947] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[433.141167] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.683s)
[433.448486] [092/133] (686s left) gem_exec_reloc (basic-gtt-cpu)
[433.577049] Starting subtest: basic-gtt-cpu
[433.599975] Subtest basic-gtt-cpu: SUCCESS (0.021s)
[433.865510] [093/133] (685s left) kms_addfb_basic (bad-pitch-128)
[433.976710] Starting subtest: bad-pitch-128
[433.980740] Subtest bad-pitch-128: SUCCESS (0.000s)
[434.248657] [094/133] (685s left) kms_setmode (invalid-clone-exclusive-crtc)
[434.378276] Starting subtest: invalid-clone-exclusive-crtc
[434.869164] Subtest invalid-clone-exclusive-crtc: SKIP (0.505s)
[435.178676] [095/133] (684s left) gem_readwrite (read-bad-handle)
[435.290228] Starting subtest: read-bad-handle
[435.296865] Subtest read-bad-handle: SUCCESS (0.000s)
[435.482510] [096/133] (684s left) gem_exec_schedule (preempt-queue-contexts)
[435.636127] Starting subtest: preempt-queue-contexts
[435.639302] Starting dynamic subtest: rcs0
[436.478353] Dynamic subtest rcs0: SUCCESS (0.841s)
[436.504581] Starting dynamic subtest: bcs0
[437.228867] Dynamic subtest bcs0: SUCCESS (0.750s)
[437.259091] Starting dynamic subtest: vcs0
[437.919333] Dynamic subtest vcs0: SUCCESS (0.682s)
[437.942553] Starting dynamic subtest: vecs0
[438.639140] Dynamic subtest vecs0: SUCCESS (0.714s)
[438.642873] Subtest preempt-queue-contexts: SUCCESS (3.007s)
[439.075172] [097/133] (681s left) kms_flip (2x-flip-vs-dpms-on-nop)
[439.253415] Starting subtest: 2x-flip-vs-dpms-on-nop
[439.266438] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[440.992053] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.644s)
[441.060698] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[442.525063] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.615s)
[442.550679] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[444.140415] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.611s)
[444.146040] Subtest 2x-flip-vs-dpms-on-nop: SUCCESS (4.888s)
[444.764409] [098/133] (675s left) kms_cursor_legacy (single-move)
[444.958418] Starting subtest: single-move
[444.961523] Starting dynamic subtest: pipe-A
[450.369950] Dynamic subtest pipe-A: SUCCESS (5.404s)
[450.414600] Starting dynamic subtest: pipe-B
[455.774456] Dynamic subtest pipe-B: SUCCESS (5.405s)
[455.817047] Starting dynamic subtest: pipe-C
[461.184363] Dynamic subtest pipe-C: SUCCESS (5.406s)
[461.273031] Starting dynamic subtest: all-pipes
[466.595808] Dynamic subtest all-pipes: SUCCESS (5.407s)
[466.600590] Subtest single-move: SUCCESS (21.636s)
[466.759808] [099/133] (653s left) i915_module_load (resize-bar)
[466.861222] Starting subtest: resize-bar
[466.877571] Subtest resize-bar: SKIP (0.016s)
[467.020302] [100/133] (653s left) prime_busy (hang)
[467.133429] Starting subtest: hang
[467.137187] Starting dynamic subtest: rcs0
[473.652357] Dynamic subtest rcs0: SUCCESS (6.511s)
[473.677113] Starting dynamic subtest: bcs0
[480.624086] Dynamic subtest bcs0: SUCCESS (6.968s)
[480.647794] Starting dynamic subtest: vcs0
[487.663589] Dynamic subtest vcs0: SUCCESS (7.036s)
[487.688598] Starting dynamic subtest: vecs0
[494.634422] Dynamic subtest vecs0: SUCCESS (6.973s)
[494.638443] Subtest hang: SUCCESS (27.504s)
[494.793269] [101/133] (625s left) i915_suspend (debugfs-reader)
[494.897347] Starting subtest: debugfs-reader
[513.570548] Subtest debugfs-reader: SUCCESS (3.359s)
[525.727034] [102/133] (606s left) gem_exec_reloc (basic-gtt-wc-active)
[525.867645] Starting subtest: basic-gtt-wc-active
[526.007408] Subtest basic-gtt-wc-active: SUCCESS (0.138s)
[526.293384] [103/133] (606s left) kms_flip (nonexisting-fb)
[526.480452] Starting subtest: nonexisting-fb
[526.485312] Starting dynamic subtest: A-HDMI-A1
[527.124574] Dynamic subtest A-HDMI-A1: SUCCESS (0.641s)
[527.175131] Starting dynamic subtest: B-HDMI-A1
[527.530736] Dynamic subtest B-HDMI-A1: SUCCESS (0.401s)
[527.566279] Starting dynamic subtest: C-HDMI-A1
[527.912009] Dynamic subtest C-HDMI-A1: SUCCESS (0.374s)
[527.962656] Starting dynamic subtest: A-HDMI-A2
[528.329934] Dynamic subtest A-HDMI-A2: SUCCESS (0.413s)
[528.382681] Starting dynamic subtest: B-HDMI-A2
[528.741888] Dynamic subtest B-HDMI-A2: SUCCESS (0.407s)
[528.791539] Starting dynamic subtest: C-HDMI-A2
[529.140847] Dynamic subtest C-HDMI-A2: SUCCESS (0.394s)
[529.143953] Subtest nonexisting-fb: SUCCESS (2.664s)
[529.675063] [104/133] (603s left) gem_mmap_offset (mmap-boundaries)
[529.786066] Starting subtest: mmap-boundaries
[529.789402] Starting dynamic subtest: smem0
[530.681677] Dynamic subtest smem0: SUCCESS (0.895s)
[530.687898] Subtest mmap-boundaries: SUCCESS (0.898s)
[530.890841] [105/133] (602s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[531.078698] Starting subtest: cursorA-vs-flipA-atomic-transitions
[542.363355] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.288s)
[542.699086] [106/133] (590s left) gem_cs_tlb (engines)
[542.831750] Starting subtest: engines
[542.835239] Starting dynamic subtest: rcs0
[544.997113] Dynamic subtest rcs0: SUCCESS (2.156s)
[545.025696] Starting dynamic subtest: bcs0
[547.156690] Dynamic subtest bcs0: SUCCESS (2.156s)
[547.188089] Starting dynamic subtest: vcs0
[549.316460] Dynamic subtest vcs0: SUCCESS (2.155s)
[549.350887] Starting dynamic subtest: vecs0
[551.470417] Dynamic subtest vecs0: SUCCESS (2.155s)
[551.474611] Subtest engines: SUCCESS (8.637s)
[551.660515] [107/133] (581s left) gem_exec_fence (basic-busy)
[551.909612] Starting subtest: basic-busy
[551.913348] Starting dynamic subtest: rcs0
[551.933331] Dynamic subtest rcs0: SUCCESS (0.020s)
[551.961870] Starting dynamic subtest: bcs0
[551.971700] Dynamic subtest bcs0: SUCCESS (0.033s)
[552.008495] Starting dynamic subtest: vcs0
[552.016605] Dynamic subtest vcs0: SUCCESS (0.037s)
[552.043736] Starting dynamic subtest: vecs0
[552.051657] Dynamic subtest vecs0: SUCCESS (0.022s)
[552.055626] Subtest basic-busy: SUCCESS (0.127s)
[552.771523] [108/133] (580s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[552.876722] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[552.983421] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[553.160100] [109/133] (580s left) i915_drm_fdinfo (most-busy-check-all)
[553.270550] Starting subtest: most-busy-check-all
[553.273754] Starting dynamic subtest: rcs0
[553.802852] Dynamic subtest rcs0: SUCCESS (0.530s)
[553.830841] Starting dynamic subtest: bcs0
[554.334202] Dynamic subtest bcs0: SUCCESS (0.524s)
[554.362530] Starting dynamic subtest: vcs0
[554.863244] Dynamic subtest vcs0: SUCCESS (0.523s)
[554.897971] Starting dynamic subtest: vecs0
[555.386710] Dynamic subtest vecs0: SUCCESS (0.525s)
[555.390495] Subtest most-busy-check-all: SUCCESS (2.117s)
[555.560620] [110/133] (578s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[555.775679] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[555.782369] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[555.945806] [111/133] (577s left) core_getversion (basic)
[556.055932] Starting subtest: basic
[556.064273] Subtest basic: SUCCESS (0.000s)
[556.242938] [112/133] (577s left) syncobj_timeline (wait-all-for-submit-snapshot)
[556.356571] Starting subtest: wait-all-for-submit-snapshot
[556.438854] Subtest wait-all-for-submit-snapshot: SUCCESS (0.088s)
[556.626121] [113/133] (577s left) kms_async_flips (async-flip-suspend-resume)
[556.813647] Starting subtest: async-flip-suspend-resume
[557.412472] Starting dynamic subtest: pipe-A-HDMI-A-1