[90.879877] Initializing watchdogs [90.880128] /dev/watchdog0 [90.920802] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [90.936075] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [90.943092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [90.950993] [001/133] (960s left) gem_eio (banned) [91.109842] Starting subtest: banned [91.320439] Subtest banned: SUCCESS (0.212s) [91.568423] [002/133] (959s left) perf (mi-rpc) [91.798293] Starting subtest: mi-rpc [91.821833] Subtest mi-rpc: SUCCESS (0.033s) [91.921172] [003/133] (959s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [92.105101] Starting subtest: compare-crc-sanitycheck-xr24 [92.109582] Starting dynamic subtest: pipe-A-HDMI-A-1 [93.241230] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.069s) [93.307576] Starting dynamic subtest: pipe-B-HDMI-A-2 [93.761219] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.539s) [93.798407] Starting dynamic subtest: pipe-C-HDMI-A-1 [94.310230] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.586s) [94.320146] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.207s) [94.631919] [004/133] (957s left) gem_cs_tlb (engines) [94.755956] Starting subtest: engines [94.765064] Starting dynamic subtest: rcs0 [96.917320] Dynamic subtest rcs0: SUCCESS (2.157s) [96.941649] Starting dynamic subtest: bcs0 [99.075971] Dynamic subtest bcs0: SUCCESS (2.157s) [99.102728] Starting dynamic subtest: vcs0 [101.229527] Dynamic subtest vcs0: SUCCESS (2.153s) [101.255289] Starting dynamic subtest: vecs0 [103.382999] Dynamic subtest vecs0: SUCCESS (2.152s) [103.386571] Subtest engines: SUCCESS (8.622s) [103.524649] [005/133] (948s left) sw_sync (sync_multi_timeline_wait) [103.635183] Starting subtest: sync_multi_timeline_wait [103.644190] Subtest sync_multi_timeline_wait: SUCCESS (0.005s) [103.760675] [006/133] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [103.963118] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [103.970331] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [104.097692] [007/133] (947s left) gem_fence_thrash (bo-write-verify-threaded-y) [104.205347] Starting subtest: bo-write-verify-threaded-y [108.629683] Subtest bo-write-verify-threaded-y: SUCCESS (4.430s) [108.780151] [008/133] (943s left) kms_psr (pr-suspend) [108.965071] Subtest pr-suspend: SKIP (0.000s) [109.073041] [009/133] (943s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [109.198778] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [109.202881] Starting dynamic subtest: smem [109.547883] Dynamic subtest smem: SUCCESS (0.350s) [109.551123] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.352s) [109.810315] [010/133] (942s left) kms_plane_multiple (tiling-y) [109.998189] Starting subtest: tiling-y [110.003113] Starting dynamic subtest: pipe-A-HDMI-A-1 [112.004561] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.994s) [112.031090] Starting dynamic subtest: pipe-A-HDMI-A-2 [113.828226] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.826s) [113.871155] Starting dynamic subtest: pipe-B-HDMI-A-1 [115.594092] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.764s) [115.633878] Starting dynamic subtest: pipe-B-HDMI-A-2 [117.409802] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.814s) [117.446177] Starting dynamic subtest: pipe-C-HDMI-A-1 [119.279085] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.859s) [119.312348] Starting dynamic subtest: pipe-C-HDMI-A-2 [121.084209] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.798s) [121.088633] Subtest tiling-y: SUCCESS (11.079s) [121.393760] [011/133] (930s left) i915_selftest (live) [123.207118] Starting subtest: live [123.210963] Starting dynamic subtest: sanitycheck [125.903576] Dynamic subtest sanitycheck: SUCCESS (2.699s) [125.924555] Starting dynamic subtest: uncore [128.285226] Dynamic subtest uncore: SUCCESS (2.375s) [128.307371] Starting dynamic subtest: workarounds [131.133784] Dynamic subtest workarounds: SUCCESS (2.856s) [131.154089] Starting dynamic subtest: gt_engines [134.060742] Dynamic subtest gt_engines: SUCCESS (2.924s) [134.083320] Starting dynamic subtest: gt_timelines [149.938497] Dynamic subtest gt_timelines: SUCCESS (15.875s) [149.959368] Starting dynamic subtest: gt_contexts [152.431372] Dynamic subtest gt_contexts: SUCCESS (2.489s) [152.453496] Starting dynamic subtest: gt_lrc [157.456126] Dynamic subtest gt_lrc: SUCCESS (5.024s) [157.477288] Starting dynamic subtest: gt_mocs [160.153248] Dynamic subtest gt_mocs: SUCCESS (2.687s) [160.173687] Starting dynamic subtest: gt_pm [171.976482] Dynamic subtest gt_pm: SUCCESS (11.833s) [171.997558] Starting dynamic subtest: gt_heartbeat [174.448409] Dynamic subtest gt_heartbeat: SUCCESS (2.464s) [174.470236] Starting dynamic subtest: gt_tlb [178.176429] Dynamic subtest gt_tlb: SUCCESS (3.731s) [178.198395] Starting dynamic subtest: requests [187.145768] Dynamic subtest requests: SUCCESS (8.970s) [187.168236] Starting dynamic subtest: migrate [192.526618] Dynamic subtest migrate: SUCCESS (5.379s) [192.549403] Starting dynamic subtest: active [195.200231] Dynamic subtest active: SUCCESS (2.671s) [195.221656] Starting dynamic subtest: objects [199.475202] Dynamic subtest objects: SUCCESS (4.273s) [199.496617] Starting dynamic subtest: mman [207.218586] Dynamic subtest mman: SUCCESS (7.741s) [207.240101] Starting dynamic subtest: dmabuf [209.670435] Dynamic subtest dmabuf: SUCCESS (2.447s) [209.693550] Starting dynamic subtest: vma [212.074038] Dynamic subtest vma: SUCCESS (2.404s) [212.095521] Starting dynamic subtest: coherency [221.530084] Dynamic subtest coherency: SUCCESS (9.454s) [221.554397] Starting dynamic subtest: gtt [231.646553] Dynamic subtest gtt: SUCCESS (10.115s) [231.670411] Starting dynamic subtest: gem [234.516375] Dynamic subtest gem: SUCCESS (2.867s) [234.538312] Starting dynamic subtest: evict [240.070931] Dynamic subtest evict: SUCCESS (5.552s) [240.092745] Starting dynamic subtest: hugepages [249.119322] Dynamic subtest hugepages: SUCCESS (9.047s) [249.140756] Starting dynamic subtest: gem_contexts [269.644861] Dynamic subtest gem_contexts: SUCCESS (20.524s) [269.667347] Starting dynamic subtest: client [272.399679] Dynamic subtest client: SUCCESS (2.752s) [272.421177] Starting dynamic subtest: gem_migrate [274.911104] Dynamic subtest gem_migrate: SUCCESS (2.499s) [274.951117] Starting dynamic subtest: reset [281.285740] Dynamic subtest reset: SUCCESS (6.381s) [281.307409] Starting dynamic subtest: memory_region [283.908241] Dynamic subtest memory_region: SUCCESS (2.619s) [283.930353] Starting dynamic subtest: hangcheck [309.516139] Dynamic subtest hangcheck: SUCCESS (25.607s) [309.537548] Starting dynamic subtest: execlists [321.479775] Dynamic subtest execlists: SUCCESS (11.961s) [321.501535] Starting dynamic subtest: ring_submission [323.933941] Dynamic subtest ring_submission: SUCCESS (2.450s) [323.956303] Starting dynamic subtest: perf [326.434770] Dynamic subtest perf: SUCCESS (2.491s) [326.455636] Starting dynamic subtest: slpc [329.092056] Dynamic subtest slpc: SUCCESS (2.660s) [329.115315] Starting dynamic subtest: guc [331.781747] Dynamic subtest guc: SUCCESS (2.653s) [331.846596] Starting dynamic subtest: guc_multi_lrc [334.180668] Dynamic subtest guc_multi_lrc: SUCCESS (2.428s) [334.203411] Starting dynamic subtest: guc_hang [336.762828] Dynamic subtest guc_hang: SUCCESS (2.578s) [336.786363] Starting dynamic subtest: late_gt_pm [339.231797] Dynamic subtest late_gt_pm: SUCCESS (2.465s) [339.235210] Subtest live: SUCCESS (216.055s) [339.299768] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [339.306612] [012/133] (713s left) gem_exec_schedule (deep) [342.244053] Starting subtest: deep [342.255060] Starting dynamic subtest: rcs0 [355.652396] Dynamic subtest rcs0: SUCCESS (13.407s) [355.704234] Starting dynamic subtest: bcs0 [370.097068] Dynamic subtest bcs0: SUCCESS (14.434s) [370.154202] Starting dynamic subtest: vcs0 [383.831049] Dynamic subtest vcs0: SUCCESS (13.713s) [383.889064] Starting dynamic subtest: vecs0 [397.647071] Dynamic subtest vecs0: SUCCESS (13.799s) [397.651987] Subtest deep: SUCCESS (55.415s) [398.612360] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.i915: true [398.614218] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true [398.621542] [013/133] (653s left) gem_exec_flush (basic-wb-rw-before-default) [398.754882] Starting subtest: basic-wb-rw-before-default [404.170374] Subtest basic-wb-rw-before-default: SUCCESS (5.416s) [404.439894] [014/133] (648s left) gem_exec_reloc (basic-gtt) [404.561143] Starting subtest: basic-gtt [404.582093] Subtest basic-gtt: SUCCESS (0.021s) [404.823545] [015/133] (647s left) prime_mmap_coherency (write) [404.959166] Starting subtest: write [410.347487] Subtest write: SUCCESS (5.388s) [410.520993] [016/133] (642s left) gem_ctx_persistence (idempotent) [410.642054] Starting subtest: idempotent [410.645889] Subtest idempotent: SUCCESS (0.000s) [410.789188] [017/133] (642s left) dmabuf_sync_file (export-multiwait) [410.939295] Starting subtest: export-multiwait [410.945111] Subtest export-multiwait: SUCCESS (0.004s) [411.070481] [018/133] (641s left) i915_drm_fdinfo (memory-info-purgeable) [411.216243] Starting subtest: memory-info-purgeable [411.223168] Starting dynamic subtest: smem0 [412.271046] Dynamic subtest smem0: SUCCESS (1.054s) [412.279059] Subtest memory-info-purgeable: SUCCESS (1.060s) [412.456357] [019/133] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [412.757124] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [412.765369] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [413.029947] [020/133] (640s left) gem_exec_schedule (semaphore-power) [413.315176] Starting subtest: semaphore-power [414.191709] Subtest semaphore-power: SUCCESS (0.864s) [414.469070] [021/133] (638s left) gem_eio (context-create) [414.622096] Starting subtest: context-create [414.692033] Subtest context-create: SUCCESS (0.048s) [414.938812] [022/133] (638s left) kms_universal_plane (universal-plane-pageflip-windowed) [415.130148] Starting subtest: universal-plane-pageflip-windowed [415.135119] Starting dynamic subtest: pipe-A-HDMI-A-1 [416.202112] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.067s) [416.242376] Starting dynamic subtest: pipe-B-HDMI-A-2 [416.774128] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.563s) [416.821067] Starting dynamic subtest: pipe-C-HDMI-A-1 [417.330243] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.548s) [417.337364] Subtest universal-plane-pageflip-windowed: SUCCESS (2.204s) [417.695926] [023/133] (635s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [417.915245] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [419.540598] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.627s) [419.824361] [024/133] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [420.033730] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [422.592415] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.566s) [422.932648] [025/133] (630s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [423.129071] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [423.242223] [026/133] (630s left) kms_flip (2x-flip-vs-panning-interruptible) [423.440076] Starting subtest: 2x-flip-vs-panning-interruptible [423.454417] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [434.280304] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.834s) [434.312887] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [444.998579] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.707s) [445.026224] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [455.712545] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.705s) [455.717080] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (32.271s) [456.631526] [027/133] (597s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [457.287581] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [459.503311] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SUCCESS (2.542s) [459.721864] [028/133] (594s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [459.929073] Starting subtest: flip-vs-cursor-atomic-transitions [475.498976] Subtest flip-vs-cursor-atomic-transitions: FAIL (14.531s) [475.604740] [029/133] (578s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [475.805576] Starting subtest: bad-aux-stride-y-tiled-ccs [475.811235] Starting dynamic subtest: pipe-A-HDMI-A-1 [475.843631] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.004s) [475.894356] Starting dynamic subtest: pipe-A-HDMI-A-2 [475.938521] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.004s) [475.984473] Starting dynamic subtest: pipe-B-HDMI-A-1 [476.020812] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.003s) [476.045794] Starting dynamic subtest: pipe-B-HDMI-A-2 [476.073585] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.004s) [476.100571] Starting dynamic subtest: pipe-C-HDMI-A-1 [476.132027] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [476.156919] Starting dynamic subtest: pipe-C-HDMI-A-2 [476.187277] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [476.190517] Subtest bad-aux-stride-y-tiled-ccs: SUCCESS (0.051s) [476.920091] [030/133] (577s left) kms_color (invalid-degamma-lut-sizes) [477.116183] Starting subtest: invalid-degamma-lut-sizes [477.121358] Starting dynamic subtest: pipe-A [477.507143] Dynamic subtest pipe-A: SUCCESS (0.398s) [477.548254] Starting dynamic subtest: pipe-B [477.553598] Dynamic subtest pipe-B: SUCCESS (0.001s) [477.610617] Starting dynamic subtest: pipe-C [477.617232] Dynamic subtest pipe-C: SUCCESS (0.004s) [477.622471] Subtest invalid-degamma-lut-sizes: SUCCESS (0.415s) [477.832447] [031/133] (576s left) gem_render_copy (linear-to-vebox-yf-tiled) [477.964602] Starting subtest: linear-to-vebox-yf-tiled [477.970878] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [478.243300] [032/133] (576s left) gem_exec_params (invalid-fence-in) [478.358512] Starting subtest: invalid-fence-in [478.362079] Subtest invalid-fence-in: SUCCESS (0.001s) [478.514392] [033/133] (576s left) gem_exec_schedule (preempt-hang) [478.842444] Starting subtest: preempt-hang [478.906576] Starting dynamic subtest: rcs0 [479.099091] Dynamic subtest rcs0: SUCCESS (0.261s) [479.163868] Starting dynamic subtest: bcs0 [479.358481] Dynamic subtest bcs0: SUCCESS (0.278s) [479.423319] Starting dynamic subtest: vcs0 [479.618989] Dynamic subtest vcs0: SUCCESS (0.255s) [479.684862] Starting dynamic subtest: vecs0 [479.945682] Dynamic subtest vecs0: SUCCESS (0.258s) [480.010899] Subtest preempt-hang: SUCCESS (1.070s) [480.312555] [034/133] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [480.510357] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [480.516912] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [480.665619] [035/133] (574s left) kms_psr (fbc-pr-cursor-render) [480.862109] Subtest fbc-pr-cursor-render: SKIP (0.000s) [480.991892] [036/133] (574s left) gem_mmap_gtt (flink-race) [481.108237] Starting subtest: flink-race [501.178178] Subtest flink-race: SUCCESS (20.076s) [501.342874] [037/133] (554s left) kms_concurrent (multi-plane-atomic-lowres) [501.542088] Starting subtest: multi-plane-atomic-lowres [501.548371] Starting dynamic subtest: pipe-A-HDMI-A-1 [502.664055] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.117s) [502.728506] Starting dynamic subtest: pipe-A-HDMI-A-2 [503.396962] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.733s) [503.434148] Starting dynamic subtest: pipe-B-HDMI-A-1 [504.126230] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.719s) [504.172089] Starting dynamic subtest: pipe-B-HDMI-A-2 [504.901299] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.773s) [504.957346] Starting dynamic subtest: pipe-C-HDMI-A-1 [505.701130] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.786s) [505.757259] Starting dynamic subtest: pipe-C-HDMI-A-2 [506.479876] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.772s) [506.487580] Subtest multi-plane-atomic-lowres: SUCCESS (4.945s) [506.822867] [038/133] (548s left) kms_big_fb (linear-8bpp-rotate-90) [507.048074] Starting subtest: linear-8bpp-rotate-90 [507.433853] Subtest linear-8bpp-rotate-90: SKIP (0.376s) [507.705588] [039/133] (548s left) api_intel_bb (render) [507.821284] Starting subtest: render [507.824428] Starting dynamic subtest: render-none-512 [507.928895] Dynamic subtest render-none-512: SUCCESS (0.108s) [507.960217] Starting dynamic subtest: render-none-reloc-512 [508.037020] Dynamic subtest render-none-reloc-512: SUCCESS (0.104s) [508.064876] Starting dynamic subtest: render-none-1024 [508.421417] Dynamic subtest render-none-1024: SUCCESS (0.378s) [508.450103] Starting dynamic subtest: render-none-reloc-1024 [508.801534] Dynamic subtest render-none-reloc-1024: SUCCESS (0.373s) [508.827222] Starting dynamic subtest: render-x-512 [508.888491] Dynamic subtest render-x-512: SUCCESS (0.091s) [508.918507] Starting dynamic subtest: render-x-reloc-512 [508.978565] Dynamic subtest render-x-reloc-512: SUCCESS (0.085s) [509.004841] Starting dynamic subtest: render-x-1024 [509.304445] Dynamic subtest render-x-1024: SUCCESS (0.321s) [509.330127] Starting dynamic subtest: render-x-reloc-1024 [509.638907] Dynamic subtest render-x-reloc-1024: SUCCESS (0.325s) [509.665617] Starting dynamic subtest: render-y-512 [509.723072] Dynamic subtest render-y-512: SUCCESS (0.090s) [509.751312] Starting dynamic subtest: render-y-reloc-512 [509.810103] Dynamic subtest render-y-reloc-512: SUCCESS (0.084s) [509.837958] Starting dynamic subtest: render-y-1024 [510.134452] Dynamic subtest render-y-1024: SUCCESS (0.320s) [510.162039] Starting dynamic subtest: render-y-reloc-1024 [510.462639] Dynamic subtest render-y-reloc-1024: SUCCESS (0.326s) [510.466132] Subtest render: SUCCESS (2.643s) [510.637064] [040/133] (545s left) perf (gen12-group-exclusive-stream-sample-oa) [510.884270] Starting subtest: gen12-group-exclusive-stream-sample-oa [510.890326] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s) [511.005157] [041/133] (544s left) kms_frontbuffer_tracking (pipe-fbc-rte) [511.208910] Starting subtest: pipe-fbc-rte [511.229089] Subtest pipe-fbc-rte: SKIP (0.001s) [511.370086] [042/133] (544s left) kms_plane (plane-position-covered) [511.566080] Starting subtest: plane-position-covered [512.360151] Starting dynamic subtest: pipe-A-plane-1 [512.913155] Dynamic subtest pipe-A-plane-1: SUCCESS (0.554s) [512.965551] Starting dynamic subtest: pipe-A-plane-2 [513.455099] Dynamic subtest pipe-A-plane-2: SUCCESS (0.535s) [513.501605] Starting dynamic subtest: pipe-A-plane-3 [514.034244] Dynamic subtest pipe-A-plane-3: SUCCESS (0.574s) [514.067059] Starting dynamic subtest: pipe-A-plane-4 [514.074496] Dynamic subtest pipe-A-plane-4: SUCCESS (0.012s) [514.560854] Starting dynamic subtest: pipe-B-plane-1 [515.060218] Dynamic subtest pipe-B-plane-1: SUCCESS (0.551s) [515.103339] Starting dynamic subtest: pipe-B-plane-2 [515.613425] Dynamic subtest pipe-B-plane-2: SUCCESS (0.545s) [515.670840] Starting dynamic subtest: pipe-B-plane-3 [516.135170] Dynamic subtest pipe-B-plane-3: SUCCESS (0.521s) [516.169062] Starting dynamic subtest: pipe-B-plane-4 [516.176740] Dynamic subtest pipe-B-plane-4: SUCCESS (0.008s) [516.179932] Subtest plane-position-covered: SUCCESS (4.578s) [516.485838] [043/133] (539s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [516.609835] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [516.616612] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.002s) [516.764851] [044/133] (539s left) gem_busy (close-race) [516.895887] Starting subtest: close-race [539.506491] Subtest close-race: SUCCESS (22.612s) [539.941386] [045/133] (516s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [540.284419] Starting subtest: addfb25-x-tiled-mismatch-legacy [540.287507] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [540.433520] [046/133] (516s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [540.651315] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [540.660312] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [540.801259] [047/133] (515s left) kms_cursor_edge_walk (128x128-right-edge) [541.008295] Starting subtest: 128x128-right-edge [541.014256] Starting dynamic subtest: pipe-A-HDMI-A-1 [545.005610] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.994s) [545.038798] Starting dynamic subtest: pipe-C-HDMI-A-1 [548.415116] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.406s) [548.419763] Subtest 128x128-right-edge: SUCCESS (7.413s) [548.716351] [048/133] (508s left) gem_exec_reloc (basic-softpin) [548.856665] Starting subtest: basic-softpin [548.859843] Subtest basic-softpin: SUCCESS (0.008s) [549.098509] [049/133] (507s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [549.314624] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [549.325171] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.002s) [549.465709] [050/133] (507s left) gem_ctx_isolation (dirty-switch) [549.600158] Starting subtest: dirty-switch [549.604637] Starting dynamic subtest: rcs0 [550.191089] Dynamic subtest rcs0: SUCCESS (0.587s) [550.223744] Starting dynamic subtest: bcs0 [551.146792] Dynamic subtest bcs0: SUCCESS (0.952s) [551.183149] Starting dynamic subtest: vcs0 [551.728765] Dynamic subtest vcs0: SUCCESS (0.576s) [551.770246] Starting dynamic subtest: vecs0 [552.301197] Dynamic subtest vecs0: SUCCESS (0.573s) [552.304753] Subtest dirty-switch: SUCCESS (2.703s) [552.592743] [051/133] (504s left) gem_exec_balancer (invalid-bonds) [552.726308] Starting subtest: invalid-bonds [552.732754] Subtest invalid-bonds: SUCCESS (0.009s) [553.359268] [052/133] (504s left) gem_exec_reloc (basic-write-wc) [553.827857] Starting subtest: basic-write-wc [553.897092] Subtest basic-write-wc: SUCCESS (0.016s) [554.381922] [053/133] (503s left) i915_pm_rps (basic-api) [554.503181] Starting subtest: basic-api [554.514330] Subtest basic-api: SUCCESS (0.011s) [554.666231] [054/133] (503s left) syncobj_timeline (single-wait-signaled) [554.798483] Starting subtest: single-wait-signaled [554.802097] Subtest single-wait-signaled: SUCCESS (0.003s) [554.965520] [055/133] (503s left) kms_addfb_basic (size-max) [555.170250] Starting subtest: size-max [555.173646] Subtest size-max: SUCCESS (0.001s) [555.338095] [056/133] (502s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [555.553920] Starting subtest: yf-tiled-32bpp-rotate-90 [560.376315] Subtest yf-tiled-32bpp-rotate-90: SUCCESS (4.822s) [560.787802] [057/133] (497s left) syncobj_wait (invalid-reset-illegal-handle) [560.908056] Starting subtest: invalid-reset-illegal-handle [560.912306] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [561.067236] [058/133] (497s left) gem_lmem_swapping (basic) [561.185487] Subtest basic: SKIP (0.000s) [561.309351] [059/133] (497s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [561.499182] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [572.844229] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.341s) [573.226540] [060/133] (485s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [573.476138] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [573.481513] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s) [573.641781] [061/133] (485s left) kms_display_modes (extended-mode-basic) [573.848690] Starting subtest: extended-mode-basic [573.853518] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2 [574.882142] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.022s) [574.943497] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2 [576.486273] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.580s) [576.542470] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1 [577.878310] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.383s) [577.924376] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1 [579.263590] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.285s) [579.366567] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2 [580.550805] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.372s) [580.609499] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2 [581.870471] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.311s) [581.911336] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1 [583.211701] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.328s) [583.269575] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1 [584.495038] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.283s) [584.563061] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2 [585.828844] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.324s) [585.862025] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2 [587.078314] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.242s) [587.113508] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1 [588.310311] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.224s) [588.368575] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1 [589.876153] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.534s) [589.883065] Subtest extended-mode-basic: SUCCESS (16.012s) [590.168310] [062/133] (468s left) gem_exec_fence (long-history) [590.804089] Starting subtest: long-history [596.647528] Subtest long-history: SUCCESS (5.815s) [597.351559] [063/133] (461s left) vgem_basic (bad-fence) [597.483048] Starting subtest: bad-fence [597.486578] Subtest bad-fence: SUCCESS (0.000s) [597.618504] [064/133] (461s left) kms_chamelium_edid (hdmi-mode-timings) [598.187074] Subtest hdmi-mode-timings: SKIP (0.000s) [598.518527] [065/133] (460s left) syncobj_timeline (invalid-wait-illegal-handle) [598.643682] Starting subtest: invalid-wait-illegal-handle [598.646898] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [598.798173] [066/133] (460s left) kms_psr (fbc-psr2-cursor-blt) [598.998107] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [599.124523] [067/133] (460s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [599.344150] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [599.595570] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.246s) [599.883125] [068/133] (459s left) kms_cursor_crc (cursor-rapid-movement-32x32) [600.097191] Starting subtest: cursor-rapid-movement-32x32 [600.314164] Subtest cursor-rapid-movement-32x32: SKIP (0.215s) [600.494913] [069/133] (459s left) api_intel_allocator (reopen) [600.608903] Starting subtest: reopen [600.612465] Subtest reopen: SUCCESS (0.006s) [600.781090] [070/133] (458s left) gem_exec_parallel (fds) [600.917225] Starting subtest: fds [600.920914] Starting dynamic subtest: rcs0 [609.175357] Dynamic subtest rcs0: SUCCESS (8.253s) [609.203700] Starting dynamic subtest: bcs0 [617.381613] Dynamic subtest bcs0: SUCCESS (8.202s) [617.410737] Starting dynamic subtest: vcs0 [622.517164] Dynamic subtest vcs0: SUCCESS (5.132s) [622.546498] Starting dynamic subtest: vecs0 [627.551320] Dynamic subtest vecs0: SUCCESS (5.029s) [627.554820] Subtest fds: SUCCESS (26.635s) [627.844334] [071/133] (432s left) gem_exec_whisper (basic-fds-all) [627.987392] Starting subtest: basic-fds-all [643.403154] Subtest basic-fds-all: SUCCESS (15.415s) [643.695494] [072/133] (416s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [643.903779] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [643.912042] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [644.053617] [073/133] (416s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [644.258101] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [644.265123] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [644.419089] [074/133] (415s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [644.634053] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [644.640234] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [644.801519] [075/133] (415s left) kms_psr (fbc-psr-primary-page-flip) [645.000076] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [645.127535] [076/133] (415s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [645.331163] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [645.337284] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [645.482637] [077/133] (415s left) kms_chamelium_color (ctm-green-to-red) [645.674148] Subtest ctm-green-to-red: SKIP (0.000s) [645.793089] [078/133] (414s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [646.419508] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [646.711740] [079/133] (414s left) perf_pmu (init-busy) [646.837108] Starting subtest: init-busy [646.841275] Starting dynamic subtest: rcs0 [646.846233] Dynamic subtest rcs0: SUCCESS (0.002s) [646.888663] Starting dynamic subtest: bcs0 [646.891648] Dynamic subtest bcs0: SUCCESS (0.002s) [646.926675] Starting dynamic subtest: vcs0 [646.930724] Dynamic subtest vcs0: SUCCESS (0.002s) [646.957728] Starting dynamic subtest: vecs0 [646.961946] Dynamic subtest vecs0: SUCCESS (0.002s) [646.966067] Subtest init-busy: SUCCESS (0.018s) [647.071925] [080/133] (413s left) sw_sync (sync_merge_invalid) [647.180521] Starting subtest: sync_merge_invalid [647.190181] Subtest sync_merge_invalid: SUCCESS (0.009s) [647.318171] [081/133] (413s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [647.517164] Starting subtest: modeset-transition-nonblocking-fencing [647.520285] Starting dynamic subtest: 1x-outputs [651.042124] Dynamic subtest 1x-outputs: SUCCESS (3.528s) [651.070433] Starting dynamic subtest: 2x-outputs [658.402528] Dynamic subtest 2x-outputs: SUCCESS (7.356s) [658.407452] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.890s) [658.774339] [082/133] (402s left) gem_softpin (evict-prime-sanity-check) [658.895214] Starting subtest: evict-prime-sanity-check [658.899077] Starting dynamic subtest: rcs0 [660.000072] Dynamic subtest rcs0: SUCCESS (1.102s) [660.037455] Starting dynamic subtest: bcs0 [661.109657] Dynamic subtest bcs0: SUCCESS (1.105s) [661.146855] Starting dynamic subtest: vcs0 [662.211686] Dynamic subtest vcs0: SUCCESS (1.099s) [662.241978] Starting dynamic subtest: vecs0 [663.314963] Dynamic subtest vecs0: SUCCESS (1.100s) [663.345552] Starting dynamic subtest: all [664.417778] Dynamic subtest all: SUCCESS (1.097s) [664.422137] Subtest evict-prime-sanity-check: SUCCESS (5.523s) [664.590689] [083/133] (396s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [664.695935] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [664.806490] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s) [664.966797] [084/133] (396s left) kms_frontbuffer_tracking (fbc-stridechange) [665.177105] Starting subtest: fbc-stridechange [667.247773] Subtest fbc-stridechange: SUCCESS (2.074s) [667.540226] [085/133] (393s left) kms_fbcon_fbt (fbc) [667.659139] Starting subtest: fbc [671.834097] Subtest fbc: SUCCESS (4.176s) [671.958183] [086/133] (389s left) sriov_basic (enable-vfs-bind-unbind-each) [672.080764] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s) [672.200597] [087/133] (389s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [672.401145] Starting subtest: fbc-1p-primscrn-cur-indfb-move [675.384528] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.991s) [675.692817] [088/133] (386s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [675.902300] Starting subtest: yf-tiled-32bpp-rotate-0 [680.786036] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (4.884s) [681.226232] [089/133] (380s left) prime_vgem (fence-flip-hang) [681.359459] Subtest fence-flip-hang: SKIP (0.000s) [681.538529] [090/133] (380s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [681.731760] Starting subtest: cursor-vs-flip-varying-size [728.264242] Subtest cursor-vs-flip-varying-size: SUCCESS (46.533s) [728.578779] [091/133] (333s left) gem_vm_create (invalid-create) [728.704085] Starting subtest: invalid-create [728.708895] Subtest invalid-create: SUCCESS (0.001s) [728.853838] [092/133] (333s left) gem_ccs (block-multicopy-compressed) [728.974144] Subtest block-multicopy-compressed: SKIP (0.000s) [729.100189] [093/133] (333s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [729.283074] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [729.289523] Starting dynamic subtest: pipe-A-valid-mode [730.317839] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.032s) [730.324668] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (1.039s) [730.703945] [094/133] (331s left) gem_partial_pwrite_pread (writes-after-reads) [730.834870] Starting subtest: writes-after-reads [751.903320] Subtest writes-after-reads: SUCCESS (21.072s) [752.084327] [095/133] (310s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [752.199189] Starting subtest: etime-multi-wait-all-for-submit-submitted [752.311141] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s) [752.467552] [096/133] (310s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [752.666146] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [755.131273] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.467s) [755.400620] [097/133] (307s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [755.593046] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [802.184204] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (46.589s) [802.525793] [098/133] (260s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [802.724560] Starting subtest: addfb25-framebuffer-vs-set-tiling [802.728377] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [802.891811] [099/133] (260s left) gem_mmap (basic-small-bo) [803.006855] Starting subtest: basic-small-bo [803.563565] Subtest basic-small-bo: SUCCESS (0.468s) [804.635581] [100/133] (258s left) kms_psr (psr-primary-mmap-cpu) [804.970431] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [805.087246] [101/133] (258s left) kms_prop_blob (blob-prop-core) [805.200198] Starting subtest: blob-prop-core [805.205576] Subtest blob-prop-core: SUCCESS (0.000s) [805.356162] [102/133] (258s left) kms_hdr (bpc-switch) [805.546545] Starting subtest: bpc-switch [833.978341] Subtest bpc-switch: SKIP (28.423s) [834.463396] [103/133] (229s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [834.679786] Starting subtest: crc-primary-basic-y-tiled-ccs [834.684188] Starting dynamic subtest: pipe-A-HDMI-A-1 [835.290704] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.595s) [835.322957] Starting dynamic subtest: pipe-A-HDMI-A-2 [835.763289] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.446s) [835.818059] Starting dynamic subtest: pipe-B-HDMI-A-1 [836.218675] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.472s) [836.251740] Starting dynamic subtest: pipe-B-HDMI-A-2 [836.638142] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.415s) [836.691075] Starting dynamic subtest: pipe-C-HDMI-A-1 [836.743139] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s) [836.772871] Starting dynamic subtest: pipe-C-HDMI-A-2 [836.804102] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s) [836.807242] Subtest crc-primary-basic-y-tiled-ccs: SUCCESS (1.967s) [837.441164] [104/133] (226s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [837.662070] Starting subtest: fbc-rgb565-draw-mmap-wc [840.412028] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.752s) [840.702758] [105/133] (223s left) gem_mmap_wc (invalid-flags) [840.814208] Starting subtest: invalid-flags [840.817684] Subtest invalid-flags: SUCCESS (0.000s) [840.966994] [106/133] (223s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [841.185507] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [841.192605] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [841.352302] [107/133] (222s left) i915_hangman (error-state-basic) [841.494831] Starting subtest: error-state-basic [841.518491] Subtest error-state-basic: SUCCESS (0.015s) [841.697365] [108/133] (222s left) kms_vblank (ts-continuation-suspend) [841.888694] Starting subtest: ts-continuation-suspend [841.893431] Starting dynamic subtest: pipe-A-HDMI-A-1