[57.681882] Initializing watchdogs
[57.681925]   /dev/watchdog0
[57.695548] [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]
[57.699769] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.702079] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.705473] [001/131] (960s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[57.836645] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[57.838826] Starting dynamic subtest: pipe-A-eDP-1
[57.861277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.870771] Starting dynamic subtest: pipe-B-eDP-1
[57.891947] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.898486] Starting dynamic subtest: pipe-C-eDP-1
[57.920325] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.926819] Starting dynamic subtest: pipe-D-eDP-1
[57.948774] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.953246] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[60.155668] [002/131] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[60.253512] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[67.178966] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.928s)
[67.502983] [003/131] (950s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[67.665484] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[68.378832] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.715s)
[68.592872] [004/131] (949s left) kms_cursor_crc (cursor-alpha-opaque)
[68.690819] Starting subtest: cursor-alpha-opaque
[68.693086] Starting dynamic subtest: pipe-A-eDP-1
[69.300176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[69.308724] Starting dynamic subtest: pipe-D-eDP-1
[70.545533] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[70.547554] Subtest cursor-alpha-opaque: SUCCESS (1.854s)
[71.367290] [005/131] (947s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[71.430752] Starting subtest: yf-tiled-ccs-to-yf-tiled
[71.435435] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[71.636181] [006/131] (946s left) api_intel_allocator (default-alignment)
[71.693257] Starting subtest: default-alignment
[71.695750] Subtest default-alignment: SUCCESS (0.004s)
[71.854784] [007/131] (946s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[71.964875] Starting subtest: extended-modeset-hang-newfb-with-reset
[71.967169] Starting dynamic subtest: pipe-A
[85.680461] Dynamic subtest pipe-A: SUCCESS (13.712s)
[85.688447] Starting dynamic subtest: pipe-D
[101.031550] Dynamic subtest pipe-D: SUCCESS (15.349s)
[101.033805] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.065s)
[101.852209] [008/131] (916s left) gem_render_copy (y-tiled)
[101.926435] Starting subtest: y-tiled
[101.930723] Subtest y-tiled: SKIP (0.000s)
[102.126588] [009/131] (916s left) kms_rotation_crc (multiplane-rotation)
[102.216896] Starting subtest: multiplane-rotation
[119.731066] Subtest multiplane-rotation: SUCCESS (17.515s)
[119.891898] [010/131] (898s left) gem_reg_read (timestamp-moving)
[119.970165] Starting subtest: timestamp-moving
[120.975078] Subtest timestamp-moving: SUCCESS (1.001s)
[121.103568] [011/131] (897s left) kms_pm_backlight (brightness-with-dpms)
[121.210687] Starting subtest: brightness-with-dpms
[121.258495] Starting dynamic subtest: eDP-1
[123.702369] Dynamic subtest eDP-1: SUCCESS (2.442s)
[123.704604] Subtest brightness-with-dpms: SUCCESS (2.492s)
[124.587609] [012/131] (894s left) kms_addfb_basic (bad-pitch-256)
[124.659417] Starting subtest: bad-pitch-256
[124.661598] Subtest bad-pitch-256: SUCCESS (0.000s)
[124.832340] [013/131] (893s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[124.931632] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[124.935914] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[126.124674] [014/131] (892s left) i915_suspend (fence-restore-tiled2untiled)
[126.183312] Starting subtest: fence-restore-tiled2untiled
[126.187789] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[126.307469] [015/131] (892s left) gem_ctx_exec (basic-invalid-context)
[126.366921] Starting subtest: basic-invalid-context
[126.371878] Subtest basic-invalid-context: SUCCESS (0.005s)
[126.532449] [016/131] (892s left) gem_exec_reloc (basic-write-gtt-active)
[126.596520] Subtest basic-write-gtt-active: SKIP (0.000s)
[126.673905] [017/131] (892s left) i915_pm_freq_api (freq-reset-multiple)
[126.738581] Starting subtest: freq-reset-multiple
[126.740468] Starting dynamic subtest: gt0
[136.371748] Dynamic subtest gt0: SUCCESS (9.634s)
[136.379089] Starting dynamic subtest: gt1
[144.241436] Dynamic subtest gt1: SUCCESS (7.868s)
[144.244082] Subtest freq-reset-multiple: SUCCESS (17.504s)
[144.341516] [018/131] (874s left) perf (non-system-wide-paranoid)
[144.480825] Starting subtest: non-system-wide-paranoid
[144.510375] Subtest non-system-wide-paranoid: SUCCESS (0.030s)
[144.546145] [019/131] (874s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[144.641715] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[144.643978] Starting dynamic subtest: pipe-A
[144.662338] Dynamic subtest pipe-A: SKIP (0.018s)
[144.669936] Starting dynamic subtest: pipe-B
[144.697217] Dynamic subtest pipe-B: SKIP (0.034s)
[144.704619] Starting dynamic subtest: pipe-C
[144.729222] Dynamic subtest pipe-C: SKIP (0.032s)
[144.736385] Starting dynamic subtest: pipe-D
[144.782266] Dynamic subtest pipe-D: SKIP (0.028s)
[144.803055] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.114s)
[144.927641] [020/131] (874s left) gem_lmem_swapping (heavy-random)
[145.029692] Subtest heavy-random: SKIP (0.000s)
[145.110508] [021/131] (873s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[145.266671] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[149.342456] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.105s)
[150.505059] [022/131] (868s left) gem_eio (in-flight-internal-1us)
[150.721348] Starting subtest: in-flight-internal-1us
[151.960202] Subtest in-flight-internal-1us: SUCCESS (1.237s)
[152.137265] [023/131] (867s left) kms_scaling_modes (scaling-mode-full-aspect)
[152.225576] Starting subtest: scaling-mode-full-aspect
[152.227777] Starting dynamic subtest: pipe-A-eDP-1
[152.316742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s)
[152.328501] Starting dynamic subtest: pipe-B-eDP-1
[153.504625] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s)
[153.517061] Starting dynamic subtest: pipe-C-eDP-1
[154.617199] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[154.625045] Starting dynamic subtest: pipe-D-eDP-1
[155.748493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[155.750868] Subtest scaling-mode-full-aspect: SUCCESS (3.525s)
[156.938806] [024/131] (862s left) kms_psr (pr-sprite-mmap-cpu)
[157.037182] Starting subtest: pr-sprite-mmap-cpu
[157.041129] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[157.128403] [025/131] (862s left) kms_async_flips (test-cursor-atomic)
[157.229952] Starting subtest: test-cursor-atomic
[157.234162] Subtest test-cursor-atomic: SKIP (0.000s)
[158.465209] [026/131] (860s left) sysfs_preempt_timeout (idempotent)
[158.542398] Starting subtest: idempotent
[158.544831] Starting dynamic subtest: vecs0
[158.547262] Dynamic subtest vecs0: SUCCESS (0.001s)
[158.556519] Starting dynamic subtest: ccs0
[158.558801] Dynamic subtest ccs0: SUCCESS (0.001s)
[158.566063] Starting dynamic subtest: vcs0
[158.567986] Dynamic subtest vcs0: SUCCESS (0.001s)
[158.574849] Starting dynamic subtest: bcs0
[158.577231] Dynamic subtest bcs0: SUCCESS (0.001s)
[158.584540] Starting dynamic subtest: rcs0
[158.586826] Dynamic subtest rcs0: SUCCESS (0.000s)
[158.593946] Starting dynamic subtest: vcs1
[158.596212] Dynamic subtest vcs1: SUCCESS (0.000s)
[158.598442] Subtest idempotent: SUCCESS (0.011s)
[158.641887] [027/131] (860s left) gem_ctx_engines (invalid-engines)
[158.707384] Starting subtest: invalid-engines
[158.714877] Subtest invalid-engines: SUCCESS (0.008s)
[158.975325] [028/131] (860s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[159.097460] Starting subtest: cursor-vs-flip-atomic-transitions
[188.859875] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.763s)
[189.695335] [029/131] (829s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[189.764342] Starting subtest: multi-wait-for-submit-submitted-signaled
[189.766652] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[189.908725] [030/131] (829s left) kms_vrr (flipline)
[190.010947] Starting subtest: flipline
[190.017504] Subtest flipline: SKIP (0.000s)
[190.103373] [031/131] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[190.212701] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[196.706987] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.496s)
[196.900459] [032/131] (822s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[197.136885] Starting subtest: cursor-rapid-movement-128x42
[197.181414] Subtest cursor-rapid-movement-128x42: SKIP (0.039s)
[197.407527] [033/131] (822s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[197.502392] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[201.530599] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.032s)
[202.691428] [034/131] (816s left) syncobj_wait (multi-wait-submitted)
[202.747742] Starting subtest: multi-wait-submitted
[202.849571] Subtest multi-wait-submitted: SUCCESS (0.101s)
[202.977416] [035/131] (816s left) kms_flip (plain-flip-fb-recreate-interruptible)
[203.077267] Starting subtest: plain-flip-fb-recreate-interruptible
[203.079418] Starting dynamic subtest: A-eDP1
[211.961395] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[211.971413] Starting dynamic subtest: B-eDP1
[220.797886] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[220.808114] Starting dynamic subtest: C-eDP1
[229.613580] Dynamic subtest C-eDP1: SUCCESS (8.812s)
[229.622063] Starting dynamic subtest: D-eDP1
[238.448468] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[238.452860] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.375s)
[239.658659] [036/131] (780s left) api_intel_bb (intel-bb-blit-none)
[239.716811] Starting subtest: intel-bb-blit-none
[243.535982] Subtest intel-bb-blit-none: SUCCESS (3.817s)
[243.681527] [037/131] (776s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[248.715446] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[248.717839] Starting dynamic subtest: pipe-A-eDP-1
[249.515832] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[249.524682] Starting dynamic subtest: pipe-B-eDP-1
[250.652700] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[250.656724] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.936s)
[251.861908] [038/131] (767s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[251.982081] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[258.919681] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.940s)
[259.101285] [039/131] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[259.209498] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[259.213689] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[259.326898] [040/131] (760s left) kms_big_fb (linear-32bpp-rotate-270)
[259.435338] Starting subtest: linear-32bpp-rotate-270
[259.454434] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[259.614150] [041/131] (760s left) device_reset (unbind-reset-rebind)
[259.668265] Starting subtest: unbind-reset-rebind
[264.326240] Subtest unbind-reset-rebind: SUCCESS (4.656s)
[264.362059] [042/131] (755s left) prime_vgem (basic-gtt)
[264.488784] Starting subtest: basic-gtt
[264.493556] Subtest basic-gtt: SKIP (0.000s)
[264.611470] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[264.614722] [043/131] (755s left) kms_pipe_crc_basic (nonblocking-crc)
[264.715261] Starting subtest: nonblocking-crc
[264.717390] Starting dynamic subtest: pipe-A-eDP-1
[265.471981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[265.480727] Starting dynamic subtest: pipe-B-eDP-1
[266.871596] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[266.881058] Starting dynamic subtest: pipe-C-eDP-1
[268.264332] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[268.273489] Starting dynamic subtest: pipe-D-eDP-1
[269.596540] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[269.598846] Subtest nonblocking-crc: SUCCESS (4.881s)
[270.429269] [044/131] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[270.525611] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[270.529729] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[270.652262] [045/131] (749s left) syncobj_timeline (device-signal-unordered)
[270.715489] Starting subtest: device-signal-unordered
[270.717912] Subtest device-signal-unordered: SUCCESS (0.000s)
[270.852941] [046/131] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[270.962331] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[274.735063] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.775s)
[275.924677] [047/131] (744s left) gem_ringfill (basic-all)
[281.879969] Starting subtest: basic-all
[283.044966] Subtest basic-all: SUCCESS (1.164s)
[283.216156] [048/131] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[283.335253] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[290.439873] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.106s)
[290.620369] [049/131] (729s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[290.724799] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[290.736331] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[290.837657] [050/131] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[290.935332] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[290.939706] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[291.059716] [051/131] (729s left) perf_pmu (semaphore-wait-idle)
[291.103964] Starting subtest: semaphore-wait-idle
[291.106177] Starting dynamic subtest: rcs0
[291.616834] Dynamic subtest rcs0: SUCCESS (0.512s)
[291.626866] Starting dynamic subtest: bcs0
[292.130420] Dynamic subtest bcs0: SUCCESS (0.511s)
[292.142496] Starting dynamic subtest: vcs0
[292.644372] Dynamic subtest vcs0: SUCCESS (0.511s)
[292.656730] Starting dynamic subtest: vcs1
[293.157337] Dynamic subtest vcs1: SUCCESS (0.510s)
[293.169250] Starting dynamic subtest: vecs0
[293.669973] Dynamic subtest vecs0: SUCCESS (0.510s)
[293.681605] Starting dynamic subtest: ccs0
[294.185991] Dynamic subtest ccs0: SUCCESS (0.513s)
[294.188770] Subtest semaphore-wait-idle: SUCCESS (3.083s)
[294.344549] [052/131] (725s left) kms_pm_rpm (universal-planes-dpms)
[296.076323] Starting subtest: universal-planes-dpms
[296.078595] Starting dynamic subtest: plane-33
[304.693598] Dynamic subtest plane-33: SUCCESS (8.619s)
[304.705659] Starting dynamic subtest: plane-63
[313.204822] Dynamic subtest plane-63: SUCCESS (8.507s)
[313.216984] Starting dynamic subtest: plane-93
[321.776042] Dynamic subtest plane-93: SUCCESS (8.569s)
[321.787534] Starting dynamic subtest: plane-123
[330.099597] Dynamic subtest plane-123: SUCCESS (8.320s)
[330.111212] Starting dynamic subtest: plane-133
[338.521856] Dynamic subtest plane-133: SUCCESS (8.420s)
[338.533350] Starting dynamic subtest: plane-143
[346.962046] Dynamic subtest plane-143: SUCCESS (8.437s)
[346.964516] Subtest universal-planes-dpms: SUCCESS (50.889s)
[347.341236] [053/131] (673s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[347.477523] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[364.636651] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.159s)
[365.521605] [054/131] (654s left) kms_addfb_basic (invalid-get-prop-any)
[365.577699] Starting subtest: invalid-get-prop-any
[365.579699] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[365.742308] [055/131] (654s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[365.845113] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[365.849352] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[365.957403] [056/131] (654s left) kms_properties (connector-properties-atomic)
[366.051921] Starting subtest: connector-properties-atomic
[366.054175] Starting dynamic subtest: pipe-A-eDP-1
[374.074315] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.020s)
[374.083761] Starting dynamic subtest: pipe-None-DP-1
[374.088736] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[374.097335] Starting dynamic subtest: pipe-None-HDMI-A-1
[374.101654] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[374.110045] Starting dynamic subtest: pipe-None-DP-2
[374.114056] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[374.122082] Starting dynamic subtest: pipe-None-HDMI-A-2
[374.126115] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[374.133702] Starting dynamic subtest: pipe-None-DP-3
[374.137793] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[374.149079] Starting dynamic subtest: pipe-None-DP-4
[374.153484] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[374.155592] Subtest connector-properties-atomic: SUCCESS (8.031s)
[374.972036] [057/131] (645s left) gem_sync (basic-each)
[375.052172] Starting subtest: basic-each
[377.329516] Subtest basic-each: SUCCESS (2.288s)
[377.539750] [058/131] (643s left) kms_invalid_mode (uint-max-clock)
[377.657407] Starting subtest: uint-max-clock
[377.659612] Starting dynamic subtest: pipe-A-eDP-1
[377.933942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[377.943527] Starting dynamic subtest: pipe-B-eDP-1
[377.945430] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[377.953679] Starting dynamic subtest: pipe-C-eDP-1
[377.955961] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[377.964684] Starting dynamic subtest: pipe-D-eDP-1
[377.971102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[377.973643] Subtest uint-max-clock: SUCCESS (0.288s)
[378.790184] [059/131] (641s left) gem_userptr_blits (sync-unmap-after-close)
[378.857945] Starting subtest: sync-unmap-after-close
[378.868978] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[379.040113] [060/131] (641s left) gem_mmap_wc (bad-size)
[379.110232] Subtest bad-size: SKIP (0.000s)
[379.167348] [061/131] (641s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[379.268413] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[379.270853] Starting dynamic subtest: pipe-A-eDP-1
[379.296743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.312620] Starting dynamic subtest: pipe-B-eDP-1
[379.337208] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.347496] Starting dynamic subtest: pipe-C-eDP-1
[379.371333] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.380246] Starting dynamic subtest: pipe-D-eDP-1
[379.405150] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.409225] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[381.468961] [062/131] (639s left) gen3_render_tiledy_blits
[381.603748] [063/131] (639s left) syncobj_wait (single-wait-all-signaled)
[381.646397] Starting subtest: single-wait-all-signaled
[381.648577] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[381.765273] [064/131] (639s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[381.823604] Starting subtest: etime-multi-wait-all-submitted-signaled
[381.928566] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[382.032696] [065/131] (638s left) kms_flip (basic-flip-vs-modeset)
[382.122296] Starting subtest: basic-flip-vs-modeset
[382.124824] Starting dynamic subtest: A-eDP1
[384.732873] Dynamic subtest A-eDP1: SUCCESS (2.609s)
[384.742775] Starting dynamic subtest: B-eDP1
[386.899464] Dynamic subtest B-eDP1: SUCCESS (2.162s)
[386.909027] Starting dynamic subtest: C-eDP1
[388.977629] Dynamic subtest C-eDP1: SUCCESS (2.080s)
[388.986937] Starting dynamic subtest: D-eDP1
[391.129551] Dynamic subtest D-eDP1: SUCCESS (2.151s)
[391.131933] Subtest basic-flip-vs-modeset: SUCCESS (9.010s)
[391.963049] [066/131] (628s left) gem_exec_schedule (timeslicing)
[392.049031] Starting subtest: timeslicing
[392.051347] Starting dynamic subtest: rcs0
[392.058839] Dynamic subtest rcs0: SUCCESS (0.021s)
[392.069283] Starting dynamic subtest: bcs0
[392.079172] Dynamic subtest bcs0: SUCCESS (0.020s)
[392.087788] Starting dynamic subtest: vcs0
[392.100152] Dynamic subtest vcs0: SUCCESS (0.020s)
[392.108419] Starting dynamic subtest: vcs1
[392.120707] Dynamic subtest vcs1: SUCCESS (0.020s)
[392.129138] Starting dynamic subtest: vecs0
[392.141137] Dynamic subtest vecs0: SUCCESS (0.020s)
[392.149599] Starting dynamic subtest: ccs0
[392.161432] Dynamic subtest ccs0: SUCCESS (0.020s)
[392.163739] Subtest timeslicing: SUCCESS (0.124s)
[394.005858] [067/131] (626s left) perf_pmu (module-unload)
[394.101766] Starting subtest: module-unload
[400.819349] Subtest module-unload: FAIL (6.617s)
[400.849693] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[400.850405] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[400.853418] [068/131] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[402.397605] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[408.891318] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.497s)
[409.042264] [FACT kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[409.043632] [FACT kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[409.047939] [069/131] (611s left) gem_eio (create)
[409.204814] Starting subtest: create
[409.364110] Subtest create: SUCCESS (0.160s)
[409.531700] [070/131] (611s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[409.625915] Starting subtest: primary-yf-tiled-reflect-x-90
[409.630363] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[409.722456] [071/131] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[409.830455] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[409.834765] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[409.958450] [072/131] (611s left) gem_spin_batch (spin-all-new)
[410.022235] Starting subtest: spin-all-new
[410.044958] Subtest spin-all-new: SUCCESS (0.023s)
[411.987607] [073/131] (609s left) kms_vblank (query-busy-hang)
[412.095242] Starting subtest: query-busy-hang
[412.097126] Starting dynamic subtest: pipe-A-eDP-1
[438.696040] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.599s)
[438.708819] Starting dynamic subtest: pipe-D-eDP-1
[453.642056] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.944s)
[453.644401] Subtest query-busy-hang: SUCCESS (41.548s)
[454.502457] [074/131] (566s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[459.541700] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[459.544070] Starting dynamic subtest: pipe-A-eDP-1
[471.566891] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.022s)
[471.575652] Starting dynamic subtest: pipe-B-eDP-1
[483.600073] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.029s)
[483.602257] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.058s)
[484.483536] [075/131] (536s left) gen7_exec_parse (batch-without-end)
[484.554931] Subtest batch-without-end: SKIP (0.000s)
[484.636300] [076/131] (536s left) kms_color (ctm-0-25)
[484.733072] Starting subtest: ctm-0-25
[484.734877] Starting dynamic subtest: pipe-A-eDP-1
[488.175856] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[488.184942] Starting dynamic subtest: pipe-B-eDP-1
[492.263867] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.095s)
[492.276914] Starting dynamic subtest: pipe-C-eDP-1
[496.209874] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.945s)
[496.218594] Starting dynamic subtest: pipe-D-eDP-1
[500.237588] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.024s)
[500.239711] Subtest ctm-0-25: SUCCESS (15.505s)
[501.073065] [077/131] (520s left) gem_userptr_blits (userfault)
[501.142073] Starting subtest: userfault
[501.144454] Subtest userfault: SUCCESS (0.006s)
[501.311890] [078/131] (520s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[501.396961] Starting subtest: drrs-dirtyfb-ioctl
[501.410090] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[501.523477] [079/131] (519s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[501.624485] Starting subtest: psr-rgb101010-draw-mmap-gtt
[501.628539] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[501.760183] [080/131] (519s left) kms_plane_alpha_blend (constant-alpha-mid)
[501.859991] Starting subtest: constant-alpha-mid
[502.137033] Starting dynamic subtest: pipe-A-eDP-1
[502.883173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[502.892069] Starting dynamic subtest: pipe-D-eDP-1
[504.308783] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.427s)
[504.311126] Subtest constant-alpha-mid: SUCCESS (2.450s)
[505.137853] [081/131] (516s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[505.234031] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[505.236297] Starting dynamic subtest: pipe-A-default-mode
[507.981071] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[507.983344] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.747s)
[508.836383] [082/131] (512s left) gem_exec_create (madvise)
[508.898265] Starting subtest: madvise
[508.900424] Starting dynamic subtest: smem
[530.005807] Dynamic subtest smem: SUCCESS (21.105s)
[530.008465] Subtest madvise: SUCCESS (21.106s)
[531.091016] [083/131] (490s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[531.230325] Starting subtest: cursorA-vs-flipB-atomic-transitions
[531.234635] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[531.398203] [084/131] (490s left) kms_psr (psr2-sprite-render)
[531.489034] Starting subtest: psr2-sprite-render
[531.491323] Starting dynamic subtest: eDP-1
[533.199944] Dynamic subtest eDP-1: SUCCESS (1.712s)
[533.202343] Subtest psr2-sprite-render: SUCCESS (1.713s)
[534.090540] [085/131] (487s left) kms_flip (modeset-vs-vblank-race-interruptible)
[534.202648] Starting subtest: modeset-vs-vblank-race-interruptible
[534.204845] Starting dynamic subtest: A-eDP1
[538.886518] Dynamic subtest A-eDP1: SUCCESS (4.683s)
[538.897774] Starting dynamic subtest: B-eDP1
[543.511824] Dynamic subtest B-eDP1: SUCCESS (4.623s)
[543.521520] Starting dynamic subtest: C-eDP1
[548.094400] Dynamic subtest C-eDP1: SUCCESS (4.581s)
[548.104095] Starting dynamic subtest: D-eDP1
[552.625360] Dynamic subtest D-eDP1: SUCCESS (4.529s)
[552.627796] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.425s)
[553.817450] [086/131] (467s left) gem_exec_create (legacy)
[553.872497] Starting subtest: legacy
[553.874705] Starting dynamic subtest: smem
[557.845370] Dynamic subtest smem: SUCCESS (3.973s)
[557.848121] Subtest legacy: SUCCESS (3.975s)
[558.059061] [087/131] (463s left) sw_sync (sync_merge_same)
[558.106624] Starting subtest: sync_merge_same
[558.108526] Subtest sync_merge_same: SUCCESS (0.000s)
[558.193411] [088/131] (463s left) i915_pm_rpm (gem-idle)
[559.944716] Starting subtest: gem-idle
[566.159313] Subtest gem-idle: SUCCESS (6.215s)
[566.509135] [089/131] (455s left) gem_ccs (block-multicopy-compressed)
[567.868590] Starting subtest: block-multicopy-compressed
[567.872991] Subtest block-multicopy-compressed: SKIP (0.000s)
[568.018412] [090/131] (453s left) kms_draw_crc (fill-fb)
[568.118878] Starting subtest: fill-fb
[568.559914] Subtest fill-fb: SUCCESS (0.442s)
[568.686551] [091/131] (453s left) gem_exec_reloc (basic-cpu-read-active)
[568.746630] Subtest basic-cpu-read-active: SKIP (0.000s)
[568.814942] [092/131] (453s left) gem_tiled_blits (interruptible)
[568.886215] Subtest interruptible: SKIP (0.000s)
[568.948335] [093/131] (453s left) gem_mmap_gtt (basic-short)
[568.995635] Subtest basic-short: SKIP (0.000s)
[569.057037] [094/131] (452s left) gem_lmem_swapping (verify-random)
[569.101277] Subtest verify-random: SKIP (0.000s)
[569.163320] [095/131] (452s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[569.266555] Starting subtest: x-tiled-8bpp-rotate-0
[570.491355] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.223s)
[570.662197] [096/131] (451s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[570.726588] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[570.728535] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[570.854290] [097/131] (451s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[570.935908] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[570.937713] Starting dynamic subtest: pipe-A-eDP-1
[570.954189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[570.963408] Starting dynamic subtest: pipe-B-eDP-1
[570.979234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[570.987101] Starting dynamic subtest: pipe-C-eDP-1
[571.002423] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[571.010058] Starting dynamic subtest: pipe-D-eDP-1
[571.025293] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[571.027046] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[573.184232] [098/131] (449s left) syncobj_timeline (single-wait-for-submit-signaled)
[573.251820] Starting subtest: single-wait-for-submit-signaled
[573.254276] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[573.385908] [099/131] (448s left) kms_addfb_basic (addfb25-4-tiled)
[573.513080] Starting subtest: addfb25-4-tiled
[573.515435] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[573.645233] [100/131] (448s left) i915_drm_fdinfo (busy-check-all)
[573.686205] Starting subtest: busy-check-all
[573.688483] Starting dynamic subtest: rcs0
[573.692945] Dynamic subtest rcs0: SKIP (0.003s)
[573.706076] Starting dynamic subtest: bcs0
[573.710531] Dynamic subtest bcs0: SKIP (0.000s)
[573.723562] Starting dynamic subtest: vcs0
[573.728050] Dynamic subtest vcs0: SKIP (0.000s)
[573.738111] Starting dynamic subtest: vcs1
[573.742407] Dynamic subtest vcs1: SKIP (0.000s)
[573.750064] Starting dynamic subtest: vecs0
[573.754270] Dynamic subtest vecs0: SKIP (0.000s)
[573.762081] Starting dynamic subtest: ccs0
[573.766259] Dynamic subtest ccs0: SKIP (0.000s)
[573.770552] Subtest busy-check-all: SKIP (0.008s)
[573.806101] [101/131] (448s left) gem_exec_reloc (basic-concurrent0)
[573.873240] Subtest basic-concurrent0: SKIP (0.000s)
[573.977112] [102/131] (448s left) prime_mmap (test_map_unmap)
[574.038608] Starting subtest: test_map_unmap
[574.040920] Starting dynamic subtest: test_map_unmap-smem
[574.065806] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[574.068181] Subtest test_map_unmap: SUCCESS (0.030s)
[574.212362] [103/131] (448s left) gem_exec_store (dword)
[574.280886] Starting subtest: dword
[574.282976] Starting dynamic subtest: rcs0
[574.377518] Dynamic subtest rcs0: SUCCESS (0.098s)
[574.388765] Starting dynamic subtest: bcs0
[574.419190] Dynamic subtest bcs0: SUCCESS (0.039s)
[574.431724] Starting dynamic subtest: vcs0
[574.461799] Dynamic subtest vcs0: SUCCESS (0.040s)
[574.471069] Starting dynamic subtest: vcs1
[574.502702] Dynamic subtest vcs1: SUCCESS (0.039s)
[574.512485] Starting dynamic subtest: vecs0
[574.544687] Dynamic subtest vecs0: SUCCESS (0.040s)
[574.555791] Starting dynamic subtest: ccs0
[574.587154] Dynamic subtest ccs0: SUCCESS (0.040s)
[574.589485] Subtest dword: SUCCESS (0.309s)
[574.796282] [104/131] (447s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[574.908853] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[574.913210] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[575.084843] [105/131] (447s left) kms_cursor_edge_walk (64x64-top-bottom)
[575.186654] Starting subtest: 64x64-top-bottom
[575.188832] Starting dynamic subtest: pipe-A-eDP-1
[578.637723] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[578.648218] Starting dynamic subtest: pipe-D-eDP-1
[581.765136] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[581.767420] Subtest 64x64-top-bottom: SUCCESS (6.579s)
[582.588809] [106/131] (439s left) kms_invalid_mode (bad-htotal)
[582.681071] Starting subtest: bad-htotal
[582.683355] Starting dynamic subtest: pipe-A-eDP-1
[582.966422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[582.975908] Starting dynamic subtest: pipe-B-eDP-1
[582.978323] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[582.986397] Starting dynamic subtest: pipe-C-eDP-1
[582.988696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[582.996621] Starting dynamic subtest: pipe-D-eDP-1
[582.998746] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[583.000921] Subtest bad-htotal: SUCCESS (0.289s)
[583.819980] [107/131] (438s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[583.920791] Starting subtest: yf-tiled-8bpp-rotate-270
[583.925280] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[584.053922] [108/131] (438s left) prime_mmap (test_invalid_sync_flags)
[584.110442] Starting subtest: test_invalid_sync_flags
[584.112641] Starting dynamic subtest: test_invalid_sync_flags-smem
[584.114863] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[584.117079] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[584.220677] [109/131] (438s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[584.325340] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[592.983333] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.660s)
[593.120222] [110/131] (429s left) kms_chamelium_edid (dp-edid-resolution-list)
[593.522735] Subtest dp-edid-resolution-list: SKIP (0.000s)
[594.353447] [111/131] (428s left) gem_mmap_gtt (isolation)
[594.412649] Subtest isolation: SKIP (0.000s)
[594.468231] [112/131] (428s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[594.528630] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[594.530936] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[594.665282] [113/131] (428s left) kms_color (ctm-signed)
[594.759294] Starting subtest: ctm-signed
[594.761520] Starting dynamic subtest: pipe-A-eDP-1
[596.822484] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.062s)
[596.831828] Starting dynamic subtest: pipe-B-eDP-1
[599.593583] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[599.602506] Starting dynamic subtest: pipe-C-eDP-1
[602.237473] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.645s)
[602.247053] Starting dynamic subtest: pipe-D-eDP-1
[604.889018] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.650s)
[604.891305] Subtest ctm-signed: SUCCESS (10.127s)
[605.731746] [114/131] (417s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[605.834432] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[605.838467] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[605.959643] [115/131] (416s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[610.992596] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[610.997388] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[611.857032] [116/131] (411s left) gem_exec_fence (expired-history)
[612.305269] Starting subtest: expired-history
[619.673266] Subtest expired-history: SUCCESS (7.368s)
[620.356685] [117/131] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[620.466097] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[620.470095] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[620.615115] [118/131] (402s left) gem_ctx_persistence (many-contexts)
[620.688341] Starting subtest: many-contexts
[665.934029] Subtest many-contexts: SUCCESS (45.246s)
[666.043715] [119/131] (357s left) kms_feature_discovery (psr1)
[666.144845] Starting subtest: psr1
[666.147162] Subtest psr1: SUCCESS (0.000s)
[666.239696] [120/131] (356s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[666.358865] Starting subtest: flip-vs-cursor-toggle
[674.815473] Subtest flip-vs-cursor-toggle: SUCCESS (8.454s)
[675.688306] [121/131] (347s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[675.810880] Starting subtest: yf-tiled-64bpp-rotate-270
[675.815072] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[675.952910] [122/131] (347s left) sw_sync (sync_merge)
[675.996094] Starting subtest: sync_merge
[675.997874] Subtest sync_merge: SUCCESS (0.000s)
[676.075932] [123/131] (347s left) gem_exec_schedule (preempt-queue)
[676.152478] Subtest preempt-queue: SKIP (0.000s)
[676.461882] [124/131] (346s left) kms_psr (fbc-pr-no-drrs)
[676.551677] Starting subtest: fbc-pr-no-drrs
[676.555802] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[676.646388] [125/131] (346s left) gem_userptr_blits (sync-overlap)
[676.730783] Starting subtest: sync-overlap
[676.732769] Subtest sync-overlap: SUCCESS (0.000s)
[676.905111] [126/131] (346s left) kms_plane (plane-panning-bottom-right)
[676.997205] Starting subtest: plane-panning-bottom-right
[676.999122] Starting dynamic subtest: pipe-A
[678.635069] Dynamic subtest pipe-A: SUCCESS (1.635s)
[678.643718] Starting dynamic subtest: pipe-B
[680.864791] Dynamic subtest pipe-B: SUCCESS (2.232s)
[680.867221] Subtest plane-panning-bottom-right: SUCCESS (3.869s)
[681.715080] [127/131] (341s left) kms_plane_scaling (2x-scaler-multi-pipe)
[681.813861] Starting subtest: 2x-scaler-multi-pipe
[681.818414] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[681.937978] [128/131] (341s left) kms_chamelium_color (ctm-limited-range)
[682.044111] Subtest ctm-limited-range: SKIP (0.000s)
[682.086937] [129/131] (341s left) gem_exec_balancer (bonded-true-hang)
[682.351069] Starting subtest: bonded-true-hang
[682.356061] Subtest bonded-true-hang: SKIP (0.000s)
[682.491114] [130/131] (341s left) kms_cursor_crc (cursor-offscreen-64x64)
[682.673070] Starting subtest: cursor-offscreen-64x64
[682.675453] Starting dynamic subtest: pipe-A-eDP-1
[684.606359] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[684.636946] Starting dynamic subtest: pipe-D-eDP-1
[687.184912] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[687.186857] Subtest cursor-offscreen-64x64: SUCCESS (4.512s)
[688.071196] [131/131] (335s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[688.175016] Starting subtest: fbc-psr2-sprite-mmap-gtt
[688.177317] Starting dynamic subtest: eDP-1
[688.181659] Dynamic subtest eDP-1: SKIP (0.000s)
[688.186101] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[688.267708] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: api_intel_allocator
results: parsing output: 6/ for test: kms_busy
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: gem_reg_read
results: parsing output: 10/ for test: kms_pm_backlight
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: i915_suspend
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: i915_pm_freq_api
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: kms_scaling_modes
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: sysfs_preempt_timeout
results: parsing output: 26/ for test: gem_ctx_engines
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_vrr
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: device_reset
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ringfill
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_properties
results: parsing output: 56/ for test: gem_sync
results: parsing output: 57/ for test: kms_invalid_mode
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gen3_render_tiledy_blits
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_rotation_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: gen7_exec_parse
results: parsing output: 75/ for test: kms_color
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_dirtyfb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane_alpha_blend
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_exec_create
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_exec_create
results: parsing output: 86/ for test: sw_sync
results: parsing output: 87/ for test: i915_pm_rpm
results: parsing output: 88/ for test: gem_ccs
results: parsing output: 89/ for test: kms_draw_crc
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: gem_tiled_blits
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: prime_mmap
results: parsing output: 102/ for test: gem_exec_store
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_cursor_edge_walk
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_edid
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_feature_discovery
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_chamelium_color
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_psr
Done.