[59.958949] Initializing watchdogs [59.959123] /dev/watchdog0 [59.973029] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.976892] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.979082] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.982415] [001/131] (960s left) gem_exec_schedule (u-semaphore-codependency) [60.134398] Starting subtest: u-semaphore-codependency [60.157028] Subtest u-semaphore-codependency: SUCCESS (0.023s) [60.516053] [002/131] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [60.630292] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [63.231632] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.617s) [63.356938] [003/131] (957s left) gem_userptr_blits (invalid-null-pointer) [63.427973] Starting subtest: invalid-null-pointer [63.429831] Subtest invalid-null-pointer: SUCCESS (0.001s) [63.553380] [004/131] (957s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [63.651530] Starting subtest: nonblocking-crc-frame-sequence [63.653594] Starting dynamic subtest: pipe-A-eDP-1 [64.397022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s) [64.403659] Starting dynamic subtest: pipe-B-eDP-1 [65.803331] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s) [65.811929] Starting dynamic subtest: pipe-C-eDP-1 [67.202970] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s) [67.212063] Starting dynamic subtest: pipe-D-eDP-1 [68.516729] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s) [68.519162] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.890s) [69.308985] [005/131] (951s left) gem_exec_reloc (basic-gtt-read-noreloc) [69.366534] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [69.443597] [006/131] (951s left) gem_softpin (full) [69.498329] Starting subtest: full [69.506574] Subtest full: SUCCESS (0.008s) [69.648779] [007/131] (950s left) perf_pmu (invalid-init) [69.689357] Starting subtest: invalid-init [69.741644] Subtest invalid-init: FAIL (0.012s) [69.807069] [008/131] (950s left) kms_psr (fbc-psr-sprite-plane-move) [69.905116] Starting subtest: fbc-psr-sprite-plane-move [69.907334] Starting dynamic subtest: eDP-1 [69.911291] Dynamic subtest eDP-1: SKIP (0.000s) [69.915205] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [69.969403] [009/131] (950s left) kms_dp_linktrain_fallback (dp-fallback) [70.058444] Starting subtest: dp-fallback [70.065385] Subtest dp-fallback: SKIP (0.000s) [70.122198] [010/131] (950s left) kms_big_fb (x-tiled-8bpp-rotate-90) [70.230167] Starting subtest: x-tiled-8bpp-rotate-90 [70.252754] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s) [70.377710] [011/131] (950s left) kms_flip (flip-vs-rmfb) [70.472543] Starting subtest: flip-vs-rmfb [70.474479] Starting dynamic subtest: A-eDP1 [79.215368] Dynamic subtest A-eDP1: SUCCESS (8.758s) [79.224124] Starting dynamic subtest: B-eDP1 [87.906077] Dynamic subtest B-eDP1: SUCCESS (8.695s) [87.914029] Starting dynamic subtest: C-eDP1 [96.652783] Dynamic subtest C-eDP1: SUCCESS (8.747s) [96.661857] Starting dynamic subtest: D-eDP1 [105.342636] Dynamic subtest D-eDP1: SUCCESS (8.687s) [105.347686] Subtest flip-vs-rmfb: SUCCESS (34.894s) [106.510892] [012/131] (914s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [106.604906] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [106.607281] Starting dynamic subtest: pipe-A-eDP-1 [106.629935] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [106.638395] Starting dynamic subtest: pipe-B-eDP-1 [106.661754] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [106.668275] Starting dynamic subtest: pipe-C-eDP-1 [106.690273] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [106.697252] Starting dynamic subtest: pipe-D-eDP-1 [106.719017] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [106.723379] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s) [108.764306] [013/131] (912s left) prime_mmap (test_dup) [108.826877] Starting subtest: test_dup [108.829294] Starting dynamic subtest: test_dup-smem [108.859219] Dynamic subtest test_dup-smem: SUCCESS (0.033s) [108.861761] Subtest test_dup: SUCCESS (0.033s) [108.923333] [014/131] (911s left) sysfs_preempt_timeout (timeout) [108.984520] Starting subtest: timeout [108.986962] Starting dynamic subtest: vecs0 [118.970103] Dynamic subtest vecs0: SUCCESS (9.980s) [118.979820] Starting dynamic subtest: ccs0 [120.285700] Dynamic subtest ccs0: SUCCESS (1.315s) [120.297848] Starting dynamic subtest: vcs0 [129.920711] Dynamic subtest vcs0: SUCCESS (9.632s) [129.930073] Starting dynamic subtest: bcs0 [131.253370] Dynamic subtest bcs0: SUCCESS (1.331s) [131.261396] Starting dynamic subtest: rcs0 [132.609690] Dynamic subtest rcs0: SUCCESS (1.354s) [132.619579] Starting dynamic subtest: vcs1 [141.942009] Dynamic subtest vcs1: SUCCESS (9.329s) [141.944397] Subtest timeout: SUCCESS (32.953s) [142.007503] [015/131] (878s left) gem_exec_reloc (basic-gtt-wc-active) [142.068352] Subtest basic-gtt-wc-active: SKIP (0.000s) [142.136063] [016/131] (878s left) fbdev (unaligned-write) [142.185463] Starting subtest: unaligned-write [142.288743] Subtest unaligned-write: SUCCESS (0.102s) [142.344147] [017/131] (878s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [142.401114] Starting subtest: multi-wait-all-for-submit-signaled [142.403443] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [142.494471] [018/131] (878s left) gem_ringfill (basic-all) [147.949264] Starting subtest: basic-all [149.104502] Subtest basic-all: SUCCESS (1.156s) [149.237726] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true [149.241447] [019/131] (871s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [149.307811] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [149.382379] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s) [149.420171] [020/131] (871s left) kms_plane_lowres (tiling-y) [149.520127] Starting subtest: tiling-y [149.524636] Subtest tiling-y: SKIP (0.000s) [149.589439] [021/131] (871s left) gem_pxp (hw-rejects-pxp-context) [149.709385] Starting subtest: hw-rejects-pxp-context [149.713527] Subtest hw-rejects-pxp-context: SKIP (0.000s) [149.827472] [022/131] (871s left) kms_vblank (query-busy) [149.917108] Starting subtest: query-busy [149.919446] Starting dynamic subtest: pipe-A-eDP-1 [151.813980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s) [151.828394] Starting dynamic subtest: pipe-D-eDP-1 [154.336385] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.521s) [154.338623] Subtest query-busy: SUCCESS (4.419s) [155.124249] [023/131] (866s left) gem_mmap_offset (mmap-boundaries) [155.175827] Starting subtest: mmap-boundaries [155.178148] Starting dynamic subtest: smem0 [156.283796] Dynamic subtest smem0: SUCCESS (1.110s) [156.286314] Subtest mmap-boundaries: SUCCESS (1.111s) [156.468448] [024/131] (864s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [156.528830] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [156.628367] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [156.699753] [025/131] (864s left) gem_reg_read (timestamp-moving) [156.756619] Starting subtest: timestamp-moving [157.757447] Subtest timestamp-moving: SUCCESS (1.001s) [157.831654] [026/131] (863s left) gem_exec_fence (nb-await) [158.007119] Starting subtest: nb-await [158.009615] Starting dynamic subtest: rcs0 [158.084552] Dynamic subtest rcs0: SUCCESS (0.077s) [158.094403] Starting dynamic subtest: bcs0 [158.144984] Dynamic subtest bcs0: SUCCESS (0.059s) [158.154795] Starting dynamic subtest: vcs0 [158.204881] Dynamic subtest vcs0: SUCCESS (0.058s) [158.214063] Starting dynamic subtest: vcs1 [158.265684] Dynamic subtest vcs1: SUCCESS (0.059s) [158.275827] Starting dynamic subtest: vecs0 [158.324182] Dynamic subtest vecs0: SUCCESS (0.057s) [158.332394] Starting dynamic subtest: ccs0 [158.385267] Dynamic subtest ccs0: SUCCESS (0.059s) [158.387740] Subtest nb-await: SUCCESS (0.379s) [160.007840] [027/131] (861s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [160.108386] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [160.110762] Starting dynamic subtest: pipe-A-default-mode [160.409582] Dynamic subtest pipe-A-default-mode: SKIP (0.298s) [160.414182] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.299s) [161.247663] [028/131] (860s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [161.354294] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [161.356556] Starting dynamic subtest: pipe-A-eDP-1 [162.721801] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.339s) [162.972339] Starting dynamic subtest: pipe-B-eDP-1 [164.016994] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s) [164.285796] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.927s) [165.117129] [029/131] (856s left) gem_exec_schedule (preempt) [165.194862] Starting subtest: preempt [165.197107] Starting dynamic subtest: rcs0 [165.209593] Dynamic subtest rcs0: SUCCESS (0.022s) [165.218332] Starting dynamic subtest: bcs0 [165.227895] Dynamic subtest bcs0: SUCCESS (0.018s) [165.235066] Starting dynamic subtest: vcs0 [165.246736] Dynamic subtest vcs0: SUCCESS (0.018s) [165.253914] Starting dynamic subtest: vcs1 [165.267527] Dynamic subtest vcs1: SUCCESS (0.020s) [165.275207] Starting dynamic subtest: vecs0 [165.283603] Dynamic subtest vecs0: SUCCESS (0.016s) [165.290612] Starting dynamic subtest: ccs0 [165.302476] Dynamic subtest ccs0: SUCCESS (0.018s) [165.304714] Subtest preempt: SUCCESS (0.115s) [167.062326] [030/131] (854s left) kms_sequence (queue-busy) [167.163707] Starting subtest: queue-busy [167.166186] Starting dynamic subtest: pipe-A-eDP-1 [169.086968] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [169.094866] Starting dynamic subtest: pipe-B-eDP-1 [171.712794] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s) [171.720196] Starting dynamic subtest: pipe-C-eDP-1 [174.309783] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.596s) [174.317447] Starting dynamic subtest: pipe-D-eDP-1 [176.831386] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.521s) [176.833603] Subtest queue-busy: SUCCESS (9.667s) [177.615045] [031/131] (843s left) kms_addfb_basic (size-max) [177.719856] Starting subtest: size-max [177.722061] Subtest size-max: SUCCESS (0.000s) [177.831314] [032/131] (843s left) kms_psr (fbc-pr-primary-render) [177.939359] Starting subtest: fbc-pr-primary-render [177.943709] Subtest fbc-pr-primary-render: SKIP (0.000s) [178.004289] [033/131] (843s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [178.123717] Starting subtest: flip-vs-cursor-varying-size [185.909970] Subtest flip-vs-cursor-varying-size: SUCCESS (7.785s) [186.741059] [034/131] (834s left) i915_hangman (engine-engine-hang) [186.806475] Starting subtest: engine-engine-hang [186.808386] Starting dynamic subtest: rcs0 [187.914698] Dynamic subtest rcs0: SUCCESS (1.108s) [187.924513] Starting dynamic subtest: bcs0 [189.895992] Dynamic subtest bcs0: SUCCESS (1.979s) [189.907011] Starting dynamic subtest: vcs0 [191.879858] Dynamic subtest vcs0: SUCCESS (1.981s) [191.890287] Starting dynamic subtest: vcs1 [193.865107] Dynamic subtest vcs1: SUCCESS (1.983s) [193.874032] Starting dynamic subtest: vecs0 [195.912055] Dynamic subtest vecs0: SUCCESS (2.044s) [195.922462] Starting dynamic subtest: ccs0 [197.897532] Dynamic subtest ccs0: SUCCESS (1.983s) [197.900685] Subtest engine-engine-hang: SUCCESS (11.092s) [197.969416] [035/131] (823s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [198.075780] Starting subtest: fbc-rgb101010-draw-blt [201.638761] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.566s) [201.771227] [036/131] (819s left) syncobj_wait (multi-wait-submitted-signaled) [201.826025] Starting subtest: multi-wait-submitted-signaled [201.828525] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [201.920666] [037/131] (819s left) kms_pwrite_crc [203.480988] [038/131] (818s left) gem_cs_tlb (engines) [203.538874] Starting subtest: engines [203.541225] Starting dynamic subtest: rcs0 [205.694325] Dynamic subtest rcs0: SUCCESS (2.152s) [205.701260] Starting dynamic subtest: bcs0 [207.848432] Dynamic subtest bcs0: SUCCESS (2.152s) [207.857303] Starting dynamic subtest: vcs0 [210.001908] Dynamic subtest vcs0: SUCCESS (2.152s) [210.009441] Starting dynamic subtest: vcs1 [212.154686] Dynamic subtest vcs1: SUCCESS (2.153s) [212.164564] Starting dynamic subtest: vecs0 [214.307439] Dynamic subtest vecs0: SUCCESS (2.153s) [214.316678] Starting dynamic subtest: ccs0 [216.464159] Dynamic subtest ccs0: SUCCESS (2.155s) [216.466638] Subtest engines: SUCCESS (12.921s) [216.599409] [039/131] (805s left) kms_psr (pr-sprite-render) [216.711253] Starting subtest: pr-sprite-render [216.715711] Subtest pr-sprite-render: SKIP (0.000s) [216.777883] [040/131] (804s left) gem_pread (uncached) [216.842691] Subtest uncached: SKIP (0.000s) [216.907865] [041/131] (804s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [221.933538] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [221.938342] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [222.780729] [042/131] (799s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [223.173465] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [223.984645] [043/131] (797s left) gem_userptr_blits (vma-merge) [224.061106] Starting subtest: vma-merge [224.107735] Subtest vma-merge: SUCCESS (0.049s) [224.235862] [044/131] (797s left) gem_exec_balancer (hang) [224.496198] Starting subtest: hang [225.982502] Subtest hang: SUCCESS (1.491s) [226.118307] [045/131] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [226.223818] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [226.228402] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [226.336428] [046/131] (795s left) gem_basic (create-fd-close) [226.396404] Starting subtest: create-fd-close [226.400361] Subtest create-fd-close: SUCCESS (0.000s) [226.495164] [047/131] (795s left) gem_mmap_gtt (basic-small-copy) [226.566875] Subtest basic-small-copy: SKIP (0.000s) [226.629794] [048/131] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [226.736062] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [230.202238] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.471s) [230.321495] [049/131] (791s left) gen9_exec_parse (bb-start-out) [230.381662] Subtest bb-start-out: SKIP (0.000s) [230.437742] [050/131] (791s left) syncobj_timeline (single-wait-all-available-submitted) [230.495662] Starting subtest: single-wait-all-available-submitted [230.497701] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [230.590812] [051/131] (791s left) kms_color (legacy-gamma) [230.692074] Starting subtest: legacy-gamma [230.694074] Starting dynamic subtest: pipe-A-eDP-1 [231.400716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s) [231.409323] Starting dynamic subtest: pipe-B-eDP-1 [232.810785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s) [232.819100] Starting dynamic subtest: pipe-C-eDP-1 [234.193321] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s) [234.201758] Starting dynamic subtest: pipe-D-eDP-1 [235.527445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s) [235.532049] Subtest legacy-gamma: SUCCESS (4.834s) [236.320762] [052/131] (785s left) drm_read (short-buffer-wakeup) [236.490051] Starting subtest: short-buffer-wakeup [268.708069] Subtest short-buffer-wakeup: SUCCESS (32.216s) [268.834846] [053/131] (753s left) gem_mmap_gtt (big-bo) [268.903535] Subtest big-bo: SKIP (0.000s) [268.951442] [054/131] (753s left) gem_mmap_gtt (close-race) [269.008961] Subtest close-race: SKIP (0.000s) [269.070640] [055/131] (753s left) gem_ctx_shared (q-smoketest-all) [269.149506] Starting subtest: Q-smoketest-all [301.556290] Subtest Q-smoketest-all: SUCCESS (32.356s) [303.085209] [056/131] (719s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [303.199767] Starting subtest: yf-tiled-64bpp-rotate-90 [303.203977] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [303.306931] [057/131] (718s left) gem_ctx_persistence (engines-hostile-preempt) [303.370560] Starting subtest: engines-hostile-preempt [303.372973] Starting dynamic subtest: rcs0 [303.477565] Dynamic subtest rcs0: SUCCESS (0.107s) [303.487258] Starting dynamic subtest: bcs0 [303.558348] Dynamic subtest bcs0: SUCCESS (0.078s) [303.568543] Starting dynamic subtest: vcs0 [304.919695] Dynamic subtest vcs0: SUCCESS (1.359s) [304.928776] Starting dynamic subtest: vcs1 [306.906530] Dynamic subtest vcs1: SUCCESS (1.985s) [306.915636] Starting dynamic subtest: vecs0 [308.930448] Dynamic subtest vecs0: SUCCESS (2.022s) [308.941374] Starting dynamic subtest: ccs0 [308.988041] Dynamic subtest ccs0: SUCCESS (0.057s) [308.990816] Subtest engines-hostile-preempt: SUCCESS (5.618s) [309.061908] [058/131] (713s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [309.174420] Starting subtest: fbc-rgb101010-draw-mmap-gtt [309.178770] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [309.280532] [059/131] (713s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [309.371049] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [309.373312] Starting dynamic subtest: pipe-A-eDP-1 [310.238882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s) [310.246268] Starting dynamic subtest: pipe-B-eDP-1 [311.723114] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.481s) [311.731077] Starting dynamic subtest: pipe-C-eDP-1 [313.243245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.518s) [313.251963] Starting dynamic subtest: pipe-D-eDP-1 [314.756329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s) [314.758537] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.374s) [315.927723] [060/131] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [316.047483] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [316.051754] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [316.157043] [061/131] (706s left) core_setmaster (master-drop-set-root) [318.313490] Starting subtest: master-drop-set-root [318.323365] Subtest master-drop-set-root: SUCCESS (0.010s) [318.360244] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.amdgpu: true [318.360917] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.xe: true [318.364054] [062/131] (704s left) gem_render_copy (yf-tiled) [318.425827] Starting subtest: yf-tiled [318.430206] Subtest yf-tiled: SKIP (0.000s) [318.606366] [063/131] (703s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu) [318.704359] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu [323.360498] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.658s) [323.473225] [064/131] (699s left) kms_vblank (wait-forked-busy-hang) [323.571852] Starting subtest: wait-forked-busy-hang [323.574202] Starting dynamic subtest: pipe-A-eDP-1 [349.664217] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.088s) [349.676078] Starting dynamic subtest: pipe-D-eDP-1 [374.693116] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s) [374.695089] Subtest wait-forked-busy-hang: SUCCESS (51.116s) [375.531741] [065/131] (647s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [375.627079] Starting subtest: planes-downscale-factor-0-75-unity-scaling [375.629264] Starting dynamic subtest: pipe-A [375.711770] Dynamic subtest pipe-A: SUCCESS (0.084s) [375.720499] Starting dynamic subtest: pipe-B [376.857232] Dynamic subtest pipe-B: SUCCESS (1.144s) [376.864632] Starting dynamic subtest: pipe-C [377.961524] Dynamic subtest pipe-C: SUCCESS (1.103s) [377.969899] Starting dynamic subtest: pipe-D [379.086461] Dynamic subtest pipe-D: SUCCESS (1.123s) [379.088622] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.460s) [380.235728] [066/131] (642s left) kms_big_fb (4-tiled-16bpp-rotate-0) [380.340283] Starting subtest: 4-tiled-16bpp-rotate-0 [381.707863] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.369s) [381.845979] [067/131] (640s left) perf (blocking-parameterized) [381.957339] Starting subtest: blocking-parameterized [401.994651] Subtest blocking-parameterized: SUCCESS (20.035s) [402.036946] [068/131] (620s left) kms_flip (dpms-vs-vblank-race) [402.138102] Starting subtest: dpms-vs-vblank-race [402.140408] Starting dynamic subtest: A-eDP1 [407.102990] Dynamic subtest A-eDP1: SUCCESS (4.963s) [407.113593] Starting dynamic subtest: B-eDP1 [411.693325] Dynamic subtest B-eDP1: SUCCESS (4.587s) [411.701530] Starting dynamic subtest: C-eDP1 [416.270592] Dynamic subtest C-eDP1: SUCCESS (4.577s) [416.278818] Starting dynamic subtest: D-eDP1 [420.868892] Dynamic subtest D-eDP1: SUCCESS (4.598s) [420.871249] Subtest dpms-vs-vblank-race: SUCCESS (18.733s) [421.739862] [069/131] (600s left) kms_cursor_crc (cursor-random-256x256) [421.974729] Starting subtest: cursor-random-256x256 [421.979827] Starting dynamic subtest: pipe-A-eDP-1 [425.720079] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.741s) [425.750574] Starting dynamic subtest: pipe-D-eDP-1 [430.160308] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.416s) [430.162943] Subtest cursor-random-256x256: SUCCESS (8.185s) [430.990221] [070/131] (591s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [431.117848] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [447.875982] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (16.756s) [448.677370] [071/131] (574s left) kms_pm_dc (dc5-retention-flops) [449.793902] Starting subtest: dc5-retention-flops [449.798121] Subtest dc5-retention-flops: SKIP (0.000s) [449.859772] [072/131] (572s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [449.962907] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [449.965320] Starting dynamic subtest: pipe-A-default-mode [450.250967] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [450.255888] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.285s) [451.101520] [073/131] (571s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [451.162330] Starting subtest: single-wait-all-for-submit-unsubmitted [451.269376] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [451.339858] [074/131] (571s left) syncobj_timeline (etime-single-wait-all-submitted) [451.403488] Starting subtest: etime-single-wait-all-submitted [451.510348] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s) [451.580760] [075/131] (571s left) gem_mmap_wc (write-cpu-read-wc) [451.637811] Subtest write-cpu-read-wc: SKIP (0.000s) [451.693875] [076/131] (571s left) kms_psr (fbc-psr2-sprite-blt) [451.793247] Starting subtest: fbc-psr2-sprite-blt [451.795504] Starting dynamic subtest: eDP-1 [451.799623] Dynamic subtest eDP-1: SKIP (0.000s) [451.803575] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [451.863366] [077/131] (571s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [451.958318] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [451.960630] Starting dynamic subtest: pipe-A-eDP-1 [451.983731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [451.993157] Starting dynamic subtest: pipe-B-eDP-1 [452.015140] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [452.022874] Starting dynamic subtest: pipe-C-eDP-1 [452.045400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [452.052958] Starting dynamic subtest: pipe-D-eDP-1 [452.075287] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [452.079371] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s) [454.150109] [078/131] (568s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [454.261256] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [454.265252] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [454.362937] [079/131] (568s left) gem_ctx_persistence (legacy-engines-mixed) [454.423563] Starting subtest: legacy-engines-mixed [454.425887] Starting dynamic subtest: render [454.534857] Dynamic subtest render: SUCCESS (0.111s) [454.544652] Starting dynamic subtest: bsd1 [454.601339] Dynamic subtest bsd1: SUCCESS (0.064s) [454.611082] Starting dynamic subtest: bsd2 [454.681763] Dynamic subtest bsd2: SUCCESS (0.079s) [454.691099] Starting dynamic subtest: blt [454.774872] Dynamic subtest blt: SUCCESS (0.090s) [454.787357] Starting dynamic subtest: vebox [454.800530] Dynamic subtest vebox: SUCCESS (0.024s) [454.802938] Subtest legacy-engines-mixed: SUCCESS (0.377s) [454.907385] [080/131] (568s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [455.022505] Starting subtest: fbcpsr-rgb101010-draw-render [459.650601] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.631s) [459.766965] [081/131] (563s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [460.315811] Starting subtest: syncobj-stationary-timeline-chain-engines [460.403712] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.089s) [462.026144] [082/131] (561s left) perf (polling-parameterized) [462.120629] Starting subtest: polling-parameterized [482.152911] Subtest polling-parameterized: SUCCESS (20.029s) [482.195355] [083/131] (540s left) api_intel_bb (intel-bb-blit-y) [482.246069] Starting subtest: intel-bb-blit-y [485.753524] Subtest intel-bb-blit-y: SUCCESS (3.507s) [485.865541] [084/131] (537s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [485.996962] Starting subtest: cursorB-vs-flipB-legacy [486.001085] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [486.126630] [085/131] (537s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [486.234684] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [491.774802] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.544s) [491.907368] [086/131] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [492.018795] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [496.674704] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.659s) [496.790909] [087/131] (526s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [496.891079] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [496.895257] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [496.977792] [088/131] (526s left) drm_fdinfo (busy-idle-check-all) [497.016528] Starting subtest: busy-idle-check-all [497.018491] Starting dynamic subtest: rcs0 [497.023115] Dynamic subtest rcs0: SKIP (0.004s) [497.032635] Starting dynamic subtest: bcs0 [497.037024] Dynamic subtest bcs0: SKIP (0.000s) [497.044594] Starting dynamic subtest: vcs0 [497.048962] Dynamic subtest vcs0: SKIP (0.000s) [497.055969] Starting dynamic subtest: vcs1 [497.059972] Dynamic subtest vcs1: SKIP (0.000s) [497.066985] Starting dynamic subtest: vecs0 [497.071084] Dynamic subtest vecs0: SKIP (0.000s) [497.078069] Starting dynamic subtest: ccs0 [497.082185] Dynamic subtest ccs0: SKIP (0.000s) [497.086299] Subtest busy-idle-check-all: SKIP (0.008s) [497.115386] [089/131] (526s left) kms_psr (psr-cursor-plane-move) [497.257186] Starting subtest: psr-cursor-plane-move [497.259481] Starting dynamic subtest: eDP-1 [498.943613] Dynamic subtest eDP-1: SUCCESS (1.684s) [498.946178] Subtest psr-cursor-plane-move: SUCCESS (1.686s) [499.801802] [090/131] (523s left) syncobj_timeline (wait-delayed-signal) [499.857662] Starting subtest: wait-delayed-signal [499.959375] Subtest wait-delayed-signal: SUCCESS (0.103s) [500.032297] [091/131] (523s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [500.132140] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [500.134425] Starting dynamic subtest: pipe-A-default-mode [501.257503] Dynamic subtest pipe-A-default-mode: SKIP (1.122s) [501.261715] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.123s) [501.416841] [092/131] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [501.525462] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [501.529586] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [501.614237] [093/131] (521s left) gem_exec_params (rs-invalid) [501.678643] Starting subtest: rs-invalid [501.683307] Subtest rs-invalid: SUCCESS (0.003s) [501.809979] [094/131] (521s left) kms_cursor_crc (cursor-rapid-movement-128x42) [502.031356] Starting subtest: cursor-rapid-movement-128x42 [502.071143] Subtest cursor-rapid-movement-128x42: SKIP (0.035s) [502.271978] [095/131] (521s left) kms_invalid_mode (bad-htotal) [502.376493] Starting subtest: bad-htotal [502.378540] Starting dynamic subtest: pipe-A-eDP-1 [502.659994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [502.668798] Starting dynamic subtest: pipe-B-eDP-1 [502.671107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [502.678365] Starting dynamic subtest: pipe-C-eDP-1 [502.680659] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [502.688120] Starting dynamic subtest: pipe-D-eDP-1 [502.690090] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [502.692052] Subtest bad-htotal: SUCCESS (0.288s) [503.456231] [096/131] (520s left) gem_ctx_param (set-priority-not-supported) [503.521435] Starting subtest: set-priority-not-supported [503.526782] Subtest set-priority-not-supported: SKIP (0.000s) [503.597851] [097/131] (520s left) gem_exec_reloc (basic-write-cpu-active) [503.669025] Subtest basic-write-cpu-active: SKIP (0.000s) [503.754646] [098/131] (519s left) gem_shrink (reclaim) [503.817462] Starting subtest: reclaim [506.333115] Subtest reclaim: SUCCESS (2.513s) [506.480117] [099/131] (517s left) kms_flip (2x-plain-flip-ts-check-interruptible) [506.589703] Starting subtest: 2x-plain-flip-ts-check-interruptible [506.602536] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [506.673115] [100/131] (517s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [506.759040] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [506.761191] Starting dynamic subtest: pipe-A-eDP-1 [506.785511] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [506.793441] Starting dynamic subtest: pipe-B-eDP-1 [506.816193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [506.823916] Starting dynamic subtest: pipe-C-eDP-1 [506.847908] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [506.856578] Starting dynamic subtest: pipe-D-eDP-1 [506.880322] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [506.884668] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [508.921442] [101/131] (514s left) i915_pm_rps (thresholds-idle) [508.991542] Starting subtest: thresholds-idle [508.996162] Subtest thresholds-idle: SKIP (0.001s) [509.081383] [102/131] (514s left) kms_frontbuffer_tracking (pipe-fbc-rte) [509.197581] Starting subtest: pipe-fbc-rte [509.203883] Starting dynamic subtest: pipe-B-eDP-1 [513.548884] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.360s) [513.556451] Subtest pipe-fbc-rte: SUCCESS (4.362s) [514.742215] [103/131] (509s left) kms_tv_load_detect (load-detect) [514.805305] Subtest load-detect: SKIP (0.000s) [514.861468] [104/131] (509s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [514.958229] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [514.962136] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [515.056372] [105/131] (508s left) gem_exec_flush (basic-uc-rw-default) [515.113981] Starting subtest: basic-uc-rw-default [520.595872] Subtest basic-uc-rw-default: SUCCESS (5.481s) [520.777515] [106/131] (503s left) kms_big_fb (linear-32bpp-rotate-180) [520.894133] Starting subtest: linear-32bpp-rotate-180 [522.550239] Subtest linear-32bpp-rotate-180: SUCCESS (1.656s) [522.744832] [107/131] (501s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [522.840577] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [522.844803] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [522.928823] [108/131] (501s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [523.033850] Starting subtest: psr-modesetfrombusy [527.125546] Subtest psr-modesetfrombusy: SUCCESS (4.097s) [527.258137] [109/131] (496s left) kms_async_flips (crc) [527.356196] Starting subtest: crc [527.725998] Starting dynamic subtest: pipe-A-eDP-1 [530.614389] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.889s) [530.987301] Starting dynamic subtest: pipe-B-eDP-1 [533.849066] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.868s) [534.231063] Starting dynamic subtest: pipe-C-eDP-1 [537.043400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.827s) [537.401878] Starting dynamic subtest: pipe-D-eDP-1 [540.265094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s) [540.267493] Subtest crc: SUCCESS (12.909s) [541.448094] [110/131] (482s left) kms_fbcon_fbt (fbc) [541.514408] Starting subtest: fbc [546.808079] Subtest fbc: SUCCESS (5.294s) [546.879627] [111/131] (477s left) kms_content_protection (legacy) [547.056914] Starting subtest: legacy [550.904950] Subtest legacy: SKIP (3.844s) [552.099868] [112/131] (472s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [557.146075] Starting subtest: pr-overlay-plane-update-continuous-sf [557.150817] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [558.003508] [113/131] (466s left) gem_lmem_swapping (massive) [558.050586] Subtest massive: SKIP (0.000s) [558.093917] [114/131] (466s left) i915_selftest (perf) [561.698077] Starting subtest: perf [561.700657] Starting dynamic subtest: engine_cs [566.066893] Dynamic subtest engine_cs: SUCCESS (4.369s) [566.074766] Starting dynamic subtest: request [571.466038] Dynamic subtest request: SUCCESS (5.397s) [571.474467] Starting dynamic subtest: migrate [575.872968] Dynamic subtest migrate: SUCCESS (4.404s) [575.881375] Starting dynamic subtest: region [581.730155] Dynamic subtest region: SUCCESS (5.855s) [581.732792] Subtest perf: SUCCESS (20.031s) [581.754615] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [581.755455] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [581.759227] [115/131] (442s left) kms_flip (basic-plain-flip) [583.548597] Starting subtest: basic-plain-flip [583.550986] Starting dynamic subtest: A-eDP1 [585.303686] Dynamic subtest A-eDP1: SUCCESS (1.754s) [585.312131] Starting dynamic subtest: B-eDP1 [587.028548] Dynamic subtest B-eDP1: SUCCESS (1.724s) [587.037079] Starting dynamic subtest: C-eDP1 [588.739975] Dynamic subtest C-eDP1: SUCCESS (1.710s) [588.748249] Starting dynamic subtest: D-eDP1 [590.459828] Dynamic subtest D-eDP1: SUCCESS (1.719s) [590.462192] Subtest basic-plain-flip: SUCCESS (6.915s) [591.620955] [FACT kms_flip (basic-plain-flip)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [591.622726] [FACT kms_flip (basic-plain-flip)] new: kernel.kmod_is_loaded.i915: true [591.626588] [116/131] (432s left) kms_chamelium_color (ctm-green-to-red) [591.735227] Subtest ctm-green-to-red: SKIP (0.000s) [591.774939] [117/131] (432s left) gem_render_copy (y-tiled) [591.834072] Starting subtest: y-tiled [591.838803] Subtest y-tiled: SKIP (0.000s) [592.011390] [118/131] (432s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [592.146189] Starting subtest: basic-flip-before-cursor-atomic [593.050553] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.906s) [593.843917] [119/131] (430s left) kms_rotation_crc (primary-rotation-270) [593.944099] Starting subtest: primary-rotation-270 [593.948588] Subtest primary-rotation-270: SKIP (0.001s) [594.010344] [120/131] (430s left) kms_pm_rpm (pm-tiling) [596.151793] Starting subtest: pm-tiling [596.156518] Subtest pm-tiling: SKIP (0.000s) [596.499180] [121/131] (428s left) kms_lease (invalid-create-leases) [596.587180] Starting subtest: invalid-create-leases [596.594889] Subtest invalid-create-leases: SUCCESS (0.006s) [596.690055] [122/131] (427s left) kms_big_fb (x-tiled-32bpp-rotate-270) [596.793420] Starting subtest: x-tiled-32bpp-rotate-270 [596.812782] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [596.920122] [123/131] (427s left) syncobj_wait (wait-all-for-submit-complex) [596.979683] Starting subtest: wait-all-for-submit-complex [597.192999] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [597.260677] [124/131] (427s left) gem_ctx_param (invalid-param-set) [597.313913] Starting subtest: invalid-param-set [597.316254] Subtest invalid-param-set: SUCCESS (0.000s) [597.385073] [125/131] (427s left) gem_exec_whisper (basic-forked-all) [597.460455] Starting subtest: basic-forked-all [610.889701] Subtest basic-forked-all: SUCCESS (13.424s) [611.070800] [126/131] (413s left) kms_cursor_legacy (torture-bo) [611.197768] Starting subtest: torture-bo [611.200131] Starting dynamic subtest: pipe-A [616.887574] Dynamic subtest pipe-A: SUCCESS (5.687s) [616.899466] Starting dynamic subtest: pipe-B [622.947728] Dynamic subtest pipe-B: SUCCESS (6.059s) [622.959284] Starting dynamic subtest: pipe-C [629.224219] Dynamic subtest pipe-C: SUCCESS (6.275s) [629.234223] Starting dynamic subtest: pipe-D [636.028543] Dynamic subtest pipe-D: SUCCESS (6.802s) [636.039165] Starting dynamic subtest: all-pipes [642.747274] Dynamic subtest all-pipes: SUCCESS (6.717s) [642.749659] Subtest torture-bo: SUCCESS (31.547s) [642.890644] [127/131] (381s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [642.993087] Starting subtest: bad-pixel-format-y-tiled-ccs [642.995328] Starting dynamic subtest: pipe-A-eDP-1 [643.017816] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [643.027149] Starting dynamic subtest: pipe-B-eDP-1 [643.048748] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [643.056534] Starting dynamic subtest: pipe-C-eDP-1 [643.078647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [643.086401] Starting dynamic subtest: pipe-D-eDP-1 [643.108571] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [643.112665] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [645.139996] [128/131] (379s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [645.239124] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [645.241453] Starting dynamic subtest: pipe-A [646.288832] Dynamic subtest pipe-A: SUCCESS (1.050s) [646.296207] Starting dynamic subtest: pipe-B [648.442493] Dynamic subtest pipe-B: SUCCESS (2.153s) [648.449776] Starting dynamic subtest: pipe-C [649.639109] Dynamic subtest pipe-C: SUCCESS (1.195s) [649.648756] Starting dynamic subtest: pipe-D [650.774833] Dynamic subtest pipe-D: SUCCESS (1.136s) [650.777198] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.536s) [651.961270] [129/131] (372s left) gem_softpin (softpin) [652.031416] Starting subtest: softpin [684.409058] Subtest softpin: SUCCESS (32.374s) [684.534109] [130/131] (340s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [684.642349] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [689.177414] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.536s) [689.319208] [131/131] (335s left) kms_addfb_basic (framebuffer-vs-set-tiling) [689.383712] Starting subtest: framebuffer-vs-set-tiling [689.388069] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [689.506110] Closing watchdogs results: parsing output: 0/ for test: gem_exec_schedule results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_userptr_blits results: parsing output: 3/ for test: kms_pipe_crc_basic results: parsing output: 4/ for test: gem_exec_reloc results: parsing output: 5/ for test: gem_softpin results: parsing output: 6/ for test: perf_pmu results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: kms_dp_linktrain_fallback results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_flip results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: prime_mmap results: parsing output: 13/ for test: sysfs_preempt_timeout results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: fbdev results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: gem_ringfill results: parsing output: 18/ for test: sriov_basic results: parsing output: 19/ for test: kms_plane_lowres results: parsing output: 20/ for test: gem_pxp results: parsing output: 21/ for test: kms_vblank results: parsing output: 22/ for test: gem_mmap_offset results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: gem_reg_read results: parsing output: 25/ for test: gem_exec_fence results: parsing output: 26/ for test: kms_flip_scaled_crc results: parsing output: 27/ for test: kms_atomic_transition results: parsing output: 28/ for test: gem_exec_schedule results: parsing output: 29/ for test: kms_sequence results: parsing output: 30/ for test: kms_addfb_basic results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: i915_hangman results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: syncobj_wait results: parsing output: 36/ for test: kms_pwrite_crc results: parsing output: 37/ for test: gem_cs_tlb results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: gem_pread results: parsing output: 40/ for test: kms_psr2_sf results: parsing output: 41/ for test: kms_chamelium_hpd results: parsing output: 42/ for test: gem_userptr_blits results: parsing output: 43/ for test: gem_exec_balancer results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_basic results: parsing output: 46/ for test: gem_mmap_gtt results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gen9_exec_parse results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_color results: parsing output: 51/ for test: drm_read results: parsing output: 52/ for test: gem_mmap_gtt results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: gem_ctx_shared results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: gem_ctx_persistence results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: core_setmaster results: parsing output: 61/ for test: gem_render_copy results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_vblank results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: perf results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: kms_cursor_crc results: parsing output: 69/ for test: kms_cursor_legacy results: parsing output: 70/ for test: kms_pm_dc results: parsing output: 71/ for test: kms_flip_scaled_crc results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: gem_mmap_wc results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: gem_ctx_persistence results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_exec_fence results: parsing output: 81/ for test: perf results: parsing output: 82/ for test: api_intel_bb results: parsing output: 83/ for test: kms_cursor_legacy results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: drm_fdinfo results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: kms_flip_scaled_crc results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_exec_params results: parsing output: 93/ for test: kms_cursor_crc results: parsing output: 94/ for test: kms_invalid_mode results: parsing output: 95/ for test: gem_ctx_param results: parsing output: 96/ for test: gem_exec_reloc results: parsing output: 97/ for test: gem_shrink results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: i915_pm_rps results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_tv_load_detect results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_flush results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_async_flips results: parsing output: 109/ for test: kms_fbcon_fbt results: parsing output: 110/ for test: kms_content_protection results: parsing output: 111/ for test: kms_psr2_sf results: parsing output: 112/ for test: gem_lmem_swapping results: parsing output: 113/ for test: i915_selftest results: parsing output: 114/ for test: kms_flip results: parsing output: 115/ for test: kms_chamelium_color results: parsing output: 116/ for test: gem_render_copy results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: kms_rotation_crc results: parsing output: 119/ for test: kms_pm_rpm results: parsing output: 120/ for test: kms_lease results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: gem_ctx_param results: parsing output: 124/ for test: gem_exec_whisper results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: kms_plane_scaling results: parsing output: 128/ for test: gem_softpin results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_addfb_basic Done.