[94.106978] Initializing watchdogs [94.107280] /dev/watchdog0 [94.147854] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [94.162924] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [94.170201] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [94.178439] [001/133] (960s left) gem_eio (in-flight-contexts-10ms) [94.341127] Starting subtest: in-flight-contexts-10ms [106.020371] Subtest in-flight-contexts-10ms: SUCCESS (11.678s) [106.278920] [002/133] (948s left) gem_ctx_shared (single-timeline) [106.412599] Starting subtest: single-timeline [106.434664] Subtest single-timeline: SUCCESS (0.013s) [106.719913] [003/133] (948s left) gem_exec_nop (basic-series) [106.866673] Starting subtest: basic-series [109.914757] Subtest basic-series: SUCCESS (3.063s) [110.205393] [004/133] (944s left) perf_pmu (busy-double-start) [110.334093] Starting subtest: busy-double-start [110.339079] Starting dynamic subtest: rcs0 [113.873772] Dynamic subtest rcs0: SUCCESS (3.541s) [113.898566] Starting dynamic subtest: bcs0 [117.428255] Dynamic subtest bcs0: SUCCESS (3.554s) [117.450177] Starting dynamic subtest: vcs0 [120.972508] Dynamic subtest vcs0: SUCCESS (3.542s) [120.994150] Starting dynamic subtest: vecs0 [124.514075] Dynamic subtest vecs0: SUCCESS (3.539s) [124.518219] Subtest busy-double-start: SUCCESS (14.181s) [124.657145] [005/133] (930s left) kms_dsc (dsc-with-output-formats) [124.843111] Subtest dsc-with-output-formats: SKIP (0.000s) [124.953282] [006/133] (930s left) gem_pxp (reject-modify-context-protection-off-3) [127.605106] Starting subtest: reject-modify-context-protection-off-3 [127.612984] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [127.741949] [007/133] (927s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [127.949179] Starting subtest: fbc-1p-pri-indfb-multidraw [144.853863] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (16.911s) [145.127445] [008/133] (910s left) syncobj_timeline (signal) [145.246656] Starting subtest: signal [145.250065] Subtest signal: SUCCESS (0.001s) [145.421895] [009/133] (909s left) kms_frontbuffer_tracking (psr-slowdraw) [145.627646] Starting subtest: psr-slowdraw [145.634609] Subtest psr-slowdraw: SKIP (0.000s) [145.778385] [010/133] (909s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [145.992118] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [148.507069] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (2.522s) [148.791964] [011/133] (906s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [148.981445] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [148.986288] Starting dynamic subtest: pipe-A-valid-mode [149.971830] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.985s) [149.977356] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (0.989s) [150.313268] [012/133] (905s left) kms_addfb_basic (invalid-set-prop) [150.431697] Starting subtest: invalid-set-prop [150.436064] Subtest invalid-set-prop: SUCCESS (0.000s) [150.647538] [013/133] (905s left) kms_big_fb (y-tiled-8bpp-rotate-0) [150.871931] Starting subtest: y-tiled-8bpp-rotate-0 [154.458032] Subtest y-tiled-8bpp-rotate-0: SUCCESS (3.586s) [154.747900] [014/133] (901s left) i915_selftest (mock) [156.243122] Starting subtest: mock [156.246850] Starting dynamic subtest: sanitycheck [157.886319] Dynamic subtest sanitycheck: SUCCESS (1.637s) [157.909312] Starting dynamic subtest: shmem [159.494370] Dynamic subtest shmem: SUCCESS (1.608s) [159.517305] Starting dynamic subtest: fence [168.081099] Dynamic subtest fence: SUCCESS (8.581s) [168.103285] Starting dynamic subtest: scatterlist [170.718080] Dynamic subtest scatterlist: SUCCESS (2.642s) [170.739979] Starting dynamic subtest: syncmap [174.421383] Dynamic subtest syncmap: SUCCESS (3.698s) [174.445362] Starting dynamic subtest: uncore [176.048681] Dynamic subtest uncore: SUCCESS (1.626s) [176.072385] Starting dynamic subtest: ring [177.661396] Dynamic subtest ring: SUCCESS (1.613s) [177.684398] Starting dynamic subtest: engine [179.295209] Dynamic subtest engine: SUCCESS (1.630s) [179.318262] Starting dynamic subtest: timelines [188.897140] Dynamic subtest timelines: SUCCESS (9.601s) [188.921604] Starting dynamic subtest: requests [192.613074] Dynamic subtest requests: SUCCESS (3.713s) [192.635218] Starting dynamic subtest: objects [194.362034] Dynamic subtest objects: SUCCESS (1.747s) [194.385307] Starting dynamic subtest: phys [196.132434] Dynamic subtest phys: SUCCESS (1.767s) [196.156318] Starting dynamic subtest: dmabuf [197.879897] Dynamic subtest dmabuf: SUCCESS (1.747s) [197.902546] Starting dynamic subtest: vma [218.873231] Dynamic subtest vma: SUCCESS (20.992s) [218.895443] Starting dynamic subtest: evict [222.949999] Dynamic subtest evict: SUCCESS (4.076s) [222.972097] Starting dynamic subtest: gtt [228.522329] Dynamic subtest gtt: SUCCESS (5.570s) [228.545255] Starting dynamic subtest: hugepages [230.849511] Dynamic subtest hugepages: SUCCESS (2.323s) [230.873259] Starting dynamic subtest: memory_region [239.100422] Dynamic subtest memory_region: SUCCESS (8.251s) [239.103654] Subtest mock: SUCCESS (82.858s) [239.169947] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [239.175768] [015/133] (816s left) gen7_exec_parse (basic-allowed) [241.879124] Subtest basic-allowed: SKIP (0.000s) [242.081132] [FACT gen7_exec_parse (basic-allowed)] new: kernel.kmod_is_loaded.i915: true [242.096689] [016/133] (814s left) gem_softpin (allocator-evict) [242.277919] Starting subtest: allocator-evict [242.282287] Starting dynamic subtest: rcs0 [270.790181] Dynamic subtest rcs0: SUCCESS (28.514s) [270.814131] Starting dynamic subtest: bcs0 [297.134752] Dynamic subtest bcs0: SUCCESS (26.343s) [297.159201] Starting dynamic subtest: vcs0 [323.727233] Dynamic subtest vcs0: SUCCESS (26.596s) [323.754054] Starting dynamic subtest: vecs0 [350.371402] Dynamic subtest vecs0: SUCCESS (26.637s) [350.375046] Subtest allocator-evict: SUCCESS (108.096s) [350.528963] [017/133] (705s left) kms_cursor_crc (cursor-sliding-64x21) [350.874876] Starting subtest: cursor-sliding-64x21 [350.939096] Starting dynamic subtest: pipe-A-HDMI-A-1 [355.285744] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.344s) [355.396244] Starting dynamic subtest: pipe-C-HDMI-A-1 [359.099188] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.743s) [359.104715] Subtest cursor-sliding-64x21: SUCCESS (8.220s) [359.450468] [018/133] (696s left) perf (low-oa-exponent-permissions) [359.735775] Starting subtest: low-oa-exponent-permissions [359.837032] Subtest low-oa-exponent-permissions: SUCCESS (0.100s) [359.946074] [019/133] (696s left) api_intel_bb (add-remove-objects) [360.062112] Starting subtest: add-remove-objects [360.071965] Subtest add-remove-objects: SUCCESS (0.017s) [360.225191] [020/133] (696s left) syncobj_eventfd (invalid-bad-flags) [360.345583] Starting subtest: invalid-bad-flags [360.350145] Subtest invalid-bad-flags: SUCCESS (0.000s) [360.477267] [021/133] (696s left) syncobj_wait (multi-wait-all-for-submit-submitted) [360.583566] Starting subtest: multi-wait-all-for-submit-submitted [360.692563] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s) [360.824141] [022/133] (695s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [361.003847] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [361.010177] Starting dynamic subtest: pipe-A-HDMI-A-1 [361.057870] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [361.109491] Starting dynamic subtest: pipe-A-HDMI-A-2 [361.154091] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s) [361.181049] Starting dynamic subtest: pipe-B-HDMI-A-1 [361.216097] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [361.239108] Starting dynamic subtest: pipe-B-HDMI-A-2 [361.269352] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [361.292599] Starting dynamic subtest: pipe-C-HDMI-A-1 [361.324036] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [361.347852] Starting dynamic subtest: pipe-C-HDMI-A-2 [361.377131] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [361.383104] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.029s) [362.482308] [023/133] (694s left) vgem_basic (bad-handle) [363.368700] Starting subtest: bad-handle [363.372684] Subtest bad-handle: SUCCESS (0.000s) [363.489201] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true [363.495931] [024/133] (693s left) gem_exec_params (rel-constants-invalid-rel-gen5) [363.609819] Starting subtest: rel-constants-invalid-rel-gen5 [363.613096] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s) [363.759814] [025/133] (693s left) gem_exec_fence (syncobj-channel) [364.323803] Starting subtest: syncobj-channel [365.404428] Subtest syncobj-channel: SUCCESS (1.078s) [365.797499] [026/133] (691s left) syncobj_wait (wait-all-for-submit-delayed-submit) [365.905295] Starting subtest: wait-all-for-submit-delayed-submit [366.008906] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s) [366.193098] [027/133] (691s left) kms_chamelium_hpd (common-hpd-after-suspend) [366.782078] Subtest common-hpd-after-suspend: SKIP (0.000s) [367.089327] [028/133] (690s left) kms_content_protection (suspend-resume) [367.302280] Starting subtest: suspend-resume [367.322897] Subtest suspend-resume: SKIP (0.014s) [367.472861] [029/133] (690s left) gem_mmap_gtt (pf-nonblock) [367.585612] Starting subtest: pf-nonblock [367.594848] Subtest pf-nonblock: SUCCESS (0.009s) [367.753982] [030/133] (690s left) kms_pm_dc (dc6-dpms) [368.957161] Starting subtest: dc6-dpms [368.969170] Subtest dc6-dpms: SKIP (0.000s) [369.108436] [031/133] (689s left) gem_pread (exhaustion) [369.235331] Starting subtest: exhaustion [395.415752] Subtest exhaustion: SUCCESS (26.195s) [395.605456] [032/133] (662s left) gem_ctx_persistence (engines-cleanup) [395.736161] Starting subtest: engines-cleanup [395.742210] Starting dynamic subtest: rcs0 [395.765562] Dynamic subtest rcs0: SUCCESS (0.032s) [395.791651] Starting dynamic subtest: bcs0 [395.795121] Dynamic subtest bcs0: SUCCESS (0.024s) [395.819922] Starting dynamic subtest: vcs0 [395.823223] Dynamic subtest vcs0: SUCCESS (0.014s) [395.848557] Starting dynamic subtest: vecs0 [395.852415] Dynamic subtest vecs0: SUCCESS (0.029s) [395.856350] Subtest engines-cleanup: SUCCESS (0.108s) [396.019877] [033/133] (662s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [396.230114] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [398.719102] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.497s) [399.008273] [034/133] (659s left) kms_debugfs (display-off-read-all) [399.191557] Starting subtest: display-off-read-all [399.574424] Subtest display-off-read-all: SUCCESS (0.386s) [399.917773] [035/133] (658s left) kms_color (ctm-negative) [400.118516] Starting subtest: ctm-negative [400.121641] Starting dynamic subtest: pipe-A-HDMI-A-1 [401.053975] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.937s) [401.111894] Starting dynamic subtest: pipe-A-HDMI-A-2 [401.717284] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.655s) [401.749044] Starting dynamic subtest: pipe-B-HDMI-A-1 [402.385873] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.674s) [402.433182] Starting dynamic subtest: pipe-B-HDMI-A-2 [403.038299] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.649s) [403.073438] Starting dynamic subtest: pipe-C-HDMI-A-1 [403.707178] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.668s) [403.756572] Starting dynamic subtest: pipe-C-HDMI-A-2 [404.354743] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.647s) [404.361529] Subtest ctm-negative: SUCCESS (4.242s) [404.710832] [036/133] (654s left) sw_sync (sync_multi_consumer_producer) [404.826181] Starting subtest: sync_multi_consumer_producer [405.291379] Subtest sync_multi_consumer_producer: SUCCESS (0.468s) [405.426518] [037/133] (653s left) gen9_exec_parse (bb-large) [405.558211] Starting subtest: bb-large [450.747146] Subtest bb-large: SUCCESS (45.190s) [451.060232] [038/133] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [451.454136] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [451.460830] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [451.613814] [039/133] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [451.815532] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [451.822138] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [451.982208] [040/133] (607s left) kms_flip (2x-plain-flip-ts-check-interruptible) [452.189060] Starting subtest: 2x-plain-flip-ts-check-interruptible [452.193140] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [463.299842] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.105s) [463.326152] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [474.352086] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.052s) [474.383995] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [485.351695] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.993s) [485.356226] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (33.165s) [486.020928] [041/133] (573s left) kms_cursor_crc (cursor-onscreen-32x10) [486.221243] Starting subtest: cursor-onscreen-32x10 [486.423098] Subtest cursor-onscreen-32x10: SKIP (0.166s) [486.561956] [042/133] (572s left) gem_eio (in-flight-external) [486.707511] Starting subtest: in-flight-external [486.838068] Subtest in-flight-external: SUCCESS (0.120s) [487.074882] [043/133] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [487.297492] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [487.305066] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [487.456757] [044/133] (572s left) kms_invalid_mode (zero-vdisplay) [487.652101] Starting subtest: zero-vdisplay [487.655973] Starting dynamic subtest: pipe-A-HDMI-A-1 [488.071140] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.418s) [488.123936] Starting dynamic subtest: pipe-A-HDMI-A-2 [488.135230] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [488.169078] Starting dynamic subtest: pipe-B-HDMI-A-1 [488.173661] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s) [488.224228] Starting dynamic subtest: pipe-B-HDMI-A-2 [488.230378] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [488.275890] Starting dynamic subtest: pipe-C-HDMI-A-1 [488.278845] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.004s) [488.308130] Starting dynamic subtest: pipe-C-HDMI-A-2 [488.311243] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.005s) [488.314332] Subtest zero-vdisplay: SUCCESS (0.469s) [488.460089] [045/133] (571s left) sw_sync (alloc_timeline) [488.574420] Starting subtest: alloc_timeline [488.577463] Subtest alloc_timeline: SUCCESS (0.000s) [488.708074] [046/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [488.928344] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [488.934364] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [489.093317] [047/133] (570s left) kms_big_fb (linear-64bpp-rotate-180) [489.304277] Starting subtest: linear-64bpp-rotate-180 [494.986551] Subtest linear-64bpp-rotate-180: SUCCESS (5.683s) [495.510510] [048/133] (564s left) kms_big_fb (4-tiled-64bpp-rotate-270) [495.714116] Starting subtest: 4-tiled-64bpp-rotate-270 [495.722089] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s) [495.877924] [049/133] (564s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [496.093956] Starting subtest: psr-rgb101010-draw-blt [496.101237] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [496.259258] [050/133] (564s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [496.468233] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [496.482204] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s) [496.628659] [051/133] (563s left) gem_mmap_wc (invalid-flags) [496.746788] Starting subtest: invalid-flags [496.750899] Subtest invalid-flags: SUCCESS (0.001s) [496.891760] [052/133] (563s left) gem_set_tiling_vs_pwrite [497.174822] [053/133] (563s left) kms_lease (invalid-create-leases) [497.377299] Starting subtest: invalid-create-leases [497.385092] Subtest invalid-create-leases: SUCCESS (0.010s) [497.554960] [054/133] (563s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [497.746151] Starting subtest: cursorA-vs-flipA-atomic [509.027559] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.281s) [509.358215] [055/133] (551s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [509.558128] Starting subtest: basic-flip-before-cursor-legacy [510.897500] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.340s) [511.270617] [056/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [511.490679] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [511.496834] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [511.653287] [057/133] (549s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [511.867348] Starting subtest: extended-pageflip-modeset-hang-oldfb [511.872089] Starting dynamic subtest: pipe-A [515.832961] Dynamic subtest pipe-A: SUCCESS (3.962s) [515.885729] Starting dynamic subtest: pipe-C [519.840634] Dynamic subtest pipe-C: SUCCESS (3.997s) [519.846022] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (7.977s) [520.194381] [058/133] (540s left) gem_exec_flush (basic-wb-ro-default) [520.341056] Starting subtest: basic-wb-ro-default [525.761819] Subtest basic-wb-ro-default: SUCCESS (5.421s) [526.037529] [059/133] (535s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [526.252385] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [526.259601] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [526.408459] [060/133] (534s left) kms_psr (fbc-psr-primary-mmap-cpu) [526.600873] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [526.732312] [061/133] (534s left) gem_ctx_persistence (heartbeat-stop) [526.860128] Starting subtest: heartbeat-stop [526.993809] Subtest heartbeat-stop: SUCCESS (0.132s) [527.156473] [062/133] (534s left) kms_pm_rpm (package-g7) [529.067687] Starting subtest: package-g7 [529.080055] Subtest package-g7: SKIP (0.000s) [529.473197] [063/133] (532s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [529.588047] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [529.693066] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s) [529.852495] [064/133] (531s left) kms_psr (fbc-pr-basic) [530.055032] Subtest fbc-pr-basic: SKIP (0.000s) [530.181087] [065/133] (531s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [530.421860] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [530.429663] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [530.587461] [066/133] (531s left) kms_addfb_basic (clobberred-modifier) [530.699468] Starting subtest: clobberred-modifier [530.703074] Subtest clobberred-modifier: SUCCESS (0.000s) [530.956371] [067/133] (531s left) kms_vblank (query-forked-busy-hang) [531.151369] Starting subtest: query-forked-busy-hang [531.155154] Starting dynamic subtest: pipe-A-HDMI-A-1 [538.451032] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.294s) [538.509996] Starting dynamic subtest: pipe-A-HDMI-A-2 [545.414126] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.954s) [545.467901] Starting dynamic subtest: pipe-C-HDMI-A-1 [552.379656] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.952s) [552.429633] Starting dynamic subtest: pipe-C-HDMI-A-2 [559.409694] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.025s) [559.412895] Subtest query-forked-busy-hang: SUCCESS (28.259s) [559.777386] [068/133] (502s left) gem_exec_schedule (independent) [559.917541] Starting subtest: independent [559.920858] Starting dynamic subtest: rcs0 [560.071032] Dynamic subtest rcs0: SUCCESS (0.148s) [560.104175] Starting dynamic subtest: bcs0 [560.228513] Dynamic subtest bcs0: SUCCESS (0.155s) [560.275164] Starting dynamic subtest: vcs0 [560.388639] Dynamic subtest vcs0: SUCCESS (0.158s) [560.417680] Starting dynamic subtest: vecs0 [560.528538] Dynamic subtest vecs0: SUCCESS (0.135s) [560.532578] Subtest independent: SUCCESS (0.612s) [560.925174] [069/133] (501s left) kms_psr (psr-no-drrs) [561.125030] Subtest psr-no-drrs: SKIP (0.000s) [561.253573] [070/133] (501s left) perf_pmu (multi-client) [561.384244] Starting subtest: multi-client [561.389526] Starting dynamic subtest: rcs0 [562.414879] Dynamic subtest rcs0: SUCCESS (1.028s) [562.443539] Starting dynamic subtest: bcs0 [563.446872] Dynamic subtest bcs0: SUCCESS (1.028s) [563.474713] Starting dynamic subtest: vcs0 [564.482778] Dynamic subtest vcs0: SUCCESS (1.030s) [564.510743] Starting dynamic subtest: vecs0 [565.514075] Dynamic subtest vecs0: SUCCESS (1.026s) [565.518118] Subtest multi-client: SUCCESS (4.129s) [565.672681] [071/133] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [565.881157] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [565.888126] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [566.043395] [072/133] (496s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [566.159370] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [566.162797] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.002s) [566.352812] [073/133] (496s left) i915_pm_rpm (reg-read-ioctl) [568.263510] Starting subtest: reg-read-ioctl [568.608468] Subtest reg-read-ioctl: SUCCESS (0.345s) [569.028727] [074/133] (493s left) gem_exec_balancer (parallel-keep-in-fence) [569.286136] Subtest parallel-keep-in-fence: SKIP (0.000s) [569.458530] [075/133] (493s left) gem_exec_schedule (preempt-user) [569.605253] Starting subtest: preempt-user [569.608944] Starting dynamic subtest: rcs0 [569.659306] Dynamic subtest rcs0: SUCCESS (0.055s) [569.695270] Starting dynamic subtest: bcs0 [569.732949] Dynamic subtest bcs0: SUCCESS (0.072s) [569.769385] Starting dynamic subtest: vcs0 [569.783370] Dynamic subtest vcs0: SUCCESS (0.049s) [569.818313] Starting dynamic subtest: vecs0 [569.836488] Dynamic subtest vecs0: SUCCESS (0.048s) [569.840763] Subtest preempt-user: SUCCESS (0.235s) [570.243171] [076/133] (492s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [570.427776] Starting subtest: cursorA-vs-flipB-atomic-transitions [581.713684] Subtest cursorA-vs-flipB-atomic-transitions: SUCCESS (11.284s) [582.057387] [077/133] (481s left) i915_fb_tiling (basic-x-tiling) [582.186602] Starting subtest: basic-x-tiling [582.190480] Subtest basic-x-tiling: SUCCESS (0.002s) [582.343047] [078/133] (481s left) kms_selftest (drm_cmdline_parser) [582.477562] Starting subtest: drm_cmdline_parser [582.537070] Starting dynamic subtest: drm_test_cmdline_force_d_only [582.591982] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.060s) [582.625499] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [582.653553] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.054s) [582.686659] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [582.726065] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.061s) [582.758300] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [582.789277] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.056s) [582.822106] Starting dynamic subtest: drm_test_cmdline_force_e_only [582.845323] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.050s) [582.877931] Starting dynamic subtest: drm_test_cmdline_res [582.909058] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.053s) [582.938112] Starting dynamic subtest: drm_test_cmdline_res_vesa [582.960388] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.049s) [582.993644] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [583.014851] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.049s) [583.050912] Starting dynamic subtest: drm_test_cmdline_res_rblank [583.068055] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.048s) [583.100642] Starting dynamic subtest: drm_test_cmdline_res_bpp [583.114844] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.039s) [583.148892] Starting dynamic subtest: drm_test_cmdline_res_refresh [583.165024] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.042s) [583.196330] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [583.219899] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.051s) [583.253133] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [583.286077] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.053s) [583.315200] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [583.343737] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.053s) [583.370440] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [583.392671] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.042s) [583.419973] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [583.451656] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.061s) [583.482606] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [583.524673] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.069s) [583.556180] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [583.587820] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.055s) [583.620059] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [583.651086] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.055s) [583.680546] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [583.709867] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.054s) [583.741923] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [583.775664] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.063s) [583.808931] Starting dynamic subtest: drm_test_cmdline_name [583.838736] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.056s) [583.871605] Starting dynamic subtest: drm_test_cmdline_name_bpp [583.899907] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.055s) [583.932904] Starting dynamic subtest: drm_test_cmdline_name_option [583.974053] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.063s) [584.002900] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [584.027405] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.053s) [584.060572] Starting dynamic subtest: drm_test_cmdline_rotate_0 [584.103057] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.065s) [584.133600] Starting dynamic subtest: drm_test_cmdline_rotate_90 [584.171064] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.063s) [584.199537] Starting dynamic subtest: drm_test_cmdline_rotate_180 [584.237114] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.063s) [584.266603] Starting dynamic subtest: drm_test_cmdline_rotate_270 [584.296242] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.056s) [584.328834] Starting dynamic subtest: drm_test_cmdline_hmirror [584.364233] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.062s) [584.397347] Starting dynamic subtest: drm_test_cmdline_vmirror [584.430408] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.062s) [584.463805] Starting dynamic subtest: drm_test_cmdline_margin_options [584.498928] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.062s) [584.531867] Starting dynamic subtest: drm_test_cmdline_multiple_options [584.560482] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.055s) [584.593719] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [584.637323] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.066s) [584.664995] Starting dynamic subtest: drm_test_cmdline_extra_and_option [584.685637] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.046s) [584.718531] Starting dynamic subtest: drm_test_cmdline_freestanding_options [584.747977] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.056s) [584.781269] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [584.807417] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.052s) [584.840517] Starting dynamic subtest: drm_test_cmdline_panel_orientation [584.872718] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.055s) [584.905579] Starting dynamic subtest: drm_test_cmdline_invalid [584.978130] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.097s) [585.006639] Starting dynamic subtest: drm_test_cmdline_tv_options [585.059518] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.078s) [585.067036] Subtest drm_cmdline_parser: SUCCESS (2.584s) [585.262125] [079/133] (478s left) kms_flip (2x-blocking-absolute-wf_vblank) [585.478661] Starting subtest: 2x-blocking-absolute-wf_vblank [585.484049] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [596.320629] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.843s) [596.348820] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [607.022160] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.696s) [607.055238] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [617.771063] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.739s) [617.778060] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (32.299s) [618.421447] [080/133] (445s left) syncobj_wait (multi-wait-all-submitted-signaled) [618.539854] Starting subtest: multi-wait-all-submitted-signaled [618.645206] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.109s) [618.816889] [081/133] (444s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [619.029093] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [621.896039] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.870s) [622.234696] [082/133] (441s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [622.438546] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [622.445041] Starting dynamic subtest: pipe-A [623.530911] Dynamic subtest pipe-A: SUCCESS (1.098s) [623.560292] Starting dynamic subtest: pipe-B [624.711914] Dynamic subtest pipe-B: SUCCESS (1.179s) [624.772329] Starting dynamic subtest: pipe-C [625.131714] Dynamic subtest pipe-C: SUCCESS (0.416s) [625.137376] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (2.705s) [625.742350] [083/133] (438s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [625.943895] Starting subtest: basic-busy-flip-before-cursor-legacy [625.954044] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [626.108152] [084/133] (437s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [626.314093] Starting subtest: short-flip-before-cursor-toggle [627.664916] Subtest short-flip-before-cursor-toggle: SUCCESS (1.357s) [627.976541] [085/133] (436s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [628.198867] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [631.201168] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (3.002s) [631.425952] [086/133] (432s left) kms_frontbuffer_tracking (fbc-1p-rte) [631.643134] Starting subtest: fbc-1p-rte [635.328076] Subtest fbc-1p-rte: SUCCESS (3.699s) [635.699204] [087/133] (428s left) gem_softpin (evict-snoop-interruptible) [635.824700] Starting subtest: evict-snoop-interruptible [635.832174] Subtest evict-snoop-interruptible: SKIP (0.000s) [635.987931] [088/133] (428s left) kms_atomic_transition (modeset-transition-fencing) [636.183065] Starting subtest: modeset-transition-fencing [636.187107] Starting dynamic subtest: 1x-outputs [639.704490] Dynamic subtest 1x-outputs: SUCCESS (3.527s) [639.732057] Starting dynamic subtest: 2x-outputs [647.066031] Dynamic subtest 2x-outputs: SUCCESS (7.357s) [647.069491] Subtest modeset-transition-fencing: SUCCESS (10.894s) [647.394565] [089/133] (417s left) api_intel_bb (intel-bb-blit-y) [647.515169] Starting subtest: intel-bb-blit-y [650.767985] Subtest intel-bb-blit-y: SUCCESS (3.256s) [650.971497] [090/133] (413s left) kms_async_flips (async-flip-suspend-resume) [651.167258] Starting subtest: async-flip-suspend-resume [651.763423] Starting dynamic subtest: pipe-A-HDMI-A-1