[58.212007] Initializing watchdogs [58.212073] /dev/watchdog0 [58.232466] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [58.243215] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [58.246799] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.249594] [001/131] (960s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [58.448202] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [58.492052] [002/131] (960s left) syncobj_wait (invalid-multi-wait-unsubmitted) [58.558969] Starting subtest: invalid-multi-wait-unsubmitted [58.560012] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [58.689510] [003/131] (960s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [58.879200] Starting subtest: plane-scaler-unity-scaling-with-modifiers [58.880165] Starting dynamic subtest: pipe-A [59.481132] Dynamic subtest pipe-A: SUCCESS (0.605s) [59.496137] Starting dynamic subtest: pipe-B [60.130471] Dynamic subtest pipe-B: SUCCESS (0.652s) [60.149547] Starting dynamic subtest: pipe-C [60.828855] Dynamic subtest pipe-C: SUCCESS (0.701s) [60.848363] Starting dynamic subtest: pipe-D [61.477859] Dynamic subtest pipe-D: SUCCESS (0.651s) [61.478943] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.611s) [61.801535] [004/131] (957s left) sw_sync (alloc_fence_invalid_timeline) [61.846051] Starting subtest: alloc_fence_invalid_timeline [61.846982] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [61.920804] [005/131] (957s left) kms_frontbuffer_tracking (fbc-1p-rte) [62.115430] Starting subtest: fbc-1p-rte [65.611252] Subtest fbc-1p-rte: SUCCESS (3.508s) [65.862813] [006/131] (953s left) syncobj_timeline (wait-for-submit-delayed-submit) [65.937083] Starting subtest: wait-for-submit-delayed-submit [66.038734] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [66.134756] [007/131] (952s left) kms_pm_lpsp (screens-disabled) [67.329370] Starting subtest: screens-disabled [67.331298] Subtest screens-disabled: SKIP (0.000s) [67.458247] [008/131] (951s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [67.799382] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [67.937672] [009/131] (951s left) kms_async_flips (alternate-sync-async-flip-atomic) [68.127237] Starting subtest: alternate-sync-async-flip-atomic [68.362062] Starting dynamic subtest: pipe-A-DP-3 [70.656798] Dynamic subtest pipe-A-DP-3: SUCCESS (2.298s) [70.900440] Starting dynamic subtest: pipe-B-DP-3 [73.004802] Dynamic subtest pipe-B-DP-3: SUCCESS (2.114s) [73.230252] Starting dynamic subtest: pipe-C-DP-3 [75.335055] Dynamic subtest pipe-C-DP-3: SUCCESS (2.113s) [75.543776] Starting dynamic subtest: pipe-D-DP-3 [77.669226] Dynamic subtest pipe-D-DP-3: SUCCESS (2.132s) [77.671264] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.550s) [78.148188] [010/131] (941s left) kms_plane (pixel-format-source-clamping) [78.340215] Starting subtest: pixel-format-source-clamping [78.367372] Starting dynamic subtest: pipe-A-plane-0 [86.902034] Dynamic subtest pipe-A-plane-0: SUCCESS (8.533s) [86.910292] Starting dynamic subtest: pipe-A-plane-3 [91.302593] Dynamic subtest pipe-A-plane-3: SUCCESS (4.400s) [91.311438] Starting dynamic subtest: pipe-A-plane-5 [91.312569] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [91.575954] Starting dynamic subtest: pipe-B-plane-0 [99.559140] Dynamic subtest pipe-B-plane-0: SUCCESS (8.016s) [99.569235] Starting dynamic subtest: pipe-B-plane-3 [103.842641] Dynamic subtest pipe-B-plane-3: SUCCESS (4.283s) [103.851233] Starting dynamic subtest: pipe-B-plane-5 [103.852162] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [103.933887] Subtest pixel-format-source-clamping: SUCCESS (25.591s) [104.179557] [011/131] (915s left) kms_flip (2x-plain-flip-fb-recreate) [104.366982] Starting subtest: 2x-plain-flip-fb-recreate [104.381532] Subtest 2x-plain-flip-fb-recreate: SKIP (0.014s) [104.475077] [012/131] (914s left) kms_cursor_crc (cursor-onscreen-32x32) [104.748134] Starting subtest: cursor-onscreen-32x32 [104.810272] Subtest cursor-onscreen-32x32: SKIP (0.054s) [105.211179] [013/131] (914s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [105.401798] Starting subtest: cursorA-vs-flipA-varying-size [116.346930] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.944s) [116.603887] [014/131] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [116.798009] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [116.799762] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [116.951915] [015/131] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [117.146988] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [117.148885] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [117.265828] [016/131] (902s left) perf_pmu (invalid-init) [117.333096] Starting subtest: invalid-init [117.334077] Subtest invalid-init: SUCCESS (0.000s) [117.500824] [017/131] (902s left) prime_vgem (fence-wait) [117.638355] Starting subtest: fence-wait [117.639649] Starting dynamic subtest: rcs0 [118.696928] Dynamic subtest rcs0: SUCCESS (1.058s) [118.707479] Starting dynamic subtest: bcs0 [119.756271] Dynamic subtest bcs0: SUCCESS (1.057s) [119.765619] Starting dynamic subtest: vcs0 [120.806158] Dynamic subtest vcs0: SUCCESS (1.047s) [120.814688] Starting dynamic subtest: vcs1 [121.849232] Dynamic subtest vcs1: SUCCESS (1.041s) [121.861675] Starting dynamic subtest: vecs0 [122.893233] Dynamic subtest vecs0: SUCCESS (1.041s) [122.903656] Starting dynamic subtest: vecs1 [123.938437] Dynamic subtest vecs1: SUCCESS (1.043s) [123.951877] Starting dynamic subtest: ccs0 [124.984186] Dynamic subtest ccs0: SUCCESS (1.044s) [124.985203] Subtest fence-wait: SUCCESS (7.346s) [125.119721] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true [125.121957] [018/131] (894s left) gem_create (hog-create) [125.205374] Starting subtest: hog-create [125.206348] Starting dynamic subtest: lmem0 [157.480337] Dynamic subtest lmem0: SUCCESS (32.274s) [157.488931] Starting dynamic subtest: smem0 [189.756260] Dynamic subtest smem0: SUCCESS (32.275s) [189.757238] Subtest hog-create: SUCCESS (64.549s) [189.994812] [019/131] (829s left) sw_sync (sync_merge_same) [190.044078] Starting subtest: sync_merge_same [190.045035] Subtest sync_merge_same: SUCCESS (0.000s) [190.120277] [020/131] (829s left) perf (blocking-parameterized) [190.498919] Starting subtest: blocking-parameterized [210.532108] Subtest blocking-parameterized: SUCCESS (20.033s) [210.587604] [021/131] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [210.787985] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [210.789735] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [210.930477] [022/131] (809s left) gem_mmap_gtt (isolation) [211.011043] Subtest isolation: SKIP (0.000s) [211.096486] [023/131] (809s left) gem_exec_schedule (submit-late-slice) [211.193226] Starting subtest: submit-late-slice [211.194221] Starting dynamic subtest: rcs0 [211.268211] Dynamic subtest rcs0: SUCCESS (0.075s) [211.277069] Starting dynamic subtest: bcs0 [211.316944] Dynamic subtest bcs0: SUCCESS (0.048s) [211.325675] Starting dynamic subtest: vcs0 [211.366362] Dynamic subtest vcs0: SUCCESS (0.049s) [211.375436] Starting dynamic subtest: vcs1 [211.415039] Dynamic subtest vcs1: SUCCESS (0.048s) [211.423877] Starting dynamic subtest: vecs0 [211.467546] Dynamic subtest vecs0: SUCCESS (0.052s) [211.476920] Starting dynamic subtest: vecs1 [211.518173] Dynamic subtest vecs1: SUCCESS (0.050s) [211.527044] Starting dynamic subtest: ccs0 [211.571237] Dynamic subtest ccs0: SUCCESS (0.053s) [211.572187] Subtest submit-late-slice: SUCCESS (0.378s) [212.017833] [024/131] (808s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt) [212.218011] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt [212.219769] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s) [212.347246] [025/131] (807s left) gem_watchdog (default-virtual) [212.440980] Starting subtest: default-virtual [219.516357] Subtest default-virtual: SUCCESS (7.074s) [219.620564] [026/131] (800s left) kms_getfb (getfb2-accept-nv12) [219.817618] Starting subtest: getfb2-accept-nv12 [219.819926] Subtest getfb2-accept-nv12: SUCCESS (0.002s) [219.996418] [027/131] (800s left) gem_mmap (big-bo) [220.075025] Subtest big-bo: SKIP (0.000s) [220.161291] [028/131] (800s left) gem_mmap_offset (partial-remap) [220.237167] Starting subtest: partial-remap [220.238155] Starting dynamic subtest: lmem0 [220.242149] Dynamic subtest lmem0: SUCCESS (0.004s) [220.251185] Starting dynamic subtest: smem0 [220.253553] Dynamic subtest smem0: SUCCESS (0.004s) [220.254586] Subtest partial-remap: SUCCESS (0.009s) [220.419340] [029/131] (800s left) gem_softpin (allocator-fork) [220.506369] Starting subtest: allocator-fork [222.791499] Subtest allocator-fork: SUCCESS (2.285s) [222.954424] [030/131] (797s left) kms_vblank (query-idle) [223.147364] Starting subtest: query-idle [223.149584] Starting dynamic subtest: pipe-A-DP-3 [225.486326] Dynamic subtest pipe-A-DP-3: SUCCESS (2.336s) [225.506028] Starting dynamic subtest: pipe-D-DP-3 [227.743503] Dynamic subtest pipe-D-DP-3: SUCCESS (2.250s) [227.744382] Subtest query-idle: SUCCESS (4.595s) [227.956554] [031/131] (792s left) perf_pmu (busy-idle-no-semaphores) [228.028249] Starting subtest: busy-idle-no-semaphores [228.029204] Starting dynamic subtest: rcs0 [228.709832] Dynamic subtest rcs0: SUCCESS (0.680s) [228.721702] Starting dynamic subtest: bcs0 [229.370212] Dynamic subtest bcs0: SUCCESS (0.657s) [229.382987] Starting dynamic subtest: vcs0 [230.026414] Dynamic subtest vcs0: SUCCESS (0.655s) [230.039870] Starting dynamic subtest: vcs1 [230.683522] Dynamic subtest vcs1: SUCCESS (0.655s) [230.697066] Starting dynamic subtest: vecs0 [231.341116] Dynamic subtest vecs0: SUCCESS (0.655s) [231.354250] Starting dynamic subtest: vecs1 [231.997469] Dynamic subtest vecs1: SUCCESS (0.654s) [232.011435] Starting dynamic subtest: ccs0 [232.654365] Dynamic subtest ccs0: SUCCESS (0.654s) [232.656391] Subtest busy-idle-no-semaphores: SUCCESS (4.626s) [232.834852] [032/131] (787s left) kms_big_fb (4-tiled-8bpp-rotate-90) [233.048497] Starting subtest: 4-tiled-8bpp-rotate-90 [233.113916] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.065s) [233.313609] [033/131] (787s left) gem_pxp (reject-modify-context-protection-off-1) [235.920462] Starting subtest: reject-modify-context-protection-off-1 [235.922747] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [236.016801] [034/131] (784s left) gen9_exec_parse (bb-start-param) [236.109126] Subtest bb-start-param: SKIP (0.000s) [236.195723] [035/131] (784s left) gem_linear_blits (normal) [236.545784] Starting subtest: normal [243.704389] Subtest normal: SUCCESS (7.158s) [244.047338] [036/131] (776s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [244.276370] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [244.277331] Starting dynamic subtest: pipe-A-DP-3 [244.285929] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [244.295679] Starting dynamic subtest: pipe-B-DP-3 [244.304367] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [244.314028] Starting dynamic subtest: pipe-C-DP-3 [244.322551] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [244.332494] Starting dynamic subtest: pipe-D-DP-3 [244.344013] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [244.346159] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [244.767867] [037/131] (776s left) kms_joiner (basic-ultra-joiner) [244.970414] Starting subtest: basic-ultra-joiner [244.972136] Subtest basic-ultra-joiner: SKIP (0.000s) [245.078185] [038/131] (776s left) gem_exec_schedule (independent) [245.176395] Starting subtest: independent [245.177389] Starting dynamic subtest: rcs0 [245.551560] Dynamic subtest rcs0: SUCCESS (0.375s) [245.564292] Starting dynamic subtest: bcs0 [245.846596] Dynamic subtest bcs0: SUCCESS (0.294s) [245.862052] Starting dynamic subtest: vcs0 [246.142553] Dynamic subtest vcs0: SUCCESS (0.295s) [246.153669] Starting dynamic subtest: vcs1 [246.423526] Dynamic subtest vcs1: SUCCESS (0.280s) [246.436058] Starting dynamic subtest: vecs0 [246.711811] Dynamic subtest vecs0: SUCCESS (0.287s) [246.745296] Starting dynamic subtest: vecs1 [247.027374] Dynamic subtest vecs1: SUCCESS (0.314s) [247.039390] Starting dynamic subtest: ccs0 [247.320354] Dynamic subtest ccs0: SUCCESS (0.292s) [247.321558] Subtest independent: SUCCESS (2.144s) [247.735152] [039/131] (773s left) gem_softpin (evict-snoop) [247.824091] Starting subtest: evict-snoop [247.826206] Subtest evict-snoop: SKIP (0.000s) [247.951179] [040/131] (773s left) kms_draw_crc (draw-method-blt) [248.151415] Starting subtest: draw-method-blt [248.152285] Starting dynamic subtest: xrgb8888-untiled [248.485880] Dynamic subtest xrgb8888-untiled: SUCCESS (0.334s) [248.526977] Starting dynamic subtest: rgb565-untiled [248.819192] Dynamic subtest rgb565-untiled: SUCCESS (0.330s) [248.857838] Starting dynamic subtest: xrgb2101010-untiled [249.135744] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s) [249.172274] Starting dynamic subtest: xbgr16161616f-untiled [249.452490] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.314s) [249.490179] Starting dynamic subtest: xrgb8888-xtiled [249.619434] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.164s) [249.658389] Starting dynamic subtest: rgb565-xtiled [249.786134] Dynamic subtest rgb565-xtiled: SUCCESS (0.164s) [249.827504] Starting dynamic subtest: xrgb2101010-xtiled [249.935330] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.146s) [249.968327] Starting dynamic subtest: xbgr16161616f-xtiled [250.085803] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.148s) [250.122319] Starting dynamic subtest: xrgb8888-4tiled [250.252894] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.164s) [250.292599] Starting dynamic subtest: rgb565-4tiled [250.436150] Dynamic subtest rgb565-4tiled: SUCCESS (0.180s) [250.450198] Starting dynamic subtest: xrgb2101010-4tiled [250.569334] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.130s) [250.606911] Starting dynamic subtest: xbgr16161616f-4tiled [250.719247] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.147s) [250.721235] Subtest draw-method-blt: SUCCESS (2.570s) [250.938249] [041/131] (770s left) gem_fence_thrash (bo-write-verify-x) [250.985292] Starting subtest: bo-write-verify-x [251.024152] Subtest bo-write-verify-x: SKIP (0.037s) [251.097660] [042/131] (770s left) gem_fence_thrash (bo-copy) [251.145922] Starting subtest: bo-copy [251.176135] Subtest bo-copy: SKIP (0.030s) [251.250731] [043/131] (770s left) syncobj_timeline (multi-wait-submitted-signaled) [251.330172] Starting subtest: multi-wait-submitted-signaled [251.331102] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [251.473791] [044/131] (770s left) kms_feature_discovery (psr2) [251.671397] Starting subtest: psr2 [251.673201] Subtest psr2: SKIP (0.000s) [251.779913] [045/131] (769s left) kms_addfb_basic (bo-too-small) [251.979466] Starting subtest: bo-too-small [251.980408] Subtest bo-too-small: SUCCESS (0.000s) [252.132927] [046/131] (769s left) kms_psr (fbc-psr-sprite-mmap-gtt) [252.328206] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [252.379234] [047/131] (769s left) syncobj_wait (multi-wait-submitted-signaled) [252.459121] Starting subtest: multi-wait-submitted-signaled [252.460070] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [252.629411] [048/131] (769s left) gem_userptr_blits (process-exit-busy) [252.724367] Starting subtest: process-exit-busy [252.740267] Subtest process-exit-busy: SUCCESS (0.016s) [252.881688] [049/131] (769s left) kms_chamelium_frames (hdmi-frame-dump) [253.162678] Subtest hdmi-frame-dump: SKIP (0.000s) [253.323591] [050/131] (768s left) syncobj_timeline (wait-all-delayed-signal) [253.401262] Starting subtest: wait-all-delayed-signal [253.502856] Subtest wait-all-delayed-signal: SUCCESS (0.101s) [253.649028] [051/131] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [253.851172] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [253.852888] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [254.013729] [052/131] (768s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [254.213180] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [254.270659] [053/131] (767s left) api_intel_bb (simple-bb) [254.352221] Starting subtest: simple-bb [254.381131] Subtest simple-bb: SUCCESS (0.029s) [254.552420] [054/131] (767s left) i915_query (query-garbage) [254.632251] Starting subtest: query-garbage [254.633195] Subtest query-garbage: SUCCESS (0.000s) [254.796156] [055/131] (767s left) i915_module_load (reload-no-display) [254.843062] Starting subtest: reload-no-display [259.073603] Subtest reload-no-display: SUCCESS (4.230s) [259.103375] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [259.104345] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [259.106279] [056/131] (763s left) i915_pm_rpm (system-suspend-devices) [263.098146] Starting subtest: system-suspend-devices [270.832999] Subtest system-suspend-devices: SUCCESS (7.738s) [290.277338] [FACT i915_pm_rpm (system-suspend-devices)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [290.281025] [FACT i915_pm_rpm (system-suspend-devices)] new: kernel.kmod_is_loaded.i915: true [290.283964] [057/131] (751s left) kms_setmode (invalid-clone-single-crtc) [290.367689] Starting subtest: invalid-clone-single-crtc [290.370388] Subtest invalid-clone-single-crtc: SKIP (0.000s) [290.525188] [058/131] (751s left) gem_exec_capture (capture) [290.617630] Starting subtest: capture [290.618466] Starting dynamic subtest: rcs0-smem [291.576361] Dynamic subtest rcs0-smem: SUCCESS (0.957s) [291.588204] Starting dynamic subtest: rcs0-lmem0 [292.998438] Dynamic subtest rcs0-lmem0: SUCCESS (1.421s) [293.009543] Starting dynamic subtest: bcs0-smem [293.906404] Dynamic subtest bcs0-smem: SUCCESS (0.907s) [293.917798] Starting dynamic subtest: bcs0-lmem0 [294.801407] Dynamic subtest bcs0-lmem0: SUCCESS (0.894s) [294.812847] Starting dynamic subtest: vcs0-smem [295.705205] Dynamic subtest vcs0-smem: SUCCESS (0.904s) [295.716510] Starting dynamic subtest: vcs0-lmem0 [297.118369] Dynamic subtest vcs0-lmem0: SUCCESS (1.412s) [297.129513] Starting dynamic subtest: vcs1-smem [298.206397] Dynamic subtest vcs1-smem: SUCCESS (1.087s) [298.217649] Starting dynamic subtest: vcs1-lmem0 [299.112310] Dynamic subtest vcs1-lmem0: SUCCESS (0.905s) [299.123569] Starting dynamic subtest: vecs0-smem [300.294891] Dynamic subtest vecs0-smem: FAIL (1.161s) [300.305925] Starting dynamic subtest: vecs0-lmem0 [301.551697] Dynamic subtest vecs0-lmem0: FAIL (1.254s) [301.562781] Starting dynamic subtest: vecs1-smem [302.959857] Dynamic subtest vecs1-smem: FAIL (1.405s) [302.970887] Starting dynamic subtest: vecs1-lmem0 [303.975438] Dynamic subtest vecs1-lmem0: FAIL (1.009s) [303.986469] Starting dynamic subtest: ccs0-smem [305.365390] Dynamic subtest ccs0-smem: SUCCESS (1.419s) [305.377187] Starting dynamic subtest: ccs0-lmem0 [306.785349] Dynamic subtest ccs0-lmem0: SUCCESS (1.419s) [306.786343] Subtest capture: FAIL (16.167s) [306.921831] [059/131] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [307.125244] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [307.126943] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [307.278492] [060/131] (734s left) kms_cursor_crc (cursor-rapid-movement-64x21) [307.645384] Starting subtest: cursor-rapid-movement-64x21 [307.661380] Starting dynamic subtest: pipe-A-DP-3 [308.116933] Dynamic subtest pipe-A-DP-3: SUCCESS (0.454s) [308.163551] Starting dynamic subtest: pipe-D-DP-3 [308.546512] Dynamic subtest pipe-D-DP-3: SUCCESS (0.393s) [308.547541] Subtest cursor-rapid-movement-64x21: SUCCESS (0.901s) [309.029557] [061/131] (732s left) syncobj_wait (wait-for-submit-delayed-submit) [309.114523] Starting subtest: wait-for-submit-delayed-submit [309.216263] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [309.361876] [062/131] (732s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [309.451234] Starting subtest: yf-tiled-ccs-to-y-tiled [309.453642] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [309.663655] [063/131] (732s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [309.867425] Starting subtest: short-flip-before-cursor-toggle [310.869471] Subtest short-flip-before-cursor-toggle: SUCCESS (1.002s) [311.150146] [064/131] (730s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [311.348544] Starting subtest: nonblocking-crc-frame-sequence [311.350988] Starting dynamic subtest: pipe-A-DP-3 [312.112220] Dynamic subtest pipe-A-DP-3: SUCCESS (0.762s) [312.126933] Starting dynamic subtest: pipe-B-DP-3 [312.737515] Dynamic subtest pipe-B-DP-3: SUCCESS (0.623s) [312.753434] Starting dynamic subtest: pipe-C-DP-3 [313.364551] Dynamic subtest pipe-C-DP-3: SUCCESS (0.624s) [313.385282] Starting dynamic subtest: pipe-D-DP-3 [314.032619] Dynamic subtest pipe-D-DP-3: SUCCESS (0.666s) [314.033618] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.684s) [314.326651] [065/131] (727s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [314.523509] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [314.526118] Starting dynamic subtest: pipe-A-DP-3 [314.534911] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [314.546537] Starting dynamic subtest: pipe-B-DP-3 [314.555384] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [314.567080] Starting dynamic subtest: pipe-C-DP-3 [314.575538] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [314.586617] Starting dynamic subtest: pipe-D-DP-3 [314.597436] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [314.599508] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s) [314.990991] [066/131] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [315.192122] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [315.193791] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [315.326830] [067/131] (726s left) gem_mmap_gtt (basic-write-read-distinct) [315.408241] Subtest basic-write-read-distinct: SKIP (0.000s) [315.483566] [068/131] (726s left) kms_flip (plain-flip-fb-recreate) [315.675035] Starting subtest: plain-flip-fb-recreate [315.679415] Starting dynamic subtest: A-DP3 [323.822407] Dynamic subtest A-DP3: SUCCESS (8.142s) [323.845701] Starting dynamic subtest: B-DP3 [331.897400] Dynamic subtest B-DP3: SUCCESS (8.071s) [331.939579] Starting dynamic subtest: C-DP3 [339.984219] Dynamic subtest C-DP3: SUCCESS (8.079s) [340.026329] Starting dynamic subtest: D-DP3 [348.075375] Dynamic subtest D-DP3: SUCCESS (8.084s) [348.084550] Subtest plain-flip-fb-recreate: SUCCESS (32.404s) [348.463515] [069/131] (694s left) api_intel_allocator (simple-allocator) [348.543440] Starting subtest: simple-allocator [348.544401] Starting dynamic subtest: basic [348.572671] Dynamic subtest basic: SUCCESS (0.029s) [348.584293] Starting dynamic subtest: parallel-one [348.763185] Dynamic subtest parallel-one: SUCCESS (0.182s) [348.775126] Starting dynamic subtest: print [348.776063] Dynamic subtest print: SUCCESS (0.000s) [348.787989] Starting dynamic subtest: reuse [348.789178] Dynamic subtest reuse: SUCCESS (0.000s) [348.800989] Starting dynamic subtest: reserve [348.801995] Dynamic subtest reserve: SUCCESS (0.000s) [348.813272] Starting dynamic subtest: fork-reopen-allocator [348.814286] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [348.815397] Subtest simple-allocator: SUCCESS (0.231s) [348.915476] [070/131] (693s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [349.125384] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [350.392038] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.265s) [350.598362] [071/131] (692s left) kms_big_fb (linear-8bpp-rotate-180) [350.809369] Starting subtest: linear-8bpp-rotate-180 [352.459129] Subtest linear-8bpp-rotate-180: SUCCESS (1.648s) [352.619783] [072/131] (690s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [352.823174] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [352.824916] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [352.968869] [073/131] (689s left) kms_atomic_interruptible (legacy-setmode) [353.166456] Starting subtest: legacy-setmode [353.167393] Starting dynamic subtest: pipe-A-DP-3 [359.512548] Dynamic subtest pipe-A-DP-3: SUCCESS (6.342s) [359.513808] Subtest legacy-setmode: SUCCESS (6.345s) [359.765365] [074/131] (683s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [359.966147] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [362.332139] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.365s) [362.514386] [075/131] (680s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [362.715124] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [362.716825] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [362.869402] [076/131] (680s left) gem_exec_async (concurrent-writes) [362.961449] Starting subtest: concurrent-writes [362.969806] Starting dynamic subtest: rcs0 [363.003228] Dynamic subtest rcs0: SUCCESS (0.043s) [363.016506] Starting dynamic subtest: bcs0 [363.017419] Dynamic subtest bcs0: SUCCESS (0.012s) [363.029491] Starting dynamic subtest: vcs0 [363.030434] Dynamic subtest vcs0: SUCCESS (0.012s) [363.042367] Starting dynamic subtest: vcs1 [363.043324] Dynamic subtest vcs1: SUCCESS (0.011s) [363.055201] Starting dynamic subtest: vecs0 [363.056164] Dynamic subtest vecs0: SUCCESS (0.011s) [363.068050] Starting dynamic subtest: vecs1 [363.069000] Dynamic subtest vecs1: SUCCESS (0.011s) [363.080984] Starting dynamic subtest: ccs0 [363.082166] Dynamic subtest ccs0: SUCCESS (0.011s) [363.083218] Subtest concurrent-writes: SUCCESS (0.118s) [363.377203] [077/131] (679s left) gem_create (create-massive) [363.456757] Starting subtest: create-massive [363.457649] Subtest create-massive: SUCCESS (0.000s) [363.701202] [078/131] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [363.902134] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [363.903868] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [364.036609] [079/131] (679s left) gem_close_race (basic-threads) [364.153227] Starting subtest: basic-threads [365.329593] Subtest basic-threads: SUCCESS (1.176s) [365.654657] [080/131] (677s left) kms_cursor_crc (cursor-alpha-opaque) [365.849683] Starting subtest: cursor-alpha-opaque [365.852169] Starting dynamic subtest: pipe-A-DP-3 [366.423709] Dynamic subtest pipe-A-DP-3: SUCCESS (0.572s) [366.448640] Starting dynamic subtest: pipe-D-DP-3 [366.977475] Dynamic subtest pipe-D-DP-3: SUCCESS (0.548s) [366.978930] Subtest cursor-alpha-opaque: SUCCESS (1.127s) [367.604929] [081/131] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [367.806307] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [367.808120] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [367.948933] [082/131] (675s left) kms_flip (flip-vs-rmfb-interruptible) [368.150138] Starting subtest: flip-vs-rmfb-interruptible [368.154819] Starting dynamic subtest: A-DP3 [375.977179] Dynamic subtest A-DP3: SUCCESS (7.821s) [376.020052] Starting dynamic subtest: B-DP3 [383.746510] Dynamic subtest B-DP3: SUCCESS (7.764s) [383.776331] Starting dynamic subtest: C-DP3 [391.496036] Dynamic subtest C-DP3: SUCCESS (7.745s) [391.533032] Starting dynamic subtest: D-DP3 [399.238817] Dynamic subtest D-DP3: SUCCESS (7.737s) [399.244975] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.091s) [399.625626] [083/131] (643s left) gem_spin_batch (legacy) [399.724421] Starting subtest: legacy [399.725327] Starting dynamic subtest: default [402.983469] Dynamic subtest default: SUCCESS (3.256s) [403.005529] Starting dynamic subtest: render [406.228494] Dynamic subtest render: SUCCESS (3.240s) [406.248521] Starting dynamic subtest: bsd [409.471067] Dynamic subtest bsd: SUCCESS (3.237s) [409.492744] Starting dynamic subtest: bsd1 [412.716262] Dynamic subtest bsd1: SUCCESS (3.239s) [412.730616] Starting dynamic subtest: bsd2 [415.952196] Dynamic subtest bsd2: SUCCESS (3.230s) [415.973309] Starting dynamic subtest: blt [419.196835] Dynamic subtest blt: SUCCESS (3.238s) [419.217874] Starting dynamic subtest: vebox [422.438937] Dynamic subtest vebox: SUCCESS (3.236s) [422.440850] Subtest legacy: SUCCESS (22.714s) [422.672673] [084/131] (620s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [422.875179] Starting subtest: psr-rgb565-draw-pwrite [422.877030] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s) [423.025658] [085/131] (620s left) kms_rotation_crc (multiplane-rotation-cropping-top) [423.220587] Starting subtest: multiplane-rotation-cropping-top [434.993017] Subtest multiplane-rotation-cropping-top: SUCCESS (11.771s) [435.212777] [086/131] (608s left) kms_psr (psr-cursor-render) [435.412050] Subtest psr-cursor-render: SKIP (0.000s) [435.471443] [087/131] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [435.670168] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [435.672042] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [435.791909] [088/131] (608s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [435.999202] Starting subtest: yf-tiled-8bpp-rotate-90 [436.000973] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [436.126422] [089/131] (607s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [436.326051] Starting subtest: fbc-rgb101010-draw-mmap-gtt [436.327874] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [436.478055] [090/131] (607s left) gem_exec_balancer (semaphore) [436.574566] Starting subtest: semaphore [438.196396] Subtest semaphore: SUCCESS (1.622s) [438.629404] [091/131] (605s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [438.720503] Starting subtest: etime-multi-wait-all-available-unsubmitted [438.828810] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s) [438.965117] [092/131] (605s left) kms_color (legacy-gamma) [439.161561] Starting subtest: legacy-gamma [439.162463] Starting dynamic subtest: pipe-A-DP-3 [439.838859] Dynamic subtest pipe-A-DP-3: SUCCESS (0.676s) [439.863817] Starting dynamic subtest: pipe-B-DP-3 [440.456942] Dynamic subtest pipe-B-DP-3: SUCCESS (0.616s) [440.474472] Starting dynamic subtest: pipe-C-DP-3 [441.056293] Dynamic subtest pipe-C-DP-3: SUCCESS (0.597s) [441.072913] Starting dynamic subtest: pipe-D-DP-3 [441.675313] Dynamic subtest pipe-D-DP-3: SUCCESS (0.617s) [441.676368] Subtest legacy-gamma: SUCCESS (2.512s) [441.949935] [093/131] (602s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [442.147460] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [442.149206] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [442.264522] [094/131] (602s left) gem_exec_nop (basic-parallel) [442.356521] Starting subtest: basic-parallel [446.740062] Subtest basic-parallel: SUCCESS (4.383s) [447.055011] [095/131] (597s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [447.134308] Starting subtest: invalid-multi-wait-unsubmitted [447.135255] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [447.295645] [096/131] (597s left) gem_mmap_gtt (basic-small-copy-odd) [447.375322] Subtest basic-small-copy-odd: SKIP (0.000s) [447.453733] [097/131] (597s left) kms_psr (fbc-psr2-primary-render) [447.650052] Subtest fbc-psr2-primary-render: SKIP (0.000s) [447.712663] [098/131] (596s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [447.915682] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [447.918216] Starting dynamic subtest: pipe-A-valid-mode [447.993174] Dynamic subtest pipe-A-valid-mode: SKIP (0.075s) [447.995076] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.077s) [448.215012] [099/131] (596s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [448.411528] Starting subtest: bad-aux-stride-yf-tiled-ccs [448.414047] Starting dynamic subtest: pipe-A-DP-3 [448.422876] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [448.435124] Starting dynamic subtest: pipe-B-DP-3 [448.443906] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [448.455763] Starting dynamic subtest: pipe-C-DP-3 [448.464540] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [448.476366] Starting dynamic subtest: pipe-D-DP-3 [448.486968] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [448.489365] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s) [448.819736] [100/131] (596s left) gem_ctx_persistence (engines-hostile-preempt) [448.910175] Starting subtest: engines-hostile-preempt [448.911374] Starting dynamic subtest: rcs0 [449.023417] Dynamic subtest rcs0: SUCCESS (0.113s) [449.044580] Starting dynamic subtest: bcs0 [449.082096] Dynamic subtest bcs0: SUCCESS (0.057s) [449.099815] Starting dynamic subtest: vcs0 [449.135408] Dynamic subtest vcs0: SUCCESS (0.050s) [449.158075] Starting dynamic subtest: vcs1 [449.194597] Dynamic subtest vcs1: SUCCESS (0.057s) [449.232587] Starting dynamic subtest: vecs0 [449.264475] Dynamic subtest vecs0: SUCCESS (0.067s) [449.286157] Starting dynamic subtest: vecs1 [449.307347] Dynamic subtest vecs1: SUCCESS (0.041s) [449.328801] Starting dynamic subtest: ccs0 [449.357559] Dynamic subtest ccs0: SUCCESS (0.048s) [449.358800] Subtest engines-hostile-preempt: SUCCESS (0.448s) [449.551732] [101/131] (595s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [449.752138] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [449.753970] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [449.899418] [102/131] (595s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [449.977445] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [450.085511] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s) [450.235724] [103/131] (594s left) kms_vblank (ts-continuation-idle-hang) [450.429599] Starting subtest: ts-continuation-idle-hang [450.432203] Starting dynamic subtest: pipe-A-DP-3 [476.529688] Dynamic subtest pipe-A-DP-3: SUCCESS (26.096s) [476.545253] Starting dynamic subtest: pipe-D-DP-3 [501.540413] Dynamic subtest pipe-D-DP-3: SUCCESS (25.005s) [501.541346] Subtest ts-continuation-idle-hang: SUCCESS (51.107s) [501.803451] [104/131] (543s left) kms_plane_scaling (planes-upscale-factor-0-25) [502.001604] Starting subtest: planes-upscale-factor-0-25 [502.002523] Starting dynamic subtest: pipe-A [502.097518] Dynamic subtest pipe-A: SUCCESS (0.095s) [502.109557] Starting dynamic subtest: pipe-B [502.333615] Dynamic subtest pipe-B: SUCCESS (0.235s) [502.350941] Starting dynamic subtest: pipe-C [502.583411] Dynamic subtest pipe-C: SUCCESS (0.248s) [502.600238] Starting dynamic subtest: pipe-D [502.817347] Dynamic subtest pipe-D: SUCCESS (0.232s) [502.818534] Subtest planes-upscale-factor-0-25: SUCCESS (0.816s) [503.152945] [105/131] (542s left) api_intel_allocator (open-vm) [503.230341] Starting subtest: open-vm [503.257985] Subtest open-vm: SUCCESS (0.028s) [503.417215] [106/131] (541s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [503.619065] Starting subtest: fbc-indfb-scaledprimary [507.182972] Subtest fbc-indfb-scaledprimary: SUCCESS (3.563s) [507.416900] [107/131] (538s left) i915_drm_fdinfo (virtual-idle) [507.488421] Starting subtest: virtual-idle [511.096063] Subtest virtual-idle: SUCCESS (3.603s) [511.188166] [108/131] (534s left) kms_big_fb (x-tiled-addfb) [511.400179] Starting subtest: x-tiled-addfb [511.401131] Subtest x-tiled-addfb: SUCCESS (0.000s) [511.547422] [109/131] (534s left) kms_psr (fbc-pr-cursor-plane-onoff) [511.743223] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [511.812766] [110/131] (533s left) gem_lmem_swapping (verify) [514.696375] Starting subtest: verify [514.697377] Starting dynamic subtest: lmem0 [549.783812] Dynamic subtest lmem0: SUCCESS (35.085s) [549.784850] Subtest verify: SUCCESS (35.086s) [551.244800] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [551.246280] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true [551.248199] [111/131] (494s left) kms_chamelium_audio (dp-audio-edid) [553.063064] Subtest dp-audio-edid: SKIP (0.000s) [553.221218] [FACT kms_chamelium_audio (dp-audio-edid)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [553.224766] [FACT kms_chamelium_audio (dp-audio-edid)] new: kernel.kmod_is_loaded.i915: true [553.227811] [112/131] (492s left) drm_read (short-buffer-wakeup) [553.504946] Starting subtest: short-buffer-wakeup [585.720062] Subtest short-buffer-wakeup: SUCCESS (32.213s) [585.943117] [113/131] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [586.148451] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [586.150239] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [586.282648] [114/131] (459s left) kms_psr (psr2-cursor-plane-move) [586.486174] Subtest psr2-cursor-plane-move: SKIP (0.000s) [586.553896] [115/131] (459s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [586.764417] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [586.766194] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [586.895468] [116/131] (459s left) prime_self_import (basic-llseek-size) [586.945187] Starting subtest: basic-llseek-size [586.975786] Subtest basic-llseek-size: SUCCESS (0.032s) [587.125291] [117/131] (458s left) kms_lease (page-flip-implicit-plane) [587.322567] Starting subtest: page-flip-implicit-plane [587.325073] Starting dynamic subtest: pipe-A-DP-3 [587.736241] Dynamic subtest pipe-A-DP-3: SUCCESS (0.411s) [587.755466] Starting dynamic subtest: pipe-B-DP-3 [588.086585] Dynamic subtest pipe-B-DP-3: SUCCESS (0.347s) [588.114216] Starting dynamic subtest: pipe-C-DP-3 [588.430992] Dynamic subtest pipe-C-DP-3: SUCCESS (0.339s) [588.449798] Starting dynamic subtest: pipe-D-DP-3 [588.768222] Dynamic subtest pipe-D-DP-3: SUCCESS (0.334s) [588.769283] Subtest page-flip-implicit-plane: SUCCESS (1.446s) [589.039711] [118/131] (457s left) gem_exec_store (dword) [589.138355] Starting subtest: dword [589.139379] Starting dynamic subtest: rcs0 [589.228815] Dynamic subtest rcs0: SUCCESS (0.090s) [589.250896] Starting dynamic subtest: bcs0 [589.274084] Dynamic subtest bcs0: SUCCESS (0.044s) [589.302102] Starting dynamic subtest: vcs0 [589.320070] Dynamic subtest vcs0: SUCCESS (0.044s) [589.343177] Starting dynamic subtest: vcs1 [589.363902] Dynamic subtest vcs1: SUCCESS (0.042s) [589.383649] Starting dynamic subtest: vecs0 [589.407392] Dynamic subtest vecs0: SUCCESS (0.042s) [589.427175] Starting dynamic subtest: vecs1 [589.450812] Dynamic subtest vecs1: SUCCESS (0.042s) [589.470950] Starting dynamic subtest: ccs0 [589.494852] Dynamic subtest ccs0: SUCCESS (0.042s) [589.496196] Subtest dword: SUCCESS (0.357s) [589.752050] [119/131] (456s left) gem_ctx_shared (exec-single-timeline) [589.846268] Starting subtest: exec-single-timeline [589.847224] Starting dynamic subtest: rcs0 [590.934409] Dynamic subtest rcs0: SUCCESS (1.086s) [590.949661] Starting dynamic subtest: bcs0 [591.958433] Dynamic subtest bcs0: SUCCESS (1.019s) [591.973498] Starting dynamic subtest: vcs0 [592.982381] Dynamic subtest vcs0: SUCCESS (1.019s) [592.997648] Starting dynamic subtest: vcs1 [594.007341] Dynamic subtest vcs1: SUCCESS (1.019s) [594.022049] Starting dynamic subtest: vecs0 [595.030275] Dynamic subtest vecs0: SUCCESS (1.019s) [595.045589] Starting dynamic subtest: vecs1 [596.054516] Dynamic subtest vecs1: SUCCESS (1.019s) [596.069757] Starting dynamic subtest: ccs0 [597.078396] Dynamic subtest ccs0: SUCCESS (1.019s) [597.082764] Subtest exec-single-timeline: SUCCESS (7.233s) [597.332169] [120/131] (448s left) gem_exec_whisper (basic-normal-all) [597.422635] Starting subtest: basic-normal-all [599.536144] Subtest basic-normal-all: SUCCESS (2.112s) [599.782080] [121/131] (446s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [599.862430] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [599.863522] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [600.019527] [122/131] (446s left) kms_pwrite_crc [601.115911] [123/131] (445s left) kms_big_fb (y-tiled-32bpp-rotate-90) [601.324166] Starting subtest: y-tiled-32bpp-rotate-90 [601.325784] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [601.472010] [124/131] (445s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [603.009314] Starting subtest: modeset-lpsp-stress-no-wait [603.239223] Subtest modeset-lpsp-stress-no-wait: SKIP (0.229s) [603.458320] [125/131] (443s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [603.653545] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [603.656100] Starting dynamic subtest: pipe-A-DP-3 [603.659795] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [603.671425] Starting dynamic subtest: pipe-B-DP-3 [603.674964] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [603.686422] Starting dynamic subtest: pipe-C-DP-3 [603.690040] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [603.701267] Starting dynamic subtest: pipe-D-DP-3 [603.704785] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [603.706976] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.007s) [604.130960] [126/131] (442s left) gem_exec_params (invalid-fence-in-submit) [604.218248] Starting subtest: invalid-fence-in-submit [604.222112] Subtest invalid-fence-in-submit: SUCCESS (0.002s) [604.400360] [127/131] (442s left) vgem_basic (sysfs) [604.447953] Starting subtest: sysfs [604.448932] Subtest sysfs: SUCCESS (0.000s) [604.534804] [128/131] (442s left) syncobj_wait (multi-wait-for-submit-signaled) [604.616435] Starting subtest: multi-wait-for-submit-signaled [604.617375] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [604.735894] [129/131] (442s left) i915_selftest (mock) [605.954465] Starting subtest: mock [605.955440] Starting dynamic subtest: sanitycheck [606.816443] Dynamic subtest sanitycheck: SUCCESS (0.860s) [606.837552] Starting dynamic subtest: shmem [607.692928] Dynamic subtest shmem: SUCCESS (0.871s) [607.710989] Starting dynamic subtest: fence [615.990750] Dynamic subtest fence: SUCCESS (8.293s) [616.006391] Starting dynamic subtest: scatterlist [617.844846] Dynamic subtest scatterlist: SUCCESS (1.852s) [617.855049] Starting dynamic subtest: syncmap [620.753334] Dynamic subtest syncmap: SUCCESS (2.906s) [620.765757] Starting dynamic subtest: uncore [621.577500] Dynamic subtest uncore: SUCCESS (0.820s) [621.594563] Starting dynamic subtest: ring [622.429808] Dynamic subtest ring: SUCCESS (0.848s) [622.441994] Starting dynamic subtest: engine [623.265687] Dynamic subtest engine: SUCCESS (0.832s) [623.283389] Starting dynamic subtest: timelines [627.915528] Dynamic subtest timelines: SUCCESS (4.645s) [627.943458] Starting dynamic subtest: requests [630.765978] Dynamic subtest requests: SUCCESS (2.848s) [630.777410] Starting dynamic subtest: objects [631.722018] Dynamic subtest objects: SUCCESS (0.954s) [631.735837] Starting dynamic subtest: phys [632.742073] Dynamic subtest phys: SUCCESS (1.019s) [632.753410] Starting dynamic subtest: dmabuf [633.684052] Dynamic subtest dmabuf: SUCCESS (0.941s) [633.696163] Starting dynamic subtest: vma [641.862196] Dynamic subtest vma: SUCCESS (8.176s) [641.898526] Starting dynamic subtest: evict [643.701159] Dynamic subtest evict: SUCCESS (1.836s) [643.717521] Starting dynamic subtest: gtt [647.712860] Dynamic subtest gtt: SUCCESS (4.010s) [647.727430] Starting dynamic subtest: hugepages [648.842955] Dynamic subtest hugepages: SUCCESS (1.129s) [648.853222] Starting dynamic subtest: memory_region [653.911403] Dynamic subtest memory_region: SUCCESS (5.067s) [653.912603] Subtest mock: SUCCESS (47.955s) [653.981445] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [653.982632] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [653.984772] [130/131] (393s left) kms_addfb_basic (addfb25-modifier-no-flag) [655.702652] Starting subtest: addfb25-modifier-no-flag [655.703576] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [655.777279] [FACT kms_addfb_basic (addfb25-modifier-no-flag)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [655.780942] [FACT kms_addfb_basic (addfb25-modifier-no-flag)] new: kernel.kmod_is_loaded.i915: true [655.783718] [131/131] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [655.998223] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [656.000113] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [656.139267] Closing watchdogs results: parsing output: 0/ for test: kms_psr2_sf results: parsing output: 1/ for test: syncobj_wait results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: sw_sync results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_pm_lpsp results: parsing output: 7/ for test: kms_chamelium_edid results: parsing output: 8/ for test: kms_async_flips results: parsing output: 9/ for test: kms_plane results: parsing output: 10/ for test: kms_flip results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: kms_cursor_legacy results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: perf_pmu results: parsing output: 16/ for test: prime_vgem results: parsing output: 17/ for test: gem_create results: parsing output: 18/ for test: sw_sync results: parsing output: 19/ for test: perf results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_mmap_gtt results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_watchdog results: parsing output: 25/ for test: kms_getfb results: parsing output: 26/ for test: gem_mmap results: parsing output: 27/ for test: gem_mmap_offset results: parsing output: 28/ for test: gem_softpin results: parsing output: 29/ for test: kms_vblank results: parsing output: 30/ for test: perf_pmu results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: gem_pxp results: parsing output: 33/ for test: gen9_exec_parse results: parsing output: 34/ for test: gem_linear_blits results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: kms_joiner results: parsing output: 37/ for test: gem_exec_schedule results: parsing output: 38/ for test: gem_softpin results: parsing output: 39/ for test: kms_draw_crc results: parsing output: 40/ for test: gem_fence_thrash results: parsing output: 41/ for test: gem_fence_thrash results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_feature_discovery results: parsing output: 44/ for test: kms_addfb_basic results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: syncobj_wait results: parsing output: 47/ for test: gem_userptr_blits results: parsing output: 48/ for test: kms_chamelium_frames results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_psr2_sf results: parsing output: 52/ for test: api_intel_bb results: parsing output: 53/ for test: i915_query results: parsing output: 54/ for test: i915_module_load results: parsing output: 55/ for test: i915_pm_rpm results: parsing output: 56/ for test: kms_setmode results: parsing output: 57/ for test: gem_exec_capture results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_cursor_crc results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: gem_render_copy results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: kms_pipe_crc_basic results: parsing output: 64/ for test: kms_ccs results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_mmap_gtt results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: api_intel_allocator results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_atomic_interruptible results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_exec_async results: parsing output: 76/ for test: gem_create results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_close_race results: parsing output: 79/ for test: kms_cursor_crc results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: gem_spin_batch results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_rotation_crc results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_exec_balancer results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_color results: parsing output: 92/ for test: kms_cursor_legacy results: parsing output: 93/ for test: gem_exec_nop results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: gem_mmap_gtt results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_flip_scaled_crc results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: gem_ctx_persistence results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: syncobj_timeline results: parsing output: 102/ for test: kms_vblank results: parsing output: 103/ for test: kms_plane_scaling results: parsing output: 104/ for test: api_intel_allocator results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: kms_big_fb results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: gem_lmem_swapping results: parsing output: 110/ for test: kms_chamelium_audio results: parsing output: 111/ for test: drm_read results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: prime_self_import results: parsing output: 116/ for test: kms_lease results: parsing output: 117/ for test: gem_exec_store results: parsing output: 118/ for test: gem_ctx_shared results: parsing output: 119/ for test: gem_exec_whisper results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: kms_pwrite_crc results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_ccs results: parsing output: 125/ for test: gem_exec_params results: parsing output: 126/ for test: vgem_basic results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: i915_selftest results: parsing output: 129/ for test: kms_addfb_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.