[58.398058] Initializing watchdogs [58.398108] /dev/watchdog0 [58.413292] [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.417760] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.419868] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.423256] [001/133] (960s left) kms_vrr (flip-dpms) [58.538889] Starting subtest: flip-dpms [58.545995] Subtest flip-dpms: SKIP (0.000s) [58.606945] [002/133] (960s left) gem_softpin (evict-snoop-interruptible) [58.667863] Starting subtest: evict-snoop-interruptible [58.672246] Subtest evict-snoop-interruptible: SKIP (0.000s) [58.764312] [003/133] (960s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [58.822225] Starting subtest: single-wait-all-for-submit-unsubmitted [58.929787] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [59.000581] [004/133] (960s left) gem_ctx_persistence (engines-hostile) [59.059141] Starting subtest: engines-hostile [59.061480] Starting dynamic subtest: rcs0 [59.183436] Dynamic subtest rcs0: SUCCESS (0.125s) [59.193704] Starting dynamic subtest: bcs0 [59.288534] Dynamic subtest bcs0: SUCCESS (0.104s) [59.298605] Starting dynamic subtest: vcs0 [59.380357] Dynamic subtest vcs0: SUCCESS (0.091s) [59.390774] Starting dynamic subtest: vcs1 [59.475456] Dynamic subtest vcs1: SUCCESS (0.094s) [59.484626] Starting dynamic subtest: vecs0 [59.568485] Dynamic subtest vecs0: SUCCESS (0.091s) [59.579062] Starting dynamic subtest: ccs0 [59.667700] Dynamic subtest ccs0: SUCCESS (0.097s) [59.670151] Subtest engines-hostile: SUCCESS (0.610s) [59.747174] [005/133] (959s left) kms_big_fb (4-tiled-addfb) [59.839896] Starting subtest: 4-tiled-addfb [59.842158] Subtest 4-tiled-addfb: SUCCESS (0.000s) [59.929763] [006/133] (959s left) syncobj_basic (create-signaled) [59.991104] Starting subtest: create-signaled [59.992789] Subtest create-signaled: SUCCESS (0.000s) [60.090392] [007/133] (959s left) gem_wait (busy) [60.158630] Starting subtest: busy [60.160741] Starting dynamic subtest: all-engines [61.909248] Dynamic subtest all-engines: SUCCESS (1.749s) [61.919917] Starting dynamic subtest: rcs0 [62.451217] Dynamic subtest rcs0: SUCCESS (0.543s) [62.461032] Starting dynamic subtest: bcs0 [62.991630] Dynamic subtest bcs0: SUCCESS (0.540s) [63.000879] Starting dynamic subtest: vcs0 [64.917069] Dynamic subtest vcs0: SUCCESS (1.924s) [64.927072] Starting dynamic subtest: vcs1 [66.901817] Dynamic subtest vcs1: SUCCESS (1.984s) [66.912087] Starting dynamic subtest: vecs0 [68.885875] Dynamic subtest vecs0: SUCCESS (1.983s) [68.896801] Starting dynamic subtest: ccs0 [69.427041] Dynamic subtest ccs0: SUCCESS (0.542s) [69.429806] Subtest busy: SUCCESS (9.270s) [69.625190] [008/133] (949s left) gem_mmap_gtt (big-bo-tiledx) [69.687215] Subtest big-bo-tiledX: SKIP (0.000s) [69.746197] [009/133] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [69.845614] Starting subtest: fbc-1p-primscrn-spr-indfb-move [74.127571] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.288s) [75.282619] [010/133] (943s left) kms_plane_cursor (primary) [75.385094] Starting subtest: primary [75.389715] Starting dynamic subtest: pipe-A-eDP-1-size-64 [77.985209] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.601s) [78.009882] Starting dynamic subtest: pipe-A-eDP-1-size-128 [80.551870] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s) [80.575508] Starting dynamic subtest: pipe-A-eDP-1-size-256 [83.153454] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s) [83.470664] Starting dynamic subtest: pipe-B-eDP-1-size-64 [86.746450] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.284s) [86.768245] Starting dynamic subtest: pipe-B-eDP-1-size-128 [89.335070] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.572s) [89.358392] Starting dynamic subtest: pipe-B-eDP-1-size-256 [91.926120] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.575s) [92.237308] Starting dynamic subtest: pipe-C-eDP-1-size-64 [95.116333] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.888s) [95.141791] Starting dynamic subtest: pipe-C-eDP-1-size-128 [97.349970] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s) [97.376068] Starting dynamic subtest: pipe-C-eDP-1-size-256 [99.605331] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s) [99.927496] Starting dynamic subtest: pipe-D-eDP-1-size-64 [102.824175] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.906s) [102.848838] Starting dynamic subtest: pipe-D-eDP-1-size-128 [105.046239] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s) [105.072376] Starting dynamic subtest: pipe-D-eDP-1-size-256 [107.235204] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s) [107.547461] Subtest primary: SUCCESS (32.163s) [108.387475] [011/133] (910s left) syncobj_wait (multi-wait-submitted-signaled) [108.440057] Starting subtest: multi-wait-submitted-signaled [108.442424] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [108.546443] [012/133] (910s left) gem_flink_basic (flink-lifetime) [108.586977] Starting subtest: flink-lifetime [108.589245] Subtest flink-lifetime: SUCCESS (0.001s) [108.682742] [013/133] (910s left) i915_pm_rc6_residency (rc6-accuracy) [108.741251] Starting subtest: rc6-accuracy [108.743509] Starting dynamic subtest: gt0 [111.913373] Dynamic subtest gt0: SUCCESS (3.169s) [111.921640] Starting dynamic subtest: gt1 [115.084680] Dynamic subtest gt1: SUCCESS (3.167s) [115.087274] Subtest rc6-accuracy: SUCCESS (6.342s) [115.157760] [014/133] (904s left) gem_exec_flush (basic-uc-pro-default) [115.214733] Starting subtest: basic-uc-pro-default [120.707690] Subtest basic-uc-pro-default: SUCCESS (5.493s) [120.894552] [015/133] (898s left) kms_vrr (seamless-rr-switch-vrr) [121.000155] Starting subtest: seamless-rr-switch-vrr [121.006353] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [121.080984] [016/133] (898s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [121.217291] Starting subtest: modeset-atomic-cursor-hotspot [121.221853] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [121.354378] [017/133] (898s left) syncobj_timeline (invalid-signal-bad-pad) [121.422488] Starting subtest: invalid-signal-bad-pad [121.424431] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [121.505921] [018/133] (898s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [121.557269] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [121.559156] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [121.671157] [019/133] (897s left) kms_color (ctm-red-to-blue) [121.754295] Starting subtest: ctm-red-to-blue [121.756156] Starting dynamic subtest: pipe-A-eDP-1 [122.463688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s) [122.472379] Starting dynamic subtest: pipe-B-eDP-1 [123.898845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s) [123.907622] Starting dynamic subtest: pipe-C-eDP-1 [125.284587] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s) [125.292706] Starting dynamic subtest: pipe-D-eDP-1 [126.606344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s) [126.608848] Subtest ctm-red-to-blue: SUCCESS (4.854s) [127.417049] [020/133] (892s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [127.513559] Starting subtest: psr-rgb101010-draw-render [134.819735] Subtest psr-rgb101010-draw-render: SUCCESS (7.308s) [134.962438] [021/133] (884s left) kms_pm_lpsp (kms-lpsp) [136.068525] Starting subtest: kms-lpsp [136.070985] Starting dynamic subtest: pipe-A-eDP-1 [136.248119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.181s) [136.553926] Subtest kms-lpsp: SUCCESS (0.488s) [137.378527] [022/133] (882s left) prime_self_import (basic-with_fd_dup) [137.411760] Starting subtest: basic-with_fd_dup [137.435784] Subtest basic-with_fd_dup: SUCCESS (0.025s) [137.550290] [023/133] (882s left) kms_big_fb (x-tiled-32bpp-rotate-270) [137.649257] Starting subtest: x-tiled-32bpp-rotate-270 [137.668584] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [137.778492] [024/133] (882s left) kms_psr (fbc-psr2-sprite-plane-onoff) [137.865112] Starting subtest: fbc-psr2-sprite-plane-onoff [137.867388] Starting dynamic subtest: eDP-1 [137.871810] Dynamic subtest eDP-1: SKIP (0.000s) [137.876235] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [137.936119] [025/133] (881s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [138.029410] Starting subtest: ccs-on-another-bo-y-tiled-ccs [138.031626] Starting dynamic subtest: pipe-A-eDP-1 [138.054496] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [138.064545] Starting dynamic subtest: pipe-B-eDP-1 [138.086572] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [138.094040] Starting dynamic subtest: pipe-C-eDP-1 [138.115719] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [138.123078] Starting dynamic subtest: pipe-D-eDP-1 [138.145081] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [138.149149] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [140.346579] [026/133] (879s left) kms_flip (modeset-vs-vblank-race-interruptible) [140.447794] Starting subtest: modeset-vs-vblank-race-interruptible [140.450234] Starting dynamic subtest: A-eDP1 [145.163731] Dynamic subtest A-eDP1: SUCCESS (4.715s) [145.174977] Starting dynamic subtest: B-eDP1 [149.793440] Dynamic subtest B-eDP1: SUCCESS (4.627s) [149.804501] Starting dynamic subtest: C-eDP1 [154.392093] Dynamic subtest C-eDP1: SUCCESS (4.596s) [154.403860] Starting dynamic subtest: D-eDP1 [159.014408] Dynamic subtest D-eDP1: SUCCESS (4.619s) [159.019187] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.572s) [160.173412] [027/133] (859s left) gem_ctx_persistence (heartbeat-stop) [160.227279] Starting subtest: heartbeat-stop [160.232202] Subtest heartbeat-stop: SKIP (0.000s) [160.337629] [028/133] (859s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [160.450582] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [161.403635] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.954s) [162.207031] [029/133] (857s left) gem_partial_pwrite_pread (write-display) [162.277342] Subtest write-display: SKIP (0.000s) [162.345187] [030/133] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [162.438599] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [169.102984] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.666s) [169.225729] [031/133] (850s left) api_intel_bb (reset-bb) [169.285903] Starting subtest: reset-bb [169.288203] Subtest reset-bb: SUCCESS (0.003s) [169.396542] [032/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [169.492721] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [169.496833] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [169.592746] [033/133] (850s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [169.676743] Starting subtest: flip-vs-dpms-on-nop-interruptible [169.678630] Starting dynamic subtest: A-eDP1 [171.532145] Dynamic subtest A-eDP1: SUCCESS (1.854s) [171.543651] Starting dynamic subtest: B-eDP1 [173.358820] Dynamic subtest B-eDP1: SUCCESS (1.823s) [173.368717] Starting dynamic subtest: C-eDP1 [175.163229] Dynamic subtest C-eDP1: SUCCESS (1.802s) [175.173696] Starting dynamic subtest: D-eDP1 [176.995356] Dynamic subtest D-eDP1: SUCCESS (1.829s) [177.000650] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.323s) [178.172853] [034/133] (842s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [178.265337] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [178.267639] Starting dynamic subtest: pipe-A-eDP-1 [179.076185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s) [179.084930] Starting dynamic subtest: pipe-B-eDP-1 [180.636211] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.557s) [180.647369] Starting dynamic subtest: pipe-C-eDP-1 [182.131102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s) [182.139248] Starting dynamic subtest: pipe-D-eDP-1 [183.672445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.540s) [183.674730] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.401s) [184.895558] [035/133] (835s left) kms_cursor_edge_walk (256x256-top-bottom) [185.004854] Starting subtest: 256x256-top-bottom [185.007165] Starting dynamic subtest: pipe-A-eDP-1 [188.443182] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s) [188.451059] Starting dynamic subtest: pipe-D-eDP-1 [191.568533] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [191.570461] Subtest 256x256-top-bottom: SUCCESS (6.563s) [192.376270] [036/133] (827s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [192.474542] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [192.476679] Starting dynamic subtest: pipe-A-eDP-1 [203.780858] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.307s) [203.789107] Starting dynamic subtest: pipe-B-eDP-1 [215.781635] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.999s) [215.783933] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.309s) [216.619630] [037/133] (803s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [216.730236] Starting subtest: primary-yf-tiled-reflect-x-90 [216.734896] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [216.800509] [038/133] (803s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [216.896740] Starting subtest: pr-cursor-plane-move-continuous-sf [216.901135] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [216.961949] [039/133] (803s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [217.070437] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [223.894083] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.825s) [224.029146] [040/133] (796s left) kms_legacy_colorkey (basic) [224.125254] Starting subtest: basic [224.127175] Starting dynamic subtest: pipe-A [224.168195] Dynamic subtest pipe-A: SUCCESS (0.045s) [224.178857] Starting dynamic subtest: pipe-B [224.181500] Dynamic subtest pipe-B: SUCCESS (0.000s) [224.188251] Starting dynamic subtest: pipe-C [224.190588] Dynamic subtest pipe-C: SUCCESS (0.000s) [224.197557] Starting dynamic subtest: pipe-D [224.199813] Dynamic subtest pipe-D: SUCCESS (0.000s) [224.202019] Subtest basic: SUCCESS (0.050s) [224.235200] [041/133] (796s left) perf (buffer-fill) [224.356381] Starting subtest: buffer-fill [224.358631] Starting dynamic subtest: 0-rcs0 [226.600865] Dynamic subtest 0-rcs0: SUCCESS (2.245s) [226.608399] Starting dynamic subtest: 1-vcs0 [231.033773] Dynamic subtest 1-vcs0: SUCCESS (4.431s) [231.035996] Subtest buffer-fill: SUCCESS (6.679s) [231.080040] [042/133] (789s left) core_getversion (all-cards) [231.115321] Starting subtest: all-cards [231.122434] Subtest all-cards: SUCCESS (0.008s) [231.155792] [043/133] (789s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [231.251406] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [231.253765] Starting dynamic subtest: pipe-A-eDP-1 [231.276330] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [231.284854] Starting dynamic subtest: pipe-B-eDP-1 [231.305132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [231.311916] Starting dynamic subtest: pipe-C-eDP-1 [231.332502] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [231.339201] Starting dynamic subtest: pipe-D-eDP-1 [231.362357] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [231.366786] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s) [233.433599] [044/133] (787s left) api_intel_allocator (simple-allocator) [233.497313] Starting subtest: simple-allocator [233.499614] Starting dynamic subtest: basic [233.501643] Dynamic subtest basic: SUCCESS (0.003s) [233.512138] Starting dynamic subtest: parallel-one [233.679722] Dynamic subtest parallel-one: SUCCESS (0.180s) [233.687989] Starting dynamic subtest: print [233.690588] Dynamic subtest print: SUCCESS (0.000s) [233.697868] Starting dynamic subtest: reuse [233.700293] Dynamic subtest reuse: SUCCESS (0.000s) [233.707250] Starting dynamic subtest: reserve [233.709115] Dynamic subtest reserve: SUCCESS (0.000s) [233.715844] Starting dynamic subtest: fork-reopen-allocator [233.717776] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [233.719683] Subtest simple-allocator: SUCCESS (0.205s) [233.817268] [045/133] (786s left) prime_mmap (test_correct_cpu_write) [233.879551] Starting subtest: test_correct_cpu_write [233.882121] Starting dynamic subtest: test_correct_cpu_write-smem [233.884566] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [233.886620] Subtest test_correct_cpu_write: SUCCESS (0.002s) [233.981246] [046/133] (786s left) kms_psr (pr-cursor-render) [234.074675] Starting subtest: pr-cursor-render [234.078857] Subtest pr-cursor-render: SKIP (0.000s) [234.144885] [047/133] (786s left) gem_exec_balancer (parallel) [234.391748] Starting subtest: parallel [235.311482] Subtest parallel: SUCCESS (0.920s) [235.974657] [048/133] (784s left) perf_pmu (busy-idle-no-semaphores) [236.017052] Starting subtest: busy-idle-no-semaphores [236.019371] Starting dynamic subtest: rcs0 [236.666234] Dynamic subtest rcs0: SUCCESS (0.650s) [236.680196] Starting dynamic subtest: bcs0 [237.324314] Dynamic subtest bcs0: SUCCESS (0.654s) [237.333741] Starting dynamic subtest: vcs0 [237.978911] Dynamic subtest vcs0: SUCCESS (0.652s) [237.989999] Starting dynamic subtest: vcs1 [239.551389] Dynamic subtest vcs1: SUCCESS (1.570s) [239.563250] Starting dynamic subtest: vecs0 [241.534457] Dynamic subtest vecs0: SUCCESS (1.980s) [241.545638] Starting dynamic subtest: ccs0 [243.519647] Dynamic subtest ccs0: SUCCESS (1.982s) [243.522582] Subtest busy-idle-no-semaphores: SUCCESS (7.505s) [243.633549] [049/133] (777s left) gem_exec_store (dword) [243.696731] Starting subtest: dword [243.698899] Starting dynamic subtest: rcs0 [243.785116] Dynamic subtest rcs0: SUCCESS (0.091s) [243.796231] Starting dynamic subtest: bcs0 [243.830056] Dynamic subtest bcs0: SUCCESS (0.043s) [243.840304] Starting dynamic subtest: vcs0 [243.872855] Dynamic subtest vcs0: SUCCESS (0.042s) [243.881814] Starting dynamic subtest: vcs1 [243.913842] Dynamic subtest vcs1: SUCCESS (0.040s) [243.930828] Starting dynamic subtest: vecs0 [243.956551] Dynamic subtest vecs0: SUCCESS (0.041s) [243.967882] Starting dynamic subtest: ccs0 [244.000851] Dynamic subtest ccs0: SUCCESS (0.043s) [244.003209] Subtest dword: SUCCESS (0.308s) [244.182031] [050/133] (776s left) gem_ctx_shared (q-promotion) [244.247546] Starting subtest: Q-promotion [244.249967] Starting dynamic subtest: rcs0 [244.454461] Dynamic subtest rcs0: SUCCESS (0.205s) [244.472968] Starting dynamic subtest: vcs0 [244.569837] Dynamic subtest vcs0: SUCCESS (0.114s) [244.588625] Starting dynamic subtest: vcs1 [244.688864] Dynamic subtest vcs1: SUCCESS (0.119s) [244.706135] Starting dynamic subtest: vecs0 [244.800740] Dynamic subtest vecs0: SUCCESS (0.111s) [244.816252] Starting dynamic subtest: ccs0 [244.923440] Dynamic subtest ccs0: SUCCESS (0.121s) [244.926109] Subtest Q-promotion: SUCCESS (0.675s) [246.008350] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true [246.013188] [051/133] (774s left) prime_mmap (test_aperture_limit) [246.076584] Starting subtest: test_aperture_limit [246.078832] Starting dynamic subtest: test_aperture_limit-smem [246.086281] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s) [246.090589] Subtest test_aperture_limit: SKIP (0.008s) [246.178513] [052/133] (774s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [246.276479] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [246.280879] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [246.392186] [053/133] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [246.488170] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [253.750314] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.265s) [253.897928] [054/133] (767s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [253.984070] Starting subtest: random-ccs-data-yf-tiled-ccs [253.986288] Starting dynamic subtest: pipe-A-eDP-1 [254.011191] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [254.021434] Starting dynamic subtest: pipe-B-eDP-1 [254.045412] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [254.053379] Starting dynamic subtest: pipe-C-eDP-1 [254.076686] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [254.084605] Starting dynamic subtest: pipe-D-eDP-1 [254.108608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [254.112792] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s) [256.142022] [055/133] (764s left) i915_drm_fdinfo (virtual-busy-hang-all) [256.185670] Starting subtest: virtual-busy-hang-all [256.190342] Subtest virtual-busy-hang-all: SKIP (0.000s) [256.250157] [056/133] (764s left) gen9_exec_parse (basic-rejected-ctx-param) [256.312547] Subtest basic-rejected-ctx-param: SKIP (0.000s) [256.381537] [057/133] (764s left) gem_ctx_engines (invalid-engines) [256.436319] Starting subtest: invalid-engines [256.444602] Subtest invalid-engines: SUCCESS (0.008s) [256.669360] [058/133] (764s left) kms_chamelium_frames (hdmi-crc-multiple) [257.050366] Subtest hdmi-crc-multiple: SKIP (0.000s) [257.864133] [059/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [257.963746] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [257.967911] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [258.047927] [060/133] (763s left) i915_drm_fdinfo (busy-idle-check-all) [258.088655] Starting subtest: busy-idle-check-all [258.090544] Starting dynamic subtest: rcs0 [258.095072] Dynamic subtest rcs0: SKIP (0.004s) [258.103462] Starting dynamic subtest: bcs0 [258.107753] Dynamic subtest bcs0: SKIP (0.000s) [258.115717] Starting dynamic subtest: vcs0 [258.119913] Dynamic subtest vcs0: SKIP (0.000s) [258.127511] Starting dynamic subtest: vcs1 [258.131765] Dynamic subtest vcs1: SKIP (0.000s) [258.139401] Starting dynamic subtest: vecs0 [258.143714] Dynamic subtest vecs0: SKIP (0.000s) [258.151191] Starting dynamic subtest: ccs0 [258.155559] Dynamic subtest ccs0: SKIP (0.000s) [258.159960] Subtest busy-idle-check-all: SKIP (0.009s) [258.195630] [061/133] (763s left) kms_universal_plane (disable-primary-vs-flip) [258.334836] Starting subtest: disable-primary-vs-flip [258.337052] Starting dynamic subtest: pipe-A-eDP-1 [259.854467] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.520s) [259.863523] Starting dynamic subtest: pipe-B-eDP-1 [262.040845] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.176s) [262.058783] Starting dynamic subtest: pipe-C-eDP-1 [264.292183] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.258s) [264.300314] Starting dynamic subtest: pipe-D-eDP-1 [266.472072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.178s) [266.474528] Subtest disable-primary-vs-flip: SUCCESS (8.138s) [267.268640] [062/133] (753s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [267.328680] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [267.434507] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s) [267.520410] [063/133] (753s left) gem_eio (in-flight-internal-1us) [267.755113] Starting subtest: in-flight-internal-1us [268.966735] Subtest in-flight-internal-1us: SUCCESS (1.210s) [269.122978] [064/133] (752s left) gem_spin_batch (engines) [269.183627] Starting subtest: engines [269.186069] Starting dynamic subtest: rcs0 [272.425157] Dynamic subtest rcs0: SUCCESS (3.236s) [272.436846] Starting dynamic subtest: bcs0 [275.662300] Dynamic subtest bcs0: SUCCESS (3.234s) [275.673416] Starting dynamic subtest: vcs0 [278.901497] Dynamic subtest vcs0: SUCCESS (3.236s) [278.912030] Starting dynamic subtest: vcs1 [282.140123] Dynamic subtest vcs1: SUCCESS (3.236s) [282.150659] Starting dynamic subtest: vecs0 [285.379288] Dynamic subtest vecs0: SUCCESS (3.236s) [285.389816] Starting dynamic subtest: ccs0 [288.618900] Dynamic subtest ccs0: SUCCESS (3.236s) [288.621476] Subtest engines: SUCCESS (19.430s) [288.846927] [065/133] (732s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [288.982270] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [295.543300] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.564s) [295.667890] [066/133] (725s left) kms_cursor_crc (cursor-rapid-movement-32x10) [295.833654] Starting subtest: cursor-rapid-movement-32x10 [295.876285] Subtest cursor-rapid-movement-32x10: SKIP (0.039s) [296.167083] [067/133] (725s left) gem_exec_nop (basic-parallel) [296.236180] Starting subtest: basic-parallel [312.855195] Subtest basic-parallel: SUCCESS (16.628s) [313.090286] [068/133] (708s left) kms_async_flips (test-time-stamp-atomic) [313.185761] Starting subtest: test-time-stamp-atomic [313.571022] Starting dynamic subtest: pipe-A-eDP-1 [314.402185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s) [314.780178] Starting dynamic subtest: pipe-B-eDP-1 [315.533683] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s) [315.900877] Starting dynamic subtest: pipe-C-eDP-1 [316.658860] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [317.031267] Starting dynamic subtest: pipe-D-eDP-1 [317.800292] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s) [317.802950] Subtest test-time-stamp-atomic: SUCCESS (4.615s) [318.959745] [069/133] (702s left) gem_exec_whisper (basic-sync) [319.026920] Starting subtest: basic-sync [327.631467] Subtest basic-sync: SUCCESS (8.602s) [327.813512] [070/133] (693s left) gem_partial_pwrite_pread (writes-after-reads) [327.874504] Subtest writes-after-reads: SKIP (0.000s) [327.931911] [071/133] (693s left) gem_exec_balancer (waits) [327.994696] Starting subtest: waits [334.454615] Subtest waits: SUCCESS (6.458s) [334.752123] [072/133] (686s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [334.856077] Starting subtest: async-flip-with-page-flip-events-tiled [335.225313] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [338.034272] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.807s) [338.045894] Starting dynamic subtest: pipe-A-eDP-1-4 [340.208144] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [340.216532] Starting dynamic subtest: pipe-A-eDP-1-4 [342.219062] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [342.227860] Starting dynamic subtest: pipe-A-eDP-1-x [344.408825] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [344.777092] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [347.566646] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.796s) [347.577283] Starting dynamic subtest: pipe-B-eDP-1-4 [349.752795] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [349.761449] Starting dynamic subtest: pipe-B-eDP-1-4 [351.762398] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [351.771038] Starting dynamic subtest: pipe-B-eDP-1-x [353.952788] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [354.321063] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [357.107252] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.791s) [357.115783] Starting dynamic subtest: pipe-C-eDP-1-4 [359.281050] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [359.289693] Starting dynamic subtest: pipe-C-eDP-1-4 [361.291921] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [361.300291] Starting dynamic subtest: pipe-C-eDP-1-x [363.492520] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s) [363.861656] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [366.642242] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.786s) [366.651404] Starting dynamic subtest: pipe-D-eDP-1-4 [368.805502] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s) [368.813936] Starting dynamic subtest: pipe-D-eDP-1-4 [370.815688] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [370.824399] Starting dynamic subtest: pipe-D-eDP-1-x [372.993852] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [372.996222] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.139s) [374.233602] [073/133] (647s left) kms_plane_alpha_blend (alpha-basic) [374.343996] Starting subtest: alpha-basic [374.635665] Starting dynamic subtest: pipe-A-eDP-1 [376.537313] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.900s) [376.566990] Starting dynamic subtest: pipe-D-eDP-1 [379.203487] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.644s) [379.205782] Subtest alpha-basic: SUCCESS (4.859s) [379.998373] [074/133] (641s left) gem_exec_params (invalid-fence-in-submit) [380.065969] Starting subtest: invalid-fence-in-submit [380.071166] Subtest invalid-fence-in-submit: SUCCESS (0.003s) [380.193745] [075/133] (641s left) gem_exec_params (sol-reset-not-gen7) [380.251432] Starting subtest: sol-reset-not-gen7 [380.256145] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [380.371702] [076/133] (641s left) i915_power (sanity) [380.432367] Starting subtest: sanity [384.489344] Subtest sanity: SUCCESS (4.051s) [385.956649] [077/133] (635s left) kms_flip (plain-flip-ts-check) [386.061321] Starting subtest: plain-flip-ts-check [386.063634] Starting dynamic subtest: A-eDP1 [394.885180] Dynamic subtest A-eDP1: SUCCESS (8.826s) [394.894488] Starting dynamic subtest: B-eDP1 [403.718064] Dynamic subtest B-eDP1: SUCCESS (8.831s) [403.729089] Starting dynamic subtest: C-eDP1 [412.557931] Dynamic subtest C-eDP1: SUCCESS (8.837s) [412.568456] Starting dynamic subtest: D-eDP1 [421.390724] Dynamic subtest D-eDP1: SUCCESS (8.833s) [421.393137] Subtest plain-flip-ts-check: SUCCESS (35.335s) [422.560124] [078/133] (599s left) kms_vblank (crtc-id) [422.665370] Starting subtest: crtc-id [422.667655] Starting dynamic subtest: pipe-A-eDP-1 [423.106479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s) [423.120494] Starting dynamic subtest: pipe-D-eDP-1 [424.299970] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.190s) [424.302135] Subtest crtc-id: SUCCESS (1.637s) [425.129440] [079/133] (596s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [425.224136] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [425.226425] Starting dynamic subtest: pipe-A-default-mode [427.970207] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s) [427.972572] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.748s) [428.829309] [080/133] (593s left) kms_fence_pin_leak [428.994329] [081/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [429.093493] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [435.906145] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.815s) [436.040308] [082/133] (586s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [436.155337] Starting subtest: 2x-flip-vs-cursor-atomic [436.159832] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [436.299766] [083/133] (585s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [436.387342] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [436.389627] Starting dynamic subtest: pipe-A-eDP-1 [436.398919] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [436.408337] Starting dynamic subtest: pipe-B-eDP-1 [436.417561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [436.426063] Starting dynamic subtest: pipe-C-eDP-1 [436.434179] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [436.441786] Starting dynamic subtest: pipe-D-eDP-1 [436.449952] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [436.453999] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [438.632603] [084/133] (583s left) gem_exec_reloc (basic-gtt-cpu-active) [438.695111] Subtest basic-gtt-cpu-active: SKIP (0.000s) [438.767394] [085/133] (583s left) kms_cursor_crc (cursor-onscreen-32x32) [438.906860] Starting subtest: cursor-onscreen-32x32 [438.958566] Subtest cursor-onscreen-32x32: SKIP (0.048s) [439.249971] [086/133] (582s left) gem_pxp (fail-invalid-protected-context) [439.386239] Starting subtest: fail-invalid-protected-context [439.388559] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [439.497308] [087/133] (582s left) kms_pm_rpm (pm-caching) [441.117498] Starting subtest: pm-caching [441.123190] Subtest pm-caching: SKIP (0.000s) [441.781668] [088/133] (580s left) gem_mmap_gtt (flink-race) [441.832741] Subtest flink-race: SKIP (0.000s) [441.888951] [089/133] (580s left) kms_psr (psr2-cursor-mmap-gtt) [441.978878] Starting subtest: psr2-cursor-mmap-gtt [441.981207] Starting dynamic subtest: eDP-1 [443.728061] Dynamic subtest eDP-1: SUCCESS (1.748s) [443.730313] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.750s) [444.517202] [090/133] (577s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [444.903714] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [445.735219] [091/133] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [445.831874] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [445.836288] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [445.927152] [092/133] (576s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [446.040054] Starting subtest: basic-flip-before-cursor-varying-size [446.966099] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s) [447.781942] [093/133] (574s left) gem_exec_schedule (thriceslice) [447.847409] Starting subtest: thriceslice [447.849302] Starting dynamic subtest: rcs0 [447.867640] Dynamic subtest rcs0: SUCCESS (0.029s) [447.879852] Starting dynamic subtest: bcs0 [447.897305] Dynamic subtest bcs0: SUCCESS (0.029s) [447.908249] Starting dynamic subtest: vcs0 [447.955970] Dynamic subtest vcs0: SUCCESS (0.055s) [447.968031] Starting dynamic subtest: vcs1 [447.985712] Dynamic subtest vcs1: SUCCESS (0.028s) [447.994487] Starting dynamic subtest: vecs0 [448.014631] Dynamic subtest vecs0: SUCCESS (0.028s) [448.023117] Starting dynamic subtest: ccs0 [448.044707] Dynamic subtest ccs0: SUCCESS (0.029s) [448.047312] Subtest thriceslice: SUCCESS (0.207s) [448.352253] [094/133] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [448.457780] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [448.461948] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [448.556518] [095/133] (574s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [448.643236] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [448.645567] Starting dynamic subtest: pipe-A-eDP-1 [448.700955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.059s) [448.710106] Starting dynamic subtest: pipe-B-eDP-1 [448.761944] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s) [448.770860] Starting dynamic subtest: pipe-C-eDP-1 [448.822495] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s) [448.831299] Starting dynamic subtest: pipe-D-eDP-1 [448.883766] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s) [448.886092] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.243s) [451.137207] [096/133] (571s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [451.203444] Starting subtest: multi-wait-available-unsubmitted-signaled [451.205680] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [451.334772] [097/133] (571s left) gem_exec_fence (long-history) [451.825926] Starting subtest: long-history [458.634399] Subtest long-history: SUCCESS (6.809s) [459.119435] [098/133] (563s left) kms_dp_link_training (uhbr-sst) [459.207987] Starting subtest: uhbr-sst [459.216368] Subtest uhbr-sst: SKIP (0.000s) [459.281226] [099/133] (563s left) prime_vgem (basic-gtt) [459.362757] Starting subtest: basic-gtt [459.367413] Subtest basic-gtt: SKIP (0.000s) [459.458662] [100/133] (563s left) gem_exec_schedule (preempt) [459.525165] Starting subtest: preempt [459.527287] Starting dynamic subtest: rcs0 [459.538513] Dynamic subtest rcs0: SUCCESS (0.021s) [459.548987] Starting dynamic subtest: bcs0 [459.558746] Dynamic subtest bcs0: SUCCESS (0.020s) [459.568828] Starting dynamic subtest: vcs0 [459.581206] Dynamic subtest vcs0: SUCCESS (0.022s) [459.589645] Starting dynamic subtest: vcs1 [459.602666] Dynamic subtest vcs1: SUCCESS (0.021s) [459.612800] Starting dynamic subtest: vecs0 [459.627561] Dynamic subtest vecs0: SUCCESS (0.024s) [459.636051] Starting dynamic subtest: ccs0 [459.654512] Dynamic subtest ccs0: SUCCESS (0.026s) [459.656857] Subtest preempt: SUCCESS (0.138s) [460.955840] [101/133] (561s left) gem_exec_create (madvise) [461.029700] Starting subtest: madvise [461.032059] Starting dynamic subtest: smem [482.965576] Dynamic subtest smem: SUCCESS (21.931s) [482.968334] Subtest madvise: SUCCESS (21.932s) [483.763514] [102/133] (539s left) kms_psr (psr-no-drrs) [483.880920] Starting subtest: psr-no-drrs [483.883158] Starting dynamic subtest: eDP-1 [485.517653] Dynamic subtest eDP-1: SUCCESS (1.635s) [485.519581] Subtest psr-no-drrs: SUCCESS (1.636s) [486.398934] [103/133] (536s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [486.502661] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [486.542246] Starting dynamic subtest: pipe-A-plane-0 [486.930257] Dynamic subtest pipe-A-plane-0: SUCCESS (0.388s) [486.941802] Starting dynamic subtest: pipe-A-plane-3 [487.174583] Dynamic subtest pipe-A-plane-3: SUCCESS (0.241s) [488.287073] Starting dynamic subtest: pipe-B-plane-0 [488.570671] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s) [488.579419] Starting dynamic subtest: pipe-B-plane-3 [488.803898] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [489.113158] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.611s) [489.961824] [104/133] (532s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [490.033418] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [490.037725] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [490.220135] [105/133] (532s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [490.320369] Starting subtest: fbc-rgb101010-draw-mmap-wc [494.868687] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.551s) [495.984210] [106/133] (527s left) fbdev (read) [496.035616] Starting subtest: read [496.685702] Subtest read: SUCCESS (0.650s) [496.753263] [107/133] (526s left) kms_concurrent (multi-plane-atomic-lowres) [496.847075] Starting subtest: multi-plane-atomic-lowres [496.849316] Starting dynamic subtest: pipe-A-eDP-1 [497.341673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.494s) [497.350516] Starting dynamic subtest: pipe-B-eDP-1 [498.639604] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.295s) [498.648535] Starting dynamic subtest: pipe-C-eDP-1 [499.847955] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s) [499.859871] Starting dynamic subtest: pipe-D-eDP-1 [501.075123] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [501.077520] Subtest multi-plane-atomic-lowres: SUCCESS (4.229s) [501.904625] [108/133] (521s left) vgem_slow (nohang) [501.947507] Starting subtest: nohang [512.115080] Subtest nohang: SUCCESS (10.167s) [512.178898] [109/133] (510s left) gem_mmap_gtt (cpuset-basic-small-copy) [512.235463] Subtest cpuset-basic-small-copy: SKIP (0.000s) [512.296295] [110/133] (510s left) kms_prop_blob (invalid-get-prop-any) [512.348501] Starting subtest: invalid-get-prop-any [512.350781] Subtest invalid-get-prop-any: SUCCESS (0.000s) [512.454647] [111/133] (510s left) tools_test (sysfs_l3_parity) [512.509022] Starting subtest: sysfs_l3_parity [512.585281] Subtest sysfs_l3_parity: SKIP (0.088s) [512.640680] [112/133] (510s left) syncobj_timeline (single-wait-for-submit-signaled) [512.702148] Starting subtest: single-wait-for-submit-signaled [512.704491] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [512.810061] [113/133] (510s left) kms_psr (fbc-psr2-sprite-blt) [512.906718] Starting subtest: fbc-psr2-sprite-blt [512.908964] Starting dynamic subtest: eDP-1 [512.913109] Dynamic subtest eDP-1: SKIP (0.000s) [512.917145] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [512.979824] [114/133] (510s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [513.071203] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [513.728554] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s) [513.892937] [115/133] (509s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [513.979059] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [518.424744] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.449s) [519.588894] [116/133] (503s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [519.680394] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [523.788196] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.111s) [524.985951] [117/133] (498s left) sysfs_heartbeat_interval (idempotent) [525.045755] Starting subtest: idempotent [525.048168] Starting dynamic subtest: vecs0 [525.050516] Dynamic subtest vecs0: SUCCESS (0.000s) [525.063048] Starting dynamic subtest: ccs0 [525.065311] Dynamic subtest ccs0: SUCCESS (0.001s) [525.073556] Starting dynamic subtest: vcs0 [525.075769] Dynamic subtest vcs0: SUCCESS (0.000s) [525.083973] Starting dynamic subtest: bcs0 [525.086215] Dynamic subtest bcs0: SUCCESS (0.001s) [525.094375] Starting dynamic subtest: rcs0 [525.096276] Dynamic subtest rcs0: SUCCESS (0.000s) [525.104487] Starting dynamic subtest: vcs1 [525.106886] Dynamic subtest vcs1: SUCCESS (0.000s) [525.109099] Subtest idempotent: SUCCESS (0.007s) [525.152042] [118/133] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [525.246575] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [532.553496] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.310s) [532.689121] [119/133] (490s left) kms_flip (2x-flip-vs-rmfb-interruptible) [532.779702] Starting subtest: 2x-flip-vs-rmfb-interruptible [532.790332] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s) [532.867717] [120/133] (490s left) prime_busy (hang) [532.926478] Starting subtest: hang [532.928831] Starting dynamic subtest: rcs0 [559.409116] Dynamic subtest rcs0: SUCCESS (26.477s) [559.417611] Starting dynamic subtest: bcs0 [566.563761] Dynamic subtest bcs0: SUCCESS (7.153s) [566.572459] Starting dynamic subtest: vcs0 [573.533751] Dynamic subtest vcs0: SUCCESS (6.972s) [573.545478] Starting dynamic subtest: vcs1 [580.574433] Dynamic subtest vcs1: SUCCESS (7.040s) [580.585943] Starting dynamic subtest: vecs0 [587.544063] Dynamic subtest vecs0: SUCCESS (6.968s) [587.552723] Starting dynamic subtest: ccs0 [601.451560] Dynamic subtest ccs0: SUCCESS (13.906s) [601.454149] Subtest hang: SUCCESS (68.522s) [601.561604] [121/133] (422s left) gem_softpin (softpin) [601.640080] Starting subtest: softpin [633.954300] Subtest softpin: SUCCESS (32.308s) [634.078202] [122/133] (389s left) kms_invalid_mode (bad-hsync-end) [634.174185] Starting subtest: bad-hsync-end [634.176501] Starting dynamic subtest: pipe-A-eDP-1 [634.468791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s) [634.477592] Starting dynamic subtest: pipe-B-eDP-1 [634.479790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [634.488162] Starting dynamic subtest: pipe-C-eDP-1 [634.490270] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [634.498454] Starting dynamic subtest: pipe-D-eDP-1 [634.500357] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [634.502255] Subtest bad-hsync-end: SUCCESS (0.301s) [635.318329] [123/133] (388s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [635.411998] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [635.416176] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [635.530126] [124/133] (388s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [635.629748] Starting subtest: fbc-2p-primscrn-cur-indfb-move [635.634214] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [635.736409] [125/133] (388s left) vgem_basic (dmabuf-export) [635.775060] Starting subtest: dmabuf-export [635.819175] Subtest dmabuf-export: SUCCESS (0.046s) [635.945211] [126/133] (387s left) gem_shrink (reclaim) [636.006132] Starting subtest: reclaim [638.392248] Subtest reclaim: SUCCESS (2.386s) [638.502446] [127/133] (385s left) kms_big_fb (linear-8bpp-rotate-0) [638.624786] Starting subtest: linear-8bpp-rotate-0 [639.859775] Subtest linear-8bpp-rotate-0: SUCCESS (1.235s) [639.985140] [128/133] (383s left) kms_plane_scaling (planes-upscale-20x20) [640.076582] Starting subtest: planes-upscale-20x20 [640.078598] Starting dynamic subtest: pipe-A [640.137162] Dynamic subtest pipe-A: SUCCESS (0.062s) [640.147571] Starting dynamic subtest: pipe-B [641.249163] Dynamic subtest pipe-B: SUCCESS (1.111s) [641.260383] Starting dynamic subtest: pipe-C [642.359763] Dynamic subtest pipe-C: SUCCESS (1.109s) [642.368436] Starting dynamic subtest: pipe-D [643.505351] Dynamic subtest pipe-D: SUCCESS (1.145s) [643.507712] Subtest planes-upscale-20x20: SUCCESS (3.431s) [644.653679] [129/133] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [644.753931] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [644.758225] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [644.864475] [130/133] (379s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [644.918095] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [645.025259] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s) [645.099470] [131/133] (378s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [645.184894] Starting subtest: plane-scaler-unity-scaling-with-modifiers [645.187216] Starting dynamic subtest: pipe-A [645.522400] Dynamic subtest pipe-A: SUCCESS (0.339s) [645.531060] Starting dynamic subtest: pipe-B [646.933833] Dynamic subtest pipe-B: SUCCESS (1.410s) [646.952017] Starting dynamic subtest: pipe-C [648.368051] Dynamic subtest pipe-C: SUCCESS (1.432s) [648.377760] Starting dynamic subtest: pipe-D [649.802279] Dynamic subtest pipe-D: SUCCESS (1.433s) [649.804623] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.620s) [650.976030] [132/133] (373s left) gem_pxp (reject-modify-context-protection-on) [651.073804] Starting subtest: reject-modify-context-protection-on [651.076361] Subtest reject-modify-context-protection-on: SUCCESS (0.001s) [651.177852] [133/133] (372s left) kms_addfb_basic (unused-handle) [651.233332] Starting subtest: unused-handle [651.235253] Subtest unused-handle: SUCCESS (0.000s) [651.370479] Closing watchdogs results: parsing output: 0/ for test: kms_vrr results: parsing output: 1/ for test: gem_softpin results: parsing output: 2/ for test: syncobj_wait results: parsing output: 3/ for test: gem_ctx_persistence results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: syncobj_basic results: parsing output: 6/ for test: gem_wait results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_plane_cursor results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: gem_flink_basic results: parsing output: 12/ for test: i915_pm_rc6_residency results: parsing output: 13/ for test: gem_exec_flush results: parsing output: 14/ for test: kms_vrr results: parsing output: 15/ for test: kms_cursor_legacy results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: kms_color results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_pm_lpsp results: parsing output: 21/ for test: prime_self_import results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_ctx_persistence results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: gem_partial_pwrite_pread results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: api_intel_bb results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: kms_ccs results: parsing output: 34/ for test: kms_cursor_edge_walk results: parsing output: 35/ for test: kms_psr2_sf results: parsing output: 36/ for test: kms_rotation_crc results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_legacy_colorkey results: parsing output: 40/ for test: perf results: parsing output: 41/ for test: core_getversion results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: api_intel_allocator results: parsing output: 44/ for test: prime_mmap results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: gem_exec_balancer results: parsing output: 47/ for test: perf_pmu results: parsing output: 48/ for test: gem_exec_store results: parsing output: 49/ for test: gem_ctx_shared results: parsing output: 50/ for test: prime_mmap results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: i915_drm_fdinfo results: parsing output: 55/ for test: gen9_exec_parse results: parsing output: 56/ for test: gem_ctx_engines results: parsing output: 57/ for test: kms_chamelium_frames results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: i915_drm_fdinfo results: parsing output: 60/ for test: kms_universal_plane results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: gem_eio results: parsing output: 63/ for test: gem_spin_batch results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: gem_exec_nop results: parsing output: 67/ for test: kms_async_flips results: parsing output: 68/ for test: gem_exec_whisper results: parsing output: 69/ for test: gem_partial_pwrite_pread results: parsing output: 70/ for test: gem_exec_balancer results: parsing output: 71/ for test: kms_async_flips results: parsing output: 72/ for test: kms_plane_alpha_blend results: parsing output: 73/ for test: gem_exec_params results: parsing output: 74/ for test: gem_exec_params results: parsing output: 75/ for test: i915_power results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: kms_vblank results: parsing output: 78/ for test: kms_flip_scaled_crc results: parsing output: 79/ for test: kms_fence_pin_leak results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: kms_ccs results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_pxp results: parsing output: 86/ for test: kms_pm_rpm results: parsing output: 87/ for test: gem_mmap_gtt results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_chamelium_hpd results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_cursor_legacy results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: kms_dp_link_training results: parsing output: 98/ for test: prime_vgem results: parsing output: 99/ for test: gem_exec_schedule results: parsing output: 100/ for test: gem_exec_create results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_plane results: parsing output: 103/ for test: gem_render_copy results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: fbdev results: parsing output: 106/ for test: kms_concurrent results: parsing output: 107/ for test: vgem_slow results: parsing output: 108/ for test: gem_mmap_gtt results: parsing output: 109/ for test: kms_prop_blob results: parsing output: 110/ for test: tools_test results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: sysfs_heartbeat_interval results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: prime_busy results: parsing output: 120/ for test: gem_softpin results: parsing output: 121/ for test: kms_invalid_mode results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: vgem_basic results: parsing output: 125/ for test: gem_shrink results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: kms_plane_scaling results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_plane_scaling results: parsing output: 131/ for test: gem_pxp results: parsing output: 132/ for test: kms_addfb_basic Done.