[91.261426] Initializing watchdogs [91.261604] /dev/watchdog0 [91.302862] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [91.319612] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [91.326784] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [91.335130] [001/133] (960s left) gem_exec_flush (basic-wb-ro-before-default) [91.494325] Starting subtest: basic-wb-ro-before-default [96.917148] Subtest basic-wb-ro-before-default: SUCCESS (5.423s) [97.173314] [002/133] (954s left) kms_plane_multiple (tiling-4) [97.370261] Starting subtest: tiling-4 [97.375980] Subtest tiling-4: SKIP (0.000s) [97.512170] [003/133] (954s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [97.733059] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [101.143154] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.414s) [101.473738] [004/133] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [101.692624] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [104.694099] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.997s) [105.025183] [005/133] (947s left) kms_vblank (wait-busy) [105.218901] Starting subtest: wait-busy [105.222445] Starting dynamic subtest: pipe-A-HDMI-A-1 [108.126174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.904s) [108.166378] Starting dynamic subtest: pipe-A-HDMI-A-2 [110.735109] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.601s) [110.768082] Starting dynamic subtest: pipe-C-HDMI-A-1 [113.368698] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.623s) [113.401340] Starting dynamic subtest: pipe-C-HDMI-A-2 [115.966405] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.599s) [115.969933] Subtest wait-busy: SUCCESS (10.748s) [116.278712] [006/133] (936s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [116.477365] Starting subtest: primary-4-tiled-reflect-x-180 [116.484207] Subtest primary-4-tiled-reflect-x-180: SKIP (0.004s) [116.609823] [007/133] (935s left) kms_rotation_crc (sprite-rotation-180) [116.812539] Starting subtest: sprite-rotation-180 [128.007712] Subtest sprite-rotation-180: SUCCESS (11.201s) [128.259593] [008/133] (924s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [128.473845] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [128.480057] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [128.623190] [009/133] (923s left) syncobj_timeline (host-signal-ordered) [128.736320] Starting subtest: host-signal-ordered [128.740158] Subtest host-signal-ordered: SUCCESS (0.003s) [128.873794] [010/133] (923s left) gem_exec_reloc (basic-gtt-read-active) [128.992169] Starting subtest: basic-gtt-read-active [129.138303] Subtest basic-gtt-read-active: SUCCESS (0.142s) [129.358641] [011/133] (923s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [129.574350] Starting subtest: fbc-rgb101010-draw-mmap-cpu [132.603277] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.031s) [132.896309] [012/133] (919s left) i915_selftest (live) [134.432499] Starting subtest: live [134.436322] Starting dynamic subtest: sanitycheck [137.399371] Dynamic subtest sanitycheck: SUCCESS (2.964s) [137.422281] Starting dynamic subtest: uncore [140.240507] Dynamic subtest uncore: SUCCESS (2.841s) [140.261525] Starting dynamic subtest: workarounds [143.130289] Dynamic subtest workarounds: SUCCESS (2.883s) [143.152236] Starting dynamic subtest: gt_engines [146.291137] Dynamic subtest gt_engines: SUCCESS (3.160s) [146.311548] Starting dynamic subtest: gt_timelines [162.962598] Dynamic subtest gt_timelines: SUCCESS (16.675s) [162.984533] Starting dynamic subtest: gt_contexts [165.789698] Dynamic subtest gt_contexts: SUCCESS (2.823s) [165.810545] Starting dynamic subtest: gt_lrc [171.134415] Dynamic subtest gt_lrc: SUCCESS (5.343s) [171.157293] Starting dynamic subtest: gt_mocs [173.960220] Dynamic subtest gt_mocs: SUCCESS (2.817s) [173.980529] Starting dynamic subtest: gt_pm [185.977298] Dynamic subtest gt_pm: SUCCESS (12.024s) [185.998372] Starting dynamic subtest: gt_heartbeat [188.845216] Dynamic subtest gt_heartbeat: SUCCESS (2.831s) [188.911098] Starting dynamic subtest: gt_tlb [192.816142] Dynamic subtest gt_tlb: SUCCESS (4.004s) [192.838354] Starting dynamic subtest: requests [202.132769] Dynamic subtest requests: SUCCESS (9.315s) [202.155406] Starting dynamic subtest: migrate [207.784122] Dynamic subtest migrate: SUCCESS (5.648s) [207.806336] Starting dynamic subtest: active [210.568951] Dynamic subtest active: SUCCESS (2.783s) [210.591268] Starting dynamic subtest: objects [215.325134] Dynamic subtest objects: SUCCESS (4.754s) [215.345884] Starting dynamic subtest: mman [223.689700] Dynamic subtest mman: SUCCESS (8.361s) [223.710783] Starting dynamic subtest: dmabuf [226.531239] Dynamic subtest dmabuf: SUCCESS (2.833s) [226.552532] Starting dynamic subtest: vma [229.447469] Dynamic subtest vma: SUCCESS (2.920s) [229.469304] Starting dynamic subtest: coherency [235.589983] Dynamic subtest coherency: SUCCESS (6.139s) [235.611364] Starting dynamic subtest: gtt [246.163088] Dynamic subtest gtt: SUCCESS (10.572s) [246.185465] Starting dynamic subtest: gem [249.237110] Dynamic subtest gem: SUCCESS (3.021s) [249.303187] Starting dynamic subtest: evict [255.164953] Dynamic subtest evict: SUCCESS (5.975s) [255.187412] Starting dynamic subtest: hugepages [264.242100] Dynamic subtest hugepages: SUCCESS (9.074s) [264.265258] Starting dynamic subtest: gem_contexts [285.044683] Dynamic subtest gem_contexts: SUCCESS (20.800s) [285.067308] Starting dynamic subtest: client [287.993803] Dynamic subtest client: SUCCESS (2.947s) [288.015343] Starting dynamic subtest: gem_migrate [290.749421] Dynamic subtest gem_migrate: SUCCESS (2.753s) [290.770557] Starting dynamic subtest: reset [297.582542] Dynamic subtest reset: SUCCESS (6.831s) [297.604330] Starting dynamic subtest: memory_region [300.235248] Dynamic subtest memory_region: SUCCESS (2.648s) [300.258345] Starting dynamic subtest: hangcheck [326.011799] Dynamic subtest hangcheck: SUCCESS (25.776s) [326.033436] Starting dynamic subtest: execlists [338.543855] Dynamic subtest execlists: SUCCESS (12.530s) [338.564765] Starting dynamic subtest: ring_submission [341.496273] Dynamic subtest ring_submission: SUCCESS (2.947s) [341.518491] Starting dynamic subtest: perf [344.242582] Dynamic subtest perf: SUCCESS (2.745s) [344.266359] Starting dynamic subtest: slpc [347.023272] Dynamic subtest slpc: SUCCESS (2.777s) [347.046420] Starting dynamic subtest: guc [349.793374] Dynamic subtest guc: SUCCESS (2.759s) [349.814129] Starting dynamic subtest: guc_multi_lrc [352.713860] Dynamic subtest guc_multi_lrc: SUCCESS (2.923s) [352.735483] Starting dynamic subtest: guc_hang [355.681797] Dynamic subtest guc_hang: SUCCESS (2.967s) [355.704271] Starting dynamic subtest: late_gt_pm [358.529473] Dynamic subtest late_gt_pm: SUCCESS (2.844s) [358.532904] Subtest live: SUCCESS (224.099s) [358.598893] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [358.605511] [013/133] (694s left) kms_chamelium_frames (dp-crc-multiple) [362.153467] Subtest dp-crc-multiple: SKIP (0.000s) [362.733645] [FACT kms_chamelium_frames (dp-crc-multiple)] new: kernel.kmod_is_loaded.i915: true [362.839609] [014/133] (690s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [363.302545] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [363.309396] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [363.904069] [015/133] (689s left) gem_sync (basic-store-all) [364.070628] Starting subtest: basic-store-all [366.810830] Subtest basic-store-all: SUCCESS (2.754s) [367.077883] [016/133] (686s left) gen9_exec_parse (allowed-single) [367.209962] Starting subtest: allowed-single [367.224238] Subtest allowed-single: SUCCESS (0.011s) [367.508626] [017/133] (686s left) gem_exec_reloc (basic-softpin) [367.641359] Starting subtest: basic-softpin [367.644735] Subtest basic-softpin: SUCCESS (0.007s) [367.878066] [018/133] (686s left) gem_exec_schedule (manyslice) [368.021585] Starting subtest: manyslice [368.028159] Starting dynamic subtest: rcs0 [369.433572] Dynamic subtest rcs0: SUCCESS (1.409s) [369.486104] Starting dynamic subtest: bcs0 [370.203088] Dynamic subtest bcs0: SUCCESS (0.767s) [370.246072] Starting dynamic subtest: vcs0 [370.854086] Dynamic subtest vcs0: SUCCESS (0.646s) [370.900912] Starting dynamic subtest: vecs0 [371.493771] Dynamic subtest vecs0: SUCCESS (0.638s) [371.499376] Subtest manyslice: SUCCESS (3.476s) [371.893838] [019/133] (682s left) kms_psr (fbc-psr-primary-mmap-gtt) [372.089118] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [372.205776] [020/133] (681s left) kms_big_fb (4-tiled-addfb) [372.415314] Starting subtest: 4-tiled-addfb [372.424040] Subtest 4-tiled-addfb: SKIP (0.000s) [372.561610] [021/133] (681s left) sw_sync (sync_multi_producer_single_consumer) [372.668354] Starting subtest: sync_multi_producer_single_consumer [373.744354] Subtest sync_multi_producer_single_consumer: SUCCESS (1.079s) [373.902866] [022/133] (680s left) fbdev (unaligned-write) [374.023977] Starting subtest: unaligned-write [374.234175] Subtest unaligned-write: SUCCESS (0.211s) [374.358788] [023/133] (680s left) perf (invalid-oa-exponent) [374.599191] Starting subtest: invalid-oa-exponent [374.643987] Subtest invalid-oa-exponent: SUCCESS (0.046s) [374.755887] [024/133] (679s left) gem_exec_whisper (basic-normal-all) [374.898167] Starting subtest: basic-normal-all [382.054116] Subtest basic-normal-all: SUCCESS (7.153s) [382.314733] [025/133] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [382.527078] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [385.068412] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.554s) [385.270339] [026/133] (669s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [385.471966] Starting subtest: modeset-transition-nonblocking-fencing [385.477050] Starting dynamic subtest: 1x-outputs [389.042661] Dynamic subtest 1x-outputs: SUCCESS (3.572s) [389.068484] Starting dynamic subtest: 2x-outputs [396.429607] Dynamic subtest 2x-outputs: SUCCESS (7.383s) [396.432878] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.963s) [396.735615] [027/133] (658s left) syncobj_timeline (transfer-timeline-point) [396.858751] Starting subtest: transfer-timeline-point [396.863755] Subtest transfer-timeline-point: SUCCESS (0.001s) [396.998082] [028/133] (657s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [397.215910] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [397.222521] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [397.367254] [029/133] (657s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [397.560150] Starting subtest: plane-downscale-factor-0-5-with-modifiers [397.564761] Starting dynamic subtest: pipe-A [398.486780] Dynamic subtest pipe-A: SUCCESS (0.924s) [398.531643] Starting dynamic subtest: pipe-B [399.381414] Dynamic subtest pipe-B: SUCCESS (0.891s) [399.427107] Starting dynamic subtest: pipe-C [400.397528] Dynamic subtest pipe-C: SUCCESS (0.895s) [400.462661] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.719s) [401.204319] [030/133] (654s left) gem_ctx_shared (q-in-order) [401.337306] Starting subtest: Q-in-order [401.341959] Starting dynamic subtest: rcs0 [401.509452] Dynamic subtest rcs0: SUCCESS (0.163s) [401.536332] Starting dynamic subtest: bcs0 [401.618100] Dynamic subtest bcs0: SUCCESS (0.112s) [401.656437] Starting dynamic subtest: vcs0 [401.711726] Dynamic subtest vcs0: SUCCESS (0.088s) [401.743555] Starting dynamic subtest: vecs0 [401.804935] Dynamic subtest vecs0: SUCCESS (0.087s) [401.809535] Subtest Q-in-order: SUCCESS (0.466s) [402.081039] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true [402.088620] [031/133] (653s left) sysfs_timeslice_duration (invalid) [402.208122] Starting subtest: invalid [402.213412] Starting dynamic subtest: vecs0 [402.217314] Dynamic subtest vecs0: SUCCESS (0.001s) [402.247637] Starting dynamic subtest: vcs0 [402.251756] Dynamic subtest vcs0: SUCCESS (0.001s) [402.276612] Starting dynamic subtest: bcs0 [402.281066] Dynamic subtest bcs0: SUCCESS (0.001s) [402.304857] Starting dynamic subtest: rcs0 [402.309269] Dynamic subtest rcs0: SUCCESS (0.001s) [402.313457] Subtest invalid: SUCCESS (0.018s) [402.414224] [032/133] (653s left) vgem_basic (create) [402.542911] Starting subtest: create [402.547589] Subtest create: SUCCESS (0.001s) [402.670713] [033/133] (653s left) gem_lmem_swapping (basic) [402.794500] Subtest basic: SKIP (0.000s) [402.911929] [034/133] (652s left) gem_exec_reloc (basic-range-active) [403.039119] Starting subtest: basic-range-active [403.144253] Subtest basic-range-active: SUCCESS (0.091s) [403.375387] [035/133] (652s left) kms_draw_crc (draw-method-mmap-wc) [403.574850] Starting subtest: draw-method-mmap-wc [403.578551] Starting dynamic subtest: xrgb8888-untiled [404.066274] Dynamic subtest xrgb8888-untiled: SUCCESS (0.493s) [404.090621] Starting dynamic subtest: rgb565-untiled [404.316556] Dynamic subtest rgb565-untiled: SUCCESS (0.246s) [404.344966] Starting dynamic subtest: xrgb2101010-untiled [404.581487] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.261s) [404.606802] Starting dynamic subtest: xbgr16161616f-untiled [404.849493] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.263s) [404.872706] Starting dynamic subtest: xrgb8888-xtiled [405.031760] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.179s) [405.054915] Starting dynamic subtest: rgb565-xtiled [405.215845] Dynamic subtest rgb565-xtiled: SUCCESS (0.179s) [405.239786] Starting dynamic subtest: xrgb2101010-xtiled [405.383159] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.162s) [405.408044] Starting dynamic subtest: xbgr16161616f-xtiled [405.548588] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.163s) [405.573919] Starting dynamic subtest: xrgb8888-ytiled [405.731618] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.179s) [405.755275] Starting dynamic subtest: rgb565-ytiled [405.916165] Dynamic subtest rgb565-ytiled: SUCCESS (0.178s) [405.939383] Starting dynamic subtest: xrgb2101010-ytiled [406.082139] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.162s) [406.106127] Starting dynamic subtest: xbgr16161616f-ytiled [406.250774] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.164s) [406.254491] Subtest draw-method-mmap-wc: SUCCESS (2.680s) [406.518704] [036/133] (649s left) gem_userptr_blits (userfault) [406.652223] Starting subtest: userfault [406.657229] Subtest userfault: SUCCESS (0.009s) [406.875060] [037/133] (649s left) gem_pxp (reject-modify-context-protection-off-2) [409.522353] Starting subtest: reject-modify-context-protection-off-2 [409.529661] Subtest reject-modify-context-protection-off-2: SKIP (0.000s) [409.673184] [038/133] (646s left) kms_plane_scaling (planes-upscale-factor-0-25) [409.873077] Starting subtest: planes-upscale-factor-0-25 [409.877618] Starting dynamic subtest: pipe-A [410.214135] Dynamic subtest pipe-A: SUCCESS (0.349s) [410.261533] Starting dynamic subtest: pipe-B [410.627651] Dynamic subtest pipe-B: SUCCESS (0.410s) [410.676553] Starting dynamic subtest: pipe-C [410.713207] Dynamic subtest pipe-C: SUCCESS (0.077s) [410.730366] Subtest planes-upscale-factor-0-25: SUCCESS (0.846s) [411.184620] [039/133] (645s left) kms_flip (2x-flip-vs-fences) [411.390081] Starting subtest: 2x-flip-vs-fences [411.394157] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [422.255091] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.864s) [422.286923] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [433.185201] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.924s) [433.215446] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [443.947191] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.749s) [443.954037] Subtest 2x-flip-vs-fences: SUCCESS (32.558s) [444.596412] [040/133] (611s left) gem_exec_capture (userptr) [444.730927] Starting subtest: userptr [446.026478] Subtest userptr: SUCCESS (1.297s) [446.179162] [041/133] (610s left) sw_sync (sync_multi_consumer) [446.287286] Starting subtest: sync_multi_consumer [446.981424] Subtest sync_multi_consumer: SUCCESS (0.693s) [447.120186] [042/133] (609s left) kms_pm_rpm (pm-tiling) [448.964316] Starting subtest: pm-tiling [450.948485] Subtest pm-tiling: SUCCESS (1.969s) [451.297117] [043/133] (605s left) perf_pmu (multi-client) [451.424942] Starting subtest: multi-client [451.428488] Starting dynamic subtest: rcs0 [452.455153] Dynamic subtest rcs0: SUCCESS (1.028s) [452.488680] Starting dynamic subtest: bcs0 [453.491045] Dynamic subtest bcs0: SUCCESS (1.028s) [453.516294] Starting dynamic subtest: vcs0 [454.520724] Dynamic subtest vcs0: SUCCESS (1.026s) [454.546032] Starting dynamic subtest: vecs0 [455.552733] Dynamic subtest vecs0: SUCCESS (1.029s) [455.556176] Subtest multi-client: SUCCESS (4.133s) [455.729515] [044/133] (601s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [455.951161] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [455.959102] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [456.142606] [045/133] (600s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [456.365767] Starting subtest: psr-rgb565-draw-blt [456.372908] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [456.529869] [046/133] (600s left) kms_cursor_crc (cursor-sliding-128x128) [456.756428] Starting subtest: cursor-sliding-128x128 [456.828211] Starting dynamic subtest: pipe-A-HDMI-A-1 [460.881913] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.050s) [460.979098] Starting dynamic subtest: pipe-C-HDMI-A-1 [464.768190] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.806s) [464.776379] Subtest cursor-sliding-128x128: SUCCESS (8.008s) [465.160590] [047/133] (592s left) gem_mmap_gtt (basic-small-bo) [465.305165] Starting subtest: basic-small-bo [466.193308] Subtest basic-small-bo: SUCCESS (0.799s) [466.984891] [048/133] (590s left) kms_flip (2x-flip-vs-suspend-interruptible) [467.351333] Starting subtest: 2x-flip-vs-suspend-interruptible [467.356193] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2