[56.592768] Initializing watchdogs [56.592813] /dev/watchdog0 [56.607303] [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] [56.611592] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.613982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.617202] [001/133] (960s left) gem_busy (extended) [56.834732] Starting subtest: extended [56.836958] Starting dynamic subtest: rcs0 [56.923431] Dynamic subtest rcs0: SUCCESS (0.093s) [56.933220] Starting dynamic subtest: bcs0 [56.966795] Dynamic subtest bcs0: SUCCESS (0.043s) [56.976479] Starting dynamic subtest: vcs0 [58.309498] Dynamic subtest vcs0: SUCCESS (1.359s) [58.318700] Starting dynamic subtest: vcs1 [60.291687] Dynamic subtest vcs1: SUCCESS (2.004s) [60.301943] Starting dynamic subtest: vecs0 [62.276472] Dynamic subtest vecs0: SUCCESS (2.000s) [62.289879] Starting dynamic subtest: ccs0 [62.321902] Dynamic subtest ccs0: SUCCESS (0.047s) [62.324241] Subtest extended: SUCCESS (5.553s) [62.563425] [002/133] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [62.652143] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [62.654534] Starting dynamic subtest: pipe-A-eDP-1 [62.678281] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [62.691205] Starting dynamic subtest: pipe-B-eDP-1 [62.712401] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [62.718906] Starting dynamic subtest: pipe-C-eDP-1 [62.741222] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [62.748052] Starting dynamic subtest: pipe-D-eDP-1 [62.769241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [62.773552] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s) [64.884179] [003/133] (952s left) kms_frontbuffer_tracking (psr-2p-rte) [64.985035] Starting subtest: psr-2p-rte [64.989191] Subtest psr-2p-rte: SKIP (0.000s) [65.083460] [004/133] (952s left) syncobj_wait (reset-during-wait-for-submit) [65.134826] Starting subtest: reset-during-wait-for-submit [65.239949] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [65.314212] [005/133] (951s left) gem_fenced_exec_thrash (too-many-fences) [65.362475] Subtest too-many-fences: SKIP (0.000s) [65.416873] [006/133] (951s left) gem_tiled_fence_blits (basic) [65.470148] Subtest basic: SKIP (0.000s) [65.526193] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [65.630689] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [72.978845] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.375s) [73.195694] [008/133] (944s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [73.296969] Starting subtest: psr-rgb101010-draw-render [80.888190] Subtest psr-rgb101010-draw-render: SUCCESS (7.603s) [81.006907] [009/133] (936s left) kms_big_fb (x-tiled-64bpp-rotate-90) [81.110294] Starting subtest: x-tiled-64bpp-rotate-90 [81.132130] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [81.219935] [010/133] (936s left) gem_eio (wait-1us) [81.373126] Starting subtest: wait-1us [81.578602] Subtest wait-1us: SUCCESS (0.206s) [81.732416] [011/133] (935s left) kms_psr (fbc-psr-sprite-mmap-cpu) [81.821933] Starting subtest: fbc-psr-sprite-mmap-cpu [81.823905] Starting dynamic subtest: eDP-1 [81.827434] Dynamic subtest eDP-1: SKIP (0.000s) [81.830825] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [81.891948] [012/133] (935s left) gem_exec_schedule (manyslice) [81.950196] Starting subtest: manyslice [81.951733] Starting dynamic subtest: rcs0 [87.077024] Dynamic subtest rcs0: SUCCESS (5.130s) [87.100162] Starting dynamic subtest: bcs0 [94.219863] Dynamic subtest bcs0: SUCCESS (7.142s) [94.238572] Starting dynamic subtest: vcs0 [100.300535] Dynamic subtest vcs0: SUCCESS (6.080s) [100.314954] Starting dynamic subtest: vcs1 [106.378075] Dynamic subtest vcs1: SUCCESS (6.076s) [106.387060] Starting dynamic subtest: vecs0 [112.455263] Dynamic subtest vecs0: SUCCESS (6.074s) [112.467861] Starting dynamic subtest: ccs0 [118.639560] Dynamic subtest ccs0: SUCCESS (6.186s) [118.642216] Subtest manyslice: SUCCESS (36.693s) [118.941299] [013/133] (898s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [118.999994] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [119.002425] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [119.103714] [014/133] (898s left) gem_exec_schedule (wide) [119.297236] Starting subtest: wide [119.299780] Starting dynamic subtest: rcs0 [130.343205] Dynamic subtest rcs0: SUCCESS (11.045s) [130.355515] Starting dynamic subtest: vcs0 [142.695299] Dynamic subtest vcs0: SUCCESS (12.352s) [142.706048] Starting dynamic subtest: vcs1 [154.113694] Dynamic subtest vcs1: SUCCESS (11.419s) [154.124934] Starting dynamic subtest: vecs0 [165.947781] Dynamic subtest vecs0: SUCCESS (11.831s) [165.957279] Starting dynamic subtest: ccs0 [180.692258] Dynamic subtest ccs0: SUCCESS (14.743s) [180.694731] Subtest wide: SUCCESS (61.392s) [182.226961] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true [182.230062] [015/133] (835s left) kms_addfb_basic (small-bo) [182.329666] Starting subtest: small-bo [182.331590] Subtest small-bo: SUCCESS (0.000s) [182.437400] [016/133] (835s left) gem_exec_balancer (full-late) [182.508031] Starting subtest: full-late [187.154795] Subtest full-late: SUCCESS (4.646s) [187.481767] [017/133] (830s left) kms_pm_backlight (brightness-with-dpms) [187.573143] Starting subtest: brightness-with-dpms [187.653161] Starting dynamic subtest: eDP-1 [190.108773] Dynamic subtest eDP-1: SUCCESS (2.454s) [190.111076] Subtest brightness-with-dpms: SUCCESS (2.537s) [190.959823] [018/133] (826s left) api_intel_allocator (fork-simple-once) [191.034266] Starting subtest: fork-simple-once [191.049421] Subtest fork-simple-once: SUCCESS (0.017s) [191.160439] [019/133] (826s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [191.252889] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [191.257039] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [191.329883] [020/133] (826s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [191.430014] Starting subtest: psr2-plane-move-sf-dmg-area [191.432258] Starting dynamic subtest: pipe-A-eDP-1 [196.006342] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.577s) [196.015643] Starting dynamic subtest: pipe-B-eDP-1 [201.370663] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.364s) [201.373019] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.943s) [202.241551] [021/133] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [202.336030] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [205.922875] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.591s) [207.036342] [022/133] (810s left) kms_frontbuffer_tracking (fbc-2p-rte) [207.135033] Starting subtest: fbc-2p-rte [207.139192] Subtest fbc-2p-rte: SKIP (0.000s) [207.244969] [023/133] (810s left) gem_exec_reloc (basic-cpu-wc) [207.303525] Subtest basic-cpu-wc: SKIP (0.000s) [207.357738] [024/133] (810s left) gem_tiled_blits (normal) [207.408031] Subtest normal: SKIP (0.000s) [207.475704] [025/133] (810s left) syncobj_timeline (wait-all-for-submit-complex) [207.521825] Starting subtest: wait-all-for-submit-complex [207.735795] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [207.823501] [026/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [207.911368] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [207.915482] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [208.007636] [027/133] (810s left) kms_dsc (dsc-with-output-formats-with-bpc) [208.090742] Starting subtest: dsc-with-output-formats-with-bpc [208.147532] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s) [208.189572] [028/133] (810s left) gem_exec_flush (basic-wb-rw-default) [208.257905] Starting subtest: basic-wb-rw-default [213.708448] Subtest basic-wb-rw-default: SUCCESS (5.451s) [213.905709] [029/133] (804s left) kms_joiner (basic-big-joiner) [214.002661] Starting subtest: basic-big-joiner [214.007112] Subtest basic-big-joiner: SKIP (0.000s) [214.069734] [030/133] (804s left) perf_pmu (render-node-busy-idle) [214.138783] Starting subtest: render-node-busy-idle [214.141294] Starting dynamic subtest: rcs0 [214.838335] Dynamic subtest rcs0: SUCCESS (0.699s) [214.850359] Starting dynamic subtest: bcs0 [215.507555] Dynamic subtest bcs0: SUCCESS (0.669s) [215.519432] Starting dynamic subtest: vcs0 [217.284253] Dynamic subtest vcs0: SUCCESS (1.773s) [217.296622] Starting dynamic subtest: vcs1 [219.333031] Dynamic subtest vcs1: SUCCESS (2.047s) [219.345762] Starting dynamic subtest: vecs0 [221.316097] Dynamic subtest vecs0: SUCCESS (1.981s) [221.328212] Starting dynamic subtest: ccs0 [221.983087] Dynamic subtest ccs0: SUCCESS (0.667s) [221.985537] Subtest render-node-busy-idle: SUCCESS (7.845s) [222.057551] [031/133] (796s left) kms_addfb_basic (invalid-get-prop) [222.109693] Starting subtest: invalid-get-prop [222.112266] Subtest invalid-get-prop: SUCCESS (0.000s) [222.251289] [032/133] (796s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [222.348574] Starting subtest: fbc-2p-primscrn-spr-indfb-move [222.352653] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [222.439013] [033/133] (795s left) i915_pm_rps (thresholds) [222.492366] Starting subtest: thresholds [222.496856] Subtest thresholds: SKIP (0.001s) [222.592194] [034/133] (795s left) gem_mmap_wc (bad-offset) [222.649426] Subtest bad-offset: SKIP (0.000s) [222.715917] [035/133] (795s left) kms_rotation_crc (multiplane-rotation) [222.819832] Starting subtest: multiplane-rotation [240.288997] Subtest multiplane-rotation: SUCCESS (17.471s) [240.391428] [036/133] (778s left) gem_softpin (evict-prime-sanity-check) [240.450352] Starting subtest: evict-prime-sanity-check [240.452369] Starting dynamic subtest: rcs0 [241.596888] Dynamic subtest rcs0: SUCCESS (1.144s) [241.606442] Starting dynamic subtest: bcs0 [242.708564] Dynamic subtest bcs0: SUCCESS (1.111s) [242.719061] Starting dynamic subtest: vcs0 [244.284445] Dynamic subtest vcs0: SUCCESS (1.573s) [244.295602] Starting dynamic subtest: vcs1 [246.276497] Dynamic subtest vcs1: SUCCESS (1.990s) [246.287294] Starting dynamic subtest: vecs0 [248.325586] Dynamic subtest vecs0: SUCCESS (2.047s) [248.336466] Starting dynamic subtest: ccs0 [249.444672] Dynamic subtest ccs0: SUCCESS (1.119s) [249.455455] Starting dynamic subtest: all [250.566612] Dynamic subtest all: SUCCESS (1.121s) [250.568842] Subtest evict-prime-sanity-check: SUCCESS (10.116s) [250.645356] [037/133] (767s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [250.748094] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [250.752251] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [250.818228] [038/133] (767s left) kms_flip (flip-vs-expired-vblank-interruptible) [250.910079] Starting subtest: flip-vs-expired-vblank-interruptible [250.912380] Starting dynamic subtest: A-eDP1 [259.540509] Dynamic subtest A-eDP1: SUCCESS (8.630s) [259.550517] Starting dynamic subtest: B-eDP1 [268.168218] Dynamic subtest B-eDP1: SUCCESS (8.625s) [268.179709] Starting dynamic subtest: C-eDP1 [276.787863] Dynamic subtest C-eDP1: SUCCESS (8.616s) [276.797875] Starting dynamic subtest: D-eDP1 [285.420380] Dynamic subtest D-eDP1: SUCCESS (8.634s) [285.422865] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.514s) [286.622895] [039/133] (732s left) gem_ctx_shared (disjoint-timelines) [286.686652] Starting subtest: disjoint-timelines [286.721970] Subtest disjoint-timelines: SUCCESS (0.035s) [286.969669] [040/133] (731s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [287.058551] Starting subtest: fbcpsr-rgb101010-draw-render [293.843663] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.788s) [293.991895] [041/133] (724s left) gem_exec_parallel (fds) [294.044105] Starting subtest: fds [294.046361] Starting dynamic subtest: rcs0 [297.543857] Dynamic subtest rcs0: SUCCESS (3.497s) [297.560311] Starting dynamic subtest: bcs0 [301.501801] Dynamic subtest bcs0: SUCCESS (3.956s) [301.511299] Starting dynamic subtest: vcs0 [305.580513] Dynamic subtest vcs0: SUCCESS (4.077s) [305.592691] Starting dynamic subtest: vcs1 [309.521373] Dynamic subtest vcs1: SUCCESS (3.939s) [309.533094] Starting dynamic subtest: vecs0 [313.579741] Dynamic subtest vecs0: SUCCESS (4.056s) [313.592698] Starting dynamic subtest: ccs0 [317.676562] Dynamic subtest ccs0: SUCCESS (4.094s) [317.679446] Subtest fds: SUCCESS (23.632s) [317.886013] [042/133] (700s left) gem_readwrite (new-obj) [317.946203] Subtest new-obj: SKIP (0.000s) [318.013679] [043/133] (700s left) gem_mmap_wc (fault-concurrent) [318.072281] Subtest fault-concurrent: SKIP (0.000s) [318.128067] [044/133] (700s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [318.227294] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [319.350815] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.124s) [319.483158] [045/133] (699s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [319.543376] Starting subtest: multi-wait-for-submit-available-signaled [319.545339] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s) [319.626405] [046/133] (699s left) gem_exec_fence (basic-busy-all) [319.688067] Starting subtest: basic-busy-all [319.790821] Subtest basic-busy-all: SUCCESS (0.102s) [321.377758] [047/133] (697s left) gem_lmem_swapping (parallel-random-verify-ccs) [321.418227] Subtest parallel-random-verify-ccs: SKIP (0.000s) [321.463120] [048/133] (697s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [321.554079] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [321.556332] Starting dynamic subtest: pipe-A-eDP-1 [321.578765] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [321.589922] Starting dynamic subtest: pipe-B-eDP-1 [321.611277] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [321.620061] Starting dynamic subtest: pipe-C-eDP-1 [321.641348] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [321.650151] Starting dynamic subtest: pipe-D-eDP-1 [321.672458] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [321.677036] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [323.864390] [049/133] (695s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [323.962686] Starting subtest: pr-plane-move-sf-dmg-area [323.967250] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [324.027642] [050/133] (695s left) kms_psr (fbc-psr2-sprite-blt) [324.113426] Starting subtest: fbc-psr2-sprite-blt [324.115591] Starting dynamic subtest: eDP-1 [324.119794] Dynamic subtest eDP-1: SKIP (0.000s) [324.124156] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [324.196159] [051/133] (694s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [324.292339] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [330.977562] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.688s) [331.114330] [052/133] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [331.218474] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [331.222708] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [331.318505] [053/133] (687s left) gem_eio (wait-10ms) [331.530587] Starting subtest: wait-10ms [331.877161] Subtest wait-10ms: SUCCESS (0.347s) [332.003600] [054/133] (687s left) kms_prime (basic-crc-vgem) [332.080599] Starting subtest: basic-crc-vgem [332.082651] Starting dynamic subtest: second-to-first [333.084379] Dynamic subtest second-to-first: SUCCESS (1.007s) [333.086348] Subtest basic-crc-vgem: SUCCESS (1.007s) [333.177769] [055/133] (686s left) kms_busy (extended-modeset-hang-newfb-with-reset) [333.299933] Starting subtest: extended-modeset-hang-newfb-with-reset [333.301832] Starting dynamic subtest: pipe-A [348.040492] Dynamic subtest pipe-A: SUCCESS (14.739s) [348.050518] Starting dynamic subtest: pipe-D [363.031976] Dynamic subtest pipe-D: SUCCESS (14.988s) [363.034370] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.731s) [363.825495] [056/133] (655s left) kms_hdr (static-swap) [363.922069] Starting subtest: static-swap [363.928202] Subtest static-swap: SKIP (0.000s) [363.996073] [057/133] (655s left) kms_content_protection (type1) [364.128706] Starting subtest: type1 [364.133421] Subtest type1: SKIP (0.000s) [364.245739] [058/133] (655s left) gem_flink_basic (double-flink) [364.293848] Starting subtest: double-flink [364.295685] Subtest double-flink: SUCCESS (0.000s) [364.379513] [059/133] (655s left) gem_tiled_swapping (non-threaded) [364.432314] Subtest non-threaded: SKIP (0.000s) [364.492826] [060/133] (655s left) gem_render_copy (yf-tiled) [364.552054] Starting subtest: yf-tiled [364.556066] Subtest yf-tiled: SKIP (0.000s) [364.733208] [061/133] (654s left) gem_exec_balancer (semaphore) [364.793768] Starting subtest: semaphore [366.265523] Subtest semaphore: SUCCESS (1.470s) [366.602270] [062/133] (653s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [366.668997] Starting subtest: y-tiled-to-vebox-x-tiled [366.673516] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [366.869586] [063/133] (652s left) gem_exec_fence (syncobj-timeline-wait) [367.417884] Starting subtest: syncobj-timeline-wait [368.363060] Subtest syncobj-timeline-wait: SUCCESS (0.945s) [370.404010] [064/133] (649s left) kms_flip (dpms-vs-vblank-race) [370.513448] Starting subtest: dpms-vs-vblank-race [370.515787] Starting dynamic subtest: A-eDP1 [375.508590] Dynamic subtest A-eDP1: SUCCESS (4.994s) [375.519778] Starting dynamic subtest: B-eDP1 [380.150096] Dynamic subtest B-eDP1: SUCCESS (4.638s) [380.161130] Starting dynamic subtest: C-eDP1 [383.661803] Dynamic subtest C-eDP1: SUCCESS (3.511s) [383.673078] Starting dynamic subtest: D-eDP1 [388.301149] Dynamic subtest D-eDP1: SUCCESS (4.637s) [388.303417] Subtest dpms-vs-vblank-race: SUCCESS (17.789s) [389.192903] [065/133] (630s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [389.250695] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [389.351110] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s) [389.427320] [066/133] (630s left) syncobj_timeline (invalid-transfer-bad-pad) [389.495978] Starting subtest: invalid-transfer-bad-pad [389.498036] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [389.609677] [067/133] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [389.702603] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [396.286191] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.586s) [396.446774] [068/133] (623s left) kms_color (ctm-max) [396.530447] Starting subtest: ctm-max [396.532311] Starting dynamic subtest: pipe-A-eDP-1 [397.245601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s) [397.255605] Starting dynamic subtest: pipe-B-eDP-1 [398.627770] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s) [398.638514] Starting dynamic subtest: pipe-C-eDP-1 [400.004995] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s) [400.015229] Starting dynamic subtest: pipe-D-eDP-1 [401.347298] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [401.349277] Subtest ctm-max: SUCCESS (4.817s) [402.168967] [069/133] (617s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [402.268219] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [402.272504] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [402.341670] [070/133] (617s left) gem_eio (hibernate) [402.563482] Starting subtest: hibernate [417.388695] Subtest hibernate: SUCCESS (14.824s) [424.518290] [071/133] (602s left) gem_wait (write-wait) [424.597071] Starting subtest: write-wait [424.599379] Starting dynamic subtest: all-engines [425.694077] Dynamic subtest all-engines: SUCCESS (1.096s) [425.713667] Starting dynamic subtest: rcs0 [426.750265] Dynamic subtest rcs0: SUCCESS (1.054s) [426.770720] Starting dynamic subtest: bcs0 [427.810119] Dynamic subtest bcs0: SUCCESS (1.057s) [427.829445] Starting dynamic subtest: vcs0 [428.863890] Dynamic subtest vcs0: SUCCESS (1.052s) [428.883974] Starting dynamic subtest: vcs1 [429.922422] Dynamic subtest vcs1: SUCCESS (1.055s) [429.942438] Starting dynamic subtest: vecs0 [430.978304] Dynamic subtest vecs0: SUCCESS (1.053s) [430.995623] Starting dynamic subtest: ccs0 [432.036711] Dynamic subtest ccs0: SUCCESS (1.055s) [432.039446] Subtest write-wait: SUCCESS (7.441s) [432.245926] [072/133] (594s left) kms_async_flips (async-flip-dpms) [432.347728] Starting subtest: async-flip-dpms [432.734914] Starting dynamic subtest: pipe-A-eDP-1 [436.504770] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.769s) [436.890852] Starting dynamic subtest: pipe-B-eDP-1 [439.682664] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.803s) [440.076240] Starting dynamic subtest: pipe-C-eDP-1 [442.837401] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s) [443.212928] Starting dynamic subtest: pipe-D-eDP-1 [445.998611] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s) [446.000747] Subtest async-flip-dpms: SUCCESS (13.651s) [447.188116] [073/133] (579s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [447.297169] Starting subtest: primary-yf-tiled-reflect-x-270 [447.301629] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [447.369455] [074/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [447.468049] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [447.472275] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [447.570507] [075/133] (579s left) gem_exec_fence (syncobj-invalid-flags) [447.980124] Starting subtest: syncobj-invalid-flags [447.982654] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [449.367610] [076/133] (577s left) perf (non-zero-reason) [449.496715] Starting subtest: non-zero-reason [449.499617] Starting dynamic subtest: 0-rcs0 [454.815054] Dynamic subtest 0-rcs0: SUCCESS (5.317s) [454.829459] Starting dynamic subtest: 1-vecs0 [458.689367] Dynamic subtest 1-vecs0: SUCCESS (3.872s) [458.692420] Subtest non-zero-reason: SUCCESS (9.192s) [458.741905] [077/133] (568s left) i915_pm_freq_api (freq-basic-api) [458.797395] Starting subtest: freq-basic-api [458.799742] Starting dynamic subtest: gt0 [458.804902] Dynamic subtest gt0: SUCCESS (0.005s) [458.817088] Starting dynamic subtest: gt1 [458.819277] Dynamic subtest gt1: SUCCESS (0.003s) [458.821443] Subtest freq-basic-api: SUCCESS (0.009s) [458.907547] [078/133] (568s left) gem_mmap_gtt (ptrace) [458.965548] Subtest ptrace: SKIP (0.000s) [459.025985] [079/133] (568s left) kms_pipe_crc_basic (suspend-read-crc) [459.132117] Starting subtest: suspend-read-crc [459.133962] Starting dynamic subtest: pipe-A-eDP-1 [477.108681] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.590s) [477.120033] Starting dynamic subtest: pipe-B-eDP-1 [496.066159] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.258s) [496.077239] Starting dynamic subtest: pipe-C-eDP-1 [514.040905] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.149s) [514.053872] Starting dynamic subtest: pipe-D-eDP-1 [532.047623] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.068s) [532.050275] Subtest suspend-read-crc: SUCCESS (12.072s) [532.867148] [080/133] (494s left) kms_big_fb (4-tiled-64bpp-rotate-90) [532.971069] Starting subtest: 4-tiled-64bpp-rotate-90 [532.994713] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s) [533.104428] [081/133] (494s left) gem_partial_pwrite_pread (reads-uncached) [533.161710] Subtest reads-uncached: SKIP (0.000s) [533.233110] [082/133] (494s left) sysfs_heartbeat_interval (precise) [533.286026] Starting subtest: precise [533.288866] Starting dynamic subtest: vecs0 [541.274816] Dynamic subtest vecs0: SUCCESS (8.083s) [541.289698] Starting dynamic subtest: ccs0 [542.401396] Dynamic subtest ccs0: SUCCESS (1.130s) [542.414547] Starting dynamic subtest: vcs0 [550.299852] Dynamic subtest vcs0: SUCCESS (7.930s) [550.313893] Starting dynamic subtest: bcs0 [551.401954] Dynamic subtest bcs0: SUCCESS (1.102s) [551.419612] Starting dynamic subtest: rcs0 [552.464531] Dynamic subtest rcs0: SUCCESS (1.062s) [552.476514] Starting dynamic subtest: vcs1 [560.359686] Dynamic subtest vcs1: SUCCESS (7.904s) [560.362736] Subtest precise: SUCCESS (27.222s) [560.437321] [083/133] (467s left) gem_ctx_exec (basic-close-race) [560.501009] Starting subtest: basic-close-race [566.170881] Subtest basic-close-race: SUCCESS (5.666s) [566.293719] [084/133] (461s left) kms_cursor_crc (cursor-rapid-movement-max-size) [566.609809] Starting subtest: cursor-rapid-movement-max-size [566.617683] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [566.741494] [085/133] (460s left) kms_psr (pr-no-drrs) [566.832852] Starting subtest: pr-no-drrs [566.837726] Subtest pr-no-drrs: SKIP (0.000s) [566.907678] [086/133] (460s left) gem_userptr_blits (process-exit-busy) [566.976016] Starting subtest: process-exit-busy [566.984210] Subtest process-exit-busy: SUCCESS (0.011s) [567.110528] [087/133] (460s left) gem_ctx_persistence (engines-mixed-process) [567.160511] Starting subtest: engines-mixed-process [567.163138] Starting dynamic subtest: rcs0 [568.371448] Dynamic subtest rcs0: SUCCESS (1.209s) [568.384616] Starting dynamic subtest: bcs0 [570.341322] Dynamic subtest bcs0: SUCCESS (1.967s) [570.353578] Starting dynamic subtest: vcs0 [572.329895] Dynamic subtest vcs0: SUCCESS (1.987s) [572.343172] Starting dynamic subtest: vcs1 [574.287712] Dynamic subtest vcs1: SUCCESS (1.955s) [574.299538] Starting dynamic subtest: vecs0 [576.356448] Dynamic subtest vecs0: SUCCESS (2.068s) [576.369191] Starting dynamic subtest: ccs0 [578.360396] Dynamic subtest ccs0: SUCCESS (2.003s) [578.363472] Subtest engines-mixed-process: SUCCESS (11.196s) [578.445408] [088/133] (449s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [578.545664] Starting subtest: fbc-rgb101010-draw-mmap-gtt [578.550773] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [578.641162] [089/133] (449s left) kms_psr (psr-cursor-mmap-cpu) [578.722485] Starting subtest: psr-cursor-mmap-cpu [578.725145] Starting dynamic subtest: eDP-1 [580.491963] Dynamic subtest eDP-1: SUCCESS (1.768s) [580.494450] Subtest psr-cursor-mmap-cpu: SUCCESS (1.769s) [581.351660] [090/133] (446s left) gem_exec_schedule (preempt-self) [581.438263] Starting subtest: preempt-self [581.440519] Starting dynamic subtest: rcs0 [581.447966] Dynamic subtest rcs0: SUCCESS (0.021s) [581.463689] Starting dynamic subtest: bcs0 [581.466152] Dynamic subtest bcs0: SUCCESS (0.016s) [581.477397] Starting dynamic subtest: vcs0 [581.486421] Dynamic subtest vcs0: SUCCESS (0.021s) [581.497624] Starting dynamic subtest: vcs1 [581.508355] Dynamic subtest vcs1: SUCCESS (0.021s) [581.519524] Starting dynamic subtest: vecs0 [581.526923] Dynamic subtest vecs0: SUCCESS (0.018s) [581.538150] Starting dynamic subtest: ccs0 [581.545662] Dynamic subtest ccs0: SUCCESS (0.018s) [581.547984] Subtest preempt-self: SUCCESS (0.121s) [583.412068] [091/133] (444s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [583.457144] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [583.565222] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s) [583.656659] [092/133] (444s left) kms_flip (flip-vs-absolute-wf_vblank) [583.750775] Starting subtest: flip-vs-absolute-wf_vblank [583.753301] Starting dynamic subtest: A-eDP1 [592.701745] Dynamic subtest A-eDP1: SUCCESS (8.951s) [592.717465] Starting dynamic subtest: B-eDP1 [601.630144] Dynamic subtest B-eDP1: SUCCESS (8.928s) [601.641497] Starting dynamic subtest: C-eDP1 [610.538539] Dynamic subtest C-eDP1: SUCCESS (8.908s) [610.551903] Starting dynamic subtest: D-eDP1 [619.477441] Dynamic subtest D-eDP1: SUCCESS (8.938s) [619.480055] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.735s) [620.701851] [093/133] (407s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [620.781881] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [620.784608] Starting dynamic subtest: pipe-A [621.933456] Dynamic subtest pipe-A: SUCCESS (1.154s) [621.945306] Starting dynamic subtest: pipe-B [624.170529] Dynamic subtest pipe-B: SUCCESS (2.237s) [624.182593] Starting dynamic subtest: pipe-C [625.310634] Dynamic subtest pipe-C: SUCCESS (1.138s) [625.322114] Starting dynamic subtest: pipe-D [626.453636] Dynamic subtest pipe-D: SUCCESS (1.142s) [626.456406] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.676s) [627.640907] [094/133] (400s left) sw_sync (sync_multi_consumer_producer) [627.678291] Starting subtest: sync_multi_consumer_producer [628.109351] Subtest sync_multi_consumer_producer: SUCCESS (0.433s) [628.175086] [095/133] (399s left) gem_readwrite (write-bad-handle) [628.230074] Subtest write-bad-handle: SKIP (0.000s) [628.288573] [096/133] (399s left) kms_chamelium_color (ctm-limited-range) [628.372727] Subtest ctm-limited-range: SKIP (0.000s) [628.425058] [097/133] (399s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [628.521694] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [628.526709] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [628.610023] [098/133] (399s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [628.704618] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [628.707720] Starting dynamic subtest: pipe-A-eDP-1 [628.733689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [628.746058] Starting dynamic subtest: pipe-B-eDP-1 [628.768909] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [628.780681] Starting dynamic subtest: pipe-C-eDP-1 [628.801816] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [628.813796] Starting dynamic subtest: pipe-D-eDP-1 [628.837716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [628.840051] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s) [631.100513] [099/133] (397s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [631.480691] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [632.311791] [100/133] (395s left) kms_sequence (get-forked) [632.412485] Starting subtest: get-forked [632.415032] Starting dynamic subtest: pipe-A-eDP-1 [634.269773] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.857s) [634.283153] Starting dynamic subtest: pipe-B-eDP-1 [636.893545] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s) [636.907536] Starting dynamic subtest: pipe-C-eDP-1 [639.391719] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.496s) [639.405032] Starting dynamic subtest: pipe-D-eDP-1 [641.912481] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s) [641.915097] Subtest get-forked: SUCCESS (9.497s) [642.785327] [101/133] (385s left) gem_lmem_swapping (heavy-verify-multi) [642.829649] Subtest heavy-verify-multi: SKIP (0.000s) [642.881253] [102/133] (385s left) api_intel_bb (intel-bb-blit-y) [642.934353] Starting subtest: intel-bb-blit-y [646.627857] Subtest intel-bb-blit-y: SUCCESS (3.694s) [646.755300] [103/133] (381s left) kms_cursor_crc (cursor-tearing-position-change) [646.873860] Starting subtest: cursor-tearing-position-change [646.876625] Starting dynamic subtest: pipe-A-eDP-1 [647.452790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s) [647.464891] Starting dynamic subtest: pipe-D-eDP-1 [648.691666] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s) [648.694292] Subtest cursor-tearing-position-change: SUCCESS (1.815s) [649.547306] [104/133] (378s left) i915_suspend (fence-restore-untiled) [649.600539] Starting subtest: fence-restore-untiled [649.606395] Subtest fence-restore-untiled: SKIP (0.000s) [649.693124] [105/133] (378s left) kms_addfb_basic (addfb25-modifier-no-flag) [649.780220] Starting subtest: addfb25-modifier-no-flag [649.782949] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [649.882420] [106/133] (378s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [649.980655] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [649.985723] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [650.078170] [107/133] (378s left) kms_chamelium_hpd (vga-hpd) [650.457594] Subtest vga-hpd: SKIP (0.000s) [651.249073] [108/133] (377s left) drm_read (short-buffer-wakeup) [651.404300] Starting subtest: short-buffer-wakeup [683.618345] Subtest short-buffer-wakeup: SUCCESS (32.216s) [683.755546] [109/133] (344s left) kms_big_fb (y-tiled-32bpp-rotate-90) [683.861917] Starting subtest: y-tiled-32bpp-rotate-90 [683.866585] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [683.965784] [110/133] (344s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [684.073225] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [684.078494] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [684.172094] [111/133] (344s left) i915_drm_fdinfo (most-busy-check-all) [684.210756] Starting subtest: most-busy-check-all [684.213647] Starting dynamic subtest: rcs0 [684.219306] Dynamic subtest rcs0: SKIP (0.003s) [684.232864] Starting dynamic subtest: bcs0 [684.238105] Dynamic subtest bcs0: SKIP (0.000s) [684.249372] Starting dynamic subtest: vcs0 [684.254611] Dynamic subtest vcs0: SKIP (0.000s) [684.265759] Starting dynamic subtest: vcs1 [684.271104] Dynamic subtest vcs1: SKIP (0.000s) [684.282119] Starting dynamic subtest: vecs0 [684.287361] Dynamic subtest vecs0: SKIP (0.000s) [684.298588] Starting dynamic subtest: ccs0 [684.303627] Dynamic subtest ccs0: SKIP (0.000s) [684.308647] Subtest most-busy-check-all: SKIP (0.009s) [684.352728] [112/133] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [684.462984] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [691.286399] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.828s) [691.414206] [113/133] (337s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [691.504677] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [691.509310] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [691.600652] [114/133] (337s left) perf (polling-small-buf) [691.698859] Starting subtest: polling-small-buf [691.787279] Subtest polling-small-buf: SUCCESS (0.087s) [691.839076] [115/133] (337s left) kms_plane_multiple (tiling-x) [691.930695] Starting subtest: tiling-x [691.933495] Starting dynamic subtest: pipe-A-eDP-1 [695.614721] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.687s) [695.627882] Starting dynamic subtest: pipe-B-eDP-1 [700.058635] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.442s) [700.071239] Starting dynamic subtest: pipe-C-eDP-1 [704.395779] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.336s) [704.410359] Starting dynamic subtest: pipe-D-eDP-1 [708.746448] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.352s) [708.749172] Subtest tiling-x: SUCCESS (16.821s) [709.581841] [116/133] (319s left) gen9_exec_parse (bb-start-cmd) [709.649685] Subtest bb-start-cmd: SKIP (0.000s) [709.712882] [117/133] (319s left) kms_cursor_crc (cursor-offscreen-512x512) [710.004899] Starting subtest: cursor-offscreen-512x512 [710.010551] Subtest cursor-offscreen-512x512: SKIP (0.001s) [710.165625] [118/133] (318s left) gem_ctx_shared (create-shared-gtt) [710.232850] Starting subtest: create-shared-gtt [712.384875] Subtest create-shared-gtt: SUCCESS (2.151s) [713.319771] [119/133] (315s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [713.423426] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [713.434697] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [713.510766] [120/133] (315s left) kms_dp_linktrain_fallback (dsc-fallback) [713.605665] Starting subtest: dsc-fallback [713.613167] Subtest dsc-fallback: SKIP (0.000s) [713.681952] [121/133] (315s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [713.768688] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [713.771387] Starting dynamic subtest: pipe-A-eDP-1 [713.796116] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [713.811746] Starting dynamic subtest: pipe-B-eDP-1 [713.836550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [713.848725] Starting dynamic subtest: pipe-C-eDP-1 [713.871763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [713.882451] Starting dynamic subtest: pipe-D-eDP-1 [713.905809] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [713.910514] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [716.028379] [122/133] (313s left) syncobj_wait (single-wait-all-submitted) [716.081674] Starting subtest: single-wait-all-submitted [716.189329] Subtest single-wait-all-submitted: SUCCESS (0.107s) [716.284685] [123/133] (313s left) kms_atomic (atomic-invalid-params) [716.374203] Starting subtest: atomic-invalid-params [716.376844] Starting dynamic subtest: pipe-A-eDP-1 [716.763160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s) [716.765848] Subtest atomic-invalid-params: SUCCESS (0.389s) [717.565657] [124/133] (311s left) perf_pmu (all-busy-check-all) [717.611223] Starting subtest: all-busy-check-all [719.329569] Subtest all-busy-check-all: SUCCESS (1.719s) [719.436165] [125/133] (309s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [719.531346] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [719.536380] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [719.653684] [126/133] (309s left) kms_lease (lease-invalid-connector) [719.740927] Starting subtest: lease-invalid-connector [719.743612] Starting dynamic subtest: pipe-A-eDP-1 [719.746275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [719.758747] Starting dynamic subtest: pipe-B-eDP-1 [719.761128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [719.772917] Starting dynamic subtest: pipe-C-eDP-1 [719.775750] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [719.790126] Starting dynamic subtest: pipe-D-eDP-1 [719.792862] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [719.795571] Subtest lease-invalid-connector: SUCCESS (0.004s) [719.835684] [127/133] (309s left) gem_madvise (dontneed-after-mmap) [719.871876] Starting subtest: dontneed-after-mmap [719.893458] Subtest dontneed-after-mmap: SUCCESS (0.023s) [719.991542] [128/133] (309s left) kms_flip (flip-vs-suspend-interruptible) [720.085871] Starting subtest: flip-vs-suspend-interruptible [720.088714] Starting dynamic subtest: A-eDP1 [865.191348] Dynamic subtest A-eDP1: SUCCESS (11.253s) [865.195891] Subtest flip-vs-suspend-interruptible: SUCCESS (11.255s) [865.337763] [129/133] (164s left) kms_vblank (wait-forked-busy) [865.439233] Starting subtest: wait-forked-busy [865.441625] Starting dynamic subtest: pipe-A-eDP-1 [867.336082] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s) [867.352874] Starting dynamic subtest: pipe-D-eDP-1 [869.913207] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s) [869.916200] Subtest wait-forked-busy: SUCCESS (4.463s) [870.724935] [130/133] (158s left) kms_big_fb (linear-32bpp-rotate-180) [870.823421] Starting subtest: linear-32bpp-rotate-180 [872.339003] Subtest linear-32bpp-rotate-180: SUCCESS (1.512s) [872.467285] [131/133] (157s left) gen3_render_tiledx_blits [872.598278] [132/133] (157s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [872.691674] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [879.699514] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.002s) [879.807673] [133/133] (149s left) kms_plane_scaling (planes-scaler-unity-scaling) [879.901361] Starting subtest: planes-scaler-unity-scaling [879.904079] Starting dynamic subtest: pipe-A [879.962410] Dynamic subtest pipe-A: SUCCESS (0.064s) [879.974169] Starting dynamic subtest: pipe-B [881.083595] Dynamic subtest pipe-B: SUCCESS (1.120s) [881.095771] Starting dynamic subtest: pipe-C [882.210735] Dynamic subtest pipe-C: SUCCESS (1.125s) [882.224637] Starting dynamic subtest: pipe-D [883.330903] Dynamic subtest pipe-D: SUCCESS (1.119s) [883.333385] Subtest planes-scaler-unity-scaling: SUCCESS (3.431s) [884.490546] Closing watchdogs results: parsing output: 0/ for test: gem_busy results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: syncobj_wait results: parsing output: 4/ for test: gem_fenced_exec_thrash results: parsing output: 5/ for test: gem_tiled_fence_blits results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: gem_eio results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: gem_exec_schedule results: parsing output: 12/ for test: syncobj_wait results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: kms_addfb_basic results: parsing output: 15/ for test: gem_exec_balancer results: parsing output: 16/ for test: kms_pm_backlight results: parsing output: 17/ for test: api_intel_allocator results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: kms_psr2_sf results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_exec_reloc results: parsing output: 23/ for test: gem_tiled_blits results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_dsc results: parsing output: 27/ for test: gem_exec_flush results: parsing output: 28/ for test: kms_joiner results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: kms_addfb_basic results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: i915_pm_rps results: parsing output: 33/ for test: gem_mmap_wc results: parsing output: 34/ for test: kms_rotation_crc results: parsing output: 35/ for test: gem_softpin results: parsing output: 36/ for test: kms_flip_scaled_crc results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: gem_ctx_shared results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_parallel results: parsing output: 41/ for test: gem_readwrite results: parsing output: 42/ for test: gem_mmap_wc results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: syncobj_timeline results: parsing output: 45/ for test: gem_exec_fence results: parsing output: 46/ for test: gem_lmem_swapping results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: kms_psr2_sf results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_eio results: parsing output: 53/ for test: kms_prime results: parsing output: 54/ for test: kms_busy results: parsing output: 55/ for test: kms_hdr results: parsing output: 56/ for test: kms_content_protection results: parsing output: 57/ for test: gem_flink_basic results: parsing output: 58/ for test: gem_tiled_swapping results: parsing output: 59/ for test: gem_render_copy results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: gem_render_copy results: parsing output: 62/ for test: gem_exec_fence results: parsing output: 63/ for test: kms_flip results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_color results: parsing output: 68/ for test: kms_plane results: parsing output: 69/ for test: gem_eio results: parsing output: 70/ for test: gem_wait results: parsing output: 71/ for test: kms_async_flips results: parsing output: 72/ for test: kms_rotation_crc results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_exec_fence results: parsing output: 75/ for test: perf results: parsing output: 76/ for test: i915_pm_freq_api results: parsing output: 77/ for test: gem_mmap_gtt results: parsing output: 78/ for test: kms_pipe_crc_basic results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: gem_partial_pwrite_pread results: parsing output: 81/ for test: sysfs_heartbeat_interval results: parsing output: 82/ for test: gem_ctx_exec results: parsing output: 83/ for test: kms_cursor_crc results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: gem_userptr_blits results: parsing output: 86/ for test: gem_ctx_persistence results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_flip results: parsing output: 92/ for test: kms_plane_scaling results: parsing output: 93/ for test: sw_sync results: parsing output: 94/ for test: gem_readwrite results: parsing output: 95/ for test: kms_chamelium_color results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: kms_chamelium_frames results: parsing output: 99/ for test: kms_sequence results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: api_intel_bb results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: i915_suspend results: parsing output: 104/ for test: kms_addfb_basic results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_chamelium_hpd results: parsing output: 107/ for test: drm_read results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: i915_drm_fdinfo results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: perf results: parsing output: 114/ for test: kms_plane_multiple results: parsing output: 115/ for test: gen9_exec_parse results: parsing output: 116/ for test: kms_cursor_crc results: parsing output: 117/ for test: gem_ctx_shared results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: kms_dp_linktrain_fallback results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: syncobj_wait results: parsing output: 122/ for test: kms_atomic results: parsing output: 123/ for test: perf_pmu results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_lease results: parsing output: 126/ for test: gem_madvise results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: kms_vblank results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: gen3_render_tiledx_blits results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_plane_scaling Done.