[63.161355] Initializing watchdogs [63.161402] /dev/watchdog0 [63.176420] [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] [63.180870] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.183571] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.185517] [001/133] (960s left) kms_big_fb (4-tiled-16bpp-rotate-90) [63.292164] Starting subtest: 4-tiled-16bpp-rotate-90 [63.327428] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.035s) [63.444232] [002/133] (960s left) kms_chamelium_audio (hdmi-audio) [63.815907] Subtest hdmi-audio: SKIP (0.000s) [64.615938] [003/133] (959s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [64.702238] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [64.704214] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [64.767648] [004/133] (959s left) gem_mmap_wc (coherency) [64.815641] Subtest coherency: SKIP (0.000s) [64.872262] [005/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [64.964352] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [64.966106] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [65.063491] [006/133] (958s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [65.164141] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [65.165865] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [65.271838] [007/133] (958s left) kms_pm_rpm (package-g7) [67.020607] Starting subtest: package-g7 [67.023067] Subtest package-g7: SKIP (0.000s) [67.578727] [008/133] (956s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [67.732030] Starting subtest: blocking-absolute-wf_vblank-interruptible [67.735028] Starting dynamic subtest: A-eDP1 [76.434343] Dynamic subtest A-eDP1: SUCCESS (8.688s) [76.442213] Starting dynamic subtest: B-eDP1 [85.145319] Dynamic subtest B-eDP1: SUCCESS (8.734s) [85.152466] Starting dynamic subtest: C-eDP1 [93.900050] Dynamic subtest C-eDP1: SUCCESS (8.716s) [93.908590] Starting dynamic subtest: D-eDP1 [102.643327] Dynamic subtest D-eDP1: SUCCESS (8.742s) [102.644336] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.888s) [103.811949] [009/133] (920s left) kms_async_flips (async-flip-hang) [103.899415] Starting subtest: async-flip-hang [104.273084] Starting dynamic subtest: pipe-A-eDP-1 [119.412835] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.138s) [119.784221] Starting dynamic subtest: pipe-B-eDP-1 [135.345736] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.566s) [135.739492] Starting dynamic subtest: pipe-C-eDP-1 [151.407979] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.670s) [151.791571] Starting dynamic subtest: pipe-D-eDP-1 [167.344452] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.556s) [167.345340] Subtest async-flip-hang: SUCCESS (63.441s) [168.586930] [010/133] (855s left) kms_sequence (queue-busy) [168.679017] Starting subtest: queue-busy [168.680036] Starting dynamic subtest: pipe-A-eDP-1 [170.614439] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [170.623971] Starting dynamic subtest: pipe-B-eDP-1 [173.172136] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.557s) [173.178672] Starting dynamic subtest: pipe-C-eDP-1 [175.802777] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.630s) [175.812850] Starting dynamic subtest: pipe-D-eDP-1 [178.431478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s) [178.432467] Subtest queue-busy: SUCCESS (9.752s) [179.234159] [011/133] (844s left) syncobj_eventfd (invalid-bad-pad) [179.281923] Starting subtest: invalid-bad-pad [179.282911] Subtest invalid-bad-pad: SUCCESS (0.000s) [179.374783] [012/133] (844s left) gem_userptr_blits (huge-split) [179.446292] Starting subtest: huge-split [179.453027] Subtest huge-split: SUCCESS (0.007s) [179.550884] [013/133] (844s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [179.638596] Starting subtest: psr-shrfb-scaledprimary [185.426028] Subtest psr-shrfb-scaledprimary: SUCCESS (5.789s) [185.543471] [014/133] (838s left) api_intel_allocator (reopen) [185.593168] Starting subtest: reopen [185.596737] Subtest reopen: SUCCESS (0.004s) [185.709130] [015/133] (838s left) gem_exec_fence (expired-history) [186.150277] Starting subtest: expired-history [193.675799] Subtest expired-history: SUCCESS (7.516s) [194.213285] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true [194.215459] [016/133] (829s left) kms_chamelium_frames (dp-crc-fast) [194.607365] Subtest dp-crc-fast: SKIP (0.000s) [195.453475] [017/133] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [195.545675] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [195.547479] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [195.638359] [018/133] (828s left) syncobj_wait (wait-for-submit-complex) [195.690350] Starting subtest: wait-for-submit-complex [195.752411] Subtest wait-for-submit-complex: SUCCESS (0.062s) [195.819777] [019/133] (828s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [195.914259] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [195.926103] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [195.995625] [020/133] (828s left) prime_vgem (sync) [196.061827] Starting subtest: sync [196.062881] Starting dynamic subtest: rcs0 [196.103324] Dynamic subtest rcs0: SUCCESS (0.041s) [196.110325] Starting dynamic subtest: bcs0 [196.178671] Dynamic subtest bcs0: SUCCESS (0.075s) [196.184718] Starting dynamic subtest: vcs0 [196.230992] Dynamic subtest vcs0: SUCCESS (0.051s) [196.237405] Starting dynamic subtest: vcs1 [196.276396] Dynamic subtest vcs1: SUCCESS (0.044s) [196.282528] Starting dynamic subtest: vecs0 [196.321937] Dynamic subtest vecs0: SUCCESS (0.045s) [196.328343] Starting dynamic subtest: ccs0 [196.369126] Dynamic subtest ccs0: SUCCESS (0.047s) [196.369944] Subtest sync: SUCCESS (0.308s) [196.482595] [021/133] (827s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [196.579978] Starting subtest: plane-lut1d-pre-ctm3x4 [196.732807] Starting dynamic subtest: pipe-A-plane-0 [196.933412] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s) [196.942598] Starting dynamic subtest: pipe-A-plane-1 [197.133274] Dynamic subtest pipe-A-plane-1: SUCCESS (0.200s) [197.144293] Starting dynamic subtest: pipe-A-plane-2 [197.321885] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [198.492790] Starting dynamic subtest: pipe-B-plane-0 [198.664086] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [198.671454] Starting dynamic subtest: pipe-B-plane-1 [198.831036] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [198.837430] Starting dynamic subtest: pipe-B-plane-2 [198.997761] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [200.232947] Starting dynamic subtest: pipe-C-plane-0 [200.370512] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [200.377248] Starting dynamic subtest: pipe-C-plane-1 [200.515060] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [200.521688] Starting dynamic subtest: pipe-C-plane-2 [200.659573] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [201.847997] Starting dynamic subtest: pipe-D-plane-0 [201.986664] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [201.993392] Starting dynamic subtest: pipe-D-plane-1 [202.130863] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s) [202.137714] Starting dynamic subtest: pipe-D-plane-2 [202.275475] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [202.575686] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.995s) [203.417461] [022/133] (820s left) kms_addfb_basic (size-max) [203.499516] Starting subtest: size-max [203.500540] Subtest size-max: SUCCESS (0.000s) [203.586428] [023/133] (820s left) gem_mmap_wc (invalid-flags) [203.631876] Subtest invalid-flags: SKIP (0.000s) [203.693121] [024/133] (820s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [203.785258] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [210.453310] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.668s) [210.560961] [025/133] (813s left) syncobj_basic (bad-destroy) [210.614908] Starting subtest: bad-destroy [210.615758] Subtest bad-destroy: SUCCESS (0.000s) [210.719735] [026/133] (813s left) gem_exec_async (concurrent-writes) [210.777622] Starting subtest: concurrent-writes [210.778657] Starting dynamic subtest: rcs0 [210.796596] Dynamic subtest rcs0: SUCCESS (0.019s) [210.806890] Starting dynamic subtest: bcs0 [210.807820] Dynamic subtest bcs0: SUCCESS (0.007s) [210.814676] Starting dynamic subtest: vcs0 [210.815684] Dynamic subtest vcs0: SUCCESS (0.005s) [210.822653] Starting dynamic subtest: vcs1 [210.823661] Dynamic subtest vcs1: SUCCESS (0.006s) [210.830248] Starting dynamic subtest: vecs0 [210.831088] Dynamic subtest vecs0: SUCCESS (0.006s) [210.837047] Starting dynamic subtest: ccs0 [210.837878] Dynamic subtest ccs0: SUCCESS (0.007s) [210.838746] Subtest concurrent-writes: SUCCESS (0.053s) [211.063092] [027/133] (813s left) kms_plane_multiple (tiling-yf) [211.162758] Starting subtest: tiling-yf [211.164573] Subtest tiling-yf: SKIP (0.000s) [211.228287] [028/133] (813s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [211.317970] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [218.379092] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.062s) [218.511739] [029/133] (806s left) kms_joiner (basic-big-joiner) [218.597920] Starting subtest: basic-big-joiner [218.599622] Subtest basic-big-joiner: SKIP (0.000s) [218.677345] [030/133] (805s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [218.767424] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [219.791249] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.024s) [219.895552] [031/133] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [219.976330] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [219.978351] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [220.065449] [032/133] (804s left) device_reset (cold-reset-bound) [220.110905] Starting subtest: cold-reset-bound [220.112764] Subtest cold-reset-bound: SKIP (0.000s) [220.177582] [033/133] (804s left) kms_cursor_crc (cursor-random-32x32) [220.313053] Starting subtest: cursor-random-32x32 [220.356719] Subtest cursor-random-32x32: SKIP (0.043s) [220.619976] [034/133] (804s left) kms_big_fb (linear-8bpp-rotate-0) [220.715174] Starting subtest: linear-8bpp-rotate-0 [221.950615] Subtest linear-8bpp-rotate-0: SUCCESS (1.236s) [222.091066] [035/133] (802s left) kms_psr (fbc-psr-cursor-render) [222.189617] Starting subtest: fbc-psr-cursor-render [222.190524] Starting dynamic subtest: eDP-1 [222.192279] Dynamic subtest eDP-1: SKIP (0.000s) [222.193914] Subtest fbc-psr-cursor-render: SKIP (0.001s) [222.275708] [036/133] (802s left) i915_drm_fdinfo (virtual-busy-all) [222.312222] Starting subtest: virtual-busy-all [222.314426] Subtest virtual-busy-all: SKIP (0.000s) [222.369639] [037/133] (802s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [222.412687] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [222.413762] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [222.498627] [038/133] (802s left) api_intel_bb (delta-check) [222.557516] Starting subtest: delta-check [222.562274] Subtest delta-check: SUCCESS (0.006s) [222.694933] [039/133] (802s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [222.755308] Starting subtest: mixed-tiled-to-y-tiled-ccs [222.757032] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [222.941394] [040/133] (802s left) gem_lmem_swapping (smem-oom) [222.977553] Subtest smem-oom: SKIP (0.000s) [223.016739] [041/133] (801s left) i915_hangman (engine-error-state-capture) [223.081859] Starting subtest: engine-error-state-capture [223.082849] Starting dynamic subtest: rcs0 [226.877540] Dynamic subtest rcs0: SUCCESS (3.787s) [226.886427] Starting dynamic subtest: bcs0 [232.892882] Dynamic subtest bcs0: SUCCESS (6.013s) [232.902415] Starting dynamic subtest: vcs0 [238.846515] Dynamic subtest vcs0: SUCCESS (5.950s) [238.855572] Starting dynamic subtest: vcs1 [243.837305] Dynamic subtest vcs1: SUCCESS (4.989s) [243.846084] Starting dynamic subtest: vecs0 [249.917871] Dynamic subtest vecs0: SUCCESS (6.078s) [249.927561] Starting dynamic subtest: ccs0 [255.868881] Dynamic subtest ccs0: SUCCESS (5.948s) [255.870321] Subtest engine-error-state-capture: SUCCESS (32.779s) [255.999744] [042/133] (769s left) gem_mmap_offset (isolation) [256.048241] Starting subtest: isolation [256.056087] Subtest isolation: SUCCESS (0.006s) [256.158096] [043/133] (768s left) kms_flip (2x-dpms-vs-vblank-race) [256.241552] Starting subtest: 2x-dpms-vs-vblank-race [256.252235] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [256.343513] [044/133] (768s left) syncobj_timeline (host-signal-ordered) [256.388344] Starting subtest: host-signal-ordered [256.389219] Subtest host-signal-ordered: SUCCESS (0.000s) [256.479225] [045/133] (768s left) gem_exec_params (invalid-batch-start-offset) [256.534689] Starting subtest: invalid-batch-start-offset [256.535702] Subtest invalid-batch-start-offset: SUCCESS (0.003s) [256.662333] [046/133] (768s left) gem_ctx_isolation (dirty-switch) [256.712448] Starting subtest: dirty-switch [256.713521] Starting dynamic subtest: rcs0 [256.895145] Dynamic subtest rcs0: SUCCESS (0.183s) [256.904882] Starting dynamic subtest: bcs0 [257.111359] Dynamic subtest bcs0: SUCCESS (0.215s) [257.120583] Starting dynamic subtest: vcs0 [257.325746] Dynamic subtest vcs0: SUCCESS (0.214s) [257.332627] Starting dynamic subtest: vcs1 [259.094866] Dynamic subtest vcs1: SUCCESS (1.768s) [259.103541] Starting dynamic subtest: vecs0 [261.089099] Dynamic subtest vecs0: SUCCESS (1.993s) [261.098063] Starting dynamic subtest: ccs0 [263.165298] Dynamic subtest ccs0: SUCCESS (2.075s) [263.166351] Subtest dirty-switch: SUCCESS (6.453s) [263.395808] [047/133] (761s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [263.487364] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [263.498852] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s) [263.567695] [048/133] (761s left) kms_draw_crc (fill-fb) [263.654191] Starting subtest: fill-fb [264.162543] Subtest fill-fb: SUCCESS (0.509s) [264.263166] [049/133] (760s left) kms_atomic_transition (modeset-transition-fencing) [264.350927] Starting subtest: modeset-transition-fencing [264.351901] Starting dynamic subtest: 1x-outputs [275.227044] Dynamic subtest 1x-outputs: SUCCESS (10.876s) [275.228353] Subtest modeset-transition-fencing: SUCCESS (10.877s) [276.079404] [050/133] (749s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [276.190508] Starting subtest: cursorB-vs-flipB-atomic-transitions [276.192384] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [276.328446] [051/133] (748s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [276.394734] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [276.396541] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [276.597727] [052/133] (748s left) kms_mmap_write_crc (main) [276.677621] Starting subtest: main [276.678517] Starting dynamic subtest: pipe-A-eDP-1 [280.156324] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s) [280.157226] Subtest main: SUCCESS (3.478s) [281.012730] [053/133] (744s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [281.068338] Starting subtest: multi-wait-available-unsubmitted-submitted [281.069216] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [281.170154] [054/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [281.262940] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [281.264710] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [281.372647] [055/133] (744s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [281.461716] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [288.543083] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.081s) [288.660536] [056/133] (736s left) gem_tiled_partial_pwrite_pread (reads) [288.712327] Subtest reads: SKIP (0.000s) [288.760784] [057/133] (736s left) kms_cursor_crc (cursor-sliding-64x64) [288.926746] Starting subtest: cursor-sliding-64x64 [288.938511] Starting dynamic subtest: pipe-A-eDP-1 [292.171288] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.237s) [292.207631] Starting dynamic subtest: pipe-D-eDP-1 [296.116780] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.923s) [296.117867] Subtest cursor-sliding-64x64: SUCCESS (7.189s) [296.912479] [058/133] (728s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [297.003481] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [297.004403] Starting dynamic subtest: pipe-A-eDP-1 [297.027450] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [297.034719] Starting dynamic subtest: pipe-B-eDP-1 [297.057198] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [297.063792] Starting dynamic subtest: pipe-C-eDP-1 [297.085179] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [297.091677] Starting dynamic subtest: pipe-D-eDP-1 [297.112831] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [297.114502] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s) [299.304679] [059/133] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [299.386177] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [299.387928] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [299.476928] [060/133] (726s left) perf (non-system-wide-paranoid) [299.589983] Starting subtest: non-system-wide-paranoid [299.617916] Subtest non-system-wide-paranoid: SUCCESS (0.029s) [299.662414] [061/133] (725s left) kms_busy (extended-pageflip-hang-newfb) [299.749918] Starting subtest: extended-pageflip-hang-newfb [299.750854] Starting dynamic subtest: pipe-A [325.732366] Dynamic subtest pipe-A: SUCCESS (25.981s) [325.740615] Starting dynamic subtest: pipe-D [340.711358] Dynamic subtest pipe-D: SUCCESS (14.976s) [340.712237] Subtest extended-pageflip-hang-newfb: SUCCESS (40.961s) [341.546483] [062/133] (684s left) kms_psr (psr2-cursor-blt) [341.639641] Starting subtest: psr2-cursor-blt [341.640615] Starting dynamic subtest: eDP-1 [343.342203] Dynamic subtest eDP-1: SUCCESS (1.702s) [343.343104] Subtest psr2-cursor-blt: SUCCESS (1.703s) [344.133854] [063/133] (681s left) gen9_exec_parse (batch-without-end) [344.185660] Subtest batch-without-end: SKIP (0.000s) [344.244897] [064/133] (681s left) kms_lease (setcrtc-implicit-plane) [344.327185] Starting subtest: setcrtc-implicit-plane [344.327964] Starting dynamic subtest: pipe-A-eDP-1 [344.795506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s) [344.803242] Starting dynamic subtest: pipe-B-eDP-1 [345.972544] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.174s) [345.980305] Starting dynamic subtest: pipe-C-eDP-1 [347.085234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s) [347.092240] Starting dynamic subtest: pipe-D-eDP-1 [348.230074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s) [348.230977] Subtest setcrtc-implicit-plane: SUCCESS (3.902s) [349.076555] [065/133] (676s left) gem_exec_fence (syncobj-timeline-repeat) [349.682984] Starting subtest: syncobj-timeline-repeat [349.931180] Subtest syncobj-timeline-repeat: SUCCESS (0.248s) [350.939772] [066/133] (674s left) gem_exec_schedule (promotion) [351.012478] Starting subtest: promotion [351.013437] Starting dynamic subtest: rcs0 [351.136604] Dynamic subtest rcs0: SUCCESS (0.122s) [351.146801] Starting dynamic subtest: vcs0 [351.226872] Dynamic subtest vcs0: SUCCESS (0.090s) [351.236727] Starting dynamic subtest: vcs1 [351.307339] Dynamic subtest vcs1: SUCCESS (0.080s) [351.316700] Starting dynamic subtest: vecs0 [351.392501] Dynamic subtest vecs0: SUCCESS (0.085s) [351.402323] Starting dynamic subtest: ccs0 [351.484481] Dynamic subtest ccs0: SUCCESS (0.091s) [351.485937] Subtest promotion: SUCCESS (0.473s) [352.986894] [067/133] (672s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [353.031888] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [353.033167] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [353.150067] [068/133] (672s left) gem_ccs (ctrl-surf-copy) [353.203488] Starting subtest: ctrl-surf-copy [353.205751] Subtest ctrl-surf-copy: SKIP (0.000s) [353.296212] [069/133] (672s left) syncobj_timeline (transfer-timeline-point) [353.358249] Starting subtest: transfer-timeline-point [353.359140] Subtest transfer-timeline-point: SUCCESS (0.000s) [353.446319] [070/133] (672s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [353.547231] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [353.548999] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [353.643858] [071/133] (672s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [353.749558] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [353.751483] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [353.814170] [072/133] (672s left) kms_vrr (flip-suspend) [353.908077] Starting subtest: flip-suspend [353.910826] Subtest flip-suspend: SKIP (0.000s) [353.978482] [073/133] (672s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [354.065602] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [354.067047] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [354.151972] [074/133] (671s left) gem_exec_whisper (basic-normal-all) [354.218841] Starting subtest: basic-normal-all [356.481144] Subtest basic-normal-all: SUCCESS (2.261s) [356.662161] [075/133] (669s left) kms_psr (psr2-cursor-plane-move) [356.763999] Starting subtest: psr2-cursor-plane-move [356.765043] Starting dynamic subtest: eDP-1 [358.446510] Dynamic subtest eDP-1: SUCCESS (1.684s) [358.447426] Subtest psr2-cursor-plane-move: SUCCESS (1.685s) [359.235514] [076/133] (666s left) kms_cursor_legacy (flip-vs-cursor-legacy) [359.352645] Starting subtest: flip-vs-cursor-legacy [366.566846] Subtest flip-vs-cursor-legacy: SUCCESS (7.213s) [367.370953] [077/133] (658s left) gem_ctx_persistence (heartbeat-many) [367.426047] Starting subtest: heartbeat-many [367.428248] Subtest heartbeat-many: SKIP (0.000s) [367.514575] [078/133] (658s left) kms_psr (fbc-psr2-cursor-plane-move) [367.604266] Starting subtest: fbc-psr2-cursor-plane-move [367.605046] Starting dynamic subtest: eDP-1 [367.606890] Dynamic subtest eDP-1: SKIP (0.000s) [367.608660] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [367.673092] [079/133] (658s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [367.753203] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [367.754024] Starting dynamic subtest: pipe-A-eDP-1 [367.757478] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [367.765021] Starting dynamic subtest: pipe-B-eDP-1 [367.768673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [367.777830] Starting dynamic subtest: pipe-C-eDP-1 [367.781082] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [367.788116] Starting dynamic subtest: pipe-D-eDP-1 [367.791170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [367.792670] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s) [370.020518] [080/133] (656s left) i915_pm_rpm (gem-execbuf-stress-pc8) [372.055180] Starting subtest: gem-execbuf-stress-pc8 [372.089961] Subtest gem-execbuf-stress-pc8: SKIP (0.037s) [372.428780] [081/133] (653s left) gem_exec_schedule (in-order) [372.492596] Starting subtest: in-order [372.493510] Starting dynamic subtest: rcs0 [372.598469] Dynamic subtest rcs0: SUCCESS (0.105s) [372.608794] Starting dynamic subtest: vcs0 [372.680998] Dynamic subtest vcs0: SUCCESS (0.081s) [372.692058] Starting dynamic subtest: vcs1 [372.770357] Dynamic subtest vcs1: SUCCESS (0.089s) [372.781954] Starting dynamic subtest: vecs0 [372.860899] Dynamic subtest vecs0: SUCCESS (0.090s) [372.874026] Starting dynamic subtest: ccs0 [372.965844] Dynamic subtest ccs0: SUCCESS (0.102s) [372.967752] Subtest in-order: SUCCESS (0.473s) [373.997595] [082/133] (652s left) kms_addfb_basic (no-handle) [374.061799] Starting subtest: no-handle [374.062790] Subtest no-handle: SUCCESS (0.000s) [374.207045] [083/133] (652s left) gem_eio (in-flight-internal-1us) [374.437600] Starting subtest: in-flight-internal-1us [375.975752] Subtest in-flight-internal-1us: SUCCESS (1.540s) [376.122007] [084/133] (650s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [376.207400] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [376.208260] Starting dynamic subtest: pipe-A-eDP-1 [376.216378] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [376.224333] Starting dynamic subtest: pipe-B-eDP-1 [376.232645] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [376.240275] Starting dynamic subtest: pipe-C-eDP-1 [376.248327] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [376.256087] Starting dynamic subtest: pipe-D-eDP-1 [376.264623] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [376.266240] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s) [378.483580] [085/133] (647s left) kms_rotation_crc (cursor-rotation-180) [378.577378] Starting subtest: cursor-rotation-180 [380.075542] Subtest cursor-rotation-180: SUCCESS (1.498s) [381.245177] [086/133] (645s left) kms_flip (modeset-vs-vblank-race) [381.330378] Starting subtest: modeset-vs-vblank-race [381.331272] Starting dynamic subtest: A-eDP1 [386.073773] Dynamic subtest A-eDP1: SUCCESS (4.742s) [386.085163] Starting dynamic subtest: B-eDP1 [390.810098] Dynamic subtest B-eDP1: SUCCESS (4.733s) [390.820192] Starting dynamic subtest: C-eDP1 [395.509410] Dynamic subtest C-eDP1: SUCCESS (4.697s) [395.520088] Starting dynamic subtest: D-eDP1 [400.060322] Dynamic subtest D-eDP1: SUCCESS (4.548s) [400.065100] Subtest modeset-vs-vblank-race: SUCCESS (18.735s) [401.207704] [087/133] (625s left) kms_pm_dc (dc5-dpms) [402.306546] Starting subtest: dc5-dpms [404.400078] Subtest dc5-dpms: SUCCESS (2.083s) [404.460642] [088/133] (622s left) gem_exec_params (invalid-bsd2-flag-on-blt) [404.509556] Starting subtest: invalid-bsd2-flag-on-blt [404.510462] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [404.599623] [089/133] (621s left) i915_suspend (fence-restore-untiled) [404.642775] Starting subtest: fence-restore-untiled [404.644596] Subtest fence-restore-untiled: SKIP (0.000s) [404.732441] [090/133] (621s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [404.815999] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [404.817906] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [404.914115] [091/133] (621s left) gem_spin_batch (resubmit) [404.962606] Starting subtest: resubmit [404.963550] Starting dynamic subtest: rcs0 [404.967219] Dynamic subtest rcs0: SUCCESS (0.006s) [404.975481] Starting dynamic subtest: bcs0 [404.976297] Dynamic subtest bcs0: SUCCESS (0.002s) [404.984033] Starting dynamic subtest: vcs0 [404.984889] Dynamic subtest vcs0: SUCCESS (0.002s) [404.992086] Starting dynamic subtest: vcs1 [404.992913] Dynamic subtest vcs1: SUCCESS (0.002s) [405.000329] Starting dynamic subtest: vecs0 [405.001196] Dynamic subtest vecs0: SUCCESS (0.003s) [405.008403] Starting dynamic subtest: ccs0 [405.009281] Dynamic subtest ccs0: SUCCESS (0.003s) [405.010137] Subtest resubmit: SUCCESS (0.022s) [405.204840] [092/133] (621s left) kms_content_protection (mei-interface) [405.337880] Starting subtest: mei-interface [405.339824] Subtest mei-interface: SKIP (0.001s) [405.455843] [093/133] (621s left) gem_render_copy (y-tiled) [405.513020] Starting subtest: y-tiled [405.514576] Subtest y-tiled: SKIP (0.000s) [405.690232] [094/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [405.783514] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [405.785300] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [405.884847] [095/133] (620s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [406.264902] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [407.049203] [096/133] (619s left) kms_cursor_crc (cursor-onscreen-64x21) [407.228512] Starting subtest: cursor-onscreen-64x21 [407.278686] Subtest cursor-onscreen-64x21: SKIP (0.048s) [407.534048] [097/133] (619s left) kms_getfb (getfb-addfb-different-handles) [407.621993] Starting subtest: getfb-addfb-different-handles [407.623071] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [407.714554] [098/133] (619s left) kms_vblank (wait-forked-busy-hang) [407.799367] Starting subtest: wait-forked-busy-hang [407.800306] Starting dynamic subtest: pipe-A-eDP-1 [434.716771] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.915s) [434.726030] Starting dynamic subtest: pipe-D-eDP-1 [449.750881] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.031s) [449.751714] Subtest wait-forked-busy-hang: SUCCESS (41.951s) [450.546221] [099/133] (576s left) gem_eio (in-flight-internal-10ms) [450.748549] Starting subtest: in-flight-internal-10ms [452.004331] Subtest in-flight-internal-10ms: SUCCESS (1.256s) [452.135792] [100/133] (574s left) syncobj_wait (invalid-signal-illegal-handle) [452.192176] Starting subtest: invalid-signal-illegal-handle [452.193068] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [452.294302] [101/133] (574s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [452.342200] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [452.343431] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [452.433822] [102/133] (574s left) kms_big_fb (y-tiled-16bpp-rotate-90) [452.531171] Starting subtest: y-tiled-16bpp-rotate-90 [452.533491] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [452.631596] [103/133] (574s left) gem_userptr_blits (stress-mm) [452.692289] Starting subtest: stress-mm [458.108640] Subtest stress-mm: SUCCESS (5.369s) [458.179714] [104/133] (568s left) perf_pmu (multi-client) [458.224383] Starting subtest: multi-client [458.225304] Starting dynamic subtest: rcs0 [459.285331] Dynamic subtest rcs0: SUCCESS (1.051s) [459.295488] Starting dynamic subtest: bcs0 [460.340073] Dynamic subtest bcs0: SUCCESS (1.052s) [460.348533] Starting dynamic subtest: vcs0 [461.394559] Dynamic subtest vcs0: SUCCESS (1.052s) [461.402901] Starting dynamic subtest: vcs1 [462.936327] Dynamic subtest vcs1: SUCCESS (1.538s) [462.946569] Starting dynamic subtest: vecs0 [464.919930] Dynamic subtest vecs0: SUCCESS (1.980s) [464.930530] Starting dynamic subtest: ccs0 [466.968630] Dynamic subtest ccs0: SUCCESS (2.045s) [466.969969] Subtest multi-client: SUCCESS (8.736s) [467.071561] [105/133] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [467.165597] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [467.167486] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [467.250671] [106/133] (559s left) gem_exec_fence (basic-busy-all) [467.321712] Starting subtest: basic-busy-all [467.408932] Subtest basic-busy-all: SUCCESS (0.087s) [468.965589] [107/133] (558s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [469.060490] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [469.061410] Starting dynamic subtest: pipe-A-eDP-1 [469.069913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [469.078364] Starting dynamic subtest: pipe-B-eDP-1 [469.086825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [469.094855] Starting dynamic subtest: pipe-C-eDP-1 [469.102755] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [469.110329] Starting dynamic subtest: pipe-D-eDP-1 [469.118351] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [469.120041] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [471.319288] [108/133] (555s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [471.403423] Starting subtest: plane-upscale-20x20-with-modifiers [471.404388] Starting dynamic subtest: pipe-A [471.740719] Dynamic subtest pipe-A: SUCCESS (0.338s) [471.749778] Starting dynamic subtest: pipe-B [473.109919] Dynamic subtest pipe-B: SUCCESS (1.367s) [473.118113] Starting dynamic subtest: pipe-C [474.554700] Dynamic subtest pipe-C: SUCCESS (1.444s) [474.564298] Starting dynamic subtest: pipe-D [475.975387] Dynamic subtest pipe-D: SUCCESS (1.419s) [475.978495] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.574s) [477.139764] [109/133] (550s left) kms_dsc (dsc-with-bpc-formats) [477.223281] Starting subtest: dsc-with-bpc-formats [477.272617] Subtest dsc-with-bpc-formats: SKIP (0.003s) [477.306810] [110/133] (550s left) gem_exec_balancer (fairslice) [477.369245] Starting subtest: fairslice [480.346900] Subtest fairslice: SUCCESS (2.968s) [480.659698] [111/133] (546s left) gem_mmap (basic-small-bo) [480.708660] Subtest basic-small-bo: SKIP (0.000s) [480.759425] [112/133] (546s left) i915_query (query-topology-matches-eu-total) [480.809062] Starting subtest: query-topology-matches-eu-total [480.810181] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [480.905595] [113/133] (546s left) syncobj_timeline (multi-wait-all-available-submitted) [480.951196] Starting subtest: multi-wait-all-available-submitted [480.952064] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [481.043124] [114/133] (546s left) kms_cursor_legacy (forked-move) [481.162186] Starting subtest: forked-move [481.163032] Starting dynamic subtest: pipe-A [486.693421] Dynamic subtest pipe-A: SUCCESS (5.484s) [486.704125] Starting dynamic subtest: pipe-B [492.227384] Dynamic subtest pipe-B: SUCCESS (5.530s) [492.237637] Starting dynamic subtest: pipe-C [497.702951] Dynamic subtest pipe-C: SUCCESS (5.473s) [497.713184] Starting dynamic subtest: pipe-D [503.167878] Dynamic subtest pipe-D: SUCCESS (5.470s) [503.176817] Starting dynamic subtest: all-pipes [508.681861] Dynamic subtest all-pipes: SUCCESS (5.506s) [508.682928] Subtest forked-move: SUCCESS (27.473s) [508.778611] [115/133] (518s left) gem_pread (bench) [508.823265] Subtest bench: SKIP (0.000s) [508.871060] [116/133] (518s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [508.978459] Starting subtest: basic-flip-before-cursor-atomic [509.891869] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s) [510.762515] [117/133] (516s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [510.860725] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [515.225793] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.366s) [516.375515] [118/133] (511s left) gem_ppgtt (blt-vs-render-ctx0) [516.427163] Starting subtest: blt-vs-render-ctx0 [549.492318] Subtest blt-vs-render-ctx0: SUCCESS (33.053s) [549.607351] [119/133] (478s left) kms_plane_scaling (intel-max-src-size) [549.731034] Starting subtest: intel-max-src-size [549.733595] Subtest intel-max-src-size: SKIP (0.000s) [549.824548] [120/133] (477s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [549.917687] Starting subtest: psr2-overlay-plane-move-continuous-sf [549.918709] Starting dynamic subtest: pipe-A-eDP-1 [555.932780] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.012s) [555.941851] Starting dynamic subtest: pipe-B-eDP-1 [562.665275] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.733s) [562.666148] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.748s) [563.542281] [121/133] (464s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [563.629267] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [571.036680] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.407s) [571.193390] [122/133] (456s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [571.288391] Starting subtest: yf-tiled-8bpp-rotate-0 [571.290175] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [571.377760] [123/133] (456s left) kms_prop_blob (invalid-get-prop) [571.435140] Starting subtest: invalid-get-prop [571.435996] Subtest invalid-get-prop: SUCCESS (0.000s) [571.534175] [124/133] (456s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [571.640884] Starting subtest: 2x-long-cursor-vs-flip-legacy [571.643807] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [571.794877] [125/133] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [571.885078] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [571.886627] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [571.981295] [126/133] (455s left) gem_lmem_swapping (heavy-random) [572.024481] Subtest heavy-random: SKIP (0.000s) [572.065337] [127/133] (455s left) kms_flip (flip-vs-rmfb-interruptible) [572.155767] Starting subtest: flip-vs-rmfb-interruptible [572.158092] Starting dynamic subtest: A-eDP1 [580.870196] Dynamic subtest A-eDP1: SUCCESS (8.711s) [580.880815] Starting dynamic subtest: B-eDP1 [589.499343] Dynamic subtest B-eDP1: SUCCESS (8.626s) [589.509621] Starting dynamic subtest: C-eDP1 [598.122371] Dynamic subtest C-eDP1: SUCCESS (8.620s) [598.139884] Starting dynamic subtest: D-eDP1 [606.753562] Dynamic subtest D-eDP1: SUCCESS (8.628s) [606.758200] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.600s) [607.942425] [128/133] (420s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [608.028396] Starting subtest: flip-primary-invalidate-overlay [619.667059] Subtest flip-primary-invalidate-overlay: SUCCESS (11.639s) [619.824176] [129/133] (408s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [619.917560] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [619.918510] Starting dynamic subtest: pipe-A-eDP-1 [620.039736] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s) [620.048355] Starting dynamic subtest: pipe-B-eDP-1 [621.206935] Dynamic subtest pipe-B-eDP-1: SKIP (1.166s) [621.208614] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.291s) [622.395051] [130/133] (405s left) gem_create (create-ext-cpu-access-sanity-check) [622.562322] Starting subtest: create-ext-cpu-access-sanity-check [622.564316] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [622.625641] [131/133] (405s left) sysfs_heartbeat_interval (idempotent) [622.686694] Starting subtest: idempotent [622.687762] Starting dynamic subtest: vecs0 [622.688682] Dynamic subtest vecs0: SUCCESS (0.001s) [622.699276] Starting dynamic subtest: ccs0 [622.700086] Dynamic subtest ccs0: SUCCESS (0.001s) [622.708210] Starting dynamic subtest: vcs0 [622.709051] Dynamic subtest vcs0: SUCCESS (0.000s) [622.716698] Starting dynamic subtest: bcs0 [622.717582] Dynamic subtest bcs0: SUCCESS (0.001s) [622.725281] Starting dynamic subtest: rcs0 [622.726090] Dynamic subtest rcs0: SUCCESS (0.001s) [622.733678] Starting dynamic subtest: vcs1 [622.734556] Dynamic subtest vcs1: SUCCESS (0.000s) [622.735552] Subtest idempotent: SUCCESS (0.008s) [622.786005] [132/133] (405s left) kms_frontbuffer_tracking (fbc-tiling-y) [622.876349] Starting subtest: fbc-tiling-y [622.877918] Subtest fbc-tiling-y: SKIP (0.000s) [622.973725] [133/133] (405s left) kms_flip (absolute-wf_vblank-interruptible) [623.075391] Starting subtest: absolute-wf_vblank-interruptible [623.077724] Starting dynamic subtest: A-eDP1 [631.783455] Dynamic subtest A-eDP1: SUCCESS (8.678s) [631.793635] Starting dynamic subtest: B-eDP1 [640.509333] Dynamic subtest B-eDP1: SUCCESS (8.723s) [640.522688] Starting dynamic subtest: C-eDP1 [649.235662] Dynamic subtest C-eDP1: SUCCESS (8.714s) [649.245806] Starting dynamic subtest: D-eDP1 [657.969872] Dynamic subtest D-eDP1: SUCCESS (8.731s) [657.971300] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.856s) [659.145235] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: kms_chamelium_audio results: parsing output: 2/ for test: kms_plane results: parsing output: 3/ for test: gem_mmap_wc results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_pm_rpm results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: kms_async_flips results: parsing output: 9/ for test: kms_sequence results: parsing output: 10/ for test: syncobj_eventfd results: parsing output: 11/ for test: gem_userptr_blits results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: api_intel_allocator results: parsing output: 14/ for test: gem_exec_fence results: parsing output: 15/ for test: kms_chamelium_frames results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: prime_vgem results: parsing output: 20/ for test: kms_color_pipeline results: parsing output: 21/ for test: kms_addfb_basic results: parsing output: 22/ for test: gem_mmap_wc results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: syncobj_basic results: parsing output: 25/ for test: gem_exec_async results: parsing output: 26/ for test: kms_plane_multiple results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_joiner results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: device_reset results: parsing output: 32/ for test: kms_cursor_crc results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: i915_drm_fdinfo results: parsing output: 36/ for test: syncobj_wait results: parsing output: 37/ for test: api_intel_bb results: parsing output: 38/ for test: gem_render_copy results: parsing output: 39/ for test: gem_lmem_swapping results: parsing output: 40/ for test: i915_hangman results: parsing output: 41/ for test: gem_mmap_offset results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: gem_exec_params results: parsing output: 45/ for test: gem_ctx_isolation results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_draw_crc results: parsing output: 48/ for test: kms_atomic_transition results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: gem_render_copy results: parsing output: 51/ for test: kms_mmap_write_crc results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 56/ for test: kms_cursor_crc results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: perf results: parsing output: 60/ for test: kms_busy results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: gen9_exec_parse results: parsing output: 63/ for test: kms_lease results: parsing output: 64/ for test: gem_exec_fence results: parsing output: 65/ for test: gem_exec_schedule results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: gem_ccs results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_flip_scaled_crc results: parsing output: 71/ for test: kms_vrr results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_exec_whisper results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: gem_ctx_persistence results: parsing output: 77/ for test: kms_psr results: parsing output: 78/ for test: kms_ccs results: parsing output: 79/ for test: i915_pm_rpm results: parsing output: 80/ for test: gem_exec_schedule results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: gem_eio results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_rotation_crc results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: kms_pm_dc results: parsing output: 87/ for test: gem_exec_params results: parsing output: 88/ for test: i915_suspend results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_spin_batch results: parsing output: 91/ for test: kms_content_protection results: parsing output: 92/ for test: gem_render_copy results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_chamelium_hpd results: parsing output: 95/ for test: kms_cursor_crc results: parsing output: 96/ for test: kms_getfb results: parsing output: 97/ for test: kms_vblank results: parsing output: 98/ for test: gem_eio results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: syncobj_wait results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: perf_pmu results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_fence results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: kms_plane_scaling results: parsing output: 108/ for test: kms_dsc results: parsing output: 109/ for test: gem_exec_balancer results: parsing output: 110/ for test: gem_mmap results: parsing output: 111/ for test: i915_query results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_pread results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_ppgtt results: parsing output: 118/ for test: kms_plane_scaling results: parsing output: 119/ for test: kms_psr2_sf results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: kms_prop_blob results: parsing output: 123/ for test: kms_cursor_legacy results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_lmem_swapping results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_psr_stress_test results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: gem_create results: parsing output: 130/ for test: sysfs_heartbeat_interval results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_flip Done.