[58.626589] Initializing watchdogs [58.626651] /dev/watchdog0 [58.639391] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.643145] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.645216] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.648122] [001/131] (960s left) api_intel_allocator (reloc-allocator) [58.765842] Starting subtest: reloc-allocator [58.768283] Starting dynamic subtest: basic [58.773013] Dynamic subtest basic: SUCCESS (0.007s) [58.781229] Starting dynamic subtest: parallel-one [58.783625] Dynamic subtest parallel-one: SUCCESS (0.008s) [58.789885] Starting dynamic subtest: print [58.792107] Dynamic subtest print: SUCCESS (0.000s) [58.799961] Starting dynamic subtest: reuse [58.801879] Dynamic subtest reuse: SUCCESS (0.000s) [58.807853] Starting dynamic subtest: fork-reopen-allocator [58.810049] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s) [58.812288] Subtest reloc-allocator: SUCCESS (0.031s) [58.934204] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [59.050646] Starting subtest: fbcpsr-rgb101010-draw-blt [63.753394] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.657s) [63.881312] [003/131] (955s left) kms_cdclk (mode-transition-all-outputs) [63.972969] Starting subtest: mode-transition-all-outputs [64.260230] Subtest mode-transition-all-outputs: SKIP (0.282s) [65.117907] [004/131] (954s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [65.211844] Starting subtest: plane-upscale-20x20-with-pixel-format [65.214747] Starting dynamic subtest: pipe-A [66.266563] Dynamic subtest pipe-A: SUCCESS (1.049s) [66.274422] Starting dynamic subtest: pipe-B [68.337468] Dynamic subtest pipe-B: SUCCESS (2.061s) [68.343579] Starting dynamic subtest: pipe-C [69.540119] Dynamic subtest pipe-C: SUCCESS (1.198s) [69.547183] Starting dynamic subtest: pipe-D [70.662813] Dynamic subtest pipe-D: SUCCESS (1.119s) [70.665269] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.427s) [71.852966] [005/131] (947s left) gen9_exec_parse (bb-start-out) [72.023423] Subtest bb-start-out: SKIP (0.000s) [72.099180] [006/131] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [72.199500] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [72.204058] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [72.307503] [007/131] (947s left) gem_ctx_persistence (legacy-engines-cleanup) [72.366195] Starting subtest: legacy-engines-cleanup [72.368536] Starting dynamic subtest: render [72.475265] Dynamic subtest render: SUCCESS (0.108s) [72.484855] Starting dynamic subtest: bsd1 [72.534111] Dynamic subtest bsd1: SUCCESS (0.058s) [72.543609] Starting dynamic subtest: bsd2 [72.590129] Dynamic subtest bsd2: SUCCESS (0.055s) [72.599309] Starting dynamic subtest: blt [72.647987] Dynamic subtest blt: SUCCESS (0.057s) [72.657594] Starting dynamic subtest: vebox [72.671450] Dynamic subtest vebox: SUCCESS (0.023s) [72.673824] Subtest legacy-engines-cleanup: SUCCESS (0.305s) [72.806691] [008/131] (946s left) syncobj_timeline (wait-any-snapshot) [72.860753] Starting subtest: wait-any-snapshot [72.941699] Subtest wait-any-snapshot: SUCCESS (0.081s) [73.004564] [009/131] (946s left) kms_busy (extended-pageflip-hang-newfb) [73.103510] Starting subtest: extended-pageflip-hang-newfb [73.105501] Starting dynamic subtest: pipe-A [99.711119] Dynamic subtest pipe-A: SUCCESS (26.580s) [99.719764] Starting dynamic subtest: pipe-D [125.689793] Dynamic subtest pipe-D: SUCCESS (25.969s) [125.692300] Subtest extended-pageflip-hang-newfb: SUCCESS (52.553s) [126.519632] [010/131] (893s left) kms_cursor_legacy (flip-vs-cursor-toggle) [126.644149] Starting subtest: flip-vs-cursor-toggle [134.259568] Subtest flip-vs-cursor-toggle: SUCCESS (7.615s) [135.044970] [011/131] (884s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt) [135.152826] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt [135.157084] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [135.252473] [012/131] (884s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [135.354629] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [136.412026] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.057s) [136.544289] [013/131] (883s left) i915_selftest (live) [139.917392] Starting subtest: live [139.919463] Starting dynamic subtest: sanitycheck [144.301797] Dynamic subtest sanitycheck: SUCCESS (4.383s) [144.309711] Starting dynamic subtest: uncore [148.682078] Dynamic subtest uncore: SUCCESS (4.380s) [148.690098] Starting dynamic subtest: workarounds [151.834459] Dynamic subtest workarounds: SUCCESS (3.152s) [151.843050] Starting dynamic subtest: gt_engines [154.920980] Dynamic subtest gt_engines: SUCCESS (3.086s) [154.932664] Starting dynamic subtest: gt_timelines [171.704078] Dynamic subtest gt_timelines: SUCCESS (16.783s) [171.710693] Starting dynamic subtest: gt_contexts [174.483992] Dynamic subtest gt_contexts: SUCCESS (2.778s) [174.491940] Starting dynamic subtest: gt_lrc [180.731397] Dynamic subtest gt_lrc: SUCCESS (6.247s) [180.739563] Starting dynamic subtest: gt_mocs [183.722384] Dynamic subtest gt_mocs: SUCCESS (2.989s) [183.730325] Starting dynamic subtest: gt_pm [190.581426] Dynamic subtest gt_pm: SUCCESS (6.858s) [190.589414] Starting dynamic subtest: gt_heartbeat [194.980421] Dynamic subtest gt_heartbeat: SUCCESS (4.397s) [194.988820] Starting dynamic subtest: gt_tlb [203.258443] Dynamic subtest gt_tlb: SUCCESS (8.277s) [203.265997] Starting dynamic subtest: requests [214.676948] Dynamic subtest requests: SUCCESS (11.417s) [214.685071] Starting dynamic subtest: migrate [220.714234] Dynamic subtest migrate: SUCCESS (6.036s) [220.723632] Starting dynamic subtest: active [225.059348] Dynamic subtest active: SUCCESS (4.343s) [225.067203] Starting dynamic subtest: objects [229.782363] Dynamic subtest objects: SUCCESS (4.722s) [229.790847] Starting dynamic subtest: mman [234.533963] Dynamic subtest mman: SUCCESS (4.750s) [234.542059] Starting dynamic subtest: dmabuf [239.002068] Dynamic subtest dmabuf: SUCCESS (4.466s) [239.010814] Starting dynamic subtest: vma [243.356969] Dynamic subtest vma: SUCCESS (4.354s) [243.364284] Starting dynamic subtest: coherency [246.899247] Dynamic subtest coherency: SUCCESS (3.540s) [246.908030] Starting dynamic subtest: gtt [256.569049] Dynamic subtest gtt: SUCCESS (9.667s) [256.578245] Starting dynamic subtest: gem [262.857771] Dynamic subtest gem: SUCCESS (6.288s) [262.865769] Starting dynamic subtest: evict [268.151449] Dynamic subtest evict: SUCCESS (5.292s) [268.159747] Starting dynamic subtest: hugepages [279.120870] Dynamic subtest hugepages: SUCCESS (10.968s) [279.129242] Starting dynamic subtest: gem_contexts [306.607424] Dynamic subtest gem_contexts: SUCCESS (27.486s) [306.616159] Starting dynamic subtest: client [311.074578] Dynamic subtest client: SUCCESS (4.467s) [311.082527] Starting dynamic subtest: gem_migrate [315.500281] Dynamic subtest gem_migrate: SUCCESS (4.424s) [315.508132] Starting dynamic subtest: reset [318.287395] Dynamic subtest reset: SUCCESS (2.786s) [318.295583] Starting dynamic subtest: memory_region [322.671828] Dynamic subtest memory_region: SUCCESS (4.382s) [322.680714] Starting dynamic subtest: hangcheck [336.036549] Dynamic subtest hangcheck: SUCCESS (13.363s) [336.044751] Starting dynamic subtest: execlists [340.373114] Dynamic subtest execlists: SUCCESS (4.334s) [340.381838] Starting dynamic subtest: ring_submission [344.768324] Dynamic subtest ring_submission: SUCCESS (4.393s) [344.776875] Starting dynamic subtest: perf [347.575136] Dynamic subtest perf: SUCCESS (2.805s) [347.583629] Starting dynamic subtest: slpc [361.686368] Dynamic subtest slpc: SUCCESS (14.108s) [361.692127] Starting dynamic subtest: guc [365.560145] Dynamic subtest guc: SUCCESS (3.872s) [365.567599] Starting dynamic subtest: guc_multi_lrc [370.014524] Dynamic subtest guc_multi_lrc: SUCCESS (4.453s) [370.022517] Starting dynamic subtest: guc_hang [374.955043] Dynamic subtest guc_hang: SUCCESS (4.938s) [374.963416] Starting dynamic subtest: late_gt_pm [377.784609] Dynamic subtest late_gt_pm: SUCCESS (2.827s) [377.787898] Subtest live: SUCCESS (237.859s) [377.810229] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [377.813333] [014/131] (641s left) gem_render_copy (y-tiled) [379.129763] Starting subtest: y-tiled [379.134447] Subtest y-tiled: SKIP (0.000s) [379.269426] [FACT gem_render_copy (y-tiled)] new: kernel.kmod_is_loaded.i915: true [379.273069] [015/131] (640s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [379.660112] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [380.490997] [016/131] (639s left) kms_lease (lease-get) [380.585222] Starting subtest: lease-get [380.587436] Starting dynamic subtest: pipe-A-eDP-1 [380.590068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [380.597674] Starting dynamic subtest: pipe-B-eDP-1 [380.599664] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [380.605551] Starting dynamic subtest: pipe-C-eDP-1 [380.607371] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [380.613025] Starting dynamic subtest: pipe-D-eDP-1 [380.614826] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [380.616625] Subtest lease-get: SUCCESS (0.008s) [380.696029] [017/131] (639s left) gem_lmem_swapping (massive) [380.745462] Subtest massive: SKIP (0.000s) [380.779683] [018/131] (639s left) gem_tiled_blits (basic) [380.825996] Subtest basic: SKIP (0.000s) [380.892438] [019/131] (638s left) i915_pm_rpm (gem-idle) [383.129637] Starting subtest: gem-idle [389.308768] Subtest gem-idle: SUCCESS (6.179s) [389.611781] [020/131] (630s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [390.975184] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [395.682801] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.708s) [395.799506] [021/131] (624s left) syncobj_wait (single-wait-for-submit-signaled) [395.865528] Starting subtest: single-wait-for-submit-signaled [395.867467] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [395.956296] [022/131] (623s left) kms_flip (bo-too-big) [396.060222] Starting subtest: bo-too-big [396.062544] Starting dynamic subtest: A-eDP1 [397.860822] Dynamic subtest A-eDP1: SUCCESS (1.800s) [397.869203] Starting dynamic subtest: B-eDP1 [399.583682] Dynamic subtest B-eDP1: SUCCESS (1.722s) [399.593090] Starting dynamic subtest: C-eDP1 [401.291166] Dynamic subtest C-eDP1: SUCCESS (1.707s) [401.298415] Starting dynamic subtest: D-eDP1 [403.024767] Dynamic subtest D-eDP1: SUCCESS (1.733s) [403.027192] Subtest bo-too-big: SUCCESS (6.968s) [404.292376] [023/131] (615s left) gem_ctx_isolation (nonpriv) [404.358471] Starting subtest: nonpriv [404.360816] Starting dynamic subtest: rcs0 [404.882240] Dynamic subtest rcs0: SUCCESS (0.522s) [404.892309] Starting dynamic subtest: bcs0 [405.419944] Dynamic subtest bcs0: SUCCESS (0.538s) [405.429623] Starting dynamic subtest: vcs0 [405.968788] Dynamic subtest vcs0: SUCCESS (0.548s) [405.977912] Starting dynamic subtest: vcs1 [407.484585] Dynamic subtest vcs1: SUCCESS (1.515s) [407.494849] Starting dynamic subtest: vecs0 [409.471290] Dynamic subtest vecs0: SUCCESS (1.986s) [409.481118] Starting dynamic subtest: ccs0 [411.495692] Dynamic subtest ccs0: SUCCESS (2.024s) [411.498503] Subtest nonpriv: SUCCESS (7.137s) [411.754562] [024/131] (608s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [411.864882] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [411.867182] Starting dynamic subtest: pipe-A-default-mode [414.617250] Dynamic subtest pipe-A-default-mode: SUCCESS (2.749s) [414.619609] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.750s) [415.478401] [025/131] (604s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [415.579932] Starting subtest: psr-indfb-scaledprimary [419.281833] Subtest psr-indfb-scaledprimary: SUCCESS (3.706s) [419.408842] [026/131] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [419.508572] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [419.512966] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [419.603470] [027/131] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [419.712633] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [419.716959] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [419.814442] [028/131] (600s left) i915_module_load (resize-bar) [419.851597] Starting subtest: resize-bar [419.858687] Subtest resize-bar: SKIP (0.007s) [419.886582] [029/131] (600s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [419.937089] Starting subtest: invalid-multi-wait-unsubmitted-signaled [419.939340] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [420.024429] [030/131] (600s left) gem_vm_create (invalid-destroy) [420.084555] Starting subtest: invalid-destroy [420.087072] Subtest invalid-destroy: SUCCESS (0.002s) [420.185489] [031/131] (600s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [420.298403] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [421.522599] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.225s) [421.818778] [032/131] (598s left) perf_pmu (busy) [421.858923] Starting subtest: busy [421.861449] Starting dynamic subtest: rcs0 [422.480688] Dynamic subtest rcs0: SUCCESS (0.622s) [422.490755] Starting dynamic subtest: bcs0 [423.049657] Dynamic subtest bcs0: SUCCESS (0.567s) [423.059789] Starting dynamic subtest: vcs0 [424.939094] Dynamic subtest vcs0: SUCCESS (1.886s) [424.949404] Starting dynamic subtest: vcs1 [426.922834] Dynamic subtest vcs1: SUCCESS (1.981s) [426.935294] Starting dynamic subtest: vecs0 [428.905381] Dynamic subtest vecs0: SUCCESS (1.980s) [428.916229] Starting dynamic subtest: ccs0 [429.487141] Dynamic subtest ccs0: SUCCESS (0.581s) [429.489675] Subtest busy: SUCCESS (7.630s) [429.605040] [033/131] (590s left) kms_pipe_crc_basic (bad-source) [429.712029] Starting subtest: bad-source [429.714233] Subtest bad-source: SUCCESS (0.000s) [429.776854] [034/131] (590s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [429.874319] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [429.876658] Starting dynamic subtest: A-eDP1 [438.772065] Dynamic subtest A-eDP1: SUCCESS (8.896s) [438.781291] Starting dynamic subtest: B-eDP1 [447.697266] Dynamic subtest B-eDP1: SUCCESS (8.923s) [447.706057] Starting dynamic subtest: C-eDP1 [456.609778] Dynamic subtest C-eDP1: SUCCESS (8.911s) [456.620343] Starting dynamic subtest: D-eDP1 [465.534299] Dynamic subtest D-eDP1: SUCCESS (8.922s) [465.536673] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.660s) [466.748581] [035/131] (553s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [466.858234] Starting subtest: yf-tiled-64bpp-rotate-90 [466.862229] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [466.977148] [036/131] (553s left) kms_cursor_edge_walk (64x64-top-bottom) [467.075706] Starting subtest: 64x64-top-bottom [467.078025] Starting dynamic subtest: pipe-A-eDP-1 [470.522680] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s) [470.530665] Starting dynamic subtest: pipe-D-eDP-1 [473.629189] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.105s) [473.631576] Subtest 64x64-top-bottom: SUCCESS (6.551s) [474.426614] [037/131] (545s left) kms_psr (fbc-pr-cursor-mmap-cpu) [474.537079] Starting subtest: fbc-pr-cursor-mmap-cpu [474.541181] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [474.599181] [038/131] (545s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [474.711168] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [474.715517] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [474.799246] [039/131] (545s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [474.908454] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [474.910844] Starting dynamic subtest: pipe-A-eDP-1 [474.933658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [474.943178] Starting dynamic subtest: pipe-B-eDP-1 [474.965083] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [474.971879] Starting dynamic subtest: pipe-C-eDP-1 [474.994034] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [475.000925] Starting dynamic subtest: pipe-D-eDP-1 [475.022984] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [475.027409] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s) [477.083064] [040/131] (543s left) gem_exec_whisper (basic-fds) [477.148700] Starting subtest: basic-fds [482.750699] Subtest basic-fds: SUCCESS (5.601s) [482.968592] [041/131] (537s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [483.080319] Starting subtest: fbc-rgb101010-draw-mmap-wc [486.669540] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.591s) [486.775247] [042/131] (533s left) kms_properties (plane-properties-legacy) [486.866961] Starting subtest: plane-properties-legacy [486.869272] Starting dynamic subtest: pipe-A-eDP-1 [487.437906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s) [487.445713] Starting dynamic subtest: pipe-B-eDP-1 [488.683237] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s) [488.691236] Starting dynamic subtest: pipe-C-eDP-1 [489.895754] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s) [489.906070] Starting dynamic subtest: pipe-D-eDP-1 [491.118458] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s) [491.120844] Subtest plane-properties-legacy: SUCCESS (4.250s) [491.909288] [043/131] (528s left) vgem_basic (dmabuf-export) [492.002492] Starting subtest: dmabuf-export [492.044618] Subtest dmabuf-export: SUCCESS (0.044s) [492.116687] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true [492.119903] [044/131] (528s left) kms_plane_lowres (tiling-none) [492.207161] Starting subtest: tiling-none [492.209398] Starting dynamic subtest: pipe-A-eDP-1 [492.213798] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [492.499097] Starting dynamic subtest: pipe-B-eDP-1 [492.503738] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [492.510859] Starting dynamic subtest: pipe-C-eDP-1 [492.515451] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [492.522468] Starting dynamic subtest: pipe-D-eDP-1 [492.526717] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [492.530990] Subtest tiling-none: SKIP (0.289s) [493.334125] [045/131] (527s left) kms_addfb_basic (invalid-set-prop) [493.397570] Starting subtest: invalid-set-prop [493.400070] Subtest invalid-set-prop: SUCCESS (0.000s) [493.551119] [046/131] (527s left) core_getstats [493.711802] [047/131] (527s left) gem_bad_reloc (negative-reloc-lut) [493.781272] Subtest negative-reloc-lut: SKIP (0.000s) [493.845556] [048/131] (526s left) kms_addfb_basic (basic) [493.901805] Starting subtest: basic [493.904086] Subtest basic: SUCCESS (0.000s) [494.031323] [049/131] (526s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [494.135722] Starting subtest: fbc-farfromfence-mmap-gtt [494.139860] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [494.210484] [050/131] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [494.308359] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [498.849536] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.543s) [499.000699] [051/131] (521s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [499.102852] Starting subtest: psr-farfromfence-mmap-gtt [499.107103] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [499.212948] [052/131] (521s left) gem_exec_balancer (noheartbeat) [499.471747] Starting subtest: noheartbeat [499.476307] Subtest noheartbeat: SKIP (0.000s) [499.599296] [053/131] (521s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [499.701160] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [499.703381] Starting dynamic subtest: pipe-A [499.773939] Dynamic subtest pipe-A: SUCCESS (0.072s) [499.782379] Starting dynamic subtest: pipe-B [500.909182] Dynamic subtest pipe-B: SUCCESS (1.134s) [500.917863] Starting dynamic subtest: pipe-C [502.014912] Dynamic subtest pipe-C: SUCCESS (1.105s) [502.028388] Starting dynamic subtest: pipe-D [503.144963] Dynamic subtest pipe-D: SUCCESS (1.129s) [503.147323] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.444s) [504.294485] [054/131] (516s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [504.687477] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [505.510348] [055/131] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [505.626629] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [510.401192] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.776s) [510.527287] [056/131] (510s left) kms_fbcon_fbt (psr-suspend) [510.582460] Starting subtest: psr-suspend [557.921262] Subtest psr-suspend: SUCCESS (17.693s) [557.999749] [057/131] (492s left) drm_read (empty-block) [558.170425] Starting subtest: empty-block [559.176580] Subtest empty-block: SUCCESS (0.984s) [559.328755] [058/131] (491s left) kms_vblank (wait-idle-hang) [559.433164] Starting subtest: wait-idle-hang [559.435954] Starting dynamic subtest: pipe-A-eDP-1 [586.245549] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.653s) [586.260855] Starting dynamic subtest: pipe-D-eDP-1 [611.201888] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.943s) [611.204706] Subtest wait-idle-hang: SUCCESS (51.601s) [612.006555] [059/131] (439s left) kms_psr (psr2-sprite-mmap-gtt) [612.107344] Starting subtest: psr2-sprite-mmap-gtt [612.110130] Starting dynamic subtest: eDP-1 [613.515214] Dynamic subtest eDP-1: SKIP (1.405s) [613.521301] Subtest psr2-sprite-mmap-gtt: SKIP (1.407s) [613.663454] [060/131] (437s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [613.776822] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [613.781996] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [613.863504] [061/131] (437s left) kms_invalid_mode (zero-clock) [613.966395] Starting subtest: zero-clock [613.969168] Starting dynamic subtest: pipe-A-eDP-1 [614.249074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [614.259537] Starting dynamic subtest: pipe-B-eDP-1 [614.262144] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [614.271042] Starting dynamic subtest: pipe-C-eDP-1 [614.273519] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [614.282228] Starting dynamic subtest: pipe-D-eDP-1 [614.285216] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [614.288092] Subtest zero-clock: SUCCESS (0.286s) [615.054850] [062/131] (436s left) kms_psr (psr-cursor-mmap-gtt) [615.163788] Starting subtest: psr-cursor-mmap-gtt [615.166211] Starting dynamic subtest: eDP-1 [616.844963] Dynamic subtest eDP-1: SUCCESS (1.679s) [616.847670] Subtest psr-cursor-mmap-gtt: SUCCESS (1.680s) [617.708603] [063/131] (433s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [617.815215] Starting subtest: primary-yf-tiled-reflect-x-0 [617.877382] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s) [617.975431] [064/131] (433s left) api_intel_bb (object-noreloc-keep-cache-simple) [618.043493] Starting subtest: object-noreloc-keep-cache-simple [618.049642] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s) [618.183245] [065/131] (433s left) syncobj_wait (wait-all-for-submit-delayed-submit) [618.236200] Starting subtest: wait-all-for-submit-delayed-submit [618.338365] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [618.408062] [066/131] (432s left) sw_sync (sync_busy_fork_unixsocket) [618.447051] Starting subtest: sync_busy_fork_unixsocket [618.456384] Subtest sync_busy_fork_unixsocket: SUCCESS (0.011s) [618.510989] [067/131] (432s left) gem_ctx_create (basic-files) [618.577081] Starting subtest: basic-files [621.230378] Subtest basic-files: SUCCESS (2.651s) [622.502171] [068/131] (428s left) kms_addfb_basic (too-high) [622.603893] Starting subtest: too-high [622.606419] Subtest too-high: SUCCESS (0.000s) [622.718204] [069/131] (428s left) gem_exec_store (pages) [622.789152] Starting subtest: pages [622.791967] Starting dynamic subtest: rcs0 [622.916284] Dynamic subtest rcs0: SUCCESS (0.128s) [622.925466] Starting dynamic subtest: bcs0 [622.991233] Dynamic subtest bcs0: SUCCESS (0.073s) [623.000408] Starting dynamic subtest: vcs0 [623.061048] Dynamic subtest vcs0: SUCCESS (0.069s) [623.071396] Starting dynamic subtest: vcs1 [623.140302] Dynamic subtest vcs1: SUCCESS (0.079s) [623.151399] Starting dynamic subtest: vecs0 [623.212788] Dynamic subtest vecs0: SUCCESS (0.072s) [623.221426] Starting dynamic subtest: ccs0 [623.292138] Dynamic subtest ccs0: SUCCESS (0.072s) [623.295098] Subtest pages: SUCCESS (0.498s) [623.463625] [070/131] (427s left) kms_psr2_su (page_flip-nv12) [623.524216] Subtest page_flip-NV12: SKIP (0.000s) [623.583916] [071/131] (427s left) kms_big_fb (4-tiled-16bpp-rotate-180) [623.695374] Starting subtest: 4-tiled-16bpp-rotate-180 [625.073835] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.379s) [625.202776] [072/131] (426s left) vgem_basic (create) [625.249220] Starting subtest: create [625.251650] Subtest create: SUCCESS (0.000s) [625.298573] [073/131] (426s left) kms_big_fb (y-tiled-addfb-size-overflow) [625.401682] Starting subtest: y-tiled-addfb-size-overflow [625.406367] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [625.505774] [074/131] (426s left) kms_cursor_crc (cursor-random-max-size) [625.787063] Starting subtest: cursor-random-max-size [625.794244] Subtest cursor-random-max-size: SKIP (0.000s) [625.911783] [075/131] (425s left) kms_selftest (drm_format_helper) [625.948621] Starting subtest: drm_format_helper [625.981227] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [626.130763] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.148s) [626.139402] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [626.279774] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.150s) [626.288379] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [626.402063] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.122s) [626.410690] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [626.535212] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.130s) [626.544613] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [626.623889] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.091s) [626.635050] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [626.761888] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.137s) [626.773420] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [626.881252] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.118s) [626.890035] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [626.995633] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.113s) [627.004062] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [627.138153] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.144s) [627.147037] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [627.282938] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.143s) [627.291929] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [627.419943] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.135s) [627.428700] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [627.584244] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.161s) [627.594201] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [627.733638] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.147s) [627.742906] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [627.862210] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.127s) [627.873087] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [628.002996] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.142s) [628.011483] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [628.134854] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.133s) [628.144212] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list [628.278241] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.143s) [628.287040] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [628.418112] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.137s) [628.420402] Subtest drm_format_helper: SUCCESS (2.470s) [628.618106] [076/131] (423s left) kms_plane (pixel-format-source-clamping) [628.721894] Starting subtest: pixel-format-source-clamping [628.760410] Starting dynamic subtest: pipe-A-plane-0 [633.856162] Dynamic subtest pipe-A-plane-0: SUCCESS (5.089s) [633.866115] Starting dynamic subtest: pipe-A-plane-3 [636.129985] Dynamic subtest pipe-A-plane-3: SUCCESS (2.277s) [636.139265] Starting dynamic subtest: pipe-A-plane-5 [636.141882] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [637.209994] Starting dynamic subtest: pipe-B-plane-0 [641.981864] Dynamic subtest pipe-B-plane-0: SUCCESS (4.777s) [641.990445] Starting dynamic subtest: pipe-B-plane-3 [644.261257] Dynamic subtest pipe-B-plane-3: SUCCESS (2.277s) [644.269646] Starting dynamic subtest: pipe-B-plane-5 [644.271800] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [644.567109] Subtest pixel-format-source-clamping: SUCCESS (15.838s) [645.380719] [077/131] (406s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [645.489933] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [645.492211] Starting dynamic subtest: pipe-A-default-mode [646.631126] Dynamic subtest pipe-A-default-mode: SKIP (1.139s) [646.637003] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.140s) [646.800525] [078/131] (404s left) gem_ctx_isolation (preservation) [646.870768] Starting subtest: preservation [646.873448] Starting dynamic subtest: rcs0 [647.137242] Dynamic subtest rcs0: SUCCESS (0.265s) [647.148383] Starting dynamic subtest: bcs0 [647.432417] Dynamic subtest bcs0: SUCCESS (0.294s) [647.444144] Starting dynamic subtest: vcs0 [647.728791] Dynamic subtest vcs0: SUCCESS (0.296s) [647.738038] Starting dynamic subtest: vcs1 [649.710304] Dynamic subtest vcs1: SUCCESS (1.980s) [649.722275] Starting dynamic subtest: vecs0 [651.701640] Dynamic subtest vecs0: SUCCESS (1.991s) [651.713184] Starting dynamic subtest: ccs0 [653.730181] Dynamic subtest ccs0: SUCCESS (2.029s) [653.732999] Subtest preservation: SUCCESS (6.858s) [653.970638] [079/131] (397s left) sysfs_heartbeat_interval (mixed) [654.032293] Starting subtest: mixed [654.035184] Starting dynamic subtest: vecs0 [659.292445] Dynamic subtest vecs0: SUCCESS (5.261s) [659.305402] Starting dynamic subtest: ccs0 [664.507004] Dynamic subtest ccs0: SUCCESS (5.214s) [664.519621] Starting dynamic subtest: vcs0 [669.731391] Dynamic subtest vcs0: SUCCESS (5.223s) [669.743417] Starting dynamic subtest: bcs0 [674.915403] Dynamic subtest bcs0: SUCCESS (5.183s) [674.926877] Starting dynamic subtest: rcs0 [680.087235] Dynamic subtest rcs0: SUCCESS (5.172s) [680.098120] Starting dynamic subtest: vcs1 [685.317289] Dynamic subtest vcs1: SUCCESS (5.228s) [685.320361] Subtest mixed: SUCCESS (31.290s) [685.390381] [080/131] (366s left) syncobj_eventfd (invalid-bad-flags) [685.455655] Starting subtest: invalid-bad-flags [685.458747] Subtest invalid-bad-flags: SUCCESS (0.000s) [685.555622] [081/131] (366s left) perf_pmu (semaphore-wait-idle) [685.594761] Starting subtest: semaphore-wait-idle [685.597384] Starting dynamic subtest: rcs0 [686.109961] Dynamic subtest rcs0: SUCCESS (0.517s) [686.122838] Starting dynamic subtest: bcs0 [686.625694] Dynamic subtest bcs0: SUCCESS (0.514s) [686.639016] Starting dynamic subtest: vcs0 [687.139873] Dynamic subtest vcs0: SUCCESS (0.512s) [687.151241] Starting dynamic subtest: vcs1 [687.654008] Dynamic subtest vcs1: SUCCESS (0.512s) [687.664410] Starting dynamic subtest: vecs0 [688.168954] Dynamic subtest vecs0: SUCCESS (0.512s) [688.181256] Starting dynamic subtest: ccs0 [688.683912] Dynamic subtest ccs0: SUCCESS (0.513s) [688.687017] Subtest semaphore-wait-idle: SUCCESS (3.093s) [688.810663] [082/131] (363s left) syncobj_basic (bad-pad-fd-to-handle) [688.877390] Starting subtest: bad-pad-fd-to-handle [688.880500] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [688.981098] [083/131] (362s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [689.091181] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [693.329189] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.240s) [693.424805] [084/131] (358s left) syncobj_wait (single-wait-all-for-submit-signaled) [693.484283] Starting subtest: single-wait-all-for-submit-signaled [693.487316] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [693.598337] [085/131] (358s left) gem_exec_schedule (smoketest-all) [693.674781] Starting subtest: smoketest-all [726.071937] Subtest smoketest-all: SUCCESS (32.340s) [727.514734] [086/131] (324s left) kms_addfb_basic (legacy-format) [727.577955] Starting subtest: legacy-format [727.597941] Subtest legacy-format: SUCCESS (0.019s) [727.727545] [087/131] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [727.834692] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [727.839765] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [727.920714] [088/131] (324s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [732.899728] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [732.902049] Starting dynamic subtest: pipe-A-eDP-1 [733.699680] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s) [733.713830] Starting dynamic subtest: pipe-B-eDP-1 [734.821246] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s) [734.826644] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.920s) [735.991661] [089/131] (316s left) gem_mmap_offset (isolation) [736.045261] Starting subtest: isolation [736.067011] Subtest isolation: SUCCESS (0.005s) [736.138755] [090/131] (316s left) gem_mmap_wc (write-wc-read-gtt) [736.202314] Subtest write-wc-read-gtt: SKIP (0.000s) [736.259736] [091/131] (315s left) kms_dsc (dsc-with-output-formats-with-bpc) [736.362114] Starting subtest: dsc-with-output-formats-with-bpc [736.431784] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s) [736.467608] [092/131] (315s left) kms_psr (fbc-psr2-no-drrs) [736.572132] Starting subtest: fbc-psr2-no-drrs [736.574783] Starting dynamic subtest: eDP-1 [736.579648] Dynamic subtest eDP-1: SKIP (0.000s) [736.584416] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [736.643376] [093/131] (315s left) perf (non-system-wide-paranoid) [736.751538] Starting subtest: non-system-wide-paranoid [736.787716] Subtest non-system-wide-paranoid: SUCCESS (0.038s) [736.831671] [094/131] (315s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [736.930898] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [736.935144] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [737.012858] [095/131] (315s left) gem_exec_schedule (reorder-wide) [737.203395] Subtest reorder-wide: SKIP (0.000s) [737.373271] [096/131] (314s left) kms_big_fb (linear-64bpp-rotate-270) [737.469670] Starting subtest: linear-64bpp-rotate-270 [737.488212] Subtest linear-64bpp-rotate-270: SKIP (0.018s) [737.595763] [097/131] (314s left) gem_render_copy_redux (flink) [737.645553] Starting subtest: flink [738.537840] Subtest flink: SUCCESS (0.892s) [738.696438] [098/131] (313s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [738.752028] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [738.755104] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [738.830927] [099/131] (313s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [739.403702] Starting subtest: syncobj-stationary-timeline-chain-engines [739.499825] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.097s) [740.472990] [100/131] (312s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [740.570623] Starting subtest: plane-all-transition-nonblocking-fencing [740.572681] Starting dynamic subtest: pipe-A-eDP-1 [743.075319] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s) [743.364916] Starting dynamic subtest: pipe-B-eDP-1 [746.627963] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.272s) [746.908354] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.334s) [747.737696] [101/131] (304s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [747.865400] Starting subtest: cursorA-vs-flipB-varying-size [747.870261] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [747.959432] [102/131] (304s left) gem_fence_thrash (bo-copy) [747.992011] Starting subtest: bo-copy [748.015061] Subtest bo-copy: SKIP (0.021s) [748.075010] [103/131] (304s left) gem_mmap_gtt (cpuset-medium-copy) [748.137764] Subtest cpuset-medium-copy: SKIP (0.000s) [748.190235] [104/131] (304s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [748.315207] Starting subtest: verify-pxp-stale-buf-optout-execution [749.376689] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.062s) [749.512034] [105/131] (303s left) gem_exec_schedule (independent) [749.591013] Starting subtest: independent [749.593400] Starting dynamic subtest: rcs0 [751.491996] Dynamic subtest rcs0: SUCCESS (1.910s) [751.505224] Starting dynamic subtest: vcs0 [753.515364] Dynamic subtest vcs0: SUCCESS (2.021s) [753.528382] Starting dynamic subtest: vcs1 [755.473786] Dynamic subtest vcs1: SUCCESS (1.956s) [755.484935] Starting dynamic subtest: vecs0 [757.455084] Dynamic subtest vecs0: SUCCESS (1.979s) [757.467316] Starting dynamic subtest: ccs0 [759.491795] Dynamic subtest ccs0: SUCCESS (2.034s) [759.494806] Subtest independent: SUCCESS (9.908s) [759.789091] [106/131] (292s left) kms_cursor_crc (cursor-alpha-transparent) [759.888603] Starting subtest: cursor-alpha-transparent [759.890926] Starting dynamic subtest: pipe-A-eDP-1 [760.546320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.657s) [760.557147] Starting dynamic subtest: pipe-D-eDP-1 [761.847794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.300s) [761.850237] Subtest cursor-alpha-transparent: SUCCESS (1.959s) [762.693719] [107/131] (290s left) kms_universal_plane (universal-plane-functional) [762.800377] Starting subtest: universal-plane-functional [762.803109] Starting dynamic subtest: pipe-A-eDP-1 [766.617002] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.814s) [766.626927] Starting dynamic subtest: pipe-B-eDP-1 [770.998777] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.378s) [771.008421] Starting dynamic subtest: pipe-C-eDP-1 [775.237128] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.237s) [775.247882] Starting dynamic subtest: pipe-D-eDP-1 [779.415747] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.177s) [779.418294] Subtest universal-plane-functional: SUCCESS (16.611s) [780.208189] [108/131] (272s left) gem_exec_async (forked-writes) [780.286183] Starting subtest: forked-writes [780.288925] Starting dynamic subtest: rcs0 [780.319026] Dynamic subtest rcs0: SUCCESS (0.032s) [780.330659] Starting dynamic subtest: bcs0 [780.345451] Dynamic subtest bcs0: SUCCESS (0.026s) [780.355621] Starting dynamic subtest: vcs0 [780.373419] Dynamic subtest vcs0: SUCCESS (0.027s) [780.383390] Starting dynamic subtest: vcs1 [780.402503] Dynamic subtest vcs1: SUCCESS (0.029s) [780.412545] Starting dynamic subtest: vecs0 [780.430394] Dynamic subtest vecs0: SUCCESS (0.027s) [780.441798] Starting dynamic subtest: ccs0 [780.457823] Dynamic subtest ccs0: SUCCESS (0.027s) [780.460406] Subtest forked-writes: SUCCESS (0.172s) [780.689924] [109/131] (272s left) gem_ringfill (engines-basic) [786.440430] Starting subtest: engines-basic [786.443410] Starting dynamic subtest: rcs0 [786.514434] Dynamic subtest rcs0: SUCCESS (0.075s) [786.526447] Starting dynamic subtest: bcs0 [786.561438] Dynamic subtest bcs0: SUCCESS (0.045s) [786.572161] Starting dynamic subtest: vcs0 [786.605318] Dynamic subtest vcs0: SUCCESS (0.042s) [786.615251] Starting dynamic subtest: vcs1 [786.650277] Dynamic subtest vcs1: SUCCESS (0.043s) [786.660372] Starting dynamic subtest: vecs0 [786.694393] Dynamic subtest vecs0: SUCCESS (0.043s) [786.704175] Starting dynamic subtest: ccs0 [786.741659] Dynamic subtest ccs0: SUCCESS (0.046s) [786.744304] Subtest engines-basic: SUCCESS (0.304s) [786.814888] [110/131] (266s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [786.928070] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [786.930707] Starting dynamic subtest: pipe-A-eDP-1 [787.789295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.850s) [787.800355] Starting dynamic subtest: pipe-B-eDP-1 [789.313840] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.524s) [789.324352] Starting dynamic subtest: pipe-C-eDP-1 [790.815353] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s) [790.825367] Starting dynamic subtest: pipe-D-eDP-1 [792.238991] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s) [792.241273] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.301s) [793.409747] [111/131] (259s left) kms_chamelium_color (ctm-green-to-red) [793.503946] Subtest ctm-green-to-red: SKIP (0.000s) [793.544712] [112/131] (259s left) sw_sync (alloc_merge_fence) [793.585257] Starting subtest: alloc_merge_fence [793.587796] Subtest alloc_merge_fence: SUCCESS (0.000s) [793.635445] [113/131] (259s left) gem_exec_flush (basic-batch-kernel-default-wb) [793.699975] Starting subtest: basic-batch-kernel-default-wb [799.436539] Subtest basic-batch-kernel-default-wb: SUCCESS (5.740s) [799.622295] [114/131] (253s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [799.735652] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [799.741195] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [799.844653] [115/131] (253s left) kms_cursor_crc (cursor-rapid-movement-max-size) [800.142402] Starting subtest: cursor-rapid-movement-max-size [800.151510] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [800.278749] [116/131] (252s left) kms_properties (connector-properties-atomic) [800.373743] Starting subtest: connector-properties-atomic [800.376051] Starting dynamic subtest: pipe-A-eDP-1 [808.059373] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.682s) [808.069410] Starting dynamic subtest: pipe-None-DP-1 [808.074701] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [808.082990] Starting dynamic subtest: pipe-None-HDMI-A-1 [808.088228] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [808.097084] Starting dynamic subtest: pipe-None-DP-2 [808.102158] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [808.111164] Starting dynamic subtest: pipe-None-HDMI-A-2 [808.116275] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [808.125042] Starting dynamic subtest: pipe-None-DP-3 [808.130212] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [808.139365] Starting dynamic subtest: pipe-None-DP-4 [808.144841] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [808.147285] Subtest connector-properties-atomic: SUCCESS (7.694s) [808.918655] [117/131] (244s left) kms_psr (pr-cursor-plane-onoff) [809.018243] Starting subtest: pr-cursor-plane-onoff [809.024152] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [809.090182] [118/131] (244s left) gem_softpin (evict-single-offset) [809.164165] Starting subtest: evict-single-offset [836.483822] Subtest evict-single-offset: SUCCESS (27.318s) [836.564574] [119/131] (216s left) kms_pwrite_crc [838.235725] [120/131] (214s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [843.289285] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [843.295060] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [844.137227] [121/131] (209s left) kms_pm_rpm (modeset-non-lpsp-stress) [845.684771] Starting subtest: modeset-non-lpsp-stress [846.842033] Subtest modeset-non-lpsp-stress: SKIP (1.154s) [847.185949] [122/131] (206s left) drm_fdinfo (virtual-busy-all) [847.229376] Starting subtest: virtual-busy-all [847.235154] Subtest virtual-busy-all: SKIP (0.000s) [847.298758] [123/131] (206s left) gem_create (create-valid-nonaligned) [847.363371] Starting subtest: create-valid-nonaligned [847.366140] Subtest create-valid-nonaligned: SUCCESS (0.000s) [847.547733] [124/131] (205s left) syncobj_eventfd (timeline-wait-signaled) [847.617647] Starting subtest: timeline-wait-signaled [847.620683] Subtest timeline-wait-signaled: SUCCESS (0.000s) [847.730384] [125/131] (205s left) kms_atomic_interruptible (legacy-dpms) [847.830190] Starting subtest: legacy-dpms [847.832868] Starting dynamic subtest: pipe-A-eDP-1 [855.190980] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.359s) [855.193362] Subtest legacy-dpms: SUCCESS (7.360s) [856.020656] [126/131] (197s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [856.122823] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [856.127724] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [857.260500] [127/131] (196s left) drm_fdinfo (memory-info-idle) [857.301137] Starting subtest: memory-info-idle [857.303841] Starting dynamic subtest: smem0 [857.378117] Dynamic subtest smem0: SUCCESS (0.077s) [857.381384] Subtest memory-info-idle: SUCCESS (0.078s) [857.454227] [128/131] (196s left) syncobj_timeline (invalid-transfer-bad-pad) [857.518254] Starting subtest: invalid-transfer-bad-pad [857.521141] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [857.607961] [129/131] (195s left) gem_eio (suspend) [857.843111] Starting subtest: suspend [869.722145] Subtest suspend: SUCCESS (11.879s) [869.877883] [130/131] (183s left) gem_exec_fence (basic-wait) [870.054036] Starting subtest: basic-wait [870.056684] Starting dynamic subtest: rcs0 [870.164145] Dynamic subtest rcs0: SUCCESS (0.110s) [870.176113] Starting dynamic subtest: bcs0 [870.232281] Dynamic subtest bcs0: SUCCESS (0.066s) [870.243173] Starting dynamic subtest: vcs0 [870.303908] Dynamic subtest vcs0: SUCCESS (0.070s) [870.314423] Starting dynamic subtest: vcs1 [870.360131] Dynamic subtest vcs1: SUCCESS (0.055s) [870.371592] Starting dynamic subtest: vecs0 [870.415425] Dynamic subtest vecs0: SUCCESS (0.053s) [870.426669] Starting dynamic subtest: ccs0 [870.480663] Dynamic subtest ccs0: SUCCESS (0.063s) [870.483500] Subtest basic-wait: SUCCESS (0.427s) [872.550149] [131/131] (181s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [872.610620] Starting subtest: etime-single-wait-all-available-unsubmitted [872.718727] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.108s) [872.788711] Closing watchdogs results: parsing output: 0/ for test: api_intel_allocator results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cdclk results: parsing output: 3/ for test: kms_plane_scaling results: parsing output: 4/ for test: gen9_exec_parse results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_ctx_persistence results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: kms_busy results: parsing output: 9/ for test: kms_cursor_legacy results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: i915_selftest results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: kms_chamelium_hpd results: parsing output: 15/ for test: kms_lease results: parsing output: 16/ for test: gem_lmem_swapping results: parsing output: 17/ for test: gem_tiled_blits results: parsing output: 18/ for test: i915_pm_rpm results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: gem_ctx_isolation results: parsing output: 23/ for test: kms_flip_scaled_crc 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: i915_module_load results: parsing output: 28/ for test: syncobj_wait results: parsing output: 29/ for test: gem_vm_create results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: perf_pmu results: parsing output: 32/ for test: kms_pipe_crc_basic results: parsing output: 33/ for test: kms_flip results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_cursor_edge_walk results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: gem_exec_whisper results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_properties results: parsing output: 42/ for test: vgem_basic results: parsing output: 43/ for test: kms_plane_lowres results: parsing output: 44/ for test: kms_addfb_basic results: parsing output: 45/ for test: core_getstats results: parsing output: 46/ for test: gem_bad_reloc results: parsing output: 47/ for test: kms_addfb_basic results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_exec_balancer results: parsing output: 52/ for test: kms_plane_scaling results: parsing output: 53/ for test: kms_chamelium_hpd results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_fbcon_fbt results: parsing output: 56/ for test: drm_read results: parsing output: 57/ for test: kms_vblank results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_invalid_mode results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: kms_rotation_crc results: parsing output: 63/ for test: api_intel_bb results: parsing output: 64/ for test: syncobj_wait results: parsing output: 65/ for test: sw_sync results: parsing output: 66/ for test: gem_ctx_create results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: gem_exec_store results: parsing output: 69/ for test: kms_psr2_su results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: vgem_basic results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_cursor_crc results: parsing output: 74/ for test: kms_selftest results: parsing output: 75/ for test: kms_plane results: parsing output: 76/ for test: kms_flip_scaled_crc results: parsing output: 77/ for test: gem_ctx_isolation results: parsing output: 78/ for test: sysfs_heartbeat_interval results: parsing output: 79/ for test: syncobj_eventfd results: parsing output: 80/ for test: perf_pmu results: parsing output: 81/ for test: syncobj_basic results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: syncobj_wait results: parsing output: 84/ for test: gem_exec_schedule results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_psr2_sf results: parsing output: 88/ for test: gem_mmap_offset results: parsing output: 89/ for test: gem_mmap_wc results: parsing output: 90/ for test: kms_dsc results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: perf results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_exec_schedule results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: gem_render_copy_redux results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: gem_exec_fence results: parsing output: 99/ for test: kms_atomic_transition results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: gem_fence_thrash results: parsing output: 102/ for test: gem_mmap_gtt results: parsing output: 103/ for test: gem_pxp results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_universal_plane results: parsing output: 107/ for test: gem_exec_async results: parsing output: 108/ for test: gem_ringfill results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: kms_chamelium_color results: parsing output: 111/ for test: sw_sync results: parsing output: 112/ for test: gem_exec_flush results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_cursor_crc results: parsing output: 115/ for test: kms_properties results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: gem_softpin results: parsing output: 118/ for test: kms_pwrite_crc results: parsing output: 119/ for test: kms_psr2_sf results: parsing output: 120/ for test: kms_pm_rpm results: parsing output: 121/ for test: drm_fdinfo results: parsing output: 122/ for test: gem_create results: parsing output: 123/ for test: syncobj_eventfd results: parsing output: 124/ for test: kms_atomic_interruptible results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: drm_fdinfo results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: gem_eio results: parsing output: 129/ for test: gem_exec_fence results: parsing output: 130/ for test: syncobj_timeline Done.