[57.920224] Initializing watchdogs
[57.920269]   /dev/watchdog0
[57.935243] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.939621] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.941615] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.944979] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[58.057884] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[58.062063] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[58.131781] [002/133] (960s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[58.227970] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[58.231971] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[58.299858] [003/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[58.388500] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[59.402823] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.014s)
[59.509307] [004/133] (959s left) gem_exec_schedule (promotion)
[59.586050] Starting subtest: promotion
[59.587978] Starting dynamic subtest: rcs0
[59.682524] Dynamic subtest rcs0: SUCCESS (0.102s)
[59.689687] Starting dynamic subtest: vcs0
[59.768319] Dynamic subtest vcs0: SUCCESS (0.086s)
[59.776887] Starting dynamic subtest: vcs1
[59.852105] Dynamic subtest vcs1: SUCCESS (0.084s)
[59.860778] Starting dynamic subtest: vecs0
[59.929028] Dynamic subtest vecs0: SUCCESS (0.077s)
[59.938156] Starting dynamic subtest: ccs0
[60.013036] Dynamic subtest ccs0: SUCCESS (0.084s)
[60.015042] Subtest promotion: SUCCESS (0.433s)
[61.337216] [005/133] (957s left) gem_exec_reloc (basic-scanout)
[61.400673] Subtest basic-scanout: SKIP (0.000s)
[61.466567] [006/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[61.541386] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[65.418906] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.881s)
[66.556713] [007/133] (952s left) gem_mmap (pf-nonblock)
[66.634332] Subtest pf-nonblock: SKIP (0.000s)
[66.700955] [008/133] (952s left) gem_ctx_persistence (processes)
[66.761769] Starting subtest: processes
[68.223547] Subtest processes: SUCCESS (1.464s)
[68.298665] [009/133] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[68.376124] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[68.380326] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[68.457863] [010/133] (950s left) kms_psr (pr-primary-page-flip)
[68.530784] Starting subtest: pr-primary-page-flip
[68.535346] Subtest pr-primary-page-flip: SKIP (0.000s)
[68.597816] [011/133] (950s left) syncobj_wait (wait-for-submit-complex)
[68.644473] Starting subtest: wait-for-submit-complex
[68.704952] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[68.777695] [012/133] (950s left) gem_gpgpu_fill (basic)
[68.831717] Starting subtest: basic
[68.833994] Starting dynamic subtest: smem
[68.836253] Dynamic subtest smem: SUCCESS (0.005s)
[68.838484] Subtest basic: SUCCESS (0.006s)
[68.970117] [013/133] (949s left) kms_cursor_legacy (single-move)
[69.071776] Starting subtest: single-move
[69.073989] Starting dynamic subtest: pipe-A
[74.454681] Dynamic subtest pipe-A: SUCCESS (5.379s)
[74.465266] Starting dynamic subtest: pipe-B
[79.837047] Dynamic subtest pipe-B: SUCCESS (5.381s)
[79.847518] Starting dynamic subtest: pipe-C
[85.217341] Dynamic subtest pipe-C: SUCCESS (5.379s)
[85.227435] Starting dynamic subtest: pipe-D
[90.599817] Dynamic subtest pipe-D: SUCCESS (5.380s)
[90.610908] Starting dynamic subtest: all-pipes
[95.987853] Dynamic subtest all-pipes: SUCCESS (5.387s)
[95.990315] Subtest single-move: SUCCESS (26.912s)
[96.133901] [014/133] (922s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[96.220728] Starting subtest: plane-ctm3x4-lut1d
[96.389266] Starting dynamic subtest: pipe-A-plane-0
[96.578250] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[96.587961] Starting dynamic subtest: pipe-A-plane-1
[96.756455] Dynamic subtest pipe-A-plane-1: SUCCESS (0.178s)
[96.765561] Starting dynamic subtest: pipe-A-plane-2
[96.889389] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[98.038526] Starting dynamic subtest: pipe-B-plane-0
[98.176358] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[98.187173] Starting dynamic subtest: pipe-B-plane-1
[98.309422] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[98.317339] Starting dynamic subtest: pipe-B-plane-2
[98.453780] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[99.673903] Starting dynamic subtest: pipe-C-plane-0
[99.810742] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[99.820066] Starting dynamic subtest: pipe-C-plane-1
[99.944176] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[99.953393] Starting dynamic subtest: pipe-C-plane-2
[100.088858] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[101.312654] Starting dynamic subtest: pipe-D-plane-0
[101.438822] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[101.449223] Starting dynamic subtest: pipe-D-plane-1
[101.572693] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[101.580743] Starting dynamic subtest: pipe-D-plane-2
[101.705483] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[101.991514] Subtest plane-ctm3x4-lut1d: SUCCESS (5.772s)
[102.778127] [015/133] (916s left) kms_pm_rpm (pm-caching)
[104.395650] Starting subtest: pm-caching
[104.400638] Subtest pm-caching: SKIP (0.000s)
[105.021834] [016/133] (913s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[105.116188] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[112.025730] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.914s)
[112.148046] [017/133] (906s left) kms_psr (psr-sprite-render)
[112.218151] Starting subtest: psr-sprite-render
[112.220487] Starting dynamic subtest: eDP-1
[113.968635] Dynamic subtest eDP-1: SUCCESS (1.751s)
[113.970780] Subtest psr-sprite-render: SUCCESS (1.751s)
[114.809579] [018/133] (904s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[115.187770] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[116.013302] [019/133] (903s left) kms_psr (fbc-pr-sprite-plane-onoff)
[116.081874] Starting subtest: fbc-pr-sprite-plane-onoff
[116.086366] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[116.144716] [020/133] (903s left) gem_exec_schedule (in-order)
[116.217033] Starting subtest: in-order
[116.219284] Starting dynamic subtest: rcs0
[116.304921] Dynamic subtest rcs0: SUCCESS (0.096s)
[116.316653] Starting dynamic subtest: vcs0
[116.389192] Dynamic subtest vcs0: SUCCESS (0.084s)
[116.403869] Starting dynamic subtest: vcs1
[116.466059] Dynamic subtest vcs1: SUCCESS (0.077s)
[116.477037] Starting dynamic subtest: vecs0
[116.546043] Dynamic subtest vecs0: SUCCESS (0.078s)
[116.558521] Starting dynamic subtest: ccs0
[116.631721] Dynamic subtest ccs0: SUCCESS (0.085s)
[116.634519] Subtest in-order: SUCCESS (0.423s)
[118.290297] [021/133] (900s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[118.349462] Starting subtest: x-tiled-to-vebox-yf-tiled
[118.353697] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[118.545840] [022/133] (900s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[118.639545] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[118.643829] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[118.706637] [023/133] (900s left) gem_eio (in-flight-contexts-10ms)
[118.925731] Starting subtest: in-flight-contexts-10ms
[130.254028] Subtest in-flight-contexts-10ms: SUCCESS (11.328s)
[130.390706] [024/133] (888s left) gem_pwrite_snooped
[130.523364] [025/133] (888s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[130.611497] Starting subtest: cursorA-vs-flipB-varying-size
[130.616093] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[130.755539] [026/133] (888s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[130.830343] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[130.834851] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[130.918166] [027/133] (888s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[130.976328] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[130.979153] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[131.095638] [028/133] (888s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[131.166130] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[131.168483] Starting dynamic subtest: pipe-A-eDP-1
[131.191569] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[131.202238] Starting dynamic subtest: pipe-B-eDP-1
[131.224202] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[131.231762] Starting dynamic subtest: pipe-C-eDP-1
[131.249711] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.257058] Starting dynamic subtest: pipe-D-eDP-1
[131.275108] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.278629] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[133.394475] [029/133] (886s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[133.473784] Starting subtest: fbc-pr-cursor-mmap-cpu
[133.478068] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[133.548963] [030/133] (886s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[133.630050] Starting subtest: plane-upscale-20x20-with-modifiers
[133.632389] Starting dynamic subtest: pipe-A
[133.965599] Dynamic subtest pipe-A: SUCCESS (0.338s)
[133.974081] Starting dynamic subtest: pipe-B
[135.384237] Dynamic subtest pipe-B: SUCCESS (1.417s)
[135.393088] Starting dynamic subtest: pipe-C
[136.807058] Dynamic subtest pipe-C: SUCCESS (1.422s)
[136.816977] Starting dynamic subtest: pipe-D
[138.241855] Dynamic subtest pipe-D: SUCCESS (1.434s)
[138.244199] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.615s)
[139.404033] [031/133] (880s left) core_getversion (all-cards)
[139.440269] Starting subtest: all-cards
[139.448160] Subtest all-cards: SUCCESS (0.008s)
[139.493378] [032/133] (880s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[139.560973] Starting subtest: primary-x-tiled-reflect-x-0
[146.617058] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.059s)
[147.778386] [033/133] (871s left) kms_plane (plane-position-hole-dpms)
[147.844228] Starting subtest: plane-position-hole-dpms
[148.357847] Starting dynamic subtest: pipe-A-plane-1
[150.804757] Dynamic subtest pipe-A-plane-1: SUCCESS (2.448s)
[150.815547] Starting dynamic subtest: pipe-A-plane-2
[153.172491] Dynamic subtest pipe-A-plane-2: SUCCESS (2.366s)
[153.180899] Starting dynamic subtest: pipe-A-plane-3
[155.602335] Dynamic subtest pipe-A-plane-3: SUCCESS (2.428s)
[155.619131] Starting dynamic subtest: pipe-A-plane-4
[157.963944] Dynamic subtest pipe-A-plane-4: SUCCESS (2.362s)
[157.972826] Starting dynamic subtest: pipe-A-plane-5
[157.988402] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[159.116818] Starting dynamic subtest: pipe-B-plane-1
[161.451143] Dynamic subtest pipe-B-plane-1: SUCCESS (2.342s)
[161.462053] Starting dynamic subtest: pipe-B-plane-2
[163.808603] Dynamic subtest pipe-B-plane-2: SUCCESS (2.349s)
[163.816579] Starting dynamic subtest: pipe-B-plane-3
[166.077878] Dynamic subtest pipe-B-plane-3: SUCCESS (2.277s)
[166.087243] Starting dynamic subtest: pipe-B-plane-4
[168.451067] Dynamic subtest pipe-B-plane-4: SUCCESS (2.371s)
[168.460500] Starting dynamic subtest: pipe-B-plane-5
[168.476836] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[168.479162] Subtest plane-position-hole-dpms: SUCCESS (20.631s)
[169.269129] [034/133] (850s left) kms_async_flips (async-flip-dpms)
[169.345919] Starting subtest: async-flip-dpms
[169.720076] Starting dynamic subtest: pipe-A-eDP-1
[173.566075] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.847s)
[173.962063] Starting dynamic subtest: pipe-B-eDP-1
[176.742580] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.786s)
[177.117145] Starting dynamic subtest: pipe-C-eDP-1
[179.918320] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.807s)
[180.282536] Starting dynamic subtest: pipe-D-eDP-1
[183.094251] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.818s)
[183.096418] Subtest async-flip-dpms: SUCCESS (13.749s)
[184.267172] [035/133] (835s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[184.354839] Starting subtest: 4-tiled-8bpp-rotate-270
[184.376658] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[184.476222] [036/133] (835s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[184.562169] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[184.564396] Starting dynamic subtest: pipe-A-eDP-1
[184.586359] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[184.596250] Starting dynamic subtest: pipe-B-eDP-1
[184.617213] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[184.624778] Starting dynamic subtest: pipe-C-eDP-1
[184.645868] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[184.653545] Starting dynamic subtest: pipe-D-eDP-1
[184.675345] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[184.679702] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[187.054250] [037/133] (832s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[187.143598] Starting subtest: fbc-rgb101010-draw-render
[191.751377] Subtest fbc-rgb101010-draw-render: SUCCESS (4.611s)
[192.960405] [038/133] (826s left) i915_suspend (fence-restore-untiled)
[193.012045] Starting subtest: fence-restore-untiled
[193.016426] Subtest fence-restore-untiled: SKIP (0.000s)
[193.098149] [039/133] (826s left) kms_psr (psr2-primary-render)
[193.166785] Starting subtest: psr2-primary-render
[193.168948] Starting dynamic subtest: eDP-1
[194.840902] Dynamic subtest eDP-1: SUCCESS (1.672s)
[194.843084] Subtest psr2-primary-render: SUCCESS (1.673s)
[195.705590] [040/133] (824s left) i915_drm_fdinfo (idle)
[195.756050] Starting subtest: idle
[195.758286] Starting dynamic subtest: rcs0
[196.302457] Dynamic subtest rcs0: SUCCESS (0.547s)
[196.313338] Starting dynamic subtest: bcs0
[196.845351] Dynamic subtest bcs0: SUCCESS (0.539s)
[196.856074] Starting dynamic subtest: vcs0
[197.350386] Dynamic subtest vcs0: SUCCESS (0.503s)
[197.360764] Starting dynamic subtest: vcs1
[197.855933] Dynamic subtest vcs1: SUCCESS (0.503s)
[197.867284] Starting dynamic subtest: vecs0
[198.361105] Dynamic subtest vecs0: SUCCESS (0.503s)
[198.372198] Starting dynamic subtest: ccs0
[198.866668] Dynamic subtest ccs0: SUCCESS (0.503s)
[198.869299] Subtest idle: SUCCESS (3.112s)
[198.943669] [041/133] (821s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[199.030404] Starting subtest: psr-farfromfence-mmap-gtt
[199.034717] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[199.113434] [042/133] (820s left) kms_chamelium_frames (dp-frame-dump)
[199.485307] Subtest dp-frame-dump: SKIP (0.000s)
[200.320247] [043/133] (819s left) kms_plane_alpha_blend (constant-alpha-max)
[200.399186] Starting subtest: constant-alpha-max
[200.689730] Starting dynamic subtest: pipe-A-eDP-1
[201.813811] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.120s)
[201.822689] Starting dynamic subtest: pipe-D-eDP-1
[203.471675] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.658s)
[203.474024] Subtest constant-alpha-max: SUCCESS (3.072s)
[204.284080] [044/133] (815s left) kms_plane_cursor (viewport)
[204.368514] Starting subtest: viewport
[204.373040] Starting dynamic subtest: pipe-A-eDP-1-size-64
[206.775429] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.408s)
[206.835606] Starting dynamic subtest: pipe-A-eDP-1-size-128
[209.233047] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.405s)
[209.292945] Starting dynamic subtest: pipe-A-eDP-1-size-256
[211.690077] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.404s)
[212.038509] Starting dynamic subtest: pipe-B-eDP-1-size-64
[215.112808] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.084s)
[215.172717] Starting dynamic subtest: pipe-B-eDP-1-size-128
[217.592081] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.427s)
[217.651483] Starting dynamic subtest: pipe-B-eDP-1-size-256
[220.092836] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.449s)
[220.440800] Starting dynamic subtest: pipe-C-eDP-1-size-64
[223.189164] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.760s)
[223.226147] Starting dynamic subtest: pipe-C-eDP-1-size-128
[225.311350] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[225.349506] Starting dynamic subtest: pipe-C-eDP-1-size-256
[227.433703] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[227.764901] Starting dynamic subtest: pipe-D-eDP-1-size-64
[230.517240] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.762s)
[230.557669] Starting dynamic subtest: pipe-D-eDP-1-size-128
[232.606436] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.059s)
[232.645638] Starting dynamic subtest: pipe-D-eDP-1-size-256
[234.674068] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.036s)
[234.992539] Subtest viewport: SUCCESS (30.623s)
[235.801978] [045/133] (784s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[235.882849] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[235.887390] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[235.968936] [046/133] (784s left) perf (global-sseu-config)
[236.088202] Starting subtest: global-sseu-config
[236.092581] Subtest global-sseu-config: SKIP (0.000s)
[236.131279] [047/133] (784s left) gem_busy (extended)
[236.313622] Starting subtest: extended
[236.315843] Starting dynamic subtest: rcs0
[236.389429] Dynamic subtest rcs0: SUCCESS (0.078s)
[236.403491] Starting dynamic subtest: bcs0
[236.432525] Dynamic subtest bcs0: SUCCESS (0.040s)
[236.445078] Starting dynamic subtest: vcs0
[238.206507] Dynamic subtest vcs0: SUCCESS (1.769s)
[238.219602] Starting dynamic subtest: vcs1
[240.254734] Dynamic subtest vcs1: SUCCESS (2.045s)
[240.267243] Starting dynamic subtest: vecs0
[242.238523] Dynamic subtest vecs0: SUCCESS (1.981s)
[242.252073] Starting dynamic subtest: ccs0
[242.283835] Dynamic subtest ccs0: SUCCESS (0.044s)
[242.286209] Subtest extended: SUCCESS (5.974s)
[242.523218] [048/133] (777s left) kms_psr (fbc-psr-primary-mmap-cpu)
[242.594424] Starting subtest: fbc-psr-primary-mmap-cpu
[242.596737] Starting dynamic subtest: eDP-1
[242.600887] Dynamic subtest eDP-1: SKIP (0.000s)
[242.605057] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[242.676745] [049/133] (777s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[242.789570] Starting subtest: cursorB-vs-flipA-legacy
[242.793959] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[242.948267] [050/133] (777s left) gem_eio (in-flight-internal-1us)
[243.185062] Starting subtest: in-flight-internal-1us
[244.291924] Subtest in-flight-internal-1us: SUCCESS (1.105s)
[244.436328] [051/133] (775s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[244.513064] Starting subtest: yf-tiled-8bpp-rotate-270
[244.517449] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[244.612098] [052/133] (775s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[244.710730] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[244.715260] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[244.812894] [053/133] (775s left) gem_exec_whisper (basic-fds-priority)
[244.878479] Starting subtest: basic-fds-priority
[268.934148] Subtest basic-fds-priority: SUCCESS (24.056s)
[269.118705] [054/133] (751s left) core_auth (getclient-master-drop)
[269.168248] Starting subtest: getclient-master-drop
[269.186891] Subtest getclient-master-drop: SUCCESS (0.021s)
[269.305315] [055/133] (751s left) kms_vblank (query-forked-busy)
[269.382477] Starting subtest: query-forked-busy
[269.384367] Starting dynamic subtest: pipe-A-eDP-1
[271.263265] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[271.277204] Starting dynamic subtest: pipe-D-eDP-1
[273.859980] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.595s)
[273.862451] Subtest query-forked-busy: SUCCESS (4.476s)
[274.661299] [056/133] (745s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[274.708399] Starting subtest: etime-multi-wait-all-submitted-signaled
[274.809350] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[274.884015] [057/133] (745s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[274.967886] Starting subtest: y-tiled-8bpp-rotate-90
[274.972175] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[275.092944] [058/133] (745s left) i915_module_load (resize-bar)
[275.129936] Starting subtest: resize-bar
[275.137505] Subtest resize-bar: SKIP (0.006s)
[275.173137] [059/133] (745s left) gem_exec_alignment (many)
[275.243898] Starting subtest: many
[298.672167] Subtest many: SUCCESS (23.429s)
[301.849461] [060/133] (718s left) kms_content_protection (atomic-dpms)
[302.022168] Starting subtest: atomic-dpms
[302.026744] Subtest atomic-dpms: SKIP (0.000s)
[302.135171] [061/133] (718s left) gem_partial_pwrite_pread (write)
[302.196049] Subtest write: SKIP (0.000s)
[302.260534] [062/133] (718s left) perf (disabled-read-error)
[302.378986] Starting subtest: disabled-read-error
[302.399582] Subtest disabled-read-error: SUCCESS (0.021s)
[302.438510] [063/133] (718s left) syncobj_timeline (signal)
[302.489990] Starting subtest: signal
[302.492384] Subtest signal: SUCCESS (0.000s)
[302.617129] [064/133] (718s left) gem_exec_balancer (indices)
[302.695675] Starting subtest: indices
[305.179418] Subtest indices: SUCCESS (2.482s)
[305.486582] [065/133] (715s left) gem_create (create-invalid-size)
[305.540891] Starting subtest: create-invalid-size
[305.543264] Subtest create-invalid-size: SUCCESS (0.000s)
[305.732413] [066/133] (715s left) gem_softpin (allocator-evict)
[305.797040] Starting subtest: allocator-evict
[305.799497] Starting dynamic subtest: rcs0
[329.861906] Dynamic subtest rcs0: SUCCESS (24.063s)
[329.873715] Starting dynamic subtest: bcs0
[353.950519] Dynamic subtest bcs0: SUCCESS (24.086s)
[353.961176] Starting dynamic subtest: vcs0
[377.940204] Dynamic subtest vcs0: SUCCESS (23.988s)
[377.954813] Starting dynamic subtest: vcs1
[401.715961] Dynamic subtest vcs1: SUCCESS (23.773s)
[401.727760] Starting dynamic subtest: vecs0
[425.619378] Dynamic subtest vecs0: SUCCESS (23.901s)
[425.630064] Starting dynamic subtest: ccs0
[449.705485] Dynamic subtest ccs0: SUCCESS (24.085s)
[449.708070] Subtest allocator-evict: SUCCESS (143.903s)
[449.784302] [067/133] (571s left) gen9_exec_parse (cmd-crossing-page)
[449.890040] Subtest cmd-crossing-page: SKIP (0.000s)
[449.953270] [068/133] (571s left) kms_flip (2x-flip-vs-panning)
[450.038655] Starting subtest: 2x-flip-vs-panning
[450.047253] Subtest 2x-flip-vs-panning: SKIP (0.008s)
[450.139222] [069/133] (571s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[450.221235] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[450.225640] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[450.302359] [070/133] (570s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[450.377025] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[450.381591] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[450.453858] [071/133] (570s left) gem_exec_capture (capture-invisible)
[450.513139] Starting subtest: capture-invisible
[450.515459] Starting dynamic subtest: smem0
[450.519780] Dynamic subtest smem0: SKIP (0.000s)
[450.524459] Subtest capture-invisible: SKIP (0.001s)
[450.618969] [072/133] (570s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[450.677543] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[450.681189] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[450.872296] [073/133] (570s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[450.950088] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[450.952413] Starting dynamic subtest: pipe-A-eDP-1
[450.975999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[450.987086] Starting dynamic subtest: pipe-B-eDP-1
[451.008906] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.018073] Starting dynamic subtest: pipe-C-eDP-1
[451.040196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.049060] Starting dynamic subtest: pipe-D-eDP-1
[451.070268] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.074634] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[453.109405] [074/133] (568s left) syncobj_wait (single-wait-for-submit-submitted)
[453.163967] Starting subtest: single-wait-for-submit-submitted
[453.266385] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[453.351292] [075/133] (568s left) gem_reg_read (bad-register)
[453.398563] Starting subtest: bad-register
[453.400868] Subtest bad-register: SUCCESS (0.000s)
[453.480415] [076/133] (567s left) kms_invalid_mode (bad-vtotal)
[453.559276] Starting subtest: bad-vtotal
[453.561600] Starting dynamic subtest: pipe-A-eDP-1
[453.854848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[453.865673] Starting dynamic subtest: pipe-B-eDP-1
[453.868018] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[453.877172] Starting dynamic subtest: pipe-C-eDP-1
[453.879552] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[453.888746] Starting dynamic subtest: pipe-D-eDP-1
[453.891384] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[453.893675] Subtest bad-vtotal: SUCCESS (0.302s)
[454.652736] [077/133] (566s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[454.719150] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[454.827429] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[454.900287] [078/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[454.987607] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[454.991703] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.091515] [079/133] (566s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[455.272665] Starting subtest: cursor-rapid-movement-64x21
[455.317438] Subtest cursor-rapid-movement-64x21: SKIP (0.039s)
[455.557457] [080/133] (566s left) gem_wait (await)
[455.620423] Starting subtest: await
[455.622894] Starting dynamic subtest: all-engines
[456.804103] Dynamic subtest all-engines: SUCCESS (1.182s)
[456.821961] Starting dynamic subtest: rcs0
[457.870979] Dynamic subtest rcs0: SUCCESS (1.056s)
[457.881096] Starting dynamic subtest: bcs0
[458.920596] Dynamic subtest bcs0: SUCCESS (1.057s)
[458.937417] Starting dynamic subtest: vcs0
[459.973820] Dynamic subtest vcs0: SUCCESS (1.051s)
[459.992303] Starting dynamic subtest: vcs1
[461.027019] Dynamic subtest vcs1: SUCCESS (1.051s)
[461.043769] Starting dynamic subtest: vecs0
[462.079550] Dynamic subtest vecs0: SUCCESS (1.051s)
[462.096152] Starting dynamic subtest: ccs0
[463.137669] Dynamic subtest ccs0: SUCCESS (1.056s)
[463.140269] Subtest await: SUCCESS (7.518s)
[463.344626] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[463.347914] [081/133] (558s left) syncobj_basic (bad-fd-to-handle)
[463.408762] Starting subtest: bad-fd-to-handle
[463.411115] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[463.531377] [082/133] (558s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[463.616467] Starting subtest: yf-tiled-16bpp-rotate-270
[463.620870] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[463.713606] [083/133] (558s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[463.772868] Starting subtest: y-tiled-ccs-to-x-tiled
[463.777153] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[463.957270] [084/133] (557s left) gem_fence_thrash (bo-write-verify-threaded-y)
[463.997380] Starting subtest: bo-write-verify-threaded-y
[464.021099] Subtest bo-write-verify-threaded-y: SKIP (0.025s)
[464.076430] [085/133] (557s left) prime_vgem (basic-blt)
[464.145664] Starting subtest: basic-blt
[464.171445] Subtest basic-blt: SUCCESS (0.028s)
[464.285634] [086/133] (557s left) kms_fb_coherency (memset-crc)
[464.352651] Starting subtest: memset-crc
[464.355025] Starting dynamic subtest: mmap-offset-wc
[464.736769] Dynamic subtest mmap-offset-wc: SUCCESS (0.386s)
[465.038756] Starting dynamic subtest: mmap-offset-uc
[471.150461] Dynamic subtest mmap-offset-uc: SUCCESS (6.123s)
[471.450519] Subtest memset-crc: SUCCESS (7.100s)
[472.254781] [087/133] (549s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[472.339545] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[472.344128] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[472.434257] [088/133] (549s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[472.516217] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[472.520211] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[472.608451] [089/133] (549s left) gem_mmap_offset (mmap-boundaries)
[472.668970] Starting subtest: mmap-boundaries
[472.671170] Starting dynamic subtest: smem0
[472.950740] Dynamic subtest smem0: SUCCESS (0.267s)
[472.953124] Subtest mmap-boundaries: SUCCESS (0.268s)
[473.057728] [090/133] (548s left) gem_userptr_blits (access-control)
[473.126532] Starting subtest: access-control
[473.130822] Subtest access-control: SKIP (0.000s)
[473.235778] [091/133] (548s left) gem_exec_fence (submit3)
[473.402161] Starting subtest: submit3
[473.406532] Subtest submit3: SKIP (0.000s)
[475.354133] [092/133] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[475.436160] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[475.440155] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[475.554735] [093/133] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[475.635373] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[484.216854] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.586s)
[484.363319] [094/133] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[484.444751] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[491.357682] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.917s)
[491.470809] [095/133] (530s left) kms_flip (flip-vs-dpms-on-nop)
[491.545327] Starting subtest: flip-vs-dpms-on-nop
[491.547612] Starting dynamic subtest: A-eDP1
[493.439438] Dynamic subtest A-eDP1: SUCCESS (1.896s)
[493.451627] Starting dynamic subtest: B-eDP1
[495.271673] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[495.283896] Starting dynamic subtest: C-eDP1
[497.090953] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[497.101720] Starting dynamic subtest: D-eDP1
[498.918102] Dynamic subtest D-eDP1: SUCCESS (1.826s)
[498.922906] Subtest flip-vs-dpms-on-nop: SUCCESS (7.380s)
[500.088801] [096/133] (522s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[500.153146] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[500.160359] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.008s)
[500.237981] [097/133] (522s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[502.347752] Starting subtest: gem-execbuf-stress-pc8
[502.384991] Subtest gem-execbuf-stress-pc8: SKIP (0.037s)
[502.720646] [098/133] (519s left) kms_plane_scaling (2x-scaler-multi-pipe)
[502.794451] Starting subtest: 2x-scaler-multi-pipe
[502.799170] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[502.917427] [099/133] (519s left) kms_lease (cursor-implicit-plane)
[502.991185] Starting subtest: cursor-implicit-plane
[502.993071] Starting dynamic subtest: pipe-A-eDP-1
[503.437278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[503.447801] Starting dynamic subtest: pipe-B-eDP-1
[504.543214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.106s)
[504.555787] Starting dynamic subtest: pipe-C-eDP-1
[505.654553] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[505.666758] Starting dynamic subtest: pipe-D-eDP-1
[506.783030] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[506.785451] Subtest cursor-implicit-plane: SUCCESS (3.794s)
[507.650643] [100/133] (514s left) gem_userptr_blits (process-exit)
[507.723125] Starting subtest: process-exit
[507.730034] Subtest process-exit: SUCCESS (0.009s)
[507.848959] [101/133] (514s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[507.936152] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[514.717496] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.785s)
[514.840879] [102/133] (507s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[514.916144] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[514.918406] Starting dynamic subtest: pipe-A-eDP-1
[514.945169] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[514.956899] Starting dynamic subtest: pipe-B-eDP-1
[514.981969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[514.990925] Starting dynamic subtest: pipe-C-eDP-1
[515.013741] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[515.022907] Starting dynamic subtest: pipe-D-eDP-1
[515.046303] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[515.050608] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[517.083730] [103/133] (505s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[517.162486] Starting subtest: fbcpsr-rgb565-draw-blt
[524.122893] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.963s)
[524.249291] [104/133] (498s left) kms_pm_rpm (cursor)
[526.352021] Starting subtest: cursor
[526.357471] Subtest cursor: SKIP (0.000s)
[526.712165] [105/133] (495s left) kms_rotation_crc (sprite-rotation-270)
[526.789802] Starting subtest: sprite-rotation-270
[526.794248] Subtest sprite-rotation-270: SKIP (0.001s)
[526.860466] [106/133] (495s left) gem_mmap_wc (read)
[526.916729] Subtest read: SKIP (0.000s)
[526.976981] [107/133] (495s left) gem_userptr_blits (map-fixed-invalidate-busy)
[527.063980] Starting subtest: map-fixed-invalidate-busy
[527.068108] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[527.178957] [108/133] (495s left) kms_flip (2x-blocking-wf_vblank)
[527.250389] Starting subtest: 2x-blocking-wf_vblank
[527.258029] Subtest 2x-blocking-wf_vblank: SKIP (0.007s)
[527.364545] [109/133] (495s left) api_intel_bb (blit-noreloc-keep-cache)
[527.413925] Starting subtest: blit-noreloc-keep-cache
[527.421045] Subtest blit-noreloc-keep-cache: SUCCESS (0.009s)
[527.532809] [110/133] (495s left) prime_vgem (basic-read)
[527.620736] Starting subtest: basic-read
[527.629376] Subtest basic-read: SKIP (0.006s)
[527.737629] [111/133] (495s left) gem_compute (compute-square)
[527.786261] Starting subtest: compute-square
[527.789724] Subtest compute-square: SUCCESS (0.005s)
[527.926507] [112/133] (495s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[527.979058] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[528.043701] [113/133] (494s left) gem_exec_params (dr1-dirt)
[528.100958] Starting subtest: DR1-dirt
[528.102919] Subtest DR1-dirt: SUCCESS (0.000s)
[528.192124] [114/133] (494s left) kms_sequence (queue-idle)
[528.265263] Starting subtest: queue-idle
[528.267122] Starting dynamic subtest: pipe-A-eDP-1
[530.074872] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[530.087058] Starting dynamic subtest: pipe-B-eDP-1
[532.601998] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.524s)
[532.614184] Starting dynamic subtest: pipe-C-eDP-1
[535.026359] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s)
[535.037078] Starting dynamic subtest: pipe-D-eDP-1
[537.468728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.442s)
[537.471062] Subtest queue-idle: SUCCESS (9.204s)
[538.271066] [115/133] (484s left) kms_force_connector_basic (force-load-detect)
[538.329648] Subtest force-load-detect: SKIP (0.000s)
[538.402724] [116/133] (484s left) sysfs_timeslice_duration (idempotent)
[538.445518] Starting subtest: idempotent
[538.448056] Starting dynamic subtest: vecs0
[538.450472] Dynamic subtest vecs0: SUCCESS (0.000s)
[538.462716] Starting dynamic subtest: ccs0
[538.465024] Dynamic subtest ccs0: SUCCESS (0.000s)
[538.474504] Starting dynamic subtest: vcs0
[538.476468] Dynamic subtest vcs0: SUCCESS (0.000s)
[538.490069] Starting dynamic subtest: bcs0
[538.492533] Dynamic subtest bcs0: SUCCESS (0.000s)
[538.501759] Starting dynamic subtest: rcs0
[538.503673] Dynamic subtest rcs0: SUCCESS (0.000s)
[538.512704] Starting dynamic subtest: vcs1
[538.514621] Dynamic subtest vcs1: SUCCESS (0.000s)
[538.516576] Subtest idempotent: SUCCESS (0.006s)
[538.554733] [117/133] (484s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[538.649080] Starting subtest: short-flip-before-cursor-atomic-transitions
[539.610285] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s)
[540.409422] [118/133] (482s left) perf_pmu (init-busy)
[540.448543] Starting subtest: init-busy
[540.450901] Starting dynamic subtest: rcs0
[540.453248] Dynamic subtest rcs0: SUCCESS (0.001s)
[540.464187] Starting dynamic subtest: bcs0
[540.466345] Dynamic subtest bcs0: SUCCESS (0.001s)
[540.475562] Starting dynamic subtest: vcs0
[540.477448] Dynamic subtest vcs0: SUCCESS (0.001s)
[540.486299] Starting dynamic subtest: vcs1
[540.488583] Dynamic subtest vcs1: SUCCESS (0.001s)
[540.497665] Starting dynamic subtest: vecs0
[540.499874] Dynamic subtest vecs0: SUCCESS (0.000s)
[540.508777] Starting dynamic subtest: ccs0
[540.510666] Dynamic subtest ccs0: SUCCESS (0.000s)
[540.512550] Subtest init-busy: SUCCESS (0.007s)
[540.552957] [119/133] (482s left) syncobj_timeline (invalid-transfer-non-existent-point)
[540.613441] Starting subtest: invalid-transfer-non-existent-point
[540.615670] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[540.706448] [120/133] (482s left) kms_cursor_crc (cursor-onscreen-128x128)
[540.893805] Starting subtest: cursor-onscreen-128x128
[540.898686] Starting dynamic subtest: pipe-A-eDP-1
[543.002207] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s)
[543.032294] Starting dynamic subtest: pipe-D-eDP-1
[545.784087] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[545.786264] Subtest cursor-onscreen-128x128: SUCCESS (4.888s)
[546.618699] [121/133] (476s left) gem_mmap_gtt (basic-small-copy)
[546.682079] Subtest basic-small-copy: SKIP (0.000s)
[546.743567] [122/133] (476s left) gem_pread (display)
[546.799252] Subtest display: SKIP (0.000s)
[546.852917] [123/133] (476s left) kms_addfb_basic (invalid-set-prop)
[546.919321] Starting subtest: invalid-set-prop
[546.921193] Subtest invalid-set-prop: SUCCESS (0.000s)
[547.040252] [124/133] (476s left) gem_ctx_param (invalid-get-engines)
[547.098618] Starting subtest: invalid-get-engines
[547.101042] Subtest invalid-get-engines: SUCCESS (0.001s)
[547.199753] [125/133] (476s left) kms_flip (flip-vs-wf_vblank-interruptible)
[547.269809] Starting subtest: flip-vs-wf_vblank-interruptible
[547.272162] Starting dynamic subtest: A-eDP1
[549.144061] Dynamic subtest A-eDP1: SUCCESS (1.873s)
[549.157112] Starting dynamic subtest: B-eDP1
[551.084692] Dynamic subtest B-eDP1: SUCCESS (1.938s)
[551.100060] Starting dynamic subtest: C-eDP1
[553.006799] Dynamic subtest C-eDP1: SUCCESS (1.919s)
[553.019501] Starting dynamic subtest: D-eDP1
[554.849807] Dynamic subtest D-eDP1: SUCCESS (1.840s)
[554.855043] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.584s)
[555.998490] [126/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[556.079470] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[556.083576] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[556.176489] [127/133] (467s left) kms_big_fb (linear-addfb)
[556.257988] Starting subtest: linear-addfb
[556.260276] Subtest linear-addfb: SUCCESS (0.000s)
[556.340953] [128/133] (467s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[556.434701] Starting subtest: flip-vs-cursor-busy-crc-atomic
[557.226738] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.793s)
[558.023256] [129/133] (465s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[558.093940] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[558.098846] Starting dynamic subtest: pipe-A-eDP-1
[558.120068] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[558.130686] Starting dynamic subtest: pipe-B-eDP-1
[558.150825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[558.159986] Starting dynamic subtest: pipe-C-eDP-1
[558.180601] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[558.189735] Starting dynamic subtest: pipe-D-eDP-1
[558.211373] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[558.215687] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[560.315561] [130/133] (463s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[560.411318] Starting subtest: basic-busy-flip-before-cursor-varying-size
[560.415773] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[560.554160] [131/133] (463s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[560.644994] Starting subtest: 4-tiled-16bpp-rotate-0
[562.012314] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[562.132201] [132/133] (461s left) gem_eio (wait-wedge-immediate)
[562.410319] Starting subtest: wait-wedge-immediate
[564.289417] Subtest wait-wedge-immediate: SUCCESS (1.877s)
[564.407590] [133/133] (459s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[564.489728] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[564.493972] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[564.579291] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_mmap
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_gpgpu_fill
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_color_pipeline
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_pwrite_snooped
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: core_getversion
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: i915_drm_fdinfo
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_plane_alpha_blend
results: parsing output: 43/ for test: kms_plane_cursor
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: gem_busy
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: core_auth
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: i915_module_load
results: parsing output: 58/ for test: gem_exec_alignment
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: gem_partial_pwrite_pread
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: gem_exec_capture
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_reg_read
results: parsing output: 75/ for test: kms_invalid_mode
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: gem_wait
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_fence_thrash
results: parsing output: 84/ for test: prime_vgem
results: parsing output: 85/ for test: kms_fb_coherency
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: i915_pm_rpm
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_lease
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_rotation_crc
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: gem_compute
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: kms_sequence
results: parsing output: 114/ for test: kms_force_connector_basic
results: parsing output: 115/ for test: sysfs_timeslice_duration
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: gem_pread
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.