[57.702548] Initializing watchdogs [57.702667] /dev/watchdog0 [57.717536] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [57.721375] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.723488] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.726805] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear) [57.837219] Starting subtest: fbcpsr-tiling-linear [64.444981] Subtest fbcpsr-tiling-linear: SUCCESS (6.618s) [64.564088] [002/130] (953s left) kms_pm_dc (dc5-dpms-negative) [65.638765] Starting subtest: dc5-dpms-negative [65.643450] Subtest dc5-dpms-negative: SKIP (0.000s) [65.704857] [003/130] (952s left) kms_psr (fbc-psr-sprite-plane-move) [65.778901] Starting subtest: fbc-psr-sprite-plane-move [65.781270] Starting dynamic subtest: eDP-1 [65.785687] Dynamic subtest eDP-1: SKIP (0.000s) [65.790468] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [65.851222] [004/130] (952s left) i915_drm_fdinfo (busy) [65.891634] Starting subtest: busy [65.894066] Starting dynamic subtest: rcs0 [65.915751] Dynamic subtest rcs0: SKIP (0.020s) [65.922140] Starting dynamic subtest: bcs0 [65.926152] Dynamic subtest bcs0: SKIP (0.000s) [65.932724] Starting dynamic subtest: vcs0 [65.936915] Dynamic subtest vcs0: SKIP (0.000s) [65.943419] Starting dynamic subtest: vcs1 [65.947453] Dynamic subtest vcs1: SKIP (0.000s) [65.961044] Starting dynamic subtest: vecs0 [65.965264] Dynamic subtest vecs0: SKIP (0.000s) [65.971591] Starting dynamic subtest: ccs0 [65.975597] Dynamic subtest ccs0: SKIP (0.000s) [65.979605] Subtest busy: SKIP (0.023s) [66.013145] [005/130] (952s left) gem_ctx_persistence (legacy-engines-mixed) [66.076840] Starting subtest: legacy-engines-mixed [66.079169] Starting dynamic subtest: render [66.145765] Dynamic subtest render: SUCCESS (0.071s) [66.159888] Starting dynamic subtest: bsd1 [66.205070] Dynamic subtest bsd1: SUCCESS (0.058s) [66.214876] Starting dynamic subtest: bsd2 [66.248840] Dynamic subtest bsd2: SUCCESS (0.043s) [66.258048] Starting dynamic subtest: blt [66.291819] Dynamic subtest blt: SUCCESS (0.042s) [66.300908] Starting dynamic subtest: vebox [66.339611] Dynamic subtest vebox: SUCCESS (0.047s) [66.342209] Subtest legacy-engines-mixed: SUCCESS (0.266s) [66.414804] [006/130] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [66.507650] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [66.512088] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [66.603868] [007/130] (951s left) gem_exec_schedule (preempt-queue-contexts-chain) [66.714477] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [67.252028] [008/130] (951s left) syncobj_basic (bad-pad-fd-to-handle) [67.398060] Starting subtest: bad-pad-fd-to-handle [67.400403] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [67.566068] [009/130] (950s left) syncobj_timeline (reset-signaled) [67.645769] Starting subtest: reset-signaled [67.648720] Subtest reset-signaled: SUCCESS (0.001s) [67.813245] [010/130] (950s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [67.995089] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [69.107317] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.113s) [69.238753] [011/130] (949s left) gem_exec_schedule (noreorder-priority) [69.427529] Starting subtest: noreorder-priority [69.430083] Starting dynamic subtest: rcs0 [70.562941] Dynamic subtest rcs0: SUCCESS (1.137s) [70.571767] Starting dynamic subtest: vcs0 [71.806169] Dynamic subtest vcs0: SUCCESS (1.243s) [71.817232] Starting dynamic subtest: vcs1 [73.878297] Dynamic subtest vcs1: SUCCESS (2.070s) [73.889139] Starting dynamic subtest: vecs0 [75.856997] Dynamic subtest vecs0: SUCCESS (1.977s) [75.867625] Starting dynamic subtest: ccs0 [76.998438] Dynamic subtest ccs0: SUCCESS (1.141s) [77.001279] Subtest noreorder-priority: SUCCESS (7.573s) [77.181156] [012/130] (941s left) gem_exec_balancer (full) [77.249763] Starting subtest: full [81.711733] Subtest full: SUCCESS (4.462s) [82.016652] [013/130] (936s left) kms_content_protection (dp-mst-lic-type-0) [82.156967] Starting subtest: dp-mst-lic-type-0 [82.161597] Subtest dp-mst-lic-type-0: SKIP (0.000s) [82.279837] [014/130] (936s left) gem_exec_reloc (basic-write-cpu-active) [82.342093] Subtest basic-write-cpu-active: SKIP (0.000s) [82.405260] [015/130] (936s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [82.482736] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [82.487478] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s) [82.564218] [016/130] (936s left) kms_addfb_basic (bad-pitch-32) [82.618565] Starting subtest: bad-pitch-32 [82.620827] Subtest bad-pitch-32: SUCCESS (0.000s) [82.732873] [017/130] (936s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [82.798470] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [82.803071] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [83.879479] [018/130] (935s left) syncobj_wait (wait-all-interrupted) [83.930877] Starting subtest: wait-all-interrupted [84.030915] Subtest wait-all-interrupted: SUCCESS (0.101s) [84.100538] [019/130] (934s left) gem_ctx_exec (basic) [84.157828] Starting subtest: basic [84.162545] Subtest basic: SUCCESS (0.005s) [84.279423] [020/130] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [84.370497] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [84.374966] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [84.470972] [021/130] (934s left) gem_softpin (32b-excludes-last-page) [84.527092] Starting subtest: 32b-excludes-last-page [84.532686] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [84.655684] [022/130] (934s left) gem_softpin (allocator-nopin-reserve) [84.713098] Starting subtest: allocator-nopin-reserve [84.805672] Subtest allocator-nopin-reserve: SUCCESS (0.093s) [84.931217] [023/130] (934s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [84.983872] Starting subtest: yf-tiled-ccs-to-x-tiled [84.988379] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [85.162502] [024/130] (933s left) kms_chamelium_audio (dp-audio) [85.545430] Subtest dp-audio: SKIP (0.000s) [86.394593] [025/130] (932s left) kms_chamelium_frames (dp-crc-fast) [86.777657] Subtest dp-crc-fast: SKIP (0.000s) [87.627760] [026/130] (931s left) gen3_render_tiledy_blits [87.742259] [027/130] (931s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [87.808527] Starting subtest: primary-yf-tiled-reflect-x-270 [87.812820] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [87.892569] [028/130] (931s left) i915_drm_fdinfo (virtual-busy-hang-all) [87.930207] Starting subtest: virtual-busy-hang-all [87.934928] Subtest virtual-busy-hang-all: SKIP (0.000s) [87.989834] [029/130] (931s left) kms_addfb_basic (bad-pitch-0) [88.042946] Starting subtest: bad-pitch-0 [88.045311] Subtest bad-pitch-0: SUCCESS (0.000s) [88.168908] [030/130] (931s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [88.251300] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [88.255142] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [88.336729] [031/130] (931s left) kms_addfb_basic (addfb25-y-tiled-legacy) [88.418789] Starting subtest: addfb25-y-tiled-legacy [88.420660] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [88.514608] [032/130] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [88.590472] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [88.593780] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [88.676677] [033/130] (930s left) kms_dsc (dsc-with-formats) [88.745340] Starting subtest: dsc-with-formats [88.776789] Subtest dsc-with-formats: SKIP (0.001s) [88.825328] [034/130] (930s left) kms_cursor_crc (cursor-onscreen-256x256) [89.036892] Starting subtest: cursor-onscreen-256x256 [89.041222] Starting dynamic subtest: pipe-A-eDP-1 [91.146454] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s) [91.179734] Starting dynamic subtest: pipe-D-eDP-1 [93.902860] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.729s) [93.905366] Subtest cursor-onscreen-256x256: SUCCESS (4.865s) [94.697630] [035/130] (924s left) syncobj_timeline (single-wait-for-submit-available-submitted) [94.750828] Starting subtest: single-wait-for-submit-available-submitted [94.753234] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s) [94.840839] [036/130] (924s left) kms_big_fb (y-tiled-64bpp-rotate-0) [94.926453] Starting subtest: y-tiled-64bpp-rotate-0 [94.930692] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [95.015164] [037/130] (924s left) gem_create (create-ext-placement-each) [95.172023] Starting subtest: create-ext-placement-each [95.174899] Subtest create-ext-placement-each: SUCCESS (0.000s) [95.280437] [038/130] (924s left) gem_exec_reloc (basic-range) [95.339641] Subtest basic-range: SKIP (0.000s) [95.395061] [039/130] (924s left) gem_exec_whisper (basic-contexts-forked) [95.460856] Starting subtest: basic-contexts-forked [120.272511] Subtest basic-contexts-forked: SUCCESS (24.757s) [120.398293] [040/130] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [120.495620] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [120.499840] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [120.583517] [041/130] (899s left) gem_exec_parallel (engines) [120.645608] Starting subtest: engines [120.647785] Starting dynamic subtest: basic [122.842300] Dynamic subtest basic: SUCCESS (2.197s) [122.851420] Starting dynamic subtest: contexts [127.182498] Dynamic subtest contexts: SUCCESS (4.338s) [127.191109] Starting dynamic subtest: fds [130.990765] Dynamic subtest fds: SUCCESS (3.807s) [130.998970] Starting dynamic subtest: userptr [132.826451] Dynamic subtest userptr: SUCCESS (1.835s) [132.829084] Subtest engines: SUCCESS (12.182s) [133.011724] [042/130] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [133.127284] Starting subtest: basic-flip-after-cursor-atomic [134.054859] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.926s) [134.922464] [043/130] (884s left) kms_flip (basic-flip-vs-dpms) [134.993208] Starting subtest: basic-flip-vs-dpms [134.995570] Starting dynamic subtest: A-eDP1 [137.524161] Dynamic subtest A-eDP1: SUCCESS (2.532s) [137.535788] Starting dynamic subtest: B-eDP1 [139.698363] Dynamic subtest B-eDP1: SUCCESS (2.171s) [139.707928] Starting dynamic subtest: C-eDP1 [141.870193] Dynamic subtest C-eDP1: SUCCESS (2.173s) [141.879862] Starting dynamic subtest: D-eDP1 [143.942169] Dynamic subtest D-eDP1: SUCCESS (2.072s) [143.947080] Subtest basic-flip-vs-dpms: SUCCESS (8.956s) [144.747418] [044/130] (875s left) gem_exec_nop (basic-series) [144.820120] Starting subtest: basic-series [160.861606] Subtest basic-series: SUCCESS (16.046s) [161.076363] [045/130] (858s left) perf (non-system-wide-paranoid) [161.195409] Starting subtest: non-system-wide-paranoid [161.229514] Subtest non-system-wide-paranoid: SUCCESS (0.035s) [161.278019] [046/130] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [161.358476] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [161.362599] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [161.452518] [047/130] (858s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [161.499723] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [161.606264] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s) [161.675564] [048/130] (858s left) gem_mmap_gtt (basic-read-write) [161.732442] Subtest basic-read-write: SKIP (0.000s) [161.791767] [049/130] (858s left) kms_plane_alpha_blend (coverage-7efc) [161.869467] Starting subtest: coverage-7efc [162.152911] Starting dynamic subtest: pipe-A-eDP-1 [162.752493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s) [162.777467] Starting dynamic subtest: pipe-D-eDP-1 [164.089040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [164.091450] Subtest coverage-7efc: SUCCESS (2.222s) [164.927251] [050/130] (855s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [165.535447] Starting subtest: syncobj-timeline-multiple-ext-nodes [165.540365] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s) [166.945265] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true [166.948423] [051/130] (853s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [167.014802] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [167.017025] Starting dynamic subtest: pipe-A-eDP-1 [167.038581] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [167.047651] Starting dynamic subtest: pipe-B-eDP-1 [167.068578] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [167.076798] Starting dynamic subtest: pipe-C-eDP-1 [167.098136] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [167.106094] Starting dynamic subtest: pipe-D-eDP-1 [167.127922] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [167.132066] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s) [169.212384] [052/130] (850s left) kms_plane_scaling (invalid-num-scalers) [169.298287] Starting subtest: invalid-num-scalers [169.300460] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [169.320935] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [169.331361] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [169.352219] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [169.360393] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [169.384128] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [169.392220] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [169.416411] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s) [169.418630] Subtest invalid-num-scalers: SUCCESS (0.119s) [169.526539] [053/130] (850s left) gem_exec_fence (basic-wait) [169.710654] Starting subtest: basic-wait [169.712927] Starting dynamic subtest: rcs0 [169.800069] Dynamic subtest rcs0: SUCCESS (0.091s) [169.818415] Starting dynamic subtest: bcs0 [169.862788] Dynamic subtest bcs0: SUCCESS (0.061s) [169.873088] Starting dynamic subtest: vcs0 [169.926455] Dynamic subtest vcs0: SUCCESS (0.062s) [169.936517] Starting dynamic subtest: vcs1 [169.983843] Dynamic subtest vcs1: SUCCESS (0.056s) [169.992732] Starting dynamic subtest: vecs0 [170.036667] Dynamic subtest vecs0: SUCCESS (0.051s) [170.044591] Starting dynamic subtest: ccs0 [170.105919] Dynamic subtest ccs0: SUCCESS (0.068s) [170.108409] Subtest basic-wait: SUCCESS (0.399s) [171.921771] [054/130] (848s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [172.015923] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [172.020288] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [172.122711] [055/130] (848s left) vgem_basic (bad-fence) [172.177361] Starting subtest: bad-fence [172.179601] Subtest bad-fence: SUCCESS (0.000s) [172.234215] [056/130] (848s left) kms_lease (lease-unleased-crtc) [172.311099] Starting subtest: lease-unleased-crtc [172.313464] Starting dynamic subtest: pipe-A-eDP-1 [172.599754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [172.608853] Starting dynamic subtest: pipe-B-eDP-1 [173.359323] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s) [173.369142] Starting dynamic subtest: pipe-C-eDP-1 [173.371618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [173.379890] Starting dynamic subtest: pipe-D-eDP-1 [173.382318] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [173.384461] Subtest lease-unleased-crtc: SUCCESS (1.069s) [173.731106] [057/130] (846s left) gem_lmem_swapping (smem-oom) [173.771660] Subtest smem-oom: SKIP (0.000s) [173.819894] [058/130] (846s left) kms_color (ctm-green-to-red) [173.886604] Starting subtest: ctm-green-to-red [173.888777] Starting dynamic subtest: pipe-A-eDP-1 [174.588309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s) [174.597278] Starting dynamic subtest: pipe-B-eDP-1 [176.018826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s) [176.028257] Starting dynamic subtest: pipe-C-eDP-1 [177.397039] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [177.406300] Starting dynamic subtest: pipe-D-eDP-1 [178.701582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s) [178.703885] Subtest ctm-green-to-red: SUCCESS (4.815s) [179.520389] [059/130] (840s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [179.602242] Starting subtest: flip-primary-invalidate-overlay [191.198792] Subtest flip-primary-invalidate-overlay: SUCCESS (11.598s) [191.311881] [060/130] (829s left) kms_dp_linktrain_fallback (dp-fallback) [191.389184] Starting subtest: dp-fallback [191.394551] Subtest dp-fallback: SKIP (0.000s) [191.459619] [061/130] (829s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [191.531185] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [191.533141] Starting dynamic subtest: pipe-A-eDP-1 [191.550061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [191.559878] Starting dynamic subtest: pipe-B-eDP-1 [191.576185] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [191.585883] Starting dynamic subtest: pipe-C-eDP-1 [191.603560] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [191.612915] Starting dynamic subtest: pipe-D-eDP-1 [191.629646] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [191.631255] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [193.693203] [062/130] (826s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [193.783046] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [193.785377] Starting dynamic subtest: pipe-A-default-mode [194.952985] Dynamic subtest pipe-A-default-mode: SKIP (1.166s) [194.957394] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.167s) [195.089168] [063/130] (825s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [195.200474] Starting subtest: cursorA-vs-flipA-atomic-transitions [206.382429] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.181s) [207.238379] [064/130] (813s left) gem_exec_nop (basic-sequential) [207.318511] Starting subtest: basic-sequential [223.894853] Subtest basic-sequential: SUCCESS (16.563s) [224.088665] [065/130] (796s left) template (a) [224.144093] Starting subtest: A [224.146412] Subtest A: SUCCESS (0.000s) [224.241525] [066/130] (796s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [224.341618] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [224.346038] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [224.433093] [067/130] (796s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [224.519609] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [225.521762] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.002s) [225.642147] [068/130] (795s left) kms_prop_blob (blob-prop-validate) [225.706100] Starting subtest: blob-prop-validate [225.708236] Subtest blob-prop-validate: SUCCESS (0.000s) [225.784322] [069/130] (795s left) perf_pmu (all-busy-idle-check-all) [225.822087] Starting subtest: all-busy-idle-check-all [227.866851] Subtest all-busy-idle-check-all: SUCCESS (2.043s) [227.966933] [070/130] (792s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [228.019824] Subtest no-spare-fences-interruptible: SKIP (0.000s) [228.097047] [071/130] (792s left) gem_mmap_gtt (basic-small-copy-odd) [228.151164] Subtest basic-small-copy-odd: SKIP (0.000s) [228.212533] [072/130] (792s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [228.283185] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [228.285450] Starting dynamic subtest: pipe-A-eDP-1 [228.551187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.238s) [228.559260] Starting dynamic subtest: pipe-B-eDP-1 [229.839165] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s) [229.848314] Starting dynamic subtest: pipe-C-eDP-1 [231.145105] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s) [231.153697] Starting dynamic subtest: pipe-D-eDP-1 [232.352746] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s) [232.354804] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.040s) [233.466288] [073/130] (787s left) kms_sequence (queue-idle) [233.547056] Starting subtest: queue-idle [233.549871] Starting dynamic subtest: pipe-A-eDP-1 [235.350201] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.804s) [235.360151] Starting dynamic subtest: pipe-B-eDP-1 [237.845629] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.491s) [237.855378] Starting dynamic subtest: pipe-C-eDP-1 [240.254050] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s) [240.262862] Starting dynamic subtest: pipe-D-eDP-1 [242.704968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.451s) [242.707162] Subtest queue-idle: SUCCESS (9.158s) [243.505974] [074/130] (777s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [243.576673] Starting subtest: plane-upscale-factor-0-25-with-rotation [243.578855] Starting dynamic subtest: pipe-A [243.812539] Dynamic subtest pipe-A: SUCCESS (0.237s) [243.821462] Starting dynamic subtest: pipe-B [245.091662] Dynamic subtest pipe-B: SUCCESS (1.278s) [245.100554] Starting dynamic subtest: pipe-C [246.428072] Dynamic subtest pipe-C: SUCCESS (1.336s) [246.436183] Starting dynamic subtest: pipe-D [247.763436] Dynamic subtest pipe-D: SUCCESS (1.334s) [247.765785] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.189s) [248.950472] [075/130] (772s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [249.052660] Starting subtest: short-flip-after-cursor-toggle [249.973877] Subtest short-flip-after-cursor-toggle: SUCCESS (0.920s) [250.779238] [076/130] (770s left) core_getversion (basic) [250.818148] Starting subtest: basic [250.822414] Subtest basic: SUCCESS (0.000s) [250.884839] [077/130] (770s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [250.982100] Starting subtest: blocking-absolute-wf_vblank-interruptible [250.984380] Starting dynamic subtest: A-eDP1 [259.780464] Dynamic subtest A-eDP1: SUCCESS (8.763s) [259.791496] Starting dynamic subtest: B-eDP1 [268.502373] Dynamic subtest B-eDP1: SUCCESS (8.719s) [268.511873] Starting dynamic subtest: C-eDP1 [277.224856] Dynamic subtest C-eDP1: SUCCESS (8.707s) [277.233094] Starting dynamic subtest: D-eDP1 [285.952670] Dynamic subtest D-eDP1: SUCCESS (8.723s) [285.955256] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.926s) [287.140487] [078/130] (734s left) gem_ctx_persistence (engines-queued) [287.196790] Starting subtest: engines-queued [287.199157] Starting dynamic subtest: rcs0 [287.256788] Dynamic subtest rcs0: SUCCESS (0.059s) [287.267187] Starting dynamic subtest: bcs0 [287.281313] Dynamic subtest bcs0: SUCCESS (0.024s) [287.289162] Starting dynamic subtest: vcs0 [288.826290] Dynamic subtest vcs0: SUCCESS (1.542s) [288.837025] Starting dynamic subtest: vcs1 [290.744487] Dynamic subtest vcs1: SUCCESS (1.916s) [290.756045] Starting dynamic subtest: vecs0 [291.831024] Dynamic subtest vecs0: SUCCESS (1.083s) [291.849689] Starting dynamic subtest: ccs0 [292.014588] Dynamic subtest ccs0: SUCCESS (0.183s) [292.017105] Subtest engines-queued: SUCCESS (4.817s) [292.154330] [079/130] (729s left) kms_async_flips (test-time-stamp-atomic) [292.231643] Starting subtest: test-time-stamp-atomic [292.616339] Starting dynamic subtest: pipe-A-eDP-1 [293.425096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s) [293.814947] Starting dynamic subtest: pipe-B-eDP-1 [294.557560] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s) [294.927936] Starting dynamic subtest: pipe-C-eDP-1 [295.688425] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [296.055649] Starting dynamic subtest: pipe-D-eDP-1 [296.815705] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s) [296.818177] Subtest test-time-stamp-atomic: SUCCESS (4.583s) [297.970411] [080/130] (723s left) syncobj_timeline (invalid-signal-one-illegal-handle) [298.029367] Starting subtest: invalid-signal-one-illegal-handle [298.031721] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [298.141552] [081/130] (723s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [298.210886] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [304.736070] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.528s) [304.896540] [082/130] (716s left) kms_psr (fbc-pr-sprite-blt) [304.984783] Starting subtest: fbc-pr-sprite-blt [304.989205] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [305.058971] [083/130] (716s left) kms_plane_multiple (tiling-y) [305.124405] Starting subtest: tiling-y [305.128893] Subtest tiling-y: SKIP (0.000s) [305.203883] [084/130] (716s left) gen9_exec_parse (allowed-single) [305.262719] Subtest allowed-single: SKIP (0.000s) [305.364692] [085/130] (716s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [305.454537] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [312.523771] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.073s) [313.712784] [086/130] (707s left) perf (invalid-open-flags) [313.822067] Starting subtest: invalid-open-flags [313.824408] Subtest invalid-open-flags: SUCCESS (0.000s) [313.867320] [087/130] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [313.944366] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [313.948313] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [314.045842] [088/130] (707s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [314.147785] Starting subtest: 2x-long-cursor-vs-flip-atomic [314.152658] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [314.293400] [089/130] (707s left) kms_big_fb (linear-64bpp-rotate-0) [314.369432] Starting subtest: linear-64bpp-rotate-0 [315.871044] Subtest linear-64bpp-rotate-0: SUCCESS (1.501s) [316.027354] [090/130] (705s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [316.094186] Starting subtest: pixel-format-y-tiled-ccs-modifier [316.098663] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [316.168987] [091/130] (705s left) gem_eio (unwedge-stress) [316.379104] Starting subtest: unwedge-stress [316.380781] Starting dynamic subtest: render [321.121240] Dynamic subtest render: SUCCESS (4.738s) [321.138682] Starting dynamic subtest: bsd1 [339.327997] Dynamic subtest bsd1: SUCCESS (18.205s) [339.344571] Starting dynamic subtest: bsd2 [357.317961] Dynamic subtest bsd2: SUCCESS (17.988s) [357.334226] Starting dynamic subtest: blt [357.338201] Dynamic subtest blt: SKIP (0.000s) [357.346685] Starting dynamic subtest: vebox [377.338583] Dynamic subtest vebox: SUCCESS (20.018s) [377.340580] Subtest unwedge-stress: SUCCESS (60.953s) [378.883063] [092/130] (642s left) kms_chamelium_frames (vga-frame-dump) [379.263969] Subtest vga-frame-dump: SKIP (0.000s) [380.109671] [093/130] (641s left) gem_wait (await) [380.178066] Starting subtest: await [380.180316] Starting dynamic subtest: all-engines [381.258690] Dynamic subtest all-engines: SUCCESS (1.079s) [381.275167] Starting dynamic subtest: rcs0 [382.313826] Dynamic subtest rcs0: SUCCESS (1.055s) [382.330336] Starting dynamic subtest: bcs0 [383.369897] Dynamic subtest bcs0: SUCCESS (1.053s) [383.386043] Starting dynamic subtest: vcs0 [384.422801] Dynamic subtest vcs0: SUCCESS (1.050s) [384.439086] Starting dynamic subtest: vcs1 [385.477068] Dynamic subtest vcs1: SUCCESS (1.052s) [385.493302] Starting dynamic subtest: vecs0 [386.531203] Dynamic subtest vecs0: SUCCESS (1.052s) [386.547307] Starting dynamic subtest: ccs0 [387.589238] Dynamic subtest ccs0: SUCCESS (1.055s) [387.591921] Subtest await: SUCCESS (7.413s) [387.807809] [094/130] (634s left) kms_vblank (query-forked) [387.894200] Starting subtest: query-forked [387.896541] Starting dynamic subtest: pipe-A-eDP-1 [389.725474] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.831s) [389.739633] Starting dynamic subtest: pipe-D-eDP-1 [392.248362] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.521s) [392.251094] Subtest query-forked: SUCCESS (4.356s) [393.116122] [095/130] (628s left) gem_ppgtt (blt-vs-render-ctx0) [393.176172] Starting subtest: blt-vs-render-ctx0 [426.248831] Subtest blt-vs-render-ctx0: SUCCESS (33.070s) [426.388409] [096/130] (595s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [426.517426] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [426.521313] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [426.616673] [097/130] (595s left) kms_cursor_crc (cursor-random-256x85) [426.859799] Starting subtest: cursor-random-256x85 [426.909779] Subtest cursor-random-256x85: SKIP (0.045s) [427.093955] [098/130] (594s left) gem_ctx_create (basic) [427.163707] Starting subtest: basic [427.166129] Subtest basic: SUCCESS (0.000s) [427.349810] [099/130] (594s left) kms_flip (dpms-vs-vblank-race) [427.436129] Starting subtest: dpms-vs-vblank-race [427.438119] Starting dynamic subtest: A-eDP1 [432.394081] Dynamic subtest A-eDP1: SUCCESS (4.958s) [432.403545] Starting dynamic subtest: B-eDP1 [437.021530] Dynamic subtest B-eDP1: SUCCESS (4.627s) [437.031063] Starting dynamic subtest: C-eDP1 [441.649926] Dynamic subtest C-eDP1: SUCCESS (4.625s) [441.663110] Starting dynamic subtest: D-eDP1 [446.267260] Dynamic subtest D-eDP1: SUCCESS (4.614s) [446.269812] Subtest dpms-vs-vblank-race: SUCCESS (18.834s) [447.145730] [100/130] (575s left) perf_pmu (render-node-busy-idle) [447.222811] Starting subtest: render-node-busy-idle [447.225287] Starting dynamic subtest: rcs0 [447.905108] Dynamic subtest rcs0: SUCCESS (0.682s) [447.916471] Starting dynamic subtest: bcs0 [448.563375] Dynamic subtest bcs0: SUCCESS (0.656s) [448.576531] Starting dynamic subtest: vcs0 [449.881407] Dynamic subtest vcs0: SUCCESS (1.315s) [449.894394] Starting dynamic subtest: vcs1 [451.866101] Dynamic subtest vcs1: SUCCESS (1.982s) [451.879562] Starting dynamic subtest: vecs0 [453.849312] Dynamic subtest vecs0: SUCCESS (1.980s) [453.862201] Starting dynamic subtest: ccs0 [454.525079] Dynamic subtest ccs0: SUCCESS (0.674s) [454.527893] Subtest render-node-busy-idle: SUCCESS (7.303s) [454.600416] [101/130] (567s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [454.684923] Starting subtest: fbcpsr-shrfb-scaledprimary [460.443552] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.763s) [460.590306] [102/130] (561s left) gem_exec_params (secure-non-root) [460.655718] Starting subtest: secure-non-root [460.660128] Subtest secure-non-root: SKIP (0.000s) [460.783407] [103/130] (561s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [460.863639] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [461.531887] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s) [461.702856] [104/130] (560s left) i915_pm_rpm (debugfs-read) [464.016322] Starting subtest: debugfs-read [465.162039] Subtest debugfs-read: SUCCESS (1.146s) [465.530470] [105/130] (556s left) i915_suspend (sysfs-reader) [465.587495] Starting subtest: sysfs-reader [484.087024] Subtest sysfs-reader: SUCCESS (3.268s) [484.154352] [106/130] (538s left) kms_invalid_mode (bad-htotal) [484.244531] Starting subtest: bad-htotal [484.246350] Starting dynamic subtest: pipe-A-eDP-1 [484.528083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [484.539105] Starting dynamic subtest: pipe-B-eDP-1 [484.540999] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [484.551192] Starting dynamic subtest: pipe-C-eDP-1 [484.553467] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [484.566077] Starting dynamic subtest: pipe-D-eDP-1 [484.568456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [484.570745] Subtest bad-htotal: SUCCESS (0.291s) [485.392113] [107/130] (537s left) perf (non-zero-reason) [485.502362] Starting subtest: non-zero-reason [485.504828] Starting dynamic subtest: 0-rcs0 [490.844101] Dynamic subtest 0-rcs0: SUCCESS (5.361s) [490.858352] Starting dynamic subtest: 1-vcs1 [494.725673] Dynamic subtest 1-vcs1: SUCCESS (3.890s) [494.728677] Subtest non-zero-reason: SUCCESS (9.252s) [494.776693] [108/130] (527s left) gem_mmap_offset (partial-mmap) [494.831037] Starting subtest: partial-mmap [494.833697] Starting dynamic subtest: smem0 [494.836477] Dynamic subtest smem0: SUCCESS (0.007s) [494.838885] Subtest partial-mmap: SUCCESS (0.007s) [494.981804] [109/130] (527s left) kms_hdr (bpc-switch) [495.068200] Starting subtest: bpc-switch [496.127372] Starting dynamic subtest: pipe-A-eDP-1 [499.598685] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s) [499.601029] Subtest bpc-switch: SUCCESS (4.540s) [499.709972] [110/130] (522s left) gem_huc_copy (huc-copy) [499.770875] Starting subtest: huc-copy [499.776011] Subtest huc-copy: SUCCESS (0.004s) [499.911439] [111/130] (522s left) gem_ccs (block-multicopy-inplace) [499.990292] Starting subtest: block-multicopy-inplace [499.994803] Subtest block-multicopy-inplace: SKIP (0.000s) [500.117059] [112/130] (522s left) kms_psr (pr-cursor-plane-move) [500.188574] Starting subtest: pr-cursor-plane-move [500.193028] Subtest pr-cursor-plane-move: SKIP (0.000s) [500.277208] [113/130] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [500.363719] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [500.367710] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [500.459554] [114/130] (522s left) gem_pxp (create-regular-context-1) [500.595102] Starting subtest: create-regular-context-1 [500.597235] Subtest create-regular-context-1: SUCCESS (0.002s) [500.713923] [115/130] (522s left) kms_properties (connector-properties-atomic) [500.783444] Starting subtest: connector-properties-atomic [500.785430] Starting dynamic subtest: pipe-A-eDP-1 [508.486542] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.707s) [508.497469] Starting dynamic subtest: pipe-None-DP-1 [508.501806] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [508.512038] Starting dynamic subtest: pipe-None-DP-2 [508.516101] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [508.525585] Starting dynamic subtest: pipe-None-DP-3 [508.529554] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [508.539410] Starting dynamic subtest: pipe-None-DP-4 [508.543819] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [508.553448] Starting dynamic subtest: pipe-None-DP-5 [508.558057] Dynamic subtest pipe-None-DP-5: SUCCESS (0.001s) [508.560398] Subtest connector-properties-atomic: SUCCESS (7.717s) [509.343900] [116/130] (513s left) gem_eio (hibernate) [509.556997] Starting subtest: hibernate [523.121614] Subtest hibernate: SUCCESS (13.572s) [530.317228] [117/130] (499s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [530.460277] Starting subtest: pr-primary-plane-update-sf-dmg-area [530.464544] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [530.539581] [118/130] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [530.626899] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [530.631122] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [530.708953] [119/130] (499s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [530.796969] Starting subtest: psr-modesetfrombusy [536.930777] Subtest psr-modesetfrombusy: SUCCESS (6.146s) [537.072215] [120/130] (492s left) gem_exec_params (invalid-bsd1-flag-on-blt) [537.127387] Starting subtest: invalid-bsd1-flag-on-blt [537.129099] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [537.244005] [121/130] (492s left) api_intel_allocator (two-level-inception) [537.306025] Starting subtest: two-level-inception [542.703479] Subtest two-level-inception: SUCCESS (5.400s) [542.848491] [122/130] (487s left) kms_psr (fbc-pr-cursor-mmap-gtt) [542.942443] Starting subtest: fbc-pr-cursor-mmap-gtt [542.946885] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [543.021520] [123/130] (487s left) drm_read (short-buffer-nonblock) [543.188574] Starting subtest: short-buffer-nonblock [543.190955] Subtest short-buffer-nonblock: SUCCESS (0.000s) [543.345736] [124/130] (486s left) sriov_basic (enable-vfs-bind-unbind-each) [543.421190] Starting subtest: enable-vfs-bind-unbind-each [543.423508] Starting dynamic subtest: numvfs-1 [543.502662] Dynamic subtest numvfs-1: FAIL (0.028s) [543.522759] Starting dynamic subtest: numvfs-2 [543.593239] Dynamic subtest numvfs-2: FAIL (0.006s) [543.613017] Starting dynamic subtest: numvfs-3 [543.688967] Dynamic subtest numvfs-3: FAIL (0.003s) [543.702066] Starting dynamic subtest: numvfs-4 [543.764917] Dynamic subtest numvfs-4: FAIL (0.003s) [543.777781] Starting dynamic subtest: numvfs-5 [543.838188] Dynamic subtest numvfs-5: FAIL (0.004s) [543.850620] Starting dynamic subtest: numvfs-6 [543.910192] Dynamic subtest numvfs-6: FAIL (0.003s) [543.921384] Starting dynamic subtest: numvfs-7 [543.978909] Dynamic subtest numvfs-7: FAIL (0.004s) [543.989409] Starting dynamic subtest: numvfs-random [544.049960] Dynamic subtest numvfs-random: FAIL (0.003s) [544.051559] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s) [544.091900] [125/130] (486s left) kms_cursor_edge_walk (128x128-right-edge) [544.181874] Starting subtest: 128x128-right-edge [544.183950] Starting dynamic subtest: pipe-A-eDP-1 [547.689561] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.507s) [547.701441] Starting dynamic subtest: pipe-D-eDP-1 [550.800667] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s) [550.802939] Subtest 128x128-right-edge: SUCCESS (6.621s) [551.595055] [126/130] (478s left) api_intel_bb (reset-flags) [551.647445] Starting subtest: reset-flags [551.652393] Subtest reset-flags: SUCCESS (0.007s) [551.789142] [127/130] (478s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [551.868378] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [559.347725] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.485s) [559.486330] [128/130] (470s left) syncobj_wait (multi-wait-all-signaled) [559.564769] Starting subtest: multi-wait-all-signaled [559.566696] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [559.662820] [129/130] (470s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [559.710219] Starting subtest: etime-single-wait-all-for-submit-submitted [559.819186] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s) [559.909459] [130/130] (470s left) kms_psr (psr2-no-drrs) [559.983216] Starting subtest: psr2-no-drrs [559.985502] Starting dynamic subtest: eDP-1 [561.584943] Dynamic subtest eDP-1: SUCCESS (1.601s) [561.587166] Subtest psr2-no-drrs: SUCCESS (1.602s) [562.386668] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_pm_dc results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: i915_drm_fdinfo results: parsing output: 4/ for test: gem_ctx_persistence results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: syncobj_basic results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: gem_exec_schedule results: parsing output: 11/ for test: gem_exec_balancer results: parsing output: 12/ for test: kms_content_protection results: parsing output: 13/ for test: gem_exec_reloc results: parsing output: 14/ for test: kms_flip_scaled_crc results: parsing output: 15/ for test: kms_addfb_basic results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: gem_ctx_exec results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_softpin results: parsing output: 21/ for test: gem_softpin results: parsing output: 22/ for test: gem_render_copy results: parsing output: 23/ for test: kms_chamelium_audio results: parsing output: 24/ for test: kms_chamelium_frames results: parsing output: 25/ for test: gen3_render_tiledy_blits results: parsing output: 26/ for test: kms_rotation_crc results: parsing output: 27/ for test: i915_drm_fdinfo results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_addfb_basic results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_dsc results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: gem_create results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: gem_exec_whisper results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_parallel results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: gem_exec_nop results: parsing output: 44/ for test: perf results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: gem_mmap_gtt results: parsing output: 48/ for test: kms_plane_alpha_blend results: parsing output: 49/ for test: gem_exec_fence results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: kms_plane_scaling results: parsing output: 52/ for test: gem_exec_fence results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: vgem_basic results: parsing output: 55/ for test: kms_lease results: parsing output: 56/ for test: gem_lmem_swapping results: parsing output: 57/ for test: kms_color results: parsing output: 58/ for test: kms_psr_stress_test results: parsing output: 59/ for test: kms_dp_linktrain_fallback results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: kms_flip_scaled_crc results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: gem_exec_nop results: parsing output: 64/ for test: template results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_prop_blob results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: gem_fenced_exec_thrash results: parsing output: 70/ for test: gem_mmap_gtt results: parsing output: 71/ for test: kms_ccs results: parsing output: 72/ for test: kms_sequence results: parsing output: 73/ for test: kms_plane_scaling results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: core_getversion results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: gem_ctx_persistence results: parsing output: 78/ for test: kms_async_flips results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: kms_plane_multiple results: parsing output: 83/ for test: gen9_exec_parse results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: perf results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_plane results: parsing output: 90/ for test: gem_eio results: parsing output: 91/ for test: kms_chamelium_frames results: parsing output: 92/ for test: gem_wait results: parsing output: 93/ for test: kms_vblank results: parsing output: 94/ for test: gem_ppgtt results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: gem_ctx_create results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: perf_pmu results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_exec_params results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: i915_pm_rpm results: parsing output: 104/ for test: i915_suspend results: parsing output: 105/ for test: kms_invalid_mode results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: gem_mmap_offset results: parsing output: 108/ for test: kms_hdr results: parsing output: 109/ for test: gem_huc_copy results: parsing output: 110/ for test: gem_ccs results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_pxp results: parsing output: 114/ for test: kms_properties results: parsing output: 115/ for test: gem_eio results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_exec_params results: parsing output: 120/ for test: api_intel_allocator results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: drm_read results: parsing output: 123/ for test: sriov_basic results: parsing output: 124/ for test: kms_cursor_edge_walk results: parsing output: 125/ for test: api_intel_bb results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: kms_psr Done.