[57.057956] Initializing watchdogs
[57.058137]   /dev/watchdog0
[57.072591] [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]
[57.077060] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.079405] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.082945] [001/133] (960s left) gem_mmap_gtt (basic-read-write)
[57.158155] Subtest basic-read-write: SKIP (0.000s)
[57.227212] [002/133] (960s left) kms_plane (pixel-format-linear-modifier)
[57.319919] Starting subtest: pixel-format-linear-modifier
[57.357459] Starting dynamic subtest: pipe-A-plane-0
[60.959596] Dynamic subtest pipe-A-plane-0: SUCCESS (3.600s)
[60.967639] Starting dynamic subtest: pipe-A-plane-3
[62.600495] Dynamic subtest pipe-A-plane-3: SUCCESS (1.643s)
[62.610147] Starting dynamic subtest: pipe-A-plane-5
[62.811737] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[63.913980] Starting dynamic subtest: pipe-B-plane-0
[67.651447] Dynamic subtest pipe-B-plane-0: SUCCESS (3.744s)
[67.664460] Starting dynamic subtest: pipe-B-plane-3
[69.373169] Dynamic subtest pipe-B-plane-3: SUCCESS (1.721s)
[69.381439] Starting dynamic subtest: pipe-B-plane-5
[69.572850] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s)
[69.890031] Subtest pixel-format-linear-modifier: SUCCESS (12.573s)
[70.687936] [003/133] (946s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[70.790104] Starting subtest: y-tiled-8bpp-rotate-270
[70.794569] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[70.880556] [004/133] (946s left) syncobj_wait (single-wait-for-submit-signaled)
[70.935859] Starting subtest: single-wait-for-submit-signaled
[70.937893] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[71.048318] [005/133] (946s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[71.160934] Starting subtest: flip-vs-cursor-atomic
[78.325573] Subtest flip-vs-cursor-atomic: SUCCESS (7.166s)
[79.121913] [006/133] (938s left) kms_chamelium_frames (hdmi-crc-fast)
[79.504925] Subtest hdmi-crc-fast: SKIP (0.000s)
[80.338480] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[80.446617] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[80.451225] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[80.524675] [008/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[80.629425] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[80.633862] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[80.721289] [009/133] (937s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[80.817433] Starting subtest: fbc-rgb101010-draw-blt
[85.372368] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.558s)
[86.563814] [010/133] (931s left) kms_dp_linktrain_fallback (dsc-fallback)
[86.667853] Starting subtest: dsc-fallback
[86.674066] Subtest dsc-fallback: SKIP (0.000s)
[86.736425] [011/133] (931s left) gem_exec_balancer (fairslice)
[86.810627] Starting subtest: fairslice
[89.717218] Subtest fairslice: SUCCESS (2.907s)
[90.883772] [012/133] (927s left) gem_eio (in-flight-immediate)
[91.130910] Starting subtest: in-flight-immediate
[99.726679] Subtest in-flight-immediate: SUCCESS (8.596s)
[99.892240] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[99.895222] [013/133] (918s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[99.950094] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[99.952495] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[100.061502] [014/133] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[100.161139] Starting subtest: fbcpsr-2p-rte
[100.165128] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[100.267877] [015/133] (917s left) kms_psr (psr2-cursor-mmap-cpu)
[100.362588] Starting subtest: psr2-cursor-mmap-cpu
[100.364995] Starting dynamic subtest: eDP-1
[102.031451] Dynamic subtest eDP-1: SUCCESS (1.671s)
[102.033808] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.672s)
[102.914032] [016/133] (915s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[103.015980] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[109.659066] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.644s)
[109.772916] [017/133] (908s left) sw_sync (sync_multi_consumer_producer)
[109.808663] Starting subtest: sync_multi_consumer_producer
[110.082281] Subtest sync_multi_consumer_producer: SUCCESS (0.273s)
[110.141286] [018/133] (908s left) kms_setmode (basic)
[110.187692] Starting subtest: basic
[110.524188] Starting dynamic subtest: pipe-A-eDP-1
[112.571829] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.043s)
[112.937601] Starting dynamic subtest: pipe-B-eDP-1
[114.997777] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.065s)
[115.308709] Subtest basic: SUCCESS (5.119s)
[116.150416] [019/133] (902s left) kms_psr (fbc-psr-primary-render)
[116.256079] Starting subtest: fbc-psr-primary-render
[116.258416] Starting dynamic subtest: eDP-1
[116.262848] Dynamic subtest eDP-1: SKIP (0.000s)
[116.267275] Subtest fbc-psr-primary-render: SKIP (0.001s)
[116.327880] [020/133] (901s left) kms_psr (psr-cursor-plane-move)
[116.426908] Starting subtest: psr-cursor-plane-move
[116.429259] Starting dynamic subtest: eDP-1
[118.126541] Dynamic subtest eDP-1: SUCCESS (1.699s)
[118.128854] Subtest psr-cursor-plane-move: SUCCESS (1.701s)
[118.999647] [021/133] (899s left) kms_pipe_crc_basic (suspend-read-crc)
[119.093796] Starting subtest: suspend-read-crc
[119.096298] Starting dynamic subtest: pipe-A-eDP-1
[136.357299] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.689s)
[136.367638] Starting dynamic subtest: pipe-B-eDP-1
[154.354983] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.169s)
[154.364698] Starting dynamic subtest: pipe-C-eDP-1
[172.306109] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.024s)
[172.316335] Starting dynamic subtest: pipe-D-eDP-1
[190.321690] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.091s)
[190.323912] Subtest suspend-read-crc: SUCCESS (11.978s)
[191.148391] [022/133] (827s left) kms_flip (flip-vs-dpms-on-nop)
[191.256760] Starting subtest: flip-vs-dpms-on-nop
[191.259289] Starting dynamic subtest: A-eDP1
[193.138473] Dynamic subtest A-eDP1: SUCCESS (1.885s)
[193.149937] Starting dynamic subtest: B-eDP1
[194.960912] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[194.971716] Starting dynamic subtest: C-eDP1
[196.780757] Dynamic subtest C-eDP1: SUCCESS (1.817s)
[196.794818] Starting dynamic subtest: D-eDP1
[198.612705] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[198.615006] Subtest flip-vs-dpms-on-nop: SUCCESS (7.361s)
[199.799535] [023/133] (818s left) gem_bad_reloc (negative-reloc-bltcopy)
[199.858765] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[199.929692] [024/133] (818s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[199.979872] Starting subtest: invalid-single-wait-all-unsubmitted
[199.982195] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[200.080437] [025/133] (818s left) gem_ccs (block-multicopy-compressed)
[200.136781] Starting subtest: block-multicopy-compressed
[200.141325] Subtest block-multicopy-compressed: SKIP (0.000s)
[200.235172] [026/133] (818s left) gen9_exec_parse (unaligned-jump)
[200.284668] Subtest unaligned-jump: SKIP (0.000s)
[200.350096] [027/133] (818s left) perf_pmu (multi-client)
[200.394429] Starting subtest: multi-client
[200.396771] Starting dynamic subtest: rcs0
[201.437206] Dynamic subtest rcs0: SUCCESS (1.044s)
[201.449098] Starting dynamic subtest: bcs0
[202.489637] Dynamic subtest bcs0: SUCCESS (1.050s)
[202.502806] Starting dynamic subtest: vcs0
[203.543843] Dynamic subtest vcs0: SUCCESS (1.052s)
[203.555626] Starting dynamic subtest: vcs1
[205.181511] Dynamic subtest vcs1: SUCCESS (1.635s)
[205.193427] Starting dynamic subtest: vecs0
[207.161771] Dynamic subtest vecs0: SUCCESS (1.978s)
[207.171807] Starting dynamic subtest: ccs0
[209.146670] Dynamic subtest ccs0: SUCCESS (1.982s)
[209.149558] Subtest multi-client: SUCCESS (8.753s)
[209.276555] [028/133] (809s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[209.374364] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[213.605577] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.234s)
[214.814134] [029/133] (803s left) gem_exec_schedule (fairslice-all)
[214.899761] Starting subtest: fairslice-all
[216.948395] Subtest fairslice-all: SUCCESS (2.055s)
[218.159799] [030/133] (800s left) kms_joiner (basic-max-non-joiner)
[218.266817] Starting subtest: basic-max-non-joiner
[218.271014] Subtest basic-max-non-joiner: SKIP (0.000s)
[218.334707] [031/133] (800s left) prime_vgem (coherency-gtt)
[218.401212] Starting subtest: coherency-gtt
[218.406142] Subtest coherency-gtt: SKIP (0.000s)
[218.517776] [032/133] (800s left) gem_exec_create (madvise)
[218.577266] Starting subtest: madvise
[218.579529] Starting dynamic subtest: smem
[240.196971] Dynamic subtest smem: SUCCESS (21.614s)
[240.199516] Subtest madvise: SUCCESS (21.615s)
[241.065057] [033/133] (777s left) gem_exec_fence (syncobj-repeat)
[241.560325] Starting subtest: syncobj-repeat
[241.747909] Subtest syncobj-repeat: SUCCESS (0.186s)
[243.232367] [034/133] (775s left) api_intel_bb (blit-noreloc-keep-cache)
[243.293605] Starting subtest: blit-noreloc-keep-cache
[243.309617] Subtest blit-noreloc-keep-cache: SUCCESS (0.016s)
[243.427420] [035/133] (775s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[243.494774] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[243.565846] [036/133] (775s left) gem_workarounds (basic-read)
[243.623959] Starting subtest: basic-read
[243.640500] Subtest basic-read: SUCCESS (0.016s)
[243.761567] [037/133] (775s left) prime_mmap (test_correct_cpu_write)
[243.813755] Starting subtest: test_correct_cpu_write
[243.815883] Starting dynamic subtest: test_correct_cpu_write-smem
[243.817767] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[243.819673] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[243.923271] [038/133] (775s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[244.033991] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[244.036251] Starting dynamic subtest: pipe-A-eDP-1
[244.058454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.071047] Starting dynamic subtest: pipe-B-eDP-1
[244.091367] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.099519] Starting dynamic subtest: pipe-C-eDP-1
[244.120549] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.128913] Starting dynamic subtest: pipe-D-eDP-1
[244.150931] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.155373] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[246.351486] [039/133] (772s left) gen9_exec_parse (bb-oversize)
[246.425176] Subtest bb-oversize: SKIP (0.000s)
[246.492243] [040/133] (772s left) gem_exec_schedule (pi-userfault)
[246.676567] Starting subtest: pi-userfault
[246.678894] Starting dynamic subtest: rcs0
[246.686768] Dynamic subtest rcs0: SUCCESS (0.013s)
[246.697361] Starting dynamic subtest: bcs0
[246.699244] Dynamic subtest bcs0: SUCCESS (0.008s)
[246.708445] Starting dynamic subtest: vcs0
[246.710569] Dynamic subtest vcs0: SUCCESS (0.008s)
[246.719620] Starting dynamic subtest: vcs1
[246.721452] Dynamic subtest vcs1: SUCCESS (0.008s)
[246.730342] Starting dynamic subtest: vecs0
[246.732530] Dynamic subtest vecs0: SUCCESS (0.009s)
[246.740988] Starting dynamic subtest: ccs0
[246.742851] Dynamic subtest ccs0: SUCCESS (0.008s)
[246.744731] Subtest pi-userfault: SUCCESS (0.057s)
[246.914490] [041/133] (772s left) kms_dsc (dsc-with-bpc)
[247.002893] Starting subtest: dsc-with-bpc
[247.033566] Subtest dsc-with-bpc: SKIP (0.001s)
[247.074918] [042/133] (772s left) kms_cursor_crc (cursor-offscreen-512x512)
[247.346566] Starting subtest: cursor-offscreen-512x512
[247.350857] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[247.485383] [043/133] (771s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[247.581368] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[247.585814] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[247.649411] [044/133] (771s left) vgem_basic (bad-fence)
[247.690079] Starting subtest: bad-fence
[247.691813] Subtest bad-fence: SUCCESS (0.000s)
[247.745591] [045/133] (771s left) gem_render_copy (yf-tiled-to-vebox-linear)
[247.800900] Starting subtest: yf-tiled-to-vebox-linear
[247.805002] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[247.987923] [046/133] (771s left) gem_eio (in-flight-internal-immediate)
[248.216723] Starting subtest: in-flight-internal-immediate
[249.231633] Subtest in-flight-internal-immediate: SUCCESS (1.014s)
[249.386476] [047/133] (770s left) kms_flip (blocking-absolute-wf_vblank)
[249.485236] Starting subtest: blocking-absolute-wf_vblank
[249.487637] Starting dynamic subtest: A-eDP1
[258.212022] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[258.225741] Starting dynamic subtest: B-eDP1
[266.946671] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[266.960722] Starting dynamic subtest: C-eDP1
[275.673701] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[275.689390] Starting dynamic subtest: D-eDP1
[284.409877] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[284.412449] Subtest blocking-absolute-wf_vblank: SUCCESS (34.920s)
[285.614305] [048/133] (733s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[285.701649] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[285.704011] Starting dynamic subtest: pipe-A-eDP-1
[285.730329] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.740486] Starting dynamic subtest: pipe-B-eDP-1
[285.761850] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.772227] Starting dynamic subtest: pipe-C-eDP-1
[285.792482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.801107] Starting dynamic subtest: pipe-D-eDP-1
[285.822897] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.827262] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[287.990002] [049/133] (731s left) kms_properties (connector-properties-legacy)
[288.092395] Starting subtest: connector-properties-legacy
[288.094275] Starting dynamic subtest: pipe-A-eDP-1
[295.797361] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.707s)
[295.806752] Starting dynamic subtest: pipe-None-DP-1
[295.811225] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[295.819746] Starting dynamic subtest: pipe-None-HDMI-A-1
[295.823875] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[295.832861] Starting dynamic subtest: pipe-None-DP-2
[295.836807] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[295.845341] Starting dynamic subtest: pipe-None-HDMI-A-2
[295.849258] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[295.860595] Starting dynamic subtest: pipe-None-DP-3
[295.864967] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[295.874034] Starting dynamic subtest: pipe-None-DP-4
[295.878290] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[295.880516] Subtest connector-properties-legacy: SUCCESS (7.720s)
[296.669357] [050/133] (722s left) perf_pmu (busy-hang)
[296.714815] Starting subtest: busy-hang
[296.717049] Starting dynamic subtest: rcs0
[297.996144] Dynamic subtest rcs0: SUCCESS (1.283s)
[298.007816] Starting dynamic subtest: bcs0
[299.241600] Dynamic subtest bcs0: SUCCESS (1.240s)
[299.253997] Starting dynamic subtest: vcs0
[301.704263] Dynamic subtest vcs0: SUCCESS (2.461s)
[301.715074] Starting dynamic subtest: vcs1
[303.680458] Dynamic subtest vcs1: SUCCESS (1.978s)
[303.692824] Starting dynamic subtest: vecs0
[305.666364] Dynamic subtest vecs0: SUCCESS (1.985s)
[305.676651] Starting dynamic subtest: ccs0
[306.914934] Dynamic subtest ccs0: SUCCESS (1.243s)
[306.917179] Subtest busy-hang: SUCCESS (10.200s)
[307.011929] [051/133] (712s left) kms_vblank (ts-continuation-modeset-rpm)
[307.109980] Starting subtest: ts-continuation-modeset-rpm
[307.112132] Starting dynamic subtest: pipe-A-eDP-1
[309.660471] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.550s)
[309.674718] Starting dynamic subtest: pipe-D-eDP-1
[311.902637] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[311.904984] Subtest ts-continuation-modeset-rpm: SUCCESS (4.795s)
[312.715763] [052/133] (706s left) syncobj_wait (single-wait-for-submit-submitted)
[312.766248] Starting subtest: single-wait-for-submit-submitted
[312.870656] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[312.947743] [053/133] (706s left) kms_universal_plane (cursor-fb-leak)
[313.036004] Starting subtest: cursor-fb-leak
[313.038223] Starting dynamic subtest: pipe-A-eDP-1
[313.380728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.346s)
[313.395335] Starting dynamic subtest: pipe-B-eDP-1
[314.729362] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s)
[314.741779] Starting dynamic subtest: pipe-C-eDP-1
[316.146186] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[316.156622] Starting dynamic subtest: pipe-D-eDP-1
[317.560712] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[317.563080] Subtest cursor-fb-leak: SUCCESS (4.527s)
[318.723514] [054/133] (701s left) gem_exec_schedule (smoketest)
[318.895551] Starting subtest: smoketest
[318.898143] Starting dynamic subtest: rcs0
[324.440188] Dynamic subtest rcs0: SUCCESS (5.500s)
[324.453001] Starting dynamic subtest: bcs0
[329.976380] Dynamic subtest bcs0: SUCCESS (5.532s)
[329.987469] Starting dynamic subtest: vcs0
[335.486664] Dynamic subtest vcs0: SUCCESS (5.506s)
[335.498593] Starting dynamic subtest: vcs1
[340.989414] Dynamic subtest vcs1: SUCCESS (5.507s)
[341.003467] Starting dynamic subtest: vecs0
[346.495729] Dynamic subtest vecs0: SUCCESS (5.498s)
[346.511998] Starting dynamic subtest: ccs0
[352.010720] Dynamic subtest ccs0: SUCCESS (5.511s)
[352.012958] Subtest smoketest: SUCCESS (33.061s)
[352.150313] [055/133] (667s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[352.248505] Starting subtest: x-tiled-addfb-size-offset-overflow
[352.250762] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[352.359708] [056/133] (667s left) kms_atomic_transition (plane-all-transition-nonblocking)
[352.458705] Starting subtest: plane-all-transition-nonblocking
[352.461012] Starting dynamic subtest: pipe-A-eDP-1
[354.955108] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[355.275087] Starting dynamic subtest: pipe-B-eDP-1
[358.471192] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[358.770489] Subtest plane-all-transition-nonblocking: SUCCESS (6.309s)
[359.595116] [057/133] (660s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[359.666790] Starting subtest: single-wait-for-submit-unsubmitted
[359.773685] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[359.861297] [058/133] (660s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[359.965533] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[359.970038] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[360.086711] [059/133] (659s left) kms_flip (absolute-wf_vblank)
[360.184656] Starting subtest: absolute-wf_vblank
[360.186534] Starting dynamic subtest: A-eDP1
[368.950402] Dynamic subtest A-eDP1: SUCCESS (8.766s)
[368.959868] Starting dynamic subtest: B-eDP1
[377.682248] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[377.692813] Starting dynamic subtest: C-eDP1
[386.406486] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[386.418155] Starting dynamic subtest: D-eDP1
[395.136893] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[395.139224] Subtest absolute-wf_vblank: SUCCESS (34.954s)
[396.348083] [060/133] (623s left) gem_ctx_persistence (heartbeat-hostile)
[396.417229] Starting subtest: heartbeat-hostile
[396.421653] Subtest heartbeat-hostile: SKIP (0.000s)
[396.532312] [061/133] (623s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[396.592676] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[396.692983] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[396.777203] [062/133] (623s left) gem_exec_params (dr1-dirt)
[396.824319] Starting subtest: DR1-dirt
[396.826598] Subtest DR1-dirt: SUCCESS (0.000s)
[396.925042] [063/133] (623s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[397.017494] Starting subtest: addfb25-yf-tiled-legacy
[397.019675] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[397.130229] [064/133] (623s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[397.217898] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[397.220338] Starting dynamic subtest: pipe-A-eDP-1
[397.242587] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[397.253792] Starting dynamic subtest: pipe-B-eDP-1
[397.275077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[397.283885] Starting dynamic subtest: pipe-C-eDP-1
[397.301599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[397.310225] Starting dynamic subtest: pipe-D-eDP-1
[397.329036] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[397.332611] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[399.430118] [065/133] (620s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[399.489002] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[399.491279] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[399.600288] [066/133] (620s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[399.683206] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[399.687453] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[399.756270] [067/133] (620s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[399.980798] Starting subtest: cursor-rapid-movement-128x128
[399.985558] Starting dynamic subtest: pipe-A-eDP-1
[400.531355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[400.564233] Starting dynamic subtest: pipe-D-eDP-1
[401.745246] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[401.747478] Subtest cursor-rapid-movement-128x128: SUCCESS (1.764s)
[402.583811] [068/133] (617s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[402.683654] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[402.688116] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[402.804927] [069/133] (617s left) i915_hangman (detector)
[402.869899] Starting subtest: detector
[402.871751] Starting dynamic subtest: rcs0
[414.112382] Dynamic subtest rcs0: SUCCESS (11.241s)
[414.124269] Starting dynamic subtest: bcs0
[426.080460] Dynamic subtest bcs0: SUCCESS (11.966s)
[426.095404] Starting dynamic subtest: vcs0
[438.048849] Dynamic subtest vcs0: SUCCESS (11.966s)
[438.064341] Starting dynamic subtest: vcs1
[450.080790] Dynamic subtest vcs1: SUCCESS (12.029s)
[450.093089] Starting dynamic subtest: vecs0
[461.088017] Dynamic subtest vecs0: SUCCESS (11.004s)
[461.100260] Starting dynamic subtest: ccs0
[473.120616] Dynamic subtest ccs0: SUCCESS (12.029s)
[473.123683] Subtest detector: SUCCESS (70.252s)
[473.203025] [070/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[473.303585] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[480.371541] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.068s)
[480.496789] [071/133] (539s left) core_auth (getclient-simple)
[480.537988] Starting subtest: getclient-simple
[480.563248] Subtest getclient-simple: SUCCESS (0.024s)
[480.681720] [072/133] (539s left) kms_properties (colorop-properties-legacy)
[480.774947] Starting subtest: colorop-properties-legacy
[480.777194] Starting dynamic subtest: pipe-A-eDP-1
[481.146555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[481.157239] Starting dynamic subtest: pipe-B-eDP-1
[482.267790] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.117s)
[482.281846] Starting dynamic subtest: pipe-C-eDP-1
[483.302851] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.036s)
[483.313052] Starting dynamic subtest: pipe-D-eDP-1
[484.331787] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.027s)
[484.333970] Subtest colorop-properties-legacy: SUCCESS (3.558s)
[485.136507] [073/133] (535s left) gem_ctx_param (invalid-get-engines)
[485.182929] Starting subtest: invalid-get-engines
[485.185246] Subtest invalid-get-engines: SUCCESS (0.001s)
[485.275971] [074/133] (535s left) kms_prop_blob (basic)
[485.330260] Starting subtest: basic
[485.332178] Subtest basic: SUCCESS (0.000s)
[485.424492] [075/133] (535s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[485.546756] Starting subtest: cursorB-vs-flipA-toggle
[485.551367] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[485.694062] [076/133] (534s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[485.777937] Starting subtest: plane-scaler-unity-scaling-with-rotation
[485.780196] Starting dynamic subtest: pipe-A
[486.004572] Dynamic subtest pipe-A: SUCCESS (0.228s)
[486.014728] Starting dynamic subtest: pipe-B
[487.307307] Dynamic subtest pipe-B: SUCCESS (1.301s)
[487.317205] Starting dynamic subtest: pipe-C
[488.628833] Dynamic subtest pipe-C: SUCCESS (1.320s)
[488.641012] Starting dynamic subtest: pipe-D
[489.951851] Dynamic subtest pipe-D: SUCCESS (1.322s)
[489.954219] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.176s)
[491.126544] [077/133] (529s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[491.247426] Starting subtest: extended-modeset-hang-oldfb-with-reset
[491.249827] Starting dynamic subtest: pipe-A
[503.110404] Dynamic subtest pipe-A: SUCCESS (11.860s)
[503.120302] Starting dynamic subtest: pipe-D
[515.369053] Dynamic subtest pipe-D: SUCCESS (12.257s)
[515.371292] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.121s)
[516.171644] [078/133] (504s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[516.262969] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[516.267518] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[516.367728] [079/133] (504s left) kms_plane_scaling (planes-upscale-20x20)
[516.450977] Starting subtest: planes-upscale-20x20
[516.453289] Starting dynamic subtest: pipe-A
[516.512721] Dynamic subtest pipe-A: SUCCESS (0.062s)
[516.522946] Starting dynamic subtest: pipe-B
[517.695857] Dynamic subtest pipe-B: SUCCESS (1.182s)
[517.706883] Starting dynamic subtest: pipe-C
[518.819611] Dynamic subtest pipe-C: SUCCESS (1.122s)
[518.829594] Starting dynamic subtest: pipe-D
[519.947580] Dynamic subtest pipe-D: SUCCESS (1.127s)
[519.950045] Subtest planes-upscale-20x20: SUCCESS (3.498s)
[521.121105] [080/133] (499s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[521.228792] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[521.230924] Starting dynamic subtest: pipe-A-eDP-1
[521.977504] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[521.989649] Starting dynamic subtest: pipe-B-eDP-1
[523.747996] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.769s)
[523.757512] Starting dynamic subtest: pipe-C-eDP-1
[525.582313] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.834s)
[525.593463] Starting dynamic subtest: pipe-D-eDP-1
[527.409862] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.826s)
[527.412028] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.174s)
[528.552722] [081/133] (492s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[528.649787] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[528.654277] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[528.746174] [082/133] (492s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[529.129519] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[529.970377] [083/133] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[530.079436] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[530.083776] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[530.217744] [084/133] (490s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[530.312580] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[530.314926] Starting dynamic subtest: A-eDP1
[533.906071] Dynamic subtest A-eDP1: SUCCESS (3.592s)
[533.916540] Starting dynamic subtest: B-eDP1
[537.109522] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[537.119798] Starting dynamic subtest: C-eDP1
[540.207345] Dynamic subtest C-eDP1: SUCCESS (3.094s)
[540.218310] Starting dynamic subtest: D-eDP1
[543.314787] Dynamic subtest D-eDP1: SUCCESS (3.106s)
[543.316957] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.001s)
[544.116173] [085/133] (476s left) gem_mmap_gtt (basic-read)
[544.172853] Subtest basic-read: SKIP (0.000s)
[544.245990] [086/133] (476s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[544.305198] Starting subtest: single-wait-for-submit-available-signaled
[544.307607] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[544.429784] [087/133] (476s left) gem_vm_create (isolation)
[544.492514] Starting subtest: isolation
[544.501257] Subtest isolation: SUCCESS (0.009s)
[544.620339] [088/133] (476s left) gem_mmap_gtt (hang-busy)
[544.677643] Subtest hang-busy: SKIP (0.000s)
[544.746573] [089/133] (476s left) kms_lease (lease-uevent)
[544.843769] Starting subtest: lease-uevent
[545.853959] Subtest lease-uevent: SUCCESS (1.010s)
[545.929969] [090/133] (475s left) gem_mmap_gtt (basic-short)
[545.977791] Subtest basic-short: SKIP (0.000s)
[546.042021] [091/133] (475s left) gem_mmap_gtt (cpuset-big-copy-xy)
[546.096811] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[546.159803] [092/133] (475s left) kms_scaling_modes (scaling-mode-full)
[546.251537] Starting subtest: scaling-mode-full
[546.253860] Starting dynamic subtest: pipe-A-eDP-1
[546.345293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[546.355381] Starting dynamic subtest: pipe-B-eDP-1
[547.545567] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[547.556298] Starting dynamic subtest: pipe-C-eDP-1
[548.753373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[548.772539] Starting dynamic subtest: pipe-D-eDP-1
[549.885798] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[549.888091] Subtest scaling-mode-full: SUCCESS (3.638s)
[551.066760] [093/133] (470s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[551.197868] Starting subtest: basic-flip-after-cursor-legacy
[552.117486] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.917s)
[552.984624] [094/133] (468s left) kms_flip (nonexisting-fb)
[553.083150] Starting subtest: nonexisting-fb
[553.085522] Starting dynamic subtest: A-eDP1
[554.278297] Dynamic subtest A-eDP1: SUCCESS (1.196s)
[554.288404] Starting dynamic subtest: B-eDP1
[555.411306] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[555.428187] Starting dynamic subtest: C-eDP1
[556.547450] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[556.560213] Starting dynamic subtest: D-eDP1
[557.691455] Dynamic subtest D-eDP1: SUCCESS (1.141s)
[557.696700] Subtest nonexisting-fb: SUCCESS (4.613s)
[558.861367] [095/133] (462s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[558.923106] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[559.030527] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[559.113392] [096/133] (462s left) kms_content_protection (atomic-dpms)
[559.245729] Starting subtest: atomic-dpms
[559.250465] Subtest atomic-dpms: SKIP (0.000s)
[559.377283] [097/133] (462s left) gem_exec_capture (capture)
[559.431479] Starting subtest: capture
[559.433738] Starting dynamic subtest: rcs0-smem
[560.263027] Dynamic subtest rcs0-smem: SUCCESS (0.832s)
[560.273481] Starting dynamic subtest: bcs0-smem
[561.091715] Dynamic subtest bcs0-smem: SUCCESS (0.829s)
[561.104970] Starting dynamic subtest: vcs0-smem
[561.911979] Dynamic subtest vcs0-smem: SUCCESS (0.816s)
[561.922659] Starting dynamic subtest: vcs1-smem
[562.723723] Dynamic subtest vcs1-smem: SUCCESS (0.814s)
[562.736381] Starting dynamic subtest: vecs0-smem
[564.121482] Dynamic subtest vecs0-smem: FAIL (1.343s)
[564.132260] Starting dynamic subtest: ccs0-smem
[565.388276] Dynamic subtest ccs0-smem: SUCCESS (1.318s)
[565.390654] Subtest capture: FAIL (5.957s)
[565.510023] [098/133] (456s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[565.631794] Starting subtest: cursorB-vs-flipB-atomic
[565.636393] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[565.793096] [099/133] (455s left) gem_pxp (protected-raw-src-copy-not-readible)
[565.914118] Starting subtest: protected-raw-src-copy-not-readible
[565.974077] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.062s)
[566.084407] [100/133] (455s left) i915_pm_rc6_residency (rc6-fence)
[566.150329] Starting subtest: rc6-fence
[566.168012] Starting dynamic subtest: gt0
[578.486084] Dynamic subtest gt0: SUCCESS (12.316s)
[578.497237] Starting dynamic subtest: gt1
[593.089620] Dynamic subtest gt1: SUCCESS (14.599s)
[593.092377] Subtest rc6-fence: SUCCESS (26.938s)
[593.168997] [101/133] (428s left) kms_async_flips (crc-atomic)
[593.270020] Starting subtest: crc-atomic
[593.650602] Starting dynamic subtest: pipe-A-eDP-1
[596.588682] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.938s)
[596.978638] Starting dynamic subtest: pipe-B-eDP-1
[599.917511] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.947s)
[600.306240] Starting dynamic subtest: pipe-C-eDP-1
[603.229176] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.931s)
[603.617443] Starting dynamic subtest: pipe-D-eDP-1
[606.469330] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.861s)
[606.471721] Subtest crc-atomic: SUCCESS (13.198s)
[607.639605] [102/133] (414s left) kms_psr (fbc-pr-cursor-render)
[607.747283] Starting subtest: fbc-pr-cursor-render
[607.751297] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[607.821057] [103/133] (414s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[607.938508] Starting subtest: basic-busy-flip-before-cursor-varying-size
[607.942807] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[608.086421] [104/133] (413s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[608.181456] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[614.918121] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.741s)
[615.080874] [105/133] (406s left) gem_exec_whisper (basic-contexts-priority)
[615.144858] Starting subtest: basic-contexts-priority
[638.729242] Subtest basic-contexts-priority: SUCCESS (23.583s)
[638.916933] [106/133] (383s left) kms_color (ctm-max)
[639.013098] Starting subtest: ctm-max
[639.015398] Starting dynamic subtest: pipe-A-eDP-1
[639.722002] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[639.732028] Starting dynamic subtest: pipe-B-eDP-1
[641.187865] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s)
[641.198195] Starting dynamic subtest: pipe-C-eDP-1
[642.591129] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.400s)
[642.611439] Starting dynamic subtest: pipe-D-eDP-1
[643.917675] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[643.919576] Subtest ctm-max: SUCCESS (4.904s)
[644.727438] [107/133] (377s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[644.822385] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[651.729967] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.907s)
[651.892506] [108/133] (370s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[651.990343] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[651.992591] Starting dynamic subtest: pipe-A-eDP-1
[668.654693] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.152s)
[668.666079] Starting dynamic subtest: pipe-B-eDP-1
[685.644498] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s)
[685.656832] Starting dynamic subtest: pipe-C-eDP-1
[702.599204] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[702.626489] Starting dynamic subtest: pipe-D-eDP-1
[719.603144] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.367s)
[719.605712] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.405s)
[720.826202] [109/133] (301s left) kms_psr (fbc-pr-sprite-plane-move)
[720.940105] Starting subtest: fbc-pr-sprite-plane-move
[720.944950] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[721.015740] [110/133] (301s left) kms_pm_rpm (basic-rte)
[721.059607] Starting subtest: basic-rte
[724.025329] Subtest basic-rte: SUCCESS (2.965s)
[725.968246] [111/133] (296s left) gem_ctx_shared (q-out-order)
[726.035732] Starting subtest: Q-out-order
[726.038297] Starting dynamic subtest: rcs0
[726.164069] Dynamic subtest rcs0: SUCCESS (0.125s)
[726.177737] Starting dynamic subtest: vcs0
[726.263904] Dynamic subtest vcs0: SUCCESS (0.099s)
[726.276642] Starting dynamic subtest: vcs1
[726.358144] Dynamic subtest vcs1: SUCCESS (0.094s)
[726.378405] Starting dynamic subtest: vecs0
[726.442102] Dynamic subtest vecs0: SUCCESS (0.082s)
[726.461341] Starting dynamic subtest: ccs0
[726.527952] Dynamic subtest ccs0: SUCCESS (0.084s)
[726.531072] Subtest Q-out-order: SUCCESS (0.492s)
[727.425204] [112/133] (294s left) kms_big_fb (linear-8bpp-rotate-0)
[727.518165] Starting subtest: linear-8bpp-rotate-0
[728.765685] Subtest linear-8bpp-rotate-0: SUCCESS (1.248s)
[728.867653] [113/133] (293s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[728.963130] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[728.966790] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[729.052717] [114/133] (293s left) gem_softpin (evict-prime-sanity-check)
[729.110564] Starting subtest: evict-prime-sanity-check
[729.113106] Starting dynamic subtest: rcs0
[730.252357] Dynamic subtest rcs0: SUCCESS (1.141s)
[730.265681] Starting dynamic subtest: bcs0
[731.369157] Dynamic subtest bcs0: SUCCESS (1.116s)
[731.381904] Starting dynamic subtest: vcs0
[733.338894] Dynamic subtest vcs0: SUCCESS (1.967s)
[733.350715] Starting dynamic subtest: vcs1
[735.303433] Dynamic subtest vcs1: SUCCESS (1.961s)
[735.317302] Starting dynamic subtest: vecs0
[737.305458] Dynamic subtest vecs0: SUCCESS (2.000s)
[737.316192] Starting dynamic subtest: ccs0
[738.421039] Dynamic subtest ccs0: SUCCESS (1.114s)
[738.430862] Starting dynamic subtest: all
[739.539456] Dynamic subtest all: SUCCESS (1.116s)
[739.542067] Subtest evict-prime-sanity-check: SUCCESS (10.428s)
[739.622034] [115/133] (282s left) dmabuf_sync_file (export-multiwait)
[739.672177] Starting subtest: export-multiwait
[739.674910] Subtest export-multiwait: SUCCESS (0.000s)
[739.732958] [116/133] (282s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[739.837890] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[747.155898] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.320s)
[747.272560] [117/133] (275s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[747.376392] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[747.381691] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[747.451532] [118/133] (275s left) gem_create (create-ext-set-pat)
[747.625819] Starting subtest: create-ext-set-pat
[747.629014] Subtest create-ext-set-pat: SUCCESS (0.001s)
[747.737495] [119/133] (274s left) prime_vgem (busy)
[747.802788] Starting subtest: busy
[747.805168] Starting dynamic subtest: rcs0
[747.871453] Dynamic subtest rcs0: SUCCESS (0.072s)
[747.883335] Starting dynamic subtest: bcs0
[747.938281] Dynamic subtest bcs0: SUCCESS (0.066s)
[747.949139] Starting dynamic subtest: vcs0
[747.988970] Dynamic subtest vcs0: SUCCESS (0.048s)
[747.999318] Starting dynamic subtest: vcs1
[748.039588] Dynamic subtest vcs1: SUCCESS (0.048s)
[748.049869] Starting dynamic subtest: vecs0
[748.088096] Dynamic subtest vecs0: SUCCESS (0.048s)
[748.098170] Starting dynamic subtest: ccs0
[748.135483] Dynamic subtest ccs0: SUCCESS (0.045s)
[748.137810] Subtest busy: SUCCESS (0.337s)
[748.262356] [120/133] (274s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[748.349540] Starting subtest: x-tiled-64bpp-rotate-90
[748.369824] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[748.476920] [121/133] (274s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[748.579190] Starting subtest: 4-tiled-32bpp-rotate-180
[749.957980] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.381s)
[750.094530] [122/133] (272s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[750.153928] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[750.214704] [123/133] (272s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[750.305719] Starting subtest: yf-tiled-32bpp-rotate-90
[750.310551] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[750.404666] [124/133] (272s left) gem_mmap_wc (write-prefaulted)
[750.458959] Subtest write-prefaulted: SKIP (0.000s)
[750.520593] [125/133] (272s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[750.632962] Starting subtest: cursorA-vs-flipA-legacy
[761.773932] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.136s)
[762.600743] [126/133] (260s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[762.726836] Starting subtest: 2x-long-flip-vs-cursor-legacy
[762.731935] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[762.870438] [127/133] (259s left) gem_mmap_gtt (big-bo)
[762.931669] Subtest big-bo: SKIP (0.000s)
[762.999942] [128/133] (259s left) gem_exercise_blt (fast-copy-emit)
[763.053855] Starting subtest: fast-copy-emit
[763.056491] Starting dynamic subtest: linear-smem-smem-emit
[763.077923] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[763.088916] Starting dynamic subtest: xmajor-smem-smem-emit
[763.095168] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[763.105932] Starting dynamic subtest: tile4-smem-smem-emit
[763.111146] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[763.120585] Starting dynamic subtest: tile64-smem-smem-emit
[763.127699] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[763.130003] Subtest fast-copy-emit: SUCCESS (0.074s)
[763.262198] [129/133] (259s left) perf (gen8-unprivileged-single-ctx-counters)
[763.392640] Starting subtest: gen8-unprivileged-single-ctx-counters
[763.397336] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[763.436432] [130/133] (259s left) gem_exec_reloc (basic-cpu-read)
[763.490452] Subtest basic-cpu-read: SKIP (0.000s)
[763.564540] [131/133] (259s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[763.670502] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[763.674998] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[763.763626] [132/133] (259s left) i915_pm_rps (thresholds-idle-park)
[763.823655] Starting subtest: thresholds-idle-park
[763.828454] Subtest thresholds-idle-park: SKIP (0.001s)
[763.931600] [133/133] (259s left) gem_exec_params (rsvd2-dirt)
[763.994984] Starting subtest: rsvd2-dirt
[763.998811] Subtest rsvd2-dirt: SKIP (0.000s)
[764.090155] 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.