[88.986446] Initializing watchdogs [88.986659] /dev/watchdog0 [89.026795] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [89.041738] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [89.050138] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [89.056157] [001/133] (960s left) perf_pmu (rc6) [89.191968] Starting subtest: rc6 [89.194449] Starting dynamic subtest: gt0 [95.543590] Dynamic subtest gt0: SUCCESS (6.347s) [95.577913] Starting dynamic subtest: runtime-pm-gt0 [103.401546] Dynamic subtest runtime-pm-gt0: SUCCESS (7.859s) [103.420686] Starting dynamic subtest: runtime-pm-long-gt0 [115.846130] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.440s) [115.876265] Starting dynamic subtest: other-idle-gt0 [115.880635] Dynamic subtest other-idle-gt0: SKIP (0.000s) [115.883077] Subtest rc6: SUCCESS (26.653s) [116.873397] [002/133] (932s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [117.061208] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [117.063437] Starting dynamic subtest: pipe-A [117.395881] Dynamic subtest pipe-A: SUCCESS (0.338s) [117.420072] Starting dynamic subtest: pipe-B [117.813257] Dynamic subtest pipe-B: SUCCESS (0.418s) [117.853788] Starting dynamic subtest: pipe-C [117.902261] Dynamic subtest pipe-C: SUCCESS (0.085s) [117.905421] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.843s) [118.317252] [003/133] (931s left) kms_invalid_mode (bad-vtotal) [118.497376] Starting subtest: bad-vtotal [118.501053] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.914961] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.419s) [118.952333] Starting dynamic subtest: pipe-A-HDMI-A-2 [118.954259] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.005s) [118.977955] Starting dynamic subtest: pipe-B-HDMI-A-1 [118.979638] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.003s) [118.997575] Starting dynamic subtest: pipe-B-HDMI-A-2 [118.999209] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.003s) [119.026110] Starting dynamic subtest: pipe-C-HDMI-A-1 [119.031291] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s) [119.069364] Starting dynamic subtest: pipe-C-HDMI-A-2 [119.078081] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.003s) [119.083201] Subtest bad-vtotal: SUCCESS (0.460s) [119.275830] [004/133] (930s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [119.471058] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [119.568802] [005/133] (930s left) perf_pmu (busy-check-all) [119.678114] Starting subtest: busy-check-all [119.679687] Starting dynamic subtest: rcs0 [120.215098] Dynamic subtest rcs0: SUCCESS (0.536s) [120.235402] Starting dynamic subtest: bcs0 [120.750023] Dynamic subtest bcs0: SUCCESS (0.530s) [120.769937] Starting dynamic subtest: vcs0 [121.281784] Dynamic subtest vcs0: SUCCESS (0.535s) [121.301542] Starting dynamic subtest: vecs0 [121.810805] Dynamic subtest vecs0: SUCCESS (0.527s) [121.812489] Subtest busy-check-all: SUCCESS (2.132s) [121.916351] [006/133] (928s left) gem_exec_params (invalid-flag) [122.029108] Starting subtest: invalid-flag [122.031253] Subtest invalid-flag: SUCCESS (0.001s) [122.133120] [007/133] (927s left) kms_atomic_transition (modeset-transition-fencing) [122.319043] Starting subtest: modeset-transition-fencing [122.320594] Starting dynamic subtest: 1x-outputs [125.854330] Dynamic subtest 1x-outputs: SUCCESS (3.542s) [125.876203] Starting dynamic subtest: 2x-outputs [133.215900] Dynamic subtest 2x-outputs: SUCCESS (7.362s) [133.219707] Subtest modeset-transition-fencing: SUCCESS (10.905s) [133.506901] [008/133] (916s left) gem_exec_whisper (basic-contexts-all) [133.643444] Starting subtest: basic-contexts-all [144.590467] Subtest basic-contexts-all: SUCCESS (10.946s) [144.799158] [009/133] (905s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [145.007174] Starting subtest: yf-tiled-8bpp-rotate-270 [145.011740] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [145.112944] [010/133] (905s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [145.298093] Starting subtest: cursor-vs-flip-atomic-transitions [185.924395] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (40.626s) [186.170357] [011/133] (864s left) gem_mmap_gtt (medium-copy) [186.273741] Starting subtest: medium-copy [190.573153] Subtest medium-copy: SUCCESS (4.297s) [190.690493] [012/133] (859s left) gem_render_copy (linear-to-vebox-y-tiled) [190.939202] Starting subtest: linear-to-vebox-y-tiled [190.943073] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [191.150334] [013/133] (859s left) kms_cursor_crc (cursor-onscreen-32x32) [191.354603] Starting subtest: cursor-onscreen-32x32 [191.521113] Subtest cursor-onscreen-32x32: SKIP (0.163s) [191.632913] [014/133] (859s left) gem_mmap_gtt (basic-write-gtt) [191.740126] Starting subtest: basic-write-gtt [192.465786] Subtest basic-write-gtt: SUCCESS (0.728s) [192.580645] [015/133] (858s left) api_intel_bb (bb-with-allocator) [192.688433] Starting subtest: bb-with-allocator [192.697497] Subtest bb-with-allocator: SUCCESS (0.012s) [192.800183] [016/133] (858s left) prime_vgem (basic-blt) [193.041556] Starting subtest: basic-blt [193.100707] Subtest basic-blt: SUCCESS (0.060s) [193.225681] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true [193.231222] [017/133] (857s left) core_setmaster (master-drop-set-user) [193.386100] Starting subtest: master-drop-set-user [193.431678] Subtest master-drop-set-user: SUCCESS (0.046s) [193.524223] [018/133] (857s left) prime_mmap_coherency (write) [193.639669] Starting subtest: write [199.030591] Subtest write: SUCCESS (5.391s) [199.165207] [019/133] (851s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [199.357677] Starting subtest: flip-vs-cursor-crc-atomic [200.301382] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.949s) [200.579015] [020/133] (850s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [200.796803] Starting subtest: y-tiled-addfb-size-offset-overflow [200.798581] Subtest y-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [200.923529] [021/133] (850s left) gen7_exec_parse (bitmasks) [201.039333] Subtest bitmasks: SKIP (0.000s) [201.147354] [022/133] (850s left) i915_pm_rps (basic-api) [201.264595] Starting subtest: basic-api [201.276339] Subtest basic-api: SUCCESS (0.011s) [201.387807] [023/133] (850s left) gem_userptr_blits (usage-restrictions) [201.508905] Starting subtest: usage-restrictions [201.510582] Subtest usage-restrictions: SUCCESS (0.000s) [201.677438] [024/133] (849s left) sysfs_heartbeat_interval (precise) [201.789505] Starting subtest: precise [201.795471] Starting dynamic subtest: vecs0 [203.273116] Dynamic subtest vecs0: SUCCESS (1.466s) [203.317112] Starting dynamic subtest: vcs0 [204.726237] Dynamic subtest vcs0: SUCCESS (1.463s) [204.755341] Starting dynamic subtest: bcs0 [206.169904] Dynamic subtest bcs0: SUCCESS (1.446s) [206.201342] Starting dynamic subtest: rcs0 [207.644659] Dynamic subtest rcs0: SUCCESS (1.472s) [207.646619] Subtest precise: SUCCESS (5.853s) [207.756306] [025/133] (843s left) sw_sync (sync_multi_consumer) [207.860514] Starting subtest: sync_multi_consumer [208.524080] Subtest sync_multi_consumer: SUCCESS (0.663s) [208.621348] [026/133] (843s left) kms_psr (pr-sprite-mmap-cpu) [208.815839] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [208.910799] [027/133] (842s left) prime_self_import (export-vs-gem_close-race) [209.008370] Starting subtest: export-vs-gem_close-race [214.032495] Subtest export-vs-gem_close-race: SUCCESS (5.023s) [214.136326] [028/133] (837s left) syncobj_wait (invalid-reset-bad-pad) [214.243920] Starting subtest: invalid-reset-bad-pad [214.245900] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [214.352214] [029/133] (837s left) kms_debugfs (display-on-read-all) [214.525297] Starting subtest: display-on-read-all [214.693100] Subtest display-on-read-all: SUCCESS (0.166s) [214.870414] [030/133] (837s left) kms_psr (psr-sprite-mmap-gtt) [215.051161] Subtest psr-sprite-mmap-gtt: SKIP (0.000s) [215.161958] [031/133] (837s left) kms_async_flips (async-flip-hang) [215.344059] Starting subtest: async-flip-hang [215.950646] Starting dynamic subtest: pipe-A-HDMI-A-1 [222.959753] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.008s) [223.332715] Starting dynamic subtest: pipe-A-HDMI-A-2 [230.961058] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.648s) [231.334659] Starting dynamic subtest: pipe-B-HDMI-A-1 [238.959628] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.652s) [239.314150] Starting dynamic subtest: pipe-B-HDMI-A-2 [246.959197] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (7.667s) [247.303877] Starting dynamic subtest: pipe-C-HDMI-A-1 [254.960221] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.685s) [255.321915] Starting dynamic subtest: pipe-C-HDMI-A-2 [262.963863] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.679s) [262.965460] Subtest async-flip-hang: SUCCESS (47.616s) [263.599272] [032/133] (788s left) gem_mmap_wc (close) [263.708154] Starting subtest: close [263.717121] Subtest close: SUCCESS (0.011s) [263.842370] [033/133] (788s left) syncobj_wait (reset-signaled) [263.944131] Starting subtest: reset-signaled [263.946168] Subtest reset-signaled: SUCCESS (0.001s) [264.057394] [034/133] (788s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [264.163198] Starting subtest: invalid-single-wait-all-unsubmitted [264.164817] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [264.273262] [035/133] (788s left) kms_cursor_crc (cursor-random-512x512) [264.478078] Starting subtest: cursor-random-512x512 [264.483932] Subtest cursor-random-512x512: SKIP (0.005s) [264.607953] [036/133] (788s left) kms_hdr (bpc-switch-suspend) [264.798072] Starting subtest: bpc-switch-suspend [293.335706] Subtest bpc-switch-suspend: SKIP (28.534s) [293.816975] [037/133] (759s left) kms_plane_alpha_blend (constant-alpha-mid) [294.032066] Starting subtest: constant-alpha-mid [294.206083] Starting dynamic subtest: pipe-A-HDMI-A-1 [295.231069] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.022s) [295.290839] Starting dynamic subtest: pipe-C-HDMI-A-1 [296.108986] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.872s) [296.112063] Subtest constant-alpha-mid: SUCCESS (2.077s) [296.425973] [038/133] (756s left) gem_reg_read (timestamp-moving) [296.534628] Starting subtest: timestamp-moving [297.538145] Subtest timestamp-moving: SUCCESS (1.002s) [297.648217] [039/133] (755s left) gem_userptr_blits (unsync-unmap) [297.765802] Subtest unsync-unmap: SKIP (0.000s) [297.928983] [040/133] (755s left) gem_exec_reloc (basic-wc-read) [298.056479] Starting subtest: basic-wc-read [298.078188] Subtest basic-wc-read: SUCCESS (0.021s) [298.265885] [041/133] (754s left) perf_pmu (idle-no-semaphores) [298.382410] Starting subtest: idle-no-semaphores [298.386095] Starting dynamic subtest: rcs0 [298.896073] Dynamic subtest rcs0: SUCCESS (0.513s) [298.921901] Starting dynamic subtest: bcs0 [299.413127] Dynamic subtest bcs0: SUCCESS (0.511s) [299.435522] Starting dynamic subtest: vcs0 [299.924919] Dynamic subtest vcs0: SUCCESS (0.510s) [299.951530] Starting dynamic subtest: vecs0 [300.442620] Dynamic subtest vecs0: SUCCESS (0.512s) [300.451122] Subtest idle-no-semaphores: SUCCESS (2.066s) [300.570150] [042/133] (752s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [300.752100] Starting subtest: primary-y-tiled-reflect-x-180 [300.765104] Subtest primary-y-tiled-reflect-x-180: SKIP (0.003s) [300.893114] [043/133] (752s left) kms_pm_rpm (basic-rte) [300.996424] Starting subtest: basic-rte [303.187339] Subtest basic-rte: SUCCESS (2.186s) [304.013623] [044/133] (749s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [304.130095] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [304.133357] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.004s) [304.249218] [045/133] (749s left) i915_hangman (detector) [304.385211] Starting subtest: detector [304.388120] Starting dynamic subtest: rcs0 [314.158134] Dynamic subtest rcs0: SUCCESS (9.774s) [314.257086] Starting dynamic subtest: bcs0 [324.141081] Dynamic subtest bcs0: SUCCESS (9.976s) [324.170749] Starting dynamic subtest: vcs0 [334.128073] Dynamic subtest vcs0: SUCCESS (9.982s) [334.157564] Starting dynamic subtest: vecs0 [344.114859] Dynamic subtest vecs0: SUCCESS (9.983s) [344.117824] Subtest detector: SUCCESS (39.735s) [344.261265] [046/133] (709s left) kms_psr (fbc-pr-primary-page-flip) [344.447139] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [344.555831] [047/133] (709s left) kms_cursor_edge_walk (128x128-top-bottom) [344.747057] Starting subtest: 128x128-top-bottom [344.750046] Starting dynamic subtest: pipe-A-HDMI-A-1 [348.619309] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.875s) [348.651435] Starting dynamic subtest: pipe-C-HDMI-A-1 [352.078118] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.451s) [352.079905] Subtest 128x128-top-bottom: SUCCESS (7.341s) [352.348257] [048/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [352.567284] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [352.573352] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [352.690328] [049/133] (701s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [352.873056] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [352.875146] Starting dynamic subtest: pipe-A-valid-mode [354.049547] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.175s) [354.053241] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (1.181s) [354.365895] [050/133] (699s left) syncobj_timeline (single-wait-available-submitted) [354.483290] Starting subtest: single-wait-available-submitted [354.486995] Subtest single-wait-available-submitted: SUCCESS (0.001s) [354.604753] [051/133] (699s left) gem_ctx_exec (basic-nohangcheck) [354.716250] Starting subtest: basic-nohangcheck [354.985392] Subtest basic-nohangcheck: SUCCESS (0.272s) [355.124751] [052/133] (699s left) kms_chamelium_color (ctm-max) [355.314063] Subtest ctm-max: SKIP (0.000s) [355.414717] [053/133] (699s left) kms_flip (absolute-wf_vblank) [355.618484] Starting subtest: absolute-wf_vblank [355.621114] Starting dynamic subtest: A-HDMI-A1 [361.293674] Dynamic subtest A-HDMI-A1: SUCCESS (5.678s) [361.318291] Starting dynamic subtest: B-HDMI-A1 [366.708089] Dynamic subtest B-HDMI-A1: SUCCESS (5.410s) [366.735353] Starting dynamic subtest: C-HDMI-A1 [372.099156] Dynamic subtest C-HDMI-A1: SUCCESS (5.382s) [372.123389] Starting dynamic subtest: A-HDMI-A2 [377.523801] Dynamic subtest A-HDMI-A2: SUCCESS (5.418s) [377.549928] Starting dynamic subtest: B-HDMI-A2 [382.920068] Dynamic subtest B-HDMI-A2: SUCCESS (5.393s) [382.948243] Starting dynamic subtest: C-HDMI-A2 [388.324065] Dynamic subtest C-HDMI-A2: SUCCESS (5.394s) [388.327077] Subtest absolute-wf_vblank: SUCCESS (32.716s) [388.922757] [054/133] (665s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [389.138830] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [389.144514] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [389.259990] [055/133] (665s left) kms_frontbuffer_tracking (basic) [389.453090] Starting subtest: basic [392.941929] Subtest basic: SUCCESS (3.487s) [393.184175] [056/133] (661s left) prime_vgem (basic-fence-read) [393.316090] Starting subtest: basic-fence-read [393.453058] Subtest basic-fence-read: SUCCESS (0.136s) [393.578194] [057/133] (661s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [393.762373] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [393.765861] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.000s) [393.877574] [058/133] (661s left) kms_big_fb (4-tiled-32bpp-rotate-180) [394.105765] Starting subtest: 4-tiled-32bpp-rotate-180 [394.111778] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [394.226124] [059/133] (660s left) kms_plane_multiple (tiling-x) [394.423106] Starting subtest: tiling-x [394.426214] Starting dynamic subtest: pipe-A-HDMI-A-1 [396.176912] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.753s) [396.218153] Starting dynamic subtest: pipe-A-HDMI-A-2 [397.877483] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.690s) [397.913444] Starting dynamic subtest: pipe-B-HDMI-A-1 [399.687360] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.794s) [399.736373] Starting dynamic subtest: pipe-B-HDMI-A-2 [401.349096] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.661s) [401.402315] Starting dynamic subtest: pipe-C-HDMI-A-1 [403.005067] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.648s) [403.038870] Starting dynamic subtest: pipe-C-HDMI-A-2 [404.704527] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.690s) [404.707065] Subtest tiling-x: SUCCESS (10.286s) [405.006425] [060/133] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [405.241038] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [407.347595] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.106s) [407.519353] [061/133] (647s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [407.633250] Starting subtest: etime-multi-wait-available-unsubmitted [407.740046] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s) [407.863374] [062/133] (647s left) syncobj_basic (bad-fd-to-handle) [407.972308] Starting subtest: bad-fd-to-handle [407.976183] Subtest bad-fd-to-handle: SUCCESS (0.000s) [408.095324] [063/133] (647s left) kms_psr2_su (page_flip-p010) [408.205072] Subtest page_flip-P010: SKIP (0.000s) [408.321526] [064/133] (647s left) gem_mmap (bad-offset) [408.425918] Starting subtest: bad-offset [408.429544] Subtest bad-offset: SUCCESS (0.002s) [408.550232] [065/133] (647s left) gem_eio (in-flight-suspend) [408.691300] Starting subtest: in-flight-suspend