[87.328464] Initializing watchdogs [87.328653] /dev/watchdog0 [87.368111] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [87.382859] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [87.390714] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [87.397173] [001/132] (960s left) gem_exec_schedule (preempt-queue-contexts) [87.549655] Starting subtest: preempt-queue-contexts [87.552628] Starting dynamic subtest: rcs0 [88.319019] Dynamic subtest rcs0: SUCCESS (0.763s) [88.362123] Starting dynamic subtest: bcs0 [89.058050] Dynamic subtest bcs0: SUCCESS (0.742s) [89.093701] Starting dynamic subtest: vcs0 [89.785054] Dynamic subtest vcs0: SUCCESS (0.723s) [89.822488] Starting dynamic subtest: vecs0 [90.525216] Dynamic subtest vecs0: SUCCESS (0.745s) [90.529200] Subtest preempt-queue-contexts: SUCCESS (2.978s) [90.943321] [002/132] (957s left) kms_psr (fbc-pr-primary-blt) [91.141118] Subtest fbc-pr-primary-blt: SKIP (0.000s) [91.236283] [003/132] (956s left) gem_fence_thrash (bo-copy) [91.336258] Starting subtest: bo-copy [92.698440] Subtest bo-copy: SUCCESS (1.362s) [92.860250] [004/132] (955s left) sw_sync (alloc_merge_fence) [92.961201] Starting subtest: alloc_merge_fence [92.962800] Subtest alloc_merge_fence: SUCCESS (0.002s) [93.077165] [005/132] (955s left) prime_busy (before-wait) [93.190187] Starting subtest: before-wait [93.201203] Starting dynamic subtest: rcs0 [93.214367] Dynamic subtest rcs0: SUCCESS (0.013s) [93.235404] Starting dynamic subtest: bcs0 [93.236961] Dynamic subtest bcs0: SUCCESS (0.015s) [93.256068] Starting dynamic subtest: vcs0 [93.257917] Dynamic subtest vcs0: SUCCESS (0.016s) [93.275783] Starting dynamic subtest: vecs0 [93.277980] Dynamic subtest vecs0: SUCCESS (0.011s) [93.371721] Subtest before-wait: SUCCESS (0.184s) [93.525736] [006/132] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [93.730701] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [93.734253] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [93.876253] [007/132] (954s left) gem_exec_reloc (basic-cpu) [93.992757] Starting subtest: basic-cpu [94.011099] Subtest basic-cpu: SUCCESS (0.020s) [94.226832] [008/132] (954s left) kms_flip (wf_vblank-ts-check-interruptible) [94.421078] Starting subtest: wf_vblank-ts-check-interruptible [94.426230] Starting dynamic subtest: A-HDMI-A1 [100.579832] Dynamic subtest A-HDMI-A1: SUCCESS (6.148s) [100.597994] Starting dynamic subtest: B-HDMI-A1 [106.407165] Dynamic subtest B-HDMI-A1: SUCCESS (5.827s) [106.426055] Starting dynamic subtest: C-HDMI-A1 [112.246887] Dynamic subtest C-HDMI-A1: SUCCESS (5.837s) [112.265983] Starting dynamic subtest: A-HDMI-A2 [118.113104] Dynamic subtest A-HDMI-A2: SUCCESS (5.862s) [118.136164] Starting dynamic subtest: B-HDMI-A2 [123.944744] Dynamic subtest B-HDMI-A2: SUCCESS (5.828s) [123.966269] Starting dynamic subtest: C-HDMI-A2 [129.751344] Dynamic subtest C-HDMI-A2: SUCCESS (5.804s) [129.757907] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.328s) [130.252810] [009/132] (918s left) vgem_basic (dmabuf-mmap) [130.458063] Starting subtest: dmabuf-mmap [130.483110] Subtest dmabuf-mmap: SUCCESS (0.031s) [130.637634] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true [130.642663] [010/132] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [130.849204] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [130.852631] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [131.008916] [011/132] (917s left) kms_psr (fbc-psr-sprite-plane-move) [131.200943] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [131.312716] [012/132] (917s left) gem_exec_fence (submit3) [131.577320] Starting subtest: submit3 [131.579124] Starting dynamic subtest: rcs0 [131.586315] Dynamic subtest rcs0: SUCCESS (0.011s) [131.608754] Starting dynamic subtest: bcs0 [131.610706] Dynamic subtest bcs0: SUCCESS (0.016s) [131.635410] Starting dynamic subtest: vcs0 [131.637324] Dynamic subtest vcs0: SUCCESS (0.017s) [131.656611] Starting dynamic subtest: vecs0 [131.659214] Dynamic subtest vecs0: SUCCESS (0.016s) [131.661745] Subtest submit3: SUCCESS (0.062s) [132.330228] [013/132] (916s left) vgem_basic (bad-fence) [132.438888] Starting subtest: bad-fence [132.442729] Subtest bad-fence: SUCCESS (0.000s) [132.561836] [014/132] (916s left) kms_lease (lease-again) [132.759202] Starting subtest: lease-again [132.763304] Starting dynamic subtest: pipe-A-HDMI-A-1 [132.765499] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.008s) [132.815089] Starting dynamic subtest: pipe-A-HDMI-A-2 [132.817513] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.009s) [132.840372] Starting dynamic subtest: pipe-B-HDMI-A-1 [132.841975] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s) [132.892047] Starting dynamic subtest: pipe-B-HDMI-A-2 [132.897137] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.005s) [132.934298] Starting dynamic subtest: pipe-C-HDMI-A-1 [132.935904] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.006s) [132.957950] Starting dynamic subtest: pipe-C-HDMI-A-2 [132.959539] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.010s) [132.962149] Subtest lease-again: SUCCESS (0.076s) [133.047751] [015/132] (916s left) gem_exec_reloc (basic-wc-read-active) [133.167128] Starting subtest: basic-wc-read-active [133.308089] Subtest basic-wc-read-active: SUCCESS (0.138s) [133.531889] [016/132] (915s left) gem_flink_basic (bad-open) [133.634173] Starting subtest: bad-open [133.635920] Subtest bad-open: SUCCESS (0.000s) [133.780135] [017/132] (915s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [133.988505] Starting subtest: fbcpsr-stridechange [133.991866] Subtest fbcpsr-stridechange: SKIP (0.000s) [134.142826] [018/132] (915s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [134.322800] Starting subtest: plane-lut1d-ctm3x4-lut1d [135.935233] Subtest plane-lut1d-ctm3x4-lut1d: SKIP (1.607s) [136.246138] [019/132] (913s left) gem_eio (wait-10ms) [136.398283] Starting subtest: wait-10ms [136.512566] Subtest wait-10ms: SUCCESS (0.107s) [136.751131] [020/132] (912s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [136.934696] Starting subtest: flip-vs-cursor-crc-atomic [137.791178] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.856s) [138.096352] [021/132] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [138.296419] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [138.302749] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [138.445939] [022/132] (911s left) core_auth (basic-auth) [138.551242] Starting subtest: basic-auth [138.554342] Subtest basic-auth: SUCCESS (0.002s) [138.696109] [023/132] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [138.888095] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [141.436897] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.546s) [141.749575] [024/132] (908s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [141.936704] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [141.940431] Starting dynamic subtest: pipe-A-HDMI-A-1 [142.025205] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.014s) [142.064498] Starting dynamic subtest: pipe-A-HDMI-A-2 [142.191358] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.014s) [142.211647] Starting dynamic subtest: pipe-B-HDMI-A-1 [142.277672] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.014s) [142.296603] Starting dynamic subtest: pipe-B-HDMI-A-2 [142.358975] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.014s) [142.381489] Starting dynamic subtest: pipe-C-HDMI-A-1 [142.444501] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.014s) [142.463846] Starting dynamic subtest: pipe-C-HDMI-A-2 [142.536052] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.022s) [142.539998] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.114s) [143.074250] [025/132] (907s left) gem_exec_params (secure-non-root) [143.188376] Starting subtest: secure-non-root [143.191997] Subtest secure-non-root: SKIP (0.000s) [143.344191] [026/132] (906s left) gem_ctx_bad_destroy (invalid-pad) [143.452112] Starting subtest: invalid-pad [143.454081] Subtest invalid-pad: SUCCESS (0.000s) [143.593159] [027/132] (906s left) kms_psr (psr-dpms) [143.773128] Subtest psr-dpms: SKIP (0.000s) [143.882911] [028/132] (906s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [144.090150] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [144.094029] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [144.240904] [029/132] (906s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [144.348213] Starting subtest: etime-multi-wait-available-unsubmitted [144.460930] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s) [144.610328] [030/132] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [144.800834] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [144.806141] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [144.959011] [031/132] (905s left) gem_ctx_persistence (heartbeat-hostile) [145.068497] Starting subtest: heartbeat-hostile [146.232602] Subtest heartbeat-hostile: SUCCESS (1.164s) [146.376261] [032/132] (904s left) gem_mmap_wc (set-cache-level) [146.482342] Starting subtest: set-cache-level [146.489153] Subtest set-cache-level: SUCCESS (0.009s) [146.642103] [033/132] (904s left) gem_eio (wait-wedge-immediate) [146.766552] Starting subtest: wait-wedge-immediate [146.859280] Subtest wait-wedge-immediate: SUCCESS (0.087s) [147.074449] [034/132] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [147.276664] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [149.351585] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (2.072s) [149.561376] [035/132] (901s left) kms_cursor_crc (cursor-random-128x128) [149.747088] Starting subtest: cursor-random-128x128 [149.791101] Starting dynamic subtest: pipe-A-HDMI-A-1 [153.950577] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.159s) [154.071166] Starting dynamic subtest: pipe-C-HDMI-A-1 [157.928252] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.898s) [157.930326] Subtest cursor-random-128x128: SUCCESS (8.182s) [158.248399] [036/132] (892s left) kms_cursor_crc (cursor-sliding-max-size) [158.473259] Starting subtest: cursor-sliding-max-size [158.478478] Subtest cursor-sliding-max-size: SKIP (0.000s) [158.628318] [037/132] (892s left) kms_chamelium_audio (hdmi-audio) [159.226196] Subtest hdmi-audio: SKIP (0.000s) [159.519319] [038/132] (891s left) kms_plane_lowres (tiling-none) [159.717518] Starting subtest: tiling-none [159.721052] Starting dynamic subtest: pipe-A-HDMI-A-1 [166.533651] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.819s) [166.780128] Starting dynamic subtest: pipe-A-HDMI-A-2 [173.207979] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.452s) [173.456117] Starting dynamic subtest: pipe-B-HDMI-A-1 [179.655888] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.223s) [179.897311] Starting dynamic subtest: pipe-B-HDMI-A-2 [186.032943] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (6.166s) [186.276082] Starting dynamic subtest: pipe-C-HDMI-A-1 [192.433823] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.190s) [192.708947] Starting dynamic subtest: pipe-C-HDMI-A-2 [199.056279] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.385s) [199.342444] Subtest tiling-none: SUCCESS (39.611s) [199.682934] [039/132] (851s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [199.895949] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [199.900641] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [200.047865] [040/132] (851s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [200.255050] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [203.270099] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (3.014s) [203.484351] [041/132] (848s left) kms_content_protection (legacy) [203.684256] Starting subtest: legacy [203.717451] Subtest legacy: SKIP (0.028s) [203.865899] [042/132] (847s left) gem_mmap_gtt (ptrace) [203.979051] Starting subtest: ptrace [204.197360] Subtest ptrace: SUCCESS (0.222s) [204.353518] [043/132] (847s left) core_setmaster_vs_auth [204.601141] [044/132] (847s left) gem_ctx_engines (execute-oneforall) [204.731455] Starting subtest: execute-oneforall [205.316158] Subtest execute-oneforall: SUCCESS (0.582s) [205.585341] [045/132] (846s left) kms_psr (psr2-basic) [205.773044] Subtest psr2-basic: SKIP (0.000s) [205.887239] [046/132] (846s left) kms_chamelium_edid (vga-edid-read) [206.514540] Subtest vga-edid-read: SKIP (0.000s) [206.811928] [047/132] (845s left) gem_exec_params (invalid-bsd2-flag-on-blt) [206.938606] Starting subtest: invalid-bsd2-flag-on-blt [206.940908] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s) [207.093114] [048/132] (845s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [207.301586] Starting subtest: psr-2p-primscrn-cur-indfb-move [207.306353] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [207.458496] [049/132] (845s left) kms_draw_crc (draw-method-blt) [207.657104] Starting subtest: draw-method-blt [207.660625] Starting dynamic subtest: xrgb8888-untiled [208.195073] Dynamic subtest xrgb8888-untiled: SUCCESS (0.540s) [208.247549] Starting dynamic subtest: rgb565-untiled [208.560914] Dynamic subtest rgb565-untiled: SUCCESS (0.352s) [208.585805] Starting dynamic subtest: xrgb2101010-untiled [208.861204] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.298s) [208.888106] Starting dynamic subtest: xbgr16161616f-untiled [209.160305] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.295s) [209.182208] Starting dynamic subtest: xrgb8888-xtiled [209.360049] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.196s) [209.392898] Starting dynamic subtest: rgb565-xtiled [209.544992] Dynamic subtest rgb565-xtiled: SUCCESS (0.180s) [209.566567] Starting dynamic subtest: xrgb2101010-xtiled [209.710931] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.162s) [209.734141] Starting dynamic subtest: xbgr16161616f-xtiled [209.878315] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.164s) [209.902911] Starting dynamic subtest: xrgb8888-ytiled [210.078784] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.196s) [210.106922] Starting dynamic subtest: rgb565-ytiled [210.278895] Dynamic subtest rgb565-ytiled: SUCCESS (0.194s) [210.302089] Starting dynamic subtest: xrgb2101010-ytiled [210.461498] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.178s) [210.488271] Starting dynamic subtest: xbgr16161616f-ytiled [210.629669] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.163s) [210.631579] Subtest draw-method-blt: SUCCESS (2.978s) [210.889138] [050/132] (841s left) gem_exec_reloc (basic-write-gtt-active) [211.012593] Starting subtest: basic-write-gtt-active [211.153284] Subtest basic-write-gtt-active: SUCCESS (0.139s) [211.391050] [051/132] (841s left) gem_exec_schedule (promotion) [211.540150] Starting subtest: promotion [211.541738] Starting dynamic subtest: rcs0 [211.666115] Dynamic subtest rcs0: SUCCESS (0.121s) [211.688871] Starting dynamic subtest: bcs0 [211.818834] Dynamic subtest bcs0: SUCCESS (0.141s) [211.848265] Starting dynamic subtest: vcs0 [211.952388] Dynamic subtest vcs0: SUCCESS (0.123s) [211.978989] Starting dynamic subtest: vecs0 [212.064771] Dynamic subtest vecs0: SUCCESS (0.121s) [212.070098] Subtest promotion: SUCCESS (0.524s) [212.460280] [052/132] (840s left) kms_pm_lpsp (screens-disabled) [213.658501] Starting subtest: screens-disabled [213.662931] Subtest screens-disabled: SKIP (0.000s) [213.806244] [053/132] (839s left) gem_exec_whisper (basic-fds-forked-all) [213.938598] Starting subtest: basic-fds-forked-all [229.885528] Subtest basic-fds-forked-all: SUCCESS (15.944s) [230.146101] [054/132] (822s left) i915_drm_fdinfo (busy) [230.259901] Starting subtest: busy [230.263217] Starting dynamic subtest: rcs0 [230.794872] Dynamic subtest rcs0: SUCCESS (0.533s) [230.817986] Starting dynamic subtest: bcs0 [231.327882] Dynamic subtest bcs0: SUCCESS (0.530s) [231.354424] Starting dynamic subtest: vcs0 [231.860171] Dynamic subtest vcs0: SUCCESS (0.529s) [231.886806] Starting dynamic subtest: vecs0 [232.398468] Dynamic subtest vecs0: SUCCESS (0.532s) [232.400897] Subtest busy: SUCCESS (2.141s) [232.544628] [055/132] (820s left) gem_userptr_blits (unsync-unmap-after-close) [232.657477] Subtest unsync-unmap-after-close: SKIP (0.000s) [232.862542] [056/132] (820s left) gem_softpin (evict-single-offset) [232.980164] Starting subtest: evict-single-offset [267.715508] Subtest evict-single-offset: SUCCESS (34.735s) [267.886503] [057/132] (785s left) gem_render_copy (yf-tiled-ccs-to-linear) [268.137070] Starting subtest: yf-tiled-ccs-to-linear [268.139590] Starting dynamic subtest: smem [268.367405] Dynamic subtest smem: SUCCESS (0.230s) [268.369477] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.233s) [268.647049] [058/132] (784s left) kms_plane_alpha_blend (alpha-transparent-fb) [268.844102] Starting subtest: alpha-transparent-fb [269.023051] Starting dynamic subtest: pipe-A-HDMI-A-1 [269.955182] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.486s) [269.977951] Starting dynamic subtest: pipe-C-HDMI-A-1 [270.530246] Dynamic subtest pipe-C-HDMI-A-1: FAIL (0.477s) [270.531791] Subtest alpha-transparent-fb: FAIL (1.151s) [270.637208] [059/132] (782s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [270.832055] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [270.835132] Starting dynamic subtest: pipe-A-valid-mode [271.859073] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.027s) [271.861219] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.033s) [272.181190] [060/132] (781s left) kms_flip (flip-vs-suspend) [272.378165] Starting subtest: flip-vs-suspend [272.381292] Starting dynamic subtest: A-HDMI-A1