[55.761962] Initializing watchdogs [55.762015] /dev/watchdog0 [55.774917] [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] [55.779670] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.781828] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.785223] [001/129] (960s left) kms_flip (flip-vs-suspend-interruptible) [55.947779] Starting subtest: flip-vs-suspend-interruptible [55.950159] Starting dynamic subtest: A-eDP1 [105.255413] Dynamic subtest A-eDP1: SUCCESS (4.414s) [105.267167] Starting dynamic subtest: B-eDP1 [154.258363] Dynamic subtest B-eDP1: SUCCESS (4.276s) [154.266201] Starting dynamic subtest: C-eDP1 [203.268284] Dynamic subtest C-eDP1: SUCCESS (4.299s) [203.275744] Starting dynamic subtest: D-eDP1 [252.267101] Dynamic subtest D-eDP1: SUCCESS (4.683s) [252.269798] Subtest flip-vs-suspend-interruptible: SUCCESS (17.679s) [253.491838] [002/129] (941s left) syncobj_eventfd (invalid-illegal-eventfd) [253.539805] Starting subtest: invalid-illegal-eventfd [253.542276] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [253.638183] [003/129] (941s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [253.764909] Starting subtest: short-flip-before-cursor-atomic-transitions [254.736014] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.971s) [255.520476] [004/129] (939s left) kms_plane_cursor (viewport) [255.616433] Starting subtest: viewport [255.620935] Starting dynamic subtest: pipe-A-eDP-1-size-64 [258.497477] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.878s) [258.555872] Starting dynamic subtest: pipe-A-eDP-1-size-128 [261.432507] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.882s) [261.492233] Starting dynamic subtest: pipe-A-eDP-1-size-256 [264.366006] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.882s) [264.711927] Starting dynamic subtest: pipe-B-eDP-1-size-64 [268.254009] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.549s) [268.312448] Starting dynamic subtest: pipe-B-eDP-1-size-128 [271.131863] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.826s) [271.192969] Starting dynamic subtest: pipe-B-eDP-1-size-256 [274.046236] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.859s) [274.391462] Starting dynamic subtest: pipe-C-eDP-1-size-64 [277.481493] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.101s) [277.518815] Starting dynamic subtest: pipe-C-eDP-1-size-128 [279.960728] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.446s) [279.996590] Starting dynamic subtest: pipe-C-eDP-1-size-256 [282.516650] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.524s) [282.841260] Starting dynamic subtest: pipe-D-eDP-1-size-64 [286.053688] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.220s) [286.089696] Starting dynamic subtest: pipe-D-eDP-1-size-128 [288.575891] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.491s) [288.611482] Starting dynamic subtest: pipe-D-eDP-1-size-256 [291.098962] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.491s) [291.415204] Subtest viewport: SUCCESS (35.792s) [292.223474] [005/129] (902s left) gem_exec_reloc (basic-gtt-noreloc) [292.291406] Subtest basic-gtt-noreloc: SKIP (0.000s) [292.346332] [006/129] (902s left) kms_cursor_crc (cursor-random-128x128) [292.545121] Starting subtest: cursor-random-128x128 [292.549918] Starting dynamic subtest: pipe-A-eDP-1 [296.214817] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.664s) [296.245294] Starting dynamic subtest: pipe-D-eDP-1 [300.614128] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.374s) [300.616609] Subtest cursor-random-128x128: SUCCESS (8.066s) [301.473979] [007/129] (893s left) gem_mmap_gtt (basic-write-gtt) [301.538919] Subtest basic-write-gtt: SKIP (0.000s) [301.609520] [008/129] (893s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [301.723402] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [301.727770] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [301.833264] [009/129] (893s left) vgem_basic (sysfs) [301.904898] Starting subtest: sysfs [301.907354] Subtest sysfs: SUCCESS (0.001s) [301.950761] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true [301.954149] [010/129] (893s left) kms_lease (multimaster-lease) [302.045783] Starting subtest: multimaster-lease [302.050947] Subtest multimaster-lease: SUCCESS (0.004s) [302.149911] [011/129] (893s left) api_intel_bb (purge-bb) [302.219399] Starting subtest: purge-bb [302.222028] Subtest purge-bb: SUCCESS (0.004s) [302.353843] [012/129] (892s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [302.459048] Starting subtest: psr-1p-pri-indfb-multidraw [322.466497] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (20.007s) [322.584148] [013/129] (872s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [322.687394] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [322.689295] Starting dynamic subtest: pipe-A [322.761923] Dynamic subtest pipe-A: SUCCESS (0.075s) [322.771204] Starting dynamic subtest: pipe-B [323.867244] Dynamic subtest pipe-B: SUCCESS (1.103s) [323.877010] Starting dynamic subtest: pipe-C [324.970890] Dynamic subtest pipe-C: SUCCESS (1.103s) [324.979044] Starting dynamic subtest: pipe-D [326.091606] Dynamic subtest pipe-D: SUCCESS (1.120s) [326.093993] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.404s) [327.234906] [014/129] (868s left) gem_mmap_wc (set-cache-level) [327.302079] Subtest set-cache-level: SKIP (0.000s) [327.372280] [015/129] (868s left) gem_ctx_persistence (many-contexts) [327.439112] Starting subtest: many-contexts [365.160768] Subtest many-contexts: SUCCESS (37.719s) [365.233973] [016/129] (830s left) kms_flip (wf_vblank-ts-check-interruptible) [365.340333] Starting subtest: wf_vblank-ts-check-interruptible [365.342585] Starting dynamic subtest: A-eDP1 [374.273951] Dynamic subtest A-eDP1: SUCCESS (8.931s) [374.281618] Starting dynamic subtest: B-eDP1 [383.196392] Dynamic subtest B-eDP1: SUCCESS (8.921s) [383.206399] Starting dynamic subtest: C-eDP1 [392.105728] Dynamic subtest C-eDP1: SUCCESS (8.908s) [392.114208] Starting dynamic subtest: D-eDP1 [401.025544] Dynamic subtest D-eDP1: SUCCESS (8.917s) [401.030903] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.687s) [402.241724] [017/129] (793s left) kms_plane (plane-panning-bottom-right-suspend) [402.332725] Starting subtest: plane-panning-bottom-right-suspend [402.335125] Starting dynamic subtest: pipe-A [419.693704] Dynamic subtest pipe-A: SUCCESS (2.775s) [419.702395] Starting dynamic subtest: pipe-B [437.647596] Dynamic subtest pipe-B: SUCCESS (3.328s) [437.650326] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.105s) [438.487360] [018/129] (786s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [438.539146] Starting subtest: multi-wait-for-submit-submitted-signaled [438.541789] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [438.643835] [019/129] (786s left) kms_flip (2x-plain-flip-ts-check) [438.744347] Starting subtest: 2x-plain-flip-ts-check [438.755839] Subtest 2x-plain-flip-ts-check: SKIP (0.011s) [438.832709] [020/129] (785s left) gem_exec_reloc (basic-wc-cpu-active) [438.905227] Subtest basic-wc-cpu-active: SKIP (0.000s) [438.967585] [021/129] (785s left) gem_ctx_isolation (preservation-s3) [439.031460] Starting subtest: preservation-S3 [439.034058] Starting dynamic subtest: rcs0 [455.335210] Dynamic subtest rcs0: SUCCESS (1.352s) [455.344041] Starting dynamic subtest: bcs0 [471.351505] Dynamic subtest bcs0: SUCCESS (1.402s) [471.360511] Starting dynamic subtest: vcs0 [487.335512] Dynamic subtest vcs0: SUCCESS (3.022s) [487.344058] Starting dynamic subtest: vcs1 [505.409520] Dynamic subtest vcs1: SUCCESS (5.079s) [505.417133] Starting dynamic subtest: vecs0 [523.418016] Dynamic subtest vecs0: SUCCESS (5.001s) [523.426967] Starting dynamic subtest: ccs0 [541.358937] Dynamic subtest ccs0: SUCCESS (3.131s) [541.361928] Subtest preservation-S3: SUCCESS (18.993s) [541.610354] [022/129] (766s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [541.731754] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [542.709520] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.979s) [542.838258] [023/129] (765s left) prime_busy (before) [542.900282] Starting subtest: before [542.905261] Starting dynamic subtest: rcs0 [542.940324] Dynamic subtest rcs0: SUCCESS (0.035s) [542.948574] Starting dynamic subtest: bcs0 [542.991369] Dynamic subtest bcs0: SUCCESS (0.050s) [542.999562] Starting dynamic subtest: vcs0 [543.030669] Dynamic subtest vcs0: SUCCESS (0.039s) [543.037873] Starting dynamic subtest: vcs1 [543.070957] Dynamic subtest vcs1: SUCCESS (0.040s) [543.078434] Starting dynamic subtest: vecs0 [543.112268] Dynamic subtest vecs0: SUCCESS (0.041s) [543.120262] Starting dynamic subtest: ccs0 [543.153699] Dynamic subtest ccs0: SUCCESS (0.040s) [543.262572] Subtest before: SUCCESS (0.360s) [543.333467] [024/129] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [543.441975] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [543.446530] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [543.540814] [025/129] (764s left) perf (enable-disable) [543.647986] Starting subtest: enable-disable [543.650351] Starting dynamic subtest: 0-rcs0 [545.940184] Dynamic subtest 0-rcs0: SUCCESS (2.288s) [545.950199] Starting dynamic subtest: 1-vecs0 [550.473515] Dynamic subtest 1-vecs0: SUCCESS (4.527s) [550.476032] Subtest enable-disable: SUCCESS (6.817s) [550.514279] [026/129] (757s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [550.627919] Starting subtest: psr-farfromfence-mmap-gtt [550.632101] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [550.707931] [027/129] (757s left) kms_joiner (invalid-modeset-ultra-joiner) [550.806070] Starting subtest: invalid-modeset-ultra-joiner [550.810213] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [550.864553] [028/129] (757s left) gem_ctx_isolation (nonpriv) [550.932728] Starting subtest: nonpriv [550.935174] Starting dynamic subtest: rcs0 [551.457094] Dynamic subtest rcs0: SUCCESS (0.523s) [551.464791] Starting dynamic subtest: bcs0 [552.046487] Dynamic subtest bcs0: SUCCESS (0.589s) [552.054230] Starting dynamic subtest: vcs0 [552.585760] Dynamic subtest vcs0: SUCCESS (0.538s) [552.595995] Starting dynamic subtest: vcs1 [554.654206] Dynamic subtest vcs1: SUCCESS (2.066s) [554.661831] Starting dynamic subtest: vecs0 [556.646757] Dynamic subtest vecs0: SUCCESS (1.990s) [556.657023] Starting dynamic subtest: ccs0 [558.653184] Dynamic subtest ccs0: SUCCESS (2.004s) [558.656018] Subtest nonpriv: SUCCESS (7.715s) [558.888162] [029/129] (749s left) gem_spin_batch (spin-all) [558.954045] Starting subtest: spin-all [558.973510] Subtest spin-all: SUCCESS (0.018s) [560.077047] [030/129] (748s left) kms_content_protection (dp-mst-type-1) [560.246425] Starting subtest: dp-mst-type-1 [560.251155] Subtest dp-mst-type-1: SKIP (0.000s) [560.388864] [031/129] (748s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [560.487424] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [560.489705] Starting dynamic subtest: pipe-A-eDP-1 [560.546265] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [560.553745] Starting dynamic subtest: pipe-B-eDP-1 [560.611659] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [560.620512] Starting dynamic subtest: pipe-C-eDP-1 [560.677698] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [560.685345] Starting dynamic subtest: pipe-D-eDP-1 [560.741071] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [560.745341] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s) [562.639104] [032/129] (745s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [562.748578] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [562.752857] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [562.852608] [033/129] (745s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [562.962726] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [564.208567] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.244s) [564.357759] [034/129] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [564.466002] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [564.469409] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [564.565903] [035/129] (744s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [564.658986] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [564.660900] Starting dynamic subtest: pipe-A-eDP-1 [564.681796] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [564.689908] Starting dynamic subtest: pipe-B-eDP-1 [564.708032] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [564.715582] Starting dynamic subtest: pipe-C-eDP-1 [564.734236] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [564.743185] Starting dynamic subtest: pipe-D-eDP-1 [564.761550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [564.764958] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s) [566.801122] [036/129] (741s left) gem_exec_schedule (thriceslice) [566.870383] Starting subtest: thriceslice [566.872757] Starting dynamic subtest: rcs0 [566.892445] Dynamic subtest rcs0: SUCCESS (0.031s) [566.900219] Starting dynamic subtest: bcs0 [566.944279] Dynamic subtest bcs0: SUCCESS (0.049s) [566.954919] Starting dynamic subtest: vcs0 [566.973088] Dynamic subtest vcs0: SUCCESS (0.028s) [566.981354] Starting dynamic subtest: vcs1 [567.023341] Dynamic subtest vcs1: SUCCESS (0.049s) [567.033030] Starting dynamic subtest: vecs0 [567.056429] Dynamic subtest vecs0: SUCCESS (0.031s) [567.063908] Starting dynamic subtest: ccs0 [567.087389] Dynamic subtest ccs0: SUCCESS (0.030s) [567.089713] Subtest thriceslice: SUCCESS (0.227s) [567.383894] [037/129] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [567.492925] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [572.885048] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.393s) [573.009035] [038/129] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [573.111791] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [577.754701] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.644s) [577.864034] [039/129] (730s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [577.969616] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [583.195256] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.225s) [583.312788] [040/129] (725s left) gem_exec_fence (syncobj-import) [583.764112] Starting subtest: syncobj-import [583.770069] Subtest syncobj-import: SUCCESS (0.006s) [585.143154] [041/129] (723s left) gem_mmap_gtt (basic-small-copy-xy) [585.216323] Subtest basic-small-copy-XY: SKIP (0.000s) [585.288714] [042/129] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [585.398901] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [585.403349] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [585.514880] [043/129] (723s left) gem_partial_pwrite_pread (write) [585.589827] Subtest write: SKIP (0.000s) [585.675701] [044/129] (723s left) kms_pm_dc (dc6-dpms) [586.780175] Starting subtest: dc6-dpms [593.767901] Subtest dc6-dpms: FAIL (6.647s) [593.801555] [045/129] (715s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [593.906915] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [593.911206] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [594.011893] [046/129] (715s left) kms_concurrent (multi-plane-atomic-lowres) [594.119446] Starting subtest: multi-plane-atomic-lowres [594.121323] Starting dynamic subtest: pipe-A-eDP-1 [594.628604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s) [594.631050] Subtest multi-plane-atomic-lowres: SUCCESS (0.510s) [595.458882] [047/129] (713s left) gem_mmap_wc (pf-nonblock) [595.519339] Subtest pf-nonblock: SKIP (0.000s) [595.580635] [048/129] (713s left) gem_exec_params (invalid-flag) [595.623697] Starting subtest: invalid-flag [595.625979] Subtest invalid-flag: SUCCESS (0.000s) [595.733927] [049/129] (713s left) vgem_basic (mmap) [595.782618] Starting subtest: mmap [595.788070] Subtest mmap: SUCCESS (0.007s) [595.834550] [050/129] (713s left) gem_ctx_sseu (invalid-args) [595.895094] Subtest invalid-args: SKIP (0.000s) [595.967715] [051/129] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [596.079686] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [596.083692] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [596.174027] [052/129] (713s left) syncobj_timeline (wait-zero-handles) [596.237969] Starting subtest: wait-zero-handles [596.239873] Subtest wait-zero-handles: SUCCESS (0.000s) [596.348164] [053/129] (712s left) i915_hangman (gt-error-state-capture) [596.416761] Starting subtest: gt-error-state-capture [596.418387] Starting dynamic subtest: rcs0 [608.009800] Dynamic subtest rcs0: SUCCESS (11.585s) [608.020218] Starting dynamic subtest: bcs0 [619.015784] Dynamic subtest bcs0: SUCCESS (10.998s) [619.026968] Starting dynamic subtest: vcs0 [630.984626] Dynamic subtest vcs0: SUCCESS (11.960s) [630.995887] Starting dynamic subtest: vcs1 [641.992540] Dynamic subtest vcs1: SUCCESS (11.008s) [642.003613] Starting dynamic subtest: vecs0 [653.960757] Dynamic subtest vecs0: SUCCESS (11.975s) [653.972325] Starting dynamic subtest: ccs0 [665.031957] Dynamic subtest ccs0: SUCCESS (11.073s) [665.034620] Subtest gt-error-state-capture: SUCCESS (68.614s) [665.151812] [054/129] (644s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [665.254386] Starting subtest: psr-1p-primscrn-spr-indfb-move [670.552232] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.303s) [670.670330] [055/129] (638s left) kms_psr (fbc-psr2-cursor-plane-onoff) [670.760325] Starting subtest: fbc-psr2-cursor-plane-onoff [670.762627] Starting dynamic subtest: eDP-1 [670.767053] Dynamic subtest eDP-1: SKIP (0.000s) [670.771608] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [670.828893] [056/129] (638s left) gem_eio (throttle) [671.023072] Starting subtest: throttle [671.267993] Subtest throttle: SUCCESS (0.242s) [671.413048] [057/129] (638s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [671.514142] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [671.516123] Starting dynamic subtest: pipe-A-default-mode [671.805066] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [671.809696] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.286s) [672.637916] [058/129] (636s left) fbdev (write) [672.684056] Starting subtest: write [673.050751] Subtest write: SUCCESS (0.365s) [673.110001] [059/129] (636s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [678.086577] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [678.088979] Starting dynamic subtest: pipe-A-eDP-1 [678.876246] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s) [678.885059] Starting dynamic subtest: pipe-B-eDP-1 [679.997595] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s) [680.002250] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.910s) [681.170826] [060/129] (628s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [681.303834] Starting subtest: cursorB-vs-flipA-legacy [681.308259] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [681.433022] [061/129] (628s left) kms_psr (psr-sprite-plane-move) [681.533581] Starting subtest: psr-sprite-plane-move [681.535802] Starting dynamic subtest: eDP-1 [683.310356] Dynamic subtest eDP-1: SUCCESS (1.774s) [683.312823] Subtest psr-sprite-plane-move: SUCCESS (1.775s) [684.120530] [062/129] (625s left) kms_vblank (wait-forked-hang) [684.225078] Starting subtest: wait-forked-hang [684.227371] Starting dynamic subtest: pipe-A-eDP-1 [686.080958] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.852s) [686.094484] Starting dynamic subtest: pipe-D-eDP-1 [688.657362] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s) [688.659341] Subtest wait-forked-hang: SUCCESS (4.429s) [689.464689] [063/129] (620s left) i915_suspend (basic-s2idle-without-i915) [689.500899] Starting subtest: basic-s2idle-without-i915 [710.584617] Subtest basic-s2idle-without-i915: SUCCESS (5.642s) [710.707715] [064/129] (614s left) kms_addfb_basic (bad-pitch-128) [710.771984] Starting subtest: bad-pitch-128 [710.774552] Subtest bad-pitch-128: SUCCESS (0.000s) [710.923429] [065/129] (614s left) gem_exec_whisper (basic-queues-priority-all) [710.995803] Starting subtest: basic-queues-priority-all [732.702316] Subtest basic-queues-priority-all: SUCCESS (21.679s) [732.884971] [066/129] (592s left) gem_exec_balancer (noheartbeat) [733.141472] Starting subtest: noheartbeat [733.146869] Subtest noheartbeat: SKIP (0.000s) [733.255299] [067/129] (592s left) gen9_exec_parse (cmd-crossing-page) [733.329891] Subtest cmd-crossing-page: SKIP (0.000s) [733.408667] [068/129] (591s left) syncobj_wait (reset-signaled) [733.459881] Starting subtest: reset-signaled [733.462618] Subtest reset-signaled: SUCCESS (0.000s) [733.562176] [069/129] (591s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [733.624090] Subtest writes-after-reads-snoop: SKIP (0.000s) [733.713360] [070/129] (591s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [733.818104] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [733.829457] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [733.903646] [071/129] (591s left) syncobj_wait (invalid-reset-illegal-handle) [733.969031] Starting subtest: invalid-reset-illegal-handle [733.971941] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [734.058263] [072/129] (591s left) gem_tiling_max_stride [734.179553] [073/129] (591s left) gem_exec_schedule (preempt-user) [734.258875] Starting subtest: preempt-user [734.260814] Starting dynamic subtest: rcs0 [734.280774] Dynamic subtest rcs0: SUCCESS (0.027s) [734.291691] Starting dynamic subtest: bcs0 [734.301505] Dynamic subtest bcs0: SUCCESS (0.021s) [734.309960] Starting dynamic subtest: vcs0 [734.327604] Dynamic subtest vcs0: SUCCESS (0.025s) [734.336238] Starting dynamic subtest: vcs1 [734.344791] Dynamic subtest vcs1: SUCCESS (0.016s) [734.354180] Starting dynamic subtest: vecs0 [734.362879] Dynamic subtest vecs0: SUCCESS (0.018s) [734.371785] Starting dynamic subtest: ccs0 [734.383479] Dynamic subtest ccs0: SUCCESS (0.020s) [734.385689] Subtest preempt-user: SUCCESS (0.130s) [735.565956] [074/129] (589s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [735.632896] Starting subtest: etime-multi-wait-for-submit-submitted [735.737509] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s) [735.810058] [075/129] (589s left) kms_psr (psr2-no-drrs) [735.913739] Starting subtest: psr2-no-drrs [735.916348] Starting dynamic subtest: eDP-1 [737.573980] Dynamic subtest eDP-1: SUCCESS (1.661s) [737.576828] Subtest psr2-no-drrs: SUCCESS (1.662s) [738.360393] [076/129] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [738.472075] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [738.477198] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [738.571547] [077/129] (587s left) syncobj_timeline (multi-wait-available-submitted-signaled) [738.630600] Starting subtest: multi-wait-available-submitted-signaled [738.633206] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [738.738553] [078/129] (586s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [738.863167] Starting subtest: 2x-long-flip-vs-cursor-atomic [738.868801] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [738.996224] [079/129] (586s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [744.030074] Starting subtest: psr2-primary-plane-update-sf-dmg-area [744.032889] Starting dynamic subtest: pipe-A-eDP-1 [750.632979] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.601s) [750.642257] Starting dynamic subtest: pipe-B-eDP-1 [757.269152] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.636s) [757.271868] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.242s) [758.133329] [080/129] (567s left) gem_userptr_blits (coherency-unsync) [758.222695] Subtest coherency-unsync: SKIP (0.000s) [758.353405] [081/129] (567s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [758.444916] Starting subtest: drrs-dirtyfb-ioctl [758.460157] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [758.556160] [082/129] (567s left) kms_atomic (plane-overlay-legacy) [758.658977] Starting subtest: plane-overlay-legacy [758.661797] Starting dynamic subtest: pipe-A-eDP-1 [759.082767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s) [759.085463] Subtest plane-overlay-legacy: SUCCESS (0.422s) [759.862262] [083/129] (566s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [759.921849] Starting subtest: multi-wait-all-for-submit-submitted-signaled [760.025473] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s) [760.111256] [084/129] (565s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [760.205895] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [760.208440] Starting dynamic subtest: pipe-A-eDP-1 [760.233958] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [760.243207] Starting dynamic subtest: pipe-B-eDP-1 [760.270003] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [760.278670] Starting dynamic subtest: pipe-C-eDP-1 [760.305183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [760.315160] Starting dynamic subtest: pipe-D-eDP-1 [760.341401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [760.346120] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [762.308732] [085/129] (563s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [762.372312] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [762.436194] [086/129] (563s left) syncobj_wait (multi-wait-all-submitted) [762.495205] Starting subtest: multi-wait-all-submitted [762.601196] Subtest multi-wait-all-submitted: SUCCESS (0.107s) [762.676524] [087/129] (563s left) kms_addfb_basic (legacy-format) [762.727897] Starting subtest: legacy-format [762.748750] Subtest legacy-format: SUCCESS (0.020s) [762.884492] [088/129] (563s left) gem_lmem_swapping (smem-oom) [762.934822] Subtest smem-oom: SKIP (0.000s) [762.981467] [089/129] (563s left) gem_softpin (allocator-nopin-reserve) [763.041836] Starting subtest: allocator-nopin-reserve [763.117898] Subtest allocator-nopin-reserve: SUCCESS (0.076s) [763.243095] [090/129] (562s left) kms_flip (2x-flip-vs-wf_vblank) [763.344920] Starting subtest: 2x-flip-vs-wf_vblank [763.356014] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s) [763.431329] [091/129] (562s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [763.536900] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [763.542010] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [763.648558] [092/129] (562s left) api_intel_bb (intel-bb-blit-x) [763.707123] Starting subtest: intel-bb-blit-x [767.264499] Subtest intel-bb-blit-x: SUCCESS (3.556s) [767.393011] [093/129] (558s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [767.500041] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [767.504997] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [767.593523] [094/129] (558s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [767.704031] Starting subtest: yf-tiled-64bpp-rotate-180 [767.709728] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [767.809919] [095/129] (558s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [767.939853] Starting subtest: basic-flip-after-cursor-atomic [768.856003] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s) [769.645212] [096/129] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [769.760376] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [774.415219] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.658s) [774.561360] [097/129] (551s left) kms_pm_rpm (fences) [776.710333] Starting subtest: fences [776.716917] Subtest fences: SKIP (0.000s) [777.081581] [098/129] (549s left) gem_exec_reloc (basic-write-gtt) [777.147095] Subtest basic-write-gtt: SKIP (0.000s) [777.216751] [099/129] (549s left) gem_pxp (regular-baseline-src-copy-readible) [777.337122] Starting subtest: regular-baseline-src-copy-readible [777.394206] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s) [777.533312] [100/129] (548s left) gem_exec_schedule (implicit-write-read) [777.606912] Starting subtest: implicit-write-read [777.609599] Starting dynamic subtest: rcs0 [777.705874] Dynamic subtest rcs0: SUCCESS (0.113s) [777.718266] Starting dynamic subtest: vcs0 [777.779517] Dynamic subtest vcs0: SUCCESS (0.073s) [777.791749] Starting dynamic subtest: vcs1 [777.850090] Dynamic subtest vcs1: SUCCESS (0.070s) [777.863175] Starting dynamic subtest: vecs0 [777.927929] Dynamic subtest vecs0: SUCCESS (0.077s) [777.937970] Starting dynamic subtest: ccs0 [778.001919] Dynamic subtest ccs0: SUCCESS (0.073s) [778.004968] Subtest implicit-write-read: SUCCESS (0.409s) [779.636671] [101/129] (546s left) dmabuf_sync_file (import-basic) [779.695429] Starting subtest: import-basic [779.697902] Subtest import-basic: SUCCESS (0.002s) [779.773526] [102/129] (546s left) kms_prop_blob (blob-multiple) [779.836513] Starting subtest: blob-multiple [779.838991] Subtest blob-multiple: SUCCESS (0.002s) [779.928490] [103/129] (546s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [779.993930] Starting subtest: mixed-tiled-to-yf-tiled-ccs [779.998502] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [780.176479] [104/129] (546s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [780.264681] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [780.267211] Starting dynamic subtest: pipe-A-eDP-1 [780.293887] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [780.308189] Starting dynamic subtest: pipe-B-eDP-1 [780.334840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [780.348057] Starting dynamic subtest: pipe-C-eDP-1 [780.376646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [780.386832] Starting dynamic subtest: pipe-D-eDP-1 [780.412960] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [780.418090] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s) [782.419493] [105/129] (544s left) syncobj_timeline (etime-single-wait-all-submitted) [782.472415] Starting subtest: etime-single-wait-all-submitted [782.577598] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s) [782.653427] [106/129] (544s left) gem_vm_create (create-ext) [782.699346] Starting subtest: create-ext [782.704793] Subtest create-ext: SUCCESS (0.005s) [782.810906] [107/129] (543s left) kms_properties (plane-properties-atomic) [782.909231] Starting subtest: plane-properties-atomic [782.911893] Starting dynamic subtest: pipe-A-eDP-1 [783.468957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s) [783.479302] Starting dynamic subtest: pipe-B-eDP-1 [784.697087] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.226s) [784.708851] Starting dynamic subtest: pipe-C-eDP-1 [785.905222] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s) [785.915910] Starting dynamic subtest: pipe-D-eDP-1 [787.135409] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s) [787.137596] Subtest plane-properties-atomic: SUCCESS (4.223s) [787.926221] [108/129] (538s left) kms_chamelium_hpd (dp-hpd-storm) [788.317392] Subtest dp-hpd-storm: SKIP (0.000s) [789.142979] [109/129] (537s left) kms_psr (fbc-psr-primary-blt) [789.238071] Starting subtest: fbc-psr-primary-blt [789.240591] Starting dynamic subtest: eDP-1 [789.245722] Dynamic subtest eDP-1: SKIP (0.000s) [789.250733] Subtest fbc-psr-primary-blt: SKIP (0.001s) [789.305015] [110/129] (537s left) kms_psr (fbc-pr-primary-mmap-gtt) [789.412214] Starting subtest: fbc-pr-primary-mmap-gtt [789.417806] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [789.478653] [111/129] (537s left) gem_ctx_param (basic) [789.538178] Starting subtest: basic [789.540941] Subtest basic: SUCCESS (0.001s) [789.619577] [112/129] (537s left) perf (global-sseu-config) [789.725104] Starting subtest: global-sseu-config [789.730385] Subtest global-sseu-config: SKIP (0.000s) [789.765292] [113/129] (537s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [789.882885] Starting subtest: fbc-rgb565-draw-mmap-gtt [789.887950] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [789.986012] [114/129] (537s left) syncobj_wait (reset-multiple-signaled) [790.052810] Starting subtest: reset-multiple-signaled [790.055191] Subtest reset-multiple-signaled: SUCCESS (0.000s) [790.161270] [115/129] (536s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [790.283655] Starting subtest: flip-vs-cursor-busy-crc-atomic [791.037976] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.755s) [791.891429] [116/129] (535s left) kms_vblank (ts-continuation-suspend) [791.993677] Starting subtest: ts-continuation-suspend [791.996180] Starting dynamic subtest: pipe-A-eDP-1 [808.629646] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.632s) [808.644040] Starting dynamic subtest: pipe-D-eDP-1 [825.542450] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.106s) [825.545473] Subtest ts-continuation-suspend: SUCCESS (3.741s) [826.408115] [117/129] (530s left) gem_exec_capture (capture-recoverable) [826.469608] Starting subtest: capture-recoverable [826.475344] Subtest capture-recoverable: SUCCESS (0.003s) [826.595856] [118/129] (530s left) gem_madvise (dontneed-before-mmap) [826.635461] Starting subtest: dontneed-before-mmap [826.663845] Subtest dontneed-before-mmap: SUCCESS (0.033s) [826.777252] [119/129] (530s left) i915_pm_rpm (gem-mmap-type) [828.432091] Starting subtest: gem-mmap-type [828.434796] Starting dynamic subtest: wb-smem0 [832.395764] Dynamic subtest wb-smem0: SUCCESS (3.954s) [832.405207] Starting dynamic subtest: wc-smem0 [835.511236] Dynamic subtest wc-smem0: SUCCESS (3.112s) [835.522155] Starting dynamic subtest: uc-smem0 [838.308403] Dynamic subtest uc-smem0: SUCCESS (2.791s) [838.311026] Subtest gem-mmap-type: SUCCESS (9.860s) [838.400983] [120/129] (518s left) kms_dsc (dsc-with-formats) [838.509388] Starting subtest: dsc-with-formats [838.554945] Subtest dsc-with-formats: SKIP (0.001s) [838.595526] [121/129] (518s left) kms_sequence (queue-idle) [838.684196] Starting subtest: queue-idle [838.686633] Starting dynamic subtest: pipe-A-eDP-1 [840.508186] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s) [840.518344] Starting dynamic subtest: pipe-B-eDP-1 [842.925541] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.415s) [842.935617] Starting dynamic subtest: pipe-C-eDP-1 [845.355368] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.425s) [845.365651] Starting dynamic subtest: pipe-D-eDP-1 [847.775592] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.419s) [847.778489] Subtest queue-idle: SUCCESS (9.083s) [848.582178] [122/129] (508s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [848.680544] Starting subtest: psr-rgb101010-draw-render [853.901634] Subtest psr-rgb101010-draw-render: SUCCESS (5.223s) [854.035352] [123/129] (503s left) core_setmaster_vs_auth [854.212216] [124/129] (503s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [854.308347] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [854.311090] Starting dynamic subtest: pipe-A-eDP-1 [854.338796] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [854.347846] Starting dynamic subtest: pipe-B-eDP-1 [854.373425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [854.381921] Starting dynamic subtest: pipe-C-eDP-1 [854.407378] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [854.415476] Starting dynamic subtest: pipe-D-eDP-1 [854.440114] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [854.444630] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s) [856.492795] [125/129] (500s left) kms_chamelium_frames (dp-crc-multiple) [856.882425] Subtest dp-crc-multiple: SKIP (0.000s) [857.699105] [126/129] (499s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [857.795343] Starting subtest: primary-yf-tiled-reflect-x-180 [857.858023] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [857.953974] [127/129] (499s left) drm_fdinfo (most-busy-idle-check-all) [858.000044] Starting subtest: most-busy-idle-check-all [858.002855] Starting dynamic subtest: rcs0 [858.008951] Dynamic subtest rcs0: SKIP (0.004s) [858.019129] Starting dynamic subtest: bcs0 [858.024042] Dynamic subtest bcs0: SKIP (0.000s) [858.032886] Starting dynamic subtest: vcs0 [858.038075] Dynamic subtest vcs0: SKIP (0.000s) [858.049225] Starting dynamic subtest: vcs1 [858.054571] Dynamic subtest vcs1: SKIP (0.000s) [858.063759] Starting dynamic subtest: vecs0 [858.068742] Dynamic subtest vecs0: SKIP (0.000s) [858.077253] Starting dynamic subtest: ccs0 [858.082398] Dynamic subtest ccs0: SKIP (0.000s) [858.087395] Subtest most-busy-idle-check-all: SKIP (0.009s) [858.120454] [128/129] (499s left) kms_cursor_crc (cursor-rapid-movement-32x32) [858.277585] Starting subtest: cursor-rapid-movement-32x32 [858.318032] Subtest cursor-rapid-movement-32x32: SKIP (0.035s) [858.597805] [129/129] (498s left) kms_big_fb (linear-32bpp-rotate-0) [858.705819] Starting subtest: linear-32bpp-rotate-0 [860.526131] Subtest linear-32bpp-rotate-0: SUCCESS (1.822s) [860.707760] Closing watchdogs Done.