[108.320872] Initializing watchdogs [108.321158] /dev/watchdog0 [108.362541] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [108.377344] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [108.384264] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [108.392170] [001/133] (960s left) kms_pm_dc (dc3co-vpb-simulation) [109.609659] Starting subtest: dc3co-vpb-simulation [109.618257] Subtest dc3co-vpb-simulation: SKIP (0.000s) [109.752900] [002/133] (959s left) gem_mmap_gtt (basic-read) [109.871689] Starting subtest: basic-read [109.894085] Subtest basic-read: SUCCESS (0.032s) [110.049671] [003/133] (959s left) i915_pm_freq_api (freq-reset) [110.175585] Subtest freq-reset: SKIP (0.000s) [110.280456] [004/133] (958s left) kms_chamelium_hpd (vga-hpd-after-suspend) [110.849531] Subtest vga-hpd-after-suspend: SKIP (0.000s) [111.134569] [005/133] (958s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [111.352936] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [111.360364] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s) [111.500445] [006/133] (957s left) gem_exec_whisper (basic-fds-priority-all) [111.636793] Starting subtest: basic-fds-priority-all [127.845210] Subtest basic-fds-priority-all: SUCCESS (16.205s) [128.131141] [007/133] (941s left) gem_exec_reloc (basic-wc-gtt-noreloc) [128.249080] Starting subtest: basic-wc-gtt-noreloc [128.264844] Subtest basic-wc-gtt-noreloc: SUCCESS (0.012s) [128.484370] [008/133] (941s left) i915_drm_fdinfo (basics) [128.600162] Starting subtest: basics [128.604776] Subtest basics: SUCCESS (0.001s) [128.733757] [009/133] (940s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [128.925057] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [129.028441] [010/133] (940s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [129.214882] Starting subtest: nonblocking-modeset-vs-cursor-atomic [130.116182] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.901s) [130.456486] [011/133] (939s left) drm_read (short-buffer-nonblock) [130.907386] Starting subtest: short-buffer-nonblock [130.910644] Subtest short-buffer-nonblock: SUCCESS (0.000s) [131.172223] [012/133] (938s left) gem_exec_balancer (hang) [131.417820] Starting subtest: hang [135.618395] Subtest hang: SUCCESS (4.201s) [135.783976] [013/133] (934s left) gem_exec_schedule (preempt-hang) [136.036560] Starting subtest: preempt-hang [136.040076] Starting dynamic subtest: rcs0 [136.297875] Dynamic subtest rcs0: SUCCESS (0.260s) [136.324865] Starting dynamic subtest: bcs0 [136.571552] Dynamic subtest bcs0: SUCCESS (0.278s) [136.607285] Starting dynamic subtest: vcs0 [136.834643] Dynamic subtest vcs0: SUCCESS (0.254s) [136.859794] Starting dynamic subtest: vecs0 [137.075069] Dynamic subtest vecs0: SUCCESS (0.246s) [137.079391] Subtest preempt-hang: SUCCESS (1.041s) [137.353713] [014/133] (932s left) kms_plane_cursor (overlay) [137.532103] Starting subtest: overlay [137.542031] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [140.248047] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.716s) [140.340265] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [142.931867] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.615s) [143.019987] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [145.566079] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.566s) [145.876235] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64 [148.477604] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.639s) [148.547967] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128 [151.026037] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.499s) [151.097211] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256 [153.629082] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.550s) [153.909270] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [156.530827] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.646s) [156.608219] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [159.197051] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.616s) [159.263898] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [161.845087] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.597s) [162.134323] Subtest overlay: SUCCESS (24.603s) [162.449669] [015/133] (907s left) gem_vm_create (invalid-destroy) [162.584326] Starting subtest: invalid-destroy [162.588089] Subtest invalid-destroy: SUCCESS (0.001s) [162.753983] [016/133] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [162.963943] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [166.170801] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.211s) [166.372941] [017/133] (904s left) gem_ctx_param (get-priority-new-ctx) [166.483848] Starting subtest: get-priority-new-ctx [166.487389] Subtest get-priority-new-ctx: SUCCESS (0.001s) [166.622170] [018/133] (903s left) kms_dsc (dsc-basic) [166.809079] Subtest dsc-basic: SKIP (0.000s) [166.917300] [019/133] (903s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [167.114127] Starting subtest: primary-yf-tiled-reflect-x-0 [167.122217] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.003s) [167.272960] [020/133] (903s left) gem_userptr_blits (sync-unmap-cycles) [167.418683] Starting subtest: sync-unmap-cycles [172.817483] Subtest sync-unmap-cycles: SUCCESS (5.399s) [173.023205] [021/133] (897s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [173.207921] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [173.212579] Starting dynamic subtest: pipe-A [173.534138] Dynamic subtest pipe-A: SUCCESS (0.327s) [173.582259] Starting dynamic subtest: pipe-B [173.951086] Dynamic subtest pipe-B: SUCCESS (0.416s) [173.972421] Starting dynamic subtest: pipe-C [174.017401] Dynamic subtest pipe-C: SUCCESS (0.065s) [174.023510] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.812s) [174.493271] [022/133] (896s left) kms_content_protection (dp-mst-type-1-suspend-resume) [174.699523] Starting subtest: dp-mst-type-1-suspend-resume [174.707477] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [174.840466] [023/133] (896s left) kms_big_fb (x-tiled-32bpp-rotate-270) [175.051571] Starting subtest: x-tiled-32bpp-rotate-270 [175.403632] Subtest x-tiled-32bpp-rotate-270: SKIP (0.348s) [175.660207] [024/133] (895s left) kms_big_fb (4-tiled-16bpp-rotate-90) [175.865249] Starting subtest: 4-tiled-16bpp-rotate-90 [175.874138] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s) [176.009235] [025/133] (895s left) kms_cursor_crc (cursor-rapid-movement-32x10) [176.213970] Starting subtest: cursor-rapid-movement-32x10 [176.445139] Subtest cursor-rapid-movement-32x10: SKIP (0.225s) [176.612096] [026/133] (894s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [176.824206] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [176.935557] [027/133] (894s left) gem_readwrite (new-obj) [177.356116] Starting subtest: new-obj [177.494537] Subtest new-obj: SUCCESS (0.000s) [177.924042] [028/133] (893s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [178.406102] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [178.599112] Starting dynamic subtest: pipe-A-plane-0 [178.769508] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s) [178.793356] Starting dynamic subtest: pipe-A-plane-1 [179.050642] Dynamic subtest pipe-A-plane-1: SUCCESS (0.280s) [179.074174] Starting dynamic subtest: pipe-A-plane-2 [179.332896] Dynamic subtest pipe-A-plane-2: SUCCESS (0.281s) [179.355427] Starting dynamic subtest: pipe-A-plane-3 [179.614885] Dynamic subtest pipe-A-plane-3: SUCCESS (0.282s) [180.025798] Starting dynamic subtest: pipe-B-plane-0 [180.273587] Dynamic subtest pipe-B-plane-0: SUCCESS (0.263s) [180.295982] Starting dynamic subtest: pipe-B-plane-1 [180.574947] Dynamic subtest pipe-B-plane-1: SUCCESS (0.298s) [180.596617] Starting dynamic subtest: pipe-B-plane-2 [180.858449] Dynamic subtest pipe-B-plane-2: SUCCESS (0.282s) [180.880585] Starting dynamic subtest: pipe-B-plane-3 [181.123867] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s) [181.381565] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SUCCESS (3.131s) [181.694933] [029/133] (890s left) drm_read (short-buffer-wakeup) [182.161355] Starting subtest: short-buffer-wakeup [214.374890] Subtest short-buffer-wakeup: SUCCESS (32.215s) [214.648187] [030/133] (857s left) syncobj_wait (multi-wait-submitted) [214.757168] Starting subtest: multi-wait-submitted [214.860260] Subtest multi-wait-submitted: SUCCESS (0.106s) [214.991761] [031/133] (856s left) kms_color (ctm-red-to-blue) [215.179697] Starting subtest: ctm-red-to-blue [215.184070] Starting dynamic subtest: pipe-A-HDMI-A-1 [216.173544] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.991s) [216.217300] Starting dynamic subtest: pipe-A-HDMI-A-2 [216.827064] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.657s) [216.870126] Starting dynamic subtest: pipe-B-HDMI-A-1 [217.478786] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.644s) [217.522436] Starting dynamic subtest: pipe-B-HDMI-A-2 [218.137301] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.663s) [218.181510] Starting dynamic subtest: pipe-C-HDMI-A-1 [218.790551] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.651s) [218.815896] Starting dynamic subtest: pipe-C-HDMI-A-2 [219.454786] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.662s) [219.458699] Subtest ctm-red-to-blue: SUCCESS (4.284s) [219.726432] [032/133] (852s left) perf_pmu (busy-check-all) [219.852220] Starting subtest: busy-check-all [219.855726] Starting dynamic subtest: rcs0 [220.395666] Dynamic subtest rcs0: SUCCESS (0.542s) [220.417726] Starting dynamic subtest: bcs0 [220.933971] Dynamic subtest bcs0: SUCCESS (0.531s) [220.956051] Starting dynamic subtest: vcs0 [221.457194] Dynamic subtest vcs0: SUCCESS (0.526s) [221.481125] Starting dynamic subtest: vecs0 [221.992630] Dynamic subtest vecs0: SUCCESS (0.526s) [221.997684] Subtest busy-check-all: SUCCESS (2.135s) [222.141991] [033/133] (850s left) vgem_basic (bad-fence) [222.350407] Starting subtest: bad-fence [222.354319] Subtest bad-fence: SUCCESS (0.000s) [222.474678] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true [222.481468] [034/133] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [222.684873] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [222.694247] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [222.839752] [035/133] (849s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [223.047253] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [223.054799] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [223.204188] [036/133] (849s left) gem_sync (basic-many-each) [223.351356] Starting subtest: basic-many-each [225.796539] Subtest basic-many-each: SUCCESS (2.459s) [226.052386] [037/133] (846s left) gem_softpin (evict-active) [226.166152] Starting subtest: evict-active [226.192357] Subtest evict-active: SUCCESS (0.022s) [226.353620] [038/133] (846s left) syncobj_timeline (single-wait-all-signaled) [226.467515] Starting subtest: single-wait-all-signaled [226.472207] Subtest single-wait-all-signaled: SUCCESS (0.002s) [226.620692] [039/133] (846s left) kms_vblank (query-busy-hang) [226.813861] Starting subtest: query-busy-hang [226.818203] Starting dynamic subtest: pipe-A-HDMI-A-1 [233.864238] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.048s) [233.914341] Starting dynamic subtest: pipe-A-HDMI-A-2 [240.860094] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.989s) [240.906341] Starting dynamic subtest: pipe-C-HDMI-A-1 [247.860674] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.987s) [247.893669] Starting dynamic subtest: pipe-C-HDMI-A-2 [254.836894] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.978s) [254.840391] Subtest query-busy-hang: SUCCESS (28.032s) [255.131070] [040/133] (817s left) gem_exec_alignment (forked) [255.265244] Starting subtest: forked [302.162757] Subtest forked: SUCCESS (46.904s) [302.323256] [041/133] (770s left) kms_flip (2x-absolute-wf_vblank) [302.712280] Starting subtest: 2x-absolute-wf_vblank [302.719284] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [313.575331] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.859s) [313.600901] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [324.314087] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.734s) [324.338202] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [335.051064] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.729s) [335.056073] Subtest 2x-absolute-wf_vblank: SUCCESS (32.342s) [335.650352] [042/133] (737s left) gem_pxp (hw-rejects-pxp-context) [338.307559] Starting subtest: hw-rejects-pxp-context [338.311520] Subtest hw-rejects-pxp-context: SUCCESS (0.001s) [338.493821] [043/133] (734s left) kms_cursor_crc (cursor-alpha-opaque) [338.682759] Starting subtest: cursor-alpha-opaque [338.686213] Starting dynamic subtest: pipe-A-HDMI-A-1 [339.563364] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.876s) [339.600462] Starting dynamic subtest: pipe-C-HDMI-A-1 [340.140305] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.567s) [340.144105] Subtest cursor-alpha-opaque: SUCCESS (1.455s) [340.472228] [044/133] (732s left) kms_cursor_edge_walk (256x256-left-edge) [340.676410] Starting subtest: 256x256-left-edge [340.681330] Starting dynamic subtest: pipe-A-HDMI-A-1 [344.557120] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.880s) [344.602269] Starting dynamic subtest: pipe-C-HDMI-A-1 [348.028197] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.469s) [348.032189] Subtest 256x256-left-edge: SUCCESS (7.363s) [348.351146] [045/133] (725s left) gem_exec_schedule (semaphore-codependency) [348.515670] Starting subtest: semaphore-codependency [348.536522] Subtest semaphore-codependency: SUCCESS (0.021s) [348.948707] [046/133] (724s left) perf (short-reads) [349.230121] Starting subtest: short-reads [349.250947] Subtest short-reads: SUCCESS (0.028s) [349.368427] [047/133] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [349.574102] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [352.116570] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.552s) [352.334480] [048/133] (721s left) kms_prime (basic-crc-vgem) [352.557124] Starting subtest: basic-crc-vgem [352.560384] Starting dynamic subtest: second-to-first [354.249334] Dynamic subtest second-to-first: SUCCESS (1.691s) [354.256763] Subtest basic-crc-vgem: SUCCESS (1.696s) [354.645595] [049/133] (719s left) gem_exec_reloc (basic-write-cpu-active) [354.775471] Starting subtest: basic-write-cpu-active [354.920129] Subtest basic-write-cpu-active: SUCCESS (0.142s) [355.169558] [050/133] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [355.389151] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [355.396205] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [355.553832] [051/133] (718s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [355.671282] Starting subtest: multi-wait-for-submit-available-submitted [355.675112] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s) [355.861792] [052/133] (718s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [356.045055] Starting subtest: missing-ccs-buffer-y-tiled-ccs [356.048966] Starting dynamic subtest: pipe-A-HDMI-A-1 [356.090064] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [356.141513] Starting dynamic subtest: pipe-A-HDMI-A-2 [356.185110] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [356.212640] Starting dynamic subtest: pipe-B-HDMI-A-1 [356.242180] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [356.265887] Starting dynamic subtest: pipe-B-HDMI-A-2 [356.294354] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s) [356.317677] Starting dynamic subtest: pipe-C-HDMI-A-1 [356.351377] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [356.375802] Starting dynamic subtest: pipe-C-HDMI-A-2 [356.407413] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [356.410751] Subtest missing-ccs-buffer-y-tiled-ccs: SUCCESS (0.035s) [357.140593] [053/133] (717s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [357.342066] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [357.348669] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [357.496829] [054/133] (716s left) api_intel_allocator (two-level-inception-interruptible) [357.628168] Starting subtest: two-level-inception-interruptible [363.192301] Subtest two-level-inception-interruptible: SUCCESS (5.578s) [363.348273] [055/133] (711s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [363.588826] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [363.597102] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [363.777189] [056/133] (710s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [363.890778] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [363.894927] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s) [364.047736] [057/133] (710s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [364.260208] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [364.267048] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [364.419577] [058/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [364.634130] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [364.640646] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [364.795510] [059/133] (710s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [365.010071] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [367.579328] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SUCCESS (2.575s) [367.790208] [060/133] (707s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [367.988123] Starting subtest: crc-primary-suspend-yf-tiled-ccs [367.993153] Starting dynamic subtest: pipe-A-HDMI-A-1 [384.791304] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.602s) [384.903409] Starting dynamic subtest: pipe-A-HDMI-A-2