[53.992058] Initializing watchdogs [53.992107] /dev/watchdog0 [54.004637] [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] [54.009350] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.011431] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.014586] [001/131] (960s left) kms_feature_discovery (display-2x) [54.147591] Starting subtest: display-2x [54.151414] Subtest display-2x: SKIP (0.000s) [54.213301] [002/131] (960s left) api_intel_allocator (gem-pool) [54.271362] Starting subtest: gem-pool [54.281584] Subtest gem-pool: SUCCESS (0.013s) [54.363593] [003/131] (960s left) gem_eio (throttle) [54.494290] Starting subtest: throttle [54.638021] Subtest throttle: SUCCESS (0.146s) [54.767472] [004/131] (959s left) kms_flip (basic-plain-flip) [54.860485] Starting subtest: basic-plain-flip [54.862527] Starting dynamic subtest: A-eDP1 [56.540370] Dynamic subtest A-eDP1: SUCCESS (1.701s) [56.549334] Starting dynamic subtest: B-eDP1 [58.242531] Dynamic subtest B-eDP1: SUCCESS (1.720s) [58.249706] Starting dynamic subtest: C-eDP1 [59.945381] Dynamic subtest C-eDP1: SUCCESS (1.716s) [59.953213] Starting dynamic subtest: D-eDP1 [61.657269] Dynamic subtest D-eDP1: SUCCESS (1.723s) [61.659949] Subtest basic-plain-flip: SUCCESS (6.867s) [62.796232] [005/131] (951s left) i915_module_load (reload-with-fault-injection) [62.833417] Starting subtest: reload-with-fault-injection [96.788899] Subtest reload-with-fault-injection: SUCCESS (33.990s) [96.816248] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true [96.818742] [006/131] (917s left) sysfs_timeslice_duration (timeout) [98.264869] Starting subtest: timeout [98.267228] Starting dynamic subtest: vecs0 [107.941979] Dynamic subtest vecs0: SUCCESS (9.678s) [107.952233] Starting dynamic subtest: ccs0 [109.133864] Dynamic subtest ccs0: SUCCESS (1.189s) [109.143665] Starting dynamic subtest: vcs0 [118.951019] Dynamic subtest vcs0: SUCCESS (9.818s) [118.959747] Starting dynamic subtest: bcs0 [119.498484] Dynamic subtest bcs0: SUCCESS (0.545s) [119.508719] Starting dynamic subtest: rcs0 [120.730764] Dynamic subtest rcs0: SUCCESS (1.233s) [120.740844] Starting dynamic subtest: vcs1 [129.879529] Dynamic subtest vcs1: SUCCESS (9.145s) [129.882027] Subtest timeout: SUCCESS (31.614s) [129.924672] [FACT sysfs_timeslice_duration (timeout)] new: kernel.kmod_is_loaded.i915: true [129.928137] [007/131] (884s left) kms_cursor_crc (cursor-size-change) [130.026043] Starting subtest: cursor-size-change [130.028253] Starting dynamic subtest: pipe-A-eDP-1 [131.123736] Dynamic subtest pipe-A-eDP-1: FAIL (0.551s) [131.132306] Starting dynamic subtest: pipe-D-eDP-1 [132.513997] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.935s) [132.516966] Subtest cursor-size-change: FAIL (2.487s) [133.354887] [008/131] (881s left) core_auth (basic-auth) [133.413579] Starting subtest: basic-auth [133.415882] Subtest basic-auth: SUCCESS (0.001s) [133.530147] [009/131] (881s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [133.634200] Starting subtest: random-ccs-data-yf-tiled-ccs [133.636963] Starting dynamic subtest: pipe-A-eDP-1 [133.663780] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [133.672843] Starting dynamic subtest: pipe-B-eDP-1 [133.698817] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [133.707457] Starting dynamic subtest: pipe-C-eDP-1 [133.731435] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [133.738761] Starting dynamic subtest: pipe-D-eDP-1 [133.764355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [133.768926] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.002s) [135.813463] [010/131] (879s left) gem_create (busy-create) [135.872649] Starting subtest: busy-create [135.875088] Starting dynamic subtest: smem0 [169.969333] Dynamic subtest smem0: SUCCESS (34.083s) [169.971473] Subtest busy-create: SUCCESS (34.083s) [170.155817] [011/131] (844s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [170.201798] Starting subtest: etime-single-wait-for-submit-unsubmitted [170.305818] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s) [170.381662] [012/131] (844s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [170.482885] Starting subtest: basic-flip-after-cursor-varying-size [171.534778] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.052s) [172.347195] [013/131] (842s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [172.446419] Starting subtest: fbc-rgb101010-draw-mmap-gtt [172.450547] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [172.551544] [014/131] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [172.650695] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [172.654842] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [172.746626] [015/131] (842s left) perf (invalid-create-userspace-config) [172.856962] Starting subtest: invalid-create-userspace-config [172.859332] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [172.900164] [016/131] (842s left) kms_plane (plane-position-hole-dpms) [172.984692] Starting subtest: plane-position-hole-dpms [173.487918] Starting dynamic subtest: pipe-A-plane-1 [175.811736] Dynamic subtest pipe-A-plane-1: SUCCESS (2.325s) [175.821784] Starting dynamic subtest: pipe-A-plane-2 [178.075242] Dynamic subtest pipe-A-plane-2: SUCCESS (2.260s) [178.083191] Starting dynamic subtest: pipe-A-plane-3 [180.317913] Dynamic subtest pipe-A-plane-3: SUCCESS (2.244s) [180.326061] Starting dynamic subtest: pipe-A-plane-4 [182.585711] Dynamic subtest pipe-A-plane-4: SUCCESS (2.267s) [182.595024] Starting dynamic subtest: pipe-A-plane-5 [182.623774] Dynamic subtest pipe-A-plane-5: SUCCESS (0.036s) [183.765823] Starting dynamic subtest: pipe-B-plane-1 [186.067606] Dynamic subtest pipe-B-plane-1: SUCCESS (2.304s) [186.076431] Starting dynamic subtest: pipe-B-plane-2 [188.423204] Dynamic subtest pipe-B-plane-2: SUCCESS (2.356s) [188.430586] Starting dynamic subtest: pipe-B-plane-3 [190.671349] Dynamic subtest pipe-B-plane-3: SUCCESS (2.247s) [190.682677] Starting dynamic subtest: pipe-B-plane-4 [192.927380] Dynamic subtest pipe-B-plane-4: SUCCESS (2.255s) [192.936423] Starting dynamic subtest: pipe-B-plane-5 [192.968195] Dynamic subtest pipe-B-plane-5: SUCCESS (0.038s) [192.970526] Subtest plane-position-hole-dpms: SUCCESS (19.975s) [193.736989] [017/131] (821s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [193.835172] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [193.837516] Starting dynamic subtest: pipe-A-default-mode [196.588027] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s) [196.589995] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.751s) [197.411314] [018/131] (817s left) gem_exec_schedule (smoketest-all) [197.477293] Starting subtest: smoketest-all [229.846422] Subtest smoketest-all: SUCCESS (32.321s) [230.931487] [019/131] (784s left) perf (per-context-mode-unprivileged) [231.006836] Starting subtest: per-context-mode-unprivileged [231.011174] Subtest per-context-mode-unprivileged: SKIP (0.000s) [231.050941] [020/131] (784s left) gem_exec_fence (syncobj-timeline-signal) [231.631057] Starting subtest: syncobj-timeline-signal [231.643136] Subtest syncobj-timeline-signal: SUCCESS (0.014s) [233.017529] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [233.020772] [021/131] (782s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [233.120872] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [233.123416] Starting dynamic subtest: pipe-A [233.133716] Dynamic subtest pipe-A: SKIP (0.005s) [233.143301] Starting dynamic subtest: pipe-B [233.152113] Dynamic subtest pipe-B: SKIP (0.017s) [233.159612] Starting dynamic subtest: pipe-C [233.174265] Dynamic subtest pipe-C: SKIP (0.023s) [233.186472] Starting dynamic subtest: pipe-D [233.195402] Dynamic subtest pipe-D: SKIP (0.018s) [233.199827] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.065s) [233.294873] [022/131] (781s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [233.398061] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [233.400302] Starting dynamic subtest: pipe-A-eDP-1 [234.247906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.838s) [234.256467] Starting dynamic subtest: pipe-B-eDP-1 [235.727709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s) [235.736748] Starting dynamic subtest: pipe-C-eDP-1 [237.232288] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s) [237.240640] Starting dynamic subtest: pipe-D-eDP-1 [238.662453] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.429s) [238.664602] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.254s) [239.829870] [023/131] (775s left) kms_cursor_crc (cursor-onscreen-32x32) [239.996070] Starting subtest: cursor-onscreen-32x32 [240.034738] Subtest cursor-onscreen-32x32: SKIP (0.038s) [240.341705] [024/131] (774s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [240.443736] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [240.448021] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [240.551836] [025/131] (774s left) kms_prop_blob (blob-prop-core) [240.611890] Starting subtest: blob-prop-core [240.614248] Subtest blob-prop-core: SUCCESS (0.000s) [240.720144] [026/131] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [240.818560] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [247.213232] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.395s) [247.345040] [027/131] (768s left) gem_exec_schedule (preempt-queue-chain) [247.412521] Subtest preempt-queue-chain: SKIP (0.000s) [247.695299] [028/131] (767s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [247.790352] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [247.793474] Starting dynamic subtest: pipe-A-default-mode [248.080859] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [248.085366] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s) [248.943999] [029/131] (766s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [249.058949] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [249.063226] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [249.168532] [030/131] (766s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [254.187602] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [254.192208] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [255.037635] [031/131] (760s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [255.093303] Starting subtest: yf-tiled-ccs-to-y-tiled [255.098112] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [255.278264] [032/131] (760s left) perf_pmu (semaphore-wait) [255.317324] Starting subtest: semaphore-wait [255.319638] Starting dynamic subtest: rcs0 [255.833087] Dynamic subtest rcs0: SUCCESS (0.514s) [255.844440] Starting dynamic subtest: bcs0 [256.346558] Dynamic subtest bcs0: SUCCESS (0.510s) [256.358100] Starting dynamic subtest: vcs0 [256.860081] Dynamic subtest vcs0: SUCCESS (0.511s) [256.871215] Starting dynamic subtest: vcs1 [257.372521] Dynamic subtest vcs1: SUCCESS (0.510s) [257.384075] Starting dynamic subtest: vecs0 [257.884506] Dynamic subtest vecs0: SUCCESS (0.509s) [257.895316] Starting dynamic subtest: ccs0 [258.398525] Dynamic subtest ccs0: SUCCESS (0.513s) [258.401533] Subtest semaphore-wait: SUCCESS (3.081s) [259.933706] [033/131] (755s left) kms_flip (2x-plain-flip-interruptible) [260.033729] Starting subtest: 2x-plain-flip-interruptible [260.044165] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [260.117862] [034/131] (755s left) gem_exec_flush (basic-wb-rw-before-default) [260.174892] Starting subtest: basic-wb-rw-before-default [265.629157] Subtest basic-wb-rw-before-default: SUCCESS (5.454s) [265.818059] [035/131] (749s left) gen7_exec_parse (oacontrol-tracking) [265.882837] Subtest oacontrol-tracking: SKIP (0.000s) [265.963719] [036/131] (749s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [266.062820] Starting subtest: yf-tiled-16bpp-rotate-270 [266.067045] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [266.167659] [037/131] (749s left) kms_psr (psr-sprite-plane-move) [266.256423] Starting subtest: psr-sprite-plane-move [266.258766] Starting dynamic subtest: eDP-1 [268.077240] Dynamic subtest eDP-1: SUCCESS (1.817s) [268.079524] Subtest psr-sprite-plane-move: SUCCESS (1.818s) [268.884690] [038/131] (746s left) gem_exec_params (rsvd2-dirt) [268.944467] Starting subtest: rsvd2-dirt [268.949284] Subtest rsvd2-dirt: SKIP (0.000s) [269.056270] [039/131] (746s left) kms_flip (flip-vs-wf_vblank-interruptible) [269.156966] Starting subtest: flip-vs-wf_vblank-interruptible [269.159339] Starting dynamic subtest: A-eDP1 [271.036315] Dynamic subtest A-eDP1: SUCCESS (1.878s) [271.046302] Starting dynamic subtest: B-eDP1 [272.959907] Dynamic subtest B-eDP1: SUCCESS (1.923s) [272.969752] Starting dynamic subtest: C-eDP1 [274.870089] Dynamic subtest C-eDP1: SUCCESS (1.909s) [274.878959] Starting dynamic subtest: D-eDP1 [276.788803] Dynamic subtest D-eDP1: SUCCESS (1.918s) [276.791181] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.635s) [278.006071] [040/131] (737s left) kms_universal_plane (universal-plane-pageflip-windowed) [278.108159] Starting subtest: universal-plane-pageflip-windowed [278.110483] Starting dynamic subtest: pipe-A-eDP-1 [278.710278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s) [278.718532] Starting dynamic subtest: pipe-B-eDP-1 [279.933710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s) [279.942605] Starting dynamic subtest: pipe-C-eDP-1 [281.135765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s) [281.144354] Starting dynamic subtest: pipe-D-eDP-1 [282.363760] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [282.366123] Subtest universal-plane-pageflip-windowed: SUCCESS (4.255s) [283.204201] [041/131] (732s left) gem_exec_balancer (nohangcheck) [283.465627] Starting subtest: nohangcheck [284.342569] Subtest nohangcheck: SUCCESS (0.875s) [284.499447] [042/131] (731s left) kms_big_fb (linear-16bpp-rotate-180) [284.601264] Starting subtest: linear-16bpp-rotate-180 [286.133546] Subtest linear-16bpp-rotate-180: SUCCESS (1.533s) [286.306066] [043/131] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [286.416622] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [286.420055] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [286.500427] [044/131] (729s left) gem_exec_async (forked-writes) [286.554241] Starting subtest: forked-writes [286.556090] Starting dynamic subtest: rcs0 [286.581503] Dynamic subtest rcs0: SUCCESS (0.027s) [286.589974] Starting dynamic subtest: bcs0 [286.604063] Dynamic subtest bcs0: SUCCESS (0.022s) [286.616724] Starting dynamic subtest: vcs0 [286.627520] Dynamic subtest vcs0: SUCCESS (0.022s) [286.636620] Starting dynamic subtest: vcs1 [286.651600] Dynamic subtest vcs1: SUCCESS (0.023s) [286.659909] Starting dynamic subtest: vecs0 [286.672277] Dynamic subtest vecs0: SUCCESS (0.020s) [286.680202] Starting dynamic subtest: ccs0 [286.692845] Dynamic subtest ccs0: SUCCESS (0.020s) [286.694834] Subtest forked-writes: SUCCESS (0.139s) [286.933883] [045/131] (729s left) gem_mmap_gtt (basic-write) [286.991961] Subtest basic-write: SKIP (0.000s) [287.053616] [046/131] (729s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [287.148386] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [287.261417] [047/131] (728s left) kms_chamelium_edid (hdmi-mode-timings) [287.640641] Subtest hdmi-mode-timings: SKIP (0.000s) [288.412403] [048/131] (727s left) kms_vrr (seamless-rr-switch-drrs) [288.504330] Starting subtest: seamless-rr-switch-drrs [288.511067] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [288.579980] [049/131] (727s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [288.638104] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [288.701898] [050/131] (727s left) kms_psr (pr-primary-page-flip) [288.788027] Starting subtest: pr-primary-page-flip [288.792094] Subtest pr-primary-page-flip: SKIP (0.000s) [288.857288] [051/131] (727s left) kms_psr (fbc-psr-cursor-plane-move) [288.958315] Starting subtest: fbc-psr-cursor-plane-move [288.960473] Starting dynamic subtest: eDP-1 [288.964462] Dynamic subtest eDP-1: SKIP (0.000s) [288.968558] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [289.029111] [052/131] (727s left) i915_selftest (perf) [290.914725] Starting subtest: perf [290.916885] Starting dynamic subtest: engine_cs [295.375053] Dynamic subtest engine_cs: SUCCESS (4.462s) [295.384086] Starting dynamic subtest: request [300.719779] Dynamic subtest request: SUCCESS (5.343s) [300.728675] Starting dynamic subtest: migrate [303.729042] Dynamic subtest migrate: SUCCESS (3.009s) [303.738066] Starting dynamic subtest: region [309.566033] Dynamic subtest region: SUCCESS (5.835s) [309.568795] Subtest perf: SUCCESS (18.654s) [309.612594] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [309.613279] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [309.616506] [053/131] (706s left) kms_invalid_mode (zero-vdisplay) [311.089614] Starting subtest: zero-vdisplay [311.091779] Starting dynamic subtest: pipe-A-eDP-1 [311.381636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [311.389652] Starting dynamic subtest: pipe-B-eDP-1 [311.391965] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [311.399624] Starting dynamic subtest: pipe-C-eDP-1 [311.402033] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [311.409462] Starting dynamic subtest: pipe-D-eDP-1 [311.411698] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [311.413943] Subtest zero-vdisplay: SUCCESS (0.297s) [312.254496] [FACT kms_invalid_mode (zero-vdisplay)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [312.255686] [FACT kms_invalid_mode (zero-vdisplay)] new: kernel.kmod_is_loaded.i915: true [312.259101] [054/131] (704s left) tools_test (sysfs_l3_parity) [312.314779] Starting subtest: sysfs_l3_parity [312.393376] Subtest sysfs_l3_parity: SKIP (0.091s) [312.444986] [055/131] (704s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [317.485756] Starting subtest: fbc-pr-cursor-plane-update-sf [317.490265] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s) [318.338394] [056/131] (698s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [318.431593] Starting subtest: fbcpsr-slowdraw [343.541117] Subtest fbcpsr-slowdraw: SUCCESS (25.110s) [343.674884] [057/131] (672s left) syncobj_timeline (signal) [343.721513] Starting subtest: signal [343.723485] Subtest signal: SUCCESS (0.000s) [343.827752] [058/131] (672s left) kms_content_protection (atomic) [344.000745] Starting subtest: atomic [347.360873] Subtest atomic: SKIP (3.358s) [348.522756] [059/131] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [348.635537] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [348.639637] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [348.745415] [060/131] (668s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [348.855984] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [348.860226] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [348.972177] [061/131] (667s left) gem_vm_create (execbuf) [349.040326] Starting subtest: execbuf [349.046719] Subtest execbuf: SUCCESS (0.006s) [349.187445] [062/131] (667s left) gem_softpin (reverse) [349.233775] Starting subtest: reverse [349.241990] Subtest reverse: SUCCESS (0.008s) [349.377183] [063/131] (667s left) core_setmaster_vs_auth [349.542161] [064/131] (667s left) kms_lease (lessee-list) [349.629637] Starting subtest: lessee-list [349.631725] Starting dynamic subtest: pipe-A-eDP-1 [349.633643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [349.641428] Starting dynamic subtest: pipe-B-eDP-1 [349.643228] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [349.650492] Starting dynamic subtest: pipe-C-eDP-1 [349.652249] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [349.659475] Starting dynamic subtest: pipe-D-eDP-1 [349.661298] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [349.663085] Subtest lessee-list: SUCCESS (0.008s) [349.757157] [065/131] (667s left) gem_ctx_persistence (legacy-engines-cleanup) [349.817941] Starting subtest: legacy-engines-cleanup [349.819994] Starting dynamic subtest: render [349.919588] Dynamic subtest render: SUCCESS (0.100s) [349.930394] Starting dynamic subtest: bsd1 [349.976651] Dynamic subtest bsd1: SUCCESS (0.055s) [349.987202] Starting dynamic subtest: bsd2 [350.035285] Dynamic subtest bsd2: SUCCESS (0.057s) [350.048094] Starting dynamic subtest: blt [350.066118] Dynamic subtest blt: SUCCESS (0.029s) [350.072877] Starting dynamic subtest: vebox [350.170086] Dynamic subtest vebox: SUCCESS (0.103s) [350.172638] Subtest legacy-engines-cleanup: SUCCESS (0.353s) [350.248161] [066/131] (666s left) kms_psr (fbc-pr-sprite-mmap-cpu) [350.343540] Starting subtest: fbc-pr-sprite-mmap-cpu [350.347228] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [350.412773] [067/131] (666s left) gem_fence_thrash (bo-copy) [350.446328] Starting subtest: bo-copy [350.479705] Subtest bo-copy: SKIP (0.033s) [350.540085] [068/131] (666s left) kms_atomic (plane-immutable-zpos) [350.632428] Starting subtest: plane-immutable-zpos [350.634399] Starting dynamic subtest: pipe-A-eDP-1 [351.317220] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s) [351.319461] Subtest plane-immutable-zpos: SUCCESS (0.681s) [352.148500] [069/131] (664s left) prime_mmap_coherency (ioctl-errors) [352.213102] Starting subtest: ioctl-errors [367.237365] Subtest ioctl-errors: SUCCESS (15.023s) [367.378395] [070/131] (649s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [367.460553] Starting subtest: multi-wait-for-submit-submitted-signaled [367.462797] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [367.581816] [071/131] (649s left) syncobj_eventfd (invalid-illegal-handle) [367.644708] Starting subtest: invalid-illegal-handle [367.646633] Subtest invalid-illegal-handle: SUCCESS (0.000s) [367.756881] [072/131] (649s left) syncobj_timeline (invalid-wait-illegal-handle) [367.812063] Starting subtest: invalid-wait-illegal-handle [367.814252] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [367.925193] [073/131] (649s left) gem_ctx_param (invalid-ctx-set) [367.981912] Starting subtest: invalid-ctx-set [367.984020] Subtest invalid-ctx-set: SUCCESS (0.001s) [368.096439] [074/131] (649s left) kms_pipe_crc_basic (read-crc) [368.199890] Starting subtest: read-crc [368.201876] Starting dynamic subtest: pipe-A-eDP-1 [368.909608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s) [368.919066] Starting dynamic subtest: pipe-B-eDP-1 [370.310592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s) [370.319035] Starting dynamic subtest: pipe-C-eDP-1 [371.584765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.274s) [371.593439] Starting dynamic subtest: pipe-D-eDP-1 [372.917297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [372.919466] Subtest read-crc: SUCCESS (4.717s) [373.753938] [075/131] (643s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [373.881422] Starting subtest: verify-pxp-key-change-after-suspend-resume [381.035840] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.157s) [381.183092] [076/131] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [381.300851] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [387.697812] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.400s) [387.833147] [077/131] (629s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [387.934845] Starting subtest: bad-rotation-90-y-tiled-ccs [387.937215] Starting dynamic subtest: pipe-A-eDP-1 [387.960038] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [387.971148] Starting dynamic subtest: pipe-B-eDP-1 [387.992661] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [388.001667] Starting dynamic subtest: pipe-C-eDP-1 [388.023465] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [388.032445] Starting dynamic subtest: pipe-D-eDP-1 [388.055428] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [388.059876] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s) [390.237296] [078/131] (627s left) kms_vrr (flipline) [390.343073] Starting subtest: flipline [390.349837] Subtest flipline: SKIP (0.000s) [390.415750] [079/131] (627s left) vgem_slow (nohang) [390.458885] Starting subtest: nohang [400.500807] Subtest nohang: SUCCESS (10.041s) [400.564444] [080/131] (616s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [400.669223] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [400.671622] Starting dynamic subtest: pipe-A-eDP-1 [400.730562] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [400.739261] Starting dynamic subtest: pipe-B-eDP-1 [400.797506] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [400.807109] Starting dynamic subtest: pipe-C-eDP-1 [400.865320] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [400.875472] Starting dynamic subtest: pipe-D-eDP-1 [400.931267] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [400.935494] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s) [402.791542] [081/131] (614s left) i915_drm_fdinfo (most-busy-check-all) [402.831135] Starting subtest: most-busy-check-all [402.833076] Starting dynamic subtest: rcs0 [402.837682] Dynamic subtest rcs0: SKIP (0.004s) [402.847567] Starting dynamic subtest: bcs0 [402.851847] Dynamic subtest bcs0: SKIP (0.000s) [402.860276] Starting dynamic subtest: vcs0 [402.864620] Dynamic subtest vcs0: SKIP (0.000s) [402.873611] Starting dynamic subtest: vcs1 [402.877958] Dynamic subtest vcs1: SKIP (0.000s) [402.886645] Starting dynamic subtest: vecs0 [402.891311] Dynamic subtest vecs0: SKIP (0.000s) [402.901221] Starting dynamic subtest: ccs0 [402.905367] Dynamic subtest ccs0: SKIP (0.000s) [402.909594] Subtest most-busy-check-all: SKIP (0.008s) [402.945421] [082/131] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [403.059505] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [403.063610] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [403.152812] [083/131] (614s left) gem_exec_schedule (u-submit-early-slice) [403.240128] Starting subtest: u-submit-early-slice [403.242587] Starting dynamic subtest: rcs0 [403.277863] Dynamic subtest rcs0: SUCCESS (0.046s) [403.294948] Starting dynamic subtest: bcs0 [403.316922] Dynamic subtest bcs0: SUCCESS (0.038s) [403.329297] Starting dynamic subtest: vcs0 [403.352858] Dynamic subtest vcs0: SUCCESS (0.035s) [403.362602] Starting dynamic subtest: vcs1 [403.387419] Dynamic subtest vcs1: SUCCESS (0.034s) [403.397173] Starting dynamic subtest: vecs0 [403.423907] Dynamic subtest vecs0: SUCCESS (0.036s) [403.433955] Starting dynamic subtest: ccs0 [403.461903] Dynamic subtest ccs0: SUCCESS (0.037s) [403.464201] Subtest u-submit-early-slice: SUCCESS (0.231s) [405.007820] [084/131] (612s left) kms_properties (get_properties-sanity-non-atomic) [405.100156] Starting subtest: get_properties-sanity-non-atomic [405.102533] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s) [405.172278] [085/131] (612s left) gem_exec_whisper (basic-normal-all) [405.227540] Starting subtest: basic-normal-all [407.559977] Subtest basic-normal-all: SUCCESS (2.330s) [407.742321] [086/131] (610s left) gem_ctx_shared (exec-shared-gtt) [407.794474] Starting subtest: exec-shared-gtt [407.796824] Starting dynamic subtest: rcs0 [407.805514] Dynamic subtest rcs0: SUCCESS (0.011s) [407.819972] Starting dynamic subtest: bcs0 [407.822081] Dynamic subtest bcs0: SUCCESS (0.010s) [407.834895] Starting dynamic subtest: vcs0 [407.837212] Dynamic subtest vcs0: SUCCESS (0.010s) [407.846297] Starting dynamic subtest: vcs1 [407.848222] Dynamic subtest vcs1: SUCCESS (0.010s) [407.857909] Starting dynamic subtest: vecs0 [407.860153] Dynamic subtest vecs0: SUCCESS (0.014s) [407.869138] Starting dynamic subtest: ccs0 [407.871104] Dynamic subtest ccs0: SUCCESS (0.009s) [407.872933] Subtest exec-shared-gtt: SUCCESS (0.067s) [408.060956] [087/131] (609s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [408.147742] Starting subtest: bad-aux-stride-yf-tiled-ccs [408.150181] Starting dynamic subtest: pipe-A-eDP-1 [408.172506] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [408.183366] Starting dynamic subtest: pipe-B-eDP-1 [408.204430] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [408.213152] Starting dynamic subtest: pipe-C-eDP-1 [408.234763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [408.243402] Starting dynamic subtest: pipe-D-eDP-1 [408.264888] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [408.269260] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s) [410.348910] [088/131] (607s left) kms_cursor_crc (cursor-rapid-movement-512x170) [410.636263] Starting subtest: cursor-rapid-movement-512x170 [410.640771] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [410.784506] [089/131] (607s left) gem_pread (exhaustion) [410.844116] Subtest exhaustion: SKIP (0.000s) [410.907352] [090/131] (607s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [410.967451] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [410.969414] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [411.060816] [091/131] (606s left) kms_big_fb (x-tiled-8bpp-rotate-180) [411.174738] Starting subtest: x-tiled-8bpp-rotate-180 [412.342885] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.168s) [412.522992] [092/131] (605s left) gem_mmap (basic) [412.580497] Subtest basic: SKIP (0.000s) [412.650589] [093/131] (605s left) perf_pmu (rc6-all-gts) [412.688967] Starting subtest: rc6-all-gts [419.058874] Subtest rc6-all-gts: SUCCESS (6.368s) [419.930620] [094/131] (598s left) gem_workarounds (basic-read-context) [419.992313] Starting subtest: basic-read-context [420.010851] Subtest basic-read-context: SUCCESS (0.021s) [420.164247] [095/131] (597s left) gem_madvise (dontneed-after-mmap) [420.198911] Starting subtest: dontneed-after-mmap [420.226741] Subtest dontneed-after-mmap: SUCCESS (0.028s) [420.334343] [096/131] (597s left) kms_color (ctm-max) [420.431948] Starting subtest: ctm-max [420.433986] Starting dynamic subtest: pipe-A-eDP-1 [421.142215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [421.152602] Starting dynamic subtest: pipe-B-eDP-1 [422.532953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s) [422.543739] Starting dynamic subtest: pipe-C-eDP-1 [423.912330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [423.922055] Starting dynamic subtest: pipe-D-eDP-1 [425.249619] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s) [425.251879] Subtest ctm-max: SUCCESS (4.815s) [426.045459] [097/131] (592s left) api_intel_bb (blit-reloc-purge-cache) [426.099656] Starting subtest: blit-reloc-purge-cache [426.104208] Subtest blit-reloc-purge-cache: SKIP (0.000s) [426.214568] [098/131] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [426.308285] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [426.312249] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [426.415830] [099/131] (591s left) kms_cursor_edge_walk (256x256-top-edge) [426.509356] Starting subtest: 256x256-top-edge [426.511905] Starting dynamic subtest: pipe-A-eDP-1 [430.007448] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s) [430.017505] Starting dynamic subtest: pipe-D-eDP-1 [433.119651] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s) [433.121998] Subtest 256x256-top-edge: SUCCESS (6.609s) [433.916944] [100/131] (584s left) gem_userptr_blits (sync-unmap-after-close) [433.983745] Starting subtest: sync-unmap-after-close [433.996033] Subtest sync-unmap-after-close: SUCCESS (0.010s) [434.117318] [101/131] (584s left) kms_psr (fbc-pr-sprite-plane-onoff) [434.205083] Starting subtest: fbc-pr-sprite-plane-onoff [434.209309] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [434.287533] [102/131] (584s left) i915_pm_rps (thresholds-idle) [434.344480] Starting subtest: thresholds-idle [434.349404] Subtest thresholds-idle: SKIP (0.001s) [434.426442] [103/131] (584s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [434.523370] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [435.725061] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.201s) [435.887936] [104/131] (582s left) kms_busy (extended-modeset-hang-newfb-with-reset) [435.993411] Starting subtest: extended-modeset-hang-newfb-with-reset [435.995441] Starting dynamic subtest: pipe-A [449.665778] Dynamic subtest pipe-A: SUCCESS (13.671s) [449.676580] Starting dynamic subtest: pipe-D [464.013071] Dynamic subtest pipe-D: SUCCESS (14.342s) [464.015409] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (28.019s) [464.809123] [105/131] (553s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [464.923712] Starting subtest: fbcpsr-rgb101010-draw-pwrite [471.899140] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.978s) [472.010227] [106/131] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [472.109845] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [472.114468] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [472.210093] [107/131] (546s left) gem_userptr_blits (invalid-null-pointer) [472.277860] Starting subtest: invalid-null-pointer [472.280097] Subtest invalid-null-pointer: SUCCESS (0.001s) [472.409385] [108/131] (546s left) gem_exec_schedule (fifo) [472.478198] Starting subtest: fifo [472.480409] Starting dynamic subtest: rcs0 [472.567947] Dynamic subtest rcs0: SUCCESS (0.101s) [472.585232] Starting dynamic subtest: vcs0 [472.645992] Dynamic subtest vcs0: SUCCESS (0.077s) [472.659331] Starting dynamic subtest: vcs1 [472.720163] Dynamic subtest vcs1: SUCCESS (0.074s) [472.732930] Starting dynamic subtest: vecs0 [472.794541] Dynamic subtest vecs0: SUCCESS (0.073s) [472.806412] Starting dynamic subtest: ccs0 [472.869814] Dynamic subtest ccs0: SUCCESS (0.076s) [472.871933] Subtest fifo: SUCCESS (0.405s) [474.055454] [109/131] (544s left) gem_lmem_swapping (verify-ccs) [474.099671] Subtest verify-ccs: SKIP (0.000s) [474.144114] [110/131] (544s left) syncobj_wait (multi-wait-submitted) [474.196359] Starting subtest: multi-wait-submitted [474.298830] Subtest multi-wait-submitted: SUCCESS (0.102s) [474.375870] [111/131] (544s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [474.478424] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [474.482447] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [474.597869] [112/131] (544s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [474.684303] Starting subtest: plane-scaler-with-clipping-clamping-rotation [474.686607] Starting dynamic subtest: pipe-A [475.022493] Dynamic subtest pipe-A: SUCCESS (0.338s) [475.032079] Starting dynamic subtest: pipe-B [476.389616] Dynamic subtest pipe-B: SUCCESS (1.365s) [476.399769] Starting dynamic subtest: pipe-C [477.796712] Dynamic subtest pipe-C: SUCCESS (1.406s) [477.806460] Starting dynamic subtest: pipe-D [479.223042] Dynamic subtest pipe-D: SUCCESS (1.426s) [479.225500] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.539s) [480.392189] [113/131] (538s left) kms_pm_rpm (basic-rte) [480.428852] Starting subtest: basic-rte [483.469362] Subtest basic-rte: SUCCESS (3.041s) [485.241911] [114/131] (533s left) core_setmaster (master-drop-set-shared-fd) [485.307617] Starting subtest: master-drop-set-shared-fd [485.315597] Subtest master-drop-set-shared-fd: SUCCESS (0.011s) [485.352941] [115/131] (533s left) gem_exec_create (forked) [485.411961] Starting subtest: forked [485.414382] Starting dynamic subtest: smem [506.902635] Dynamic subtest smem: SUCCESS (21.487s) [506.905539] Subtest forked: SUCCESS (21.489s) [507.087083] [116/131] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [507.197300] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [507.201235] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [507.300071] [117/131] (511s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [507.395674] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [507.399784] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [507.503263] [118/131] (511s left) gem_exec_fence (parallel) [507.678530] Starting subtest: parallel [507.681239] Starting dynamic subtest: rcs0 [509.829511] Dynamic subtest rcs0: SUCCESS (2.152s) [509.839761] Starting dynamic subtest: bcs0 [511.981973] Dynamic subtest bcs0: SUCCESS (2.152s) [511.993754] Starting dynamic subtest: vcs0 [514.134562] Dynamic subtest vcs0: SUCCESS (2.152s) [514.145829] Starting dynamic subtest: vcs1 [516.284284] Dynamic subtest vcs1: SUCCESS (2.149s) [516.296314] Starting dynamic subtest: vecs0 [518.435797] Dynamic subtest vecs0: SUCCESS (2.151s) [518.446306] Starting dynamic subtest: ccs0 [520.591140] Dynamic subtest ccs0: SUCCESS (2.155s) [520.592980] Subtest parallel: SUCCESS (12.913s) [521.246127] [119/131] (497s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [521.305508] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [521.307863] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [521.426947] [120/131] (497s left) kms_flip (2x-flip-vs-panning-interruptible) [521.535859] Starting subtest: 2x-flip-vs-panning-interruptible [521.547560] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s) [521.667346] [121/131] (497s left) gem_ctx_isolation (dirty-create) [521.727817] Starting subtest: dirty-create [521.730265] Starting dynamic subtest: rcs0 [522.169201] Dynamic subtest rcs0: SUCCESS (0.442s) [522.180756] Starting dynamic subtest: bcs0 [522.600526] Dynamic subtest bcs0: SUCCESS (0.431s) [522.612009] Starting dynamic subtest: vcs0 [523.040342] Dynamic subtest vcs0: SUCCESS (0.439s) [523.049430] Starting dynamic subtest: vcs1 [524.335377] Dynamic subtest vcs1: SUCCESS (1.294s) [524.347936] Starting dynamic subtest: vecs0 [526.342997] Dynamic subtest vecs0: SUCCESS (2.007s) [526.355519] Starting dynamic subtest: ccs0 [528.324909] Dynamic subtest ccs0: SUCCESS (1.981s) [528.328181] Subtest dirty-create: SUCCESS (6.597s) [528.586736] [122/131] (490s left) gem_bad_reloc (negative-reloc) [528.653977] Subtest negative-reloc: SKIP (0.000s) [528.752022] [123/131] (490s left) kms_psr (psr2-suspend) [528.858235] Starting subtest: psr2-suspend [528.860613] Starting dynamic subtest: eDP-1 [546.768572] Dynamic subtest eDP-1: SUCCESS (2.872s) [546.771039] Subtest psr2-suspend: SUCCESS (2.873s) [547.554788] [124/131] (471s left) kms_dsc (dsc-basic) [547.651723] Starting subtest: dsc-basic [547.665006] Subtest dsc-basic: SKIP (0.000s) [547.728338] [125/131] (471s left) kms_chamelium_hpd (dp-hpd) [548.103782] Subtest dp-hpd: SKIP (0.000s) [548.869217] [126/131] (470s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [548.968533] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [552.715216] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.808s) [553.898208] [127/131] (465s left) gen9_exec_parse (shadow-peek) [553.957627] Subtest shadow-peek: SKIP (0.000s) [554.028665] [128/131] (465s left) kms_atomic_transition (modeset-transition-nonblocking) [554.116167] Starting subtest: modeset-transition-nonblocking [554.118287] Starting dynamic subtest: 1x-outputs [564.620274] Dynamic subtest 1x-outputs: SUCCESS (10.584s) [564.882968] Subtest modeset-transition-nonblocking: SUCCESS (10.847s) [565.737866] [129/131] (453s left) drm_read (short-buffer-block) [565.895900] Starting subtest: short-buffer-block [565.898604] Subtest short-buffer-block: SUCCESS (0.000s) [566.035334] [130/131] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [566.138520] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [566.142824] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [566.279211] [131/131] (453s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [566.375351] Starting subtest: 2x-wf_vblank-ts-check-interruptible [566.385396] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s) [566.497286] Closing watchdogs results: parsing output: 0/ for test: kms_feature_discovery results: parsing output: 1/ for test: api_intel_allocator results: parsing output: 2/ for test: gem_eio results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: i915_module_load results: parsing output: 5/ for test: sysfs_timeslice_duration results: parsing output: 6/ for test: kms_cursor_crc results: parsing output: 7/ for test: core_auth results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: gem_create results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: perf results: parsing output: 15/ for test: kms_plane results: parsing output: 16/ for test: kms_flip_scaled_crc results: parsing output: 17/ for test: gem_exec_schedule results: parsing output: 18/ for test: perf results: parsing output: 19/ for test: gem_exec_fence results: parsing output: 20/ for test: kms_plane_scaling results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_prop_blob results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_schedule results: parsing output: 27/ for test: kms_flip_scaled_crc results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_psr2_sf results: parsing output: 30/ for test: gem_render_copy results: parsing output: 31/ for test: perf_pmu results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: gem_exec_flush results: parsing output: 34/ for test: gen7_exec_parse results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: gem_exec_params results: parsing output: 38/ for test: kms_flip results: parsing output: 39/ for test: kms_universal_plane results: parsing output: 40/ for test: gem_exec_balancer results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_async results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: kms_addfb_basic results: parsing output: 46/ for test: kms_chamelium_edid results: parsing output: 47/ for test: kms_vrr results: parsing output: 48/ for test: gem_mmap_gtt results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: i915_selftest results: parsing output: 52/ for test: kms_invalid_mode results: parsing output: 53/ for test: tools_test results: parsing output: 54/ for test: kms_psr2_sf results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: kms_content_protection results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_vm_create results: parsing output: 61/ for test: gem_softpin results: parsing output: 62/ for test: core_setmaster_vs_auth results: parsing output: 63/ for test: kms_lease results: parsing output: 64/ for test: gem_ctx_persistence results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: gem_fence_thrash results: parsing output: 67/ for test: kms_atomic results: parsing output: 68/ for test: prime_mmap_coherency results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: syncobj_eventfd results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: gem_ctx_param results: parsing output: 73/ for test: kms_pipe_crc_basic results: parsing output: 74/ for test: gem_pxp results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: kms_vrr results: parsing output: 78/ for test: vgem_slow results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: i915_drm_fdinfo results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_exec_schedule results: parsing output: 83/ for test: kms_properties results: parsing output: 84/ for test: gem_exec_whisper results: parsing output: 85/ for test: gem_ctx_shared results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: kms_cursor_crc results: parsing output: 88/ for test: gem_pread results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: gem_mmap results: parsing output: 92/ for test: perf_pmu results: parsing output: 93/ for test: gem_workarounds results: parsing output: 94/ for test: gem_madvise results: parsing output: 95/ for test: kms_color results: parsing output: 96/ for test: api_intel_bb results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_cursor_edge_walk results: parsing output: 99/ for test: gem_userptr_blits results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: i915_pm_rps results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_busy results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_userptr_blits results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: gem_lmem_swapping results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_plane_scaling results: parsing output: 112/ for test: kms_pm_rpm results: parsing output: 113/ for test: core_setmaster results: parsing output: 114/ for test: gem_exec_create results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_exec_fence results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: gem_ctx_isolation results: parsing output: 121/ for test: gem_bad_reloc results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: kms_dsc results: parsing output: 124/ for test: kms_chamelium_hpd results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gen9_exec_parse results: parsing output: 127/ for test: kms_atomic_transition results: parsing output: 128/ for test: drm_read results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_flip Done.