[116.494507] Initializing watchdogs [116.494552] /dev/watchdog0 [116.507308] [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] [116.510964] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [116.512904] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [116.516745] [001/129] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [116.692958] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [117.688548] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.996s) [117.798250] [002/129] (959s left) debugfs_test (sysfs) [117.850341] Starting subtest: sysfs [117.885504] Subtest sysfs: SUCCESS (0.033s) [117.986978] [003/129] (959s left) kms_cursor_crc (cursor-dpms) [118.095638] Starting subtest: cursor-dpms [118.097732] Starting dynamic subtest: pipe-A-eDP-1 [121.167955] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.069s) [121.174658] Starting dynamic subtest: pipe-D-eDP-1 [124.720669] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.552s) [124.723226] Subtest cursor-dpms: SUCCESS (6.623s) [125.557516] [004/129] (951s left) kms_async_flips (invalid-async-flip) [125.659090] Starting subtest: invalid-async-flip [125.663451] Subtest invalid-async-flip: SKIP (0.000s) [126.874042] [005/129] (950s left) kms_chamelium_hpd (hdmi-hpd) [127.274340] Subtest hdmi-hpd: SKIP (0.000s) [128.082319] [006/129] (949s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [128.196823] Starting subtest: fbcpsr-indfb-scaledprimary [133.908082] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.713s) [134.020263] [007/129] (943s left) kms_flip (2x-nonexisting-fb-interruptible) [134.129139] Starting subtest: 2x-nonexisting-fb-interruptible [134.143355] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.012s) [134.206946] [008/129] (943s left) kms_vblank (query-busy-hang) [134.306751] Starting subtest: query-busy-hang [134.309027] Starting dynamic subtest: pipe-A-eDP-1 [160.677186] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.364s) [160.693053] Starting dynamic subtest: pipe-D-eDP-1 [175.648772] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.970s) [175.650747] Subtest query-busy-hang: SUCCESS (41.338s) [176.496408] [009/129] (900s left) gem_exec_schedule (submit-early-slice) [176.570066] Starting subtest: submit-early-slice [176.572515] Starting dynamic subtest: rcs0 [176.605844] Dynamic subtest rcs0: SUCCESS (0.039s) [176.616761] Starting dynamic subtest: bcs0 [176.635420] Dynamic subtest bcs0: SUCCESS (0.029s) [176.648295] Starting dynamic subtest: vcs0 [176.668516] Dynamic subtest vcs0: SUCCESS (0.033s) [176.676315] Starting dynamic subtest: vcs1 [176.697117] Dynamic subtest vcs1: SUCCESS (0.028s) [176.705595] Starting dynamic subtest: vecs0 [176.729489] Dynamic subtest vecs0: SUCCESS (0.032s) [176.738706] Starting dynamic subtest: ccs0 [176.760596] Dynamic subtest ccs0: SUCCESS (0.031s) [176.762857] Subtest submit-early-slice: SUCCESS (0.194s) [178.056054] [010/129] (899s left) prime_self_import (basic-llseek-size) [178.089598] Starting subtest: basic-llseek-size [178.112013] Subtest basic-llseek-size: SUCCESS (0.024s) [178.187655] [011/129] (899s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [178.307399] Starting subtest: cursorA-vs-flipA-varying-size [189.460941] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.153s) [190.319660] [012/129] (887s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [190.415856] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [190.418088] Starting dynamic subtest: pipe-A-eDP-1 [206.659637] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.450s) [206.668404] Starting dynamic subtest: pipe-B-eDP-1 [223.541587] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.318s) [223.550722] Starting dynamic subtest: pipe-C-eDP-1 [240.508405] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.280s) [240.521443] Starting dynamic subtest: pipe-D-eDP-1 [257.506884] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s) [257.508716] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.222s) [258.718009] [013/129] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [258.827974] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [258.832478] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [258.916488] [014/129] (877s left) kms_cursor_crc (cursor-size-hints) [259.026735] Starting subtest: cursor-size-hints [259.029190] Starting dynamic subtest: pipe-A-eDP-1 [259.658476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s) [259.667079] Starting dynamic subtest: pipe-D-eDP-1 [260.903737] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s) [260.906177] Subtest cursor-size-hints: SUCCESS (1.867s) [261.681189] [015/129] (874s left) gem_mmap_wc (pf-nonblock) [261.741227] Subtest pf-nonblock: SKIP (0.000s) [261.796672] [016/129] (874s left) kms_selftest (drm_damage_helper) [261.832318] Starting subtest: drm_damage_helper [261.849747] Starting dynamic subtest: drm_test_damage_iter_no_damage [261.989738] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.140s) [261.996648] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [262.157872] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.152s) [262.165043] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [262.269585] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.127s) [262.278025] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [262.405352] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.134s) [262.412913] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [262.542399] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.136s) [262.550970] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [262.673623] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.130s) [262.680684] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [262.813320] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.138s) [262.819987] Starting dynamic subtest: drm_test_damage_iter_simple_damage [262.942065] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.128s) [262.948920] Starting dynamic subtest: drm_test_damage_iter_single_damage [263.078501] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.135s) [263.086038] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [263.193608] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.115s) [263.202397] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [263.300525] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.106s) [263.309536] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [263.433546] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.130s) [263.441554] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [263.580376] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.146s) [263.587453] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [263.705308] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.123s) [263.712352] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [263.847353] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.142s) [263.855100] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [263.988415] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.140s) [263.995869] Starting dynamic subtest: drm_test_damage_iter_damage [264.128300] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.139s) [264.135367] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [264.219730] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.092s) [264.226619] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [264.357476] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.135s) [264.365101] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [264.487234] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.129s) [264.493878] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [264.587607] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.100s) [264.590020] Subtest drm_damage_helper: SUCCESS (2.747s) [264.752604] [017/129] (871s left) kms_color (invalid-ctm-matrix-sizes) [264.850922] Starting subtest: invalid-ctm-matrix-sizes [264.853529] Starting dynamic subtest: pipe-A [264.855622] Dynamic subtest pipe-A: SUCCESS (0.002s) [264.865189] Starting dynamic subtest: pipe-B [264.867501] Dynamic subtest pipe-B: SUCCESS (0.003s) [264.874967] Starting dynamic subtest: pipe-C [264.877300] Dynamic subtest pipe-C: SUCCESS (0.003s) [264.883997] Starting dynamic subtest: pipe-D [264.885943] Dynamic subtest pipe-D: SUCCESS (0.004s) [264.888308] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.012s) [264.927195] [018/129] (871s left) perf (global-sseu-config) [265.035541] Starting subtest: global-sseu-config [265.039486] Subtest global-sseu-config: SKIP (0.000s) [265.068508] [019/129] (871s left) gem_lmem_swapping (parallel-random-verify-ccs) [265.110149] Subtest parallel-random-verify-ccs: SKIP (0.000s) [265.171003] [020/129] (871s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [270.135097] Starting subtest: pr-overlay-plane-move-continuous-sf [270.139854] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [270.988616] [021/129] (865s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [276.060416] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [276.062773] Starting dynamic subtest: pipe-A-eDP-1 [276.842365] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s) [276.851204] Starting dynamic subtest: pipe-B-eDP-1 [277.966020] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s) [277.970781] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.902s) [279.142826] [022/129] (857s left) gem_blits (basic) [279.205643] Starting subtest: basic [280.462113] Subtest basic: SUCCESS (1.257s) [280.577199] [023/129] (856s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [280.671103] Starting subtest: compare-crc-sanitycheck-xr24 [280.673481] Starting dynamic subtest: pipe-A-eDP-1 [281.305399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s) [281.318064] Starting dynamic subtest: pipe-B-eDP-1 [282.589779] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.283s) [282.602794] Starting dynamic subtest: pipe-C-eDP-1 [283.772864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s) [283.780919] Starting dynamic subtest: pipe-D-eDP-1 [284.997669] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s) [285.000421] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.322s) [285.842432] [024/129] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [285.952933] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [290.796752] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.847s) [290.890775] [025/129] (845s left) gem_exec_fence (syncobj-timeline-invalid-flags) [291.450657] Starting subtest: syncobj-timeline-invalid-flags [291.453505] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [292.773338] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [292.776625] [026/129] (843s left) kms_big_fb (4-tiled-16bpp-rotate-270) [292.875140] Starting subtest: 4-tiled-16bpp-rotate-270 [292.896145] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.021s) [293.001099] [027/129] (843s left) kms_psr (psr2-primary-render) [293.093124] Starting subtest: psr2-primary-render [293.095468] Starting dynamic subtest: eDP-1 [294.875572] Dynamic subtest eDP-1: SUCCESS (1.782s) [294.878146] Subtest psr2-primary-render: SUCCESS (1.783s) [295.732325] [028/129] (841s left) gem_spin_batch (engines) [295.804549] Starting subtest: engines [295.806990] Starting dynamic subtest: rcs0 [299.042736] Dynamic subtest rcs0: SUCCESS (3.233s) [299.051073] Starting dynamic subtest: bcs0 [302.276006] Dynamic subtest bcs0: SUCCESS (3.232s) [302.285215] Starting dynamic subtest: vcs0 [305.509310] Dynamic subtest vcs0: SUCCESS (3.233s) [305.519661] Starting dynamic subtest: vcs1 [308.743424] Dynamic subtest vcs1: SUCCESS (3.232s) [308.753056] Starting dynamic subtest: vecs0 [311.979740] Dynamic subtest vecs0: SUCCESS (3.233s) [311.988884] Starting dynamic subtest: ccs0 [315.214377] Dynamic subtest ccs0: SUCCESS (3.234s) [315.216328] Subtest engines: SUCCESS (19.407s) [315.463909] [029/129] (821s left) gem_partial_pwrite_pread (writes-after-reads) [315.520514] Subtest writes-after-reads: SKIP (0.000s) [315.593456] [030/129] (821s left) gem_exec_balancer (invalid-balancer) [315.664135] Starting subtest: invalid-balancer [316.385311] Subtest invalid-balancer: SUCCESS (0.719s) [316.680140] [031/129] (820s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [316.743200] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [316.747600] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [316.922771] [032/129] (820s left) i915_hangman (gt-error-state-capture) [316.990082] Starting subtest: gt-error-state-capture [316.992011] Starting dynamic subtest: rcs0 [328.722293] Dynamic subtest rcs0: SUCCESS (11.728s) [328.735559] Starting dynamic subtest: bcs0 [339.731574] Dynamic subtest bcs0: SUCCESS (11.004s) [339.741822] Starting dynamic subtest: vcs0 [351.696861] Dynamic subtest vcs0: SUCCESS (11.959s) [351.709756] Starting dynamic subtest: vcs1 [363.664623] Dynamic subtest vcs1: SUCCESS (11.969s) [363.676013] Starting dynamic subtest: vecs0 [374.672279] Dynamic subtest vecs0: SUCCESS (11.008s) [374.684917] Starting dynamic subtest: ccs0 [385.681332] Dynamic subtest ccs0: SUCCESS (11.007s) [385.684061] Subtest gt-error-state-capture: SUCCESS (68.686s) [385.756556] [033/129] (751s left) gem_exec_params (rel-constants-invalid-rel-gen5) [385.813265] Starting subtest: rel-constants-invalid-rel-gen5 [385.815647] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [385.909461] [034/129] (751s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [385.965423] Starting subtest: invalid-multi-wait-unsubmitted [385.967755] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [386.081084] [035/129] (751s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [386.195535] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [386.199926] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [386.301118] [036/129] (750s left) gem_ctx_persistence (engines-mixed) [386.359196] Starting subtest: engines-mixed [386.361637] Starting dynamic subtest: rcs0 [386.473985] Dynamic subtest rcs0: SUCCESS (0.114s) [386.483457] Starting dynamic subtest: bcs0 [386.559011] Dynamic subtest bcs0: SUCCESS (0.083s) [386.568432] Starting dynamic subtest: vcs0 [386.612614] Dynamic subtest vcs0: SUCCESS (0.052s) [386.624060] Starting dynamic subtest: vcs1 [386.691140] Dynamic subtest vcs1: SUCCESS (0.077s) [386.701157] Starting dynamic subtest: vecs0 [386.778556] Dynamic subtest vecs0: SUCCESS (0.087s) [386.794363] Starting dynamic subtest: ccs0 [386.856395] Dynamic subtest ccs0: SUCCESS (0.076s) [386.858655] Subtest engines-mixed: SUCCESS (0.497s) [386.931157] [037/129] (750s left) kms_addfb_basic (addfb25-y-tiled-legacy) [387.026994] Starting subtest: addfb25-y-tiled-legacy [387.028798] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [387.123275] [038/129] (750s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [387.224773] Starting subtest: yf-tiled-32bpp-rotate-180 [387.228453] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [387.315976] [039/129] (749s left) gem_exec_params (invalid-ring) [387.373179] Starting subtest: invalid-ring [387.375286] Subtest invalid-ring: SUCCESS (0.000s) [387.470888] [040/129] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [387.564753] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [390.939511] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.377s) [391.074099] [041/129] (746s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [391.177923] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [391.180037] Starting dynamic subtest: pipe-A-default-mode [391.474182] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [391.478933] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.285s) [392.275590] [042/129] (745s left) kms_addfb_basic (invalid-set-prop-any) [392.339828] Starting subtest: invalid-set-prop-any [392.342198] Subtest invalid-set-prop-any: SUCCESS (0.000s) [392.494498] [043/129] (744s left) kms_dp_link_training (non-uhbr-sst) [392.595895] Starting subtest: non-uhbr-sst [392.604500] Subtest non-uhbr-sst: SKIP (0.000s) [392.664070] [044/129] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [392.767097] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [392.771230] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [392.855753] [045/129] (744s left) kms_plane (planar-pixel-format-settings) [392.953035] Starting subtest: planar-pixel-format-settings [392.981904] Subtest planar-pixel-format-settings: SUCCESS (0.027s) [393.077650] [046/129] (744s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [393.178839] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [393.180989] Starting dynamic subtest: pipe-A-eDP-1 [393.203245] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [393.211600] Starting dynamic subtest: pipe-B-eDP-1 [393.229245] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [393.236696] Starting dynamic subtest: pipe-C-eDP-1 [393.253716] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [393.261010] Starting dynamic subtest: pipe-D-eDP-1 [393.278570] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [393.281862] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [395.311834] [047/129] (742s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [395.422870] Starting subtest: plane-scaler-with-clipping-clamping-rotation [395.425067] Starting dynamic subtest: pipe-A [395.759977] Dynamic subtest pipe-A: SUCCESS (0.337s) [395.769176] Starting dynamic subtest: pipe-B [397.194377] Dynamic subtest pipe-B: SUCCESS (1.434s) [397.203526] Starting dynamic subtest: pipe-C [398.613856] Dynamic subtest pipe-C: SUCCESS (1.419s) [398.623360] Starting dynamic subtest: pipe-D [400.040498] Dynamic subtest pipe-D: SUCCESS (1.426s) [400.042898] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.617s) [401.206230] [048/129] (736s left) kms_pm_rpm (i2c) [402.846654] Starting subtest: i2c [408.374436] Subtest i2c: SUCCESS (5.526s) [408.473287] [049/129] (729s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [408.572931] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [408.575216] Starting dynamic subtest: pipe-A-eDP-1 [408.596017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [408.604596] Starting dynamic subtest: pipe-B-eDP-1 [408.624471] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [408.631733] Starting dynamic subtest: pipe-C-eDP-1 [408.650082] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [408.657495] Starting dynamic subtest: pipe-D-eDP-1 [408.675958] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [408.677849] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [410.703216] [050/129] (726s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [410.800347] Starting subtest: fbc-rgb101010-draw-mmap-gtt [410.804772] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [410.896133] [051/129] (726s left) gem_exec_reloc (basic-write-wc-noreloc) [410.955683] Subtest basic-write-wc-noreloc: SKIP (0.000s) [411.033172] [052/129] (726s left) kms_cursor_legacy (flip-vs-cursor-legacy) [411.162340] Starting subtest: flip-vs-cursor-legacy [417.927372] Subtest flip-vs-cursor-legacy: SUCCESS (6.762s) [418.729713] [053/129] (718s left) gem_softpin (noreloc) [418.785869] Starting subtest: noreloc [424.202638] Subtest noreloc: SUCCESS (5.414s) [424.338020] [054/129] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [424.441071] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [427.157409] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.716s) [427.298292] [055/129] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [427.397635] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [427.400928] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [427.501663] [056/129] (710s left) kms_rotation_crc (sprite-rotation-90) [427.594481] Starting subtest: sprite-rotation-90 [427.598310] Subtest sprite-rotation-90: SKIP (0.001s) [427.665091] [057/129] (710s left) syncobj_eventfd (invalid-bad-flags) [427.720384] Starting subtest: invalid-bad-flags [427.722331] Subtest invalid-bad-flags: SUCCESS (0.000s) [427.819360] [058/129] (710s left) kms_big_fb (x-tiled-16bpp-rotate-0) [427.913033] Starting subtest: x-tiled-16bpp-rotate-0 [429.204374] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.291s) [429.350665] [059/129] (708s left) kms_prime (basic-crc-vgem) [431.427468] Starting subtest: basic-crc-vgem [431.429833] Starting dynamic subtest: second-to-first [432.363627] Dynamic subtest second-to-first: SUCCESS (0.939s) [432.366040] Subtest basic-crc-vgem: SUCCESS (0.940s) [432.438027] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.amdgpu: true [432.438651] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.xe: true [432.441764] [060/129] (705s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [432.581405] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [433.526666] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.945s) [433.668666] [061/129] (704s left) kms_cursor_crc (cursor-random-32x32) [433.805607] Starting subtest: cursor-random-32x32 [433.843705] Subtest cursor-random-32x32: SKIP (0.032s) [434.118851] [062/129] (703s left) gem_userptr_blits (sync-unmap) [434.188193] Starting subtest: sync-unmap [434.203878] Subtest sync-unmap: SUCCESS (0.014s) [434.334479] [063/129] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [434.428259] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [439.521169] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.093s) [439.671392] [064/129] (698s left) kms_atomic_transition (plane-all-transition-fencing) [439.768082] Starting subtest: plane-all-transition-fencing [439.770230] Starting dynamic subtest: pipe-A-eDP-1 [442.278100] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s) [442.558781] Starting dynamic subtest: pipe-B-eDP-1 [445.836789] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.286s) [446.111211] Subtest plane-all-transition-fencing: SUCCESS (6.341s) [446.950772] [065/129] (691s left) gem_render_copy_redux (flink-interruptible) [447.011616] Starting subtest: flink-interruptible [447.947780] Subtest flink-interruptible: SUCCESS (0.936s) [448.078327] [066/129] (690s left) gem_exec_whisper (basic-contexts-priority-all) [448.148942] Starting subtest: basic-contexts-priority-all [472.626280] Subtest basic-contexts-priority-all: SUCCESS (24.466s) [472.806188] [067/129] (665s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [472.918750] Starting subtest: blocking-absolute-wf_vblank-interruptible [472.921362] Starting dynamic subtest: A-eDP1 [481.615078] Dynamic subtest A-eDP1: SUCCESS (8.693s) [481.624962] Starting dynamic subtest: B-eDP1 [490.343074] Dynamic subtest B-eDP1: SUCCESS (8.728s) [490.353784] Starting dynamic subtest: C-eDP1 [499.056565] Dynamic subtest C-eDP1: SUCCESS (8.714s) [499.068421] Starting dynamic subtest: D-eDP1 [507.786425] Dynamic subtest D-eDP1: SUCCESS (8.730s) [507.788706] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.873s) [508.993369] [068/129] (629s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [509.095925] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [509.098269] Starting dynamic subtest: pipe-A-eDP-1 [509.107623] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [509.117035] Starting dynamic subtest: pipe-B-eDP-1 [509.126437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [509.134651] Starting dynamic subtest: pipe-C-eDP-1 [509.144018] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [509.152124] Starting dynamic subtest: pipe-D-eDP-1 [509.160719] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [509.164947] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [511.248695] [069/129] (627s left) gem_exec_suspend (basic-s3-devices) [511.311722] Starting subtest: basic-S3-devices [511.314248] Starting dynamic subtest: smem [521.779531] Dynamic subtest smem: SUCCESS (10.466s) [521.782451] Subtest basic-S3-devices: SUCCESS (10.468s) [521.959846] [070/129] (616s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [522.020836] Starting subtest: y-tiled-ccs-to-y-tiled [522.025575] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [522.201067] [071/129] (616s left) kms_psr (psr2-sprite-plane-onoff) [522.294783] Starting subtest: psr2-sprite-plane-onoff [522.297038] Starting dynamic subtest: eDP-1 [524.060917] Dynamic subtest eDP-1: SUCCESS (1.766s) [524.063166] Subtest psr2-sprite-plane-onoff: SUCCESS (1.767s) [524.918792] [072/129] (613s left) gem_exec_capture (capture-recoverable) [524.982691] Starting subtest: capture-recoverable [524.985048] Subtest capture-recoverable: SUCCESS (0.003s) [525.103173] [073/129] (613s left) kms_flip (nonexisting-fb-interruptible) [525.197663] Starting subtest: nonexisting-fb-interruptible [525.199919] Starting dynamic subtest: A-eDP1 [526.398412] Dynamic subtest A-eDP1: SUCCESS (1.199s) [526.408045] Starting dynamic subtest: B-eDP1 [527.526786] Dynamic subtest B-eDP1: SUCCESS (1.127s) [527.541357] Starting dynamic subtest: C-eDP1 [528.649084] Dynamic subtest C-eDP1: SUCCESS (1.121s) [528.660951] Starting dynamic subtest: D-eDP1 [529.775746] Dynamic subtest D-eDP1: SUCCESS (1.126s) [529.780775] Subtest nonexisting-fb-interruptible: SUCCESS (4.582s) [530.937012] [074/129] (607s left) kms_pm_backlight (fade-with-suspend) [531.038782] Starting subtest: fade-with-suspend [547.441322] Starting dynamic subtest: eDP-1 [550.120570] Dynamic subtest eDP-1: SUCCESS (2.667s) [550.122688] Subtest fade-with-suspend: SUCCESS (3.887s) [550.930063] [075/129] (602s left) kms_chamelium_edid (dp-mode-timings) [551.313753] Subtest dp-mode-timings: SKIP (0.000s) [552.139657] [076/129] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [552.250916] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [552.255047] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [552.358179] [077/129] (601s left) kms_psr (fbc-pr-primary-mmap-gtt) [552.454237] Starting subtest: fbc-pr-primary-mmap-gtt [552.458190] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [552.526835] [078/129] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [552.632681] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [552.637253] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [552.734404] [079/129] (601s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [552.846160] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [557.769976] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.912s) [557.879229] [080/129] (595s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [557.997989] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [562.260368] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.258s) [562.412420] [081/129] (591s left) gem_create (create-ext-placement-each) [562.590761] Starting subtest: create-ext-placement-each [562.593852] Subtest create-ext-placement-each: SUCCESS (0.000s) [562.709471] [082/129] (591s left) syncobj_timeline (invalid-signal-one-illegal-handle) [562.769152] Starting subtest: invalid-signal-one-illegal-handle [562.771265] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [562.885724] [083/129] (591s left) kms_flip (2x-flip-vs-panning) [562.992364] Starting subtest: 2x-flip-vs-panning [563.003012] Subtest 2x-flip-vs-panning: SKIP (0.010s) [563.119608] [084/129] (590s left) api_intel_bb (bb-with-allocator) [563.169071] Starting subtest: bb-with-allocator [563.173901] Subtest bb-with-allocator: SUCCESS (0.006s) [563.311320] [085/129] (590s left) gem_exec_reloc (basic-cpu-read) [563.377498] Subtest basic-cpu-read: SKIP (0.000s) [563.459751] [086/129] (590s left) gem_exec_schedule (implicit-write-read) [563.534865] Starting subtest: implicit-write-read [563.536945] Starting dynamic subtest: rcs0 [563.625590] Dynamic subtest rcs0: SUCCESS (0.101s) [563.637916] Starting dynamic subtest: vcs0 [563.697191] Dynamic subtest vcs0: SUCCESS (0.071s) [563.707821] Starting dynamic subtest: vcs1 [563.766853] Dynamic subtest vcs1: SUCCESS (0.069s) [563.778953] Starting dynamic subtest: vecs0 [563.834638] Dynamic subtest vecs0: SUCCESS (0.067s) [563.846317] Starting dynamic subtest: ccs0 [563.910361] Dynamic subtest ccs0: SUCCESS (0.075s) [563.912452] Subtest implicit-write-read: SUCCESS (0.387s) [565.026508] [087/129] (589s left) kms_vrr (flip-basic-fastset) [565.129575] Starting subtest: flip-basic-fastset [565.136030] Subtest flip-basic-fastset: SKIP (0.000s) [565.199446] [088/129] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [565.300804] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [565.304900] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [565.413677] [089/129] (588s left) syncobj_timeline (wait-all-complex) [565.480196] Starting subtest: wait-all-complex [565.693201] Subtest wait-all-complex: SUCCESS (0.213s) [565.765030] [090/129] (588s left) gem_exec_flush (basic-uc-ro-default) [565.825300] Starting subtest: basic-uc-ro-default [571.300663] Subtest basic-uc-ro-default: SUCCESS (5.470s) [571.481849] [091/129] (582s left) gem_close_race (basic-threads) [571.555396] Starting subtest: basic-threads [573.021706] Subtest basic-threads: SUCCESS (1.465s) [573.203756] [092/129] (581s left) gem_pwrite (basic-random) [573.261755] Subtest basic-random: SKIP (0.000s) [573.325127] [093/129] (581s left) gen9_exec_parse (basic-rejected-ctx-param) [573.389483] Subtest basic-rejected-ctx-param: SKIP (0.000s) [573.475270] [094/129] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [573.590421] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [573.594369] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [573.694640] [095/129] (580s left) gem_softpin (allocator-nopin-reserve) [573.757033] Starting subtest: allocator-nopin-reserve [573.848658] Subtest allocator-nopin-reserve: SUCCESS (0.091s) [573.986992] [096/129] (580s left) gem_exec_reloc (basic-write-wc-active) [574.046762] Subtest basic-write-wc-active: SKIP (0.000s) [574.113423] [097/129] (580s left) prime_busy (after) [574.165184] Starting subtest: after [574.169573] Starting dynamic subtest: rcs0 [574.207888] Dynamic subtest rcs0: SUCCESS (0.039s) [574.222961] Starting dynamic subtest: bcs0 [574.261403] Dynamic subtest bcs0: SUCCESS (0.052s) [574.271403] Starting dynamic subtest: vcs0 [574.301124] Dynamic subtest vcs0: SUCCESS (0.039s) [574.309698] Starting dynamic subtest: vcs1 [574.340616] Dynamic subtest vcs1: SUCCESS (0.039s) [574.350748] Starting dynamic subtest: vecs0 [574.381424] Dynamic subtest vecs0: SUCCESS (0.040s) [574.390362] Starting dynamic subtest: ccs0 [574.421824] Dynamic subtest ccs0: SUCCESS (0.040s) [574.530047] Subtest after: SUCCESS (0.363s) [574.597768] [098/129] (579s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [574.709249] Starting subtest: short-flip-before-cursor-toggle [575.616154] Subtest short-flip-before-cursor-toggle: SUCCESS (0.907s) [576.432200] [099/129] (578s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite) [576.541999] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite [580.386014] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (3.846s) [580.502703] [100/129] (574s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [580.564100] Starting subtest: etime-multi-wait-all-available-unsubmitted [580.668349] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s) [580.737575] [101/129] (573s left) gem_softpin (evict-snoop) [580.794815] Starting subtest: evict-snoop [580.799537] Subtest evict-snoop: SKIP (0.000s) [580.924373] [102/129] (573s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [581.032640] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [581.036621] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [581.129258] [103/129] (573s left) gem_mmap_gtt (cpuset-medium-copy-xy) [581.187246] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [581.264144] [104/129] (573s left) gem_softpin (noreloc-interruptible) [581.323760] Starting subtest: noreloc-interruptible [586.730861] Subtest noreloc-interruptible: SUCCESS (5.405s) [586.839946] [105/129] (567s left) gem_userptr_blits (process-exit-busy) [586.905719] Starting subtest: process-exit-busy [586.922092] Subtest process-exit-busy: SUCCESS (0.016s) [587.071706] [106/129] (567s left) perf (invalid-oa-exponent) [587.152644] Starting subtest: invalid-oa-exponent [587.171832] Subtest invalid-oa-exponent: SUCCESS (0.018s) [587.213122] [107/129] (567s left) i915_pm_rpm (gem-idle) [589.150783] Starting subtest: gem-idle [595.345447] Subtest gem-idle: SUCCESS (6.195s) [595.647883] [108/129] (559s left) drm_fdinfo (virtual-busy) [595.691298] Starting subtest: virtual-busy [595.695799] Subtest virtual-busy: SKIP (0.000s) [595.748747] [109/129] (559s left) prime_udl [595.823808] [110/129] (559s left) gem_exec_reloc (basic-write-gtt-noreloc) [596.904977] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [597.009244] [111/129] (557s left) gem_vm_create (execbuf) [597.071672] Starting subtest: execbuf [597.079480] Subtest execbuf: SUCCESS (0.008s) [597.216624] [112/129] (557s left) dmabuf_sync_file (import-multiple-read-only) [597.254119] Starting subtest: import-multiple-read-only [597.256379] Subtest import-multiple-read-only: SUCCESS (0.004s) [597.302224] [113/129] (557s left) gem_exec_schedule (preempt-other) [597.369439] Starting subtest: preempt-other [597.371437] Starting dynamic subtest: rcs0 [597.425372] Dynamic subtest rcs0: SUCCESS (0.064s) [597.438231] Starting dynamic subtest: bcs0 [597.485345] Dynamic subtest bcs0: SUCCESS (0.059s) [597.498034] Starting dynamic subtest: vcs0 [597.547529] Dynamic subtest vcs0: SUCCESS (0.062s) [597.561639] Starting dynamic subtest: vcs1 [597.609950] Dynamic subtest vcs1: SUCCESS (0.061s) [597.622411] Starting dynamic subtest: vecs0 [597.667836] Dynamic subtest vecs0: SUCCESS (0.058s) [597.678028] Starting dynamic subtest: ccs0 [597.731507] Dynamic subtest ccs0: SUCCESS (0.063s) [597.733738] Subtest preempt-other: SUCCESS (0.371s) [599.032122] [114/129] (556s left) prime_vgem (basic-fence-read) [599.102078] Starting subtest: basic-fence-read [599.120542] Subtest basic-fence-read: SKIP (0.016s) [599.238185] [115/129] (555s left) kms_psr (pr-cursor-plane-onoff) [599.337571] Starting subtest: pr-cursor-plane-onoff [599.342111] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [599.404245] [116/129] (555s left) syncobj_wait (multi-wait-all-for-submit-signaled) [599.459297] Starting subtest: multi-wait-all-for-submit-signaled [599.461610] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [599.568361] [117/129] (555s left) kms_big_fb (y-tiled-32bpp-rotate-270) [599.666147] Starting subtest: y-tiled-32bpp-rotate-270 [599.670215] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [599.780938] [118/129] (555s left) kms_lease (cursor-implicit-plane) [599.879459] Starting subtest: cursor-implicit-plane [599.881741] Starting dynamic subtest: pipe-A-eDP-1 [600.340684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [600.350055] Starting dynamic subtest: pipe-B-eDP-1 [601.466583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s) [601.478624] Starting dynamic subtest: pipe-C-eDP-1 [602.575878] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s) [602.586432] Starting dynamic subtest: pipe-D-eDP-1 [603.703648] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [603.706025] Subtest cursor-implicit-plane: SUCCESS (3.821s) [604.559008] [119/129] (550s left) perf_pmu (all-busy-check-all) [604.598068] Starting subtest: all-busy-check-all [605.952859] Subtest all-busy-check-all: SUCCESS (1.354s) [606.056658] [120/129] (549s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [606.156986] Starting subtest: fbc-rgb565-draw-mmap-wc [609.166417] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.013s) [609.287257] [121/129] (546s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [609.392499] Starting subtest: fbcpsr-tiling-4 [614.267062] Subtest fbcpsr-tiling-4: SUCCESS (4.873s) [614.418850] [122/129] (540s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area) [614.476926] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s) [614.527315] [123/129] (540s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [614.621526] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [614.623730] Starting dynamic subtest: pipe-A-eDP-1 [616.691983] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.067s) [616.700978] Starting dynamic subtest: pipe-B-eDP-1 [618.800395] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.108s) [618.809621] Starting dynamic subtest: pipe-C-eDP-1 [620.867413] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.064s) [620.877182] Starting dynamic subtest: pipe-D-eDP-1 [622.898645] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.030s) [622.901079] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.273s) [624.043155] [124/129] (531s left) kms_plane_cursor (primary) [624.138421] Starting subtest: primary [624.142742] Starting dynamic subtest: pipe-A-eDP-1-size-64 [626.886008] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.744s) [626.908039] Starting dynamic subtest: pipe-A-eDP-1-size-128 [629.652996] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.750s) [629.678014] Starting dynamic subtest: pipe-A-eDP-1-size-256 [632.419872] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.748s) [632.737332] Starting dynamic subtest: pipe-B-eDP-1-size-64 [636.205386] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.476s) [636.229971] Starting dynamic subtest: pipe-B-eDP-1-size-128 [638.950030] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.726s) [638.976823] Starting dynamic subtest: pipe-B-eDP-1-size-256 [641.707988] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.738s) [642.025448] Starting dynamic subtest: pipe-C-eDP-1-size-64 [645.077758] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.062s) [645.105535] Starting dynamic subtest: pipe-C-eDP-1-size-128 [647.453847] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.358s) [647.480234] Starting dynamic subtest: pipe-C-eDP-1-size-256 [649.853601] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.380s) [650.169997] Starting dynamic subtest: pipe-D-eDP-1-size-64 [653.307282] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.149s) [653.334452] Starting dynamic subtest: pipe-D-eDP-1-size-128 [655.705540] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.380s) [655.732951] Starting dynamic subtest: pipe-D-eDP-1-size-256 [658.127469] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.402s) [658.435661] Subtest primary: SUCCESS (34.293s) [659.249929] [125/129] (496s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [659.306946] Starting subtest: multi-wait-for-submit-available-signaled [659.309320] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s) [659.430758] [126/129] (496s left) perf (sysctl-defaults) [659.488715] Starting subtest: sysctl-defaults [659.491138] Subtest sysctl-defaults: SUCCESS (0.000s) [659.534887] [127/129] (496s left) gem_ctx_persistence (legacy-engines-hang) [659.600370] Starting subtest: legacy-engines-hang [659.602661] Starting dynamic subtest: render [659.765560] Dynamic subtest render: SUCCESS (0.164s) [659.782605] Starting dynamic subtest: bsd1 [659.867935] Dynamic subtest bsd1: SUCCESS (0.101s) [659.878392] Starting dynamic subtest: bsd2 [659.937950] Dynamic subtest bsd2: SUCCESS (0.068s) [659.948877] Starting dynamic subtest: blt [660.089634] Dynamic subtest blt: SUCCESS (0.149s) [660.101618] Starting dynamic subtest: vebox [660.203919] Dynamic subtest vebox: SUCCESS (0.113s) [660.206140] Subtest legacy-engines-hang: SUCCESS (0.605s) [660.277828] [128/129] (495s left) kms_cursor_edge_walk (64x64-top-bottom) [660.377030] Starting subtest: 64x64-top-bottom [660.378870] Starting dynamic subtest: pipe-A-eDP-1 [663.812821] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s) [663.822574] Starting dynamic subtest: pipe-D-eDP-1 [666.906468] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.095s) [666.908845] Subtest 64x64-top-bottom: SUCCESS (6.530s) [667.720179] [129/129] (487s left) kms_psr (fbc-psr-basic) [667.822619] Starting subtest: fbc-psr-basic [667.824905] Starting dynamic subtest: eDP-1 [667.829184] Dynamic subtest eDP-1: SKIP (0.000s) [667.833539] Subtest fbc-psr-basic: SKIP (0.001s) [667.890880] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: debugfs_test results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: kms_async_flips results: parsing output: 4/ for test: kms_chamelium_hpd results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: kms_vblank results: parsing output: 8/ for test: gem_exec_schedule results: parsing output: 9/ for test: prime_self_import results: parsing output: 10/ for test: kms_cursor_legacy results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: gem_mmap_wc results: parsing output: 15/ for test: kms_selftest results: parsing output: 16/ for test: kms_color results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: gem_lmem_swapping results: parsing output: 19/ for test: kms_psr2_sf results: parsing output: 20/ for test: kms_psr2_sf results: parsing output: 21/ for test: gem_blits results: parsing output: 22/ for test: kms_pipe_crc_basic results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: gem_spin_batch results: parsing output: 28/ for test: gem_partial_pwrite_pread results: parsing output: 29/ for test: gem_exec_balancer results: parsing output: 30/ for test: gem_render_copy results: parsing output: 31/ for test: i915_hangman results: parsing output: 32/ for test: gem_exec_params results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_ctx_persistence results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: gem_exec_params results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_flip_scaled_crc results: parsing output: 41/ for test: kms_addfb_basic results: parsing output: 42/ for test: kms_dp_link_training results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_plane results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_plane_scaling results: parsing output: 47/ for test: kms_pm_rpm results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_reloc results: parsing output: 51/ for test: kms_cursor_legacy results: parsing output: 52/ for test: gem_softpin results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_rotation_crc results: parsing output: 56/ for test: syncobj_eventfd results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_prime results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_cursor_crc results: parsing output: 61/ for test: gem_userptr_blits results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_atomic_transition results: parsing output: 64/ for test: gem_render_copy_redux results: parsing output: 65/ for test: gem_exec_whisper results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: gem_exec_suspend results: parsing output: 69/ for test: gem_render_copy results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: gem_exec_capture results: parsing output: 72/ for test: kms_flip results: parsing output: 73/ for test: kms_pm_backlight results: parsing output: 74/ for test: kms_chamelium_edid results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_create results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: api_intel_bb results: parsing output: 84/ for test: gem_exec_reloc results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: kms_vrr results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: gem_exec_flush results: parsing output: 90/ for test: gem_close_race results: parsing output: 91/ for test: gem_pwrite results: parsing output: 92/ for test: gen9_exec_parse results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_softpin results: parsing output: 95/ for test: gem_exec_reloc results: parsing output: 96/ for test: prime_busy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: gem_softpin results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_mmap_gtt results: parsing output: 103/ for test: gem_softpin results: parsing output: 104/ for test: gem_userptr_blits results: parsing output: 105/ for test: perf results: parsing output: 106/ for test: i915_pm_rpm results: parsing output: 107/ for test: drm_fdinfo results: parsing output: 108/ for test: prime_udl results: parsing output: 109/ for test: gem_exec_reloc results: parsing output: 110/ for test: gem_vm_create results: parsing output: 111/ for test: dmabuf_sync_file results: parsing output: 112/ for test: gem_exec_schedule results: parsing output: 113/ for test: prime_vgem results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_lease results: parsing output: 118/ for test: perf_pmu results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_fbc_dirty_rect results: parsing output: 122/ for test: kms_ccs results: parsing output: 123/ for test: kms_plane_cursor results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: perf results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_cursor_edge_walk results: parsing output: 128/ for test: kms_psr Done.