[58.828330] Initializing watchdogs [58.828376] /dev/watchdog0 [58.842941] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.847232] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.849391] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.852736] [001/133] (960s left) vgem_basic (second-client) [58.955238] Starting subtest: second-client [58.977160] Subtest second-client: SUCCESS (0.022s) [59.035476] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true [59.038567] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [59.159791] Starting subtest: cursorA-vs-flipB-atomic-transitions [59.164248] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [59.300882] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted) [59.364756] Starting subtest: multi-wait-available-submitted [59.367083] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [59.460358] [004/133] (960s left) kms_invalid_mode (bad-vsync-end) [59.557673] Starting subtest: bad-vsync-end [59.559863] Starting dynamic subtest: pipe-A-eDP-1 [59.845786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [59.853708] Starting dynamic subtest: pipe-B-eDP-1 [59.856028] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [59.862755] Starting dynamic subtest: pipe-C-eDP-1 [59.865042] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [59.872831] Starting dynamic subtest: pipe-D-eDP-1 [59.875179] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [59.877456] Subtest bad-vsync-end: SUCCESS (0.298s) [60.660942] [005/133] (958s left) kms_pm_backlight (fade-with-dpms) [60.774852] Starting subtest: fade-with-dpms [62.924711] Starting dynamic subtest: eDP-1 [65.418023] Dynamic subtest eDP-1: SUCCESS (2.499s) [65.420536] Subtest fade-with-dpms: SUCCESS (4.659s) [66.304324] [006/133] (953s left) kms_flip (bo-too-big-interruptible) [66.402776] Starting subtest: bo-too-big-interruptible [66.405155] Starting dynamic subtest: A-eDP1 [67.765505] Dynamic subtest A-eDP1: SUCCESS (1.364s) [67.773607] Starting dynamic subtest: B-eDP1 [69.078214] Dynamic subtest B-eDP1: SUCCESS (1.314s) [69.086997] Starting dynamic subtest: C-eDP1 [70.329435] Dynamic subtest C-eDP1: SUCCESS (1.251s) [70.337832] Starting dynamic subtest: D-eDP1 [71.655384] Dynamic subtest D-eDP1: SUCCESS (1.326s) [71.659967] Subtest bo-too-big-interruptible: SUCCESS (5.265s) [72.856171] [007/133] (946s left) gem_mmap_gtt (basic-read) [72.913226] Subtest basic-read: SKIP (0.000s) [72.976802] [008/133] (946s left) gem_softpin (allocator-evict) [73.033764] Starting subtest: allocator-evict [73.036242] Starting dynamic subtest: rcs0 [96.280395] Dynamic subtest rcs0: SUCCESS (23.247s) [96.288501] Starting dynamic subtest: bcs0 [120.228222] Dynamic subtest bcs0: SUCCESS (23.948s) [120.239910] Starting dynamic subtest: vcs0 [144.067209] Dynamic subtest vcs0: SUCCESS (23.838s) [144.076791] Starting dynamic subtest: vcs1 [168.917678] Dynamic subtest vcs1: SUCCESS (24.847s) [168.928794] Starting dynamic subtest: vecs0 [192.591587] Dynamic subtest vecs0: SUCCESS (23.674s) [192.601435] Starting dynamic subtest: ccs0 [216.629929] Dynamic subtest ccs0: SUCCESS (24.037s) [216.632366] Subtest allocator-evict: SUCCESS (143.594s) [216.708996] [009/133] (802s left) gem_render_linear_blits (basic) [216.804563] Starting subtest: basic [216.848744] Subtest basic: SUCCESS (0.044s) [216.931328] [010/133] (802s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [217.037058] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [217.041196] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [217.133557] [011/133] (802s left) kms_psr (psr-primary-mmap-cpu) [217.233898] Starting subtest: psr-primary-mmap-cpu [217.236285] Starting dynamic subtest: eDP-1 [218.941993] Dynamic subtest eDP-1: SUCCESS (1.708s) [218.945065] Subtest psr-primary-mmap-cpu: SUCCESS (1.709s) [219.802056] [012/133] (799s left) kms_chamelium_edid (hdmi-mode-timings) [220.192860] Subtest hdmi-mode-timings: SKIP (0.000s) [221.007349] [013/133] (798s left) gen7_exec_parse (load-register-reg) [221.064281] Subtest load-register-reg: SKIP (0.000s) [221.124755] [014/133] (798s left) syncobj_eventfd (invalid-bad-flags) [221.181919] Starting subtest: invalid-bad-flags [221.184360] Subtest invalid-bad-flags: SUCCESS (0.000s) [221.257384] [015/133] (798s left) gem_ctx_exec (basic-invalid-context) [221.313463] Starting subtest: basic-invalid-context [221.319825] Subtest basic-invalid-context: SUCCESS (0.006s) [221.410953] [016/133] (798s left) gem_exec_reloc (basic-write-read-active) [221.483667] Subtest basic-write-read-active: SKIP (0.000s) [221.549946] [017/133] (798s left) kms_vblank (wait-busy-hang) [221.649182] Starting subtest: wait-busy-hang [221.651333] Starting dynamic subtest: pipe-A-eDP-1 [247.701335] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.050s) [247.718752] Starting dynamic subtest: pipe-D-eDP-1 [262.677262] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s) [262.679705] Subtest wait-busy-hang: SUCCESS (41.029s) [263.479281] [018/133] (756s left) kms_chamelium_color (ctm-0-50) [263.569424] Subtest ctm-0-50: SKIP (0.000s) [263.619618] [019/133] (756s left) gem_exec_flush (basic-uc-prw-default) [263.688328] Starting subtest: basic-uc-prw-default [269.157732] Subtest basic-uc-prw-default: SUCCESS (5.470s) [269.362163] [020/133] (750s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [269.458430] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [276.103408] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.646s) [276.231946] [021/133] (743s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [276.345367] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [276.349807] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [276.433683] [022/133] (743s left) kms_plane_scaling (planes-upscale-factor-0-25) [276.523199] Starting subtest: planes-upscale-factor-0-25 [276.525562] Starting dynamic subtest: pipe-A [276.583548] Dynamic subtest pipe-A: SUCCESS (0.062s) [276.594657] Starting dynamic subtest: pipe-B [277.730268] Dynamic subtest pipe-B: SUCCESS (1.146s) [277.741162] Starting dynamic subtest: pipe-C [278.835369] Dynamic subtest pipe-C: SUCCESS (1.104s) [278.845609] Starting dynamic subtest: pipe-D [279.980526] Dynamic subtest pipe-D: SUCCESS (1.145s) [279.982940] Subtest planes-upscale-factor-0-25: SUCCESS (3.460s) [281.148464] [023/133] (739s left) i915_selftest (perf) [282.870798] Starting subtest: perf [282.873296] Starting dynamic subtest: engine_cs [287.203834] Dynamic subtest engine_cs: SUCCESS (4.336s) [287.213265] Starting dynamic subtest: request [294.450446] Dynamic subtest request: SUCCESS (7.245s) [294.459729] Starting dynamic subtest: migrate [298.807646] Dynamic subtest migrate: SUCCESS (4.355s) [298.816711] Starting dynamic subtest: region [304.455288] Dynamic subtest region: SUCCESS (5.647s) [304.457754] Subtest perf: SUCCESS (21.588s) [304.486319] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [304.487052] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [304.490196] [024/133] (715s left) kms_color (legacy-gamma) [306.077203] Starting subtest: legacy-gamma [306.079341] Starting dynamic subtest: pipe-A-eDP-1 [306.833422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s) [306.841839] Starting dynamic subtest: pipe-B-eDP-1 [308.203841] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.371s) [308.212588] Starting dynamic subtest: pipe-C-eDP-1 [309.586489] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s) [309.594762] Starting dynamic subtest: pipe-D-eDP-1 [310.917673] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [310.919849] Subtest legacy-gamma: SUCCESS (4.841s) [311.759609] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [311.760847] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true [311.764272] [025/133] (708s left) perf (gen12-mi-rpc) [311.915649] Starting subtest: gen12-mi-rpc [311.917855] Starting dynamic subtest: rcs0 [311.936781] Dynamic subtest rcs0: SUCCESS (0.019s) [311.938611] Subtest gen12-mi-rpc: SUCCESS (0.020s) [311.985492] [026/133] (708s left) syncobj_timeline (invalid-wait-bad-flags) [312.061305] Starting subtest: invalid-wait-bad-flags [312.063558] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [312.183267] [027/133] (708s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [312.300954] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [312.305412] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [312.443096] [028/133] (708s left) gem_eio (kms) [312.635887] Starting subtest: kms [328.336818] Subtest kms: SUCCESS (15.699s) [328.444924] [029/133] (692s left) gem_exec_fence (long-history) [328.861622] Starting subtest: long-history [335.597096] Subtest long-history: SUCCESS (6.735s) [336.295997] [030/133] (684s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [336.406597] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [336.411114] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [336.508991] [031/133] (684s left) gem_render_copy (y-tiled) [336.567123] Starting subtest: y-tiled [336.571609] Subtest y-tiled: SKIP (0.000s) [336.762473] [032/133] (683s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [336.863060] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [336.865385] Starting dynamic subtest: pipe-A-default-mode [338.040811] Dynamic subtest pipe-A-default-mode: SKIP (1.176s) [338.044729] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.177s) [338.198666] [033/133] (682s left) sw_sync (sync_multi_consumer) [338.240289] Starting subtest: sync_multi_consumer [338.663471] Subtest sync_multi_consumer: SUCCESS (0.426s) [338.724750] [034/133] (681s left) gem_exec_schedule (noreorder-priority) [338.902409] Starting subtest: noreorder-priority [338.904469] Starting dynamic subtest: rcs0 [340.026503] Dynamic subtest rcs0: SUCCESS (1.126s) [340.039726] Starting dynamic subtest: vcs0 [341.907475] Dynamic subtest vcs0: SUCCESS (1.879s) [341.919357] Starting dynamic subtest: vcs1 [343.869613] Dynamic subtest vcs1: SUCCESS (1.960s) [343.881859] Starting dynamic subtest: vecs0 [345.873292] Dynamic subtest vecs0: SUCCESS (2.002s) [345.884948] Starting dynamic subtest: ccs0 [347.017392] Dynamic subtest ccs0: SUCCESS (1.144s) [347.019891] Subtest noreorder-priority: SUCCESS (8.119s) [347.205806] [035/133] (673s left) gem_tiled_fence_blits (basic) [347.262920] Subtest basic: SKIP (0.000s) [347.328193] [036/133] (673s left) i915_pm_rpm (gem-execbuf-stress) [349.055075] Starting subtest: gem-execbuf-stress [349.057674] Starting dynamic subtest: smem0 [361.884757] Dynamic subtest smem0: SUCCESS (12.828s) [361.894790] Starting dynamic subtest: extra-wait-smem0 [423.564859] Dynamic subtest extra-wait-smem0: SUCCESS (61.674s) [423.567971] Subtest gem-execbuf-stress: SUCCESS (74.507s) [423.951844] [037/133] (596s left) kms_addfb_basic (basic-y-tiled-legacy) [424.019698] Starting subtest: basic-y-tiled-legacy [424.023930] Subtest basic-y-tiled-legacy: SKIP (0.000s) [424.150339] [038/133] (596s left) kms_concurrent (multi-plane-atomic-lowres) [424.252112] Starting subtest: multi-plane-atomic-lowres [424.257926] Starting dynamic subtest: pipe-A-eDP-1 [424.764714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s) [424.775034] Starting dynamic subtest: pipe-B-eDP-1 [425.971758] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s) [425.981745] Starting dynamic subtest: pipe-C-eDP-1 [427.209539] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s) [427.224557] Starting dynamic subtest: pipe-D-eDP-1 [428.440827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [428.443622] Subtest multi-plane-atomic-lowres: SUCCESS (4.189s) [429.286165] [039/133] (591s left) gem_exec_balancer (bonded-true-hang) [429.554815] Starting subtest: bonded-true-hang [429.559670] Subtest bonded-true-hang: SKIP (0.000s) [429.650207] [040/133] (591s left) prime_self_import (basic-with_two_bos) [429.687460] Starting subtest: basic-with_two_bos [429.710105] Subtest basic-with_two_bos: SUCCESS (0.023s) [429.814157] [041/133] (591s left) gem_partial_pwrite_pread (reads) [429.871469] Subtest reads: SKIP (0.000s) [429.933963] [042/133] (591s left) syncobj_wait (invalid-multi-wait-unsubmitted) [429.982899] Starting subtest: invalid-multi-wait-unsubmitted [429.985151] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [430.069184] [043/133] (591s left) sysfs_timeslice_duration (idempotent) [430.132839] Starting subtest: idempotent [430.135171] Starting dynamic subtest: vecs0 [430.137371] Dynamic subtest vecs0: SUCCESS (0.000s) [430.146422] Starting dynamic subtest: ccs0 [430.148615] Dynamic subtest ccs0: SUCCESS (0.000s) [430.157226] Starting dynamic subtest: vcs0 [430.159371] Dynamic subtest vcs0: SUCCESS (0.000s) [430.167974] Starting dynamic subtest: bcs0 [430.170211] Dynamic subtest bcs0: SUCCESS (0.000s) [430.179176] Starting dynamic subtest: rcs0 [430.181023] Dynamic subtest rcs0: SUCCESS (0.000s) [430.189651] Starting dynamic subtest: vcs1 [430.191818] Dynamic subtest vcs1: SUCCESS (0.000s) [430.194086] Subtest idempotent: SUCCESS (0.006s) [430.237259] [044/133] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [430.333496] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [430.337931] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [430.433579] [045/133] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [430.532711] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [437.628452] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.098s) [437.742871] [046/133] (583s left) kms_vblank (query-busy) [437.826930] Starting subtest: query-busy [437.829242] Starting dynamic subtest: pipe-A-eDP-1 [439.711164] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s) [439.725419] Starting dynamic subtest: pipe-D-eDP-1 [442.267402] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s) [442.269706] Subtest query-busy: SUCCESS (4.441s) [443.072992] [047/133] (578s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [443.133321] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [443.135299] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [443.220965] [048/133] (578s left) gem_render_copy (y-tiled-to-vebox-linear) [443.281916] Starting subtest: y-tiled-to-vebox-linear [443.286078] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [443.477339] [049/133] (577s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [443.603573] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [443.607872] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [443.703369] [050/133] (577s left) perf_pmu (interrupts) [443.752913] Starting subtest: interrupts [444.832835] Subtest interrupts: SUCCESS (1.078s) [444.958081] [051/133] (576s left) gem_mmap (basic) [445.027957] Subtest basic: SKIP (0.000s) [445.093773] [052/133] (576s left) syncobj_timeline (single-wait-all-available-submitted) [445.157438] Starting subtest: single-wait-all-available-submitted [445.159407] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [445.250199] [053/133] (576s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [447.079098] Starting subtest: modeset-lpsp-stress-no-wait [456.853407] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.777s) [456.940211] [054/133] (564s left) gem_exec_reloc (basic-wc-gtt-noreloc) [457.005808] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [457.075085] [055/133] (564s left) gem_exec_fence (syncobj-unused-fence) [457.503366] Starting subtest: syncobj-unused-fence [457.509409] Subtest syncobj-unused-fence: SUCCESS (0.004s) [458.977107] [056/133] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [459.065855] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [459.070227] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [459.170169] [057/133] (562s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [459.275457] Starting subtest: yf-tiled-16bpp-rotate-270 [459.279820] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [459.359107] [058/133] (562s left) gem_exec_fence (basic-wait) [459.536700] Starting subtest: basic-wait [459.539182] Starting dynamic subtest: rcs0 [459.612192] Dynamic subtest rcs0: SUCCESS (0.078s) [459.624551] Starting dynamic subtest: bcs0 [459.666138] Dynamic subtest bcs0: SUCCESS (0.052s) [459.677726] Starting dynamic subtest: vcs0 [459.719916] Dynamic subtest vcs0: SUCCESS (0.051s) [459.731509] Starting dynamic subtest: vcs1 [459.773715] Dynamic subtest vcs1: SUCCESS (0.052s) [459.784683] Starting dynamic subtest: vecs0 [459.828694] Dynamic subtest vecs0: SUCCESS (0.053s) [459.840422] Starting dynamic subtest: ccs0 [459.881438] Dynamic subtest ccs0: SUCCESS (0.051s) [459.883730] Subtest basic-wait: SUCCESS (0.350s) [461.999316] [059/133] (559s left) prime_mmap_coherency (ioctl-errors) [462.067027] Starting subtest: ioctl-errors [479.945467] Subtest ioctl-errors: SUCCESS (17.880s) [480.101436] [060/133] (541s left) kms_busy (basic) [480.244900] Starting subtest: basic [480.247073] Starting dynamic subtest: flip [480.899312] Dynamic subtest flip: SUCCESS (0.655s) [480.909184] Starting dynamic subtest: modeset [484.327099] Dynamic subtest modeset: SUCCESS (3.426s) [484.329331] Subtest basic: SUCCESS (4.083s) [485.143346] [061/133] (536s left) gem_exec_store (cachelines) [485.210509] Starting subtest: cachelines [485.212879] Starting dynamic subtest: rcs0 [485.281368] Dynamic subtest rcs0: SUCCESS (0.074s) [485.295277] Starting dynamic subtest: bcs0 [485.334948] Dynamic subtest bcs0: SUCCESS (0.052s) [485.346768] Starting dynamic subtest: vcs0 [485.387930] Dynamic subtest vcs0: SUCCESS (0.052s) [485.399081] Starting dynamic subtest: vcs1 [485.441603] Dynamic subtest vcs1: SUCCESS (0.051s) [485.452228] Starting dynamic subtest: vecs0 [485.498247] Dynamic subtest vecs0: SUCCESS (0.055s) [485.508617] Starting dynamic subtest: ccs0 [485.558892] Dynamic subtest ccs0: SUCCESS (0.058s) [485.561514] Subtest cachelines: SUCCESS (0.353s) [485.757342] [062/133] (536s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [485.875902] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [486.899655] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s) [487.024781] [063/133] (534s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [487.118261] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [487.120597] Starting dynamic subtest: pipe-A-eDP-1 [487.142036] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [487.152443] Starting dynamic subtest: pipe-B-eDP-1 [487.170708] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [487.179987] Starting dynamic subtest: pipe-C-eDP-1 [487.198018] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [487.207100] Starting dynamic subtest: pipe-D-eDP-1 [487.225472] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [487.228806] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.008s) [489.397519] [064/133] (532s left) prime_busy (hang-wait) [489.462021] Starting subtest: hang-wait [489.464301] Starting dynamic subtest: rcs0 [515.380099] Dynamic subtest rcs0: SUCCESS (25.914s) [515.390863] Starting dynamic subtest: bcs0 [522.535915] Dynamic subtest bcs0: SUCCESS (7.157s) [522.547681] Starting dynamic subtest: vcs0 [529.573593] Dynamic subtest vcs0: SUCCESS (7.032s) [529.584450] Starting dynamic subtest: vcs1 [536.483769] Dynamic subtest vcs1: SUCCESS (6.908s) [536.494754] Starting dynamic subtest: vecs0 [543.522137] Dynamic subtest vecs0: SUCCESS (7.036s) [543.533637] Starting dynamic subtest: ccs0 [557.360898] Dynamic subtest ccs0: SUCCESS (13.836s) [557.363392] Subtest hang-wait: SUCCESS (67.896s) [557.473338] [065/133] (464s left) kms_flip (flip-vs-panning-vs-hang) [557.576116] Starting subtest: flip-vs-panning-vs-hang [557.578082] Starting dynamic subtest: A-eDP1 [608.449987] Dynamic subtest A-eDP1: SUCCESS (50.874s) [608.460043] Starting dynamic subtest: D-eDP1 [659.392282] Dynamic subtest D-eDP1: SUCCESS (50.938s) [659.394519] Subtest flip-vs-panning-vs-hang: SUCCESS (101.816s) [660.601595] [066/133] (361s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [660.695132] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [660.697422] Starting dynamic subtest: pipe-A-eDP-1 [660.989122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.260s) [661.001136] Starting dynamic subtest: pipe-B-eDP-1 [662.271263] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.279s) [662.283693] Starting dynamic subtest: pipe-C-eDP-1 [663.483771] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s) [663.495524] Starting dynamic subtest: pipe-D-eDP-1 [664.730304] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s) [664.732427] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.006s) [665.826244] [067/133] (356s left) gem_set_tiling_vs_blt (tiled-to-tiled) [665.906714] Subtest tiled-to-tiled: SKIP (0.000s) [665.971834] [068/133] (356s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [666.067723] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [666.071930] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [666.143966] [069/133] (356s left) gem_ctx_isolation (clean) [666.213134] Starting subtest: clean [666.215563] Starting dynamic subtest: rcs0 [666.289733] Dynamic subtest rcs0: SUCCESS (0.076s) [666.300278] Starting dynamic subtest: bcs0 [666.370796] Dynamic subtest bcs0: SUCCESS (0.080s) [666.381145] Starting dynamic subtest: vcs0 [666.447899] Dynamic subtest vcs0: SUCCESS (0.076s) [666.459272] Starting dynamic subtest: vcs1 [667.924131] Dynamic subtest vcs1: SUCCESS (1.475s) [667.937985] Starting dynamic subtest: vecs0 [669.908635] Dynamic subtest vecs0: SUCCESS (1.983s) [669.920570] Starting dynamic subtest: ccs0 [671.923722] Dynamic subtest ccs0: SUCCESS (2.014s) [671.926398] Subtest clean: SUCCESS (5.710s) [672.151066] [070/133] (350s left) perf_pmu (init-sema) [672.197632] Starting subtest: init-sema [672.200237] Starting dynamic subtest: rcs0 [672.202344] Dynamic subtest rcs0: SUCCESS (0.002s) [672.219165] Starting dynamic subtest: bcs0 [672.221486] Dynamic subtest bcs0: SUCCESS (0.000s) [672.231660] Starting dynamic subtest: vcs0 [672.233828] Dynamic subtest vcs0: SUCCESS (0.001s) [672.243186] Starting dynamic subtest: vcs1 [672.245452] Dynamic subtest vcs1: SUCCESS (0.001s) [672.255074] Starting dynamic subtest: vecs0 [672.257227] Dynamic subtest vecs0: SUCCESS (0.000s) [672.266786] Starting dynamic subtest: ccs0 [672.268651] Dynamic subtest ccs0: SUCCESS (0.000s) [672.270520] Subtest init-sema: SUCCESS (0.008s) [672.313589] [071/133] (349s left) kms_force_connector_basic (prune-stale-modes) [672.390965] Starting subtest: prune-stale-modes [672.838821] Subtest prune-stale-modes: SUCCESS (0.448s) [672.992913] [072/133] (349s left) gem_fenced_exec_thrash (no-spare-fences-busy) [673.047080] Subtest no-spare-fences-busy: SKIP (0.000s) [673.104337] [073/133] (349s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [673.189849] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [673.193555] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [674.354548] [074/133] (348s left) i915_pm_freq_api (freq-suspend) [674.412477] Starting subtest: freq-suspend [674.414963] Starting dynamic subtest: gt0 [690.969879] Dynamic subtest gt0: SUCCESS (2.470s) [690.983029] Starting dynamic subtest: gt1 [707.972106] Dynamic subtest gt1: SUCCESS (1.650s) [707.976609] Subtest freq-suspend: SUCCESS (4.122s) [714.062140] [075/133] (314s left) kms_cursor_edge_walk (256x256-top-bottom) [714.162660] Starting subtest: 256x256-top-bottom [714.164885] Starting dynamic subtest: pipe-A-eDP-1 [717.758394] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.675s) [717.770197] Starting dynamic subtest: pipe-D-eDP-1 [720.841690] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s) [720.843816] Subtest 256x256-top-bottom: SUCCESS (6.806s) [721.658833] [076/133] (306s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [721.764271] Starting subtest: psr-rgb565-draw-pwrite [728.729712] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.016s) [728.848724] [077/133] (299s left) kms_cursor_crc (cursor-rapid-movement-64x64) [729.025426] Starting subtest: cursor-rapid-movement-64x64 [729.030144] Starting dynamic subtest: pipe-A-eDP-1 [729.569695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s) [729.603791] Starting dynamic subtest: pipe-D-eDP-1 [730.738379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s) [730.740546] Subtest cursor-rapid-movement-64x64: SUCCESS (1.718s) [731.556067] [078/133] (297s left) gem_ctx_persistence (legacy-engines-queued) [731.611047] Starting subtest: legacy-engines-queued [731.613703] Starting dynamic subtest: render [731.683672] Dynamic subtest render: SUCCESS (0.072s) [731.698888] Starting dynamic subtest: bsd1 [733.283022] Dynamic subtest bsd1: SUCCESS (1.600s) [733.296912] Starting dynamic subtest: bsd2 [735.264343] Dynamic subtest bsd2: SUCCESS (1.984s) [735.278248] Starting dynamic subtest: blt [735.322684] Dynamic subtest blt: SUCCESS (0.057s) [735.336394] Starting dynamic subtest: vebox [737.313199] Dynamic subtest vebox: SUCCESS (1.990s) [737.316195] Subtest legacy-engines-queued: SUCCESS (5.715s) [737.397526] [079/133] (291s left) kms_flip (2x-flip-vs-fences-interruptible) [737.512575] Starting subtest: 2x-flip-vs-fences-interruptible [737.517189] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [737.631196] [080/133] (291s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [737.738101] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [737.740364] Starting dynamic subtest: pipe-A-eDP-1 [737.835610] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [737.850728] Starting dynamic subtest: pipe-B-eDP-1 [738.987080] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s) [738.991626] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.253s) [740.244429] [081/133] (288s left) syncobj_timeline (etime-multi-wait-submitted) [740.308115] Starting subtest: etime-multi-wait-submitted [740.416467] Subtest etime-multi-wait-submitted: SUCCESS (0.107s) [740.498540] [082/133] (288s left) gem_render_copy (linear-to-vebox-yf-tiled) [740.570004] Starting subtest: linear-to-vebox-yf-tiled [740.574590] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [740.755849] [083/133] (288s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [740.857363] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [740.859534] Starting dynamic subtest: pipe-A-eDP-1 [740.879531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [740.891873] Starting dynamic subtest: pipe-B-eDP-1 [740.911128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [740.922143] Starting dynamic subtest: pipe-C-eDP-1 [740.941427] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [740.952694] Starting dynamic subtest: pipe-D-eDP-1 [740.971764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [740.973952] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s) [743.234905] [084/133] (285s left) kms_psr (psr-cursor-render) [743.333614] Starting subtest: psr-cursor-render [743.335886] Starting dynamic subtest: eDP-1 [745.102587] Dynamic subtest eDP-1: SUCCESS (1.769s) [745.104861] Subtest psr-cursor-render: SUCCESS (1.770s) [745.935690] [085/133] (282s left) kms_atomic (atomic-invalid-params) [746.036704] Starting subtest: atomic-invalid-params [746.038947] Starting dynamic subtest: pipe-A-eDP-1 [746.422102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s) [746.424504] Subtest atomic-invalid-params: SUCCESS (0.387s) [747.230609] [086/133] (281s left) gem_exec_schedule (semaphore-power) [747.415398] Subtest semaphore-power: SKIP (0.000s) [747.596506] [087/133] (281s left) api_intel_allocator (default-alignment) [747.655988] Starting subtest: default-alignment [747.658346] Subtest default-alignment: SUCCESS (0.003s) [747.782395] [088/133] (281s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [747.877377] Starting subtest: yf-tiled-32bpp-rotate-90 [747.881646] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [747.968836] [089/133] (281s left) gem_mmap_wc (copy) [748.025798] Subtest copy: SKIP (0.000s) [748.089387] [090/133] (281s left) gem_exec_whisper (basic-queues-forked-all) [748.152263] Starting subtest: basic-queues-forked-all [767.586884] Subtest basic-queues-forked-all: SUCCESS (19.433s) [767.772945] [091/133] (261s left) kms_plane_scaling (intel-max-src-size) [767.873740] Starting subtest: intel-max-src-size [767.880402] Subtest intel-max-src-size: SKIP (0.000s) [767.974905] [092/133] (261s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [768.073913] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [775.122142] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.052s) [775.284665] [093/133] (253s left) kms_psr (fbc-psr2-sprite-render) [775.384073] Starting subtest: fbc-psr2-sprite-render [775.386259] Starting dynamic subtest: eDP-1 [775.390313] Dynamic subtest eDP-1: SKIP (0.000s) [775.394378] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [775.460057] [094/133] (253s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [775.563031] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [775.567498] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [775.658854] [095/133] (253s left) gem_pread (self) [775.718959] Subtest self: SKIP (0.000s) [775.782104] [096/133] (253s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [775.898028] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [775.902015] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [776.021382] [097/133] (253s left) kms_prop_blob (invalid-set-prop) [776.083552] Starting subtest: invalid-set-prop [776.085191] Subtest invalid-set-prop: SUCCESS (0.000s) [776.200232] [098/133] (253s left) fbdev (unaligned-write) [776.243911] Starting subtest: unaligned-write [776.343169] Subtest unaligned-write: SUCCESS (0.099s) [776.413172] [099/133] (253s left) kms_plane (pixel-format-x-tiled-modifier) [776.518246] Starting subtest: pixel-format-x-tiled-modifier [776.546059] Starting dynamic subtest: pipe-A-plane-0 [777.188042] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s) [777.201887] Starting dynamic subtest: pipe-A-plane-3 [777.576572] Dynamic subtest pipe-A-plane-3: SUCCESS (0.387s) [777.587499] Starting dynamic subtest: pipe-A-plane-5 [777.592534] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [778.681575] Starting dynamic subtest: pipe-B-plane-0 [779.291805] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s) [779.302779] Starting dynamic subtest: pipe-B-plane-3 [779.736576] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [779.749219] Starting dynamic subtest: pipe-B-plane-5 [779.752997] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [780.059697] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.542s) [780.938087] [100/133] (248s left) gem_exec_reloc (basic-wc-cpu-noreloc) [781.004090] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [781.074135] [101/133] (248s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [781.176516] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [784.886468] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.715s) [786.040077] [102/133] (243s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [786.132976] Starting subtest: 2x-wf_vblank-ts-check-interruptible [786.145629] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [786.243776] [103/133] (243s left) core_getversion (all-cards) [786.284159] Starting subtest: all-cards [786.291328] Subtest all-cards: SUCCESS (0.012s) [786.334242] [104/133] (243s left) gem_exec_reloc (basic-wc-read-noreloc) [786.389369] Subtest basic-wc-read-noreloc: SKIP (0.000s) [786.452916] [105/133] (243s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [786.552379] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [786.557217] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [786.658405] [106/133] (243s left) kms_big_fb (x-tiled-16bpp-rotate-90) [786.752130] Starting subtest: x-tiled-16bpp-rotate-90 [786.774860] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s) [786.898384] [107/133] (243s left) kms_feature_discovery (display-1x) [786.984704] Starting subtest: display-1x [786.986538] Subtest display-1x: SUCCESS (0.000s) [787.067005] [108/133] (242s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [787.185338] Starting subtest: cursorA-vs-flipB-varying-size [787.189090] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [787.342985] [109/133] (242s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [787.432733] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [787.436409] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [787.511898] [110/133] (242s left) kms_psr2_su (page_flip-xrgb8888) [787.563896] Subtest page_flip-XRGB8888: SKIP (0.000s) [787.621052] [111/133] (242s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [787.710401] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [787.713716] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [787.810467] [112/133] (242s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [787.906712] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [792.335577] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.433s) [793.524041] [113/133] (236s left) i915_drm_fdinfo (isolation) [793.571089] Starting subtest: isolation [793.573018] Starting dynamic subtest: rcs0 [793.583449] Dynamic subtest rcs0: SKIP (0.012s) [793.595028] Starting dynamic subtest: bcs0 [793.599710] Dynamic subtest bcs0: SKIP (0.012s) [793.610008] Starting dynamic subtest: vcs0 [793.614694] Dynamic subtest vcs0: SKIP (0.000s) [793.625465] Starting dynamic subtest: vcs1 [793.629799] Dynamic subtest vcs1: SKIP (0.000s) [793.640455] Starting dynamic subtest: vecs0 [793.644789] Dynamic subtest vecs0: SKIP (0.000s) [793.655826] Starting dynamic subtest: ccs0 [793.660146] Dynamic subtest ccs0: SKIP (0.000s) [793.664494] Subtest isolation: SKIP (0.029s) [793.704577] [114/133] (236s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [793.796783] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [793.800728] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [793.892101] [115/133] (236s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [793.988180] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [798.417579] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.435s) [799.626383] [116/133] (230s left) kms_big_fb (4-tiled-addfb) [799.732242] Starting subtest: 4-tiled-addfb [799.734614] Subtest 4-tiled-addfb: SUCCESS (0.000s) [799.835610] [117/133] (230s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [799.939145] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [799.943559] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [800.055230] [118/133] (230s left) kms_cursor_crc (cursor-offscreen-512x512) [800.344682] Starting subtest: cursor-offscreen-512x512 [800.348412] Subtest cursor-offscreen-512x512: SKIP (0.001s) [800.489335] [119/133] (229s left) gem_mmap (bad-size) [800.547794] Subtest bad-size: SKIP (0.000s) [800.607191] [120/133] (229s left) gem_mmap_offset (blt-coherency) [800.651938] Starting subtest: blt-coherency [800.656904] Subtest blt-coherency: SUCCESS (0.007s) [800.783258] [121/133] (229s left) api_intel_bb (simple-bb-ctx) [800.866074] Starting subtest: simple-bb-ctx [800.882400] Subtest simple-bb-ctx: SUCCESS (0.016s) [801.003310] [122/133] (229s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [801.091436] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [801.094831] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [801.188448] [123/133] (229s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [801.285021] Starting subtest: switch-modeset-ultra-joiner-big-joiner [801.288460] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [801.353604] [124/133] (229s left) kms_psr (fbc-pr-sprite-mmap-gtt) [801.458245] Starting subtest: fbc-pr-sprite-mmap-gtt [801.462006] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [801.545950] [125/133] (229s left) kms_psr (pr-primary-mmap-gtt) [801.634093] Starting subtest: pr-primary-mmap-gtt [801.637819] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [801.707053] [126/133] (229s left) kms_pipe_crc_basic (suspend-read-crc) [801.808157] Starting subtest: suspend-read-crc [801.810124] Starting dynamic subtest: pipe-A-eDP-1 [819.863937] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.921s) [819.876102] Starting dynamic subtest: pipe-B-eDP-1 [838.848423] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.625s) [838.859933] Starting dynamic subtest: pipe-C-eDP-1 [857.843337] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.439s) [857.859490] Starting dynamic subtest: pipe-D-eDP-1 [876.828302] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.436s) [876.830524] Subtest suspend-read-crc: SUCCESS (13.427s) [882.645336] [127/133] (153s left) kms_chamelium_hpd (hdmi-hpd-storm) [883.073238] Subtest hdmi-hpd-storm: SKIP (0.000s) [883.812486] [128/133] (151s left) gem_wait (write-busy) [883.882968] Starting subtest: write-busy [883.885305] Starting dynamic subtest: all-engines [884.465082] Dynamic subtest all-engines: SUCCESS (0.594s) [884.486116] Starting dynamic subtest: rcs0 [885.019256] Dynamic subtest rcs0: SUCCESS (0.566s) [885.039055] Starting dynamic subtest: bcs0 [885.570987] Dynamic subtest bcs0: SUCCESS (0.560s) [885.590806] Starting dynamic subtest: vcs0 [886.947042] Dynamic subtest vcs0: SUCCESS (1.398s) [886.965750] Starting dynamic subtest: vcs1 [888.934601] Dynamic subtest vcs1: SUCCESS (2.011s) [888.953697] Starting dynamic subtest: vecs0 [890.914425] Dynamic subtest vecs0: SUCCESS (2.001s) [890.932960] Starting dynamic subtest: ccs0 [891.466610] Dynamic subtest ccs0: SUCCESS (0.555s) [891.469122] Subtest write-busy: SUCCESS (7.697s) [891.672666] [129/133] (144s left) gem_userptr_blits (relocations) [891.789346] Starting subtest: relocations [891.793496] Subtest relocations: SKIP (0.001s) [891.929981] [130/133] (143s left) gem_eio (wait-immediate) [892.167523] Starting subtest: wait-immediate [892.512560] Subtest wait-immediate: SUCCESS (0.351s) [892.649414] [131/133] (143s left) gem_userptr_blits (create-destroy-unsync) [892.713017] Subtest create-destroy-unsync: SKIP (0.000s) [892.829985] [132/133] (143s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [892.934304] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [900.214605] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.319s) [900.335430] [133/133] (135s left) gem_exec_reloc (basic-wc) [900.444302] Subtest basic-wc: SKIP (0.000s) [900.514238] Closing watchdogs results: parsing output: 0/ for test: vgem_basic results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: kms_invalid_mode results: parsing output: 4/ for test: kms_pm_backlight results: parsing output: 5/ for test: kms_flip results: parsing output: 6/ for test: gem_mmap_gtt results: parsing output: 7/ for test: gem_softpin results: parsing output: 8/ for test: gem_render_linear_blits results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_chamelium_edid results: parsing output: 12/ for test: gen7_exec_parse results: parsing output: 13/ for test: syncobj_eventfd results: parsing output: 14/ for test: gem_ctx_exec results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: kms_vblank results: parsing output: 17/ for test: kms_chamelium_color results: parsing output: 18/ for test: gem_exec_flush results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_plane results: parsing output: 21/ for test: kms_plane_scaling results: parsing output: 22/ for test: i915_selftest results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: perf results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: gem_eio results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: gem_render_copy results: parsing output: 31/ for test: kms_flip_scaled_crc results: parsing output: 32/ for test: sw_sync results: parsing output: 33/ for test: gem_exec_schedule results: parsing output: 34/ for test: gem_tiled_fence_blits results: parsing output: 35/ for test: i915_pm_rpm results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: kms_concurrent results: parsing output: 38/ for test: gem_exec_balancer results: parsing output: 39/ for test: prime_self_import results: parsing output: 40/ for test: gem_partial_pwrite_pread results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: sysfs_timeslice_duration results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_vblank results: parsing output: 46/ for test: syncobj_wait results: parsing output: 47/ for test: gem_render_copy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: perf_pmu results: parsing output: 50/ for test: gem_mmap results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_pm_rpm results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: gem_exec_fence results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: gem_exec_fence results: parsing output: 58/ for test: prime_mmap_coherency results: parsing output: 59/ for test: kms_busy results: parsing output: 60/ for test: gem_exec_store results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: prime_busy results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: gem_set_tiling_vs_blt results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: gem_ctx_isolation results: parsing output: 69/ for test: perf_pmu results: parsing output: 70/ for test: kms_force_connector_basic results: parsing output: 71/ for test: gem_fenced_exec_thrash results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: i915_pm_freq_api results: parsing output: 74/ for test: kms_cursor_edge_walk results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: gem_ctx_persistence results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: kms_psr2_sf results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: gem_render_copy results: parsing output: 82/ for test: kms_ccs results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_atomic results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: api_intel_allocator results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: gem_mmap_wc results: parsing output: 89/ for test: gem_exec_whisper results: parsing output: 90/ for test: kms_plane_scaling results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_pread results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_prop_blob results: parsing output: 97/ for test: fbdev results: parsing output: 98/ for test: kms_plane results: parsing output: 99/ for test: gem_exec_reloc results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: core_getversion results: parsing output: 103/ for test: gem_exec_reloc results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_feature_discovery results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_flip_scaled_crc results: parsing output: 109/ for test: kms_psr2_su results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: i915_drm_fdinfo results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: gem_mmap results: parsing output: 119/ for test: gem_mmap_offset results: parsing output: 120/ for test: api_intel_bb results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_joiner results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_pipe_crc_basic results: parsing output: 126/ for test: kms_chamelium_hpd results: parsing output: 127/ for test: gem_wait results: parsing output: 128/ for test: gem_userptr_blits results: parsing output: 129/ for test: gem_eio results: parsing output: 130/ for test: gem_userptr_blits results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_exec_reloc Done.