[59.465463] Initializing watchdogs
[59.465510]   /dev/watchdog0
[59.479256] [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.483835] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.485931] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.489086] [001/133] (960s left) gem_mmap_gtt (basic-read-write)
[59.573105] Subtest basic-read-write: SKIP (0.000s)
[59.619521] [002/133] (960s left) kms_plane (pixel-format-linear-modifier)
[59.714375] Starting subtest: pixel-format-linear-modifier
[59.753104] Starting dynamic subtest: pipe-A-plane-0
[63.186203] Dynamic subtest pipe-A-plane-0: SUCCESS (3.434s)
[63.192579] Starting dynamic subtest: pipe-A-plane-3
[64.863870] Dynamic subtest pipe-A-plane-3: SUCCESS (1.677s)
[64.870824] Starting dynamic subtest: pipe-A-plane-5
[65.074831] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[66.142454] Starting dynamic subtest: pipe-B-plane-0
[69.879938] Dynamic subtest pipe-B-plane-0: SUCCESS (3.744s)
[69.886583] Starting dynamic subtest: pipe-B-plane-3
[71.503660] Dynamic subtest pipe-B-plane-3: SUCCESS (1.622s)
[71.510512] Starting dynamic subtest: pipe-B-plane-5
[71.714064] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[72.038845] Subtest pixel-format-linear-modifier: SUCCESS (12.323s)
[72.836577] [003/133] (947s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[72.951944] Starting subtest: y-tiled-8bpp-rotate-270
[72.955956] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[73.045392] [004/133] (947s left) syncobj_wait (single-wait-for-submit-signaled)
[73.102707] Starting subtest: single-wait-for-submit-signaled
[73.105059] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[73.185700] [005/133] (946s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[73.294092] Starting subtest: flip-vs-cursor-atomic
[80.546161] Subtest flip-vs-cursor-atomic: SUCCESS (7.251s)
[81.386343] [006/133] (938s left) kms_chamelium_frames (hdmi-crc-fast)
[81.778052] Subtest hdmi-crc-fast: SKIP (0.000s)
[82.581915] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[82.687204] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[82.691723] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[82.793587] [008/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[82.899759] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[82.904225] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[82.991589] [009/133] (937s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[83.104319] Starting subtest: fbc-rgb101010-draw-blt
[87.726395] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.625s)
[88.922338] [010/133] (931s left) kms_dp_linktrain_fallback (dsc-fallback)
[89.011628] Starting subtest: dsc-fallback
[89.018348] Subtest dsc-fallback: SKIP (0.000s)
[89.080065] [011/133] (931s left) gem_exec_balancer (fairslice)
[89.144617] Starting subtest: fairslice
[92.034482] Subtest fairslice: SUCCESS (2.887s)
[92.952932] [012/133] (927s left) gem_eio (in-flight-immediate)
[93.185893] Starting subtest: in-flight-immediate
[101.675921] Subtest in-flight-immediate: SUCCESS (8.490s)
[101.826791] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[101.829812] [013/133] (918s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[101.882667] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[101.884779] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[101.974796] [014/133] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[102.070267] Starting subtest: fbcpsr-2p-rte
[102.074656] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[102.173184] [015/133] (918s left) kms_psr (psr2-cursor-mmap-cpu)
[102.268869] Starting subtest: psr2-cursor-mmap-cpu
[102.271130] Starting dynamic subtest: eDP-1
[103.988220] Dynamic subtest eDP-1: SUCCESS (1.718s)
[103.990592] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.719s)
[104.796788] [016/133] (915s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[104.897763] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[111.495919] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.600s)
[111.611410] [017/133] (908s left) sw_sync (sync_multi_consumer_producer)
[111.649061] Starting subtest: sync_multi_consumer_producer
[111.938289] Subtest sync_multi_consumer_producer: SUCCESS (0.289s)
[111.997226] [018/133] (908s left) kms_setmode (basic)
[112.049075] Starting subtest: basic
[112.368283] Starting dynamic subtest: pipe-A-eDP-1
[114.415256] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.042s)
[114.755825] Starting dynamic subtest: pipe-B-eDP-1
[116.849321] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.096s)
[117.154072] Subtest basic: SUCCESS (5.103s)
[117.996658] [019/133] (902s left) kms_psr (fbc-psr-primary-render)
[118.114485] Starting subtest: fbc-psr-primary-render
[118.116732] Starting dynamic subtest: eDP-1
[118.121070] Dynamic subtest eDP-1: SKIP (0.000s)
[118.125298] Subtest fbc-psr-primary-render: SKIP (0.001s)
[118.191567] [020/133] (902s left) kms_psr (psr-cursor-plane-move)
[118.281315] Starting subtest: psr-cursor-plane-move
[118.283678] Starting dynamic subtest: eDP-1
[119.991418] Dynamic subtest eDP-1: SUCCESS (1.707s)
[119.993661] Subtest psr-cursor-plane-move: SUCCESS (1.708s)
[120.867535] [021/133] (899s left) kms_pipe_crc_basic (suspend-read-crc)
[120.973147] Starting subtest: suspend-read-crc
[120.975595] Starting dynamic subtest: pipe-A-eDP-1
[138.710161] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.673s)
[138.722411] Starting dynamic subtest: pipe-B-eDP-1
[157.700415] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.825s)
[157.709607] Starting dynamic subtest: pipe-C-eDP-1
[175.669073] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.999s)
[175.677402] Starting dynamic subtest: pipe-D-eDP-1
[193.684539] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.089s)
[193.686545] Subtest suspend-read-crc: SUCCESS (12.590s)
[194.524784] [022/133] (826s left) kms_flip (flip-vs-dpms-on-nop)
[194.628261] Starting subtest: flip-vs-dpms-on-nop
[194.630121] Starting dynamic subtest: A-eDP1
[196.505068] Dynamic subtest A-eDP1: SUCCESS (1.877s)
[196.515568] Starting dynamic subtest: B-eDP1
[198.334865] Dynamic subtest B-eDP1: SUCCESS (1.826s)
[198.345058] Starting dynamic subtest: C-eDP1
[200.149698] Dynamic subtest C-eDP1: SUCCESS (1.812s)
[200.158302] Starting dynamic subtest: D-eDP1
[201.986872] Dynamic subtest D-eDP1: SUCCESS (1.834s)
[201.991831] Subtest flip-vs-dpms-on-nop: SUCCESS (7.360s)
[203.165463] [023/133] (817s left) gem_bad_reloc (negative-reloc-bltcopy)
[203.218306] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[203.295989] [024/133] (817s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[203.359435] Starting subtest: invalid-single-wait-all-unsubmitted
[203.361708] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[203.467897] [025/133] (817s left) gem_ccs (block-multicopy-compressed)
[203.531243] Starting subtest: block-multicopy-compressed
[203.535886] Subtest block-multicopy-compressed: SKIP (0.000s)
[203.636989] [026/133] (817s left) gen9_exec_parse (unaligned-jump)
[203.693278] Subtest unaligned-jump: SKIP (0.000s)
[203.759587] [027/133] (817s left) perf_pmu (multi-client)
[203.802315] Starting subtest: multi-client
[203.804428] Starting dynamic subtest: rcs0
[204.873458] Dynamic subtest rcs0: SUCCESS (1.070s)
[204.885461] Starting dynamic subtest: bcs0
[205.924372] Dynamic subtest bcs0: SUCCESS (1.048s)
[205.936195] Starting dynamic subtest: vcs0
[206.977617] Dynamic subtest vcs0: SUCCESS (1.051s)
[206.989377] Starting dynamic subtest: vcs1
[209.052697] Dynamic subtest vcs1: SUCCESS (2.072s)
[209.064107] Starting dynamic subtest: vecs0
[211.034907] Dynamic subtest vecs0: SUCCESS (1.979s)
[211.046437] Starting dynamic subtest: ccs0
[213.020357] Dynamic subtest ccs0: SUCCESS (1.983s)
[213.022995] Subtest multi-client: SUCCESS (9.214s)
[213.149126] [028/133] (807s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[213.261019] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[217.388833] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.129s)
[218.573839] [029/133] (802s left) gem_exec_schedule (fairslice-all)
[218.641360] Starting subtest: fairslice-all
[220.693176] Subtest fairslice-all: SUCCESS (2.059s)
[221.000872] [030/133] (800s left) kms_joiner (basic-max-non-joiner)
[221.115316] Starting subtest: basic-max-non-joiner
[221.119425] Subtest basic-max-non-joiner: SKIP (0.000s)
[221.180580] [031/133] (799s left) prime_vgem (coherency-gtt)
[221.248567] Starting subtest: coherency-gtt
[221.253286] Subtest coherency-gtt: SKIP (0.000s)
[221.341292] [032/133] (799s left) gem_exec_create (madvise)
[221.400234] Starting subtest: madvise
[221.402697] Starting dynamic subtest: smem
[241.557448] Dynamic subtest smem: SUCCESS (20.145s)
[241.559872] Subtest madvise: SUCCESS (20.146s)
[242.377366] [033/133] (778s left) gem_exec_fence (syncobj-repeat)
[242.868477] Starting subtest: syncobj-repeat
[243.058543] Subtest syncobj-repeat: SUCCESS (0.188s)
[244.101444] [034/133] (777s left) api_intel_bb (blit-noreloc-keep-cache)
[244.164042] Starting subtest: blit-noreloc-keep-cache
[244.190317] Subtest blit-noreloc-keep-cache: SUCCESS (0.029s)
[244.308372] [035/133] (776s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[244.374871] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[244.437321] [036/133] (776s left) gem_workarounds (basic-read)
[244.506036] Starting subtest: basic-read
[244.523930] Subtest basic-read: SUCCESS (0.018s)
[244.648879] [037/133] (776s left) prime_mmap (test_correct_cpu_write)
[244.714038] Starting subtest: test_correct_cpu_write
[244.716261] Starting dynamic subtest: test_correct_cpu_write-smem
[244.718123] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[244.720064] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[244.825386] [038/133] (776s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[244.924567] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[244.926661] Starting dynamic subtest: pipe-A-eDP-1
[244.948562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.958469] Starting dynamic subtest: pipe-B-eDP-1
[244.979053] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.987476] Starting dynamic subtest: pipe-C-eDP-1
[245.007764] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.016382] Starting dynamic subtest: pipe-D-eDP-1
[245.037445] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.041240] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[247.240035] [039/133] (774s left) gen9_exec_parse (bb-oversize)
[247.314051] Subtest bb-oversize: SKIP (0.000s)
[247.367563] [040/133] (774s left) gem_exec_schedule (pi-userfault)
[247.548427] Starting subtest: pi-userfault
[247.550306] Starting dynamic subtest: rcs0
[247.557765] Dynamic subtest rcs0: SUCCESS (0.012s)
[247.567428] Starting dynamic subtest: bcs0
[247.569558] Dynamic subtest bcs0: SUCCESS (0.008s)
[247.578298] Starting dynamic subtest: vcs0
[247.580152] Dynamic subtest vcs0: SUCCESS (0.009s)
[247.589006] Starting dynamic subtest: vcs1
[247.591208] Dynamic subtest vcs1: SUCCESS (0.009s)
[247.599870] Starting dynamic subtest: vecs0
[247.601693] Dynamic subtest vecs0: SUCCESS (0.008s)
[247.610474] Starting dynamic subtest: ccs0
[247.612687] Dynamic subtest ccs0: SUCCESS (0.009s)
[247.614875] Subtest pi-userfault: SUCCESS (0.059s)
[247.787119] [041/133] (773s left) kms_dsc (dsc-with-bpc)
[247.891872] Starting subtest: dsc-with-bpc
[247.921121] Subtest dsc-with-bpc: SKIP (0.001s)
[247.961088] [042/133] (773s left) kms_cursor_crc (cursor-offscreen-512x512)
[248.215177] Starting subtest: cursor-offscreen-512x512
[248.219605] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[248.365155] [043/133] (773s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[248.458474] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[248.462634] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[248.524935] [044/133] (773s left) vgem_basic (bad-fence)
[248.566186] Starting subtest: bad-fence
[248.567837] Subtest bad-fence: SUCCESS (0.000s)
[248.624503] [045/133] (773s left) gem_render_copy (yf-tiled-to-vebox-linear)
[248.686426] Starting subtest: yf-tiled-to-vebox-linear
[248.690025] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[248.866077] [046/133] (772s left) gem_eio (in-flight-internal-immediate)
[249.095488] Starting subtest: in-flight-internal-immediate
[250.095345] Subtest in-flight-internal-immediate: SUCCESS (0.999s)
[250.212710] [047/133] (771s left) kms_flip (blocking-absolute-wf_vblank)
[250.306050] Starting subtest: blocking-absolute-wf_vblank
[250.308262] Starting dynamic subtest: A-eDP1
[259.009355] Dynamic subtest A-eDP1: SUCCESS (8.698s)
[259.020936] Starting dynamic subtest: B-eDP1
[267.741641] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[267.750476] Starting dynamic subtest: C-eDP1
[276.468114] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[276.481901] Starting dynamic subtest: D-eDP1
[285.197493] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[285.202682] Subtest blocking-absolute-wf_vblank: SUCCESS (34.882s)
[286.412843] [048/133] (735s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[286.524835] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[286.527247] Starting dynamic subtest: pipe-A-eDP-1
[286.550891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[286.561693] Starting dynamic subtest: pipe-B-eDP-1
[286.583951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[286.592936] Starting dynamic subtest: pipe-C-eDP-1
[286.614310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[286.622823] Starting dynamic subtest: pipe-D-eDP-1
[286.644744] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[286.648856] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.013s)
[288.703008] [049/133] (733s left) kms_properties (connector-properties-legacy)
[288.801967] Starting subtest: connector-properties-legacy
[288.804226] Starting dynamic subtest: pipe-A-eDP-1
[296.726518] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.919s)
[296.735098] Starting dynamic subtest: pipe-None-DP-1
[296.739484] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[296.747780] Starting dynamic subtest: pipe-None-HDMI-A-1
[296.752098] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[296.760525] Starting dynamic subtest: pipe-None-DP-2
[296.764594] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[296.772812] Starting dynamic subtest: pipe-None-HDMI-A-2
[296.777124] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[296.785413] Starting dynamic subtest: pipe-None-DP-3
[296.790006] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[296.798932] Starting dynamic subtest: pipe-None-DP-4
[296.803440] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[296.805274] Subtest connector-properties-legacy: SUCCESS (7.930s)
[297.587017] [050/133] (724s left) perf_pmu (busy-hang)
[297.639416] Starting subtest: busy-hang
[297.641571] Starting dynamic subtest: rcs0
[298.910533] Dynamic subtest rcs0: SUCCESS (1.270s)
[298.921866] Starting dynamic subtest: bcs0
[300.143510] Dynamic subtest bcs0: SUCCESS (1.228s)
[300.153105] Starting dynamic subtest: vcs0
[302.569138] Dynamic subtest vcs0: SUCCESS (2.422s)
[302.579723] Starting dynamic subtest: vcs1
[304.546020] Dynamic subtest vcs1: SUCCESS (1.977s)
[304.555687] Starting dynamic subtest: vecs0
[306.535509] Dynamic subtest vecs0: SUCCESS (1.987s)
[306.545513] Starting dynamic subtest: ccs0
[307.784051] Dynamic subtest ccs0: SUCCESS (1.243s)
[307.786096] Subtest busy-hang: SUCCESS (10.138s)
[307.870080] [051/133] (714s left) kms_vblank (ts-continuation-modeset-rpm)
[307.984230] Starting subtest: ts-continuation-modeset-rpm
[307.986500] Starting dynamic subtest: pipe-A-eDP-1
[310.508876] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.519s)
[310.523569] Starting dynamic subtest: pipe-D-eDP-1
[312.742278] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.231s)
[312.744628] Subtest ts-continuation-modeset-rpm: SUCCESS (4.755s)
[313.620193] [052/133] (708s left) syncobj_wait (single-wait-for-submit-submitted)
[313.676733] Starting subtest: single-wait-for-submit-submitted
[313.785658] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[313.876247] [053/133] (708s left) kms_universal_plane (cursor-fb-leak)
[313.978865] Starting subtest: cursor-fb-leak
[313.981286] Starting dynamic subtest: pipe-A-eDP-1
[314.325649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.347s)
[314.337427] Starting dynamic subtest: pipe-B-eDP-1
[315.660576] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.332s)
[315.672773] Starting dynamic subtest: pipe-C-eDP-1
[317.075995] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.412s)
[317.091137] Starting dynamic subtest: pipe-D-eDP-1
[318.395459] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[318.397973] Subtest cursor-fb-leak: SUCCESS (4.416s)
[319.552009] [054/133] (702s left) gem_exec_schedule (smoketest)
[319.750383] Starting subtest: smoketest
[319.753041] Starting dynamic subtest: rcs0
[325.307519] Dynamic subtest rcs0: SUCCESS (5.502s)
[325.317929] Starting dynamic subtest: bcs0
[330.851313] Dynamic subtest bcs0: SUCCESS (5.541s)
[330.871681] Starting dynamic subtest: vcs0
[336.355477] Dynamic subtest vcs0: SUCCESS (5.498s)
[336.375397] Starting dynamic subtest: vcs1
[341.868341] Dynamic subtest vcs1: SUCCESS (5.512s)
[341.885425] Starting dynamic subtest: vecs0
[347.385536] Dynamic subtest vecs0: SUCCESS (5.511s)
[347.401158] Starting dynamic subtest: ccs0
[352.924596] Dynamic subtest ccs0: SUCCESS (5.532s)
[352.927021] Subtest smoketest: SUCCESS (33.104s)
[353.096086] [055/133] (668s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[353.197289] Starting subtest: x-tiled-addfb-size-offset-overflow
[353.199499] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[353.292918] [056/133] (668s left) kms_atomic_transition (plane-all-transition-nonblocking)
[353.387913] Starting subtest: plane-all-transition-nonblocking
[353.390145] Starting dynamic subtest: pipe-A-eDP-1
[355.882350] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[356.189172] Starting dynamic subtest: pipe-B-eDP-1
[359.409393] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.227s)
[359.713055] Subtest plane-all-transition-nonblocking: SUCCESS (6.322s)
[360.541448] [057/133] (661s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[360.599031] Starting subtest: single-wait-for-submit-unsubmitted
[360.705207] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[360.780657] [058/133] (661s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[360.873294] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[360.877668] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[360.996824] [059/133] (661s left) kms_flip (absolute-wf_vblank)
[361.080309] Starting subtest: absolute-wf_vblank
[361.082626] Starting dynamic subtest: A-eDP1
[369.802375] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[369.811274] Starting dynamic subtest: B-eDP1
[378.539719] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[378.548369] Starting dynamic subtest: C-eDP1
[387.263620] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[387.273684] Starting dynamic subtest: D-eDP1
[396.000497] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[396.005304] Subtest absolute-wf_vblank: SUCCESS (34.909s)
[397.206222] [060/133] (625s left) gem_ctx_persistence (heartbeat-hostile)
[397.265821] Starting subtest: heartbeat-hostile
[397.270359] Subtest heartbeat-hostile: SKIP (0.000s)
[397.383256] [061/133] (624s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[397.428713] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[397.529579] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[397.617387] [062/133] (624s left) gem_exec_params (dr1-dirt)
[397.690494] Starting subtest: DR1-dirt
[397.693031] Subtest DR1-dirt: SUCCESS (0.000s)
[397.798308] [063/133] (624s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[397.889092] Starting subtest: addfb25-yf-tiled-legacy
[397.891348] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[397.990809] [064/133] (624s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[398.076030] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[398.078859] Starting dynamic subtest: pipe-A-eDP-1
[398.102134] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[398.113038] Starting dynamic subtest: pipe-B-eDP-1
[398.135544] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[398.144508] Starting dynamic subtest: pipe-C-eDP-1
[398.166641] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[398.175254] Starting dynamic subtest: pipe-D-eDP-1
[398.198057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[398.202190] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[400.278731] [065/133] (622s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[400.329043] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[400.331320] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[400.416803] [066/133] (622s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[400.513847] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[400.518158] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[400.589663] [067/133] (621s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[400.790624] Starting subtest: cursor-rapid-movement-128x128
[400.795420] Starting dynamic subtest: pipe-A-eDP-1
[401.352205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[401.382829] Starting dynamic subtest: pipe-D-eDP-1
[402.590243] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s)
[402.592114] Subtest cursor-rapid-movement-128x128: SUCCESS (1.796s)
[403.445509] [068/133] (619s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[403.540960] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[403.545277] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[403.645730] [069/133] (619s left) i915_hangman (detector)
[403.713715] Starting subtest: detector
[403.715836] Starting dynamic subtest: rcs0
[414.979365] Dynamic subtest rcs0: SUCCESS (11.260s)
[414.995454] Starting dynamic subtest: bcs0
[425.987781] Dynamic subtest bcs0: SUCCESS (10.997s)
[426.000158] Starting dynamic subtest: vcs0
[437.955000] Dynamic subtest vcs0: SUCCESS (11.959s)
[437.966790] Starting dynamic subtest: vcs1
[449.923203] Dynamic subtest vcs1: SUCCESS (11.958s)
[449.935593] Starting dynamic subtest: vecs0
[460.932036] Dynamic subtest vecs0: SUCCESS (11.000s)
[460.943265] Starting dynamic subtest: ccs0
[472.963226] Dynamic subtest ccs0: SUCCESS (12.023s)
[472.965849] Subtest detector: SUCCESS (69.219s)
[473.045486] [070/133] (549s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[473.155324] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[480.368763] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.213s)
[480.472563] [071/133] (542s left) core_auth (getclient-simple)
[480.511128] Starting subtest: getclient-simple
[480.534473] Subtest getclient-simple: SUCCESS (0.023s)
[480.645972] [072/133] (542s left) kms_properties (colorop-properties-legacy)
[480.736555] Starting subtest: colorop-properties-legacy
[480.738752] Starting dynamic subtest: pipe-A-eDP-1
[481.078818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.341s)
[481.088688] Starting dynamic subtest: pipe-B-eDP-1
[482.146449] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.066s)
[482.156519] Starting dynamic subtest: pipe-C-eDP-1
[483.173460] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.033s)
[483.182807] Starting dynamic subtest: pipe-D-eDP-1
[484.211307] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.045s)
[484.213220] Subtest colorop-properties-legacy: SUCCESS (3.491s)
[485.016182] [073/133] (537s left) gem_ctx_param (invalid-get-engines)
[485.077960] Starting subtest: invalid-get-engines
[485.080243] Subtest invalid-get-engines: SUCCESS (0.001s)
[485.170999] [074/133] (537s left) kms_prop_blob (basic)
[485.222702] Starting subtest: basic
[485.224706] Subtest basic: SUCCESS (0.000s)
[485.329364] [075/133] (537s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[485.444332] Starting subtest: cursorB-vs-flipA-toggle
[485.448852] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[485.601686] [076/133] (537s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[485.697784] Starting subtest: plane-scaler-unity-scaling-with-rotation
[485.699658] Starting dynamic subtest: pipe-A
[485.922278] Dynamic subtest pipe-A: SUCCESS (0.228s)
[485.931360] Starting dynamic subtest: pipe-B
[487.267470] Dynamic subtest pipe-B: SUCCESS (1.353s)
[487.277105] Starting dynamic subtest: pipe-C
[488.612119] Dynamic subtest pipe-C: SUCCESS (1.352s)
[488.622209] Starting dynamic subtest: pipe-D
[489.933481] Dynamic subtest pipe-D: SUCCESS (1.327s)
[489.935881] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.265s)
[491.086134] [077/133] (531s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[491.194863] Starting subtest: extended-modeset-hang-oldfb-with-reset
[491.197306] Starting dynamic subtest: pipe-A
[502.932182] Dynamic subtest pipe-A: SUCCESS (11.781s)
[502.941796] Starting dynamic subtest: pipe-D
[515.202331] Dynamic subtest pipe-D: SUCCESS (12.294s)
[515.204721] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.079s)
[516.006946] [078/133] (507s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[516.109435] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[516.113643] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[516.201261] [079/133] (506s left) kms_plane_scaling (planes-upscale-20x20)
[516.305955] Starting subtest: planes-upscale-20x20
[516.308235] Starting dynamic subtest: pipe-A
[516.367280] Dynamic subtest pipe-A: SUCCESS (0.063s)
[516.377174] Starting dynamic subtest: pipe-B
[517.522341] Dynamic subtest pipe-B: SUCCESS (1.156s)
[517.533767] Starting dynamic subtest: pipe-C
[518.630454] Dynamic subtest pipe-C: SUCCESS (1.108s)
[518.640762] Starting dynamic subtest: pipe-D
[519.759073] Dynamic subtest pipe-D: SUCCESS (1.130s)
[519.761339] Subtest planes-upscale-20x20: SUCCESS (3.460s)
[520.926408] [080/133] (502s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[521.017281] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[521.019157] Starting dynamic subtest: pipe-A-eDP-1
[521.731756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[521.742646] Starting dynamic subtest: pipe-B-eDP-1
[523.525733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.795s)
[523.535965] Starting dynamic subtest: pipe-C-eDP-1
[525.259348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.734s)
[525.269993] Starting dynamic subtest: pipe-D-eDP-1
[526.991046] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.731s)
[526.993352] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.974s)
[528.143101] [081/133] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[528.239259] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[528.243733] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[528.344074] [082/133] (494s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[528.726273] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[529.546271] [083/133] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[529.637593] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[529.642011] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[529.725262] [084/133] (493s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[529.815047] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[529.817263] Starting dynamic subtest: A-eDP1
[533.486378] Dynamic subtest A-eDP1: SUCCESS (3.671s)
[533.496556] Starting dynamic subtest: B-eDP1
[536.688637] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[536.698953] Starting dynamic subtest: C-eDP1
[539.792505] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[539.804686] Starting dynamic subtest: D-eDP1
[542.893374] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[542.895343] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.089s)
[543.729024] [085/133] (479s left) gem_mmap_gtt (basic-read)
[543.807111] Subtest basic-read: SKIP (0.000s)
[543.876731] [086/133] (479s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[543.927039] Starting subtest: single-wait-for-submit-available-signaled
[543.929363] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[544.036292] [087/133] (479s left) gem_vm_create (isolation)
[544.088943] Starting subtest: isolation
[544.098048] Subtest isolation: SUCCESS (0.012s)
[544.207802] [088/133] (479s left) gem_mmap_gtt (hang-busy)
[544.277489] Subtest hang-busy: SKIP (0.000s)
[544.340550] [089/133] (479s left) kms_lease (lease-uevent)
[544.429284] Starting subtest: lease-uevent
[545.441440] Subtest lease-uevent: SUCCESS (1.011s)
[545.513507] [090/133] (478s left) gem_mmap_gtt (basic-short)
[545.564383] Subtest basic-short: SKIP (0.000s)
[545.623263] [091/133] (477s left) gem_mmap_gtt (cpuset-big-copy-xy)
[545.674076] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[545.735047] [092/133] (477s left) kms_scaling_modes (scaling-mode-full)
[545.821923] Starting subtest: scaling-mode-full
[545.824175] Starting dynamic subtest: pipe-A-eDP-1
[545.912243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.091s)
[545.923044] Starting dynamic subtest: pipe-B-eDP-1
[547.105000] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[547.114327] Starting dynamic subtest: pipe-C-eDP-1
[548.313565] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[548.323033] Starting dynamic subtest: pipe-D-eDP-1
[549.459289] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[549.461512] Subtest scaling-mode-full: SUCCESS (3.639s)
[550.618528] [093/133] (473s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[550.737520] Starting subtest: basic-flip-after-cursor-legacy
[551.660073] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.921s)
[552.453130] [094/133] (471s left) kms_flip (nonexisting-fb)
[552.548877] Starting subtest: nonexisting-fb
[552.551179] Starting dynamic subtest: A-eDP1
[553.742596] Dynamic subtest A-eDP1: SUCCESS (1.196s)
[553.752023] Starting dynamic subtest: B-eDP1
[554.876064] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[554.888188] Starting dynamic subtest: C-eDP1
[556.010221] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[556.019791] Starting dynamic subtest: D-eDP1
[557.142970] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[557.149015] Subtest nonexisting-fb: SUCCESS (4.601s)
[558.317671] [095/133] (465s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[558.383058] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[558.488745] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[558.568895] [096/133] (465s left) kms_content_protection (atomic-dpms)
[558.696903] Starting subtest: atomic-dpms
[558.701458] Subtest atomic-dpms: SKIP (0.000s)
[558.812510] [097/133] (465s left) gem_exec_capture (capture)
[558.864568] Starting subtest: capture
[558.867197] Starting dynamic subtest: rcs0-smem
[559.709863] Dynamic subtest rcs0-smem: SUCCESS (0.844s)
[559.720888] Starting dynamic subtest: bcs0-smem
[561.032610] Dynamic subtest bcs0-smem: SUCCESS (1.318s)
[561.042830] Starting dynamic subtest: vcs0-smem
[561.843622] Dynamic subtest vcs0-smem: SUCCESS (0.813s)
[561.855192] Starting dynamic subtest: vcs1-smem
[562.667722] Dynamic subtest vcs1-smem: SUCCESS (0.820s)
[562.678595] Starting dynamic subtest: vecs0-smem
[564.064610] Dynamic subtest vecs0-smem: FAIL (1.340s)
[564.075702] Starting dynamic subtest: ccs0-smem
[565.326161] Dynamic subtest ccs0-smem: SUCCESS (1.318s)
[565.328711] Subtest capture: FAIL (6.458s)
[565.466403] [098/133] (458s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[565.589382] Starting subtest: cursorB-vs-flipB-atomic
[565.593888] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[565.739241] [099/133] (458s left) gem_pxp (protected-raw-src-copy-not-readible)
[565.859438] Starting subtest: protected-raw-src-copy-not-readible
[565.918563] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[566.034737] [100/133] (457s left) i915_pm_rc6_residency (rc6-fence)
[566.098593] Starting subtest: rc6-fence
[566.124888] Starting dynamic subtest: gt0
[578.448914] Dynamic subtest gt0: SUCCESS (12.321s)
[578.461543] Starting dynamic subtest: gt1
[592.997378] Dynamic subtest gt1: SUCCESS (14.544s)
[593.000284] Subtest rc6-fence: SUCCESS (26.899s)
[593.076402] [101/133] (430s left) kms_async_flips (crc-atomic)
[593.176644] Starting subtest: crc-atomic
[593.559635] Starting dynamic subtest: pipe-A-eDP-1
[596.431493] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.871s)
[596.807010] Starting dynamic subtest: pipe-B-eDP-1
[599.768450] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.969s)
[600.157372] Starting dynamic subtest: pipe-C-eDP-1
[603.073579] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.926s)
[603.467968] Starting dynamic subtest: pipe-D-eDP-1
[606.297534] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.847s)
[606.300094] Subtest crc-atomic: SUCCESS (13.122s)
[607.492152] [102/133] (416s left) kms_psr (fbc-pr-cursor-render)
[607.580044] Starting subtest: fbc-pr-cursor-render
[607.584203] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[607.667497] [103/133] (416s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[607.779913] Starting subtest: basic-busy-flip-before-cursor-varying-size
[607.784542] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[607.923249] [104/133] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[608.029111] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[614.862241] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.836s)
[615.010154] [105/133] (409s left) gem_exec_whisper (basic-contexts-priority)
[615.073523] Starting subtest: basic-contexts-priority
[638.481811] Subtest basic-contexts-priority: SUCCESS (23.410s)
[638.663091] [106/133] (385s left) kms_color (ctm-max)
[638.759713] Starting subtest: ctm-max
[638.761855] Starting dynamic subtest: pipe-A-eDP-1
[639.491896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[639.501705] Starting dynamic subtest: pipe-B-eDP-1
[640.884629] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[640.894758] Starting dynamic subtest: pipe-C-eDP-1
[642.264278] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[642.273879] Starting dynamic subtest: pipe-D-eDP-1
[643.587052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[643.589304] Subtest ctm-max: SUCCESS (4.830s)
[644.392531] [107/133] (379s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[644.482030] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[651.336040] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.858s)
[651.486996] [108/133] (372s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[651.585191] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[651.587151] Starting dynamic subtest: pipe-A-eDP-1
[668.009947] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.426s)
[668.020206] Starting dynamic subtest: pipe-B-eDP-1
[685.000916] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.443s)
[685.012017] Starting dynamic subtest: pipe-C-eDP-1
[701.978297] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.442s)
[701.989848] Starting dynamic subtest: pipe-D-eDP-1
[718.981757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.379s)
[718.983627] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.694s)
[720.198188] [109/133] (304s left) kms_psr (fbc-pr-sprite-plane-move)
[720.310750] Starting subtest: fbc-pr-sprite-plane-move
[720.315173] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[720.382923] [110/133] (304s left) kms_pm_rpm (basic-rte)
[720.417904] Starting subtest: basic-rte
[723.361087] Subtest basic-rte: SUCCESS (2.942s)
[725.326696] [111/133] (299s left) gem_ctx_shared (q-out-order)
[725.386314] Starting subtest: Q-out-order
[725.388728] Starting dynamic subtest: rcs0
[725.508285] Dynamic subtest rcs0: SUCCESS (0.119s)
[725.523017] Starting dynamic subtest: vcs0
[725.621540] Dynamic subtest vcs0: SUCCESS (0.114s)
[725.634206] Starting dynamic subtest: vcs1
[725.710808] Dynamic subtest vcs1: SUCCESS (0.088s)
[725.729308] Starting dynamic subtest: vecs0
[725.792872] Dynamic subtest vecs0: SUCCESS (0.081s)
[725.809223] Starting dynamic subtest: ccs0
[725.887747] Dynamic subtest ccs0: SUCCESS (0.094s)
[725.890635] Subtest Q-out-order: SUCCESS (0.501s)
[726.848533] [112/133] (297s left) kms_big_fb (linear-8bpp-rotate-0)
[726.950598] Starting subtest: linear-8bpp-rotate-0
[728.191358] Subtest linear-8bpp-rotate-0: SUCCESS (1.237s)
[728.300895] [113/133] (296s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[728.401167] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[728.404870] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[728.500445] [114/133] (296s left) gem_softpin (evict-prime-sanity-check)
[728.568797] Starting subtest: evict-prime-sanity-check
[728.570765] Starting dynamic subtest: rcs0
[729.717167] Dynamic subtest rcs0: SUCCESS (1.147s)
[729.726954] Starting dynamic subtest: bcs0
[730.829297] Dynamic subtest bcs0: SUCCESS (1.110s)
[730.839900] Starting dynamic subtest: vcs0
[732.692304] Dynamic subtest vcs0: SUCCESS (1.858s)
[732.704530] Starting dynamic subtest: vcs1
[734.677292] Dynamic subtest vcs1: SUCCESS (1.982s)
[734.690124] Starting dynamic subtest: vecs0
[736.660958] Dynamic subtest vecs0: SUCCESS (1.980s)
[736.673263] Starting dynamic subtest: ccs0
[737.801710] Dynamic subtest ccs0: SUCCESS (1.139s)
[737.812769] Starting dynamic subtest: all
[738.915201] Dynamic subtest all: SUCCESS (1.111s)
[738.918109] Subtest evict-prime-sanity-check: SUCCESS (10.343s)
[739.009590] [115/133] (285s left) dmabuf_sync_file (export-multiwait)
[739.066337] Starting subtest: export-multiwait
[739.068753] Subtest export-multiwait: SUCCESS (0.000s)
[739.125137] [116/133] (285s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[739.227855] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[746.552859] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.325s)
[746.685807] [117/133] (278s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[746.776513] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[746.780531] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[746.851542] [118/133] (277s left) gem_create (create-ext-set-pat)
[747.012552] Starting subtest: create-ext-set-pat
[747.015677] Subtest create-ext-set-pat: SUCCESS (0.001s)
[747.119122] [119/133] (277s left) prime_vgem (busy)
[747.192225] Starting subtest: busy
[747.194390] Starting dynamic subtest: rcs0
[747.249730] Dynamic subtest rcs0: SUCCESS (0.058s)
[747.260690] Starting dynamic subtest: bcs0
[747.310701] Dynamic subtest bcs0: SUCCESS (0.060s)
[747.320105] Starting dynamic subtest: vcs0
[747.360543] Dynamic subtest vcs0: SUCCESS (0.049s)
[747.370173] Starting dynamic subtest: vcs1
[747.408929] Dynamic subtest vcs1: SUCCESS (0.047s)
[747.418398] Starting dynamic subtest: vecs0
[747.454417] Dynamic subtest vecs0: SUCCESS (0.045s)
[747.463876] Starting dynamic subtest: ccs0
[747.503691] Dynamic subtest ccs0: SUCCESS (0.048s)
[747.505925] Subtest busy: SUCCESS (0.313s)
[747.630674] [120/133] (277s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[747.729798] Starting subtest: x-tiled-64bpp-rotate-90
[747.749296] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[747.853471] [121/133] (277s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[747.945275] Starting subtest: 4-tiled-32bpp-rotate-180
[749.391264] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.445s)
[749.581602] [122/133] (275s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[749.652535] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[749.718247] [123/133] (275s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[749.818701] Starting subtest: yf-tiled-32bpp-rotate-90
[749.822679] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[749.926647] [124/133] (275s left) gem_mmap_wc (write-prefaulted)
[749.976853] Subtest write-prefaulted: SKIP (0.000s)
[750.038298] [125/133] (275s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[750.162009] Starting subtest: cursorA-vs-flipA-legacy
[761.302502] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.139s)
[762.102381] [126/133] (263s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[762.221544] Starting subtest: 2x-long-flip-vs-cursor-legacy
[762.226235] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[762.363985] [127/133] (262s left) gem_mmap_gtt (big-bo)
[762.416250] Subtest big-bo: SKIP (0.000s)
[762.473655] [128/133] (262s left) gem_exercise_blt (fast-copy-emit)
[762.532820] Starting subtest: fast-copy-emit
[762.535063] Starting dynamic subtest: linear-smem-smem-emit
[762.554252] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[762.567409] Starting dynamic subtest: xmajor-smem-smem-emit
[762.572171] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[762.581305] Starting dynamic subtest: tile4-smem-smem-emit
[762.590173] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[762.607442] Starting dynamic subtest: tile64-smem-smem-emit
[762.610008] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[762.612322] Subtest fast-copy-emit: SUCCESS (0.077s)
[762.735832] [129/133] (262s left) perf (gen8-unprivileged-single-ctx-counters)
[762.910945] Starting subtest: gen8-unprivileged-single-ctx-counters
[762.915339] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[762.959240] [130/133] (262s left) gem_exec_reloc (basic-cpu-read)
[763.016119] Subtest basic-cpu-read: SKIP (0.000s)
[763.092385] [131/133] (262s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[763.190315] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[763.193754] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[763.299523] [132/133] (262s left) i915_pm_rps (thresholds-idle-park)
[763.369594] Starting subtest: thresholds-idle-park
[763.373426] Subtest thresholds-idle-park: SKIP (0.001s)
[763.449290] [133/133] (261s left) gem_exec_params (rsvd2-dirt)
[763.509546] Starting subtest: rsvd2-dirt
[763.513287] Subtest rsvd2-dirt: SKIP (0.000s)
[763.614782] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_chamelium_frames
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_dp_linktrain_fallback
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_setmode
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_pipe_crc_basic
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_bad_reloc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_ccs
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_joiner
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: gem_exec_create
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_workarounds
results: parsing output: 36/ for test: prime_mmap
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: vgem_basic
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: core_auth
results: parsing output: 71/ for test: kms_properties
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_scaling_modes
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: gem_exec_capture
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: i915_pm_rc6_residency
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: gem_create
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_pipe_b_c_ivb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_exercise_blt
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pm_rps
results: parsing output: 132/ for test: gem_exec_params
Done.