[90.199857] Initializing watchdogs [90.200112] /dev/watchdog0 [90.239996] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [90.255066] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [90.261489] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [90.266656] [001/133] (960s left) gem_exec_flush (basic-wb-ro-before-default) [90.412818] Starting subtest: basic-wb-ro-before-default [95.832099] Subtest basic-wb-ro-before-default: SUCCESS (5.418s) [96.107308] [002/133] (954s left) kms_plane_multiple (tiling-4) [96.296943] Starting subtest: tiling-4 [96.300930] Subtest tiling-4: SKIP (0.000s) [96.424560] [003/133] (954s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [96.641322] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [100.033190] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.392s) [100.308422] [004/133] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [100.513074] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [103.452643] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.933s) [103.753182] [005/133] (947s left) kms_vblank (wait-busy) [103.937065] Starting subtest: wait-busy [103.939089] Starting dynamic subtest: pipe-A-HDMI-A-1 [106.832567] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.891s) [106.861106] Starting dynamic subtest: pipe-A-HDMI-A-2 [109.454061] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.615s) [109.486256] Starting dynamic subtest: pipe-C-HDMI-A-1 [112.078321] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.607s) [112.100460] Starting dynamic subtest: pipe-C-HDMI-A-2 [114.693223] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.608s) [114.694993] Subtest wait-busy: SUCCESS (10.758s) [114.996753] [006/133] (936s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [115.174182] Starting subtest: primary-4-tiled-reflect-x-180 [115.177388] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s) [115.296417] [007/133] (935s left) kms_rotation_crc (sprite-rotation-180) [115.472063] Starting subtest: sprite-rotation-180 [126.653415] Subtest sprite-rotation-180: SUCCESS (11.178s) [126.874254] [008/133] (924s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [127.086553] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [127.091535] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [127.208117] [009/133] (924s left) syncobj_timeline (host-signal-ordered) [127.312433] Starting subtest: host-signal-ordered [127.316521] Subtest host-signal-ordered: SUCCESS (0.004s) [127.473676] [010/133] (924s left) gem_exec_reloc (basic-gtt-read-active) [127.587022] Starting subtest: basic-gtt-read-active [127.727253] Subtest basic-gtt-read-active: SUCCESS (0.139s) [127.923123] [011/133] (923s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [128.122128] Starting subtest: fbc-rgb101010-draw-mmap-cpu [131.133041] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.008s) [131.378556] [012/133] (920s left) i915_selftest (live) [133.161150] Starting subtest: live [133.162057] Starting dynamic subtest: sanitycheck [135.777141] Dynamic subtest sanitycheck: SUCCESS (2.614s) [135.796096] Starting dynamic subtest: uncore [138.454199] Dynamic subtest uncore: SUCCESS (2.677s) [138.475379] Starting dynamic subtest: workarounds [141.219816] Dynamic subtest workarounds: SUCCESS (2.761s) [141.237577] Starting dynamic subtest: gt_engines [144.305422] Dynamic subtest gt_engines: SUCCESS (3.083s) [144.324395] Starting dynamic subtest: gt_timelines [160.317981] Dynamic subtest gt_timelines: SUCCESS (16.012s) [160.341329] Starting dynamic subtest: gt_contexts [162.963738] Dynamic subtest gt_contexts: SUCCESS (2.643s) [162.991181] Starting dynamic subtest: gt_lrc [168.150389] Dynamic subtest gt_lrc: SUCCESS (5.180s) [168.170112] Starting dynamic subtest: gt_mocs [170.805607] Dynamic subtest gt_mocs: SUCCESS (2.656s) [170.823547] Starting dynamic subtest: gt_pm [182.974277] Dynamic subtest gt_pm: SUCCESS (12.165s) [182.993394] Starting dynamic subtest: gt_heartbeat [185.697914] Dynamic subtest gt_heartbeat: SUCCESS (2.723s) [185.718384] Starting dynamic subtest: gt_tlb [189.810593] Dynamic subtest gt_tlb: SUCCESS (4.110s) [189.830311] Starting dynamic subtest: requests [198.775893] Dynamic subtest requests: SUCCESS (8.963s) [198.794024] Starting dynamic subtest: migrate [204.190777] Dynamic subtest migrate: SUCCESS (5.412s) [204.210308] Starting dynamic subtest: active [207.004683] Dynamic subtest active: SUCCESS (2.810s) [207.036844] Starting dynamic subtest: objects [211.456288] Dynamic subtest objects: SUCCESS (4.451s) [211.475398] Starting dynamic subtest: mman [219.535454] Dynamic subtest mman: SUCCESS (8.078s) [219.555377] Starting dynamic subtest: dmabuf [222.259522] Dynamic subtest dmabuf: SUCCESS (2.723s) [222.312237] Starting dynamic subtest: vma [225.038701] Dynamic subtest vma: SUCCESS (2.775s) [225.057338] Starting dynamic subtest: coherency [230.040927] Dynamic subtest coherency: SUCCESS (5.001s) [230.059592] Starting dynamic subtest: gtt [240.298389] Dynamic subtest gtt: SUCCESS (10.255s) [240.316654] Starting dynamic subtest: gem [243.480401] Dynamic subtest gem: SUCCESS (3.180s) [243.499406] Starting dynamic subtest: evict [249.190874] Dynamic subtest evict: SUCCESS (5.709s) [249.210719] Starting dynamic subtest: hugepages [258.231270] Dynamic subtest hugepages: SUCCESS (9.035s) [258.254339] Starting dynamic subtest: gem_contexts [279.282185] Dynamic subtest gem_contexts: SUCCESS (21.049s) [279.302316] Starting dynamic subtest: client [281.868615] Dynamic subtest client: SUCCESS (2.585s) [281.889334] Starting dynamic subtest: gem_migrate [284.404126] Dynamic subtest gem_migrate: SUCCESS (2.533s) [284.423068] Starting dynamic subtest: reset [290.934238] Dynamic subtest reset: SUCCESS (6.528s) [290.953070] Starting dynamic subtest: memory_region [293.700805] Dynamic subtest memory_region: SUCCESS (2.764s) [293.719370] Starting dynamic subtest: hangcheck [319.435916] Dynamic subtest hangcheck: SUCCESS (25.734s) [319.456314] Starting dynamic subtest: execlists [331.257245] Dynamic subtest execlists: SUCCESS (11.819s) [331.276510] Starting dynamic subtest: ring_submission [333.941204] Dynamic subtest ring_submission: SUCCESS (2.681s) [333.962316] Starting dynamic subtest: perf [336.605328] Dynamic subtest perf: SUCCESS (2.660s) [336.625395] Starting dynamic subtest: slpc [339.294252] Dynamic subtest slpc: SUCCESS (2.687s) [339.312686] Starting dynamic subtest: guc [342.040697] Dynamic subtest guc: SUCCESS (2.745s) [342.061269] Starting dynamic subtest: guc_multi_lrc [344.654346] Dynamic subtest guc_multi_lrc: SUCCESS (2.610s) [344.676306] Starting dynamic subtest: guc_hang [347.465303] Dynamic subtest guc_hang: SUCCESS (2.805s) [347.488325] Starting dynamic subtest: late_gt_pm [350.160847] Dynamic subtest late_gt_pm: SUCCESS (2.694s) [350.161907] Subtest live: SUCCESS (216.999s) [350.222724] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [350.226487] [013/133] (701s left) kms_chamelium_frames (dp-crc-multiple) [353.529094] Subtest dp-crc-multiple: SKIP (0.000s) [353.826959] [FACT kms_chamelium_frames (dp-crc-multiple)] new: kernel.kmod_is_loaded.i915: true [353.833133] [014/133] (697s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [354.037052] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [354.043383] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [354.813682] [015/133] (697s left) gem_sync (basic-store-all) [354.968701] Starting subtest: basic-store-all [357.458299] Subtest basic-store-all: SUCCESS (2.498s) [357.704978] [016/133] (694s left) gen9_exec_parse (allowed-single) [357.831856] Starting subtest: allowed-single [357.845741] Subtest allowed-single: SUCCESS (0.011s) [358.107131] [017/133] (693s left) gem_exec_reloc (basic-softpin) [358.226238] Starting subtest: basic-softpin [358.232614] Subtest basic-softpin: SUCCESS (0.008s) [358.454567] [018/133] (693s left) gem_exec_schedule (manyslice) [358.588877] Starting subtest: manyslice [358.591220] Starting dynamic subtest: rcs0 [359.876701] Dynamic subtest rcs0: SUCCESS (1.282s) [359.929140] Starting dynamic subtest: bcs0 [360.752086] Dynamic subtest bcs0: SUCCESS (0.865s) [360.807346] Starting dynamic subtest: vcs0 [361.228098] Dynamic subtest vcs0: SUCCESS (0.470s) [361.278051] Starting dynamic subtest: vecs0 [362.002992] Dynamic subtest vecs0: SUCCESS (0.775s) [362.004304] Subtest manyslice: SUCCESS (3.411s) [362.374902] [019/133] (689s left) kms_psr (fbc-psr-primary-mmap-gtt) [362.567148] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [362.661697] [020/133] (689s left) kms_big_fb (4-tiled-addfb) [362.886282] Starting subtest: 4-tiled-addfb [362.889334] Subtest 4-tiled-addfb: SKIP (0.001s) [363.021177] [021/133] (689s left) sw_sync (sync_multi_producer_single_consumer) [363.130457] Starting subtest: sync_multi_producer_single_consumer [364.205791] Subtest sync_multi_producer_single_consumer: SUCCESS (1.079s) [364.323324] [022/133] (688s left) fbdev (unaligned-write) [364.441857] Starting subtest: unaligned-write [364.662675] Subtest unaligned-write: SUCCESS (0.221s) [364.800991] [023/133] (687s left) perf (invalid-oa-exponent) [365.029119] Starting subtest: invalid-oa-exponent [365.062264] Subtest invalid-oa-exponent: SUCCESS (0.037s) [365.156368] [024/133] (687s left) gem_exec_whisper (basic-normal-all) [365.280148] Starting subtest: basic-normal-all [371.658445] Subtest basic-normal-all: SUCCESS (6.379s) [371.907877] [025/133] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [372.125202] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [374.758682] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.636s) [374.940099] [026/133] (677s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [375.136255] Starting subtest: modeset-transition-nonblocking-fencing [375.137657] Starting dynamic subtest: 1x-outputs [378.698592] Dynamic subtest 1x-outputs: SUCCESS (3.558s) [378.719973] Starting dynamic subtest: 2x-outputs [386.055034] Dynamic subtest 2x-outputs: SUCCESS (7.357s) [386.057125] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.921s) [386.363988] [027/133] (666s left) syncobj_timeline (transfer-timeline-point) [386.479169] Starting subtest: transfer-timeline-point [386.482414] Subtest transfer-timeline-point: SUCCESS (0.001s) [386.617171] [028/133] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [386.808288] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [386.812196] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [387.021356] [029/133] (666s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [387.199774] Starting subtest: plane-downscale-factor-0-5-with-modifiers [387.203078] Starting dynamic subtest: pipe-A [388.148373] Dynamic subtest pipe-A: SUCCESS (0.945s) [388.188612] Starting dynamic subtest: pipe-B [389.009074] Dynamic subtest pipe-B: SUCCESS (0.857s) [389.031997] Starting dynamic subtest: pipe-C [389.890346] Dynamic subtest pipe-C: SUCCESS (0.879s) [389.892444] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.691s) [390.435174] [030/133] (662s left) gem_ctx_shared (q-in-order) [390.570129] Starting subtest: Q-in-order [390.571227] Starting dynamic subtest: rcs0 [390.727070] Dynamic subtest rcs0: SUCCESS (0.158s) [390.764996] Starting dynamic subtest: bcs0 [390.849160] Dynamic subtest bcs0: SUCCESS (0.112s) [390.886867] Starting dynamic subtest: vcs0 [390.938924] Dynamic subtest vcs0: SUCCESS (0.087s) [390.974566] Starting dynamic subtest: vecs0 [391.029556] Dynamic subtest vecs0: SUCCESS (0.086s) [391.030716] Subtest Q-in-order: SUCCESS (0.462s) [391.313555] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true [391.318060] [031/133] (661s left) sysfs_timeslice_duration (invalid) [391.435101] Starting subtest: invalid [391.436343] Starting dynamic subtest: vecs0 [391.437382] Dynamic subtest vecs0: SUCCESS (0.001s) [391.471136] Starting dynamic subtest: vcs0 [391.471997] Dynamic subtest vcs0: SUCCESS (0.002s) [391.492111] Starting dynamic subtest: bcs0 [391.492965] Dynamic subtest bcs0: SUCCESS (0.001s) [391.513328] Starting dynamic subtest: rcs0 [391.514749] Dynamic subtest rcs0: SUCCESS (0.001s) [391.515746] Subtest invalid: SUCCESS (0.020s) [391.599286] [032/133] (661s left) vgem_basic (create) [391.714362] Starting subtest: create [391.717153] Subtest create: SUCCESS (0.001s) [391.849353] [033/133] (661s left) gem_lmem_swapping (basic) [391.966981] Subtest basic: SKIP (0.000s) [392.073582] [034/133] (661s left) gem_exec_reloc (basic-range-active) [392.192757] Starting subtest: basic-range-active [392.293779] Subtest basic-range-active: SUCCESS (0.090s) [392.518349] [035/133] (661s left) kms_draw_crc (draw-method-mmap-wc) [392.704051] Starting subtest: draw-method-mmap-wc [392.706085] Starting dynamic subtest: xrgb8888-untiled [393.186755] Dynamic subtest xrgb8888-untiled: SUCCESS (0.488s) [393.211814] Starting dynamic subtest: rgb565-untiled [393.437793] Dynamic subtest rgb565-untiled: SUCCESS (0.247s) [393.464849] Starting dynamic subtest: xrgb2101010-untiled [393.705805] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.262s) [393.730059] Starting dynamic subtest: xbgr16161616f-untiled [393.974164] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.262s) [393.994498] Starting dynamic subtest: xrgb8888-xtiled [394.171039] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.197s) [394.194389] Starting dynamic subtest: rgb565-xtiled [394.356586] Dynamic subtest rgb565-xtiled: SUCCESS (0.178s) [394.380833] Starting dynamic subtest: xrgb2101010-xtiled [394.522629] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.160s) [394.547603] Starting dynamic subtest: xbgr16161616f-xtiled [394.703702] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.177s) [394.729844] Starting dynamic subtest: xrgb8888-ytiled [394.890124] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.181s) [394.911161] Starting dynamic subtest: rgb565-ytiled [395.069609] Dynamic subtest rgb565-ytiled: SUCCESS (0.179s) [395.096420] Starting dynamic subtest: xrgb2101010-ytiled [395.237869] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.162s) [395.260477] Starting dynamic subtest: xbgr16161616f-ytiled [395.424432] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.179s) [395.425830] Subtest draw-method-mmap-wc: SUCCESS (2.724s) [395.664921] [036/133] (658s left) gem_userptr_blits (userfault) [395.789916] Starting subtest: userfault [395.797739] Subtest userfault: SUCCESS (0.008s) [396.017828] [037/133] (657s left) gem_pxp (reject-modify-context-protection-off-2) [398.662864] Starting subtest: reject-modify-context-protection-off-2 [398.665287] Subtest reject-modify-context-protection-off-2: SKIP (0.000s) [398.817382] [038/133] (655s left) kms_plane_scaling (planes-upscale-factor-0-25) [399.009380] Starting subtest: planes-upscale-factor-0-25 [399.012261] Starting dynamic subtest: pipe-A [399.404113] Dynamic subtest pipe-A: SUCCESS (0.393s) [399.431328] Starting dynamic subtest: pipe-B [399.833174] Dynamic subtest pipe-B: SUCCESS (0.424s) [399.862769] Starting dynamic subtest: pipe-C [399.931631] Dynamic subtest pipe-C: SUCCESS (0.099s) [399.932527] Subtest planes-upscale-factor-0-25: SUCCESS (0.925s) [400.421449] [039/133] (653s left) kms_flip (2x-flip-vs-fences) [400.617478] Starting subtest: 2x-flip-vs-fences [400.620226] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [411.549103] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.931s) [411.577415] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [422.367573] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.812s) [422.399863] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [433.241906] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.863s) [433.243201] Subtest 2x-flip-vs-fences: SUCCESS (32.629s) [433.915472] [040/133] (620s left) gem_exec_capture (userptr) [434.032769] Starting subtest: userptr [435.342740] Subtest userptr: SUCCESS (1.311s) [435.494954] [041/133] (618s left) sw_sync (sync_multi_consumer) [435.598445] Starting subtest: sync_multi_consumer [436.267142] Subtest sync_multi_consumer: SUCCESS (0.666s) [436.400511] [042/133] (617s left) kms_pm_rpm (pm-tiling) [438.202257] Starting subtest: pm-tiling [440.146089] Subtest pm-tiling: SUCCESS (1.932s) [440.464814] [043/133] (613s left) perf_pmu (multi-client) [440.583251] Starting subtest: multi-client [440.584464] Starting dynamic subtest: rcs0 [441.604740] Dynamic subtest rcs0: SUCCESS (1.025s) [441.632874] Starting dynamic subtest: bcs0 [442.643799] Dynamic subtest bcs0: SUCCESS (1.033s) [442.668663] Starting dynamic subtest: vcs0 [443.675992] Dynamic subtest vcs0: SUCCESS (1.027s) [443.703307] Starting dynamic subtest: vecs0 [444.708461] Dynamic subtest vecs0: SUCCESS (1.027s) [444.714671] Subtest multi-client: SUCCESS (4.133s) [444.874411] [044/133] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [445.071278] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [445.075474] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [445.221233] [045/133] (609s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [445.442093] Starting subtest: psr-rgb565-draw-blt [445.445352] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [445.596994] [046/133] (609s left) kms_cursor_crc (cursor-sliding-128x128) [445.808202] Starting subtest: cursor-sliding-128x128 [445.868234] Starting dynamic subtest: pipe-A-HDMI-A-1 [449.951405] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.071s) [450.071408] Starting dynamic subtest: pipe-C-HDMI-A-1 [453.746521] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.735s) [453.747765] Subtest cursor-sliding-128x128: SUCCESS (7.943s) [454.110207] [047/133] (600s left) gem_mmap_gtt (basic-small-bo) [454.222191] Starting subtest: basic-small-bo [455.046116] Subtest basic-small-bo: SUCCESS (0.826s) [455.241593] [048/133] (599s left) kms_flip (2x-flip-vs-suspend-interruptible) [455.544061] Starting subtest: 2x-flip-vs-suspend-interruptible [455.551803] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2