[59.275539] Initializing watchdogs
[59.275585]   /dev/watchdog0
[59.289389] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.294105] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.296458] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.299969] [001/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[59.424215] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[59.428153] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[59.542993] [002/132] (960s left) kms_cursor_crc (cursor-onscreen-64x21)
[59.728791] Starting subtest: cursor-onscreen-64x21
[59.780944] Subtest cursor-onscreen-64x21: SKIP (0.047s)
[60.029590] [003/132] (959s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[65.012868] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[65.015322] Starting dynamic subtest: pipe-A-eDP-1
[65.824420] Dynamic subtest pipe-A-eDP-1: SKIP (0.808s)
[65.831471] Starting dynamic subtest: pipe-B-eDP-1
[66.952966] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[66.957646] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.939s)
[68.451331] [004/132] (951s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[68.544987] Starting subtest: primary-y-tiled-reflect-x-90
[68.549368] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[68.632618] [005/132] (951s left) kms_vrr (negative-basic)
[68.729255] Starting subtest: negative-basic
[68.735986] Starting dynamic subtest: pipe-A-eDP-1
[74.149062] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s)
[74.434766] Subtest negative-basic: SUCCESS (5.709s)
[75.273179] [006/132] (944s left) gem_exec_whisper (basic-fds-priority)
[75.344345] Starting subtest: basic-fds-priority
[99.884116] Subtest basic-fds-priority: SUCCESS (24.536s)
[100.090185] [007/132] (919s left) kms_chamelium_edid (dp-edid-resolution-list)
[100.491412] Subtest dp-edid-resolution-list: SKIP (0.000s)
[101.260698] [008/132] (918s left) kms_frontbuffer_tracking (fbc-suspend)
[101.363799] Starting subtest: fbc-suspend
[139.543535] Subtest fbc-suspend: SUCCESS (11.306s)
[140.757892] [009/132] (879s left) syncobj_timeline (multi-wait-submitted-signaled)
[140.826655] Starting subtest: multi-wait-submitted-signaled
[140.829122] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[140.947621] [010/132] (879s left) syncobj_wait (multi-wait-all-submitted)
[141.000268] Starting subtest: multi-wait-all-submitted
[141.106687] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[141.206623] [011/132] (878s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[141.306838] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[141.311146] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[141.449322] [012/132] (878s left) gem_partial_pwrite_pread (write-uncached)
[141.508752] Subtest write-uncached: SKIP (0.000s)
[141.589796] [013/132] (878s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[141.694780] Starting subtest: fbc-pr-sprite-mmap-gtt
[141.699005] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[141.786355] [014/132] (878s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[141.891598] Starting subtest: x-tiled-32bpp-rotate-270
[141.911320] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[142.044749] [015/132] (878s left) gem_exec_fence (basic-wait)
[142.226473] Starting subtest: basic-wait
[142.228877] Starting dynamic subtest: rcs0
[142.341134] Dynamic subtest rcs0: SUCCESS (0.115s)
[142.352444] Starting dynamic subtest: bcs0
[142.404928] Dynamic subtest bcs0: SUCCESS (0.063s)
[142.413568] Starting dynamic subtest: vcs0
[142.460612] Dynamic subtest vcs0: SUCCESS (0.055s)
[142.469010] Starting dynamic subtest: vcs1
[142.519570] Dynamic subtest vcs1: SUCCESS (0.058s)
[142.527558] Starting dynamic subtest: vecs0
[142.584163] Dynamic subtest vecs0: SUCCESS (0.064s)
[142.592535] Starting dynamic subtest: ccs0
[142.648078] Dynamic subtest ccs0: SUCCESS (0.063s)
[142.650431] Subtest basic-wait: SUCCESS (0.424s)
[144.894109] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[144.897477] [016/132] (875s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[145.002635] Starting subtest: plane-lut1d-post-ctm3x4
[145.017805] Starting dynamic subtest: pipe-A-eDP-1
[145.725028] Dynamic subtest pipe-A-eDP-1: FAIL (0.324s)
[146.386465] Starting dynamic subtest: pipe-B-eDP-1
[147.244752] Dynamic subtest pipe-B-eDP-1: FAIL (0.336s)
[147.819597] Starting dynamic subtest: pipe-C-eDP-1
[148.688191] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[149.147846] Starting dynamic subtest: pipe-D-eDP-1
[149.995384] Dynamic subtest pipe-D-eDP-1: FAIL (0.269s)
[149.997348] Subtest plane-lut1d-post-ctm3x4: FAIL (4.707s)
[150.547560] [017/132] (869s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[150.657912] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[150.660251] Starting dynamic subtest: pipe-A-default-mode
[153.343794] Dynamic subtest pipe-A-default-mode: SUCCESS (2.690s)
[153.346094] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.691s)
[154.229754] [018/132] (866s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[154.333453] Starting subtest: 2x-absolute-wf_vblank-interruptible
[154.345511] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[154.484888] [019/132] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[154.599343] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[161.193236] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.604s)
[161.332282] [020/132] (859s left) gem_exec_params (invalid-bsd2-flag-on-render)
[161.390703] Starting subtest: invalid-bsd2-flag-on-render
[161.393092] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[161.513857] [021/132] (859s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[161.621346] Starting subtest: psr-rgb101010-draw-blt
[169.008639] Subtest psr-rgb101010-draw-blt: SUCCESS (7.393s)
[169.145998] [022/132] (851s left) syncobj_timeline (invalid-wait-bad-flags)
[169.211666] Starting subtest: invalid-wait-bad-flags
[169.213582] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[169.324076] [023/132] (851s left) gem_mmap_gtt (cpuset-big-copy-odd)
[169.379658] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[169.445864] [024/132] (851s left) gem_mmap_wc (bad-size)
[169.510900] Subtest bad-size: SKIP (0.000s)
[169.580129] [025/132] (851s left) gem_exec_balancer (invalid-bonds)
[169.645365] Starting subtest: invalid-bonds
[169.649775] Subtest invalid-bonds: SKIP (0.000s)
[169.982302] [026/132] (850s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[170.081053] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[170.085154] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[170.219463] [027/132] (850s left) kms_lease (lease-get)
[170.306402] Starting subtest: lease-get
[170.308812] Starting dynamic subtest: pipe-A-eDP-1
[170.311088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[170.324153] Starting dynamic subtest: pipe-B-eDP-1
[170.326503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[170.336505] Starting dynamic subtest: pipe-C-eDP-1
[170.338646] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[170.346623] Starting dynamic subtest: pipe-D-eDP-1
[170.348765] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[170.350993] Subtest lease-get: SUCCESS (0.008s)
[170.453252] [028/132] (850s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[170.554933] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[174.838335] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.284s)
[176.046999] [029/132] (844s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[176.425977] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[177.225318] [030/132] (843s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[177.323244] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[181.000463] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.680s)
[182.207848] [031/132] (838s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[182.325244] Starting subtest: yf-tiled-64bpp-rotate-0
[182.329611] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[182.442762] [032/132] (838s left) gem_mmap_gtt (medium-copy-odd)
[182.507450] Subtest medium-copy-odd: SKIP (0.000s)
[182.570375] [033/132] (838s left) gem_pxp (protected-raw-src-copy-not-readible)
[182.696144] Starting subtest: protected-raw-src-copy-not-readible
[182.754443] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[182.919203] [034/132] (838s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[183.029890] Starting subtest: flip-vs-cursor-crc-atomic
[183.702715] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.672s)
[184.597108] [035/132] (836s left) kms_atomic_transition (plane-all-transition-fencing)
[184.681923] Starting subtest: plane-all-transition-fencing
[184.684193] Starting dynamic subtest: pipe-A-eDP-1
[187.177747] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[187.516680] Starting dynamic subtest: pipe-B-eDP-1
[190.733668] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.225s)
[191.031648] Subtest plane-all-transition-fencing: SUCCESS (6.351s)
[191.862168] [036/132] (829s left) prime_self_import (basic-with_one_bo_two_files)
[191.904290] Starting subtest: basic-with_one_bo_two_files
[191.934250] Subtest basic-with_one_bo_two_files: SUCCESS (0.031s)
[192.068856] [037/132] (829s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[192.170314] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[192.172666] Starting dynamic subtest: pipe-A-eDP-1
[192.195346] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[192.206261] Starting dynamic subtest: pipe-B-eDP-1
[192.227549] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.235381] Starting dynamic subtest: pipe-C-eDP-1
[192.257788] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.265490] Starting dynamic subtest: pipe-D-eDP-1
[192.287891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.291952] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[194.345696] [038/132] (826s left) i915_drm_fdinfo (all-busy-check-all)
[194.387956] Starting subtest: all-busy-check-all
[194.395765] Subtest all-busy-check-all: SKIP (0.004s)
[194.483821] [039/132] (826s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[194.627287] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[194.629549] Starting dynamic subtest: pipe-A-default-mode
[194.918280] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[194.922904] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.291s)
[195.784353] [040/132] (825s left) kms_addfb_basic (bad-pitch-0)
[195.842944] Starting subtest: bad-pitch-0
[195.845173] Subtest bad-pitch-0: SUCCESS (0.000s)
[196.020542] [041/132] (825s left) gem_ctx_persistence (heartbeat-stop)
[196.081056] Starting subtest: heartbeat-stop
[196.085590] Subtest heartbeat-stop: SKIP (0.000s)
[196.203302] [042/132] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[196.301839] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[196.305871] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[196.433066] [043/132] (825s left) gem_exec_schedule (smoketest)
[196.617434] Starting subtest: smoketest
[196.620213] Starting dynamic subtest: rcs0
[202.159964] Dynamic subtest rcs0: SUCCESS (5.490s)
[202.175185] Starting dynamic subtest: bcs0
[207.666149] Dynamic subtest bcs0: SUCCESS (5.513s)
[207.675480] Starting dynamic subtest: vcs0
[213.151846] Dynamic subtest vcs0: SUCCESS (5.482s)
[213.162063] Starting dynamic subtest: vcs1
[218.661587] Dynamic subtest vcs1: SUCCESS (5.507s)
[218.671221] Starting dynamic subtest: vecs0
[224.152842] Dynamic subtest vecs0: SUCCESS (5.499s)
[224.167576] Starting dynamic subtest: ccs0
[229.652454] Dynamic subtest ccs0: SUCCESS (5.498s)
[229.654751] Subtest smoketest: SUCCESS (32.999s)
[229.900067] [044/132] (791s left) gem_exec_parallel (contexts)
[229.978438] Starting subtest: contexts
[229.980845] Starting dynamic subtest: rcs0
[233.591681] Dynamic subtest rcs0: SUCCESS (3.611s)
[233.602947] Starting dynamic subtest: bcs0
[237.372251] Dynamic subtest bcs0: SUCCESS (3.776s)
[237.380939] Starting dynamic subtest: vcs0
[241.267897] Dynamic subtest vcs0: SUCCESS (3.894s)
[241.276764] Starting dynamic subtest: vcs1
[245.261845] Dynamic subtest vcs1: SUCCESS (3.990s)
[245.270121] Starting dynamic subtest: vecs0
[249.324238] Dynamic subtest vecs0: SUCCESS (4.058s)
[249.334090] Starting dynamic subtest: ccs0
[253.340128] Dynamic subtest ccs0: SUCCESS (4.012s)
[253.344057] Subtest contexts: SUCCESS (23.355s)
[253.551311] [045/132] (768s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[253.615934] Starting subtest: invalid-bsd2-flag-on-blt
[253.618327] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[253.759769] [046/132] (767s left) kms_psr (fbc-psr2-primary-render)
[253.863176] Starting subtest: fbc-psr2-primary-render
[253.865338] Starting dynamic subtest: eDP-1
[253.869386] Dynamic subtest eDP-1: SKIP (0.000s)
[253.873340] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[253.957667] [047/132] (767s left) prime_vgem (coherency-gtt)
[254.047453] Starting subtest: coherency-gtt
[254.052043] Subtest coherency-gtt: SKIP (0.000s)
[254.183199] [048/132] (767s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[254.305603] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[254.310174] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[254.472602] [049/132] (767s left) kms_flip (flip-vs-expired-vblank)
[254.556726] Starting subtest: flip-vs-expired-vblank
[254.558725] Starting dynamic subtest: A-eDP1
[263.252560] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[263.269232] Starting dynamic subtest: B-eDP1
[271.977746] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[271.987522] Starting dynamic subtest: C-eDP1
[280.630880] Dynamic subtest C-eDP1: SUCCESS (8.652s)
[280.640198] Starting dynamic subtest: D-eDP1
[289.251715] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[289.254238] Subtest flip-vs-expired-vblank: SUCCESS (34.699s)
[290.445969] [050/132] (731s left) gem_mmap_wc (write-read)
[290.506590] Subtest write-read: SKIP (0.000s)
[290.561735] [051/132] (731s left) kms_psr (psr-sprite-render)
[290.657384] Starting subtest: psr-sprite-render
[290.659507] Starting dynamic subtest: eDP-1
[292.441452] Dynamic subtest eDP-1: SUCCESS (1.785s)
[292.443740] Subtest psr-sprite-render: SUCCESS (1.786s)
[293.309829] [052/132] (728s left) kms_psr (psr2-cursor-blt)
[293.410641] Starting subtest: psr2-cursor-blt
[293.412844] Starting dynamic subtest: eDP-1
[295.062452] Dynamic subtest eDP-1: SUCCESS (1.653s)
[295.064775] Subtest psr2-cursor-blt: SUCCESS (1.654s)
[295.890163] [053/132] (726s left) kms_prime (basic-modeset-hybrid)
[295.974617] Subtest basic-modeset-hybrid: SKIP (0.000s)
[296.094970] [054/132] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[296.192808] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[296.196789] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[296.322362] [055/132] (725s left) kms_psr (fbc-psr-sprite-plane-onoff)
[296.420802] Starting subtest: fbc-psr-sprite-plane-onoff
[296.423028] Starting dynamic subtest: eDP-1
[296.427062] Dynamic subtest eDP-1: SKIP (0.000s)
[296.431092] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[296.516781] [056/132] (725s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[296.590384] Starting subtest: stress-mm-invalidate-close-overlap
[298.738965] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[298.893132] [057/132] (723s left) gem_exec_params (batch-first)
[298.954650] Starting subtest: batch-first
[298.964852] Subtest batch-first: SUCCESS (0.011s)
[299.122838] [058/132] (722s left) i915_pm_rpm (gem-mmap-type)
[300.949586] Starting subtest: gem-mmap-type
[300.952273] Starting dynamic subtest: wb-smem0
[304.490365] Dynamic subtest wb-smem0: SUCCESS (3.539s)
[304.499214] Starting dynamic subtest: wc-smem0
[307.942420] Dynamic subtest wc-smem0: SUCCESS (3.453s)
[307.951338] Starting dynamic subtest: uc-smem0
[311.400929] Dynamic subtest uc-smem0: SUCCESS (3.458s)
[311.403352] Subtest gem-mmap-type: SUCCESS (10.454s)
[311.498706] [059/132] (710s left) dumb_buffer (create-clear)
[311.559354] Starting subtest: create-clear
[345.467125] Subtest create-clear: SUCCESS (33.914s)
[345.611242] [060/132] (676s left) i915_module_load (resize-bar)
[345.647562] Starting subtest: resize-bar
[345.656763] Subtest resize-bar: SKIP (0.008s)
[345.700296] [061/132] (676s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[345.764858] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[345.768986] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[345.978324] [062/132] (676s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[346.104950] Starting subtest: basic-busy-flip-before-cursor-varying-size
[346.109469] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[346.279397] [063/132] (676s left) gem_eio (kms)
[346.566921] Starting subtest: kms
[367.196896] Subtest kms: SUCCESS (20.631s)
[368.395217] [064/132] (653s left) gem_exec_fence (keep-in-fence)
[368.583155] Starting subtest: keep-in-fence
[368.585553] Starting dynamic subtest: rcs0
[368.660441] Dynamic subtest rcs0: SUCCESS (0.076s)
[368.672111] Starting dynamic subtest: bcs0
[368.714226] Dynamic subtest bcs0: SUCCESS (0.052s)
[368.725632] Starting dynamic subtest: vcs0
[369.830809] Dynamic subtest vcs0: SUCCESS (1.112s)
[369.843135] Starting dynamic subtest: vcs1
[371.814741] Dynamic subtest vcs1: SUCCESS (1.981s)
[371.826720] Starting dynamic subtest: vecs0
[373.798019] Dynamic subtest vecs0: SUCCESS (1.981s)
[373.810246] Starting dynamic subtest: ccs0
[374.042234] Dynamic subtest ccs0: SUCCESS (0.242s)
[374.045390] Subtest keep-in-fence: SUCCESS (5.458s)
[375.869960] [065/132] (646s left) kms_big_fb (linear-8bpp-rotate-270)
[375.983497] Starting subtest: linear-8bpp-rotate-270
[376.007453] Subtest linear-8bpp-rotate-270: SKIP (0.023s)
[376.167831] [066/132] (646s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[376.279729] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[383.355769] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.076s)
[383.508148] [067/132] (638s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[383.613351] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[383.617775] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[384.760306] [068/132] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[384.870201] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[384.874606] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[385.005231] [069/132] (637s left) i915_query (query-garbage)
[385.070459] Starting subtest: query-garbage
[385.073166] Subtest query-garbage: SUCCESS (0.000s)
[385.182318] [070/132] (637s left) gem_huc_copy (huc-copy)
[385.243370] Starting subtest: huc-copy
[385.248664] Subtest huc-copy: SUCCESS (0.003s)
[385.425856] [071/132] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[385.528217] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[389.276628] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.751s)
[390.453768] [072/132] (632s left) gem_create (create-invalid-size)
[390.517481] Starting subtest: create-invalid-size
[390.519377] Subtest create-invalid-size: SUCCESS (0.000s)
[390.723968] [073/132] (632s left) kms_pm_rpm (drm-resources-equal)
[392.953297] Starting subtest: drm-resources-equal
[397.973260] Subtest drm-resources-equal: SUCCESS (5.023s)
[398.091798] [074/132] (624s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[398.189502] Starting subtest: random-ccs-data-yf-tiled-ccs
[398.191924] Starting dynamic subtest: pipe-A-eDP-1
[398.216386] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[398.227795] Starting dynamic subtest: pipe-B-eDP-1
[398.250871] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[398.260012] Starting dynamic subtest: pipe-C-eDP-1
[398.282976] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[398.292163] Starting dynamic subtest: pipe-D-eDP-1
[398.317954] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[398.322165] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.007s)
[400.483872] [075/132] (622s left) kms_lease (empty-lease)
[400.584285] Starting subtest: empty-lease
[400.586547] Starting dynamic subtest: pipe-A-eDP-1
[400.588700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[400.598320] Starting dynamic subtest: pipe-B-eDP-1
[400.600491] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[400.609241] Starting dynamic subtest: pipe-C-eDP-1
[400.611388] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[400.619857] Starting dynamic subtest: pipe-D-eDP-1
[400.622014] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[400.624079] Subtest empty-lease: SUCCESS (0.008s)
[400.721246] [076/132] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[400.832371] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[400.836490] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[400.966010] [077/132] (621s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[401.034337] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[401.036556] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[401.177537] [078/132] (621s left) api_intel_allocator (gem-pool)
[401.243013] Starting subtest: gem-pool
[401.248073] Subtest gem-pool: SUCCESS (0.008s)
[401.410618] [079/132] (621s left) core_getclient (basic)
[401.457271] Starting subtest: basic
[401.459138] Subtest basic: SUCCESS (0.000s)
[401.585176] [080/132] (621s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[401.682437] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[401.684506] Starting dynamic subtest: pipe-A
[402.064188] Dynamic subtest pipe-A: SUCCESS (0.383s)
[402.073336] Starting dynamic subtest: pipe-B
[403.450022] Dynamic subtest pipe-B: SUCCESS (1.384s)
[403.458825] Starting dynamic subtest: pipe-C
[404.873569] Dynamic subtest pipe-C: SUCCESS (1.422s)
[404.883213] Starting dynamic subtest: pipe-D
[406.319849] Dynamic subtest pipe-D: SUCCESS (1.445s)
[406.322165] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.639s)
[407.496171] [081/132] (615s left) syncobj_timeline (etime-single-wait-submitted)
[407.560240] Starting subtest: etime-single-wait-submitted
[407.667234] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[407.770255] [082/132] (615s left) gem_basic (create-close)
[407.830877] Starting subtest: create-close
[407.835574] Subtest create-close: SUCCESS (0.000s)
[407.978326] [083/132] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[408.079716] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[414.683012] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.606s)
[414.833512] [084/132] (608s left) gem_spin_batch (legacy-resubmit)
[414.896088] Starting subtest: legacy-resubmit
[414.898462] Starting dynamic subtest: default
[414.903310] Dynamic subtest default: SUCCESS (0.007s)
[414.913380] Starting dynamic subtest: render
[414.916278] Dynamic subtest render: SUCCESS (0.001s)
[414.935502] Starting dynamic subtest: bsd
[414.937387] Dynamic subtest bsd: SUCCESS (0.002s)
[414.945771] Starting dynamic subtest: bsd1
[414.947710] Dynamic subtest bsd1: SUCCESS (0.001s)
[414.956224] Starting dynamic subtest: bsd2
[414.958173] Dynamic subtest bsd2: SUCCESS (0.003s)
[414.966400] Starting dynamic subtest: blt
[414.968353] Dynamic subtest blt: SUCCESS (0.002s)
[414.976594] Starting dynamic subtest: vebox
[414.978535] Dynamic subtest vebox: SUCCESS (0.002s)
[414.980409] Subtest legacy-resubmit: SUCCESS (0.024s)
[415.185166] [085/132] (608s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[415.287569] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[415.289829] Starting dynamic subtest: pipe-A-eDP-1
[415.310127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[415.320975] Starting dynamic subtest: pipe-B-eDP-1
[415.340294] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[415.349223] Starting dynamic subtest: pipe-C-eDP-1
[415.368637] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[415.377170] Starting dynamic subtest: pipe-D-eDP-1
[415.397117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[415.399383] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[417.615814] [086/132] (605s left) perf_pmu (semaphore-wait-idle)
[417.664239] Starting subtest: semaphore-wait-idle
[417.666298] Starting dynamic subtest: rcs0
[418.176468] Dynamic subtest rcs0: SUCCESS (0.513s)
[418.189406] Starting dynamic subtest: bcs0
[418.691442] Dynamic subtest bcs0: SUCCESS (0.512s)
[418.703665] Starting dynamic subtest: vcs0
[419.206846] Dynamic subtest vcs0: SUCCESS (0.512s)
[419.219757] Starting dynamic subtest: vcs1
[419.721172] Dynamic subtest vcs1: SUCCESS (0.511s)
[419.733922] Starting dynamic subtest: vecs0
[420.233893] Dynamic subtest vecs0: SUCCESS (0.510s)
[420.245859] Starting dynamic subtest: ccs0
[420.748962] Dynamic subtest ccs0: SUCCESS (0.513s)
[420.751698] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[421.906265] [087/132] (601s left) gem_wait (write-wait)
[421.968027] Starting subtest: write-wait
[421.970391] Starting dynamic subtest: all-engines
[423.104614] Dynamic subtest all-engines: SUCCESS (1.135s)
[423.121200] Starting dynamic subtest: rcs0
[424.161157] Dynamic subtest rcs0: SUCCESS (1.054s)
[424.178494] Starting dynamic subtest: bcs0
[425.219533] Dynamic subtest bcs0: SUCCESS (1.056s)
[425.236644] Starting dynamic subtest: vcs0
[426.275068] Dynamic subtest vcs0: SUCCESS (1.053s)
[426.291158] Starting dynamic subtest: vcs1
[427.328998] Dynamic subtest vcs1: SUCCESS (1.052s)
[427.345562] Starting dynamic subtest: vecs0
[428.384095] Dynamic subtest vecs0: SUCCESS (1.053s)
[428.401123] Starting dynamic subtest: ccs0
[429.440958] Dynamic subtest ccs0: SUCCESS (1.055s)
[429.443719] Subtest write-wait: SUCCESS (7.473s)
[429.664243] [088/132] (593s left) kms_atomic (plane-primary-legacy)
[429.784814] Starting subtest: plane-primary-legacy
[429.787547] Starting dynamic subtest: pipe-A-eDP-1
[430.231028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[430.233247] Subtest plane-primary-legacy: SUCCESS (0.447s)
[431.052738] [089/132] (592s left) sysfs_preempt_timeout (invalid)
[431.119939] Starting subtest: invalid
[431.122310] Starting dynamic subtest: vecs0
[431.124617] Dynamic subtest vecs0: SUCCESS (0.000s)
[431.135252] Starting dynamic subtest: ccs0
[431.137462] Dynamic subtest ccs0: SUCCESS (0.000s)
[431.146182] Starting dynamic subtest: vcs0
[431.148438] Dynamic subtest vcs0: SUCCESS (0.000s)
[431.157398] Starting dynamic subtest: bcs0
[431.159654] Dynamic subtest bcs0: SUCCESS (0.000s)
[431.168403] Starting dynamic subtest: rcs0
[431.170618] Dynamic subtest rcs0: SUCCESS (0.000s)
[431.179680] Starting dynamic subtest: vcs1
[431.181533] Dynamic subtest vcs1: SUCCESS (0.000s)
[431.183372] Subtest invalid: SUCCESS (0.006s)
[431.260036] [090/132] (592s left) gem_exec_fence (syncobj-timeline-signal)
[431.787182] Starting subtest: syncobj-timeline-signal
[431.793139] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[432.929434] [091/132] (590s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[433.125255] Starting subtest: cursor-rapid-movement-64x21
[433.166891] Subtest cursor-rapid-movement-64x21: SKIP (0.041s)
[433.431038] [092/132] (590s left) perf (oa-formats)
[433.572722] Starting subtest: oa-formats
[433.574529] Starting dynamic subtest: 0-rcs0
[433.586245] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[433.595903] Starting dynamic subtest: 1-vcs1
[433.607733] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[433.610026] Subtest oa-formats: SUCCESS (0.037s)
[433.657452] [093/132] (589s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[433.754939] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[433.756875] Starting dynamic subtest: pipe-A-eDP-1
[433.816736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[433.826265] Starting dynamic subtest: pipe-B-eDP-1
[433.879825] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[433.888999] Starting dynamic subtest: pipe-C-eDP-1
[433.943468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[433.952562] Starting dynamic subtest: pipe-D-eDP-1
[434.007471] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.063s)
[434.009300] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.256s)
[436.226697] [094/132] (587s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[436.287798] Starting subtest: invalid-bsd1-flag-on-blt
[436.290149] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[436.464688] [095/132] (587s left) gem_ctx_persistence (engines-cleanup)
[436.532538] Starting subtest: engines-cleanup
[436.534851] Starting dynamic subtest: rcs0
[436.645639] Dynamic subtest rcs0: SUCCESS (0.112s)
[436.658218] Starting dynamic subtest: bcs0
[436.671045] Dynamic subtest bcs0: SUCCESS (0.023s)
[436.680309] Starting dynamic subtest: vcs0
[436.728604] Dynamic subtest vcs0: SUCCESS (0.057s)
[436.737660] Starting dynamic subtest: vcs1
[436.823454] Dynamic subtest vcs1: SUCCESS (0.093s)
[436.838901] Starting dynamic subtest: vecs0
[436.893741] Dynamic subtest vecs0: SUCCESS (0.067s)
[436.905911] Starting dynamic subtest: ccs0
[436.964765] Dynamic subtest ccs0: SUCCESS (0.068s)
[436.967661] Subtest engines-cleanup: SUCCESS (0.434s)
[437.073312] [096/132] (586s left) i915_suspend (debugfs-reader)
[437.133713] Starting subtest: debugfs-reader
[455.088127] Subtest debugfs-reader: SUCCESS (3.171s)
[455.277979] [097/132] (568s left) kms_draw_crc (draw-method-mmap-wc)
[455.379618] Starting subtest: draw-method-mmap-wc
[455.381517] Starting dynamic subtest: xrgb8888-untiled
[455.610165] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s)
[455.619815] Starting dynamic subtest: rgb565-untiled
[455.820482] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[455.829995] Starting dynamic subtest: xrgb2101010-untiled
[456.030474] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[456.039849] Starting dynamic subtest: xbgr16161616f-untiled
[456.250739] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[456.259688] Starting dynamic subtest: xrgb8888-xtiled
[456.394474] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[456.403383] Starting dynamic subtest: rgb565-xtiled
[456.538164] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s)
[456.547309] Starting dynamic subtest: xrgb2101010-xtiled
[456.704187] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.166s)
[456.713292] Starting dynamic subtest: xbgr16161616f-xtiled
[456.837234] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[456.854970] Starting dynamic subtest: xrgb8888-4tiled
[457.002927] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.164s)
[457.011947] Starting dynamic subtest: rgb565-4tiled
[457.146518] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[457.156017] Starting dynamic subtest: xrgb2101010-4tiled
[457.290439] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[457.299233] Starting dynamic subtest: xbgr16161616f-4tiled
[457.467074] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.176s)
[457.469043] Subtest draw-method-mmap-wc: SUCCESS (2.102s)
[457.604925] [098/132] (566s left) gem_userptr_blits (sync-unmap)
[457.671468] Starting subtest: sync-unmap
[457.685408] Subtest sync-unmap: SUCCESS (0.014s)
[457.864427] [099/132] (566s left) kms_content_protection (dp-mst-suspend-resume)
[458.008886] Starting subtest: dp-mst-suspend-resume
[458.012641] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[458.199160] [100/132] (565s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[458.298261] Starting subtest: addfb25-y-tiled-small-legacy
[458.301622] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[458.432256] [101/132] (565s left) syncobj_timeline (wait-for-submit-snapshot)
[458.494803] Starting subtest: wait-for-submit-snapshot
[458.575519] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[458.674584] [102/132] (565s left) gem_eio (in-flight-internal-1us)
[458.886774] Starting subtest: in-flight-internal-1us
[460.647466] Subtest in-flight-internal-1us: SUCCESS (1.767s)
[460.835139] [103/132] (563s left) gem_create (create-size-update)
[460.893592] Starting subtest: create-size-update
[460.895889] Subtest create-size-update: SUCCESS (0.000s)
[461.136727] [104/132] (563s left) kms_draw_crc (fill-fb)
[461.232071] Starting subtest: fill-fb
[461.672794] Subtest fill-fb: SUCCESS (0.443s)
[461.804432] [105/132] (562s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[461.892898] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[461.895140] Starting dynamic subtest: pipe-A-eDP-1
[462.394820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[462.405233] Starting dynamic subtest: pipe-B-eDP-1
[463.854073] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s)
[463.864536] Starting dynamic subtest: pipe-C-eDP-1
[465.230323] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[465.241738] Starting dynamic subtest: pipe-D-eDP-1
[466.553288] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[466.555223] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.646s)
[467.773673] [106/132] (556s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[467.884411] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[467.888886] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[468.019087] [107/132] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[468.120720] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[468.124684] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[468.261646] [108/132] (556s left) gem_mmap_offset (bad-flags)
[468.328441] Starting subtest: bad-flags
[468.330420] Subtest bad-flags: SUCCESS (0.000s)
[468.438936] [109/132] (555s left) gem_mmap_gtt (big-copy)
[468.493256] Subtest big-copy: SKIP (0.000s)
[468.553358] [110/132] (555s left) kms_plane_multiple (tiling-y)
[468.635602] Starting subtest: tiling-y
[468.639719] Subtest tiling-y: SKIP (0.000s)
[468.730869] [111/132] (555s left) kms_plane_scaling (planes-upscale-factor-0-25)
[468.833861] Starting subtest: planes-upscale-factor-0-25
[468.835450] Starting dynamic subtest: pipe-A
[468.896563] Dynamic subtest pipe-A: SUCCESS (0.064s)
[468.906766] Starting dynamic subtest: pipe-B
[470.065848] Dynamic subtest pipe-B: SUCCESS (1.170s)
[470.077437] Starting dynamic subtest: pipe-C
[471.169439] Dynamic subtest pipe-C: SUCCESS (1.103s)
[471.188312] Starting dynamic subtest: pipe-D
[472.305054] Dynamic subtest pipe-D: SUCCESS (1.134s)
[472.307483] Subtest planes-upscale-factor-0-25: SUCCESS (3.478s)
[473.483951] [112/132] (551s left) gem_ctx_param (set-priority-range)
[473.546980] Starting subtest: set-priority-range
[473.561774] Subtest set-priority-range: SUCCESS (0.015s)
[473.690162] [113/132] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[473.786937] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[473.790876] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[473.890792] [114/132] (550s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[473.994845] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[480.552183] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.565s)
[480.687894] [115/132] (543s left) kms_scaling_modes (scaling-mode-center)
[480.789258] Starting subtest: scaling-mode-center
[480.791456] Starting dynamic subtest: pipe-A-eDP-1
[480.891798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.104s)
[480.901491] Starting dynamic subtest: pipe-B-eDP-1
[482.106161] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[482.115998] Starting dynamic subtest: pipe-C-eDP-1
[483.220802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[483.230624] Starting dynamic subtest: pipe-D-eDP-1
[484.362211] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[484.364494] Subtest scaling-mode-center: SUCCESS (3.578s)
[485.634196] [116/132] (539s left) gen9_exec_parse (secure-batches)
[485.695355] Subtest secure-batches: SKIP (0.000s)
[485.783635] [117/132] (538s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[485.885231] Starting subtest: 4-tiled-64bpp-rotate-180
[487.363355] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.478s)
[487.579668] [118/132] (537s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[492.609624] Starting subtest: psr2-plane-move-sf-dmg-area
[492.611867] Starting dynamic subtest: pipe-A-eDP-1
[497.892236] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.280s)
[497.904198] Starting dynamic subtest: pipe-B-eDP-1
[503.220901] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.325s)
[503.223301] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.610s)
[504.118619] [119/132] (520s left) kms_vblank (query-forked-busy)
[504.217583] Starting subtest: query-forked-busy
[504.219481] Starting dynamic subtest: pipe-A-eDP-1
[506.094686] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[506.114520] Starting dynamic subtest: pipe-D-eDP-1
[508.644372] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[508.646657] Subtest query-forked-busy: SUCCESS (4.429s)
[509.475131] [120/132] (515s left) gem_ccs (block-copy-uncompressed)
[509.549945] Starting subtest: block-copy-uncompressed
[509.552200] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[509.570586] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[509.580172] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[509.589604] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[509.601787] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[509.606859] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[509.618445] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[509.628616] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[509.630882] Subtest block-copy-uncompressed: SUCCESS (0.082s)
[509.793657] [121/132] (515s left) syncobj_eventfd (binary-wait-signaled)
[509.855182] Starting subtest: binary-wait-signaled
[509.857149] Subtest binary-wait-signaled: SUCCESS (0.000s)
[509.978911] [122/132] (514s left) kms_draw_crc (draw-method-mmap-gtt)
[510.077582] Starting subtest: draw-method-mmap-gtt
[510.081811] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[510.206470] [123/132] (514s left) gem_exec_schedule (preempt-other)
[510.282131] Starting subtest: preempt-other
[510.284170] Starting dynamic subtest: rcs0
[510.348241] Dynamic subtest rcs0: SUCCESS (0.073s)
[510.361420] Starting dynamic subtest: bcs0
[510.414438] Dynamic subtest bcs0: SUCCESS (0.066s)
[510.423655] Starting dynamic subtest: vcs0
[510.484716] Dynamic subtest vcs0: SUCCESS (0.070s)
[510.495746] Starting dynamic subtest: vcs1
[510.552458] Dynamic subtest vcs1: SUCCESS (0.067s)
[510.566680] Starting dynamic subtest: vecs0
[510.618446] Dynamic subtest vecs0: SUCCESS (0.065s)
[510.630363] Starting dynamic subtest: ccs0
[510.686347] Dynamic subtest ccs0: SUCCESS (0.068s)
[510.688335] Subtest preempt-other: SUCCESS (0.413s)
[511.743591] [124/132] (513s left) kms_plane_lowres (tiling-4)
[511.841766] Starting subtest: tiling-4
[511.844050] Starting dynamic subtest: pipe-A-eDP-1
[511.848797] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[512.136834] Starting dynamic subtest: pipe-B-eDP-1
[512.141571] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[512.151370] Starting dynamic subtest: pipe-C-eDP-1
[512.156039] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[512.165347] Starting dynamic subtest: pipe-D-eDP-1
[512.169769] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[512.174228] Subtest tiling-4: SKIP (0.294s)
[513.007452] [125/132] (512s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[513.100624] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[519.360987] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.265s)
[520.504077] [126/132] (504s left) vgem_basic (setversion)
[520.557705] Starting subtest: setversion
[520.562037] Subtest setversion: SUCCESS (0.000s)
[520.637786] [127/132] (504s left) gem_exec_suspend (basic-s3-devices)
[520.703090] Starting subtest: basic-S3-devices
[520.705350] Starting dynamic subtest: smem
[532.583576] Dynamic subtest smem: SUCCESS (11.881s)
[532.586615] Subtest basic-S3-devices: SUCCESS (11.883s)
[532.795619] [128/132] (492s left) gem_eio (in-flight-suspend)
[533.066444] Starting subtest: in-flight-suspend
[576.406600] Subtest in-flight-suspend: SUCCESS (13.580s)
[576.589743] [129/132] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[576.696840] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[584.116120] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.423s)
[584.276743] [130/132] (441s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[584.391488] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[588.784063] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.397s)
[590.004532] [131/132] (435s left) perf (non-zero-reason)
[590.116534] Starting subtest: non-zero-reason
[590.118467] Starting dynamic subtest: 0-rcs0
[595.483442] Dynamic subtest 0-rcs0: SUCCESS (5.369s)
[595.495695] Starting dynamic subtest: 1-vecs0
[599.381739] Dynamic subtest 1-vecs0: SUCCESS (3.898s)
[599.384675] Subtest non-zero-reason: SUCCESS (9.270s)
[599.430846] [132/132] (425s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[599.484992] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[599.589674] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[599.695176] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_rotation_crc
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_chamelium_edid
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: prime_self_import
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_exec_parallel
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: prime_vgem
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_prime
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: dumb_buffer
results: parsing output: 59/ for test: i915_module_load
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: gem_huc_copy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: core_getclient
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_spin_batch
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_wait
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: sysfs_preempt_timeout
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: i915_suspend
results: parsing output: 96/ for test: kms_draw_crc
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: kms_draw_crc
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_plane_multiple
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_scaling_modes
results: parsing output: 115/ for test: gen9_exec_parse
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: gem_ccs
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_plane_lowres
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: gem_exec_suspend
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: syncobj_timeline
Done.