[58.275549] Initializing watchdogs
[58.275599]   /dev/watchdog0
[58.290234] [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.294636] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.296966] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.300397] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[58.442612] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[58.447065] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[58.569168] [002/131] (960s left) prime_vgem (sync)
[58.692853] Starting subtest: sync
[58.694919] Starting dynamic subtest: rcs0
[58.741874] Dynamic subtest rcs0: SUCCESS (0.051s)
[58.748523] Starting dynamic subtest: bcs0
[58.808703] Dynamic subtest bcs0: SUCCESS (0.066s)
[58.815646] Starting dynamic subtest: vcs0
[58.857272] Dynamic subtest vcs0: SUCCESS (0.049s)
[58.863755] Starting dynamic subtest: vcs1
[58.902369] Dynamic subtest vcs1: SUCCESS (0.045s)
[58.909137] Starting dynamic subtest: vecs0
[58.949536] Dynamic subtest vecs0: SUCCESS (0.047s)
[58.956403] Starting dynamic subtest: ccs0
[58.995589] Dynamic subtest ccs0: SUCCESS (0.044s)
[58.998095] Subtest sync: SUCCESS (0.304s)
[59.138777] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[59.141929] [003/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[59.232876] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[59.237160] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[59.373186] [004/131] (959s left) i915_suspend (fence-restore-tiled2untiled)
[59.429940] Starting subtest: fence-restore-tiled2untiled
[59.433505] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[59.563124] [005/131] (959s left) kms_atomic_transition (plane-all-transition)
[59.652030] Starting subtest: plane-all-transition
[59.653978] Starting dynamic subtest: pipe-A-eDP-1
[62.194072] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.539s)
[62.501454] Starting dynamic subtest: pipe-B-eDP-1
[65.735159] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.237s)
[66.052495] Subtest plane-all-transition: SUCCESS (6.392s)
[66.882473] [006/131] (952s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[67.068595] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[67.177356] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[67.291289] [007/131] (951s left) kms_color (ctm-negative)
[67.525029] Starting subtest: ctm-negative
[67.527436] Starting dynamic subtest: pipe-A-eDP-1
[68.256131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[68.264281] Starting dynamic subtest: pipe-B-eDP-1
[69.671270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s)
[69.679797] Starting dynamic subtest: pipe-C-eDP-1
[71.049773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[71.059281] Starting dynamic subtest: pipe-D-eDP-1
[72.381654] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[72.383997] Subtest ctm-negative: SUCCESS (4.855s)
[73.214571] [008/131] (945s left) syncobj_timeline (wait-for-submit-snapshot)
[73.277051] Starting subtest: wait-for-submit-snapshot
[73.359387] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[73.456638] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[73.553272] Starting subtest: fbcpsr-slowdraw
[98.854015] Subtest fbcpsr-slowdraw: SUCCESS (25.300s)
[99.026143] [010/131] (920s left) kms_joiner (basic-max-non-joiner)
[99.136733] Starting subtest: basic-max-non-joiner
[99.140824] Subtest basic-max-non-joiner: SKIP (0.000s)
[99.226935] [011/131] (919s left) kms_psr (pr-cursor-mmap-cpu)
[99.321982] Starting subtest: pr-cursor-mmap-cpu
[99.326687] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[99.419958] [012/131] (919s left) vgem_basic (create)
[99.458077] Starting subtest: create
[99.459991] Subtest create: SUCCESS (0.000s)
[99.536544] [013/131] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[99.637090] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[99.640421] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[99.778129] [014/131] (919s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[99.872752] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[99.876671] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[100.989007] [015/131] (918s left) kms_selftest (drm_dp_mst_helper)
[101.023898] Starting subtest: drm_dp_mst_helper
[101.031050] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[101.165583] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.135s)
[101.176979] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[101.303879] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.137s)
[101.311998] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[101.431072] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.126s)
[101.433183] Subtest drm_dp_mst_helper: SUCCESS (0.407s)
[101.652253] [016/131] (917s left) kms_lease (lease-uevent)
[101.761913] Starting subtest: lease-uevent
[102.777642] Subtest lease-uevent: SUCCESS (1.017s)
[102.874500] [017/131] (916s left) gem_exec_fence (invalid-timeline-fence-array)
[103.396795] Starting subtest: invalid-timeline-fence-array
[103.402269] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[105.038732] [018/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[105.144033] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[105.148243] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[105.268305] [019/131] (914s left) kms_feature_discovery (display-4x)
[105.357207] Starting subtest: display-4x
[105.361738] Subtest display-4x: SKIP (0.000s)
[105.460494] [020/131] (914s left) perf (oa-formats)
[105.596930] Starting subtest: oa-formats
[105.599216] Starting dynamic subtest: 0-rcs0
[105.612074] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[105.621195] Starting dynamic subtest: 1-vcs1
[105.632318] Dynamic subtest 1-vcs1: SUCCESS (0.020s)
[105.634596] Subtest oa-formats: SUCCESS (0.037s)
[105.681339] [021/131] (913s left) api_intel_allocator (execbuf-with-allocator)
[105.743931] Starting subtest: execbuf-with-allocator
[105.747357] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[105.864249] [022/131] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[105.960858] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[113.419917] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.462s)
[113.600990] [023/131] (906s left) kms_cursor_edge_walk (256x256-left-edge)
[113.695419] Starting subtest: 256x256-left-edge
[113.697729] Starting dynamic subtest: pipe-A-eDP-1
[117.174332] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[117.182703] Starting dynamic subtest: pipe-D-eDP-1
[120.300414] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[120.302758] Subtest 256x256-left-edge: SUCCESS (6.605s)
[121.116191] [024/131] (898s left) gem_exec_whisper (basic-fds-priority)
[121.194188] Starting subtest: basic-fds-priority
[146.266505] Subtest basic-fds-priority: SUCCESS (25.069s)
[146.472043] [025/131] (873s left) kms_sequence (get-forked-busy)
[146.563969] Starting subtest: get-forked-busy
[146.566726] Starting dynamic subtest: pipe-A-eDP-1
[148.508661] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s)
[148.518078] Starting dynamic subtest: pipe-B-eDP-1
[151.095277] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.584s)
[151.104049] Starting dynamic subtest: pipe-C-eDP-1
[153.703240] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[153.715398] Starting dynamic subtest: pipe-D-eDP-1
[156.252409] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[156.254776] Subtest get-forked-busy: SUCCESS (9.690s)
[157.147875] [026/131] (862s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[157.237536] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[157.239933] Starting dynamic subtest: pipe-A-default-mode
[157.537562] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[157.542239] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.301s)
[158.390176] [027/131] (861s left) kms_draw_crc (draw-method-mmap-wc)
[158.487939] Starting subtest: draw-method-mmap-wc
[158.489968] Starting dynamic subtest: xrgb8888-untiled
[158.752330] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[158.761576] Starting dynamic subtest: rgb565-untiled
[158.997351] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[159.004852] Starting dynamic subtest: xrgb2101010-untiled
[159.218626] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[159.226746] Starting dynamic subtest: xbgr16161616f-untiled
[159.462613] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[159.474688] Starting dynamic subtest: xrgb8888-xtiled
[159.607281] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[159.614543] Starting dynamic subtest: rgb565-xtiled
[159.785301] Dynamic subtest rgb565-xtiled: SUCCESS (0.177s)
[159.794851] Starting dynamic subtest: xrgb2101010-xtiled
[159.918641] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[159.926223] Starting dynamic subtest: xbgr16161616f-xtiled
[160.051546] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[160.059097] Starting dynamic subtest: xrgb8888-4tiled
[160.196461] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[160.203745] Starting dynamic subtest: rgb565-4tiled
[160.340652] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[160.347952] Starting dynamic subtest: xrgb2101010-4tiled
[160.473877] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[160.481027] Starting dynamic subtest: xbgr16161616f-4tiled
[160.642719] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[160.644535] Subtest draw-method-mmap-wc: SUCCESS (2.158s)
[160.768286] [028/131] (859s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[160.860200] Starting subtest: plane-upscale-factor-0-25-with-rotation
[160.862092] Starting dynamic subtest: pipe-A
[161.086822] Dynamic subtest pipe-A: SUCCESS (0.228s)
[161.094460] Starting dynamic subtest: pipe-B
[162.351527] Dynamic subtest pipe-B: SUCCESS (1.263s)
[162.359503] Starting dynamic subtest: pipe-C
[163.692714] Dynamic subtest pipe-C: SUCCESS (1.338s)
[163.706841] Starting dynamic subtest: pipe-D
[165.028041] Dynamic subtest pipe-D: SUCCESS (1.334s)
[165.030781] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.170s)
[166.241978] [029/131] (853s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[166.328413] Starting subtest: primary-y-tiled-reflect-x-270
[166.332706] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[166.423374] [030/131] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[166.530539] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[166.534600] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[166.669890] [031/131] (853s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[166.730549] Subtest writes-after-reads: SKIP (0.000s)
[166.810226] [032/131] (853s left) gem_mmap_gtt (isolation)
[166.866178] Subtest isolation: SKIP (0.000s)
[166.921323] [033/131] (853s left) gem_mmap_offset (pf-nonblock)
[166.983054] Starting subtest: pf-nonblock
[166.987897] Subtest pf-nonblock: SUCCESS (0.007s)
[167.159690] [034/131] (852s left) prime_self_import (basic-with_one_bo)
[167.193064] Starting subtest: basic-with_one_bo
[167.223074] Subtest basic-with_one_bo: SUCCESS (0.030s)
[167.363607] [035/131] (852s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[167.462481] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[167.465855] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[167.594375] [036/131] (852s left) syncobj_wait (single-wait-signaled)
[167.654674] Starting subtest: single-wait-signaled
[167.656575] Subtest single-wait-signaled: SUCCESS (0.000s)
[167.780046] [037/131] (852s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[172.806374] Starting subtest: pr-cursor-plane-update-sf
[172.810923] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[173.673860] [038/131] (846s left) kms_cursor_crc (cursor-onscreen-256x256)
[173.899760] Starting subtest: cursor-onscreen-256x256
[173.904789] Starting dynamic subtest: pipe-A-eDP-1
[176.213772] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.309s)
[176.243015] Starting dynamic subtest: pipe-D-eDP-1
[179.046043] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.808s)
[179.047869] Subtest cursor-onscreen-256x256: SUCCESS (5.143s)
[179.871268] [039/131] (840s left) kms_vrr (flipline)
[179.972781] Starting subtest: flipline
[179.979250] Subtest flipline: SKIP (0.000s)
[180.071056] [040/131] (840s left) kms_chamelium_color (ctm-0-50)
[180.171789] Subtest ctm-0-50: SKIP (0.000s)
[180.215936] [041/131] (840s left) gem_mmap_wc (fault-concurrent)
[180.271615] Subtest fault-concurrent: SKIP (0.000s)
[180.334042] [042/131] (840s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[180.445415] Starting subtest: cursorA-vs-flipB-varying-size
[180.449914] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[180.611702] [043/131] (839s left) gem_exec_schedule (fairslice)
[180.685973] Starting subtest: fairslice
[180.688170] Starting dynamic subtest: rcs0
[182.700066] Dynamic subtest rcs0: SUCCESS (2.019s)
[182.713380] Starting dynamic subtest: bcs0
[184.719483] Dynamic subtest bcs0: SUCCESS (2.018s)
[184.733531] Starting dynamic subtest: vcs0
[186.737471] Dynamic subtest vcs0: SUCCESS (2.017s)
[186.747151] Starting dynamic subtest: vcs1
[188.757108] Dynamic subtest vcs1: SUCCESS (2.016s)
[188.766298] Starting dynamic subtest: vecs0
[190.772705] Dynamic subtest vecs0: SUCCESS (2.017s)
[190.782682] Starting dynamic subtest: ccs0
[192.794077] Dynamic subtest ccs0: SUCCESS (2.019s)
[192.796150] Subtest fairslice: SUCCESS (12.113s)
[193.157961] [044/131] (827s left) syncobj_wait (signal)
[193.222984] Starting subtest: signal
[193.225197] Subtest signal: SUCCESS (0.000s)
[193.373370] [045/131] (827s left) gem_exec_schedule (thriceslice)
[193.455236] Starting subtest: thriceslice
[193.457253] Starting dynamic subtest: rcs0
[193.502036] Dynamic subtest rcs0: SUCCESS (0.056s)
[193.512995] Starting dynamic subtest: bcs0
[193.561200] Dynamic subtest bcs0: SUCCESS (0.057s)
[193.574163] Starting dynamic subtest: vcs0
[193.619123] Dynamic subtest vcs0: SUCCESS (0.056s)
[193.631764] Starting dynamic subtest: vcs1
[193.652765] Dynamic subtest vcs1: SUCCESS (0.032s)
[193.663421] Starting dynamic subtest: vecs0
[193.705090] Dynamic subtest vecs0: SUCCESS (0.052s)
[193.715606] Starting dynamic subtest: ccs0
[193.763902] Dynamic subtest ccs0: SUCCESS (0.057s)
[193.766495] Subtest thriceslice: SUCCESS (0.320s)
[194.090595] [046/131] (826s left) gem_exec_balancer (hog)
[194.155330] Starting subtest: hog
[194.160132] Subtest hog: SKIP (0.000s)
[194.478439] [047/131] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[194.574792] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[194.579131] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[194.701135] [048/131] (826s left) gem_partial_pwrite_pread (write)
[194.773197] Subtest write: SKIP (0.000s)
[194.832803] [049/131] (825s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[197.054417] Starting subtest: modeset-lpsp-stress-no-wait
[206.766676] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.712s)
[206.867594] [050/131] (813s left) kms_plane_multiple (tiling-4)
[206.975965] Starting subtest: tiling-4
[206.978285] Starting dynamic subtest: pipe-A-eDP-1
[210.659068] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.682s)
[210.667406] Starting dynamic subtest: pipe-B-eDP-1
[215.012080] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.352s)
[215.024765] Starting dynamic subtest: pipe-C-eDP-1
[219.325375] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.312s)
[219.334360] Starting dynamic subtest: pipe-D-eDP-1
[223.658971] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.332s)
[223.660818] Subtest tiling-4: SUCCESS (16.683s)
[224.500605] [051/131] (796s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[224.607198] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[224.609505] Starting dynamic subtest: pipe-A-eDP-1
[224.632357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.646231] Starting dynamic subtest: pipe-B-eDP-1
[224.668585] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.678124] Starting dynamic subtest: pipe-C-eDP-1
[224.699175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.706645] Starting dynamic subtest: pipe-D-eDP-1
[224.728184] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.732472] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[226.870579] [052/131] (794s left) kms_big_fb (linear-32bpp-rotate-270)
[226.993450] Starting subtest: linear-32bpp-rotate-270
[227.012296] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[227.175511] [053/131] (793s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[227.273097] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[227.275390] Starting dynamic subtest: pipe-A-default-mode
[228.408296] Dynamic subtest pipe-A-default-mode: SKIP (1.133s)
[228.412323] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.134s)
[228.600329] [054/131] (792s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[228.696643] Starting subtest: fbcpsr-indfb-scaledprimary
[234.449379] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.756s)
[234.630193] [055/131] (786s left) gem_exec_flush (basic-wb-ro-default)
[234.701042] Starting subtest: basic-wb-ro-default
[240.151931] Subtest basic-wb-ro-default: SUCCESS (5.452s)
[240.364468] [056/131] (780s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[240.473968] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[240.478550] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[240.610535] [057/131] (780s left) kms_flip (2x-blocking-wf_vblank)
[240.713167] Starting subtest: 2x-blocking-wf_vblank
[240.724100] Subtest 2x-blocking-wf_vblank: SKIP (0.013s)
[240.856251] [058/131] (780s left) core_setmaster (master-drop-set-root)
[240.946955] Starting subtest: master-drop-set-root
[240.958678] Subtest master-drop-set-root: SUCCESS (0.012s)
[241.008676] [059/131] (780s left) gem_partial_pwrite_pread (reads)
[241.058744] Subtest reads: SKIP (0.000s)
[241.140597] [060/131] (780s left) kms_pm_rpm (fences-dpms)
[243.082962] Starting subtest: fences-dpms
[243.088098] Subtest fences-dpms: SKIP (0.000s)
[243.471080] [061/131] (777s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[243.529726] Starting subtest: multi-wait-all-for-submit-signaled
[243.532079] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[243.651163] [062/131] (777s left) kms_chamelium_edid (dp-edid-resolution-list)
[244.032968] Subtest dp-edid-resolution-list: SKIP (0.000s)
[244.858396] [063/131] (776s left) gem_mmap_gtt (bad-object)
[244.924596] Subtest bad-object: SKIP (0.000s)
[244.992388] [064/131] (776s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[245.092169] Starting subtest: async-flip-with-page-flip-events-tiled
[245.465582] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[248.254146] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[248.265990] Starting dynamic subtest: pipe-A-eDP-1-4
[250.440400] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[250.448443] Starting dynamic subtest: pipe-A-eDP-1-4
[252.450718] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[252.458950] Starting dynamic subtest: pipe-A-eDP-1-x
[254.629548] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[255.017438] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[257.779779] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[257.788364] Starting dynamic subtest: pipe-B-eDP-1-4
[259.977994] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[259.995943] Starting dynamic subtest: pipe-B-eDP-1-4
[261.987665] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[261.996337] Starting dynamic subtest: pipe-B-eDP-1-x
[264.188268] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[264.550353] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[267.307917] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[267.316676] Starting dynamic subtest: pipe-C-eDP-1-4
[269.482766] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[269.490809] Starting dynamic subtest: pipe-C-eDP-1-4
[271.493235] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[271.504183] Starting dynamic subtest: pipe-C-eDP-1-x
[273.671806] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[274.033351] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[276.839200] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[276.850787] Starting dynamic subtest: pipe-D-eDP-1-4
[279.026182] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.187s)
[279.035676] Starting dynamic subtest: pipe-D-eDP-1-4
[281.035342] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.007s)
[281.049124] Starting dynamic subtest: pipe-D-eDP-1-x
[283.225037] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[283.227383] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.133s)
[284.441782] [065/131] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[284.543149] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[284.547082] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[284.680489] [066/131] (736s left) gem_exec_alignment (many)
[284.737559] Starting subtest: many
[308.005638] Subtest many: SUCCESS (23.265s)
[309.672417] [067/131] (711s left) kms_psr (psr-dpms)
[309.810086] Starting subtest: psr-dpms
[309.812358] Starting dynamic subtest: eDP-1
[312.753264] Dynamic subtest eDP-1: SUCCESS (2.943s)
[312.755565] Subtest psr-dpms: SUCCESS (2.944s)
[313.645545] [068/131] (707s left) gem_ctx_persistence (engines-mixed-process)
[313.710764] Starting subtest: engines-mixed-process
[313.713096] Starting dynamic subtest: rcs0
[314.917623] Dynamic subtest rcs0: SUCCESS (1.206s)
[314.928853] Starting dynamic subtest: bcs0
[316.871189] Dynamic subtest bcs0: SUCCESS (1.950s)
[316.881367] Starting dynamic subtest: vcs0
[318.880411] Dynamic subtest vcs0: SUCCESS (2.010s)
[318.891868] Starting dynamic subtest: vcs1
[320.886235] Dynamic subtest vcs1: SUCCESS (2.004s)
[320.897494] Starting dynamic subtest: vecs0
[322.932948] Dynamic subtest vecs0: SUCCESS (2.044s)
[322.944311] Starting dynamic subtest: ccs0
[324.925077] Dynamic subtest ccs0: SUCCESS (1.990s)
[324.927816] Subtest engines-mixed-process: SUCCESS (11.214s)
[325.033850] [069/131] (696s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[325.156413] Starting subtest: 4-tiled-32bpp-rotate-180
[326.579624] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.423s)
[326.772934] [070/131] (694s left) prime_vgem (coherency-gtt)
[326.853603] Starting subtest: coherency-gtt
[326.857183] Subtest coherency-gtt: SKIP (0.000s)
[326.981961] [071/131] (694s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[327.211211] Starting subtest: cursor-rapid-movement-128x42
[327.256312] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[327.496737] [072/131] (694s left) gem_exec_balancer (waits)
[327.554841] Starting subtest: waits
[334.017359] Subtest waits: SUCCESS (6.461s)
[334.351547] [073/131] (687s left) sysfs_preempt_timeout (invalid)
[334.421977] Starting subtest: invalid
[334.424317] Starting dynamic subtest: vecs0
[334.426605] Dynamic subtest vecs0: SUCCESS (0.000s)
[334.435487] Starting dynamic subtest: ccs0
[334.437686] Dynamic subtest ccs0: SUCCESS (0.000s)
[334.446506] Starting dynamic subtest: vcs0
[334.448812] Dynamic subtest vcs0: SUCCESS (0.000s)
[334.459353] Starting dynamic subtest: bcs0
[334.461630] Dynamic subtest bcs0: SUCCESS (0.000s)
[334.470198] Starting dynamic subtest: rcs0
[334.472113] Dynamic subtest rcs0: SUCCESS (0.000s)
[334.480760] Starting dynamic subtest: vcs1
[334.482975] Dynamic subtest vcs1: SUCCESS (0.000s)
[334.485187] Subtest invalid: SUCCESS (0.006s)
[334.560495] [074/131] (687s left) gem_spin_batch (resubmit-all)
[334.619529] Starting subtest: resubmit-all
[334.621893] Starting dynamic subtest: rcs0
[334.641946] Dynamic subtest rcs0: SUCCESS (0.022s)
[334.653968] Starting dynamic subtest: bcs0
[334.656324] Dynamic subtest bcs0: SUCCESS (0.003s)
[334.666753] Starting dynamic subtest: vcs0
[334.668601] Dynamic subtest vcs0: SUCCESS (0.002s)
[334.676654] Starting dynamic subtest: vcs1
[334.678558] Dynamic subtest vcs1: SUCCESS (0.002s)
[334.686552] Starting dynamic subtest: vecs0
[334.688428] Dynamic subtest vecs0: SUCCESS (0.002s)
[334.696716] Starting dynamic subtest: ccs0
[334.698597] Dynamic subtest ccs0: SUCCESS (0.003s)
[334.700759] Subtest resubmit-all: SUCCESS (0.037s)
[334.946530] [075/131] (686s left) gem_exec_gttfill (basic)
[335.017658] Starting subtest: basic
[338.132249] Subtest basic: SUCCESS (3.113s)
[338.348539] [076/131] (683s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[338.504408] Starting subtest: yf-tiled-16bpp-rotate-270
[338.508465] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[338.639207] [077/131] (683s left) gem_ctx_persistence (file)
[338.707146] Starting subtest: file
[338.838265] Subtest file: SUCCESS (0.131s)
[339.002684] [078/131] (682s left) gem_fenced_exec_thrash (too-many-fences)
[339.071581] Subtest too-many-fences: SKIP (0.000s)
[339.152515] [079/131] (682s left) api_intel_bb (misplaced-blitter)
[339.211887] Starting subtest: misplaced-blitter
[339.220056] Subtest misplaced-blitter: SUCCESS (0.009s)
[339.386240] [080/131] (682s left) gen7_exec_parse (basic-rejected)
[339.439994] Subtest basic-rejected: SKIP (0.000s)
[339.526192] [081/131] (682s left) gem_pxp (hw-rejects-pxp-context)
[339.640070] Starting subtest: hw-rejects-pxp-context
[339.644067] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[339.782716] [082/131] (682s left) gem_softpin (evict-active-interruptible)
[339.851330] Starting subtest: evict-active-interruptible
[339.857132] Subtest evict-active-interruptible: SUCCESS (0.006s)
[340.013522] [083/131] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[340.110992] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[340.114556] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.245568] [084/131] (681s left) syncobj_timeline (invalid-signal-zero-handles)
[340.306471] Starting subtest: invalid-signal-zero-handles
[340.308503] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[340.442119] [085/131] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[340.538079] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[340.541370] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[340.680920] [086/131] (681s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[340.776604] Starting subtest: x-tiled-8bpp-rotate-270
[340.798660] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[340.957135] [087/131] (681s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[341.054981] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[341.058919] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[341.166467] [088/131] (681s left) i915_pm_freq_api (freq-reset)
[341.227519] Starting subtest: freq-reset
[341.229451] Starting dynamic subtest: gt0
[341.423615] Dynamic subtest gt0: SUCCESS (0.193s)
[341.432440] Starting dynamic subtest: gt1
[341.592893] Dynamic subtest gt1: SUCCESS (0.168s)
[341.595617] Subtest freq-reset: SUCCESS (0.364s)
[341.690434] [089/131] (680s left) gem_unfence_active_buffers
[341.864174] [090/131] (680s left) syncobj_timeline (reset-unsignaled)
[341.924536] Starting subtest: reset-unsignaled
[341.926757] Subtest reset-unsignaled: SUCCESS (0.000s)
[342.053312] [091/131] (680s left) gem_render_copy (y-tiled)
[342.113345] Starting subtest: y-tiled
[342.117922] Subtest y-tiled: SKIP (0.000s)
[342.327632] [092/131] (680s left) gem_wait (busy)
[342.390686] Starting subtest: busy
[342.393097] Starting dynamic subtest: all-engines
[343.893467] Dynamic subtest all-engines: SUCCESS (1.500s)
[343.910699] Starting dynamic subtest: rcs0
[344.437715] Dynamic subtest rcs0: SUCCESS (0.542s)
[344.448729] Starting dynamic subtest: bcs0
[344.979128] Dynamic subtest bcs0: SUCCESS (0.541s)
[344.990401] Starting dynamic subtest: vcs0
[346.901473] Dynamic subtest vcs0: SUCCESS (1.920s)
[346.912495] Starting dynamic subtest: vcs1
[348.886612] Dynamic subtest vcs1: SUCCESS (1.982s)
[348.898295] Starting dynamic subtest: vecs0
[350.933079] Dynamic subtest vecs0: SUCCESS (2.044s)
[350.944897] Starting dynamic subtest: ccs0
[351.475737] Dynamic subtest ccs0: SUCCESS (0.541s)
[351.478266] Subtest busy: SUCCESS (9.085s)
[351.696553] [093/131] (670s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[351.806756] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[351.811247] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[351.928433] [094/131] (670s left) i915_drm_fdinfo (busy-check-all)
[351.971899] Starting subtest: busy-check-all
[351.974308] Starting dynamic subtest: rcs0
[351.979046] Dynamic subtest rcs0: SKIP (0.004s)
[351.994188] Starting dynamic subtest: bcs0
[351.998303] Dynamic subtest bcs0: SKIP (0.000s)
[352.007239] Starting dynamic subtest: vcs0
[352.011622] Dynamic subtest vcs0: SKIP (0.000s)
[352.019849] Starting dynamic subtest: vcs1
[352.024241] Dynamic subtest vcs1: SKIP (0.000s)
[352.032374] Starting dynamic subtest: vecs0
[352.036857] Dynamic subtest vecs0: SKIP (0.000s)
[352.045294] Starting dynamic subtest: ccs0
[352.049663] Dynamic subtest ccs0: SKIP (0.000s)
[352.054046] Subtest busy-check-all: SKIP (0.009s)
[352.091130] [095/131] (670s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[352.188488] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[359.175630] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.989s)
[359.351928] [096/131] (663s left) gem_gtt_cpu_tlb
[359.497148] [097/131] (663s left) gem_eio (wait-wedge-10ms)
[359.682218] Starting subtest: wait-wedge-10ms
[360.972309] Subtest wait-wedge-10ms: SUCCESS (1.291s)
[361.152259] [098/131] (661s left) core_setmaster_vs_auth
[361.363656] [099/131] (661s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[361.489326] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[370.519430] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.030s)
[371.398920] [100/131] (651s left) kms_flip (2x-absolute-wf_vblank)
[371.504648] Starting subtest: 2x-absolute-wf_vblank
[371.513040] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[371.656569] [101/131] (651s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[371.755640] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[371.757895] Starting dynamic subtest: pipe-A-eDP-1
[371.777864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[371.791446] Starting dynamic subtest: pipe-B-eDP-1
[371.810894] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[371.824768] Starting dynamic subtest: pipe-C-eDP-1
[371.844594] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[371.858663] Starting dynamic subtest: pipe-D-eDP-1
[371.879504] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.024s)
[371.881862] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.099s)
[374.090418] [102/131] (648s left) i915_pm_rps (engine-order)
[374.154621] Starting subtest: engine-order
[380.604608] Subtest engine-order: SUCCESS (6.449s)
[380.772330] [103/131] (642s left) kms_rotation_crc (bad-pixel-format)
[380.873140] Starting subtest: bad-pixel-format
[380.877632] Subtest bad-pixel-format: SKIP (0.001s)
[380.985298] [104/131] (642s left) perf_pmu (module-unload)
[381.070939] Starting subtest: module-unload
[388.136653] Subtest module-unload: FAIL (6.965s)
[388.168785] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.169491] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[388.172480] [105/131] (634s left) gem_render_copy (y-tiled-to-vebox-linear)
[389.749945] Starting subtest: y-tiled-to-vebox-linear
[389.754740] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[389.902685] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[389.904041] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[389.907756] [106/131] (633s left) gem_cs_tlb (engines)
[389.975269] Starting subtest: engines
[389.977433] Starting dynamic subtest: rcs0
[392.131894] Dynamic subtest rcs0: SUCCESS (2.155s)
[392.140408] Starting dynamic subtest: bcs0
[394.284045] Dynamic subtest bcs0: SUCCESS (2.151s)
[394.292418] Starting dynamic subtest: vcs0
[396.436699] Dynamic subtest vcs0: SUCCESS (2.151s)
[396.446623] Starting dynamic subtest: vcs1
[398.590300] Dynamic subtest vcs1: SUCCESS (2.152s)
[398.600874] Starting dynamic subtest: vecs0
[400.742978] Dynamic subtest vecs0: SUCCESS (2.152s)
[400.753290] Starting dynamic subtest: ccs0
[402.898066] Dynamic subtest ccs0: SUCCESS (2.154s)
[402.900692] Subtest engines: SUCCESS (12.922s)
[403.072936] [107/131] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[403.185674] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[403.190079] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[403.314629] [108/131] (619s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[403.382011] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[403.384316] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[403.531359] [109/131] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[403.624509] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[410.960996] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.339s)
[411.143724] [110/131] (612s left) kms_rotation_crc (exhaust-fences)
[411.239556] Starting subtest: exhaust-fences
[411.243672] Subtest exhaust-fences: SKIP (0.000s)
[411.338335] [111/131] (611s left) kms_atomic (plane-overlay-legacy)
[411.443105] Starting subtest: plane-overlay-legacy
[411.445270] Starting dynamic subtest: pipe-A-eDP-1
[411.861347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[411.863594] Subtest plane-overlay-legacy: SUCCESS (0.420s)
[412.686273] [112/131] (610s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[412.791806] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[412.794077] Starting dynamic subtest: pipe-A-eDP-1
[413.108242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[413.116624] Starting dynamic subtest: pipe-B-eDP-1
[414.368388] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.261s)
[414.378761] Starting dynamic subtest: pipe-C-eDP-1
[415.653726] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s)
[415.664154] Starting dynamic subtest: pipe-D-eDP-1
[416.877433] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[416.879789] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.053s)
[418.114300] [113/131] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[418.216725] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[418.220769] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[418.354409] [114/131] (605s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[418.742107] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[419.589660] [115/131] (603s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[419.700132] Starting subtest: fbc-psr2-sprite-plane-onoff
[419.702407] Starting dynamic subtest: eDP-1
[419.706797] Dynamic subtest eDP-1: SKIP (0.000s)
[419.711215] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[419.801115] [116/131] (603s left) kms_psr (pr-primary-page-flip)
[419.894077] Starting subtest: pr-primary-page-flip
[419.898395] Subtest pr-primary-page-flip: SKIP (0.000s)
[419.991993] [117/131] (603s left) gem_exec_reloc (basic-wc-gtt)
[420.057087] Subtest basic-wc-gtt: SKIP (0.000s)
[420.144762] [118/131] (603s left) kms_plane_scaling (intel-max-src-size)
[420.243884] Starting subtest: intel-max-src-size
[420.250270] Subtest intel-max-src-size: SKIP (0.000s)
[420.379811] [119/131] (603s left) gem_eio (in-flight-1us)
[420.611987] Starting subtest: in-flight-1us
[428.867507] Subtest in-flight-1us: SUCCESS (8.253s)
[429.070125] [120/131] (594s left) kms_psr (fbc-pr-dpms)
[429.164419] Starting subtest: fbc-pr-dpms
[429.168897] Subtest fbc-pr-dpms: SKIP (0.000s)
[429.260582] [121/131] (594s left) gem_exec_schedule (noreorder)
[429.448253] Starting subtest: noreorder
[429.450763] Starting dynamic subtest: rcs0
[429.541026] Dynamic subtest rcs0: SUCCESS (0.094s)
[429.552760] Starting dynamic subtest: vcs0
[430.891189] Dynamic subtest vcs0: SUCCESS (1.347s)
[430.902961] Starting dynamic subtest: vcs1
[432.950383] Dynamic subtest vcs1: SUCCESS (2.056s)
[432.965823] Starting dynamic subtest: vecs0
[434.883411] Dynamic subtest vecs0: SUCCESS (1.930s)
[434.895076] Starting dynamic subtest: ccs0
[434.973089] Dynamic subtest ccs0: SUCCESS (0.088s)
[434.975910] Subtest noreorder: SUCCESS (5.527s)
[435.184104] [122/131] (588s left) gem_ccs (block-multicopy-inplace)
[435.252865] Starting subtest: block-multicopy-inplace
[435.257383] Subtest block-multicopy-inplace: SKIP (0.000s)
[435.410367] [123/131] (588s left) gem_exec_whisper (basic-queues-priority)
[435.487266] Starting subtest: basic-queues-priority
[459.869241] Subtest basic-queues-priority: SUCCESS (24.380s)
[460.082826] [124/131] (563s left) sw_sync (sync_merge)
[460.124785] Starting subtest: sync_merge
[460.127072] Subtest sync_merge: SUCCESS (0.000s)
[460.215086] [125/131] (563s left) kms_legacy_colorkey (invalid-plane)
[460.319943] Starting subtest: invalid-plane
[460.322268] Starting dynamic subtest: zero-id
[460.324397] Dynamic subtest zero-id: SUCCESS (0.000s)
[460.332851] Starting dynamic subtest: outrange-id
[460.335102] Dynamic subtest outrange-id: SUCCESS (0.000s)
[460.336944] Subtest invalid-plane: SUCCESS (0.001s)
[460.417735] [126/131] (563s left) kms_dirtyfb (default-dirtyfb-ioctl)
[460.513875] Starting subtest: default-dirtyfb-ioctl
[460.516224] Starting dynamic subtest: A-eDP-1
[462.089709] Dynamic subtest A-eDP-1: SUCCESS (1.576s)
[462.092034] Subtest default-dirtyfb-ioctl: SUCCESS (1.578s)
[462.963924] [127/131] (561s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[468.031386] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[468.035926] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[468.892818] [128/131] (555s left) prime_mmap (test_map_unmap)
[468.948640] Starting subtest: test_map_unmap
[468.950573] Starting dynamic subtest: test_map_unmap-smem
[468.977879] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[468.980273] Subtest test_map_unmap: SUCCESS (0.032s)
[469.091945] [129/131] (555s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[469.151549] Starting subtest: etime-multi-wait-all-for-submit-submitted
[469.258426] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[469.377476] [130/131] (554s left) gem_userptr_blits (process-exit)
[469.457287] Starting subtest: process-exit
[469.464050] Subtest process-exit: SUCCESS (0.009s)
[469.629153] [131/131] (554s left) perf_pmu (busy-idle-check-all)
[469.669407] Starting subtest: busy-idle-check-all
[469.671346] Starting dynamic subtest: rcs0
[470.345777] Dynamic subtest rcs0: SUCCESS (0.677s)
[470.359969] Starting dynamic subtest: bcs0
[471.000576] Dynamic subtest bcs0: SUCCESS (0.652s)
[471.012201] Starting dynamic subtest: vcs0
[472.918452] Dynamic subtest vcs0: SUCCESS (1.914s)
[472.931042] Starting dynamic subtest: vcs1
[474.901701] Dynamic subtest vcs1: SUCCESS (1.980s)
[474.913381] Starting dynamic subtest: vecs0
[476.886268] Dynamic subtest vecs0: SUCCESS (1.982s)
[476.896258] Starting dynamic subtest: ccs0
[477.546265] Dynamic subtest ccs0: SUCCESS (0.658s)
[477.548742] Subtest busy-idle-check-all: SUCCESS (7.879s)
[477.676427] 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.