[59.589981] Initializing watchdogs [59.590348] /dev/watchdog0 [59.605680] [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] [59.610306] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.613063] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.616415] [001/132] (960s left) perf (rc6-disable) [59.784725] Starting subtest: rc6-disable [59.960198] Subtest rc6-disable: SUCCESS (0.177s) [60.001201] [002/132] (960s left) gem_mmap_offset (clear-via-pagefault) [60.053716] Starting subtest: clear-via-pagefault [60.055673] Starting dynamic subtest: smem0 [93.099415] Dynamic subtest smem0: SUCCESS (33.078s) [93.102464] Subtest clear-via-pagefault: SUCCESS (33.079s) [93.218283] [003/132] (926s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [93.318091] Starting subtest: plane-downscale-factor-0-5-with-rotation [93.320517] Starting dynamic subtest: pipe-A [93.340922] Dynamic subtest pipe-A: SKIP (0.019s) [93.348934] Starting dynamic subtest: pipe-B [93.376323] Dynamic subtest pipe-B: SKIP (0.037s) [93.384160] Starting dynamic subtest: pipe-C [93.414208] Dynamic subtest pipe-C: SKIP (0.036s) [93.421794] Starting dynamic subtest: pipe-D [93.448701] Dynamic subtest pipe-D: SKIP (0.036s) [93.452715] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.128s) [93.549331] [004/132] (926s left) gem_exec_store (cachelines) [93.607301] Starting subtest: cachelines [93.609585] Starting dynamic subtest: rcs0 [93.666106] Dynamic subtest rcs0: SUCCESS (0.062s) [93.677750] Starting dynamic subtest: bcs0 [93.719862] Dynamic subtest bcs0: SUCCESS (0.053s) [93.729498] Starting dynamic subtest: vcs0 [93.768690] Dynamic subtest vcs0: SUCCESS (0.048s) [93.779349] Starting dynamic subtest: vcs1 [93.817639] Dynamic subtest vcs1: SUCCESS (0.048s) [93.827097] Starting dynamic subtest: vecs0 [93.869964] Dynamic subtest vecs0: SUCCESS (0.052s) [93.880290] Starting dynamic subtest: ccs0 [93.924095] Dynamic subtest ccs0: SUCCESS (0.053s) [93.926895] Subtest cachelines: SUCCESS (0.320s) [94.104857] [005/132] (926s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [94.157178] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [94.265658] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [94.355243] [006/132] (925s left) kms_big_fb (linear-32bpp-rotate-270) [94.462981] Starting subtest: linear-32bpp-rotate-270 [94.495911] Subtest linear-32bpp-rotate-270: SKIP (0.033s) [94.627968] [007/132] (925s left) i915_query (hwconfig_table) [94.679080] Starting subtest: hwconfig_table [94.977733] Subtest hwconfig_table: SUCCESS (0.001s) [95.013664] [008/132] (925s left) kms_flip (wf_vblank-ts-check) [95.102721] Starting subtest: wf_vblank-ts-check [95.104987] Starting dynamic subtest: A-eDP1 [104.309758] Dynamic subtest A-eDP1: SUCCESS (9.208s) [104.320414] Starting dynamic subtest: B-eDP1 [113.239799] Dynamic subtest B-eDP1: SUCCESS (8.928s) [113.250776] Starting dynamic subtest: C-eDP1 [122.148863] Dynamic subtest C-eDP1: SUCCESS (8.908s) [122.158946] Starting dynamic subtest: D-eDP1 [131.082403] Dynamic subtest D-eDP1: SUCCESS (8.933s) [131.085129] Subtest wf_vblank-ts-check: SUCCESS (35.985s) [132.524231] [009/132] (887s left) sriov_basic (enable-vfs-autoprobe-on) [132.575672] Starting subtest: enable-vfs-autoprobe-on [132.578182] Starting dynamic subtest: numvfs-1 [132.655979] Dynamic subtest numvfs-1: FAIL (0.016s) [132.665624] Starting dynamic subtest: numvfs-2 [132.740750] Dynamic subtest numvfs-2: FAIL (0.004s) [132.750143] Starting dynamic subtest: numvfs-3 [132.825129] Dynamic subtest numvfs-3: FAIL (0.004s) [132.834515] Starting dynamic subtest: numvfs-4 [132.909313] Dynamic subtest numvfs-4: FAIL (0.004s) [132.919404] Starting dynamic subtest: numvfs-5 [132.993458] Dynamic subtest numvfs-5: FAIL (0.004s) [133.002527] Starting dynamic subtest: numvfs-6 [133.077577] Dynamic subtest numvfs-6: FAIL (0.004s) [133.087696] Starting dynamic subtest: numvfs-7 [133.162064] Dynamic subtest numvfs-7: FAIL (0.004s) [133.171564] Starting dynamic subtest: numvfs-random [133.242255] Dynamic subtest numvfs-random: FAIL (0.004s) [133.251852] Starting dynamic subtest: numvfs-all [133.325433] Dynamic subtest numvfs-all: FAIL (0.520s) [133.327436] Subtest enable-vfs-autoprobe-on: FAIL (0.567s) [133.362398] [010/132] (887s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [133.455022] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [133.457127] Starting dynamic subtest: pipe-A-eDP-1 [133.475130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [133.484579] Starting dynamic subtest: pipe-B-eDP-1 [133.500723] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [133.508076] Starting dynamic subtest: pipe-C-eDP-1 [133.524136] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [133.531396] Starting dynamic subtest: pipe-D-eDP-1 [133.548269] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [133.550183] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.008s) [135.788952] [011/132] (884s left) kms_cursor_legacy (single-move) [135.906911] Starting subtest: single-move [135.909173] Starting dynamic subtest: pipe-A [141.290910] Dynamic subtest pipe-A: SUCCESS (5.380s) [141.299727] Starting dynamic subtest: pipe-B [146.672715] Dynamic subtest pipe-B: SUCCESS (5.381s) [146.680643] Starting dynamic subtest: pipe-C [152.055569] Dynamic subtest pipe-C: SUCCESS (5.381s) [152.063430] Starting dynamic subtest: pipe-D [157.437520] Dynamic subtest pipe-D: SUCCESS (5.380s) [157.447081] Starting dynamic subtest: all-pipes [162.827696] Dynamic subtest all-pipes: SUCCESS (5.388s) [162.831057] Subtest single-move: SUCCESS (26.916s) [162.977158] [012/132] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [163.075357] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [170.465393] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.391s) [170.588340] [013/132] (850s left) gem_exec_fence (syncobj-timeline-invalid-flags) [171.155968] Starting subtest: syncobj-timeline-invalid-flags [171.158897] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [172.346552] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [172.349975] [014/132] (848s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [172.446423] Starting subtest: pr-overlay-plane-update-sf-dmg-area [172.450512] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [172.518267] [015/132] (848s left) kms_content_protection (lic-type-1) [172.672101] Starting subtest: lic-type-1 [172.676333] Subtest lic-type-1: SKIP (0.000s) [172.804892] [016/132] (847s left) kms_flip (dpms-off-confusion-interruptible) [172.908058] Starting subtest: dpms-off-confusion-interruptible [172.910228] Starting dynamic subtest: A-eDP1 [181.623881] Dynamic subtest A-eDP1: SUCCESS (8.714s) [181.633354] Starting dynamic subtest: B-eDP1 [190.250069] Dynamic subtest B-eDP1: SUCCESS (8.624s) [190.258594] Starting dynamic subtest: C-eDP1 [198.873585] Dynamic subtest C-eDP1: SUCCESS (8.622s) [198.883572] Starting dynamic subtest: D-eDP1 [207.509614] Dynamic subtest D-eDP1: SUCCESS (8.634s) [207.512038] Subtest dpms-off-confusion-interruptible: SUCCESS (34.602s) [208.683530] [017/132] (812s left) syncobj_wait (wait-any-complex) [208.750083] Starting subtest: wait-any-complex [208.813071] Subtest wait-any-complex: SUCCESS (0.062s) [208.890511] [018/132] (811s left) gem_spin_batch (legacy) [208.960043] Starting subtest: legacy [208.962419] Starting dynamic subtest: default [212.196725] Dynamic subtest default: SUCCESS (3.234s) [212.207686] Starting dynamic subtest: render [215.430067] Dynamic subtest render: SUCCESS (3.232s) [215.443539] Starting dynamic subtest: bsd [218.662118] Dynamic subtest bsd: SUCCESS (3.231s) [218.672463] Starting dynamic subtest: bsd1 [221.899103] Dynamic subtest bsd1: SUCCESS (3.236s) [221.909807] Starting dynamic subtest: bsd2 [225.134856] Dynamic subtest bsd2: SUCCESS (3.234s) [225.144655] Starting dynamic subtest: blt [228.370887] Dynamic subtest blt: SUCCESS (3.233s) [228.381726] Starting dynamic subtest: vebox [231.606397] Dynamic subtest vebox: SUCCESS (3.234s) [231.608832] Subtest legacy: SUCCESS (22.645s) [232.352049] [019/132] (788s left) kms_atomic (atomic-plane-damage) [232.449054] Starting subtest: atomic-plane-damage [232.496888] Starting dynamic subtest: pipe-A-eDP-1 [233.021581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.523s) [233.024076] Subtest atomic-plane-damage: SUCCESS (0.573s) [233.829234] [020/132] (787s left) drm_mm (drm_mm) [233.872223] Starting subtest: drm_mm [233.886155] Starting dynamic subtest: drm_test_mm_init [233.964527] Dynamic subtest drm_test_mm_init: SUCCESS (0.077s) [233.975162] Starting dynamic subtest: drm_test_mm_debug [234.064329] Dynamic subtest drm_test_mm_debug: SUCCESS (0.100s) [234.077334] Starting dynamic subtest: drm_test_mm_align32 [234.160479] Dynamic subtest drm_test_mm_align32: SUCCESS (0.096s) [234.168803] Starting dynamic subtest: drm_test_mm_align64 [234.255332] Dynamic subtest drm_test_mm_align64: SUCCESS (0.095s) [234.264503] Starting dynamic subtest: drm_test_mm_lowest [234.338354] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.083s) [234.346503] Starting dynamic subtest: drm_test_mm_highest [234.435465] Dynamic subtest drm_test_mm_highest: SUCCESS (0.095s) [234.437486] Subtest drm_mm: SUCCESS (0.562s) [234.584585] [021/132] (786s left) gem_partial_pwrite_pread (write-display) [234.644752] Subtest write-display: SKIP (0.000s) [234.717055] [022/132] (786s left) gem_exec_schedule (noreorder-corked) [234.890762] Starting subtest: noreorder-corked [234.893451] Starting dynamic subtest: rcs0 [236.023073] Dynamic subtest rcs0: SUCCESS (1.133s) [236.034935] Starting dynamic subtest: vcs0 [237.318538] Dynamic subtest vcs0: SUCCESS (1.293s) [237.329524] Starting dynamic subtest: vcs1 [239.311127] Dynamic subtest vcs1: SUCCESS (1.992s) [239.322052] Starting dynamic subtest: vecs0 [241.263829] Dynamic subtest vecs0: SUCCESS (1.951s) [241.276954] Starting dynamic subtest: ccs0 [242.397741] Dynamic subtest ccs0: SUCCESS (1.134s) [242.400368] Subtest noreorder-corked: SUCCESS (7.509s) [242.596242] [023/132] (778s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [242.692828] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [242.697267] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [242.825523] [024/132] (778s left) kms_getfb (getfb-addfb-different-handles) [242.929071] Starting subtest: getfb-addfb-different-handles [242.931332] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [243.020069] [025/132] (778s left) i915_pm_rps (fence-order) [243.078304] Starting subtest: fence-order [246.020854] Subtest fence-order: SUCCESS (2.939s) [246.155767] [026/132] (774s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [246.273768] Starting subtest: flip-vs-cursor-varying-size [255.340165] Subtest flip-vs-cursor-varying-size: SUCCESS (9.066s) [256.153446] [027/132] (765s left) gem_mmap_wc (bad-offset) [256.216820] Subtest bad-offset: SKIP (0.000s) [256.279107] [028/132] (764s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [256.385028] Starting subtest: basic-max-pipe-crc-check [256.389611] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [256.431506] [029/132] (764s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [256.526884] Starting subtest: fbc-rgb565-draw-pwrite [261.166067] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.641s) [262.355895] [030/132] (758s left) gem_userptr_blits (unsync-unmap) [262.430083] Subtest unsync-unmap: SKIP (0.000s) [262.545670] [031/132] (758s left) kms_psr (fbc-psr2-basic) [262.638640] Starting subtest: fbc-psr2-basic [262.641048] Starting dynamic subtest: eDP-1 [262.645627] Dynamic subtest eDP-1: SKIP (0.000s) [262.650210] Subtest fbc-psr2-basic: SKIP (0.001s) [262.710753] [032/132] (758s left) gem_mmap_wc (read-write) [262.761133] Subtest read-write: SKIP (0.000s) [262.821272] [033/132] (758s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [262.929066] Starting subtest: basic-busy-flip-before-cursor-varying-size [262.933419] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [263.075951] [034/132] (758s left) kms_invalid_mode (zero-clock) [263.164453] Starting subtest: zero-clock [263.166958] Starting dynamic subtest: pipe-A-eDP-1 [263.468618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.304s) [263.478608] Starting dynamic subtest: pipe-B-eDP-1 [263.480618] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [263.489650] Starting dynamic subtest: pipe-C-eDP-1 [263.491913] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [263.500683] Starting dynamic subtest: pipe-D-eDP-1 [263.503076] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [263.505455] Subtest zero-clock: SUCCESS (0.308s) [264.284479] [035/132] (757s left) gem_lmem_swapping (random) [264.329101] Subtest random: SKIP (0.000s) [264.370426] [036/132] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [264.467749] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [264.472034] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [264.565759] [037/132] (757s left) gem_ctx_exec (basic-norecovery) [264.627251] Starting subtest: basic-norecovery [264.901262] Subtest basic-norecovery: SUCCESS (0.276s) [265.051985] [038/132] (756s left) syncobj_wait (signal) [265.106017] Starting subtest: signal [265.108314] Subtest signal: SUCCESS (0.000s) [265.192020] [039/132] (756s left) kms_vrr (max-min) [265.285537] Starting subtest: max-min [265.291028] Subtest max-min: SKIP (0.000s) [265.367508] [040/132] (756s left) gem_exec_schedule (semaphore-user) [265.439832] Starting subtest: semaphore-user [265.496318] Subtest semaphore-user: SUCCESS (0.057s) [267.324652] [041/132] (754s left) kms_pm_rpm (pm-caching) [269.447554] Starting subtest: pm-caching [269.452909] Subtest pm-caching: SKIP (0.000s) [269.857499] [042/132] (751s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [269.962736] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [269.967070] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [270.054845] [043/132] (751s left) gem_ctx_param (set-priority-not-supported) [270.114134] Starting subtest: set-priority-not-supported [270.118517] Subtest set-priority-not-supported: SKIP (0.000s) [270.190932] [044/132] (751s left) gem_exec_reloc (basic-write-read-active) [270.241708] Subtest basic-write-read-active: SKIP (0.000s) [270.313104] [045/132] (751s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [270.402056] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [270.427663] Starting dynamic subtest: pipe-A-plane-0 [270.705370] Dynamic subtest pipe-A-plane-0: SUCCESS (0.277s) [270.716893] Starting dynamic subtest: pipe-A-plane-3 [270.916533] Dynamic subtest pipe-A-plane-3: SUCCESS (0.211s) [272.023805] Starting dynamic subtest: pipe-B-plane-0 [272.304074] Dynamic subtest pipe-B-plane-0: SUCCESS (0.290s) [272.313507] Starting dynamic subtest: pipe-B-plane-3 [272.514726] Dynamic subtest pipe-B-plane-3: SUCCESS (0.209s) [272.845590] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.445s) [273.695320] [046/132] (748s left) gem_ctx_engines (none) [273.755605] Starting subtest: none [273.758023] Subtest none: SUCCESS (0.001s) [273.941319] [047/132] (748s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [274.045806] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [278.501559] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.459s) [279.694249] [048/132] (742s left) gem_exec_suspend (basic-s3-devices) [279.763450] Starting subtest: basic-S3-devices [279.765983] Starting dynamic subtest: smem [291.334355] Dynamic subtest smem: SUCCESS (11.567s) [291.337437] Subtest basic-S3-devices: SUCCESS (11.569s) [291.514213] [049/132] (730s left) gem_ctx_persistence (idempotent) [291.582631] Starting subtest: idempotent [291.585134] Subtest idempotent: SUCCESS (0.000s) [291.684472] [050/132] (730s left) gem_userptr_blits (input-checking) [291.755750] Starting subtest: input-checking [291.758021] Subtest input-checking: SUCCESS (0.000s) [291.897484] [051/132] (730s left) perf (invalid-create-userspace-config) [292.009134] Starting subtest: invalid-create-userspace-config [292.011508] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [292.058458] [052/132] (730s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [292.155188] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [292.157441] Starting dynamic subtest: pipe-A-eDP-1 [293.021984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s) [293.032802] Starting dynamic subtest: pipe-B-eDP-1 [294.773355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.745s) [294.789892] Starting dynamic subtest: pipe-C-eDP-1 [296.342023] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.569s) [296.352510] Starting dynamic subtest: pipe-D-eDP-1 [297.869405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s) [297.871553] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.706s) [299.117291] [053/132] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [299.211041] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [299.215105] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [299.320432] [054/132] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [299.421539] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [299.425660] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [299.546235] [055/132] (722s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [299.646503] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [299.650929] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [299.746318] [056/132] (722s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [299.839388] Starting subtest: plane-all-modeset-transition-internal-panels [299.841287] Starting dynamic subtest: pipe-A-eDP-1 [301.150365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.310s) [301.440678] Starting dynamic subtest: pipe-B-eDP-1 [302.484485] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s) [302.752551] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.912s) [303.601326] [057/132] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [303.687180] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [304.064138] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [306.882061] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.817s) [306.892434] Starting dynamic subtest: pipe-A-eDP-1-4 [309.055794] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s) [309.067889] Starting dynamic subtest: pipe-A-eDP-1-4 [311.065404] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [311.075340] Starting dynamic subtest: pipe-A-eDP-1-x [313.244656] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [313.619839] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [316.408099] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.797s) [316.418302] Starting dynamic subtest: pipe-B-eDP-1-4 [318.593475] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s) [318.606030] Starting dynamic subtest: pipe-B-eDP-1-4 [320.602549] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [320.615284] Starting dynamic subtest: pipe-B-eDP-1-x [322.804085] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [323.168830] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [325.939590] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s) [325.952883] Starting dynamic subtest: pipe-C-eDP-1-4 [328.113073] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [328.123184] Starting dynamic subtest: pipe-C-eDP-1-4 [330.123903] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s) [330.134846] Starting dynamic subtest: pipe-C-eDP-1-x [332.312721] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s) [332.683796] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [335.485182] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.810s) [335.496645] Starting dynamic subtest: pipe-D-eDP-1-4 [337.656990] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.171s) [337.667531] Starting dynamic subtest: pipe-D-eDP-1-4 [339.667318] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s) [339.677447] Starting dynamic subtest: pipe-D-eDP-1-x [341.857068] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [341.859863] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.170s) [343.075987] [058/132] (679s left) kms_big_fb (x-tiled-64bpp-rotate-270) [343.172983] Starting subtest: x-tiled-64bpp-rotate-270 [343.194207] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s) [343.322387] [059/132] (679s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [343.375938] Starting subtest: invalid-single-wait-all-unsubmitted [343.377892] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [343.497744] [060/132] (679s left) i915_hangman (engine-engine-hang) [343.565341] Starting subtest: engine-engine-hang [343.567348] Starting dynamic subtest: rcs0 [345.253457] Dynamic subtest rcs0: SUCCESS (1.686s) [345.268520] Starting dynamic subtest: bcs0 [347.300593] Dynamic subtest bcs0: SUCCESS (2.046s) [347.313914] Starting dynamic subtest: vcs0 [349.284460] Dynamic subtest vcs0: SUCCESS (1.981s) [349.297413] Starting dynamic subtest: vcs1 [351.268695] Dynamic subtest vcs1: SUCCESS (1.982s) [351.282669] Starting dynamic subtest: vecs0 [353.252077] Dynamic subtest vecs0: SUCCESS (1.981s) [353.265983] Starting dynamic subtest: ccs0 [355.236026] Dynamic subtest ccs0: SUCCESS (1.981s) [355.238550] Subtest engine-engine-hang: SUCCESS (11.671s) [355.363380] [061/132] (667s left) gen7_exec_parse (basic-allowed) [355.426635] Subtest basic-allowed: SKIP (0.000s) [355.502432] [062/132] (667s left) kms_chamelium_hpd (common-hpd-after-suspend) [355.898929] Subtest common-hpd-after-suspend: SKIP (0.000s) [356.682166] [063/132] (665s left) kms_pm_lpsp (kms-lpsp) [357.790744] Starting subtest: kms-lpsp [357.792631] Starting dynamic subtest: pipe-A-eDP-1 [357.930726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s) [358.232320] Subtest kms-lpsp: SUCCESS (0.443s) [359.043880] [064/132] (663s left) kms_cursor_crc (cursor-random-512x512) [359.297731] Starting subtest: cursor-random-512x512 [359.302369] Subtest cursor-random-512x512: SKIP (0.001s) [359.450149] [065/132] (663s left) syncobj_timeline (single-wait-available-signaled) [359.501285] Starting subtest: single-wait-available-signaled [359.503496] Subtest single-wait-available-signaled: SUCCESS (0.001s) [359.590740] [066/132] (663s left) gem_mmap_wc (write-read) [359.650122] Subtest write-read: SKIP (0.000s) [359.711712] [067/132] (663s left) kms_chamelium_frames (hdmi-aspect-ratio) [360.095874] Subtest hdmi-aspect-ratio: SKIP (0.000s) [360.953087] [068/132] (661s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [361.059700] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [361.063935] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [361.163098] [069/132] (661s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [361.264941] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [362.355781] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.093s) [362.467525] [070/132] (660s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [362.566685] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [362.570452] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s) [362.645691] [071/132] (660s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [362.752771] Starting subtest: plane-upscale-20x20-with-modifiers [362.754813] Starting dynamic subtest: pipe-A [363.088148] Dynamic subtest pipe-A: SUCCESS (0.337s) [363.098812] Starting dynamic subtest: pipe-B [364.472449] Dynamic subtest pipe-B: SUCCESS (1.383s) [364.485664] Starting dynamic subtest: pipe-C [365.912021] Dynamic subtest pipe-C: SUCCESS (1.439s) [365.924537] Starting dynamic subtest: pipe-D [367.341247] Dynamic subtest pipe-D: SUCCESS (1.427s) [367.343508] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.590s) [368.509848] [072/132] (654s left) kms_explicit_fence (multiplane-atomic-fence-wait) [368.656344] Starting subtest: multiplane-atomic-fence-wait [368.975807] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s) [370.144839] [073/132] (652s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [370.246225] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [370.248585] Starting dynamic subtest: pipe-A-default-mode [371.413139] Dynamic subtest pipe-A-default-mode: SKIP (1.164s) [371.417849] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.165s) [371.559869] [074/132] (651s left) gem_exec_capture (pi) [371.614958] Starting subtest: pi [371.617266] Starting dynamic subtest: rcs0 [376.111768] Dynamic subtest rcs0: SUCCESS (4.496s) [376.125780] Starting dynamic subtest: bcs0 [380.202755] Dynamic subtest bcs0: SUCCESS (4.089s) [380.213749] Starting dynamic subtest: vcs0 [384.282142] Dynamic subtest vcs0: SUCCESS (4.078s) [384.295246] Starting dynamic subtest: vcs1 [388.356168] Dynamic subtest vcs1: SUCCESS (4.072s) [388.367670] Starting dynamic subtest: vecs0 [392.434565] Dynamic subtest vecs0: SUCCESS (4.077s) [392.446255] Starting dynamic subtest: ccs0 [396.680463] Dynamic subtest ccs0: SUCCESS (4.244s) [396.683071] Subtest pi: SUCCESS (25.065s) [396.778491] [075/132] (626s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [396.946173] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [396.950744] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [398.119076] [076/132] (625s left) kms_vblank (accuracy-idle) [398.211464] Starting subtest: accuracy-idle [398.213445] Starting dynamic subtest: pipe-A-eDP-1 [399.968036] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s) [399.984073] Starting dynamic subtest: pipe-D-eDP-1 [402.463674] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.492s) [402.466064] Subtest accuracy-idle: SUCCESS (4.254s) [403.273967] [077/132] (620s left) gem_close_race (basic-threads) [403.348355] Starting subtest: basic-threads [404.722398] Subtest basic-threads: SUCCESS (1.376s) [404.925517] [078/132] (618s left) kms_addfb_basic (basic) [404.972815] Starting subtest: basic [404.975156] Subtest basic: SUCCESS (0.000s) [405.115145] [079/132] (618s left) kms_cursor_legacy (cursor-vs-flip-atomic) [405.232515] Starting subtest: cursor-vs-flip-atomic [435.074505] Subtest cursor-vs-flip-atomic: SUCCESS (29.839s) [435.911139] [080/132] (587s left) prime_vgem (fence-read-hang) [435.989062] Subtest fence-read-hang: SKIP (0.000s) [436.102671] [081/132] (587s left) gem_eio (create) [436.308770] Starting subtest: create [436.600548] Subtest create: SUCCESS (0.291s) [436.720060] [082/132] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [436.812485] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [443.504247] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.695s) [443.649081] [083/132] (579s left) vgem_basic (dmabuf-export) [443.693738] Starting subtest: dmabuf-export [443.725608] Subtest dmabuf-export: SUCCESS (0.035s) [443.844076] [084/132] (579s left) prime_mmap (test_errors) [443.896747] Starting subtest: test_errors [443.898705] Starting dynamic subtest: test_errors-smem [443.992694] Dynamic subtest test_errors-smem: SUCCESS (0.098s) [443.995609] Subtest test_errors: SUCCESS (0.099s) [444.094031] [085/132] (579s left) perf_pmu (idle-no-semaphores) [444.135681] Starting subtest: idle-no-semaphores [444.137585] Starting dynamic subtest: rcs0 [444.677719] Dynamic subtest rcs0: SUCCESS (0.541s) [444.690945] Starting dynamic subtest: bcs0 [445.195604] Dynamic subtest bcs0: SUCCESS (0.515s) [445.210071] Starting dynamic subtest: vcs0 [445.713111] Dynamic subtest vcs0: SUCCESS (0.514s) [445.725656] Starting dynamic subtest: vcs1 [446.230497] Dynamic subtest vcs1: SUCCESS (0.515s) [446.245290] Starting dynamic subtest: vecs0 [446.754615] Dynamic subtest vecs0: SUCCESS (0.520s) [446.768210] Starting dynamic subtest: ccs0 [447.285606] Dynamic subtest ccs0: SUCCESS (0.527s) [447.288473] Subtest idle-no-semaphores: SUCCESS (3.151s) [447.404677] [086/132] (576s left) kms_plane_lowres (tiling-none) [447.502882] Starting subtest: tiling-none [447.505146] Starting dynamic subtest: pipe-A-eDP-1 [447.509635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [447.810752] Starting dynamic subtest: pipe-B-eDP-1 [447.815739] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [447.826783] Starting dynamic subtest: pipe-C-eDP-1 [447.831382] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [447.842174] Starting dynamic subtest: pipe-D-eDP-1 [447.846358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [447.850558] Subtest tiling-none: SKIP (0.302s) [448.669536] [087/132] (575s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [448.758264] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [448.763016] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [449.897530] [088/132] (573s left) kms_cursor_crc (cursor-offscreen-256x256) [450.137907] Starting subtest: cursor-offscreen-256x256 [450.142893] Starting dynamic subtest: pipe-A-eDP-1 [452.085536] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s) [452.115945] Starting dynamic subtest: pipe-D-eDP-1 [454.722329] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s) [454.724737] Subtest cursor-offscreen-256x256: SUCCESS (4.582s) [455.566585] [089/132] (568s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [455.622272] Starting subtest: single-wait-all-for-submit-unsubmitted [455.730472] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [455.810980] [090/132] (568s left) kms_psr (psr2-sprite-blt) [455.907570] Starting subtest: psr2-sprite-blt [455.910099] Starting dynamic subtest: eDP-1 [457.671662] Dynamic subtest eDP-1: SUCCESS (1.761s) [457.673800] Subtest psr2-sprite-blt: SUCCESS (1.763s) [458.529855] [091/132] (565s left) prime_vgem (basic-fence-flip) [458.611303] Starting subtest: basic-fence-flip [458.917427] Subtest basic-fence-flip: SUCCESS (0.306s) [459.022682] [092/132] (564s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [459.129870] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [466.474759] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.348s) [466.606773] [093/132] (557s left) kms_psr (pr-basic) [466.695061] Starting subtest: pr-basic [466.699413] Subtest pr-basic: SKIP (0.000s) [466.782625] [094/132] (557s left) kms_vblank (query-idle) [466.868356] Starting subtest: query-idle [466.870287] Starting dynamic subtest: pipe-A-eDP-1 [468.622862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s) [468.638514] Starting dynamic subtest: pipe-D-eDP-1 [471.103823] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.476s) [471.105835] Subtest query-idle: SUCCESS (4.236s) [471.926797] [095/132] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [472.019175] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [472.023128] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [472.114526] [096/132] (551s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [472.172557] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [472.174746] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [472.278767] [097/132] (551s left) kms_big_fb (4-tiled-addfb) [472.379641] Starting subtest: 4-tiled-addfb [472.382090] Subtest 4-tiled-addfb: SUCCESS (0.000s) [472.491267] [098/132] (551s left) kms_force_connector_basic (force-connector-state) [472.561863] Starting subtest: force-connector-state [473.181503] Subtest force-connector-state: SUCCESS (0.620s) [474.179058] [099/132] (550s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [474.275163] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [474.279090] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [474.378254] [100/132] (549s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [474.476669] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [474.481513] Starting dynamic subtest: A-eDP1 [478.093594] Dynamic subtest A-eDP1: SUCCESS (3.610s) [478.106811] Starting dynamic subtest: B-eDP1 [481.399335] Dynamic subtest B-eDP1: SUCCESS (3.308s) [481.412529] Starting dynamic subtest: C-eDP1 [484.692100] Dynamic subtest C-eDP1: SUCCESS (3.290s) [484.703467] Starting dynamic subtest: D-eDP1 [487.993353] Dynamic subtest D-eDP1: SUCCESS (3.302s) [487.995732] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.518s) [488.869441] [101/132] (535s left) api_intel_allocator (reserve-simple) [488.933184] Starting subtest: reserve-simple [488.935492] Subtest reserve-simple: SUCCESS (0.003s) [489.061662] [102/132] (535s left) kms_rotation_crc (multiplane-rotation) [489.150866] Starting subtest: multiplane-rotation [506.619673] Subtest multiplane-rotation: SUCCESS (17.471s) [506.750430] [103/132] (517s left) gem_ccs (block-multicopy-inplace) [506.818665] Starting subtest: block-multicopy-inplace [506.822451] Subtest block-multicopy-inplace: SKIP (0.000s) [506.919122] [104/132] (517s left) vgem_basic (mmap) [506.959665] Starting subtest: mmap [506.966719] Subtest mmap: SUCCESS (0.009s) [507.028366] [105/132] (517s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [507.087427] Starting subtest: yf-tiled-to-vebox-yf-tiled [507.090752] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [507.277788] [106/132] (517s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [507.402811] Starting subtest: cursorB-vs-flipB-toggle [507.407518] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [507.556805] [107/132] (517s left) gem_render_copy (linear-to-vebox-yf-tiled) [507.633377] Starting subtest: linear-to-vebox-yf-tiled [507.637618] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [507.824954] [108/132] (516s left) gem_exec_balancer (bonded-semaphore) [507.887616] Starting subtest: bonded-semaphore [507.892061] Subtest bonded-semaphore: SKIP (0.000s) [508.227043] [109/132] (516s left) kms_properties (crtc-properties-legacy) [508.318370] Starting subtest: crtc-properties-legacy [508.320768] Starting dynamic subtest: pipe-A-eDP-1 [508.771345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s) [508.782472] Starting dynamic subtest: pipe-B-eDP-1 [509.996732] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s) [510.008173] Starting dynamic subtest: pipe-C-eDP-1 [511.169758] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.172s) [511.181157] Starting dynamic subtest: pipe-D-eDP-1 [512.383826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [512.386117] Subtest crtc-properties-legacy: SUCCESS (4.067s) [513.254209] [110/132] (511s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [513.356063] Starting subtest: fbcpsr-slowdraw [538.593036] Subtest fbcpsr-slowdraw: SUCCESS (25.242s) [538.756052] [111/132] (485s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [538.861094] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [538.874104] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s) [538.951689] [112/132] (485s left) i915_drm_fdinfo (busy-check-all) [539.000385] Starting subtest: busy-check-all [539.002659] Starting dynamic subtest: rcs0 [539.007191] Dynamic subtest rcs0: SKIP (0.003s) [539.019088] Starting dynamic subtest: bcs0 [539.023406] Dynamic subtest bcs0: SKIP (0.000s) [539.036064] Starting dynamic subtest: vcs0 [539.040208] Dynamic subtest vcs0: SKIP (0.000s) [539.050619] Starting dynamic subtest: vcs1 [539.055114] Dynamic subtest vcs1: SKIP (0.000s) [539.068083] Starting dynamic subtest: vecs0 [539.072488] Dynamic subtest vecs0: SKIP (0.000s) [539.084468] Starting dynamic subtest: ccs0 [539.088642] Dynamic subtest ccs0: SKIP (0.000s) [539.092782] Subtest busy-check-all: SKIP (0.009s) [539.131563] [113/132] (485s left) kms_big_fb (y-tiled-addfb-size-overflow) [539.266395] Starting subtest: y-tiled-addfb-size-overflow [539.270838] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [539.386580] [114/132] (485s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [539.486513] Starting subtest: psr-rgb101010-draw-mmap-wc [546.624380] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.140s) [546.756275] [115/132] (478s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [546.851502] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [546.863488] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s) [546.946703] [116/132] (478s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [547.007118] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [547.114365] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s) [547.204900] [117/132] (477s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [547.303149] Starting subtest: fbc-pr-plane-move-sf-dmg-area [547.307492] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [547.373256] [118/132] (477s left) kms_color (invalid-ctm-matrix-sizes) [547.468985] Starting subtest: invalid-ctm-matrix-sizes [547.471613] Starting dynamic subtest: pipe-A [547.473979] Dynamic subtest pipe-A: SUCCESS (0.002s) [547.489324] Starting dynamic subtest: pipe-B [547.491258] Dynamic subtest pipe-B: SUCCESS (0.003s) [547.502446] Starting dynamic subtest: pipe-C [547.504662] Dynamic subtest pipe-C: SUCCESS (0.003s) [547.515271] Starting dynamic subtest: pipe-D [547.517120] Dynamic subtest pipe-D: SUCCESS (0.004s) [547.518985] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s) [547.570857] [119/132] (477s left) sysfs_timeslice_duration (idempotent) [547.635798] Starting subtest: idempotent [547.638176] Starting dynamic subtest: vecs0 [547.640444] Dynamic subtest vecs0: SUCCESS (0.000s) [547.652665] Starting dynamic subtest: ccs0 [547.654883] Dynamic subtest ccs0: SUCCESS (0.000s) [547.665684] Starting dynamic subtest: vcs0 [547.667963] Dynamic subtest vcs0: SUCCESS (0.000s) [547.678595] Starting dynamic subtest: bcs0 [547.680836] Dynamic subtest bcs0: SUCCESS (0.000s) [547.691606] Starting dynamic subtest: rcs0 [547.693525] Dynamic subtest rcs0: SUCCESS (0.000s) [547.703890] Starting dynamic subtest: vcs1 [547.706096] Dynamic subtest vcs1: SUCCESS (0.000s) [547.708255] Subtest idempotent: SUCCESS (0.007s) [547.748670] [120/132] (477s left) gen9_exec_parse (bb-secure) [547.805690] Subtest bb-secure: SKIP (0.000s) [547.869948] [121/132] (477s left) api_intel_bb (lot-of-buffers) [547.917264] Starting subtest: lot-of-buffers [548.988500] Subtest lot-of-buffers: SUCCESS (1.073s) [549.419103] [122/132] (475s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [549.538925] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [549.543340] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [549.647054] [123/132] (475s left) gem_exec_gttfill (engines) [549.725776] Starting subtest: engines [549.728090] Starting dynamic subtest: rcs0 [572.464425] Dynamic subtest rcs0: SUCCESS (22.741s) [572.477822] Starting dynamic subtest: bcs0 [595.835280] Dynamic subtest bcs0: SUCCESS (23.368s) [595.846867] Starting dynamic subtest: vcs0 [619.165779] Dynamic subtest vcs0: SUCCESS (23.329s) [619.179251] Starting dynamic subtest: vcs1 [642.482643] Dynamic subtest vcs1: SUCCESS (23.314s) [642.494221] Starting dynamic subtest: vecs0 [665.840839] Dynamic subtest vecs0: SUCCESS (23.356s) [665.852082] Starting dynamic subtest: ccs0 [689.238163] Dynamic subtest ccs0: SUCCESS (23.395s) [689.240423] Subtest engines: SUCCESS (139.514s) [689.432430] [124/132] (335s left) gem_exec_whisper (basic-queues-priority) [689.542072] Starting subtest: basic-queues-priority [712.404448] Subtest basic-queues-priority: SUCCESS (22.858s) [712.602673] [125/132] (312s left) gem_eio (in-flight-immediate) [712.850277] Starting subtest: in-flight-immediate [721.240743] Subtest in-flight-immediate: SUCCESS (8.390s) [721.422317] [126/132] (303s left) kms_psr (fbc-pr-cursor-blt) [721.516972] Starting subtest: fbc-pr-cursor-blt [721.521224] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [721.591803] [127/132] (303s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [721.696452] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [729.157614] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.463s) [729.276873] [128/132] (296s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [729.377530] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [729.379771] Starting dynamic subtest: pipe-A-eDP-1 [729.404707] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [729.418053] Starting dynamic subtest: pipe-B-eDP-1 [729.442169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [729.453349] Starting dynamic subtest: pipe-C-eDP-1 [729.477699] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [729.488539] Starting dynamic subtest: pipe-D-eDP-1 [729.512770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [729.516848] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [731.634640] [129/132] (293s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [731.736876] Starting subtest: switch-modeset-ultra-joiner-big-joiner [731.741067] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [731.806489] [130/132] (293s left) kms_hdr (bpc-switch-suspend) [731.899273] Starting subtest: bpc-switch-suspend [732.978507] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [752.371409] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.573s) [753.477452] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [773.369492] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.566s) [773.371922] Subtest bpc-switch-suspend: SUCCESS (11.310s) [773.496719] [131/132] (252s left) kms_psr (fbc-psr-sprite-blt) [773.599965] Starting subtest: fbc-psr-sprite-blt [773.602266] Starting dynamic subtest: eDP-1 [773.606666] Dynamic subtest eDP-1: SKIP (0.000s) [773.611096] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [773.676386] [132/132] (251s left) kms_atomic_interruptible (universal-setplane-cursor) [773.778440] Starting subtest: universal-setplane-cursor [773.780807] Starting dynamic subtest: pipe-A-eDP-1 [781.214739] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.425s) [781.217337] Subtest universal-setplane-cursor: SUCCESS (7.426s) [782.034333] Closing watchdogs results: parsing output: 0/ for test: perf results: parsing output: 1/ for test: gem_mmap_offset results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: gem_exec_store results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: i915_query results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: sriov_basic results: parsing output: 9/ for test: kms_ccs results: parsing output: 10/ for test: kms_cursor_legacy results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: kms_psr2_sf results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: gem_spin_batch results: parsing output: 18/ for test: kms_atomic results: parsing output: 19/ for test: drm_mm results: parsing output: 20/ for test: gem_partial_pwrite_pread results: parsing output: 21/ for test: gem_exec_schedule results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_getfb results: parsing output: 24/ for test: i915_pm_rps results: parsing output: 25/ for test: kms_cursor_legacy results: parsing output: 26/ for test: gem_mmap_wc results: parsing output: 27/ for test: kms_multipipe_modeset results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: gem_mmap_wc results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_invalid_mode results: parsing output: 34/ for test: gem_lmem_swapping results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_ctx_exec results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: kms_vrr results: parsing output: 39/ for test: gem_exec_schedule results: parsing output: 40/ for test: kms_pm_rpm results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_ctx_param results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: kms_plane results: parsing output: 45/ for test: gem_ctx_engines results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_exec_suspend results: parsing output: 48/ for test: gem_ctx_persistence results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_atomic_transition results: parsing output: 56/ for test: kms_async_flips results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: i915_hangman results: parsing output: 60/ for test: gen7_exec_parse results: parsing output: 61/ for test: kms_chamelium_hpd results: parsing output: 62/ for test: kms_pm_lpsp results: parsing output: 63/ for test: kms_cursor_crc results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: gem_mmap_wc results: parsing output: 66/ for test: kms_chamelium_frames results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: kms_flip_scaled_crc results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: kms_explicit_fence results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_capture results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_vblank results: parsing output: 76/ for test: gem_close_race results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_cursor_legacy results: parsing output: 79/ for test: prime_vgem results: parsing output: 80/ for test: gem_eio results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: vgem_basic results: parsing output: 83/ for test: prime_mmap results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_plane_lowres results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: kms_cursor_crc results: parsing output: 88/ for test: syncobj_wait results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: prime_vgem results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: kms_vblank results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_force_connector_basic results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_flip results: parsing output: 100/ for test: api_intel_allocator results: parsing output: 101/ for test: kms_rotation_crc results: parsing output: 102/ for test: gem_ccs results: parsing output: 103/ for test: vgem_basic results: parsing output: 104/ for test: gem_render_copy results: parsing output: 105/ for test: kms_cursor_legacy results: parsing output: 106/ for test: gem_render_copy results: parsing output: 107/ for test: gem_exec_balancer results: parsing output: 108/ for test: kms_properties results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: i915_drm_fdinfo results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_flip results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: kms_color results: parsing output: 118/ for test: sysfs_timeslice_duration results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: api_intel_bb results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: gem_exec_gttfill results: parsing output: 123/ for test: gem_exec_whisper results: parsing output: 124/ for test: gem_eio results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: kms_joiner results: parsing output: 129/ for test: kms_hdr results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: kms_atomic_interruptible Done.