[55.937842] Initializing watchdogs [55.937980] /dev/watchdog0 [55.947006] [001/130] (960s left) dmabuf_sync_file (export-wait-after-attach) [56.036283] Starting subtest: export-wait-after-attach [56.038743] Subtest export-wait-after-attach: SUCCESS (0.001s) [56.071895] [002/130] (960s left) kms_plane_alpha_blend (constant-alpha-max) [56.172898] Starting subtest: constant-alpha-max [56.444613] Starting dynamic subtest: pipe-A-eDP-1 [57.350801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s) [57.358457] Starting dynamic subtest: pipe-D-eDP-1 [58.958161] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.579s) [58.960581] Subtest constant-alpha-max: SUCCESS (2.730s) [59.824722] [003/130] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [59.932734] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [59.937368] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [60.019542] [004/130] (956s left) gem_exec_balancer (sliced) [60.096243] Starting subtest: sliced [60.100953] Subtest sliced: SKIP (0.000s) [60.354627] [005/130] (956s left) i915_pm_rps (min-max-config-loaded) [60.414046] Starting subtest: min-max-config-loaded [60.419163] Subtest min-max-config-loaded: SKIP (0.000s) [60.475998] [006/130] (956s left) gen7_exec_parse (load-register-reg) [60.548333] Subtest load-register-reg: SKIP (0.000s) [60.607530] [007/130] (956s left) kms_psr (pr-basic) [60.714157] Starting subtest: pr-basic [60.718708] Subtest pr-basic: SKIP (0.000s) [60.764201] [008/130] (955s left) syncobj_timeline (invalid-transfer-illegal-handle) [60.826221] Starting subtest: invalid-transfer-illegal-handle [60.828624] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [60.917943] [009/130] (955s left) kms_pm_rpm (basic-pci-d3-state) [63.069687] Starting subtest: basic-pci-d3-state [64.532894] Subtest basic-pci-d3-state: SUCCESS (1.448s) [64.586139] [010/130] (952s left) gem_exec_schedule (semaphore-resolve) [64.661801] Starting subtest: semaphore-resolve [64.695853] Subtest semaphore-resolve: SUCCESS (0.038s) [65.034774] [011/130] (951s left) kms_frontbuffer_tracking (fbc-2p-rte) [65.149268] Starting subtest: fbc-2p-rte [65.153437] Subtest fbc-2p-rte: SKIP (0.000s) [65.247891] [012/130] (951s left) gem_lmem_swapping (verify) [65.291205] Subtest verify: SKIP (0.000s) [65.308631] [013/130] (951s left) gem_exec_whisper (basic-contexts) [65.370003] Starting subtest: basic-contexts [70.727933] Subtest basic-contexts: SUCCESS (5.329s) [70.892541] [014/130] (945s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [71.025309] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [71.027756] Starting dynamic subtest: pipe-A [71.095663] Dynamic subtest pipe-A: SUCCESS (0.070s) [71.105449] Starting dynamic subtest: pipe-B [72.246236] Dynamic subtest pipe-B: SUCCESS (1.147s) [72.258674] Starting dynamic subtest: pipe-C [73.348388] Dynamic subtest pipe-C: SUCCESS (1.099s) [73.356776] Starting dynamic subtest: pipe-D [74.469173] Dynamic subtest pipe-D: SUCCESS (1.118s) [74.471646] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.435s) [75.603799] [015/130] (941s left) gem_userptr_blits (usage-restrictions) [75.664478] Starting subtest: usage-restrictions [75.666702] Subtest usage-restrictions: SUCCESS (0.000s) [75.782303] [016/130] (941s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [75.880606] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [75.882846] Starting dynamic subtest: pipe-A-eDP-1 [75.904648] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [75.911603] Starting dynamic subtest: pipe-B-eDP-1 [75.932735] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [75.939620] Starting dynamic subtest: pipe-C-eDP-1 [75.960136] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [75.966120] Starting dynamic subtest: pipe-D-eDP-1 [75.986943] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [75.991113] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s) [78.062302] [017/130] (938s left) api_intel_bb (intel-bb-blit-none) [78.111718] Starting subtest: intel-bb-blit-none [82.652263] Subtest intel-bb-blit-none: SUCCESS (4.537s) [82.764806] [018/130] (934s left) kms_cursor_edge_walk (128x128-left-edge) [82.870912] Starting subtest: 128x128-left-edge [82.873401] Starting dynamic subtest: pipe-A-eDP-1 [86.312348] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s) [86.320497] Starting dynamic subtest: pipe-D-eDP-1 [89.437351] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [89.439720] Subtest 128x128-left-edge: SUCCESS (6.560s) [90.228064] [019/130] (926s left) gem_exec_schedule (noreorder-corked) [90.403442] Starting subtest: noreorder-corked [90.405841] Starting dynamic subtest: rcs0 [91.531081] Dynamic subtest rcs0: SUCCESS (1.126s) [91.540688] Starting dynamic subtest: vcs0 [92.936417] Dynamic subtest vcs0: SUCCESS (1.404s) [92.945162] Starting dynamic subtest: vcs1 [94.986435] Dynamic subtest vcs1: SUCCESS (2.048s) [94.996421] Starting dynamic subtest: vecs0 [96.940751] Dynamic subtest vecs0: SUCCESS (1.954s) [96.950411] Starting dynamic subtest: ccs0 [98.113648] Dynamic subtest ccs0: SUCCESS (1.173s) [98.116548] Subtest noreorder-corked: SUCCESS (7.706s) [98.274177] [020/130] (918s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [98.387205] Starting subtest: yf-tiled-64bpp-rotate-90 [98.391288] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [98.472637] [021/130] (918s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [98.575401] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [99.440314] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.867s) [99.564820] [022/130] (917s left) kms_lease (lease-unleased-crtc) [99.656816] Starting subtest: lease-unleased-crtc [99.659241] Starting dynamic subtest: pipe-A-eDP-1 [99.946130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [99.955033] Starting dynamic subtest: pipe-B-eDP-1 [100.703617] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s) [100.711212] Starting dynamic subtest: pipe-C-eDP-1 [100.713395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [100.721436] Starting dynamic subtest: pipe-D-eDP-1 [100.723753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [100.725650] Subtest lease-unleased-crtc: SUCCESS (1.063s) [101.030715] [023/130] (916s left) gem_basic (create-fd-close) [101.083025] Starting subtest: create-fd-close [101.087675] Subtest create-fd-close: SUCCESS (0.000s) [101.167188] [024/130] (915s left) kms_async_flips (crc) [101.270122] Starting subtest: crc [101.628603] Starting dynamic subtest: pipe-A-eDP-1 [104.524948] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.894s) [104.888459] Starting dynamic subtest: pipe-B-eDP-1 [107.744102] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.863s) [108.101557] Starting dynamic subtest: pipe-C-eDP-1 [110.954729] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.859s) [111.317066] Starting dynamic subtest: pipe-D-eDP-1 [114.164253] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s) [114.166663] Subtest crc: SUCCESS (12.889s) [115.342335] [025/130] (901s left) gem_exec_params (cliprects_ptr-dirt) [115.400523] Starting subtest: cliprects_ptr-dirt [115.402854] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [115.476999] [026/130] (901s left) kms_getfb (getfb2-handle-not-fb) [115.529122] Starting subtest: getfb2-handle-not-fb [115.569800] Subtest getfb2-handle-not-fb: SUCCESS (0.043s) [115.661684] [027/130] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [115.756347] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [115.760767] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [115.847639] [028/130] (901s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [115.947142] Starting subtest: plane-all-modeset-transition-fencing [115.951812] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [115.997564] [029/130] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [116.087997] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [116.092022] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [116.144359] [030/130] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [116.247430] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [118.760271] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.517s) [118.875804] [031/130] (898s left) kms_cursor_crc (cursor-offscreen-64x64) [119.027071] Starting subtest: cursor-offscreen-64x64 [119.029159] Starting dynamic subtest: pipe-A-eDP-1 [120.945164] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.916s) [120.966615] Starting dynamic subtest: pipe-D-eDP-1 [123.569648] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.606s) [123.572042] Subtest cursor-offscreen-64x64: SUCCESS (4.541s) [124.410517] [032/130] (892s left) gem_mmap_gtt (basic-read) [124.469209] Subtest basic-read: SKIP (0.000s) [124.522476] [033/130] (892s left) kms_color (ctm-max) [124.617904] Starting subtest: ctm-max [124.620220] Starting dynamic subtest: pipe-A-eDP-1 [125.260560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s) [125.267913] Starting dynamic subtest: pipe-B-eDP-1 [126.569318] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.310s) [126.576460] Starting dynamic subtest: pipe-C-eDP-1 [127.842596] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s) [127.849621] Starting dynamic subtest: pipe-D-eDP-1 [129.176981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s) [129.179376] Subtest ctm-max: SUCCESS (4.558s) [130.006147] [034/130] (887s left) kms_psr (fbc-psr2-primary-mmap-gtt) [130.114055] Starting subtest: fbc-psr2-primary-mmap-gtt [130.116300] Starting dynamic subtest: eDP-1 [130.120284] Dynamic subtest eDP-1: SKIP (0.000s) [130.124310] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [130.166560] [035/130] (887s left) kms_flip (wf_vblank-ts-check-interruptible) [130.272929] Starting subtest: wf_vblank-ts-check-interruptible [130.275330] Starting dynamic subtest: A-eDP1 [139.173437] Dynamic subtest A-eDP1: SUCCESS (8.898s) [139.182889] Starting dynamic subtest: B-eDP1 [148.106454] Dynamic subtest B-eDP1: SUCCESS (8.931s) [148.114231] Starting dynamic subtest: C-eDP1 [157.016187] Dynamic subtest C-eDP1: SUCCESS (8.910s) [157.025337] Starting dynamic subtest: D-eDP1 [165.843182] Dynamic subtest D-eDP1: SUCCESS (8.826s) [165.848722] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.573s) [167.041716] [036/130] (850s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [167.144032] Starting subtest: plane-scaler-with-clipping-clamping-rotation [167.146377] Starting dynamic subtest: pipe-A [167.385230] Dynamic subtest pipe-A: SUCCESS (0.241s) [167.393863] Starting dynamic subtest: pipe-B [168.637151] Dynamic subtest pipe-B: SUCCESS (1.251s) [168.649758] Starting dynamic subtest: pipe-C [169.978382] Dynamic subtest pipe-C: SUCCESS (1.341s) [169.985495] Starting dynamic subtest: pipe-D [171.303549] Dynamic subtest pipe-D: SUCCESS (1.324s) [171.305954] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.160s) [172.443289] [037/130] (844s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [172.551105] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [172.555268] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [172.623308] [038/130] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [172.724742] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [172.729266] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [172.796134] [039/130] (844s left) kms_pm_rpm (fences-dpms) [175.124053] Starting subtest: fences-dpms [175.129479] Subtest fences-dpms: SKIP (0.000s) [175.467323] [040/130] (841s left) gem_ctx_persistence (hostile) [175.527759] Starting subtest: hostile [177.100026] Subtest hostile: FAIL (1.511s) [177.148884] [041/130] (840s left) prime_mmap_coherency (ioctl-errors) [177.215334] Starting subtest: ioctl-errors [188.860392] Subtest ioctl-errors: SUCCESS (11.644s) [189.070840] [042/130] (828s left) perf (oa-exponents) [189.233180] Starting subtest: oa-exponents [189.235491] Starting dynamic subtest: 0-rcs0 [191.032175] Dynamic subtest 0-rcs0: SUCCESS (1.800s) [191.039527] Starting dynamic subtest: 1-vcs0 [192.861345] Dynamic subtest 1-vcs0: SUCCESS (1.828s) [192.863852] Subtest oa-exponents: SUCCESS (3.629s) [192.887716] [043/130] (824s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [192.980975] Starting subtest: primary-yf-tiled-reflect-x-90 [192.985463] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [193.032409] [044/130] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [193.139726] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [193.144153] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [193.207203] [045/130] (824s left) gem_exec_fence (syncobj-timeline-repeat) [193.750067] Starting subtest: syncobj-timeline-repeat [193.972278] Subtest syncobj-timeline-repeat: SUCCESS (0.222s) [194.995828] [046/130] (822s left) kms_big_fb (linear-16bpp-rotate-180) [195.098457] Starting subtest: linear-16bpp-rotate-180 [196.309487] Subtest linear-16bpp-rotate-180: SUCCESS (1.210s) [196.432739] [047/130] (821s left) gem_mmap_gtt (cpuset-medium-copy) [196.490859] Subtest cpuset-medium-copy: SKIP (0.000s) [196.532277] [048/130] (820s left) gem_exec_params (invalid-fence-in) [196.584772] Starting subtest: invalid-fence-in [196.586572] Subtest invalid-fence-in: SUCCESS (0.000s) [196.657372] [049/130] (820s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [196.744664] Starting subtest: bad-aux-stride-y-tiled-ccs [196.746630] Starting dynamic subtest: pipe-A-eDP-1 [196.765524] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [196.773360] Starting dynamic subtest: pipe-B-eDP-1 [196.791539] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [196.798593] Starting dynamic subtest: pipe-C-eDP-1 [196.816481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [196.823580] Starting dynamic subtest: pipe-D-eDP-1 [196.841810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [196.845148] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s) [198.905468] [050/130] (818s left) sysfs_heartbeat_interval (precise) [198.962315] Starting subtest: precise [198.964577] Starting dynamic subtest: vecs0 [206.970229] Dynamic subtest vecs0: SUCCESS (8.003s) [206.978152] Starting dynamic subtest: ccs0 [208.173894] Dynamic subtest ccs0: SUCCESS (1.205s) [208.184812] Starting dynamic subtest: vcs0 [215.931842] Dynamic subtest vcs0: SUCCESS (7.755s) [215.944121] Starting dynamic subtest: bcs0 [217.126221] Dynamic subtest bcs0: SUCCESS (1.193s) [217.136159] Starting dynamic subtest: rcs0 [218.199057] Dynamic subtest rcs0: SUCCESS (1.072s) [218.209676] Starting dynamic subtest: vcs1 [225.993106] Dynamic subtest vcs1: SUCCESS (7.788s) [225.995554] Subtest precise: SUCCESS (27.026s) [226.048611] [051/130] (791s left) gem_exec_balancer (nop) [226.107849] Starting subtest: nop [272.556357] Subtest nop: SUCCESS (46.445s) [272.835118] [052/130] (744s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [272.933103] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [272.935381] Starting dynamic subtest: pipe-A-eDP-1 [273.751428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s) [273.760916] Starting dynamic subtest: pipe-B-eDP-1 [275.249809] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s) [275.258046] Starting dynamic subtest: pipe-C-eDP-1 [276.727128] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s) [276.735940] Starting dynamic subtest: pipe-D-eDP-1 [278.244075] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.515s) [278.246385] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.301s) [279.395907] [053/130] (738s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [284.347528] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [284.352347] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [285.184139] [054/130] (732s left) kms_addfb_basic (small-bo) [285.280026] Starting subtest: small-bo [285.282247] Subtest small-bo: SUCCESS (0.000s) [285.362034] [055/130] (732s left) kms_flip_event_leak (basic) [285.459023] Starting subtest: basic [285.461311] Starting dynamic subtest: pipe-A-eDP-1 [285.879610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s) [285.888263] Starting dynamic subtest: pipe-B-eDP-1 [287.010738] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s) [287.020846] Starting dynamic subtest: pipe-C-eDP-1 [288.114629] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s) [288.123563] Starting dynamic subtest: pipe-D-eDP-1 [289.244552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s) [289.246942] Subtest basic: SUCCESS (3.784s) [290.080452] [056/130] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [290.184267] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [290.188383] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [290.288510] [057/130] (727s left) i915_hangman (engine-engine-hang) [290.363193] Starting subtest: engine-engine-hang [290.365446] Starting dynamic subtest: rcs0 [291.914760] Dynamic subtest rcs0: SUCCESS (1.552s) [291.924712] Starting dynamic subtest: bcs0 [293.899279] Dynamic subtest bcs0: SUCCESS (1.982s) [293.910977] Starting dynamic subtest: vcs0 [295.882811] Dynamic subtest vcs0: SUCCESS (1.982s) [295.895800] Starting dynamic subtest: vcs1 [297.866906] Dynamic subtest vcs1: SUCCESS (1.982s) [297.878695] Starting dynamic subtest: vecs0 [299.915621] Dynamic subtest vecs0: SUCCESS (2.047s) [299.926754] Starting dynamic subtest: ccs0 [301.899571] Dynamic subtest ccs0: SUCCESS (1.981s) [301.902628] Subtest engine-engine-hang: SUCCESS (11.538s) [301.959851] [058/130] (715s left) gem_exec_params (no-bsd) [302.005992] Starting subtest: no-bsd [302.011069] Subtest no-bsd: SUCCESS (0.002s) [303.978432] [059/130] (713s left) drm_fdinfo (memory-info-shared) [304.023450] Starting subtest: memory-info-shared [304.025762] Starting dynamic subtest: smem0 [304.092521] Dynamic subtest smem0: SUCCESS (0.072s) [304.094990] Subtest memory-info-shared: SUCCESS (0.073s) [304.147153] [060/130] (713s left) gem_userptr_blits (sd-probe) [304.208755] Starting subtest: sd-probe [304.210983] Subtest sd-probe: SUCCESS (0.000s) [304.324052] [061/130] (713s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [304.422259] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [304.424583] Starting dynamic subtest: pipe-A-eDP-1 [304.433866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [304.443599] Starting dynamic subtest: pipe-B-eDP-1 [304.452441] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [304.460224] Starting dynamic subtest: pipe-C-eDP-1 [304.468628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [304.475952] Starting dynamic subtest: pipe-D-eDP-1 [304.484477] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [304.488610] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [306.524952] [062/130] (711s left) gem_ringfill (engines-basic) [311.919604] Starting subtest: engines-basic [311.922205] Starting dynamic subtest: rcs0 [311.991819] Dynamic subtest rcs0: SUCCESS (0.072s) [312.002474] Starting dynamic subtest: bcs0 [312.038293] Dynamic subtest bcs0: SUCCESS (0.045s) [312.049257] Starting dynamic subtest: vcs0 [312.081047] Dynamic subtest vcs0: SUCCESS (0.041s) [312.090733] Starting dynamic subtest: vcs1 [312.122293] Dynamic subtest vcs1: SUCCESS (0.040s) [312.132086] Starting dynamic subtest: vecs0 [312.164152] Dynamic subtest vecs0: SUCCESS (0.041s) [312.174035] Starting dynamic subtest: ccs0 [312.209202] Dynamic subtest ccs0: SUCCESS (0.044s) [312.211584] Subtest engines-basic: SUCCESS (0.291s) [312.265137] [063/130] (705s left) kms_chamelium_edid (dp-edid-read) [312.658641] Subtest dp-edid-read: SKIP (0.000s) [313.423164] [064/130] (704s left) kms_prime (basic-crc-vgem) [315.357859] Starting subtest: basic-crc-vgem [315.360226] Starting dynamic subtest: second-to-first [316.207585] Dynamic subtest second-to-first: SUCCESS (0.855s) [316.209846] Subtest basic-crc-vgem: SUCCESS (0.855s) [316.271503] [065/130] (701s left) kms_lease (lease-get) [316.385150] Starting subtest: lease-get [316.387232] Starting dynamic subtest: pipe-A-eDP-1 [316.389230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [316.398585] Starting dynamic subtest: pipe-B-eDP-1 [316.400479] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [316.407802] Starting dynamic subtest: pipe-C-eDP-1 [316.409804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [316.416941] Starting dynamic subtest: pipe-D-eDP-1 [316.418839] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [316.420718] Subtest lease-get: SUCCESS (0.008s) [316.492155] [066/130] (701s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [321.400891] Starting subtest: psr2-overlay-plane-move-continuous-sf [321.403209] Starting dynamic subtest: pipe-A-eDP-1 [328.102759] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.701s) [328.116333] Starting dynamic subtest: pipe-B-eDP-1 [334.833657] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.727s) [334.835995] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.433s) [335.678931] [067/130] (682s left) kms_vblank (wait-idle) [335.786133] Starting subtest: wait-idle [335.788491] Starting dynamic subtest: pipe-A-eDP-1 [337.541063] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s) [337.554539] Starting dynamic subtest: pipe-D-eDP-1 [339.930607] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.387s) [339.933076] Subtest wait-idle: SUCCESS (4.143s) [340.726387] [068/130] (677s left) perf (low-oa-exponent-permissions) [340.822671] Starting subtest: low-oa-exponent-permissions [340.856170] Subtest low-oa-exponent-permissions: SUCCESS (0.034s) [340.879395] [069/130] (677s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [340.991769] Starting subtest: nonblocking-modeset-vs-cursor-atomic [342.412082] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.417s) [343.180978] [070/130] (674s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [343.294601] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [343.299109] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [343.397168] [071/130] (674s left) kms_content_protection (legacy) [343.542742] Starting subtest: legacy [347.407902] Subtest legacy: SKIP (3.861s) [348.580831] [072/130] (669s left) api_intel_bb (intel-bb-blit-y) [348.637532] Starting subtest: intel-bb-blit-y [352.383893] Subtest intel-bb-blit-y: SUCCESS (3.747s) [352.515375] [073/130] (665s left) gem_flink_basic (double-flink) [352.572919] Starting subtest: double-flink [352.574894] Subtest double-flink: SUCCESS (0.000s) [352.652619] [074/130] (665s left) gem_ctx_exec (basic-norecovery) [352.713305] Starting subtest: basic-norecovery [353.042725] Subtest basic-norecovery: SUCCESS (0.328s) [353.148937] [075/130] (664s left) gem_ctx_param (invalid-param-get) [353.210021] Starting subtest: invalid-param-get [353.212458] Subtest invalid-param-get: SUCCESS (0.001s) [353.307188] [076/130] (664s left) kms_display_modes (mst-extended-mode-negative) [353.420993] Starting subtest: mst-extended-mode-negative [353.424729] Subtest mst-extended-mode-negative: SKIP (0.000s) [353.446326] [077/130] (664s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [353.557953] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [357.695900] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.139s) [357.810353] [078/130] (660s left) kms_cursor_legacy (cursor-vs-flip-atomic) [357.931067] Starting subtest: cursor-vs-flip-atomic [387.359691] Subtest cursor-vs-flip-atomic: SUCCESS (29.427s) [388.153233] [079/130] (629s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [388.257266] Starting subtest: fbc-farfromfence-mmap-gtt [388.261598] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [388.341052] [080/130] (629s left) kms_psr (fbc-psr-cursor-mmap-gtt) [388.438800] Starting subtest: fbc-psr-cursor-mmap-gtt [388.441238] Starting dynamic subtest: eDP-1 [388.445603] Dynamic subtest eDP-1: SKIP (0.000s) [388.449642] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [388.492480] [081/130] (629s left) gem_ctx_isolation (nonpriv) [388.553862] Starting subtest: nonpriv [388.556383] Starting dynamic subtest: rcs0 [388.787577] Dynamic subtest rcs0: SUCCESS (0.233s) [388.797030] Starting dynamic subtest: bcs0 [389.041732] Dynamic subtest bcs0: SUCCESS (0.253s) [389.050104] Starting dynamic subtest: vcs0 [389.298027] Dynamic subtest vcs0: SUCCESS (0.256s) [389.308041] Starting dynamic subtest: vcs1 [391.189833] Dynamic subtest vcs1: SUCCESS (1.891s) [391.200606] Starting dynamic subtest: vecs0 [393.187134] Dynamic subtest vecs0: SUCCESS (1.996s) [393.197286] Starting dynamic subtest: ccs0 [395.203396] Dynamic subtest ccs0: SUCCESS (2.015s) [395.205783] Subtest nonpriv: SUCCESS (6.649s) [395.422977] [082/130] (622s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [395.525155] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [395.527433] Starting dynamic subtest: pipe-A-default-mode [395.815577] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [395.820338] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.286s) [396.579636] [083/130] (621s left) perf (mi-rpc) [396.671560] Starting subtest: mi-rpc [396.676024] Subtest mi-rpc: SKIP (0.000s) [396.694333] [084/130] (621s left) kms_chamelium_frames (hdmi-crc-multiple) [397.088752] Subtest hdmi-crc-multiple: SKIP (0.000s) [397.882017] [085/130] (620s left) gem_mmap_wc (bad-size) [397.940854] Subtest bad-size: SKIP (0.000s) [397.976691] [086/130] (620s left) kms_big_fb (x-tiled-addfb-size-overflow) [398.086574] Starting subtest: x-tiled-addfb-size-overflow [398.088628] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s) [398.165242] [087/130] (620s left) kms_flip (basic-flip-vs-modeset) [398.271161] Starting subtest: basic-flip-vs-modeset [398.273527] Starting dynamic subtest: A-eDP1 [400.810334] Dynamic subtest A-eDP1: SUCCESS (2.536s) [400.820086] Starting dynamic subtest: B-eDP1 [402.957049] Dynamic subtest B-eDP1: SUCCESS (2.146s) [402.965647] Starting dynamic subtest: C-eDP1 [405.104146] Dynamic subtest C-eDP1: SUCCESS (2.147s) [405.112667] Starting dynamic subtest: D-eDP1 [407.242598] Dynamic subtest D-eDP1: SUCCESS (2.140s) [407.244925] Subtest basic-flip-vs-modeset: SUCCESS (8.975s) [408.023651] [088/130] (610s left) gem_softpin (evict-active-interruptible) [408.082861] Starting subtest: evict-active-interruptible [408.090081] Subtest evict-active-interruptible: SUCCESS (0.007s) [408.169402] [089/130] (610s left) perf_pmu (busy-accuracy-98) [408.208831] Starting subtest: busy-accuracy-98 [408.210750] Starting dynamic subtest: rcs0 [411.251042] Dynamic subtest rcs0: SUCCESS (3.040s) [411.262128] Starting dynamic subtest: bcs0 [414.308868] Dynamic subtest bcs0: SUCCESS (3.057s) [414.319742] Starting dynamic subtest: vcs0 [417.349439] Dynamic subtest vcs0: SUCCESS (3.039s) [417.359923] Starting dynamic subtest: vcs1 [420.393952] Dynamic subtest vcs1: SUCCESS (3.044s) [420.404266] Starting dynamic subtest: vecs0 [423.437870] Dynamic subtest vecs0: SUCCESS (3.042s) [423.447079] Starting dynamic subtest: ccs0 [426.503766] Dynamic subtest ccs0: SUCCESS (3.063s) [426.506239] Subtest busy-accuracy-98: SUCCESS (18.293s) [426.601137] [090/130] (591s left) perf_pmu (interrupts) [426.640481] Starting subtest: interrupts [427.727900] Subtest interrupts: SUCCESS (1.088s) [427.831576] [091/130] (590s left) gem_exec_alignment (pi) [427.893440] Starting subtest: pi [478.676207] Subtest pi: SUCCESS (50.775s) [479.512504] [092/130] (538s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [479.599750] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [479.602307] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [479.706253] [093/130] (538s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [480.823653] Starting subtest: verify-pxp-stale-buf-optout-execution [480.884988] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (0.062s) [481.041073] [094/130] (537s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [481.144969] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [485.559303] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.416s) [485.686564] [095/130] (532s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [485.786152] Starting subtest: flip-primary-invalidate-overlay [497.241770] Subtest flip-primary-invalidate-overlay: SUCCESS (11.458s) [497.359713] [096/130] (521s left) gen9_exec_parse (basic-rejected) [497.427963] Subtest basic-rejected: SKIP (0.000s) [497.500836] [097/130] (520s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [497.608203] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [497.611833] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [497.689432] [098/130] (520s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc) [497.783170] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc [502.201959] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.420s) [502.306825] [099/130] (516s left) gem_reg_read (bad-register) [502.365962] Starting subtest: bad-register [502.368265] Subtest bad-register: SUCCESS (0.000s) [502.452589] [100/130] (516s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [502.566550] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [502.570737] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [502.640196] [101/130] (515s left) gem_mmap_gtt (hang) [502.696081] Subtest hang: SKIP (0.000s) [502.733307] [102/130] (515s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [502.837820] Starting subtest: missing-ccs-buffer-y-tiled-ccs [502.840193] Starting dynamic subtest: pipe-A-eDP-1 [502.862907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [502.872928] Starting dynamic subtest: pipe-B-eDP-1 [502.894301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [502.902145] Starting dynamic subtest: pipe-C-eDP-1 [502.923745] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [502.931503] Starting dynamic subtest: pipe-D-eDP-1 [502.953442] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [502.957814] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s) [504.972829] [103/130] (513s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [505.029584] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [505.087586] [104/130] (513s left) kms_big_fb (4-tiled-16bpp-rotate-0) [505.198113] Starting subtest: 4-tiled-16bpp-rotate-0 [506.352973] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.155s) [506.455885] [105/130] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [506.549223] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [506.555420] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [506.649775] [106/130] (511s left) gem_pxp (protected-encrypted-src-copy-not-readible) [506.712470] Starting subtest: protected-encrypted-src-copy-not-readible [506.823880] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.110s) [507.975509] [107/130] (510s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [508.029915] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [508.137385] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [508.191916] [108/130] (510s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [508.290808] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [510.982922] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.697s) [511.083786] [109/130] (507s left) kms_flip (2x-busy-flip) [511.183133] Starting subtest: 2x-busy-flip [511.193903] Subtest 2x-busy-flip: SKIP (0.010s) [511.252347] [110/130] (507s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [511.350791] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [511.354238] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [511.435716] [111/130] (507s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [511.530933] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [511.534298] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [511.628144] [112/130] (507s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [511.722394] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [511.726059] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [511.785188] [113/130] (506s left) gem_exec_schedule (implicit-write-read) [511.850588] Starting subtest: implicit-write-read [511.852335] Starting dynamic subtest: rcs0 [511.954118] Dynamic subtest rcs0: SUCCESS (0.108s) [511.966550] Starting dynamic subtest: vcs0 [512.024546] Dynamic subtest vcs0: SUCCESS (0.071s) [512.035843] Starting dynamic subtest: vcs1 [512.100347] Dynamic subtest vcs1: SUCCESS (0.075s) [512.111591] Starting dynamic subtest: vecs0 [512.177383] Dynamic subtest vecs0: SUCCESS (0.077s) [512.187224] Starting dynamic subtest: ccs0 [512.265425] Dynamic subtest ccs0: SUCCESS (0.087s) [512.267565] Subtest implicit-write-read: SUCCESS (0.421s) [513.003894] [114/130] (505s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [513.052314] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [513.161053] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.109s) [513.214326] [115/130] (505s left) i915_suspend (debugfs-reader) [513.275594] Starting subtest: debugfs-reader [530.862211] Subtest debugfs-reader: SUCCESS (3.180s) [531.049476] [116/130] (502s left) gem_mmap_gtt (big-bo-tiledy) [531.108417] Subtest big-bo-tiledY: SKIP (0.000s) [531.138801] [117/130] (502s left) syncobj_basic (create-signaled) [531.207627] Starting subtest: create-signaled [531.210471] Subtest create-signaled: SUCCESS (0.000s) [531.291058] [118/130] (502s left) gem_partial_pwrite_pread (write-snoop) [531.346051] Subtest write-snoop: SKIP (0.000s) [531.422211] [119/130] (502s left) kms_psr (psr2-dpms) [531.525467] Starting subtest: psr2-dpms [531.527746] Starting dynamic subtest: eDP-1 [534.421849] Dynamic subtest eDP-1: SUCCESS (2.816s) [534.424291] Subtest psr2-dpms: SUCCESS (2.817s) [535.290222] [120/130] (498s left) kms_scaling_modes (scaling-mode-none) [535.389779] Starting subtest: scaling-mode-none [535.392120] Starting dynamic subtest: pipe-A-eDP-1 [535.484487] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s) [535.496778] Starting dynamic subtest: pipe-B-eDP-1 [535.517218] Dynamic subtest pipe-B-eDP-1: SKIP (0.030s) [535.527034] Starting dynamic subtest: pipe-C-eDP-1 [535.547642] Dynamic subtest pipe-C-eDP-1: SKIP (0.029s) [535.561632] Starting dynamic subtest: pipe-D-eDP-1 [535.582845] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s) [535.587364] Subtest scaling-mode-none: SKIP (0.187s) [535.695728] [121/130] (497s left) fbdev (unaligned-read) [535.743380] Starting subtest: unaligned-read [535.758818] Subtest unaligned-read: SUCCESS (0.015s) [535.797229] [122/130] (497s left) gem_mmap_gtt (basic-short) [535.854609] Subtest basic-short: SKIP (0.000s) [535.890869] [123/130] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [535.996517] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [536.001053] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [536.083917] [124/130] (497s left) gem_render_copy (y-tiled) [536.141651] Starting subtest: y-tiled [536.146126] Subtest y-tiled: SKIP (0.000s) [536.306433] [125/130] (497s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [536.432056] Starting subtest: basic-flip-after-cursor-legacy [537.359912] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s) [538.163172] [126/130] (495s left) kms_big_fb (y-tiled-64bpp-rotate-90) [538.260855] Starting subtest: y-tiled-64bpp-rotate-90 [538.264872] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [538.347309] [127/130] (495s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [538.414711] Starting subtest: multi-wait-for-submit-available-submitted-signaled [538.417244] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [538.487274] [128/130] (495s left) kms_cursor_crc (cursor-sliding-128x42) [538.695949] Starting subtest: cursor-sliding-128x42 [538.737724] Subtest cursor-sliding-128x42: SKIP (0.035s) [538.929289] [129/130] (494s left) kms_vrr (flip-suspend) [539.023730] Starting subtest: flip-suspend [539.030529] Subtest flip-suspend: SKIP (0.000s) [539.078231] [130/130] (494s left) prime_vgem (fence-wait) [539.173215] Starting subtest: fence-wait [539.175244] Starting dynamic subtest: rcs0 [540.224309] Dynamic subtest rcs0: SUCCESS (1.037s) [540.235699] Starting dynamic subtest: bcs0 [541.318860] Dynamic subtest bcs0: SUCCESS (1.082s) [541.328193] Starting dynamic subtest: vcs0 [542.368333] Dynamic subtest vcs0: SUCCESS (1.039s) [542.380224] Starting dynamic subtest: vcs1 [543.409882] Dynamic subtest vcs1: SUCCESS (1.032s) [543.420014] Starting dynamic subtest: vecs0 [544.453421] Dynamic subtest vecs0: SUCCESS (1.034s) [544.463036] Starting dynamic subtest: ccs0 [545.500740] Dynamic subtest ccs0: SUCCESS (1.039s) [545.503726] Subtest fence-wait: SUCCESS (6.272s) [545.625079] Closing watchdogs Done.