[91.919959] Initializing watchdogs
[91.920034]   /dev/watchdog0
[91.936976] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[91.942785] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.945494] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.947401] [001/131] (960s left) syncobj_timeline (wait-all-interrupted)
[91.984950] Starting subtest: wait-all-interrupted
[92.087953] Subtest wait-all-interrupted: SUCCESS (0.102s)
[92.176424] [002/131] (960s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[92.266168] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[92.305391] [003/131] (960s left) sriov_basic (enable-vfs-bind-unbind-each)
[92.338066] Starting subtest: enable-vfs-bind-unbind-each
[92.338795] Starting dynamic subtest: numvfs-1
[92.368055] Dynamic subtest numvfs-1: FAIL (0.017s)
[92.373357] Starting dynamic subtest: numvfs-2
[92.395206] Dynamic subtest numvfs-2: FAIL (0.006s)
[92.400716] Starting dynamic subtest: numvfs-3
[92.422118] Dynamic subtest numvfs-3: FAIL (0.005s)
[92.427246] Starting dynamic subtest: numvfs-4
[92.448433] Dynamic subtest numvfs-4: FAIL (0.006s)
[92.453612] Starting dynamic subtest: numvfs-5
[92.474803] Dynamic subtest numvfs-5: FAIL (0.005s)
[92.479739] Starting dynamic subtest: numvfs-6
[92.500971] Dynamic subtest numvfs-6: FAIL (0.005s)
[92.505766] Starting dynamic subtest: numvfs-7
[92.527182] Dynamic subtest numvfs-7: FAIL (0.005s)
[92.532144] Starting dynamic subtest: numvfs-random
[92.553312] Dynamic subtest numvfs-random: FAIL (0.005s)
[92.553987] Subtest enable-vfs-bind-unbind-each: FAIL (0.057s)
[92.580842] [004/131] (959s left) kms_lease (cursor-implicit-plane)
[92.664607] Starting subtest: cursor-implicit-plane
[92.665337] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.869564] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.203s)
[92.876591] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.023179] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.152s)
[93.033403] Starting dynamic subtest: pipe-C-HDMI-A-1
[93.174722] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.151s)
[93.181145] Starting dynamic subtest: pipe-D-HDMI-A-1
[93.326121] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.150s)
[93.326836] Subtest cursor-implicit-plane: SUCCESS (0.661s)
[93.451267] [005/131] (959s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[93.540698] Starting subtest: flip-vs-cursor-toggle
[101.984379] Subtest flip-vs-cursor-toggle: SUCCESS (8.440s)
[102.150811] [006/131] (950s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[102.634895] Starting subtest: syncobj-timeline-invalid-flags
[102.635958] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[102.820519] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[102.823058] [007/131] (949s left) kms_vrr (seamless-rr-switch-drrs)
[102.908473] Starting subtest: seamless-rr-switch-drrs
[102.910447] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[102.987060] [008/131] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[103.074431] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[103.075784] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[103.176276] [009/131] (949s left) kms_addfb_basic (tile-pitch-mismatch)
[103.208387] Starting subtest: tile-pitch-mismatch
[103.209083] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[103.358893] [010/131] (949s left) gem_eio (in-flight-contexts-10ms)
[103.400305] Starting subtest: in-flight-contexts-10ms
[116.841381] Subtest in-flight-contexts-10ms: SUCCESS (13.438s)
[117.040037] [011/131] (935s left) gen3_render_mixed_blits
[117.112428] [012/131] (935s left) gem_lmem_swapping (heavy-random)
[117.147085] Subtest heavy-random: SKIP (0.000s)
[117.190532] [013/131] (935s left) gem_create (create-ext-set-pat)
[117.341894] Starting subtest: create-ext-set-pat
[117.344071] Subtest create-ext-set-pat: SKIP (0.000s)
[117.426907] [014/131] (935s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[117.513403] Starting subtest: fbc-tiling-linear
[118.634840] Subtest fbc-tiling-linear: SUCCESS (1.121s)
[118.792106] [015/131] (934s left) kms_cdclk (mode-transition)
[118.824840] Subtest mode-transition: SKIP (0.000s)
[118.862627] [016/131] (934s left) gem_mmap_gtt (medium-copy-xy)
[118.894012] Starting subtest: medium-copy-XY
[124.133504] Subtest medium-copy-XY: SUCCESS (5.238s)
[124.226380] [017/131] (928s left) kms_plane (plane-position-hole)
[124.359510] Starting subtest: plane-position-hole
[124.568857] Starting dynamic subtest: pipe-A-plane-1
[124.811331] Dynamic subtest pipe-A-plane-1: SUCCESS (0.243s)
[124.817991] Starting dynamic subtest: pipe-A-plane-2
[125.063274] Dynamic subtest pipe-A-plane-2: SUCCESS (0.251s)
[125.071880] Starting dynamic subtest: pipe-A-plane-3
[125.304533] Dynamic subtest pipe-A-plane-3: SUCCESS (0.241s)
[125.311470] Starting dynamic subtest: pipe-A-plane-4
[125.565432] Dynamic subtest pipe-A-plane-4: SUCCESS (0.260s)
[125.572216] Starting dynamic subtest: pipe-A-plane-5
[125.808230] Dynamic subtest pipe-A-plane-5: SUCCESS (0.243s)
[125.816258] Starting dynamic subtest: pipe-A-plane-6
[126.058406] Dynamic subtest pipe-A-plane-6: SUCCESS (0.249s)
[126.065007] Starting dynamic subtest: pipe-A-plane-7
[126.066374] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[126.242555] Starting dynamic subtest: pipe-B-plane-1
[126.459543] Dynamic subtest pipe-B-plane-1: SUCCESS (0.225s)
[126.467277] Starting dynamic subtest: pipe-B-plane-2
[126.677618] Dynamic subtest pipe-B-plane-2: SUCCESS (0.217s)
[126.684374] Starting dynamic subtest: pipe-B-plane-3
[126.901591] Dynamic subtest pipe-B-plane-3: SUCCESS (0.224s)
[126.910081] Starting dynamic subtest: pipe-B-plane-4
[127.126984] Dynamic subtest pipe-B-plane-4: SUCCESS (0.225s)
[127.135523] Starting dynamic subtest: pipe-B-plane-5
[127.360110] Dynamic subtest pipe-B-plane-5: SUCCESS (0.233s)
[127.368832] Starting dynamic subtest: pipe-B-plane-6
[127.575928] Dynamic subtest pipe-B-plane-6: SUCCESS (0.215s)
[127.584659] Starting dynamic subtest: pipe-B-plane-7
[127.586059] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[127.586781] Subtest plane-position-hole: SUCCESS (3.219s)
[127.731599] [018/131] (925s left) kms_chamelium_hpd (vga-hpd-fast)
[127.872689] Subtest vga-hpd-fast: SKIP (0.000s)
[127.958110] [019/131] (925s left) kms_universal_plane (disable-primary-vs-flip)
[128.046549] Starting subtest: disable-primary-vs-flip
[128.047255] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.376228] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.329s)
[128.383773] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.638842] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.261s)
[128.646417] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.910460] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.270s)
[128.917947] Starting dynamic subtest: pipe-D-HDMI-A-1
[129.215771] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.303s)
[129.216475] Subtest disable-primary-vs-flip: SUCCESS (1.169s)
[129.356979] [020/131] (923s left) kms_psr (psr2-cursor-mmap-cpu)
[129.446424] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[129.486316] [021/131] (923s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[129.573923] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[129.590686] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.009s)
[129.668589] [022/131] (923s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[129.763595] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[130.440264] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.676s)
[130.605745] [023/131] (922s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[130.692479] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[132.390849] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (1.698s)
[132.539345] [024/131] (920s left) vgem_basic (unload)
[132.569832] Starting subtest: unload
[161.613218] Subtest unload: SUCCESS (29.009s)
[161.692534] [025/131] (891s left) kms_pm_rpm (modeset-lpsp)
[163.083214] Starting subtest: modeset-lpsp
[164.377238] Subtest modeset-lpsp: SUCCESS (1.295s)
[164.510802] [026/131] (888s left) kms_psr (psr-cursor-render)
[164.595652] Subtest psr-cursor-render: SKIP (0.000s)
[164.639094] [027/131] (888s left) kms_plane_alpha_blend (alpha-transparent-fb)
[164.722053] Starting subtest: alpha-transparent-fb
[164.787298] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.047706] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.260s)
[165.057233] Starting dynamic subtest: pipe-D-HDMI-A-1
[165.360700] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.312s)
[165.361429] Subtest alpha-transparent-fb: SUCCESS (0.640s)
[165.547415] [028/131] (887s left) kms_plane_cursor (viewport)
[165.632691] Starting subtest: viewport
[165.634098] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[167.038476] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.405s)
[167.086748] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[168.480250] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.407s)
[168.522418] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[169.930322] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.416s)
[170.019585] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[171.467866] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.455s)
[171.503061] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[172.893441] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.400s)
[172.925108] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[174.326644] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.408s)
[174.399149] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[175.787854] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.394s)
[175.822371] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[177.213193] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.400s)
[177.247139] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[178.613346] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.375s)
[178.690903] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[180.110712] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.426s)
[180.142436] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[181.511318] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.375s)
[181.543251] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[182.894558] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.358s)
[182.961898] Subtest viewport: SUCCESS (17.330s)
[183.084825] [029/131] (870s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[183.177988] Starting subtest: bad-pixel-format-y-tiled-ccs
[183.178704] Starting dynamic subtest: pipe-A-HDMI-A-1
[183.185486] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[183.193923] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.200731] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[183.209028] Starting dynamic subtest: pipe-C-HDMI-A-1
[183.215811] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[183.223842] Starting dynamic subtest: pipe-D-HDMI-A-1
[183.231054] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[183.232357] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[183.430232] [030/131] (870s left) gem_userptr_blits (dmabuf-unsync)
[183.468819] Subtest dmabuf-unsync: SKIP (0.000s)
[183.621620] [031/131] (869s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[183.706456] Starting subtest: basic-flip-after-cursor-varying-size
[184.217437] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.507s)
[184.375850] [032/131] (869s left) kms_async_flips (crc-atomic)
[184.461956] Starting subtest: crc-atomic
[184.584198] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.723193] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.131s)
[186.873713] Starting dynamic subtest: pipe-B-HDMI-A-1
[188.988374] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.114s)
[189.111604] Starting dynamic subtest: pipe-C-HDMI-A-1
[191.246428] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.132s)
[191.361630] Starting dynamic subtest: pipe-D-HDMI-A-1
[193.471075] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.108s)
[193.471781] Subtest crc-atomic: SUCCESS (9.001s)
[193.702248] [033/131] (859s left) kms_cursor_crc (cursor-random-512x512)
[193.797558] Starting subtest: cursor-random-512x512
[193.798951] Subtest cursor-random-512x512: SKIP (0.001s)
[193.924183] [034/131] (859s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[194.011897] Starting subtest: fbcpsr-stridechange
[194.013289] Subtest fbcpsr-stridechange: SKIP (0.000s)
[194.122739] [035/131] (859s left) gem_softpin (noreloc-s3)
[194.162405] Starting subtest: noreloc-S3
[213.732394] Subtest noreloc-S3: SUCCESS (5.386s)
[219.860920] [036/131] (839s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[219.898231] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[219.898948] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[219.975698] [037/131] (839s left) gen7_exec_parse (basic-allowed)
[220.011060] Subtest basic-allowed: SKIP (0.000s)
[220.055379] [038/131] (839s left) kms_frontbuffer_tracking (fbc-tiling-y)
[220.148182] Starting subtest: fbc-tiling-y
[221.515120] Subtest fbc-tiling-y: SUCCESS (1.319s)
[221.688106] [039/131] (838s left) gem_pxp (create-regular-context-2)
[221.792370] Starting subtest: create-regular-context-2
[221.793545] Subtest create-regular-context-2: SUCCESS (0.001s)
[221.877395] [040/131] (838s left) kms_cursor_crc (cursor-sliding-256x256)
[221.970108] Starting subtest: cursor-sliding-256x256
[221.975203] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.887858] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.851s)
[223.933178] Starting dynamic subtest: pipe-D-HDMI-A-1
[225.808839] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.834s)
[225.809654] Subtest cursor-sliding-256x256: SUCCESS (3.728s)
[225.994846] [041/131] (834s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[226.096753] Starting subtest: yf-tiled-32bpp-rotate-180
[226.098829] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[226.221983] [042/131] (833s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[226.305821] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[226.307618] Starting dynamic subtest: pipe-A-HDMI-A-1
[226.314192] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[226.321747] Starting dynamic subtest: pipe-B-HDMI-A-1
[226.328336] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[226.335799] Starting dynamic subtest: pipe-C-HDMI-A-1
[226.342330] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[226.349887] Starting dynamic subtest: pipe-D-HDMI-A-1
[226.356578] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[226.357934] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[226.567190] [043/131] (833s left) kms_hdr (static-toggle)
[226.654376] Starting subtest: static-toggle
[226.656527] Subtest static-toggle: SKIP (0.001s)
[226.729341] [044/131] (833s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[226.822994] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[226.824338] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[226.939467] [045/131] (833s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[227.024978] Starting subtest: primary-y-tiled-reflect-x-180
[232.026596] Subtest primary-y-tiled-reflect-x-180: SUCCESS (4.930s)
[232.262434] [046/131] (827s left) gem_mmap_offset (partial-mmap)
[232.294823] Starting subtest: partial-mmap
[232.295645] Starting dynamic subtest: smem0
[232.298547] Dynamic subtest smem0: SUCCESS (0.004s)
[232.299220] Subtest partial-mmap: SUCCESS (0.005s)
[232.429820] [047/131] (827s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[232.465848] Starting subtest: basic-cpu-wc-noreloc
[232.468819] Subtest basic-cpu-wc-noreloc: SUCCESS (0.003s)
[232.606356] [048/131] (827s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[232.694975] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[232.738290] [049/131] (827s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[232.822485] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[232.832186] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[232.933160] [050/131] (827s left) kms_fbcon_fbt (psr-suspend)
[232.969968] Starting subtest: psr-suspend
[232.971336] Subtest psr-suspend: SKIP (0.000s)
[233.090914] [051/131] (827s left) kms_vblank (wait-idle-hang)
[233.175827] Starting subtest: wait-idle-hang
[233.177642] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.739924] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.502s)
[246.751876] Starting dynamic subtest: pipe-D-HDMI-A-1
[261.066108] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.315s)
[261.066803] Subtest wait-idle-hang: SUCCESS (27.824s)
[261.244054] [052/131] (799s left) kms_cursor_crc (cursor-onscreen-256x85)
[261.343155] Starting subtest: cursor-onscreen-256x85
[261.347632] Starting dynamic subtest: pipe-A-HDMI-A-1
[262.534442] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.187s)
[262.581808] Starting dynamic subtest: pipe-D-HDMI-A-1
[263.721739] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.149s)
[263.722461] Subtest cursor-onscreen-256x85: SUCCESS (2.379s)
[263.918489] [053/131] (796s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[264.012642] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[264.014011] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[264.133985] [054/131] (796s left) kms_addfb_basic (bad-pitch-63)
[264.167173] Starting subtest: bad-pitch-63
[264.167872] Subtest bad-pitch-63: SUCCESS (0.000s)
[264.367141] [055/131] (796s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[264.528050] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[264.627980] [056/131] (796s left) gem_exec_fence (syncobj-unused-fence)
[264.959038] Starting subtest: syncobj-unused-fence
[264.961626] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[265.280802] [057/131] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[265.371423] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[265.372817] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[265.483325] [058/131] (795s left) kms_flip (basic-flip-vs-dpms)
[265.567573] Starting subtest: basic-flip-vs-dpms
[265.569556] Starting dynamic subtest: A-HDMI-A1
[266.289301] Dynamic subtest A-HDMI-A1: SUCCESS (0.718s)
[266.296920] Starting dynamic subtest: B-HDMI-A1
[266.916121] Dynamic subtest B-HDMI-A1: SUCCESS (0.625s)
[266.924073] Starting dynamic subtest: C-HDMI-A1
[267.555232] Dynamic subtest C-HDMI-A1: SUCCESS (0.637s)
[267.565256] Starting dynamic subtest: D-HDMI-A1
[268.207071] Dynamic subtest D-HDMI-A1: SUCCESS (0.651s)
[268.208785] Subtest basic-flip-vs-dpms: SUCCESS (2.641s)
[268.390324] [059/131] (792s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[268.487587] Starting subtest: x-tiled-8bpp-rotate-0
[269.500822] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.012s)
[269.646436] [060/131] (791s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[269.737630] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[269.738972] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[269.859187] [061/131] (791s left) gem_exec_reloc (basic-wc-cpu-active)
[269.895313] Starting subtest: basic-wc-cpu-active
[270.025272] Subtest basic-wc-cpu-active: SUCCESS (0.121s)
[270.159991] [062/131] (790s left) kms_flip (basic-plain-flip)
[270.245704] Starting subtest: basic-plain-flip
[270.247681] Starting dynamic subtest: A-HDMI-A1
[270.911970] Dynamic subtest A-HDMI-A1: SUCCESS (0.664s)
[270.929001] Starting dynamic subtest: B-HDMI-A1
[271.576374] Dynamic subtest B-HDMI-A1: SUCCESS (0.659s)
[271.584651] Starting dynamic subtest: C-HDMI-A1
[272.232494] Dynamic subtest C-HDMI-A1: SUCCESS (0.652s)
[272.246168] Starting dynamic subtest: D-HDMI-A1
[272.888282] Dynamic subtest D-HDMI-A1: SUCCESS (0.655s)
[272.891115] Subtest basic-plain-flip: SUCCESS (2.645s)
[273.057306] [063/131] (787s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[273.151722] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[273.153168] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[273.269534] [064/131] (787s left) syncobj_timeline (single-wait-all-available-submitted)
[273.303243] Starting subtest: single-wait-all-available-submitted
[273.303943] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[273.393920] [065/131] (787s left) kms_color (degamma)
[273.476899] Starting subtest: degamma
[273.477612] Starting dynamic subtest: pipe-A-HDMI-A-1
[273.803382] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.325s)
[273.811113] Starting dynamic subtest: pipe-B-HDMI-A-1
[274.111804] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.307s)
[274.119628] Starting dynamic subtest: pipe-C-HDMI-A-1
[274.403300] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.291s)
[274.412057] Starting dynamic subtest: pipe-D-HDMI-A-1
[274.715242] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.309s)
[274.715945] Subtest degamma: SUCCESS (1.237s)
[274.864838] [066/131] (786s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[274.908560] Starting subtest: verify-pxp-stale-buf-optout-execution
[275.973553] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s)
[276.109162] [067/131] (785s left) perf_pmu (rc6-all-gts)
[276.145202] Starting subtest: rc6-all-gts
[276.146618] Subtest rc6-all-gts: SKIP (0.000s)
[276.235499] [068/131] (784s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[276.326913] Starting subtest: psr-rgb565-draw-mmap-gtt
[276.328316] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[276.446096] [069/131] (784s left) kms_pm_rpm (package-g7)
[277.832687] Starting subtest: package-g7
[277.834911] Subtest package-g7: SKIP (0.000s)
[278.029785] [070/131] (783s left) gem_ctx_exec (basic-invalid-context)
[278.065349] Starting subtest: basic-invalid-context
[278.066034] Subtest basic-invalid-context: SUCCESS (0.002s)
[278.196027] [071/131] (783s left) gem_spin_batch (engines)
[278.236485] Starting subtest: engines
[278.237251] Starting dynamic subtest: rcs0
[281.589803] Dynamic subtest rcs0: SUCCESS (3.316s)
[281.600402] Starting dynamic subtest: bcs0
[284.912091] Dynamic subtest bcs0: SUCCESS (3.319s)
[284.922629] Starting dynamic subtest: vcs0
[288.233021] Dynamic subtest vcs0: SUCCESS (3.318s)
[288.243328] Starting dynamic subtest: vcs1
[291.553828] Dynamic subtest vcs1: SUCCESS (3.317s)
[291.564292] Starting dynamic subtest: vecs0
[294.873486] Dynamic subtest vecs0: SUCCESS (3.316s)
[294.874459] Subtest engines: SUCCESS (16.596s)
[295.034735] [072/131] (766s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[295.126633] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[297.597505] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.470s)
[297.725255] [073/131] (763s left) sw_sync (alloc_timeline)
[297.755982] Starting subtest: alloc_timeline
[297.756698] Subtest alloc_timeline: SUCCESS (0.000s)
[297.834974] [074/131] (763s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[297.920918] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[297.922696] Starting dynamic subtest: pipe-A-HDMI-A-1
[297.930209] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[297.937983] Starting dynamic subtest: pipe-B-HDMI-A-1
[297.945442] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[297.953194] Starting dynamic subtest: pipe-C-HDMI-A-1
[297.960647] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[297.968144] Starting dynamic subtest: pipe-D-HDMI-A-1
[297.975782] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[297.977138] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[298.170224] [075/131] (763s left) gem_tiled_wb
[302.840260] [076/131] (758s left) gem_mmap_gtt (basic-copy)
[302.872251] Starting subtest: basic-copy
[303.344991] Subtest basic-copy: SUCCESS (0.464s)
[303.441130] [077/131] (758s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[303.528551] Starting subtest: flip-vs-dpms-off-vs-modeset
[303.530651] Starting dynamic subtest: A-HDMI-A1
[304.216097] Dynamic subtest A-HDMI-A1: SUCCESS (0.684s)
[304.223907] Starting dynamic subtest: B-HDMI-A1
[304.917092] Dynamic subtest B-HDMI-A1: SUCCESS (0.699s)
[304.927255] Starting dynamic subtest: C-HDMI-A1
[305.583774] Dynamic subtest C-HDMI-A1: SUCCESS (0.666s)
[305.592672] Starting dynamic subtest: D-HDMI-A1
[306.194987] Dynamic subtest D-HDMI-A1: SUCCESS (0.610s)
[306.197166] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.668s)
[306.347761] [078/131] (755s left) kms_cursor_legacy (forked-move)
[306.439282] Starting subtest: forked-move
[306.440019] Starting dynamic subtest: pipe-A
[311.892339] Dynamic subtest pipe-A: SUCCESS (5.415s)
[311.900561] Starting dynamic subtest: pipe-B
[317.312838] Dynamic subtest pipe-B: SUCCESS (5.420s)
[317.321354] Starting dynamic subtest: pipe-C
[322.730583] Dynamic subtest pipe-C: SUCCESS (5.418s)
[322.738677] Starting dynamic subtest: pipe-D
[328.149855] Dynamic subtest pipe-D: SUCCESS (5.419s)
[328.159253] Starting dynamic subtest: all-pipes
[333.581850] Dynamic subtest all-pipes: SUCCESS (5.431s)
[333.582740] Subtest forked-move: SUCCESS (27.111s)
[333.646813] [079/131] (727s left) i915_pm_rpm (gem-execbuf)
[335.039918] Starting subtest: gem-execbuf
[335.041106] Starting dynamic subtest: smem0
[338.885970] Dynamic subtest smem0: SUCCESS (3.846s)
[338.886790] Subtest gem-execbuf: SUCCESS (3.848s)
[339.072279] [080/131] (722s left) gem_ctx_sseu (invalid-sseu)
[339.109269] Subtest invalid-sseu: SKIP (0.000s)
[339.153372] [081/131] (722s left) i915_pm_sseu (full-enable)
[339.190050] Subtest full-enable: SKIP (0.000s)
[339.278087] [082/131] (722s left) vgem_basic (second-client)
[339.312760] Starting subtest: second-client
[339.330639] Subtest second-client: SUCCESS (0.017s)
[339.412257] [083/131] (722s left) gem_partial_pwrite_pread (writes-after-reads)
[339.448674] Starting subtest: writes-after-reads
[351.418384] Subtest writes-after-reads: SUCCESS (11.969s)
[351.565752] [084/131] (710s left) i915_drm_fdinfo (most-busy-check-all)
[351.601901] Starting subtest: most-busy-check-all
[351.602661] Starting dynamic subtest: rcs0
[352.158979] Dynamic subtest rcs0: SUCCESS (0.540s)
[352.172506] Starting dynamic subtest: bcs0
[352.688208] Dynamic subtest bcs0: SUCCESS (0.543s)
[352.700277] Starting dynamic subtest: vcs0
[353.226041] Dynamic subtest vcs0: SUCCESS (0.536s)
[353.239297] Starting dynamic subtest: vcs1
[353.754085] Dynamic subtest vcs1: SUCCESS (0.525s)
[353.764921] Starting dynamic subtest: vecs0
[354.286395] Dynamic subtest vecs0: SUCCESS (0.530s)
[354.287466] Subtest most-busy-check-all: SUCCESS (2.685s)
[354.377372] [085/131] (707s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[354.467970] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[354.477594] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.009s)
[354.573392] [086/131] (707s left) sw_sync (sync_multi_consumer)
[354.604866] Starting subtest: sync_multi_consumer
[355.117931] Subtest sync_multi_consumer: SUCCESS (0.505s)
[355.201050] [087/131] (706s left) syncobj_timeline (invalid-signal-bad-pad)
[355.233911] Starting subtest: invalid-signal-bad-pad
[355.234622] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[355.321066] [088/131] (706s left) gem_mmap_gtt (basic-write)
[355.352270] Starting subtest: basic-write
[355.482705] Subtest basic-write: SUCCESS (0.122s)
[355.599765] [089/131] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[355.691387] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[355.692753] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[355.824925] [090/131] (706s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[355.857146] Starting subtest: etime-single-wait-all-for-submit-submitted
[355.965663] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[356.058115] [091/131] (706s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[356.093395] Starting subtest: cpuset-basic-small-copy-XY
[361.379019] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.287s)
[361.497405] [092/131] (700s left) gem_exec_schedule (semaphore-resolve)
[361.592864] Starting subtest: semaphore-resolve
[361.610189] Subtest semaphore-resolve: SUCCESS (0.017s)
[361.926816] [093/131] (700s left) syncobj_basic (bad-flags-fd-to-handle)
[361.960844] Starting subtest: bad-flags-fd-to-handle
[361.961582] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[362.051081] [094/131] (700s left) gem_reg_read (bad-register)
[362.085019] Starting subtest: bad-register
[362.085754] Subtest bad-register: SUCCESS (0.000s)
[362.176797] [095/131] (700s left) gem_eio (wait-10ms)
[362.217483] Starting subtest: wait-10ms
[362.374577] Subtest wait-10ms: SUCCESS (0.156s)
[362.517679] [096/131] (699s left) kms_psr (fbc-psr-primary-blt)
[362.604671] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[362.648897] [097/131] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[362.738283] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[362.739693] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[362.868268] [098/131] (699s left) kms_plane_scaling (planes-downscale-factor-0-75)
[362.953877] Starting subtest: planes-downscale-factor-0-75
[362.954604] Starting dynamic subtest: pipe-A
[363.093697] Dynamic subtest pipe-A: SUCCESS (0.139s)
[363.104334] Starting dynamic subtest: pipe-B
[363.219028] Dynamic subtest pipe-B: SUCCESS (0.124s)
[363.230195] Starting dynamic subtest: pipe-C
[363.345028] Dynamic subtest pipe-C: SUCCESS (0.125s)
[363.355913] Starting dynamic subtest: pipe-D
[363.470021] Dynamic subtest pipe-D: SUCCESS (0.123s)
[363.470816] Subtest planes-downscale-factor-0-75: SUCCESS (0.517s)
[363.668904] [099/131] (698s left) kms_chamelium_edid (hdmi-mode-timings)
[363.806230] Subtest hdmi-mode-timings: SKIP (0.000s)
[363.897837] [100/131] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[363.999168] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[364.000633] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[364.116736] [101/131] (698s left) kms_addfb_basic (basic-y-tiled-legacy)
[364.150655] Starting subtest: basic-y-tiled-legacy
[364.151374] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[364.326077] [102/131] (698s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[364.421164] Starting subtest: 4-tiled-64bpp-rotate-270
[364.422656] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[364.551693] [103/131] (698s left) kms_selftest (drm_damage_helper)
[364.586994] Starting subtest: drm_damage_helper
[364.611812] Starting dynamic subtest: drm_test_damage_iter_no_damage
[364.689256] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.075s)
[364.707665] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[364.780254] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.090s)
[364.800541] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[364.857639] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.071s)
[364.877004] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[364.954845] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.092s)
[364.974526] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[365.037067] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.078s)
[365.054948] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[365.126263] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.087s)
[365.146446] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[365.217295] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.086s)
[365.237238] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[365.302181] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.081s)
[365.322168] Starting dynamic subtest: drm_test_damage_iter_single_damage
[365.394587] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.089s)
[365.413907] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[365.481555] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.082s)
[365.496854] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[365.565271] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.082s)
[365.585357] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[365.652646] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.084s)
[365.671560] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[365.729646] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.075s)
[365.745493] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[365.815790] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.084s)
[365.833852] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[365.890777] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.072s)
[365.908743] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[365.954020] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.060s)
[365.971002] Starting dynamic subtest: drm_test_damage_iter_damage
[366.027664] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.071s)
[366.047097] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[366.109777] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.077s)
[366.127732] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[366.203282] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.091s)
[366.223311] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[366.288716] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.082s)
[366.306576] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[366.356745] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.065s)
[366.357853] Subtest drm_damage_helper: SUCCESS (1.769s)
[366.519294] [104/131] (696s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[366.609600] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[367.894021] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.284s)
[368.044112] [105/131] (694s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[368.135878] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[368.136617] Starting dynamic subtest: pipe-A-valid-mode
[369.299861] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.162s)
[369.300727] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (1.165s)
[369.472861] [106/131] (693s left) gem_exec_schedule (preempt-engines)
[369.520808] Starting subtest: preempt-engines
[369.521526] Starting dynamic subtest: rcs0
[369.597698] Dynamic subtest rcs0: SUCCESS (0.077s)
[369.609604] Starting dynamic subtest: bcs0
[369.681699] Dynamic subtest bcs0: SUCCESS (0.082s)
[369.693720] Starting dynamic subtest: vcs0
[369.762719] Dynamic subtest vcs0: SUCCESS (0.080s)
[369.774685] Starting dynamic subtest: vcs1
[369.846326] Dynamic subtest vcs1: SUCCESS (0.082s)
[369.855847] Starting dynamic subtest: vecs0
[369.927273] Dynamic subtest vecs0: SUCCESS (0.080s)
[369.928035] Subtest preempt-engines: SUCCESS (0.408s)
[370.246439] [107/131] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[370.337668] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[370.339126] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[370.438619] [108/131] (692s left) gem_ctx_persistence (hang)
[370.477108] Starting subtest: hang
[370.479334] Subtest hang: SUCCESS (0.002s)
[370.560490] [109/131] (692s left) kms_psr (fbc-pr-primary-mmap-gtt)
[370.645596] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[370.685393] [110/131] (692s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[370.728734] Starting subtest: map-fixed-invalidate-overlap
[370.729504] Starting dynamic subtest: gtt
[370.810914] Dynamic subtest gtt: SUCCESS (0.081s)
[370.821423] Starting dynamic subtest: wb
[370.864159] Dynamic subtest wb: SUCCESS (0.052s)
[370.873855] Starting dynamic subtest: wc
[370.916977] Dynamic subtest wc: SUCCESS (0.052s)
[370.926580] Starting dynamic subtest: uc
[370.968761] Dynamic subtest uc: SUCCESS (0.051s)
[370.969464] Subtest map-fixed-invalidate-overlap: SUCCESS (0.241s)
[371.105810] [111/131] (691s left) gem_exec_async (forked-writes)
[371.146623] Starting subtest: forked-writes
[371.147328] Starting dynamic subtest: rcs0
[371.172074] Dynamic subtest rcs0: SUCCESS (0.025s)
[371.182711] Starting dynamic subtest: bcs0
[371.197161] Dynamic subtest bcs0: SUCCESS (0.024s)
[371.207517] Starting dynamic subtest: vcs0
[371.221997] Dynamic subtest vcs0: SUCCESS (0.024s)
[371.231503] Starting dynamic subtest: vcs1
[371.247182] Dynamic subtest vcs1: SUCCESS (0.024s)
[371.257084] Starting dynamic subtest: vecs0
[371.272408] Dynamic subtest vecs0: SUCCESS (0.024s)
[371.273194] Subtest forked-writes: SUCCESS (0.126s)
[371.480932] [112/131] (691s left) kms_busy (extended-pageflip-hang-newfb)
[371.570326] Starting subtest: extended-pageflip-hang-newfb
[371.571189] Starting dynamic subtest: pipe-A
[386.060398] Dynamic subtest pipe-A: SUCCESS (14.486s)
[386.071926] Starting dynamic subtest: pipe-D
[399.858363] Dynamic subtest pipe-D: SUCCESS (13.789s)
[399.859175] Subtest extended-pageflip-hang-newfb: SUCCESS (28.282s)
[400.036571] [113/131] (663s left) api_intel_allocator (reserve-simple)
[400.072160] Starting subtest: reserve-simple
[400.072991] Subtest reserve-simple: SUCCESS (0.001s)
[400.225805] [114/131] (662s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[400.313784] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[400.314490] Starting dynamic subtest: pipe-A-HDMI-A-1
[400.331869] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[400.339868] Starting dynamic subtest: pipe-B-HDMI-A-1
[400.357561] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[400.365496] Starting dynamic subtest: pipe-C-HDMI-A-1
[400.382510] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[400.390457] Starting dynamic subtest: pipe-D-HDMI-A-1
[400.408716] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[400.410140] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.014s)
[400.570688] [115/131] (662s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[400.659721] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[400.661110] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[400.758313] [116/131] (662s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[400.846082] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[402.252704] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (1.406s)
[402.411875] [117/131] (660s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[402.450625] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[402.451342] Starting dynamic subtest: smem
[402.525773] Dynamic subtest smem: SUCCESS (0.075s)
[402.526513] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.076s)
[402.728846] [118/131] (660s left) gem_exec_whisper (basic-contexts-forked)
[402.771758] Starting subtest: basic-contexts-forked
[405.330721] Subtest basic-contexts-forked: SUCCESS (2.550s)
[405.524405] [119/131] (657s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[405.560081] Starting subtest: invalid-bsd2-flag-on-vebox
[405.560852] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[405.662392] [120/131] (657s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[405.695125] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[405.797690] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[405.889878] [121/131] (657s left) sysfs_timeslice_duration (duration)
[405.925789] Starting subtest: duration
[405.927765] Starting dynamic subtest: vecs0
[406.010844] Dynamic subtest vecs0: SUCCESS (0.083s)
[406.031199] Starting dynamic subtest: vcs0
[406.102126] Dynamic subtest vcs0: SUCCESS (0.088s)
[406.123613] Starting dynamic subtest: bcs0
[406.179652] Dynamic subtest bcs0: SUCCESS (0.074s)
[406.198575] Starting dynamic subtest: rcs0
[406.260082] Dynamic subtest rcs0: SUCCESS (0.077s)
[406.279117] Starting dynamic subtest: vcs1
[406.340700] Dynamic subtest vcs1: SUCCESS (0.078s)
[406.344118] Subtest duration: SUCCESS (0.417s)
[406.437443] [122/131] (657s left) api_intel_bb (intel-bb-blit-none)
[406.468863] Starting subtest: intel-bb-blit-none
[409.948095] Subtest intel-bb-blit-none: SUCCESS (3.444s)
[410.044299] [123/131] (653s left) gen9_exec_parse (basic-rejected)
[410.081602] Subtest basic-rejected: SKIP (0.000s)
[410.129368] [124/131] (653s left) core_setmaster (master-drop-set-root)
[410.208860] Starting subtest: master-drop-set-root
[410.213654] Subtest master-drop-set-root: SUCCESS (0.005s)
[410.258074] [125/131] (653s left) perf (gen8-unprivileged-single-ctx-counters)
[410.360947] Starting subtest: gen8-unprivileged-single-ctx-counters
[410.362308] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[410.399366] [126/131] (653s left) gem_bad_reloc (negative-reloc-lut)
[410.436594] Starting subtest: negative-reloc-lut
[410.438723] Subtest negative-reloc-lut: SUCCESS (0.000s)
[410.573828] [127/131] (653s left) kms_draw_crc (draw-method-mmap-gtt)
[410.663262] Starting subtest: draw-method-mmap-gtt
[410.664035] Starting dynamic subtest: xrgb8888-untiled
[410.814611] Dynamic subtest xrgb8888-untiled: SUCCESS (0.150s)
[410.834309] Starting dynamic subtest: rgb565-untiled
[410.972820] Dynamic subtest rgb565-untiled: SUCCESS (0.156s)
[410.991188] Starting dynamic subtest: xrgb2101010-untiled
[411.114493] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.139s)
[411.132089] Starting dynamic subtest: xbgr16161616f-untiled
[411.264708] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.148s)
[411.281346] Starting dynamic subtest: xrgb8888-xtiled
[411.339836] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.073s)
[411.358113] Starting dynamic subtest: rgb565-xtiled
[411.423069] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[411.442255] Starting dynamic subtest: xrgb2101010-xtiled
[411.498069] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.073s)
[411.514198] Starting dynamic subtest: xbgr16161616f-xtiled
[411.573546] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.072s)
[411.590802] Starting dynamic subtest: xrgb8888-ytiled
[411.656451] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.080s)
[411.674161] Starting dynamic subtest: rgb565-ytiled
[411.739876] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[411.759308] Starting dynamic subtest: xrgb2101010-ytiled
[411.814960] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.072s)
[411.832534] Starting dynamic subtest: xbgr16161616f-ytiled
[411.923352] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.106s)
[411.926585] Subtest draw-method-mmap-gtt: SUCCESS (1.261s)
[412.041947] [128/131] (651s left) kms_flip (dpms-vs-vblank-race-interruptible)
[412.139606] Starting subtest: dpms-vs-vblank-race-interruptible
[412.142877] Starting dynamic subtest: A-HDMI-A1
[414.958452] Dynamic subtest A-HDMI-A1: SUCCESS (2.814s)
[414.968437] Starting dynamic subtest: B-HDMI-A1
[417.727101] Dynamic subtest B-HDMI-A1: SUCCESS (2.766s)
[417.738630] Starting dynamic subtest: C-HDMI-A1
[420.523517] Dynamic subtest C-HDMI-A1: SUCCESS (2.795s)
[420.537103] Starting dynamic subtest: D-HDMI-A1
[423.268001] Dynamic subtest D-HDMI-A1: SUCCESS (2.741s)
[423.268750] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.126s)
[423.405032] [129/131] (640s left) i915_drm_fdinfo (virtual-busy-idle-all)
[423.448827] Starting subtest: virtual-busy-idle-all
[424.066557] Subtest virtual-busy-idle-all: SUCCESS (0.617s)
[424.153593] [130/131] (639s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[424.245663] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[424.283296] [131/131] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[424.371584] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[424.373047] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[424.490454] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: sriov_basic
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: kms_vrr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: gen3_render_mixed_blits
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cdclk
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: kms_universal_plane
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: vgem_basic
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_plane_alpha_blend
results: parsing output: 27/ for test: kms_plane_cursor
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gen7_exec_parse
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_hdr
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: gem_mmap_offset
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_fbcon_fbt
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_color
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_ctx_exec
results: parsing output: 70/ for test: gem_spin_batch
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_tiled_wb
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: gem_ctx_sseu
results: parsing output: 80/ for test: i915_pm_sseu
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: gem_partial_pwrite_pread
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: syncobj_basic
results: parsing output: 93/ for test: gem_reg_read
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_chamelium_edid
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_selftest
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: gem_exec_async
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: api_intel_allocator
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_render_copy
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: sysfs_timeslice_duration
results: parsing output: 121/ for test: api_intel_bb
results: parsing output: 122/ for test: gen9_exec_parse
results: parsing output: 123/ for test: core_setmaster
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: gem_bad_reloc
results: parsing output: 126/ for test: kms_draw_crc
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: i915_drm_fdinfo
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.