[59.292725] Initializing watchdogs [59.292771] /dev/watchdog0 [59.306341] [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.310934] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.313097] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.316395] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [59.454424] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [59.459062] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [59.599369] [002/131] (960s left) gem_vm_create (invalid-create) [59.660817] Starting subtest: invalid-create [59.663219] Subtest invalid-create: SUCCESS (0.002s) [59.819644] [003/131] (960s left) gen7_exec_parse (basic-rejected) [59.881409] Subtest basic-rejected: SKIP (0.000s) [59.949698] [004/131] (960s left) kms_psr (pr-no-drrs) [60.042841] Starting subtest: pr-no-drrs [60.047142] Subtest pr-no-drrs: SKIP (0.000s) [60.132167] [005/131] (959s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [60.232430] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [60.234364] Starting dynamic subtest: pipe-A-eDP-1 [60.253926] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [60.262186] Starting dynamic subtest: pipe-B-eDP-1 [60.280001] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [60.286117] Starting dynamic subtest: pipe-C-eDP-1 [60.303878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [60.310045] Starting dynamic subtest: pipe-D-eDP-1 [60.327993] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [60.331499] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [62.511830] [006/131] (957s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [62.569625] Starting subtest: x-tiled-to-vebox-y-tiled [62.573984] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [62.771592] [007/131] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [62.872705] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [62.876839] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [63.009437] [008/131] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [63.117529] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [63.121877] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [63.245996] [009/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [63.358287] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [63.362785] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [63.487698] [010/131] (956s left) gem_ctx_engines (execute-oneforall) [63.565857] Starting subtest: execute-oneforall [64.010755] Subtest execute-oneforall: SUCCESS (0.446s) [65.080132] [011/131] (955s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [65.186181] Starting subtest: fbcpsr-tiling-y [65.190793] Subtest fbcpsr-tiling-y: SKIP (0.000s) [65.299126] [012/131] (954s left) core_auth (basic-auth) [65.357758] Starting subtest: basic-auth [65.360162] Subtest basic-auth: SUCCESS (0.001s) [65.487660] [013/131] (954s left) kms_hdmi_inject (inject-audio) [65.837622] Starting subtest: inject-audio [66.117080] Subtest inject-audio: SUCCESS (0.281s) [66.692176] [014/131] (953s left) drm_read (short-buffer-nonblock) [66.899148] Starting subtest: short-buffer-nonblock [66.901462] Subtest short-buffer-nonblock: SUCCESS (0.000s) [67.303381] [015/131] (953s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [72.547249] Starting subtest: psr2-overlay-plane-move-continuous-sf [72.549565] Starting dynamic subtest: pipe-A-eDP-1 [79.195456] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.641s) [79.203078] Starting dynamic subtest: pipe-B-eDP-1 [85.897933] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.695s) [85.900347] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.339s) [86.778775] [016/131] (933s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [86.896665] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [93.408964] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.513s) [93.552330] [017/131] (926s left) gem_partial_pwrite_pread (write-snoop) [93.620382] Subtest write-snoop: SKIP (0.000s) [93.698204] [018/131] (926s left) gem_mmap_gtt (fault-concurrent-y) [93.748342] Subtest fault-concurrent-Y: SKIP (0.000s) [93.803680] [019/131] (926s left) gem_exec_balancer (full-pulse) [93.870450] Starting subtest: full-pulse [98.804741] Subtest full-pulse: SUCCESS (4.933s) [99.163291] [020/131] (921s left) syncobj_basic (bad-flags-handle-to-fd) [99.222202] Starting subtest: bad-flags-handle-to-fd [99.224551] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [99.364332] [021/131] (921s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [99.419943] Starting subtest: etime-single-wait-all-for-submit-submitted [99.529864] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.109s) [99.630804] [022/131] (921s left) kms_big_fb (y-tiled-32bpp-rotate-270) [99.735319] Starting subtest: y-tiled-32bpp-rotate-270 [99.739214] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [99.874720] [023/131] (920s left) kms_rotation_crc (multiplane-rotation-cropping-top) [99.967817] Starting subtest: multiplane-rotation-cropping-top [117.406868] Subtest multiplane-rotation-cropping-top: SUCCESS (17.438s) [117.552136] [024/131] (903s left) kms_big_fb (x-tiled-addfb) [117.665791] Starting subtest: x-tiled-addfb [117.667742] Subtest x-tiled-addfb: SUCCESS (0.000s) [117.775276] [025/131] (903s left) kms_big_fb (linear-8bpp-rotate-0) [117.872707] Starting subtest: linear-8bpp-rotate-0 [119.097618] Subtest linear-8bpp-rotate-0: SUCCESS (1.224s) [119.286485] [026/131] (901s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [119.352232] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [119.355973] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [119.550764] [027/131] (901s left) kms_content_protection (atomic) [119.694999] Starting subtest: atomic [119.699670] Subtest atomic: SKIP (0.000s) [119.865083] [028/131] (901s left) kms_cursor_edge_walk (64x64-top-edge) [119.961782] Starting subtest: 64x64-top-edge [119.963931] Starting dynamic subtest: pipe-A-eDP-1 [123.394371] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s) [123.402731] Starting dynamic subtest: pipe-D-eDP-1 [126.595639] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.200s) [126.597894] Subtest 64x64-top-edge: SUCCESS (6.636s) [127.474603] [029/131] (893s left) kms_dp_link_training (uhbr-mst) [127.563629] Starting subtest: uhbr-mst [127.572232] Subtest uhbr-mst: SKIP (0.000s) [127.660158] [030/131] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [127.750570] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [127.754999] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [127.874220] [031/131] (893s left) kms_cursor_crc (cursor-onscreen-512x170) [128.162083] Starting subtest: cursor-onscreen-512x170 [128.166848] Subtest cursor-onscreen-512x170: SKIP (0.001s) [128.321353] [032/131] (892s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [128.409451] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [128.411458] Starting dynamic subtest: pipe-A-default-mode [128.759331] Dynamic subtest pipe-A-default-mode: SKIP (0.348s) [128.763727] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.350s) [129.588686] [033/131] (891s left) gem_eio (wait-wedge-1us) [129.824583] Starting subtest: wait-wedge-1us [130.970308] Subtest wait-wedge-1us: SUCCESS (1.144s) [131.137732] [034/131] (889s left) i915_drm_fdinfo (virtual-busy-idle) [131.176316] Starting subtest: virtual-busy-idle [131.180434] Subtest virtual-busy-idle: SKIP (0.000s) [131.270379] [035/131] (889s left) syncobj_wait (single-wait-for-submit-submitted) [131.319589] Starting subtest: single-wait-for-submit-submitted [131.425811] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s) [131.521090] [036/131] (889s left) perf_pmu (init-busy) [131.566228] Starting subtest: init-busy [131.568416] Starting dynamic subtest: rcs0 [131.570537] Dynamic subtest rcs0: SUCCESS (0.001s) [131.578215] Starting dynamic subtest: bcs0 [131.580367] Dynamic subtest bcs0: SUCCESS (0.001s) [131.587739] Starting dynamic subtest: vcs0 [131.589879] Dynamic subtest vcs0: SUCCESS (0.001s) [131.597064] Starting dynamic subtest: vcs1 [131.599177] Dynamic subtest vcs1: SUCCESS (0.001s) [131.606282] Starting dynamic subtest: vecs0 [131.608468] Dynamic subtest vecs0: SUCCESS (0.001s) [131.615671] Starting dynamic subtest: ccs0 [131.617774] Dynamic subtest ccs0: SUCCESS (0.001s) [131.619909] Subtest init-busy: SUCCESS (0.008s) [131.716351] [037/131] (889s left) gem_spin_batch (resubmit-new-all) [131.787328] Starting subtest: resubmit-new-all [131.789602] Starting dynamic subtest: rcs0 [131.801239] Dynamic subtest rcs0: SUCCESS (0.014s) [131.811054] Starting dynamic subtest: bcs0 [131.813297] Dynamic subtest bcs0: SUCCESS (0.009s) [131.820567] Starting dynamic subtest: vcs0 [131.825167] Dynamic subtest vcs0: SUCCESS (0.012s) [131.832424] Starting dynamic subtest: vcs1 [131.838569] Dynamic subtest vcs1: SUCCESS (0.013s) [131.845734] Starting dynamic subtest: vecs0 [131.850111] Dynamic subtest vecs0: SUCCESS (0.009s) [131.857250] Starting dynamic subtest: ccs0 [131.859448] Dynamic subtest ccs0: SUCCESS (0.009s) [131.861285] Subtest resubmit-new-all: SUCCESS (0.071s) [132.946825] [038/131] (888s left) kms_psr (psr2-no-drrs) [133.055152] Starting subtest: psr2-no-drrs [133.057333] Starting dynamic subtest: eDP-1 [134.689954] Dynamic subtest eDP-1: SUCCESS (1.634s) [134.692254] Subtest psr2-no-drrs: SUCCESS (1.635s) [135.580325] [039/131] (885s left) gem_exec_fence (syncobj-timeline-export) [136.151820] Starting subtest: syncobj-timeline-export [136.157040] Subtest syncobj-timeline-export: SUCCESS (0.007s) [137.975523] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true [137.979027] [040/131] (883s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [138.088937] Starting subtest: compare-crc-sanitycheck-xr24 [138.091300] Starting dynamic subtest: pipe-A-eDP-1 [138.698122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s) [138.707619] Starting dynamic subtest: pipe-B-eDP-1 [139.990817] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s) [140.000190] Starting dynamic subtest: pipe-C-eDP-1 [141.234971] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s) [141.243409] Starting dynamic subtest: pipe-D-eDP-1 [142.431497] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s) [142.433705] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.342s) [143.284062] [041/131] (878s left) kms_pm_rpm (dpms-lpsp) [145.116592] Starting subtest: dpms-lpsp [145.495109] Subtest dpms-lpsp: SUCCESS (0.381s) [145.620235] [042/131] (875s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [150.649526] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [150.654193] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s) [151.477401] [043/131] (869s left) syncobj_timeline (signal) [151.545265] Starting subtest: signal [151.547581] Subtest signal: SUCCESS (0.000s) [151.685443] [044/131] (869s left) kms_invalid_mode (overflow-vrefresh) [151.787270] Starting subtest: overflow-vrefresh [151.789381] Starting dynamic subtest: pipe-A-eDP-1 [152.077275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [152.086415] Starting dynamic subtest: pipe-B-eDP-1 [152.088707] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [152.096595] Starting dynamic subtest: pipe-C-eDP-1 [152.098944] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [152.106862] Starting dynamic subtest: pipe-D-eDP-1 [152.109135] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [152.111366] Subtest overflow-vrefresh: SUCCESS (0.294s) [152.900705] [045/131] (868s left) api_intel_allocator (reserve-simple) [152.963366] Starting subtest: reserve-simple [152.965653] Subtest reserve-simple: SUCCESS (0.002s) [153.095708] [046/131] (868s left) kms_lease (lease-unleased-connector) [153.187171] Starting subtest: lease-unleased-connector [153.189450] Starting dynamic subtest: pipe-A-eDP-1 [153.194606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s) [153.204027] Starting dynamic subtest: pipe-B-eDP-1 [153.206374] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s) [153.215318] Starting dynamic subtest: pipe-C-eDP-1 [153.217582] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [153.225592] Starting dynamic subtest: pipe-D-eDP-1 [153.227458] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [153.229373] Subtest lease-unleased-connector: SUCCESS (0.033s) [153.365384] [047/131] (868s left) kms_rotation_crc (bad-tiling) [153.465061] Starting subtest: bad-tiling [153.469576] Subtest bad-tiling: SKIP (0.001s) [153.561199] [048/131] (868s left) prime_vgem (shrink) [153.649084] Starting subtest: shrink [153.664386] Subtest shrink: SUCCESS (0.013s) [153.800411] [049/131] (867s left) gem_workarounds (reset-context) [153.866648] Starting subtest: reset-context [154.046678] Subtest reset-context: SUCCESS (0.180s) [154.214941] [050/131] (867s left) kms_prop_blob (blob-prop-lifetime) [154.263718] Starting subtest: blob-prop-lifetime [154.265732] Subtest blob-prop-lifetime: SUCCESS (0.001s) [154.394683] [051/131] (867s left) kms_big_fb (4-tiled-64bpp-rotate-180) [154.504414] Starting subtest: 4-tiled-64bpp-rotate-180 [156.178771] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.673s) [156.367771] [052/131] (865s left) kms_vblank (wait-forked-busy-hang) [156.475217] Starting subtest: wait-forked-busy-hang [156.477087] Starting dynamic subtest: pipe-A-eDP-1 [182.695709] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.218s) [182.709685] Starting dynamic subtest: pipe-D-eDP-1 [207.646277] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s) [207.648592] Subtest wait-forked-busy-hang: SUCCESS (51.170s) [208.473785] [053/131] (813s left) gem_ccs (block-copy-compressed) [208.540499] Starting subtest: block-copy-compressed [208.544827] Subtest block-copy-compressed: SKIP (0.000s) [208.686574] [054/131] (813s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [208.802472] Starting subtest: basic-flip-before-cursor-atomic [209.717417] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.915s) [210.567172] [055/131] (811s left) kms_flip (flip-vs-suspend-interruptible) [210.669291] Starting subtest: flip-vs-suspend-interruptible [210.671500] Starting dynamic subtest: A-eDP1 [244.120805] Dynamic subtest A-eDP1: SUCCESS (7.865s) [244.130641] Starting dynamic subtest: B-eDP1 [293.165479] Dynamic subtest B-eDP1: SUCCESS (4.630s) [293.189908] Starting dynamic subtest: C-eDP1 [342.127037] Dynamic subtest C-eDP1: SUCCESS (4.672s) [342.143981] Starting dynamic subtest: D-eDP1 [391.114207] Dynamic subtest D-eDP1: SUCCESS (4.462s) [391.116672] Subtest flip-vs-suspend-interruptible: SUCCESS (21.640s) [392.419675] [056/131] (629s left) gem_lmem_swapping (parallel-random-verify-ccs) [392.468639] Subtest parallel-random-verify-ccs: SKIP (0.000s) [392.511439] [057/131] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [392.611404] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [399.958960] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.195s) [400.165012] [058/131] (621s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [400.268931] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [400.271323] Starting dynamic subtest: pipe-A-eDP-1 [400.295035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [400.306255] Starting dynamic subtest: pipe-B-eDP-1 [400.327917] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [400.336906] Starting dynamic subtest: pipe-C-eDP-1 [400.359406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [400.368456] Starting dynamic subtest: pipe-D-eDP-1 [400.390675] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [400.395066] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s) [402.593902] [059/131] (619s left) i915_pm_rps (basic-api) [402.660048] Starting subtest: basic-api [402.664571] Subtest basic-api: SKIP (0.000s) [402.782114] [060/131] (619s left) kms_pm_backlight (bad-brightness) [402.879969] Starting subtest: bad-brightness [402.931011] Starting dynamic subtest: eDP-1 [403.241866] Dynamic subtest eDP-1: SUCCESS (0.309s) [403.244225] Subtest bad-brightness: SUCCESS (0.359s) [404.109264] [061/131] (618s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [404.159941] Subtest no-spare-fences-interruptible: SKIP (0.000s) [404.229965] [062/131] (618s left) gem_exec_balancer (parallel-keep-in-fence) [404.483712] Starting subtest: parallel-keep-in-fence [405.574893] Subtest parallel-keep-in-fence: SUCCESS (1.084s) [405.717129] [063/131] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [405.819708] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [405.823682] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [405.941946] [064/131] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [406.038521] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [406.042922] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [406.148388] [065/131] (616s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [406.239339] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [406.241591] Starting dynamic subtest: pipe-A-eDP-1 [406.263235] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [406.274640] Starting dynamic subtest: pipe-B-eDP-1 [406.296243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [406.306528] Starting dynamic subtest: pipe-C-eDP-1 [406.328046] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [406.336765] Starting dynamic subtest: pipe-D-eDP-1 [406.358435] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [406.362714] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s) [408.532569] [066/131] (613s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [408.630748] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [409.005976] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [411.755069] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.737s) [411.764167] Starting dynamic subtest: pipe-A-eDP-1-4 [413.937319] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.175s) [413.946574] Starting dynamic subtest: pipe-A-eDP-1-4 [415.941893] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (1.998s) [415.953733] Starting dynamic subtest: pipe-A-eDP-1-x [418.113990] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.168s) [418.471315] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [421.284049] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.816s) [421.296416] Starting dynamic subtest: pipe-B-eDP-1-4 [423.462020] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.176s) [423.474553] Starting dynamic subtest: pipe-B-eDP-1-4 [425.471591] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [425.483572] Starting dynamic subtest: pipe-B-eDP-1-x [427.661432] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [428.025522] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [430.784806] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.765s) [430.797332] Starting dynamic subtest: pipe-C-eDP-1-4 [432.949244] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s) [432.959647] Starting dynamic subtest: pipe-C-eDP-1-4 [434.959848] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [434.975754] Starting dynamic subtest: pipe-C-eDP-1-x [437.138386] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [437.509823] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [440.285528] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.787s) [440.297477] Starting dynamic subtest: pipe-D-eDP-1-4 [442.460849] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [442.472481] Starting dynamic subtest: pipe-D-eDP-1-4 [444.471265] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [444.480492] Starting dynamic subtest: pipe-D-eDP-1-x [446.639469] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s) [446.642562] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (37.975s) [447.870717] [067/131] (574s left) gen3_render_mixed_blits [448.008692] [068/131] (574s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [448.111893] Starting subtest: modeset-transition-nonblocking-fencing [448.114110] Starting dynamic subtest: 1x-outputs [459.212734] Dynamic subtest 1x-outputs: SUCCESS (11.098s) [459.215186] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.099s) [460.074090] [069/131] (562s left) vgem_basic (sysfs) [460.123834] Starting subtest: sysfs [460.126163] Subtest sysfs: SUCCESS (0.000s) [460.208436] [070/131] (562s left) gem_ctx_persistence (saturated-hostile-nopreempt) [460.264993] Starting subtest: saturated-hostile-nopreempt [460.267318] Starting dynamic subtest: rcs0 [460.343848] Dynamic subtest rcs0: SKIP (0.076s) [460.354745] Starting dynamic subtest: bcs0 [460.368143] Dynamic subtest bcs0: SKIP (0.022s) [460.377397] Starting dynamic subtest: vcs0 [460.386523] Dynamic subtest vcs0: SKIP (0.015s) [460.395050] Starting dynamic subtest: vcs1 [460.404086] Dynamic subtest vcs1: SKIP (0.018s) [460.413414] Starting dynamic subtest: vecs0 [460.420216] Dynamic subtest vecs0: SKIP (0.014s) [460.428685] Starting dynamic subtest: ccs0 [460.440138] Dynamic subtest ccs0: SKIP (0.020s) [460.444655] Subtest saturated-hostile-nopreempt: SKIP (0.174s) [460.542914] [071/131] (562s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [460.652683] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [460.656999] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [460.776465] [072/131] (561s left) api_intel_bb (render) [460.831687] Starting subtest: render [460.833484] Starting dynamic subtest: render-none-512 [460.938364] Dynamic subtest render-none-512: SUCCESS (0.107s) [460.947902] Starting dynamic subtest: render-none-1024 [461.310448] Dynamic subtest render-none-1024: SUCCESS (0.371s) [461.320139] Starting dynamic subtest: render-x-512 [461.394475] Dynamic subtest render-x-512: SUCCESS (0.084s) [461.406280] Starting dynamic subtest: render-x-1024 [461.736886] Dynamic subtest render-x-1024: SUCCESS (0.342s) [461.748913] Starting dynamic subtest: render-y-512 [461.822419] Dynamic subtest render-y-512: SUCCESS (0.084s) [461.833899] Starting dynamic subtest: render-y-1024 [462.159197] Dynamic subtest render-y-1024: SUCCESS (0.333s) [462.161722] Subtest render: SUCCESS (1.327s) [462.314868] [073/131] (560s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [462.434310] Starting subtest: cursor-tearing-framebuffer-change [462.436477] Starting dynamic subtest: pipe-A-eDP-1 [463.011959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s) [463.021207] Starting dynamic subtest: pipe-D-eDP-1 [464.249787] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s) [464.252261] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.815s) [465.064475] [074/131] (557s left) gem_ppgtt (shrink-vs-evict-pinned) [465.131088] Starting subtest: shrink-vs-evict-pinned [472.298052] Subtest shrink-vs-evict-pinned: SUCCESS (7.162s) [472.425294] [075/131] (550s left) kms_flip (flip-vs-dpms-off-vs-modeset) [472.530035] Starting subtest: flip-vs-dpms-off-vs-modeset [472.532637] Starting dynamic subtest: A-eDP1 [476.171234] Dynamic subtest A-eDP1: SUCCESS (3.635s) [476.192524] Starting dynamic subtest: B-eDP1 [479.470333] Dynamic subtest B-eDP1: SUCCESS (3.301s) [479.480787] Starting dynamic subtest: C-eDP1 [482.791231] Dynamic subtest C-eDP1: SUCCESS (3.318s) [482.803008] Starting dynamic subtest: D-eDP1 [486.075417] Dynamic subtest D-eDP1: SUCCESS (3.282s) [486.077794] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.544s) [486.972365] [076/131] (535s left) gem_exec_reloc (basic-cpu-wc) [487.055530] Subtest basic-cpu-wc: SKIP (0.000s) [487.124995] [077/131] (535s left) i915_drm_fdinfo (busy-check-all) [487.160928] Starting subtest: busy-check-all [487.162869] Starting dynamic subtest: rcs0 [487.167543] Dynamic subtest rcs0: SKIP (0.003s) [487.182772] Starting dynamic subtest: bcs0 [487.187418] Dynamic subtest bcs0: SKIP (0.000s) [487.198316] Starting dynamic subtest: vcs0 [487.202794] Dynamic subtest vcs0: SKIP (0.000s) [487.211657] Starting dynamic subtest: vcs1 [487.215999] Dynamic subtest vcs1: SKIP (0.000s) [487.224944] Starting dynamic subtest: vecs0 [487.229381] Dynamic subtest vecs0: SKIP (0.000s) [487.238661] Starting dynamic subtest: ccs0 [487.243214] Dynamic subtest ccs0: SKIP (0.000s) [487.247748] Subtest busy-check-all: SKIP (0.008s) [487.288099] [078/131] (535s left) gem_exec_whisper (basic-queues-priority) [487.359309] Starting subtest: basic-queues-priority [510.452712] Subtest basic-queues-priority: SUCCESS (23.095s) [510.655804] [079/131] (512s left) sysfs_heartbeat_interval (nopreempt) [510.723576] Starting subtest: nopreempt [510.725851] Starting dynamic subtest: vecs0 [520.283529] Dynamic subtest vecs0: SUCCESS (9.556s) [520.294265] Starting dynamic subtest: ccs0 [524.370100] Dynamic subtest ccs0: SUCCESS (4.086s) [524.381568] Starting dynamic subtest: vcs0 [534.295954] Dynamic subtest vcs0: SUCCESS (9.925s) [534.308053] Starting dynamic subtest: bcs0 [538.286842] Dynamic subtest bcs0: SUCCESS (3.987s) [538.298493] Starting dynamic subtest: rcs0 [542.379723] Dynamic subtest rcs0: SUCCESS (4.091s) [542.390563] Starting dynamic subtest: vcs1 [552.289233] Dynamic subtest vcs1: SUCCESS (9.902s) [552.291737] Subtest nopreempt: SUCCESS (41.558s) [552.384888] [080/131] (470s left) gem_exec_whisper (basic-forked) [552.440343] Starting subtest: basic-forked [561.401916] Subtest basic-forked: SUCCESS (8.957s) [561.611692] [081/131] (461s left) prime_vgem (basic-fence-read) [561.702672] Starting subtest: basic-fence-read [561.723788] Subtest basic-fence-read: SKIP (0.019s) [561.889701] [082/131] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [561.991745] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [561.996276] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [562.149454] [083/131] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [562.252109] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [562.256206] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [562.364428] [084/131] (460s left) gem_flink_basic (flink-lifetime) [562.410533] Starting subtest: flink-lifetime [562.412959] Subtest flink-lifetime: SUCCESS (0.002s) [562.545804] [085/131] (460s left) gem_exec_reloc (basic-wc-read-active) [562.598896] Subtest basic-wc-read-active: SKIP (0.000s) [562.685371] [086/131] (460s left) core_setmaster (master-drop-set-shared-fd) [562.783963] Starting subtest: master-drop-set-shared-fd [562.805673] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [562.844419] [087/131] (460s left) kms_flip (flip-vs-panning) [562.944569] Starting subtest: flip-vs-panning [562.946398] Starting dynamic subtest: A-eDP1 [571.644653] Dynamic subtest A-eDP1: SUCCESS (8.699s) [571.655021] Starting dynamic subtest: B-eDP1 [580.331411] Dynamic subtest B-eDP1: SUCCESS (8.683s) [580.342120] Starting dynamic subtest: C-eDP1 [589.017052] Dynamic subtest C-eDP1: SUCCESS (8.682s) [589.027540] Starting dynamic subtest: D-eDP1 [597.718132] Dynamic subtest D-eDP1: SUCCESS (8.698s) [597.723796] Subtest flip-vs-panning: SUCCESS (34.773s) [598.991312] [088/131] (424s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [599.098207] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [599.102706] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [599.202365] [089/131] (424s left) sw_sync (sync_expired_merge) [599.241121] Starting subtest: sync_expired_merge [600.317328] Subtest sync_expired_merge: SUCCESS (1.075s) [600.406027] [090/131] (423s left) kms_psr (fbc-psr-primary-mmap-cpu) [600.503886] Starting subtest: fbc-psr-primary-mmap-cpu [600.506179] Starting dynamic subtest: eDP-1 [600.510257] Dynamic subtest eDP-1: SKIP (0.000s) [600.514336] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [600.599664] [091/131] (422s left) syncobj_timeline (single-wait-available-signaled) [600.659822] Starting subtest: single-wait-available-signaled [600.661754] Subtest single-wait-available-signaled: SUCCESS (0.000s) [600.792036] [092/131] (422s left) i915_pm_rps (thresholds-park) [600.843790] Starting subtest: thresholds-park [600.848242] Subtest thresholds-park: SKIP (0.001s) [600.980867] [093/131] (422s left) kms_cursor_crc (cursor-size-change) [601.075405] Starting subtest: cursor-size-change [601.077458] Starting dynamic subtest: pipe-A-eDP-1 [601.858450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [601.868984] Starting dynamic subtest: pipe-D-eDP-1 [603.297779] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s) [603.299710] Subtest cursor-size-change: SUCCESS (2.223s) [604.169974] [094/131] (419s left) gem_exec_reloc (basic-write-wc) [604.225714] Subtest basic-write-wc: SKIP (0.000s) [604.304038] [095/131] (419s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [604.406223] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [604.410290] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [604.516896] [096/131] (419s left) kms_psr (fbc-pr-primary-mmap-gtt) [604.605904] Starting subtest: fbc-pr-primary-mmap-gtt [604.610111] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [604.702924] [097/131] (419s left) gem_ctx_shared (q-promotion) [604.776692] Starting subtest: Q-promotion [604.779111] Starting dynamic subtest: rcs0 [604.889955] Dynamic subtest rcs0: SUCCESS (0.111s) [604.904536] Starting dynamic subtest: vcs0 [604.983568] Dynamic subtest vcs0: SUCCESS (0.094s) [605.000444] Starting dynamic subtest: vcs1 [605.067821] Dynamic subtest vcs1: SUCCESS (0.084s) [605.084394] Starting dynamic subtest: vecs0 [605.146803] Dynamic subtest vecs0: SUCCESS (0.078s) [605.162211] Starting dynamic subtest: ccs0 [605.238128] Dynamic subtest ccs0: SUCCESS (0.090s) [605.240709] Subtest Q-promotion: SUCCESS (0.460s) [606.445989] [098/131] (417s left) gem_exec_schedule (u-semaphore-codependency) [606.524901] Starting subtest: u-semaphore-codependency [606.532985] Subtest u-semaphore-codependency: SUCCESS (0.015s) [606.935896] [099/131] (416s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [607.032608] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [607.034840] Starting dynamic subtest: pipe-A-eDP-1 [607.835374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [607.844856] Starting dynamic subtest: pipe-B-eDP-1 [609.340702] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s) [609.350995] Starting dynamic subtest: pipe-C-eDP-1 [610.807080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.456s) [610.818659] Starting dynamic subtest: pipe-D-eDP-1 [612.332251] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s) [612.334526] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.291s) [613.567951] [100/131] (410s left) kms_atomic_transition (plane-all-transition) [613.668575] Starting subtest: plane-all-transition [613.670926] Starting dynamic subtest: pipe-A-eDP-1 [616.164889] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s) [616.471546] Starting dynamic subtest: pipe-B-eDP-1 [619.663813] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.204s) [619.961292] Subtest plane-all-transition: SUCCESS (6.295s) [620.790704] [101/131] (403s left) gem_exec_params (invalid-ring2) [620.864037] Starting subtest: invalid-ring2 [620.865983] Subtest invalid-ring2: SUCCESS (0.000s) [621.003923] [102/131] (402s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [621.115719] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [624.808424] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.697s) [625.979675] [103/131] (398s left) gem_render_copy (x-tiled) [626.039890] Starting subtest: x-tiled [626.042099] Starting dynamic subtest: smem [626.078061] Dynamic subtest smem: SUCCESS (0.041s) [626.080535] Subtest x-tiled: SUCCESS (0.042s) [626.345945] [104/131] (397s left) kms_chamelium_hpd (vga-hpd-without-ddc) [626.734823] Subtest vga-hpd-without-ddc: SKIP (0.000s) [627.529879] [105/131] (396s left) syncobj_timeline (invalid-query-zero-handles) [627.595296] Starting subtest: invalid-query-zero-handles [627.597684] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [627.728195] [106/131] (396s left) kms_chamelium_frames (hdmi-crc-fast) [628.123247] Subtest hdmi-crc-fast: SKIP (0.000s) [628.915016] [107/131] (395s left) gem_ctx_exec (basic-invalid-context) [628.983114] Starting subtest: basic-invalid-context [628.988354] Subtest basic-invalid-context: SUCCESS (0.005s) [629.156164] [108/131] (395s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [629.250617] Starting subtest: primary-x-tiled-reflect-x-180 [636.464493] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.217s) [637.668819] [109/131] (386s left) vgem_basic (dmabuf-mmap) [637.719858] Starting subtest: dmabuf-mmap [637.738718] Subtest dmabuf-mmap: SUCCESS (0.021s) [637.819355] [110/131] (386s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [637.937670] Starting subtest: cursorB-vs-flipB-atomic-transitions [637.942001] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [638.106488] [111/131] (386s left) kms_vblank (invalid) [638.205673] Starting subtest: invalid [638.207586] Starting dynamic subtest: pipe-A-eDP-1 [638.599655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s) [638.601845] Subtest invalid: SUCCESS (0.397s) [639.460661] [112/131] (384s left) kms_getfb (getfb2-handle-closed) [639.558628] Starting subtest: getfb2-handle-closed [639.560921] Subtest getfb2-handle-closed: SUCCESS (0.000s) [639.701827] [113/131] (384s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [639.804550] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [639.806795] Starting dynamic subtest: pipe-A-eDP-1 [640.524362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s) [640.533959] Starting dynamic subtest: pipe-B-eDP-1 [642.321746] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.796s) [642.332474] Starting dynamic subtest: pipe-C-eDP-1 [644.110870] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.789s) [644.121108] Starting dynamic subtest: pipe-D-eDP-1 [645.932320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.820s) [645.934542] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.122s) [647.174222] [114/131] (377s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [647.280571] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [647.282870] Starting dynamic subtest: pipe-A [647.412912] Dynamic subtest pipe-A: SKIP (0.128s) [647.423357] Starting dynamic subtest: pipe-B [648.610899] Dynamic subtest pipe-B: SKIP (1.198s) [648.621923] Starting dynamic subtest: pipe-C [649.789556] Dynamic subtest pipe-C: SUCCESS (1.184s) [649.799356] Starting dynamic subtest: pipe-D [650.979289] Dynamic subtest pipe-D: SUCCESS (1.188s) [650.981636] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.704s) [652.169650] [115/131] (372s left) template (b) [652.238245] Starting subtest: B [652.240709] Subtest B: SUCCESS (0.000s) [652.356794] [116/131] (372s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [652.452819] Starting subtest: fbc-psr2-cursor-mmap-gtt [652.454698] Starting dynamic subtest: eDP-1 [652.458706] Dynamic subtest eDP-1: SKIP (0.000s) [652.462741] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [652.554810] [117/131] (372s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [652.661259] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [652.665663] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [652.799112] [118/131] (371s left) kms_busy (extended-modeset-hang-oldfb) [652.896474] Starting subtest: extended-modeset-hang-oldfb [652.898815] Starting dynamic subtest: pipe-A [664.685691] Dynamic subtest pipe-A: SUCCESS (11.788s) [664.696068] Starting dynamic subtest: pipe-D [676.986614] Dynamic subtest pipe-D: SUCCESS (12.297s) [676.989518] Subtest extended-modeset-hang-oldfb: SUCCESS (24.090s) [677.853549] [119/131] (346s left) kms_flip (2x-flip-vs-fences) [677.957707] Starting subtest: 2x-flip-vs-fences [677.961745] Subtest 2x-flip-vs-fences: SKIP (0.000s) [678.102906] [120/131] (346s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [678.191030] Starting subtest: yf-tiled-32bpp-rotate-180 [678.195365] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [678.324634] [121/131] (346s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [678.424122] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [678.428155] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [678.542439] [122/131] (346s left) prime_mmap (test_correct) [678.605879] Starting subtest: test_correct [678.608004] Starting dynamic subtest: test_correct-smem [678.643960] Dynamic subtest test_correct-smem: SUCCESS (0.039s) [678.646389] Subtest test_correct: SUCCESS (0.040s) [678.752419] [123/131] (346s left) kms_cursor_crc (cursor-offscreen-64x64) [678.926538] Starting subtest: cursor-offscreen-64x64 [678.932038] Starting dynamic subtest: pipe-A-eDP-1 [680.863127] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [680.898770] Starting dynamic subtest: pipe-D-eDP-1 [683.517575] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.632s) [683.519971] Subtest cursor-offscreen-64x64: SUCCESS (4.590s) [684.361406] [124/131] (340s left) perf (gen12-group-exclusive-stream-sample-oa) [684.495365] Starting subtest: gen12-group-exclusive-stream-sample-oa [684.514261] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s) [684.594971] [125/131] (340s left) gem_exec_schedule (in-order) [684.684331] Starting subtest: in-order [684.686246] Starting dynamic subtest: rcs0 [684.786107] Dynamic subtest rcs0: SUCCESS (0.104s) [684.798430] Starting dynamic subtest: vcs0 [684.867571] Dynamic subtest vcs0: SUCCESS (0.080s) [684.878798] Starting dynamic subtest: vcs1 [684.944130] Dynamic subtest vcs1: SUCCESS (0.076s) [684.955320] Starting dynamic subtest: vecs0 [685.017528] Dynamic subtest vecs0: SUCCESS (0.073s) [685.028869] Starting dynamic subtest: ccs0 [685.108261] Dynamic subtest ccs0: SUCCESS (0.090s) [685.110587] Subtest in-order: SUCCESS (0.427s) [686.419068] [126/131] (338s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [686.529469] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [686.533827] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [686.662577] [127/131] (338s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [686.755116] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [686.759523] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [686.865851] [128/131] (338s left) gem_exec_schedule (fairslice) [686.939387] Starting subtest: fairslice [686.941473] Starting dynamic subtest: rcs0 [688.954008] Dynamic subtest rcs0: SUCCESS (2.021s) [688.969879] Starting dynamic subtest: bcs0 [690.975546] Dynamic subtest bcs0: SUCCESS (2.021s) [690.986154] Starting dynamic subtest: vcs0 [692.998796] Dynamic subtest vcs0: SUCCESS (2.020s) [693.009450] Starting dynamic subtest: vcs1 [695.017843] Dynamic subtest vcs1: SUCCESS (2.019s) [695.027920] Starting dynamic subtest: vecs0 [697.037930] Dynamic subtest vecs0: SUCCESS (2.018s) [697.049168] Starting dynamic subtest: ccs0 [699.059364] Dynamic subtest ccs0: SUCCESS (2.022s) [699.061398] Subtest fairslice: SUCCESS (12.127s) [699.380455] [129/131] (325s left) gem_exec_parallel (basic) [699.442139] Starting subtest: basic [699.444551] Starting dynamic subtest: rcs0 [701.029855] Dynamic subtest rcs0: SUCCESS (1.587s) [701.042560] Starting dynamic subtest: bcs0 [702.550220] Dynamic subtest bcs0: SUCCESS (1.517s) [702.562563] Starting dynamic subtest: vcs0 [704.355871] Dynamic subtest vcs0: SUCCESS (1.801s) [704.367159] Starting dynamic subtest: vcs1 [706.280598] Dynamic subtest vcs1: SUCCESS (1.923s) [706.292965] Starting dynamic subtest: vecs0 [708.304598] Dynamic subtest vecs0: SUCCESS (2.022s) [708.327270] Starting dynamic subtest: ccs0 [709.807585] Dynamic subtest ccs0: SUCCESS (1.502s) [709.810090] Subtest basic: SUCCESS (10.365s) [710.020895] [130/131] (315s left) kms_plane_alpha_blend (coverage-7efc) [710.118650] Starting subtest: coverage-7efc [710.399891] Starting dynamic subtest: pipe-A-eDP-1 [710.988348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s) [711.014213] Starting dynamic subtest: pipe-D-eDP-1 [712.318576] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s) [712.320890] Subtest coverage-7efc: SUCCESS (2.200s) [713.150537] [131/131] (312s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [713.219556] Starting subtest: etime-multi-wait-all-for-submit-submitted [713.325297] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s) [713.419776] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_vm_create results: parsing output: 2/ for test: gen7_exec_parse results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: gem_render_copy 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_frontbuffer_tracking results: parsing output: 9/ for test: gem_ctx_engines results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: core_auth results: parsing output: 12/ for test: kms_hdmi_inject results: parsing output: 13/ for test: drm_read results: parsing output: 14/ for test: kms_psr2_sf results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_partial_pwrite_pread results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: gem_exec_balancer results: parsing output: 19/ for test: syncobj_basic results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_rotation_crc results: parsing output: 23/ for test: kms_big_fb results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: gem_render_copy results: parsing output: 26/ for test: kms_content_protection results: parsing output: 27/ for test: kms_cursor_edge_walk results: parsing output: 28/ for test: kms_dp_link_training results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: kms_flip_scaled_crc results: parsing output: 32/ for test: gem_eio results: parsing output: 33/ for test: i915_drm_fdinfo results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: perf_pmu results: parsing output: 36/ for test: gem_spin_batch results: parsing output: 37/ for test: kms_psr results: parsing output: 38/ for test: gem_exec_fence results: parsing output: 39/ for test: kms_pipe_crc_basic results: parsing output: 40/ for test: kms_pm_rpm results: parsing output: 41/ for test: kms_psr2_sf results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_invalid_mode results: parsing output: 44/ for test: api_intel_allocator results: parsing output: 45/ for test: kms_lease results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: prime_vgem results: parsing output: 48/ for test: gem_workarounds results: parsing output: 49/ for test: kms_prop_blob results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: kms_vblank results: parsing output: 52/ for test: gem_ccs results: parsing output: 53/ for test: kms_cursor_legacy results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: gem_lmem_swapping results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: i915_pm_rps results: parsing output: 59/ for test: kms_pm_backlight results: parsing output: 60/ for test: gem_fenced_exec_thrash results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_ccs results: parsing output: 65/ for test: kms_async_flips results: parsing output: 66/ for test: gen3_render_mixed_blits results: parsing output: 67/ for test: kms_atomic_transition results: parsing output: 68/ for test: vgem_basic results: parsing output: 69/ for test: gem_ctx_persistence results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: api_intel_bb results: parsing output: 72/ for test: kms_cursor_crc results: parsing output: 73/ for test: gem_ppgtt results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: gem_exec_reloc results: parsing output: 76/ for test: i915_drm_fdinfo results: parsing output: 77/ for test: gem_exec_whisper results: parsing output: 78/ for test: sysfs_heartbeat_interval results: parsing output: 79/ for test: gem_exec_whisper results: parsing output: 80/ for test: prime_vgem results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_flink_basic results: parsing output: 84/ for test: gem_exec_reloc results: parsing output: 85/ for test: core_setmaster results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: sw_sync results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: i915_pm_rps results: parsing output: 92/ for test: kms_cursor_crc results: parsing output: 93/ for test: gem_exec_reloc results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: gem_ctx_shared results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_atomic_transition results: parsing output: 100/ for test: gem_exec_params results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_render_copy results: parsing output: 103/ for test: kms_chamelium_hpd results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_chamelium_frames results: parsing output: 106/ for test: gem_ctx_exec results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: vgem_basic results: parsing output: 109/ for test: kms_cursor_legacy results: parsing output: 110/ for test: kms_vblank results: parsing output: 111/ for test: kms_getfb results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_plane_scaling results: parsing output: 114/ for test: template results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_busy results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: prime_mmap results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: perf results: parsing output: 124/ for test: gem_exec_schedule results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: gem_exec_parallel results: parsing output: 129/ for test: kms_plane_alpha_blend results: parsing output: 130/ for test: syncobj_timeline Done.