[88.119952] Initializing watchdogs
[88.120181]   /dev/watchdog0
[88.160250] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.174858] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.183200] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.189328] [001/156] (960s left) kms_atomic (crtc-invalid-params)
[88.391156] Starting subtest: crtc-invalid-params
[88.393239] Starting dynamic subtest: pipe-A-HDMI-A-1
[88.974327] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.576s)
[88.977334] Subtest crtc-invalid-params: SUCCESS (0.581s)
[89.359276] [002/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[89.561208] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[89.566195] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[89.695139] [003/156] (959s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[89.881182] Starting subtest: addfb25-y-tiled-legacy
[89.882747] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[90.039342] [004/156] (958s left) kms_addfb_basic (size-max)
[90.231254] Starting subtest: size-max
[90.233317] Subtest size-max: SUCCESS (0.000s)
[90.375705] [005/156] (958s left) core_auth (getclient-master-drop)
[90.478087] Starting subtest: getclient-master-drop
[90.482381] Subtest getclient-master-drop: SUCCESS (0.006s)
[90.615432] [006/156] (958s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[90.723214] Starting subtest: single-wait-for-submit-available-signaled
[90.728394] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.002s)
[90.862338] [007/156] (958s left) kms_hdmi_inject (inject-4k)
[91.395375] Starting subtest: inject-4k
[91.680832] Subtest inject-4k: SUCCESS (0.286s)
[92.177136] [008/156] (957s left) kms_psr (fbc-pr-primary-page-flip)
[92.383118] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[92.487808] [009/156] (956s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[92.702300] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[92.707565] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.844448] [010/156] (956s left) gem_exec_whisper (basic-sync-all)
[92.994250] Starting subtest: basic-sync-all
[100.169145] Subtest basic-sync-all: SUCCESS (7.175s)
[100.432149] [011/156] (949s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[100.561111] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[100.565243] Starting dynamic subtest: smem
[100.957686] Dynamic subtest smem: SUCCESS (0.395s)
[100.959389] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.396s)
[101.215416] [012/156] (948s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[101.778150] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[102.087125] [013/156] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[102.300442] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[105.168466] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.867s)
[105.490200] [014/156] (944s left) kms_content_protection (atomic)
[105.711638] Starting subtest: atomic
[105.729787] Subtest atomic: SKIP (0.015s)
[105.870924] [015/156] (944s left) testdisplay
[147.796392] [016/156] (902s left) drm_read (empty-block)
[148.257882] Starting subtest: empty-block
[149.260102] Subtest empty-block: SUCCESS (1.001s)
[149.570225] [017/156] (900s left) gem_exec_params (dr1-dirt)
[149.695790] Starting subtest: DR1-dirt
[149.697656] Subtest DR1-dirt: SUCCESS (0.001s)
[149.837711] [018/156] (900s left) kms_flip (flip-vs-expired-vblank-interruptible)
[150.028103] Starting subtest: flip-vs-expired-vblank-interruptible
[150.034558] Starting dynamic subtest: A-HDMI-A1
[155.691077] Dynamic subtest A-HDMI-A1: SUCCESS (5.657s)
[155.718683] Starting dynamic subtest: B-HDMI-A1
[156.371078] Dynamic subtest B-HDMI-A1: FAIL (0.561s)
[156.431279] Starting dynamic subtest: C-HDMI-A1
[161.699218] Dynamic subtest C-HDMI-A1: SUCCESS (5.435s)
[161.722426] Starting dynamic subtest: A-HDMI-A2
[167.161216] Dynamic subtest A-HDMI-A2: SUCCESS (5.457s)
[167.188087] Starting dynamic subtest: B-HDMI-A2
[172.579276] Dynamic subtest B-HDMI-A2: SUCCESS (5.412s)
[172.606427] Starting dynamic subtest: C-HDMI-A2
[177.994066] Dynamic subtest C-HDMI-A2: SUCCESS (5.410s)
[177.995877] Subtest flip-vs-expired-vblank-interruptible: FAIL (27.966s)
[178.528584] [019/156] (871s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[178.729455] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[178.737171] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[178.864597] [020/156] (871s left) kms_pm_rpm (modeset-pc8-residency-stress)
[180.801172] Starting subtest: modeset-pc8-residency-stress
[180.808424] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[181.212244] [021/156] (869s left) kms_fb_coherency (memset-crc)
[181.406216] Starting subtest: memset-crc
[181.410145] Starting dynamic subtest: mmap-gtt
[182.111853] Dynamic subtest mmap-gtt: SUCCESS (0.706s)
[182.398465] Starting dynamic subtest: mmap-offset-wc
[182.762857] Dynamic subtest mmap-offset-wc: SUCCESS (0.411s)
[183.020374] Starting dynamic subtest: mmap-offset-uc
[183.848072] Dynamic subtest mmap-offset-uc: SUCCESS (0.867s)
[184.105017] Starting dynamic subtest: mmap-legacy-wc
[184.498834] Dynamic subtest mmap-legacy-wc: SUCCESS (0.429s)
[184.719147] Subtest memset-crc: SUCCESS (3.310s)
[185.086624] [022/156] (865s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[185.279558] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[185.519034] Starting dynamic subtest: pipe-A-plane-0
[185.983102] Dynamic subtest pipe-A-plane-0: SUCCESS (0.466s)
[186.007485] Starting dynamic subtest: pipe-A-plane-1
[186.418376] Dynamic subtest pipe-A-plane-1: SUCCESS (0.429s)
[186.439449] Starting dynamic subtest: pipe-A-plane-2
[186.834127] Dynamic subtest pipe-A-plane-2: SUCCESS (0.414s)
[186.859777] Starting dynamic subtest: pipe-A-plane-3
[187.267367] Dynamic subtest pipe-A-plane-3: SUCCESS (0.429s)
[187.705059] Starting dynamic subtest: pipe-B-plane-0
[188.115398] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[188.136831] Starting dynamic subtest: pipe-B-plane-1
[188.549672] Dynamic subtest pipe-B-plane-1: SUCCESS (0.430s)
[188.570794] Starting dynamic subtest: pipe-B-plane-2
[188.983432] Dynamic subtest pipe-B-plane-2: SUCCESS (0.430s)
[189.004769] Starting dynamic subtest: pipe-B-plane-3
[189.398294] Dynamic subtest pipe-B-plane-3: SUCCESS (0.413s)
[189.635167] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (4.353s)
[190.101148] [023/156] (860s left) gem_mmap_offset (clear)
[190.204540] Starting subtest: clear
[190.206200] Starting dynamic subtest: smem0
[212.674262] Dynamic subtest smem0: SUCCESS (22.453s)
[212.676071] Subtest clear: SUCCESS (22.457s)
[212.872388] [024/156] (837s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[213.220505] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[213.223422] Starting dynamic subtest: pipe-A
[213.529510] Dynamic subtest pipe-A: SUCCESS (0.313s)
[213.578367] Starting dynamic subtest: pipe-B
[213.998320] Dynamic subtest pipe-B: SUCCESS (0.464s)
[214.045516] Starting dynamic subtest: pipe-C
[214.097737] Dynamic subtest pipe-C: SUCCESS (0.091s)
[214.101880] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.879s)
[214.580147] [025/156] (836s left) kms_psr (psr-cursor-mmap-cpu)
[214.769126] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[214.879914] [026/156] (836s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt)
[215.107280] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt
[215.113128] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[215.249920] [027/156] (835s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[215.472515] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[215.715672] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.240s)
[215.967557] [028/156] (835s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[216.192551] Starting subtest: fbchdr-rgb101010-draw-pwrite
[216.199144] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[216.333391] [029/156] (834s left) syncobj_basic (create-signaled)
[216.447800] Starting subtest: create-signaled
[216.449535] Subtest create-signaled: SUCCESS (0.000s)
[216.584527] [030/156] (834s left) i915_pm_rc6_residency (rc6-fence)
[216.692563] Starting subtest: rc6-fence
[216.712058] Starting dynamic subtest: gt0
[231.975629] Dynamic subtest gt0: SUCCESS (15.268s)
[231.981785] Subtest rc6-fence: SUCCESS (15.289s)
[232.133648] [031/156] (819s left) gem_exec_schedule (pi-common)
[232.411167] Starting subtest: pi-common
[232.414507] Starting dynamic subtest: rcs0
[232.561536] Dynamic subtest rcs0: SUCCESS (0.121s)
[232.589667] Starting dynamic subtest: bcs0
[232.593524] Dynamic subtest bcs0: SUCCESS (0.050s)
[232.619220] Starting dynamic subtest: vcs0
[232.635988] Dynamic subtest vcs0: SUCCESS (0.048s)
[232.681164] Starting dynamic subtest: vecs0
[232.701172] Dynamic subtest vecs0: SUCCESS (0.057s)
[232.703041] Subtest pi-common: SUCCESS (0.289s)
[232.960761] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[232.967536] [032/156] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[233.167051] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[233.170088] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[233.338544] [033/156] (818s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[233.518878] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[233.531101] Starting dynamic subtest: pipe-A-HDMI-A-1
[233.539085] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[233.594908] Starting dynamic subtest: pipe-A-HDMI-A-2
[233.610081] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[233.660094] Starting dynamic subtest: pipe-B-HDMI-A-1
[233.666372] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[233.691337] Starting dynamic subtest: pipe-B-HDMI-A-2
[233.697362] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[233.721766] Starting dynamic subtest: pipe-C-HDMI-A-1
[233.728231] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[233.751830] Starting dynamic subtest: pipe-C-HDMI-A-2
[233.757848] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[233.760831] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.034s)
[234.615947] [034/156] (817s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[234.732496] Starting subtest: multi-wait-all-for-submit-signaled
[234.735762] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s)
[234.895953] [035/156] (816s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[235.114087] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[235.118814] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[235.281817] [036/156] (816s left) kms_pm_rpm (drm-resources-equal)
[237.234265] Starting subtest: drm-resources-equal
[238.557095] Subtest drm-resources-equal: SUCCESS (1.324s)
[238.877127] [037/156] (813s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[239.080376] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[239.083745] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[239.229050] [038/156] (812s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[239.449448] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[239.457550] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[239.610848] [039/156] (812s left) vgem_basic (bad-fence)
[239.736129] Starting subtest: bad-fence
[239.738451] Subtest bad-fence: SUCCESS (0.000s)
[239.862538] [040/156] (812s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[240.088596] Starting subtest: y-tiled-16bpp-rotate-180
[244.058623] Subtest y-tiled-16bpp-rotate-180: SUCCESS (3.980s)
[244.413202] [041/156] (807s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[244.614200] Starting subtest: psr-dirtyfb-ioctl
[244.634212] Subtest psr-dirtyfb-ioctl: SKIP (0.002s)
[244.762910] [042/156] (807s left) api_intel_allocator (gem-pool)
[244.873475] Starting subtest: gem-pool
[244.888114] Subtest gem-pool: SUCCESS (0.018s)
[245.062763] [043/156] (807s left) kms_big_fb (linear-64bpp-rotate-180)
[245.270482] Starting subtest: linear-64bpp-rotate-180
[250.826155] Subtest linear-64bpp-rotate-180: SUCCESS (5.556s)
[251.374686] [044/156] (801s left) gem_exec_schedule (fifo)
[251.512673] Starting subtest: fifo
[251.514688] Starting dynamic subtest: rcs0
[251.637644] Dynamic subtest rcs0: SUCCESS (0.120s)
[251.676341] Starting dynamic subtest: bcs0
[251.773726] Dynamic subtest bcs0: SUCCESS (0.131s)
[251.813187] Starting dynamic subtest: vcs0
[251.901956] Dynamic subtest vcs0: SUCCESS (0.122s)
[251.931965] Starting dynamic subtest: vecs0
[252.024794] Dynamic subtest vecs0: SUCCESS (0.118s)
[252.027671] Subtest fifo: SUCCESS (0.508s)
[252.431491] [045/156] (800s left) gem_softpin (overlap)
[252.558295] Starting subtest: overlap
[255.118257] Subtest overlap: SUCCESS (2.561s)
[255.282566] [046/156] (797s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[255.496229] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[255.501142] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[255.662689] [047/156] (797s left) i915_drm_fdinfo (memory-info-idle)
[255.785852] Starting subtest: memory-info-idle
[255.789175] Starting dynamic subtest: smem0
[255.825441] Dynamic subtest smem0: SUCCESS (0.037s)
[255.827376] Subtest memory-info-idle: SUCCESS (0.041s)
[255.983571] [048/156] (797s left) syncobj_timeline (invalid-transfer-bad-pad)
[256.102820] Starting subtest: invalid-transfer-bad-pad
[256.104489] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[256.251446] [049/156] (796s left) i915_hangman (gt-engine-hang)
[256.387562] Starting subtest: gt-engine-hang
[256.390135] Starting dynamic subtest: rcs0
[256.983111] Dynamic subtest rcs0: SUCCESS (0.594s)
[257.014288] Starting dynamic subtest: bcs0
[257.558783] Dynamic subtest bcs0: SUCCESS (0.574s)
[257.591470] Starting dynamic subtest: vcs0
[258.139686] Dynamic subtest vcs0: SUCCESS (0.577s)
[258.173781] Starting dynamic subtest: vecs0
[258.721904] Dynamic subtest vecs0: SUCCESS (0.578s)
[258.730624] Subtest gt-engine-hang: SUCCESS (2.341s)
[258.898174] [050/156] (794s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[259.117575] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[261.441846] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (2.325s)
[261.763179] [051/156] (791s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[261.960085] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[261.963162] Starting dynamic subtest: pipe-A-HDMI-A-1
[261.988494] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[262.041333] Starting dynamic subtest: pipe-A-HDMI-A-2
[262.075474] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[262.126427] Starting dynamic subtest: pipe-B-HDMI-A-1
[262.146515] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[262.179766] Starting dynamic subtest: pipe-B-HDMI-A-2
[262.196364] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[262.222087] Starting dynamic subtest: pipe-C-HDMI-A-1
[262.237212] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[262.261282] Starting dynamic subtest: pipe-C-HDMI-A-2
[262.276441] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[262.279474] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.051s)
[263.098192] [052/156] (790s left) kms_psr (fbc-psr-sprite-render)
[263.303086] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[263.438954] [053/156] (790s left) gem_pread (display)
[263.548363] Starting subtest: display
[266.645272] Subtest display: SUCCESS (3.095s)
[266.800306] [054/156] (786s left) kms_flip (blocking-wf_vblank)
[266.993271] Starting subtest: blocking-wf_vblank
[267.005087] Starting dynamic subtest: A-HDMI-A1
[273.174760] Dynamic subtest A-HDMI-A1: SUCCESS (6.176s)
[273.205180] Starting dynamic subtest: B-HDMI-A1
[278.895628] Dynamic subtest B-HDMI-A1: SUCCESS (5.714s)
[278.927440] Starting dynamic subtest: C-HDMI-A1
[284.592613] Dynamic subtest C-HDMI-A1: SUCCESS (5.692s)
[284.623233] Starting dynamic subtest: A-HDMI-A2
[290.480657] Dynamic subtest A-HDMI-A2: SUCCESS (5.884s)
[290.511923] Starting dynamic subtest: B-HDMI-A2
[296.359972] Dynamic subtest B-HDMI-A2: SUCCESS (5.872s)
[296.390757] Starting dynamic subtest: C-HDMI-A2
[302.052968] Dynamic subtest C-HDMI-A2: SUCCESS (5.687s)
[302.068065] Subtest blocking-wf_vblank: SUCCESS (35.067s)
[302.637270] [055/156] (751s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[302.838394] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[302.843092] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[302.986152] [056/156] (750s left) syncobj_basic (bad-destroy-pad)
[303.091258] Starting subtest: bad-destroy-pad
[303.094568] Subtest bad-destroy-pad: SUCCESS (0.000s)
[303.253734] [057/156] (750s left) kms_plane (plane-position-hole-dpms)
[303.450040] Starting subtest: plane-position-hole-dpms
[304.205074] Starting dynamic subtest: pipe-A-plane-1
[305.097240] Dynamic subtest pipe-A-plane-1: SUCCESS (0.894s)
[305.155130] Starting dynamic subtest: pipe-A-plane-2
[306.046367] Dynamic subtest pipe-A-plane-2: SUCCESS (0.946s)
[306.096530] Starting dynamic subtest: pipe-A-plane-3
[306.939161] Dynamic subtest pipe-A-plane-3: SUCCESS (0.887s)
[306.975740] Starting dynamic subtest: pipe-A-plane-4
[306.981587] Dynamic subtest pipe-A-plane-4: SUCCESS (0.015s)
[307.473215] Starting dynamic subtest: pipe-B-plane-1
[308.336643] Dynamic subtest pipe-B-plane-1: SUCCESS (0.887s)
[308.389608] Starting dynamic subtest: pipe-B-plane-2
[309.217534] Dynamic subtest pipe-B-plane-2: SUCCESS (0.887s)
[309.265552] Starting dynamic subtest: pipe-B-plane-3
[310.052245] Dynamic subtest pipe-B-plane-3: SUCCESS (0.829s)
[310.083134] Starting dynamic subtest: pipe-B-plane-4
[310.088085] Dynamic subtest pipe-B-plane-4: SUCCESS (0.010s)
[310.090102] Subtest plane-position-hole-dpms: SUCCESS (6.625s)
[310.473357] [058/156] (743s left) kms_chamelium_color (ctm-0-50)
[310.673045] Subtest ctm-0-50: SKIP (0.000s)
[310.832151] [059/156] (743s left) kms_properties (plane-properties-legacy)
[311.012346] Starting subtest: plane-properties-legacy
[311.016123] Starting dynamic subtest: pipe-A-HDMI-A-1
[311.712101] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.693s)
[311.742301] Starting dynamic subtest: pipe-B-HDMI-A-2
[312.347819] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.625s)
[312.382929] Starting dynamic subtest: pipe-C-HDMI-A-1
[312.958195] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.609s)
[312.961322] Subtest plane-properties-legacy: SUCCESS (1.945s)
[313.359511] [060/156] (741s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[313.470948] Starting subtest: wait-all-for-submit-delayed-submit
[313.573843] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s)
[313.737495] [061/156] (740s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[313.933420] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[313.937963] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[314.099463] [062/156] (740s left) kms_psr (pr-sprite-blt)
[314.286087] Subtest pr-sprite-blt: SKIP (0.000s)
[314.403886] [063/156] (740s left) kms_frontbuffer_tracking (fbc-tiling-4)
[314.608520] Starting subtest: fbc-tiling-4
[314.613581] Subtest fbc-tiling-4: SKIP (0.000s)
[314.795476] [064/156] (740s left) gem_userptr_blits (userfault)
[314.916621] Starting subtest: userfault
[314.926947] Subtest userfault: SUCCESS (0.011s)
[315.133255] [065/156] (739s left) gem_exec_reloc (basic-wc-noreloc)
[315.254555] Starting subtest: basic-wc-noreloc
[315.261870] Subtest basic-wc-noreloc: SUCCESS (0.008s)
[315.526142] [066/156] (739s left) gem_exec_whisper (basic-contexts-all)
[315.660998] Starting subtest: basic-contexts-all
[326.585483] Subtest basic-contexts-all: SUCCESS (10.923s)
[326.852863] [067/156] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[327.075371] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[327.080889] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[327.232875] [068/156] (727s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[327.430360] Starting subtest: hdr-1p-pri-indfb-multidraw
[327.436496] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[327.584062] [069/156] (727s left) kms_vblank (invalid)
[327.769971] Starting subtest: invalid
[327.772524] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.415178] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.641s)
[328.417574] Subtest invalid: SUCCESS (0.649s)
[328.811909] [070/156] (726s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[329.014087] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[332.027082] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SUCCESS (3.012s)
[332.230969] [071/156] (723s left) prime_busy (after)
[332.352824] Starting subtest: after
[332.366774] Starting dynamic subtest: rcs0
[332.375085] Dynamic subtest rcs0: SUCCESS (0.010s)
[332.416226] Starting dynamic subtest: bcs0
[332.419642] Dynamic subtest bcs0: SUCCESS (0.008s)
[332.443733] Starting dynamic subtest: vcs0
[332.446301] Dynamic subtest vcs0: SUCCESS (0.015s)
[332.471417] Starting dynamic subtest: vecs0
[332.473415] Dynamic subtest vecs0: SUCCESS (0.011s)
[332.532774] Subtest after: SUCCESS (0.182s)
[332.727748] [072/156] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[332.943265] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[332.949081] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[333.096574] [073/156] (722s left) syncobj_timeline (multi-wait-submitted-signaled)
[333.209878] Starting subtest: multi-wait-submitted-signaled
[333.213784] Subtest multi-wait-submitted-signaled: SUCCESS (0.004s)
[333.359297] [074/156] (722s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[333.575939] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[333.579456] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[333.730848] [075/156] (722s left) gem_exec_schedule (u-fairslice-all)
[333.874223] Starting subtest: u-fairslice-all
[335.981292] Subtest u-fairslice-all: SUCCESS (2.109s)
[336.397272] [076/156] (719s left) kms_color (deep-color)
[336.586066] Starting subtest: deep-color
[336.591776] Subtest deep-color: SKIP (0.000s)
[336.745245] [077/156] (719s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[336.959294] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[336.964067] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.110863] [078/156] (719s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[337.307375] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[337.313145] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[337.460526] [079/156] (718s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[337.590163] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[337.594224] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[337.864429] [080/156] (718s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[338.071582] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[341.143623] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.070s)
[341.498079] [081/156] (715s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[341.712978] Starting subtest: hdr-rgb565-draw-mmap-wc
[341.717079] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[341.864734] [082/156] (714s left) perf (global-sseu-config-invalid)
[342.122662] Starting subtest: global-sseu-config-invalid
[342.125171] Starting dynamic subtest: 0-rcs0
[342.158061] Dynamic subtest 0-rcs0: SUCCESS (0.034s)
[342.160468] Subtest global-sseu-config-invalid: SUCCESS (0.038s)
[342.283187] [083/156] (714s left) kms_pipe_crc_basic (nonblocking-crc)
[342.483314] Starting subtest: nonblocking-crc
[342.486767] Starting dynamic subtest: pipe-A-HDMI-A-1
[343.534076] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.044s)
[343.579480] Starting dynamic subtest: pipe-B-HDMI-A-2
[344.290833] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.753s)
[344.333501] Starting dynamic subtest: pipe-C-HDMI-A-1
[345.031363] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.735s)
[345.040153] Subtest nonblocking-crc: SUCCESS (2.555s)
[345.393615] [084/156] (711s left) syncobj_wait (wait-delayed-signal)
[345.512277] Starting subtest: wait-delayed-signal
[345.616388] Subtest wait-delayed-signal: SUCCESS (0.105s)
[345.768258] [085/156] (711s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[345.964627] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[345.967965] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[346.130906] [086/156] (710s left) gem_busy (extended)
[346.397361] Starting subtest: extended
[346.400171] Starting dynamic subtest: rcs0
[346.421472] Dynamic subtest rcs0: SUCCESS (0.023s)
[346.454433] Starting dynamic subtest: bcs0
[346.456253] Dynamic subtest bcs0: SUCCESS (0.016s)
[346.482179] Starting dynamic subtest: vcs0
[346.483812] Dynamic subtest vcs0: SUCCESS (0.014s)
[346.509428] Starting dynamic subtest: vecs0
[346.512102] Dynamic subtest vecs0: SUCCESS (0.014s)
[346.514788] Subtest extended: SUCCESS (0.083s)
[346.766572] [087/156] (710s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[346.980013] Starting subtest: x-tiled-64bpp-rotate-270
[347.392117] Subtest x-tiled-64bpp-rotate-270: SKIP (0.406s)
[347.730363] [088/156] (709s left) gem_madvise (dontneed-after-mmap)
[347.835069] Starting subtest: dontneed-after-mmap
[347.850185] Subtest dontneed-after-mmap: SUCCESS (0.017s)
[348.042236] [089/156] (709s left) gem_spin_batch (legacy-resubmit)
[348.180166] Starting subtest: legacy-resubmit
[348.182780] Starting dynamic subtest: default
[348.190749] Dynamic subtest default: SUCCESS (0.005s)
[348.245393] Starting dynamic subtest: render
[348.247308] Dynamic subtest render: SUCCESS (0.004s)
[348.272573] Starting dynamic subtest: bsd
[348.274869] Dynamic subtest bsd: SUCCESS (0.004s)
[348.299454] Starting dynamic subtest: bsd1
[348.301811] Dynamic subtest bsd1: SUCCESS (0.004s)
[348.328422] Starting dynamic subtest: blt
[348.331211] Dynamic subtest blt: SUCCESS (0.006s)
[348.361386] Starting dynamic subtest: vebox
[348.363932] Dynamic subtest vebox: SUCCESS (0.004s)
[348.366760] Subtest legacy-resubmit: SUCCESS (0.054s)
[348.543633] [090/156] (708s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[348.735161] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[348.737835] Starting dynamic subtest: pipe-A-HDMI-A-1
[348.759226] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[348.814204] Starting dynamic subtest: pipe-A-HDMI-A-2
[348.857382] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[348.883409] Starting dynamic subtest: pipe-B-HDMI-A-1
[348.913262] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[348.943226] Starting dynamic subtest: pipe-B-HDMI-A-2
[348.958675] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[348.985721] Starting dynamic subtest: pipe-C-HDMI-A-1
[349.002363] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[349.028246] Starting dynamic subtest: pipe-C-HDMI-A-2
[349.043307] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[349.044931] Subtest missing-ccs-buffer-y-tiled-ccs: SUCCESS (0.050s)
[349.952293] [091/156] (707s left) gem_eio (create)
[350.106173] Starting subtest: create
[350.204507] Subtest create: SUCCESS (0.091s)
[350.468189] [092/156] (707s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[350.682891] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[350.686987] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[350.851677] [093/156] (706s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[351.061381] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[351.065472] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[351.218380] [094/156] (706s left) gem_pipe_control_store_loop (fresh-buffer)
[351.343091] Starting subtest: fresh-buffer
[353.496104] Subtest fresh-buffer: SUCCESS (2.152s)
[353.667595] [095/156] (704s left) kms_flip (basic-plain-flip)
[353.859290] Starting subtest: basic-plain-flip
[353.861092] Starting dynamic subtest: A-HDMI-A1
[355.049564] Dynamic subtest A-HDMI-A1: SUCCESS (1.187s)
[355.081607] Starting dynamic subtest: B-HDMI-A1
[355.963626] Dynamic subtest B-HDMI-A1: SUCCESS (0.906s)
[355.992254] Starting dynamic subtest: C-HDMI-A1
[356.905153] Dynamic subtest C-HDMI-A1: SUCCESS (0.936s)
[356.937958] Starting dynamic subtest: A-HDMI-A2
[357.807844] Dynamic subtest A-HDMI-A2: SUCCESS (0.898s)
[357.839921] Starting dynamic subtest: B-HDMI-A2
[358.714035] Dynamic subtest B-HDMI-A2: SUCCESS (0.899s)
[358.746444] Starting dynamic subtest: C-HDMI-A2
[359.616278] Dynamic subtest C-HDMI-A2: SUCCESS (0.894s)
[359.617955] Subtest basic-plain-flip: SUCCESS (5.760s)
[360.178992] [096/156] (697s left) kms_flip (2x-flip-vs-panning)
[360.375074] Starting subtest: 2x-flip-vs-panning
[360.390567] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[371.228766] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.843s)
[371.261298] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[382.052079] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.815s)
[382.086158] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[392.942193] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.884s)
[392.947057] Subtest 2x-flip-vs-panning: SUCCESS (32.569s)
[393.600303] [097/156] (664s left) gen9_exec_parse (bb-start-far)
[393.738841] Starting subtest: bb-start-far
[393.740772] Subtest bb-start-far: SUCCESS (0.005s)
[394.023496] [098/156] (664s left) gem_exec_fence (keep-in-fence)
[394.285714] Starting subtest: keep-in-fence
[394.289419] Starting dynamic subtest: rcs0
[394.323887] Dynamic subtest rcs0: SUCCESS (0.034s)
[394.357315] Starting dynamic subtest: bcs0
[394.449665] Dynamic subtest bcs0: SUCCESS (0.123s)
[394.484354] Starting dynamic subtest: vcs0
[394.499130] Dynamic subtest vcs0: SUCCESS (0.043s)
[394.529340] Starting dynamic subtest: vecs0
[394.552898] Dynamic subtest vecs0: SUCCESS (0.049s)
[394.555427] Subtest keep-in-fence: SUCCESS (0.269s)
[395.291268] [099/156] (663s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[395.398306] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[395.500467] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[395.666445] [100/156] (662s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[395.864407] Starting subtest: primary-x-tiled-reflect-x-180
[395.869615] Subtest primary-x-tiled-reflect-x-180: SKIP (0.004s)
[396.015803] [101/156] (662s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[396.222963] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[396.226545] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[396.381851] [102/156] (662s left) kms_invalid_mode (bad-htotal)
[396.569121] Starting subtest: bad-htotal
[396.572328] Starting dynamic subtest: pipe-A-HDMI-A-1
[397.007953] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.437s)
[397.045177] Starting dynamic subtest: pipe-A-HDMI-A-2
[397.046876] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.005s)
[397.076257] Starting dynamic subtest: pipe-B-HDMI-A-1
[397.077932] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.003s)
[397.108763] Starting dynamic subtest: pipe-B-HDMI-A-2
[397.113153] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.004s)
[397.169254] Starting dynamic subtest: pipe-C-HDMI-A-1
[397.174365] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s)
[397.207332] Starting dynamic subtest: pipe-C-HDMI-A-2
[397.211375] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.005s)
[397.215423] Subtest bad-htotal: SUCCESS (0.508s)
[397.509737] [103/156] (661s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[397.621629] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[397.733630] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.111s)
[397.913637] [104/156] (661s left) gem_mmap_gtt (big-copy-odd)
[398.023480] Starting subtest: big-copy-odd
[407.282456] Subtest big-copy-odd: SUCCESS (9.257s)
[407.459179] [105/156] (651s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw)
[407.831123] Starting subtest: psrhdr-2p-pri-indfb-multidraw
[407.835317] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[407.998163] [106/156] (651s left) gem_flink_race (flink_close)
[408.100837] Starting subtest: flink_close
[413.119503] Subtest flink_close: SUCCESS (5.018s)
[413.282216] [107/156] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[413.479689] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[413.486176] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[413.629965] [108/156] (645s left) gem_ctx_exec (basic-norecovery)
[413.751210] Starting subtest: basic-norecovery
[413.788958] Subtest basic-norecovery: SUCCESS (0.034s)
[413.965429] [109/156] (645s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[414.163126] Starting subtest: psr-rgb101010-draw-blt
[414.167950] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[414.359139] [110/156] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[414.567103] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[414.571559] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[414.729492] [111/156] (645s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[414.927209] Starting subtest: fbc-shrfb-scaledprimary
[416.209154] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.283s)
[416.530167] [112/156] (643s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[416.745806] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[416.750126] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[416.912882] [113/156] (643s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[417.145475] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[418.473998] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.332s)
[418.841890] [114/156] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[419.056463] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[421.129099] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SUCCESS (2.069s)
[421.346980] [115/156] (638s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[421.563255] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[421.567273] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[421.729075] [116/156] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[421.921181] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[421.927182] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[422.080693] [117/156] (638s left) kms_psr (fbc-psr2-primary-render)
[422.266059] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[422.389649] [118/156] (638s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[422.608316] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[422.613390] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[422.766443] [119/156] (637s left) kms_rotation_crc (multiplane-rotation)
[422.946076] Starting subtest: multiplane-rotation
[552.498055] Disk usage limit exceeded.
[553.449918] Closing watchdogs
[553.458169] Initializing watchdogs
[553.458308]   /dev/watchdog0
[553.505469] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[553.530474] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[553.533471] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[553.535243] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[553.541424] [120/156] (507s left) kms_lease (invalid-create-leases)
[553.745570] Starting subtest: invalid-create-leases
[553.756973] Subtest invalid-create-leases: SUCCESS (0.015s)
[553.937172] [121/156] (506s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[554.159200] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[554.164734] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.001s)
[554.321580] [122/156] (506s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[554.541211] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[554.545809] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[554.707852] [123/156] (506s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[554.902639] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[554.907224] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[555.053588] [124/156] (506s left) kms_cursor_crc (cursor-offscreen-256x85)
[555.275565] Starting subtest: cursor-offscreen-256x85
[555.359055] Starting dynamic subtest: pipe-A-HDMI-A-1
[558.234203] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.875s)
[558.368236] Starting dynamic subtest: pipe-C-HDMI-A-1
[560.890680] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.573s)
[560.892256] Subtest cursor-offscreen-256x85: SUCCESS (5.613s)
[561.331825] [125/156] (499s left) kms_big_fb (yf-tiled-addfb)
[561.548779] Starting subtest: yf-tiled-addfb
[561.551258] Subtest yf-tiled-addfb: SUCCESS (0.001s)
[561.701854] [126/156] (499s left) gem_userptr_blits (dmabuf-unsync)
[561.827523] Subtest dmabuf-unsync: SKIP (0.000s)
[562.036564] [127/156] (499s left) kms_cursor_crc (cursor-random-256x256)
[562.243061] Starting subtest: cursor-random-256x256
[562.308252] Starting dynamic subtest: pipe-A-HDMI-A-1
[566.469339] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.159s)
[566.602101] Starting dynamic subtest: pipe-C-HDMI-A-1
[570.463943] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.908s)
[570.469027] Subtest cursor-random-256x256: SUCCESS (8.216s)
[570.857383] [128/156] (490s left) kms_chamelium_edid (hdmi-mode-timings)
[571.504272] Subtest hdmi-mode-timings: SKIP (0.000s)
[571.884154] [129/156] (489s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[572.083718] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[572.202420] [130/156] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[572.412073] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[572.418177] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[572.576139] [131/156] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[572.788663] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[572.793177] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.001s)
[572.944771] [132/156] (489s left) gem_mmap_wc (write-gtt-read-wc)
[573.064653] Starting subtest: write-gtt-read-wc
[573.531573] Subtest write-gtt-read-wc: SUCCESS (0.473s)
[573.695829] [133/156] (488s left) kms_getfb (getfb-handle-protection)
[573.899425] Starting subtest: getfb-handle-protection
[573.923671] Subtest getfb-handle-protection: SUCCESS (0.030s)
[574.095343] [134/156] (488s left) kms_vblank (ts-continuation-idle-hang)
[574.290079] Starting subtest: ts-continuation-idle-hang
[574.300212] Starting dynamic subtest: pipe-A-HDMI-A-1
[581.874405] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.575s)
[581.940162] Starting dynamic subtest: pipe-A-HDMI-A-2
[588.862352] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.978s)
[588.902473] Starting dynamic subtest: pipe-C-HDMI-A-1
[595.829118] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.955s)
[595.887397] Starting dynamic subtest: pipe-C-HDMI-A-2
[602.862733] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.030s)
[602.869214] Subtest ts-continuation-idle-hang: SUCCESS (28.578s)
[603.219750] [135/156] (459s left) gem_create (create-invalid-size)
[603.333790] Starting subtest: create-invalid-size
[603.335415] Subtest create-invalid-size: SUCCESS (0.000s)
[603.611637] [136/156] (458s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[603.809219] Starting subtest: cursorA-vs-flipB-legacy
[615.262255] Subtest cursorA-vs-flipB-legacy: SUCCESS (11.451s)
[615.698992] [137/156] (446s left) gem_mmap_wc (write-prefaulted)
[615.807016] Starting subtest: write-prefaulted
[615.993172] Subtest write-prefaulted: SUCCESS (0.188s)
[616.146411] [138/156] (446s left) perf (i915-ref-count)
[616.385317] Starting subtest: i915-ref-count
[616.450668] Subtest i915-ref-count: SUCCESS (0.069s)
[616.603435] [139/156] (446s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[616.818120] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[617.687541] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (0.870s)
[617.989238] [140/156] (444s left) gem_ctx_engines (none)
[618.123047] Starting subtest: none
[618.124784] Subtest none: SUCCESS (0.003s)
[618.392694] [141/156] (444s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[618.581341] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[618.712574] [142/156] (444s left) i915_pm_rps (waitboost)
[618.842428] Starting subtest: waitboost
[622.417905] Subtest waitboost: SUCCESS (3.579s)
[622.579783] [143/156] (440s left) kms_cursor_edge_walk (128x128-top-bottom)
[622.793912] Starting subtest: 128x128-top-bottom
[622.798242] Starting dynamic subtest: pipe-A-HDMI-A-1
[626.692963] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.898s)
[626.747543] Starting dynamic subtest: pipe-C-HDMI-A-1
[630.163861] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.466s)
[630.166295] Subtest 128x128-top-bottom: SUCCESS (7.376s)
[630.543442] [144/156] (432s left) kms_atomic_interruptible (universal-setplane-primary)
[630.748732] Starting subtest: universal-setplane-primary
[630.760275] Starting dynamic subtest: pipe-A-HDMI-A-1
[637.627740] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.871s)
[637.630164] Subtest universal-setplane-primary: SUCCESS (6.880s)
[638.095151] [145/156] (425s left) gem_exec_big (single)
[638.226679] Starting subtest: single
[690.189603] Subtest single: SUCCESS (51.959s)
[690.833828] [146/156] (372s left) gem_exec_balancer (full-late)
[691.097317] Starting subtest: full-late
[696.517059] Subtest full-late: SUCCESS (5.420s)
[696.814174] [147/156] (366s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[697.045973] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[697.050291] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[697.212628] [148/156] (366s left) gem_lmem_swapping (verify-random)
[697.341611] Subtest verify-random: SKIP (0.000s)
[697.456265] [149/156] (366s left) gem_ctx_persistence (legacy-engines-cleanup)
[697.584607] Starting subtest: legacy-engines-cleanup
[697.586244] Starting dynamic subtest: render
[697.624367] Dynamic subtest render: SUCCESS (0.039s)
[697.656722] Starting dynamic subtest: bsd
[697.658322] Dynamic subtest bsd: SUCCESS (0.026s)
[697.705314] Starting dynamic subtest: blt
[697.709073] Dynamic subtest blt: SUCCESS (0.033s)
[697.760543] Starting dynamic subtest: vebox
[697.763930] Dynamic subtest vebox: SUCCESS (0.032s)
[697.767109] Subtest legacy-engines-cleanup: SUCCESS (0.162s)
[697.942091] [150/156] (365s left) core_setmaster (master-drop-set-shared-fd)
[698.135997] Starting subtest: master-drop-set-shared-fd
[698.176796] Subtest master-drop-set-shared-fd: SUCCESS (0.042s)
[698.280420] [151/156] (365s left) kms_addfb_basic (unused-pitches)
[698.387635] Starting subtest: unused-pitches
[698.390085] Subtest unused-pitches: SUCCESS (0.000s)
[698.632162] [152/156] (365s left) gem_mmap_wc (read)
[698.740094] Starting subtest: read
[698.766303] Subtest read: SUCCESS (0.027s)
[698.932542] [153/156] (365s left) perf_pmu (faulting-read)
[699.048823] Starting subtest: faulting-read
[699.050815] Starting dynamic subtest: gtt
[699.057843] Dynamic subtest gtt: SUCCESS (0.005s)
[699.085142] Starting dynamic subtest: wb
[699.088699] Dynamic subtest wb: SUCCESS (0.002s)
[699.114651] Starting dynamic subtest: wc
[699.116203] Dynamic subtest wc: SUCCESS (0.002s)
[699.142482] Starting dynamic subtest: uc
[699.144130] Dynamic subtest uc: SUCCESS (0.003s)
[699.145726] Subtest faulting-read: SUCCESS (0.030s)
[699.249253] [154/156] (365s left) gem_userptr_blits (access-control)
[699.417848] Starting subtest: access-control
[699.421047] Subtest access-control: SKIP (0.000s)
[699.582693] [155/156] (364s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[699.782219] Starting subtest: cursorB-vs-flipB-atomic-transitions
[711.164742] Subtest cursorB-vs-flipB-atomic-transitions: SUCCESS (11.377s)
[711.588981] [156/156] (352s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[711.803520] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[711.807234] Starting dynamic subtest: pipe-A-HDMI-A-1
[711.835062] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[711.888137] Starting dynamic subtest: pipe-A-HDMI-A-2
[711.941810] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[711.990840] Starting dynamic subtest: pipe-B-HDMI-A-1
[712.006648] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[712.033750] Starting dynamic subtest: pipe-B-HDMI-A-2
[712.048866] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[712.075282] Starting dynamic subtest: pipe-C-HDMI-A-1
[712.090222] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[712.116047] Starting dynamic subtest: pipe-C-HDMI-A-2
[712.130896] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[712.133926] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.042s)
[712.959930] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: core_auth
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_hdmi_inject
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: testdisplay
results: parsing output: 15/ for test: drm_read
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_fb_coherency
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: gem_mmap_offset
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_basic
results: parsing output: 29/ for test: i915_pm_rc6_residency
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_dirtyfb
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: i915_hangman
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_pread
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_basic
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: kms_properties
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_color
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: gem_busy
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_madvise
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_pipe_control_store_loop
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_invalid_mode
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_flink_race
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_ctx_exec
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_chamelium_edid
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_wc
results: parsing output: 132/ for test: kms_getfb
results: parsing output: 133/ for test: kms_vblank
results: parsing output: 134/ for test: gem_create
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: gem_mmap_wc
results: parsing output: 137/ for test: perf
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_ctx_engines
results: parsing output: 140/ for test: kms_psr2_sf
results: parsing output: 141/ for test: i915_pm_rps
results: parsing output: 142/ for test: kms_cursor_edge_walk
results: parsing output: 143/ for test: kms_atomic_interruptible
results: parsing output: 144/ for test: gem_exec_big
results: parsing output: 145/ for test: gem_exec_balancer
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_lmem_swapping
results: parsing output: 148/ for test: gem_ctx_persistence
results: parsing output: 149/ for test: core_setmaster
results: parsing output: 150/ for test: kms_addfb_basic
results: parsing output: 151/ for test: gem_mmap_wc
results: parsing output: 152/ for test: perf_pmu
results: parsing output: 153/ for test: gem_userptr_blits
results: parsing output: 154/ for test: kms_cursor_legacy
results: parsing output: 155/ for test: kms_ccs
Done.