[59.215815] Initializing watchdogs [59.215860] /dev/watchdog0 [59.229972] [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.234610] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.236722] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.240415] [001/132] (960s left) gem_wait (await) [59.333499] Starting subtest: await [59.335931] Starting dynamic subtest: all-engines [60.464625] Dynamic subtest all-engines: SUCCESS (1.141s) [60.479327] Starting dynamic subtest: rcs0 [61.521811] Dynamic subtest rcs0: SUCCESS (1.064s) [61.537579] Starting dynamic subtest: bcs0 [62.579628] Dynamic subtest bcs0: SUCCESS (1.064s) [62.593229] Starting dynamic subtest: vcs0 [63.633438] Dynamic subtest vcs0: SUCCESS (1.059s) [63.646953] Starting dynamic subtest: vcs1 [64.685486] Dynamic subtest vcs1: SUCCESS (1.056s) [64.698240] Starting dynamic subtest: vecs0 [65.738949] Dynamic subtest vecs0: SUCCESS (1.058s) [65.752382] Starting dynamic subtest: ccs0 [66.845271] Dynamic subtest ccs0: SUCCESS (1.110s) [66.847609] Subtest await: SUCCESS (7.558s) [67.088483] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true [67.091893] [002/132] (952s left) kms_psr (fbc-psr-sprite-blt) [67.227910] Starting subtest: fbc-psr-sprite-blt [67.230606] Starting dynamic subtest: eDP-1 [67.234702] Dynamic subtest eDP-1: SKIP (0.000s) [67.238758] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [67.623773] [003/132] (952s left) gem_render_copy (yf-tiled) [67.725635] Starting subtest: yf-tiled [67.730562] Subtest yf-tiled: SKIP (0.000s) [68.009049] [004/132] (951s left) kms_big_fb (y-tiled-32bpp-rotate-180) [68.137992] Starting subtest: y-tiled-32bpp-rotate-180 [68.142271] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [68.228373] [005/132] (951s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [68.357607] Starting subtest: cursorA-vs-flipB-varying-size [68.362347] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [68.510682] [006/132] (951s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [68.599342] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [68.601680] Starting dynamic subtest: pipe-A-eDP-1 [69.497102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.891s) [69.506066] Starting dynamic subtest: pipe-B-eDP-1 [70.990241] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.494s) [70.998831] Starting dynamic subtest: pipe-C-eDP-1 [72.510418] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.523s) [72.519456] Starting dynamic subtest: pipe-D-eDP-1 [74.038439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.530s) [74.040730] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.441s) [75.208133] [007/132] (944s left) gem_exec_fence (invalid-timeline-fence-array) [75.742859] Starting subtest: invalid-timeline-fence-array [75.748866] Subtest invalid-timeline-fence-array: SUCCESS (0.005s) [76.956334] [008/132] (943s left) gem_exec_flush (basic-batch-kernel-default-wb) [77.012118] Starting subtest: basic-batch-kernel-default-wb [82.990663] Subtest basic-batch-kernel-default-wb: SUCCESS (5.979s) [83.192791] [009/132] (936s left) kms_flip (2x-flip-vs-modeset-vs-hang) [83.291848] Starting subtest: 2x-flip-vs-modeset-vs-hang [83.302718] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s) [83.397361] [010/132] (936s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [83.495557] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [83.499610] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [83.584185] [011/132] (936s left) kms_cursor_crc (cursor-sliding-128x128) [83.790824] Starting subtest: cursor-sliding-128x128 [83.793243] Starting dynamic subtest: pipe-A-eDP-1 [87.062301] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.269s) [87.090031] Starting dynamic subtest: pipe-D-eDP-1 [91.015107] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.927s) [91.017458] Subtest cursor-sliding-128x128: SUCCESS (7.222s) [91.892077] [012/132] (928s left) kms_psr (psr-primary-mmap-cpu) [91.983958] Starting subtest: psr-primary-mmap-cpu [91.986289] Starting dynamic subtest: eDP-1 [93.668668] Dynamic subtest eDP-1: SUCCESS (1.686s) [93.670967] Subtest psr-primary-mmap-cpu: SUCCESS (1.686s) [94.543210] [013/132] (925s left) gem_exec_params (rsvd2-dirt) [94.620155] Starting subtest: rsvd2-dirt [94.624989] Subtest rsvd2-dirt: SKIP (0.000s) [94.721145] [014/132] (925s left) kms_big_fb (linear-32bpp-rotate-0) [94.815200] Starting subtest: linear-32bpp-rotate-0 [96.248644] Subtest linear-32bpp-rotate-0: SUCCESS (1.434s) [96.383706] [015/132] (923s left) gem_lmem_swapping (heavy-verify-multi) [96.422396] Subtest heavy-verify-multi: SKIP (0.000s) [96.465974] [016/132] (923s left) gem_ctx_shared (exec-shared-gtt) [96.530247] Starting subtest: exec-shared-gtt [96.532366] Starting dynamic subtest: rcs0 [96.539571] Dynamic subtest rcs0: SUCCESS (0.009s) [96.549771] Starting dynamic subtest: bcs0 [96.551374] Dynamic subtest bcs0: SUCCESS (0.009s) [96.559127] Starting dynamic subtest: vcs0 [96.561030] Dynamic subtest vcs0: SUCCESS (0.010s) [96.568200] Starting dynamic subtest: vcs1 [96.569711] Dynamic subtest vcs1: SUCCESS (0.007s) [96.578053] Starting dynamic subtest: vecs0 [96.579823] Dynamic subtest vecs0: SUCCESS (0.005s) [96.586452] Starting dynamic subtest: ccs0 [96.588152] Dynamic subtest ccs0: SUCCESS (0.004s) [96.589856] Subtest exec-shared-gtt: SUCCESS (0.046s) [96.771805] [017/132] (923s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.866956] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [96.973618] [018/132] (923s left) gem_workarounds (suspend-resume-fd) [97.042078] Starting subtest: suspend-resume-fd [113.178925] Subtest suspend-resume-fd: SUCCESS (1.284s) [113.323859] [019/132] (907s left) gem_ccs (large-ctrl-surf-copy) [113.384323] Starting subtest: large-ctrl-surf-copy [113.389001] Subtest large-ctrl-surf-copy: SKIP (0.000s) [113.485710] [020/132] (907s left) i915_module_load (reload-no-display) [113.523583] Starting subtest: reload-no-display [119.252072] Subtest reload-no-display: SUCCESS (5.936s) [119.278692] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [119.279546] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [119.282512] [021/132] (901s left) kms_flip (flip-vs-rmfb-interruptible) [120.823203] Starting subtest: flip-vs-rmfb-interruptible [120.825421] Starting dynamic subtest: A-eDP1 [129.516270] Dynamic subtest A-eDP1: SUCCESS (8.794s) [129.528550] Starting dynamic subtest: B-eDP1 [138.138269] Dynamic subtest B-eDP1: SUCCESS (8.655s) [138.150422] Starting dynamic subtest: C-eDP1 [146.856649] Dynamic subtest C-eDP1: SUCCESS (8.721s) [146.864944] Starting dynamic subtest: D-eDP1 [155.466384] Dynamic subtest D-eDP1: SUCCESS (8.600s) [155.470945] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.783s) [156.680975] [FACT kms_flip (flip-vs-rmfb-interruptible)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [156.682310] [FACT kms_flip (flip-vs-rmfb-interruptible)] new: kernel.kmod_is_loaded.i915: true [156.686632] [022/132] (863s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [156.776672] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [156.780783] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [156.872334] [023/132] (863s left) syncobj_timeline (device-submit-unordered) [156.931634] Starting subtest: device-submit-unordered [156.933963] Subtest device-submit-unordered: SUCCESS (0.001s) [157.027511] [024/132] (863s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [157.144352] Starting subtest: short-flip-after-cursor-atomic-transitions [158.135547] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.989s) [158.992453] [025/132] (861s left) kms_chamelium_frames (hdmi-crc-single) [159.374961] Subtest hdmi-crc-single: SKIP (0.000s) [160.192842] [026/132] (860s left) kms_getfb (getfb2-handle-not-fb) [160.293409] Starting subtest: getfb2-handle-not-fb [160.295797] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [160.397489] [027/132] (860s left) kms_psr (pr-sprite-plane-move) [160.491055] Starting subtest: pr-sprite-plane-move [160.495394] Subtest pr-sprite-plane-move: SKIP (0.000s) [160.569357] [028/132] (860s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [160.664141] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [160.668139] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [160.760714] [029/132] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [160.857687] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [160.861870] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [160.962423] [030/132] (860s left) syncobj_timeline (wait-any-snapshot) [161.033454] Starting subtest: wait-any-snapshot [161.115769] Subtest wait-any-snapshot: SUCCESS (0.081s) [161.189425] [031/132] (859s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [161.248178] Subtest writes-after-reads: SKIP (0.000s) [161.291505] [032/132] (859s left) gem_exec_schedule (semaphore-noskip) [161.356066] Starting subtest: semaphore-noskip [161.776966] Subtest semaphore-noskip: SUCCESS (0.424s) [162.113061] [033/132] (858s left) kms_atomic (plane-primary-legacy) [162.210104] Starting subtest: plane-primary-legacy [162.212363] Starting dynamic subtest: pipe-A-eDP-1 [162.654163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s) [162.656556] Subtest plane-primary-legacy: SUCCESS (0.443s) [163.438351] [034/132] (857s left) gem_exec_balancer (bonded-true-hang) [163.719063] Starting subtest: bonded-true-hang [163.723794] Subtest bonded-true-hang: SKIP (0.000s) [163.824084] [035/132] (857s left) gem_exec_reloc (basic-gtt-wc-noreloc) [163.892081] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [163.977166] [036/132] (857s left) api_intel_allocator (simple-allocator) [164.036344] Starting subtest: simple-allocator [164.038300] Starting dynamic subtest: basic [164.040696] Dynamic subtest basic: SUCCESS (0.004s) [164.052145] Starting dynamic subtest: parallel-one [164.209243] Dynamic subtest parallel-one: SUCCESS (0.169s) [164.217037] Starting dynamic subtest: print [164.219332] Dynamic subtest print: SUCCESS (0.000s) [164.230191] Starting dynamic subtest: reuse [164.232063] Dynamic subtest reuse: SUCCESS (0.000s) [164.239821] Starting dynamic subtest: reserve [164.241795] Dynamic subtest reserve: SUCCESS (0.000s) [164.249270] Starting dynamic subtest: fork-reopen-allocator [164.251181] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s) [164.253084] Subtest simple-allocator: SUCCESS (0.187s) [164.340292] [037/132] (856s left) kms_cursor_crc (cursor-offscreen-64x21) [164.517969] Starting subtest: cursor-offscreen-64x21 [164.562483] Subtest cursor-offscreen-64x21: SKIP (0.040s) [164.825973] [038/132] (856s left) sw_sync (alloc_timeline) [164.860783] Starting subtest: alloc_timeline [164.862882] Subtest alloc_timeline: SUCCESS (0.000s) [164.917824] [039/132] (856s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [165.021441] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [169.170237] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.151s) [170.345689] [040/132] (851s left) kms_addfb_basic (unused-pitches) [170.404321] Starting subtest: unused-pitches [170.406888] Subtest unused-pitches: SUCCESS (0.000s) [170.549895] [041/132] (850s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [170.652574] Starting subtest: fbc-shrfb-scaledprimary [173.587107] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.939s) [174.745524] [042/132] (846s left) gem_exec_suspend (basic-s0) [174.793795] Starting subtest: basic-S0 [174.796075] Starting dynamic subtest: smem [196.129663] Dynamic subtest smem: SUCCESS (6.994s) [196.132706] Subtest basic-S0: SUCCESS (6.997s) [196.316847] [043/132] (825s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [196.417009] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [196.419643] Starting dynamic subtest: pipe-A-default-mode [199.173216] Dynamic subtest pipe-A-default-mode: SUCCESS (2.785s) [199.175641] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.786s) [199.973869] [044/132] (821s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [200.083000] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [200.085733] Starting dynamic subtest: pipe-A [200.105112] Dynamic subtest pipe-A: SKIP (0.016s) [200.119270] Starting dynamic subtest: pipe-B [200.131957] Dynamic subtest pipe-B: SKIP (0.028s) [200.140229] Starting dynamic subtest: pipe-C [200.160295] Dynamic subtest pipe-C: SKIP (0.029s) [200.168557] Starting dynamic subtest: pipe-D [200.187270] Dynamic subtest pipe-D: SKIP (0.029s) [200.191656] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.106s) [200.281047] [045/132] (821s left) gem_exec_parallel (contexts) [200.346164] Starting subtest: contexts [200.348560] Starting dynamic subtest: rcs0 [203.394673] Dynamic subtest rcs0: SUCCESS (3.149s) [203.406471] Starting dynamic subtest: bcs0 [207.793488] Dynamic subtest bcs0: SUCCESS (4.484s) [207.802372] Starting dynamic subtest: vcs0 [213.509693] Dynamic subtest vcs0: SUCCESS (5.721s) [213.521828] Starting dynamic subtest: vcs1 [219.378684] Dynamic subtest vcs1: SUCCESS (5.898s) [219.391196] Starting dynamic subtest: vecs0 [225.453971] Dynamic subtest vecs0: SUCCESS (6.088s) [225.468668] Starting dynamic subtest: ccs0 [230.152975] Dynamic subtest ccs0: SUCCESS (4.754s) [230.156006] Subtest contexts: SUCCESS (30.109s) [230.359233] [046/132] (791s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [230.460995] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [230.462873] Starting dynamic subtest: pipe-A-eDP-1 [231.197310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s) [231.206328] Starting dynamic subtest: pipe-B-eDP-1 [232.965633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.766s) [232.976211] Starting dynamic subtest: pipe-C-eDP-1 [234.799332] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.833s) [234.807376] Starting dynamic subtest: pipe-D-eDP-1 [236.627480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.823s) [236.630348] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.154s) [237.770134] [047/132] (783s left) gem_mmap_gtt (basic-read) [237.830356] Subtest basic-read: SKIP (0.000s) [237.887150] [048/132] (783s left) dmabuf_sync_file (export-wait-after-attach) [237.952436] Starting subtest: export-wait-after-attach [237.954477] Subtest export-wait-after-attach: SUCCESS (0.000s) [238.008753] [049/132] (783s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [238.108178] Starting subtest: pr-overlay-plane-update-sf-dmg-area [238.112642] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [238.175131] [050/132] (783s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [238.272412] Starting subtest: psr-rgb565-draw-pwrite [245.257384] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.986s) [245.364167] [051/132] (776s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [245.494558] Starting subtest: cursorB-vs-flipB-toggle [245.499982] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [245.642090] [052/132] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [245.734405] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [245.739037] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [245.828075] [053/132] (776s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier) [245.926214] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier [245.930872] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s) [246.001680] [054/132] (775s left) perf (gen12-oa-tlb-invalidate) [246.123896] Starting subtest: gen12-oa-tlb-invalidate [246.126236] Starting dynamic subtest: 0-rcs0 [256.237125] Dynamic subtest 0-rcs0: SUCCESS (10.060s) [256.247105] Starting dynamic subtest: 1-vcs1 [266.231020] Dynamic subtest 1-vcs1: SUCCESS (10.045s) [266.233669] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.108s) [266.280142] [055/132] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [266.387914] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [266.392495] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [266.499584] [056/132] (755s left) kms_properties (crtc-properties-atomic) [266.585720] Starting subtest: crtc-properties-atomic [266.588404] Starting dynamic subtest: pipe-A-eDP-1 [267.024422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s) [267.033456] Starting dynamic subtest: pipe-B-eDP-1 [268.160543] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.136s) [268.171250] Starting dynamic subtest: pipe-C-eDP-1 [269.293904] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s) [269.302865] Starting dynamic subtest: pipe-D-eDP-1 [270.420481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s) [270.423361] Subtest crtc-properties-atomic: SUCCESS (3.838s) [271.240452] [057/132] (750s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [271.350332] Starting subtest: yf-tiled-8bpp-rotate-180 [271.355251] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [271.436501] [058/132] (750s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [271.531224] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [275.258848] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.731s) [276.440964] [059/132] (745s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [276.527521] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [276.530347] Starting dynamic subtest: pipe-A-default-mode [277.689419] Dynamic subtest pipe-A-default-mode: SKIP (1.160s) [277.694157] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.162s) [277.845761] [060/132] (744s left) gem_ccs (block-multicopy-inplace) [277.899107] Starting subtest: block-multicopy-inplace [277.904466] Subtest block-multicopy-inplace: SKIP (0.000s) [277.999371] [061/132] (744s left) gem_mmap_gtt (hang-busy) [278.060441] Subtest hang-busy: SKIP (0.000s) [278.118601] [062/132] (744s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [278.223901] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [278.226368] Starting dynamic subtest: pipe-A-eDP-1 [278.299660] Dynamic subtest pipe-A-eDP-1: SKIP (0.080s) [278.308471] Starting dynamic subtest: pipe-B-eDP-1 [279.446305] Dynamic subtest pipe-B-eDP-1: SKIP (1.144s) [279.451950] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.226s) [280.634570] [063/132] (741s left) kms_chamelium_frames (vga-frame-dump) [281.012737] Subtest vga-frame-dump: SKIP (0.000s) [281.841444] [064/132] (740s left) kms_getfb (getfb-repeated-different-handles) [281.941232] Starting subtest: getfb-repeated-different-handles [281.943815] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [282.033475] [065/132] (740s left) kms_cursor_edge_walk (256x256-top-edge) [282.119559] Starting subtest: 256x256-top-edge [282.122123] Starting dynamic subtest: pipe-A-eDP-1 [285.542155] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.423s) [285.555278] Starting dynamic subtest: pipe-D-eDP-1 [288.673527] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s) [288.676572] Subtest 256x256-top-edge: SUCCESS (6.557s) [289.480417] [066/132] (733s left) gem_exec_reloc (basic-concurrent16) [289.539233] Subtest basic-concurrent16: SKIP (0.000s) [289.597477] [067/132] (732s left) gem_exec_schedule (smoketest-all) [289.663951] Starting subtest: smoketest-all [322.055227] Subtest smoketest-all: SUCCESS (32.334s) [323.204071] [068/132] (699s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [323.295372] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [323.297678] Starting dynamic subtest: pipe-A-eDP-1 [323.320516] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [323.330372] Starting dynamic subtest: pipe-B-eDP-1 [323.354288] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [323.363462] Starting dynamic subtest: pipe-C-eDP-1 [323.386452] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [323.394848] Starting dynamic subtest: pipe-D-eDP-1 [323.417861] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [323.422154] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [325.531703] [069/132] (697s left) perf_pmu (event-wait) [325.572823] Starting subtest: event-wait [325.575504] Starting dynamic subtest: rcs0 [325.580975] Dynamic subtest rcs0: SKIP (0.000s) [325.586170] Subtest event-wait: SKIP (0.001s) [325.673877] [070/132] (696s left) i915_drm_fdinfo (busy-check-all) [325.718345] Starting subtest: busy-check-all [325.720660] Starting dynamic subtest: rcs0 [325.725530] Dynamic subtest rcs0: SKIP (0.004s) [325.735549] Starting dynamic subtest: bcs0 [325.740464] Dynamic subtest bcs0: SKIP (0.001s) [325.749397] Starting dynamic subtest: vcs0 [325.754396] Dynamic subtest vcs0: SKIP (0.000s) [325.762648] Starting dynamic subtest: vcs1 [325.767271] Dynamic subtest vcs1: SKIP (0.000s) [325.775596] Starting dynamic subtest: vecs0 [325.780289] Dynamic subtest vecs0: SKIP (0.000s) [325.789941] Starting dynamic subtest: ccs0 [325.794493] Dynamic subtest ccs0: SKIP (0.000s) [325.799323] Subtest busy-check-all: SKIP (0.010s) [325.841269] [071/132] (696s left) kms_cursor_legacy (cursor-vs-flip-atomic) [325.990055] Starting subtest: cursor-vs-flip-atomic [355.634390] Subtest cursor-vs-flip-atomic: SUCCESS (29.646s) [356.459987] [072/132] (666s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [356.562378] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [356.564792] Starting dynamic subtest: pipe-A-eDP-1 [356.630221] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [356.640449] Starting dynamic subtest: pipe-B-eDP-1 [356.706961] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [356.717165] Starting dynamic subtest: pipe-C-eDP-1 [356.782878] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [356.791831] Starting dynamic subtest: pipe-D-eDP-1 [356.861343] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [356.866647] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [358.757382] [073/132] (664s left) kms_psr (psr2-primary-mmap-cpu) [358.858474] Starting subtest: psr2-primary-mmap-cpu [358.861156] Starting dynamic subtest: eDP-1 [360.542781] Dynamic subtest eDP-1: SUCCESS (1.686s) [360.545558] Subtest psr2-primary-mmap-cpu: SUCCESS (1.687s) [361.411243] [074/132] (661s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [361.508250] Starting subtest: psr-2p-scndscrn-cur-indfb-move [361.513332] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [361.587040] [075/132] (661s left) i915_pm_sseu (full-enable) [361.644461] Subtest full-enable: SKIP (0.000s) [361.727464] [076/132] (661s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [361.821321] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [362.855262] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.037s) [362.965192] [077/132] (659s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [363.060519] Starting subtest: plane-use-after-nonblocking-unbind-fencing [363.063045] Starting dynamic subtest: pipe-A-eDP-1 [363.120665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [363.428462] Starting dynamic subtest: pipe-B-eDP-1 [364.208638] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.789s) [364.502304] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.440s) [365.370084] [078/132] (657s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [365.477813] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [372.754400] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.282s) [372.868111] [079/132] (650s left) kms_psr (fbc-pr-basic) [372.957118] Starting subtest: fbc-pr-basic [372.962104] Subtest fbc-pr-basic: SKIP (0.000s) [373.032072] [080/132] (650s left) kms_lease (multimaster-lease) [373.115407] Starting subtest: multimaster-lease [373.117954] Subtest multimaster-lease: SUCCESS (0.004s) [373.218687] [081/132] (649s left) gem_exec_balancer (parallel-keep-submit-fence) [373.490116] Starting subtest: parallel-keep-submit-fence [374.807837] Subtest parallel-keep-submit-fence: SUCCESS (1.321s) [374.916861] [082/132] (648s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [375.011434] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [378.999522] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.992s) [380.131552] [083/132] (643s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [380.231529] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [380.234195] Starting dynamic subtest: pipe-A-eDP-1 [397.373782] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.392s) [397.383716] Starting dynamic subtest: pipe-B-eDP-1 [414.323929] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.374s) [414.333681] Starting dynamic subtest: pipe-C-eDP-1 [431.298233] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.429s) [431.307091] Starting dynamic subtest: pipe-D-eDP-1 [448.313023] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.356s) [448.315333] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.557s) [449.490765] [084/132] (573s left) kms_fbcon_fbt (fbc) [449.547709] Starting subtest: fbc [455.857527] Subtest fbc: SUCCESS (6.480s) [456.951542] [085/132] (566s left) gem_exec_params (rel-constants-invalid-rel-gen5) [457.004362] Starting subtest: rel-constants-invalid-rel-gen5 [457.006812] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [457.113134] [086/132] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [457.209789] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [457.213552] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [457.310608] [087/132] (566s left) syncobj_wait (single-wait-for-submit-unsubmitted) [457.376096] Starting subtest: single-wait-for-submit-unsubmitted [457.482285] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s) [457.560853] [088/132] (565s left) syncobj_wait (invalid-signal-one-illegal-handle) [457.624246] Starting subtest: invalid-signal-one-illegal-handle [457.626122] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [457.723906] [089/132] (565s left) gem_pxp (display-protected-crc) [457.850168] Starting subtest: display-protected-crc [459.852745] Subtest display-protected-crc: SUCCESS (2.028s) [459.965288] [090/132] (563s left) gem_exec_schedule (pi-userfault) [460.152163] Starting subtest: pi-userfault [460.154100] Starting dynamic subtest: rcs0 [460.160300] Dynamic subtest rcs0: SUCCESS (0.010s) [460.170799] Starting dynamic subtest: bcs0 [460.172949] Dynamic subtest bcs0: SUCCESS (0.007s) [460.185336] Starting dynamic subtest: vcs0 [460.187583] Dynamic subtest vcs0: SUCCESS (0.010s) [460.196230] Starting dynamic subtest: vcs1 [460.198063] Dynamic subtest vcs1: SUCCESS (0.007s) [460.206676] Starting dynamic subtest: vecs0 [460.208861] Dynamic subtest vecs0: SUCCESS (0.006s) [460.217214] Starting dynamic subtest: ccs0 [460.219377] Dynamic subtest ccs0: SUCCESS (0.007s) [460.221516] Subtest pi-userfault: SUCCESS (0.051s) [460.381733] [091/132] (563s left) kms_pm_dc (dc5-retention-flops) [461.476436] Starting subtest: dc5-retention-flops [461.480803] Subtest dc5-retention-flops: SKIP (0.000s) [461.547344] [092/132] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [461.646583] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [461.650993] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [461.736292] [093/132] (561s left) kms_plane_cursor (overlay) [461.828902] Starting subtest: overlay [461.833051] Starting dynamic subtest: pipe-A-eDP-1-size-64 [464.307172] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.497s) [464.364661] Starting dynamic subtest: pipe-A-eDP-1-size-128 [466.948326] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.604s) [467.007148] Starting dynamic subtest: pipe-A-eDP-1-size-256 [469.518438] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.528s) [469.867634] Starting dynamic subtest: pipe-B-eDP-1-size-64 [473.010485] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.164s) [473.070206] Starting dynamic subtest: pipe-B-eDP-1-size-128 [475.496037] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.438s) [475.556536] Starting dynamic subtest: pipe-B-eDP-1-size-256 [478.005500] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.462s) [478.353672] Starting dynamic subtest: pipe-C-eDP-1-size-64 [481.186780] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.842s) [481.225362] Starting dynamic subtest: pipe-C-eDP-1-size-128 [483.345006] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s) [483.383262] Starting dynamic subtest: pipe-C-eDP-1-size-256 [485.480318] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.103s) [485.813759] Starting dynamic subtest: pipe-D-eDP-1-size-64 [488.698757] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.895s) [488.735917] Starting dynamic subtest: pipe-D-eDP-1-size-128 [490.877392] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s) [490.915810] Starting dynamic subtest: pipe-D-eDP-1-size-256 [492.956619] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.047s) [493.276585] Subtest overlay: SUCCESS (31.494s) [494.076380] [094/132] (529s left) gem_ctx_shared (create-shared-gtt) [494.139286] Starting subtest: create-shared-gtt [496.355798] Subtest create-shared-gtt: SUCCESS (2.152s) [496.748636] [095/132] (526s left) gem_mmap_gtt (basic-read-write-distinct) [496.807015] Subtest basic-read-write-distinct: SKIP (0.000s) [496.864506] [096/132] (526s left) sw_sync (timeline_closed_signaled) [496.905392] Starting subtest: timeline_closed_signaled [496.907486] Subtest timeline_closed_signaled: SUCCESS (0.000s) [496.961661] [097/132] (526s left) api_intel_bb (lot-of-buffers) [497.012383] Starting subtest: lot-of-buffers [498.073781] Subtest lot-of-buffers: SUCCESS (1.062s) [498.941533] [098/132] (524s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [499.040480] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [499.044893] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [499.138112] [099/132] (524s left) kms_addfb_basic (bad-pitch-1024) [499.183438] Starting subtest: bad-pitch-1024 [499.185480] Subtest bad-pitch-1024: SUCCESS (0.000s) [499.306078] [100/132] (524s left) gen9_exec_parse (allowed-all) [499.358984] Subtest allowed-all: SKIP (0.000s) [499.424603] [101/132] (524s left) kms_flip (plain-flip-fb-recreate) [499.510866] Starting subtest: plain-flip-fb-recreate [499.513134] Starting dynamic subtest: A-eDP1 [508.364020] Dynamic subtest A-eDP1: SUCCESS (8.852s) [508.376403] Starting dynamic subtest: B-eDP1 [517.213245] Dynamic subtest B-eDP1: SUCCESS (8.847s) [517.223944] Starting dynamic subtest: C-eDP1 [526.023377] Dynamic subtest C-eDP1: SUCCESS (8.811s) [526.038233] Starting dynamic subtest: D-eDP1 [534.846310] Dynamic subtest D-eDP1: SUCCESS (8.823s) [534.852148] Subtest plain-flip-fb-recreate: SUCCESS (35.348s) [536.020523] [102/132] (487s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [536.089855] Starting subtest: yf-tiled-to-vebox-x-tiled [536.094240] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [536.272542] [103/132] (487s left) gem_userptr_blits (process-exit-busy) [536.340566] Starting subtest: process-exit-busy [536.356952] Subtest process-exit-busy: SUCCESS (0.018s) [536.480336] [104/132] (487s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [536.535680] Starting subtest: single-wait-all-for-submit-available-submitted [536.537954] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [536.629012] [105/132] (487s left) kms_psr (fbc-psr2-no-drrs) [536.718600] Starting subtest: fbc-psr2-no-drrs [536.720897] Starting dynamic subtest: eDP-1 [536.725219] Dynamic subtest eDP-1: SKIP (0.000s) [536.729576] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [536.790181] [106/132] (487s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [536.910718] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [536.914949] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [537.055739] [107/132] (487s left) kms_content_protection (atomic-dpms-hdcp14) [537.203383] Starting subtest: atomic-dpms-hdcp14 [537.207892] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [537.310790] [108/132] (486s left) i915_pm_rpm (system-suspend) [539.048080] Starting subtest: system-suspend [557.964055] Subtest system-suspend: SUCCESS (2.872s) [558.334048] [109/132] (465s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [558.448572] Starting subtest: fbcpsr-rgb101010-draw-render [565.002267] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.748s) [565.118372] [110/132] (459s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [565.237229] Starting subtest: basic-flip-after-cursor-legacy [566.134572] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s) [566.961766] [111/132] (457s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [567.066124] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [573.876865] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.879s) [573.990057] [112/132] (450s left) syncobj_basic (bad-pad-handle-to-fd) [574.058839] Starting subtest: bad-pad-handle-to-fd [574.061219] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [574.150283] [113/132] (450s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [574.199884] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [574.300353] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [574.377709] [114/132] (450s left) syncobj_timeline (invalid-signal-illegal-point) [574.439655] Starting subtest: invalid-signal-illegal-point [574.442316] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [574.531546] [115/132] (449s left) gem_lmem_swapping (smem-oom) [574.572441] Subtest smem-oom: SKIP (0.000s) [574.617347] [116/132] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [574.702038] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [582.043481] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.371s) [582.167756] [117/132] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [582.256566] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [582.261281] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [582.335238] [118/132] (442s left) syncobj_timeline (multi-wait-available-submitted) [582.390454] Starting subtest: multi-wait-available-submitted [582.393339] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [582.482607] [119/132] (442s left) kms_invalid_mode (overflow-vrefresh) [582.589102] Starting subtest: overflow-vrefresh [582.591515] Starting dynamic subtest: pipe-A-eDP-1 [582.881411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [582.891200] Starting dynamic subtest: pipe-B-eDP-1 [582.893686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [582.903505] Starting dynamic subtest: pipe-C-eDP-1 [582.906033] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [582.915213] Starting dynamic subtest: pipe-D-eDP-1 [582.917828] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [582.920538] Subtest overflow-vrefresh: SUCCESS (0.297s) [583.726190] [120/132] (441s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [583.825605] Starting subtest: basic-max-pipe-crc-check [583.830618] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [583.873351] [121/132] (440s left) kms_vblank (ts-continuation-idle) [583.963805] Starting subtest: ts-continuation-idle [583.966164] Starting dynamic subtest: pipe-A-eDP-1 [584.364180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s) [584.380324] Starting dynamic subtest: pipe-D-eDP-1 [585.426600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.064s) [585.429492] Subtest ts-continuation-idle: SUCCESS (1.468s) [586.297011] [122/132] (438s left) kms_feature_discovery (dp-mst) [586.391593] Starting subtest: dp-mst [586.396590] Subtest dp-mst: SKIP (0.000s) [586.470268] [123/132] (438s left) kms_plane_scaling (invalid-num-scalers) [586.563285] Starting subtest: invalid-num-scalers [586.565594] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [586.580090] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s) [586.589698] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [586.611220] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.029s) [586.620826] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [586.639950] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s) [586.649409] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [586.673286] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s) [586.675582] Subtest invalid-num-scalers: SUCCESS (0.111s) [586.770658] [124/132] (438s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [586.879430] Starting subtest: yf-tiled-32bpp-rotate-0 [586.884558] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [586.991963] [125/132] (437s left) syncobj_wait (wait-all-for-submit-snapshot) [587.047527] Starting subtest: wait-all-for-submit-snapshot [587.127867] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s) [587.206488] [126/132] (437s left) gem_ctx_persistence (engines-hang) [587.253242] Starting subtest: engines-hang [587.255434] Starting dynamic subtest: rcs0 [587.322494] Dynamic subtest rcs0: SUCCESS (0.068s) [587.335334] Starting dynamic subtest: bcs0 [587.420454] Dynamic subtest bcs0: SUCCESS (0.094s) [587.432341] Starting dynamic subtest: vcs0 [587.513513] Dynamic subtest vcs0: SUCCESS (0.091s) [587.525129] Starting dynamic subtest: vcs1 [587.603463] Dynamic subtest vcs1: SUCCESS (0.088s) [587.614357] Starting dynamic subtest: vecs0 [587.691370] Dynamic subtest vecs0: SUCCESS (0.086s) [587.702475] Starting dynamic subtest: ccs0 [587.781565] Dynamic subtest ccs0: SUCCESS (0.088s) [587.784097] Subtest engines-hang: SUCCESS (0.530s) [587.867001] [127/132] (437s left) kms_sequence (get-idle) [587.967646] Starting subtest: get-idle [587.970472] Starting dynamic subtest: pipe-A-eDP-1 [589.773334] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.805s) [589.787930] Starting dynamic subtest: pipe-B-eDP-1 [592.272505] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.499s) [592.283716] Starting dynamic subtest: pipe-C-eDP-1 [594.714663] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.441s) [594.728544] Starting dynamic subtest: pipe-D-eDP-1 [597.127040] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.405s) [597.129564] Subtest get-idle: SUCCESS (9.157s) [597.926699] [128/132] (427s left) prime_vgem (coherency-blt) [598.015689] Starting subtest: coherency-blt [599.168959] Subtest coherency-blt: SUCCESS (1.152s) [599.306838] [129/132] (425s left) gem_softpin (evict-single-offset) [599.364169] Starting subtest: evict-single-offset [625.970977] Subtest evict-single-offset: SUCCESS (26.604s) [626.055984] [130/132] (399s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [626.166656] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [626.268928] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s) [626.347518] [131/132] (398s left) kms_color (legacy-gamma-reset) [626.453719] Starting subtest: legacy-gamma-reset [626.456170] Starting dynamic subtest: pipe-A-eDP-1 [626.837296] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s) [626.847339] Starting dynamic subtest: pipe-B-eDP-1 [626.849758] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [626.859648] Starting dynamic subtest: pipe-C-eDP-1 [626.862083] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [626.871656] Starting dynamic subtest: pipe-D-eDP-1 [626.874118] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [626.876327] Subtest legacy-gamma-reset: SUCCESS (0.421s) [627.675506] [132/132] (397s left) syncobj_wait (wait-all-delayed-signal) [627.729575] Starting subtest: wait-all-delayed-signal [627.830290] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [627.909115] Closing watchdogs results: parsing output: 0/ for test: gem_wait results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: gem_render_copy results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_cursor_legacy results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: gem_exec_flush results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_cursor_crc results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: gem_exec_params results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: gem_lmem_swapping results: parsing output: 15/ for test: gem_ctx_shared results: parsing output: 16/ for test: kms_addfb_basic results: parsing output: 17/ for test: gem_workarounds results: parsing output: 18/ for test: gem_ccs results: parsing output: 19/ for test: i915_module_load results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: kms_cursor_legacy results: parsing output: 24/ for test: kms_chamelium_frames results: parsing output: 25/ for test: kms_getfb results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 31/ for test: gem_exec_schedule results: parsing output: 32/ for test: kms_atomic results: parsing output: 33/ for test: gem_exec_balancer results: parsing output: 34/ for test: gem_exec_reloc results: parsing output: 35/ for test: api_intel_allocator results: parsing output: 36/ for test: kms_cursor_crc results: parsing output: 37/ for test: sw_sync results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_addfb_basic results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_exec_suspend results: parsing output: 42/ for test: kms_flip_scaled_crc results: parsing output: 43/ for test: kms_plane_scaling results: parsing output: 44/ for test: gem_exec_parallel results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: gem_mmap_gtt results: parsing output: 47/ for test: dmabuf_sync_file results: parsing output: 48/ for test: kms_psr2_sf results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_plane results: parsing output: 53/ for test: perf results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_properties results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_flip_scaled_crc results: parsing output: 59/ for test: gem_ccs results: parsing output: 60/ for test: gem_mmap_gtt results: parsing output: 61/ for test: kms_psr2_sf results: parsing output: 62/ for test: kms_chamelium_frames results: parsing output: 63/ for test: kms_getfb results: parsing output: 64/ for test: kms_cursor_edge_walk results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: i915_drm_fdinfo results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_ccs results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: i915_pm_sseu results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: kms_atomic_transition results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_lease results: parsing output: 80/ for test: gem_exec_balancer results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_ccs results: parsing output: 83/ for test: kms_fbcon_fbt results: parsing output: 84/ for test: gem_exec_params results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: gem_pxp results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_pm_dc results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_plane_cursor results: parsing output: 93/ for test: gem_ctx_shared results: parsing output: 94/ for test: gem_mmap_gtt results: parsing output: 95/ for test: sw_sync results: parsing output: 96/ for test: api_intel_bb results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_addfb_basic results: parsing output: 99/ for test: gen9_exec_parse results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: gem_render_copy results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: kms_cursor_legacy results: parsing output: 106/ for test: kms_content_protection results: parsing output: 107/ for test: i915_pm_rpm results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_cursor_legacy results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: syncobj_basic results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: gem_lmem_swapping results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: kms_invalid_mode results: parsing output: 119/ for test: kms_multipipe_modeset results: parsing output: 120/ for test: kms_vblank results: parsing output: 121/ for test: kms_feature_discovery results: parsing output: 122/ for test: kms_plane_scaling results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: gem_ctx_persistence results: parsing output: 126/ for test: kms_sequence results: parsing output: 127/ for test: prime_vgem results: parsing output: 128/ for test: gem_softpin results: parsing output: 129/ for test: syncobj_wait results: parsing output: 130/ for test: kms_color results: parsing output: 131/ for test: syncobj_wait Done.