[57.596339] Initializing watchdogs [57.596388] /dev/watchdog0 [57.610267] [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] [57.614997] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.617497] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.620963] [001/132] (960s left) sysfs_preempt_timeout (timeout) [57.700801] Starting subtest: timeout [57.703209] Starting dynamic subtest: vecs0 [66.953296] Dynamic subtest vecs0: SUCCESS (9.249s) [66.961702] Starting dynamic subtest: ccs0 [68.562817] Dynamic subtest ccs0: SUCCESS (1.608s) [68.575055] Starting dynamic subtest: vcs0 [77.908745] Dynamic subtest vcs0: SUCCESS (9.346s) [77.918706] Starting dynamic subtest: bcs0 [79.011398] Dynamic subtest bcs0: SUCCESS (1.102s) [79.021897] Starting dynamic subtest: rcs0 [80.191438] Dynamic subtest rcs0: SUCCESS (1.180s) [80.199583] Starting dynamic subtest: vcs1 [89.938494] Dynamic subtest vcs1: SUCCESS (9.744s) [89.941107] Subtest timeout: SUCCESS (32.234s) [90.007311] [002/132] (928s left) kms_properties (get_properties-sanity-non-atomic) [90.102517] Starting subtest: get_properties-sanity-non-atomic [90.104773] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [90.195852] [003/132] (927s left) syncobj_timeline (device-signal-unordered) [90.258839] Starting subtest: device-signal-unordered [90.261257] Subtest device-signal-unordered: SUCCESS (0.001s) [90.364709] [004/132] (927s left) gem_pxp (hw-rejects-pxp-buffer) [90.485713] Starting subtest: hw-rejects-pxp-buffer [90.490545] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [90.588972] [005/132] (927s left) syncobj_wait (invalid-reset-one-illegal-handle) [90.637807] Starting subtest: invalid-reset-one-illegal-handle [90.639654] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [90.730885] [006/132] (927s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [90.818726] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [90.857735] Starting dynamic subtest: pipe-A-plane-0 [91.157953] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s) [91.167391] Starting dynamic subtest: pipe-A-plane-3 [91.390970] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [91.399035] Starting dynamic subtest: pipe-A-plane-5 [91.402851] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [92.486073] Starting dynamic subtest: pipe-B-plane-0 [92.787072] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [92.794468] Starting dynamic subtest: pipe-B-plane-3 [93.020519] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [93.029279] Starting dynamic subtest: pipe-B-plane-5 [93.033542] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [93.348227] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.531s) [94.164900] [007/132] (924s left) kms_plane_multiple (tiling-x) [94.257856] Starting subtest: tiling-x [94.260102] Starting dynamic subtest: pipe-A-eDP-1 [98.013950] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.757s) [98.025228] Starting dynamic subtest: pipe-B-eDP-1 [102.457106] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.442s) [102.466631] Starting dynamic subtest: pipe-C-eDP-1 [106.884239] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.428s) [106.892693] Starting dynamic subtest: pipe-D-eDP-1 [111.247654] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.362s) [111.250038] Subtest tiling-x: SUCCESS (16.992s) [112.058236] [008/132] (906s left) api_intel_bb (lot-of-buffers) [112.117926] Starting subtest: lot-of-buffers [113.182576] Subtest lot-of-buffers: SUCCESS (1.066s) [113.605700] [009/132] (904s left) kms_cursor_crc (cursor-rapid-movement-512x512) [113.878755] Starting subtest: cursor-rapid-movement-512x512 [113.882662] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [114.050133] [010/132] (904s left) gem_ctx_sseu (invalid-sseu) [114.114605] Subtest invalid-sseu: SKIP (0.000s) [114.177908] [011/132] (904s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [114.264474] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [114.268760] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [114.368641] [012/132] (904s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [114.469641] Starting subtest: extended-modeset-hang-oldfb-with-reset [114.471858] Starting dynamic subtest: pipe-A [126.439950] Dynamic subtest pipe-A: SUCCESS (11.967s) [126.456815] Starting dynamic subtest: pipe-D [138.702140] Dynamic subtest pipe-D: SUCCESS (12.261s) [138.704494] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.233s) [139.507498] [013/132] (879s left) gem_exec_reloc (basic-softpin) [139.571145] Subtest basic-softpin: SKIP (0.000s) [139.642577] [014/132] (878s left) perf (non-sampling-read-error) [139.764687] Starting subtest: non-sampling-read-error [139.776762] Subtest non-sampling-read-error: SUCCESS (0.011s) [139.821192] [015/132] (878s left) kms_frontbuffer_tracking (fbc-tiling-4) [139.912288] Starting subtest: fbc-tiling-4 [144.097439] Subtest fbc-tiling-4: SUCCESS (4.188s) [145.215083] [016/132] (873s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [145.325297] Starting subtest: compare-crc-sanitycheck-nv12 [145.327573] Starting dynamic subtest: pipe-A-eDP-1 [146.021324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s) [146.031128] Starting dynamic subtest: pipe-B-eDP-1 [147.308257] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s) [147.321320] Starting dynamic subtest: pipe-C-eDP-1 [148.590757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.282s) [148.601127] Starting dynamic subtest: pipe-D-eDP-1 [149.841443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s) [149.843510] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.516s) [150.676908] [017/132] (868s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [150.774576] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [150.778969] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [150.865164] [018/132] (867s left) kms_big_fb (x-tiled-32bpp-rotate-270) [150.968306] Starting subtest: x-tiled-32bpp-rotate-270 [150.988321] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [151.101948] [019/132] (867s left) gem_exec_suspend (basic-s4-devices) [151.164369] Starting subtest: basic-S4-devices [151.167512] Starting dynamic subtest: smem [163.927968] Dynamic subtest smem: SUCCESS (12.760s) [163.931223] Subtest basic-S4-devices: SUCCESS (12.762s) [169.127627] [020/132] (854s left) kms_psr (fbc-psr2-sprite-render) [169.261931] Starting subtest: fbc-psr2-sprite-render [169.264350] Starting dynamic subtest: eDP-1 [169.268782] Dynamic subtest eDP-1: SKIP (0.000s) [169.273333] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [169.333021] [021/132] (854s left) gem_partial_pwrite_pread (write-snoop) [169.387171] Subtest write-snoop: SKIP (0.000s) [169.467852] [022/132] (854s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [169.583612] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [169.588116] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [169.722864] [023/132] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [169.830712] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [169.835159] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [169.937482] [024/132] (854s left) kms_pm_rpm (basic-pci-d3-state) [172.074992] Starting subtest: basic-pci-d3-state [173.543492] Subtest basic-pci-d3-state: SUCCESS (1.473s) [173.639184] [025/132] (850s left) kms_invalid_mode (bad-vsync-end) [173.736410] Starting subtest: bad-vsync-end [173.738746] Starting dynamic subtest: pipe-A-eDP-1 [174.032397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [174.042248] Starting dynamic subtest: pipe-B-eDP-1 [174.044467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [174.053382] Starting dynamic subtest: pipe-C-eDP-1 [174.055300] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [174.063605] Starting dynamic subtest: pipe-D-eDP-1 [174.065506] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [174.067435] Subtest bad-vsync-end: SUCCESS (0.302s) [174.842396] [026/132] (849s left) gem_pxp (create-valid-protected-context) [174.943863] Starting subtest: create-valid-protected-context [174.946304] Subtest create-valid-protected-context: SUCCESS (0.002s) [175.047923] [027/132] (849s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [175.110284] Starting subtest: map-fixed-invalidate-overlap-busy [175.114639] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [175.219852] [028/132] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [175.317331] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [175.321387] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [175.412674] [029/132] (848s left) gem_mmap_offset (partial-unmap) [175.467961] Starting subtest: partial-unmap [175.469877] Starting dynamic subtest: smem0 [175.977352] Dynamic subtest smem0: SUCCESS (0.509s) [175.979900] Subtest partial-unmap: SUCCESS (0.510s) [176.100812] [030/132] (848s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [176.190343] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [176.192835] Starting dynamic subtest: pipe-A-eDP-1 [176.219722] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [176.229286] Starting dynamic subtest: pipe-B-eDP-1 [176.253388] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [176.262169] Starting dynamic subtest: pipe-C-eDP-1 [176.286528] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [176.295296] Starting dynamic subtest: pipe-D-eDP-1 [176.320222] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [176.324279] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [178.503494] [031/132] (845s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [178.613061] Starting subtest: yf-tiled-32bpp-rotate-270 [178.617484] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [178.722340] [032/132] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [178.817627] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [185.949344] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.135s) [186.075198] [033/132] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [186.183509] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [186.187598] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [186.283980] [034/132] (838s left) kms_psr (pr-primary-mmap-cpu) [186.378169] Starting subtest: pr-primary-mmap-cpu [186.382554] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [186.496356] [035/132] (838s left) api_intel_allocator (simple-allocator) [186.551102] Starting subtest: simple-allocator [186.553455] Starting dynamic subtest: basic [186.555747] Dynamic subtest basic: SUCCESS (0.004s) [186.567412] Starting dynamic subtest: parallel-one [186.733235] Dynamic subtest parallel-one: SUCCESS (0.179s) [186.742400] Starting dynamic subtest: print [186.744702] Dynamic subtest print: SUCCESS (0.000s) [186.754133] Starting dynamic subtest: reuse [186.756308] Dynamic subtest reuse: SUCCESS (0.000s) [186.765048] Starting dynamic subtest: reserve [186.767177] Dynamic subtest reserve: SUCCESS (0.000s) [186.776063] Starting dynamic subtest: fork-reopen-allocator [186.778177] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [186.780289] Subtest simple-allocator: SUCCESS (0.200s) [186.854514] [036/132] (837s left) kms_vblank (ts-continuation-dpms-suspend) [186.953061] Starting subtest: ts-continuation-dpms-suspend [186.955424] Starting dynamic subtest: pipe-A-eDP-1 [204.227286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.966s) [204.242770] Starting dynamic subtest: pipe-D-eDP-1 [222.175616] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s) [222.177606] Subtest ts-continuation-dpms-suspend: SUCCESS (4.497s) [222.984079] [037/132] (801s left) kms_cursor_edge_walk (256x256-top-bottom) [223.086023] Starting subtest: 256x256-top-bottom [223.088290] Starting dynamic subtest: pipe-A-eDP-1 [226.539674] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s) [226.549630] Starting dynamic subtest: pipe-D-eDP-1 [229.681406] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s) [229.683501] Subtest 256x256-top-bottom: SUCCESS (6.594s) [230.483665] [038/132] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [230.582489] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [238.254724] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.675s) [238.368042] [039/132] (786s left) gen9_exec_parse (basic-rejected) [238.441794] Subtest basic-rejected: SKIP (0.000s) [238.506555] [040/132] (786s left) kms_display_modes (extended-mode-basic) [238.602900] Starting subtest: extended-mode-basic [238.607328] Subtest extended-mode-basic: SKIP (0.000s) [238.649572] [041/132] (786s left) gem_exec_reloc (basic-write-wc-noreloc) [238.709444] Subtest basic-write-wc-noreloc: SKIP (0.000s) [238.783590] [042/132] (786s left) gem_exec_whisper (basic-contexts-priority-all) [238.848736] Starting subtest: basic-contexts-priority-all [261.569063] Subtest basic-contexts-priority-all: SUCCESS (22.712s) [261.749584] [043/132] (763s left) perf (invalid-create-userspace-config) [261.852851] Starting subtest: invalid-create-userspace-config [261.856060] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [261.896377] [044/132] (762s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [261.993136] Starting subtest: primary-y-tiled-reflect-x-180 [262.053442] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [262.156554] [045/132] (762s left) perf_pmu (most-busy-check-all) [262.198426] Starting subtest: most-busy-check-all [262.200258] Starting dynamic subtest: rcs0 [263.642982] Dynamic subtest rcs0: SUCCESS (1.443s) [263.657130] Starting dynamic subtest: bcs0 [265.628184] Dynamic subtest bcs0: SUCCESS (1.981s) [265.641532] Starting dynamic subtest: vcs0 [267.612290] Dynamic subtest vcs0: SUCCESS (1.981s) [267.628213] Starting dynamic subtest: vcs1 [269.661209] Dynamic subtest vcs1: SUCCESS (2.045s) [269.673044] Starting dynamic subtest: vecs0 [271.644292] Dynamic subtest vecs0: SUCCESS (1.981s) [271.657595] Starting dynamic subtest: ccs0 [273.628334] Dynamic subtest ccs0: SUCCESS (1.981s) [273.631349] Subtest most-busy-check-all: SUCCESS (11.428s) [273.718877] [046/132] (751s left) kms_psr2_su (page_flip-xrgb8888) [273.777097] Subtest page_flip-XRGB8888: SKIP (0.000s) [273.835532] [047/132] (751s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [273.932333] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [280.533011] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.602s) [280.669494] [048/132] (744s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [280.776832] Starting subtest: async-flip-with-page-flip-events-linear-atomic [281.149821] Starting dynamic subtest: pipe-A-eDP-1 [283.887532] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s) [284.274363] Starting dynamic subtest: pipe-B-eDP-1 [287.026683] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s) [287.398188] Starting dynamic subtest: pipe-C-eDP-1 [290.156200] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s) [290.540982] Starting dynamic subtest: pipe-D-eDP-1 [293.284610] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.753s) [293.287509] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.508s) [294.465225] [049/132] (730s left) kms_psr (fbc-pr-primary-page-flip) [294.564233] Starting subtest: fbc-pr-primary-page-flip [294.568299] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [294.639615] [050/132] (730s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [294.703167] Starting subtest: invalid-single-wait-all-unsubmitted [294.705383] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [294.815516] [051/132] (730s left) gem_eio (banned) [295.016861] Starting subtest: banned [295.551227] Subtest banned: SUCCESS (0.535s) [295.705263] [052/132] (729s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [295.807697] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [295.811692] Starting dynamic subtest: A-eDP1 [299.391400] Dynamic subtest A-eDP1: SUCCESS (3.580s) [299.402996] Starting dynamic subtest: B-eDP1 [302.591237] Dynamic subtest B-eDP1: SUCCESS (3.199s) [302.601446] Starting dynamic subtest: C-eDP1 [305.703713] Dynamic subtest C-eDP1: SUCCESS (3.111s) [305.714727] Starting dynamic subtest: D-eDP1 [308.836635] Dynamic subtest D-eDP1: SUCCESS (3.130s) [308.838950] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.027s) [309.630031] [053/132] (715s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [309.738195] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [309.742256] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [309.831429] [054/132] (715s left) gem_busy (extended) [310.017574] Starting subtest: extended [310.020184] Starting dynamic subtest: rcs0 [310.113329] Dynamic subtest rcs0: SUCCESS (0.096s) [310.127646] Starting dynamic subtest: bcs0 [310.157215] Dynamic subtest bcs0: SUCCESS (0.042s) [310.169874] Starting dynamic subtest: vcs0 [311.580513] Dynamic subtest vcs0: SUCCESS (1.419s) [311.594154] Starting dynamic subtest: vcs1 [313.591641] Dynamic subtest vcs1: SUCCESS (1.979s) [313.604926] Starting dynamic subtest: vecs0 [315.611931] Dynamic subtest vecs0: SUCCESS (2.046s) [315.629496] Starting dynamic subtest: ccs0 [315.657803] Dynamic subtest ccs0: SUCCESS (0.044s) [315.660221] Subtest extended: SUCCESS (5.642s) [315.909490] [055/132] (709s left) gem_exec_reloc (basic-concurrent16) [315.957359] Subtest basic-concurrent16: SKIP (0.000s) [316.023390] [056/132] (709s left) gem_lmem_swapping (massive) [316.068317] Subtest massive: SKIP (0.000s) [316.113910] [057/132] (709s left) gem_spin_batch (resubmit-new) [316.185414] Starting subtest: resubmit-new [316.187980] Starting dynamic subtest: rcs0 [316.198231] Dynamic subtest rcs0: SUCCESS (0.016s) [316.211811] Starting dynamic subtest: bcs0 [316.214390] Dynamic subtest bcs0: SUCCESS (0.006s) [316.232401] Starting dynamic subtest: vcs0 [316.234319] Dynamic subtest vcs0: SUCCESS (0.007s) [316.244307] Starting dynamic subtest: vcs1 [316.246576] Dynamic subtest vcs1: SUCCESS (0.009s) [316.256263] Starting dynamic subtest: vecs0 [316.258223] Dynamic subtest vecs0: SUCCESS (0.013s) [316.267808] Starting dynamic subtest: ccs0 [316.269736] Dynamic subtest ccs0: SUCCESS (0.007s) [316.271658] Subtest resubmit-new: SUCCESS (0.064s) [317.701028] [058/132] (707s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [317.803202] Starting subtest: crc-primary-suspend-y-tiled-ccs [317.805537] Starting dynamic subtest: pipe-A-eDP-1 [317.815284] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [317.828639] Starting dynamic subtest: pipe-B-eDP-1 [317.838029] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [317.847959] Starting dynamic subtest: pipe-C-eDP-1 [317.862041] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [317.871462] Starting dynamic subtest: pipe-D-eDP-1 [317.880609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [317.884738] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [320.110891] [059/132] (705s left) i915_pm_rpm (gem-execbuf-stress-pc8) [321.759584] Starting subtest: gem-execbuf-stress-pc8 [321.802236] Subtest gem-execbuf-stress-pc8: SKIP (0.043s) [322.352479] [060/132] (703s left) kms_async_flips (test-cursor-atomic) [322.445928] Starting subtest: test-cursor-atomic [322.818969] Starting dynamic subtest: pipe-A-eDP-1 [323.637990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s) [324.030985] Starting dynamic subtest: pipe-B-eDP-1 [324.764335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.749s) [325.144491] Starting dynamic subtest: pipe-C-eDP-1 [325.895842] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s) [326.270042] Starting dynamic subtest: pipe-D-eDP-1 [327.025214] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s) [327.027542] Subtest test-cursor-atomic: SUCCESS (4.582s) [328.214176] [061/132] (697s left) gem_ctx_persistence (idempotent) [328.265250] Starting subtest: idempotent [328.267511] Subtest idempotent: SUCCESS (0.000s) [328.393742] [062/132] (697s left) gem_exec_reloc (basic-wc-cpu-active) [328.457198] Subtest basic-wc-cpu-active: SKIP (0.000s) [328.576623] [063/132] (697s left) syncobj_timeline (wait-all-for-submit-complex) [328.638906] Starting subtest: wait-all-for-submit-complex [328.853996] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [328.945141] [064/132] (696s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [329.049919] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [336.364243] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.317s) [336.488674] [065/132] (689s left) kms_psr (psr-sprite-plane-onoff) [336.588860] Starting subtest: psr-sprite-plane-onoff [336.591138] Starting dynamic subtest: eDP-1 [338.355161] Dynamic subtest eDP-1: SUCCESS (1.766s) [338.357536] Subtest psr-sprite-plane-onoff: SUCCESS (1.767s) [339.168341] [066/132] (686s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [339.264645] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [339.266933] Starting dynamic subtest: pipe-A-eDP-1 [339.288919] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [339.300730] Starting dynamic subtest: pipe-B-eDP-1 [339.321402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [339.331106] Starting dynamic subtest: pipe-C-eDP-1 [339.352001] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [339.361339] Starting dynamic subtest: pipe-D-eDP-1 [339.383791] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [339.388572] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s) [341.536038] [067/132] (684s left) gem_exec_nop (basic-parallel) [341.603378] Starting subtest: basic-parallel [357.660504] Subtest basic-parallel: SUCCESS (16.063s) [357.926175] [068/132] (668s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [358.036644] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [358.038926] Starting dynamic subtest: pipe-A-eDP-1 [358.060542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [358.072483] Starting dynamic subtest: pipe-B-eDP-1 [358.093220] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [358.102785] Starting dynamic subtest: pipe-C-eDP-1 [358.122902] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [358.132332] Starting dynamic subtest: pipe-D-eDP-1 [358.154190] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [358.158598] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [360.302888] [069/132] (665s left) syncobj_timeline (invalid-query-zero-handles) [360.373386] Starting subtest: invalid-query-zero-handles [360.375561] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [360.470052] [070/132] (665s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [360.567996] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [360.572241] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [360.677024] [071/132] (665s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [360.777587] Starting subtest: fbcpsr-rgb101010-draw-pwrite [367.794942] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.019s) [367.928997] [072/132] (658s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [367.988955] Starting subtest: etime-single-wait-all-available-unsubmitted [368.095395] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s) [368.170936] [073/132] (657s left) i915_drm_fdinfo (busy-check-all) [368.209821] Starting subtest: busy-check-all [368.212147] Starting dynamic subtest: rcs0 [368.216930] Dynamic subtest rcs0: SKIP (0.003s) [368.234308] Starting dynamic subtest: bcs0 [368.238807] Dynamic subtest bcs0: SKIP (0.000s) [368.251735] Starting dynamic subtest: vcs0 [368.256365] Dynamic subtest vcs0: SKIP (0.000s) [368.266190] Starting dynamic subtest: vcs1 [368.270530] Dynamic subtest vcs1: SKIP (0.000s) [368.280319] Starting dynamic subtest: vecs0 [368.284693] Dynamic subtest vecs0: SKIP (0.000s) [368.294220] Starting dynamic subtest: ccs0 [368.298538] Dynamic subtest ccs0: SKIP (0.000s) [368.302974] Subtest busy-check-all: SKIP (0.009s) [368.339067] [074/132] (657s left) gem_ctx_persistence (engines-hang) [368.417240] Starting subtest: engines-hang [368.419726] Starting dynamic subtest: rcs0 [368.543333] Dynamic subtest rcs0: SUCCESS (0.126s) [368.556322] Starting dynamic subtest: bcs0 [368.636388] Dynamic subtest bcs0: SUCCESS (0.091s) [368.648637] Starting dynamic subtest: vcs0 [368.727353] Dynamic subtest vcs0: SUCCESS (0.089s) [368.740055] Starting dynamic subtest: vcs1 [368.832363] Dynamic subtest vcs1: SUCCESS (0.103s) [368.844958] Starting dynamic subtest: vecs0 [368.943768] Dynamic subtest vecs0: SUCCESS (0.109s) [368.957028] Starting dynamic subtest: ccs0 [369.015314] Dynamic subtest ccs0: SUCCESS (0.069s) [369.017686] Subtest engines-hang: SUCCESS (0.600s) [369.144278] [075/132] (657s left) kms_cdclk (mode-transition) [369.237819] Starting subtest: mode-transition [369.239808] Starting dynamic subtest: pipe-A-eDP-1 [369.544104] Dynamic subtest pipe-A-eDP-1: SKIP (0.304s) [369.554621] Starting dynamic subtest: pipe-B-eDP-1 [369.559020] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [369.568836] Starting dynamic subtest: pipe-C-eDP-1 [369.573396] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [369.583281] Starting dynamic subtest: pipe-D-eDP-1 [369.587781] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [369.591897] Subtest mode-transition: SKIP (0.312s) [370.349917] [076/132] (655s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [370.447174] Starting subtest: plane-use-after-nonblocking-unbind [370.449469] Starting dynamic subtest: pipe-A-eDP-1 [370.508052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [370.827658] Starting dynamic subtest: pipe-B-eDP-1 [371.649602] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.834s) [371.950797] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.504s) [372.835080] [077/132] (653s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [372.943311] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [376.612563] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.673s) [377.815556] [078/132] (648s left) kms_chamelium_color (ctm-red-to-blue) [377.903478] Subtest ctm-red-to-blue: SKIP (0.000s) [377.952443] [079/132] (648s left) kms_atomic_interruptible (legacy-pageflip) [378.058841] Starting subtest: legacy-pageflip [378.061153] Starting dynamic subtest: pipe-A-eDP-1 [385.514067] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.451s) [385.516225] Subtest legacy-pageflip: SUCCESS (7.454s) [386.363986] [080/132] (640s left) gem_exec_balancer (sequential) [386.424602] Starting subtest: sequential [389.511419] Subtest sequential: SUCCESS (3.087s) [389.833597] [081/132] (636s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [389.931044] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [389.935080] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s) [390.002686] [082/132] (636s left) kms_plane (planar-pixel-format-settings) [390.099925] Starting subtest: planar-pixel-format-settings [390.170284] Subtest planar-pixel-format-settings: SUCCESS (0.069s) [390.322386] [083/132] (636s left) gem_exec_flush (basic-wb-pro-default) [390.392806] Starting subtest: basic-wb-pro-default [395.850838] Subtest basic-wb-pro-default: SUCCESS (5.458s) [396.039382] [084/132] (630s left) syncobj_timeline (multi-wait-signaled) [396.097788] Starting subtest: multi-wait-signaled [396.100522] Subtest multi-wait-signaled: SUCCESS (0.001s) [396.205139] [085/132] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [396.301711] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [396.305546] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [396.383469] [086/132] (630s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [396.480361] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [397.293743] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s) [397.497474] [087/132] (629s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [397.564179] Starting subtest: yf-tiled-to-vebox-x-tiled [397.568008] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [397.744128] [088/132] (629s left) gem_ctx_create (basic) [397.806141] Starting subtest: basic [397.808103] Subtest basic: SUCCESS (0.000s) [397.984702] [089/132] (628s left) syncobj_basic (bad-flags-fd-to-handle) [398.045710] Starting subtest: bad-flags-fd-to-handle [398.048043] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [398.161997] [090/132] (628s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [398.256780] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [398.261010] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [398.330477] [091/132] (628s left) kms_hdmi_inject (inject-4k) [398.692165] Starting subtest: inject-4k [399.008033] Subtest inject-4k: SUCCESS (0.319s) [399.520213] [092/132] (627s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [399.627234] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [399.631580] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [399.709250] [093/132] (627s left) kms_feature_discovery (display) [399.804679] Starting subtest: display [399.806924] Subtest display: SUCCESS (0.000s) [399.891576] [094/132] (627s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [399.984406] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [399.988527] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [400.088873] [095/132] (627s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [400.187916] Starting subtest: yf-tiled-64bpp-rotate-180 [400.191847] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [400.285889] [096/132] (626s left) kms_lease (page-flip-implicit-plane) [400.383171] Starting subtest: page-flip-implicit-plane [400.385065] Starting dynamic subtest: pipe-A-eDP-1 [400.862565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s) [400.873922] Starting dynamic subtest: pipe-B-eDP-1 [402.010819] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s) [402.022043] Starting dynamic subtest: pipe-C-eDP-1 [403.177687] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.167s) [403.188861] Starting dynamic subtest: pipe-D-eDP-1 [404.271166] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s) [404.273545] Subtest page-flip-implicit-plane: SUCCESS (3.890s) [405.088152] [097/132] (622s left) kms_chamelium_hpd (vga-hpd-after-suspend) [405.480663] Subtest vga-hpd-after-suspend: SKIP (0.000s) [406.265471] [098/132] (621s left) i915_module_load (reload) [406.304104] Starting subtest: reload [409.710217] Subtest reload: SUCCESS (3.408s) [409.772116] [099/132] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [411.631372] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [411.635865] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [411.733179] [100/132] (615s left) syncobj_wait (invalid-reset-illegal-handle) [411.784693] Starting subtest: invalid-reset-illegal-handle [411.787046] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [411.883120] [101/132] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [411.972975] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [411.976881] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [412.057341] [102/132] (615s left) kms_flip (flip-vs-panning) [412.141848] Starting subtest: flip-vs-panning [412.143784] Starting dynamic subtest: A-eDP1 [420.852355] Dynamic subtest A-eDP1: SUCCESS (8.709s) [420.864790] Starting dynamic subtest: B-eDP1 [429.585522] Dynamic subtest B-eDP1: SUCCESS (8.733s) [429.596638] Starting dynamic subtest: C-eDP1 [438.302271] Dynamic subtest C-eDP1: SUCCESS (8.714s) [438.311574] Starting dynamic subtest: D-eDP1 [447.032019] Dynamic subtest D-eDP1: SUCCESS (8.727s) [447.036435] Subtest flip-vs-panning: SUCCESS (34.894s) [448.210227] [103/132] (579s left) gem_exec_fence (submit) [448.393267] Starting subtest: submit [448.397856] Subtest submit: SKIP (0.000s) [449.679493] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true [449.683146] [104/132] (577s left) kms_pm_rpm (modeset-non-lpsp) [451.717340] Starting subtest: modeset-non-lpsp [452.865533] Subtest modeset-non-lpsp: SKIP (1.148s) [453.273526] [105/132] (574s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [453.372671] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [457.776330] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.407s) [458.964004] [106/132] (568s left) prime_vgem (shrink) [459.046027] Starting subtest: shrink [459.061128] Subtest shrink: SUCCESS (0.013s) [459.181004] [107/132] (568s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [459.277218] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [459.279395] Starting dynamic subtest: pipe-A-eDP-1 [459.363984] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [459.377676] Starting dynamic subtest: pipe-B-eDP-1 [460.523404] Dynamic subtest pipe-B-eDP-1: SKIP (1.158s) [460.527598] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.250s) [461.721986] [108/132] (565s left) gem_tiled_swapping (non-threaded) [461.791406] Subtest non-threaded: SKIP (0.000s) [461.863939] [109/132] (565s left) i915_suspend (sysfs-reader) [461.921873] Starting subtest: sysfs-reader [479.633596] Subtest sysfs-reader: SUCCESS (3.116s) [479.701686] [110/132] (548s left) core_sysfs (read-all-entries) [479.755652] Starting subtest: read-all-entries [479.757623] Subtest read-all-entries: SUCCESS (0.002s) [479.857395] [111/132] (548s left) kms_cursor_crc (cursor-dpms) [479.992845] Starting subtest: cursor-dpms [479.994750] Starting dynamic subtest: pipe-A-eDP-1 [483.066514] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.069s) [483.076839] Starting dynamic subtest: pipe-D-eDP-1 [486.683992] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.615s) [486.685998] Subtest cursor-dpms: SUCCESS (6.687s) [487.518660] [112/132] (540s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [487.609274] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [487.611537] Starting dynamic subtest: pipe-A [488.656854] Dynamic subtest pipe-A: SUCCESS (1.050s) [488.666579] Starting dynamic subtest: pipe-B [490.826693] Dynamic subtest pipe-B: SUCCESS (2.168s) [490.835864] Starting dynamic subtest: pipe-C [492.020115] Dynamic subtest pipe-C: SUCCESS (1.191s) [492.032371] Starting dynamic subtest: pipe-D [493.260845] Dynamic subtest pipe-D: SUCCESS (1.238s) [493.263151] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.653s) [494.442288] [113/132] (533s left) gem_exec_schedule (preemptive-hang) [494.630629] Starting subtest: preemptive-hang [494.632901] Starting dynamic subtest: rcs0 [504.336579] Dynamic subtest rcs0: SUCCESS (9.707s) [504.346848] Starting dynamic subtest: bcs0 [513.353987] Dynamic subtest bcs0: SUCCESS (9.010s) [513.365075] Starting dynamic subtest: vcs0 [522.379307] Dynamic subtest vcs0: SUCCESS (9.015s) [522.393896] Starting dynamic subtest: vcs1 [531.402268] Dynamic subtest vcs1: SUCCESS (9.014s) [531.415135] Starting dynamic subtest: vecs0 [540.358134] Dynamic subtest vecs0: SUCCESS (8.949s) [540.370495] Starting dynamic subtest: ccs0 [549.329442] Dynamic subtest ccs0: SUCCESS (8.967s) [549.332108] Subtest preemptive-hang: SUCCESS (54.672s) [549.581351] [114/132] (478s left) kms_psr (psr2-suspend) [549.671336] Starting subtest: psr2-suspend [549.673715] Starting dynamic subtest: eDP-1 [567.055133] Dynamic subtest eDP-1: SUCCESS (2.840s) [567.057608] Subtest psr2-suspend: SUCCESS (2.841s) [567.940360] [115/132] (460s left) gem_exec_params (secure-non-root) [568.012430] Starting subtest: secure-non-root [568.017011] Subtest secure-non-root: SKIP (0.000s) [568.124186] [116/132] (459s left) gem_ctx_exec (basic-invalid-context) [568.174100] Starting subtest: basic-invalid-context [568.178775] Subtest basic-invalid-context: SUCCESS (0.005s) [568.322304] [117/132] (459s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [568.442878] Starting subtest: cursorA-vs-flipA-toggle [579.582794] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.135s) [580.380807] [118/132] (447s left) sw_sync (sync_merge) [580.424481] Starting subtest: sync_merge [580.426641] Subtest sync_merge: SUCCESS (0.000s) [580.487115] [119/132] (447s left) kms_content_protection (type1) [580.634692] Starting subtest: type1 [580.639348] Subtest type1: SKIP (0.000s) [580.769888] [120/132] (447s left) gem_userptr_blits (huge-split) [580.841020] Starting subtest: huge-split [580.847779] Subtest huge-split: SUCCESS (0.007s) [581.013561] [121/132] (447s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [581.101005] Starting subtest: psr-2p-scndscrn-spr-indfb-move [581.105364] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [581.191520] [122/132] (447s left) gem_lmem_swapping (verify-random-ccs) [581.233863] Subtest verify-random-ccs: SKIP (0.000s) [581.274629] [123/132] (447s left) gem_exec_balancer (individual) [581.339391] Starting subtest: individual [582.773821] Subtest individual: SUCCESS (1.432s) [583.083815] [124/132] (445s left) perf (gen12-group-concurrent-oa-buffer-read) [583.213623] Starting subtest: gen12-group-concurrent-oa-buffer-read [593.254307] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.038s) [593.304758] [125/132] (435s left) syncobj_wait (invalid-signal-illegal-handle) [593.366598] Starting subtest: invalid-signal-illegal-handle [593.368922] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [593.468579] [126/132] (435s left) kms_flip (bo-too-big) [593.563395] Starting subtest: bo-too-big [593.565494] Starting dynamic subtest: A-eDP1 [594.829749] Dynamic subtest A-eDP1: SUCCESS (1.267s) [594.843152] Starting dynamic subtest: B-eDP1 [596.186995] Dynamic subtest B-eDP1: SUCCESS (1.356s) [596.200375] Starting dynamic subtest: C-eDP1 [597.498158] Dynamic subtest C-eDP1: SUCCESS (1.310s) [597.510206] Starting dynamic subtest: D-eDP1 [598.836428] Dynamic subtest D-eDP1: SUCCESS (1.335s) [598.838929] Subtest bo-too-big: SUCCESS (5.277s) [600.034699] [127/132] (428s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [600.138009] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [601.205722] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.069s) [601.328958] [128/132] (427s left) gem_exec_schedule (u-semaphore-user) [601.394786] Starting subtest: u-semaphore-user [601.447363] Subtest u-semaphore-user: SUCCESS (0.056s) [602.846067] [129/132] (425s left) kms_sequence (get-forked-busy) [602.948780] Starting subtest: get-forked-busy [602.951271] Starting dynamic subtest: pipe-A-eDP-1 [604.889172] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [604.902655] Starting dynamic subtest: pipe-B-eDP-1 [607.537971] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.648s) [607.550856] Starting dynamic subtest: pipe-C-eDP-1 [610.159938] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s) [610.170804] Starting dynamic subtest: pipe-D-eDP-1 [612.790122] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s) [612.792439] Subtest get-forked-busy: SUCCESS (9.838s) [613.602025] [130/132] (415s left) syncobj_basic (bad-pad-fd-to-handle) [613.649949] Starting subtest: bad-pad-fd-to-handle [613.652292] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [613.744405] [131/132] (415s left) perf_pmu (interrupts) [613.782124] Starting subtest: interrupts [614.852201] Subtest interrupts: SUCCESS (1.071s) [614.963801] [132/132] (413s left) kms_color_pipeline (plane-ctm3x4-lut1d) [615.083480] Starting subtest: plane-ctm3x4-lut1d [615.245531] Starting dynamic subtest: pipe-A-plane-0 [615.411804] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [615.422512] Starting dynamic subtest: pipe-A-plane-1 [615.601601] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [615.612220] Starting dynamic subtest: pipe-A-plane-2 [615.756654] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [616.997413] Starting dynamic subtest: pipe-B-plane-0 [617.152839] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [617.163379] Starting dynamic subtest: pipe-B-plane-1 [617.342769] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [617.353426] Starting dynamic subtest: pipe-B-plane-2 [617.509405] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [618.731400] Starting dynamic subtest: pipe-C-plane-0 [618.878745] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [618.888988] Starting dynamic subtest: pipe-C-plane-1 [619.012113] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s) [619.021991] Starting dynamic subtest: pipe-C-plane-2 [619.167639] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [620.366391] Starting dynamic subtest: pipe-D-plane-0 [620.502588] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [620.512807] Starting dynamic subtest: pipe-D-plane-1 [620.658347] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [620.671998] Starting dynamic subtest: pipe-D-plane-2 [620.813862] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [621.112508] Subtest plane-ctm3x4-lut1d: SUCCESS (6.026s) [621.920813] Closing watchdogs results: parsing output: 0/ for test: sysfs_preempt_timeout results: parsing output: 1/ for test: kms_properties results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: gem_pxp results: parsing output: 4/ for test: syncobj_wait results: parsing output: 5/ for test: kms_plane results: parsing output: 6/ for test: kms_plane_multiple results: parsing output: 7/ for test: api_intel_bb results: parsing output: 8/ for test: kms_cursor_crc results: parsing output: 9/ for test: gem_ctx_sseu results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_busy results: parsing output: 12/ for test: gem_exec_reloc results: parsing output: 13/ for test: perf results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_pipe_crc_basic results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: gem_exec_suspend results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: gem_partial_pwrite_pread results: parsing output: 21/ for test: kms_cursor_legacy results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_pm_rpm results: parsing output: 24/ for test: kms_invalid_mode results: parsing output: 25/ for test: gem_pxp results: parsing output: 26/ for test: gem_userptr_blits results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_mmap_offset results: parsing output: 29/ for test: kms_ccs results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: api_intel_allocator results: parsing output: 35/ for test: kms_vblank results: parsing output: 36/ for test: kms_cursor_edge_walk results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: kms_display_modes results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: gem_exec_whisper results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: kms_rotation_crc results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: kms_psr2_su results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_async_flips results: parsing output: 48/ for test: kms_psr results: parsing output: 49/ for test: syncobj_wait results: parsing output: 50/ for test: gem_eio results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_busy results: parsing output: 54/ for test: gem_exec_reloc results: parsing output: 55/ for test: gem_lmem_swapping results: parsing output: 56/ for test: gem_spin_batch results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: i915_pm_rpm results: parsing output: 59/ for test: kms_async_flips results: parsing output: 60/ for test: gem_ctx_persistence results: parsing output: 61/ for test: gem_exec_reloc results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: gem_exec_nop results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: i915_drm_fdinfo results: parsing output: 73/ for test: gem_ctx_persistence results: parsing output: 74/ for test: kms_cdclk results: parsing output: 75/ for test: kms_atomic_transition results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_chamelium_color results: parsing output: 78/ for test: kms_atomic_interruptible results: parsing output: 79/ for test: gem_exec_balancer results: parsing output: 80/ for test: kms_flip_scaled_crc results: parsing output: 81/ for test: kms_plane results: parsing output: 82/ for test: gem_exec_flush results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: gem_ctx_create results: parsing output: 88/ for test: syncobj_basic results: parsing output: 89/ for test: kms_flip_scaled_crc results: parsing output: 90/ for test: kms_hdmi_inject results: parsing output: 91/ for test: kms_psr2_sf results: parsing output: 92/ for test: kms_feature_discovery results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_lease results: parsing output: 96/ for test: kms_chamelium_hpd results: parsing output: 97/ for test: i915_module_load results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: gem_exec_fence results: parsing output: 103/ for test: kms_pm_rpm results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: prime_vgem results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: gem_tiled_swapping results: parsing output: 108/ for test: i915_suspend results: parsing output: 109/ for test: core_sysfs results: parsing output: 110/ for test: kms_cursor_crc results: parsing output: 111/ for test: kms_plane_scaling results: parsing output: 112/ for test: gem_exec_schedule results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: gem_exec_params results: parsing output: 115/ for test: gem_ctx_exec results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: sw_sync results: parsing output: 118/ for test: kms_content_protection results: parsing output: 119/ for test: gem_userptr_blits results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_lmem_swapping results: parsing output: 122/ for test: gem_exec_balancer results: parsing output: 123/ for test: perf results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: kms_sequence results: parsing output: 129/ for test: syncobj_basic results: parsing output: 130/ for test: perf_pmu results: parsing output: 131/ for test: kms_color_pipeline Done.