[59.942516] Initializing watchdogs
[59.942611]   /dev/watchdog0
[59.958504] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.963371] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.965732] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.968294] [001/156] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[60.078854] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[60.080883] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[60.167955] [002/156] (960s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[60.290678] Starting subtest: cursorB-vs-flipB-legacy
[60.292238] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[60.425583] [003/156] (960s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[60.519709] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[60.521466] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[60.608953] [004/156] (959s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[60.701763] Starting subtest: psr-modesetfrombusy
[66.839160] Subtest psr-modesetfrombusy: SUCCESS (6.139s)
[66.972115] [005/156] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[67.057350] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[67.059057] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[67.138851] [006/156] (953s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[67.193436] Starting subtest: single-wait-all-for-submit-signaled
[67.194340] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[67.285570] [007/156] (953s left) gem_exec_balancer (parallel-ordering)
[67.576131] Starting subtest: parallel-ordering
[68.664073] Subtest parallel-ordering: SUCCESS (1.088s)
[68.778896] [008/156] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[68.876099] Starting subtest: fbcpsr-2p-rte
[68.877800] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[68.955672] [009/156] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[69.042758] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[69.044589] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[69.138805] [010/156] (951s left) kms_psr (pr-primary-render)
[69.223025] Starting subtest: pr-primary-render
[69.224906] Subtest pr-primary-render: SKIP (0.000s)
[69.287836] [011/156] (951s left) kms_plane (pixel-format-linear-modifier)
[69.378120] Starting subtest: pixel-format-linear-modifier
[69.405863] Starting dynamic subtest: pipe-A-plane-0
[69.972380] Dynamic subtest pipe-A-plane-0: SUCCESS (0.567s)
[69.981909] Starting dynamic subtest: pipe-A-plane-3
[70.428085] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[70.435754] Starting dynamic subtest: pipe-A-plane-5
[70.639166] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[71.728389] Starting dynamic subtest: pipe-B-plane-0
[72.287416] Dynamic subtest pipe-B-plane-0: SUCCESS (0.567s)
[72.297070] Starting dynamic subtest: pipe-B-plane-3
[72.809384] Dynamic subtest pipe-B-plane-3: SUCCESS (0.522s)
[72.817101] Starting dynamic subtest: pipe-B-plane-5
[73.020590] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[73.328509] Subtest pixel-format-linear-modifier: SUCCESS (3.951s)
[74.207552] [012/156] (946s left) kms_getfb (getfb-handle-protection)
[74.297892] Starting subtest: getfb-handle-protection
[74.320172] Subtest getfb-handle-protection: SUCCESS (0.023s)
[74.437470] [013/156] (946s left) syncobj_eventfd (invalid-illegal-handle)
[74.486101] Starting subtest: invalid-illegal-handle
[74.487283] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[74.568746] [014/156] (946s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[74.659056] Starting subtest: bad-aux-stride-y-tiled-ccs
[74.659931] Starting dynamic subtest: pipe-A-eDP-1
[74.669416] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.676531] Starting dynamic subtest: pipe-B-eDP-1
[74.686714] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.693682] Starting dynamic subtest: pipe-C-eDP-1
[74.702755] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.709438] Starting dynamic subtest: pipe-D-eDP-1
[74.719050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.720765] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[76.958956] [015/156] (943s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[77.013112] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[77.014842] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[77.186381] [016/156] (943s left) kms_plane_alpha_blend (alpha-basic)
[77.268515] Starting subtest: alpha-basic
[77.559347] Starting dynamic subtest: pipe-A-eDP-1
[79.468068] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.909s)
[79.494641] Starting dynamic subtest: pipe-D-eDP-1
[82.151904] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s)
[82.153330] Subtest alpha-basic: SUCCESS (4.884s)
[83.026692] [017/156] (937s left) gem_ccs (block-copy-compressed)
[83.081288] Starting subtest: block-copy-compressed
[83.083133] Subtest block-copy-compressed: SKIP (0.000s)
[83.166727] [018/156] (937s left) kms_flip (2x-wf_vblank-ts-check)
[83.263987] Starting subtest: 2x-wf_vblank-ts-check
[83.274510] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[83.358682] [019/156] (937s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[83.443979] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[83.445858] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[83.510280] [020/156] (937s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[83.596797] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[83.598803] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[83.676553] [021/156] (937s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[83.771715] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[83.773354] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[83.851621] [022/156] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[83.939908] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[83.949663] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[84.041226] [023/156] (937s left) kms_psr (fbc-psr2-cursor-plane-move)
[84.120180] Starting subtest: fbc-psr2-cursor-plane-move
[84.121092] Starting dynamic subtest: eDP-1
[84.122816] Dynamic subtest eDP-1: SKIP (0.000s)
[84.124446] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[84.184502] [024/156] (936s left) syncobj_timeline (invalid-transfer-bad-pad)
[84.229876] Starting subtest: invalid-transfer-bad-pad
[84.230992] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[84.327026] [025/156] (936s left) kms_big_fb (linear-16bpp-rotate-0)
[84.416425] Starting subtest: linear-16bpp-rotate-0
[85.783865] Subtest linear-16bpp-rotate-0: SUCCESS (1.368s)
[85.900507] [026/156] (935s left) kms_properties (get_properties-sanity-atomic)
[85.984139] Starting subtest: get_properties-sanity-atomic
[85.986847] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[86.051330] [027/156] (935s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[86.134788] Starting subtest: psr2-plane-move-sf-dmg-area
[86.135878] Starting dynamic subtest: pipe-A-eDP-1
[90.674437] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.539s)
[90.683499] Starting dynamic subtest: pipe-B-eDP-1
[95.988352] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.312s)
[95.989394] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.853s)
[96.862769] [028/156] (924s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[96.959215] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[96.960077] Starting dynamic subtest: pipe-A-eDP-1
[97.850420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.888s)
[97.857946] Starting dynamic subtest: pipe-B-eDP-1
[99.518785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.667s)
[99.526582] Starting dynamic subtest: pipe-C-eDP-1
[101.028741] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s)
[101.035880] Starting dynamic subtest: pipe-D-eDP-1
[102.534062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s)
[102.535205] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.572s)
[103.707038] [029/156] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[103.801268] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[110.399432] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.599s)
[110.530737] [030/156] (910s left) kms_atomic_interruptible (universal-setplane-primary)
[110.622489] Starting subtest: universal-setplane-primary
[110.623412] Starting dynamic subtest: pipe-A-eDP-1
[118.083062] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.459s)
[118.084295] Subtest universal-setplane-primary: SUCCESS (7.460s)
[118.912373] [031/156] (902s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[119.004820] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[119.653220] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[119.829386] [032/156] (901s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[119.918512] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[124.036297] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.119s)
[125.220073] [033/156] (896s left) kms_cursor_crc (cursor-onscreen-32x32)
[125.354021] Starting subtest: cursor-onscreen-32x32
[125.399855] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[125.676957] [034/156] (895s left) gem_userptr_blits (coherency-unsync)
[125.730752] Subtest coherency-unsync: SKIP (0.000s)
[125.855033] [035/156] (895s left) kms_cdclk (mode-transition-all-outputs)
[125.937836] Starting subtest: mode-transition-all-outputs
[126.236570] Subtest mode-transition-all-outputs: SKIP (0.298s)
[127.047602] [036/156] (894s left) kms_async_flips (test-cursor)
[127.127387] Starting subtest: test-cursor
[127.512593] Starting dynamic subtest: pipe-A-eDP-1
[128.354588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[128.735754] Starting dynamic subtest: pipe-B-eDP-1
[129.505952] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[129.896038] Starting dynamic subtest: pipe-C-eDP-1
[130.741251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.853s)
[131.108372] Starting dynamic subtest: pipe-D-eDP-1
[131.870416] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[131.871586] Subtest test-cursor: SUCCESS (4.744s)
[133.046996] [037/156] (888s left) gem_exec_whisper (basic-normal-all)
[133.101306] Starting subtest: basic-normal-all
[135.347252] Subtest basic-normal-all: SUCCESS (2.245s)
[135.518635] [038/156] (886s left) syncobj_timeline (host-signal-points)
[135.569722] Starting subtest: host-signal-points
[135.574762] Subtest host-signal-points: SUCCESS (0.005s)
[135.631486] [039/156] (886s left) kms_psr (psr-sprite-plane-onoff)
[135.724582] Starting subtest: psr-sprite-plane-onoff
[135.725895] Starting dynamic subtest: eDP-1
[137.465178] Dynamic subtest eDP-1: SUCCESS (1.740s)
[137.466647] Subtest psr-sprite-plane-onoff: SUCCESS (1.741s)
[138.299380] [040/156] (883s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[138.414265] Starting subtest: 2x-cursor-vs-flip-atomic
[138.416921] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[138.555484] [041/156] (883s left) kms_pm_rpm (system-suspend-modeset)
[140.481448] Starting subtest: system-suspend-modeset
[160.602361] Subtest system-suspend-modeset: SUCCESS (4.778s)
[166.046874] [042/156] (860s left) gem_exec_reloc (basic-active)
[166.093734] Subtest basic-active: SKIP (0.000s)
[166.151625] [043/156] (860s left) gem_ctx_persistence (smoketest)
[166.210758] Starting subtest: smoketest
[205.630145] Subtest smoketest: SUCCESS (39.397s)
[205.692509] [044/156] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[205.784130] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[205.785754] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[205.886870] [045/156] (821s left) kms_cursor_legacy (forked-bo)
[206.001760] Starting subtest: forked-bo
[206.002637] Starting dynamic subtest: pipe-A
[211.513068] Dynamic subtest pipe-A: SUCCESS (5.463s)
[211.523896] Starting dynamic subtest: pipe-B
[216.998714] Dynamic subtest pipe-B: SUCCESS (5.483s)
[217.010106] Starting dynamic subtest: pipe-C
[222.471554] Dynamic subtest pipe-C: SUCCESS (5.470s)
[222.482479] Starting dynamic subtest: pipe-D
[227.948000] Dynamic subtest pipe-D: SUCCESS (5.473s)
[227.961867] Starting dynamic subtest: all-pipes
[233.452179] Dynamic subtest all-pipes: SUCCESS (5.500s)
[233.453325] Subtest forked-bo: SUCCESS (27.400s)
[233.548942] [046/156] (793s left) gem_userptr_blits (sync-unmap)
[233.610869] Starting subtest: sync-unmap
[233.623505] Subtest sync-unmap: SUCCESS (0.013s)
[233.745046] [047/156] (793s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[233.855399] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[233.856974] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[233.944947] [048/156] (793s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[234.053107] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[234.055003] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[234.191994] [049/156] (792s left) api_intel_allocator (standalone)
[234.235466] Starting subtest: standalone
[234.252054] Subtest standalone: SUCCESS (0.018s)
[234.350414] [050/156] (792s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[234.442451] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[234.444117] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[234.538342] [051/156] (792s left) gem_exec_schedule (preempt-hang)
[234.710575] Starting subtest: preempt-hang
[234.711855] Starting dynamic subtest: rcs0
[234.953904] Dynamic subtest rcs0: SUCCESS (0.244s)
[234.966575] Starting dynamic subtest: bcs0
[235.183722] Dynamic subtest bcs0: SUCCESS (0.228s)
[235.192758] Starting dynamic subtest: vcs0
[235.411816] Dynamic subtest vcs0: SUCCESS (0.227s)
[235.420243] Starting dynamic subtest: vcs1
[235.637922] Dynamic subtest vcs1: SUCCESS (0.225s)
[235.648036] Starting dynamic subtest: vecs0
[235.863167] Dynamic subtest vecs0: SUCCESS (0.224s)
[235.872213] Starting dynamic subtest: ccs0
[236.090832] Dynamic subtest ccs0: SUCCESS (0.227s)
[236.091897] Subtest preempt-hang: SUCCESS (1.382s)
[236.781397] [052/156] (790s left) kms_flip (flip-vs-panning-vs-hang)
[236.875719] Starting subtest: flip-vs-panning-vs-hang
[236.876852] Starting dynamic subtest: A-eDP1
[248.774507] Dynamic subtest A-eDP1: SUCCESS (11.898s)
[248.785801] Starting dynamic subtest: D-eDP1
[261.837649] Dynamic subtest D-eDP1: SUCCESS (13.061s)
[261.838775] Subtest flip-vs-panning-vs-hang: SUCCESS (24.965s)
[263.015958] [053/156] (764s left) gem_softpin (evict-snoop-interruptible)
[263.076751] Starting subtest: evict-snoop-interruptible
[263.078712] Subtest evict-snoop-interruptible: SKIP (0.000s)
[263.180215] [054/156] (764s left) gem_create (create-ext-cpu-access-sanity-check)
[263.355761] Starting subtest: create-ext-cpu-access-sanity-check
[263.357822] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[263.415746] [055/156] (763s left) kms_feature_discovery (display-3x)
[263.504826] Starting subtest: display-3x
[263.506927] Subtest display-3x: SKIP (0.000s)
[263.573343] [056/156] (763s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[263.663864] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[263.665483] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[263.764860] [057/156] (763s left) kms_addfb_basic (master-rmfb)
[263.812815] Starting subtest: master-rmfb
[263.813904] Subtest master-rmfb: SUCCESS (0.001s)
[263.950307] [058/156] (763s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[264.038207] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[264.040346] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[264.132403] [059/156] (763s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[264.215403] Starting subtest: fbc-tiling-linear
[267.964369] Subtest fbc-tiling-linear: SUCCESS (3.751s)
[269.135835] [060/156] (758s left) gem_exercise_blt (fast-copy)
[269.194837] Starting subtest: fast-copy
[269.195854] Starting dynamic subtest: linear-smem-smem
[269.217487] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[269.231387] Starting dynamic subtest: xmajor-smem-smem
[269.237858] Dynamic subtest xmajor-smem-smem: SUCCESS (0.020s)
[269.249524] Starting dynamic subtest: tile4-smem-smem
[269.256104] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[269.264862] Starting dynamic subtest: tile64-smem-smem
[269.273844] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[269.274978] Subtest fast-copy: SUCCESS (0.080s)
[269.394777] [061/156] (758s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[269.484989] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[269.485960] Starting dynamic subtest: pipe-A-default-mode
[270.674263] Dynamic subtest pipe-A-default-mode: SKIP (1.189s)
[270.676054] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.190s)
[270.818703] [062/156] (756s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[270.916139] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[270.918391] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.017070] [063/156] (756s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[271.124635] Starting subtest: 4-tiled-64bpp-rotate-0
[272.747559] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.623s)
[272.932468] [064/156] (754s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[273.026111] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[273.027867] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[273.123722] [065/156] (754s left) gem_exec_schedule (u-fairslice-all)
[273.180974] Starting subtest: u-fairslice-all
[275.241111] Subtest u-fairslice-all: SUCCESS (2.060s)
[276.706287] [066/156] (750s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[276.755640] Starting subtest: invalid-bsd2-flag-on-blt
[276.756779] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[276.847782] [067/156] (750s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[276.935475] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[276.937353] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[277.033534] [068/156] (750s left) kms_properties (connector-properties-atomic)
[277.121960] Starting subtest: connector-properties-atomic
[277.123035] Starting dynamic subtest: pipe-A-eDP-1
[285.164325] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.043s)
[285.173609] Starting dynamic subtest: pipe-None-DP-1
[285.175633] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[285.190620] Starting dynamic subtest: pipe-None-HDMI-A-1
[285.192200] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[285.202516] Starting dynamic subtest: pipe-None-DP-2
[285.204161] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[285.212113] Starting dynamic subtest: pipe-None-HDMI-A-2
[285.213929] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[285.222308] Starting dynamic subtest: pipe-None-DP-3
[285.224340] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[285.235007] Starting dynamic subtest: pipe-None-DP-4
[285.236984] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[285.238006] Subtest connector-properties-atomic: SUCCESS (8.055s)
[286.035619] [069/156] (741s left) kms_vblank (ts-continuation-modeset)
[286.117851] Starting subtest: ts-continuation-modeset
[286.118736] Starting dynamic subtest: pipe-A-eDP-1
[287.592311] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.475s)
[287.604377] Starting dynamic subtest: pipe-D-eDP-1
[289.760919] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[289.761909] Subtest ts-continuation-modeset: SUCCESS (3.645s)
[290.558521] [070/156] (737s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[290.657746] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[290.659576] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[290.749600] [071/156] (737s left) gem_exec_params (secure-non-root)
[290.797833] Starting subtest: secure-non-root
[290.800366] Subtest secure-non-root: SKIP (0.000s)
[290.891916] [072/156] (736s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[290.987091] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[290.989051] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[291.069165] [073/156] (736s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[291.153385] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[291.155191] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[291.242060] [074/156] (736s left) i915_selftest (perf)
[294.560243] Starting subtest: perf
[294.561831] Starting dynamic subtest: engine_cs
[299.020551] Dynamic subtest engine_cs: SUCCESS (4.460s)
[299.030176] Starting dynamic subtest: request
[306.324325] Dynamic subtest request: SUCCESS (7.302s)
[306.332741] Starting dynamic subtest: migrate
[309.250854] Dynamic subtest migrate: SUCCESS (2.924s)
[309.260435] Starting dynamic subtest: region
[315.042010] Dynamic subtest region: SUCCESS (5.790s)
[315.043261] Subtest perf: SUCCESS (20.483s)
[315.074096] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[315.076258] [075/156] (712s left) syncobj_basic (bad-destroy)
[316.649615] Starting subtest: bad-destroy
[316.650564] Subtest bad-destroy: SUCCESS (0.000s)
[316.732128] [FACT syncobj_basic (bad-destroy)] new: kernel.kmod_is_loaded.i915: true
[316.734515] [076/156] (711s left) syncobj_wait (invalid-wait-illegal-handle)
[316.791961] Starting subtest: invalid-wait-illegal-handle
[316.793004] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[316.888169] [077/156] (711s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[316.984730] Starting subtest: x-tiled-16bpp-rotate-0
[318.300800] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.316s)
[318.404625] [078/156] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[318.497167] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[325.895617] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.399s)
[326.026467] [079/156] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[326.113757] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[326.115377] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[326.210112] [080/156] (701s left) api_intel_bb (simple-bb-ctx)
[326.256683] Starting subtest: simple-bb-ctx
[326.264418] Subtest simple-bb-ctx: SUCCESS (0.009s)
[326.381075] [081/156] (701s left) gem_userptr_blits (map-fixed-invalidate)
[326.458596] Starting subtest: map-fixed-invalidate
[326.460759] Subtest map-fixed-invalidate: SKIP (0.000s)
[326.591359] [082/156] (701s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[326.679435] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[326.681097] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[326.768606] [083/156] (701s left) gem_exec_flush (basic-wb-rw-before-default)
[326.820037] Starting subtest: basic-wb-rw-before-default
[332.290977] Subtest basic-wb-rw-before-default: SUCCESS (5.470s)
[332.470969] [084/156] (695s left) kms_psr (fbc-psr-sprite-blt)
[332.568670] Starting subtest: fbc-psr-sprite-blt
[332.569528] Starting dynamic subtest: eDP-1
[332.571320] Dynamic subtest eDP-1: SKIP (0.000s)
[332.573060] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[332.636092] [085/156] (695s left) gem_exec_reloc (basic-wc-read)
[332.693377] Subtest basic-wc-read: SKIP (0.000s)
[332.744573] [086/156] (695s left) dumb_buffer (map-uaf)
[332.787782] Starting subtest: map-uaf
[332.791414] Subtest map-uaf: SUCCESS (0.005s)
[332.882024] [087/156] (695s left) perf_pmu (busy-accuracy-2)
[332.917711] Starting subtest: busy-accuracy-2
[332.918880] Starting dynamic subtest: rcs0
[335.968237] Dynamic subtest rcs0: SUCCESS (3.044s)
[335.977358] Starting dynamic subtest: bcs0
[339.026879] Dynamic subtest bcs0: SUCCESS (3.055s)
[339.038666] Starting dynamic subtest: vcs0
[342.075659] Dynamic subtest vcs0: SUCCESS (3.047s)
[342.086727] Starting dynamic subtest: vcs1
[345.123844] Dynamic subtest vcs1: SUCCESS (3.045s)
[345.135161] Starting dynamic subtest: vecs0
[348.174720] Dynamic subtest vecs0: SUCCESS (3.049s)
[348.183264] Starting dynamic subtest: ccs0
[351.233275] Dynamic subtest ccs0: SUCCESS (3.056s)
[351.234204] Subtest busy-accuracy-2: SUCCESS (18.310s)
[351.340224] [088/156] (677s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[351.529451] Starting subtest: cursor-rapid-movement-64x21
[351.576862] Subtest cursor-rapid-movement-64x21: SKIP (0.046s)
[351.811767] [089/156] (676s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[351.901179] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[351.902737] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[352.008055] [090/156] (676s left) perf_pmu (init-busy)
[352.046964] Starting subtest: init-busy
[352.048068] Starting dynamic subtest: rcs0
[352.049000] Dynamic subtest rcs0: SUCCESS (0.001s)
[352.058441] Starting dynamic subtest: bcs0
[352.059322] Dynamic subtest bcs0: SUCCESS (0.001s)
[352.067544] Starting dynamic subtest: vcs0
[352.068373] Dynamic subtest vcs0: SUCCESS (0.001s)
[352.076180] Starting dynamic subtest: vcs1
[352.077069] Dynamic subtest vcs1: SUCCESS (0.001s)
[352.084909] Starting dynamic subtest: vecs0
[352.085836] Dynamic subtest vecs0: SUCCESS (0.001s)
[352.093682] Starting dynamic subtest: ccs0
[352.094654] Dynamic subtest ccs0: SUCCESS (0.001s)
[352.095559] Subtest init-busy: SUCCESS (0.009s)
[352.175514] [091/156] (676s left) gen9_exec_parse (bb-large)
[352.239991] Subtest bb-large: SKIP (0.000s)
[352.310612] [092/156] (676s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[352.398921] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[352.400660] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[353.510244] [093/156] (675s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[353.611367] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[353.613121] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[353.714084] [094/156] (674s left) gem_lmem_swapping (verify-random-ccs)
[353.748704] Subtest verify-random-ccs: SKIP (0.000s)
[353.790434] [095/156] (674s left) gem_pread (uncached)
[353.835889] Subtest uncached: SKIP (0.000s)
[353.889620] [096/156] (674s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[353.977712] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[353.978644] Starting dynamic subtest: pipe-A-eDP-1
[365.766792] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.776s)
[365.776239] Starting dynamic subtest: pipe-B-eDP-1
[377.040184] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.282s)
[377.041310] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.063s)
[377.875505] [097/156] (650s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[377.974320] Starting subtest: plane-scaler-unity-scaling-with-rotation
[377.975300] Starting dynamic subtest: pipe-A
[378.202220] Dynamic subtest pipe-A: SUCCESS (0.228s)
[378.210379] Starting dynamic subtest: pipe-B
[379.471276] Dynamic subtest pipe-B: SUCCESS (1.269s)
[379.479829] Starting dynamic subtest: pipe-C
[380.807372] Dynamic subtest pipe-C: SUCCESS (1.335s)
[380.816888] Starting dynamic subtest: pipe-D
[382.137466] Dynamic subtest pipe-D: SUCCESS (1.329s)
[382.138739] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.164s)
[383.313471] [098/156] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[383.417506] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[383.419215] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[383.518952] [099/156] (645s left) gem_softpin (allocator-basic)
[383.584336] Starting subtest: allocator-basic
[383.661559] Subtest allocator-basic: SUCCESS (0.077s)
[383.795903] [100/156] (644s left) kms_pm_lpsp (screens-disabled)
[384.891361] Starting subtest: screens-disabled
[384.893129] Subtest screens-disabled: SKIP (0.000s)
[384.984596] [101/156] (643s left) gem_ctx_param (invalid-param-set)
[385.037022] Starting subtest: invalid-param-set
[385.038214] Subtest invalid-param-set: SUCCESS (0.000s)
[385.119403] [102/156] (643s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[385.210304] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[385.212004] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[385.295806] [103/156] (643s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[385.387425] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[385.389405] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[385.468089] [104/156] (643s left) gem_eio (hibernate)
[385.682686] Starting subtest: hibernate
[401.289185] Subtest hibernate: SUCCESS (15.605s)
[408.423545] [105/156] (627s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[408.803089] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[409.596549] [106/156] (626s left) i915_pm_rpm (gem-execbuf-stress)
[411.836800] Starting subtest: gem-execbuf-stress
[411.838130] Starting dynamic subtest: smem0
[425.542634] Dynamic subtest smem0: SUCCESS (13.706s)
[425.557235] Starting dynamic subtest: extra-wait-smem0
[487.616619] Dynamic subtest extra-wait-smem0: SUCCESS (62.020s)
[487.617792] Subtest gem-execbuf-stress: SUCCESS (75.732s)
[487.954127] [107/156] (548s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[488.050535] Starting subtest: plane-upscale-20x20-with-pixel-format
[488.051406] Starting dynamic subtest: pipe-A
[489.100412] Dynamic subtest pipe-A: SUCCESS (1.050s)
[489.110036] Starting dynamic subtest: pipe-B
[491.263792] Dynamic subtest pipe-B: SUCCESS (2.162s)
[491.281541] Starting dynamic subtest: pipe-C
[492.460208] Dynamic subtest pipe-C: SUCCESS (1.195s)
[492.472088] Starting dynamic subtest: pipe-D
[493.706353] Dynamic subtest pipe-D: SUCCESS (1.245s)
[493.707343] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.656s)
[494.889371] [108/156] (541s left) kms_busy (basic-hang)
[494.995730] Starting subtest: basic-hang
[494.996694] Starting dynamic subtest: flip-pipe-A
[495.578578] Dynamic subtest flip-pipe-A: SUCCESS (0.581s)
[495.592525] Starting dynamic subtest: modeset-pipe-A
[499.254843] Dynamic subtest modeset-pipe-A: SUCCESS (3.675s)
[499.265234] Starting dynamic subtest: flip-pipe-D
[500.465804] Dynamic subtest flip-pipe-D: SUCCESS (1.208s)
[500.476137] Starting dynamic subtest: modeset-pipe-D
[503.905684] Dynamic subtest modeset-pipe-D: SUCCESS (3.440s)
[503.907848] Subtest basic-hang: SUCCESS (8.912s)
[504.720732] [109/156] (531s left) kms_chamelium_frames (hdmi-crc-single)
[505.092778] Subtest hdmi-crc-single: SKIP (0.000s)
[505.917193] [110/156] (530s left) kms_content_protection (dp-mst-type-1)
[506.054877] Starting subtest: dp-mst-type-1
[506.056924] Subtest dp-mst-type-1: SKIP (0.000s)
[506.168474] [111/156] (529s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[506.260658] Starting subtest: hdr-rgb101010-draw-blt
[506.262363] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[506.349362] [112/156] (529s left) kms_invalid_mode (int-max-clock)
[506.435060] Starting subtest: int-max-clock
[506.436054] Starting dynamic subtest: pipe-A-eDP-1
[506.719843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[506.729490] Starting dynamic subtest: pipe-B-eDP-1
[506.730563] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[506.739275] Starting dynamic subtest: pipe-C-eDP-1
[506.740145] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[506.749044] Starting dynamic subtest: pipe-D-eDP-1
[506.749978] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[506.750965] Subtest int-max-clock: SUCCESS (0.289s)
[507.563573] [113/156] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[507.655072] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[507.656874] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[507.760105] [114/156] (528s left) gem_userptr_blits (nohangcheck)
[507.837577] Starting subtest: nohangcheck
[508.093207] Subtest nohangcheck: SUCCESS (0.257s)
[508.214257] [115/156] (528s left) gem_set_tiling_vs_gtt
[508.322649] [116/156] (527s left) gem_exec_balancer (parallel)
[508.586254] Starting subtest: parallel
[509.623370] Subtest parallel: SUCCESS (1.037s)
[510.741587] [117/156] (525s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[510.830826] Starting subtest: psr-1p-pri-indfb-multidraw
[534.155694] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.325s)
[534.277724] [118/156] (502s left) kms_psr (psr-primary-blt)
[534.374654] Starting subtest: psr-primary-blt
[534.375611] Starting dynamic subtest: eDP-1
[536.099925] Dynamic subtest eDP-1: SUCCESS (1.724s)
[536.100913] Subtest psr-primary-blt: SUCCESS (1.725s)
[536.956894] [119/156] (499s left) kms_lease (page-flip-implicit-plane)
[537.053748] Starting subtest: page-flip-implicit-plane
[537.054754] Starting dynamic subtest: pipe-A-eDP-1
[537.534980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[537.544709] Starting dynamic subtest: pipe-B-eDP-1
[538.709453] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s)
[538.720988] Starting dynamic subtest: pipe-C-eDP-1
[539.816131] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[539.827621] Starting dynamic subtest: pipe-D-eDP-1
[540.950201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[540.951348] Subtest page-flip-implicit-plane: SUCCESS (3.896s)
[541.770160] [120/156] (494s left) i915_drm_fdinfo (memory-info-active)
[541.804999] Starting subtest: memory-info-active
[541.806056] Starting dynamic subtest: smem0
[544.562337] Dynamic subtest smem0: SUCCESS (2.756s)
[544.564098] Subtest memory-info-active: SUCCESS (2.757s)
[544.634108] [121/156] (491s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[544.722849] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[544.724721] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[544.813877] [122/156] (491s left) kms_vblank (query-forked-hang)
[544.893682] Starting subtest: query-forked-hang
[544.894981] Starting dynamic subtest: pipe-A-eDP-1
[571.476620] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.580s)
[571.488231] Starting dynamic subtest: pipe-D-eDP-1
[586.512526] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.033s)
[586.513633] Subtest query-forked-hang: SUCCESS (41.617s)
[587.317334] [123/156] (449s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[587.429182] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[587.431199] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[587.516845] [124/156] (449s left) kms_flip (plain-flip-fb-recreate)
[587.613698] Starting subtest: plain-flip-fb-recreate
[587.614622] Starting dynamic subtest: A-eDP1
[596.520584] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[596.532456] Starting dynamic subtest: B-eDP1
[605.357346] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[605.373249] Starting dynamic subtest: C-eDP1
[614.184339] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[614.198449] Starting dynamic subtest: D-eDP1
[623.008990] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[623.011640] Subtest plain-flip-fb-recreate: SUCCESS (35.396s)
[624.188227] [125/156] (412s left) gem_ctx_param (root-set)
[624.230788] Starting subtest: root-set
[624.231668] Subtest root-set: SUCCESS (0.001s)
[624.324951] [126/156] (412s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[624.374547] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[624.436684] [127/156] (412s left) drm_read (short-buffer-nonblock)
[624.588491] Starting subtest: short-buffer-nonblock
[624.589734] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[624.699371] [128/156] (412s left) gem_mmap_offset (close-race)
[624.751654] Starting subtest: close-race
[644.916222] Subtest close-race: SUCCESS (20.117s)
[645.020855] [129/156] (391s left) gem_mmap_gtt (basic-copy)
[645.065439] Subtest basic-copy: SKIP (0.000s)
[645.123066] [130/156] (391s left) gem_exec_parallel (basic)
[645.184467] Starting subtest: basic
[645.185680] Starting dynamic subtest: rcs0
[646.717947] Dynamic subtest rcs0: SUCCESS (1.533s)
[646.731348] Starting dynamic subtest: bcs0
[648.234022] Dynamic subtest bcs0: SUCCESS (1.513s)
[648.246815] Starting dynamic subtest: vcs0
[649.716659] Dynamic subtest vcs0: SUCCESS (1.479s)
[649.732485] Starting dynamic subtest: vcs1
[651.675792] Dynamic subtest vcs1: SUCCESS (1.945s)
[651.690396] Starting dynamic subtest: vecs0
[653.650285] Dynamic subtest vecs0: SUCCESS (1.980s)
[653.664769] Starting dynamic subtest: ccs0
[655.178999] Dynamic subtest ccs0: SUCCESS (1.527s)
[655.180216] Subtest basic: SUCCESS (9.994s)
[655.363822] [131/156] (381s left) gem_exec_fence (syncobj-timeline-chain-engines)
[656.014233] Starting subtest: syncobj-timeline-chain-engines
[656.225009] Subtest syncobj-timeline-chain-engines: SUCCESS (0.211s)
[657.778115] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[657.780219] [132/156] (379s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[657.833719] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[657.913404] [133/156] (378s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[658.028828] Starting subtest: y-tiled-16bpp-rotate-90
[658.030495] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[658.119478] [134/156] (378s left) kms_display_modes (extended-mode-basic)
[658.216667] Starting subtest: extended-mode-basic
[658.218618] Subtest extended-mode-basic: SKIP (0.000s)
[658.260597] [135/156] (378s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[658.367230] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[658.369343] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[658.474145] [136/156] (378s left) prime_mmap (test_reprime)
[658.533019] Starting subtest: test_reprime
[658.534045] Starting dynamic subtest: test_reprime-smem
[658.566242] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[658.567507] Subtest test_reprime: SUCCESS (0.035s)
[658.664389] [137/156] (378s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[658.715502] Starting subtest: multi-wait-available-unsubmitted-submitted
[658.716579] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[658.816418] [138/156] (378s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[658.901441] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[658.902287] Starting dynamic subtest: pipe-A-eDP-1
[658.993061] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[659.003737] Starting dynamic subtest: pipe-B-eDP-1
[660.173821] Dynamic subtest pipe-B-eDP-1: SKIP (1.180s)
[660.175739] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.272s)
[661.464151] [139/156] (375s left) gem_ctx_param (invalid-set-ringsize)
[661.511635] Starting subtest: invalid-set-ringsize
[661.512580] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[661.573067] [140/156] (375s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[661.657005] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[661.658546] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[661.753453] [141/156] (375s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[661.849556] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[661.851083] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[661.940087] [142/156] (375s left) gem_softpin (allocator-basic-reserve)
[662.002341] Starting subtest: allocator-basic-reserve
[662.078916] Subtest allocator-basic-reserve: SUCCESS (0.076s)
[662.207901] [143/156] (375s left) kms_color_pipeline (plane-ctm3x4)
[662.290918] Starting subtest: plane-ctm3x4
[662.437550] Starting dynamic subtest: pipe-A-plane-0
[662.604634] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[662.619889] Starting dynamic subtest: pipe-A-plane-1
[662.715353] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[662.725967] Starting dynamic subtest: pipe-A-plane-2
[662.870929] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[664.105009] Starting dynamic subtest: pipe-B-plane-0
[664.227635] Dynamic subtest pipe-B-plane-0: SUCCESS (0.133s)
[664.239522] Starting dynamic subtest: pipe-B-plane-1
[664.361019] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[664.374080] Starting dynamic subtest: pipe-B-plane-2
[664.483354] Dynamic subtest pipe-B-plane-2: SUCCESS (0.122s)
[665.687171] Starting dynamic subtest: pipe-C-plane-0
[665.809358] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[665.819710] Starting dynamic subtest: pipe-C-plane-1
[665.920373] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[665.930865] Starting dynamic subtest: pipe-C-plane-2
[666.053675] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[667.218242] Starting dynamic subtest: pipe-D-plane-0
[667.319275] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[667.329830] Starting dynamic subtest: pipe-D-plane-1
[667.430233] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[667.441698] Starting dynamic subtest: pipe-D-plane-2
[667.574894] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[667.861816] Subtest plane-ctm3x4: SUCCESS (5.571s)
[668.691758] [144/156] (368s left) gem_mmap_wc (read-write-distinct)
[668.757601] Subtest read-write-distinct: SKIP (0.000s)
[668.811818] [145/156] (368s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[668.904864] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[668.906550] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[669.014166] [146/156] (368s left) prime_vgem (basic-fence-flip)
[669.082910] Starting subtest: basic-fence-flip
[669.382874] Subtest basic-fence-flip: SUCCESS (0.300s)
[669.495763] [147/156] (367s left) gem_eio (in-flight-internal-10ms)
[669.716892] Starting subtest: in-flight-internal-10ms
[670.753051] Subtest in-flight-internal-10ms: SUCCESS (1.037s)
[670.907691] [148/156] (366s left) i915_pm_freq_api (freq-reset)
[670.968552] Starting subtest: freq-reset
[670.969619] Starting dynamic subtest: gt0
[671.159841] Dynamic subtest gt0: SUCCESS (0.191s)
[671.170180] Starting dynamic subtest: gt1
[671.343049] Dynamic subtest gt1: SUCCESS (0.173s)
[671.344495] Subtest freq-reset: SUCCESS (0.367s)
[671.409994] [149/156] (366s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[671.509442] Starting subtest: fbcpsrhdr-modesetfrombusy
[671.511014] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[671.610837] [150/156] (365s left) sysfs_preempt_timeout (idempotent)
[671.665057] Starting subtest: idempotent
[671.667094] Starting dynamic subtest: vecs0
[671.668092] Dynamic subtest vecs0: SUCCESS (0.001s)
[671.678569] Starting dynamic subtest: ccs0
[671.679360] Dynamic subtest ccs0: SUCCESS (0.000s)
[671.689218] Starting dynamic subtest: vcs0
[671.690166] Dynamic subtest vcs0: SUCCESS (0.000s)
[671.700217] Starting dynamic subtest: bcs0
[671.701143] Dynamic subtest bcs0: SUCCESS (0.001s)
[671.710878] Starting dynamic subtest: rcs0
[671.712040] Dynamic subtest rcs0: SUCCESS (0.000s)
[671.721704] Starting dynamic subtest: vcs1
[671.722990] Dynamic subtest vcs1: SUCCESS (0.000s)
[671.724099] Subtest idempotent: SUCCESS (0.009s)
[671.779088] [151/156] (365s left) gem_ctx_sseu (engines)
[671.829730] Subtest engines: SKIP (0.000s)
[671.902198] [152/156] (365s left) gem_ppgtt (shrink-vs-evict-pinned)
[671.964608] Starting subtest: shrink-vs-evict-pinned
[679.670457] Subtest shrink-vs-evict-pinned: SUCCESS (7.660s)
[679.702978] [153/156] (357s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[679.806528] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[684.337674] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.532s)
[685.513172] [154/156] (352s left) prime_vgem (shrink)
[685.586585] Starting subtest: shrink
[685.598729] Subtest shrink: SUCCESS (0.011s)
[685.719680] [155/156] (352s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[685.820682] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[685.822511] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[685.911527] [156/156] (351s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[685.992619] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[685.993485] Starting dynamic subtest: pipe-A-eDP-1
[686.002518] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[686.017129] Starting dynamic subtest: pipe-B-eDP-1
[686.025895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[686.036272] Starting dynamic subtest: pipe-C-eDP-1
[686.044549] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[686.054437] Starting dynamic subtest: pipe-D-eDP-1
[686.062999] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[686.064711] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[688.269491] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: syncobj_eventfd
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_plane_alpha_blend
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_atomic_interruptible
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_cdclk
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_feature_discovery
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exercise_blt
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_selftest
results: parsing output: 74/ for test: syncobj_basic
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: dumb_buffer
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: gem_pread
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: kms_pm_lpsp
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: i915_pm_rpm
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_busy
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: kms_content_protection
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_set_tiling_vs_gtt
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_lease
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_pipe_b_c_ivb
results: parsing output: 126/ for test: drm_read
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: gem_exec_parallel
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: gem_fenced_exec_thrash
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: kms_display_modes
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: prime_mmap
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: kms_psr2_sf
results: parsing output: 138/ for test: gem_ctx_param
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_softpin
results: parsing output: 142/ for test: kms_color_pipeline
results: parsing output: 143/ for test: gem_mmap_wc
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: prime_vgem
results: parsing output: 146/ for test: gem_eio
results: parsing output: 147/ for test: i915_pm_freq_api
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: sysfs_preempt_timeout
results: parsing output: 150/ for test: gem_ctx_sseu
results: parsing output: 151/ for test: gem_ppgtt
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: prime_vgem
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_ccs
Done.