[55.406378] Initializing watchdogs [55.406436] /dev/watchdog0 [55.421711] [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] [55.426461] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.428911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.432768] [001/156] (960s left) i915_selftest (live) [58.779138] Starting subtest: live [58.783337] Starting dynamic subtest: sanitycheck [63.209645] Dynamic subtest sanitycheck: SUCCESS (4.396s) [63.218533] Starting dynamic subtest: uncore [67.571750] Dynamic subtest uncore: SUCCESS (4.340s) [67.580648] Starting dynamic subtest: workarounds [70.653960] Dynamic subtest workarounds: SUCCESS (3.073s) [70.663257] Starting dynamic subtest: gt_engines [74.155500] Dynamic subtest gt_engines: SUCCESS (3.494s) [74.166772] Starting dynamic subtest: gt_timelines [91.915077] Dynamic subtest gt_timelines: SUCCESS (17.748s) [91.929898] Starting dynamic subtest: gt_contexts [96.256662] Dynamic subtest gt_contexts: SUCCESS (4.339s) [96.266194] Starting dynamic subtest: gt_lrc [100.621833] Dynamic subtest gt_lrc: SUCCESS (4.363s) [100.630680] Starting dynamic subtest: gt_mocs [103.628240] Dynamic subtest gt_mocs: SUCCESS (3.005s) [103.636509] Starting dynamic subtest: gt_pm [110.434315] Dynamic subtest gt_pm: SUCCESS (6.803s) [110.445655] Starting dynamic subtest: gt_heartbeat [114.798363] Dynamic subtest gt_heartbeat: SUCCESS (4.363s) [114.807163] Starting dynamic subtest: gt_tlb [124.100996] Dynamic subtest gt_tlb: SUCCESS (9.301s) [124.109518] Starting dynamic subtest: requests [135.763356] Dynamic subtest requests: SUCCESS (11.660s) [135.772019] Starting dynamic subtest: migrate [143.513747] Dynamic subtest migrate: SUCCESS (7.750s) [143.521745] Starting dynamic subtest: active [147.928743] Dynamic subtest active: SUCCESS (4.413s) [147.938022] Starting dynamic subtest: objects [152.588999] Dynamic subtest objects: SUCCESS (4.660s) [152.598320] Starting dynamic subtest: mman [157.399377] Dynamic subtest mman: SUCCESS (4.810s) [157.407501] Starting dynamic subtest: dmabuf [160.195324] Dynamic subtest dmabuf: SUCCESS (2.795s) [160.203534] Starting dynamic subtest: vma [164.548045] Dynamic subtest vma: SUCCESS (4.352s) [164.557842] Starting dynamic subtest: coherency [169.529560] Dynamic subtest coherency: SUCCESS (4.982s) [169.543356] Starting dynamic subtest: gtt [179.498990] Dynamic subtest gtt: SUCCESS (9.969s) [179.508671] Starting dynamic subtest: gem [187.014245] Dynamic subtest gem: SUCCESS (7.515s) [187.023127] Starting dynamic subtest: evict [192.435183] Dynamic subtest evict: SUCCESS (5.419s) [192.443942] Starting dynamic subtest: hugepages [201.312696] Dynamic subtest hugepages: SUCCESS (8.877s) [201.321966] Starting dynamic subtest: gem_contexts [227.920780] Dynamic subtest gem_contexts: SUCCESS (26.608s) [227.930320] Starting dynamic subtest: client [232.290752] Dynamic subtest client: SUCCESS (4.369s) [232.299704] Starting dynamic subtest: gem_migrate [236.713355] Dynamic subtest gem_migrate: SUCCESS (4.420s) [236.723374] Starting dynamic subtest: reset [239.552355] Dynamic subtest reset: SUCCESS (2.837s) [239.561590] Starting dynamic subtest: memory_region [243.903169] Dynamic subtest memory_region: SUCCESS (4.350s) [243.912496] Starting dynamic subtest: hangcheck [256.870415] Dynamic subtest hangcheck: SUCCESS (12.965s) [256.879162] Starting dynamic subtest: execlists [261.254076] Dynamic subtest execlists: SUCCESS (4.382s) [261.266577] Starting dynamic subtest: ring_submission [263.974310] Dynamic subtest ring_submission: SUCCESS (2.719s) [263.982750] Starting dynamic subtest: perf [268.343616] Dynamic subtest perf: SUCCESS (4.367s) [268.353021] Starting dynamic subtest: slpc [282.483551] Dynamic subtest slpc: SUCCESS (14.138s) [282.493139] Starting dynamic subtest: guc [286.423339] Dynamic subtest guc: SUCCESS (3.938s) [286.440031] Starting dynamic subtest: guc_multi_lrc [290.754923] Dynamic subtest guc_multi_lrc: SUCCESS (4.329s) [290.764093] Starting dynamic subtest: guc_hang [294.159515] Dynamic subtest guc_hang: SUCCESS (3.403s) [294.170502] Starting dynamic subtest: late_gt_pm [298.467979] Dynamic subtest late_gt_pm: SUCCESS (4.307s) [298.470971] Subtest live: SUCCESS (239.603s) [298.496862] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [298.500558] [002/156] (717s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [300.111944] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [300.116529] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [300.225489] [FACT kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true [300.230130] [003/156] (715s left) kms_content_protection (dp-mst-type-0) [300.390116] Starting subtest: dp-mst-type-0 [300.394661] Subtest dp-mst-type-0: SKIP (0.000s) [300.534988] [004/156] (715s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [300.597309] Starting subtest: invalid-multi-wait-unsubmitted [300.599229] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [300.690407] [005/156] (715s left) gem_mmap_gtt (basic-read-write-distinct) [300.738949] Subtest basic-read-write-distinct: SKIP (0.000s) [300.792288] [006/156] (715s left) kms_prime (basic-modeset-hybrid) [300.874122] Subtest basic-modeset-hybrid: SKIP (0.000s) [300.994572] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [300.998107] [007/156] (715s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt) [301.097267] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt [301.100800] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [301.184709] [008/156] (715s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [301.578663] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [302.464506] [009/156] (713s left) tools_test (tools_test) [302.514972] Starting subtest: tools_test [302.571855] Subtest tools_test: SUCCESS (0.072s) [302.630692] [010/156] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [302.738133] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [302.742162] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [302.841438] [011/156] (713s left) kms_dsc (dsc-fractional-bpp) [302.927092] Starting subtest: dsc-fractional-bpp [302.940165] Subtest dsc-fractional-bpp: SKIP (0.000s) [302.997792] [012/156] (713s left) gem_exec_fence (parallel) [303.178804] Starting subtest: parallel [303.181581] Starting dynamic subtest: rcs0 [305.326199] Dynamic subtest rcs0: SUCCESS (2.149s) [305.336099] Starting dynamic subtest: bcs0 [307.478559] Dynamic subtest bcs0: SUCCESS (2.152s) [307.487311] Starting dynamic subtest: vcs0 [309.627284] Dynamic subtest vcs0: SUCCESS (2.148s) [309.637060] Starting dynamic subtest: vcs1 [311.783322] Dynamic subtest vcs1: SUCCESS (2.154s) [311.795688] Starting dynamic subtest: vecs0 [313.933795] Dynamic subtest vecs0: SUCCESS (2.150s) [313.946289] Starting dynamic subtest: ccs0 [316.091341] Dynamic subtest ccs0: SUCCESS (2.157s) [316.093598] Subtest parallel: SUCCESS (12.914s) [318.357134] [013/156] (698s left) gem_wait (write-wait) [318.426226] Starting subtest: write-wait [318.428534] Starting dynamic subtest: all-engines [319.542076] Dynamic subtest all-engines: SUCCESS (1.115s) [319.558888] Starting dynamic subtest: rcs0 [320.599568] Dynamic subtest rcs0: SUCCESS (1.055s) [320.616281] Starting dynamic subtest: bcs0 [321.658395] Dynamic subtest bcs0: SUCCESS (1.057s) [321.673447] Starting dynamic subtest: vcs0 [322.715424] Dynamic subtest vcs0: SUCCESS (1.055s) [322.732055] Starting dynamic subtest: vcs1 [323.772032] Dynamic subtest vcs1: SUCCESS (1.053s) [323.787409] Starting dynamic subtest: vecs0 [324.824679] Dynamic subtest vecs0: SUCCESS (1.050s) [324.840361] Starting dynamic subtest: ccs0 [325.882295] Dynamic subtest ccs0: SUCCESS (1.055s) [325.885654] Subtest write-wait: SUCCESS (7.457s) [326.081484] [014/156] (690s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [326.146778] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [326.252084] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [326.331076] [015/156] (690s left) gem_mmap_gtt (basic-read-write) [326.384359] Subtest basic-read-write: SKIP (0.000s) [326.439263] [016/156] (690s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [326.529498] Starting subtest: plane-lut1d-ctm3x4-lut1d [326.710879] Starting dynamic subtest: pipe-A-plane-0 [326.878911] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s) [326.887633] Starting dynamic subtest: pipe-A-plane-1 [327.043082] Dynamic subtest pipe-A-plane-1: SUCCESS (0.165s) [327.051899] Starting dynamic subtest: pipe-A-plane-2 [327.209505] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [328.493392] Starting dynamic subtest: pipe-B-plane-0 [328.675285] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s) [328.685070] Starting dynamic subtest: pipe-B-plane-1 [328.863807] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [328.872916] Starting dynamic subtest: pipe-B-plane-2 [329.052892] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s) [330.307997] Starting dynamic subtest: pipe-C-plane-0 [330.475423] Dynamic subtest pipe-C-plane-0: SUCCESS (0.177s) [330.484735] Starting dynamic subtest: pipe-C-plane-1 [330.643181] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [330.654575] Starting dynamic subtest: pipe-C-plane-2 [330.808760] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [332.030470] Starting dynamic subtest: pipe-D-plane-0 [332.190476] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [332.201315] Starting dynamic subtest: pipe-D-plane-1 [332.356945] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s) [332.365719] Starting dynamic subtest: pipe-D-plane-2 [332.512382] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [332.801447] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.273s) [333.690078] [017/156] (682s left) gem_exec_schedule (preemptive-hang) [333.885998] Starting subtest: preemptive-hang [333.887940] Starting dynamic subtest: rcs0 [343.408256] Dynamic subtest rcs0: SUCCESS (9.524s) [343.417765] Starting dynamic subtest: bcs0 [352.495532] Dynamic subtest bcs0: SUCCESS (9.085s) [352.504335] Starting dynamic subtest: vcs0 [361.452719] Dynamic subtest vcs0: SUCCESS (8.954s) [361.468506] Starting dynamic subtest: vcs1 [370.408228] Dynamic subtest vcs1: SUCCESS (8.957s) [370.417063] Starting dynamic subtest: vecs0 [379.427855] Dynamic subtest vecs0: SUCCESS (9.019s) [379.438750] Starting dynamic subtest: ccs0 [388.396792] Dynamic subtest ccs0: SUCCESS (8.962s) [388.399999] Subtest preemptive-hang: SUCCESS (54.508s) [388.627876] [018/156] (628s left) vgem_basic (bad-flag) [388.676114] Starting subtest: bad-flag [388.677986] Subtest bad-flag: SUCCESS (0.000s) [388.731660] [019/156] (627s left) kms_cursor_crc (cursor-onscreen-512x170) [389.023799] Starting subtest: cursor-onscreen-512x170 [389.028388] Subtest cursor-onscreen-512x170: SKIP (0.001s) [389.148770] [020/156] (627s left) kms_frontbuffer_tracking (hdr-1p-rte) [389.257971] Starting subtest: hdr-1p-rte [389.261992] Subtest hdr-1p-rte: SKIP (0.000s) [389.351034] [021/156] (627s left) kms_psr (psr-sprite-plane-move) [389.446442] Starting subtest: psr-sprite-plane-move [389.448449] Starting dynamic subtest: eDP-1 [391.189550] Dynamic subtest eDP-1: SUCCESS (1.742s) [391.191882] Subtest psr-sprite-plane-move: SUCCESS (1.743s) [392.039337] [022/156] (624s left) kms_plane_multiple (tiling-x) [392.130564] Starting subtest: tiling-x [392.132601] Starting dynamic subtest: pipe-A-eDP-1 [395.901734] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.770s) [395.911387] Starting dynamic subtest: pipe-B-eDP-1 [400.538354] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.636s) [400.547379] Starting dynamic subtest: pipe-C-eDP-1 [405.081175] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.541s) [405.090413] Starting dynamic subtest: pipe-D-eDP-1 [409.537721] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.457s) [409.539792] Subtest tiling-x: SUCCESS (17.408s) [410.352850] [023/156] (606s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [410.405954] Starting subtest: multi-wait-all-for-submit-submitted-signaled [410.508048] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s) [410.585299] [024/156] (606s left) gem_ccs (block-multicopy-inplace) [410.644951] Starting subtest: block-multicopy-inplace [410.649594] Subtest block-multicopy-inplace: SKIP (0.000s) [410.759064] [025/156] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [410.869521] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [410.873595] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [410.962265] [026/156] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [411.053672] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [411.057829] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [411.137277] [027/156] (605s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [411.230794] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [411.235196] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [411.324446] [028/156] (605s left) kms_vblank (query-busy-hang) [411.420392] Starting subtest: query-busy-hang [411.422319] Starting dynamic subtest: pipe-A-eDP-1 [438.078381] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.656s) [438.095160] Starting dynamic subtest: pipe-D-eDP-1 [463.037796] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.957s) [463.040285] Subtest query-busy-hang: SUCCESS (51.618s) [463.907986] [029/156] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [464.014684] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [464.018707] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [464.097423] [030/156] (553s left) kms_psr (psr2-cursor-blt) [464.200211] Starting subtest: psr2-cursor-blt [464.202529] Starting dynamic subtest: eDP-1 [465.886511] Dynamic subtest eDP-1: SUCCESS (1.686s) [465.888911] Subtest psr2-cursor-blt: SUCCESS (1.687s) [466.777017] [031/156] (550s left) syncobj_wait (single-wait-for-submit-signaled) [466.833567] Starting subtest: single-wait-for-submit-signaled [466.835780] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [466.931404] [032/156] (550s left) api_intel_bb (bb-with-allocator) [466.985679] Starting subtest: bb-with-allocator [466.991793] Subtest bb-with-allocator: SUCCESS (0.006s) [467.118713] [033/156] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [467.215870] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [467.220254] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [467.299915] [034/156] (549s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [467.395611] Starting subtest: fbc-psr2-cursor-mmap-cpu [467.397913] Starting dynamic subtest: eDP-1 [467.402058] Dynamic subtest eDP-1: SKIP (0.000s) [467.406186] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [467.475433] [035/156] (549s left) gem_exec_schedule (u-semaphore-user) [467.550510] Starting subtest: u-semaphore-user [467.607265] Subtest u-semaphore-user: SUCCESS (0.063s) [469.350736] [036/156] (548s left) gem_ctx_param (invalid-ctx-get) [469.414080] Starting subtest: invalid-ctx-get [469.416555] Subtest invalid-ctx-get: SUCCESS (0.000s) [469.499938] [037/156] (547s left) gem_userptr_blits (usage-restrictions) [469.569778] Starting subtest: usage-restrictions [469.572037] Subtest usage-restrictions: SUCCESS (0.000s) [469.693959] [038/156] (547s left) syncobj_wait (single-wait-submitted) [469.753044] Starting subtest: single-wait-submitted [469.860230] Subtest single-wait-submitted: SUCCESS (0.106s) [469.952285] [039/156] (547s left) kms_cursor_legacy (forked-bo) [470.079898] Starting subtest: forked-bo [470.082338] Starting dynamic subtest: pipe-A [475.592427] Dynamic subtest pipe-A: SUCCESS (5.455s) [475.602274] Starting dynamic subtest: pipe-B [481.058610] Dynamic subtest pipe-B: SUCCESS (5.465s) [481.069753] Starting dynamic subtest: pipe-C [486.533900] Dynamic subtest pipe-C: SUCCESS (5.472s) [486.545184] Starting dynamic subtest: pipe-D [492.013036] Dynamic subtest pipe-D: SUCCESS (5.476s) [492.029645] Starting dynamic subtest: all-pipes [497.510786] Dynamic subtest all-pipes: SUCCESS (5.497s) [497.513291] Subtest forked-bo: SUCCESS (27.378s) [497.613015] [040/156] (519s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [497.722210] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [497.724491] Starting dynamic subtest: pipe-A [497.745226] Dynamic subtest pipe-A: SKIP (0.019s) [497.754501] Starting dynamic subtest: pipe-B [497.780515] Dynamic subtest pipe-B: SKIP (0.033s) [497.789863] Starting dynamic subtest: pipe-C [497.812187] Dynamic subtest pipe-C: SKIP (0.033s) [497.821197] Starting dynamic subtest: pipe-D [497.846719] Dynamic subtest pipe-D: SKIP (0.033s) [497.850932] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.121s) [497.960301] [041/156] (519s left) kms_big_fb (x-tiled-32bpp-rotate-0) [498.060417] Starting subtest: x-tiled-32bpp-rotate-0 [499.550664] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.491s) [499.685351] [042/156] (517s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [499.782893] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [499.786351] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [499.876018] [043/156] (517s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary) [499.972833] Starting subtest: fbcpsrhdr-shrfb-scaledprimary [499.976291] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s) [500.071080] [044/156] (517s left) gem_mmap_offset (clear) [500.126029] Starting subtest: clear [500.128745] Starting dynamic subtest: smem0 [525.688580] Dynamic subtest smem0: SUCCESS (25.557s) [525.690857] Subtest clear: SUCCESS (25.560s) [525.850373] [045/156] (491s left) kms_atomic (plane-invalid-params) [526.005760] Starting subtest: plane-invalid-params [526.008169] Starting dynamic subtest: pipe-A-eDP-1 [526.446590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s) [526.448859] Subtest plane-invalid-params: SUCCESS (0.442s) [527.322533] [046/156] (490s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [527.420257] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [527.424343] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [527.505524] [047/156] (490s left) gem_ctx_persistence (saturated-hostile) [527.560790] Starting subtest: saturated-hostile [527.563098] Starting dynamic subtest: rcs0 [528.372855] Dynamic subtest rcs0: SUCCESS (0.811s) [528.385630] Starting dynamic subtest: bcs0 [529.160075] Dynamic subtest bcs0: SUCCESS (0.785s) [529.172837] Starting dynamic subtest: vcs0 [529.951845] Dynamic subtest vcs0: SUCCESS (0.785s) [529.961327] Starting dynamic subtest: vcs1 [530.764364] Dynamic subtest vcs1: SUCCESS (0.813s) [530.775490] Starting dynamic subtest: vecs0 [531.536593] Dynamic subtest vecs0: SUCCESS (0.770s) [531.549807] Starting dynamic subtest: ccs0 [532.368939] Dynamic subtest ccs0: SUCCESS (0.831s) [532.371654] Subtest saturated-hostile: SUCCESS (4.809s) [532.465567] [048/156] (485s left) gem_exec_params (larger-than-life-batch) [532.522045] Starting subtest: larger-than-life-batch [534.625054] Subtest larger-than-life-batch: SUCCESS (2.102s) [535.345431] [049/156] (482s left) gem_exec_await (wide-contexts) [535.622524] Starting subtest: wide-contexts [558.965664] Subtest wide-contexts: SUCCESS (23.322s) [559.152771] [050/156] (458s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [559.258615] Starting subtest: yf-tiled-to-vebox-yf-tiled [559.263030] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [559.443356] [051/156] (458s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move) [559.556152] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move [559.560344] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [559.665637] [052/156] (458s left) gem_exec_params (invalid-bsd-ring) [559.720936] Starting subtest: invalid-bsd-ring [559.722848] Subtest invalid-bsd-ring: SUCCESS (0.000s) [559.838545] [053/156] (458s left) syncobj_wait (single-wait-for-submit-unsubmitted) [559.897983] Starting subtest: single-wait-for-submit-unsubmitted [560.004049] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s) [560.093982] [054/156] (458s left) gem_create (create-valid-nonaligned) [560.141783] Starting subtest: create-valid-nonaligned [560.143742] Subtest create-valid-nonaligned: SUCCESS (0.000s) [560.337529] [055/156] (457s left) kms_flip (2x-flip-vs-fences-interruptible) [560.439317] Starting subtest: 2x-flip-vs-fences-interruptible [560.443344] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [560.552322] [056/156] (457s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [560.649661] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [560.653740] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [560.746357] [057/156] (457s left) syncobj_wait (invalid-reset-illegal-handle) [560.805234] Starting subtest: invalid-reset-illegal-handle [560.807576] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [560.927861] [058/156] (457s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt) [561.019839] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt [561.024132] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [561.117985] [059/156] (457s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc) [561.223172] Starting subtest: hdr-rgb101010-draw-mmap-wc [561.227261] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [561.341739] [060/156] (457s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary) [561.445456] Starting subtest: fbcpsrhdr-indfb-scaledprimary [561.449026] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s) [561.573145] [061/156] (456s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [561.667464] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [561.669243] Starting dynamic subtest: pipe-A-default-mode [564.371744] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s) [564.373975] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.706s) [565.219393] [062/156] (453s left) gem_exec_balancer (sliced) [565.302629] Starting subtest: sliced [565.307248] Subtest sliced: SKIP (0.000s) [565.626487] [063/156] (452s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [565.722472] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [565.726879] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [565.819141] [064/156] (452s left) i915_hangman (engine-engine-error) [565.890272] Starting subtest: engine-engine-error [565.892571] Starting dynamic subtest: rcs0 [567.264304] Dynamic subtest rcs0: SUCCESS (1.372s) [567.274780] Starting dynamic subtest: bcs0 [569.245969] Dynamic subtest bcs0: SUCCESS (1.978s) [569.258777] Starting dynamic subtest: vcs0 [571.228399] Dynamic subtest vcs0: SUCCESS (1.981s) [571.239765] Starting dynamic subtest: vcs1 [573.277958] Dynamic subtest vcs1: SUCCESS (2.046s) [573.290607] Starting dynamic subtest: vecs0 [575.262311] Dynamic subtest vecs0: SUCCESS (1.982s) [575.275045] Starting dynamic subtest: ccs0 [577.181948] Dynamic subtest ccs0: SUCCESS (1.917s) [577.184791] Subtest engine-engine-error: SUCCESS (11.292s) [577.309526] [065/156] (441s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [577.409898] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [584.316846] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.911s) [584.468427] [066/156] (434s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [584.579543] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [585.693809] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.114s) [585.815155] [067/156] (432s left) gem_ctx_isolation (dirty-switch) [585.878291] Starting subtest: dirty-switch [585.879900] Starting dynamic subtest: rcs0 [586.077827] Dynamic subtest rcs0: SUCCESS (0.201s) [586.087192] Starting dynamic subtest: bcs0 [586.298522] Dynamic subtest bcs0: SUCCESS (0.219s) [586.313091] Starting dynamic subtest: vcs0 [586.513435] Dynamic subtest vcs0: SUCCESS (0.214s) [586.522966] Starting dynamic subtest: vcs1 [588.481482] Dynamic subtest vcs1: SUCCESS (1.966s) [588.491319] Starting dynamic subtest: vecs0 [590.478870] Dynamic subtest vecs0: SUCCESS (1.997s) [590.488511] Starting dynamic subtest: ccs0 [592.552994] Dynamic subtest ccs0: SUCCESS (2.073s) [592.555519] Subtest dirty-switch: SUCCESS (6.677s) [592.782436] [068/156] (425s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt) [592.890502] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt [592.894624] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [592.994647] [069/156] (425s left) kms_cursor_crc (cursor-rapid-movement-32x10) [593.159881] Starting subtest: cursor-rapid-movement-32x10 [593.211370] Subtest cursor-rapid-movement-32x10: SKIP (0.044s) [593.496463] [070/156] (425s left) gem_spin_batch (user-each) [593.556817] Starting subtest: user-each [596.828779] Subtest user-each: SUCCESS (3.265s) [597.384506] [071/156] (421s left) syncobj_basic (bad-destroy) [597.436188] Starting subtest: bad-destroy [597.441572] Subtest bad-destroy: SUCCESS (0.000s) [597.552447] [072/156] (421s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [597.651805] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu [597.655847] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [597.762616] [073/156] (421s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [597.857130] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [597.859402] Starting dynamic subtest: pipe-A-default-mode [599.004235] Dynamic subtest pipe-A-default-mode: SKIP (1.146s) [599.008187] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.147s) [599.162516] [074/156] (419s left) kms_frontbuffer_tracking (fbc-suspend) [599.259442] Starting subtest: fbc-suspend [637.533209] Subtest fbc-suspend: SUCCESS (7.651s) [638.743315] [075/156] (380s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [638.846148] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [638.850383] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [638.939875] [076/156] (380s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [639.337549] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [640.186899] [077/156] (378s left) kms_chamelium_audio (hdmi-audio) [640.592544] Subtest hdmi-audio: SKIP (0.000s) [641.427131] [078/156] (377s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [641.524485] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [641.528875] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [641.594831] [079/156] (377s left) kms_psr (fbc-pr-primary-render) [641.690135] Starting subtest: fbc-pr-primary-render [641.694278] Subtest fbc-pr-primary-render: SKIP (0.000s) [641.779166] [080/156] (377s left) prime_vgem (basic-gtt) [641.843941] Starting subtest: basic-gtt [641.848516] Subtest basic-gtt: SKIP (0.000s) [641.959896] [081/156] (377s left) gem_mmap_gtt (fault-concurrent-y) [642.020386] Subtest fault-concurrent-Y: SKIP (0.000s) [642.079197] [082/156] (377s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [642.178993] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu [642.182784] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [642.273016] [083/156] (377s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [642.335989] Starting subtest: multi-wait-all-for-submit-available-submitted [642.338402] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [642.441178] [084/156] (376s left) kms_frontbuffer_tracking (fbchdr-tiling-4) [642.542876] Starting subtest: fbchdr-tiling-4 [642.546610] Subtest fbchdr-tiling-4: SKIP (0.000s) [642.643102] [085/156] (376s left) kms_vrr (flip-basic-fastset) [642.731193] Starting subtest: flip-basic-fastset [642.736456] Subtest flip-basic-fastset: SKIP (0.000s) [642.805503] [086/156] (376s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [642.900567] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [642.903998] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [642.994343] [087/156] (376s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [643.083941] Starting subtest: fbcpsr-farfromfence-mmap-gtt [643.087416] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [643.172015] [088/156] (376s left) gem_lmem_swapping (massive) [643.219035] Subtest massive: SKIP (0.000s) [643.317098] [089/156] (376s left) kms_psr (pr-basic) [643.411146] Starting subtest: pr-basic [643.414814] Subtest pr-basic: SKIP (0.000s) [643.485264] [090/156] (376s left) kms_async_flips (async-flip-with-page-flip-events-linear) [643.573435] Starting subtest: async-flip-with-page-flip-events-linear [643.956281] Starting dynamic subtest: pipe-A-eDP-1 [646.750578] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.772s) [647.124706] Starting dynamic subtest: pipe-B-eDP-1 [649.962886] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s) [650.270500] Starting dynamic subtest: pipe-C-eDP-1 [653.110996] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.785s) [653.433177] Starting dynamic subtest: pipe-D-eDP-1 [656.251393] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s) [656.253577] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.560s) [657.401063] [091/156] (362s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [657.529651] Starting subtest: basic-busy-flip-before-cursor-atomic [657.534225] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [657.673985] [092/156] (362s left) kms_big_fb (y-tiled-8bpp-rotate-90) [657.773039] Starting subtest: y-tiled-8bpp-rotate-90 [657.777061] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [657.872214] [093/156] (361s left) kms_invalid_mode (bad-vsync-start) [657.966980] Starting subtest: bad-vsync-start [657.969222] Starting dynamic subtest: pipe-A-eDP-1 [658.252085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [658.264575] Starting dynamic subtest: pipe-B-eDP-1 [658.266477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [658.276505] Starting dynamic subtest: pipe-C-eDP-1 [658.278617] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [658.288385] Starting dynamic subtest: pipe-D-eDP-1 [658.290484] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [658.292924] Subtest bad-vsync-start: SUCCESS (0.292s) [659.135434] [094/156] (360s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [659.264120] Starting subtest: short-flip-after-cursor-toggle [660.186332] Subtest short-flip-after-cursor-toggle: SUCCESS (0.919s) [661.049077] [095/156] (358s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [661.141938] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [661.144328] Starting dynamic subtest: pipe-A-eDP-1 [661.167198] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [661.178708] Starting dynamic subtest: pipe-B-eDP-1 [661.200185] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [661.210327] Starting dynamic subtest: pipe-C-eDP-1 [661.231925] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [661.241293] Starting dynamic subtest: pipe-D-eDP-1 [661.263781] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [661.268375] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [663.424654] [096/156] (356s left) gem_exec_alignment (forked) [663.476832] Starting subtest: forked [702.562602] Subtest forked: SUCCESS (39.032s) [702.622950] [097/156] (317s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [702.784796] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [702.789349] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [702.876272] [098/156] (317s left) drm_read (short-buffer-block) [703.055143] Starting subtest: short-buffer-block [703.057433] Subtest short-buffer-block: SUCCESS (0.000s) [703.182823] [099/156] (316s left) perf_pmu (busy-idle) [703.228938] Starting subtest: busy-idle [703.230732] Starting dynamic subtest: rcs0 [703.906415] Dynamic subtest rcs0: SUCCESS (0.678s) [703.920074] Starting dynamic subtest: bcs0 [704.570466] Dynamic subtest bcs0: SUCCESS (0.661s) [704.583474] Starting dynamic subtest: vcs0 [705.284906] Dynamic subtest vcs0: FAIL (0.659s) [705.297453] Starting dynamic subtest: vcs1 [706.488083] Dynamic subtest vcs1: FAIL (1.192s) [706.500433] Starting dynamic subtest: vecs0 [708.532948] Dynamic subtest vecs0: FAIL (2.043s) [708.544004] Starting dynamic subtest: ccs0 [710.518519] Dynamic subtest ccs0: FAIL (1.984s) [710.520518] Subtest busy-idle: FAIL (7.226s) [710.571241] [100/156] (309s left) syncobj_timeline (wait-for-submit-snapshot) [710.626737] Starting subtest: wait-for-submit-snapshot [710.709621] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [710.793636] [101/156] (309s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [710.894628] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [710.922793] Starting dynamic subtest: pipe-A-plane-0 [711.211411] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [711.222642] Starting dynamic subtest: pipe-A-plane-3 [711.456013] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s) [711.469527] Starting dynamic subtest: pipe-A-plane-5 [711.473591] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [712.614293] Starting dynamic subtest: pipe-B-plane-0 [712.904557] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [712.915830] Starting dynamic subtest: pipe-B-plane-3 [713.138156] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [713.149746] Starting dynamic subtest: pipe-B-plane-5 [713.154356] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [713.461734] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.565s) [714.285772] [102/156] (305s left) gem_exec_balancer (bonded-semaphore) [714.349206] Starting subtest: bonded-semaphore [714.353996] Subtest bonded-semaphore: SKIP (0.000s) [714.652183] [103/156] (305s left) kms_big_fb (linear-32bpp-rotate-90) [714.751464] Starting subtest: linear-32bpp-rotate-90 [714.770628] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [714.884471] [104/156] (305s left) sw_sync (sync_multi_consumer) [714.923453] Starting subtest: sync_multi_consumer [715.357400] Subtest sync_multi_consumer: SUCCESS (0.436s) [715.434239] [105/156] (304s left) perf_pmu (render-node-busy) [715.523691] Starting subtest: render-node-busy [715.525730] Starting dynamic subtest: rcs0 [716.120938] Dynamic subtest rcs0: SUCCESS (0.598s) [716.134661] Starting dynamic subtest: bcs0 [716.678317] Dynamic subtest bcs0: SUCCESS (0.555s) [716.692541] Starting dynamic subtest: vcs0 [717.831219] Dynamic subtest vcs0: SUCCESS (1.149s) [717.844916] Starting dynamic subtest: vcs1 [719.813753] Dynamic subtest vcs1: SUCCESS (1.979s) [719.830386] Starting dynamic subtest: vecs0 [721.798072] Dynamic subtest vecs0: SUCCESS (1.980s) [721.812325] Starting dynamic subtest: ccs0 [722.368638] Dynamic subtest ccs0: SUCCESS (0.569s) [722.371516] Subtest render-node-busy: SUCCESS (6.846s) [722.446319] [106/156] (297s left) kms_pipe_stress (stress-xrgb8888-ytiled) [722.555988] Starting subtest: stress-xrgb8888-ytiled [722.560336] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [722.642049] [107/156] (297s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [722.738815] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [722.743198] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [722.842522] [108/156] (297s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [722.947790] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [722.952214] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [723.070273] [109/156] (297s left) device_reset (unbind-cold-reset-rebind) [723.120959] Starting subtest: unbind-cold-reset-rebind [723.125320] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [723.212371] [110/156] (297s left) gem_ctx_exec (basic-close-race) [723.276734] Starting subtest: basic-close-race [729.242022] Subtest basic-close-race: SUCCESS (5.910s) [729.341089] [111/156] (291s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [729.438567] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [729.440740] Starting dynamic subtest: pipe-A-eDP-1 [731.777404] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.341s) [731.788392] Starting dynamic subtest: pipe-B-eDP-1 [734.224330] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.446s) [734.235393] Starting dynamic subtest: pipe-C-eDP-1 [736.417735] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.192s) [736.429721] Starting dynamic subtest: pipe-D-eDP-1 [738.637985] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.221s) [738.639982] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.205s) [739.811085] [112/156] (280s left) kms_flip (2x-plain-flip) [739.903939] Starting subtest: 2x-plain-flip [739.915168] Subtest 2x-plain-flip: SKIP (0.011s) [739.996068] [113/156] (280s left) syncobj_wait (multi-wait-all-submitted) [740.045932] Starting subtest: multi-wait-all-submitted [740.154185] Subtest multi-wait-all-submitted: SUCCESS (0.107s) [740.232160] [114/156] (280s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [740.330373] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [747.426635] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.106s) [747.553078] [115/156] (273s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [747.652466] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [747.654828] Starting dynamic subtest: pipe-A-eDP-1 [747.713267] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [747.723788] Starting dynamic subtest: pipe-B-eDP-1 [747.783880] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [747.796513] Starting dynamic subtest: pipe-C-eDP-1 [747.853050] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [747.865238] Starting dynamic subtest: pipe-D-eDP-1 [747.922352] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [747.926859] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [749.918255] [116/156] (270s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt) [750.015473] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt [750.019521] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [750.116027] [117/156] (270s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [750.222726] Starting subtest: psr-1p-primscrn-spr-indfb-move [757.669134] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.453s) [757.809209] [118/156] (263s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [757.921108] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt [757.925458] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [758.011438] [119/156] (262s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc) [758.115732] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc [758.120098] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [758.215129] [120/156] (262s left) i915_pm_rc6_residency (rc6-accuracy) [758.270231] Starting subtest: rc6-accuracy [758.272424] Starting dynamic subtest: gt0 [761.444409] Dynamic subtest gt0: SUCCESS (3.170s) [761.458436] Starting dynamic subtest: gt1 [764.665425] Dynamic subtest gt1: SUCCESS (3.168s) [764.667883] Subtest rc6-accuracy: SUCCESS (6.344s) [764.713888] [121/156] (256s left) kms_legacy_colorkey (invalid-plane) [764.802900] Starting subtest: invalid-plane [764.805188] Starting dynamic subtest: zero-id [764.807097] Dynamic subtest zero-id: SUCCESS (0.000s) [764.818747] Starting dynamic subtest: outrange-id [764.821059] Dynamic subtest outrange-id: SUCCESS (0.000s) [764.823366] Subtest invalid-plane: SUCCESS (0.001s) [764.876233] [122/156] (256s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [764.967287] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [772.305145] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.343s) [772.445010] [123/156] (248s left) gem_partial_pwrite_pread (write-uncached) [772.509938] Subtest write-uncached: SKIP (0.000s) [772.583142] [124/156] (248s left) gem_userptr_blits (readonly-unsync) [772.652000] Subtest readonly-unsync: SKIP (0.000s) [772.787208] [125/156] (248s left) syncobj_basic (bad-pad-fd-to-handle) [772.840801] Starting subtest: bad-pad-fd-to-handle [772.842660] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [772.945846] [126/156] (248s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render) [773.043601] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render [773.047892] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [773.136959] [127/156] (248s left) perf (invalid-oa-format-id) [773.289629] Starting subtest: invalid-oa-format-id [773.300262] Subtest invalid-oa-format-id: SUCCESS (0.010s) [773.351187] [128/156] (248s left) gem_mmap_wc (pf-nonblock) [773.399645] Subtest pf-nonblock: SKIP (0.000s) [773.462020] [129/156] (247s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [773.504590] Starting subtest: multi-wait-for-submit-submitted-signaled [773.506592] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [773.589001] [130/156] (247s left) kms_psr (psr2-sprite-plane-onoff) [773.680048] Starting subtest: psr2-sprite-plane-onoff [773.681982] Starting dynamic subtest: eDP-1 [775.482737] Dynamic subtest eDP-1: SUCCESS (1.802s) [775.485054] Subtest psr2-sprite-plane-onoff: SUCCESS (1.803s) [776.320967] [131/156] (245s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [776.413284] Starting subtest: psr-shrfb-scaledprimary [782.176479] Subtest psr-shrfb-scaledprimary: SUCCESS (5.765s) [782.316746] [132/156] (239s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt) [782.424406] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt [782.428403] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [782.522173] [133/156] (239s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [782.628360] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc [782.632740] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [782.723554] [134/156] (238s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [782.779943] Starting subtest: invalid-single-wait-all-unsubmitted [782.782276] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [782.906256] [135/156] (238s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [783.014284] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [783.016574] Starting dynamic subtest: pipe-A-eDP-1 [783.111089] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [783.124443] Starting dynamic subtest: pipe-B-eDP-1 [784.326825] Dynamic subtest pipe-B-eDP-1: SKIP (1.213s) [784.331460] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.316s) [785.517547] [136/156] (236s left) kms_dp_link_training (uhbr-mst) [785.606043] Starting subtest: uhbr-mst [785.614296] Subtest uhbr-mst: SKIP (0.000s) [785.680348] [137/156] (236s left) prime_busy (hang) [785.732572] Starting subtest: hang [785.734843] Starting dynamic subtest: rcs0 [811.371150] Dynamic subtest rcs0: SUCCESS (25.621s) [811.381391] Starting dynamic subtest: bcs0 [818.525799] Dynamic subtest bcs0: SUCCESS (7.154s) [818.539101] Starting dynamic subtest: vcs0 [825.487269] Dynamic subtest vcs0: SUCCESS (6.970s) [825.499763] Starting dynamic subtest: vcs1 [832.463601] Dynamic subtest vcs1: SUCCESS (6.973s) [832.474624] Starting dynamic subtest: vecs0 [839.515059] Dynamic subtest vecs0: SUCCESS (7.035s) [839.525760] Starting dynamic subtest: ccs0 [853.344362] Dynamic subtest ccs0: SUCCESS (13.835s) [853.346774] Subtest hang: SUCCESS (67.595s) [853.452977] [138/156] (168s left) i915_drm_fdinfo (virtual-busy-all) [853.500468] Starting subtest: virtual-busy-all [853.504943] Subtest virtual-busy-all: SKIP (0.000s) [853.587276] [139/156] (168s left) gen9_exec_parse (allowed-all) [853.657335] Subtest allowed-all: SKIP (0.000s) [853.725816] [140/156] (168s left) gem_exec_schedule (u-submit-late-slice) [853.803174] Starting subtest: u-submit-late-slice [853.805435] Starting dynamic subtest: rcs0 [853.855830] Dynamic subtest rcs0: SUCCESS (0.059s) [853.868631] Starting dynamic subtest: bcs0 [853.904024] Dynamic subtest bcs0: SUCCESS (0.047s) [853.915743] Starting dynamic subtest: vcs0 [853.947825] Dynamic subtest vcs0: SUCCESS (0.043s) [853.960320] Starting dynamic subtest: vcs1 [853.985805] Dynamic subtest vcs1: SUCCESS (0.037s) [853.999036] Starting dynamic subtest: vecs0 [854.028937] Dynamic subtest vecs0: SUCCESS (0.043s) [854.040924] Starting dynamic subtest: ccs0 [854.074610] Dynamic subtest ccs0: SUCCESS (0.045s) [854.076976] Subtest u-submit-late-slice: SUCCESS (0.278s) [855.902823] [141/156] (166s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [855.970755] Starting subtest: x-tiled-to-vebox-y-tiled [855.975301] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [856.156533] [142/156] (165s left) api_intel_bb (reset-flags) [856.201743] Starting subtest: reset-flags [856.210896] Subtest reset-flags: SUCCESS (0.010s) [856.337267] [143/156] (165s left) kms_flip (2x-flip-vs-wf_vblank) [856.438767] Starting subtest: 2x-flip-vs-wf_vblank [856.448005] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s) [856.588194] [144/156] (165s left) kms_pm_dc (dc5-dpms) [857.688855] Starting subtest: dc5-dpms [859.795709] Subtest dc5-dpms: SUCCESS (2.107s) [859.876900] [145/156] (162s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render) [859.972642] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render [859.977234] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [860.072358] [146/156] (162s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [860.161808] Starting subtest: bad-rotation-90-yf-tiled-ccs [860.164040] Starting dynamic subtest: pipe-A-eDP-1 [860.187126] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [860.200153] Starting dynamic subtest: pipe-B-eDP-1 [860.221809] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [860.233657] Starting dynamic subtest: pipe-C-eDP-1 [860.255790] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [860.267351] Starting dynamic subtest: pipe-D-eDP-1 [860.289403] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [860.293582] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s) [862.425328] [147/156] (159s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [862.524398] Starting subtest: 4-tiled-addfb-size-offset-overflow [862.526741] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [862.649303] [148/156] (159s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [862.748262] Starting subtest: fbcpsr-1p-rte [869.761132] Subtest fbcpsr-1p-rte: SUCCESS (7.021s) [869.933274] [149/156] (152s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [869.994991] Subtest writes-after-reads: SKIP (0.000s) [870.086965] [150/156] (152s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render) [870.188727] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render [870.192811] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [870.298499] [151/156] (152s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt) [870.397381] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt [870.401925] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [870.504330] [152/156] (151s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [870.602976] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [870.614175] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [870.708151] [153/156] (151s left) kms_plane (plane-panning-bottom-right-suspend) [870.795644] Starting subtest: plane-panning-bottom-right-suspend [870.797320] Starting dynamic subtest: pipe-A [888.345664] Dynamic subtest pipe-A: SUCCESS (2.906s) [888.358329] Starting dynamic subtest: pipe-B [907.346878] Dynamic subtest pipe-B: SUCCESS (3.494s) [907.349805] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.403s) [908.164467] [154/156] (114s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [908.296779] Starting subtest: basic-flip-before-cursor-legacy [909.212810] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.917s) [910.090427] [155/156] (112s left) kms_getfb (getfb-reject-nv12) [910.181398] Starting subtest: getfb-reject-nv12 [910.183917] Subtest getfb-reject-nv12: SUCCESS (0.001s) [910.299049] [156/156] (112s left) gem_render_copy (x-tiled) [910.356533] Starting subtest: x-tiled [910.358854] Starting dynamic subtest: smem [910.399911] Dynamic subtest smem: SUCCESS (0.043s) [910.402825] Subtest x-tiled: SUCCESS (0.044s) [910.583107] Closing watchdogs results: parsing output: 0/ for test: i915_selftest results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_content_protection results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: gem_mmap_gtt results: parsing output: 5/ for test: kms_prime results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_chamelium_hpd results: parsing output: 8/ for test: tools_test results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_dsc results: parsing output: 11/ for test: gem_exec_fence results: parsing output: 12/ for test: gem_wait results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: gem_mmap_gtt results: parsing output: 15/ for test: kms_color_pipeline results: parsing output: 16/ for test: gem_exec_schedule results: parsing output: 17/ for test: vgem_basic results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_plane_multiple results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: gem_ccs results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_vblank results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: api_intel_bb results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: gem_ctx_param results: parsing output: 36/ for test: gem_userptr_blits results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: kms_plane_scaling results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_mmap_offset results: parsing output: 44/ for test: kms_atomic results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_ctx_persistence results: parsing output: 47/ for test: gem_exec_params results: parsing output: 48/ for test: gem_exec_await results: parsing output: 49/ for test: gem_render_copy results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_exec_params results: parsing output: 52/ for test: syncobj_wait results: parsing output: 53/ for test: gem_create results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: syncobj_wait results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_flip_scaled_crc results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: i915_hangman results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: gem_ctx_isolation results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_cursor_crc results: parsing output: 69/ for test: gem_spin_batch results: parsing output: 70/ for test: syncobj_basic results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_chamelium_frames results: parsing output: 76/ for test: kms_chamelium_audio results: parsing output: 77/ for test: kms_psr2_sf results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: prime_vgem results: parsing output: 80/ for test: gem_mmap_gtt results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_vrr results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_lmem_swapping results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_async_flips results: parsing output: 90/ for test: kms_cursor_legacy results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_invalid_mode results: parsing output: 93/ for test: kms_cursor_legacy results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: gem_exec_alignment results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: drm_read results: parsing output: 98/ for test: perf_pmu results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: kms_plane results: parsing output: 101/ for test: gem_exec_balancer results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: sw_sync results: parsing output: 104/ for test: perf_pmu results: parsing output: 105/ for test: kms_pipe_stress results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: device_reset results: parsing output: 109/ for test: gem_ctx_exec results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: kms_flip results: parsing output: 112/ for test: syncobj_wait results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: i915_pm_rc6_residency results: parsing output: 120/ for test: kms_legacy_colorkey results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_partial_pwrite_pread results: parsing output: 123/ for test: gem_userptr_blits results: parsing output: 124/ for test: syncobj_basic results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: perf results: parsing output: 127/ for test: gem_mmap_wc results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: syncobj_wait results: parsing output: 134/ for test: kms_psr2_sf results: parsing output: 135/ for test: kms_dp_link_training results: parsing output: 136/ for test: prime_busy results: parsing output: 137/ for test: i915_drm_fdinfo results: parsing output: 138/ for test: gen9_exec_parse results: parsing output: 139/ for test: gem_exec_schedule results: parsing output: 140/ for test: gem_render_copy results: parsing output: 141/ for test: api_intel_bb results: parsing output: 142/ for test: kms_flip results: parsing output: 143/ for test: kms_pm_dc results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_ccs results: parsing output: 146/ for test: kms_big_fb results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_flip results: parsing output: 152/ for test: kms_plane results: parsing output: 153/ for test: kms_cursor_legacy results: parsing output: 154/ for test: kms_getfb results: parsing output: 155/ for test: gem_render_copy Done.