[59.153194] Initializing watchdogs [59.153239] /dev/watchdog0 [59.166878] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.171086] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.173196] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.176590] [001/132] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [59.309616] Starting subtest: psr-rgb565-draw-mmap-wc [66.058995] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.724s) [66.202653] [002/132] (953s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [66.323209] Starting subtest: flip-vs-cursor-atomic-transitions [74.085053] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.747s) [74.903583] [003/132] (944s left) i915_hangman (engine-error-state-capture) [74.967129] Starting subtest: engine-error-state-capture [74.969521] Starting dynamic subtest: rcs0 [78.900381] Dynamic subtest rcs0: SUCCESS (3.930s) [78.908892] Starting dynamic subtest: bcs0 [84.850844] Dynamic subtest bcs0: SUCCESS (5.946s) [84.861876] Starting dynamic subtest: vcs0 [90.870335] Dynamic subtest vcs0: SUCCESS (6.016s) [90.880979] Starting dynamic subtest: vcs1 [96.882789] Dynamic subtest vcs1: SUCCESS (6.009s) [96.892757] Starting dynamic subtest: vecs0 [102.835923] Dynamic subtest vecs0: SUCCESS (5.950s) [102.846472] Starting dynamic subtest: ccs0 [108.851034] Dynamic subtest ccs0: SUCCESS (6.013s) [108.853967] Subtest engine-error-state-capture: SUCCESS (33.871s) [108.953946] [004/132] (910s left) perf_pmu (frequency) [108.998672] Starting subtest: frequency [109.000941] Starting dynamic subtest: gt0 [111.169654] Dynamic subtest gt0: SUCCESS (2.163s) [111.178889] Starting dynamic subtest: idle-gt0 [111.674678] Dynamic subtest idle-gt0: SUCCESS (0.504s) [111.684634] Starting dynamic subtest: gt1 [115.960197] Dynamic subtest gt1: SUCCESS (4.282s) [115.970296] Starting dynamic subtest: idle-gt1 [116.464243] Dynamic subtest idle-gt1: SUCCESS (0.505s) [116.466838] Subtest frequency: SUCCESS (7.465s) [116.615035] [005/132] (903s left) kms_pm_dc (dc5-dpms) [117.730210] Starting subtest: dc5-dpms [119.775877] Subtest dc5-dpms: SUCCESS (2.045s) [119.869402] [006/132] (899s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [119.948931] Starting subtest: multi-wait-all-for-submit-available-submitted [119.951343] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [120.070564] [007/132] (899s left) gen9_exec_parse (basic-rejected) [120.133067] Subtest basic-rejected: SKIP (0.000s) [120.212962] [008/132] (899s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [120.307940] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [120.312306] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [120.450762] [009/132] (899s left) gem_exec_schedule (promotion) [120.527360] Starting subtest: promotion [120.529570] Starting dynamic subtest: rcs0 [120.628354] Dynamic subtest rcs0: SUCCESS (0.108s) [120.637044] Starting dynamic subtest: vcs0 [120.715303] Dynamic subtest vcs0: SUCCESS (0.086s) [120.725153] Starting dynamic subtest: vcs1 [120.792949] Dynamic subtest vcs1: SUCCESS (0.077s) [120.803124] Starting dynamic subtest: vecs0 [120.868077] Dynamic subtest vecs0: SUCCESS (0.075s) [120.877558] Starting dynamic subtest: ccs0 [120.952661] Dynamic subtest ccs0: SUCCESS (0.083s) [120.955190] Subtest promotion: SUCCESS (0.431s) [122.066912] [010/132] (897s left) kms_rotation_crc (exhaust-fences) [122.157981] Starting subtest: exhaust-fences [122.162394] Subtest exhaust-fences: SKIP (0.000s) [122.251279] [011/132] (897s left) syncobj_wait (signal) [122.319987] Starting subtest: signal [122.321952] Subtest signal: SUCCESS (0.000s) [122.430099] [012/132] (897s left) kms_color (deep-color) [122.534150] Starting subtest: deep-color [123.602953] Starting dynamic subtest: pipe-A-eDP-1-gamma [124.330625] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.726s) [124.340026] Starting dynamic subtest: pipe-A-eDP-1-degamma [125.791239] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.460s) [125.800210] Starting dynamic subtest: pipe-A-eDP-1-ctm [127.199620] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.409s) [127.998523] Starting dynamic subtest: pipe-B-eDP-1-gamma [128.684951] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.692s) [128.694159] Starting dynamic subtest: pipe-B-eDP-1-degamma [130.070660] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.385s) [130.079878] Starting dynamic subtest: pipe-B-eDP-1-ctm [131.520145] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.449s) [132.281251] Starting dynamic subtest: pipe-C-eDP-1-gamma [132.945238] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.670s) [132.954648] Starting dynamic subtest: pipe-C-eDP-1-degamma [134.336455] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.390s) [134.344584] Starting dynamic subtest: pipe-C-eDP-1-ctm [135.742693] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.405s) [136.565433] Starting dynamic subtest: pipe-D-eDP-1-gamma [137.259124] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.699s) [137.268104] Starting dynamic subtest: pipe-D-eDP-1-degamma [138.661069] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.402s) [138.672147] Starting dynamic subtest: pipe-D-eDP-1-ctm [140.081677] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.420s) [140.084099] Subtest deep-color: SUCCESS (17.548s) [140.941021] [013/132] (879s left) gem_exec_fence (syncobj-signal) [141.370151] Starting subtest: syncobj-signal [141.375201] Subtest syncobj-signal: SUCCESS (0.005s) [143.038127] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true [143.041494] [014/132] (877s left) gem_exec_balancer (semaphore) [143.112707] Starting subtest: semaphore [144.934250] Subtest semaphore: SUCCESS (1.822s) [145.294494] [015/132] (874s left) gem_workarounds (suspend-resume-context) [145.375091] Starting subtest: suspend-resume-context [161.258762] Subtest suspend-resume-context: SUCCESS (2.241s) [161.423950] [016/132] (858s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [161.536993] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [161.539352] Starting dynamic subtest: pipe-A-eDP-1 [161.562543] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [161.573768] Starting dynamic subtest: pipe-B-eDP-1 [161.595705] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [161.604403] Starting dynamic subtest: pipe-C-eDP-1 [161.626315] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [161.635184] Starting dynamic subtest: pipe-D-eDP-1 [161.658385] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [161.662727] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [163.756812] [017/132] (856s left) gem_spin_batch (resubmit-new) [163.836711] Starting subtest: resubmit-new [163.838732] Starting dynamic subtest: rcs0 [163.843458] Dynamic subtest rcs0: SUCCESS (0.008s) [163.854819] Starting dynamic subtest: bcs0 [163.857675] Dynamic subtest bcs0: SUCCESS (0.006s) [163.866956] Starting dynamic subtest: vcs0 [163.868870] Dynamic subtest vcs0: SUCCESS (0.005s) [163.877788] Starting dynamic subtest: vcs1 [163.879997] Dynamic subtest vcs1: SUCCESS (0.004s) [163.888874] Starting dynamic subtest: vecs0 [163.891115] Dynamic subtest vecs0: SUCCESS (0.005s) [163.899923] Starting dynamic subtest: ccs0 [163.902212] Dynamic subtest ccs0: SUCCESS (0.006s) [163.904554] Subtest resubmit-new: SUCCESS (0.037s) [165.600829] [018/132] (854s left) kms_pm_rpm (i2c) [167.651904] Starting subtest: i2c [172.968454] Subtest i2c: SUCCESS (5.247s) [173.079686] [019/132] (847s left) gem_pxp (display-protected-crc) [173.207457] Starting subtest: display-protected-crc [174.914458] Subtest display-protected-crc: SUCCESS (1.695s) [175.042927] [020/132] (845s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [175.137151] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [175.139356] Starting dynamic subtest: pipe-A-eDP-1 [175.162855] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [175.173638] Starting dynamic subtest: pipe-B-eDP-1 [175.194549] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [175.203446] Starting dynamic subtest: pipe-C-eDP-1 [175.224091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [175.232568] Starting dynamic subtest: pipe-D-eDP-1 [175.254128] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [175.258240] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [177.466846] [021/132] (842s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [177.569430] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [177.574263] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [178.704391] [022/132] (841s left) i915_selftest (live) [182.174529] Starting subtest: live [182.177180] Starting dynamic subtest: sanitycheck [186.692325] Dynamic subtest sanitycheck: SUCCESS (4.510s) [186.702356] Starting dynamic subtest: uncore [191.115289] Dynamic subtest uncore: SUCCESS (4.415s) [191.124736] Starting dynamic subtest: workarounds [194.344606] Dynamic subtest workarounds: SUCCESS (3.226s) [194.354333] Starting dynamic subtest: gt_engines [199.069733] Dynamic subtest gt_engines: SUCCESS (4.724s) [199.079477] Starting dynamic subtest: gt_timelines [216.748353] Dynamic subtest gt_timelines: SUCCESS (17.673s) [216.758253] Starting dynamic subtest: gt_contexts [221.212893] Dynamic subtest gt_contexts: SUCCESS (4.462s) [221.222529] Starting dynamic subtest: gt_lrc [225.669203] Dynamic subtest gt_lrc: SUCCESS (4.453s) [225.678791] Starting dynamic subtest: gt_mocs [228.789765] Dynamic subtest gt_mocs: SUCCESS (3.118s) [228.799164] Starting dynamic subtest: gt_pm [235.690186] Dynamic subtest gt_pm: SUCCESS (6.896s) [235.699812] Starting dynamic subtest: gt_heartbeat [240.117881] Dynamic subtest gt_heartbeat: SUCCESS (4.425s) [240.127910] Starting dynamic subtest: gt_tlb [249.595547] Dynamic subtest gt_tlb: SUCCESS (9.471s) [249.605367] Starting dynamic subtest: requests [261.235878] Dynamic subtest requests: SUCCESS (11.638s) [261.250203] Starting dynamic subtest: migrate [269.386879] Dynamic subtest migrate: SUCCESS (8.152s) [269.396934] Starting dynamic subtest: active [273.880476] Dynamic subtest active: SUCCESS (4.494s) [273.890156] Starting dynamic subtest: objects [277.270733] Dynamic subtest objects: SUCCESS (3.388s) [277.280131] Starting dynamic subtest: mman [282.259737] Dynamic subtest mman: SUCCESS (4.987s) [282.269428] Starting dynamic subtest: dmabuf [286.721575] Dynamic subtest dmabuf: SUCCESS (4.460s) [286.731707] Starting dynamic subtest: vma [291.144837] Dynamic subtest vma: SUCCESS (4.421s) [291.154559] Starting dynamic subtest: coherency [296.606270] Dynamic subtest coherency: SUCCESS (5.459s) [296.614267] Starting dynamic subtest: gtt [306.697698] Dynamic subtest gtt: SUCCESS (10.089s) [306.706310] Starting dynamic subtest: gem [312.454152] Dynamic subtest gem: SUCCESS (5.752s) [312.463540] Starting dynamic subtest: evict [316.572537] Dynamic subtest evict: SUCCESS (4.115s) [316.582355] Starting dynamic subtest: hugepages [327.707734] Dynamic subtest hugepages: SUCCESS (11.130s) [327.717310] Starting dynamic subtest: gem_contexts [356.803927] Dynamic subtest gem_contexts: SUCCESS (29.087s) [356.814315] Starting dynamic subtest: client [361.166140] Dynamic subtest client: SUCCESS (4.359s) [361.176035] Starting dynamic subtest: gem_migrate [365.591901] Dynamic subtest gem_migrate: SUCCESS (4.423s) [365.601184] Starting dynamic subtest: reset [370.088912] Dynamic subtest reset: SUCCESS (4.493s) [370.098530] Starting dynamic subtest: memory_region [374.586876] Dynamic subtest memory_region: SUCCESS (4.494s) [374.596148] Starting dynamic subtest: hangcheck [387.385266] Dynamic subtest hangcheck: SUCCESS (12.794s) [387.395328] Starting dynamic subtest: execlists [391.962463] Dynamic subtest execlists: SUCCESS (4.577s) [391.971974] Starting dynamic subtest: ring_submission [396.401018] Dynamic subtest ring_submission: SUCCESS (4.437s) [396.410827] Starting dynamic subtest: perf [399.369529] Dynamic subtest perf: SUCCESS (2.967s) [399.378960] Starting dynamic subtest: slpc [411.604934] Dynamic subtest slpc: SUCCESS (12.235s) [411.614570] Starting dynamic subtest: guc [415.591857] Dynamic subtest guc: SUCCESS (3.985s) [415.602183] Starting dynamic subtest: guc_multi_lrc [420.069836] Dynamic subtest guc_multi_lrc: SUCCESS (4.476s) [420.079377] Starting dynamic subtest: guc_hang [425.156153] Dynamic subtest guc_hang: SUCCESS (5.084s) [425.165757] Starting dynamic subtest: late_gt_pm [429.615689] Dynamic subtest late_gt_pm: SUCCESS (4.458s) [429.618541] Subtest live: SUCCESS (247.401s) [429.646562] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [429.647229] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [429.650265] [023/132] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [431.185508] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [438.030722] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.847s) [438.171207] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [438.172375] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true [438.176434] [024/132] (582s left) perf (gen12-oa-tlb-invalidate) [438.343354] Starting subtest: gen12-oa-tlb-invalidate [438.345300] Starting dynamic subtest: 0-rcs0 [448.385110] Dynamic subtest 0-rcs0: SUCCESS (10.041s) [448.394200] Starting dynamic subtest: 1-vecs0 [458.432980] Dynamic subtest 1-vecs0: SUCCESS (10.047s) [458.435338] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.090s) [458.471878] [025/132] (562s left) kms_addfb_basic (too-wide) [458.572319] Starting subtest: too-wide [458.574664] Subtest too-wide: SUCCESS (0.000s) [458.717916] [026/132] (561s left) kms_big_fb (linear-8bpp-rotate-180) [458.821466] Starting subtest: linear-8bpp-rotate-180 [460.008577] Subtest linear-8bpp-rotate-180: SUCCESS (1.187s) [460.167269] [027/132] (560s left) kms_getfb (getfb-reject-nv12) [460.263055] Starting subtest: getfb-reject-nv12 [460.265012] Subtest getfb-reject-nv12: SUCCESS (0.001s) [460.401950] [028/132] (560s left) kms_plane (plane-panning-bottom-right) [460.501913] Starting subtest: plane-panning-bottom-right [460.503579] Starting dynamic subtest: pipe-A [462.126928] Dynamic subtest pipe-A: SUCCESS (1.624s) [462.137323] Starting dynamic subtest: pipe-B [464.521541] Dynamic subtest pipe-B: SUCCESS (2.393s) [464.523869] Subtest plane-panning-bottom-right: SUCCESS (4.020s) [465.422890] [029/132] (555s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [465.489803] Starting subtest: map-fixed-invalidate-overlap-busy [465.493957] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [465.642828] [030/132] (555s left) prime_vgem (basic-write) [465.728929] Starting subtest: basic-write [465.737795] Subtest basic-write: SKIP (0.007s) [465.881886] [031/132] (554s left) gem_exec_whisper (basic-contexts-forked-all) [465.955871] Starting subtest: basic-contexts-forked-all [486.527527] Subtest basic-contexts-forked-all: SUCCESS (20.568s) [486.738911] [032/132] (534s left) kms_psr (fbc-pr-cursor-blt) [486.830584] Starting subtest: fbc-pr-cursor-blt [486.834904] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [486.927880] [033/132] (533s left) gen7_exec_parse (basic-allowed) [486.990752] Subtest basic-allowed: SKIP (0.000s) [487.057627] [034/132] (533s left) core_auth (getclient-simple) [487.094322] Starting subtest: getclient-simple [487.116015] Subtest getclient-simple: SUCCESS (0.019s) [487.261918] [035/132] (533s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [487.353527] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [487.355843] Starting dynamic subtest: pipe-A-default-mode [487.649871] Dynamic subtest pipe-A-default-mode: SKIP (0.292s) [487.654573] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.294s) [488.465718] [036/132] (532s left) gem_create (create-ext-placement-sanity-check) [488.643214] Starting subtest: create-ext-placement-sanity-check [488.645715] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s) [488.773751] [037/132] (532s left) kms_psr (psr2-sprite-blt) [488.872628] Starting subtest: psr2-sprite-blt [488.874970] Starting dynamic subtest: eDP-1 [490.644568] Dynamic subtest eDP-1: SUCCESS (1.770s) [490.646821] Subtest psr2-sprite-blt: SUCCESS (1.771s) [491.545150] [038/132] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [491.656378] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [491.660572] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [491.787567] [039/132] (529s left) gem_ctx_persistence (engines-hang) [491.851243] Starting subtest: engines-hang [491.853655] Starting dynamic subtest: rcs0 [491.970760] Dynamic subtest rcs0: SUCCESS (0.118s) [491.982440] Starting dynamic subtest: bcs0 [492.082336] Dynamic subtest bcs0: SUCCESS (0.110s) [492.094246] Starting dynamic subtest: vcs0 [492.200376] Dynamic subtest vcs0: SUCCESS (0.116s) [492.213555] Starting dynamic subtest: vcs1 [492.312342] Dynamic subtest vcs1: SUCCESS (0.110s) [492.324413] Starting dynamic subtest: vecs0 [492.426298] Dynamic subtest vecs0: SUCCESS (0.112s) [492.438525] Starting dynamic subtest: ccs0 [492.528675] Dynamic subtest ccs0: SUCCESS (0.101s) [492.530706] Subtest engines-hang: SUCCESS (0.679s) [492.631917] [040/132] (528s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [492.747731] Starting subtest: cursorA-vs-flipB-atomic [492.751472] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [492.916762] [041/132] (528s left) gem_exec_reloc (basic-write-gtt) [492.982987] Subtest basic-write-gtt: SKIP (0.000s) [493.070658] [042/132] (528s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [493.121824] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [493.227583] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [493.326410] [043/132] (527s left) gem_render_copy (linear-to-vebox-yf-tiled) [493.393431] Starting subtest: linear-to-vebox-yf-tiled [493.398175] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [493.600456] [044/132] (527s left) kms_addfb_basic (invalid-get-prop-any) [493.669030] Starting subtest: invalid-get-prop-any [493.671376] Subtest invalid-get-prop-any: SUCCESS (0.000s) [493.839780] [045/132] (527s left) kms_flip (busy-flip) [493.939991] Starting subtest: busy-flip [493.941910] Starting dynamic subtest: A-eDP1 [495.635576] Dynamic subtest A-eDP1: SUCCESS (1.697s) [495.646948] Starting dynamic subtest: B-eDP1 [497.269341] Dynamic subtest B-eDP1: SUCCESS (1.632s) [497.280611] Starting dynamic subtest: C-eDP1 [498.886942] Dynamic subtest C-eDP1: SUCCESS (1.616s) [498.898433] Starting dynamic subtest: D-eDP1 [500.523001] Dynamic subtest D-eDP1: SUCCESS (1.634s) [500.528373] Subtest busy-flip: SUCCESS (6.592s) [501.814733] [046/132] (519s left) gem_readwrite (read-bad-handle) [501.880176] Subtest read-bad-handle: SKIP (0.000s) [501.963846] [047/132] (519s left) core_getstats (basic) [502.030079] Starting subtest: basic [502.031995] Subtest basic: SUCCESS (0.000s) [502.153363] [048/132] (519s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [502.255819] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [502.879939] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s) [503.098601] [049/132] (518s left) kms_atomic (plane-invalid-params-fence) [503.199879] Starting subtest: plane-invalid-params-fence [503.202274] Starting dynamic subtest: pipe-A-eDP-1 [503.571277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.371s) [503.573673] Subtest plane-invalid-params-fence: SUCCESS (0.374s) [504.449893] [050/132] (517s left) kms_pm_rpm (pc8-residency) [506.696293] Starting subtest: pc8-residency [506.708022] Subtest pc8-residency: SKIP (0.000s) [507.097015] [051/132] (514s left) kms_psr2_su (frontbuffer-xrgb8888) [507.155823] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [507.247965] [052/132] (514s left) syncobj_timeline (etime-single-wait-submitted) [507.304269] Starting subtest: etime-single-wait-submitted [507.412303] Subtest etime-single-wait-submitted: SUCCESS (0.107s) [507.510436] [053/132] (514s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [507.617713] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [507.621652] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [507.751836] [054/132] (514s left) kms_chamelium_color (ctm-blue-to-red) [507.841148] Subtest ctm-blue-to-red: SKIP (0.000s) [507.887666] [055/132] (513s left) syncobj_wait (multi-wait-all-signaled) [507.942874] Starting subtest: multi-wait-all-signaled [507.945365] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [508.082614] [056/132] (513s left) prime_mmap (test_correct_cpu_write) [508.145900] Starting subtest: test_correct_cpu_write [508.148129] Starting dynamic subtest: test_correct_cpu_write-smem [508.150002] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [508.151900] Subtest test_correct_cpu_write: SUCCESS (0.001s) [508.279600] [057/132] (513s left) gem_exec_reloc (basic-concurrent16) [508.350487] Subtest basic-concurrent16: SKIP (0.000s) [508.440804] [058/132] (513s left) vgem_basic (bad-handle) [508.483309] Starting subtest: bad-handle [508.485351] Subtest bad-handle: SUCCESS (0.000s) [508.568639] [059/132] (513s left) gem_userptr_blits (readonly-pwrite-unsync) [508.645833] Subtest readonly-pwrite-unsync: SKIP (0.000s) [508.817492] [060/132] (513s left) gem_exec_schedule (implicit-read-write) [508.886286] Starting subtest: implicit-read-write [508.888104] Starting dynamic subtest: rcs0 [508.980026] Dynamic subtest rcs0: SUCCESS (0.101s) [508.994083] Starting dynamic subtest: vcs0 [509.069294] Dynamic subtest vcs0: SUCCESS (0.087s) [509.078552] Starting dynamic subtest: vcs1 [509.148146] Dynamic subtest vcs1: SUCCESS (0.077s) [509.159823] Starting dynamic subtest: vecs0 [509.219970] Dynamic subtest vecs0: SUCCESS (0.071s) [509.230958] Starting dynamic subtest: ccs0 [509.303629] Dynamic subtest ccs0: SUCCESS (0.083s) [509.305572] Subtest implicit-read-write: SUCCESS (0.425s) [510.707620] [061/132] (511s left) gem_tiled_fence_blits (normal) [510.782304] Subtest normal: SKIP (0.000s) [510.868044] [062/132] (511s left) i915_pm_rpm (gem-idle) [512.696560] Starting subtest: gem-idle [518.899971] Subtest gem-idle: SUCCESS (6.202s) [519.260177] [063/132] (502s left) kms_content_protection (content-type-change) [520.532418] Starting subtest: content-type-change [520.537143] Subtest content-type-change: SKIP (0.000s) [520.697742] [064/132] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [520.806120] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [524.534619] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.731s) [525.772107] [065/132] (496s left) kms_vblank (ts-continuation-dpms-suspend) [525.871646] Starting subtest: ts-continuation-dpms-suspend [525.873871] Starting dynamic subtest: pipe-A-eDP-1 [542.700552] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.850s) [542.716586] Starting dynamic subtest: pipe-D-eDP-1 [560.717912] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.478s) [560.719852] Subtest ts-continuation-dpms-suspend: SUCCESS (4.332s) [561.571535] [066/132] (460s left) perf_pmu (most-busy-idle-check-all) [561.622210] Starting subtest: most-busy-idle-check-all [561.624261] Starting dynamic subtest: rcs0 [562.346069] Dynamic subtest rcs0: FAIL (0.646s) [562.358860] Starting dynamic subtest: bcs0 [563.004778] Dynamic subtest bcs0: SUCCESS (0.700s) [563.020243] Starting dynamic subtest: vcs0 [564.926231] Dynamic subtest vcs0: SUCCESS (1.873s) [564.942365] Starting dynamic subtest: vcs1 [566.974503] Dynamic subtest vcs1: SUCCESS (2.012s) [566.990138] Starting dynamic subtest: vecs0 [569.024232] Dynamic subtest vecs0: SUCCESS (2.018s) [569.036933] Starting dynamic subtest: ccs0 [570.941826] Dynamic subtest ccs0: SUCCESS (1.895s) [570.945111] Subtest most-busy-idle-check-all: FAIL (9.160s) [571.081911] [067/132] (451s left) gem_exec_balancer (full-pulse) [571.151986] Starting subtest: full-pulse [575.797965] Subtest full-pulse: SUCCESS (4.614s) [576.162065] [068/132] (446s left) kms_invalid_mode (bad-hsync-end) [576.265444] Starting subtest: bad-hsync-end [576.267661] Starting dynamic subtest: pipe-A-eDP-1 [576.556039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [576.566482] Starting dynamic subtest: pipe-B-eDP-1 [576.568728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [576.578397] Starting dynamic subtest: pipe-C-eDP-1 [576.580718] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [576.589802] Starting dynamic subtest: pipe-D-eDP-1 [576.592042] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [576.594314] Subtest bad-hsync-end: SUCCESS (0.297s) [577.401311] [069/132] (445s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [577.454258] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [577.456663] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [577.598130] [070/132] (444s left) kms_draw_crc (fill-fb) [577.698569] Starting subtest: fill-fb [578.229203] Subtest fill-fb: SUCCESS (0.531s) [578.346888] [071/132] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [578.447091] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [578.450453] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [578.571537] [072/132] (444s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [578.674566] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [585.948610] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.258s) [586.115467] [073/132] (436s left) syncobj_timeline (multi-wait-submitted-signaled) [586.173348] Starting subtest: multi-wait-submitted-signaled [586.175747] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [586.314372] [074/132] (436s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [586.411711] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [586.415907] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [586.546598] [075/132] (436s left) kms_lease (invalid-create-leases) [586.640429] Starting subtest: invalid-create-leases [586.644820] Subtest invalid-create-leases: SUCCESS (0.005s) [586.788932] [076/132] (435s left) gem_render_copy (linear) [586.849434] Starting subtest: linear [586.851800] Starting dynamic subtest: smem [586.887581] Dynamic subtest smem: SUCCESS (0.038s) [586.889605] Subtest linear: SUCCESS (0.039s) [587.156479] [077/132] (435s left) gem_mmap_offset (clear-via-pagefault) [587.221307] Starting subtest: clear-via-pagefault [587.223972] Starting dynamic subtest: smem0 [622.608641] Dynamic subtest smem0: SUCCESS (35.382s) [622.611094] Subtest clear-via-pagefault: SUCCESS (35.385s) [622.756922] [078/132] (400s left) i915_query (query-garbage) [622.806224] Starting subtest: query-garbage [622.808555] Subtest query-garbage: SUCCESS (0.000s) [622.933849] [079/132] (399s left) gem_exec_whisper (basic-queues-forked-all) [622.996853] Starting subtest: basic-queues-forked-all [645.099318] Subtest basic-queues-forked-all: SUCCESS (22.093s) [645.309767] [080/132] (377s left) gem_media_fill (media-fill) [645.372531] Subtest media-fill: SKIP (0.000s) [645.511479] [081/132] (377s left) i915_query (query-topology-kernel-writes) [645.568221] Starting subtest: query-topology-kernel-writes [645.570071] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [645.697579] [082/132] (377s left) kms_flip (2x-flip-vs-rmfb) [645.781314] Starting subtest: 2x-flip-vs-rmfb [645.792317] Subtest 2x-flip-vs-rmfb: SKIP (0.010s) [645.899793] [083/132] (377s left) kms_psr (pr-primary-mmap-cpu) [645.982502] Starting subtest: pr-primary-mmap-cpu [645.986967] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [646.075507] [084/132] (377s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [646.172837] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [646.177378] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [646.322499] [085/132] (376s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [646.379177] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [646.382432] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [646.585043] [086/132] (376s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [646.701857] Starting subtest: modeset-atomic-cursor-hotspot [646.706516] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [646.873889] [087/132] (376s left) perf (blocking-parameterized) [646.981560] Starting subtest: blocking-parameterized [666.997091] Subtest blocking-parameterized: SUCCESS (20.017s) [667.049325] [088/132] (356s left) kms_frontbuffer_tracking (psr-1p-rte) [667.162204] Starting subtest: psr-1p-rte [672.544471] Subtest psr-1p-rte: SUCCESS (5.388s) [672.719586] [089/132] (350s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [672.825111] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [672.829139] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [672.948849] [090/132] (350s left) kms_psr2_sf (pr-cursor-plane-update-sf) [677.912125] Starting subtest: pr-cursor-plane-update-sf [677.916896] Subtest pr-cursor-plane-update-sf: SKIP (0.002s) [678.785574] [091/132] (344s left) kms_async_flips (async-flip-suspend-resume) [678.876185] Starting subtest: async-flip-suspend-resume [679.259571] Starting dynamic subtest: pipe-A-eDP-1 [697.125301] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.897s) [697.508245] Starting dynamic subtest: pipe-B-eDP-1 [715.145363] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.850s) [715.530796] Starting dynamic subtest: pipe-C-eDP-1 [733.390609] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.108s) [733.768217] Starting dynamic subtest: pipe-D-eDP-1 [751.364568] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.080s) [751.366948] Subtest async-flip-suspend-resume: SUCCESS (13.424s) [752.592410] [092/132] (270s left) prime_mmap_coherency (ioctl-errors) [752.653267] Starting subtest: ioctl-errors [776.728968] Subtest ioctl-errors: SUCCESS (23.867s) [776.920397] [093/132] (246s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [777.060883] Starting subtest: psr-rgb101010-draw-mmap-cpu [784.002959] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.935s) [784.150540] [094/132] (239s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [784.251876] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [784.257114] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [784.371124] [095/132] (239s left) kms_fb_coherency (memset-crc) [784.470080] Starting subtest: memset-crc [784.472870] Starting dynamic subtest: mmap-offset-wc [784.885761] Dynamic subtest mmap-offset-wc: SUCCESS (0.417s) [785.205098] Starting dynamic subtest: mmap-offset-uc [791.312207] Dynamic subtest mmap-offset-uc: SUCCESS (6.123s) [791.606214] Subtest memset-crc: SUCCESS (7.145s) [792.462480] [096/132] (231s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [792.569262] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [792.571590] Starting dynamic subtest: pipe-A-default-mode [795.314412] Dynamic subtest pipe-A-default-mode: SUCCESS (2.744s) [795.317009] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.746s) [796.169245] [097/132] (227s left) gem_ppgtt (blt-vs-render-ctxn) [796.236852] Starting subtest: blt-vs-render-ctxN [829.425645] Subtest blt-vs-render-ctxN: SUCCESS (33.189s) [829.598843] [098/132] (194s left) i915_drm_fdinfo (busy-idle) [829.684533] Starting subtest: busy-idle [829.686580] Starting dynamic subtest: rcs0 [829.717919] Dynamic subtest rcs0: SKIP (0.035s) [829.731744] Starting dynamic subtest: bcs0 [829.736732] Dynamic subtest bcs0: SKIP (0.001s) [829.749096] Starting dynamic subtest: vcs0 [829.754720] Dynamic subtest vcs0: SKIP (0.000s) [829.765020] Starting dynamic subtest: vcs1 [829.769940] Dynamic subtest vcs1: SKIP (0.000s) [829.779595] Starting dynamic subtest: vecs0 [829.785115] Dynamic subtest vecs0: SKIP (0.000s) [829.794439] Starting dynamic subtest: ccs0 [829.798820] Dynamic subtest ccs0: SKIP (0.000s) [829.803064] Subtest busy-idle: SKIP (0.043s) [829.840501] [099/132] (193s left) kms_frontbuffer_tracking (fbc-1p-rte) [829.956529] Starting subtest: fbc-1p-rte [835.441284] Subtest fbc-1p-rte: SUCCESS (5.488s) [836.693846] [100/132] (187s left) dumb_buffer (map-valid) [836.754134] Starting subtest: map-valid [836.756925] Subtest map-valid: SUCCESS (0.000s) [836.894984] [101/132] (186s left) kms_chamelium_edid (dp-edid-resolution-list) [837.286994] Subtest dp-edid-resolution-list: SKIP (0.000s) [838.063865] [102/132] (185s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [838.158721] Starting subtest: fbc-dirtyfb-ioctl [838.161307] Starting dynamic subtest: A-eDP-1 [840.749896] Dynamic subtest A-eDP-1: SUCCESS (2.589s) [840.752858] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.591s) [841.565993] [103/132] (182s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [841.670954] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [841.675967] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [841.797469] [104/132] (182s left) prime_vgem (fence-wait) [841.878201] Starting subtest: fence-wait [841.880942] Starting dynamic subtest: rcs0 [842.943688] Dynamic subtest rcs0: SUCCESS (1.064s) [842.957213] Starting dynamic subtest: bcs0 [844.027889] Dynamic subtest bcs0: SUCCESS (1.083s) [844.039633] Starting dynamic subtest: vcs0 [845.073075] Dynamic subtest vcs0: SUCCESS (1.044s) [845.085354] Starting dynamic subtest: vcs1 [846.114134] Dynamic subtest vcs1: SUCCESS (1.039s) [846.127435] Starting dynamic subtest: vecs0 [847.156826] Dynamic subtest vecs0: SUCCESS (1.041s) [847.170215] Starting dynamic subtest: ccs0 [848.795742] Dynamic subtest ccs0: SUCCESS (1.636s) [848.798953] Subtest fence-wait: SUCCESS (6.916s) [848.938918] [105/132] (175s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [849.043894] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [849.049592] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [849.169379] [106/132] (174s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [849.271659] Starting subtest: yf-tiled-64bpp-rotate-0 [849.276880] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [849.400994] [107/132] (174s left) gem_ctx_persistence (legacy-engines-mixed) [849.454061] Starting subtest: legacy-engines-mixed [849.456872] Starting dynamic subtest: render [849.546473] Dynamic subtest render: SUCCESS (0.092s) [849.559997] Starting dynamic subtest: bsd1 [849.626385] Dynamic subtest bsd1: SUCCESS (0.077s) [849.640322] Starting dynamic subtest: bsd2 [849.678285] Dynamic subtest bsd2: SUCCESS (0.049s) [849.691693] Starting dynamic subtest: blt [849.743318] Dynamic subtest blt: SUCCESS (0.063s) [849.756061] Starting dynamic subtest: vebox [849.803769] Dynamic subtest vebox: SUCCESS (0.059s) [849.806226] Subtest legacy-engines-mixed: SUCCESS (0.351s) [849.909111] [108/132] (174s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [850.002852] Starting subtest: fbc-2p-pri-indfb-multidraw [850.006885] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [850.120368] [109/132] (174s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [850.220982] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [850.225849] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [850.347764] [110/132] (173s left) syncobj_wait (wait-any-snapshot) [850.399553] Starting subtest: wait-any-snapshot [850.482187] Subtest wait-any-snapshot: SUCCESS (0.082s) [850.587075] [111/132] (173s left) kms_psr (psr-sprite-blt) [850.690606] Starting subtest: psr-sprite-blt [850.692609] Starting dynamic subtest: eDP-1 [852.464343] Dynamic subtest eDP-1: SUCCESS (1.774s) [852.466952] Subtest psr-sprite-blt: SUCCESS (1.775s) [853.333530] [112/132] (170s left) kms_cursor_crc (cursor-onscreen-256x256) [853.581867] Starting subtest: cursor-onscreen-256x256 [853.587914] Starting dynamic subtest: pipe-A-eDP-1 [855.725370] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.140s) [855.758712] Starting dynamic subtest: pipe-D-eDP-1 [858.510618] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s) [858.513261] Subtest cursor-onscreen-256x256: SUCCESS (4.928s) [859.395210] [113/132] (164s left) kms_big_fb (x-tiled-64bpp-rotate-90) [859.492818] Starting subtest: x-tiled-64bpp-rotate-90 [859.513043] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s) [859.674139] [114/132] (164s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [859.798899] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [859.804039] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [859.967932] [115/132] (164s left) gem_ctx_shared (q-in-order) [860.032790] Starting subtest: Q-in-order [860.035471] Starting dynamic subtest: rcs0 [860.140901] Dynamic subtest rcs0: SUCCESS (0.107s) [860.157845] Starting dynamic subtest: vcs0 [860.224736] Dynamic subtest vcs0: SUCCESS (0.084s) [860.244419] Starting dynamic subtest: vcs1 [860.306241] Dynamic subtest vcs1: SUCCESS (0.080s) [860.323987] Starting dynamic subtest: vecs0 [860.379649] Dynamic subtest vecs0: SUCCESS (0.073s) [860.397658] Starting dynamic subtest: ccs0 [860.458325] Dynamic subtest ccs0: SUCCESS (0.078s) [860.461167] Subtest Q-in-order: SUCCESS (0.426s) [861.936436] [116/132] (162s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [862.039036] Starting subtest: fbc-rgb101010-draw-mmap-wc [866.665754] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.630s) [867.809151] [117/132] (156s left) syncobj_wait (invalid-reset-zero-handles) [867.876210] Starting subtest: invalid-reset-zero-handles [867.878936] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [867.998131] [118/132] (156s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [868.094804] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [868.097514] Starting dynamic subtest: pipe-A [868.114270] Dynamic subtest pipe-A: SKIP (0.016s) [868.128947] Starting dynamic subtest: pipe-B [868.147481] Dynamic subtest pipe-B: SKIP (0.029s) [868.158374] Starting dynamic subtest: pipe-C [868.175654] Dynamic subtest pipe-C: SKIP (0.029s) [868.186051] Starting dynamic subtest: pipe-D [868.206767] Dynamic subtest pipe-D: SKIP (0.029s) [868.211994] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.106s) [868.342406] [119/132] (156s left) kms_big_fb (y-tiled-16bpp-rotate-90) [868.447708] Starting subtest: y-tiled-16bpp-rotate-90 [868.452834] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [868.590327] [120/132] (156s left) kms_psr (fbc-psr-cursor-mmap-gtt) [868.679962] Starting subtest: fbc-psr-cursor-mmap-gtt [868.682878] Starting dynamic subtest: eDP-1 [868.687936] Dynamic subtest eDP-1: SKIP (0.000s) [868.692979] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [868.779216] [121/132] (155s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [868.872371] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [868.874427] Starting dynamic subtest: pipe-A-eDP-1 [869.589047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [869.600509] Starting dynamic subtest: pipe-B-eDP-1 [871.382212] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.787s) [871.393440] Starting dynamic subtest: pipe-C-eDP-1 [873.105033] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.726s) [873.116716] Starting dynamic subtest: pipe-D-eDP-1 [874.847971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.723s) [874.850405] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.950s) [876.009136] [122/132] (148s left) kms_busy (basic) [876.115758] Starting subtest: basic [876.118076] Starting dynamic subtest: flip [876.710051] Dynamic subtest flip: SUCCESS (0.596s) [876.723209] Starting dynamic subtest: modeset [880.393642] Dynamic subtest modeset: SUCCESS (3.680s) [880.396042] Subtest basic: SUCCESS (4.278s) [881.282835] [123/132] (143s left) kms_cursor_crc (cursor-rapid-movement-512x170) [881.567126] Starting subtest: cursor-rapid-movement-512x170 [881.572820] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [881.759902] [124/132] (143s left) kms_plane_alpha_blend (constant-alpha-min) [881.875853] Starting subtest: constant-alpha-min [882.173568] Starting dynamic subtest: pipe-A-eDP-1 [882.863370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s) [882.875099] Starting dynamic subtest: pipe-D-eDP-1 [884.370032] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.501s) [884.372573] Subtest constant-alpha-min: SUCCESS (2.493s) [885.227721] [125/132] (139s left) prime_self_import (basic-llseek-bad) [885.260317] Starting subtest: basic-llseek-bad [885.280547] Subtest basic-llseek-bad: SUCCESS (0.019s) [885.397301] [126/132] (139s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [885.789211] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [886.633575] [127/132] (138s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [886.737979] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [886.740682] Starting dynamic subtest: A-eDP1 [895.598399] Dynamic subtest A-eDP1: SUCCESS (8.860s) [895.611437] Starting dynamic subtest: B-eDP1 [904.537406] Dynamic subtest B-eDP1: SUCCESS (8.937s) [904.548830] Starting dynamic subtest: C-eDP1 [913.460719] Dynamic subtest C-eDP1: SUCCESS (8.921s) [913.473522] Starting dynamic subtest: D-eDP1 [922.388848] Dynamic subtest D-eDP1: SUCCESS (8.925s) [922.394882] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.653s) [923.632739] [128/132] (101s left) gem_exec_parallel (fds) [923.699993] Starting subtest: fds [923.702935] Starting dynamic subtest: rcs0 [927.972750] Dynamic subtest rcs0: SUCCESS (4.270s) [927.987501] Starting dynamic subtest: bcs0 [932.805261] Dynamic subtest bcs0: SUCCESS (4.829s) [932.816669] Starting dynamic subtest: vcs0 [937.058827] Dynamic subtest vcs0: SUCCESS (4.252s) [937.072377] Starting dynamic subtest: vcs1 [942.809576] Dynamic subtest vcs1: SUCCESS (5.748s) [942.820958] Starting dynamic subtest: vecs0 [947.008267] Dynamic subtest vecs0: SUCCESS (4.194s) [947.019371] Starting dynamic subtest: ccs0 [951.890049] Dynamic subtest ccs0: SUCCESS (4.878s) [951.893207] Subtest fds: SUCCESS (28.185s) [952.117387] [129/132] ( 72s left) prime_vgem (fence-write-hang) [952.217925] Subtest fence-write-hang: SKIP (0.000s) [952.373845] [130/132] ( 72s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [952.505299] Starting subtest: fbc-modesetfrombusy [956.366816] Subtest fbc-modesetfrombusy: SUCCESS (3.865s) [957.566993] [131/132] ( 67s left) syncobj_timeline (wait-all-for-submit-snapshot) [957.628981] Starting subtest: wait-all-for-submit-snapshot [957.708606] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [957.812352] [132/132] ( 67s left) kms_scaling_modes (scaling-mode-center) [957.912778] Starting subtest: scaling-mode-center [957.914945] Starting dynamic subtest: pipe-A-eDP-1 [958.010926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s) [958.023135] Starting dynamic subtest: pipe-B-eDP-1 [959.159089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s) [959.170940] Starting dynamic subtest: pipe-C-eDP-1 [960.277684] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s) [960.291520] Starting dynamic subtest: pipe-D-eDP-1 [961.414330] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [961.416899] Subtest scaling-mode-center: SUCCESS (3.504s) [962.595460] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: i915_hangman results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: kms_pm_dc results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: gen9_exec_parse results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: gem_exec_schedule results: parsing output: 9/ for test: kms_rotation_crc results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_color results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: gem_exec_balancer results: parsing output: 14/ for test: gem_workarounds results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: gem_spin_batch results: parsing output: 17/ for test: kms_pm_rpm results: parsing output: 18/ for test: gem_pxp results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: i915_selftest results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: perf results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_getfb results: parsing output: 27/ for test: kms_plane results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: prime_vgem results: parsing output: 30/ for test: gem_exec_whisper results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: gen7_exec_parse results: parsing output: 33/ for test: core_auth results: parsing output: 34/ for test: kms_flip_scaled_crc results: parsing output: 35/ for test: gem_create results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_ctx_persistence results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: gem_render_copy results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: gem_readwrite results: parsing output: 46/ for test: core_getstats results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: kms_atomic results: parsing output: 49/ for test: kms_pm_rpm results: parsing output: 50/ for test: kms_psr2_su results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_chamelium_color results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: prime_mmap results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: vgem_basic results: parsing output: 58/ for test: gem_userptr_blits results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: gem_tiled_fence_blits results: parsing output: 61/ for test: i915_pm_rpm results: parsing output: 62/ for test: kms_content_protection results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_vblank results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: gem_exec_balancer results: parsing output: 67/ for test: kms_invalid_mode results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: kms_draw_crc results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_lease results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: gem_mmap_offset results: parsing output: 77/ for test: i915_query results: parsing output: 78/ for test: gem_exec_whisper results: parsing output: 79/ for test: gem_media_fill results: parsing output: 80/ for test: i915_query results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_render_copy results: parsing output: 85/ for test: kms_cursor_legacy results: parsing output: 86/ for test: perf results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: kms_async_flips results: parsing output: 91/ for test: prime_mmap_coherency results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_fb_coherency results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: gem_ppgtt results: parsing output: 97/ for test: i915_drm_fdinfo results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: dumb_buffer results: parsing output: 100/ for test: kms_chamelium_edid results: parsing output: 101/ for test: kms_dirtyfb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: prime_vgem results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: gem_ctx_persistence results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: kms_cursor_crc results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_ctx_shared results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: kms_plane_scaling results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_busy results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: kms_plane_alpha_blend results: parsing output: 124/ for test: prime_self_import results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: gem_exec_parallel results: parsing output: 128/ for test: prime_vgem results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: kms_scaling_modes Done.