[59.796212] Initializing watchdogs
[59.796260]   /dev/watchdog0
[59.810388] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.815328] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.817539] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.820786] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[59.938334] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[59.942238] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[60.068951] [002/131] (960s left) prime_vgem (sync)
[60.183683] Starting subtest: sync
[60.186177] Starting dynamic subtest: rcs0
[60.239119] Dynamic subtest rcs0: SUCCESS (0.056s)
[60.245845] Starting dynamic subtest: bcs0
[60.317253] Dynamic subtest bcs0: SUCCESS (0.077s)
[60.323943] Starting dynamic subtest: vcs0
[60.366130] Dynamic subtest vcs0: SUCCESS (0.048s)
[60.372952] Starting dynamic subtest: vcs1
[60.412608] Dynamic subtest vcs1: SUCCESS (0.046s)
[60.419251] Starting dynamic subtest: vecs0
[60.459260] Dynamic subtest vecs0: SUCCESS (0.046s)
[60.465864] Starting dynamic subtest: ccs0
[60.506407] Dynamic subtest ccs0: SUCCESS (0.046s)
[60.508720] Subtest sync: SUCCESS (0.322s)
[60.664107] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[60.667113] [003/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[60.765593] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[60.769875] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[60.895049] [004/131] (959s left) i915_suspend (fence-restore-tiled2untiled)
[60.948470] Starting subtest: fence-restore-tiled2untiled
[60.951940] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[61.070435] [005/131] (959s left) kms_atomic_transition (plane-all-transition)
[61.163285] Starting subtest: plane-all-transition
[61.165179] Starting dynamic subtest: pipe-A-eDP-1
[63.710364] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.539s)
[64.749787] Starting dynamic subtest: pipe-B-eDP-1
[67.586001] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.841s)
[67.882751] Subtest plane-all-transition: SUCCESS (6.702s)
[68.735809] [006/131] (951s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[68.803244] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[68.903693] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[69.003168] [007/131] (951s left) kms_color (ctm-negative)
[69.100177] Starting subtest: ctm-negative
[69.102427] Starting dynamic subtest: pipe-A-eDP-1
[69.804514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[69.812793] Starting dynamic subtest: pipe-B-eDP-1
[71.223346] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[71.231630] Starting dynamic subtest: pipe-C-eDP-1
[72.603257] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[72.611521] Starting dynamic subtest: pipe-D-eDP-1
[73.930507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[73.932863] Subtest ctm-negative: SUCCESS (4.827s)
[74.762517] [008/131] (945s left) syncobj_timeline (wait-for-submit-snapshot)
[74.830749] Starting subtest: wait-for-submit-snapshot
[74.911964] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[75.010204] [009/131] (945s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[75.114485] Starting subtest: fbcpsr-slowdraw
[100.381459] Subtest fbcpsr-slowdraw: SUCCESS (25.261s)
[100.550409] [010/131] (920s left) kms_joiner (basic-max-non-joiner)
[100.656769] Starting subtest: basic-max-non-joiner
[100.661164] Subtest basic-max-non-joiner: SKIP (0.000s)
[100.739544] [011/131] (919s left) kms_psr (pr-cursor-mmap-cpu)
[100.837297] Starting subtest: pr-cursor-mmap-cpu
[100.841861] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[100.933424] [012/131] (919s left) vgem_basic (create)
[100.983681] Starting subtest: create
[100.985974] Subtest create: SUCCESS (0.000s)
[101.070480] [013/131] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[101.165126] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[101.168658] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[101.298719] [014/131] (919s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[101.397926] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[101.401851] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[102.533959] [015/131] (918s left) kms_selftest (drm_dp_mst_helper)
[102.567887] Starting subtest: drm_dp_mst_helper
[102.575378] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[102.708477] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.133s)
[102.717177] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[102.850482] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.141s)
[102.859232] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[102.958584] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.109s)
[102.960998] Subtest drm_dp_mst_helper: SUCCESS (0.393s)
[103.196059] [016/131] (917s left) kms_lease (lease-uevent)
[103.296214] Starting subtest: lease-uevent
[104.307773] Subtest lease-uevent: SUCCESS (1.011s)
[104.406059] [017/131] (916s left) gem_exec_fence (invalid-timeline-fence-array)
[104.919652] Starting subtest: invalid-timeline-fence-array
[104.925275] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[106.000937] [018/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[106.112345] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[106.116385] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[106.215890] [019/131] (914s left) kms_feature_discovery (display-4x)
[106.303988] Starting subtest: display-4x
[106.308975] Subtest display-4x: SKIP (0.000s)
[106.394721] [020/131] (914s left) perf (oa-formats)
[106.539736] Starting subtest: oa-formats
[106.541952] Starting dynamic subtest: 0-rcs0
[106.556260] Dynamic subtest 0-rcs0: SUCCESS (0.018s)
[106.563705] Starting dynamic subtest: 1-vcs1
[106.578501] Dynamic subtest 1-vcs1: SUCCESS (0.022s)
[106.580661] Subtest oa-formats: SUCCESS (0.040s)
[106.627251] [021/131] (914s left) api_intel_allocator (execbuf-with-allocator)
[106.699169] Starting subtest: execbuf-with-allocator
[106.704324] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[106.841688] [022/131] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[106.938447] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[114.240991] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.302s)
[114.419107] [023/131] (906s left) kms_cursor_edge_walk (256x256-left-edge)
[114.523705] Starting subtest: 256x256-left-edge
[114.525943] Starting dynamic subtest: pipe-A-eDP-1
[117.988493] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[117.997701] Starting dynamic subtest: pipe-D-eDP-1
[121.099599] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[121.101936] Subtest 256x256-left-edge: SUCCESS (6.576s)
[121.970981] [024/131] (899s left) gem_exec_whisper (basic-fds-priority)
[122.053754] Starting subtest: basic-fds-priority
[146.147422] Subtest basic-fds-priority: SUCCESS (24.091s)
[146.354609] [025/131] (874s left) kms_sequence (get-forked-busy)
[146.457312] Starting subtest: get-forked-busy
[146.459596] Starting dynamic subtest: pipe-A-eDP-1
[148.402478] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[148.411681] Starting dynamic subtest: pipe-B-eDP-1
[151.011522] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.608s)
[151.020434] Starting dynamic subtest: pipe-C-eDP-1
[153.622473] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[153.630640] Starting dynamic subtest: pipe-D-eDP-1
[156.168076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[156.170377] Subtest get-forked-busy: SUCCESS (9.711s)
[156.983931] [026/131] (864s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[157.079256] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[157.085046] Starting dynamic subtest: pipe-A-default-mode
[157.387875] Dynamic subtest pipe-A-default-mode: SKIP (0.303s)
[157.392148] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.305s)
[158.218926] [027/131] (863s left) kms_draw_crc (draw-method-mmap-wc)
[158.312078] Starting subtest: draw-method-mmap-wc
[158.314305] Starting dynamic subtest: xrgb8888-untiled
[158.544619] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[158.558261] Starting dynamic subtest: rgb565-untiled
[158.766213] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[158.773299] Starting dynamic subtest: xrgb2101010-untiled
[158.977351] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[158.984662] Starting dynamic subtest: xbgr16161616f-untiled
[159.199187] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[159.207479] Starting dynamic subtest: xrgb8888-xtiled
[159.354930] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.155s)
[159.361920] Starting dynamic subtest: rgb565-xtiled
[159.499216] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s)
[159.506592] Starting dynamic subtest: xrgb2101010-xtiled
[159.632740] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[159.640054] Starting dynamic subtest: xbgr16161616f-xtiled
[159.754855] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[159.762100] Starting dynamic subtest: xrgb8888-4tiled
[159.899053] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[159.906264] Starting dynamic subtest: rgb565-4tiled
[160.032527] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[160.040268] Starting dynamic subtest: xrgb2101010-4tiled
[160.165792] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[160.172949] Starting dynamic subtest: xbgr16161616f-4tiled
[160.343768] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[160.345792] Subtest draw-method-mmap-wc: SUCCESS (2.034s)
[160.492096] [028/131] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[160.597343] Starting subtest: plane-upscale-factor-0-25-with-rotation
[160.599126] Starting dynamic subtest: pipe-A
[160.822496] Dynamic subtest pipe-A: SUCCESS (0.227s)
[160.832085] Starting dynamic subtest: pipe-B
[162.083797] Dynamic subtest pipe-B: SUCCESS (1.260s)
[162.093159] Starting dynamic subtest: pipe-C
[163.414123] Dynamic subtest pipe-C: SUCCESS (1.328s)
[163.423896] Starting dynamic subtest: pipe-D
[164.757017] Dynamic subtest pipe-D: SUCCESS (1.342s)
[164.759184] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.162s)
[165.957469] [029/131] (855s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[166.051969] Starting subtest: primary-y-tiled-reflect-x-270
[166.056356] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[166.146610] [030/131] (855s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[166.246530] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[166.250687] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[166.380645] [031/131] (855s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[166.440803] Subtest writes-after-reads: SKIP (0.000s)
[166.522260] [032/131] (855s left) gem_mmap_gtt (isolation)
[166.585183] Subtest isolation: SKIP (0.000s)
[166.650567] [033/131] (854s left) gem_mmap_offset (pf-nonblock)
[166.711302] Starting subtest: pf-nonblock
[166.715762] Subtest pf-nonblock: SUCCESS (0.007s)
[166.875685] [034/131] (854s left) prime_self_import (basic-with_one_bo)
[166.919347] Starting subtest: basic-with_one_bo
[166.932139] Subtest basic-with_one_bo: SUCCESS (0.014s)
[167.073817] [035/131] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[167.162747] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[167.165765] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[167.287863] [036/131] (854s left) syncobj_wait (single-wait-signaled)
[167.334160] Starting subtest: single-wait-signaled
[167.335951] Subtest single-wait-signaled: SUCCESS (0.000s)
[167.445947] [037/131] (854s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[172.557915] Starting subtest: pr-cursor-plane-update-sf
[172.564933] Subtest pr-cursor-plane-update-sf: SKIP (0.005s)
[173.423634] [038/131] (848s left) kms_cursor_crc (cursor-onscreen-256x256)
[173.663560] Starting subtest: cursor-onscreen-256x256
[173.669129] Starting dynamic subtest: pipe-A-eDP-1
[175.755597] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.089s)
[175.792174] Starting dynamic subtest: pipe-D-eDP-1
[178.567257] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[178.569575] Subtest cursor-onscreen-256x256: SUCCESS (4.902s)
[179.381835] [039/131] (842s left) kms_vrr (flipline)
[179.469207] Starting subtest: flipline
[179.475212] Subtest flipline: SKIP (0.000s)
[179.565223] [040/131] (842s left) kms_chamelium_color (ctm-0-50)
[179.665135] Subtest ctm-0-50: SKIP (0.000s)
[179.707533] [041/131] (842s left) gem_mmap_wc (fault-concurrent)
[179.763212] Subtest fault-concurrent: SKIP (0.000s)
[179.834497] [042/131] (842s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[179.952669] Starting subtest: cursorA-vs-flipB-varying-size
[179.957493] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[180.121630] [043/131] (841s left) gem_exec_schedule (fairslice)
[180.189240] Starting subtest: fairslice
[180.191172] Starting dynamic subtest: rcs0
[182.211279] Dynamic subtest rcs0: SUCCESS (2.020s)
[182.221029] Starting dynamic subtest: bcs0
[184.228670] Dynamic subtest bcs0: SUCCESS (2.018s)
[184.235843] Starting dynamic subtest: vcs0
[186.247858] Dynamic subtest vcs0: SUCCESS (2.017s)
[186.256182] Starting dynamic subtest: vcs1
[188.265063] Dynamic subtest vcs1: SUCCESS (2.015s)
[188.273627] Starting dynamic subtest: vecs0
[190.281832] Dynamic subtest vecs0: SUCCESS (2.016s)
[190.290484] Starting dynamic subtest: ccs0
[192.299080] Dynamic subtest ccs0: SUCCESS (2.018s)
[192.301288] Subtest fairslice: SUCCESS (12.111s)
[192.619186] [044/131] (829s left) syncobj_wait (signal)
[192.681527] Starting subtest: signal
[192.683915] Subtest signal: SUCCESS (0.000s)
[192.803053] [045/131] (829s left) gem_exec_schedule (thriceslice)
[192.883106] Starting subtest: thriceslice
[192.885105] Starting dynamic subtest: rcs0
[192.926631] Dynamic subtest rcs0: SUCCESS (0.053s)
[192.937434] Starting dynamic subtest: bcs0
[192.983207] Dynamic subtest bcs0: SUCCESS (0.054s)
[192.993516] Starting dynamic subtest: vcs0
[193.014811] Dynamic subtest vcs0: SUCCESS (0.030s)
[193.022909] Starting dynamic subtest: vcs1
[193.069531] Dynamic subtest vcs1: SUCCESS (0.054s)
[193.079845] Starting dynamic subtest: vecs0
[193.125030] Dynamic subtest vecs0: SUCCESS (0.054s)
[193.134658] Starting dynamic subtest: ccs0
[193.161977] Dynamic subtest ccs0: SUCCESS (0.035s)
[193.164241] Subtest thriceslice: SUCCESS (0.290s)
[193.482568] [046/131] (828s left) gem_exec_balancer (hog)
[193.553934] Starting subtest: hog
[193.558353] Subtest hog: SKIP (0.000s)
[193.877228] [047/131] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[193.982544] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[193.986730] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[194.103309] [048/131] (828s left) gem_partial_pwrite_pread (write)
[194.186250] Subtest write: SKIP (0.000s)
[194.272926] [049/131] (827s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[196.003838] Starting subtest: modeset-lpsp-stress-no-wait
[205.758780] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.756s)
[205.856414] [050/131] (816s left) kms_plane_multiple (tiling-4)
[205.959402] Starting subtest: tiling-4
[205.961303] Starting dynamic subtest: pipe-A-eDP-1
[209.636613] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.677s)
[209.649563] Starting dynamic subtest: pipe-B-eDP-1
[213.957020] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.318s)
[213.969510] Starting dynamic subtest: pipe-C-eDP-1
[218.266909] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.309s)
[218.275255] Starting dynamic subtest: pipe-D-eDP-1
[222.737224] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.466s)
[222.739660] Subtest tiling-4: SUCCESS (16.777s)
[223.559052] [051/131] (798s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[223.656834] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[223.659168] Starting dynamic subtest: pipe-A-eDP-1
[223.682283] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.698807] Starting dynamic subtest: pipe-B-eDP-1
[223.720456] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.728266] Starting dynamic subtest: pipe-C-eDP-1
[223.750057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.757284] Starting dynamic subtest: pipe-D-eDP-1
[223.778172] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.782035] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[225.934490] [052/131] (796s left) kms_big_fb (linear-32bpp-rotate-270)
[226.033605] Starting subtest: linear-32bpp-rotate-270
[226.052460] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[226.212753] [053/131] (796s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[226.306459] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[226.308601] Starting dynamic subtest: pipe-A-default-mode
[227.465078] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[227.469563] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.159s)
[227.643807] [054/131] (794s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[227.742462] Starting subtest: fbcpsr-indfb-scaledprimary
[233.534268] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.794s)
[233.706652] [055/131] (788s left) gem_exec_flush (basic-wb-ro-default)
[233.769477] Starting subtest: basic-wb-ro-default
[239.220325] Subtest basic-wb-ro-default: SUCCESS (5.451s)
[239.438825] [056/131] (783s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[239.533076] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[239.537294] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[239.662416] [057/131] (782s left) kms_flip (2x-blocking-wf_vblank)
[239.759145] Starting subtest: 2x-blocking-wf_vblank
[239.768185] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[239.872963] [058/131] (782s left) core_setmaster (master-drop-set-root)
[239.955919] Starting subtest: master-drop-set-root
[239.965401] Subtest master-drop-set-root: SUCCESS (0.013s)
[240.014123] [059/131] (782s left) gem_partial_pwrite_pread (reads)
[240.088889] Subtest reads: SKIP (0.000s)
[240.166859] [060/131] (782s left) kms_pm_rpm (fences-dpms)
[242.086584] Starting subtest: fences-dpms
[242.091402] Subtest fences-dpms: SKIP (0.000s)
[242.472770] [061/131] (780s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[242.527864] Starting subtest: multi-wait-all-for-submit-signaled
[242.530158] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[242.674770] [062/131] (780s left) kms_chamelium_edid (dp-edid-resolution-list)
[243.070893] Subtest dp-edid-resolution-list: SKIP (0.000s)
[243.863612] [063/131] (778s left) gem_mmap_gtt (bad-object)
[243.928706] Subtest bad-object: SKIP (0.000s)
[243.995364] [064/131] (778s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[244.100726] Starting subtest: async-flip-with-page-flip-events-tiled
[244.491728] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[247.263272] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[247.274582] Starting dynamic subtest: pipe-A-eDP-1-4
[249.437875] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[249.445276] Starting dynamic subtest: pipe-A-eDP-1-4
[251.448908] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[251.459806] Starting dynamic subtest: pipe-A-eDP-1-x
[253.638127] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[254.009993] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[256.790267] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[256.798078] Starting dynamic subtest: pipe-B-eDP-1-4
[258.977088] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[258.984749] Starting dynamic subtest: pipe-B-eDP-1-4
[260.987323] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[260.997683] Starting dynamic subtest: pipe-B-eDP-1-x
[263.176954] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[263.550666] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[266.328733] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[266.342082] Starting dynamic subtest: pipe-C-eDP-1-4
[268.514799] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[268.522728] Starting dynamic subtest: pipe-C-eDP-1-4
[270.525366] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[270.533247] Starting dynamic subtest: pipe-C-eDP-1-x
[272.703717] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[273.069468] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[275.854894] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[275.869056] Starting dynamic subtest: pipe-D-eDP-1-4
[278.085960] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.230s)
[278.093852] Starting dynamic subtest: pipe-D-eDP-1-4
[280.095797] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[280.103732] Starting dynamic subtest: pipe-D-eDP-1-x
[282.285256] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[282.287543] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.185s)
[283.470860] [065/131] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[283.573243] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[283.577391] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[283.719706] [066/131] (739s left) gem_exec_alignment (many)
[283.787046] Starting subtest: many
[306.200966] Subtest many: SUCCESS (22.414s)
[307.824989] [067/131] (715s left) kms_psr (psr-dpms)
[307.964965] Starting subtest: psr-dpms
[307.967326] Starting dynamic subtest: eDP-1
[310.987108] Dynamic subtest eDP-1: SUCCESS (3.020s)
[310.989301] Subtest psr-dpms: SUCCESS (3.021s)
[311.867202] [068/131] (711s left) gem_ctx_persistence (engines-mixed-process)
[311.935576] Starting subtest: engines-mixed-process
[311.937915] Starting dynamic subtest: rcs0
[313.959770] Dynamic subtest rcs0: SUCCESS (2.024s)
[313.970446] Starting dynamic subtest: bcs0
[315.953297] Dynamic subtest bcs0: SUCCESS (1.991s)
[315.963250] Starting dynamic subtest: vcs0
[317.913212] Dynamic subtest vcs0: SUCCESS (1.958s)
[317.922652] Starting dynamic subtest: vcs1
[319.928262] Dynamic subtest vcs1: SUCCESS (2.013s)
[319.938566] Starting dynamic subtest: vecs0
[321.906942] Dynamic subtest vecs0: SUCCESS (1.976s)
[321.916368] Starting dynamic subtest: ccs0
[323.868705] Dynamic subtest ccs0: SUCCESS (1.960s)
[323.871035] Subtest engines-mixed-process: SUCCESS (11.933s)
[323.966965] [069/131] (699s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[324.078817] Starting subtest: 4-tiled-32bpp-rotate-180
[325.421611] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.344s)
[325.636946] [070/131] (697s left) prime_vgem (coherency-gtt)
[325.724429] Starting subtest: coherency-gtt
[325.728244] Subtest coherency-gtt: SKIP (0.000s)
[325.850362] [071/131] (697s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[326.091956] Starting subtest: cursor-rapid-movement-128x42
[326.136854] Subtest cursor-rapid-movement-128x42: SKIP (0.040s)
[326.380409] [072/131] (696s left) gem_exec_balancer (waits)
[326.456376] Starting subtest: waits
[332.929087] Subtest waits: SUCCESS (6.473s)
[333.256156] [073/131] (689s left) sysfs_preempt_timeout (invalid)
[333.325335] Starting subtest: invalid
[333.327838] Starting dynamic subtest: vecs0
[333.330558] Dynamic subtest vecs0: SUCCESS (0.000s)
[333.340638] Starting dynamic subtest: ccs0
[333.342885] Dynamic subtest ccs0: SUCCESS (0.000s)
[333.350790] Starting dynamic subtest: vcs0
[333.352978] Dynamic subtest vcs0: SUCCESS (0.000s)
[333.360632] Starting dynamic subtest: bcs0
[333.362810] Dynamic subtest bcs0: SUCCESS (0.000s)
[333.371063] Starting dynamic subtest: rcs0
[333.373313] Dynamic subtest rcs0: SUCCESS (0.000s)
[333.380874] Starting dynamic subtest: vcs1
[333.382786] Dynamic subtest vcs1: SUCCESS (0.000s)
[333.384677] Subtest invalid: SUCCESS (0.006s)
[333.468747] [074/131] (689s left) gem_spin_batch (resubmit-all)
[333.530252] Starting subtest: resubmit-all
[333.532717] Starting dynamic subtest: rcs0
[333.546594] Dynamic subtest rcs0: SUCCESS (0.016s)
[333.558777] Starting dynamic subtest: bcs0
[333.561174] Dynamic subtest bcs0: SUCCESS (0.003s)
[333.569275] Starting dynamic subtest: vcs0
[333.571142] Dynamic subtest vcs0: SUCCESS (0.002s)
[333.578769] Starting dynamic subtest: vcs1
[333.580650] Dynamic subtest vcs1: SUCCESS (0.002s)
[333.587864] Starting dynamic subtest: vecs0
[333.589765] Dynamic subtest vecs0: SUCCESS (0.002s)
[333.597060] Starting dynamic subtest: ccs0
[333.599164] Dynamic subtest ccs0: SUCCESS (0.002s)
[333.600994] Subtest resubmit-all: SUCCESS (0.032s)
[335.002660] [075/131] (688s left) gem_exec_gttfill (basic)
[335.072757] Starting subtest: basic
[338.900704] Subtest basic: SUCCESS (3.826s)
[339.110993] [076/131] (684s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[339.267605] Starting subtest: yf-tiled-16bpp-rotate-270
[339.271728] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[339.395614] [077/131] (683s left) gem_ctx_persistence (file)
[339.464108] Starting subtest: file
[339.612602] Subtest file: SUCCESS (0.148s)
[339.775699] [078/131] (683s left) gem_fenced_exec_thrash (too-many-fences)
[339.822365] Subtest too-many-fences: SKIP (0.000s)
[339.879724] [079/131] (683s left) api_intel_bb (misplaced-blitter)
[339.941603] Starting subtest: misplaced-blitter
[339.952487] Subtest misplaced-blitter: SUCCESS (0.013s)
[340.108706] [080/131] (683s left) gen7_exec_parse (basic-rejected)
[340.157427] Subtest basic-rejected: SKIP (0.000s)
[340.219026] [081/131] (683s left) gem_pxp (hw-rejects-pxp-context)
[340.341636] Starting subtest: hw-rejects-pxp-context
[340.345498] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[340.481973] [082/131] (683s left) gem_softpin (evict-active-interruptible)
[340.547358] Starting subtest: evict-active-interruptible
[340.552422] Subtest evict-active-interruptible: SUCCESS (0.005s)
[340.727740] [083/131] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[340.829331] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[340.832677] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.979977] [084/131] (682s left) syncobj_timeline (invalid-signal-zero-handles)
[341.048996] Starting subtest: invalid-signal-zero-handles
[341.051041] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[341.181423] [085/131] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[341.290478] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[341.293808] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[341.420147] [086/131] (682s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[341.522094] Starting subtest: x-tiled-8bpp-rotate-270
[341.548776] Subtest x-tiled-8bpp-rotate-270: SKIP (0.026s)
[341.709927] [087/131] (682s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[341.811529] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[341.815125] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[341.952311] [088/131] (681s left) i915_pm_freq_api (freq-reset)
[342.025131] Starting subtest: freq-reset
[342.026806] Starting dynamic subtest: gt0
[342.215064] Dynamic subtest gt0: SUCCESS (0.192s)
[342.228157] Starting dynamic subtest: gt1
[342.387774] Dynamic subtest gt1: SUCCESS (0.166s)
[342.390283] Subtest freq-reset: SUCCESS (0.361s)
[342.483575] [089/131] (681s left) gem_unfence_active_buffers
[342.650650] [090/131] (681s left) syncobj_timeline (reset-unsignaled)
[342.714739] Starting subtest: reset-unsignaled
[342.717077] Subtest reset-unsignaled: SUCCESS (0.000s)
[342.844813] [091/131] (681s left) gem_render_copy (y-tiled)
[342.907712] Starting subtest: y-tiled
[342.912486] Subtest y-tiled: SKIP (0.000s)
[343.114149] [092/131] (680s left) gem_wait (busy)
[343.183761] Starting subtest: busy
[343.186210] Starting dynamic subtest: all-engines
[344.917323] Dynamic subtest all-engines: SUCCESS (1.731s)
[344.928822] Starting dynamic subtest: rcs0
[345.461407] Dynamic subtest rcs0: SUCCESS (0.543s)
[345.471822] Starting dynamic subtest: bcs0
[346.002507] Dynamic subtest bcs0: SUCCESS (0.540s)
[346.012312] Starting dynamic subtest: vcs0
[347.924470] Dynamic subtest vcs0: SUCCESS (1.919s)
[347.940679] Starting dynamic subtest: vcs1
[349.909326] Dynamic subtest vcs1: SUCCESS (1.981s)
[349.919626] Starting dynamic subtest: vecs0
[351.892501] Dynamic subtest vecs0: SUCCESS (1.980s)
[351.903410] Starting dynamic subtest: ccs0
[352.434256] Dynamic subtest ccs0: SUCCESS (0.541s)
[352.436601] Subtest busy: SUCCESS (9.250s)
[352.650483] [093/131] (671s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[352.754178] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[352.758216] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[352.869238] [094/131] (671s left) i915_drm_fdinfo (busy-check-all)
[352.912141] Starting subtest: busy-check-all
[352.914554] Starting dynamic subtest: rcs0
[352.919114] Dynamic subtest rcs0: SKIP (0.003s)
[352.933832] Starting dynamic subtest: bcs0
[352.937835] Dynamic subtest bcs0: SKIP (0.000s)
[352.946290] Starting dynamic subtest: vcs0
[352.950650] Dynamic subtest vcs0: SKIP (0.000s)
[352.959384] Starting dynamic subtest: vcs1
[352.963571] Dynamic subtest vcs1: SKIP (0.000s)
[352.971153] Starting dynamic subtest: vecs0
[352.975261] Dynamic subtest vecs0: SKIP (0.000s)
[352.983159] Starting dynamic subtest: ccs0
[352.987251] Dynamic subtest ccs0: SKIP (0.000s)
[352.991481] Subtest busy-check-all: SKIP (0.008s)
[353.026441] [095/131] (671s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[353.164658] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[360.079796] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.917s)
[360.251393] [096/131] (663s left) gem_gtt_cpu_tlb
[360.353550] [097/131] (663s left) gem_eio (wait-wedge-10ms)
[360.530823] Starting subtest: wait-wedge-10ms
[361.928490] Subtest wait-wedge-10ms: SUCCESS (1.398s)
[362.091799] [098/131] (662s left) core_setmaster_vs_auth
[362.279380] [099/131] (661s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[362.386276] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[371.321312] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.933s)
[372.191383] [100/131] (652s left) kms_flip (2x-absolute-wf_vblank)
[372.293037] Starting subtest: 2x-absolute-wf_vblank
[372.301970] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[372.416992] [101/131] (651s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[372.514968] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[372.516805] Starting dynamic subtest: pipe-A-eDP-1
[372.536318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[372.546934] Starting dynamic subtest: pipe-B-eDP-1
[372.565886] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[372.574311] Starting dynamic subtest: pipe-C-eDP-1
[372.593718] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[372.602089] Starting dynamic subtest: pipe-D-eDP-1
[372.621167] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[372.623238] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[374.765654] [102/131] (649s left) i915_pm_rps (engine-order)
[374.835523] Starting subtest: engine-order
[379.987408] Subtest engine-order: SUCCESS (5.149s)
[380.154213] [103/131] (644s left) kms_rotation_crc (bad-pixel-format)
[380.256113] Starting subtest: bad-pixel-format
[380.260214] Subtest bad-pixel-format: SKIP (0.001s)
[380.353867] [104/131] (644s left) perf_pmu (module-unload)
[380.439311] Starting subtest: module-unload
[387.191074] Subtest module-unload: FAIL (6.644s)
[387.222103] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[387.222863] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[387.225814] [105/131] (637s left) gem_render_copy (y-tiled-to-vebox-linear)
[388.736963] Starting subtest: y-tiled-to-vebox-linear
[388.741528] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[388.880072] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.881251] [FACT gem_render_copy (y-tiled-to-vebox-linear)] new: kernel.kmod_is_loaded.i915: true
[388.884992] [106/131] (635s left) gem_cs_tlb (engines)
[388.956697] Starting subtest: engines
[388.959037] Starting dynamic subtest: rcs0
[391.116777] Dynamic subtest rcs0: SUCCESS (2.155s)
[391.127333] Starting dynamic subtest: bcs0
[393.268886] Dynamic subtest bcs0: SUCCESS (2.151s)
[393.277034] Starting dynamic subtest: vcs0
[395.421025] Dynamic subtest vcs0: SUCCESS (2.152s)
[395.429901] Starting dynamic subtest: vcs1
[397.574392] Dynamic subtest vcs1: SUCCESS (2.152s)
[397.582161] Starting dynamic subtest: vecs0
[399.727147] Dynamic subtest vecs0: SUCCESS (2.152s)
[399.737518] Starting dynamic subtest: ccs0
[401.879607] Dynamic subtest ccs0: SUCCESS (2.151s)
[401.882220] Subtest engines: SUCCESS (12.919s)
[402.056811] [107/131] (622s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[402.164726] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[402.168931] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[402.278604] [108/131] (622s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[402.339823] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[402.342088] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[402.468790] [109/131] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[402.577895] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[409.938385] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.363s)
[410.118194] [110/131] (614s left) kms_rotation_crc (exhaust-fences)
[410.212932] Starting subtest: exhaust-fences
[410.217274] Subtest exhaust-fences: SKIP (0.000s)
[410.308216] [111/131] (614s left) kms_atomic (plane-overlay-legacy)
[410.413793] Starting subtest: plane-overlay-legacy
[410.415991] Starting dynamic subtest: pipe-A-eDP-1
[410.841484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[410.843870] Subtest plane-overlay-legacy: SUCCESS (0.432s)
[411.743382] [112/131] (613s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[411.834329] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[411.836529] Starting dynamic subtest: pipe-A-eDP-1
[412.105798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.240s)
[412.115084] Starting dynamic subtest: pipe-B-eDP-1
[413.382939] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.278s)
[413.393664] Starting dynamic subtest: pipe-C-eDP-1
[414.600281] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[414.609961] Starting dynamic subtest: pipe-D-eDP-1
[415.835208] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[415.837076] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.971s)
[417.071220] [113/131] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[417.184398] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[417.188735] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[417.296515] [114/131] (607s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[417.688700] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[418.490478] [115/131] (606s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[418.585043] Starting subtest: fbc-psr2-sprite-plane-onoff
[418.587358] Starting dynamic subtest: eDP-1
[418.591923] Dynamic subtest eDP-1: SKIP (0.000s)
[418.596372] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.003s)
[418.676862] [116/131] (606s left) kms_psr (pr-primary-page-flip)
[418.761608] Starting subtest: pr-primary-page-flip
[418.765623] Subtest pr-primary-page-flip: SKIP (0.000s)
[418.858155] [117/131] (606s left) gem_exec_reloc (basic-wc-gtt)
[418.921288] Subtest basic-wc-gtt: SKIP (0.000s)
[419.000930] [118/131] (606s left) kms_plane_scaling (intel-max-src-size)
[419.096356] Starting subtest: intel-max-src-size
[419.102605] Subtest intel-max-src-size: SKIP (0.000s)
[419.225640] [119/131] (605s left) gem_eio (in-flight-1us)
[419.460278] Starting subtest: in-flight-1us
[427.838562] Subtest in-flight-1us: SUCCESS (8.375s)
[428.042845] [120/131] (597s left) kms_psr (fbc-pr-dpms)
[428.139324] Starting subtest: fbc-pr-dpms
[428.143644] Subtest fbc-pr-dpms: SKIP (0.000s)
[428.232465] [121/131] (596s left) gem_exec_schedule (noreorder)
[428.405686] Starting subtest: noreorder
[428.408081] Starting dynamic subtest: rcs0
[428.484372] Dynamic subtest rcs0: SUCCESS (0.078s)
[428.495059] Starting dynamic subtest: vcs0
[429.935690] Dynamic subtest vcs0: SUCCESS (1.447s)
[429.947899] Starting dynamic subtest: vcs1
[431.877193] Dynamic subtest vcs1: SUCCESS (1.938s)
[431.893488] Starting dynamic subtest: vecs0
[433.906456] Dynamic subtest vecs0: SUCCESS (2.027s)
[433.917773] Starting dynamic subtest: ccs0
[433.998795] Dynamic subtest ccs0: SUCCESS (0.091s)
[434.001213] Subtest noreorder: SUCCESS (5.595s)
[434.212504] [122/131] (590s left) gem_ccs (block-multicopy-inplace)
[434.274356] Starting subtest: block-multicopy-inplace
[434.279144] Subtest block-multicopy-inplace: SKIP (0.000s)
[434.410743] [123/131] (590s left) gem_exec_whisper (basic-queues-priority)
[434.476505] Starting subtest: basic-queues-priority
[458.859576] Subtest basic-queues-priority: SUCCESS (24.380s)
[459.067253] [124/131] (566s left) sw_sync (sync_merge)
[459.118299] Starting subtest: sync_merge
[459.120244] Subtest sync_merge: SUCCESS (0.000s)
[459.203853] [125/131] (566s left) kms_legacy_colorkey (invalid-plane)
[459.305906] Starting subtest: invalid-plane
[459.308071] Starting dynamic subtest: zero-id
[459.309929] Dynamic subtest zero-id: SUCCESS (0.000s)
[459.318584] Starting dynamic subtest: outrange-id
[459.320872] Dynamic subtest outrange-id: SUCCESS (0.000s)
[459.323043] Subtest invalid-plane: SUCCESS (0.001s)
[459.399867] [126/131] (565s left) kms_dirtyfb (default-dirtyfb-ioctl)
[459.497027] Starting subtest: default-dirtyfb-ioctl
[459.498979] Starting dynamic subtest: A-eDP-1
[461.073238] Dynamic subtest A-eDP-1: SUCCESS (1.576s)
[461.075642] Subtest default-dirtyfb-ioctl: SUCCESS (1.577s)
[461.945129] [127/131] (563s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[466.979174] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[466.983883] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[467.863020] [128/131] (557s left) prime_mmap (test_map_unmap)
[467.919420] Starting subtest: test_map_unmap
[467.921299] Starting dynamic subtest: test_map_unmap-smem
[467.945605] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[467.947995] Subtest test_map_unmap: SUCCESS (0.029s)
[468.091404] [129/131] (557s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[468.148563] Starting subtest: etime-multi-wait-all-for-submit-submitted
[468.256813] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[468.362737] [130/131] (557s left) gem_userptr_blits (process-exit)
[468.444057] Starting subtest: process-exit
[468.448891] Subtest process-exit: SUCCESS (0.008s)
[468.607906] [131/131] (556s left) perf_pmu (busy-idle-check-all)
[468.656387] Starting subtest: busy-idle-check-all
[468.658597] Starting dynamic subtest: rcs0
[469.321799] Dynamic subtest rcs0: SUCCESS (0.667s)
[469.331939] Starting dynamic subtest: bcs0
[469.986061] Dynamic subtest bcs0: SUCCESS (0.662s)
[469.997770] Starting dynamic subtest: vcs0
[471.893475] Dynamic subtest vcs0: SUCCESS (1.904s)
[471.904940] Starting dynamic subtest: vcs1
[473.940424] Dynamic subtest vcs1: SUCCESS (2.044s)
[473.950911] Starting dynamic subtest: vecs0
[475.927081] Dynamic subtest vecs0: SUCCESS (1.984s)
[475.936985] Starting dynamic subtest: ccs0
[476.582326] Dynamic subtest ccs0: SUCCESS (0.655s)
[476.584956] Subtest busy-idle-check-all: SUCCESS (7.928s)
[476.709692] 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.