[58.765040] Initializing watchdogs [58.765137] /dev/watchdog0 [58.780926] [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] [58.785726] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.788783] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.792180] [001/156] (960s left) prime_mmap_kms (buffer-sharing) [58.907619] Starting subtest: buffer-sharing [60.184911] Subtest buffer-sharing: SUCCESS (1.273s) [60.568519] [002/156] (958s left) gem_exec_reloc (basic-write-wc) [60.646274] Subtest basic-write-wc: SKIP (0.000s) [60.717608] [003/156] (958s left) perf (per-context-mode-unprivileged) [60.829871] Starting subtest: per-context-mode-unprivileged [60.834216] Subtest per-context-mode-unprivileged: SKIP (0.000s) [60.872405] [004/156] (958s left) gem_ccs (suspend-resume) [60.933400] Starting subtest: suspend-resume [60.937804] Subtest suspend-resume: SKIP (0.000s) [61.031779] [005/156] (958s left) kms_feature_discovery (chamelium) [61.131642] Starting subtest: chamelium [61.136054] Subtest chamelium: SKIP (0.000s) [61.206767] [006/156] (958s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [61.300317] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [61.304294] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [61.366847] [007/156] (958s left) kms_plane (pixel-format-x-tiled-modifier) [61.461612] Starting subtest: pixel-format-x-tiled-modifier [61.488544] Starting dynamic subtest: pipe-A-plane-0 [61.866546] Dynamic subtest pipe-A-plane-0: SUCCESS (0.378s) [61.875308] Starting dynamic subtest: pipe-A-plane-3 [62.187683] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s) [62.195160] Starting dynamic subtest: pipe-A-plane-5 [62.198781] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [63.273985] Starting dynamic subtest: pipe-B-plane-0 [63.644511] Dynamic subtest pipe-B-plane-0: SUCCESS (0.378s) [63.653154] Starting dynamic subtest: pipe-B-plane-3 [63.966719] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s) [63.974657] Starting dynamic subtest: pipe-B-plane-5 [63.978615] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [64.276936] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.814s) [65.143251] [008/156] (954s left) gem_spin_batch (engines) [65.204783] Starting subtest: engines [65.207281] Starting dynamic subtest: rcs0 [68.449057] Dynamic subtest rcs0: SUCCESS (3.237s) [68.458967] Starting dynamic subtest: bcs0 [71.734628] Dynamic subtest bcs0: SUCCESS (3.236s) [71.744793] Starting dynamic subtest: vcs0 [74.964993] Dynamic subtest vcs0: SUCCESS (3.229s) [74.975348] Starting dynamic subtest: vcs1 [78.203297] Dynamic subtest vcs1: SUCCESS (3.237s) [78.213363] Starting dynamic subtest: vecs0 [81.387905] Dynamic subtest vecs0: SUCCESS (3.234s) [81.396087] Starting dynamic subtest: ccs0 [84.676841] Dynamic subtest ccs0: SUCCESS (3.236s) [84.679471] Subtest engines: SUCCESS (19.416s) [84.862286] [009/156] (934s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw) [84.970419] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw [84.974534] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s) [85.065855] [010/156] (934s left) syncobj_timeline (invalid-signal-illegal-handle) [85.133695] Starting subtest: invalid-signal-illegal-handle [85.135762] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [85.237765] [011/156] (934s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [85.341869] Starting subtest: psr-rgb565-draw-blt [92.489919] Subtest psr-rgb565-draw-blt: SUCCESS (7.158s) [92.637730] [012/156] (927s left) gem_ctx_param (invalid-ctx-set) [92.691842] Starting subtest: invalid-ctx-set [92.694389] Subtest invalid-ctx-set: SUCCESS (0.001s) [92.806749] [013/156] (926s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt) [92.917595] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt [92.921840] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [93.022867] [014/156] (926s left) gem_exec_balancer (full) [93.079592] Starting subtest: full [98.231975] Subtest full: SUCCESS (5.152s) [98.563832] [015/156] (921s left) kms_atomic_interruptible (legacy-dpms) [98.670805] Starting subtest: legacy-dpms [98.673241] Starting dynamic subtest: pipe-A-eDP-1 [106.085202] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.414s) [106.087503] Subtest legacy-dpms: SUCCESS (7.415s) [106.919962] [016/156] (912s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [107.058411] Starting subtest: cursorA-vs-flipB-toggle [107.063130] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [107.206796] [017/156] (912s left) perf (gen12-invalid-class-instance) [107.307982] Starting subtest: gen12-invalid-class-instance [107.320842] Subtest gen12-invalid-class-instance: SUCCESS (0.011s) [107.369438] [018/156] (912s left) gem_mmap_gtt (basic-write-read) [107.430187] Subtest basic-write-read: SKIP (0.000s) [107.485215] [019/156] (912s left) kms_pipe_crc_basic (bad-source) [107.569255] Starting subtest: bad-source [107.571413] Subtest bad-source: SUCCESS (0.000s) [107.643888] [020/156] (912s left) kms_async_flips (test-time-stamp) [107.740472] Starting subtest: test-time-stamp [108.124548] Starting dynamic subtest: pipe-A-eDP-1 [108.925433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s) [109.298243] Starting dynamic subtest: pipe-B-eDP-1 [110.066062] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s) [110.442535] Starting dynamic subtest: pipe-C-eDP-1 [111.293993] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.858s) [111.655029] Starting dynamic subtest: pipe-D-eDP-1 [112.425257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s) [112.427796] Subtest test-time-stamp: SUCCESS (4.683s) [113.595388] [021/156] (906s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [113.700447] Starting subtest: fbcpsr-indfb-scaledprimary [119.445055] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.752s) [119.579911] [022/156] (900s left) kms_vblank (query-forked-hang) [119.680079] Starting subtest: query-forked-hang [119.682387] Starting dynamic subtest: pipe-A-eDP-1 [146.083643] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.400s) [146.097851] Starting dynamic subtest: pipe-D-eDP-1 [161.063384] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s) [161.065870] Subtest query-forked-hang: SUCCESS (41.382s) [161.891841] [023/156] (858s left) gem_userptr_blits (relocations) [161.947796] Starting subtest: relocations [161.952207] Subtest relocations: SKIP (0.001s) [162.072853] [024/156] (858s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [162.172937] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [162.175166] Starting dynamic subtest: pipe-A-eDP-1 [162.197718] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [162.207211] Starting dynamic subtest: pipe-B-eDP-1 [162.228356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [162.236948] Starting dynamic subtest: pipe-C-eDP-1 [162.257959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [162.267502] Starting dynamic subtest: pipe-D-eDP-1 [162.289805] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [162.294053] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [164.435372] [025/156] (855s left) kms_psr (fbc-psr2-sprite-plane-onoff) [164.533181] Starting subtest: fbc-psr2-sprite-plane-onoff [164.535068] Starting dynamic subtest: eDP-1 [164.539165] Dynamic subtest eDP-1: SKIP (0.000s) [164.543249] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [164.606042] [026/156] (855s left) syncobj_timeline (wait-any-complex) [164.664125] Starting subtest: wait-any-complex [164.727191] Subtest wait-any-complex: SUCCESS (0.063s) [164.803156] [027/156] (855s left) gem_exec_whisper (basic-contexts-forked-all) [164.853221] Starting subtest: basic-contexts-forked-all [185.165058] Subtest basic-contexts-forked-all: SUCCESS (20.254s) [185.298817] [028/156] (835s left) kms_frontbuffer_tracking (fbchdr-tiling-y) [185.402099] Starting subtest: fbchdr-tiling-y [185.406489] Subtest fbchdr-tiling-y: SKIP (0.000s) [185.502040] [029/156] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [185.604590] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [185.609232] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [185.707129] [030/156] (834s left) kms_async_flips (crc) [185.802538] Starting subtest: crc [186.176268] Starting dynamic subtest: pipe-A-eDP-1 [189.076332] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.881s) [189.436774] Starting dynamic subtest: pipe-B-eDP-1 [192.414505] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.969s) [192.771499] Starting dynamic subtest: pipe-C-eDP-1 [195.725600] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.920s) [196.055833] Starting dynamic subtest: pipe-D-eDP-1 [198.951954] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s) [198.954413] Subtest crc: SUCCESS (13.118s) [200.083077] [031/156] (820s left) gem_partial_pwrite_pread (write) [200.146205] Subtest write: SKIP (0.000s) [200.204599] [032/156] (820s left) gem_mmap_gtt (hang-busy) [200.259226] Subtest hang-busy: SKIP (0.000s) [200.317572] [033/156] (820s left) sysfs_timeslice_duration (timeout) [200.375086] Starting subtest: timeout [200.377166] Starting dynamic subtest: vecs0 [210.329923] Dynamic subtest vecs0: SUCCESS (9.951s) [210.340651] Starting dynamic subtest: ccs0 [211.527255] Dynamic subtest ccs0: SUCCESS (1.196s) [211.538520] Starting dynamic subtest: vcs0 [221.341835] Dynamic subtest vcs0: SUCCESS (9.813s) [221.353322] Starting dynamic subtest: bcs0 [221.950614] Dynamic subtest bcs0: SUCCESS (0.608s) [221.961653] Starting dynamic subtest: rcs0 [223.205775] Dynamic subtest rcs0: SUCCESS (1.254s) [223.215451] Starting dynamic subtest: vcs1 [232.343452] Dynamic subtest vcs1: SUCCESS (9.134s) [232.346041] Subtest timeout: SUCCESS (31.965s) [232.416295] [034/156] (788s left) kms_pm_rpm (i2c) [234.500989] Starting subtest: i2c [239.541260] Subtest i2c: SUCCESS (5.043s) [239.654737] [035/156] (781s left) gen9_exec_parse (bb-start-far) [239.718504] Subtest bb-start-far: SKIP (0.000s) [239.793086] [036/156] (780s left) gem_exec_flush (basic-batch-kernel-default-wb) [239.854780] Starting subtest: basic-batch-kernel-default-wb [247.028630] Subtest basic-batch-kernel-default-wb: SUCCESS (7.173s) [247.223064] [037/156] (773s left) gem_ctx_persistence (heartbeat-hang) [247.278655] Starting subtest: heartbeat-hang [247.283377] Subtest heartbeat-hang: SKIP (0.000s) [247.386087] [038/156] (773s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move) [247.488686] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move [247.492869] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [247.580669] [039/156] (773s left) sriov_basic (bind-unbind-vf) [247.641896] Starting subtest: bind-unbind-vf [247.644258] Starting dynamic subtest: vf-1 [247.716701] Dynamic subtest vf-1: FAIL (0.019s) [247.725948] Starting dynamic subtest: vf-2 [247.799266] Dynamic subtest vf-2: FAIL (0.004s) [247.809382] Starting dynamic subtest: vf-3 [247.882753] Dynamic subtest vf-3: FAIL (0.004s) [247.893094] Starting dynamic subtest: vf-4 [247.967898] Dynamic subtest vf-4: FAIL (0.004s) [247.978513] Starting dynamic subtest: vf-5 [248.051713] Dynamic subtest vf-5: FAIL (0.004s) [248.062314] Starting dynamic subtest: vf-6 [248.134570] Dynamic subtest vf-6: FAIL (0.004s) [248.143104] Starting dynamic subtest: vf-7 [248.205911] Dynamic subtest vf-7: FAIL (0.006s) [248.214515] Starting dynamic subtest: vf-random [248.272329] Dynamic subtest vf-random: FAIL (0.004s) [248.281313] Starting dynamic subtest: vf-last [248.340548] Dynamic subtest vf-last: FAIL (0.504s) [248.342474] Subtest bind-unbind-vf: FAIL (0.558s) [248.377733] [040/156] (772s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [248.480331] Starting subtest: psr-shrfb-scaledprimary [254.295303] Subtest psr-shrfb-scaledprimary: SUCCESS (5.817s) [254.427389] [041/156] (766s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [254.527609] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [254.531631] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [254.635378] [042/156] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [254.732741] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [261.307511] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.580s) [261.444462] [043/156] (759s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [261.539294] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [261.543431] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [261.622524] [044/156] (759s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [261.709578] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [261.711775] Starting dynamic subtest: pipe-A-eDP-1 [261.732449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [261.745668] Starting dynamic subtest: pipe-B-eDP-1 [261.764818] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [261.773514] Starting dynamic subtest: pipe-C-eDP-1 [261.792834] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [261.801052] Starting dynamic subtest: pipe-D-eDP-1 [261.820288] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [261.822477] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [264.047801] [045/156] (757s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [264.142375] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [264.144706] Starting dynamic subtest: A-eDP1 [273.092445] Dynamic subtest A-eDP1: SUCCESS (8.949s) [273.101657] Starting dynamic subtest: B-eDP1 [282.024489] Dynamic subtest B-eDP1: SUCCESS (8.930s) [282.034899] Starting dynamic subtest: C-eDP1 [290.992875] Dynamic subtest C-eDP1: SUCCESS (8.920s) [291.004682] Starting dynamic subtest: D-eDP1 [299.931248] Dynamic subtest D-eDP1: SUCCESS (8.933s) [299.933340] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.742s) [301.103886] [046/156] (720s left) gem_exec_params (dr1-dirt) [301.155307] Starting subtest: DR1-dirt [301.157599] Subtest DR1-dirt: SUCCESS (0.000s) [301.247762] [047/156] (719s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [301.361092] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [301.365724] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [301.501388] [048/156] (719s left) i915_getparams_basic (basic-subslice-total) [301.561218] Starting subtest: basic-subslice-total [301.565780] Subtest basic-subslice-total: SUCCESS (0.000s) [301.655980] [049/156] (719s left) gem_exec_schedule (pi-userfault) [301.842570] Starting subtest: pi-userfault [301.844563] Starting dynamic subtest: rcs0 [301.849114] Dynamic subtest rcs0: SUCCESS (0.009s) [301.858439] Starting dynamic subtest: bcs0 [301.860699] Dynamic subtest bcs0: SUCCESS (0.008s) [301.874255] Starting dynamic subtest: vcs0 [301.876711] Dynamic subtest vcs0: SUCCESS (0.009s) [301.886250] Starting dynamic subtest: vcs1 [301.888253] Dynamic subtest vcs1: SUCCESS (0.008s) [301.898813] Starting dynamic subtest: vecs0 [301.901048] Dynamic subtest vecs0: SUCCESS (0.007s) [301.910123] Starting dynamic subtest: ccs0 [301.912349] Dynamic subtest ccs0: SUCCESS (0.006s) [301.914504] Subtest pi-userfault: SUCCESS (0.051s) [302.071152] [050/156] (719s left) kms_psr (fbc-pr-cursor-mmap-gtt) [302.168132] Starting subtest: fbc-pr-cursor-mmap-gtt [302.172282] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [302.248673] [051/156] (719s left) kms_psr (psr2-cursor-blt) [302.342159] Starting subtest: psr2-cursor-blt [302.344453] Starting dynamic subtest: eDP-1 [304.078253] Dynamic subtest eDP-1: SUCCESS (1.734s) [304.080506] Subtest psr2-cursor-blt: SUCCESS (1.735s) [304.961865] [052/156] (716s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [305.057206] Starting subtest: flip-vs-dpms-on-nop-interruptible [305.059707] Starting dynamic subtest: A-eDP1 [306.970984] Dynamic subtest A-eDP1: SUCCESS (1.914s) [306.983180] Starting dynamic subtest: B-eDP1 [308.793073] Dynamic subtest B-eDP1: SUCCESS (1.820s) [308.806549] Starting dynamic subtest: C-eDP1 [310.612466] Dynamic subtest C-eDP1: SUCCESS (1.817s) [310.623364] Starting dynamic subtest: D-eDP1 [312.440550] Dynamic subtest D-eDP1: SUCCESS (1.827s) [312.446026] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.388s) [313.629211] [053/156] (707s left) kms_cursor_crc (cursor-rapid-movement-64x21) [313.831772] Starting subtest: cursor-rapid-movement-64x21 [313.881260] Subtest cursor-rapid-movement-64x21: SKIP (0.046s) [314.093064] [054/156] (707s left) gem_exec_fence (syncobj-timeline-wait) [314.702882] Starting subtest: syncobj-timeline-wait [316.351845] Subtest syncobj-timeline-wait: SUCCESS (1.649s) [318.403122] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true [318.406911] [055/156] (703s left) core_hotunplug (unbind-rebind) [318.502262] Starting subtest: unbind-rebind [324.540515] Subtest unbind-rebind: SUCCESS (6.037s) [324.578374] [056/156] (696s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [326.612071] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [327.452410] [057/156] (694s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [327.504573] Subtest writes-after-reads-uncached: SKIP (0.000s) [327.577757] [058/156] (694s left) gem_exec_params (secure-non-master) [327.623742] Starting subtest: secure-non-master [327.628288] Subtest secure-non-master: SKIP (0.000s) [327.726187] [059/156] (693s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [327.821185] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [327.825822] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [329.017431] [060/156] (692s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [329.112580] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu [329.117077] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [329.230100] [061/156] (692s left) i915_selftest (perf) [331.014782] Starting subtest: perf [331.016918] Starting dynamic subtest: engine_cs [333.827828] Dynamic subtest engine_cs: SUCCESS (2.812s) [333.838036] Starting dynamic subtest: request [341.094319] Dynamic subtest request: SUCCESS (7.264s) [341.103944] Starting dynamic subtest: migrate [345.475617] Dynamic subtest migrate: SUCCESS (4.378s) [345.491362] Starting dynamic subtest: region [351.215972] Dynamic subtest region: SUCCESS (5.738s) [351.218714] Subtest perf: SUCCESS (20.202s) [351.245625] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [351.246335] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [351.249449] [062/156] (670s left) kms_dp_link_training (non-uhbr-mst) [352.812300] Starting subtest: non-uhbr-mst [352.820792] Subtest non-uhbr-mst: SKIP (0.000s) [352.918622] [FACT kms_dp_link_training (non-uhbr-mst)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [352.919928] [FACT kms_dp_link_training (non-uhbr-mst)] new: kernel.kmod_is_loaded.i915: true [352.923810] [063/156] (668s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [353.029971] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [354.167902] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.137s) [354.289449] [064/156] (667s left) gem_exec_schedule (u-semaphore-user) [354.355527] Starting subtest: u-semaphore-user [354.413568] Subtest u-semaphore-user: SUCCESS (0.059s) [356.364731] [065/156] (665s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite) [356.468835] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite [356.472897] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [356.590394] [066/156] (665s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [356.685898] Starting subtest: fbcpsrhdr-tiling-4 [356.690090] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [356.780116] [067/156] (665s left) syncobj_timeline (signal) [356.829524] Starting subtest: signal [356.831468] Subtest signal: SUCCESS (0.000s) [356.927397] [068/156] (665s left) kms_pm_rpm (pc8-residency) [358.465397] Starting subtest: pc8-residency [358.471823] Subtest pc8-residency: SKIP (0.000s) [359.202258] [069/156] (662s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [359.302942] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [365.948323] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.650s) [366.082670] [070/156] (656s left) gem_exec_fence (syncobj-signal) [366.514827] Starting subtest: syncobj-signal [366.521397] Subtest syncobj-signal: SUCCESS (0.006s) [368.449548] [071/156] (653s left) kms_flip (nonexisting-fb-interruptible) [368.541155] Starting subtest: nonexisting-fb-interruptible [368.543446] Starting dynamic subtest: A-eDP1 [369.703649] Dynamic subtest A-eDP1: SUCCESS (1.161s) [369.714624] Starting dynamic subtest: B-eDP1 [370.836405] Dynamic subtest B-eDP1: SUCCESS (1.132s) [370.846869] Starting dynamic subtest: C-eDP1 [371.966294] Dynamic subtest C-eDP1: SUCCESS (1.129s) [371.978314] Starting dynamic subtest: D-eDP1 [373.094254] Dynamic subtest D-eDP1: SUCCESS (1.127s) [373.099723] Subtest nonexisting-fb-interruptible: SUCCESS (4.557s) [374.272899] [072/156] (647s left) kms_flip (2x-modeset-vs-vblank-race) [374.377686] Starting subtest: 2x-modeset-vs-vblank-race [374.386205] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s) [374.490137] [073/156] (647s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt) [374.591156] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt [374.595610] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [374.693536] [074/156] (647s left) kms_cursor_edge_walk (64x64-left-edge) [374.791274] Starting subtest: 64x64-left-edge [374.793478] Starting dynamic subtest: pipe-A-eDP-1 [378.237227] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s) [378.247367] Starting dynamic subtest: pipe-D-eDP-1 [381.464089] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.224s) [381.466377] Subtest 64x64-left-edge: SUCCESS (6.673s) [382.280237] [075/156] (640s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [382.382622] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [383.474737] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.092s) [383.573904] [076/156] (638s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite) [383.665253] Starting subtest: hdr-rgb101010-draw-pwrite [383.668686] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s) [383.756479] [077/156] (638s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [383.851949] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [384.654946] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s) [384.818220] [078/156] (637s left) gen3_render_tiledx_blits [384.945404] [079/156] (637s left) api_intel_bb (blit-noreloc-keep-cache) [385.001419] Starting subtest: blit-noreloc-keep-cache [385.011709] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s) [385.151023] [080/156] (637s left) kms_frontbuffer_tracking (hdr-2p-rte) [385.253451] Starting subtest: hdr-2p-rte [385.257577] Subtest hdr-2p-rte: SKIP (0.000s) [385.332390] [081/156] (637s left) kms_cursor_crc (cursor-onscreen-256x85) [385.585668] Starting subtest: cursor-onscreen-256x85 [385.638536] Subtest cursor-onscreen-256x85: SKIP (0.048s) [385.790214] [082/156] (636s left) gem_tiled_wb [385.889926] [083/156] (636s left) gem_ctx_freq (sysfs) [385.938366] Starting subtest: sysfs [385.940322] Starting dynamic subtest: gt0 [391.444223] Dynamic subtest gt0: SUCCESS (5.505s) [391.453697] Starting dynamic subtest: gt1 [433.310421] Dynamic subtest gt1: SUCCESS (41.862s) [433.312988] Subtest sysfs: SUCCESS (47.370s) [433.440940] [084/156] (589s left) i915_drm_fdinfo (busy-check-all) [433.477205] Starting subtest: busy-check-all [433.481600] Starting dynamic subtest: rcs0 [433.485973] Dynamic subtest rcs0: SKIP (0.004s) [433.495593] Starting dynamic subtest: bcs0 [433.499625] Dynamic subtest bcs0: SKIP (0.000s) [433.509615] Starting dynamic subtest: vcs0 [433.513743] Dynamic subtest vcs0: SKIP (0.000s) [433.522648] Starting dynamic subtest: vcs1 [433.526664] Dynamic subtest vcs1: SKIP (0.001s) [433.535202] Starting dynamic subtest: vecs0 [433.539226] Dynamic subtest vecs0: SKIP (0.000s) [433.547994] Starting dynamic subtest: ccs0 [433.552251] Dynamic subtest ccs0: SKIP (0.000s) [433.556508] Subtest busy-check-all: SKIP (0.013s) [433.595803] [085/156] (589s left) kms_chamelium_audio (dp-audio-edid) [434.010192] Subtest dp-audio-edid: SKIP (0.000s) [434.802155] [086/156] (587s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [434.898384] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [434.902595] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [434.969446] [087/156] (587s left) gem_userptr_blits (access-control) [435.050803] Starting subtest: access-control [435.055088] Subtest access-control: SKIP (0.000s) [435.178617] [088/156] (587s left) kms_lease (lease-unleased-connector) [435.272080] Starting subtest: lease-unleased-connector [435.274503] Starting dynamic subtest: pipe-A-eDP-1 [435.276877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [435.291034] Starting dynamic subtest: pipe-B-eDP-1 [435.293465] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [435.303744] Starting dynamic subtest: pipe-C-eDP-1 [435.306031] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [435.314634] Starting dynamic subtest: pipe-D-eDP-1 [435.316548] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [435.318469] Subtest lease-unleased-connector: SUCCESS (0.033s) [435.410081] [089/156] (587s left) gem_pxp (verify-pxp-stale-buf-execution) [435.528033] Starting subtest: verify-pxp-stale-buf-execution [436.589818] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s) [436.720704] [090/156] (586s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [436.833054] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [436.837303] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [436.920116] [091/156] (586s left) kms_vblank (ts-continuation-idle) [437.016210] Starting subtest: ts-continuation-idle [437.018090] Starting dynamic subtest: pipe-A-eDP-1 [437.413741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s) [437.427436] Starting dynamic subtest: pipe-D-eDP-1 [438.512617] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.096s) [438.514999] Subtest ts-continuation-idle: SUCCESS (1.497s) [439.387629] [092/156] (583s left) syncobj_eventfd (timeline-wait-signaled) [439.434149] Starting subtest: timeline-wait-signaled [439.436478] Subtest timeline-wait-signaled: SUCCESS (0.000s) [439.525751] [093/156] (583s left) prime_mmap (test_correct_cpu_write) [439.584139] Starting subtest: test_correct_cpu_write [439.586445] Starting dynamic subtest: test_correct_cpu_write-smem [439.588643] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [439.590736] Subtest test_correct_cpu_write: SUCCESS (0.001s) [439.702592] [094/156] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [439.792825] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [439.797067] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [439.901892] [095/156] (583s left) kms_big_fb (4-tiled-16bpp-rotate-90) [440.006709] Starting subtest: 4-tiled-16bpp-rotate-90 [440.025844] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [440.156128] [096/156] (583s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [440.244826] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [449.815650] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.575s) [449.931620] [097/156] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [450.034151] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [450.038556] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [450.130575] [098/156] (573s left) kms_setmode (basic) [450.186288] Starting subtest: basic [450.506635] Starting dynamic subtest: pipe-A-eDP-1 [452.652039] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.141s) [453.015492] Starting dynamic subtest: pipe-B-eDP-1 [455.091693] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.079s) [455.402963] Subtest basic: SUCCESS (5.216s) [456.248946] [099/156] (567s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [456.344408] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [456.348427] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [456.452265] [100/156] (566s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [456.553095] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [456.557075] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [456.649103] [101/156] (566s left) kms_content_protection (dp-mst-type-1-suspend-resume) [456.791060] Starting subtest: dp-mst-type-1-suspend-resume [456.795765] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [456.936333] [102/156] (566s left) kms_psr (psr2-primary-mmap-cpu) [457.028357] Starting subtest: psr2-primary-mmap-cpu [457.030643] Starting dynamic subtest: eDP-1 [458.751480] Dynamic subtest eDP-1: SUCCESS (1.723s) [458.754250] Subtest psr2-primary-mmap-cpu: SUCCESS (1.724s) [459.631391] [103/156] (563s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [459.740834] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [459.745159] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [459.838896] [104/156] (563s left) kms_plane_scaling (intel-max-src-size) [459.925020] Starting subtest: intel-max-src-size [459.931446] Subtest intel-max-src-size: SKIP (0.000s) [460.023888] [105/156] (563s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [460.119018] Starting subtest: fbcpsr-farfromfence-mmap-gtt [460.123239] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [460.211996] [106/156] (563s left) gem_lmem_swapping (parallel-random) [460.249623] Subtest parallel-random: SKIP (0.000s) [460.289524] [107/156] (563s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [460.389025] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [460.393288] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [460.517598] [108/156] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [460.617631] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [464.188568] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.576s) [465.426090] [109/156] (558s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [465.529335] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [465.533285] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [465.635038] [110/156] (558s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [465.740701] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [470.035615] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.301s) [471.236772] [111/156] (552s left) kms_selftest (drm_damage_helper) [471.273109] Starting subtest: drm_damage_helper [471.300509] Starting dynamic subtest: drm_test_damage_iter_no_damage [471.403217] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.103s) [471.413203] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [471.487064] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.082s) [471.496272] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [471.576324] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.087s) [471.585421] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [471.664743] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.086s) [471.675365] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [471.749368] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.084s) [471.759687] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [471.838559] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.087s) [471.849313] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [471.929265] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.090s) [471.940071] Starting dynamic subtest: drm_test_damage_iter_simple_damage [472.037142] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.107s) [472.047736] Starting dynamic subtest: drm_test_damage_iter_single_damage [472.127417] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.090s) [472.137838] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [472.217602] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.091s) [472.226517] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [472.305803] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.087s) [472.314759] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [472.395200] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.088s) [472.404048] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [472.485318] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.090s) [472.494057] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [472.572366] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.087s) [472.582770] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [472.652765] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.078s) [472.661659] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [472.744623] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.091s) [472.754667] Starting dynamic subtest: drm_test_damage_iter_damage [472.853607] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.105s) [472.862615] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [472.948246] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.094s) [472.958964] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [473.025311] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.076s) [473.036650] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [473.104761] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.077s) [473.113663] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [473.193274] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.087s) [473.194853] Subtest drm_damage_helper: SUCCESS (1.921s) [473.343880] [112/156] (550s left) kms_invalid_mode (uint-max-clock) [473.441511] Starting subtest: uint-max-clock [473.443485] Starting dynamic subtest: pipe-A-eDP-1 [473.732251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [473.743116] Starting dynamic subtest: pipe-B-eDP-1 [473.745351] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [473.754693] Starting dynamic subtest: pipe-C-eDP-1 [473.756652] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [473.772552] Starting dynamic subtest: pipe-D-eDP-1 [473.774793] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [473.777136] Subtest uint-max-clock: SUCCESS (0.295s) [474.574864] [113/156] (549s left) gem_ctx_shared (q-smoketest) [474.641023] Starting subtest: Q-smoketest [474.643419] Starting dynamic subtest: rcs0 [480.253449] Dynamic subtest rcs0: SUCCESS (5.509s) [480.264365] Starting dynamic subtest: bcs0 [485.744323] Dynamic subtest bcs0: SUCCESS (5.488s) [485.756520] Starting dynamic subtest: vcs0 [491.237679] Dynamic subtest vcs0: SUCCESS (5.498s) [491.251709] Starting dynamic subtest: vcs1 [496.735506] Dynamic subtest vcs1: SUCCESS (5.492s) [496.747386] Starting dynamic subtest: vecs0 [502.231364] Dynamic subtest vecs0: SUCCESS (5.496s) [502.242717] Starting dynamic subtest: ccs0 [507.666375] Dynamic subtest ccs0: SUCCESS (5.485s) [507.668430] Subtest Q-smoketest: SUCCESS (32.975s) [507.834198] [114/156] (516s left) gem_lmem_swapping (verify-random-ccs) [507.875251] Subtest verify-random-ccs: SKIP (0.000s) [507.915446] [115/156] (516s left) gem_exec_capture (capture-invisible) [507.975211] Starting subtest: capture-invisible [507.977524] Starting dynamic subtest: smem0 [507.981833] Dynamic subtest smem0: SKIP (0.000s) [507.986077] Subtest capture-invisible: SKIP (0.001s) [508.078381] [116/156] (515s left) gem_vm_create (execbuf) [508.140503] Starting subtest: execbuf [508.151021] Subtest execbuf: SUCCESS (0.011s) [508.270783] [117/156] (515s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [508.371046] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [508.373264] Starting dynamic subtest: pipe-A-default-mode [511.123518] Dynamic subtest pipe-A-default-mode: SUCCESS (2.752s) [511.125859] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.753s) [511.963958] [118/156] (512s left) kms_concurrent (multi-plane-atomic-lowres) [512.064399] Starting subtest: multi-plane-atomic-lowres [512.066661] Starting dynamic subtest: pipe-A-eDP-1 [512.556503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s) [512.567091] Starting dynamic subtest: pipe-B-eDP-1 [513.812933] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s) [513.823843] Starting dynamic subtest: pipe-C-eDP-1 [515.052374] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s) [515.062583] Starting dynamic subtest: pipe-D-eDP-1 [516.269931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [516.272307] Subtest multi-plane-atomic-lowres: SUCCESS (4.204s) [517.120990] [119/156] (507s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy) [517.224671] Starting subtest: fbcpsrhdr-modesetfrombusy [517.228902] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s) [517.314043] [120/156] (506s left) kms_plane_alpha_blend (alpha-transparent-fb) [517.409586] Starting subtest: alpha-transparent-fb [517.699619] Starting dynamic subtest: pipe-A-eDP-1 [518.331811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s) [518.342390] Starting dynamic subtest: pipe-D-eDP-1 [519.661923] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s) [519.664225] Subtest alpha-transparent-fb: SUCCESS (2.255s) [520.470788] [121/156] (503s left) gem_pxp (create-regular-context-1) [520.526889] Starting subtest: create-regular-context-1 [520.529388] Subtest create-regular-context-1: SUCCESS (0.001s) [520.619805] [122/156] (503s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [520.723203] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [520.727203] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [520.816060] [123/156] (503s left) gem_exec_reloc (basic-cpu-active) [520.876078] Subtest basic-cpu-active: SKIP (0.000s) [520.951663] [124/156] (503s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [521.053034] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [521.057380] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [522.208188] [125/156] (502s left) gem_exec_suspend (basic-s3) [522.258743] Starting subtest: basic-S3 [522.261074] Starting dynamic subtest: smem [543.118266] Dynamic subtest smem: SUCCESS (8.074s) [543.120842] Subtest basic-S3: SUCCESS (8.076s) [552.389198] [126/156] (481s left) kms_hdr (brightness-with-hdr) [552.500526] Starting subtest: brightness-with-hdr [552.502929] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [552.507399] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [552.520228] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [552.524278] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [552.528845] Subtest brightness-with-hdr: SKIP (0.003s) [552.586872] [127/156] (480s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [552.647113] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [552.651286] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [552.852277] [128/156] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [552.948320] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [552.952461] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [553.045610] [129/156] (480s left) perf_pmu (most-busy-idle-check-all) [553.088847] Starting subtest: most-busy-idle-check-all [553.090696] Starting dynamic subtest: rcs0 [553.790009] Dynamic subtest rcs0: FAIL (0.626s) [553.802067] Starting dynamic subtest: bcs0 [555.086769] Dynamic subtest bcs0: SUCCESS (1.367s) [555.099848] Starting dynamic subtest: vcs0 [557.134259] Dynamic subtest vcs0: SUCCESS (2.042s) [557.147342] Starting dynamic subtest: vcs1 [559.118560] Dynamic subtest vcs1: SUCCESS (1.979s) [559.131750] Starting dynamic subtest: vecs0 [561.102575] Dynamic subtest vecs0: SUCCESS (1.980s) [561.118261] Starting dynamic subtest: ccs0 [563.086287] Dynamic subtest ccs0: SUCCESS (1.980s) [563.088879] Subtest most-busy-idle-check-all: FAIL (9.989s) [563.182419] [130/156] (470s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [563.294436] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [563.298817] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [563.388494] [131/156] (470s left) gem_eio (wait-1us) [563.576028] Starting subtest: wait-1us [563.859637] Subtest wait-1us: SUCCESS (0.286s) [563.977419] [132/156] (469s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [564.080454] Starting subtest: yf-tiled-64bpp-rotate-90 [564.084687] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [564.164683] [133/156] (469s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move) [564.262832] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move [564.266213] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [564.368802] [134/156] (469s left) api_intel_bb (offset-control) [564.427802] Starting subtest: offset-control [564.435871] Subtest offset-control: SUCCESS (0.009s) [564.546600] [135/156] (469s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [564.638554] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [564.642052] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [564.734852] [136/156] (469s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt) [564.842483] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt [564.845870] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [564.928200] [137/156] (469s left) fbdev (unaligned-read) [564.965357] Starting subtest: unaligned-read [564.980905] Subtest unaligned-read: SUCCESS (0.016s) [565.036814] [138/156] (469s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [565.134722] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt [565.137981] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [565.224113] [139/156] (468s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [565.318799] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [565.322349] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [565.394315] [140/156] (468s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [565.499887] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [565.503691] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [565.589378] [141/156] (468s left) kms_psr (fbc-psr-sprite-mmap-cpu) [565.676132] Starting subtest: fbc-psr-sprite-mmap-cpu [565.678061] Starting dynamic subtest: eDP-1 [565.681443] Dynamic subtest eDP-1: SKIP (0.000s) [565.684807] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [565.753899] [142/156] (468s left) gem_exec_reloc (basic-cpu-wc-active) [565.818681] Subtest basic-cpu-wc-active: SKIP (0.000s) [565.910750] [143/156] (468s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [566.032283] Starting subtest: basic-busy-flip-before-cursor-atomic [566.035885] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [566.188389] [144/156] (468s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render) [566.285065] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render [566.288461] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [566.399943] [145/156] (467s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt) [566.509992] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt [566.513519] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [566.610270] [146/156] (467s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [566.730695] Starting subtest: basic-flip-after-cursor-legacy [567.647726] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s) [568.459613] [147/156] (465s left) i915_pm_rpm (gem-execbuf-stress-pc8) [570.295691] Starting subtest: gem-execbuf-stress-pc8 [570.332498] Subtest gem-execbuf-stress-pc8: SKIP (0.038s) [570.718008] [148/156] (463s left) gem_exec_params (invalid-bsd2-flag-on-blt) [570.766993] Starting subtest: invalid-bsd2-flag-on-blt [570.769471] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [570.872119] [149/156] (463s left) kms_color (ctm-0-25) [570.962483] Starting subtest: ctm-0-25 [570.964620] Starting dynamic subtest: pipe-A-eDP-1 [574.517267] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.553s) [574.533813] Starting dynamic subtest: pipe-B-eDP-1 [578.839151] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.321s) [578.850455] Starting dynamic subtest: pipe-C-eDP-1 [582.878659] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.040s) [582.889795] Starting dynamic subtest: pipe-D-eDP-1 [586.881861] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.002s) [586.884235] Subtest ctm-0-25: SUCCESS (15.919s) [587.717301] [150/156] (446s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [587.822696] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [587.826940] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [587.927629] [151/156] (446s left) kms_pm_backlight (fade) [588.026726] Starting subtest: fade [588.077901] Starting dynamic subtest: eDP-1 [591.062086] Dynamic subtest eDP-1: SUCCESS (2.986s) [591.064576] Subtest fade: SUCCESS (3.037s) [591.943781] [152/156] (442s left) gem_mmap_gtt (basic-copy) [592.005928] Subtest basic-copy: SKIP (0.000s) [592.063568] [153/156] (442s left) syncobj_timeline (etime-single-wait-all-submitted) [592.117992] Starting subtest: etime-single-wait-all-submitted [592.226013] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s) [592.318345] [154/156] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [592.424286] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [592.428607] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [592.534783] [155/156] (442s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [592.647893] Starting subtest: cursorB-vs-flipA-toggle [592.652505] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [592.793906] [156/156] (442s left) i915_query (query-topology-known-pci-ids) [592.848851] Starting subtest: query-topology-known-pci-ids [592.853079] Subtest query-topology-known-pci-ids: SKIP (0.000s) [592.951984] Closing watchdogs results: parsing output: 0/ for test: prime_mmap_kms results: parsing output: 1/ for test: gem_exec_reloc results: parsing output: 2/ for test: perf results: parsing output: 3/ for test: gem_ccs results: parsing output: 4/ for test: kms_feature_discovery results: parsing output: 5/ for test: kms_psr2_sf results: parsing output: 6/ for test: kms_plane results: parsing output: 7/ for test: gem_spin_batch results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_ctx_param results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_exec_balancer results: parsing output: 14/ for test: kms_atomic_interruptible results: parsing output: 15/ for test: kms_cursor_legacy results: parsing output: 16/ for test: perf results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: kms_pipe_crc_basic results: parsing output: 19/ for test: kms_async_flips results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_vblank results: parsing output: 22/ for test: gem_userptr_blits results: parsing output: 23/ for test: kms_ccs results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: gem_exec_whisper results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_async_flips results: parsing output: 30/ for test: gem_partial_pwrite_pread results: parsing output: 31/ for test: gem_mmap_gtt results: parsing output: 32/ for test: sysfs_timeslice_duration results: parsing output: 33/ for test: kms_pm_rpm results: parsing output: 34/ for test: gen9_exec_parse results: parsing output: 35/ for test: gem_exec_flush results: parsing output: 36/ for test: gem_ctx_persistence results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: sriov_basic results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: gem_exec_params results: parsing output: 46/ for test: kms_cursor_legacy results: parsing output: 47/ for test: i915_getparams_basic results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: kms_cursor_crc results: parsing output: 53/ for test: gem_exec_fence results: parsing output: 54/ for test: core_hotunplug results: parsing output: 55/ for test: kms_chamelium_edid results: parsing output: 56/ for test: gem_partial_pwrite_pread results: parsing output: 57/ for test: gem_exec_params results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: i915_selftest results: parsing output: 61/ for test: kms_dp_link_training results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: gem_exec_schedule results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_pm_rpm results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_exec_fence results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_flip results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_cursor_edge_walk results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: gen3_render_tiledx_blits results: parsing output: 78/ for test: api_intel_bb results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: gem_tiled_wb results: parsing output: 82/ for test: gem_ctx_freq results: parsing output: 83/ for test: i915_drm_fdinfo results: parsing output: 84/ for test: kms_chamelium_audio results: parsing output: 85/ for test: kms_plane results: parsing output: 86/ for test: gem_userptr_blits results: parsing output: 87/ for test: kms_lease results: parsing output: 88/ for test: gem_pxp results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_vblank results: parsing output: 91/ for test: syncobj_eventfd results: parsing output: 92/ for test: prime_mmap results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_setmode results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_content_protection results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_plane_scaling results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_lmem_swapping 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_big_fb results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_selftest results: parsing output: 111/ for test: kms_invalid_mode results: parsing output: 112/ for test: gem_ctx_shared results: parsing output: 113/ for test: gem_lmem_swapping results: parsing output: 114/ for test: gem_exec_capture results: parsing output: 115/ for test: gem_vm_create results: parsing output: 116/ for test: kms_flip_scaled_crc results: parsing output: 117/ for test: kms_concurrent results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_plane_alpha_blend results: parsing output: 120/ for test: gem_pxp results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_exec_reloc results: parsing output: 123/ for test: kms_ccs results: parsing output: 124/ for test: gem_exec_suspend results: parsing output: 125/ for test: kms_hdr results: parsing output: 126/ for test: gem_render_copy results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: perf_pmu results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_eio results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: api_intel_bb results: parsing output: 134/ for test: kms_big_fb results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: fbdev results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_psr2_sf results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_psr results: parsing output: 141/ for test: gem_exec_reloc results: parsing output: 142/ for test: kms_cursor_legacy results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_cursor_legacy results: parsing output: 146/ for test: i915_pm_rpm results: parsing output: 147/ for test: gem_exec_params results: parsing output: 148/ for test: kms_color results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_pm_backlight results: parsing output: 151/ for test: gem_mmap_gtt results: parsing output: 152/ for test: syncobj_timeline results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_cursor_legacy results: parsing output: 155/ for test: i915_query Done.