[57.159196] Initializing watchdogs
[57.159302]   /dev/watchdog0
[57.173071] [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.177093] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.179309] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.182664] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[57.318888] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[57.323541] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[57.454275] [002/131] (960s left) prime_vgem (sync)
[57.578937] Starting subtest: sync
[57.581456] Starting dynamic subtest: rcs0
[57.622275] Dynamic subtest rcs0: SUCCESS (0.043s)
[57.629121] Starting dynamic subtest: bcs0
[57.692996] Dynamic subtest bcs0: SUCCESS (0.069s)
[57.699776] Starting dynamic subtest: vcs0
[57.739802] Dynamic subtest vcs0: SUCCESS (0.047s)
[57.746667] Starting dynamic subtest: vcs1
[57.785276] Dynamic subtest vcs1: SUCCESS (0.045s)
[57.792154] Starting dynamic subtest: vecs0
[57.832773] Dynamic subtest vecs0: SUCCESS (0.047s)
[57.839594] Starting dynamic subtest: ccs0
[57.879241] Dynamic subtest ccs0: SUCCESS (0.046s)
[57.881554] Subtest sync: SUCCESS (0.299s)
[58.036257] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[58.039272] [003/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[58.125668] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[58.129747] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[58.262186] [004/131] (959s left) i915_suspend (fence-restore-tiled2untiled)
[58.330446] Starting subtest: fence-restore-tiled2untiled
[58.334040] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[58.437254] [005/131] (959s left) kms_atomic_transition (plane-all-transition)
[58.532364] Starting subtest: plane-all-transition
[58.534327] Starting dynamic subtest: pipe-A-eDP-1
[61.074234] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.534s)
[61.378360] Starting dynamic subtest: pipe-B-eDP-1
[64.615803] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.237s)
[64.913495] Subtest plane-all-transition: SUCCESS (6.363s)
[65.751950] [006/131] (952s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[65.818226] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[65.921658] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[66.016678] [007/131] (951s left) kms_color (ctm-negative)
[66.111475] Starting subtest: ctm-negative
[66.113668] Starting dynamic subtest: pipe-A-eDP-1
[66.859695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[66.869686] Starting dynamic subtest: pipe-B-eDP-1
[68.261799] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[68.268893] Starting dynamic subtest: pipe-C-eDP-1
[69.604785] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s)
[69.612860] Starting dynamic subtest: pipe-D-eDP-1
[70.951633] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[70.953988] Subtest ctm-negative: SUCCESS (4.834s)
[71.783902] [008/131] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[71.848831] Starting subtest: wait-for-submit-snapshot
[71.930373] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.027154] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[72.126851] Starting subtest: fbcpsr-slowdraw
[98.562455] Subtest fbcpsr-slowdraw: SUCCESS (26.431s)
[98.717837] [010/131] (919s left) kms_joiner (basic-max-non-joiner)
[98.830254] Starting subtest: basic-max-non-joiner
[98.834902] Subtest basic-max-non-joiner: SKIP (0.000s)
[98.921845] [011/131] (919s left) kms_psr (pr-cursor-mmap-cpu)
[99.014572] Starting subtest: pr-cursor-mmap-cpu
[99.018992] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[99.107171] [012/131] (919s left) vgem_basic (create)
[99.162049] Starting subtest: create
[99.164489] Subtest create: SUCCESS (0.000s)
[99.246311] [013/131] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[99.345650] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[99.348980] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[99.485317] [014/131] (918s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[99.567748] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[99.571752] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[100.678193] [015/131] (917s left) kms_selftest (drm_dp_mst_helper)
[100.720295] Starting subtest: drm_dp_mst_helper
[100.727234] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[100.869632] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.144s)
[100.876414] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[101.010245] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.138s)
[101.018976] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[101.146454] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.136s)
[101.148529] Subtest drm_dp_mst_helper: SUCCESS (0.428s)
[101.382287] [016/131] (916s left) kms_lease (lease-uevent)
[101.481273] Starting subtest: lease-uevent
[102.498455] Subtest lease-uevent: SUCCESS (1.017s)
[102.590552] [017/131] (915s left) gem_exec_fence (invalid-timeline-fence-array)
[103.135628] Starting subtest: invalid-timeline-fence-array
[103.141093] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[104.986797] [018/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[105.099451] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[105.103585] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[105.229192] [019/131] (913s left) kms_feature_discovery (display-4x)
[105.341725] Starting subtest: display-4x
[105.346538] Subtest display-4x: SKIP (0.000s)
[105.452830] [020/131] (912s left) perf (oa-formats)
[105.591878] Starting subtest: oa-formats
[105.593900] Starting dynamic subtest: 0-rcs0
[105.605249] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[105.615760] Starting dynamic subtest: 1-vcs1
[105.626316] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[105.628535] Subtest oa-formats: SUCCESS (0.038s)
[105.678207] [021/131] (912s left) api_intel_allocator (execbuf-with-allocator)
[105.734553] Starting subtest: execbuf-with-allocator
[105.739282] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[105.890473] [022/131] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[105.980481] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[113.316119] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.338s)
[113.467445] [023/131] (905s left) kms_cursor_edge_walk (256x256-left-edge)
[113.559332] Starting subtest: 256x256-left-edge
[113.561716] Starting dynamic subtest: pipe-A-eDP-1
[117.037777] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[117.047082] Starting dynamic subtest: pipe-D-eDP-1
[120.168655] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[120.170797] Subtest 256x256-left-edge: SUCCESS (6.608s)
[120.989031] [024/131] (897s left) gem_exec_whisper (basic-fds-priority)
[121.054302] Starting subtest: basic-fds-priority
[145.018474] Subtest basic-fds-priority: SUCCESS (23.963s)
[145.231500] [025/131] (873s left) kms_sequence (get-forked-busy)
[145.332354] Starting subtest: get-forked-busy
[145.334641] Starting dynamic subtest: pipe-A-eDP-1
[147.258648] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[147.266277] Starting dynamic subtest: pipe-B-eDP-1
[149.849735] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.592s)
[149.857489] Starting dynamic subtest: pipe-C-eDP-1
[152.453559] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[152.462930] Starting dynamic subtest: pipe-D-eDP-1
[154.997064] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[154.999451] Subtest get-forked-busy: SUCCESS (9.664s)
[155.817241] [026/131] (862s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[155.912865] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[155.915241] Starting dynamic subtest: pipe-A-default-mode
[156.200222] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[156.204592] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.286s)
[157.048319] [027/131] (861s left) kms_draw_crc (draw-method-mmap-wc)
[157.139397] Starting subtest: draw-method-mmap-wc
[157.141331] Starting dynamic subtest: xrgb8888-untiled
[157.381143] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s)
[157.390042] Starting dynamic subtest: rgb565-untiled
[157.581181] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[157.589797] Starting dynamic subtest: xrgb2101010-untiled
[157.781228] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.198s)
[157.789218] Starting dynamic subtest: xbgr16161616f-untiled
[158.002971] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.220s)
[158.010327] Starting dynamic subtest: xrgb8888-xtiled
[158.136735] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[158.148997] Starting dynamic subtest: rgb565-xtiled
[158.270711] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[158.278132] Starting dynamic subtest: xrgb2101010-xtiled
[158.391868] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[158.399879] Starting dynamic subtest: xbgr16161616f-xtiled
[158.525156] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[158.532582] Starting dynamic subtest: xrgb8888-4tiled
[158.669619] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[158.677312] Starting dynamic subtest: rgb565-4tiled
[158.814258] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[158.821245] Starting dynamic subtest: xrgb2101010-4tiled
[158.959654] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s)
[158.967106] Starting dynamic subtest: xbgr16161616f-4tiled
[159.147372] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.186s)
[159.149191] Subtest draw-method-mmap-wc: SUCCESS (2.011s)
[159.306142] [028/131] (859s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[159.419967] Starting subtest: plane-upscale-factor-0-25-with-rotation
[159.421840] Starting dynamic subtest: pipe-A
[159.649980] Dynamic subtest pipe-A: SUCCESS (0.230s)
[159.657517] Starting dynamic subtest: pipe-B
[160.905346] Dynamic subtest pipe-B: SUCCESS (1.254s)
[160.912616] Starting dynamic subtest: pipe-C
[162.236173] Dynamic subtest pipe-C: SUCCESS (1.329s)
[162.244738] Starting dynamic subtest: pipe-D
[163.579196] Dynamic subtest pipe-D: SUCCESS (1.342s)
[163.581510] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.159s)
[164.789764] [029/131] (854s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[164.896641] Starting subtest: primary-y-tiled-reflect-x-270
[164.901058] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[164.990765] [030/131] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[165.103528] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[165.107658] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[165.230336] [031/131] (853s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[165.289025] Subtest writes-after-reads: SKIP (0.000s)
[165.357078] [032/131] (853s left) gem_mmap_gtt (isolation)
[165.418673] Subtest isolation: SKIP (0.000s)
[165.470059] [033/131] (853s left) gem_mmap_offset (pf-nonblock)
[165.533268] Starting subtest: pf-nonblock
[165.541885] Subtest pf-nonblock: SUCCESS (0.010s)
[165.695848] [034/131] (853s left) prime_self_import (basic-with_one_bo)
[165.724788] Starting subtest: basic-with_one_bo
[165.747868] Subtest basic-with_one_bo: SUCCESS (0.023s)
[165.887343] [035/131] (853s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[165.982605] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[165.986314] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[166.108865] [036/131] (852s left) syncobj_wait (single-wait-signaled)
[166.159309] Starting subtest: single-wait-signaled
[166.161263] Subtest single-wait-signaled: SUCCESS (0.000s)
[166.301860] [037/131] (852s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[171.363242] Starting subtest: pr-cursor-plane-update-sf
[171.372053] Subtest pr-cursor-plane-update-sf: SKIP (0.006s)
[172.235057] [038/131] (846s left) kms_cursor_crc (cursor-onscreen-256x256)
[172.475848] Starting subtest: cursor-onscreen-256x256
[172.480936] Starting dynamic subtest: pipe-A-eDP-1
[174.578920] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[174.611326] Starting dynamic subtest: pipe-D-eDP-1
[177.391154] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s)
[177.393483] Subtest cursor-onscreen-256x256: SUCCESS (4.915s)
[178.293224] [039/131] (840s left) kms_vrr (flipline)
[178.398682] Starting subtest: flipline
[178.405271] Subtest flipline: SKIP (0.000s)
[178.493496] [040/131] (840s left) kms_chamelium_color (ctm-0-50)
[178.590463] Subtest ctm-0-50: SKIP (0.000s)
[178.633176] [041/131] (840s left) gem_mmap_wc (fault-concurrent)
[178.687926] Subtest fault-concurrent: SKIP (0.000s)
[178.762274] [042/131] (840s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[178.898780] Starting subtest: cursorA-vs-flipB-varying-size
[178.903379] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[179.067631] [043/131] (840s left) gem_exec_schedule (fairslice)
[179.133128] Starting subtest: fairslice
[179.135344] Starting dynamic subtest: rcs0
[181.147396] Dynamic subtest rcs0: SUCCESS (2.021s)
[181.155750] Starting dynamic subtest: bcs0
[183.168159] Dynamic subtest bcs0: SUCCESS (2.019s)
[183.175357] Starting dynamic subtest: vcs0
[185.188486] Dynamic subtest vcs0: SUCCESS (2.018s)
[185.196946] Starting dynamic subtest: vcs1
[187.205796] Dynamic subtest vcs1: SUCCESS (2.017s)
[187.213949] Starting dynamic subtest: vecs0
[189.221356] Dynamic subtest vecs0: SUCCESS (2.016s)
[189.229062] Starting dynamic subtest: ccs0
[191.242473] Dynamic subtest ccs0: SUCCESS (2.021s)
[191.244653] Subtest fairslice: SUCCESS (12.117s)
[191.564735] [044/131] (827s left) syncobj_wait (signal)
[191.624515] Starting subtest: signal
[191.626498] Subtest signal: SUCCESS (0.000s)
[191.749344] [045/131] (827s left) gem_exec_schedule (thriceslice)
[191.816916] Starting subtest: thriceslice
[191.819262] Starting dynamic subtest: rcs0
[191.862042] Dynamic subtest rcs0: SUCCESS (0.055s)
[191.873432] Starting dynamic subtest: bcs0
[191.897509] Dynamic subtest bcs0: SUCCESS (0.033s)
[191.906564] Starting dynamic subtest: vcs0
[191.950100] Dynamic subtest vcs0: SUCCESS (0.052s)
[191.962446] Starting dynamic subtest: vcs1
[191.981174] Dynamic subtest vcs1: SUCCESS (0.030s)
[191.988680] Starting dynamic subtest: vecs0
[192.037654] Dynamic subtest vecs0: SUCCESS (0.055s)
[192.051202] Starting dynamic subtest: ccs0
[192.095737] Dynamic subtest ccs0: SUCCESS (0.057s)
[192.098651] Subtest thriceslice: SUCCESS (0.290s)
[194.006966] [046/131] (825s left) gem_exec_balancer (hog)
[194.073983] Starting subtest: hog
[194.078337] Subtest hog: SKIP (0.000s)
[194.397158] [047/131] (825s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[194.502937] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[194.507386] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[194.635904] [048/131] (824s left) gem_partial_pwrite_pread (write)
[194.692743] Subtest write: SKIP (0.000s)
[194.767460] [049/131] (824s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[197.095202] Starting subtest: modeset-lpsp-stress-no-wait
[206.880395] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.790s)
[206.980485] [050/131] (812s left) kms_plane_multiple (tiling-4)
[207.080855] Starting subtest: tiling-4
[207.083182] Starting dynamic subtest: pipe-A-eDP-1
[210.769126] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.686s)
[210.777851] Starting dynamic subtest: pipe-B-eDP-1
[215.206058] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.436s)
[215.214592] Starting dynamic subtest: pipe-C-eDP-1
[219.515077] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.306s)
[219.523631] Starting dynamic subtest: pipe-D-eDP-1
[223.854700] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.340s)
[223.857170] Subtest tiling-4: SUCCESS (16.775s)
[224.700613] [051/131] (794s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[224.803272] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[224.805556] Starting dynamic subtest: pipe-A-eDP-1
[224.828477] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.838379] Starting dynamic subtest: pipe-B-eDP-1
[224.859506] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.866375] Starting dynamic subtest: pipe-C-eDP-1
[224.886760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.893471] Starting dynamic subtest: pipe-D-eDP-1
[224.914093] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.918149] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[226.960272] [052/131] (792s left) kms_big_fb (linear-32bpp-rotate-270)
[227.070639] Starting subtest: linear-32bpp-rotate-270
[227.090082] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[227.241321] [053/131] (792s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[227.328229] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[227.330568] Starting dynamic subtest: pipe-A-default-mode
[228.491117] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[228.495237] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.163s)
[228.642222] [054/131] (791s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[228.741330] Starting subtest: fbcpsr-indfb-scaledprimary
[234.551196] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.811s)
[234.719242] [055/131] (785s left) gem_exec_flush (basic-wb-ro-default)
[234.779320] Starting subtest: basic-wb-ro-default
[240.230475] Subtest basic-wb-ro-default: SUCCESS (5.452s)
[240.439895] [056/131] (779s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[240.542768] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[240.547166] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[240.674809] [057/131] (779s left) kms_flip (2x-blocking-wf_vblank)
[240.770272] Starting subtest: 2x-blocking-wf_vblank
[240.780944] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[240.913408] [058/131] (779s left) core_setmaster (master-drop-set-root)
[240.995085] Starting subtest: master-drop-set-root
[241.007607] Subtest master-drop-set-root: SUCCESS (0.012s)
[241.055063] [059/131] (778s left) gem_partial_pwrite_pread (reads)
[241.113438] Subtest reads: SKIP (0.000s)
[241.173545] [060/131] (778s left) kms_pm_rpm (fences-dpms)
[243.089768] Starting subtest: fences-dpms
[243.094839] Subtest fences-dpms: SKIP (0.000s)
[243.498292] [061/131] (776s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[243.559046] Starting subtest: multi-wait-all-for-submit-signaled
[243.561389] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[243.676243] [062/131] (776s left) kms_chamelium_edid (dp-edid-resolution-list)
[244.053817] Subtest dp-edid-resolution-list: SKIP (0.000s)
[244.860456] [063/131] (775s left) gem_mmap_gtt (bad-object)
[244.927083] Subtest bad-object: SKIP (0.000s)
[244.999380] [064/131] (775s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[245.094090] Starting subtest: async-flip-with-page-flip-events-tiled
[245.476093] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[248.262886] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[248.273148] Starting dynamic subtest: pipe-A-eDP-1-4
[250.448085] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[250.456468] Starting dynamic subtest: pipe-A-eDP-1-4
[252.458079] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[252.468081] Starting dynamic subtest: pipe-A-eDP-1-x
[254.648281] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[255.013875] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[257.798374] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[257.806121] Starting dynamic subtest: pipe-B-eDP-1-4
[259.996094] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[260.003736] Starting dynamic subtest: pipe-B-eDP-1-4
[262.006475] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[262.015686] Starting dynamic subtest: pipe-B-eDP-1-x
[264.195178] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[264.557977] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[267.323220] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[267.332482] Starting dynamic subtest: pipe-C-eDP-1-4
[269.509959] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[269.517877] Starting dynamic subtest: pipe-C-eDP-1-4
[271.519801] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[271.527602] Starting dynamic subtest: pipe-C-eDP-1-x
[273.698900] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[274.058801] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[276.859525] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[276.867487] Starting dynamic subtest: pipe-D-eDP-1-4
[279.050259] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[279.062337] Starting dynamic subtest: pipe-D-eDP-1-4
[281.045128] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[281.053334] Starting dynamic subtest: pipe-D-eDP-1-x
[283.223671] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[283.226220] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.129s)
[284.475895] [065/131] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[284.592218] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[284.596608] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[284.699873] [066/131] (735s left) gem_exec_alignment (many)
[284.774796] Starting subtest: many
[307.579037] Subtest many: SUCCESS (22.805s)
[309.875730] [067/131] (710s left) kms_psr (psr-dpms)
[310.018757] Starting subtest: psr-dpms
[310.020990] Starting dynamic subtest: eDP-1
[312.990126] Dynamic subtest eDP-1: SUCCESS (2.968s)
[312.992471] Subtest psr-dpms: SUCCESS (2.970s)
[313.873283] [068/131] (706s left) gem_ctx_persistence (engines-mixed-process)
[313.935245] Starting subtest: engines-mixed-process
[313.937611] Starting dynamic subtest: rcs0
[315.869221] Dynamic subtest rcs0: SUCCESS (1.933s)
[315.882820] Starting dynamic subtest: bcs0
[317.946234] Dynamic subtest bcs0: SUCCESS (2.074s)
[317.957179] Starting dynamic subtest: vcs0
[319.905697] Dynamic subtest vcs0: SUCCESS (1.958s)
[319.916438] Starting dynamic subtest: vcs1
[321.893753] Dynamic subtest vcs1: SUCCESS (1.986s)
[321.903346] Starting dynamic subtest: vecs0
[323.950041] Dynamic subtest vecs0: SUCCESS (2.054s)
[323.959788] Starting dynamic subtest: ccs0
[325.894303] Dynamic subtest ccs0: SUCCESS (1.940s)
[325.896161] Subtest engines-mixed-process: SUCCESS (11.956s)
[326.028316] [069/131] (694s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[326.133169] Starting subtest: 4-tiled-32bpp-rotate-180
[327.535581] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.404s)
[327.728905] [070/131] (692s left) prime_vgem (coherency-gtt)
[327.794872] Starting subtest: coherency-gtt
[327.798679] Subtest coherency-gtt: SKIP (0.000s)
[327.935846] [071/131] (692s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[328.169988] Starting subtest: cursor-rapid-movement-128x42
[328.214212] Subtest cursor-rapid-movement-128x42: SKIP (0.040s)
[328.470055] [072/131] (692s left) gem_exec_balancer (waits)
[328.532624] Starting subtest: waits
[334.987793] Subtest waits: SUCCESS (6.455s)
[335.283902] [073/131] (685s left) sysfs_preempt_timeout (invalid)
[335.346880] Starting subtest: invalid
[335.349440] Starting dynamic subtest: vecs0
[335.351851] Dynamic subtest vecs0: SUCCESS (0.000s)
[335.362089] Starting dynamic subtest: ccs0
[335.364193] Dynamic subtest ccs0: SUCCESS (0.000s)
[335.372296] Starting dynamic subtest: vcs0
[335.374486] Dynamic subtest vcs0: SUCCESS (0.000s)
[335.383148] Starting dynamic subtest: bcs0
[335.385246] Dynamic subtest bcs0: SUCCESS (0.000s)
[335.392892] Starting dynamic subtest: rcs0
[335.394769] Dynamic subtest rcs0: SUCCESS (0.000s)
[335.403454] Starting dynamic subtest: vcs1
[335.405639] Dynamic subtest vcs1: SUCCESS (0.000s)
[335.407769] Subtest invalid: SUCCESS (0.005s)
[335.484053] [074/131] (685s left) gem_spin_batch (resubmit-all)
[335.558811] Starting subtest: resubmit-all
[335.561129] Starting dynamic subtest: rcs0
[335.574511] Dynamic subtest rcs0: SUCCESS (0.019s)
[335.585732] Starting dynamic subtest: bcs0
[335.587951] Dynamic subtest bcs0: SUCCESS (0.003s)
[335.596427] Starting dynamic subtest: vcs0
[335.598264] Dynamic subtest vcs0: SUCCESS (0.002s)
[335.605619] Starting dynamic subtest: vcs1
[335.607456] Dynamic subtest vcs1: SUCCESS (0.002s)
[335.615081] Starting dynamic subtest: vecs0
[335.616867] Dynamic subtest vecs0: SUCCESS (0.004s)
[335.624643] Starting dynamic subtest: ccs0
[335.626496] Dynamic subtest ccs0: SUCCESS (0.003s)
[335.628588] Subtest resubmit-all: SUCCESS (0.039s)
[336.980508] [075/131] (683s left) gem_exec_gttfill (basic)
[337.049632] Starting subtest: basic
[340.885481] Subtest basic: SUCCESS (3.833s)
[341.096279] [076/131] (679s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[341.248408] Starting subtest: yf-tiled-16bpp-rotate-270
[341.252420] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[341.376064] [077/131] (679s left) gem_ctx_persistence (file)
[341.448263] Starting subtest: file
[341.590288] Subtest file: SUCCESS (0.142s)
[341.751700] [078/131] (679s left) gem_fenced_exec_thrash (too-many-fences)
[341.815818] Subtest too-many-fences: SKIP (0.000s)
[341.876097] [079/131] (678s left) api_intel_bb (misplaced-blitter)
[341.935768] Starting subtest: misplaced-blitter
[341.946918] Subtest misplaced-blitter: SUCCESS (0.012s)
[342.125365] [080/131] (678s left) gen7_exec_parse (basic-rejected)
[342.185426] Subtest basic-rejected: SKIP (0.000s)
[342.264087] [081/131] (678s left) gem_pxp (hw-rejects-pxp-context)
[342.387427] Starting subtest: hw-rejects-pxp-context
[342.391370] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[342.533528] [082/131] (678s left) gem_softpin (evict-active-interruptible)
[342.598381] Starting subtest: evict-active-interruptible
[342.603657] Subtest evict-active-interruptible: SUCCESS (0.005s)
[342.748390] [083/131] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[342.851596] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[342.855136] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[342.998965] [084/131] (678s left) syncobj_timeline (invalid-signal-zero-handles)
[343.063183] Starting subtest: invalid-signal-zero-handles
[343.065172] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[343.202592] [085/131] (677s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[343.306043] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[343.309524] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[343.417266] [086/131] (677s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[343.518216] Starting subtest: x-tiled-8bpp-rotate-270
[343.539175] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[343.696963] [087/131] (677s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[343.786539] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[343.790092] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[343.923933] [088/131] (677s left) i915_pm_freq_api (freq-reset)
[343.992642] Starting subtest: freq-reset
[343.994543] Starting dynamic subtest: gt0
[344.179792] Dynamic subtest gt0: SUCCESS (0.184s)
[344.187845] Starting dynamic subtest: gt1
[344.344643] Dynamic subtest gt1: SUCCESS (0.164s)
[344.347355] Subtest freq-reset: SUCCESS (0.351s)
[344.443022] [089/131] (676s left) gem_unfence_active_buffers
[344.628030] [090/131] (676s left) syncobj_timeline (reset-unsignaled)
[344.689600] Starting subtest: reset-unsignaled
[344.691821] Subtest reset-unsignaled: SUCCESS (0.000s)
[344.804382] [091/131] (676s left) gem_render_copy (y-tiled)
[344.855750] Starting subtest: y-tiled
[344.860130] Subtest y-tiled: SKIP (0.000s)
[345.062468] [092/131] (676s left) gem_wait (busy)
[345.131449] Starting subtest: busy
[345.133783] Starting dynamic subtest: all-engines
[346.900976] Dynamic subtest all-engines: SUCCESS (1.767s)
[346.913227] Starting dynamic subtest: rcs0
[347.444242] Dynamic subtest rcs0: SUCCESS (0.542s)
[347.455506] Starting dynamic subtest: bcs0
[347.987511] Dynamic subtest bcs0: SUCCESS (0.541s)
[347.998947] Starting dynamic subtest: vcs0
[349.909363] Dynamic subtest vcs0: SUCCESS (1.919s)
[349.921017] Starting dynamic subtest: vcs1
[351.892783] Dynamic subtest vcs1: SUCCESS (1.980s)
[351.904631] Starting dynamic subtest: vecs0
[353.951548] Dynamic subtest vecs0: SUCCESS (2.047s)
[353.960295] Starting dynamic subtest: ccs0
[354.483280] Dynamic subtest ccs0: SUCCESS (0.541s)
[354.485802] Subtest busy: SUCCESS (9.352s)
[354.705351] [093/131] (666s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[354.809070] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[354.813315] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[354.934976] [094/131] (666s left) i915_drm_fdinfo (busy-check-all)
[354.977485] Starting subtest: busy-check-all
[354.979739] Starting dynamic subtest: rcs0
[354.984217] Dynamic subtest rcs0: SKIP (0.004s)
[354.992706] Starting dynamic subtest: bcs0
[354.996778] Dynamic subtest bcs0: SKIP (0.000s)
[355.005070] Starting dynamic subtest: vcs0
[355.009243] Dynamic subtest vcs0: SKIP (0.000s)
[355.017109] Starting dynamic subtest: vcs1
[355.021162] Dynamic subtest vcs1: SKIP (0.000s)
[355.028981] Starting dynamic subtest: vecs0
[355.033129] Dynamic subtest vecs0: SKIP (0.000s)
[355.041996] Starting dynamic subtest: ccs0
[355.046100] Dynamic subtest ccs0: SKIP (0.000s)
[355.050116] Subtest busy-check-all: SKIP (0.009s)
[355.085599] [095/131] (666s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[355.196030] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[361.995845] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.801s)
[362.149070] [096/131] (659s left) gem_gtt_cpu_tlb
[362.275870] [097/131] (659s left) gem_eio (wait-wedge-10ms)
[362.463360] Starting subtest: wait-wedge-10ms
[363.978740] Subtest wait-wedge-10ms: SUCCESS (1.514s)
[364.145029] [098/131] (657s left) core_setmaster_vs_auth
[364.341801] [099/131] (657s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[364.466817] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[373.526473] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.058s)
[374.339063] [100/131] (647s left) kms_flip (2x-absolute-wf_vblank)
[374.452263] Starting subtest: 2x-absolute-wf_vblank
[374.463405] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[374.594391] [101/131] (647s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[374.699994] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[374.701925] Starting dynamic subtest: pipe-A-eDP-1
[374.721732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[374.733727] Starting dynamic subtest: pipe-B-eDP-1
[374.753656] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[374.762251] Starting dynamic subtest: pipe-C-eDP-1
[374.782560] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[374.790857] Starting dynamic subtest: pipe-D-eDP-1
[374.810511] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[374.812761] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[376.999997] [102/131] (644s left) i915_pm_rps (engine-order)
[377.058398] Starting subtest: engine-order
[382.026040] Subtest engine-order: SUCCESS (4.965s)
[382.165213] [103/131] (639s left) kms_rotation_crc (bad-pixel-format)
[382.260172] Starting subtest: bad-pixel-format
[382.264590] Subtest bad-pixel-format: SKIP (0.001s)
[382.359945] [104/131] (639s left) perf_pmu (module-unload)
[382.466709] Starting subtest: module-unload
[390.932278] Subtest module-unload: FAIL (8.364s)
[390.962676] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[390.963376] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[390.966404] [105/131] (630s left) gem_render_copy (y-tiled-to-vebox-linear)
[392.495676] Starting subtest: y-tiled-to-vebox-linear
[392.500673] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[392.646716] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[392.648513] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[392.652208] [106/131] (629s left) gem_cs_tlb (engines)
[392.714831] Starting subtest: engines
[392.717178] Starting dynamic subtest: rcs0
[394.873707] Dynamic subtest rcs0: SUCCESS (2.154s)
[394.884555] Starting dynamic subtest: bcs0
[397.025391] Dynamic subtest bcs0: SUCCESS (2.150s)
[397.036213] Starting dynamic subtest: vcs0
[399.178680] Dynamic subtest vcs0: SUCCESS (2.153s)
[399.188932] Starting dynamic subtest: vcs1
[401.332728] Dynamic subtest vcs1: SUCCESS (2.152s)
[401.341105] Starting dynamic subtest: vecs0
[403.485511] Dynamic subtest vecs0: SUCCESS (2.152s)
[403.495850] Starting dynamic subtest: ccs0
[405.638063] Dynamic subtest ccs0: SUCCESS (2.152s)
[405.640512] Subtest engines: SUCCESS (12.919s)
[405.783230] [107/131] (616s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[405.898594] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[405.902712] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[406.025217] [108/131] (615s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[406.077081] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[406.079374] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[406.228981] [109/131] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[406.337168] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[413.682333] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.348s)
[413.840571] [110/131] (608s left) kms_rotation_crc (exhaust-fences)
[413.944615] Starting subtest: exhaust-fences
[413.950951] Subtest exhaust-fences: SKIP (0.000s)
[414.042091] [111/131] (608s left) kms_atomic (plane-overlay-legacy)
[414.141757] Starting subtest: plane-overlay-legacy
[414.143994] Starting dynamic subtest: pipe-A-eDP-1
[414.555805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[414.558076] Subtest plane-overlay-legacy: SUCCESS (0.414s)
[415.423828] [112/131] (606s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[415.527091] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[415.529365] Starting dynamic subtest: pipe-A-eDP-1
[415.800084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.244s)
[415.809030] Starting dynamic subtest: pipe-B-eDP-1
[417.058525] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[417.068888] Starting dynamic subtest: pipe-C-eDP-1
[418.268771] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[418.278744] Starting dynamic subtest: pipe-D-eDP-1
[419.522322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.254s)
[419.524278] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.968s)
[420.744118] [113/131] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[420.839412] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[420.843687] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[420.966340] [114/131] (601s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[421.348361] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[422.126309] [115/131] (600s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[422.232269] Starting subtest: fbc-psr2-sprite-plane-onoff
[422.234608] Starting dynamic subtest: eDP-1
[422.238851] Dynamic subtest eDP-1: SKIP (0.000s)
[422.243114] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[422.346808] [116/131] (599s left) kms_psr (pr-primary-page-flip)
[422.449728] Starting subtest: pr-primary-page-flip
[422.453639] Subtest pr-primary-page-flip: SKIP (0.000s)
[422.544668] [117/131] (599s left) gem_exec_reloc (basic-wc-gtt)
[422.603069] Subtest basic-wc-gtt: SKIP (0.000s)
[422.690529] [118/131] (599s left) kms_plane_scaling (intel-max-src-size)
[422.789159] Starting subtest: intel-max-src-size
[422.795286] Subtest intel-max-src-size: SKIP (0.000s)
[422.920293] [119/131] (599s left) gem_eio (in-flight-1us)
[423.148983] Starting subtest: in-flight-1us
[431.774618] Subtest in-flight-1us: SUCCESS (8.625s)
[431.968377] [120/131] (590s left) kms_psr (fbc-pr-dpms)
[432.072668] Starting subtest: fbc-pr-dpms
[432.076785] Subtest fbc-pr-dpms: SKIP (0.000s)
[432.166470] [121/131] (590s left) gem_exec_schedule (noreorder)
[432.348905] Starting subtest: noreorder
[432.351138] Starting dynamic subtest: rcs0
[432.413896] Dynamic subtest rcs0: SUCCESS (0.064s)
[432.423940] Starting dynamic subtest: vcs0
[433.967792] Dynamic subtest vcs0: SUCCESS (1.551s)
[433.978939] Starting dynamic subtest: vcs1
[435.941329] Dynamic subtest vcs1: SUCCESS (1.970s)
[435.957719] Starting dynamic subtest: vecs0
[437.929072] Dynamic subtest vecs0: SUCCESS (1.985s)
[437.940771] Starting dynamic subtest: ccs0
[438.036082] Dynamic subtest ccs0: SUCCESS (0.105s)
[438.038764] Subtest noreorder: SUCCESS (5.688s)
[438.255889] [122/131] (584s left) gem_ccs (block-multicopy-inplace)
[438.315547] Starting subtest: block-multicopy-inplace
[438.320054] Subtest block-multicopy-inplace: SKIP (0.000s)
[438.454943] [123/131] (584s left) gem_exec_whisper (basic-queues-priority)
[438.530483] Starting subtest: basic-queues-priority
[462.804119] Subtest basic-queues-priority: SUCCESS (24.270s)
[463.011951] [124/131] (559s left) sw_sync (sync_merge)
[463.051894] Starting subtest: sync_merge
[463.054103] Subtest sync_merge: SUCCESS (0.000s)
[463.135830] [125/131] (559s left) kms_legacy_colorkey (invalid-plane)
[463.228031] Starting subtest: invalid-plane
[463.230332] Starting dynamic subtest: zero-id
[463.232570] Dynamic subtest zero-id: SUCCESS (0.000s)
[463.241737] Starting dynamic subtest: outrange-id
[463.243633] Dynamic subtest outrange-id: SUCCESS (0.000s)
[463.245526] Subtest invalid-plane: SUCCESS (0.001s)
[463.327485] [126/131] (559s left) kms_dirtyfb (default-dirtyfb-ioctl)
[463.429267] Starting subtest: default-dirtyfb-ioctl
[463.431515] Starting dynamic subtest: A-eDP-1
[465.011438] Dynamic subtest A-eDP-1: SUCCESS (1.583s)
[465.013887] Subtest default-dirtyfb-ioctl: SUCCESS (1.584s)
[465.896921] [127/131] (556s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[470.943932] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[470.948513] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[471.815244] [128/131] (550s left) prime_mmap (test_map_unmap)
[471.881349] Starting subtest: test_map_unmap
[471.883505] Starting dynamic subtest: test_map_unmap-smem
[471.908619] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[471.910995] Subtest test_map_unmap: SUCCESS (0.030s)
[472.052014] [129/131] (550s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[472.116550] Starting subtest: etime-multi-wait-all-for-submit-submitted
[472.218488] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[472.319500] [130/131] (550s left) gem_userptr_blits (process-exit)
[472.391932] Starting subtest: process-exit
[472.396918] Subtest process-exit: SUCCESS (0.008s)
[472.573373] [131/131] (550s left) perf_pmu (busy-idle-check-all)
[472.613904] Starting subtest: busy-idle-check-all
[472.615728] Starting dynamic subtest: rcs0
[473.302032] Dynamic subtest rcs0: SUCCESS (0.688s)
[473.313881] Starting dynamic subtest: bcs0
[473.955615] Dynamic subtest bcs0: SUCCESS (0.651s)
[473.966869] Starting dynamic subtest: vcs0
[475.926433] Dynamic subtest vcs0: SUCCESS (1.967s)
[475.938254] Starting dynamic subtest: vcs1
[477.910504] Dynamic subtest vcs1: SUCCESS (1.981s)
[477.922609] Starting dynamic subtest: vecs0
[479.893313] Dynamic subtest vecs0: SUCCESS (1.980s)
[479.905217] Starting dynamic subtest: ccs0
[480.549933] Dynamic subtest ccs0: SUCCESS (0.656s)
[480.552483] Subtest busy-idle-check-all: SUCCESS (7.938s)
[480.680787] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_suspend
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_selftest
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_feature_discovery
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: api_intel_allocator
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: prime_self_import
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_vrr
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_partial_pwrite_pread
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: core_setmaster
results: parsing output: 58/ for test: gem_partial_pwrite_pread
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_chamelium_edid
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_alignment
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: sysfs_preempt_timeout
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: gem_exec_gttfill
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: gem_fenced_exec_thrash
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: gen7_exec_parse
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: i915_pm_freq_api
results: parsing output: 88/ for test: gem_unfence_active_buffers
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_wait
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_gtt_cpu_tlb
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: core_setmaster_vs_auth
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_cs_tlb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_atomic
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_ccs
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: kms_legacy_colorkey
results: parsing output: 125/ for test: kms_dirtyfb
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: prime_mmap
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: perf_pmu
Done.