[58.003584] Initializing watchdogs
[58.003676]   /dev/watchdog0
[58.018161] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.022153] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.024652] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.028573] [001/133] (960s left) gem_mmap_gtt (basic-read-write)
[58.109530] Subtest basic-read-write: SKIP (0.000s)
[58.169390] [002/133] (960s left) kms_plane (pixel-format-linear-modifier)
[58.250755] Starting subtest: pixel-format-linear-modifier
[58.288427] Starting dynamic subtest: pipe-A-plane-0
[61.721342] Dynamic subtest pipe-A-plane-0: SUCCESS (3.433s)
[61.731185] Starting dynamic subtest: pipe-A-plane-3
[63.343456] Dynamic subtest pipe-A-plane-3: SUCCESS (1.622s)
[63.350992] Starting dynamic subtest: pipe-A-plane-5
[63.554986] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[64.927302] Starting dynamic subtest: pipe-B-plane-0
[68.499687] Dynamic subtest pipe-B-plane-0: SUCCESS (3.578s)
[68.508039] Starting dynamic subtest: pipe-B-plane-3
[70.144573] Dynamic subtest pipe-B-plane-3: SUCCESS (1.644s)
[70.151760] Starting dynamic subtest: pipe-B-plane-5
[70.355323] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[70.664837] Subtest pixel-format-linear-modifier: SUCCESS (12.415s)
[71.501898] [003/133] (947s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[71.598644] Starting subtest: y-tiled-8bpp-rotate-270
[71.602909] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[71.689061] [004/133] (946s left) syncobj_wait (single-wait-for-submit-signaled)
[71.739605] Starting subtest: single-wait-for-submit-signaled
[71.741495] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[71.827666] [005/133] (946s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[71.925817] Starting subtest: flip-vs-cursor-atomic
[78.970560] Subtest flip-vs-cursor-atomic: SUCCESS (7.046s)
[79.841509] [006/133] (938s left) kms_chamelium_frames (hdmi-crc-fast)
[80.210798] Subtest hdmi-crc-fast: SKIP (0.000s)
[81.045480] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[81.129188] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[81.133437] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[81.209150] [008/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[81.300757] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[81.305150] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[81.388441] [009/133] (937s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[81.487273] Starting subtest: fbc-rgb101010-draw-blt
[86.077764] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.595s)
[87.271182] [010/133] (931s left) kms_dp_linktrain_fallback (dsc-fallback)
[87.353141] Starting subtest: dsc-fallback
[87.360041] Subtest dsc-fallback: SKIP (0.000s)
[87.451536] [011/133] (931s left) gem_exec_balancer (fairslice)
[87.507388] Starting subtest: fairslice
[90.396549] Subtest fairslice: SUCCESS (2.887s)
[90.917550] [012/133] (928s left) gem_eio (in-flight-immediate)
[91.158206] Starting subtest: in-flight-immediate
[99.740682] Subtest in-flight-immediate: SUCCESS (8.583s)
[99.877537] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[99.880593] [013/133] (919s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[99.933050] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[99.935052] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[100.055186] [014/133] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[100.141957] Starting subtest: fbcpsr-2p-rte
[100.146173] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[100.239778] [015/133] (918s left) kms_psr (psr2-cursor-mmap-cpu)
[100.325230] Starting subtest: psr2-cursor-mmap-cpu
[100.327597] Starting dynamic subtest: eDP-1
[102.031409] Dynamic subtest eDP-1: SUCCESS (1.706s)
[102.033409] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.706s)
[102.900201] [016/133] (916s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[102.986601] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[109.624882] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.642s)
[109.737669] [017/133] (909s left) sw_sync (sync_multi_consumer_producer)
[109.779869] Starting subtest: sync_multi_consumer_producer
[110.071987] Subtest sync_multi_consumer_producer: SUCCESS (0.291s)
[110.140367] [018/133] (909s left) kms_setmode (basic)
[110.186932] Starting subtest: basic
[110.520385] Starting dynamic subtest: pipe-A-eDP-1
[112.652461] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.127s)
[112.995200] Starting dynamic subtest: pipe-B-eDP-1
[115.083120] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[115.394053] Subtest basic: SUCCESS (5.204s)
[116.225418] [019/133] (902s left) kms_psr (fbc-psr-primary-render)
[116.306106] Starting subtest: fbc-psr-primary-render
[116.308574] Starting dynamic subtest: eDP-1
[116.312609] Dynamic subtest eDP-1: SKIP (0.000s)
[116.316960] Subtest fbc-psr-primary-render: SKIP (0.001s)
[116.385964] [020/133] (902s left) kms_psr (psr-cursor-plane-move)
[116.464659] Starting subtest: psr-cursor-plane-move
[116.466822] Starting dynamic subtest: eDP-1
[118.232565] Dynamic subtest eDP-1: SUCCESS (1.767s)
[118.234984] Subtest psr-cursor-plane-move: SUCCESS (1.767s)
[119.093578] [021/133] (900s left) kms_pipe_crc_basic (suspend-read-crc)
[119.166979] Starting subtest: suspend-read-crc
[119.169419] Starting dynamic subtest: pipe-A-eDP-1
[136.518189] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.789s)
[136.529038] Starting dynamic subtest: pipe-B-eDP-1
[154.476537] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.181s)
[154.485425] Starting dynamic subtest: pipe-C-eDP-1
[172.446964] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.058s)
[172.459908] Starting dynamic subtest: pipe-D-eDP-1
[190.458139] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.068s)
[190.460436] Subtest suspend-read-crc: SUCCESS (12.101s)
[191.278516] [022/133] (828s left) kms_flip (flip-vs-dpms-on-nop)
[191.355303] Starting subtest: flip-vs-dpms-on-nop
[191.357733] Starting dynamic subtest: A-eDP1
[193.251949] Dynamic subtest A-eDP1: SUCCESS (1.896s)
[193.262169] Starting dynamic subtest: B-eDP1
[195.082104] Dynamic subtest B-eDP1: SUCCESS (1.826s)
[195.093838] Starting dynamic subtest: C-eDP1
[196.900607] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[196.913317] Starting dynamic subtest: D-eDP1
[198.727286] Dynamic subtest D-eDP1: SUCCESS (1.825s)
[198.729816] Subtest flip-vs-dpms-on-nop: SUCCESS (7.371s)
[199.920204] [023/133] (819s left) gem_bad_reloc (negative-reloc-bltcopy)
[199.977825] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[200.064862] [024/133] (819s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[200.120019] Starting subtest: invalid-single-wait-all-unsubmitted
[200.122274] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[200.228109] [025/133] (819s left) gem_ccs (block-multicopy-compressed)
[200.277812] Starting subtest: block-multicopy-compressed
[200.282337] Subtest block-multicopy-compressed: SKIP (0.000s)
[200.391885] [026/133] (819s left) gen9_exec_parse (unaligned-jump)
[200.461528] Subtest unaligned-jump: SKIP (0.000s)
[200.542975] [027/133] (818s left) perf_pmu (multi-client)
[200.596828] Starting subtest: multi-client
[200.599097] Starting dynamic subtest: rcs0
[201.652568] Dynamic subtest rcs0: SUCCESS (1.055s)
[201.664698] Starting dynamic subtest: bcs0
[202.699336] Dynamic subtest bcs0: SUCCESS (1.043s)
[202.711219] Starting dynamic subtest: vcs0
[203.755453] Dynamic subtest vcs0: SUCCESS (1.051s)
[203.767164] Starting dynamic subtest: vcs1
[205.059188] Dynamic subtest vcs1: SUCCESS (1.301s)
[205.071813] Starting dynamic subtest: vecs0
[207.043547] Dynamic subtest vecs0: SUCCESS (1.981s)
[207.055218] Starting dynamic subtest: ccs0
[209.031755] Dynamic subtest ccs0: SUCCESS (1.986s)
[209.034436] Subtest multi-client: SUCCESS (8.432s)
[209.146345] [028/133] (810s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[209.232048] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[213.359962] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.129s)
[214.544074] [029/133] (805s left) gem_exec_schedule (fairslice-all)
[214.614543] Starting subtest: fairslice-all
[216.669492] Subtest fairslice-all: SUCCESS (2.062s)
[216.960903] [030/133] (802s left) kms_joiner (basic-max-non-joiner)
[217.045920] Starting subtest: basic-max-non-joiner
[217.050357] Subtest basic-max-non-joiner: SKIP (0.000s)
[217.122428] [031/133] (802s left) prime_vgem (coherency-gtt)
[217.205492] Starting subtest: coherency-gtt
[217.210246] Subtest coherency-gtt: SKIP (0.000s)
[217.303562] [032/133] (802s left) gem_exec_create (madvise)
[217.377753] Starting subtest: madvise
[217.380235] Starting dynamic subtest: smem
[237.535496] Dynamic subtest smem: SUCCESS (20.149s)
[237.538330] Subtest madvise: SUCCESS (20.149s)
[238.399017] [033/133] (781s left) gem_exec_fence (syncobj-repeat)
[238.872010] Starting subtest: syncobj-repeat
[239.055993] Subtest syncobj-repeat: SUCCESS (0.183s)
[240.073438] [034/133] (779s left) api_intel_bb (blit-noreloc-keep-cache)
[240.126905] Starting subtest: blit-noreloc-keep-cache
[240.141788] Subtest blit-noreloc-keep-cache: SUCCESS (0.017s)
[240.251524] [035/133] (779s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[240.313729] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[240.391554] [036/133] (779s left) gem_workarounds (basic-read)
[240.447732] Starting subtest: basic-read
[240.462834] Subtest basic-read: SUCCESS (0.016s)
[240.596011] [037/133] (779s left) prime_mmap (test_correct_cpu_write)
[240.646834] Starting subtest: test_correct_cpu_write
[240.649181] Starting dynamic subtest: test_correct_cpu_write-smem
[240.651351] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[240.653566] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[240.760089] [038/133] (779s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[240.837840] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[240.840089] Starting dynamic subtest: pipe-A-eDP-1
[240.862314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.872889] Starting dynamic subtest: pipe-B-eDP-1
[240.893442] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.901978] Starting dynamic subtest: pipe-C-eDP-1
[240.922421] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.930429] Starting dynamic subtest: pipe-D-eDP-1
[240.951365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.955485] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[242.995817] [039/133] (777s left) gen9_exec_parse (bb-oversize)
[243.071423] Subtest bb-oversize: SKIP (0.000s)
[243.149817] [040/133] (776s left) gem_exec_schedule (pi-userfault)
[243.328222] Starting subtest: pi-userfault
[243.330073] Starting dynamic subtest: rcs0
[243.335030] Dynamic subtest rcs0: SUCCESS (0.009s)
[243.343793] Starting dynamic subtest: bcs0
[243.345994] Dynamic subtest bcs0: SUCCESS (0.009s)
[243.355084] Starting dynamic subtest: vcs0
[243.357202] Dynamic subtest vcs0: SUCCESS (0.008s)
[243.365983] Starting dynamic subtest: vcs1
[243.367861] Dynamic subtest vcs1: SUCCESS (0.007s)
[243.376900] Starting dynamic subtest: vecs0
[243.379078] Dynamic subtest vecs0: SUCCESS (0.011s)
[243.387712] Starting dynamic subtest: ccs0
[243.389581] Dynamic subtest ccs0: SUCCESS (0.012s)
[243.391482] Subtest pi-userfault: SUCCESS (0.060s)
[243.573998] [041/133] (776s left) kms_dsc (dsc-with-bpc)
[243.653552] Starting subtest: dsc-with-bpc
[243.682441] Subtest dsc-with-bpc: SKIP (0.001s)
[243.724185] [042/133] (776s left) kms_cursor_crc (cursor-offscreen-512x512)
[243.992516] Starting subtest: cursor-offscreen-512x512
[243.996067] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[244.122739] [043/133] (776s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[244.211834] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[244.215891] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[244.275786] [044/133] (775s left) vgem_basic (bad-fence)
[244.311719] Starting subtest: bad-fence
[244.313847] Subtest bad-fence: SUCCESS (0.000s)
[244.367172] [045/133] (775s left) gem_render_copy (yf-tiled-to-vebox-linear)
[244.415573] Starting subtest: yf-tiled-to-vebox-linear
[244.419929] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[244.603373] [046/133] (775s left) gem_eio (in-flight-internal-immediate)
[244.822577] Starting subtest: in-flight-internal-immediate
[246.104538] Subtest in-flight-internal-immediate: SUCCESS (1.280s)
[246.221631] [047/133] (774s left) kms_flip (blocking-absolute-wf_vblank)
[246.290828] Starting subtest: blocking-absolute-wf_vblank
[246.293053] Starting dynamic subtest: A-eDP1
[255.058351] Dynamic subtest A-eDP1: SUCCESS (8.763s)
[255.083745] Starting dynamic subtest: B-eDP1
[263.901219] Dynamic subtest B-eDP1: SUCCESS (8.839s)
[263.912798] Starting dynamic subtest: C-eDP1
[272.626844] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[272.637037] Starting dynamic subtest: D-eDP1
[281.362659] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[281.368402] Subtest blocking-absolute-wf_vblank: SUCCESS (35.066s)
[282.586097] [048/133] (737s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[282.653634] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[282.655804] Starting dynamic subtest: pipe-A-eDP-1
[282.677852] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.687958] Starting dynamic subtest: pipe-B-eDP-1
[282.709019] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.718074] Starting dynamic subtest: pipe-C-eDP-1
[282.739135] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.749927] Starting dynamic subtest: pipe-D-eDP-1
[282.771580] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.775564] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[284.946524] [049/133] (735s left) kms_properties (connector-properties-legacy)
[285.026808] Starting subtest: connector-properties-legacy
[285.029155] Starting dynamic subtest: pipe-A-eDP-1
[292.863422] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.840s)
[292.872842] Starting dynamic subtest: pipe-None-DP-1
[292.877005] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[292.885312] Starting dynamic subtest: pipe-None-DP-2
[292.889473] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[292.897921] Starting dynamic subtest: pipe-None-DP-3
[292.902380] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[292.910855] Starting dynamic subtest: pipe-None-DP-4
[292.915282] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[292.923838] Starting dynamic subtest: pipe-None-DP-5
[292.928416] Dynamic subtest pipe-None-DP-5: SUCCESS (0.001s)
[292.930742] Subtest connector-properties-legacy: SUCCESS (7.851s)
[293.730013] [050/133] (726s left) perf_pmu (busy-hang)
[293.780660] Starting subtest: busy-hang
[293.783150] Starting dynamic subtest: rcs0
[295.051813] Dynamic subtest rcs0: SUCCESS (1.271s)
[295.062608] Starting dynamic subtest: bcs0
[296.279156] Dynamic subtest bcs0: SUCCESS (1.226s)
[296.290005] Starting dynamic subtest: vcs0
[298.570598] Dynamic subtest vcs0: SUCCESS (2.294s)
[298.583024] Starting dynamic subtest: vcs1
[300.562820] Dynamic subtest vcs1: SUCCESS (1.989s)
[300.574170] Starting dynamic subtest: vecs0
[302.538726] Dynamic subtest vecs0: SUCCESS (1.977s)
[302.552018] Starting dynamic subtest: ccs0
[303.769047] Dynamic subtest ccs0: SUCCESS (1.229s)
[303.771980] Subtest busy-hang: SUCCESS (9.996s)
[303.887061] [051/133] (716s left) kms_vblank (ts-continuation-modeset-rpm)
[303.968065] Starting subtest: ts-continuation-modeset-rpm
[303.970247] Starting dynamic subtest: pipe-A-eDP-1
[306.476651] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.507s)
[306.491130] Starting dynamic subtest: pipe-D-eDP-1
[308.641340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.164s)
[308.643688] Subtest ts-continuation-modeset-rpm: SUCCESS (4.676s)
[309.434714] [052/133] (711s left) syncobj_wait (single-wait-for-submit-submitted)
[309.497071] Starting subtest: single-wait-for-submit-submitted
[309.599307] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[309.683897] [053/133] (710s left) kms_universal_plane (cursor-fb-leak)
[309.763870] Starting subtest: cursor-fb-leak
[309.766279] Starting dynamic subtest: pipe-A-eDP-1
[310.102494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.339s)
[310.115805] Starting dynamic subtest: pipe-B-eDP-1
[311.484791] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[311.499739] Starting dynamic subtest: pipe-C-eDP-1
[312.864616] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[312.876258] Starting dynamic subtest: pipe-D-eDP-1
[314.205611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[314.207831] Subtest cursor-fb-leak: SUCCESS (4.445s)
[315.355930] [054/133] (705s left) gem_exec_schedule (smoketest)
[315.539729] Starting subtest: smoketest
[315.542060] Starting dynamic subtest: rcs0
[321.097908] Dynamic subtest rcs0: SUCCESS (5.508s)
[321.115458] Starting dynamic subtest: bcs0
[326.650462] Dynamic subtest bcs0: SUCCESS (5.546s)
[326.669825] Starting dynamic subtest: vcs0
[332.159033] Dynamic subtest vcs0: SUCCESS (5.515s)
[332.172989] Starting dynamic subtest: vcs1
[337.660234] Dynamic subtest vcs1: SUCCESS (5.498s)
[337.671239] Starting dynamic subtest: vecs0
[343.172195] Dynamic subtest vecs0: SUCCESS (5.513s)
[343.186849] Starting dynamic subtest: ccs0
[348.693098] Dynamic subtest ccs0: SUCCESS (5.518s)
[348.695009] Subtest smoketest: SUCCESS (33.107s)
[348.842212] [055/133] (671s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[348.922035] Starting subtest: x-tiled-addfb-size-offset-overflow
[348.923955] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[349.018025] [056/133] (671s left) kms_atomic_transition (plane-all-transition-nonblocking)
[349.090890] Starting subtest: plane-all-transition-nonblocking
[349.093168] Starting dynamic subtest: pipe-A-eDP-1
[351.585296] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[351.902292] Starting dynamic subtest: pipe-B-eDP-1
[355.076172] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.189s)
[355.393196] Subtest plane-all-transition-nonblocking: SUCCESS (6.301s)
[356.210097] [057/133] (664s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[356.262853] Starting subtest: single-wait-for-submit-unsubmitted
[356.368088] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[356.459197] [058/133] (664s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[356.542318] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[356.546507] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[356.633426] [059/133] (664s left) kms_flip (absolute-wf_vblank)
[356.706494] Starting subtest: absolute-wf_vblank
[356.708915] Starting dynamic subtest: A-eDP1
[365.462291] Dynamic subtest A-eDP1: SUCCESS (8.756s)
[365.474232] Starting dynamic subtest: B-eDP1
[374.188209] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[374.197584] Starting dynamic subtest: C-eDP1
[382.907365] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[382.917016] Starting dynamic subtest: D-eDP1
[391.640149] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[391.642479] Subtest absolute-wf_vblank: SUCCESS (34.933s)
[392.859309] [060/133] (628s left) gem_ctx_persistence (heartbeat-hostile)
[392.938502] Starting subtest: heartbeat-hostile
[392.943247] Subtest heartbeat-hostile: SKIP (0.000s)
[393.035396] [061/133] (627s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[393.089861] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[393.191743] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.102s)
[393.267455] [062/133] (627s left) gem_exec_params (dr1-dirt)
[393.317113] Starting subtest: DR1-dirt
[393.319064] Subtest DR1-dirt: SUCCESS (0.000s)
[393.409190] [063/133] (627s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[393.489005] Starting subtest: addfb25-yf-tiled-legacy
[393.490829] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[393.577873] [064/133] (627s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[393.643568] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[393.645829] Starting dynamic subtest: pipe-A-eDP-1
[393.667389] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.678627] Starting dynamic subtest: pipe-B-eDP-1
[393.699260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.707573] Starting dynamic subtest: pipe-C-eDP-1
[393.727972] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.736305] Starting dynamic subtest: pipe-D-eDP-1
[393.756828] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.760899] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[395.838959] [065/133] (625s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[395.902611] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[395.904610] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[396.009872] [066/133] (625s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[396.079593] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[396.083855] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[396.154128] [067/133] (625s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[396.344606] Starting subtest: cursor-rapid-movement-128x128
[396.346909] Starting dynamic subtest: pipe-A-eDP-1
[396.889472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[396.917034] Starting dynamic subtest: pipe-D-eDP-1
[398.052659] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[398.054484] Subtest cursor-rapid-movement-128x128: SUCCESS (1.709s)
[398.911178] [068/133] (622s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[398.991933] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[398.996971] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[399.095949] [069/133] (622s left) i915_hangman (detector)
[399.153058] Starting subtest: detector
[399.155171] Starting dynamic subtest: rcs0
[410.987232] Dynamic subtest rcs0: SUCCESS (11.832s)
[410.999442] Starting dynamic subtest: bcs0
[421.993617] Dynamic subtest bcs0: SUCCESS (11.004s)
[422.005522] Starting dynamic subtest: vcs0
[433.002341] Dynamic subtest vcs0: SUCCESS (11.007s)
[433.016194] Starting dynamic subtest: vcs1
[444.969122] Dynamic subtest vcs1: SUCCESS (11.965s)
[444.981562] Starting dynamic subtest: vecs0
[457.000972] Dynamic subtest vecs0: SUCCESS (12.029s)
[457.014665] Starting dynamic subtest: ccs0
[469.033870] Dynamic subtest ccs0: SUCCESS (12.030s)
[469.037031] Subtest detector: SUCCESS (69.882s)
[469.127905] [070/133] (552s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[469.233232] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[476.244969] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.014s)
[476.354663] [071/133] (544s left) core_auth (getclient-simple)
[476.404096] Starting subtest: getclient-simple
[476.424955] Subtest getclient-simple: SUCCESS (0.021s)
[476.536941] [072/133] (544s left) kms_properties (colorop-properties-legacy)
[476.610944] Starting subtest: colorop-properties-legacy
[476.613222] Starting dynamic subtest: pipe-A-eDP-1
[476.949952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.339s)
[476.960302] Starting dynamic subtest: pipe-B-eDP-1
[477.988277] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.035s)
[478.003372] Starting dynamic subtest: pipe-C-eDP-1
[479.021070] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.033s)
[479.038351] Starting dynamic subtest: pipe-D-eDP-1
[480.059170] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.036s)
[480.061449] Subtest colorop-properties-legacy: SUCCESS (3.447s)
[480.850965] [073/133] (540s left) gem_ctx_param (invalid-get-engines)
[480.912402] Starting subtest: invalid-get-engines
[480.914795] Subtest invalid-get-engines: SUCCESS (0.001s)
[481.043740] [074/133] (540s left) kms_prop_blob (basic)
[481.095968] Starting subtest: basic
[481.097887] Subtest basic: SUCCESS (0.000s)
[481.184096] [075/133] (540s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[481.285265] Starting subtest: cursorB-vs-flipA-toggle
[481.289947] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[481.429322] [076/133] (540s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[481.509983] Starting subtest: plane-scaler-unity-scaling-with-rotation
[481.512270] Starting dynamic subtest: pipe-A
[481.736862] Dynamic subtest pipe-A: SUCCESS (0.228s)
[481.746881] Starting dynamic subtest: pipe-B
[483.030920] Dynamic subtest pipe-B: SUCCESS (1.293s)
[483.040899] Starting dynamic subtest: pipe-C
[484.362814] Dynamic subtest pipe-C: SUCCESS (1.331s)
[484.373400] Starting dynamic subtest: pipe-D
[485.705810] Dynamic subtest pipe-D: SUCCESS (1.342s)
[485.707982] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.198s)
[486.888873] [077/133] (534s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[486.976856] Starting subtest: extended-modeset-hang-oldfb-with-reset
[486.979154] Starting dynamic subtest: pipe-A
[498.864801] Dynamic subtest pipe-A: SUCCESS (11.885s)
[498.875021] Starting dynamic subtest: pipe-D
[511.148474] Dynamic subtest pipe-D: SUCCESS (12.280s)
[511.150665] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.169s)
[511.937294] [078/133] (509s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[512.026424] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[512.030784] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[512.136949] [079/133] (509s left) kms_plane_scaling (planes-upscale-20x20)
[512.218832] Starting subtest: planes-upscale-20x20
[512.221054] Starting dynamic subtest: pipe-A
[512.280324] Dynamic subtest pipe-A: SUCCESS (0.063s)
[512.289601] Starting dynamic subtest: pipe-B
[513.456875] Dynamic subtest pipe-B: SUCCESS (1.175s)
[513.467961] Starting dynamic subtest: pipe-C
[514.566836] Dynamic subtest pipe-C: SUCCESS (1.109s)
[514.575944] Starting dynamic subtest: pipe-D
[515.704196] Dynamic subtest pipe-D: SUCCESS (1.136s)
[515.706471] Subtest planes-upscale-20x20: SUCCESS (3.487s)
[516.864746] [080/133] (504s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[516.940621] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[516.942872] Starting dynamic subtest: pipe-A-eDP-1
[517.643577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[517.653798] Starting dynamic subtest: pipe-B-eDP-1
[519.381085] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.736s)
[519.391915] Starting dynamic subtest: pipe-C-eDP-1
[521.102895] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.721s)
[521.113388] Starting dynamic subtest: pipe-D-eDP-1
[522.852966] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.748s)
[522.855191] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.905s)
[524.010392] [081/133] (497s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[524.095341] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[524.099976] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[524.187000] [082/133] (497s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[524.557419] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[525.325240] [083/133] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[525.410649] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[525.414968] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[525.492569] [084/133] (496s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[525.569320] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[525.571550] Starting dynamic subtest: A-eDP1
[529.163228] Dynamic subtest A-eDP1: SUCCESS (3.591s)
[529.172959] Starting dynamic subtest: B-eDP1
[532.357819] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[532.367975] Starting dynamic subtest: C-eDP1
[535.451876] Dynamic subtest C-eDP1: SUCCESS (3.090s)
[535.461963] Starting dynamic subtest: D-eDP1
[538.661165] Dynamic subtest D-eDP1: SUCCESS (3.209s)
[538.663512] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.092s)
[539.471657] [085/133] (482s left) gem_mmap_gtt (basic-read)
[539.530587] Subtest basic-read: SKIP (0.000s)
[539.599243] [086/133] (482s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[539.650690] Starting subtest: single-wait-for-submit-available-signaled
[539.652971] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[539.740906] [087/133] (482s left) gem_vm_create (isolation)
[539.800624] Starting subtest: isolation
[539.810343] Subtest isolation: SUCCESS (0.009s)
[539.949870] [088/133] (482s left) gem_mmap_gtt (hang-busy)
[540.010796] Subtest hang-busy: SKIP (0.000s)
[540.064721] [089/133] (482s left) kms_lease (lease-uevent)
[540.142035] Starting subtest: lease-uevent
[541.154116] Subtest lease-uevent: SUCCESS (1.012s)
[541.241295] [090/133] (480s left) gem_mmap_gtt (basic-short)
[541.298467] Subtest basic-short: SKIP (0.000s)
[541.363206] [091/133] (480s left) gem_mmap_gtt (cpuset-big-copy-xy)
[541.430075] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[541.483328] [092/133] (480s left) kms_scaling_modes (scaling-mode-full)
[541.561179] Starting subtest: scaling-mode-full
[541.563415] Starting dynamic subtest: pipe-A-eDP-1
[541.669369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.110s)
[541.680507] Starting dynamic subtest: pipe-B-eDP-1
[542.879464] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[542.889433] Starting dynamic subtest: pipe-C-eDP-1
[543.992730] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[544.002343] Starting dynamic subtest: pipe-D-eDP-1
[545.119074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[545.121387] Subtest scaling-mode-full: SUCCESS (3.562s)
[546.285720] [093/133] (475s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[546.395000] Starting subtest: basic-flip-after-cursor-legacy
[547.317429] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.920s)
[548.115015] [094/133] (474s left) kms_flip (nonexisting-fb)
[548.190788] Starting subtest: nonexisting-fb
[548.192909] Starting dynamic subtest: A-eDP1
[549.310428] Dynamic subtest A-eDP1: SUCCESS (1.121s)
[549.320830] Starting dynamic subtest: B-eDP1
[550.445214] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[550.457382] Starting dynamic subtest: C-eDP1
[551.577868] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[551.587117] Starting dynamic subtest: D-eDP1
[552.709555] Dynamic subtest D-eDP1: SUCCESS (1.130s)
[552.711731] Subtest nonexisting-fb: SUCCESS (4.524s)
[553.873961] [095/133] (468s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[553.938072] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[554.038056] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[554.115083] [096/133] (468s left) kms_content_protection (atomic-dpms)
[554.237257] Starting subtest: atomic-dpms
[554.241614] Subtest atomic-dpms: SKIP (0.000s)
[554.350480] [097/133] (468s left) gem_exec_capture (capture)
[554.408050] Starting subtest: capture
[554.410514] Starting dynamic subtest: rcs0-smem
[555.284443] Dynamic subtest rcs0-smem: SUCCESS (0.876s)
[555.294127] Starting dynamic subtest: bcs0-smem
[556.346865] Dynamic subtest bcs0-smem: SUCCESS (1.059s)
[556.355982] Starting dynamic subtest: vcs0-smem
[557.193477] Dynamic subtest vcs0-smem: SUCCESS (0.846s)
[557.203034] Starting dynamic subtest: vcs1-smem
[558.016937] Dynamic subtest vcs1-smem: SUCCESS (0.825s)
[558.026385] Starting dynamic subtest: vecs0-smem
[558.917625] Dynamic subtest vecs0-smem: FAIL (0.841s)
[558.928234] Starting dynamic subtest: ccs0-smem
[560.186022] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[560.188036] Subtest capture: FAIL (5.776s)
[560.307851] [098/133] (462s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[560.416322] Starting subtest: cursorB-vs-flipB-atomic
[560.420941] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[560.578127] [099/133] (461s left) gem_pxp (protected-raw-src-copy-not-readible)
[560.696579] Starting subtest: protected-raw-src-copy-not-readible
[560.753685] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[560.884185] [100/133] (461s left) i915_pm_rc6_residency (rc6-fence)
[560.941897] Starting subtest: rc6-fence
[560.956513] Starting dynamic subtest: gt0
[573.278421] Dynamic subtest gt0: SUCCESS (12.320s)
[573.291173] Starting dynamic subtest: gt1
[588.043666] Dynamic subtest gt1: SUCCESS (14.759s)
[588.046599] Subtest rc6-fence: SUCCESS (27.100s)
[588.121227] [101/133] (434s left) kms_async_flips (crc-atomic)
[588.208900] Starting subtest: crc-atomic
[588.584329] Starting dynamic subtest: pipe-A-eDP-1
[591.510571] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.925s)
[591.889062] Starting dynamic subtest: pipe-B-eDP-1
[594.822574] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.945s)
[595.208033] Starting dynamic subtest: pipe-C-eDP-1
[598.054689] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.855s)
[598.425555] Starting dynamic subtest: pipe-D-eDP-1
[601.288326] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s)
[601.290524] Subtest crc-atomic: SUCCESS (13.078s)
[602.455047] [102/133] (420s left) kms_psr (fbc-pr-cursor-render)
[602.530212] Starting subtest: fbc-pr-cursor-render
[602.534566] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[602.604649] [103/133] (420s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[602.707348] Starting subtest: basic-busy-flip-before-cursor-varying-size
[602.711957] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[602.849510] [104/133] (419s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[602.935839] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[609.682099] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.751s)
[609.837655] [105/133] (412s left) gem_exec_whisper (basic-contexts-priority)
[609.908741] Starting subtest: basic-contexts-priority
[633.451799] Subtest basic-contexts-priority: SUCCESS (23.536s)
[633.643391] [106/133] (389s left) kms_color (ctm-max)
[633.729292] Starting subtest: ctm-max
[633.731446] Starting dynamic subtest: pipe-A-eDP-1
[634.448948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[634.459330] Starting dynamic subtest: pipe-B-eDP-1
[635.867382] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s)
[635.877151] Starting dynamic subtest: pipe-C-eDP-1
[637.244655] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[637.255021] Starting dynamic subtest: pipe-D-eDP-1
[638.571389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[638.573517] Subtest ctm-max: SUCCESS (4.841s)
[639.369853] [107/133] (383s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[639.457431] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[646.351167] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.895s)
[646.502515] [108/133] (376s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[646.567293] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[646.569200] Starting dynamic subtest: pipe-A-eDP-1
[662.820134] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.519s)
[662.830313] Starting dynamic subtest: pipe-B-eDP-1
[680.793053] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.477s)
[680.805828] Starting dynamic subtest: pipe-C-eDP-1
[697.748642] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.458s)
[697.761620] Starting dynamic subtest: pipe-D-eDP-1
[714.711391] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.330s)
[714.713272] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.789s)
[715.882585] [109/133] (307s left) kms_psr (fbc-pr-sprite-plane-move)
[715.975485] Starting subtest: fbc-pr-sprite-plane-move
[715.979482] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[716.048096] [110/133] (306s left) kms_pm_rpm (basic-rte)
[716.087600] Starting subtest: basic-rte
[719.007199] Subtest basic-rte: SUCCESS (2.918s)
[720.464000] [111/133] (302s left) gem_ctx_shared (q-out-order)
[720.532903] Starting subtest: Q-out-order
[720.535303] Starting dynamic subtest: rcs0
[720.660707] Dynamic subtest rcs0: SUCCESS (0.126s)
[720.672288] Starting dynamic subtest: vcs0
[720.762056] Dynamic subtest vcs0: SUCCESS (0.099s)
[720.772631] Starting dynamic subtest: vcs1
[720.883849] Dynamic subtest vcs1: SUCCESS (0.123s)
[720.901057] Starting dynamic subtest: vecs0
[720.967734] Dynamic subtest vecs0: SUCCESS (0.081s)
[720.986431] Starting dynamic subtest: ccs0
[721.048451] Dynamic subtest ccs0: SUCCESS (0.079s)
[721.051765] Subtest Q-out-order: SUCCESS (0.514s)
[722.492354] [112/133] (300s left) kms_big_fb (linear-8bpp-rotate-0)
[722.579167] Starting subtest: linear-8bpp-rotate-0
[723.816777] Subtest linear-8bpp-rotate-0: SUCCESS (1.237s)
[723.939380] [113/133] (299s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[724.021323] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[724.024687] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[724.120669] [114/133] (298s left) gem_softpin (evict-prime-sanity-check)
[724.185927] Starting subtest: evict-prime-sanity-check
[724.188032] Starting dynamic subtest: rcs0
[725.327572] Dynamic subtest rcs0: SUCCESS (1.140s)
[725.340121] Starting dynamic subtest: bcs0
[726.442298] Dynamic subtest bcs0: SUCCESS (1.113s)
[726.455475] Starting dynamic subtest: vcs0
[728.320333] Dynamic subtest vcs0: SUCCESS (1.872s)
[728.332862] Starting dynamic subtest: vcs1
[730.304507] Dynamic subtest vcs1: SUCCESS (1.980s)
[730.317053] Starting dynamic subtest: vecs0
[732.375943] Dynamic subtest vecs0: SUCCESS (2.068s)
[732.388090] Starting dynamic subtest: ccs0
[733.495309] Dynamic subtest ccs0: SUCCESS (1.118s)
[733.505776] Starting dynamic subtest: all
[734.611352] Dynamic subtest all: SUCCESS (1.113s)
[734.613894] Subtest evict-prime-sanity-check: SUCCESS (10.419s)
[734.694942] [115/133] (288s left) dmabuf_sync_file (export-multiwait)
[734.735719] Starting subtest: export-multiwait
[734.737931] Subtest export-multiwait: SUCCESS (0.000s)
[734.791609] [116/133] (288s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[734.881183] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[742.172735] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.289s)
[742.313626] [117/133] (280s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[742.387313] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[742.391524] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[742.482341] [118/133] (280s left) gem_create (create-ext-set-pat)
[742.640781] Starting subtest: create-ext-set-pat
[742.643409] Subtest create-ext-set-pat: SUCCESS (0.001s)
[742.738096] [119/133] (280s left) prime_vgem (busy)
[742.802501] Starting subtest: busy
[742.804981] Starting dynamic subtest: rcs0
[742.875290] Dynamic subtest rcs0: SUCCESS (0.072s)
[742.890235] Starting dynamic subtest: bcs0
[742.923803] Dynamic subtest bcs0: SUCCESS (0.048s)
[742.933454] Starting dynamic subtest: vcs0
[742.969895] Dynamic subtest vcs0: SUCCESS (0.045s)
[742.980392] Starting dynamic subtest: vcs1
[743.015766] Dynamic subtest vcs1: SUCCESS (0.045s)
[743.025476] Starting dynamic subtest: vecs0
[743.061527] Dynamic subtest vecs0: SUCCESS (0.045s)
[743.071332] Starting dynamic subtest: ccs0
[743.109355] Dynamic subtest ccs0: SUCCESS (0.047s)
[743.111694] Subtest busy: SUCCESS (0.308s)
[743.213818] [120/133] (280s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[743.295682] Starting subtest: x-tiled-64bpp-rotate-90
[743.317105] Subtest x-tiled-64bpp-rotate-90: SKIP (0.021s)
[743.430737] [121/133] (279s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[743.517032] Starting subtest: 4-tiled-32bpp-rotate-180
[744.841799] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.324s)
[744.996645] [122/133] (278s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[745.049381] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[745.116955] [123/133] (278s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[745.199924] Starting subtest: yf-tiled-32bpp-rotate-90
[745.203680] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[745.299876] [124/133] (278s left) gem_mmap_wc (write-prefaulted)
[745.353475] Subtest write-prefaulted: SKIP (0.000s)
[745.423000] [125/133] (278s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[745.525897] Starting subtest: cursorA-vs-flipA-legacy
[756.703469] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.179s)
[757.535540] [126/133] (266s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[757.632270] Starting subtest: 2x-long-flip-vs-cursor-legacy
[757.636941] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[757.778415] [127/133] (265s left) gem_mmap_gtt (big-bo)
[757.826678] Subtest big-bo: SKIP (0.000s)
[757.885826] [128/133] (265s left) gem_exercise_blt (fast-copy-emit)
[757.942527] Starting subtest: fast-copy-emit
[757.944787] Starting dynamic subtest: linear-smem-smem-emit
[757.967321] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[757.979329] Starting dynamic subtest: xmajor-smem-smem-emit
[757.985964] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[757.995801] Starting dynamic subtest: tile4-smem-smem-emit
[758.003776] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[758.015373] Starting dynamic subtest: tile64-smem-smem-emit
[758.021190] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[758.023465] Subtest fast-copy-emit: SUCCESS (0.079s)
[758.140355] [129/133] (265s left) perf (gen8-unprivileged-single-ctx-counters)
[758.268945] Starting subtest: gen8-unprivileged-single-ctx-counters
[758.273106] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[758.313694] [130/133] (265s left) gem_exec_reloc (basic-cpu-read)
[758.366611] Subtest basic-cpu-read: SKIP (0.000s)
[758.443561] [131/133] (265s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[758.522025] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[758.525621] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[758.611581] [132/133] (265s left) i915_pm_rps (thresholds-idle-park)
[758.669113] Starting subtest: thresholds-idle-park
[758.673260] Subtest thresholds-idle-park: SKIP (0.001s)
[758.767764] [133/133] (265s left) gem_exec_params (rsvd2-dirt)
[758.831195] Starting subtest: rsvd2-dirt
[758.834815] Subtest rsvd2-dirt: SKIP (0.000s)
[758.923927] 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.