[58.382726] Initializing watchdogs
[58.382772]   /dev/watchdog0
[58.397963] [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]
[58.402738] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.405119] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.407078] [001/133] (960s left) gem_mmap_gtt (basic-read-write)
[58.467326] Subtest basic-read-write: SKIP (0.000s)
[58.515881] [002/133] (960s left) kms_plane (pixel-format-linear-modifier)
[58.603176] Starting subtest: pixel-format-linear-modifier
[58.642263] Starting dynamic subtest: pipe-A-plane-0
[62.120045] Dynamic subtest pipe-A-plane-0: SUCCESS (3.478s)
[62.126102] Starting dynamic subtest: pipe-A-plane-3
[63.853758] Dynamic subtest pipe-A-plane-3: SUCCESS (1.733s)
[63.861452] Starting dynamic subtest: pipe-A-plane-5
[64.064446] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[65.144644] Starting dynamic subtest: pipe-B-plane-0
[68.993962] Dynamic subtest pipe-B-plane-0: SUCCESS (3.856s)
[69.001885] Starting dynamic subtest: pipe-B-plane-3
[70.682916] Dynamic subtest pipe-B-plane-3: SUCCESS (1.688s)
[70.690033] Starting dynamic subtest: pipe-B-plane-5
[70.893779] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[71.209326] Subtest pixel-format-linear-modifier: SUCCESS (12.605s)
[72.005564] [003/133] (946s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[72.113833] Starting subtest: y-tiled-8bpp-rotate-270
[72.115952] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[72.207508] [004/133] (946s left) syncobj_wait (single-wait-for-submit-signaled)
[72.264039] Starting subtest: single-wait-for-submit-signaled
[72.265133] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[72.366756] [005/133] (946s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[72.478081] Starting subtest: flip-vs-cursor-atomic
[79.703664] Subtest flip-vs-cursor-atomic: SUCCESS (7.225s)
[80.540897] [006/133] (938s left) kms_chamelium_frames (hdmi-crc-fast)
[80.944867] Subtest hdmi-crc-fast: SKIP (0.000s)
[81.754562] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[81.839084] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[81.840832] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[81.928659] [008/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[82.014996] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[82.016575] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[82.100300] [009/133] (937s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[82.201385] Starting subtest: fbc-rgb101010-draw-blt
[86.807220] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.606s)
[87.977252] [010/133] (931s left) kms_dp_linktrain_fallback (dsc-fallback)
[88.074153] Starting subtest: dsc-fallback
[88.076892] Subtest dsc-fallback: SKIP (0.000s)
[88.138801] [011/133] (931s left) gem_exec_balancer (fairslice)
[88.188688] Starting subtest: fairslice
[91.161617] Subtest fairslice: SUCCESS (2.963s)
[91.452211] [012/133] (927s left) gem_eio (in-flight-immediate)
[91.685780] Starting subtest: in-flight-immediate
[99.712132] Subtest in-flight-immediate: SUCCESS (8.026s)
[99.854078] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[99.855672] [013/133] (919s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[99.898955] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[99.899881] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[99.986312] [014/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[100.083614] Starting subtest: fbcpsr-2p-rte
[100.085387] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[100.192632] [015/133] (919s left) kms_psr (psr2-cursor-mmap-cpu)
[100.280088] Starting subtest: psr2-cursor-mmap-cpu
[100.281146] Starting dynamic subtest: eDP-1
[101.960336] Dynamic subtest eDP-1: SUCCESS (1.681s)
[101.961164] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.681s)
[102.839075] [016/133] (916s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[102.942832] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[109.612314] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.669s)
[109.729025] [017/133] (909s left) sw_sync (sync_multi_consumer_producer)
[109.762512] Starting subtest: sync_multi_consumer_producer
[110.030310] Subtest sync_multi_consumer_producer: SUCCESS (0.259s)
[110.077983] [018/133] (909s left) kms_setmode (basic)
[110.135942] Starting subtest: basic
[110.461626] Starting dynamic subtest: pipe-A-eDP-1
[112.520462] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.047s)
[112.859413] Starting dynamic subtest: pipe-B-eDP-1
[114.953286] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s)
[115.250916] Subtest basic: SUCCESS (5.114s)
[116.087350] [019/133] (903s left) kms_psr (fbc-psr-primary-render)
[116.167159] Starting subtest: fbc-psr-primary-render
[116.167977] Starting dynamic subtest: eDP-1
[116.169965] Dynamic subtest eDP-1: SKIP (0.000s)
[116.171633] Subtest fbc-psr-primary-render: SKIP (0.001s)
[116.241356] [020/133] (903s left) kms_psr (psr-cursor-plane-move)
[116.322161] Starting subtest: psr-cursor-plane-move
[116.322952] Starting dynamic subtest: eDP-1
[118.098361] Dynamic subtest eDP-1: SUCCESS (1.776s)
[118.099185] Subtest psr-cursor-plane-move: SUCCESS (1.777s)
[118.962841] [021/133] (900s left) kms_pipe_crc_basic (suspend-read-crc)
[119.062524] Starting subtest: suspend-read-crc
[119.063479] Starting dynamic subtest: pipe-A-eDP-1
[136.914716] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.068s)
[136.922255] Starting dynamic subtest: pipe-B-eDP-1
[155.888946] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.553s)
[155.896370] Starting dynamic subtest: pipe-C-eDP-1
[174.852245] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.390s)
[174.861152] Starting dynamic subtest: pipe-D-eDP-1
[193.865201] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.402s)
[193.866066] Subtest suspend-read-crc: SUCCESS (13.417s)
[200.730524] [022/133] (824s left) kms_flip (flip-vs-dpms-on-nop)
[200.824016] Starting subtest: flip-vs-dpms-on-nop
[200.826198] Starting dynamic subtest: A-eDP1
[202.688339] Dynamic subtest A-eDP1: SUCCESS (1.863s)
[202.703462] Starting dynamic subtest: B-eDP1
[204.526641] Dynamic subtest B-eDP1: SUCCESS (1.836s)
[204.537080] Starting dynamic subtest: C-eDP1
[206.343342] Dynamic subtest C-eDP1: SUCCESS (1.813s)
[206.351900] Starting dynamic subtest: D-eDP1
[208.169350] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[208.171968] Subtest flip-vs-dpms-on-nop: SUCCESS (7.347s)
[209.351445] [023/133] (816s left) gem_bad_reloc (negative-reloc-bltcopy)
[209.400021] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[209.459767] [024/133] (816s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[209.503816] Starting subtest: invalid-single-wait-all-unsubmitted
[209.504860] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[209.593376] [025/133] (816s left) gem_ccs (block-multicopy-compressed)
[209.644497] Starting subtest: block-multicopy-compressed
[209.646155] Subtest block-multicopy-compressed: SKIP (0.000s)
[209.737779] [026/133] (815s left) gen9_exec_parse (unaligned-jump)
[209.785823] Subtest unaligned-jump: SKIP (0.000s)
[209.845122] [027/133] (815s left) perf_pmu (multi-client)
[209.879073] Starting subtest: multi-client
[209.879880] Starting dynamic subtest: rcs0
[210.941133] Dynamic subtest rcs0: SUCCESS (1.053s)
[210.951300] Starting dynamic subtest: bcs0
[211.991646] Dynamic subtest bcs0: SUCCESS (1.048s)
[212.001713] Starting dynamic subtest: vcs0
[213.045821] Dynamic subtest vcs0: SUCCESS (1.052s)
[213.054329] Starting dynamic subtest: vcs1
[214.308415] Dynamic subtest vcs1: SUCCESS (1.260s)
[214.318427] Starting dynamic subtest: vecs0
[216.354886] Dynamic subtest vecs0: SUCCESS (2.044s)
[216.364572] Starting dynamic subtest: ccs0
[218.343994] Dynamic subtest ccs0: SUCCESS (1.987s)
[218.345459] Subtest multi-client: SUCCESS (8.458s)
[218.450070] [028/133] (807s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[218.541969] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[222.829068] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.287s)
[223.961970] [029/133] (801s left) gem_exec_schedule (fairslice-all)
[224.036541] Starting subtest: fairslice-all
[226.092337] Subtest fairslice-all: SUCCESS (2.056s)
[227.308871] [030/133] (798s left) kms_joiner (basic-max-non-joiner)
[227.404664] Starting subtest: basic-max-non-joiner
[227.406321] Subtest basic-max-non-joiner: SKIP (0.000s)
[227.469638] [031/133] (798s left) prime_vgem (coherency-gtt)
[227.538594] Starting subtest: coherency-gtt
[227.540373] Subtest coherency-gtt: SKIP (0.000s)
[227.615038] [032/133] (798s left) gem_exec_create (madvise)
[227.676565] Starting subtest: madvise
[227.677569] Starting dynamic subtest: smem
[249.387467] Dynamic subtest smem: SUCCESS (21.699s)
[249.389062] Subtest madvise: SUCCESS (21.700s)
[250.293449] [033/133] (775s left) gem_exec_fence (syncobj-repeat)
[250.751897] Starting subtest: syncobj-repeat
[250.959965] Subtest syncobj-repeat: SUCCESS (0.198s)
[252.397261] [034/133] (773s left) api_intel_bb (blit-noreloc-keep-cache)
[252.449178] Starting subtest: blit-noreloc-keep-cache
[252.462660] Subtest blit-noreloc-keep-cache: SUCCESS (0.015s)
[252.573302] [035/133] (773s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[252.627215] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[252.691081] [036/133] (773s left) gem_workarounds (basic-read)
[252.754615] Starting subtest: basic-read
[252.768976] Subtest basic-read: SUCCESS (0.014s)
[252.898042] [037/133] (773s left) prime_mmap (test_correct_cpu_write)
[252.953596] Starting subtest: test_correct_cpu_write
[252.954629] Starting dynamic subtest: test_correct_cpu_write-smem
[252.955580] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[252.956531] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[253.052741] [038/133] (773s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[253.146548] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[253.147414] Starting dynamic subtest: pipe-A-eDP-1
[253.155747] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[253.163442] Starting dynamic subtest: pipe-B-eDP-1
[253.172430] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[253.181345] Starting dynamic subtest: pipe-C-eDP-1
[253.188873] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[253.196339] Starting dynamic subtest: pipe-D-eDP-1
[253.204267] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[253.205798] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[255.411678] [039/133] (770s left) gen9_exec_parse (bb-oversize)
[255.468374] Subtest bb-oversize: SKIP (0.000s)
[255.538557] [040/133] (770s left) gem_exec_schedule (pi-userfault)
[255.721940] Starting subtest: pi-userfault
[255.723182] Starting dynamic subtest: rcs0
[255.730544] Dynamic subtest rcs0: SUCCESS (0.010s)
[255.740073] Starting dynamic subtest: bcs0
[255.743717] Dynamic subtest bcs0: SUCCESS (0.012s)
[255.757532] Starting dynamic subtest: vcs0
[255.758531] Dynamic subtest vcs0: SUCCESS (0.010s)
[255.767019] Starting dynamic subtest: vcs1
[255.767889] Dynamic subtest vcs1: SUCCESS (0.008s)
[255.776501] Starting dynamic subtest: vecs0
[255.777401] Dynamic subtest vecs0: SUCCESS (0.008s)
[255.785129] Starting dynamic subtest: ccs0
[255.786132] Dynamic subtest ccs0: SUCCESS (0.010s)
[255.787025] Subtest pi-userfault: SUCCESS (0.062s)
[255.962053] [041/133] (770s left) kms_dsc (dsc-with-bpc)
[256.049244] Starting subtest: dsc-with-bpc
[256.060085] Subtest dsc-with-bpc: SKIP (0.001s)
[256.116282] [042/133] (770s left) kms_cursor_crc (cursor-offscreen-512x512)
[256.382958] Starting subtest: cursor-offscreen-512x512
[256.384625] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[256.536326] [043/133] (769s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[256.617451] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[256.619176] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[256.685692] [044/133] (769s left) vgem_basic (bad-fence)
[256.720216] Starting subtest: bad-fence
[256.721108] Subtest bad-fence: SUCCESS (0.000s)
[256.786481] [045/133] (769s left) gem_render_copy (yf-tiled-to-vebox-linear)
[256.843980] Starting subtest: yf-tiled-to-vebox-linear
[256.845727] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[257.021257] [046/133] (769s left) gem_eio (in-flight-internal-immediate)
[257.244991] Starting subtest: in-flight-internal-immediate
[258.352689] Subtest in-flight-internal-immediate: SUCCESS (1.108s)
[258.489573] [047/133] (767s left) kms_flip (blocking-absolute-wf_vblank)
[258.577717] Starting subtest: blocking-absolute-wf_vblank
[258.578692] Starting dynamic subtest: A-eDP1
[267.311939] Dynamic subtest A-eDP1: SUCCESS (8.705s)
[267.322426] Starting dynamic subtest: B-eDP1
[276.045559] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[276.055835] Starting dynamic subtest: C-eDP1
[284.769879] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[284.780232] Starting dynamic subtest: D-eDP1
[293.463473] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[293.466871] Subtest blocking-absolute-wf_vblank: SUCCESS (34.889s)
[294.665189] [048/133] (731s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[294.776266] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[294.777152] Starting dynamic subtest: pipe-A-eDP-1
[294.785682] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[294.793952] Starting dynamic subtest: pipe-B-eDP-1
[294.802631] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[294.810424] Starting dynamic subtest: pipe-C-eDP-1
[294.818631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[294.825719] Starting dynamic subtest: pipe-D-eDP-1
[294.834112] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[294.835728] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[296.964907] [049/133] (729s left) kms_properties (connector-properties-legacy)
[297.054316] Starting subtest: connector-properties-legacy
[297.055098] Starting dynamic subtest: pipe-A-eDP-1
[305.042218] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.987s)
[305.049971] Starting dynamic subtest: pipe-None-DP-1
[305.051698] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[305.059196] Starting dynamic subtest: pipe-None-HDMI-A-1
[305.060862] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[305.068090] Starting dynamic subtest: pipe-None-DP-2
[305.069807] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[305.077388] Starting dynamic subtest: pipe-None-HDMI-A-2
[305.079048] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[305.086508] Starting dynamic subtest: pipe-None-DP-3
[305.088210] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[305.095579] Starting dynamic subtest: pipe-None-DP-4
[305.097467] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[305.098340] Subtest connector-properties-legacy: SUCCESS (7.998s)
[305.902663] [050/133] (720s left) perf_pmu (busy-hang)
[305.946090] Starting subtest: busy-hang
[305.956735] Starting dynamic subtest: rcs0
[307.242394] Dynamic subtest rcs0: SUCCESS (1.294s)
[307.251988] Starting dynamic subtest: bcs0
[308.473983] Dynamic subtest bcs0: SUCCESS (1.231s)
[308.485443] Starting dynamic subtest: vcs0
[310.821616] Dynamic subtest vcs0: SUCCESS (2.343s)
[310.831629] Starting dynamic subtest: vcs1
[312.805179] Dynamic subtest vcs1: SUCCESS (1.981s)
[312.815413] Starting dynamic subtest: vecs0
[314.790408] Dynamic subtest vecs0: SUCCESS (1.983s)
[314.800097] Starting dynamic subtest: ccs0
[316.025962] Dynamic subtest ccs0: SUCCESS (1.234s)
[316.027554] Subtest busy-hang: SUCCESS (10.077s)
[316.142975] [051/133] (710s left) kms_vblank (ts-continuation-modeset-rpm)
[316.235110] Starting subtest: ts-continuation-modeset-rpm
[316.236182] Starting dynamic subtest: pipe-A-eDP-1
[318.792705] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.557s)
[318.802188] Starting dynamic subtest: pipe-D-eDP-1
[321.052720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s)
[321.053622] Subtest ts-continuation-modeset-rpm: SUCCESS (4.817s)
[321.942005] [052/133] (704s left) syncobj_wait (single-wait-for-submit-submitted)
[322.005490] Starting subtest: single-wait-for-submit-submitted
[322.110522] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[322.178577] [053/133] (704s left) kms_universal_plane (cursor-fb-leak)
[322.267467] Starting subtest: cursor-fb-leak
[322.268296] Starting dynamic subtest: pipe-A-eDP-1
[322.616867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.348s)
[322.629111] Starting dynamic subtest: pipe-B-eDP-1
[323.956403] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[323.967385] Starting dynamic subtest: pipe-C-eDP-1
[325.263205] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s)
[325.273700] Starting dynamic subtest: pipe-D-eDP-1
[326.594979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[326.596011] Subtest cursor-fb-leak: SUCCESS (4.328s)
[327.764755] [054/133] (698s left) gem_exec_schedule (smoketest)
[327.941494] Starting subtest: smoketest
[327.942744] Starting dynamic subtest: rcs0
[333.493181] Dynamic subtest rcs0: SUCCESS (5.483s)
[333.507528] Starting dynamic subtest: bcs0
[339.001621] Dynamic subtest bcs0: SUCCESS (5.508s)
[339.015975] Starting dynamic subtest: vcs0
[344.495557] Dynamic subtest vcs0: SUCCESS (5.492s)
[344.506270] Starting dynamic subtest: vcs1
[350.004098] Dynamic subtest vcs1: SUCCESS (5.509s)
[350.013223] Starting dynamic subtest: vecs0
[355.504149] Dynamic subtest vecs0: SUCCESS (5.493s)
[355.518626] Starting dynamic subtest: ccs0
[361.022982] Dynamic subtest ccs0: SUCCESS (5.522s)
[361.024125] Subtest smoketest: SUCCESS (33.016s)
[361.156077] [055/133] (665s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[361.256295] Starting subtest: x-tiled-addfb-size-offset-overflow
[361.257122] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[361.343737] [056/133] (665s left) kms_atomic_transition (plane-all-transition-nonblocking)
[361.430325] Starting subtest: plane-all-transition-nonblocking
[361.431237] Starting dynamic subtest: pipe-A-eDP-1
[363.928353] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[364.243898] Starting dynamic subtest: pipe-B-eDP-1
[367.494191] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s)
[367.807945] Subtest plane-all-transition-nonblocking: SUCCESS (6.377s)
[368.607966] [057/133] (658s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[368.670520] Starting subtest: single-wait-for-submit-unsubmitted
[368.776131] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[368.847566] [058/133] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[368.940320] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[368.942135] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[369.030632] [059/133] (657s left) kms_flip (absolute-wf_vblank)
[369.118693] Starting subtest: absolute-wf_vblank
[369.119588] Starting dynamic subtest: A-eDP1
[377.901925] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[377.910815] Starting dynamic subtest: B-eDP1
[386.632120] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[386.640351] Starting dynamic subtest: C-eDP1
[395.370880] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[395.380403] Starting dynamic subtest: D-eDP1
[404.103893] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[404.105473] Subtest absolute-wf_vblank: SUCCESS (34.953s)
[405.274327] [060/133] (621s left) gem_ctx_persistence (heartbeat-hostile)
[405.325417] Starting subtest: heartbeat-hostile
[405.327067] Subtest heartbeat-hostile: SKIP (0.000s)
[405.421798] [061/133] (621s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[405.475002] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[405.583976] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s)
[405.654522] [062/133] (621s left) gem_exec_params (dr1-dirt)
[405.705548] Starting subtest: DR1-dirt
[405.706661] Subtest DR1-dirt: SUCCESS (0.000s)
[405.794329] [063/133] (621s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[405.881319] Starting subtest: addfb25-yf-tiled-legacy
[405.882182] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[405.982426] [064/133] (621s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[406.076446] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[406.077289] Starting dynamic subtest: pipe-A-eDP-1
[406.085905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[406.094049] Starting dynamic subtest: pipe-B-eDP-1
[406.102307] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[406.110256] Starting dynamic subtest: pipe-C-eDP-1
[406.125860] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[406.133354] Starting dynamic subtest: pipe-D-eDP-1
[406.142443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[406.143977] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[408.346657] [065/133] (618s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[408.405166] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[408.406017] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[408.517035] [066/133] (618s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[408.604623] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[408.606519] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[408.671440] [067/133] (618s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[408.876999] Starting subtest: cursor-rapid-movement-128x128
[408.880357] Starting dynamic subtest: pipe-A-eDP-1
[409.429620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[409.458705] Starting dynamic subtest: pipe-D-eDP-1
[410.668793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[410.669759] Subtest cursor-rapid-movement-128x128: SUCCESS (1.791s)
[411.523480] [068/133] (615s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[411.623773] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[411.625525] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[411.722953] [069/133] (615s left) i915_hangman (detector)
[411.784328] Starting subtest: detector
[411.785216] Starting dynamic subtest: rcs0
[423.243663] Dynamic subtest rcs0: SUCCESS (11.449s)
[423.256912] Starting dynamic subtest: bcs0
[435.274794] Dynamic subtest bcs0: SUCCESS (12.028s)
[435.283388] Starting dynamic subtest: vcs0
[447.243625] Dynamic subtest vcs0: SUCCESS (11.965s)
[447.251834] Starting dynamic subtest: vcs1
[459.275551] Dynamic subtest vcs1: SUCCESS (12.028s)
[459.286701] Starting dynamic subtest: vecs0
[470.283412] Dynamic subtest vecs0: SUCCESS (11.005s)
[470.293844] Starting dynamic subtest: ccs0
[482.252037] Dynamic subtest ccs0: SUCCESS (11.964s)
[482.253517] Subtest detector: SUCCESS (70.455s)
[482.319602] [070/133] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[482.423107] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[489.526124] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.103s)
[489.623966] [071/133] (537s left) core_auth (getclient-simple)
[489.655542] Starting subtest: getclient-simple
[489.677311] Subtest getclient-simple: SUCCESS (0.020s)
[489.775548] [072/133] (537s left) kms_properties (colorop-properties-legacy)
[489.865708] Starting subtest: colorop-properties-legacy
[489.866634] Starting dynamic subtest: pipe-A-eDP-1
[490.235672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.370s)
[490.245016] Starting dynamic subtest: pipe-B-eDP-1
[491.332286] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.094s)
[491.340340] Starting dynamic subtest: pipe-C-eDP-1
[492.370342] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[492.383189] Starting dynamic subtest: pipe-D-eDP-1
[493.394068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.022s)
[493.394958] Subtest colorop-properties-legacy: SUCCESS (3.529s)
[494.192323] [073/133] (533s left) gem_ctx_param (invalid-get-engines)
[494.248864] Starting subtest: invalid-get-engines
[494.249906] Subtest invalid-get-engines: SUCCESS (0.001s)
[494.362985] [074/133] (533s left) kms_prop_blob (basic)
[494.418772] Starting subtest: basic
[494.420198] Subtest basic: SUCCESS (0.000s)
[494.555017] [075/133] (532s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[494.665011] Starting subtest: cursorB-vs-flipA-toggle
[494.667940] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[494.805777] [076/133] (532s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[494.892222] Starting subtest: plane-scaler-unity-scaling-with-rotation
[494.893090] Starting dynamic subtest: pipe-A
[495.120127] Dynamic subtest pipe-A: SUCCESS (0.228s)
[495.129390] Starting dynamic subtest: pipe-B
[496.377049] Dynamic subtest pipe-B: SUCCESS (1.256s)
[496.386560] Starting dynamic subtest: pipe-C
[497.742712] Dynamic subtest pipe-C: SUCCESS (1.364s)
[497.751360] Starting dynamic subtest: pipe-D
[499.041826] Dynamic subtest pipe-D: SUCCESS (1.298s)
[499.045020] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.151s)
[500.238317] [077/133] (527s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[500.332492] Starting subtest: extended-modeset-hang-oldfb-with-reset
[500.333464] Starting dynamic subtest: pipe-A
[511.907949] Dynamic subtest pipe-A: SUCCESS (11.573s)
[511.924367] Starting dynamic subtest: pipe-D
[524.186238] Dynamic subtest pipe-D: SUCCESS (12.275s)
[524.187067] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.855s)
[525.070720] [078/133] (502s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[525.167439] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[525.169263] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[525.272085] [079/133] (502s left) kms_plane_scaling (planes-upscale-20x20)
[525.366584] Starting subtest: planes-upscale-20x20
[525.367422] Starting dynamic subtest: pipe-A
[525.428758] Dynamic subtest pipe-A: SUCCESS (0.063s)
[525.439407] Starting dynamic subtest: pipe-B
[526.814361] Dynamic subtest pipe-B: SUCCESS (1.385s)
[526.824673] Starting dynamic subtest: pipe-C
[527.924276] Dynamic subtest pipe-C: SUCCESS (1.108s)
[527.932193] Starting dynamic subtest: pipe-D
[529.080599] Dynamic subtest pipe-D: SUCCESS (1.155s)
[529.081513] Subtest planes-upscale-20x20: SUCCESS (3.716s)
[530.226538] [080/133] (497s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[530.323397] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[530.324298] Starting dynamic subtest: pipe-A-eDP-1
[531.069466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[531.077129] Starting dynamic subtest: pipe-B-eDP-1
[532.856026] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.784s)
[532.864942] Starting dynamic subtest: pipe-C-eDP-1
[534.692678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.834s)
[534.700652] Starting dynamic subtest: pipe-D-eDP-1
[536.544225] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.850s)
[536.545202] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.218s)
[537.743602] [081/133] (489s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[537.831579] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[537.833593] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[537.934204] [082/133] (489s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[538.306116] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[539.153898] [083/133] (488s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[539.246728] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[539.248609] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[539.338920] [084/133] (488s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[539.431647] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[539.433991] Starting dynamic subtest: A-eDP1
[543.011485] Dynamic subtest A-eDP1: SUCCESS (3.575s)
[543.025572] Starting dynamic subtest: B-eDP1
[546.206592] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[546.214842] Starting dynamic subtest: C-eDP1
[549.321796] Dynamic subtest C-eDP1: SUCCESS (3.113s)
[549.329943] Starting dynamic subtest: D-eDP1
[552.413852] Dynamic subtest D-eDP1: SUCCESS (3.091s)
[552.416092] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.983s)
[553.210502] [085/133] (474s left) gem_mmap_gtt (basic-read)
[553.272504] Subtest basic-read: SKIP (0.000s)
[553.331914] [086/133] (474s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[553.387668] Starting subtest: single-wait-for-submit-available-signaled
[553.388762] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[553.500191] [087/133] (474s left) gem_vm_create (isolation)
[553.550190] Starting subtest: isolation
[553.558799] Subtest isolation: SUCCESS (0.009s)
[553.684155] [088/133] (474s left) gem_mmap_gtt (hang-busy)
[553.743984] Subtest hang-busy: SKIP (0.000s)
[553.795200] [089/133] (474s left) kms_lease (lease-uevent)
[553.896647] Starting subtest: lease-uevent
[554.926410] Subtest lease-uevent: SUCCESS (1.020s)
[555.024118] [090/133] (472s left) gem_mmap_gtt (basic-short)
[555.077564] Subtest basic-short: SKIP (0.000s)
[555.127845] [091/133] (472s left) gem_mmap_gtt (cpuset-big-copy-xy)
[555.174816] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[555.235248] [092/133] (472s left) kms_scaling_modes (scaling-mode-full)
[555.317724] Starting subtest: scaling-mode-full
[555.318693] Starting dynamic subtest: pipe-A-eDP-1
[555.424123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[555.433730] Starting dynamic subtest: pipe-B-eDP-1
[556.655765] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[556.666926] Starting dynamic subtest: pipe-C-eDP-1
[557.877642] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[557.887223] Starting dynamic subtest: pipe-D-eDP-1
[558.998682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[558.999696] Subtest scaling-mode-full: SUCCESS (3.682s)
[560.155322] [093/133] (467s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[560.283785] Starting subtest: basic-flip-after-cursor-legacy
[561.200176] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.916s)
[561.992325] [094/133] (466s left) kms_flip (nonexisting-fb)
[562.073917] Starting subtest: nonexisting-fb
[562.075033] Starting dynamic subtest: A-eDP1
[563.285850] Dynamic subtest A-eDP1: SUCCESS (1.212s)
[563.296339] Starting dynamic subtest: B-eDP1
[564.415883] Dynamic subtest B-eDP1: SUCCESS (1.127s)
[564.425855] Starting dynamic subtest: C-eDP1
[565.551030] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[565.560362] Starting dynamic subtest: D-eDP1
[566.690228] Dynamic subtest D-eDP1: SUCCESS (1.138s)
[566.692574] Subtest nonexisting-fb: SUCCESS (4.621s)
[567.854898] [095/133] (460s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[567.898841] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[568.007925] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[568.082136] [096/133] (460s left) kms_content_protection (atomic-dpms)
[568.221718] Starting subtest: atomic-dpms
[568.223654] Subtest atomic-dpms: SKIP (0.000s)
[568.341139] [097/133] (459s left) gem_exec_capture (capture)
[568.402682] Starting subtest: capture
[568.403601] Starting dynamic subtest: rcs0-smem
[569.232628] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[569.241723] Starting dynamic subtest: bcs0-smem
[570.059864] Dynamic subtest bcs0-smem: SUCCESS (0.826s)
[570.067476] Starting dynamic subtest: vcs0-smem
[570.880921] Dynamic subtest vcs0-smem: SUCCESS (0.819s)
[570.888896] Starting dynamic subtest: vcs1-smem
[572.207489] Dynamic subtest vcs1-smem: SUCCESS (1.326s)
[572.215112] Starting dynamic subtest: vecs0-smem
[573.057841] Dynamic subtest vecs0-smem: FAIL (0.831s)
[573.065580] Starting dynamic subtest: ccs0-smem
[574.369663] Dynamic subtest ccs0-smem: SUCCESS (1.329s)
[574.370570] Subtest capture: FAIL (5.966s)
[574.490848] [098/133] (453s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[574.624347] Starting subtest: cursorB-vs-flipB-atomic
[574.625976] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[574.763205] [099/133] (453s left) gem_pxp (protected-raw-src-copy-not-readible)
[574.893430] Starting subtest: protected-raw-src-copy-not-readible
[574.952613] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[575.072180] [100/133] (453s left) i915_pm_rc6_residency (rc6-fence)
[575.135029] Starting subtest: rc6-fence
[575.159506] Starting dynamic subtest: gt0
[587.490710] Dynamic subtest gt0: SUCCESS (12.319s)
[587.501403] Starting dynamic subtest: gt1
[602.284918] Dynamic subtest gt1: SUCCESS (14.793s)
[602.286139] Subtest rc6-fence: SUCCESS (27.141s)
[602.362135] [101/133] (425s left) kms_async_flips (crc-atomic)
[602.463517] Starting subtest: crc-atomic
[602.838297] Starting dynamic subtest: pipe-A-eDP-1
[605.775403] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.937s)
[606.163175] Starting dynamic subtest: pipe-B-eDP-1
[609.125706] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s)
[609.505717] Starting dynamic subtest: pipe-C-eDP-1
[612.438767] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s)
[612.802003] Starting dynamic subtest: pipe-D-eDP-1
[615.661691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.867s)
[615.662567] Subtest crc-atomic: SUCCESS (13.199s)
[616.816572] [102/133] (411s left) kms_psr (fbc-pr-cursor-render)
[616.908422] Starting subtest: fbc-pr-cursor-render
[616.910040] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[616.976657] [103/133] (411s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[617.094394] Starting subtest: basic-busy-flip-before-cursor-varying-size
[617.096091] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[617.234395] [104/133] (411s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[617.322442] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[624.109477] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.788s)
[624.219966] [105/133] (404s left) gem_exec_whisper (basic-contexts-priority)
[624.277561] Starting subtest: basic-contexts-priority
[647.752368] Subtest basic-contexts-priority: SUCCESS (23.465s)
[647.922984] [106/133] (380s left) kms_color (ctm-max)
[648.022350] Starting subtest: ctm-max
[648.023361] Starting dynamic subtest: pipe-A-eDP-1
[648.732324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[648.740535] Starting dynamic subtest: pipe-B-eDP-1
[650.164486] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[650.172830] Starting dynamic subtest: pipe-C-eDP-1
[651.544011] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[651.551900] Starting dynamic subtest: pipe-D-eDP-1
[652.872190] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[652.873123] Subtest ctm-max: SUCCESS (4.850s)
[653.663957] [107/133] (374s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[653.747548] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[660.772896] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.024s)
[660.908574] [108/133] (367s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[660.988888] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[660.989980] Starting dynamic subtest: pipe-A-eDP-1
[678.194234] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s)
[678.202954] Starting dynamic subtest: pipe-B-eDP-1
[696.182136] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.862s)
[696.190856] Starting dynamic subtest: pipe-C-eDP-1
[714.163262] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.746s)
[714.171731] Starting dynamic subtest: pipe-D-eDP-1
[732.145031] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.734s)
[732.145961] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.172s)
[738.446246] [109/133] (295s left) kms_psr (fbc-pr-sprite-plane-move)
[738.542511] Starting subtest: fbc-pr-sprite-plane-move
[738.544233] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[738.611468] [110/133] (295s left) kms_pm_rpm (basic-rte)
[738.646632] Starting subtest: basic-rte
[741.905846] Subtest basic-rte: SUCCESS (3.255s)
[743.411987] [111/133] (290s left) gem_ctx_shared (q-out-order)
[743.477416] Starting subtest: Q-out-order
[743.478492] Starting dynamic subtest: rcs0
[743.607008] Dynamic subtest rcs0: SUCCESS (0.120s)
[743.618522] Starting dynamic subtest: vcs0
[743.697468] Dynamic subtest vcs0: SUCCESS (0.098s)
[743.708167] Starting dynamic subtest: vcs1
[743.778285] Dynamic subtest vcs1: SUCCESS (0.080s)
[743.793756] Starting dynamic subtest: vecs0
[743.855290] Dynamic subtest vecs0: SUCCESS (0.075s)
[743.873104] Starting dynamic subtest: ccs0
[743.941103] Dynamic subtest ccs0: SUCCESS (0.083s)
[743.942352] Subtest Q-out-order: SUCCESS (0.464s)
[745.386997] [112/133] (288s left) kms_big_fb (linear-8bpp-rotate-0)
[745.472315] Starting subtest: linear-8bpp-rotate-0
[746.719554] Subtest linear-8bpp-rotate-0: SUCCESS (1.246s)
[746.845397] [113/133] (286s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[746.930141] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[746.932077] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[747.019633] [114/133] (286s left) gem_softpin (evict-prime-sanity-check)
[747.083200] Starting subtest: evict-prime-sanity-check
[747.084462] Starting dynamic subtest: rcs0
[748.219096] Dynamic subtest rcs0: SUCCESS (1.135s)
[748.231143] Starting dynamic subtest: bcs0
[749.337218] Dynamic subtest bcs0: SUCCESS (1.115s)
[749.347359] Starting dynamic subtest: vcs0
[751.264072] Dynamic subtest vcs0: SUCCESS (1.914s)
[751.273057] Starting dynamic subtest: vcs1
[753.313391] Dynamic subtest vcs1: SUCCESS (2.045s)
[753.324941] Starting dynamic subtest: vecs0
[755.212018] Dynamic subtest vecs0: SUCCESS (1.895s)
[755.225228] Starting dynamic subtest: ccs0
[756.358392] Dynamic subtest ccs0: SUCCESS (1.153s)
[756.375470] Starting dynamic subtest: all
[757.491023] Dynamic subtest all: SUCCESS (1.130s)
[757.492197] Subtest evict-prime-sanity-check: SUCCESS (10.403s)
[757.566301] [115/133] (276s left) dmabuf_sync_file (export-multiwait)
[757.610981] Starting subtest: export-multiwait
[757.611945] Subtest export-multiwait: SUCCESS (0.000s)
[757.678651] [116/133] (276s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[757.771664] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[765.150325] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.377s)
[765.263556] [117/133] (268s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[765.351093] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[765.352826] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[765.432394] [118/133] (268s left) gem_create (create-ext-set-pat)
[765.599923] Starting subtest: create-ext-set-pat
[765.601129] Subtest create-ext-set-pat: SUCCESS (0.001s)
[765.667185] [119/133] (268s left) prime_vgem (busy)
[765.728521] Starting subtest: busy
[765.729378] Starting dynamic subtest: rcs0
[765.794794] Dynamic subtest rcs0: SUCCESS (0.066s)
[765.802613] Starting dynamic subtest: bcs0
[765.857431] Dynamic subtest bcs0: SUCCESS (0.062s)
[765.867083] Starting dynamic subtest: vcs0
[765.897029] Dynamic subtest vcs0: SUCCESS (0.038s)
[765.905256] Starting dynamic subtest: vcs1
[765.942066] Dynamic subtest vcs1: SUCCESS (0.044s)
[765.950499] Starting dynamic subtest: vecs0
[765.988997] Dynamic subtest vecs0: SUCCESS (0.046s)
[765.997403] Starting dynamic subtest: ccs0
[766.033659] Dynamic subtest ccs0: SUCCESS (0.044s)
[766.034792] Subtest busy: SUCCESS (0.306s)
[766.165765] [120/133] (267s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[766.258142] Starting subtest: x-tiled-64bpp-rotate-90
[766.280239] Subtest x-tiled-64bpp-rotate-90: SKIP (0.021s)
[766.389948] [121/133] (267s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[766.500554] Starting subtest: 4-tiled-32bpp-rotate-180
[767.991404] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.490s)
[768.136217] [122/133] (266s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[768.178378] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[768.241292] [123/133] (265s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[768.350948] Starting subtest: yf-tiled-32bpp-rotate-90
[768.352562] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[768.455274] [124/133] (265s left) gem_mmap_wc (write-prefaulted)
[768.509185] Subtest write-prefaulted: SKIP (0.000s)
[768.567508] [125/133] (265s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[768.680319] Starting subtest: cursorA-vs-flipA-legacy
[779.816595] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.137s)
[780.656042] [126/133] (253s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[780.767462] Starting subtest: 2x-long-flip-vs-cursor-legacy
[780.771216] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[780.910986] [127/133] (253s left) gem_mmap_gtt (big-bo)
[780.958109] Subtest big-bo: SKIP (0.000s)
[781.007512] [128/133] (253s left) gem_exercise_blt (fast-copy-emit)
[781.064831] Starting subtest: fast-copy-emit
[781.065810] Starting dynamic subtest: linear-smem-smem-emit
[781.087908] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[781.097495] Starting dynamic subtest: xmajor-smem-smem-emit
[781.105335] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[781.113570] Starting dynamic subtest: tile4-smem-smem-emit
[781.123386] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[781.131481] Starting dynamic subtest: tile64-smem-smem-emit
[781.140912] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[781.141792] Subtest fast-copy-emit: SUCCESS (0.077s)
[781.274126] [129/133] (253s left) perf (gen8-unprivileged-single-ctx-counters)
[781.400002] Starting subtest: gen8-unprivileged-single-ctx-counters
[781.401538] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[781.437853] [130/133] (252s left) gem_exec_reloc (basic-cpu-read)
[781.487478] Subtest basic-cpu-read: SKIP (0.000s)
[781.548150] [131/133] (252s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[781.635937] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[781.637587] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[781.725966] [132/133] (252s left) i915_pm_rps (thresholds-idle-park)
[781.782832] Starting subtest: thresholds-idle-park
[781.784719] Subtest thresholds-idle-park: SKIP (0.001s)
[781.876841] [133/133] (252s left) gem_exec_params (rsvd2-dirt)
[781.925833] Starting subtest: rsvd2-dirt
[781.927612] Subtest rsvd2-dirt: SKIP (0.000s)
[782.010310] 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.