[58.550439] Initializing watchdogs
[58.550521]   /dev/watchdog0
[58.564665] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.569218] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.571247] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.573013] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[58.686325] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[58.688089] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[58.812631] [002/131] (960s left) prime_vgem (sync)
[58.915745] Starting subtest: sync
[58.916862] Starting dynamic subtest: rcs0
[58.983423] Dynamic subtest rcs0: SUCCESS (0.067s)
[58.988778] Starting dynamic subtest: bcs0
[59.068275] Dynamic subtest bcs0: SUCCESS (0.084s)
[59.073286] Starting dynamic subtest: vcs0
[59.114948] Dynamic subtest vcs0: SUCCESS (0.046s)
[59.120270] Starting dynamic subtest: vcs1
[59.158319] Dynamic subtest vcs1: SUCCESS (0.042s)
[59.163543] Starting dynamic subtest: vecs0
[59.203147] Dynamic subtest vecs0: SUCCESS (0.045s)
[59.208520] Starting dynamic subtest: ccs0
[59.248993] Dynamic subtest ccs0: SUCCESS (0.045s)
[59.250025] Subtest sync: SUCCESS (0.332s)
[59.406043] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[59.407878] [003/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[59.501718] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[59.503413] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[59.611981] [004/131] (959s left) i915_suspend (fence-restore-tiled2untiled)
[59.674202] Starting subtest: fence-restore-tiled2untiled
[59.675939] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[59.812630] [005/131] (959s left) kms_atomic_transition (plane-all-transition)
[59.914412] Starting subtest: plane-all-transition
[59.915416] Starting dynamic subtest: pipe-A-eDP-1
[62.455630] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.534s)
[62.750172] Starting dynamic subtest: pipe-B-eDP-1
[66.029541] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.279s)
[66.325202] Subtest plane-all-transition: SUCCESS (6.395s)
[67.213712] [006/131] (952s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[67.453832] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[67.564425] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[67.675862] [007/131] (951s left) kms_color (ctm-negative)
[67.787832] Starting subtest: ctm-negative
[67.789000] Starting dynamic subtest: pipe-A-eDP-1
[68.531277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[68.537099] Starting dynamic subtest: pipe-B-eDP-1
[69.983816] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.451s)
[69.990345] Starting dynamic subtest: pipe-C-eDP-1
[71.366869] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[71.372890] Starting dynamic subtest: pipe-D-eDP-1
[72.793902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.425s)
[72.794860] Subtest ctm-negative: SUCCESS (5.002s)
[73.609771] [008/131] (945s left) syncobj_timeline (wait-for-submit-snapshot)
[73.660092] Starting subtest: wait-for-submit-snapshot
[73.743390] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[73.836154] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[73.931858] Starting subtest: fbcpsr-slowdraw
[99.073808] Subtest fbcpsr-slowdraw: SUCCESS (25.137s)
[99.258979] [010/131] (920s left) kms_joiner (basic-max-non-joiner)
[99.350875] Starting subtest: basic-max-non-joiner
[99.352816] Subtest basic-max-non-joiner: SKIP (0.000s)
[99.437974] [011/131] (919s left) kms_psr (pr-cursor-mmap-cpu)
[99.525060] Starting subtest: pr-cursor-mmap-cpu
[99.526923] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[99.616254] [012/131] (919s left) vgem_basic (create)
[99.660215] Starting subtest: create
[99.661446] Subtest create: SUCCESS (0.000s)
[99.735254] [013/131] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[99.830141] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[99.831855] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[99.959877] [014/131] (919s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[100.042381] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[100.044130] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[101.186441] [015/131] (918s left) kms_selftest (drm_dp_mst_helper)
[101.224338] Starting subtest: drm_dp_mst_helper
[101.231337] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[101.372841] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.141s)
[101.380073] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[101.498197] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.124s)
[101.504484] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[101.608987] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.111s)
[101.609910] Subtest drm_dp_mst_helper: SUCCESS (0.385s)
[101.798055] [016/131] (917s left) kms_lease (lease-uevent)
[101.887599] Starting subtest: lease-uevent
[102.903637] Subtest lease-uevent: SUCCESS (1.017s)
[103.012651] [017/131] (916s left) gem_exec_fence (invalid-timeline-fence-array)
[103.549398] Starting subtest: invalid-timeline-fence-array
[103.556819] Subtest invalid-timeline-fence-array: SUCCESS (0.010s)
[105.053244] [018/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[105.150612] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[105.152570] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[105.278108] [019/131] (914s left) kms_feature_discovery (display-4x)
[105.378260] Starting subtest: display-4x
[105.379842] Subtest display-4x: SKIP (0.000s)
[105.468935] [020/131] (914s left) perf (oa-formats)
[105.609861] Starting subtest: oa-formats
[105.610792] Starting dynamic subtest: 0-rcs0
[105.626647] Dynamic subtest 0-rcs0: SUCCESS (0.017s)
[105.632359] Starting dynamic subtest: 1-vecs0
[105.647783] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[105.648594] Subtest oa-formats: SUCCESS (0.039s)
[105.687967] [021/131] (914s left) api_intel_allocator (execbuf-with-allocator)
[105.744743] Starting subtest: execbuf-with-allocator
[105.750684] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[105.861086] [022/131] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[105.968480] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[113.304160] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.336s)
[113.480660] [023/131] (906s left) kms_cursor_edge_walk (256x256-left-edge)
[113.575959] Starting subtest: 256x256-left-edge
[113.576801] Starting dynamic subtest: pipe-A-eDP-1
[117.081914] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[117.089830] Starting dynamic subtest: pipe-D-eDP-1
[120.210134] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[120.210979] Subtest 256x256-left-edge: SUCCESS (6.634s)
[121.029967] [024/131] (898s left) gem_exec_whisper (basic-fds-priority)
[121.106545] Starting subtest: basic-fds-priority
[145.193277] Subtest basic-fds-priority: SUCCESS (24.081s)
[145.395222] [025/131] (874s left) kms_sequence (get-forked-busy)
[145.497915] Starting subtest: get-forked-busy
[145.498808] Starting dynamic subtest: pipe-A-eDP-1
[147.433869] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[147.440222] Starting dynamic subtest: pipe-B-eDP-1
[149.999832] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.565s)
[150.006413] Starting dynamic subtest: pipe-C-eDP-1
[152.623973] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s)
[152.630776] Starting dynamic subtest: pipe-D-eDP-1
[155.255902] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s)
[155.256681] Subtest get-forked-busy: SUCCESS (9.759s)
[156.158810] [026/131] (863s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[156.253135] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[156.253988] Starting dynamic subtest: pipe-A-default-mode
[156.544048] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[156.545855] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.290s)
[157.396807] [027/131] (862s left) kms_draw_crc (draw-method-mmap-wc)
[157.488974] Starting subtest: draw-method-mmap-wc
[157.489927] Starting dynamic subtest: xrgb8888-untiled
[157.699775] Dynamic subtest xrgb8888-untiled: SUCCESS (0.211s)
[157.706277] Starting dynamic subtest: rgb565-untiled
[157.899821] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[157.906764] Starting dynamic subtest: xrgb2101010-untiled
[158.099806] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[158.108315] Starting dynamic subtest: xbgr16161616f-untiled
[158.311178] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[158.320078] Starting dynamic subtest: xrgb8888-xtiled
[158.455408] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[158.462240] Starting dynamic subtest: rgb565-xtiled
[158.588642] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[158.595138] Starting dynamic subtest: xrgb2101010-xtiled
[158.711015] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[158.717393] Starting dynamic subtest: xbgr16161616f-xtiled
[158.832960] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[158.839262] Starting dynamic subtest: xrgb8888-4tiled
[158.988721] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[158.994851] Starting dynamic subtest: rgb565-4tiled
[159.122541] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[159.130027] Starting dynamic subtest: xrgb2101010-4tiled
[159.255387] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[159.261974] Starting dynamic subtest: xbgr16161616f-4tiled
[159.422270] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[159.423198] Subtest draw-method-mmap-wc: SUCCESS (1.935s)
[159.536184] [028/131] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[159.626921] Starting subtest: plane-upscale-factor-0-25-with-rotation
[159.627855] Starting dynamic subtest: pipe-A
[159.854132] Dynamic subtest pipe-A: SUCCESS (0.227s)
[159.865856] Starting dynamic subtest: pipe-B
[161.159295] Dynamic subtest pipe-B: SUCCESS (1.304s)
[161.167066] Starting dynamic subtest: pipe-C
[162.497944] Dynamic subtest pipe-C: SUCCESS (1.337s)
[162.504400] Starting dynamic subtest: pipe-D
[163.840100] Dynamic subtest pipe-D: SUCCESS (1.342s)
[163.842074] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.214s)
[165.037568] [029/131] (854s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[165.137416] Starting subtest: primary-y-tiled-reflect-x-270
[165.139309] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[165.226957] [030/131] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[165.320723] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[165.322567] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[165.448408] [031/131] (854s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[165.520707] Subtest writes-after-reads: SKIP (0.000s)
[165.602336] [032/131] (854s left) gem_mmap_gtt (isolation)
[165.657989] Subtest isolation: SKIP (0.000s)
[165.708478] [033/131] (854s left) gem_mmap_offset (pf-nonblock)
[165.765251] Starting subtest: pf-nonblock
[165.771770] Subtest pf-nonblock: SUCCESS (0.007s)
[165.922237] [034/131] (854s left) prime_self_import (basic-with_one_bo)
[165.949617] Starting subtest: basic-with_one_bo
[165.972946] Subtest basic-with_one_bo: SUCCESS (0.023s)
[166.108439] [035/131] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[166.189517] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[166.191234] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[166.337118] [036/131] (853s left) syncobj_wait (single-wait-signaled)
[166.396767] Starting subtest: single-wait-signaled
[166.397716] Subtest single-wait-signaled: SUCCESS (0.000s)
[166.514111] [037/131] (853s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[171.509187] Starting subtest: pr-cursor-plane-update-sf
[171.510882] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[172.380737] [038/131] (847s left) kms_cursor_crc (cursor-onscreen-256x256)
[172.616188] Starting subtest: cursor-onscreen-256x256
[172.619805] Starting dynamic subtest: pipe-A-eDP-1
[174.741577] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[174.767047] Starting dynamic subtest: pipe-D-eDP-1
[177.508810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.746s)
[177.509706] Subtest cursor-onscreen-256x256: SUCCESS (4.892s)
[178.327080] [039/131] (842s left) kms_vrr (flipline)
[178.426614] Starting subtest: flipline
[178.429239] Subtest flipline: SKIP (0.000s)
[178.513824] [040/131] (841s left) kms_chamelium_color (ctm-0-50)
[178.609306] Subtest ctm-0-50: SKIP (0.000s)
[178.647422] [041/131] (841s left) gem_mmap_wc (fault-concurrent)
[178.699793] Subtest fault-concurrent: SKIP (0.000s)
[178.758887] [042/131] (841s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[178.887832] Starting subtest: cursorA-vs-flipB-varying-size
[178.889690] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[179.048983] [043/131] (841s left) gem_exec_schedule (fairslice)
[179.116528] Starting subtest: fairslice
[179.117392] Starting dynamic subtest: rcs0
[181.139517] Dynamic subtest rcs0: SUCCESS (2.021s)
[181.145801] Starting dynamic subtest: bcs0
[183.157515] Dynamic subtest bcs0: SUCCESS (2.017s)
[183.164484] Starting dynamic subtest: vcs0
[185.182073] Dynamic subtest vcs0: SUCCESS (2.023s)
[185.188571] Starting dynamic subtest: vcs1
[187.200633] Dynamic subtest vcs1: SUCCESS (2.017s)
[187.207520] Starting dynamic subtest: vecs0
[189.219265] Dynamic subtest vecs0: SUCCESS (2.017s)
[189.226334] Starting dynamic subtest: ccs0
[191.238968] Dynamic subtest ccs0: SUCCESS (2.019s)
[191.240075] Subtest fairslice: SUCCESS (12.120s)
[191.554104] [044/131] (828s left) syncobj_wait (signal)
[191.604634] Starting subtest: signal
[191.605516] Subtest signal: SUCCESS (0.000s)
[191.744249] [045/131] (828s left) gem_exec_schedule (thriceslice)
[191.802243] Starting subtest: thriceslice
[191.803202] Starting dynamic subtest: rcs0
[191.859972] Dynamic subtest rcs0: SUCCESS (0.059s)
[191.870818] Starting dynamic subtest: bcs0
[191.918117] Dynamic subtest bcs0: SUCCESS (0.056s)
[191.927629] Starting dynamic subtest: vcs0
[191.952104] Dynamic subtest vcs0: SUCCESS (0.032s)
[191.961213] Starting dynamic subtest: vcs1
[191.983110] Dynamic subtest vcs1: SUCCESS (0.030s)
[191.990544] Starting dynamic subtest: vecs0
[192.038258] Dynamic subtest vecs0: SUCCESS (0.054s)
[192.048939] Starting dynamic subtest: ccs0
[192.097032] Dynamic subtest ccs0: SUCCESS (0.056s)
[192.098520] Subtest thriceslice: SUCCESS (0.297s)
[192.420236] [046/131] (828s left) gem_exec_balancer (hog)
[192.492817] Starting subtest: hog
[192.494598] Subtest hog: SKIP (0.000s)
[192.805997] [047/131] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[192.887827] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[192.889645] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[192.988469] [048/131] (827s left) gem_partial_pwrite_pread (write)
[193.044357] Subtest write: SKIP (0.000s)
[193.105627] [049/131] (827s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[194.957876] Starting subtest: modeset-lpsp-stress-no-wait
[204.791739] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.834s)
[204.883656] [050/131] (815s left) kms_plane_multiple (tiling-4)
[204.967302] Starting subtest: tiling-4
[204.968173] Starting dynamic subtest: pipe-A-eDP-1
[208.660206] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.693s)
[208.667354] Starting dynamic subtest: pipe-B-eDP-1
[213.043752] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.381s)
[213.054816] Starting dynamic subtest: pipe-C-eDP-1
[217.378880] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.334s)
[217.385411] Starting dynamic subtest: pipe-D-eDP-1
[221.688035] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.307s)
[221.688959] Subtest tiling-4: SUCCESS (16.721s)
[222.520300] [051/131] (798s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[222.614474] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[222.615432] Starting dynamic subtest: pipe-A-eDP-1
[222.624143] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.631221] Starting dynamic subtest: pipe-B-eDP-1
[222.640673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.648954] Starting dynamic subtest: pipe-C-eDP-1
[222.657582] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.663819] Starting dynamic subtest: pipe-D-eDP-1
[222.672629] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.674306] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[224.791872] [052/131] (795s left) kms_big_fb (linear-32bpp-rotate-270)
[224.894561] Starting subtest: linear-32bpp-rotate-270
[224.913307] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[225.071544] [053/131] (795s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[225.167616] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[225.168743] Starting dynamic subtest: pipe-A-default-mode
[226.345420] Dynamic subtest pipe-A-default-mode: SKIP (1.177s)
[226.347179] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.179s)
[226.532769] [054/131] (794s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[226.637520] Starting subtest: fbcpsr-indfb-scaledprimary
[232.366474] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.730s)
[232.555713] [055/131] (788s left) gem_exec_flush (basic-wb-ro-default)
[232.614289] Starting subtest: basic-wb-ro-default
[238.071118] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[238.273362] [056/131] (782s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[238.381364] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[238.383017] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[238.521257] [057/131] (782s left) kms_flip (2x-blocking-wf_vblank)
[238.619509] Starting subtest: 2x-blocking-wf_vblank
[238.630076] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[238.768648] [058/131] (782s left) core_setmaster (master-drop-set-root)
[238.845428] Starting subtest: master-drop-set-root
[238.858372] Subtest master-drop-set-root: SUCCESS (0.013s)
[238.914147] [059/131] (782s left) gem_partial_pwrite_pread (reads)
[238.966635] Subtest reads: SKIP (0.000s)
[239.038929] [060/131] (781s left) kms_pm_rpm (fences-dpms)
[241.059419] Starting subtest: fences-dpms
[241.061940] Subtest fences-dpms: SKIP (0.000s)
[241.444439] [061/131] (779s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[241.495146] Starting subtest: multi-wait-all-for-submit-signaled
[241.496137] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[241.626132] [062/131] (779s left) kms_chamelium_edid (dp-edid-resolution-list)
[241.992186] Subtest dp-edid-resolution-list: SKIP (0.000s)
[242.827026] [063/131] (778s left) gem_mmap_gtt (bad-object)
[242.882758] Subtest bad-object: SKIP (0.000s)
[242.942978] [064/131] (778s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[243.042413] Starting subtest: async-flip-with-page-flip-events-tiled
[243.413778] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[246.221752] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[246.228336] Starting dynamic subtest: pipe-A-eDP-1-4
[248.407695] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[248.417225] Starting dynamic subtest: pipe-A-eDP-1-4
[250.418468] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[250.428079] Starting dynamic subtest: pipe-A-eDP-1-x
[252.597085] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[252.962577] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[255.759986] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[255.776613] Starting dynamic subtest: pipe-B-eDP-1-4
[257.990242] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.228s)
[257.999678] Starting dynamic subtest: pipe-B-eDP-1-4
[259.999845] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[260.009581] Starting dynamic subtest: pipe-B-eDP-1-x
[262.190106] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[262.561242] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[265.295323] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.738s)
[265.302505] Starting dynamic subtest: pipe-C-eDP-1-4
[267.470966] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[267.477954] Starting dynamic subtest: pipe-C-eDP-1-4
[269.481637] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[269.489201] Starting dynamic subtest: pipe-C-eDP-1-x
[271.660770] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[272.037440] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[274.821542] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[274.831071] Starting dynamic subtest: pipe-D-eDP-1-4
[276.985483] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[276.995044] Starting dynamic subtest: pipe-D-eDP-1-4
[278.996350] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[279.006304] Starting dynamic subtest: pipe-D-eDP-1-x
[281.174989] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[281.176704] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.129s)
[282.353063] [065/131] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[282.449503] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[282.451241] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[282.567492] [066/131] (738s left) gem_exec_alignment (many)
[282.629964] Starting subtest: many
[306.102324] Subtest many: SUCCESS (23.467s)
[307.904248] [067/131] (713s left) kms_psr (psr-dpms)
[308.036513] Starting subtest: psr-dpms
[308.037727] Starting dynamic subtest: eDP-1
[311.050358] Dynamic subtest eDP-1: SUCCESS (3.013s)
[311.051268] Subtest psr-dpms: SUCCESS (3.014s)
[311.929021] [068/131] (709s left) gem_ctx_persistence (engines-mixed-process)
[311.981513] Starting subtest: engines-mixed-process
[311.982414] Starting dynamic subtest: rcs0
[313.892513] Dynamic subtest rcs0: SUCCESS (1.910s)
[313.902595] Starting dynamic subtest: bcs0
[315.896028] Dynamic subtest bcs0: SUCCESS (2.001s)
[315.908015] Starting dynamic subtest: vcs0
[317.893169] Dynamic subtest vcs0: SUCCESS (1.996s)
[317.909431] Starting dynamic subtest: vcs1
[319.903853] Dynamic subtest vcs1: SUCCESS (2.009s)
[319.914587] Starting dynamic subtest: vecs0
[321.921613] Dynamic subtest vecs0: SUCCESS (2.016s)
[321.932490] Starting dynamic subtest: ccs0
[323.846820] Dynamic subtest ccs0: SUCCESS (1.921s)
[323.847921] Subtest engines-mixed-process: SUCCESS (11.863s)
[323.971493] [069/131] (697s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[324.072199] Starting subtest: 4-tiled-32bpp-rotate-180
[325.595264] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.523s)
[325.850620] [070/131] (695s left) prime_vgem (coherency-gtt)
[325.927550] Starting subtest: coherency-gtt
[325.929273] Subtest coherency-gtt: SKIP (0.000s)
[326.070237] [071/131] (695s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[326.291907] Starting subtest: cursor-rapid-movement-128x42
[326.330345] Subtest cursor-rapid-movement-128x42: SKIP (0.037s)
[326.545796] [072/131] (694s left) gem_exec_balancer (waits)
[326.609736] Starting subtest: waits
[333.076563] Subtest waits: SUCCESS (6.464s)
[333.403364] [073/131] (688s left) sysfs_preempt_timeout (invalid)
[333.466446] Starting subtest: invalid
[333.467421] Starting dynamic subtest: vecs0
[333.468352] Dynamic subtest vecs0: SUCCESS (0.000s)
[333.476922] Starting dynamic subtest: ccs0
[333.477800] Dynamic subtest ccs0: SUCCESS (0.000s)
[333.484721] Starting dynamic subtest: vcs0
[333.485590] Dynamic subtest vcs0: SUCCESS (0.000s)
[333.492251] Starting dynamic subtest: bcs0
[333.493058] Dynamic subtest bcs0: SUCCESS (0.000s)
[333.499505] Starting dynamic subtest: rcs0
[333.500343] Dynamic subtest rcs0: SUCCESS (0.000s)
[333.507215] Starting dynamic subtest: vcs1
[333.508064] Dynamic subtest vcs1: SUCCESS (0.000s)
[333.508889] Subtest invalid: SUCCESS (0.005s)
[333.597203] [074/131] (687s left) gem_spin_batch (resubmit-all)
[333.657321] Starting subtest: resubmit-all
[333.658252] Starting dynamic subtest: rcs0
[333.674565] Dynamic subtest rcs0: SUCCESS (0.017s)
[333.683257] Starting dynamic subtest: bcs0
[333.684103] Dynamic subtest bcs0: SUCCESS (0.003s)
[333.691073] Starting dynamic subtest: vcs0
[333.691941] Dynamic subtest vcs0: SUCCESS (0.002s)
[333.698810] Starting dynamic subtest: vcs1
[333.699676] Dynamic subtest vcs1: SUCCESS (0.002s)
[333.706515] Starting dynamic subtest: vecs0
[333.707444] Dynamic subtest vecs0: SUCCESS (0.002s)
[333.714290] Starting dynamic subtest: ccs0
[333.715229] Dynamic subtest ccs0: SUCCESS (0.003s)
[333.716031] Subtest resubmit-all: SUCCESS (0.033s)
[334.990782] [075/131] (686s left) gem_exec_gttfill (basic)
[335.060670] Starting subtest: basic
[338.233946] Subtest basic: SUCCESS (3.172s)
[338.440083] [076/131] (683s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[338.575444] Starting subtest: yf-tiled-16bpp-rotate-270
[338.577137] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[338.686432] [077/131] (682s left) gem_ctx_persistence (file)
[338.749454] Starting subtest: file
[338.897394] Subtest file: SUCCESS (0.148s)
[339.060198] [078/131] (682s left) gem_fenced_exec_thrash (too-many-fences)
[339.123519] Subtest too-many-fences: SKIP (0.000s)
[339.191339] [079/131] (682s left) api_intel_bb (misplaced-blitter)
[339.242063] Starting subtest: misplaced-blitter
[339.247199] Subtest misplaced-blitter: SUCCESS (0.007s)
[339.418338] [080/131] (682s left) gen7_exec_parse (basic-rejected)
[339.475499] Subtest basic-rejected: SKIP (0.000s)
[339.553627] [081/131] (682s left) gem_pxp (hw-rejects-pxp-context)
[339.677277] Starting subtest: hw-rejects-pxp-context
[339.679383] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[339.813898] [082/131] (681s left) gem_softpin (evict-active-interruptible)
[339.880743] Starting subtest: evict-active-interruptible
[339.887253] Subtest evict-active-interruptible: SUCCESS (0.007s)
[340.027256] [083/131] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[340.118671] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[340.120422] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.230429] [084/131] (681s left) syncobj_timeline (invalid-signal-zero-handles)
[340.292755] Starting subtest: invalid-signal-zero-handles
[340.293816] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[340.412819] [085/131] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[340.501235] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[340.502812] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[340.611324] [086/131] (681s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[340.700562] Starting subtest: x-tiled-8bpp-rotate-270
[340.720394] Subtest x-tiled-8bpp-rotate-270: SKIP (0.019s)
[340.851475] [087/131] (681s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[340.953231] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[340.954911] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[341.084493] [088/131] (680s left) i915_pm_freq_api (freq-reset)
[341.156665] Starting subtest: freq-reset
[341.157601] Starting dynamic subtest: gt0
[341.347077] Dynamic subtest gt0: SUCCESS (0.191s)
[341.353922] Starting dynamic subtest: gt1
[341.514984] Dynamic subtest gt1: SUCCESS (0.166s)
[341.516210] Subtest freq-reset: SUCCESS (0.358s)
[341.606105] [089/131] (680s left) gem_unfence_active_buffers
[341.804099] [090/131] (680s left) syncobj_timeline (reset-unsignaled)
[341.866492] Starting subtest: reset-unsignaled
[341.867395] Subtest reset-unsignaled: SUCCESS (0.000s)
[341.996059] [091/131] (680s left) gem_render_copy (y-tiled)
[342.058805] Starting subtest: y-tiled
[342.060676] Subtest y-tiled: SKIP (0.000s)
[342.259081] [092/131] (679s left) gem_wait (busy)
[342.336220] Starting subtest: busy
[342.337159] Starting dynamic subtest: all-engines
[343.898557] Dynamic subtest all-engines: SUCCESS (1.559s)
[343.908575] Starting dynamic subtest: rcs0
[344.440322] Dynamic subtest rcs0: SUCCESS (0.541s)
[344.450404] Starting dynamic subtest: bcs0
[344.981280] Dynamic subtest bcs0: SUCCESS (0.540s)
[344.990639] Starting dynamic subtest: vcs0
[346.905239] Dynamic subtest vcs0: SUCCESS (1.920s)
[346.915734] Starting dynamic subtest: vcs1
[348.889101] Dynamic subtest vcs1: SUCCESS (1.981s)
[348.899246] Starting dynamic subtest: vecs0
[350.936842] Dynamic subtest vecs0: SUCCESS (2.045s)
[350.946280] Starting dynamic subtest: ccs0
[351.477941] Dynamic subtest ccs0: SUCCESS (0.541s)
[351.479435] Subtest busy: SUCCESS (9.142s)
[351.693732] [093/131] (670s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[351.805988] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[351.807897] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[351.915065] [094/131] (670s left) i915_drm_fdinfo (busy-check-all)
[351.954333] Starting subtest: busy-check-all
[351.955326] Starting dynamic subtest: rcs0
[351.959427] Dynamic subtest rcs0: SKIP (0.005s)
[351.969147] Starting dynamic subtest: bcs0
[351.971106] Dynamic subtest bcs0: SKIP (0.000s)
[351.984316] Starting dynamic subtest: vcs0
[351.986220] Dynamic subtest vcs0: SKIP (0.000s)
[351.995209] Starting dynamic subtest: vcs1
[351.996882] Dynamic subtest vcs1: SKIP (0.000s)
[352.004063] Starting dynamic subtest: vecs0
[352.005791] Dynamic subtest vecs0: SKIP (0.000s)
[352.012985] Starting dynamic subtest: ccs0
[352.014735] Dynamic subtest ccs0: SKIP (0.000s)
[352.016435] Subtest busy-check-all: SKIP (0.012s)
[352.043473] [095/131] (670s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[352.159290] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[359.050998] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.889s)
[359.227947] [096/131] (663s left) gem_gtt_cpu_tlb
[359.353243] [097/131] (662s left) gem_eio (wait-wedge-10ms)
[359.536277] Starting subtest: wait-wedge-10ms
[360.976628] Subtest wait-wedge-10ms: SUCCESS (1.441s)
[361.157862] [098/131] (661s left) core_setmaster_vs_auth
[361.332986] [099/131] (661s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[361.443257] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[370.531782] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.088s)
[371.393572] [100/131] (650s left) kms_flip (2x-absolute-wf_vblank)
[371.492833] Starting subtest: 2x-absolute-wf_vblank
[371.502777] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[371.600995] [101/131] (650s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[371.694408] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[371.695415] Starting dynamic subtest: pipe-A-eDP-1
[371.716817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[371.725735] Starting dynamic subtest: pipe-B-eDP-1
[371.739879] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[371.748572] Starting dynamic subtest: pipe-C-eDP-1
[371.762271] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[371.770816] Starting dynamic subtest: pipe-D-eDP-1
[371.785163] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[371.785981] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[373.962545] [102/131] (648s left) i915_pm_rps (engine-order)
[374.032384] Starting subtest: engine-order
[380.180499] Subtest engine-order: SUCCESS (6.146s)
[380.341555] [103/131] (642s left) kms_rotation_crc (bad-pixel-format)
[380.429330] Starting subtest: bad-pixel-format
[380.431096] Subtest bad-pixel-format: SKIP (0.001s)
[380.524263] [104/131] (641s left) perf_pmu (module-unload)
[380.618213] Starting subtest: module-unload
[388.885739] Subtest module-unload: FAIL (8.231s)
[388.904998] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.905713] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[388.907424] [105/131] (633s left) gem_render_copy (y-tiled-to-vebox-linear)
[390.372037] Starting subtest: y-tiled-to-vebox-linear
[390.374282] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[390.529184] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[390.530515] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[390.535484] [106/131] (632s left) gem_cs_tlb (engines)
[390.592958] Starting subtest: engines
[390.594065] Starting dynamic subtest: rcs0
[392.751622] Dynamic subtest rcs0: SUCCESS (2.155s)
[392.758889] Starting dynamic subtest: bcs0
[394.904483] Dynamic subtest bcs0: SUCCESS (2.151s)
[394.913510] Starting dynamic subtest: vcs0
[397.056715] Dynamic subtest vcs0: SUCCESS (2.151s)
[397.066054] Starting dynamic subtest: vcs1
[399.210228] Dynamic subtest vcs1: SUCCESS (2.153s)
[399.219211] Starting dynamic subtest: vecs0
[401.363255] Dynamic subtest vecs0: SUCCESS (2.152s)
[401.371878] Starting dynamic subtest: ccs0
[403.518660] Dynamic subtest ccs0: SUCCESS (2.154s)
[403.519748] Subtest engines: SUCCESS (12.922s)
[403.681325] [107/131] (618s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[403.782855] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[403.784617] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[403.917927] [108/131] (618s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[403.976952] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[403.977996] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[404.102320] [109/131] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[404.201230] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[411.484203] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.283s)
[411.685989] [110/131] (611s left) kms_rotation_crc (exhaust-fences)
[411.775763] Starting subtest: exhaust-fences
[411.777626] Subtest exhaust-fences: SKIP (0.000s)
[411.868473] [111/131] (610s left) kms_atomic (plane-overlay-legacy)
[411.964025] Starting subtest: plane-overlay-legacy
[411.964846] Starting dynamic subtest: pipe-A-eDP-1
[412.396621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[412.397808] Subtest plane-overlay-legacy: SUCCESS (0.433s)
[413.272971] [112/131] (609s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[413.372184] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[413.373030] Starting dynamic subtest: pipe-A-eDP-1
[413.593250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.210s)
[413.600379] Starting dynamic subtest: pipe-B-eDP-1
[414.811191] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[414.818554] Starting dynamic subtest: pipe-C-eDP-1
[416.013691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[416.022421] Starting dynamic subtest: pipe-D-eDP-1
[417.243723] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[417.244576] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.862s)
[418.415531] [113/131] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[418.519965] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[418.521810] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[418.622029] [114/131] (604s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[418.998117] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[419.802152] [115/131] (603s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[419.895097] Starting subtest: fbc-psr2-sprite-plane-onoff
[419.895973] Starting dynamic subtest: eDP-1
[419.897724] Dynamic subtest eDP-1: SKIP (0.000s)
[419.899408] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[419.982538] [116/131] (602s left) kms_psr (pr-primary-page-flip)
[420.071267] Starting subtest: pr-primary-page-flip
[420.072961] Subtest pr-primary-page-flip: SKIP (0.000s)
[420.165311] [117/131] (602s left) gem_exec_reloc (basic-wc-gtt)
[420.219451] Subtest basic-wc-gtt: SKIP (0.000s)
[420.291381] [118/131] (602s left) kms_plane_scaling (intel-max-src-size)
[420.391194] Starting subtest: intel-max-src-size
[420.393904] Subtest intel-max-src-size: SKIP (0.000s)
[420.523878] [119/131] (602s left) gem_eio (in-flight-1us)
[420.747183] Starting subtest: in-flight-1us
[428.843719] Subtest in-flight-1us: SUCCESS (8.096s)
[429.019612] [120/131] (594s left) kms_psr (fbc-pr-dpms)
[429.100235] Starting subtest: fbc-pr-dpms
[429.101916] Subtest fbc-pr-dpms: SKIP (0.000s)
[429.190679] [121/131] (593s left) gem_exec_schedule (noreorder)
[429.372461] Starting subtest: noreorder
[429.373694] Starting dynamic subtest: rcs0
[429.460065] Dynamic subtest rcs0: SUCCESS (0.087s)
[429.471755] Starting dynamic subtest: vcs0
[430.920059] Dynamic subtest vcs0: SUCCESS (1.456s)
[430.928833] Starting dynamic subtest: vcs1
[432.895888] Dynamic subtest vcs1: SUCCESS (1.973s)
[432.906239] Starting dynamic subtest: vecs0
[434.937446] Dynamic subtest vecs0: SUCCESS (2.039s)
[434.946775] Starting dynamic subtest: ccs0
[434.995561] Dynamic subtest ccs0: SUCCESS (0.058s)
[434.996826] Subtest noreorder: SUCCESS (5.624s)
[435.206023] [122/131] (587s left) gem_ccs (block-multicopy-inplace)
[435.264237] Starting subtest: block-multicopy-inplace
[435.266541] Subtest block-multicopy-inplace: SKIP (0.000s)
[435.392804] [123/131] (587s left) gem_exec_whisper (basic-queues-priority)
[435.457574] Starting subtest: basic-queues-priority
[459.788737] Subtest basic-queues-priority: SUCCESS (24.328s)
[459.989070] [124/131] (563s left) sw_sync (sync_merge)
[460.023710] Starting subtest: sync_merge
[460.024704] Subtest sync_merge: SUCCESS (0.000s)
[460.099786] [125/131] (563s left) kms_legacy_colorkey (invalid-plane)
[460.186076] Starting subtest: invalid-plane
[460.186921] Starting dynamic subtest: zero-id
[460.187797] Dynamic subtest zero-id: SUCCESS (0.000s)
[460.195502] Starting dynamic subtest: outrange-id
[460.196304] Dynamic subtest outrange-id: SUCCESS (0.000s)
[460.197108] Subtest invalid-plane: SUCCESS (0.001s)
[460.276772] [126/131] (562s left) kms_dirtyfb (default-dirtyfb-ioctl)
[460.368375] Starting subtest: default-dirtyfb-ioctl
[460.369211] Starting dynamic subtest: A-eDP-1
[461.934557] Dynamic subtest A-eDP-1: SUCCESS (1.566s)
[461.935493] Subtest default-dirtyfb-ioctl: SUCCESS (1.567s)
[462.778316] [127/131] (560s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[467.836944] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[467.839889] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[468.693597] [128/131] (554s left) prime_mmap (test_map_unmap)
[468.754874] Starting subtest: test_map_unmap
[468.755827] Starting dynamic subtest: test_map_unmap-smem
[468.785373] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[468.786359] Subtest test_map_unmap: SUCCESS (0.032s)
[468.901074] [129/131] (554s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[468.954457] Starting subtest: etime-multi-wait-all-for-submit-submitted
[469.061291] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[469.154730] [130/131] (554s left) gem_userptr_blits (process-exit)
[469.226236] Starting subtest: process-exit
[469.233868] Subtest process-exit: SUCCESS (0.008s)
[469.387586] [131/131] (554s left) perf_pmu (busy-idle-check-all)
[469.424213] Starting subtest: busy-idle-check-all
[469.425032] Starting dynamic subtest: rcs0
[470.077208] Dynamic subtest rcs0: SUCCESS (0.652s)
[470.089151] Starting dynamic subtest: bcs0
[470.728477] Dynamic subtest bcs0: SUCCESS (0.649s)
[470.740266] Starting dynamic subtest: vcs0
[471.897750] Dynamic subtest vcs0: SUCCESS (1.164s)
[471.908576] Starting dynamic subtest: vcs1
[473.882213] Dynamic subtest vcs1: SUCCESS (1.981s)
[473.893200] Starting dynamic subtest: vecs0
[475.930691] Dynamic subtest vecs0: SUCCESS (2.046s)
[475.941577] Starting dynamic subtest: ccs0
[476.586256] Dynamic subtest ccs0: SUCCESS (0.656s)
[476.587515] Subtest busy-idle-check-all: SUCCESS (7.163s)
[476.720970] 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.