[88.149298] Initializing watchdogs [88.149470] /dev/watchdog0 [88.189674] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605] [88.203435] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [88.212328] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [88.219185] [001/155] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt) [88.427653] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt [88.431875] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [88.576581] [002/155] (960s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite) [88.771945] Starting subtest: fbchdr-rgb565-draw-pwrite [89.784430] Subtest fbchdr-rgb565-draw-pwrite: SUCCESS (1.012s) [90.062417] [003/155] (958s left) gem_exec_reloc (basic-wc-read-active) [90.183675] Starting subtest: basic-wc-read-active [90.334643] Subtest basic-wc-read-active: SUCCESS (0.149s) [90.544480] [004/155] (958s left) gem_exec_balancer (invalid-balancer) [90.666549] Starting subtest: invalid-balancer [94.946685] Subtest invalid-balancer: SUCCESS (4.278s) [95.211638] [005/155] (953s left) gem_exec_reloc (basic-write-cpu-noreloc) [95.329407] Starting subtest: basic-write-cpu-noreloc [95.337513] Subtest basic-write-cpu-noreloc: SUCCESS (0.010s) [95.544482] [006/155] (953s left) gem_ctx_persistence (engines-queued) [95.656476] Starting subtest: engines-queued [95.658699] Starting dynamic subtest: rcs0 [95.715347] Dynamic subtest rcs0: SUCCESS (0.058s) [95.736212] Starting dynamic subtest: bcs0 [95.863094] Dynamic subtest bcs0: SUCCESS (0.145s) [95.883278] Starting dynamic subtest: vcs0 [95.933712] Dynamic subtest vcs0: SUCCESS (0.070s) [95.954642] Starting dynamic subtest: vecs0 [96.000590] Dynamic subtest vecs0: SUCCESS (0.065s) [96.002845] Subtest engines-queued: SUCCESS (0.344s) [96.126543] [007/155] (953s left) syncobj_timeline (multi-wait-available-submitted-signaled) [96.227865] Starting subtest: multi-wait-available-submitted-signaled [96.230087] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.003s) [96.366301] [008/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [96.556623] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [96.560803] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [96.699275] [009/155] (952s left) i915_pm_rps (thresholds) [96.828384] Starting subtest: thresholds [96.830604] Starting dynamic subtest: gt0 [106.943873] Dynamic subtest gt0: SUCCESS (10.114s) [106.946019] Subtest thresholds: SUCCESS (10.117s) [107.077217] [010/155] (942s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [107.280927] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc [107.284891] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [107.413195] [011/155] (942s left) syncobj_wait (invalid-signal-bad-pad) [107.513265] Starting subtest: invalid-signal-bad-pad [107.515194] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [107.642934] [012/155] (941s left) kms_big_fb (y-tiled-64bpp-rotate-90) [107.837259] Starting subtest: y-tiled-64bpp-rotate-90 [108.344592] Subtest y-tiled-64bpp-rotate-90: SKIP (0.506s) [108.598359] [013/155] (941s left) gem_ccs (block-copy-uncompressed) [108.709703] Subtest block-copy-uncompressed: SKIP (0.000s) [108.803656] [014/155] (940s left) kms_flip (2x-flip-vs-panning-interruptible) [108.985643] Starting subtest: 2x-flip-vs-panning-interruptible [108.990590] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [119.809868] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.818s) [119.833561] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [130.496677] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.682s) [130.517609] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [141.197137] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.698s) [141.199234] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (32.211s) [141.790790] [015/155] (908s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-blt) [141.981157] Starting subtest: psrhdr-rgb101010-draw-blt [141.985343] Subtest psrhdr-rgb101010-draw-blt: SKIP (0.000s) [142.110415] [016/155] (907s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite) [142.300810] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite [143.581946] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SUCCESS (1.282s) [143.761133] [017/155] (906s left) syncobj_timeline (invalid-query-zero-handles) [143.894483] Starting subtest: invalid-query-zero-handles [143.896539] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [144.026706] [018/155] (906s left) kms_content_protection (content-type-change) [144.219893] Starting subtest: content-type-change [144.235957] Subtest content-type-change: SKIP (0.012s) [144.378417] [019/155] (905s left) gem_fence_thrash (bo-write-verify-x) [144.476541] Starting subtest: bo-write-verify-x [145.732861] Subtest bo-write-verify-x: SUCCESS (1.256s) [145.911781] [020/155] (904s left) gem_exec_parallel (fds) [146.033494] Starting subtest: fds [146.035582] Starting dynamic subtest: rcs0 [149.448982] Dynamic subtest rcs0: SUCCESS (3.413s) [149.469433] Starting dynamic subtest: bcs0 [152.964688] Dynamic subtest bcs0: SUCCESS (3.513s) [152.985045] Starting dynamic subtest: vcs0 [156.368848] Dynamic subtest vcs0: SUCCESS (3.403s) [156.390260] Starting dynamic subtest: vecs0 [159.629590] Dynamic subtest vecs0: SUCCESS (3.258s) [159.632606] Subtest fds: SUCCESS (13.596s) [159.935943] [021/155] (890s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [160.112104] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [160.114038] Starting dynamic subtest: pipe-A-valid-mode [160.616597] Dynamic subtest pipe-A-valid-mode: SKIP (0.503s) [160.620909] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.507s) [161.075826] [022/155] (889s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [161.269631] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [161.273570] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [161.424709] [023/155] (889s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [161.607385] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [161.701926] [024/155] (888s left) i915_query (query-topology-garbage-items) [161.804109] Starting subtest: query-topology-garbage-items [161.806146] Subtest query-topology-garbage-items: SUCCESS (0.001s) [161.945095] [025/155] (888s left) gem_mmap_gtt (basic-small-bo) [162.045182] Starting subtest: basic-small-bo [162.974330] Subtest basic-small-bo: SUCCESS (0.930s) [163.177639] [026/155] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [163.492854] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [163.497177] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [163.643208] [027/155] (887s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [163.820501] Starting subtest: cursorA-vs-flipA-varying-size [175.083727] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.264s) [175.433783] [028/155] (875s left) kms_properties (crtc-properties-atomic) [175.620835] Starting subtest: crtc-properties-atomic [175.623196] Starting dynamic subtest: pipe-A-HDMI-A-1 [176.173307] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.551s) [176.196343] Starting dynamic subtest: pipe-B-HDMI-A-2 [176.595075] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.420s) [176.620673] Starting dynamic subtest: pipe-C-HDMI-A-1 [177.052300] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.452s) [177.054492] Subtest crtc-properties-atomic: SUCCESS (1.436s) [177.356134] [029/155] (873s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [177.543423] Starting subtest: psr-rgb565-draw-render [177.547422] Subtest psr-rgb565-draw-render: SKIP (0.000s) [177.716845] [030/155] (873s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [177.910131] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [180.933570] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.023s) [181.152102] [031/155] (870s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [181.330423] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [181.334233] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [181.467596] [032/155] (869s left) gem_exec_balancer (parallel-ordering) [181.714854] Subtest parallel-ordering: SKIP (0.000s) [181.849600] [033/155] (869s left) kms_vblank (query-forked-busy-hang) [182.026244] Starting subtest: query-forked-busy-hang [182.028132] Starting dynamic subtest: pipe-A-HDMI-A-1 [189.934493] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.908s) [189.963263] Starting dynamic subtest: pipe-A-HDMI-A-2 [196.908633] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.969s) [196.939750] Starting dynamic subtest: pipe-C-HDMI-A-1 [203.867354] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.950s) [203.892520] Starting dynamic subtest: pipe-C-HDMI-A-2 [210.912422] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.037s) [210.914636] Subtest query-forked-busy-hang: SUCCESS (28.892s) [211.223450] [034/155] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [211.418519] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [213.702840] Subtest fbc-2p-scndscrn-cur-indfb-move: SUCCESS (2.282s) [213.970230] [035/155] (837s left) perf_pmu (invalid-init) [214.084058] Starting subtest: invalid-init [214.086289] Subtest invalid-init: SUCCESS (0.001s) [214.270348] [036/155] (837s left) syncobj_timeline (single-wait-all-available-signaled) [214.389109] Starting subtest: single-wait-all-available-signaled [214.391410] Subtest single-wait-all-available-signaled: SUCCESS (0.001s) [214.521369] [037/155] (837s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render) [214.707779] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render [215.486205] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SUCCESS (0.778s) [215.790477] [038/155] (836s left) gem_userptr_blits (nohangcheck) [215.944661] Starting subtest: nohangcheck [216.248214] Subtest nohangcheck: SUCCESS (0.300s) [216.407161] [039/155] (835s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [216.581947] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [216.584155] Starting dynamic subtest: pipe-A-HDMI-A-1 [216.604471] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [216.626537] Starting dynamic subtest: pipe-A-HDMI-A-2 [216.645756] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [216.667831] Starting dynamic subtest: pipe-B-HDMI-A-1 [216.686904] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [216.709047] Starting dynamic subtest: pipe-B-HDMI-A-2 [216.728865] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [216.750367] Starting dynamic subtest: pipe-C-HDMI-A-1 [216.768899] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [216.790641] Starting dynamic subtest: pipe-C-HDMI-A-2 [216.809014] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [216.812816] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.030s) [217.548597] [040/155] (834s left) kms_cursor_crc (cursor-sliding-512x170) [217.741380] Starting subtest: cursor-sliding-512x170 [217.746726] Subtest cursor-sliding-512x170: SKIP (0.002s) [217.899853] [041/155] (834s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt) [218.090175] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt [218.994176] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SUCCESS (0.904s) [219.320594] [042/155] (832s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [219.520057] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [221.153208] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.631s) [221.467419] [043/155] (830s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [221.644842] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [221.648810] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s) [221.771406] [044/155] (830s left) kms_flip (basic-flip-vs-modeset) [221.976289] Starting subtest: basic-flip-vs-modeset [221.978505] Starting dynamic subtest: A-HDMI-A1 [223.057701] Dynamic subtest A-HDMI-A1: SUCCESS (1.101s) [223.081602] Starting dynamic subtest: B-HDMI-A1 [223.999803] Dynamic subtest B-HDMI-A1: SUCCESS (0.941s) [224.027343] Starting dynamic subtest: C-HDMI-A1 [224.953364] Dynamic subtest C-HDMI-A1: SUCCESS (0.944s) [224.976927] Starting dynamic subtest: A-HDMI-A2 [225.658187] Dynamic subtest A-HDMI-A2: SUCCESS (0.698s) [225.685321] Starting dynamic subtest: B-HDMI-A2 [226.605385] Dynamic subtest B-HDMI-A2: SUCCESS (0.948s) [226.631886] Starting dynamic subtest: C-HDMI-A2 [227.547752] Dynamic subtest C-HDMI-A2: SUCCESS (0.938s) [227.549959] Subtest basic-flip-vs-modeset: SUCCESS (5.601s) [227.880434] [045/155] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [228.106465] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [228.112727] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [228.262369] [046/155] (824s left) core_getversion (basic) [228.362237] Starting subtest: basic [228.367545] Subtest basic: SUCCESS (0.000s) [228.497079] [047/155] (824s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [228.674510] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [228.773572] [048/155] (824s left) gem_ctx_persistence (legacy-engines-queued) [228.884469] Starting subtest: legacy-engines-queued [228.887490] Starting dynamic subtest: render [228.951176] Dynamic subtest render: SUCCESS (0.065s) [228.976898] Starting dynamic subtest: bsd [228.988478] Dynamic subtest bsd: SUCCESS (0.031s) [229.010828] Starting dynamic subtest: blt [229.136292] Dynamic subtest blt: SUCCESS (0.145s) [229.163133] Starting dynamic subtest: vebox [229.203896] Dynamic subtest vebox: SUCCESS (0.061s) [229.206243] Subtest legacy-engines-queued: SUCCESS (0.323s) [229.343657] [049/155] (823s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render) [229.530745] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render [230.504461] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SUCCESS (0.974s) [230.723376] [050/155] (822s left) kms_lease (possible-crtcs-filtering) [230.901268] Starting subtest: possible-crtcs-filtering [230.909982] Subtest possible-crtcs-filtering: SUCCESS (0.008s) [231.068650] [051/155] (821s left) gem_fenced_exec_thrash (no-spare-fences) [231.176727] Starting subtest: no-spare-fences [233.345658] Subtest no-spare-fences: SUCCESS (2.167s) [233.503495] [052/155] (819s left) gem_softpin (noreloc) [233.621264] Starting subtest: noreloc [239.165153] Subtest noreloc: SUCCESS (5.542s) [239.319660] [053/155] (813s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff) [239.508863] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff [239.513819] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [239.655541] [054/155] (813s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [239.834170] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [239.838077] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [239.971705] [055/155] (813s left) gem_mmap_wc (pf-nonblock) [240.074142] Starting subtest: pf-nonblock [240.082779] Subtest pf-nonblock: SUCCESS (0.005s) [240.237246] [056/155] (813s left) gem_exec_schedule (submit-late-slice) [240.368716] Starting subtest: submit-late-slice [240.372759] Starting dynamic subtest: rcs0 [240.423742] Dynamic subtest rcs0: SUCCESS (0.056s) [240.456323] Starting dynamic subtest: bcs0 [240.477533] Dynamic subtest bcs0: SUCCESS (0.050s) [240.508407] Starting dynamic subtest: vcs0 [240.529442] Dynamic subtest vcs0: SUCCESS (0.048s) [240.559400] Starting dynamic subtest: vecs0 [240.580423] Dynamic subtest vecs0: SUCCESS (0.047s) [240.582589] Subtest submit-late-slice: SUCCESS (0.216s) [240.986976] [057/155] (812s left) gem_eio (wait-immediate) [241.115993] Starting subtest: wait-immediate [241.188573] Subtest wait-immediate: SUCCESS (0.071s) [241.423895] [058/155] (812s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt) [241.611123] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt [242.831326] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SUCCESS (1.220s) [243.046676] [059/155] (810s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [243.237100] Starting subtest: fbc-modesetfrombusy [245.168922] Subtest fbc-modesetfrombusy: SUCCESS (1.932s) [245.451753] [060/155] (808s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc) [245.646350] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc [246.723726] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.077s) [246.925871] [061/155] (807s left) gem_exec_params (sol-reset-not-gen7) [247.038574] Starting subtest: sol-reset-not-gen7 [247.041090] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [247.193395] [062/155] (806s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [249.830957] Starting subtest: verify-pxp-key-change-after-suspend-resume [249.836930] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s) [249.959173] [063/155] (804s left) prime_vgem (busy) [250.190586] Starting subtest: busy [250.192816] Starting dynamic subtest: rcs0 [250.207176] Dynamic subtest rcs0: SUCCESS (0.015s) [250.237734] Starting dynamic subtest: vcs0 [250.240343] Dynamic subtest vcs0: SUCCESS (0.018s) [250.265720] Starting dynamic subtest: vecs0 [250.268430] Dynamic subtest vecs0: SUCCESS (0.020s) [250.271493] Subtest busy: SUCCESS (0.062s) [250.412088] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true [250.421515] [064/155] (803s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [250.595289] Starting subtest: 2x-long-flip-vs-cursor-atomic [256.391325] Subtest 2x-long-flip-vs-cursor-atomic: SUCCESS (5.796s) [256.705819] [065/155] (797s left) kms_cursor_crc (cursor-rapid-movement-128x42) [256.890243] Starting subtest: cursor-rapid-movement-128x42 [256.929175] Starting dynamic subtest: pipe-A-HDMI-A-1 [257.808655] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.878s) [257.888533] Starting dynamic subtest: pipe-C-HDMI-A-1 [258.404431] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.538s) [258.407473] Subtest cursor-rapid-movement-128x42: SUCCESS (1.517s) [258.747468] [066/155] (795s left) kms_scaling_modes (scaling-mode-full-aspect) [258.925600] Starting subtest: scaling-mode-full-aspect [258.940675] Subtest scaling-mode-full-aspect: SKIP (0.001s) [259.077866] [067/155] (795s left) kms_plane (plane-position-hole) [259.255352] Starting subtest: plane-position-hole [259.945180] Starting dynamic subtest: pipe-A-plane-1 [260.448300] Dynamic subtest pipe-A-plane-1: SUCCESS (0.501s) [260.472136] Starting dynamic subtest: pipe-A-plane-2 [260.967604] Dynamic subtest pipe-A-plane-2: SUCCESS (0.517s) [260.991457] Starting dynamic subtest: pipe-A-plane-3 [261.487363] Dynamic subtest pipe-A-plane-3: SUCCESS (0.517s) [261.512257] Starting dynamic subtest: pipe-A-plane-4 [261.516194] Dynamic subtest pipe-A-plane-4: SUCCESS (0.007s) [261.948193] Starting dynamic subtest: pipe-B-plane-1 [262.421750] Dynamic subtest pipe-B-plane-1: SUCCESS (0.494s) [262.445558] Starting dynamic subtest: pipe-B-plane-2 [262.909553] Dynamic subtest pipe-B-plane-2: SUCCESS (0.486s) [262.935124] Starting dynamic subtest: pipe-B-plane-3 [263.398341] Dynamic subtest pipe-B-plane-3: SUCCESS (0.485s) [263.424075] Starting dynamic subtest: pipe-B-plane-4 [263.428040] Dynamic subtest pipe-B-plane-4: SUCCESS (0.007s) [263.430016] Subtest plane-position-hole: SUCCESS (4.155s) [263.767094] [068/155] (790s left) vgem_basic (second-client) [263.896701] Starting subtest: second-client [263.931684] Subtest second-client: SUCCESS (0.035s) [264.052939] [069/155] (790s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [264.240172] Starting subtest: fbcpsrhdr-tiling-4 [264.244374] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [264.401586] [070/155] (790s left) gem_mmap_offset (bad-object) [264.499254] Starting subtest: bad-object [264.505151] Subtest bad-object: SUCCESS (0.004s) [264.668868] [071/155] (790s left) kms_prime (basic-crc-vgem) [264.880339] Starting subtest: basic-crc-vgem [264.882403] Starting dynamic subtest: second-to-first [266.422096] Dynamic subtest second-to-first: SUCCESS (1.541s) [266.424283] Subtest basic-crc-vgem: SUCCESS (1.545s) [266.716437] [072/155] (788s left) kms_setmode (invalid-clone-single-crtc) [266.823940] Starting subtest: invalid-clone-single-crtc [267.251086] Starting dynamic subtest: pipe-A-HDMI-A-1-HDMI-A-2 [267.281770] Dynamic subtest pipe-A-HDMI-A-1-HDMI-A-2: SUCCESS (0.032s) [267.321600] Starting dynamic subtest: pipe-B-HDMI-A-1-HDMI-A-2 [267.333264] Dynamic subtest pipe-B-HDMI-A-1-HDMI-A-2: SUCCESS (0.029s) [267.337231] Subtest invalid-clone-single-crtc: SUCCESS (0.514s) [267.663486] [073/155] (787s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [267.859487] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [268.782958] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.924s) [269.111297] [074/155] (786s left) kms_big_fb (linear-8bpp-rotate-90) [269.308916] Starting subtest: linear-8bpp-rotate-90 [269.587094] Subtest linear-8bpp-rotate-90: SKIP (0.278s) [269.865756] [075/155] (785s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [270.054831] Starting subtest: psr-rgb101010-draw-blt [270.059082] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [270.228229] [076/155] (785s left) kms_atomic (plane-invalid-params) [270.407486] Starting subtest: plane-invalid-params [270.409607] Starting dynamic subtest: pipe-A-HDMI-A-1 [270.952310] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.542s) [270.954721] Subtest plane-invalid-params: SUCCESS (0.548s) [271.285806] [077/155] (784s left) kms_psr (pr-sprite-blt) [271.472665] Subtest pr-sprite-blt: SKIP (0.000s) [271.578680] [078/155] (784s left) kms_cursor_crc (cursor-onscreen-32x32) [271.756403] Starting subtest: cursor-onscreen-32x32 [271.901939] Subtest cursor-onscreen-32x32: SKIP (0.143s) [272.087317] [079/155] (783s left) kms_getfb (getfb-handle-not-fb) [272.263718] Starting subtest: getfb-handle-not-fb [272.266121] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [272.418662] [080/155] (783s left) perf_pmu (busy-idle-check-all) [272.526531] Starting subtest: busy-idle-check-all [272.529279] Starting dynamic subtest: rcs0 [273.160508] Dynamic subtest rcs0: SUCCESS (0.629s) [273.186112] Starting dynamic subtest: bcs0 [273.797067] Dynamic subtest bcs0: SUCCESS (0.637s) [273.826743] Starting dynamic subtest: vcs0 [274.431461] Dynamic subtest vcs0: SUCCESS (0.628s) [274.457226] Starting dynamic subtest: vecs0 [275.067797] Dynamic subtest vecs0: SUCCESS (0.637s) [275.070461] Subtest busy-idle-check-all: SUCCESS (2.543s) [275.219420] [081/155] (780s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [275.333152] Starting subtest: y-tiled-to-vebox-yf-tiled [275.338661] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [275.585360] [082/155] (780s left) gem_exec_params (no-blt) [275.697486] Starting subtest: no-blt [275.701822] Subtest no-blt: SUCCESS (0.004s) [275.868632] [083/155] (780s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [276.043709] Starting subtest: flip-vs-cursor-atomic-transitions [294.472170] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (18.431s) [294.809575] [084/155] (761s left) kms_flip (flip-vs-absolute-wf_vblank) [294.985154] Starting subtest: flip-vs-absolute-wf_vblank [294.993559] Starting dynamic subtest: A-HDMI-A1 [300.900202] Dynamic subtest A-HDMI-A1: SUCCESS (5.908s) [300.929308] Starting dynamic subtest: B-HDMI-A1 [306.569248] Dynamic subtest B-HDMI-A1: SUCCESS (5.665s) [306.599396] Starting dynamic subtest: C-HDMI-A1 [312.395570] Dynamic subtest C-HDMI-A1: SUCCESS (5.822s) [312.424880] Starting dynamic subtest: A-HDMI-A2 [318.082075] Dynamic subtest A-HDMI-A2: SUCCESS (5.681s) [318.111383] Starting dynamic subtest: B-HDMI-A2 [323.745429] Dynamic subtest B-HDMI-A2: SUCCESS (5.658s) [323.774762] Starting dynamic subtest: C-HDMI-A2 [329.407079] Dynamic subtest C-HDMI-A2: SUCCESS (5.658s) [329.409213] Subtest flip-vs-absolute-wf_vblank: SUCCESS (34.424s) [329.923285] [085/155] (726s left) kms_3d (basic) [330.026729] Starting subtest: basic [334.973588] Subtest basic: SUCCESS (4.945s) [335.478576] [086/155] (720s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [335.668177] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [335.674176] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [337.343554] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.669s) [337.374416] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [338.979100] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.630s) [339.008584] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [340.605076] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.621s) [340.607180] Subtest 2x-flip-vs-wf_vblank-interruptible: SUCCESS (4.939s) [341.213146] [087/155] (715s left) kms_color_pipeline (plane-ctm3x4) [341.400560] Starting subtest: plane-ctm3x4 [342.839410] Subtest plane-ctm3x4: SKIP (1.439s) [343.135585] [088/155] (713s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [343.311100] Starting subtest: crc-primary-basic-y-tiled-ccs [343.313169] Starting dynamic subtest: pipe-A-HDMI-A-1 [343.829538] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.508s) [343.855054] Starting dynamic subtest: pipe-A-HDMI-A-2 [344.292192] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.458s) [344.317670] Starting dynamic subtest: pipe-B-HDMI-A-1 [344.785494] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.488s) [344.811174] Starting dynamic subtest: pipe-B-HDMI-A-2 [345.219784] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.430s) [345.245788] Starting dynamic subtest: pipe-C-HDMI-A-1 [345.265967] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [345.291501] Starting dynamic subtest: pipe-C-HDMI-A-2 [345.310323] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [345.312221] Subtest crc-primary-basic-y-tiled-ccs: SUCCESS (1.916s) [346.026057] [089/155] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [346.217846] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [346.222199] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [346.376341] [090/155] (710s left) gem_exec_schedule (wide) [346.632950] Starting subtest: wide [346.635206] Starting dynamic subtest: rcs0 [365.547922] Dynamic subtest rcs0: SUCCESS (18.911s) [365.585773] Starting dynamic subtest: bcs0 [385.109882] Dynamic subtest bcs0: SUCCESS (19.549s) [385.143843] Starting dynamic subtest: vcs0 [404.141113] Dynamic subtest vcs0: SUCCESS (19.034s) [404.180108] Starting dynamic subtest: vecs0 [423.612426] Dynamic subtest vecs0: SUCCESS (19.465s) [423.616973] Subtest wide: SUCCESS (76.979s) [424.561296] [091/155] (632s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [424.761443] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [424.765402] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [424.911921] [092/155] (632s left) gem_exec_nop (basic-sequential) [425.040959] Starting subtest: basic-sequential [428.154851] Subtest basic-sequential: SUCCESS (3.112s) [428.441706] [093/155] (628s left) gem_exec_flush (basic-uc-rw-default) [428.565275] Starting subtest: basic-uc-rw-default [434.011216] Subtest basic-uc-rw-default: SUCCESS (5.446s) [434.307849] [094/155] (622s left) kms_chamelium_hpd (hdmi-hpd-storm) [434.846838] Subtest hdmi-hpd-storm: SKIP (0.000s) [435.146762] [095/155] (622s left) gem_ctx_shared (q-smoketest-all) [435.273554] Starting subtest: Q-smoketest-all [467.594267] Subtest Q-smoketest-all: SUCCESS (32.288s) [467.861746] [096/155] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [468.050299] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [468.054356] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [468.216130] [097/155] (589s left) gem_lmem_swapping (verify-random-ccs) [468.329316] Subtest verify-random-ccs: SKIP (0.000s) [468.439438] [098/155] (589s left) sysfs_heartbeat_interval (idempotent) [468.554049] Starting subtest: idempotent [468.556475] Starting dynamic subtest: vecs0 [468.562072] Dynamic subtest vecs0: SUCCESS (0.005s) [468.589915] Starting dynamic subtest: vcs0 [468.591965] Dynamic subtest vcs0: SUCCESS (0.005s) [468.617850] Starting dynamic subtest: bcs0 [468.620447] Dynamic subtest bcs0: SUCCESS (0.004s) [468.647645] Starting dynamic subtest: rcs0 [468.650217] Dynamic subtest rcs0: SUCCESS (0.004s) [468.653202] Subtest idempotent: SUCCESS (0.033s) [468.745864] [099/155] (588s left) gem_userptr_blits (unsync-unmap-after-close) [468.860991] Subtest unsync-unmap-after-close: SKIP (0.000s) [469.063870] [100/155] (588s left) gen7_exec_parse (load-register-reg) [469.175922] Subtest load-register-reg: SKIP (0.000s) [469.290552] [101/155] (588s left) kms_vblank (ts-continuation-idle) [469.463338] Starting subtest: ts-continuation-idle [469.465317] Starting dynamic subtest: pipe-A-HDMI-A-1 [470.095612] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.630s) [470.122175] Starting dynamic subtest: pipe-A-HDMI-A-2 [470.485161] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.385s) [470.519994] Starting dynamic subtest: pipe-C-HDMI-A-1 [470.862419] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.368s) [470.888600] Starting dynamic subtest: pipe-C-HDMI-A-2 [471.238226] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.372s) [471.240386] Subtest ts-continuation-idle: SUCCESS (1.779s) [471.556717] [102/155] (586s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc) [471.747899] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc [471.751898] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [471.904511] [103/155] (586s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt) [472.092922] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt [472.946221] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (0.855s) [473.239438] [104/155] (584s left) gem_spin_batch (engines) [473.365366] Starting subtest: engines [473.367358] Starting dynamic subtest: rcs0 [476.598869] Dynamic subtest rcs0: SUCCESS (3.232s) [476.624303] Starting dynamic subtest: bcs0 [479.838313] Dynamic subtest bcs0: SUCCESS (3.235s) [479.864041] Starting dynamic subtest: vcs0 [483.076710] Dynamic subtest vcs0: SUCCESS (3.233s) [483.102247] Starting dynamic subtest: vecs0 [486.313025] Dynamic subtest vecs0: SUCCESS (3.234s) [486.315763] Subtest engines: SUCCESS (12.949s) [486.572422] [105/155] (571s left) kms_invalid_mode (bad-vtotal) [486.745225] Starting subtest: bad-vtotal [486.747394] Starting dynamic subtest: pipe-A-HDMI-A-1 [487.137767] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.390s) [487.168927] Starting dynamic subtest: pipe-A-HDMI-A-2 [487.171048] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [487.198071] Starting dynamic subtest: pipe-B-HDMI-A-1 [487.201781] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [487.232981] Starting dynamic subtest: pipe-B-HDMI-A-2 [487.237056] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [487.267887] Starting dynamic subtest: pipe-C-HDMI-A-1 [487.271166] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [487.297481] Starting dynamic subtest: pipe-C-HDMI-A-2 [487.299633] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s) [487.302659] Subtest bad-vtotal: SUCCESS (0.426s) [487.505321] [106/155] (570s left) kms_pm_rpm (basic-pci-d3-state) [489.388317] Starting subtest: basic-pci-d3-state [489.740809] Subtest basic-pci-d3-state: SUCCESS (0.356s) [490.069564] [107/155] (568s left) gem_exec_params (rel-constants-invalid) [490.180194] Starting subtest: rel-constants-invalid [490.182451] Subtest rel-constants-invalid: SUCCESS (0.000s) [490.352398] [108/155] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [490.542164] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [490.547071] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [490.705678] [109/155] (567s left) gem_exercise_blt (fast-copy) [490.821162] Starting subtest: fast-copy [490.823997] Starting dynamic subtest: linear-smem-smem [490.868993] Dynamic subtest linear-smem-smem: SUCCESS (0.046s) [490.897863] Starting dynamic subtest: ymajor-smem-smem [490.911161] Dynamic subtest ymajor-smem-smem: SUCCESS (0.039s) [490.940257] Starting dynamic subtest: yfmajor-smem-smem [490.950814] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.036s) [490.980354] Starting dynamic subtest: tile64-smem-smem [490.989979] Dynamic subtest tile64-smem-smem: SUCCESS (0.037s) [490.992247] Subtest fast-copy: SUCCESS (0.171s) [491.187376] [110/155] (567s left) prime_mmap (test_userptr) [491.293059] Starting subtest: test_userptr [491.295295] Starting dynamic subtest: test_userptr-smem [491.297537] Dynamic subtest test_userptr-smem: SUCCESS (0.001s) [491.299742] Subtest test_userptr: SUCCESS (0.005s) [491.436459] [111/155] (567s left) kms_properties (get_properties-sanity-atomic) [491.614731] Starting subtest: get_properties-sanity-atomic [491.617014] Subtest get_properties-sanity-atomic: SUCCESS (0.007s) [491.771368] [112/155] (567s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [491.962293] Starting subtest: fbcpsr-rgb565-draw-render [491.966204] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s) [492.119292] [113/155] (566s left) perf (short-reads) [492.360399] Starting subtest: short-reads [492.390157] Subtest short-reads: SUCCESS (0.030s) [492.503113] [114/155] (566s left) kms_psr (fbc-psr-cursor-plane-onoff) [492.675374] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [492.796370] [115/155] (566s left) api_intel_bb (render-ccs) [492.896373] Starting subtest: render-ccs [493.225465] Subtest render-ccs: SUCCESS (0.327s) [493.403979] [116/155] (565s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [493.595637] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [493.599654] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [493.755265] [117/155] (565s left) i915_drm_fdinfo (all-busy-check-all) [493.870330] Starting subtest: all-busy-check-all [494.390536] Subtest all-busy-check-all: SUCCESS (0.524s) [494.569352] [118/155] (565s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [494.675528] Starting subtest: etime-multi-wait-for-submit-unsubmitted [494.773883] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s) [494.917354] [119/155] (564s left) kms_chamelium_color (ctm-blue-to-red) [495.090693] Subtest ctm-blue-to-red: SKIP (0.000s) [495.209822] [120/155] (564s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [495.396995] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu [496.136208] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (0.740s) [496.426343] [121/155] (563s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render) [496.618710] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render [497.749239] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SUCCESS (1.133s) [498.005377] [122/155] (561s left) gem_exec_schedule (pi-common) [498.285614] Starting subtest: pi-common [498.287991] Starting dynamic subtest: rcs0 [498.347651] Dynamic subtest rcs0: SUCCESS (0.053s) [498.376432] Starting dynamic subtest: bcs0 [498.398145] Dynamic subtest bcs0: SUCCESS (0.054s) [498.427175] Starting dynamic subtest: vcs0 [498.450567] Dynamic subtest vcs0: SUCCESS (0.050s) [498.482353] Starting dynamic subtest: vecs0 [498.502129] Dynamic subtest vecs0: SUCCESS (0.048s) [498.504233] Subtest pi-common: SUCCESS (0.218s) [498.775024] [123/155] (561s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite) [498.965313] Starting subtest: psrhdr-rgb565-draw-pwrite [498.969441] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s) [499.135291] [124/155] (561s left) api_intel_bb (crc32) [499.240632] Starting subtest: crc32 [499.244584] Subtest crc32: SKIP (0.000s) [499.399234] [125/155] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [499.587563] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [499.591745] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [499.753857] [126/155] (560s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [499.929807] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s) [500.044725] [127/155] (560s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [500.219073] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [500.221361] Starting dynamic subtest: pipe-A [500.733533] Dynamic subtest pipe-A: SUCCESS (0.517s) [500.767235] Starting dynamic subtest: pipe-B [501.111366] Dynamic subtest pipe-B: SUCCESS (0.373s) [501.137748] Starting dynamic subtest: pipe-C [501.165721] Dynamic subtest pipe-C: SUCCESS (0.049s) [501.167680] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.948s) [501.660979] [128/155] (558s left) kms_psr (psr2-sprite-plane-onoff) [501.838138] Subtest psr2-sprite-plane-onoff: SKIP (0.000s) [501.950591] [129/155] (558s left) kms_fbcon_fbt (fbc-suspend) [502.064400] Starting subtest: fbc-suspend