[89.799638] Initializing watchdogs
[89.799809]   /dev/watchdog0
[89.842155] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.856767] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.864990] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.873327] [001/153] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[90.105873] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[93.147412] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SUCCESS (3.052s)
[93.386691] [002/153] (957s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[93.614416] Starting subtest: fbc-rgb565-draw-mmap-wc
[96.382120] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.771s)
[96.686159] [003/153] (953s left) core_getclient (basic)
[96.796738] Starting subtest: basic
[96.800125] Subtest basic: SUCCESS (0.000s)
[96.950374] [004/153] (953s left) gem_tiled_partial_pwrite_pread (writes)
[97.079143] Starting subtest: writes
[99.182925] Subtest writes: SUCCESS (2.103s)
[99.339773] [005/153] (951s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[99.554402] Starting subtest: x-tiled-16bpp-rotate-180
[103.081566] Subtest x-tiled-16bpp-rotate-180: SUCCESS (3.530s)
[103.439751] [006/153] (947s left) gem_exec_reloc (basic-write-read)
[103.571312] Starting subtest: basic-write-read
[103.589072] Subtest basic-write-read: SUCCESS (0.017s)
[103.807286] [007/153] (947s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[103.940237] Starting subtest: legacy-engines-hostile-preempt
[103.943386] Starting dynamic subtest: render
[104.016819] Dynamic subtest render: SUCCESS (0.079s)
[104.039426] Starting dynamic subtest: bsd
[104.095472] Dynamic subtest bsd: SUCCESS (0.077s)
[104.117263] Starting dynamic subtest: blt
[104.193221] Dynamic subtest blt: SUCCESS (0.098s)
[104.215345] Starting dynamic subtest: vebox
[104.276739] Dynamic subtest vebox: SUCCESS (0.081s)
[104.280582] Subtest legacy-engines-hostile-preempt: SUCCESS (0.343s)
[104.449411] [008/153] (946s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[104.642693] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[104.646222] Starting dynamic subtest: pipe-A
[104.963374] Dynamic subtest pipe-A: SUCCESS (0.325s)
[105.002647] Starting dynamic subtest: pipe-B
[105.429571] Dynamic subtest pipe-B: SUCCESS (0.465s)
[105.476244] Starting dynamic subtest: pipe-C
[105.515612] Dynamic subtest pipe-C: SUCCESS (0.085s)
[105.520623] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.878s)
[106.017842] [009/153] (945s left) kms_cursor_crc (cursor-sliding-64x21)
[106.213134] Starting subtest: cursor-sliding-64x21
[106.250996] Starting dynamic subtest: pipe-A-HDMI-A-1
[110.247664] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.994s)
[110.334278] Starting dynamic subtest: pipe-C-HDMI-A-1
[114.055951] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.744s)
[114.059829] Subtest cursor-sliding-64x21: SUCCESS (7.843s)
[114.441997] [010/153] (936s left) kms_cursor_crc (cursor-offscreen-64x21)
[114.648592] Starting subtest: cursor-offscreen-64x21
[114.699415] Starting dynamic subtest: pipe-A-HDMI-A-1
[117.551788] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.850s)
[117.638497] Starting dynamic subtest: pipe-C-HDMI-A-1
[120.179286] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.551s)
[120.183030] Subtest cursor-offscreen-64x21: SUCCESS (5.522s)
[120.568339] [011/153] (930s left) gem_exec_reloc (basic-wc-active)
[120.693318] Starting subtest: basic-wc-active
[120.835470] Subtest basic-wc-active: SUCCESS (0.140s)
[121.068773] [012/153] (930s left) kms_vblank (ts-continuation-idle)
[121.270131] Starting subtest: ts-continuation-idle
[121.273280] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.958610] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.688s)
[121.986471] Starting dynamic subtest: pipe-A-HDMI-A-2
[122.391182] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.426s)
[122.437108] Starting dynamic subtest: pipe-C-HDMI-A-1
[122.793660] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.395s)
[122.820246] Starting dynamic subtest: pipe-C-HDMI-A-2
[123.229942] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.431s)
[123.233632] Subtest ts-continuation-idle: SUCCESS (1.962s)
[123.565284] [013/153] (927s left) gem_reg_read (timestamp-moving)
[123.681298] Starting subtest: timestamp-moving
[124.688649] Subtest timestamp-moving: SUCCESS (1.001s)
[124.811461] [014/153] (926s left) kms_cursor_crc (cursor-sliding-128x42)
[125.013607] Starting subtest: cursor-sliding-128x42
[125.060115] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.079114] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.006s)
[129.201051] Starting dynamic subtest: pipe-C-HDMI-A-1
[132.934193] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.779s)
[132.937804] Subtest cursor-sliding-128x42: SUCCESS (7.917s)
[133.269499] [015/153] (918s left) kms_plane_alpha_blend (alpha-opaque-fb)
[133.470983] Starting subtest: alpha-opaque-fb
[133.631243] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.073892] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.494s)
[135.097580] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.135420] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.336s)
[136.139693] Subtest alpha-opaque-fb: FAIL (2.002s)
[136.246278] [016/153] (915s left) gem_exec_gttfill (all-engines)
[136.382519] Starting subtest: all-engines
[166.463250] Subtest all-engines: SUCCESS (30.082s)
[166.741831] [017/153] (885s left) kms_getfb (getfb2-handle-zero)
[167.088402] Starting subtest: getfb2-handle-zero
[167.091466] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[167.243569] [018/153] (884s left) gem_mmap_wc (read)
[167.358374] Starting subtest: read
[167.382503] Subtest read: SUCCESS (0.027s)
[167.517426] [019/153] (884s left) gem_mmap_gtt (big-copy-xy)
[167.629306] Starting subtest: big-copy-XY
[178.083145] Subtest big-copy-XY: SUCCESS (10.455s)
[178.271824] [020/153] (873s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[178.625932] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[178.630181] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.674407] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[178.721491] Starting dynamic subtest: pipe-A-HDMI-A-2
[178.764444] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[178.806372] Starting dynamic subtest: pipe-B-HDMI-A-1
[178.842340] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[178.866141] Starting dynamic subtest: pipe-B-HDMI-A-2
[178.898192] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[178.922951] Starting dynamic subtest: pipe-C-HDMI-A-1
[178.952837] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[178.975806] Starting dynamic subtest: pipe-C-HDMI-A-2
[179.007582] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[179.013735] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.036s)
[179.728419] [021/153] (872s left) kms_chamelium_edid (dp-edid-resolution-list)
[180.317120] Subtest dp-edid-resolution-list: SKIP (0.000s)
[180.647082] [022/153] (871s left) kms_flip (blocking-wf_vblank)
[180.851940] Starting subtest: blocking-wf_vblank
[180.856771] Starting dynamic subtest: A-HDMI-A1
[186.889030] Dynamic subtest A-HDMI-A1: SUCCESS (6.040s)
[186.917864] Starting dynamic subtest: B-HDMI-A1
[192.603935] Dynamic subtest B-HDMI-A1: SUCCESS (5.710s)
[192.630331] Starting dynamic subtest: C-HDMI-A1
[198.478333] Dynamic subtest C-HDMI-A1: SUCCESS (5.868s)
[198.502816] Starting dynamic subtest: A-HDMI-A2
[204.343717] Dynamic subtest A-HDMI-A2: SUCCESS (5.863s)
[204.370142] Starting dynamic subtest: B-HDMI-A2
[210.052156] Dynamic subtest B-HDMI-A2: SUCCESS (5.703s)
[210.075933] Starting dynamic subtest: C-HDMI-A2
[215.931073] Dynamic subtest C-HDMI-A2: SUCCESS (5.876s)
[215.936078] Subtest blocking-wf_vblank: SUCCESS (35.085s)
[216.569523] [023/153] (835s left) gem_exec_schedule (preempt-contexts)
[216.742300] Starting subtest: preempt-contexts
[216.745737] Starting dynamic subtest: rcs0
[216.848731] Dynamic subtest rcs0: SUCCESS (0.104s)
[216.877752] Starting dynamic subtest: bcs0
[216.999804] Dynamic subtest bcs0: SUCCESS (0.146s)
[217.037248] Starting dynamic subtest: vcs0
[217.110091] Dynamic subtest vcs0: SUCCESS (0.110s)
[217.143370] Starting dynamic subtest: vecs0
[217.221109] Dynamic subtest vecs0: SUCCESS (0.106s)
[217.224942] Subtest preempt-contexts: SUCCESS (0.474s)
[217.617674] [024/153] (834s left) gem_exec_params (invalid-flag)
[217.756948] Starting subtest: invalid-flag
[217.761576] Subtest invalid-flag: SUCCESS (0.001s)
[217.915218] [025/153] (834s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[218.130903] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[218.137317] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[218.274740] [026/153] (834s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[218.491588] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[218.499403] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[218.640510] [027/153] (834s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[218.854238] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[218.860376] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[219.005442] [028/153] (833s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[219.223836] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[219.232152] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[219.374041] [029/153] (833s left) gem_exec_reloc (basic-cpu)
[219.511695] Starting subtest: basic-cpu
[219.525244] Subtest basic-cpu: SUCCESS (0.020s)
[219.760126] [030/153] (833s left) kms_cursor_legacy (forked-move)
[219.956279] Starting subtest: forked-move
[219.961026] Starting dynamic subtest: pipe-A
[225.437141] Dynamic subtest pipe-A: SUCCESS (5.478s)
[225.466122] Starting dynamic subtest: pipe-B
[230.874793] Dynamic subtest pipe-B: SUCCESS (5.438s)
[230.900080] Starting dynamic subtest: pipe-C
[236.303756] Dynamic subtest pipe-C: SUCCESS (5.426s)
[236.329479] Starting dynamic subtest: all-pipes
[241.745301] Dynamic subtest all-pipes: SUCCESS (5.439s)
[241.750893] Subtest forked-move: SUCCESS (21.791s)
[241.917584] [031/153] (811s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[242.030041] Starting subtest: invalid-smem-bo-on-discrete
[242.037046] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[242.274911] [032/153] (811s left) kms_async_flips (invalid-async-flip-atomic)
[242.473362] Starting subtest: invalid-async-flip-atomic
[243.073475] Starting dynamic subtest: pipe-A-HDMI-A-1
[243.338743] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.267s)
[243.650391] Starting dynamic subtest: pipe-A-HDMI-A-2
[243.986534] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.357s)
[244.303819] Starting dynamic subtest: pipe-B-HDMI-A-1
[244.566372] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.285s)
[244.975391] Starting dynamic subtest: pipe-B-HDMI-A-2
[245.170338] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.253s)
[245.462309] Starting dynamic subtest: pipe-C-HDMI-A-1
[245.725458] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.274s)
[246.048997] Starting dynamic subtest: pipe-C-HDMI-A-2
[246.268545] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.264s)
[246.273550] Subtest invalid-async-flip-atomic: SUCCESS (3.704s)
[246.852292] [033/153] (806s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[247.075399] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[248.278166] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SUCCESS (1.208s)
[248.505887] [034/153] (805s left) gem_partial_pwrite_pread (write-uncached)
[248.635647] Starting subtest: write-uncached
[262.996440] Subtest write-uncached: SUCCESS (14.364s)
[263.157765] [035/153] (790s left) gem_pread (exhaustion)
[263.271690] Starting subtest: exhaustion
[288.714605] Subtest exhaustion: SUCCESS (25.448s)
[288.881491] [FACT gem_pread (exhaustion)] new: kernel.kmod_is_loaded.vgem: true
[288.888246] [036/153] (764s left) kms_pm_rpm (basic-pci-d3-state)
[290.850187] Starting subtest: basic-pci-d3-state
[291.266745] Subtest basic-pci-d3-state: SUCCESS (0.405s)
[291.645705] [037/153] (762s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[291.864847] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[291.873571] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[292.034399] [038/153] (761s left) gem_ctx_isolation (preservation-reset)
[292.380064] Starting subtest: preservation-reset
[292.444399] Starting dynamic subtest: rcs0
[292.767197] Dynamic subtest rcs0: SUCCESS (0.419s)
[292.865100] Starting dynamic subtest: bcs0
[293.479728] Dynamic subtest bcs0: SUCCESS (0.709s)
[293.578128] Starting dynamic subtest: vcs0
[293.838278] Dynamic subtest vcs0: SUCCESS (0.417s)
[293.866256] Starting dynamic subtest: vecs0
[294.244882] Dynamic subtest vecs0: SUCCESS (0.405s)
[294.248690] Subtest preservation-reset: SUCCESS (1.966s)
[294.415462] [039/153] (759s left) gem_exec_schedule (submit-early-slice)
[294.560849] Starting subtest: submit-early-slice
[294.566411] Starting dynamic subtest: rcs0
[294.620252] Dynamic subtest rcs0: SUCCESS (0.058s)
[294.652406] Starting dynamic subtest: bcs0
[294.676787] Dynamic subtest bcs0: SUCCESS (0.053s)
[294.705868] Starting dynamic subtest: vcs0
[294.734908] Dynamic subtest vcs0: SUCCESS (0.055s)
[294.769208] Starting dynamic subtest: vecs0
[294.788985] Dynamic subtest vecs0: SUCCESS (0.052s)
[294.792595] Subtest submit-early-slice: SUCCESS (0.231s)
[295.225259] [040/153] (758s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[295.444519] Starting subtest: fbcpsrhdr-suspend
[295.451692] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[295.610700] [041/153] (758s left) drm_read (fault-buffer)
[296.308778] Starting subtest: fault-buffer
[296.312447] Subtest fault-buffer: SUCCESS (0.003s)
[296.667825] [042/153] (757s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[296.870320] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[296.997295] [043/153] (757s left) kms_psr (psr-cursor-blt)
[297.200074] Subtest psr-cursor-blt: SKIP (0.000s)
[297.329069] [044/153] (757s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[297.530603] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[297.535468] Starting dynamic subtest: pipe-A-HDMI-A-1
[297.571403] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[297.620466] Starting dynamic subtest: pipe-A-HDMI-A-2
[297.663532] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[297.710464] Starting dynamic subtest: pipe-B-HDMI-A-1
[297.744109] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[297.769374] Starting dynamic subtest: pipe-B-HDMI-A-2
[297.800957] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[297.826059] Starting dynamic subtest: pipe-C-HDMI-A-1
[297.856477] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[297.880432] Starting dynamic subtest: pipe-C-HDMI-A-2
[297.913242] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[297.919432] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.031s)
[298.711590] [045/153] (756s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[298.924294] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[298.933381] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[299.085413] [046/153] (755s left) gem_pread (display)
[299.206991] Starting subtest: display
[302.282916] Subtest display: SUCCESS (3.087s)
[302.445826] [047/153] (752s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[303.134273] Starting subtest: syncobj-timeline-invalid-wait
[303.138524] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[303.414111] [048/153] (751s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[303.615109] Starting subtest: basic-flip-before-cursor-legacy
[304.992811] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.379s)
[305.346829] [049/153] (749s left) prime_busy (after-wait)
[305.471748] Starting subtest: after-wait
[305.485840] Starting dynamic subtest: rcs0
[305.496673] Dynamic subtest rcs0: SUCCESS (0.011s)
[305.523555] Starting dynamic subtest: bcs0
[305.528758] Dynamic subtest bcs0: SUCCESS (0.013s)
[305.557126] Starting dynamic subtest: vcs0
[305.561436] Dynamic subtest vcs0: SUCCESS (0.015s)
[305.585600] Starting dynamic subtest: vecs0
[305.589623] Dynamic subtest vecs0: SUCCESS (0.009s)
[305.659083] Subtest after-wait: SUCCESS (0.187s)
[305.810733] [050/153] (749s left) vgem_basic (bad-handle)
[305.944670] Starting subtest: bad-handle
[305.948769] Subtest bad-handle: SUCCESS (0.000s)
[306.074778] [051/153] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[306.289246] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[306.297410] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.462285] [052/153] (749s left) api_intel_allocator (open-vm)
[306.575574] Starting subtest: open-vm
[306.579713] Subtest open-vm: SUCCESS (0.005s)
[306.737174] [053/153] (748s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[306.951637] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[307.848535] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (0.899s)
[308.159922] [054/153] (747s left) gem_exec_store (pages)
[308.293534] Starting subtest: pages
[308.296693] Starting dynamic subtest: rcs0
[308.386271] Dynamic subtest rcs0: SUCCESS (0.090s)
[308.417447] Starting dynamic subtest: bcs0
[308.473930] Dynamic subtest bcs0: SUCCESS (0.082s)
[308.500929] Starting dynamic subtest: vcs0
[308.561711] Dynamic subtest vcs0: SUCCESS (0.082s)
[308.589340] Starting dynamic subtest: vecs0
[308.653087] Dynamic subtest vecs0: SUCCESS (0.089s)
[308.656730] Subtest pages: SUCCESS (0.360s)
[308.926056] [055/153] (746s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[309.150928] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[309.157683] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[309.310763] [056/153] (746s left) gem_busy (semaphore)
[309.579911] Starting subtest: semaphore
[309.583705] Starting dynamic subtest: rcs0
[309.624238] Dynamic subtest rcs0: SUCCESS (0.041s)
[309.657250] Starting dynamic subtest: bcs0
[309.661435] Dynamic subtest bcs0: SUCCESS (0.027s)
[309.689281] Starting dynamic subtest: vcs0
[309.692237] Dynamic subtest vcs0: SUCCESS (0.019s)
[309.720317] Starting dynamic subtest: vecs0
[309.724568] Dynamic subtest vecs0: SUCCESS (0.028s)
[309.728619] Subtest semaphore: SUCCESS (0.131s)
[309.992663] [057/153] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[310.196404] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[310.203862] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[310.365118] [058/153] (745s left) gem_userptr_blits (coherency-unsync)
[310.504126] Subtest coherency-unsync: SKIP (0.000s)
[310.692925] [059/153] (745s left) gem_exec_reloc (basic-gtt-wc)
[310.814311] Starting subtest: basic-gtt-wc
[310.833090] Subtest basic-gtt-wc: SUCCESS (0.019s)
[311.063487] [060/153] (745s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[311.286880] Starting subtest: 4-tiled-8bpp-rotate-180
[311.294583] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[311.445517] [061/153] (745s left) gem_exec_reloc (basic-cpu-read)
[311.579238] Starting subtest: basic-cpu-read
[311.594826] Subtest basic-cpu-read: SUCCESS (0.016s)
[311.828395] [062/153] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[312.050024] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[312.056487] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[312.212936] [063/153] (744s left) kms_psr (psr-sprite-render)
[312.416741] Subtest psr-sprite-render: SKIP (0.000s)
[312.524076] [064/153] (744s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[312.754410] Starting subtest: yf-tiled-64bpp-rotate-90
[312.761804] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[312.910364] [065/153] (743s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-render)
[313.128105] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-render
[313.135029] Subtest psrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[313.296840] [066/153] (743s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[313.517625] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[313.525101] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s)
[313.694484] [067/153] (743s left) gem_create (create-size-update)
[313.811111] Starting subtest: create-size-update
[313.815889] Subtest create-size-update: SUCCESS (0.000s)
[314.093269] [068/153] (743s left) syncobj_timeline (single-wait-all-available-submitted)
[314.206464] Starting subtest: single-wait-all-available-submitted
[314.210477] Subtest single-wait-all-available-submitted: SUCCESS (0.002s)
[314.359538] [069/153] (742s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[314.554425] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[314.559499] Starting dynamic subtest: pipe-A-valid-mode
[315.653646] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.090s)
[315.658308] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.098s)
[316.038270] [070/153] (741s left) sw_sync (timeline_closed)
[316.149858] Starting subtest: timeline_closed
[316.154558] Subtest timeline_closed: SUCCESS (0.000s)
[316.332302] [071/153] (741s left) kms_frontbuffer_tracking (hdr-1p-rte)
[316.548126] Starting subtest: hdr-1p-rte
[317.666407] Subtest hdr-1p-rte: SUCCESS (1.050s)
[318.283843] [072/153] (739s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[318.500665] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[318.509305] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[318.662825] [073/153] (739s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[318.855620] Starting subtest: short-flip-before-cursor-atomic-transitions
[320.421117] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.565s)
[320.832772] [074/153] (737s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[321.442157] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[321.771952] [075/153] (736s left) kms_psr (psr2-cursor-plane-move)
[321.984923] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[322.110552] [076/153] (736s left) kms_flip (2x-wf_vblank-ts-check)
[322.314068] Starting subtest: 2x-wf_vblank-ts-check
[322.329065] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[333.435982] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.111s)
[333.462874] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[344.507179] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.068s)
[344.538138] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[355.566701] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.050s)
[355.573060] Subtest 2x-wf_vblank-ts-check: SUCCESS (33.254s)
[356.238463] [077/153] (702s left) gen7_exec_parse (basic-rejected)
[356.370627] Subtest basic-rejected: SKIP (0.000s)
[356.503963] [078/153] (702s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[356.715129] Starting subtest: hdr-rgb101010-draw-render
[357.547860] Subtest hdr-rgb101010-draw-render: SUCCESS (0.836s)
[357.879263] [079/153] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[358.102493] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[358.108506] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[358.273603] [080/153] (700s left) kms_content_protection (mei-interface)
[358.492349] Starting subtest: mei-interface
[358.520418] Subtest mei-interface: SKIP (0.021s)
[358.673532] [081/153] (700s left) gem_mmap_offset (bad-object)
[358.785158] Starting subtest: bad-object
[358.789085] Subtest bad-object: SUCCESS (0.005s)
[358.948909] [082/153] (700s left) syncobj_basic (bad-handle-to-fd)
[359.063751] Starting subtest: bad-handle-to-fd
[359.068239] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[359.215297] [083/153] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[359.421717] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[359.428601] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[359.572495] [084/153] (699s left) kms_flip (flip-vs-suspend)
[359.774115] Starting subtest: flip-vs-suspend
[359.780085] Starting dynamic subtest: A-HDMI-A1