[92.259589] Initializing watchdogs
[92.259757]   /dev/watchdog0
[92.301243] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[92.316111] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.323180] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[92.332593] [001/156] (960s left) gem_exec_schedule (semaphore-user)
[92.514671] Starting subtest: semaphore-user
[92.537707] Subtest semaphore-user: SUCCESS (0.024s)
[92.940881] [002/156] (959s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[93.150494] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[93.255394] [003/156] (959s left) kms_chamelium_color (ctm-max)
[93.463961] Subtest ctm-max: SKIP (0.000s)
[93.566699] [004/156] (959s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[93.764504] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[93.767626] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.787178] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[93.829070] Starting dynamic subtest: pipe-A-HDMI-A-2
[93.849414] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[93.887169] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.903769] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[93.924688] Starting dynamic subtest: pipe-B-HDMI-A-2
[93.938193] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[93.958770] Starting dynamic subtest: pipe-C-HDMI-A-1
[93.971194] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[93.990768] Starting dynamic subtest: pipe-C-HDMI-A-2
[94.003216] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[94.009080] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.019s)
[94.825821] [005/156] (958s left) syncobj_timeline (multi-wait-all-available-submitted)
[94.938487] Starting subtest: multi-wait-all-available-submitted
[94.943427] Subtest multi-wait-all-available-submitted: SUCCESS (0.003s)
[95.078372] [006/156] (958s left) sriov_basic (enable-vfs-autoprobe-on)
[95.199025] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[95.303075] [007/156] (958s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[95.524257] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[95.531182] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s)
[95.662430] [008/156] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[95.886148] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[98.587636] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.706s)
[98.838942] [009/156] (954s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[99.097628] Starting subtest: fbcpsrhdr-2p-rte
[99.105114] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[99.245951] [010/156] (954s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[99.462768] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[100.821372] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.238s)
[101.292445] [011/156] (952s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[101.565066] Starting subtest: y-tiled-8bpp-rotate-90
[102.145321] Subtest y-tiled-8bpp-rotate-90: SKIP (0.578s)
[102.437188] [012/156] (951s left) gem_userptr_blits (coherency-unsync)
[102.577183] Subtest coherency-unsync: SKIP (0.000s)
[102.793459] [013/156] (951s left) gem_exec_flush (basic-wb-set-default)
[102.923169] Starting subtest: basic-wb-set-default
[108.341144] Subtest basic-wb-set-default: SUCCESS (5.417s)
[108.598888] [014/156] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[108.806118] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[108.812170] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.952549] [015/156] (945s left) kms_frontbuffer_tracking (fbc-stridechange)
[109.174618] Starting subtest: fbc-stridechange
[111.324112] Subtest fbc-stridechange: SUCCESS (2.155s)
[111.616325] [016/156] (942s left) kms_getfb (getfb-repeated-different-handles)
[111.819092] Starting subtest: getfb-repeated-different-handles
[111.822626] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[111.967889] [017/156] (942s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[112.185958] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[112.431438] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.244s)
[112.717235] [018/156] (942s left) kms_hdr (static-toggle)
[112.912537] Starting subtest: static-toggle
[112.917309] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[128.663642] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (15.745s)
[128.730871] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[144.420286] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (15.572s)
[144.484940] Starting dynamic subtest: pipe-A-HDMI-A-2-XRGB2101010
[159.418483] Dynamic subtest pipe-A-HDMI-A-2-XRGB2101010: SKIP (15.167s)
[159.463107] Starting dynamic subtest: pipe-A-HDMI-A-2-XRGB16161616F
[174.629581] Dynamic subtest pipe-A-HDMI-A-2-XRGB16161616F: SKIP (15.201s)
[174.636375] Subtest static-toggle: SKIP (61.712s)
[175.110246] [019/156] (879s left) gem_eio (in-flight-internal-1us)
[175.261050] Starting subtest: in-flight-internal-1us
[175.396943] Subtest in-flight-internal-1us: SUCCESS (0.123s)
[175.661658] [020/156] (879s left) kms_cursor_crc (cursor-onscreen-64x64)
[175.877108] Starting subtest: cursor-onscreen-64x64
[175.933540] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.736896] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.803s)
[178.858478] Starting dynamic subtest: pipe-C-HDMI-A-1
[181.209316] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.397s)
[181.215228] Subtest cursor-onscreen-64x64: SUCCESS (5.332s)
[181.589270] [021/156] (873s left) gem_pxp (display-protected-crc)
[184.254461] Starting subtest: display-protected-crc
[184.262392] Subtest display-protected-crc: SKIP (0.000s)
[184.388896] [022/156] (870s left) kms_pm_rpm (dpms-lpsp)
[186.317678] Starting subtest: dpms-lpsp
[186.327280] Subtest dpms-lpsp: SKIP (0.001s)
[186.811894] [023/156] (868s left) kms_psr (pr-sprite-render)
[187.012845] Subtest pr-sprite-render: SKIP (0.000s)
[187.127251] [024/156] (868s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt)
[187.349170] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt
[188.668367] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SUCCESS (1.316s)
[188.866518] [025/156] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[189.085921] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[189.095129] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[189.262138] [026/156] (866s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[189.483496] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[189.491929] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[189.646972] [027/156] (865s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[189.872825] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[189.880677] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[190.045972] [028/156] (865s left) syncobj_wait (invalid-signal-zero-handles)
[190.162279] Starting subtest: invalid-signal-zero-handles
[190.166184] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[190.315462] [029/156] (865s left) kms_content_protection (legacy)
[190.540415] Starting subtest: legacy
[190.565028] Subtest legacy: SKIP (0.016s)
[190.715564] [030/156] (865s left) kms_cursor_crc (cursor-sliding-128x42)
[190.930570] Starting subtest: cursor-sliding-128x42
[191.023580] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.266584] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.241s)
[195.417150] Starting dynamic subtest: pipe-C-HDMI-A-1
[199.106195] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.737s)
[199.109981] Subtest cursor-sliding-128x42: SUCCESS (8.180s)
[199.495195] [031/156] (856s left) kms_big_fb (linear-8bpp-rotate-180)
[199.715099] Starting subtest: linear-8bpp-rotate-180
[203.719908] Subtest linear-8bpp-rotate-180: SUCCESS (4.004s)
[204.045900] [032/156] (852s left) kms_rotation_crc (sprite-rotation-180)
[204.243684] Starting subtest: sprite-rotation-180
[215.449411] Subtest sprite-rotation-180: SUCCESS (11.213s)
[215.759170] [033/156] (840s left) perf (gen12-group-exclusive-stream-ctx-handle)
[215.995887] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[216.004539] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[216.107780] [034/156] (840s left) gem_exec_balancer (parallel-keep-in-fence)
[216.356054] Subtest parallel-keep-in-fence: SKIP (0.000s)
[216.508949] [035/156] (839s left) perf_pmu (busy-double-start)
[216.630873] Starting subtest: busy-double-start
[216.635813] Starting dynamic subtest: rcs0
[220.184687] Dynamic subtest rcs0: SUCCESS (3.554s)
[220.211912] Starting dynamic subtest: bcs0
[223.739111] Dynamic subtest bcs0: SUCCESS (3.549s)
[223.764370] Starting dynamic subtest: vcs0
[227.287122] Dynamic subtest vcs0: SUCCESS (3.544s)
[227.314610] Starting dynamic subtest: vecs0
[230.836100] Dynamic subtest vecs0: SUCCESS (3.545s)
[230.840551] Subtest busy-double-start: SUCCESS (14.211s)
[230.992284] [036/156] (825s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[231.180877] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[231.188455] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[231.326413] [037/156] (825s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite)
[231.539208] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite
[231.548160] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[231.681265] [038/156] (825s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[231.881534] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[231.988988] [039/156] (824s left) perf (polling-parameterized)
[232.206022] Starting subtest: polling-parameterized
[252.258659] Subtest polling-parameterized: SUCCESS (20.050s)
[252.362626] [040/156] (804s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[252.546141] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.000s)
[252.668457] [041/156] (804s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[252.870831] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[252.991330] [042/156] (804s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[253.215805] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[256.280314] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.069s)
[256.579697] [043/156] (800s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[257.146154] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[257.551536] [044/156] (799s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[257.765350] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[257.776528] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[258.947182] [045/156] (798s left) i915_pm_rpm (gem-pread)
[260.996822] Starting subtest: gem-pread
[261.831607] Subtest gem-pread: SUCCESS (0.830s)
[262.192749] [046/156] (795s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[262.394903] Starting subtest: primary-x-tiled-reflect-x-0
[262.401380] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s)
[262.541431] [047/156] (795s left) kms_atomic (crtc-invalid-params)
[262.749060] Starting subtest: crtc-invalid-params
[262.752470] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.317637] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.567s)
[263.320956] Subtest crtc-invalid-params: SUCCESS (0.577s)
[263.671191] [048/156] (794s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[263.874464] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[263.878237] Starting dynamic subtest: pipe-A-valid-mode
[264.929433] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.055s)
[264.933698] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (1.061s)
[265.327222] [049/156] (792s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[265.444659] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[265.449595] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[265.600955] [050/156] (792s left) prime_vgem (basic-read)
[265.840272] Starting subtest: basic-read
[265.910362] Subtest basic-read: SUCCESS (0.074s)
[266.069634] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[266.077692] [051/156] (792s left) gem_ctx_persistence (legacy-engines-mixed)
[266.201774] Starting subtest: legacy-engines-mixed
[266.206496] Starting dynamic subtest: render
[266.244224] Dynamic subtest render: SUCCESS (0.044s)
[266.291227] Starting dynamic subtest: bsd
[266.295885] Dynamic subtest bsd: SUCCESS (0.048s)
[266.355287] Starting dynamic subtest: blt
[266.366900] Dynamic subtest blt: SUCCESS (0.065s)
[266.415661] Starting dynamic subtest: vebox
[266.439375] Dynamic subtest vebox: SUCCESS (0.063s)
[266.442619] Subtest legacy-engines-mixed: SUCCESS (0.245s)
[266.596456] [052/156] (791s left) gem_create (create-ext-placement-each)
[266.833535] Starting subtest: create-ext-placement-each
[266.837925] Subtest create-ext-placement-each: SUCCESS (0.000s)
[266.994321] [053/156] (791s left) gem_eio (execbuf)
[267.136619] Starting subtest: execbuf
[267.184635] Subtest execbuf: SUCCESS (0.046s)
[267.449343] [054/156] (791s left) kms_flip_event_leak (basic)
[267.636583] Starting subtest: basic
[267.639771] Starting dynamic subtest: pipe-A-HDMI-A-1
[268.336920] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.694s)
[268.399175] Starting dynamic subtest: pipe-A-HDMI-A-2
[268.816310] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.469s)
[268.871545] Starting dynamic subtest: pipe-B-HDMI-A-1
[269.253990] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.430s)
[269.300511] Starting dynamic subtest: pipe-B-HDMI-A-2
[269.689688] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.433s)
[269.739991] Starting dynamic subtest: pipe-C-HDMI-A-1
[270.111849] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.417s)
[270.153472] Starting dynamic subtest: pipe-C-HDMI-A-2
[270.577183] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.454s)
[270.581718] Subtest basic: SUCCESS (2.939s)
[270.917507] [055/156] (787s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[271.141460] Starting subtest: fbchdr-rgb101010-draw-blt
[271.892096] Subtest fbchdr-rgb101010-draw-blt: SUCCESS (0.752s)
[272.205290] [056/156] (786s left) i915_query (query-topology-coherent-slice-mask)
[272.321123] Starting subtest: query-topology-coherent-slice-mask
[272.324457] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s)
[272.467351] [057/156] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[272.696166] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[272.702739] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[272.853366] [058/156] (786s left) i915_hangman (gt-error-state-capture)
[273.009141] Starting subtest: gt-error-state-capture
[273.012835] Starting dynamic subtest: rcs0
[283.106204] Dynamic subtest rcs0: SUCCESS (10.096s)
[283.138465] Starting dynamic subtest: bcs0
[293.093715] Dynamic subtest bcs0: SUCCESS (9.984s)
[293.125022] Starting dynamic subtest: vcs0
[303.056735] Dynamic subtest vcs0: SUCCESS (9.960s)
[303.092988] Starting dynamic subtest: vecs0
[313.089364] Dynamic subtest vecs0: SUCCESS (10.023s)
[313.097380] Subtest gt-error-state-capture: SUCCESS (40.088s)
[313.280730] [059/156] (746s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[313.527676] Starting subtest: addfb25-yf-tiled-legacy
[313.530929] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[313.690666] [060/156] (745s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[313.884819] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[313.890212] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.944192] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[313.999607] Starting dynamic subtest: pipe-A-HDMI-A-2
[314.039560] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[314.065552] Starting dynamic subtest: pipe-B-HDMI-A-1
[314.098949] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[314.123506] Starting dynamic subtest: pipe-B-HDMI-A-2
[314.154604] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[314.179223] Starting dynamic subtest: pipe-C-HDMI-A-1
[314.211931] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[314.236744] Starting dynamic subtest: pipe-C-HDMI-A-2
[314.267335] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[314.273326] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.034s)
[314.967408] [061/156] (744s left) gem_linear_blits (normal)
[315.902198] Starting subtest: normal
[330.975978] Subtest normal: SUCCESS (15.076s)
[331.157339] [062/156] (728s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[331.534510] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[331.541860] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[331.711914] [063/156] (728s left) syncobj_wait (invalid-single-wait-unsubmitted)
[331.853977] Starting subtest: invalid-single-wait-unsubmitted
[331.857741] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[331.998875] [064/156] (727s left) kms_pm_lpsp (kms-lpsp)
[333.195323] Starting subtest: kms-lpsp
[333.202572] Subtest kms-lpsp: SKIP (0.001s)
[333.371554] [065/156] (726s left) gem_userptr_blits (create-destroy-unsync)
[333.513082] Subtest create-destroy-unsync: SKIP (0.000s)
[333.703213] [066/156] (726s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[333.911201] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[333.917984] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[334.071399] [067/156] (726s left) gem_spin_batch (resubmit-new-all)
[334.210220] Starting subtest: resubmit-new-all
[334.213754] Starting dynamic subtest: rcs0
[334.223719] Dynamic subtest rcs0: SUCCESS (0.014s)
[334.261764] Starting dynamic subtest: bcs0
[334.265571] Dynamic subtest bcs0: SUCCESS (0.012s)
[334.295831] Starting dynamic subtest: vcs0
[334.299575] Dynamic subtest vcs0: SUCCESS (0.013s)
[334.325297] Starting dynamic subtest: vecs0
[334.329444] Dynamic subtest vecs0: SUCCESS (0.015s)
[334.333414] Subtest resubmit-new-all: SUCCESS (0.073s)
[334.567074] [068/156] (725s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[334.694953] Starting subtest: writes-after-reads-uncached
[356.433289] Subtest writes-after-reads-uncached: SUCCESS (21.741s)
[356.600765] [069/156] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[356.818335] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[356.825578] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[357.132122] [070/156] (703s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[357.742256] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[357.877991] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[358.349615] [071/156] (702s left) tools_test (tools_test)
[358.559526] Starting subtest: tools_test
[358.760497] Subtest tools_test: SUCCESS (0.220s)
[358.929137] [072/156] (702s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[359.136153] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[361.859323] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.730s)
[362.084514] [073/156] (699s left) gem_softpin (noreloc-interruptible)
[362.214117] Starting subtest: noreloc-interruptible
[367.714296] Subtest noreloc-interruptible: SUCCESS (5.492s)
[367.900378] [074/156] (693s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[368.121193] Starting subtest: x-tiled-8bpp-rotate-90
[368.489752] Subtest x-tiled-8bpp-rotate-90: SKIP (0.365s)
[368.816412] [075/156] (692s left) gem_ctx_param (vm)
[368.934303] Starting subtest: vm
[368.989828] Subtest vm: SUCCESS (0.053s)
[369.194848] [076/156] (692s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[369.416085] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[372.489325] Subtest fbchdr-1p-pri-indfb-multidraw: SUCCESS (3.075s)
[372.804946] [077/156] (689s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[372.936769] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[372.940577] Starting dynamic subtest: smem
[373.313973] Dynamic subtest smem: SUCCESS (0.374s)
[373.318743] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.378s)
[373.581166] [078/156] (688s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[373.704952] Starting subtest: writes-after-reads-snoop
[394.278351] Subtest writes-after-reads-snoop: SUCCESS (20.578s)
[394.466302] [079/156] (667s left) gem_close (basic)
[394.594468] Starting subtest: basic
[394.598448] Subtest basic: SUCCESS (0.001s)
[394.790737] [080/156] (667s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[394.906645] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[394.910119] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s)
[395.063803] [081/156] (667s left) gen9_exec_parse (basic-rejected)
[395.205578] Starting subtest: basic-rejected
[395.209551] Subtest basic-rejected: SUCCESS (0.003s)
[395.481287] [082/156] (666s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[395.589855] Starting subtest: multi-wait-for-submit-submitted-signaled
[395.594686] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.003s)
[395.759484] [083/156] (666s left) dumb_buffer (map-uaf)
[395.869975] Starting subtest: map-uaf
[395.883815] Subtest map-uaf: SUCCESS (0.018s)
[396.046323] [084/156] (666s left) gem_vm_create (create-ext)
[396.164347] Starting subtest: create-ext
[396.177142] Subtest create-ext: SUCCESS (0.005s)
[396.330824] [085/156] (666s left) syncobj_wait (wait-for-submit-complex)
[396.441534] Starting subtest: wait-for-submit-complex
[396.506230] Subtest wait-for-submit-complex: SUCCESS (0.067s)
[396.689743] [086/156] (666s left) kms_debugfs (display-off-read-all)
[396.891421] Starting subtest: display-off-read-all
[397.325214] Subtest display-off-read-all: SUCCESS (0.441s)
[397.712459] [087/156] (665s left) gem_exec_fence (syncobj-timeline-chain-engines)
[398.456810] Starting subtest: syncobj-timeline-chain-engines
[398.577240] Subtest syncobj-timeline-chain-engines: SUCCESS (0.122s)
[398.865281] [088/156] (664s left) gem_exec_suspend (basic-s3-devices)
[399.001433] Starting subtest: basic-S3-devices
[399.004892] Starting dynamic subtest: smem
[408.884382] Dynamic subtest smem: SUCCESS (9.880s)
[408.888334] Subtest basic-S3-devices: SUCCESS (9.885s)
[420.171060] [089/156] (653s left) kms_chamelium_frames (hdmi-crc-multiple)
[420.813234] Subtest hdmi-crc-multiple: SKIP (0.000s)
[421.202343] [090/156] (653s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[421.409702] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[421.632791] Starting dynamic subtest: pipe-A-plane-0
[421.930903] Dynamic subtest pipe-A-plane-0: SUCCESS (0.298s)
[421.960358] Starting dynamic subtest: pipe-A-plane-1
[422.215677] Dynamic subtest pipe-A-plane-1: SUCCESS (0.279s)
[422.244701] Starting dynamic subtest: pipe-A-plane-2
[422.499947] Dynamic subtest pipe-A-plane-2: SUCCESS (0.280s)
[422.528573] Starting dynamic subtest: pipe-A-plane-3
[422.780884] Dynamic subtest pipe-A-plane-3: SUCCESS (0.279s)
[423.205555] Starting dynamic subtest: pipe-B-plane-0
[423.441551] Dynamic subtest pipe-B-plane-0: SUCCESS (0.264s)
[423.470637] Starting dynamic subtest: pipe-B-plane-1
[423.741719] Dynamic subtest pipe-B-plane-1: SUCCESS (0.296s)
[423.770974] Starting dynamic subtest: pipe-B-plane-2
[424.026332] Dynamic subtest pipe-B-plane-2: SUCCESS (0.280s)
[424.054796] Starting dynamic subtest: pipe-B-plane-3
[424.291469] Dynamic subtest pipe-B-plane-3: SUCCESS (0.262s)
[424.543273] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SUCCESS (3.142s)
[424.885715] [091/156] (649s left) gem_readwrite (read-write)
[425.002598] Starting subtest: read-write
[425.017713] Subtest read-write: SUCCESS (0.001s)
[425.192164] [092/156] (649s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[425.397032] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[425.404100] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[425.568525] [093/156] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[425.789723] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[425.796976] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[425.951169] [094/156] (648s left) gem_exec_reloc (basic-concurrent0)
[426.083443] Starting subtest: basic-concurrent0
[431.527515] Subtest basic-concurrent0: SUCCESS (5.445s)
[431.785917] [095/156] (643s left) kms_plane_alpha_blend (constant-alpha-mid)
[431.989663] Starting subtest: constant-alpha-mid
[432.159666] Starting dynamic subtest: pipe-A-HDMI-A-1
[433.195991] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.031s)
[433.250590] Starting dynamic subtest: pipe-C-HDMI-A-1
[434.135387] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.923s)
[434.144124] Subtest constant-alpha-mid: SUCCESS (2.141s)
[434.577225] [096/156] (640s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[434.765721] Starting subtest: short-flip-after-cursor-atomic-transitions
[436.178669] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.407s)
[436.562598] [097/156] (638s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[436.779629] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[436.786541] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[436.948890] [098/156] (638s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[437.163077] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[437.177234] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[437.331935] [099/156] (637s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[437.556211] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[437.564095] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[437.716058] [100/156] (637s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[437.940779] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[438.815569] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (0.860s)
[439.123390] [101/156] (636s left) gem_mmap_gtt (cpuset-basic-small-copy)
[439.235404] Starting subtest: cpuset-basic-small-copy
[443.161969] Subtest cpuset-basic-small-copy: SUCCESS (3.924s)
[443.357886] [102/156] (632s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[443.707690] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[443.715048] Starting dynamic subtest: pipe-A
[444.251135] Dynamic subtest pipe-A: SUCCESS (0.551s)
[444.300216] Starting dynamic subtest: pipe-B
[444.699367] Dynamic subtest pipe-B: SUCCESS (0.444s)
[444.762303] Starting dynamic subtest: pipe-C
[444.803305] Dynamic subtest pipe-C: SUCCESS (0.093s)
[444.808381] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (1.100s)
[445.360938] [103/156] (630s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[445.493568] Starting subtest: mixed-tiled-to-y-tiled-ccs
[445.498110] Starting dynamic subtest: smem
[445.744899] Dynamic subtest smem: SUCCESS (0.249s)
[445.749301] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.253s)
[446.026973] [104/156] (629s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[446.244906] Starting subtest: hdr-indfb-scaledprimary
[447.148466] Subtest hdr-indfb-scaledprimary: SUCCESS (0.902s)
[447.485846] [105/156] (628s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[447.697842] Starting subtest: 4-tiled-64bpp-rotate-180
[447.706554] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[447.859364] [106/156] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[448.081449] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[448.089095] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[448.245239] [107/156] (627s left) kms_psr (fbc-psr2-primary-blt)
[448.456194] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[448.586089] [108/156] (627s left) kms_vblank (query-idle)
[448.776533] Starting subtest: query-idle
[448.781576] Starting dynamic subtest: pipe-A-HDMI-A-1
[451.711488] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.932s)
[451.777100] Starting dynamic subtest: pipe-A-HDMI-A-2
[454.131868] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.410s)
[454.199764] Starting dynamic subtest: pipe-C-HDMI-A-1
[456.534725] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.394s)
[456.588849] Starting dynamic subtest: pipe-C-HDMI-A-2
[458.952540] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.398s)
[458.957575] Subtest query-idle: SUCCESS (10.167s)
[459.281507] [109/156] (617s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[459.490297] Starting subtest: nonblocking-crc-frame-sequence
[459.496076] Starting dynamic subtest: pipe-A-HDMI-A-1
[460.535992] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.044s)
[460.577384] Starting dynamic subtest: pipe-B-HDMI-A-2
[461.324441] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.773s)
[461.406278] Starting dynamic subtest: pipe-C-HDMI-A-1
[462.093583] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.767s)
[462.098354] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.605s)
[462.443631] [110/156] (614s left) gem_exec_schedule (preempt-queue-contexts)
[462.629744] Starting subtest: preempt-queue-contexts
[462.633158] Starting dynamic subtest: rcs0
[463.386990] Dynamic subtest rcs0: SUCCESS (0.759s)
[463.423886] Starting dynamic subtest: bcs0
[464.194234] Dynamic subtest bcs0: SUCCESS (0.802s)
[464.264356] Starting dynamic subtest: vcs0
[464.970359] Dynamic subtest vcs0: SUCCESS (0.769s)
[465.022476] Starting dynamic subtest: vecs0
[465.781439] Dynamic subtest vecs0: SUCCESS (0.808s)
[465.786086] Subtest preempt-queue-contexts: SUCCESS (3.159s)
[466.194131] [111/156] (610s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[466.400523] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[467.210385] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (0.809s)
[467.509443] [112/156] (609s left) syncobj_wait (wait-zero-handles)
[467.635122] Starting subtest: wait-zero-handles
[467.639268] Subtest wait-zero-handles: SUCCESS (0.000s)
[467.820185] [113/156] (609s left) api_intel_bb (intel-bb-blit-x)
[467.938907] Starting subtest: intel-bb-blit-x
[471.162662] Subtest intel-bb-blit-x: SUCCESS (3.229s)
[471.340265] [114/156] (605s left) vgem_basic (unload)
[471.448471] Starting subtest: unload
[500.461066] Subtest unload: SUCCESS (29.017s)
[500.688639] [115/156] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[500.907188] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[500.913973] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[501.074813] [116/156] (576s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[501.288600] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[501.296034] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[501.441578] [117/156] (575s left) gem_lmem_swapping (heavy-verify-random)
[501.567845] Subtest heavy-verify-random: SKIP (0.000s)
[501.694656] [118/156] (575s left) gem_exec_balancer (full-late-pulse)
[501.829707] Starting subtest: full-late-pulse
[506.439366] Subtest full-late-pulse: SUCCESS (4.610s)
[506.723975] [119/156] (570s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[506.932738] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[507.875222] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SUCCESS (0.946s)
[508.182074] [120/156] (569s left) syncobj_wait (wait-for-submit-snapshot)
[508.298653] Starting subtest: wait-for-submit-snapshot
[508.383503] Subtest wait-for-submit-snapshot: SUCCESS (0.085s)
[508.543672] [121/156] (569s left) vgem_basic (bad-handle)
[508.661603] Starting subtest: bad-handle
[508.665677] Subtest bad-handle: SUCCESS (0.000s)
[508.842422] [122/156] (568s left) kms_psr (psr-no-drrs)
[509.035532] Subtest psr-no-drrs: SKIP (0.000s)
[509.158709] [123/156] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-onoff)
[509.375338] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-onoff
[509.381617] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[509.577289] [124/156] (568s left) i915_suspend (basic-s3-without-i915)
[509.689445] Starting subtest: basic-s3-without-i915