[59.782456] Initializing watchdogs
[59.782503]   /dev/watchdog0
[59.797093] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.801657] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.804064] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.807330] [001/133] (960s left) gem_mmap_gtt (basic-read-write)
[59.898216] Subtest basic-read-write: SKIP (0.000s)
[59.957202] [002/133] (960s left) kms_plane (pixel-format-linear-modifier)
[60.047962] Starting subtest: pixel-format-linear-modifier
[60.085269] Starting dynamic subtest: pipe-A-plane-0
[63.578349] Dynamic subtest pipe-A-plane-0: SUCCESS (3.478s)
[63.587586] Starting dynamic subtest: pipe-A-plane-3
[65.272551] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[65.280583] Starting dynamic subtest: pipe-A-plane-5
[65.484170] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[66.587594] Starting dynamic subtest: pipe-B-plane-0
[70.331458] Dynamic subtest pipe-B-plane-0: SUCCESS (3.744s)
[70.340883] Starting dynamic subtest: pipe-B-plane-3
[72.012065] Dynamic subtest pipe-B-plane-3: SUCCESS (1.678s)
[72.023627] Starting dynamic subtest: pipe-B-plane-5
[72.222716] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[72.542600] Subtest pixel-format-linear-modifier: SUCCESS (12.461s)
[73.393305] [003/133] (947s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[73.506709] Starting subtest: y-tiled-8bpp-rotate-270
[73.510895] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[73.621016] [004/133] (946s left) syncobj_wait (single-wait-for-submit-signaled)
[73.684260] Starting subtest: single-wait-for-submit-signaled
[73.686244] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[73.783070] [005/133] (946s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[73.933337] Starting subtest: flip-vs-cursor-atomic
[81.166862] Subtest flip-vs-cursor-atomic: SUCCESS (7.226s)
[82.020936] [006/133] (938s left) kms_chamelium_frames (hdmi-crc-fast)
[82.416395] Subtest hdmi-crc-fast: SKIP (0.000s)
[83.220267] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[83.328604] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[83.332654] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[83.448501] [008/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[83.543268] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[83.547315] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[83.670469] [009/133] (936s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[83.782142] Starting subtest: fbc-rgb101010-draw-blt
[88.362218] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.580s)
[89.560383] [010/133] (931s left) kms_dp_linktrain_fallback (dsc-fallback)
[89.683441] Starting subtest: dsc-fallback
[89.690015] Subtest dsc-fallback: SKIP (0.000s)
[89.769496] [011/133] (930s left) gem_exec_balancer (fairslice)
[89.834696] Starting subtest: fairslice
[92.813258] Subtest fairslice: SUCCESS (2.977s)
[93.963656] [012/133] (926s left) gem_eio (in-flight-immediate)
[94.221214] Starting subtest: in-flight-immediate
[102.999770] Subtest in-flight-immediate: SUCCESS (8.775s)
[103.198502] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[103.201741] [013/133] (917s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[103.255420] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[103.257698] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[103.354242] [014/133] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[103.454063] Starting subtest: fbcpsr-2p-rte
[103.458048] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[103.574311] [015/133] (917s left) kms_psr (psr2-cursor-mmap-cpu)
[103.673638] Starting subtest: psr2-cursor-mmap-cpu
[103.675924] Starting dynamic subtest: eDP-1
[105.402633] Dynamic subtest eDP-1: SUCCESS (1.728s)
[105.405087] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.729s)
[106.211954] [016/133] (914s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[106.304148] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[112.916548] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.612s)
[113.040506] [017/133] (907s left) sw_sync (sync_multi_consumer_producer)
[113.088770] Starting subtest: sync_multi_consumer_producer
[113.402641] Subtest sync_multi_consumer_producer: SUCCESS (0.290s)
[113.460361] [018/133] (907s left) kms_setmode (basic)
[113.520947] Starting subtest: basic
[113.850503] Starting dynamic subtest: pipe-A-eDP-1
[115.944850] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.089s)
[116.286325] Starting dynamic subtest: pipe-B-eDP-1
[118.377240] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.093s)
[118.687550] Subtest basic: SUCCESS (5.163s)
[119.532452] [019/133] (901s left) kms_psr (fbc-psr-primary-render)
[119.638020] Starting subtest: fbc-psr-primary-render
[119.639933] Starting dynamic subtest: eDP-1
[119.644086] Dynamic subtest eDP-1: SKIP (0.000s)
[119.648197] Subtest fbc-psr-primary-render: SKIP (0.001s)
[119.723028] [020/133] (901s left) kms_psr (psr-cursor-plane-move)
[119.823873] Starting subtest: psr-cursor-plane-move
[119.826314] Starting dynamic subtest: eDP-1
[121.514587] Dynamic subtest eDP-1: SUCCESS (1.693s)
[121.516765] Subtest psr-cursor-plane-move: SUCCESS (1.693s)
[122.389544] [021/133] (898s left) kms_pipe_crc_basic (suspend-read-crc)
[122.476272] Starting subtest: suspend-read-crc
[122.478650] Starting dynamic subtest: pipe-A-eDP-1
[139.998457] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.744s)
[140.009294] Starting dynamic subtest: pipe-B-eDP-1
[157.935064] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.105s)
[157.945559] Starting dynamic subtest: pipe-C-eDP-1
[175.892214] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.019s)
[175.905366] Starting dynamic subtest: pipe-D-eDP-1
[193.897396] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.072s)
[193.899885] Subtest suspend-read-crc: SUCCESS (11.946s)
[194.784974] [022/133] (826s left) kms_flip (flip-vs-dpms-on-nop)
[194.895502] Starting subtest: flip-vs-dpms-on-nop
[194.897934] Starting dynamic subtest: A-eDP1
[196.806048] Dynamic subtest A-eDP1: SUCCESS (1.860s)
[196.815811] Starting dynamic subtest: B-eDP1
[198.688528] Dynamic subtest B-eDP1: SUCCESS (1.842s)
[198.697940] Starting dynamic subtest: C-eDP1
[200.538484] Dynamic subtest C-eDP1: SUCCESS (1.819s)
[200.549206] Starting dynamic subtest: D-eDP1
[202.383120] Dynamic subtest D-eDP1: SUCCESS (1.819s)
[202.385463] Subtest flip-vs-dpms-on-nop: SUCCESS (7.348s)
[203.583783] [023/133] (817s left) gem_bad_reloc (negative-reloc-bltcopy)
[203.640753] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[203.723883] [024/133] (817s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[203.783769] Starting subtest: invalid-single-wait-all-unsubmitted
[203.786027] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[203.901063] [025/133] (817s left) gem_ccs (block-multicopy-compressed)
[203.966504] Starting subtest: block-multicopy-compressed
[203.970947] Subtest block-multicopy-compressed: SKIP (0.000s)
[204.098697] [026/133] (817s left) gen9_exec_parse (unaligned-jump)
[204.174674] Subtest unaligned-jump: SKIP (0.000s)
[204.265056] [027/133] (817s left) perf_pmu (multi-client)
[204.303238] Starting subtest: multi-client
[204.305506] Starting dynamic subtest: rcs0
[205.386933] Dynamic subtest rcs0: SUCCESS (1.073s)
[205.398801] Starting dynamic subtest: bcs0
[206.445138] Dynamic subtest bcs0: SUCCESS (1.048s)
[206.456882] Starting dynamic subtest: vcs0
[207.506025] Dynamic subtest vcs0: SUCCESS (1.052s)
[207.517857] Starting dynamic subtest: vcs1
[209.080218] Dynamic subtest vcs1: SUCCESS (1.564s)
[209.092293] Starting dynamic subtest: vecs0
[211.124954] Dynamic subtest vecs0: SUCCESS (2.033s)
[211.136412] Starting dynamic subtest: ccs0
[213.109093] Dynamic subtest ccs0: SUCCESS (1.975s)
[213.111918] Subtest multi-client: SUCCESS (8.757s)
[213.252773] [028/133] (808s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[213.368077] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[217.534195] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.156s)
[218.683207] [029/133] (802s left) gem_exec_schedule (fairslice-all)
[218.761735] Starting subtest: fairslice-all
[220.815355] Subtest fairslice-all: SUCCESS (2.059s)
[222.125472] [030/133] (799s left) kms_joiner (basic-max-non-joiner)
[222.238323] Starting subtest: basic-max-non-joiner
[222.242431] Subtest basic-max-non-joiner: SKIP (0.000s)
[222.316555] [031/133] (799s left) prime_vgem (coherency-gtt)
[222.398223] Starting subtest: coherency-gtt
[222.402867] Subtest coherency-gtt: SKIP (0.000s)
[222.518202] [032/133] (799s left) gem_exec_create (madvise)
[222.610066] Starting subtest: madvise
[222.612361] Starting dynamic subtest: smem
[244.154228] Dynamic subtest smem: SUCCESS (21.543s)
[244.157515] Subtest madvise: SUCCESS (21.543s)
[244.943047] [033/133] (776s left) gem_exec_fence (syncobj-repeat)
[245.418391] Starting subtest: syncobj-repeat
[245.604802] Subtest syncobj-repeat: SUCCESS (0.188s)
[247.196881] [034/133] (774s left) api_intel_bb (blit-noreloc-keep-cache)
[247.249386] Starting subtest: blit-noreloc-keep-cache
[247.264320] Subtest blit-noreloc-keep-cache: SUCCESS (0.017s)
[247.411181] [035/133] (774s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[247.478515] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[247.558662] [036/133] (774s left) gem_workarounds (basic-read)
[247.615107] Starting subtest: basic-read
[247.635659] Subtest basic-read: SUCCESS (0.021s)
[247.795377] [037/133] (773s left) prime_mmap (test_correct_cpu_write)
[247.854726] Starting subtest: test_correct_cpu_write
[247.857030] Starting dynamic subtest: test_correct_cpu_write-smem
[247.859180] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[247.861267] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[247.989686] [038/133] (773s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[248.093251] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[248.095494] Starting dynamic subtest: pipe-A-eDP-1
[248.117021] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[248.128174] Starting dynamic subtest: pipe-B-eDP-1
[248.145908] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[248.154277] Starting dynamic subtest: pipe-C-eDP-1
[248.171384] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[248.179868] Starting dynamic subtest: pipe-D-eDP-1
[248.197648] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[248.200921] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.006s)
[250.270708] [039/133] (771s left) gen9_exec_parse (bb-oversize)
[250.346838] Subtest bb-oversize: SKIP (0.000s)
[250.418244] [040/133] (771s left) gem_exec_schedule (pi-userfault)
[250.594706] Starting subtest: pi-userfault
[250.596848] Starting dynamic subtest: rcs0
[250.604721] Dynamic subtest rcs0: SUCCESS (0.012s)
[250.614364] Starting dynamic subtest: bcs0
[250.616636] Dynamic subtest bcs0: SUCCESS (0.009s)
[250.626672] Starting dynamic subtest: vcs0
[250.628664] Dynamic subtest vcs0: SUCCESS (0.009s)
[250.638442] Starting dynamic subtest: vcs1
[250.640616] Dynamic subtest vcs1: SUCCESS (0.009s)
[250.650337] Starting dynamic subtest: vecs0
[250.652658] Dynamic subtest vecs0: SUCCESS (0.008s)
[250.661709] Starting dynamic subtest: ccs0
[250.663836] Dynamic subtest ccs0: SUCCESS (0.009s)
[250.665989] Subtest pi-userfault: SUCCESS (0.059s)
[250.859204] [041/133] (771s left) kms_dsc (dsc-with-bpc)
[250.964036] Starting subtest: dsc-with-bpc
[250.994941] Subtest dsc-with-bpc: SKIP (0.001s)
[251.050704] [042/133] (770s left) kms_cursor_crc (cursor-offscreen-512x512)
[251.346553] Starting subtest: cursor-offscreen-512x512
[251.350847] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[251.542150] [043/133] (770s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[251.647639] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[251.651290] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[251.728313] [044/133] (770s left) vgem_basic (bad-fence)
[251.767995] Starting subtest: bad-fence
[251.769952] Subtest bad-fence: SUCCESS (0.000s)
[251.836951] [045/133] (770s left) gem_render_copy (yf-tiled-to-vebox-linear)
[251.900417] Starting subtest: yf-tiled-to-vebox-linear
[251.904352] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[252.108839] [046/133] (770s left) gem_eio (in-flight-internal-immediate)
[252.332951] Starting subtest: in-flight-internal-immediate
[254.152259] Subtest in-flight-internal-immediate: SUCCESS (1.818s)
[254.332152] [047/133] (767s left) kms_flip (blocking-absolute-wf_vblank)
[254.415762] Starting subtest: blocking-absolute-wf_vblank
[254.417923] Starting dynamic subtest: A-eDP1
[263.125052] Dynamic subtest A-eDP1: SUCCESS (8.706s)
[263.134475] Starting dynamic subtest: B-eDP1
[271.849313] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[271.860396] Starting dynamic subtest: C-eDP1
[280.576341] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[280.592552] Starting dynamic subtest: D-eDP1
[289.315135] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[289.319808] Subtest blocking-absolute-wf_vblank: SUCCESS (34.893s)
[290.547148] [048/133] (731s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[290.655394] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[290.657564] Starting dynamic subtest: pipe-A-eDP-1
[290.679179] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.689232] Starting dynamic subtest: pipe-B-eDP-1
[290.710367] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.719254] Starting dynamic subtest: pipe-C-eDP-1
[290.739717] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.748644] Starting dynamic subtest: pipe-D-eDP-1
[290.769645] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.773507] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[292.899652] [049/133] (729s left) kms_properties (connector-properties-legacy)
[293.004267] Starting subtest: connector-properties-legacy
[293.006475] Starting dynamic subtest: pipe-A-eDP-1
[300.861929] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.858s)
[300.872266] Starting dynamic subtest: pipe-None-DP-1
[300.876635] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[300.885527] Starting dynamic subtest: pipe-None-HDMI-A-1
[300.889668] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[300.898441] Starting dynamic subtest: pipe-None-DP-2
[300.902702] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[300.911542] Starting dynamic subtest: pipe-None-HDMI-A-2
[300.915667] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[300.924428] Starting dynamic subtest: pipe-None-DP-3
[300.928627] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[300.937762] Starting dynamic subtest: pipe-None-DP-4
[300.942388] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[300.944668] Subtest connector-properties-legacy: SUCCESS (7.870s)
[301.747546] [050/133] (720s left) perf_pmu (busy-hang)
[301.784376] Starting subtest: busy-hang
[301.786674] Starting dynamic subtest: rcs0
[303.075280] Dynamic subtest rcs0: SUCCESS (1.288s)
[303.093700] Starting dynamic subtest: bcs0
[304.324334] Dynamic subtest bcs0: SUCCESS (1.248s)
[304.334735] Starting dynamic subtest: vcs0
[306.629985] Dynamic subtest vcs0: SUCCESS (2.303s)
[306.639151] Starting dynamic subtest: vcs1
[308.545307] Dynamic subtest vcs1: SUCCESS (1.914s)
[308.556102] Starting dynamic subtest: vecs0
[310.591694] Dynamic subtest vecs0: SUCCESS (2.047s)
[310.607254] Starting dynamic subtest: ccs0
[311.837685] Dynamic subtest ccs0: SUCCESS (1.244s)
[311.840323] Subtest busy-hang: SUCCESS (10.057s)
[311.968164] [051/133] (710s left) kms_vblank (ts-continuation-modeset-rpm)
[312.059288] Starting subtest: ts-continuation-modeset-rpm
[312.061477] Starting dynamic subtest: pipe-A-eDP-1
[314.548770] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.489s)
[314.568155] Starting dynamic subtest: pipe-D-eDP-1
[316.809046] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.257s)
[316.811431] Subtest ts-continuation-modeset-rpm: SUCCESS (4.751s)
[317.700860] [052/133] (704s left) syncobj_wait (single-wait-for-submit-submitted)
[317.767898] Starting subtest: single-wait-for-submit-submitted
[317.877910] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[317.977537] [053/133] (704s left) kms_universal_plane (cursor-fb-leak)
[318.080668] Starting subtest: cursor-fb-leak
[318.082837] Starting dynamic subtest: pipe-A-eDP-1
[318.405666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.326s)
[318.417672] Starting dynamic subtest: pipe-B-eDP-1
[319.707478] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.299s)
[319.719753] Starting dynamic subtest: pipe-C-eDP-1
[321.042774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.333s)
[321.057606] Starting dynamic subtest: pipe-D-eDP-1
[322.363659] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[322.366059] Subtest cursor-fb-leak: SUCCESS (4.285s)
[323.547160] [054/133] (698s left) gem_exec_schedule (smoketest)
[323.730802] Starting subtest: smoketest
[323.733205] Starting dynamic subtest: rcs0
[329.287875] Dynamic subtest rcs0: SUCCESS (5.512s)
[329.303571] Starting dynamic subtest: bcs0
[334.820942] Dynamic subtest bcs0: SUCCESS (5.532s)
[334.832308] Starting dynamic subtest: vcs0
[340.334551] Dynamic subtest vcs0: SUCCESS (5.504s)
[340.346272] Starting dynamic subtest: vcs1
[345.835341] Dynamic subtest vcs1: SUCCESS (5.505s)
[345.846255] Starting dynamic subtest: vecs0
[351.336662] Dynamic subtest vecs0: SUCCESS (5.495s)
[351.352298] Starting dynamic subtest: ccs0
[356.839479] Dynamic subtest ccs0: SUCCESS (5.499s)
[356.841554] Subtest smoketest: SUCCESS (33.059s)
[356.989901] [055/133] (665s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[357.105232] Starting subtest: x-tiled-addfb-size-offset-overflow
[357.107437] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[357.226190] [056/133] (665s left) kms_atomic_transition (plane-all-transition-nonblocking)
[357.324287] Starting subtest: plane-all-transition-nonblocking
[357.326768] Starting dynamic subtest: pipe-A-eDP-1
[359.822183] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[360.129674] Starting dynamic subtest: pipe-B-eDP-1
[363.357418] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.237s)
[363.654933] Subtest plane-all-transition-nonblocking: SUCCESS (6.330s)
[364.504799] [057/133] (658s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[364.568218] Starting subtest: single-wait-for-submit-unsubmitted
[364.668573] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[364.759295] [058/133] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[364.856072] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[364.860163] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[365.002053] [059/133] (657s left) kms_flip (absolute-wf_vblank)
[365.102399] Starting subtest: absolute-wf_vblank
[365.104738] Starting dynamic subtest: A-eDP1
[373.835669] Dynamic subtest A-eDP1: SUCCESS (8.729s)
[373.847685] Starting dynamic subtest: B-eDP1
[382.569884] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[382.579645] Starting dynamic subtest: C-eDP1
[391.290980] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[391.301812] Starting dynamic subtest: D-eDP1
[400.030774] Dynamic subtest D-eDP1: SUCCESS (8.737s)
[400.033106] Subtest absolute-wf_vblank: SUCCESS (34.922s)
[401.256517] [060/133] (621s left) gem_ctx_persistence (heartbeat-hostile)
[401.319950] Starting subtest: heartbeat-hostile
[401.324674] Subtest heartbeat-hostile: SKIP (0.000s)
[401.449221] [061/133] (621s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[401.511544] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[401.613566] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.102s)
[401.703539] [062/133] (621s left) gem_exec_params (dr1-dirt)
[401.772004] Starting subtest: DR1-dirt
[401.774409] Subtest DR1-dirt: SUCCESS (0.000s)
[401.913657] [063/133] (620s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[402.006793] Starting subtest: addfb25-yf-tiled-legacy
[402.008645] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[402.113832] [064/133] (620s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[402.211908] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[402.214222] Starting dynamic subtest: pipe-A-eDP-1
[402.237213] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[402.247739] Starting dynamic subtest: pipe-B-eDP-1
[402.268931] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[402.277997] Starting dynamic subtest: pipe-C-eDP-1
[402.298644] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[402.307348] Starting dynamic subtest: pipe-D-eDP-1
[402.328019] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[402.332212] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[404.516724] [065/133] (618s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[404.572288] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[404.574549] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[404.693494] [066/133] (618s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[404.790769] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[404.795128] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[404.873504] [067/133] (618s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[405.102500] Starting subtest: cursor-rapid-movement-128x128
[405.107399] Starting dynamic subtest: pipe-A-eDP-1
[405.668858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[405.697171] Starting dynamic subtest: pipe-D-eDP-1
[406.904293] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[406.906663] Subtest cursor-rapid-movement-128x128: SUCCESS (1.801s)
[407.767578] [068/133] (615s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[407.876923] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[407.880949] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[408.000994] [069/133] (615s left) i915_hangman (detector)
[408.077573] Starting subtest: detector
[408.079819] Starting dynamic subtest: rcs0
[420.054876] Dynamic subtest rcs0: SUCCESS (11.976s)
[420.066598] Starting dynamic subtest: bcs0
[432.023538] Dynamic subtest bcs0: SUCCESS (11.969s)
[432.035677] Starting dynamic subtest: vcs0
[443.991973] Dynamic subtest vcs0: SUCCESS (11.966s)
[444.004329] Starting dynamic subtest: vcs1
[456.022736] Dynamic subtest vcs1: SUCCESS (12.029s)
[456.037391] Starting dynamic subtest: vecs0
[467.991492] Dynamic subtest vecs0: SUCCESS (11.966s)
[468.002522] Starting dynamic subtest: ccs0
[479.064171] Dynamic subtest ccs0: SUCCESS (11.069s)
[479.067281] Subtest detector: SUCCESS (70.990s)
[479.159378] [070/133] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[479.276342] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[486.250506] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.977s)
[486.392981] [071/133] (536s left) core_auth (getclient-simple)
[486.427249] Starting subtest: getclient-simple
[486.454285] Subtest getclient-simple: SUCCESS (0.025s)
[486.573494] [072/133] (536s left) kms_properties (colorop-properties-legacy)
[486.666890] Starting subtest: colorop-properties-legacy
[486.668812] Starting dynamic subtest: pipe-A-eDP-1
[487.027118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[487.037627] Starting dynamic subtest: pipe-B-eDP-1
[488.116431] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[488.127264] Starting dynamic subtest: pipe-C-eDP-1
[489.141568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.021s)
[489.152127] Starting dynamic subtest: pipe-D-eDP-1
[490.192515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.051s)
[490.194903] Subtest colorop-properties-legacy: SUCCESS (3.526s)
[491.006765] [073/133] (532s left) gem_ctx_param (invalid-get-engines)
[491.059658] Starting subtest: invalid-get-engines
[491.062014] Subtest invalid-get-engines: SUCCESS (0.001s)
[491.190365] [074/133] (532s left) kms_prop_blob (basic)
[491.256071] Starting subtest: basic
[491.258042] Subtest basic: SUCCESS (0.000s)
[491.376952] [075/133] (532s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[491.500029] Starting subtest: cursorB-vs-flipA-toggle
[491.504651] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[491.669727] [076/133] (531s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[491.765751] Starting subtest: plane-scaler-unity-scaling-with-rotation
[491.767678] Starting dynamic subtest: pipe-A
[491.991667] Dynamic subtest pipe-A: SUCCESS (0.229s)
[492.001495] Starting dynamic subtest: pipe-B
[493.275618] Dynamic subtest pipe-B: SUCCESS (1.283s)
[493.286068] Starting dynamic subtest: pipe-C
[494.612651] Dynamic subtest pipe-C: SUCCESS (1.336s)
[494.623131] Starting dynamic subtest: pipe-D
[495.955748] Dynamic subtest pipe-D: SUCCESS (1.342s)
[495.958043] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.193s)
[497.138292] [077/133] (526s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[497.241973] Starting subtest: extended-modeset-hang-oldfb-with-reset
[497.244389] Starting dynamic subtest: pipe-A
[509.208945] Dynamic subtest pipe-A: SUCCESS (11.965s)
[509.219332] Starting dynamic subtest: pipe-D
[521.489424] Dynamic subtest pipe-D: SUCCESS (12.275s)
[521.491819] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.245s)
[522.293240] [078/133] (501s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[522.419326] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[522.423403] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[522.542356] [079/133] (501s left) kms_plane_scaling (planes-upscale-20x20)
[522.648077] Starting subtest: planes-upscale-20x20
[522.650330] Starting dynamic subtest: pipe-A
[522.709796] Dynamic subtest pipe-A: SUCCESS (0.063s)
[522.720221] Starting dynamic subtest: pipe-B
[523.815750] Dynamic subtest pipe-B: SUCCESS (1.105s)
[523.828195] Starting dynamic subtest: pipe-C
[524.934412] Dynamic subtest pipe-C: SUCCESS (1.117s)
[524.945088] Starting dynamic subtest: pipe-D
[526.074223] Dynamic subtest pipe-D: SUCCESS (1.139s)
[526.076640] Subtest planes-upscale-20x20: SUCCESS (3.427s)
[527.236877] [080/133] (496s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[527.345521] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[527.347754] Starting dynamic subtest: pipe-A-eDP-1
[528.089192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[528.098514] Starting dynamic subtest: pipe-B-eDP-1
[529.856295] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.765s)
[529.866831] Starting dynamic subtest: pipe-C-eDP-1
[531.686587] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.829s)
[531.697988] Starting dynamic subtest: pipe-D-eDP-1
[533.519042] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.831s)
[533.521334] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.166s)
[534.668385] [081/133] (488s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[534.777441] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[534.781666] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[534.882066] [082/133] (488s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[535.261152] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[536.071307] [083/133] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[536.173166] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[536.177308] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[536.292655] [084/133] (487s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[536.398328] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[536.400657] Starting dynamic subtest: A-eDP1
[540.001361] Dynamic subtest A-eDP1: SUCCESS (3.598s)
[540.012238] Starting dynamic subtest: B-eDP1
[543.191678] Dynamic subtest B-eDP1: SUCCESS (3.189s)
[543.202755] Starting dynamic subtest: C-eDP1
[546.278671] Dynamic subtest C-eDP1: SUCCESS (3.085s)
[546.289439] Starting dynamic subtest: D-eDP1
[549.381032] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[549.382879] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.980s)
[550.189233] [085/133] (473s left) gem_mmap_gtt (basic-read)
[550.249742] Subtest basic-read: SKIP (0.000s)
[550.308008] [086/133] (473s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[550.359137] Starting subtest: single-wait-for-submit-available-signaled
[550.361353] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[550.486062] [087/133] (473s left) gem_vm_create (isolation)
[550.545419] Starting subtest: isolation
[550.554757] Subtest isolation: SUCCESS (0.009s)
[550.712213] [088/133] (473s left) gem_mmap_gtt (hang-busy)
[550.770378] Subtest hang-busy: SKIP (0.000s)
[550.840619] [089/133] (473s left) kms_lease (lease-uevent)
[550.939336] Starting subtest: lease-uevent
[551.960913] Subtest lease-uevent: SUCCESS (1.021s)
[552.065763] [090/133] (471s left) gem_mmap_gtt (basic-short)
[552.129425] Subtest basic-short: SKIP (0.000s)
[552.195253] [091/133] (471s left) gem_mmap_gtt (cpuset-big-copy-xy)
[552.253890] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[552.320364] [092/133] (471s left) kms_scaling_modes (scaling-mode-full)
[552.419776] Starting subtest: scaling-mode-full
[552.422045] Starting dynamic subtest: pipe-A-eDP-1
[552.517665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[552.528424] Starting dynamic subtest: pipe-B-eDP-1
[553.714112] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s)
[553.725572] Starting dynamic subtest: pipe-C-eDP-1
[554.839060] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[554.849072] Starting dynamic subtest: pipe-D-eDP-1
[555.964883] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[555.967345] Subtest scaling-mode-full: SUCCESS (3.548s)
[557.132557] [093/133] (467s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[557.261927] Starting subtest: basic-flip-after-cursor-legacy
[558.177561] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.915s)
[559.054198] [094/133] (465s left) kms_flip (nonexisting-fb)
[559.151656] Starting subtest: nonexisting-fb
[559.153959] Starting dynamic subtest: A-eDP1
[560.330749] Dynamic subtest A-eDP1: SUCCESS (1.180s)
[560.341818] Starting dynamic subtest: B-eDP1
[561.467921] Dynamic subtest B-eDP1: SUCCESS (1.136s)
[561.480457] Starting dynamic subtest: C-eDP1
[562.601001] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[562.611683] Starting dynamic subtest: D-eDP1
[563.734060] Dynamic subtest D-eDP1: SUCCESS (1.132s)
[563.736488] Subtest nonexisting-fb: SUCCESS (4.587s)
[565.017161] [095/133] (459s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[565.084805] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[565.189327] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[565.281855] [096/133] (459s left) kms_content_protection (atomic-dpms)
[565.423343] Starting subtest: atomic-dpms
[565.428139] Subtest atomic-dpms: SKIP (0.000s)
[565.565264] [097/133] (458s left) gem_exec_capture (capture)
[565.625009] Starting subtest: capture
[565.627410] Starting dynamic subtest: rcs0-smem
[566.462485] Dynamic subtest rcs0-smem: SUCCESS (0.835s)
[566.473784] Starting dynamic subtest: bcs0-smem
[567.378326] Dynamic subtest bcs0-smem: SUCCESS (0.915s)
[567.390322] Starting dynamic subtest: vcs0-smem
[568.192956] Dynamic subtest vcs0-smem: SUCCESS (0.815s)
[568.205085] Starting dynamic subtest: vcs1-smem
[569.018804] Dynamic subtest vcs1-smem: SUCCESS (0.821s)
[569.028764] Starting dynamic subtest: vecs0-smem
[570.410096] Dynamic subtest vecs0-smem: FAIL (1.332s)
[570.421037] Starting dynamic subtest: ccs0-smem
[571.677829] Dynamic subtest ccs0-smem: SUCCESS (1.327s)
[571.680292] Subtest capture: FAIL (6.049s)
[571.832770] [098/133] (452s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[571.960959] Starting subtest: cursorB-vs-flipB-atomic
[571.965757] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[572.117026] [099/133] (452s left) gem_pxp (protected-raw-src-copy-not-readible)
[572.251568] Starting subtest: protected-raw-src-copy-not-readible
[572.313341] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.064s)
[572.479037] [100/133] (451s left) i915_pm_rc6_residency (rc6-fence)
[572.538739] Starting subtest: rc6-fence
[572.564156] Starting dynamic subtest: gt0
[584.883274] Dynamic subtest gt0: SUCCESS (12.316s)
[584.895905] Starting dynamic subtest: gt1
[600.057206] Dynamic subtest gt1: SUCCESS (15.166s)
[600.060397] Subtest rc6-fence: SUCCESS (27.515s)
[600.169190] [101/133] (424s left) kms_async_flips (crc-atomic)
[600.265522] Starting subtest: crc-atomic
[600.642724] Starting dynamic subtest: pipe-A-eDP-1
[603.512670] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.867s)
[603.893147] Starting dynamic subtest: pipe-B-eDP-1
[606.753108] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.867s)
[607.125772] Starting dynamic subtest: pipe-C-eDP-1
[609.982632] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.864s)
[610.360413] Starting dynamic subtest: pipe-D-eDP-1
[613.202856] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.851s)
[613.205192] Subtest crc-atomic: SUCCESS (12.935s)
[614.388022] [102/133] (410s left) kms_psr (fbc-pr-cursor-render)
[614.498720] Starting subtest: fbc-pr-cursor-render
[614.503208] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[614.603547] [103/133] (409s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[614.731660] Starting subtest: basic-busy-flip-before-cursor-varying-size
[614.736238] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[614.890157] [104/133] (409s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[614.978315] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[621.705133] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.729s)
[621.876462] [105/133] (402s left) gem_exec_whisper (basic-contexts-priority)
[621.950531] Starting subtest: basic-contexts-priority
[645.499653] Subtest basic-contexts-priority: SUCCESS (23.543s)
[645.699024] [106/133] (379s left) kms_color (ctm-max)
[645.802785] Starting subtest: ctm-max
[645.804928] Starting dynamic subtest: pipe-A-eDP-1
[646.543547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[646.554401] Starting dynamic subtest: pipe-B-eDP-1
[647.911872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s)
[647.922615] Starting dynamic subtest: pipe-C-eDP-1
[649.287455] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[649.298321] Starting dynamic subtest: pipe-D-eDP-1
[650.612517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[650.614488] Subtest ctm-max: SUCCESS (4.807s)
[651.431143] [107/133] (373s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[651.547975] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[658.430264] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.882s)
[658.606379] [108/133] (366s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[658.716167] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[658.718379] Starting dynamic subtest: pipe-A-eDP-1
[675.203716] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.478s)
[675.216830] Starting dynamic subtest: pipe-B-eDP-1
[692.202055] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.419s)
[692.214185] Starting dynamic subtest: pipe-C-eDP-1
[709.167832] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.334s)
[709.180245] Starting dynamic subtest: pipe-D-eDP-1
[726.162560] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.348s)
[726.165172] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.585s)
[727.448496] [109/133] (297s left) kms_psr (fbc-pr-sprite-plane-move)
[727.546285] Starting subtest: fbc-pr-sprite-plane-move
[727.550414] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[727.633222] [110/133] (297s left) kms_pm_rpm (basic-rte)
[727.676564] Starting subtest: basic-rte
[731.373632] Subtest basic-rte: SUCCESS (3.608s)
[735.845710] [111/133] (289s left) gem_ctx_shared (q-out-order)
[735.915640] Starting subtest: Q-out-order
[735.918040] Starting dynamic subtest: rcs0
[736.037832] Dynamic subtest rcs0: SUCCESS (0.119s)
[736.049570] Starting dynamic subtest: vcs0
[736.171588] Dynamic subtest vcs0: SUCCESS (0.131s)
[736.191915] Starting dynamic subtest: vcs1
[736.254203] Dynamic subtest vcs1: SUCCESS (0.080s)
[736.273751] Starting dynamic subtest: vecs0
[736.332473] Dynamic subtest vecs0: SUCCESS (0.077s)
[736.351581] Starting dynamic subtest: ccs0
[736.415807] Dynamic subtest ccs0: SUCCESS (0.082s)
[736.418990] Subtest Q-out-order: SUCCESS (0.495s)
[737.892043] [112/133] (287s left) kms_big_fb (linear-8bpp-rotate-0)
[738.010478] Starting subtest: linear-8bpp-rotate-0
[739.266970] Subtest linear-8bpp-rotate-0: SUCCESS (1.246s)
[739.422877] [113/133] (285s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[739.550272] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[739.553863] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[739.689984] [114/133] (285s left) gem_softpin (evict-prime-sanity-check)
[739.745237] Starting subtest: evict-prime-sanity-check
[739.747230] Starting dynamic subtest: rcs0
[740.920960] Dynamic subtest rcs0: SUCCESS (1.167s)
[740.932733] Starting dynamic subtest: bcs0
[742.079792] Dynamic subtest bcs0: SUCCESS (1.150s)
[742.093246] Starting dynamic subtest: vcs0
[743.749600] Dynamic subtest vcs0: SUCCESS (1.658s)
[743.762621] Starting dynamic subtest: vcs1
[745.752502] Dynamic subtest vcs1: SUCCESS (1.993s)
[745.765604] Starting dynamic subtest: vecs0
[747.734247] Dynamic subtest vecs0: SUCCESS (1.973s)
[747.747730] Starting dynamic subtest: ccs0
[748.881251] Dynamic subtest ccs0: SUCCESS (1.143s)
[748.894473] Starting dynamic subtest: all
[750.017621] Dynamic subtest all: SUCCESS (1.131s)
[750.020346] Subtest evict-prime-sanity-check: SUCCESS (10.231s)
[750.115540] [115/133] (274s left) dmabuf_sync_file (export-multiwait)
[750.161901] Starting subtest: export-multiwait
[750.164201] Subtest export-multiwait: SUCCESS (0.000s)
[750.246801] [116/133] (274s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[750.355442] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[757.716379] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.353s)
[757.841415] [117/133] (267s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[757.936746] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[757.940772] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[758.033215] [118/133] (267s left) gem_create (create-ext-set-pat)
[758.219197] Starting subtest: create-ext-set-pat
[758.221883] Subtest create-ext-set-pat: SUCCESS (0.001s)
[758.356381] [119/133] (266s left) prime_vgem (busy)
[758.450261] Starting subtest: busy
[758.452735] Starting dynamic subtest: rcs0
[758.550297] Dynamic subtest rcs0: SUCCESS (0.100s)
[758.562704] Starting dynamic subtest: bcs0
[758.628434] Dynamic subtest bcs0: SUCCESS (0.077s)
[758.638557] Starting dynamic subtest: vcs0
[758.677991] Dynamic subtest vcs0: SUCCESS (0.049s)
[758.687971] Starting dynamic subtest: vcs1
[758.724271] Dynamic subtest vcs1: SUCCESS (0.045s)
[758.734181] Starting dynamic subtest: vecs0
[758.772005] Dynamic subtest vecs0: SUCCESS (0.047s)
[758.782234] Starting dynamic subtest: ccs0
[758.818864] Dynamic subtest ccs0: SUCCESS (0.046s)
[758.821132] Subtest busy: SUCCESS (0.369s)
[758.974699] [120/133] (266s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[759.091892] Starting subtest: x-tiled-64bpp-rotate-90
[759.111533] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[759.260762] [121/133] (266s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[759.371322] Starting subtest: 4-tiled-32bpp-rotate-180
[760.729396] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.356s)
[760.897244] [122/133] (264s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[760.952594] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[761.020592] [123/133] (264s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[761.125073] Starting subtest: yf-tiled-32bpp-rotate-90
[761.128655] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[761.255424] [124/133] (264s left) gem_mmap_wc (write-prefaulted)
[761.323369] Subtest write-prefaulted: SKIP (0.000s)
[761.396448] [125/133] (264s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[761.518131] Starting subtest: cursorA-vs-flipA-legacy
[772.640865] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.115s)
[773.472392] [126/133] (252s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[773.600501] Starting subtest: 2x-long-flip-vs-cursor-legacy
[773.605074] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[773.767868] [127/133] (251s left) gem_mmap_gtt (big-bo)
[773.836907] Subtest big-bo: SKIP (0.000s)
[773.904840] [128/133] (251s left) gem_exercise_blt (fast-copy-emit)
[773.954011] Starting subtest: fast-copy-emit
[773.956321] Starting dynamic subtest: linear-smem-smem-emit
[773.975034] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[773.986589] Starting dynamic subtest: xmajor-smem-smem-emit
[773.991958] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[774.001819] Starting dynamic subtest: tile4-smem-smem-emit
[774.009764] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[774.019514] Starting dynamic subtest: tile64-smem-smem-emit
[774.026788] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[774.029157] Subtest fast-copy-emit: SUCCESS (0.073s)
[774.179061] [129/133] (251s left) perf (gen8-unprivileged-single-ctx-counters)
[774.299602] Starting subtest: gen8-unprivileged-single-ctx-counters
[774.304249] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[774.352434] [130/133] (251s left) gem_exec_reloc (basic-cpu-read)
[774.414020] Subtest basic-cpu-read: SKIP (0.000s)
[774.494922] [131/133] (251s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[774.600453] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[774.604127] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[774.719961] [132/133] (251s left) i915_pm_rps (thresholds-idle-park)
[774.793755] Starting subtest: thresholds-idle-park
[774.797811] Subtest thresholds-idle-park: SKIP (0.001s)
[774.930052] [133/133] (250s left) gem_exec_params (rsvd2-dirt)
[774.988780] Starting subtest: rsvd2-dirt
[774.992762] Subtest rsvd2-dirt: SKIP (0.000s)
[775.103981] 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.