[59.169203] Initializing watchdogs [59.169254] /dev/watchdog0 [59.183639] [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.187999] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.190217] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.193734] [001/133] (960s left) vgem_basic (second-client) [59.278025] Starting subtest: second-client [59.303101] Subtest second-client: SUCCESS (0.022s) [59.353096] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true [59.356453] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [59.477365] Starting subtest: cursorA-vs-flipB-atomic-transitions [59.482230] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [59.630782] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted) [59.689917] Starting subtest: multi-wait-available-submitted [59.692316] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [59.796040] [004/133] (960s left) kms_invalid_mode (bad-vsync-end) [59.899591] Starting subtest: bad-vsync-end [59.901973] Starting dynamic subtest: pipe-A-eDP-1 [60.184217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [60.192700] Starting dynamic subtest: pipe-B-eDP-1 [60.194628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [60.201395] Starting dynamic subtest: pipe-C-eDP-1 [60.203741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [60.210774] Starting dynamic subtest: pipe-D-eDP-1 [60.213069] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [60.215259] Subtest bad-vsync-end: SUCCESS (0.290s) [61.067301] [005/133] (958s left) kms_pm_backlight (fade-with-dpms) [61.166119] Starting subtest: fade-with-dpms [63.355050] Starting dynamic subtest: eDP-1 [65.862672] Dynamic subtest eDP-1: SUCCESS (2.507s) [65.864953] Subtest fade-with-dpms: SUCCESS (4.698s) [66.665293] [006/133] (953s left) kms_flip (bo-too-big-interruptible) [66.813289] Starting subtest: bo-too-big-interruptible [66.815781] Starting dynamic subtest: A-eDP1 [68.130297] Dynamic subtest A-eDP1: SUCCESS (1.316s) [68.141720] Starting dynamic subtest: B-eDP1 [69.454819] Dynamic subtest B-eDP1: SUCCESS (1.323s) [69.465301] Starting dynamic subtest: C-eDP1 [70.711653] Dynamic subtest C-eDP1: SUCCESS (1.256s) [70.723036] Starting dynamic subtest: D-eDP1 [72.039833] Dynamic subtest D-eDP1: SUCCESS (1.327s) [72.042371] Subtest bo-too-big-interruptible: SUCCESS (5.229s) [73.239609] [007/133] (946s left) gem_mmap_gtt (basic-read) [73.294789] Subtest basic-read: SKIP (0.000s) [73.353177] [008/133] (946s left) gem_softpin (allocator-evict) [73.413201] Starting subtest: allocator-evict [73.415505] Starting dynamic subtest: rcs0 [96.588309] Dynamic subtest rcs0: SUCCESS (23.173s) [96.598972] Starting dynamic subtest: bcs0 [120.728891] Dynamic subtest bcs0: SUCCESS (24.138s) [120.737245] Starting dynamic subtest: vcs0 [144.494774] Dynamic subtest vcs0: SUCCESS (23.762s) [144.505471] Starting dynamic subtest: vcs1 [168.087858] Dynamic subtest vcs1: SUCCESS (23.591s) [168.098770] Starting dynamic subtest: vecs0 [191.924772] Dynamic subtest vecs0: SUCCESS (23.835s) [191.933385] Starting dynamic subtest: ccs0 [215.902058] Dynamic subtest ccs0: SUCCESS (23.976s) [215.904455] Subtest allocator-evict: SUCCESS (142.478s) [215.997338] [009/133] (804s left) gem_render_linear_blits (basic) [216.098718] Starting subtest: basic [216.140657] Subtest basic: SUCCESS (0.042s) [216.222982] [010/133] (803s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [216.326530] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [216.330650] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [216.431329] [011/133] (803s left) kms_psr (psr-primary-mmap-cpu) [216.530031] Starting subtest: psr-primary-mmap-cpu [216.532298] Starting dynamic subtest: eDP-1 [218.239068] Dynamic subtest eDP-1: SUCCESS (1.711s) [218.241407] Subtest psr-primary-mmap-cpu: SUCCESS (1.711s) [219.106094] [012/133] (801s left) kms_chamelium_edid (hdmi-mode-timings) [219.493304] Subtest hdmi-mode-timings: SKIP (0.000s) [220.312561] [013/133] (799s left) gen7_exec_parse (load-register-reg) [220.374646] Subtest load-register-reg: SKIP (0.000s) [220.455893] [014/133] (799s left) syncobj_eventfd (invalid-bad-flags) [220.520170] Starting subtest: invalid-bad-flags [220.522621] Subtest invalid-bad-flags: SUCCESS (0.000s) [220.635538] [015/133] (799s left) gem_ctx_exec (basic-invalid-context) [220.690022] Starting subtest: basic-invalid-context [220.694682] Subtest basic-invalid-context: SUCCESS (0.005s) [220.830854] [016/133] (799s left) gem_exec_reloc (basic-write-read-active) [220.896776] Subtest basic-write-read-active: SKIP (0.000s) [220.975603] [017/133] (799s left) kms_vblank (wait-busy-hang) [221.061142] Starting subtest: wait-busy-hang [221.063417] Starting dynamic subtest: pipe-A-eDP-1 [247.703137] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.640s) [247.716547] Starting dynamic subtest: pipe-D-eDP-1 [262.754503] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.049s) [262.756445] Subtest wait-busy-hang: SUCCESS (41.692s) [263.606214] [018/133] (756s left) kms_chamelium_color (ctm-0-50) [263.701395] Subtest ctm-0-50: SKIP (0.000s) [263.746767] [019/133] (756s left) gem_exec_flush (basic-uc-prw-default) [263.806838] Starting subtest: basic-uc-prw-default [269.269889] Subtest basic-uc-prw-default: SUCCESS (5.463s) [269.457924] [020/133] (751s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [269.550415] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [276.451783] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.903s) [276.566616] [021/133] (743s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [276.684844] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [276.689523] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [276.774654] [022/133] (743s left) kms_plane_scaling (planes-upscale-factor-0-25) [276.872073] Starting subtest: planes-upscale-factor-0-25 [276.874370] Starting dynamic subtest: pipe-A [276.932109] Dynamic subtest pipe-A: SUCCESS (0.063s) [276.942606] Starting dynamic subtest: pipe-B [278.067631] Dynamic subtest pipe-B: SUCCESS (1.135s) [278.078509] Starting dynamic subtest: pipe-C [279.184298] Dynamic subtest pipe-C: SUCCESS (1.116s) [279.195070] Starting dynamic subtest: pipe-D [280.320403] Dynamic subtest pipe-D: SUCCESS (1.136s) [280.322751] Subtest planes-upscale-factor-0-25: SUCCESS (3.451s) [281.472988] [023/133] (739s left) i915_selftest (perf) [284.735199] Starting subtest: perf [284.737667] Starting dynamic subtest: engine_cs [289.097955] Dynamic subtest engine_cs: SUCCESS (4.367s) [289.107517] Starting dynamic subtest: request [294.407701] Dynamic subtest request: SUCCESS (5.309s) [294.415709] Starting dynamic subtest: migrate [298.758373] Dynamic subtest migrate: SUCCESS (4.350s) [298.767643] Starting dynamic subtest: region [304.497869] Dynamic subtest region: SUCCESS (5.738s) [304.500579] Subtest perf: SUCCESS (19.768s) [304.539645] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [304.540381] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [304.543613] [024/133] (716s left) kms_color (legacy-gamma) [306.125963] Starting subtest: legacy-gamma [306.127846] Starting dynamic subtest: pipe-A-eDP-1 [306.896067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.772s) [306.905286] Starting dynamic subtest: pipe-B-eDP-1 [308.334487] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s) [308.342548] Starting dynamic subtest: pipe-C-eDP-1 [309.720456] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s) [309.728753] Starting dynamic subtest: pipe-D-eDP-1 [311.047907] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s) [311.050278] Subtest legacy-gamma: SUCCESS (4.921s) [311.907341] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [311.908614] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true [311.912934] [025/133] (708s left) perf (gen12-mi-rpc) [312.065671] Starting subtest: gen12-mi-rpc [312.067880] Starting dynamic subtest: rcs0 [312.090677] Dynamic subtest rcs0: SUCCESS (0.024s) [312.093012] Subtest gen12-mi-rpc: SUCCESS (0.026s) [312.143067] [026/133] (708s left) syncobj_timeline (invalid-wait-bad-flags) [312.243611] Starting subtest: invalid-wait-bad-flags [312.245870] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [312.332200] [027/133] (708s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [312.455785] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [312.460258] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [312.632176] [028/133] (708s left) gem_eio (kms) [312.832949] Starting subtest: kms [329.368796] Subtest kms: SUCCESS (16.534s) [330.777330] [029/133] (690s left) gem_exec_fence (long-history) [331.198066] Starting subtest: long-history [337.665095] Subtest long-history: SUCCESS (6.468s) [338.166911] [030/133] (682s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [338.271743] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [338.275878] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [338.373065] [031/133] (682s left) gem_render_copy (y-tiled) [338.442068] Starting subtest: y-tiled [338.446634] Subtest y-tiled: SKIP (0.000s) [338.625186] [032/133] (682s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [338.717382] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [338.719727] Starting dynamic subtest: pipe-A-default-mode [339.833054] Dynamic subtest pipe-A-default-mode: SKIP (1.114s) [339.837570] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.115s) [339.979705] [033/133] (681s left) sw_sync (sync_multi_consumer) [340.020345] Starting subtest: sync_multi_consumer [340.447058] Subtest sync_multi_consumer: SUCCESS (0.426s) [340.508220] [034/133] (680s left) gem_exec_schedule (noreorder-priority) [340.697801] Starting subtest: noreorder-priority [340.700134] Starting dynamic subtest: rcs0 [341.828135] Dynamic subtest rcs0: SUCCESS (1.129s) [341.840138] Starting dynamic subtest: vcs0 [343.836210] Dynamic subtest vcs0: SUCCESS (2.005s) [343.848554] Starting dynamic subtest: vcs1 [346.882919] Dynamic subtest vcs1: SUCCESS (3.045s) [346.893995] Starting dynamic subtest: vecs0 [348.884876] Dynamic subtest vecs0: SUCCESS (2.000s) [348.896801] Starting dynamic subtest: ccs0 [350.028056] Dynamic subtest ccs0: SUCCESS (1.142s) [350.030918] Subtest noreorder-priority: SUCCESS (9.331s) [350.223304] [035/133] (670s left) gem_tiled_fence_blits (basic) [350.301266] Subtest basic: SKIP (0.000s) [350.363963] [036/133] (670s left) i915_pm_rpm (gem-execbuf-stress) [352.022828] Starting subtest: gem-execbuf-stress [352.025632] Starting dynamic subtest: smem0 [364.838675] Dynamic subtest smem0: SUCCESS (12.818s) [364.850971] Starting dynamic subtest: extra-wait-smem0 [426.697277] Dynamic subtest extra-wait-smem0: SUCCESS (61.854s) [426.700021] Subtest gem-execbuf-stress: SUCCESS (74.677s) [427.069544] [037/133] (594s left) kms_addfb_basic (basic-y-tiled-legacy) [427.121896] Starting subtest: basic-y-tiled-legacy [427.126066] Subtest basic-y-tiled-legacy: SKIP (0.000s) [427.259166] [038/133] (593s left) kms_concurrent (multi-plane-atomic-lowres) [427.359015] Starting subtest: multi-plane-atomic-lowres [427.361307] Starting dynamic subtest: pipe-A-eDP-1 [427.885809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.526s) [427.895663] Starting dynamic subtest: pipe-B-eDP-1 [429.097169] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s) [429.107600] Starting dynamic subtest: pipe-C-eDP-1 [430.345377] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s) [430.356061] Starting dynamic subtest: pipe-D-eDP-1 [431.545040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s) [431.547457] Subtest multi-plane-atomic-lowres: SUCCESS (4.186s) [432.398418] [039/133] (588s left) gem_exec_balancer (bonded-true-hang) [432.667327] Starting subtest: bonded-true-hang [432.672792] Subtest bonded-true-hang: SKIP (0.000s) [432.773926] [040/133] (588s left) prime_self_import (basic-with_two_bos) [432.813650] Starting subtest: basic-with_two_bos [432.831016] Subtest basic-with_two_bos: SUCCESS (0.018s) [432.952765] [041/133] (588s left) gem_partial_pwrite_pread (reads) [433.018306] Subtest reads: SKIP (0.000s) [433.092544] [042/133] (588s left) syncobj_wait (invalid-multi-wait-unsubmitted) [433.160435] Starting subtest: invalid-multi-wait-unsubmitted [433.162880] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [433.265540] [043/133] (588s left) sysfs_timeslice_duration (idempotent) [433.324439] Starting subtest: idempotent [433.326911] Starting dynamic subtest: vecs0 [433.329319] Dynamic subtest vecs0: SUCCESS (0.000s) [433.339790] Starting dynamic subtest: ccs0 [433.342044] Dynamic subtest ccs0: SUCCESS (0.000s) [433.350870] Starting dynamic subtest: vcs0 [433.353110] Dynamic subtest vcs0: SUCCESS (0.000s) [433.361974] Starting dynamic subtest: bcs0 [433.364332] Dynamic subtest bcs0: SUCCESS (0.000s) [433.375837] Starting dynamic subtest: rcs0 [433.377888] Dynamic subtest rcs0: SUCCESS (0.000s) [433.386940] Starting dynamic subtest: vcs1 [433.389411] Dynamic subtest vcs1: SUCCESS (0.000s) [433.391703] Subtest idempotent: SUCCESS (0.005s) [433.431446] [044/133] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [433.528394] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [433.532399] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [433.640356] [045/133] (587s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [433.735186] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [440.793056] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.061s) [440.922297] [046/133] (580s left) kms_vblank (query-busy) [441.019513] Starting subtest: query-busy [441.021805] Starting dynamic subtest: pipe-A-eDP-1 [442.895591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [442.913749] Starting dynamic subtest: pipe-D-eDP-1 [445.487104] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s) [445.489071] Subtest query-busy: SUCCESS (4.466s) [446.295335] [047/133] (575s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [446.362192] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [446.364469] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [446.458732] [048/133] (575s left) gem_render_copy (y-tiled-to-vebox-linear) [446.526477] Starting subtest: y-tiled-to-vebox-linear [446.531171] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [446.713445] [049/133] (575s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [446.823492] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [446.827873] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [446.929050] [050/133] (574s left) perf_pmu (interrupts) [446.975053] Starting subtest: interrupts [448.072405] Subtest interrupts: SUCCESS (1.097s) [448.188640] [051/133] (573s left) gem_mmap (basic) [448.243702] Subtest basic: SKIP (0.000s) [448.302997] [052/133] (573s left) syncobj_timeline (single-wait-all-available-submitted) [448.357527] Starting subtest: single-wait-all-available-submitted [448.359516] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [448.472185] [053/133] (573s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [450.096964] Starting subtest: modeset-lpsp-stress-no-wait [460.175839] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.082s) [460.299536] [054/133] (561s left) gem_exec_reloc (basic-wc-gtt-noreloc) [460.366903] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [460.464459] [055/133] (561s left) gem_exec_fence (syncobj-unused-fence) [460.891734] Starting subtest: syncobj-unused-fence [460.894187] Subtest syncobj-unused-fence: SUCCESS (0.005s) [461.972797] [056/133] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [462.077630] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [462.082038] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [462.184500] [057/133] (559s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [462.293371] Starting subtest: yf-tiled-16bpp-rotate-270 [462.297750] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [462.405438] [058/133] (559s left) gem_exec_fence (basic-wait) [462.580937] Starting subtest: basic-wait [462.583502] Starting dynamic subtest: rcs0 [462.663994] Dynamic subtest rcs0: SUCCESS (0.085s) [462.675968] Starting dynamic subtest: bcs0 [462.726823] Dynamic subtest bcs0: SUCCESS (0.060s) [462.740364] Starting dynamic subtest: vcs0 [462.784946] Dynamic subtest vcs0: SUCCESS (0.055s) [462.796322] Starting dynamic subtest: vcs1 [462.832260] Dynamic subtest vcs1: SUCCESS (0.047s) [462.847618] Starting dynamic subtest: vecs0 [462.886236] Dynamic subtest vecs0: SUCCESS (0.051s) [462.898063] Starting dynamic subtest: ccs0 [462.944135] Dynamic subtest ccs0: SUCCESS (0.056s) [462.946482] Subtest basic-wait: SUCCESS (0.369s) [465.009086] [059/133] (557s left) prime_mmap_coherency (ioctl-errors) [465.086293] Starting subtest: ioctl-errors [482.647217] Subtest ioctl-errors: SUCCESS (17.564s) [482.828950] [060/133] (539s left) kms_busy (basic) [482.973084] Starting subtest: basic [482.975039] Starting dynamic subtest: flip [483.589462] Dynamic subtest flip: SUCCESS (0.614s) [483.604290] Starting dynamic subtest: modeset [487.066374] Dynamic subtest modeset: SUCCESS (3.478s) [487.068638] Subtest basic: SUCCESS (4.094s) [487.869548] [061/133] (534s left) gem_exec_store (cachelines) [487.926860] Starting subtest: cachelines [487.929071] Starting dynamic subtest: rcs0 [487.986207] Dynamic subtest rcs0: SUCCESS (0.062s) [487.996671] Starting dynamic subtest: bcs0 [488.049421] Dynamic subtest bcs0: SUCCESS (0.061s) [488.060932] Starting dynamic subtest: vcs0 [488.105916] Dynamic subtest vcs0: SUCCESS (0.054s) [488.117962] Starting dynamic subtest: vcs1 [488.160255] Dynamic subtest vcs1: SUCCESS (0.053s) [488.171917] Starting dynamic subtest: vecs0 [488.224740] Dynamic subtest vecs0: SUCCESS (0.063s) [488.236209] Starting dynamic subtest: ccs0 [488.281292] Dynamic subtest ccs0: SUCCESS (0.055s) [488.283540] Subtest cachelines: SUCCESS (0.359s) [488.481425] [062/133] (533s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [488.578413] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [489.556932] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s) [489.672291] [063/133] (532s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [489.762044] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [489.764273] Starting dynamic subtest: pipe-A-eDP-1 [489.786635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [489.799063] Starting dynamic subtest: pipe-B-eDP-1 [489.820105] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [489.829533] Starting dynamic subtest: pipe-C-eDP-1 [489.848239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [489.857813] Starting dynamic subtest: pipe-D-eDP-1 [489.877498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [489.880903] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s) [492.015369] [064/133] (530s left) prime_busy (hang-wait) [492.086126] Starting subtest: hang-wait [492.088438] Starting dynamic subtest: rcs0 [518.391529] Dynamic subtest rcs0: SUCCESS (26.302s) [518.401369] Starting dynamic subtest: bcs0 [525.546583] Dynamic subtest bcs0: SUCCESS (7.150s) [525.558048] Starting dynamic subtest: vcs0 [532.520337] Dynamic subtest vcs0: SUCCESS (6.973s) [532.531836] Starting dynamic subtest: vcs1 [539.496247] Dynamic subtest vcs1: SUCCESS (6.977s) [539.508943] Starting dynamic subtest: vecs0 [546.532863] Dynamic subtest vecs0: SUCCESS (7.032s) [546.542681] Starting dynamic subtest: ccs0 [560.437874] Dynamic subtest ccs0: SUCCESS (13.902s) [560.440400] Subtest hang-wait: SUCCESS (68.347s) [560.559149] [065/133] (461s left) kms_flip (flip-vs-panning-vs-hang) [560.665087] Starting subtest: flip-vs-panning-vs-hang [560.667023] Starting dynamic subtest: A-eDP1 [600.384692] Dynamic subtest A-eDP1: SUCCESS (39.721s) [600.396411] Starting dynamic subtest: D-eDP1 [650.371035] Dynamic subtest D-eDP1: SUCCESS (49.984s) [650.376865] Subtest flip-vs-panning-vs-hang: SUCCESS (89.710s) [651.599200] [066/133] (370s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [651.696871] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [651.699184] Starting dynamic subtest: pipe-A-eDP-1 [651.998941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.267s) [652.018922] Starting dynamic subtest: pipe-B-eDP-1 [653.278100] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.279s) [653.290290] Starting dynamic subtest: pipe-C-eDP-1 [654.478265] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s) [654.490156] Starting dynamic subtest: pipe-D-eDP-1 [655.693582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s) [655.695919] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.965s) [656.817590] [067/133] (365s left) gem_set_tiling_vs_blt (tiled-to-tiled) [656.888969] Subtest tiled-to-tiled: SKIP (0.000s) [656.969433] [068/133] (365s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [657.066974] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [657.071183] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [657.142296] [069/133] (365s left) gem_ctx_isolation (clean) [657.199067] Starting subtest: clean [657.201584] Starting dynamic subtest: rcs0 [657.245586] Dynamic subtest rcs0: SUCCESS (0.049s) [657.255813] Starting dynamic subtest: bcs0 [657.304327] Dynamic subtest bcs0: SUCCESS (0.057s) [657.315820] Starting dynamic subtest: vcs0 [657.372910] Dynamic subtest vcs0: SUCCESS (0.068s) [657.383643] Starting dynamic subtest: vcs1 [658.900697] Dynamic subtest vcs1: SUCCESS (1.526s) [658.910910] Starting dynamic subtest: vecs0 [660.900921] Dynamic subtest vecs0: SUCCESS (1.999s) [660.911771] Starting dynamic subtest: ccs0 [662.940208] Dynamic subtest ccs0: SUCCESS (2.038s) [662.942713] Subtest clean: SUCCESS (5.744s) [663.168092] [070/133] (359s left) perf_pmu (init-sema) [663.207863] Starting subtest: init-sema [663.210129] Starting dynamic subtest: rcs0 [663.212414] Dynamic subtest rcs0: SUCCESS (0.002s) [663.224279] Starting dynamic subtest: bcs0 [663.226517] Dynamic subtest bcs0: SUCCESS (0.000s) [663.236648] Starting dynamic subtest: vcs0 [663.238507] Dynamic subtest vcs0: SUCCESS (0.001s) [663.248271] Starting dynamic subtest: vcs1 [663.250400] Dynamic subtest vcs1: SUCCESS (0.002s) [663.260215] Starting dynamic subtest: vecs0 [663.262059] Dynamic subtest vecs0: SUCCESS (0.001s) [663.271482] Starting dynamic subtest: ccs0 [663.273627] Dynamic subtest ccs0: SUCCESS (0.001s) [663.275791] Subtest init-sema: SUCCESS (0.018s) [663.334454] [071/133] (359s left) kms_force_connector_basic (prune-stale-modes) [663.411148] Starting subtest: prune-stale-modes [663.806249] Subtest prune-stale-modes: SUCCESS (0.398s) [663.948287] [072/133] (358s left) gem_fenced_exec_thrash (no-spare-fences-busy) [664.004542] Subtest no-spare-fences-busy: SKIP (0.000s) [664.070986] [073/133] (358s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [664.155180] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [664.158994] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [665.242584] [074/133] (357s left) i915_pm_freq_api (freq-suspend) [665.303902] Starting subtest: freq-suspend [665.305806] Starting dynamic subtest: gt0 [681.118058] Dynamic subtest gt0: SUCCESS (2.144s) [681.134298] Starting dynamic subtest: gt1 [697.139177] Dynamic subtest gt1: SUCCESS (1.236s) [697.141176] Subtest freq-suspend: SUCCESS (3.385s) [698.240641] [075/133] (325s left) kms_cursor_edge_walk (256x256-top-bottom) [698.344966] Starting subtest: 256x256-top-bottom [698.347221] Starting dynamic subtest: pipe-A-eDP-1 [701.784612] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s) [701.797354] Starting dynamic subtest: pipe-D-eDP-1 [704.974580] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.178s) [704.976569] Subtest 256x256-top-bottom: SUCCESS (6.610s) [705.834667] [076/133] (318s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [705.946840] Starting subtest: psr-rgb565-draw-pwrite [712.928834] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.976s) [713.044237] [077/133] (310s left) kms_cursor_crc (cursor-rapid-movement-64x64) [713.221662] Starting subtest: cursor-rapid-movement-64x64 [713.226376] Starting dynamic subtest: pipe-A-eDP-1 [713.757435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s) [713.789974] Starting dynamic subtest: pipe-D-eDP-1 [714.935196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.153s) [714.937129] Subtest cursor-rapid-movement-64x64: SUCCESS (1.709s) [715.748676] [078/133] (308s left) gem_ctx_persistence (legacy-engines-queued) [715.803868] Starting subtest: legacy-engines-queued [715.806211] Starting dynamic subtest: render [715.883471] Dynamic subtest render: SUCCESS (0.079s) [715.897400] Starting dynamic subtest: bsd1 [717.327261] Dynamic subtest bsd1: SUCCESS (1.438s) [717.341649] Starting dynamic subtest: bsd2 [719.307680] Dynamic subtest bsd2: SUCCESS (1.975s) [719.321840] Starting dynamic subtest: blt [719.360811] Dynamic subtest blt: SUCCESS (0.051s) [719.373529] Starting dynamic subtest: vebox [721.291768] Dynamic subtest vebox: SUCCESS (1.926s) [721.294906] Subtest legacy-engines-queued: SUCCESS (5.485s) [721.376809] [079/133] (302s left) kms_flip (2x-flip-vs-fences-interruptible) [721.467104] Starting subtest: 2x-flip-vs-fences-interruptible [721.471123] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [721.560095] [080/133] (302s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [721.660271] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [721.662561] Starting dynamic subtest: pipe-A-eDP-1 [721.756778] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [721.771179] Starting dynamic subtest: pipe-B-eDP-1 [722.903278] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s) [722.907583] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.245s) [724.165507] [081/133] (300s left) syncobj_timeline (etime-multi-wait-submitted) [724.221183] Starting subtest: etime-multi-wait-submitted [724.329803] Subtest etime-multi-wait-submitted: SUCCESS (0.108s) [724.420026] [082/133] (299s left) gem_render_copy (linear-to-vebox-yf-tiled) [724.485115] Starting subtest: linear-to-vebox-yf-tiled [724.489713] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [724.698884] [083/133] (299s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [724.795085] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [724.797012] Starting dynamic subtest: pipe-A-eDP-1 [724.821158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.025s) [724.838218] Starting dynamic subtest: pipe-B-eDP-1 [724.858333] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s) [724.869598] Starting dynamic subtest: pipe-C-eDP-1 [724.889116] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [724.900486] Starting dynamic subtest: pipe-D-eDP-1 [724.919919] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [724.922124] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.101s) [727.169356] [084/133] (297s left) kms_psr (psr-cursor-render) [727.262707] Starting subtest: psr-cursor-render [727.264966] Starting dynamic subtest: eDP-1 [729.020269] Dynamic subtest eDP-1: SUCCESS (1.758s) [729.022591] Subtest psr-cursor-render: SUCCESS (1.759s) [729.856029] [085/133] (294s left) kms_atomic (atomic-invalid-params) [729.951621] Starting subtest: atomic-invalid-params [729.953954] Starting dynamic subtest: pipe-A-eDP-1 [730.340740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s) [730.343012] Subtest atomic-invalid-params: SUCCESS (0.389s) [731.155548] [086/133] (293s left) gem_exec_schedule (semaphore-power) [731.337365] Subtest semaphore-power: SKIP (0.000s) [731.529697] [087/133] (292s left) api_intel_allocator (default-alignment) [731.579250] Starting subtest: default-alignment [731.581615] Subtest default-alignment: SUCCESS (0.003s) [731.696176] [088/133] (292s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [731.809516] Starting subtest: yf-tiled-32bpp-rotate-90 [731.813739] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [731.909878] [089/133] (292s left) gem_mmap_wc (copy) [731.966505] Subtest copy: SKIP (0.000s) [732.037524] [090/133] (292s left) gem_exec_whisper (basic-queues-forked-all) [732.109314] Starting subtest: basic-queues-forked-all [751.520731] Subtest basic-queues-forked-all: SUCCESS (19.413s) [751.701346] [091/133] (272s left) kms_plane_scaling (intel-max-src-size) [751.794810] Starting subtest: intel-max-src-size [751.801401] Subtest intel-max-src-size: SKIP (0.000s) [751.886618] [092/133] (272s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [751.979776] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [759.041824] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.065s) [759.183724] [093/133] (265s left) kms_psr (fbc-psr2-sprite-render) [759.273709] Starting subtest: fbc-psr2-sprite-render [759.275989] Starting dynamic subtest: eDP-1 [759.280130] Dynamic subtest eDP-1: SKIP (0.000s) [759.284384] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [759.355684] [094/133] (265s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [759.462285] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [759.466760] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [759.570475] [095/133] (265s left) gem_pread (self) [759.626478] Subtest self: SKIP (0.000s) [759.690476] [096/133] (265s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [759.788586] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [759.792516] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [759.894576] [097/133] (264s left) kms_prop_blob (invalid-set-prop) [759.948525] Starting subtest: invalid-set-prop [759.950675] Subtest invalid-set-prop: SUCCESS (0.000s) [760.051902] [098/133] (264s left) fbdev (unaligned-write) [760.101055] Starting subtest: unaligned-write [760.260627] Subtest unaligned-write: SUCCESS (0.159s) [760.327995] [099/133] (264s left) kms_plane (pixel-format-x-tiled-modifier) [760.412897] Starting subtest: pixel-format-x-tiled-modifier [760.440427] Starting dynamic subtest: pipe-A-plane-0 [761.095863] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s) [761.107667] Starting dynamic subtest: pipe-A-plane-3 [761.506160] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s) [761.517994] Starting dynamic subtest: pipe-A-plane-5 [761.523591] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [762.608378] Starting dynamic subtest: pipe-B-plane-0 [763.287790] Dynamic subtest pipe-B-plane-0: SUCCESS (0.688s) [763.299686] Starting dynamic subtest: pipe-B-plane-3 [763.731950] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [763.745941] Starting dynamic subtest: pipe-B-plane-5 [763.749549] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [764.049598] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.637s) [764.846224] [100/133] (260s left) gem_exec_reloc (basic-wc-cpu-noreloc) [764.919735] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [764.994054] [101/133] (260s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [765.103014] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [768.831825] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.732s) [770.052694] [102/133] (255s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [770.149625] Starting subtest: 2x-wf_vblank-ts-check-interruptible [770.161463] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [770.241108] [103/133] (254s left) core_getversion (all-cards) [770.282104] Starting subtest: all-cards [770.289092] Subtest all-cards: SUCCESS (0.012s) [770.343031] [104/133] (254s left) gem_exec_reloc (basic-wc-read-noreloc) [770.403564] Subtest basic-wc-read-noreloc: SKIP (0.000s) [770.475222] [105/133] (254s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [770.581169] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [770.585613] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [770.681864] [106/133] (254s left) kms_big_fb (x-tiled-16bpp-rotate-90) [770.784928] Starting subtest: x-tiled-16bpp-rotate-90 [770.807243] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s) [770.922556] [107/133] (254s left) kms_feature_discovery (display-1x) [771.019198] Starting subtest: display-1x [771.021007] Subtest display-1x: SUCCESS (0.000s) [771.109354] [108/133] (254s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [771.232183] Starting subtest: cursorA-vs-flipB-varying-size [771.235838] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [771.380421] [109/133] (254s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [771.481935] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [771.485538] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [771.571368] [110/133] (253s left) kms_psr2_su (page_flip-xrgb8888) [771.620577] Subtest page_flip-XRGB8888: SKIP (0.000s) [771.684296] [111/133] (253s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [771.778931] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [771.782287] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [771.902705] [112/133] (253s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [772.003045] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [776.446196] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.444s) [777.577551] [113/133] (248s left) i915_drm_fdinfo (isolation) [777.624016] Starting subtest: isolation [777.626305] Starting dynamic subtest: rcs0 [777.641998] Dynamic subtest rcs0: SKIP (0.016s) [777.654960] Starting dynamic subtest: bcs0 [777.659483] Dynamic subtest bcs0: SKIP (0.000s) [777.670825] Starting dynamic subtest: vcs0 [777.675279] Dynamic subtest vcs0: SKIP (0.000s) [777.686025] Starting dynamic subtest: vcs1 [777.690516] Dynamic subtest vcs1: SKIP (0.000s) [777.701492] Starting dynamic subtest: vecs0 [777.705938] Dynamic subtest vecs0: SKIP (0.000s) [777.716519] Starting dynamic subtest: ccs0 [777.721542] Dynamic subtest ccs0: SKIP (0.000s) [777.726255] Subtest isolation: SKIP (0.022s) [777.767943] [114/133] (247s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [777.860954] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [777.865421] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [777.950236] [115/133] (247s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [778.047516] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [782.463801] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.419s) [783.662074] [116/133] (242s left) kms_big_fb (4-tiled-addfb) [783.775767] Starting subtest: 4-tiled-addfb [783.778618] Subtest 4-tiled-addfb: SUCCESS (0.000s) [783.888013] [117/133] (241s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [783.985456] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [783.989856] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [784.108106] [118/133] (241s left) kms_cursor_crc (cursor-offscreen-512x512) [784.382804] Starting subtest: cursor-offscreen-512x512 [784.387227] Subtest cursor-offscreen-512x512: SKIP (0.001s) [784.549308] [119/133] (241s left) gem_mmap (bad-size) [784.605633] Subtest bad-size: SKIP (0.000s) [784.671028] [120/133] (241s left) gem_mmap_offset (blt-coherency) [784.726607] Starting subtest: blt-coherency [784.731568] Subtest blt-coherency: SUCCESS (0.007s) [784.872657] [121/133] (241s left) api_intel_bb (simple-bb-ctx) [784.926741] Starting subtest: simple-bb-ctx [784.934536] Subtest simple-bb-ctx: SUCCESS (0.010s) [785.050038] [122/133] (240s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [785.152867] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [785.156145] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [785.256164] [123/133] (240s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [785.359074] Starting subtest: switch-modeset-ultra-joiner-big-joiner [785.362307] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [785.425834] [124/133] (240s left) kms_psr (fbc-pr-sprite-mmap-gtt) [785.520286] Starting subtest: fbc-pr-sprite-mmap-gtt [785.523808] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [785.596476] [125/133] (240s left) kms_psr (pr-primary-mmap-gtt) [785.703294] Starting subtest: pr-primary-mmap-gtt [785.706964] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [785.782814] [126/133] (240s left) kms_pipe_crc_basic (suspend-read-crc) [785.868994] Starting subtest: suspend-read-crc [785.870818] Starting dynamic subtest: pipe-A-eDP-1 [804.030090] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.526s) [804.046749] Starting dynamic subtest: pipe-B-eDP-1 [822.056328] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.150s) [822.068030] Starting dynamic subtest: pipe-C-eDP-1 [840.006630] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.094s) [840.018068] Starting dynamic subtest: pipe-D-eDP-1 [857.994440] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.030s) [857.996758] Subtest suspend-read-crc: SUCCESS (11.806s) [858.827221] [127/133] (167s left) kms_chamelium_hpd (hdmi-hpd-storm) [859.224383] Subtest hdmi-hpd-storm: SKIP (0.000s) [860.014765] [128/133] (166s left) gem_wait (write-busy) [860.091442] Starting subtest: write-busy [860.093909] Starting dynamic subtest: all-engines [860.696124] Dynamic subtest all-engines: SUCCESS (0.603s) [860.710524] Starting dynamic subtest: rcs0 [861.260275] Dynamic subtest rcs0: SUCCESS (0.561s) [861.280408] Starting dynamic subtest: bcs0 [861.812167] Dynamic subtest bcs0: SUCCESS (0.551s) [861.830956] Starting dynamic subtest: vcs0 [863.675453] Dynamic subtest vcs0: SUCCESS (1.858s) [863.693899] Starting dynamic subtest: vcs1 [865.659311] Dynamic subtest vcs1: SUCCESS (1.979s) [865.678654] Starting dynamic subtest: vecs0 [867.644079] Dynamic subtest vecs0: SUCCESS (1.980s) [867.672685] Starting dynamic subtest: ccs0 [868.196254] Dynamic subtest ccs0: SUCCESS (0.551s) [868.198978] Subtest write-busy: SUCCESS (8.096s) [868.394635] [129/133] (157s left) gem_userptr_blits (relocations) [868.462278] Starting subtest: relocations [868.466774] Subtest relocations: SKIP (0.000s) [868.579879] [130/133] (157s left) gem_eio (wait-immediate) [868.791530] Starting subtest: wait-immediate [869.146059] Subtest wait-immediate: SUCCESS (0.354s) [869.282182] [131/133] (157s left) gem_userptr_blits (create-destroy-unsync) [869.345265] Subtest create-destroy-unsync: SKIP (0.000s) [869.472692] [132/133] (156s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [869.569791] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [876.932350] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.360s) [877.058239] [133/133] (149s left) gem_exec_reloc (basic-wc) [877.120094] Subtest basic-wc: SKIP (0.000s) [877.192137] Closing watchdogs results: parsing output: 0/ for test: vgem_basic results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: kms_invalid_mode results: parsing output: 4/ for test: kms_pm_backlight results: parsing output: 5/ for test: kms_flip results: parsing output: 6/ for test: gem_mmap_gtt results: parsing output: 7/ for test: gem_softpin results: parsing output: 8/ for test: gem_render_linear_blits results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_chamelium_edid results: parsing output: 12/ for test: gen7_exec_parse results: parsing output: 13/ for test: syncobj_eventfd results: parsing output: 14/ for test: gem_ctx_exec results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: kms_vblank results: parsing output: 17/ for test: kms_chamelium_color results: parsing output: 18/ for test: gem_exec_flush results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_plane results: parsing output: 21/ for test: kms_plane_scaling results: parsing output: 22/ for test: i915_selftest results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: perf results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: gem_eio results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: gem_render_copy results: parsing output: 31/ for test: kms_flip_scaled_crc results: parsing output: 32/ for test: sw_sync results: parsing output: 33/ for test: gem_exec_schedule results: parsing output: 34/ for test: gem_tiled_fence_blits results: parsing output: 35/ for test: i915_pm_rpm results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: kms_concurrent results: parsing output: 38/ for test: gem_exec_balancer results: parsing output: 39/ for test: prime_self_import results: parsing output: 40/ for test: gem_partial_pwrite_pread results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: sysfs_timeslice_duration results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_vblank results: parsing output: 46/ for test: syncobj_wait results: parsing output: 47/ for test: gem_render_copy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: perf_pmu results: parsing output: 50/ for test: gem_mmap results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_pm_rpm results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: gem_exec_fence results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: gem_exec_fence results: parsing output: 58/ for test: prime_mmap_coherency results: parsing output: 59/ for test: kms_busy results: parsing output: 60/ for test: gem_exec_store results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: prime_busy results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: gem_set_tiling_vs_blt results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: gem_ctx_isolation results: parsing output: 69/ for test: perf_pmu results: parsing output: 70/ for test: kms_force_connector_basic results: parsing output: 71/ for test: gem_fenced_exec_thrash results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: i915_pm_freq_api results: parsing output: 74/ for test: kms_cursor_edge_walk results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: gem_ctx_persistence results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: kms_psr2_sf results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: gem_render_copy results: parsing output: 82/ for test: kms_ccs results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_atomic results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: api_intel_allocator results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: gem_mmap_wc results: parsing output: 89/ for test: gem_exec_whisper results: parsing output: 90/ for test: kms_plane_scaling results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_pread results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_prop_blob results: parsing output: 97/ for test: fbdev results: parsing output: 98/ for test: kms_plane results: parsing output: 99/ for test: gem_exec_reloc results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: core_getversion results: parsing output: 103/ for test: gem_exec_reloc results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_feature_discovery results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_flip_scaled_crc results: parsing output: 109/ for test: kms_psr2_su results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: i915_drm_fdinfo results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: gem_mmap results: parsing output: 119/ for test: gem_mmap_offset results: parsing output: 120/ for test: api_intel_bb results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_joiner results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_pipe_crc_basic results: parsing output: 126/ for test: kms_chamelium_hpd results: parsing output: 127/ for test: gem_wait results: parsing output: 128/ for test: gem_userptr_blits results: parsing output: 129/ for test: gem_eio results: parsing output: 130/ for test: gem_userptr_blits results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_exec_reloc Done.