[57.888297] Initializing watchdogs [57.888344] /dev/watchdog0 [57.902400] [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] [57.906872] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.909612] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.913179] [001/133] (960s left) kms_vblank (wait-forked) [58.029855] Starting subtest: wait-forked [58.031737] Starting dynamic subtest: pipe-A-eDP-1 [59.868155] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.849s) [59.882678] Starting dynamic subtest: pipe-D-eDP-1 [62.407425] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s) [62.409715] Subtest wait-forked: SUCCESS (4.396s) [63.263174] [002/133] (955s left) kms_sequence (get-forked-busy) [63.355426] Starting subtest: get-forked-busy [63.357833] Starting dynamic subtest: pipe-A-eDP-1 [65.296697] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s) [65.308078] Starting dynamic subtest: pipe-B-eDP-1 [67.867785] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.575s) [67.876680] Starting dynamic subtest: pipe-C-eDP-1 [70.486622] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s) [70.495556] Starting dynamic subtest: pipe-D-eDP-1 [73.120397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.635s) [73.122648] Subtest get-forked-busy: SUCCESS (9.780s) [73.985762] [003/133] (944s left) syncobj_timeline (invalid-query-zero-handles) [74.039784] Starting subtest: invalid-query-zero-handles [74.042202] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [74.136172] [004/133] (944s left) api_intel_bb (crc32) [74.190731] Starting subtest: crc32 [74.192702] Starting dynamic subtest: rcs0-smem0 [74.478022] Dynamic subtest rcs0-smem0: SUCCESS (0.287s) [74.485977] Starting dynamic subtest: bcs0-smem0 [74.800358] Dynamic subtest bcs0-smem0: SUCCESS (0.320s) [74.811048] Starting dynamic subtest: vcs0-smem0 [75.184511] Dynamic subtest vcs0-smem0: SUCCESS (0.383s) [75.193810] Starting dynamic subtest: vcs1-smem0 [75.564352] Dynamic subtest vcs1-smem0: SUCCESS (0.377s) [75.574660] Starting dynamic subtest: vecs0-smem0 [75.914702] Dynamic subtest vecs0-smem0: SUCCESS (0.350s) [75.924669] Starting dynamic subtest: ccs0-smem0 [76.260575] Dynamic subtest ccs0-smem0: SUCCESS (0.345s) [76.263888] Subtest crc32: SUCCESS (2.073s) [76.382870] [005/133] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [76.479578] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [83.819902] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.344s) [83.944521] [006/133] (934s left) gem_exec_fence (syncobj-invalid-flags) [84.389260] Starting subtest: syncobj-invalid-flags [84.391461] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [85.997639] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [86.005996] [007/133] (932s left) gem_exec_schedule (thriceslice) [86.073895] Starting subtest: thriceslice [86.075954] Starting dynamic subtest: rcs0 [86.093425] Dynamic subtest rcs0: SUCCESS (0.030s) [86.104150] Starting dynamic subtest: bcs0 [86.145036] Dynamic subtest bcs0: SUCCESS (0.051s) [86.155546] Starting dynamic subtest: vcs0 [86.197290] Dynamic subtest vcs0: SUCCESS (0.051s) [86.205635] Starting dynamic subtest: vcs1 [86.229906] Dynamic subtest vcs1: SUCCESS (0.032s) [86.238344] Starting dynamic subtest: vecs0 [86.259809] Dynamic subtest vecs0: SUCCESS (0.029s) [86.268538] Starting dynamic subtest: ccs0 [86.289646] Dynamic subtest ccs0: SUCCESS (0.029s) [86.291983] Subtest thriceslice: SUCCESS (0.227s) [86.595604] [008/133] (932s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [86.704933] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [86.709342] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [86.808146] [009/133] (931s left) syncobj_wait (wait-any-complex) [86.869665] Starting subtest: wait-any-complex [86.933614] Subtest wait-any-complex: SUCCESS (0.062s) [87.005207] [010/133] (931s left) gem_userptr_blits (sync-overlap) [87.082257] Starting subtest: sync-overlap [87.084119] Subtest sync-overlap: SUCCESS (0.000s) [87.218462] [011/133] (931s left) gem_exec_schedule (implicit-read-write) [87.289984] Starting subtest: implicit-read-write [87.292455] Starting dynamic subtest: rcs0 [87.377853] Dynamic subtest rcs0: SUCCESS (0.099s) [87.389658] Starting dynamic subtest: vcs0 [87.466683] Dynamic subtest vcs0: SUCCESS (0.089s) [87.477011] Starting dynamic subtest: vcs1 [87.546616] Dynamic subtest vcs1: SUCCESS (0.080s) [87.558051] Starting dynamic subtest: vecs0 [87.619568] Dynamic subtest vecs0: SUCCESS (0.073s) [87.629083] Starting dynamic subtest: ccs0 [87.702930] Dynamic subtest ccs0: SUCCESS (0.083s) [87.705408] Subtest implicit-read-write: SUCCESS (0.425s) [88.993977] [012/133] (929s left) gem_create (create-ext-cpu-access-sanity-check) [89.159036] Starting subtest: create-ext-cpu-access-sanity-check [89.163545] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [89.232483] [013/133] (929s left) gem_mmap_gtt (hang-user) [89.286610] Subtest hang-user: SKIP (0.000s) [89.352083] [014/133] (929s left) kms_flip (2x-busy-flip) [89.450522] Starting subtest: 2x-busy-flip [89.458753] Subtest 2x-busy-flip: SKIP (0.011s) [89.535348] [015/133] (929s left) gem_ppgtt (blt-vs-render-ctxn) [89.595949] Starting subtest: blt-vs-render-ctxN [122.481800] Subtest blt-vs-render-ctxN: SUCCESS (32.884s) [122.608421] [016/133] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [122.759276] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [122.763449] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [122.841525] [017/133] (896s left) syncobj_timeline (single-wait-all-available-signaled) [122.908662] Starting subtest: single-wait-all-available-signaled [122.911136] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [122.993366] [018/133] (896s left) gem_mmap_gtt (cpuset-medium-copy-xy) [123.056675] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [123.115562] [019/133] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [123.214101] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [123.218040] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [123.312494] [020/133] (895s left) gem_caching (writes) [123.383473] Subtest writes: SKIP (0.000s) [123.447643] [021/133] (895s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [123.539310] Starting subtest: fbc-rgb101010-draw-render [128.161872] Subtest fbc-rgb101010-draw-render: SUCCESS (4.614s) [129.362315] [022/133] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [129.458990] Starting subtest: bad-pixel-format-y-tiled-ccs [129.461290] Starting dynamic subtest: pipe-A-eDP-1 [129.483984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [129.492192] Starting dynamic subtest: pipe-B-eDP-1 [129.513680] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [129.521288] Starting dynamic subtest: pipe-C-eDP-1 [129.543781] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [129.551140] Starting dynamic subtest: pipe-D-eDP-1 [129.572977] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [129.577413] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [131.629417] [023/133] (887s left) gem_exec_reloc (basic-gtt) [131.691604] Subtest basic-gtt: SKIP (0.000s) [131.746488] [024/133] (887s left) core_getversion (basic) [131.784197] Starting subtest: basic [131.788357] Subtest basic: SUCCESS (0.000s) [131.848173] [025/133] (887s left) kms_psr (psr-primary-blt) [131.965363] Starting subtest: psr-primary-blt [131.967678] Starting dynamic subtest: eDP-1 [133.733543] Dynamic subtest eDP-1: SUCCESS (1.767s) [133.736106] Subtest psr-primary-blt: SUCCESS (1.769s) [134.600831] [026/133] (884s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [134.699432] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [134.701872] Starting dynamic subtest: pipe-A-eDP-1 [141.489434] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.794s) [141.498713] Starting dynamic subtest: pipe-B-eDP-1 [148.452851] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.962s) [148.454798] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.758s) [149.302558] [027/133] (870s left) kms_lease (page-flip-implicit-plane) [149.390686] Starting subtest: page-flip-implicit-plane [149.393207] Starting dynamic subtest: pipe-A-eDP-1 [149.883677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s) [149.893788] Starting dynamic subtest: pipe-B-eDP-1 [151.050122] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s) [151.060244] Starting dynamic subtest: pipe-C-eDP-1 [152.169842] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s) [152.182684] Starting dynamic subtest: pipe-D-eDP-1 [153.294580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s) [153.296889] Subtest page-flip-implicit-plane: SUCCESS (3.904s) [154.132792] [028/133] (865s left) kms_chamelium_color (gamma) [154.238219] Subtest gamma: SKIP (0.000s) [154.285272] [029/133] (865s left) i915_hangman (detector) [154.349592] Starting subtest: detector [154.351952] Starting dynamic subtest: rcs0 [165.877426] Dynamic subtest rcs0: SUCCESS (11.528s) [165.895425] Starting dynamic subtest: bcs0 [177.910033] Dynamic subtest bcs0: SUCCESS (12.030s) [177.920846] Starting dynamic subtest: vcs0 [189.814589] Dynamic subtest vcs0: SUCCESS (11.901s) [189.825851] Starting dynamic subtest: vcs1 [200.821818] Dynamic subtest vcs1: SUCCESS (11.006s) [200.833043] Starting dynamic subtest: vecs0 [210.806571] Dynamic subtest vecs0: SUCCESS (9.982s) [210.817827] Starting dynamic subtest: ccs0 [221.878057] Dynamic subtest ccs0: SUCCESS (11.069s) [221.881081] Subtest detector: SUCCESS (67.528s) [221.957774] [030/133] (797s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [222.058152] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [222.060548] Starting dynamic subtest: pipe-A [223.183876] Dynamic subtest pipe-A: SUCCESS (1.129s) [223.191506] Starting dynamic subtest: pipe-B [225.503432] Dynamic subtest pipe-B: SUCCESS (2.319s) [225.512573] Starting dynamic subtest: pipe-C [226.718437] Dynamic subtest pipe-C: SUCCESS (1.214s) [226.728366] Starting dynamic subtest: pipe-D [227.956319] Dynamic subtest pipe-D: SUCCESS (1.236s) [227.958588] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.901s) [229.134357] [031/133] (790s left) gem_readwrite (write-bad-handle) [229.207905] Subtest write-bad-handle: SKIP (0.000s) [229.263613] [032/133] (790s left) gem_lmem_evict (dontneed-evict-race) [229.303991] Subtest dontneed-evict-race: SKIP (0.000s) [229.339276] [033/133] (790s left) gem_exec_params (invalid-batch-start-offset) [229.404516] Starting subtest: invalid-batch-start-offset [229.406720] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [229.530280] [034/133] (790s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [229.629992] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [229.634397] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [229.725062] [035/133] (790s left) gem_exec_parallel (contexts) [229.785185] Starting subtest: contexts [229.787604] Starting dynamic subtest: rcs0 [233.251759] Dynamic subtest rcs0: SUCCESS (3.465s) [233.262626] Starting dynamic subtest: bcs0 [237.446890] Dynamic subtest bcs0: SUCCESS (4.193s) [237.456088] Starting dynamic subtest: vcs0 [243.340915] Dynamic subtest vcs0: SUCCESS (5.842s) [243.352223] Starting dynamic subtest: vcs1 [247.458823] Dynamic subtest vcs1: SUCCESS (4.166s) [247.468334] Starting dynamic subtest: vecs0 [253.198451] Dynamic subtest vecs0: SUCCESS (5.687s) [253.209551] Starting dynamic subtest: ccs0 [257.611330] Dynamic subtest ccs0: SUCCESS (4.462s) [257.613968] Subtest contexts: SUCCESS (27.826s) [257.807401] [036/133] (762s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render) [257.910779] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render [264.816501] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.909s) [264.942072] [037/133] (754s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [265.055013] Starting subtest: cursorA-vs-flipA-legacy [276.226298] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.170s) [277.068865] [038/133] (742s left) kms_feature_discovery (psr1) [277.155177] Starting subtest: psr1 [277.157338] Subtest psr1: SUCCESS (0.000s) [277.228658] [039/133] (742s left) gen9_exec_parse (bb-start-cmd) [277.293407] Subtest bb-start-cmd: SKIP (0.000s) [277.361373] [040/133] (742s left) gem_exec_async (forked-writes) [277.416161] Starting subtest: forked-writes [277.418342] Starting dynamic subtest: rcs0 [277.444170] Dynamic subtest rcs0: SUCCESS (0.030s) [277.455660] Starting dynamic subtest: bcs0 [277.466533] Dynamic subtest bcs0: SUCCESS (0.022s) [277.475023] Starting dynamic subtest: vcs0 [277.487344] Dynamic subtest vcs0: SUCCESS (0.020s) [277.495975] Starting dynamic subtest: vcs1 [277.511162] Dynamic subtest vcs1: SUCCESS (0.023s) [277.522283] Starting dynamic subtest: vecs0 [277.539734] Dynamic subtest vecs0: SUCCESS (0.028s) [277.548054] Starting dynamic subtest: ccs0 [277.568504] Dynamic subtest ccs0: SUCCESS (0.028s) [277.570739] Subtest forked-writes: SUCCESS (0.156s) [277.816861] [041/133] (742s left) kms_properties (colorop-properties-atomic) [277.899283] Starting subtest: colorop-properties-atomic [277.901659] Starting dynamic subtest: pipe-A-eDP-1 [278.252980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s) [278.261798] Starting dynamic subtest: pipe-B-eDP-1 [279.335561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s) [279.343982] Starting dynamic subtest: pipe-C-eDP-1 [280.367516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.030s) [280.376849] Starting dynamic subtest: pipe-D-eDP-1 [281.414198] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.044s) [281.416464] Subtest colorop-properties-atomic: SUCCESS (3.515s) [282.219543] [042/133] (737s left) gem_madvise (dontneed-before-mmap) [282.262729] Starting subtest: dontneed-before-mmap [282.279165] Subtest dontneed-before-mmap: SUCCESS (0.018s) [282.380583] [043/133] (737s left) gem_mmap_offset (ptrace) [282.441509] Starting subtest: ptrace [282.445555] Starting dynamic subtest: smem0-wb [282.464906] Dynamic subtest smem0-wb: SUCCESS (0.019s) [282.473080] Starting dynamic subtest: smem0-wc [282.484139] Dynamic subtest smem0-wc: SUCCESS (0.018s) [282.492032] Starting dynamic subtest: smem0-uc [282.510421] Dynamic subtest smem0-uc: SUCCESS (0.026s) [282.512605] Subtest ptrace: SUCCESS (0.071s) [282.627877] [044/133] (737s left) perf_pmu (interrupts) [282.667181] Starting subtest: interrupts [283.750072] Subtest interrupts: SUCCESS (1.082s) [283.862696] [045/133] (736s left) kms_invalid_mode (bad-hsync-start) [283.952324] Starting subtest: bad-hsync-start [283.954451] Starting dynamic subtest: pipe-A-eDP-1 [284.242686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [284.252225] Starting dynamic subtest: pipe-B-eDP-1 [284.254513] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [284.263142] Starting dynamic subtest: pipe-C-eDP-1 [284.265451] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [284.273973] Starting dynamic subtest: pipe-D-eDP-1 [284.276392] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [284.278803] Subtest bad-hsync-start: SUCCESS (0.295s) [285.049299] [046/133] (735s left) kms_psr (pr-cursor-mmap-gtt) [285.150393] Starting subtest: pr-cursor-mmap-gtt [285.155079] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [285.224703] [047/133] (735s left) kms_fbcon_fbt (fbc-suspend) [285.279550] Starting subtest: fbc-suspend [334.510380] Subtest fbc-suspend: SUCCESS (19.518s) [335.867775] [048/133] (684s left) kms_force_connector_basic (prune-stale-modes) [335.947052] Starting subtest: prune-stale-modes [336.388224] Subtest prune-stale-modes: SUCCESS (0.448s) [336.522112] [049/133] (683s left) gem_exec_reloc (basic-gtt-wc) [336.574873] Subtest basic-gtt-wc: SKIP (0.000s) [336.648660] [050/133] (683s left) perf (polling-parameterized) [336.777394] Starting subtest: polling-parameterized [356.849589] Subtest polling-parameterized: SUCCESS (20.103s) [356.889396] [051/133] (663s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [356.991416] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [356.996020] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [357.093975] [052/133] (663s left) gem_busy (parallel) [357.293425] Starting subtest: parallel [357.296661] Starting dynamic subtest: rcs0 [358.859953] Dynamic subtest rcs0: SUCCESS (1.566s) [358.872762] Starting dynamic subtest: bcs0 [360.778516] Dynamic subtest bcs0: SUCCESS (1.916s) [360.791739] Starting dynamic subtest: vcs0 [362.825340] Dynamic subtest vcs0: SUCCESS (2.045s) [362.836397] Starting dynamic subtest: vcs1 [364.926012] Dynamic subtest vcs1: SUCCESS (2.043s) [364.936062] Starting dynamic subtest: vecs0 [366.858267] Dynamic subtest vecs0: SUCCESS (1.981s) [366.870623] Starting dynamic subtest: ccs0 [368.891948] Dynamic subtest ccs0: SUCCESS (1.980s) [368.894625] Subtest parallel: SUCCESS (11.550s) [369.072702] [053/133] (651s left) gem_softpin (allocator-fork) [369.147397] Starting subtest: allocator-fork [371.445778] Subtest allocator-fork: SUCCESS (2.246s) [371.524703] [054/133] (649s left) gem_eio (wait-immediate) [371.741478] Starting subtest: wait-immediate [372.116139] Subtest wait-immediate: SUCCESS (0.374s) [372.244762] [055/133] (648s left) gem_wait (write-busy) [372.320420] Starting subtest: write-busy [372.323248] Starting dynamic subtest: all-engines [372.903993] Dynamic subtest all-engines: SUCCESS (0.583s) [372.921165] Starting dynamic subtest: rcs0 [373.458306] Dynamic subtest rcs0: SUCCESS (0.553s) [373.475269] Starting dynamic subtest: bcs0 [374.009151] Dynamic subtest bcs0: SUCCESS (0.550s) [374.025108] Starting dynamic subtest: vcs0 [375.881367] Dynamic subtest vcs0: SUCCESS (1.869s) [375.898905] Starting dynamic subtest: vcs1 [377.865053] Dynamic subtest vcs1: SUCCESS (1.981s) [377.881536] Starting dynamic subtest: vecs0 [379.849067] Dynamic subtest vecs0: SUCCESS (1.981s) [379.866400] Starting dynamic subtest: ccs0 [380.400506] Dynamic subtest ccs0: SUCCESS (0.550s) [380.403614] Subtest write-busy: SUCCESS (8.078s) [380.597428] [056/133] (640s left) gem_exec_balancer (busy) [380.664518] Starting subtest: busy [381.822980] Subtest busy: SUCCESS (1.157s) [382.133347] [057/133] (638s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [382.192233] Starting subtest: etime-multi-wait-available-unsubmitted [382.292855] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s) [382.390522] [058/133] (638s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [382.479975] Starting subtest: crc-primary-basic-yf-tiled-ccs [382.482262] Starting dynamic subtest: pipe-A-eDP-1 [382.506720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [382.516731] Starting dynamic subtest: pipe-B-eDP-1 [382.542334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [382.551716] Starting dynamic subtest: pipe-C-eDP-1 [382.577400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [382.586548] Starting dynamic subtest: pipe-D-eDP-1 [382.612580] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [382.617388] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s) [384.714860] [059/133] (636s left) kms_big_fb (linear-8bpp-rotate-270) [384.817458] Starting subtest: linear-8bpp-rotate-270 [384.838507] Subtest linear-8bpp-rotate-270: SKIP (0.021s) [384.947308] [060/133] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [385.051789] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [385.056793] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [385.157847] [061/133] (635s left) kms_color (gamma) [385.260272] Starting subtest: gamma [385.262380] Starting dynamic subtest: pipe-A-eDP-1 [386.001574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s) [386.011956] Starting dynamic subtest: pipe-B-eDP-1 [387.422494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s) [387.432513] Starting dynamic subtest: pipe-C-eDP-1 [388.722820] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.297s) [388.733025] Starting dynamic subtest: pipe-D-eDP-1 [390.042814] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [390.045436] Subtest gamma: SUCCESS (4.784s) [390.908091] [062/133] (629s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [391.013420] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [391.018859] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [391.116647] [063/133] (629s left) kms_pipe_stress (stress-xrgb8888-ytiled) [391.211451] Starting subtest: stress-xrgb8888-ytiled [391.216598] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [391.291754] [064/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [391.385385] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [391.390496] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [391.481857] [065/133] (629s left) kms_psr (fbc-psr2-suspend) [391.586615] Starting subtest: fbc-psr2-suspend [391.589407] Starting dynamic subtest: eDP-1 [391.594375] Dynamic subtest eDP-1: SKIP (0.000s) [391.599562] Subtest fbc-psr2-suspend: SKIP (0.001s) [391.673796] [066/133] (629s left) kms_content_protection (dp-mst-type-0-suspend-resume) [391.818823] Starting subtest: dp-mst-type-0-suspend-resume [391.825133] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s) [391.934211] [067/133] (629s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [392.025281] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [392.027304] Starting dynamic subtest: pipe-A-eDP-1 [392.083330] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [392.092582] Starting dynamic subtest: pipe-B-eDP-1 [392.153433] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [392.163610] Starting dynamic subtest: pipe-C-eDP-1 [392.220312] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [392.229617] Starting dynamic subtest: pipe-D-eDP-1 [392.287736] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [392.291267] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s) [394.308091] [068/133] (626s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [394.434597] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [394.439441] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [394.576843] [069/133] (626s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [394.676412] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [394.682045] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [394.760968] [070/133] (626s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [394.829565] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [394.934035] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s) [395.024202] [071/133] (626s left) perf (gen12-group-concurrent-oa-buffer-read) [395.111383] Starting subtest: gen12-group-concurrent-oa-buffer-read [405.207020] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.045s) [405.250129] [072/133] (616s left) gem_exec_fence (basic-wait-all) [405.316527] Starting subtest: basic-wait-all [405.415894] Subtest basic-wait-all: SUCCESS (0.100s) [406.913861] [073/133] (614s left) kms_big_fb (y-tiled-8bpp-rotate-270) [407.020375] Starting subtest: y-tiled-8bpp-rotate-270 [407.025239] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [407.108760] [074/133] (614s left) kms_tv_load_detect (load-detect) [407.167840] Subtest load-detect: SKIP (0.000s) [407.223080] [075/133] (614s left) sysfs_heartbeat_interval (idempotent) [407.277161] Starting subtest: idempotent [407.279730] Starting dynamic subtest: vecs0 [407.282367] Dynamic subtest vecs0: SUCCESS (0.001s) [407.293418] Starting dynamic subtest: ccs0 [407.296101] Dynamic subtest ccs0: SUCCESS (0.001s) [407.305770] Starting dynamic subtest: vcs0 [407.308354] Dynamic subtest vcs0: SUCCESS (0.000s) [407.317996] Starting dynamic subtest: bcs0 [407.320469] Dynamic subtest bcs0: SUCCESS (0.001s) [407.329864] Starting dynamic subtest: rcs0 [407.332414] Dynamic subtest rcs0: SUCCESS (0.000s) [407.342164] Starting dynamic subtest: vcs1 [407.344637] Dynamic subtest vcs1: SUCCESS (0.000s) [407.347437] Subtest idempotent: SUCCESS (0.007s) [407.388942] [076/133] (614s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [407.490394] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [413.683999] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.198s) [414.814351] [077/133] (606s left) kms_cursor_crc (cursor-random-max-size) [415.157392] Starting subtest: cursor-random-max-size [415.164964] Subtest cursor-random-max-size: SKIP (0.000s) [415.294619] [078/133] (606s left) kms_psr (fbc-pr-suspend) [415.385890] Starting subtest: fbc-pr-suspend [415.391270] Subtest fbc-pr-suspend: SKIP (0.000s) [415.470993] [079/133] (606s left) i915_pm_rpm (gem-execbuf-stress) [417.004775] Starting subtest: gem-execbuf-stress [417.007218] Starting dynamic subtest: smem0 [429.850609] Dynamic subtest smem0: SUCCESS (12.848s) [429.863849] Starting dynamic subtest: extra-wait-smem0 [491.407092] Dynamic subtest extra-wait-smem0: SUCCESS (61.548s) [491.410163] Subtest gem-execbuf-stress: SUCCESS (74.403s) [491.775794] [080/133] (529s left) kms_flip (2x-blocking-absolute-wf_vblank) [491.868730] Starting subtest: 2x-blocking-absolute-wf_vblank [491.879852] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [491.961291] [081/133] (529s left) kms_plane_scaling (planes-scaler-unity-scaling) [492.056293] Starting subtest: planes-scaler-unity-scaling [492.059194] Starting dynamic subtest: pipe-A [492.117574] Dynamic subtest pipe-A: SUCCESS (0.064s) [492.127455] Starting dynamic subtest: pipe-B [493.286598] Dynamic subtest pipe-B: SUCCESS (1.168s) [493.298991] Starting dynamic subtest: pipe-C [494.374493] Dynamic subtest pipe-C: SUCCESS (1.084s) [494.385394] Starting dynamic subtest: pipe-D [495.470534] Dynamic subtest pipe-D: SUCCESS (1.097s) [495.473460] Subtest planes-scaler-unity-scaling: SUCCESS (3.418s) [496.607397] [082/133] (525s left) i915_pm_rps (waitboost) [496.674104] Starting subtest: waitboost [502.767312] Subtest waitboost: SUCCESS (6.094s) [502.879224] [083/133] (518s left) kms_cursor_crc (cursor-onscreen-256x85) [503.177646] Starting subtest: cursor-onscreen-256x85 [503.222658] Subtest cursor-onscreen-256x85: SKIP (0.042s) [503.393018] [084/133] (518s left) kms_addfb_basic (basic-y-tiled-legacy) [503.454012] Starting subtest: basic-y-tiled-legacy [503.458626] Subtest basic-y-tiled-legacy: SKIP (0.000s) [503.585708] [085/133] (518s left) kms_big_fb (4-tiled-8bpp-rotate-90) [503.680334] Starting subtest: 4-tiled-8bpp-rotate-90 [503.701857] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s) [503.811924] [086/133] (518s left) kms_psr (psr2-primary-page-flip) [503.905864] Starting subtest: psr2-primary-page-flip [503.908208] Starting dynamic subtest: eDP-1 [505.646425] Dynamic subtest eDP-1: SUCCESS (1.741s) [505.649483] Subtest psr2-primary-page-flip: SUCCESS (1.742s) [506.495032] [087/133] (515s left) gem_exec_reloc (basic-softpin) [506.565957] Subtest basic-softpin: SKIP (0.000s) [506.635627] [088/133] (515s left) syncobj_basic (bad-destroy) [506.689605] Starting subtest: bad-destroy [506.692354] Subtest bad-destroy: SUCCESS (0.000s) [506.779000] [089/133] (515s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [506.874264] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [511.055147] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.186s) [512.221272] [090/133] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [512.321332] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [519.245307] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.930s) [519.370977] [091/133] (502s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [519.472614] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [519.477909] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [519.551687] [092/133] (502s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [519.605535] Starting subtest: multi-wait-for-submit-available-submitted-signaled [519.608471] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [519.699135] [093/133] (502s left) kms_addfb_basic (addfb25-bad-modifier) [519.790397] Starting subtest: addfb25-bad-modifier [519.793015] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [519.902085] [094/133] (502s left) gem_softpin (evict-snoop-interruptible) [519.958157] Starting subtest: evict-snoop-interruptible [519.963576] Subtest evict-snoop-interruptible: SKIP (0.000s) [520.081173] [095/133] (502s left) kms_async_flips (test-time-stamp) [520.170492] Starting subtest: test-time-stamp [520.555604] Starting dynamic subtest: pipe-A-eDP-1 [521.350586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s) [521.725460] Starting dynamic subtest: pipe-B-eDP-1 [522.559086] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.838s) [522.938038] Starting dynamic subtest: pipe-C-eDP-1 [523.754454] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.822s) [524.122512] Starting dynamic subtest: pipe-D-eDP-1 [524.956622] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.843s) [524.959738] Subtest test-time-stamp: SUCCESS (4.788s) [526.183936] [096/133] (496s left) gem_ctx_persistence (legacy-engines-hostile) [526.250554] Starting subtest: legacy-engines-hostile [526.252961] Starting dynamic subtest: render [526.292734] Dynamic subtest render: SUCCESS (0.045s) [526.302617] Starting dynamic subtest: bsd1 [526.404892] Dynamic subtest bsd1: SUCCESS (0.111s) [526.417381] Starting dynamic subtest: bsd2 [526.507855] Dynamic subtest bsd2: SUCCESS (0.100s) [526.520587] Starting dynamic subtest: blt [526.593790] Dynamic subtest blt: SUCCESS (0.083s) [526.606435] Starting dynamic subtest: vebox [526.697011] Dynamic subtest vebox: SUCCESS (0.100s) [526.699766] Subtest legacy-engines-hostile: SUCCESS (0.451s) [526.775627] [097/133] (495s left) gem_eio (banned) [527.007462] Starting subtest: banned [527.735764] Subtest banned: SUCCESS (0.726s) [527.898882] [098/133] (494s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [528.014053] Starting subtest: flip-vs-cursor-crc-atomic [528.686384] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.671s) [529.486491] [099/133] (492s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [529.580424] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [529.609631] Starting dynamic subtest: pipe-A-plane-0 [530.362183] Dynamic subtest pipe-A-plane-0: SUCCESS (0.755s) [530.371480] Starting dynamic subtest: pipe-A-plane-3 [530.806478] Dynamic subtest pipe-A-plane-3: SUCCESS (0.442s) [531.943081] Starting dynamic subtest: pipe-B-plane-0 [532.635248] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s) [532.645251] Starting dynamic subtest: pipe-B-plane-3 [533.158372] Dynamic subtest pipe-B-plane-3: SUCCESS (0.522s) [533.469234] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.891s) [534.275207] [100/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [534.372836] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [540.867010] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.497s) [540.995988] [101/133] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [541.094053] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [547.826924] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.738s) [547.928227] [102/133] (474s left) perf_pmu (rc6-suspend) [547.973145] Starting subtest: rc6-suspend [570.392631] Subtest rc6-suspend: SUCCESS (7.628s) [571.257835] [103/133] (451s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [571.361712] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [571.364007] Starting dynamic subtest: pipe-A-eDP-1 [603.472568] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.922s) [603.482190] Starting dynamic subtest: pipe-B-eDP-1 [637.398934] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.710s) [637.408886] Starting dynamic subtest: pipe-C-eDP-1 [670.368930] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.679s) [670.379609] Starting dynamic subtest: pipe-D-eDP-1 [703.392001] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.622s) [703.394485] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.938s) [704.636547] [104/133] (318s left) kms_chamelium_hpd (vga-hpd-without-ddc) [705.022843] Subtest vga-hpd-without-ddc: SKIP (0.000s) [705.797081] [105/133] (316s left) gem_ringfill (engines-basic) [711.107314] Starting subtest: engines-basic [711.111802] Starting dynamic subtest: rcs0 [711.135406] Dynamic subtest rcs0: SUCCESS (0.054s) [711.145563] Starting dynamic subtest: bcs0 [711.174552] Dynamic subtest bcs0: SUCCESS (0.039s) [711.187473] Starting dynamic subtest: vcs0 [711.215273] Dynamic subtest vcs0: SUCCESS (0.039s) [711.226175] Starting dynamic subtest: vcs1 [711.257615] Dynamic subtest vcs1: SUCCESS (0.040s) [711.268999] Starting dynamic subtest: vecs0 [711.299908] Dynamic subtest vecs0: SUCCESS (0.040s) [711.310951] Starting dynamic subtest: ccs0 [711.342129] Dynamic subtest ccs0: SUCCESS (0.040s) [711.344588] Subtest engines-basic: SUCCESS (0.265s) [711.420286] [106/133] (311s left) syncobj_wait (single-wait-for-submit-signaled) [711.470697] Starting subtest: single-wait-for-submit-signaled [711.472961] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [711.563707] [107/133] (311s left) syncobj_wait (multi-wait-all-submitted) [711.611145] Starting subtest: multi-wait-all-submitted [711.717041] Subtest multi-wait-all-submitted: SUCCESS (0.105s) [711.800908] [108/133] (311s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [711.890813] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [711.894949] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s) [711.977068] [109/133] (310s left) kms_flip (2x-blocking-wf_vblank) [712.068019] Starting subtest: 2x-blocking-wf_vblank [712.076353] Subtest 2x-blocking-wf_vblank: SKIP (0.010s) [712.152365] [110/133] (310s left) kms_chamelium_audio (hdmi-audio) [712.526280] Subtest hdmi-audio: SKIP (0.000s) [713.318690] [111/133] (309s left) kms_draw_crc (fill-fb) [713.401010] Starting subtest: fill-fb [713.915705] Subtest fill-fb: SUCCESS (0.520s) [714.021736] [112/133] (308s left) api_intel_bb (object-noreloc-keep-cache-simple) [714.080251] Starting subtest: object-noreloc-keep-cache-simple [714.084789] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s) [714.182062] [113/133] (308s left) kms_cursor_edge_walk (64x64-top-edge) [714.275115] Starting subtest: 64x64-top-edge [714.276930] Starting dynamic subtest: pipe-A-eDP-1 [717.744711] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s) [717.756947] Starting dynamic subtest: pipe-D-eDP-1 [720.914247] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.178s) [720.916516] Subtest 64x64-top-edge: SUCCESS (6.667s) [721.714916] [114/133] (301s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [721.808564] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [721.812655] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [721.899570] [115/133] (301s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [722.027649] Starting subtest: cursorB-vs-flipB-atomic [722.032010] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [722.175557] [116/133] (301s left) kms_pm_dc (dc3co-vpb-simulation) [723.278029] Starting subtest: dc3co-vpb-simulation [731.959817] Subtest dc3co-vpb-simulation: SKIP (8.690s) [732.067802] [117/133] (291s left) prime_mmap_coherency (write) [732.133863] Starting subtest: write [737.555067] Subtest write: SUCCESS (5.372s) [737.646507] [118/133] (285s left) kms_pm_rpm (modeset-lpsp-stress) [739.196752] Starting subtest: modeset-lpsp-stress [755.657194] Subtest modeset-lpsp-stress: SUCCESS (16.470s) [755.747509] [119/133] (267s left) gem_exec_capture (capture) [755.818955] Starting subtest: capture [755.821290] Starting dynamic subtest: rcs0-smem [756.651783] Dynamic subtest rcs0-smem: SUCCESS (0.834s) [756.661589] Starting dynamic subtest: bcs0-smem [757.973863] Dynamic subtest bcs0-smem: SUCCESS (1.320s) [757.985419] Starting dynamic subtest: vcs0-smem [758.790339] Dynamic subtest vcs0-smem: SUCCESS (0.820s) [758.800962] Starting dynamic subtest: vcs1-smem [760.109444] Dynamic subtest vcs1-smem: SUCCESS (1.317s) [760.119604] Starting dynamic subtest: vecs0-smem [761.004490] Dynamic subtest vecs0-smem: FAIL (0.834s) [761.015189] Starting dynamic subtest: ccs0-smem [762.261921] Dynamic subtest ccs0-smem: SUCCESS (1.319s) [762.264224] Subtest capture: FAIL (6.448s) [762.370429] [120/133] (260s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [762.474323] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [762.476647] Starting dynamic subtest: pipe-A-eDP-1 [762.566879] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [762.581851] Starting dynamic subtest: pipe-B-eDP-1 [763.691582] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s) [763.695895] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.225s) [764.989210] [121/133] (258s left) kms_big_fb (x-tiled-8bpp-rotate-270) [765.099526] Starting subtest: x-tiled-8bpp-rotate-270 [765.120032] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s) [765.235935] [122/133] (258s left) gem_ctx_param (vm) [765.298744] Starting subtest: vm [765.346219] Subtest vm: SUCCESS (0.049s) [765.461245] [123/133] (258s left) gem_exec_whisper (basic-fds-forked) [765.518476] Starting subtest: basic-fds-forked [789.789945] Subtest basic-fds-forked: SUCCESS (24.279s) [789.973354] [124/133] (233s left) i915_drm_fdinfo (idle) [790.025307] Starting subtest: idle [790.027652] Starting dynamic subtest: rcs0 [790.566902] Dynamic subtest rcs0: SUCCESS (0.544s) [790.577321] Starting dynamic subtest: bcs0 [791.100905] Dynamic subtest bcs0: SUCCESS (0.531s) [791.111515] Starting dynamic subtest: vcs0 [791.606407] Dynamic subtest vcs0: SUCCESS (0.503s) [791.617356] Starting dynamic subtest: vcs1 [792.112241] Dynamic subtest vcs1: SUCCESS (0.503s) [792.123429] Starting dynamic subtest: vecs0 [792.619084] Dynamic subtest vecs0: SUCCESS (0.504s) [792.630290] Starting dynamic subtest: ccs0 [793.124732] Dynamic subtest ccs0: SUCCESS (0.503s) [793.127411] Subtest idle: SUCCESS (3.104s) [793.202210] [125/133] (230s left) kms_dp_aux_dev [793.548454] [126/133] (230s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [793.643284] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [794.621049] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.979s) [794.735251] [127/133] (228s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [794.823564] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [794.827882] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [794.894258] [128/133] (228s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [794.977989] Starting subtest: extended-pageflip-modeset-hang-oldfb [794.979862] Starting dynamic subtest: pipe-A [802.864232] Dynamic subtest pipe-A: SUCCESS (7.890s) [802.874264] Starting dynamic subtest: pipe-D [811.505043] Dynamic subtest pipe-D: SUCCESS (8.642s) [811.507316] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.536s) [812.323861] [129/133] (211s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [812.420897] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [812.425285] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [812.522115] [130/133] (211s left) gem_close (many-handles-one-vma) [812.583073] Starting subtest: many-handles-one-vma [812.602022] Subtest many-handles-one-vma: SUCCESS (0.021s) [812.719240] [131/133] (211s left) syncobj_wait (multi-wait-all-for-submit-signaled) [812.774990] Starting subtest: multi-wait-all-for-submit-signaled [812.777333] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [812.889870] [132/133] (211s left) sw_sync (sync_busy_fork) [812.924411] Starting subtest: sync_busy_fork [813.934831] Subtest sync_busy_fork: SUCCESS (1.012s) [814.007287] [133/133] (209s left) gem_pxp (regular-baseline-src-copy-readible) [814.146283] Starting subtest: regular-baseline-src-copy-readible [814.204738] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s) [814.336622] Closing watchdogs results: parsing output: 0/ for test: kms_vblank results: parsing output: 1/ for test: kms_sequence results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: api_intel_bb results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_exec_fence results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: syncobj_wait results: parsing output: 9/ for test: gem_userptr_blits results: parsing output: 10/ for test: gem_exec_schedule results: parsing output: 11/ for test: gem_create results: parsing output: 12/ for test: gem_mmap_gtt results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: gem_ppgtt results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_caching results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: gem_exec_reloc results: parsing output: 23/ for test: core_getversion results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_psr2_sf results: parsing output: 26/ for test: kms_lease results: parsing output: 27/ for test: kms_chamelium_color results: parsing output: 28/ for test: i915_hangman results: parsing output: 29/ for test: kms_plane_scaling results: parsing output: 30/ for test: gem_readwrite results: parsing output: 31/ for test: gem_lmem_evict results: parsing output: 32/ for test: gem_exec_params results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: gem_exec_parallel results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_feature_discovery results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: gem_exec_async results: parsing output: 40/ for test: kms_properties results: parsing output: 41/ for test: gem_madvise results: parsing output: 42/ for test: gem_mmap_offset results: parsing output: 43/ for test: perf_pmu results: parsing output: 44/ for test: kms_invalid_mode results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: kms_fbcon_fbt results: parsing output: 47/ for test: kms_force_connector_basic results: parsing output: 48/ for test: gem_exec_reloc results: parsing output: 49/ for test: perf results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_busy results: parsing output: 52/ for test: gem_softpin results: parsing output: 53/ for test: gem_eio results: parsing output: 54/ for test: gem_wait results: parsing output: 55/ for test: gem_exec_balancer results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_color results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_pipe_stress results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: kms_content_protection results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: perf results: parsing output: 71/ for test: gem_exec_fence results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_tv_load_detect results: parsing output: 74/ for test: sysfs_heartbeat_interval results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: kms_psr results: parsing output: 78/ for test: i915_pm_rpm results: parsing output: 79/ for test: kms_flip results: parsing output: 80/ for test: kms_plane_scaling results: parsing output: 81/ for test: i915_pm_rps results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: gem_exec_reloc results: parsing output: 87/ for test: syncobj_basic results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_flip_scaled_crc results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: gem_softpin results: parsing output: 94/ for test: kms_async_flips results: parsing output: 95/ for test: gem_ctx_persistence results: parsing output: 96/ for test: gem_eio results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_plane results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: perf_pmu results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: kms_chamelium_hpd results: parsing output: 104/ for test: gem_ringfill results: parsing output: 105/ for test: syncobj_wait results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: kms_flip_scaled_crc results: parsing output: 108/ for test: kms_flip results: parsing output: 109/ for test: kms_chamelium_audio results: parsing output: 110/ for test: kms_draw_crc results: parsing output: 111/ for test: api_intel_bb results: parsing output: 112/ for test: kms_cursor_edge_walk results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_cursor_legacy results: parsing output: 115/ for test: kms_pm_dc results: parsing output: 116/ for test: prime_mmap_coherency results: parsing output: 117/ for test: kms_pm_rpm results: parsing output: 118/ for test: gem_exec_capture results: parsing output: 119/ for test: kms_psr2_sf results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: gem_ctx_param results: parsing output: 122/ for test: gem_exec_whisper results: parsing output: 123/ for test: i915_drm_fdinfo results: parsing output: 124/ for test: kms_dp_aux_dev results: parsing output: 125/ for test: kms_big_fb results: parsing output: 126/ for test: kms_plane results: parsing output: 127/ for test: kms_busy results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_close results: parsing output: 130/ for test: syncobj_wait results: parsing output: 131/ for test: sw_sync results: parsing output: 132/ for test: gem_pxp Done.