[64.847975] Initializing watchdogs
[64.848046]   /dev/watchdog0
[64.861201] [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]
[64.865481] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.867736] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.871089] [001/133] (960s left) i915_pm_rps (thresholds-idle)
[64.954853] Starting subtest: thresholds-idle
[64.959449] Subtest thresholds-idle: SKIP (0.001s)
[65.027869] [002/133] (960s left) perf_pmu (rc6-all-gts)
[65.066057] Starting subtest: rc6-all-gts
[71.462812] Subtest rc6-all-gts: SUCCESS (6.389s)
[72.346934] [003/133] (953s left) syncobj_basic (create-signaled)
[72.402604] Starting subtest: create-signaled
[72.404905] Subtest create-signaled: SUCCESS (0.000s)
[72.496645] [004/133] (952s left) gem_madvise (dontneed-before-pwrite)
[72.528695] Starting subtest: dontneed-before-pwrite
[72.548682] Subtest dontneed-before-pwrite: SKIP (0.017s)
[72.606135] [005/133] (952s left) kms_universal_plane (universal-plane-functional)
[72.715276] Starting subtest: universal-plane-functional
[72.717232] Starting dynamic subtest: pipe-A-eDP-1
[76.676626] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.958s)
[76.685802] Starting dynamic subtest: pipe-B-eDP-1
[81.185772] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.507s)
[81.194794] Starting dynamic subtest: pipe-C-eDP-1
[85.535702] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.348s)
[85.542973] Starting dynamic subtest: pipe-D-eDP-1
[89.911565] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.372s)
[89.913526] Subtest universal-plane-functional: SUCCESS (17.188s)
[90.697502] [006/133] (934s left) kms_lease (lessee-list)
[90.809191] Starting subtest: lessee-list
[90.811506] Starting dynamic subtest: pipe-A-eDP-1
[90.813812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[90.821300] Starting dynamic subtest: pipe-B-eDP-1
[90.823522] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[90.831059] Starting dynamic subtest: pipe-C-eDP-1
[90.833305] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[90.840320] Starting dynamic subtest: pipe-D-eDP-1
[90.842479] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[90.844673] Subtest lessee-list: SUCCESS (0.007s)
[90.918689] [007/133] (934s left) kms_dp_aux_dev (basic)
[90.984206] Starting subtest: basic
[91.206955] Subtest basic: SUCCESS (0.221s)
[91.275963] [008/133] (934s left) i915_pm_freq_mult (media-freq)
[91.323054] Starting subtest: media-freq
[91.325045] Starting dynamic subtest: gt0
[91.329598] Dynamic subtest gt0: SKIP (0.000s)
[91.339073] Starting dynamic subtest: gt1
[91.343510] Dynamic subtest gt1: SKIP (0.000s)
[91.347876] Subtest media-freq: SKIP (0.001s)
[91.433946] [009/133] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[91.535793] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[98.828157] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.294s)
[98.969397] [010/133] (926s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[99.065861] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[99.067969] Starting dynamic subtest: pipe-A-eDP-1
[99.092149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.101176] Starting dynamic subtest: pipe-B-eDP-1
[99.124035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.130671] Starting dynamic subtest: pipe-C-eDP-1
[99.153423] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.160368] Starting dynamic subtest: pipe-D-eDP-1
[99.184163] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.188490] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[101.302643] [011/133] (924s left) kms_pm_backlight (fade-with-suspend)
[101.404951] Starting subtest: fade-with-suspend
[117.224505] Starting dynamic subtest: eDP-1
[119.728137] Dynamic subtest eDP-1: SUCCESS (2.467s)
[119.730575] Subtest fade-with-suspend: SUCCESS (3.813s)
[120.594647] [012/133] (905s left) gem_caching (writes)
[120.677635] Subtest writes: SKIP (0.000s)
[120.749276] [013/133] (905s left) i915_drm_fdinfo (all-busy-check-all)
[120.788746] Starting subtest: all-busy-check-all
[120.795545] Subtest all-busy-check-all: SKIP (0.004s)
[120.852180] [014/133] (904s left) gem_mmap_wc (read)
[120.935939] Subtest read: SKIP (0.000s)
[120.996221] [015/133] (904s left) api_intel_bb (reset-bb)
[121.056353] Starting subtest: reset-bb
[121.058994] Subtest reset-bb: SUCCESS (0.004s)
[121.170720] [016/133] (904s left) gem_mmap_gtt (big-copy-xy)
[121.229900] Subtest big-copy-XY: SKIP (0.000s)
[121.297444] [017/133] (904s left) kms_invalid_mode (bad-vsync-start)
[121.402613] Starting subtest: bad-vsync-start
[121.404718] Starting dynamic subtest: pipe-A-eDP-1
[121.687382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[121.696953] Starting dynamic subtest: pipe-B-eDP-1
[121.699170] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[121.707218] Starting dynamic subtest: pipe-C-eDP-1
[121.709351] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[121.717162] Starting dynamic subtest: pipe-D-eDP-1
[121.719281] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[121.721493] Subtest bad-vsync-start: SUCCESS (0.288s)
[122.549150] [018/133] (903s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[122.654699] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[122.659116] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[122.759544] [019/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[122.858851] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[122.863110] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.951511] [020/133] (903s left) kms_psr (fbc-psr2-primary-page-flip)
[123.041829] Starting subtest: fbc-psr2-primary-page-flip
[123.043943] Starting dynamic subtest: eDP-1
[123.048180] Dynamic subtest eDP-1: SKIP (0.000s)
[123.052640] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[123.110189] [021/133] (903s left) i915_drm_fdinfo (virtual-busy-hang-all)
[123.153823] Starting subtest: virtual-busy-hang-all
[123.158169] Subtest virtual-busy-hang-all: SKIP (0.000s)
[123.220326] [022/133] (902s left) kms_cdclk (mode-transition-all-outputs)
[123.315225] Starting subtest: mode-transition-all-outputs
[123.606108] Subtest mode-transition-all-outputs: SKIP (0.286s)
[124.405798] [023/133] (901s left) gem_tiled_partial_pwrite_pread (writes)
[124.473724] Subtest writes: SKIP (0.000s)
[124.541658] [024/133] (901s left) gem_ctx_persistence (heartbeat-many)
[124.596832] Starting subtest: heartbeat-many
[124.601044] Subtest heartbeat-many: SKIP (0.000s)
[124.692190] [025/133] (901s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[124.740268] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[124.742126] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[124.817816] [026/133] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[124.926765] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[124.930660] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[125.020054] [027/133] (901s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[125.115706] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[125.119950] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[125.214418] [028/133] (901s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[125.335831] Starting subtest: cursorA-vs-flipB-varying-size
[125.340322] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[125.480353] [029/133] (900s left) kms_plane (pixel-format-4-tiled-modifier)
[125.582072] Starting subtest: pixel-format-4-tiled-modifier
[125.608041] Starting dynamic subtest: pipe-A-plane-0
[126.234968] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[126.243727] Starting dynamic subtest: pipe-A-plane-3
[126.671398] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s)
[126.680263] Starting dynamic subtest: pipe-A-plane-5
[126.683806] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[127.812140] Starting dynamic subtest: pipe-B-plane-0
[128.465297] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[128.475694] Starting dynamic subtest: pipe-B-plane-3
[128.889430] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[128.898326] Starting dynamic subtest: pipe-B-plane-5
[128.904687] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[129.203076] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.595s)
[129.989988] [030/133] (896s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[130.091515] Starting subtest: psr-indfb-scaledprimary
[135.851906] Subtest psr-indfb-scaledprimary: SUCCESS (5.743s)
[135.966094] [031/133] (890s left) kms_psr (pr-sprite-mmap-cpu)
[136.063431] Starting subtest: pr-sprite-mmap-cpu
[136.070182] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[136.139863] [032/133] (890s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[136.235243] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[136.239513] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[136.316864] [033/133] (890s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[136.410634] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[136.412972] Starting dynamic subtest: pipe-A-eDP-1
[136.495744] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[136.504675] Starting dynamic subtest: pipe-B-eDP-1
[137.613857] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[137.618269] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.205s)
[138.805405] [034/133] (887s left) gem_exec_params (rel-constants-invalid-ring)
[138.860535] Starting subtest: rel-constants-invalid-ring
[138.862802] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[138.975424] [035/133] (887s left) gem_workarounds (reset)
[139.037812] Starting subtest: reset
[139.192897] Subtest reset: SUCCESS (0.155s)
[139.323340] [036/133] (887s left) syncobj_timeline (wait-all-for-submit-complex)
[139.384086] Starting subtest: wait-all-for-submit-complex
[139.599061] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[139.672409] [037/133] (887s left) gen9_exec_parse (allowed-all)
[139.731780] Subtest allowed-all: SKIP (0.000s)
[139.798835] [038/133] (886s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[139.894689] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[139.896935] Starting dynamic subtest: pipe-A
[140.254776] Dynamic subtest pipe-A: SUCCESS (0.361s)
[140.264074] Starting dynamic subtest: pipe-B
[141.696616] Dynamic subtest pipe-B: SUCCESS (1.439s)
[141.706616] Starting dynamic subtest: pipe-C
[143.126863] Dynamic subtest pipe-C: SUCCESS (1.427s)
[143.136945] Starting dynamic subtest: pipe-D
[144.573052] Dynamic subtest pipe-D: SUCCESS (1.444s)
[144.575374] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.675s)
[145.729318] [039/133] (881s left) kms_big_fb (4-tiled-addfb-size-overflow)
[145.831975] Starting subtest: 4-tiled-addfb-size-overflow
[145.834177] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[145.929861] [040/133] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[146.028604] Starting subtest: addfb25-yf-tiled-legacy
[146.030917] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[146.114219] [041/133] (880s left) kms_busy (extended-modeset-hang-oldfb)
[146.223404] Starting subtest: extended-modeset-hang-oldfb
[146.225664] Starting dynamic subtest: pipe-A
[157.811871] Dynamic subtest pipe-A: SUCCESS (11.584s)
[157.822048] Starting dynamic subtest: pipe-D
[170.089796] Dynamic subtest pipe-D: SUCCESS (12.270s)
[170.092009] Subtest extended-modeset-hang-oldfb: SUCCESS (23.858s)
[170.879589] [042/133] (856s left) kms_psr (psr-primary-mmap-cpu)
[170.977749] Starting subtest: psr-primary-mmap-cpu
[170.980124] Starting dynamic subtest: eDP-1
[172.681116] Dynamic subtest eDP-1: SUCCESS (1.701s)
[172.683465] Subtest psr-primary-mmap-cpu: SUCCESS (1.702s)
[173.554448] [043/133] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[173.658903] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[173.663175] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[173.754368] [044/133] (853s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[173.848364] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[174.684311] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[174.846894] [045/133] (852s left) gem_exec_whisper (basic-fds-forked-all)
[174.909577] Starting subtest: basic-fds-forked-all
[195.286210] Subtest basic-fds-forked-all: SUCCESS (20.363s)
[195.463217] [046/133] (831s left) kms_chamelium_color (degamma)
[195.570726] Subtest degamma: SKIP (0.000s)
[195.614237] [047/133] (831s left) gem_exec_schedule (preempt-other-chain)
[195.678172] Starting subtest: preempt-other-chain
[195.680284] Starting dynamic subtest: rcs0
[195.764949] Dynamic subtest rcs0: SUCCESS (0.090s)
[195.776225] Starting dynamic subtest: bcs0
[195.844271] Dynamic subtest bcs0: SUCCESS (0.080s)
[195.854206] Starting dynamic subtest: vcs0
[195.931134] Dynamic subtest vcs0: SUCCESS (0.084s)
[195.945815] Starting dynamic subtest: vcs1
[196.016280] Dynamic subtest vcs1: SUCCESS (0.085s)
[196.028703] Starting dynamic subtest: vecs0
[196.098712] Dynamic subtest vecs0: SUCCESS (0.081s)
[196.108584] Starting dynamic subtest: ccs0
[196.194217] Dynamic subtest ccs0: SUCCESS (0.095s)
[196.196562] Subtest preempt-other-chain: SUCCESS (0.522s)
[197.507833] [048/133] (829s left) gem_exec_params (invalid-fence-in)
[197.559353] Starting subtest: invalid-fence-in
[197.561779] Subtest invalid-fence-in: SUCCESS (0.000s)
[197.653036] [049/133] (829s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[197.758597] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[197.762953] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[197.826672] [050/133] (829s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[197.911456] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[197.922081] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[197.998671] [051/133] (829s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[198.096712] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[198.098886] Starting dynamic subtest: pipe-A-eDP-1
[198.121237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.132207] Starting dynamic subtest: pipe-B-eDP-1
[198.153660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.163376] Starting dynamic subtest: pipe-C-eDP-1
[198.184620] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.193232] Starting dynamic subtest: pipe-D-eDP-1
[198.215646] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.219653] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[200.244662] [052/133] (827s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[200.641652] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[201.460769] [053/133] (825s left) fbdev (write)
[201.499612] Starting subtest: write
[202.171416] Subtest write: SUCCESS (0.670s)
[202.236977] [054/133] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[202.336026] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[206.712667] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.378s)
[207.885528] [055/133] (819s left) gem_ctx_engines (execute-allforone)
[207.946740] Starting subtest: execute-allforone
[207.959376] Subtest execute-allforone: SUCCESS (0.013s)
[209.459603] [056/133] (818s left) kms_getfb (getfb2-handle-closed)
[209.554444] Starting subtest: getfb2-handle-closed
[209.556570] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[209.657948] [057/133] (817s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[209.755748] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[209.760061] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[209.851281] [058/133] (817s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[209.969042] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[211.140234] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.170s)
[211.249152] [059/133] (816s left) gem_bad_reloc (negative-reloc-bltcopy)
[211.300972] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[211.368233] [060/133] (816s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[211.458395] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[211.461886] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[211.548791] [061/133] (816s left) gem_exec_basic (basic)
[211.598969] Starting subtest: basic
[211.601194] Starting dynamic subtest: rcs0-smem
[211.603416] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[211.614710] Starting dynamic subtest: bcs0-smem
[211.616231] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[211.624943] Starting dynamic subtest: vcs0-smem
[211.626525] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[211.638223] Starting dynamic subtest: vcs1-smem
[211.639975] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[211.648287] Starting dynamic subtest: vecs0-smem
[211.649942] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[211.658031] Starting dynamic subtest: ccs0-smem
[211.659590] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[211.661160] Subtest basic: SUCCESS (0.014s)
[213.444242] [062/133] (814s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[213.540878] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[213.544761] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.618531] [063/133] (814s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[213.719856] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[213.723965] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[213.809959] [064/133] (814s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[213.868128] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[213.927329] [065/133] (813s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[214.028880] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[214.031061] Starting dynamic subtest: pipe-A-eDP-1
[214.050766] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[214.062817] Starting dynamic subtest: pipe-B-eDP-1
[214.081674] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[214.090357] Starting dynamic subtest: pipe-C-eDP-1
[214.109248] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[214.117919] Starting dynamic subtest: pipe-D-eDP-1
[214.137332] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[214.139594] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[216.345698] [066/133] (811s left) gem_ctx_param (invalid-param-set)
[216.402573] Starting subtest: invalid-param-set
[216.404911] Subtest invalid-param-set: SUCCESS (0.000s)
[216.478276] [067/133] (811s left) gem_exec_schedule (fairslice-all)
[216.564169] Starting subtest: fairslice-all
[218.615113] Subtest fairslice-all: SUCCESS (2.056s)
[218.916047] [068/133] (809s left) gem_spin_batch (resubmit-new-all)
[218.977537] Starting subtest: resubmit-new-all
[218.979830] Starting dynamic subtest: rcs0
[218.997727] Dynamic subtest rcs0: SUCCESS (0.020s)
[219.011900] Starting dynamic subtest: bcs0
[219.014044] Dynamic subtest bcs0: SUCCESS (0.014s)
[219.022789] Starting dynamic subtest: vcs0
[219.029340] Dynamic subtest vcs0: SUCCESS (0.016s)
[219.038659] Starting dynamic subtest: vcs1
[219.051120] Dynamic subtest vcs1: SUCCESS (0.021s)
[219.060203] Starting dynamic subtest: vecs0
[219.068883] Dynamic subtest vecs0: SUCCESS (0.015s)
[219.078085] Starting dynamic subtest: ccs0
[219.087956] Dynamic subtest ccs0: SUCCESS (0.018s)
[219.090195] Subtest resubmit-new-all: SUCCESS (0.111s)
[220.421136] [069/133] (807s left) syncobj_timeline (multi-wait-available-submitted)
[220.483551] Starting subtest: multi-wait-available-submitted
[220.486012] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[220.589112] [070/133] (807s left) kms_content_protection (atomic)
[220.748731] Starting subtest: atomic
[220.752717] Subtest atomic: SKIP (0.000s)
[220.879873] [071/133] (807s left) kms_vblank (ts-continuation-modeset-hang)
[220.966005] Starting subtest: ts-continuation-modeset-hang
[220.968224] Starting dynamic subtest: pipe-A-eDP-1
[247.196659] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.233s)
[247.211558] Starting dynamic subtest: pipe-D-eDP-1
[262.110626] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.910s)
[262.113130] Subtest ts-continuation-modeset-hang: SUCCESS (41.149s)
[262.971042] [072/133] (765s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[263.063107] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[263.065538] Starting dynamic subtest: pipe-A
[263.083751] Dynamic subtest pipe-A: SKIP (0.017s)
[263.093816] Starting dynamic subtest: pipe-B
[263.114058] Dynamic subtest pipe-B: SKIP (0.029s)
[263.125117] Starting dynamic subtest: pipe-C
[263.143061] Dynamic subtest pipe-C: SKIP (0.029s)
[263.152328] Starting dynamic subtest: pipe-D
[263.172766] Dynamic subtest pipe-D: SKIP (0.029s)
[263.177062] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.108s)
[263.294391] [073/133] (764s left) gem_mmap_offset (bad-object)
[263.343386] Starting subtest: bad-object
[263.345261] Subtest bad-object: SUCCESS (0.001s)
[263.455369] [074/133] (764s left) sysfs_preempt_timeout (timeout)
[263.515047] Starting subtest: timeout
[263.517359] Starting dynamic subtest: vecs0
[273.371816] Dynamic subtest vecs0: SUCCESS (9.851s)
[273.384193] Starting dynamic subtest: ccs0
[274.589488] Dynamic subtest ccs0: SUCCESS (1.216s)
[274.601027] Starting dynamic subtest: vcs0
[284.378873] Dynamic subtest vcs0: SUCCESS (9.785s)
[284.391034] Starting dynamic subtest: bcs0
[285.507044] Dynamic subtest bcs0: SUCCESS (1.127s)
[285.519578] Starting dynamic subtest: rcs0
[286.629902] Dynamic subtest rcs0: SUCCESS (1.122s)
[286.641760] Starting dynamic subtest: vcs1
[296.413955] Dynamic subtest vcs1: SUCCESS (9.780s)
[296.416564] Subtest timeout: SUCCESS (32.889s)
[296.486455] [075/133] (731s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[296.578417] Starting subtest: plane-lut1d-pre-ctm3x4
[296.701882] Starting dynamic subtest: pipe-A-plane-0
[296.869310] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[296.880246] Starting dynamic subtest: pipe-A-plane-1
[297.013716] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[297.024658] Starting dynamic subtest: pipe-A-plane-2
[297.157176] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[298.402070] Starting dynamic subtest: pipe-B-plane-0
[298.580068] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s)
[298.589919] Starting dynamic subtest: pipe-B-plane-1
[298.758887] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[298.768852] Starting dynamic subtest: pipe-B-plane-2
[298.891593] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[300.084397] Starting dynamic subtest: pipe-C-plane-0
[300.210511] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[300.220244] Starting dynamic subtest: pipe-C-plane-1
[300.343762] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[300.353338] Starting dynamic subtest: pipe-C-plane-2
[300.488170] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[301.722429] Starting dynamic subtest: pipe-D-plane-0
[301.847654] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[301.857689] Starting dynamic subtest: pipe-D-plane-1
[301.981189] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[301.991238] Starting dynamic subtest: pipe-D-plane-2
[302.114573] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[302.417401] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.839s)
[303.227372] [076/133] (725s left) gem_exec_fence (invalid-fence-array)
[303.747574] Starting subtest: invalid-fence-array
[303.750063] Subtest invalid-fence-array: SUCCESS (0.002s)
[305.453514] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[305.457099] [077/133] (722s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[305.561572] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[305.563765] Starting dynamic subtest: pipe-A-eDP-1
[321.456888] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.431s)
[321.469433] Starting dynamic subtest: pipe-B-eDP-1
[338.441185] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.424s)
[338.451322] Starting dynamic subtest: pipe-C-eDP-1
[355.398503] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.292s)
[355.409040] Starting dynamic subtest: pipe-D-eDP-1
[372.431789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.369s)
[372.434095] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.521s)
[373.673300] [078/133] (654s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[373.788047] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[378.264535] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.417s)
[379.459311] [079/133] (648s left) gem_exec_create (basic)
[379.519305] Starting subtest: basic
[379.521580] Starting dynamic subtest: smem
[381.605832] Dynamic subtest smem: SUCCESS (2.070s)
[381.608405] Subtest basic: SUCCESS (2.071s)
[381.789907] [080/133] (646s left) kms_rmfb (close-fd)
[381.893353] Starting subtest: close-fd
[381.895283] Starting dynamic subtest: pipe-A-eDP-1
[382.001539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[382.012308] Starting dynamic subtest: pipe-B-eDP-1
[383.161136] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[383.171167] Starting dynamic subtest: pipe-C-eDP-1
[384.286354] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[384.296373] Starting dynamic subtest: pipe-D-eDP-1
[385.412093] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[385.414363] Subtest close-fd: SUCCESS (3.501s)
[386.623724] [081/133] (641s left) kms_psr (fbc-psr-primary-mmap-cpu)
[386.718336] Starting subtest: fbc-psr-primary-mmap-cpu
[386.720634] Starting dynamic subtest: eDP-1
[386.724844] Dynamic subtest eDP-1: SKIP (0.000s)
[386.729134] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[386.792474] [082/133] (641s left) prime_vgem (busy)
[386.849753] Starting subtest: busy
[386.851627] Starting dynamic subtest: rcs0
[386.924024] Dynamic subtest rcs0: SUCCESS (0.076s)
[386.935108] Starting dynamic subtest: bcs0
[387.002425] Dynamic subtest bcs0: SUCCESS (0.077s)
[387.011955] Starting dynamic subtest: vcs0
[387.050668] Dynamic subtest vcs0: SUCCESS (0.047s)
[387.060258] Starting dynamic subtest: vcs1
[387.095212] Dynamic subtest vcs1: SUCCESS (0.043s)
[387.104739] Starting dynamic subtest: vecs0
[387.139280] Dynamic subtest vecs0: SUCCESS (0.043s)
[387.148791] Starting dynamic subtest: ccs0
[387.186645] Dynamic subtest ccs0: SUCCESS (0.046s)
[387.188787] Subtest busy: SUCCESS (0.339s)
[387.309473] [083/133] (641s left) syncobj_basic (bad-flags-fd-to-handle)
[387.362636] Starting subtest: bad-flags-fd-to-handle
[387.364841] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[387.469548] [084/133] (641s left) gem_mmap_wc (bad-object)
[387.521539] Subtest bad-object: SKIP (0.000s)
[387.580901] [085/133] (641s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[387.677032] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[387.680322] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[387.789885] [086/133] (640s left) gem_exec_balancer (nop)
[387.857895] Starting subtest: nop
[434.399248] Subtest nop: SUCCESS (46.520s)
[434.705656] [087/133] (594s left) gem_exec_params (no-bsd)
[434.763988] Starting subtest: no-bsd
[434.770311] Subtest no-bsd: SUCCESS (0.006s)
[436.601617] [088/133] (592s left) kms_cursor_crc (cursor-onscreen-256x85)
[436.875545] Starting subtest: cursor-onscreen-256x85
[436.927684] Subtest cursor-onscreen-256x85: SKIP (0.047s)
[437.126876] [089/133] (591s left) kms_vrr (flip-suspend)
[437.222277] Starting subtest: flip-suspend
[437.228265] Subtest flip-suspend: SKIP (0.000s)
[437.294724] [090/133] (591s left) gem_userptr_blits (coherency-sync)
[437.379333] Starting subtest: coherency-sync
[437.828001] Subtest coherency-sync: SKIP (0.415s)
[437.921214] [091/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[438.073815] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[438.077790] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[438.184537] [092/133] (590s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[438.278375] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[439.091641] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s)
[439.263882] [093/133] (589s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[439.326654] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[439.435194] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[439.526370] [094/133] (589s left) prime_vgem (basic-fence-read)
[439.611680] Starting subtest: basic-fence-read
[439.622874] Subtest basic-fence-read: SKIP (0.009s)
[439.726744] [095/133] (589s left) kms_psr (psr2-cursor-mmap-cpu)
[439.823045] Starting subtest: psr2-cursor-mmap-cpu
[439.825292] Starting dynamic subtest: eDP-1
[441.528814] Dynamic subtest eDP-1: SUCCESS (1.703s)
[441.530948] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.704s)
[442.345871] [096/133] (586s left) kms_atomic (plane-overlay-legacy)
[442.445260] Starting subtest: plane-overlay-legacy
[442.447344] Starting dynamic subtest: pipe-A-eDP-1
[442.855303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[442.857140] Subtest plane-overlay-legacy: SUCCESS (0.410s)
[443.658654] [097/133] (585s left) gem_gpgpu_fill (offset-16x16)
[443.714967] Starting subtest: offset-16x16
[443.721261] Subtest offset-16x16: SUCCESS (0.008s)
[443.857641] [098/133] (585s left) syncobj_timeline (invalid-query-illegal-handle)
[443.913068] Starting subtest: invalid-query-illegal-handle
[443.915389] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[444.013352] [099/133] (585s left) gem_exec_schedule (preempt-queue-contexts-chain)
[444.091125] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[444.378143] [100/133] (584s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[444.483219] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[444.485084] Starting dynamic subtest: A-eDP1
[448.079475] Dynamic subtest A-eDP1: SUCCESS (3.594s)
[448.090090] Starting dynamic subtest: B-eDP1
[451.286187] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[451.296720] Starting dynamic subtest: C-eDP1
[454.386552] Dynamic subtest C-eDP1: SUCCESS (3.096s)
[454.397493] Starting dynamic subtest: D-eDP1
[457.483301] Dynamic subtest D-eDP1: SUCCESS (3.096s)
[457.485584] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.999s)
[458.290972] [101/133] (571s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[458.567753] Starting subtest: cursor-rapid-movement-256x85
[458.614310] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[458.786524] [102/133] (570s left) gem_ctx_shared (exec-single-timeline)
[458.862668] Starting subtest: exec-single-timeline
[458.864940] Starting dynamic subtest: rcs0
[459.940032] Dynamic subtest rcs0: SUCCESS (1.075s)
[459.953258] Starting dynamic subtest: bcs0
[461.028625] Dynamic subtest bcs0: SUCCESS (1.084s)
[461.041651] Starting dynamic subtest: vcs0
[462.117513] Dynamic subtest vcs0: SUCCESS (1.084s)
[462.138954] Starting dynamic subtest: vcs1
[463.204661] Dynamic subtest vcs1: SUCCESS (1.084s)
[463.216922] Starting dynamic subtest: vecs0
[464.293105] Dynamic subtest vecs0: SUCCESS (1.084s)
[464.305988] Starting dynamic subtest: ccs0
[465.380697] Dynamic subtest ccs0: SUCCESS (1.084s)
[465.383297] Subtest exec-single-timeline: SUCCESS (6.516s)
[465.611056] [103/133] (563s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[465.671779] Starting subtest: y-tiled-to-vebox-yf-tiled
[465.676384] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[465.860994] [104/133] (563s left) kms_dsc (dsc-with-bpc-formats)
[465.955683] Starting subtest: dsc-with-bpc-formats
[466.064435] Subtest dsc-with-bpc-formats: SKIP (0.002s)
[466.103975] [105/133] (563s left) gem_fence_thrash (bo-copy)
[466.145923] Starting subtest: bo-copy
[466.173383] Subtest bo-copy: SKIP (0.025s)
[466.237494] [106/133] (563s left) kms_pm_rpm (system-suspend-modeset)
[467.762865] Starting subtest: system-suspend-modeset
[487.800706] Subtest system-suspend-modeset: SUCCESS (4.580s)
[488.197522] [107/133] (541s left) dmabuf_sync_file (export-basic)
[488.249067] Starting subtest: export-basic
[488.251711] Subtest export-basic: SUCCESS (0.001s)
[488.310057] [108/133] (541s left) gem_pxp (reject-modify-context-protection-off-1)
[488.443010] Starting subtest: reject-modify-context-protection-off-1
[488.445976] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[488.550258] [109/133] (541s left) gem_exec_create (forked)
[488.613061] Starting subtest: forked
[488.615792] Starting dynamic subtest: smem
[508.997526] Dynamic subtest smem: SUCCESS (20.268s)
[509.000598] Subtest forked: SUCCESS (20.271s)
[509.199482] [110/133] (520s left) kms_cursor_crc (cursor-sliding-64x64)
[509.403480] Starting subtest: cursor-sliding-64x64
[509.406115] Starting dynamic subtest: pipe-A-eDP-1
[512.641749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.232s)
[512.673307] Starting dynamic subtest: pipe-D-eDP-1
[516.530515] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.864s)
[516.533114] Subtest cursor-sliding-64x64: SUCCESS (7.120s)
[517.387432] [111/133] (512s left) gem_mmap_wc (set-cache-level)
[517.449836] Subtest set-cache-level: SKIP (0.000s)
[517.511726] [112/133] (512s left) gem_eio (wait-wedge-immediate)
[517.729053] Starting subtest: wait-wedge-immediate
[519.122591] Subtest wait-wedge-immediate: SUCCESS (1.394s)
[519.285341] [113/133] (510s left) gem_exec_reloc (basic-wc-cpu-active)
[519.341050] Subtest basic-wc-cpu-active: SKIP (0.000s)
[519.415547] [114/133] (510s left) gem_mmap_gtt (cpuset-big-copy)
[519.480445] Subtest cpuset-big-copy: SKIP (0.000s)
[519.545242] [115/133] (510s left) gem_madvise (dontneed-before-mmap)
[519.587094] Starting subtest: dontneed-before-mmap
[519.609637] Subtest dontneed-before-mmap: SUCCESS (0.025s)
[519.711641] [116/133] (510s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[519.803920] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[519.809368] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[519.877663] [117/133] (510s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[519.983272] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[519.987902] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[520.068169] [118/133] (510s left) gem_close (many-handles-one-vma)
[520.129775] Starting subtest: many-handles-one-vma
[520.152450] Subtest many-handles-one-vma: SUCCESS (0.025s)
[520.270619] [119/133] (509s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[520.377855] Starting subtest: y-tiled-64bpp-rotate-180
[520.382420] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[520.479886] [120/133] (509s left) kms_flip (busy-flip)
[520.575793] Starting subtest: busy-flip
[520.577761] Starting dynamic subtest: A-eDP1
[522.301060] Dynamic subtest A-eDP1: SUCCESS (1.726s)
[522.311352] Starting dynamic subtest: B-eDP1
[523.960763] Dynamic subtest B-eDP1: SUCCESS (1.658s)
[523.974033] Starting dynamic subtest: C-eDP1
[525.673939] Dynamic subtest C-eDP1: SUCCESS (1.710s)
[525.685933] Starting dynamic subtest: D-eDP1
[527.319649] Dynamic subtest D-eDP1: SUCCESS (1.644s)
[527.325833] Subtest busy-flip: SUCCESS (6.750s)
[528.498583] [121/133] (501s left) kms_addfb_basic (bo-too-small)
[528.599665] Starting subtest: bo-too-small
[528.602318] Subtest bo-too-small: SUCCESS (0.000s)
[528.696194] [122/133] (501s left) gem_ctx_isolation (clean)
[528.767091] Starting subtest: clean
[528.770066] Starting dynamic subtest: rcs0
[528.792823] Dynamic subtest rcs0: SUCCESS (0.025s)
[528.804924] Starting dynamic subtest: bcs0
[528.849040] Dynamic subtest bcs0: SUCCESS (0.055s)
[528.860321] Starting dynamic subtest: vcs0
[528.901319] Dynamic subtest vcs0: SUCCESS (0.051s)
[528.914405] Starting dynamic subtest: vcs1
[530.007716] Dynamic subtest vcs1: SUCCESS (1.105s)
[530.020963] Starting dynamic subtest: vecs0
[532.060825] Dynamic subtest vecs0: SUCCESS (2.051s)
[532.073860] Starting dynamic subtest: ccs0
[534.051390] Dynamic subtest ccs0: SUCCESS (1.983s)
[534.054446] Subtest clean: SUCCESS (5.278s)
[534.266935] [123/133] (496s left) api_intel_bb (bb-with-allocator)
[534.325794] Starting subtest: bb-with-allocator
[534.333727] Subtest bb-with-allocator: SUCCESS (0.010s)
[534.465143] [124/133] (495s left) kms_flip (2x-flip-vs-dpms-on-nop)
[534.563590] Starting subtest: 2x-flip-vs-dpms-on-nop
[534.574120] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[534.657679] [125/133] (495s left) syncobj_timeline (etime-multi-wait-all-submitted)
[534.713050] Starting subtest: etime-multi-wait-all-submitted
[534.815224] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[534.895962] [126/133] (495s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[534.994774] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[534.997422] Starting dynamic subtest: pipe-A-eDP-1
[546.337684] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.344s)
[546.348745] Starting dynamic subtest: pipe-B-eDP-1
[558.340896] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.999s)
[558.343872] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.345s)
[559.166803] [127/133] (471s left) sw_sync (sync_merge)
[559.211961] Starting subtest: sync_merge
[559.214520] Subtest sync_merge: SUCCESS (0.000s)
[559.267996] [128/133] (471s left) kms_draw_crc (fill-fb)
[559.366167] Starting subtest: fill-fb
[559.861315] Subtest fill-fb: SUCCESS (0.497s)
[559.971126] [129/133] (470s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[560.061063] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[560.065845] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.151375] [130/133] (470s left) gem_userptr_blits (userfault)
[560.217474] Starting subtest: userfault
[560.222429] Subtest userfault: SUCCESS (0.009s)
[560.343441] [131/133] (470s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[560.465547] Starting subtest: 2x-flip-vs-cursor-legacy
[560.469334] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[560.609666] [132/133] (470s left) kms_pipe_crc_basic (read-crc)
[560.696802] Starting subtest: read-crc
[560.698774] Starting dynamic subtest: pipe-A-eDP-1
[561.415637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[561.426041] Starting dynamic subtest: pipe-B-eDP-1
[562.777934] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s)
[562.791245] Starting dynamic subtest: pipe-C-eDP-1
[564.157952] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[564.171528] Starting dynamic subtest: pipe-D-eDP-1
[565.498008] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[565.501034] Subtest read-crc: SUCCESS (4.801s)
[566.324481] [133/133] (464s left) gem_exec_flush (basic-uc-ro-default)
[566.386935] Starting subtest: basic-uc-ro-default
[571.888526] Subtest basic-uc-ro-default: SUCCESS (5.501s)
[572.081229] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rps
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: syncobj_basic
results: parsing output: 3/ for test: gem_madvise
results: parsing output: 4/ for test: kms_universal_plane
results: parsing output: 5/ for test: kms_lease
results: parsing output: 6/ for test: kms_dp_aux_dev
results: parsing output: 7/ for test: i915_pm_freq_mult
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_pm_backlight
results: parsing output: 11/ for test: gem_caching
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: gem_mmap_wc
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_invalid_mode
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: kms_cdclk
results: parsing output: 22/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: gem_workarounds
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_chamelium_color
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: fbdev
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ctx_engines
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_bad_reloc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_pipe_b_c_ivb
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_spin_batch
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_content_protection
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: gem_mmap_offset
results: parsing output: 73/ for test: sysfs_preempt_timeout
results: parsing output: 74/ for test: kms_color_pipeline
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_create
results: parsing output: 79/ for test: kms_rmfb
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: prime_vgem
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_vrr
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: prime_vgem
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_atomic
results: parsing output: 96/ for test: gem_gpgpu_fill
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_ctx_shared
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_dsc
results: parsing output: 104/ for test: gem_fence_thrash
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: gem_exec_create
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_mmap_wc
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: gem_madvise
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_close
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: sw_sync
results: parsing output: 127/ for test: kms_draw_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_pipe_crc_basic
results: parsing output: 132/ for test: gem_exec_flush
Done.