[63.242894] Initializing watchdogs
[63.242990]   /dev/watchdog0
[63.263751] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.274443] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.278082] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.280791] [001/131] (960s left) kms_lease (lease-again)
[65.294148] Starting subtest: lease-again
[65.295156] Starting dynamic subtest: pipe-A-HDMI-A-1
[65.298995] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.004s)
[65.306204] Starting dynamic subtest: pipe-B-HDMI-A-1
[65.307249] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[65.314788] Starting dynamic subtest: pipe-C-HDMI-A-1
[65.315639] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.004s)
[65.322519] Starting dynamic subtest: pipe-D-HDMI-A-1
[65.323442] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.003s)
[65.324331] Subtest lease-again: SUCCESS (0.019s)
[65.498601] [002/131] (958s left) gem_exec_schedule (fairslice)
[65.590056] Starting subtest: fairslice
[65.591055] Starting dynamic subtest: rcs0
[67.643500] Dynamic subtest rcs0: SUCCESS (2.052s)
[67.651219] Starting dynamic subtest: bcs0
[69.666187] Dynamic subtest bcs0: SUCCESS (2.022s)
[69.674056] Starting dynamic subtest: vcs0
[71.688094] Dynamic subtest vcs0: SUCCESS (2.022s)
[71.696269] Starting dynamic subtest: vcs1
[73.707200] Dynamic subtest vcs1: SUCCESS (2.019s)
[73.714850] Starting dynamic subtest: vecs0
[75.728163] Dynamic subtest vecs0: SUCCESS (2.021s)
[75.736150] Starting dynamic subtest: vecs1
[77.748178] Dynamic subtest vecs1: SUCCESS (2.020s)
[77.755782] Starting dynamic subtest: ccs0
[79.768096] Dynamic subtest ccs0: SUCCESS (2.020s)
[79.768915] Subtest fairslice: SUCCESS (14.177s)
[80.183343] [003/131] (943s left) gen7_exec_parse (bitmasks)
[80.258167] Subtest bitmasks: SKIP (0.000s)
[80.322111] [004/131] (943s left) syncobj_eventfd (invalid-illegal-eventfd)
[80.391012] Starting subtest: invalid-illegal-eventfd
[80.391971] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[80.497667] [005/131] (943s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[82.513130] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[82.515166] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[82.651298] [006/131] (941s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[84.707361] Starting subtest: yf-tiled-64bpp-rotate-0
[84.709144] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[84.871172] [007/131] (939s left) kms_addfb_basic (bad-pitch-256)
[84.957147] Starting subtest: bad-pitch-256
[84.957980] Subtest bad-pitch-256: SUCCESS (0.000s)
[87.087722] [008/131] (937s left) gem_exec_balancer (sequential)
[87.186056] Starting subtest: sequential
[93.090425] Subtest sequential: SUCCESS (5.904s)
[93.494605] [009/131] (930s left) gem_pxp (reject-modify-context-protection-off-3)
[96.092947] Starting subtest: reject-modify-context-protection-off-3
[96.095852] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[96.182450] [010/131] (928s left) gem_ctx_persistence (engines-cleanup)
[96.261988] Starting subtest: engines-cleanup
[96.262985] Starting dynamic subtest: rcs0
[96.360060] Dynamic subtest rcs0: SUCCESS (0.098s)
[96.369165] Starting dynamic subtest: bcs0
[96.392271] Dynamic subtest bcs0: SUCCESS (0.032s)
[96.401785] Starting dynamic subtest: vcs0
[96.431419] Dynamic subtest vcs0: SUCCESS (0.039s)
[96.445606] Starting dynamic subtest: vcs1
[96.477275] Dynamic subtest vcs1: SUCCESS (0.045s)
[96.509932] Starting dynamic subtest: vecs0
[96.534968] Dynamic subtest vecs0: SUCCESS (0.057s)
[96.557800] Starting dynamic subtest: vecs1
[96.559063] Dynamic subtest vecs1: SUCCESS (0.024s)
[96.577058] Starting dynamic subtest: ccs0
[96.615690] Dynamic subtest ccs0: SUCCESS (0.056s)
[96.617529] Subtest engines-cleanup: SUCCESS (0.353s)
[96.794380] [011/131] (927s left) gem_mmap_gtt (medium-copy)
[96.863965] Subtest medium-copy: SKIP (0.000s)
[96.923964] [012/131] (927s left) gem_tiled_blits (basic)
[97.000955] Subtest basic: SKIP (0.000s)
[97.091651] [013/131] (927s left) gem_userptr_blits (coherency-unsync)
[97.174943] Subtest coherency-unsync: SKIP (0.000s)
[97.364266] [014/131] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[99.382069] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[99.383971] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[99.574870] [015/131] (925s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[101.614813] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[101.753071] [016/131] (923s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[103.760500] Starting subtest: flip-vs-cursor-varying-size
[115.692406] Subtest flip-vs-cursor-varying-size: SUCCESS (11.931s)
[115.854052] [017/131] (909s left) gem_render_copy (y-tiled)
[115.931445] Starting subtest: y-tiled
[115.933580] Subtest y-tiled: SKIP (0.000s)
[116.182878] [018/131] (908s left) kms_pipe_crc_basic (hang-read-crc)
[118.194244] Starting subtest: hang-read-crc
[118.195340] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.583556] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.388s)
[119.592467] Starting dynamic subtest: pipe-B-HDMI-A-1
[120.718202] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.133s)
[120.726442] Starting dynamic subtest: pipe-C-HDMI-A-1
[121.848331] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.129s)
[121.857294] Starting dynamic subtest: pipe-D-HDMI-A-1
[123.002506] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.152s)
[123.003509] Subtest hang-read-crc: SUCCESS (4.807s)
[123.186884] [019/131] (901s left) perf_pmu (semaphore-wait-idle)
[123.247605] Starting subtest: semaphore-wait-idle
[123.248525] Starting dynamic subtest: rcs0
[123.791221] Dynamic subtest rcs0: SUCCESS (0.542s)
[123.801689] Starting dynamic subtest: bcs0
[124.303624] Dynamic subtest bcs0: SUCCESS (0.512s)
[124.314718] Starting dynamic subtest: vcs0
[124.816653] Dynamic subtest vcs0: SUCCESS (0.512s)
[124.828153] Starting dynamic subtest: vcs1
[125.337583] Dynamic subtest vcs1: SUCCESS (0.513s)
[125.346540] Starting dynamic subtest: vecs0
[125.842623] Dynamic subtest vecs0: SUCCESS (0.511s)
[125.855938] Starting dynamic subtest: vecs1
[126.357622] Dynamic subtest vecs1: SUCCESS (0.514s)
[126.370958] Starting dynamic subtest: ccs0
[126.873293] Dynamic subtest ccs0: SUCCESS (0.515s)
[126.875267] Subtest semaphore-wait-idle: SUCCESS (3.625s)
[127.059606] [020/131] (898s left) gem_exec_schedule (pi-shared-iova)
[127.263841] Starting subtest: pi-shared-iova
[127.265190] Starting dynamic subtest: rcs0
[127.539159] Dynamic subtest rcs0: SUCCESS (0.276s)
[127.548174] Starting dynamic subtest: bcs0
[127.717912] Dynamic subtest bcs0: SUCCESS (0.178s)
[127.726943] Starting dynamic subtest: vcs0
[127.905517] Dynamic subtest vcs0: SUCCESS (0.188s)
[127.914396] Starting dynamic subtest: vcs1
[128.092777] Dynamic subtest vcs1: SUCCESS (0.187s)
[128.101889] Starting dynamic subtest: vecs0
[128.283857] Dynamic subtest vecs0: SUCCESS (0.191s)
[128.293016] Starting dynamic subtest: vecs1
[128.476881] Dynamic subtest vecs1: SUCCESS (0.193s)
[128.485755] Starting dynamic subtest: ccs0
[128.660547] Dynamic subtest ccs0: SUCCESS (0.184s)
[128.661380] Subtest pi-shared-iova: SUCCESS (1.398s)
[129.034022] [021/131] (896s left) i915_hangman (error-state-basic)
[129.116614] Starting subtest: error-state-basic
[129.315570] Subtest error-state-basic: SUCCESS (0.199s)
[129.438438] [022/131] (895s left) kms_psr (psr2-sprite-mmap-gtt)
[131.447198] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[131.593234] [023/131] (893s left) kms_rotation_crc (sprite-rotation-180)
[133.603167] Starting subtest: sprite-rotation-180
[140.530207] Subtest sprite-rotation-180: SUCCESS (6.926s)
[140.794859] [024/131] (884s left) gem_fence_thrash (bo-write-verify-none)
[140.838868] Starting subtest: bo-write-verify-none
[140.864875] Subtest bo-write-verify-none: SKIP (0.026s)
[140.938161] [025/131] (884s left) gem_ctx_persistence (processes)
[141.014886] Starting subtest: processes
[142.921203] Subtest processes: SUCCESS (1.906s)
[143.025485] [026/131] (882s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[145.036182] Starting subtest: primary-4-tiled-reflect-x-0
[155.293711] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.256s)
[155.539175] [027/131] (870s left) kms_chamelium_edid (hdmi-edid-read)
[157.587727] Subtest hdmi-edid-read: SKIP (0.000s)
[157.682421] [028/131] (868s left) sw_sync (sync_busy_fork)
[157.736107] Starting subtest: sync_busy_fork
[158.748763] Subtest sync_busy_fork: SUCCESS (1.012s)
[158.813854] [029/131] (866s left) gen9_exec_parse (cmd-crossing-page)
[158.893501] Subtest cmd-crossing-page: SKIP (0.000s)
[159.009675] [030/131] (866s left) kms_async_flips (test-time-stamp-atomic)
[161.020390] Starting subtest: test-time-stamp-atomic
[161.277743] Starting dynamic subtest: pipe-A-HDMI-A-1
[161.576130] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.298s)
[161.774176] Starting dynamic subtest: pipe-B-HDMI-A-1
[161.866285] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.099s)
[162.044015] Starting dynamic subtest: pipe-C-HDMI-A-1
[162.143473] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.107s)
[162.302197] Starting dynamic subtest: pipe-D-HDMI-A-1
[162.395470] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.101s)
[162.396442] Subtest test-time-stamp-atomic: SUCCESS (1.374s)
[162.774358] [031/131] (863s left) kms_content_protection (type1)
[164.853125] Starting subtest: type1
[165.165764] Subtest type1: SKIP (0.311s)
[165.387403] [032/131] (860s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[167.402079] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[167.417377] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[167.546966] [033/131] (858s left) gem_fence_thrash (bo-write-verify-threaded-y)
[167.629706] Starting subtest: bo-write-verify-threaded-y
[167.659056] Subtest bo-write-verify-threaded-y: SKIP (0.028s)
[167.737507] [034/131] (858s left) gem_exec_schedule (u-submit-golden-slice)
[167.821021] Starting subtest: u-submit-golden-slice
[167.821918] Starting dynamic subtest: rcs0
[167.897734] Dynamic subtest rcs0: SUCCESS (0.076s)
[167.907376] Starting dynamic subtest: bcs0
[167.949118] Dynamic subtest bcs0: SUCCESS (0.051s)
[167.958490] Starting dynamic subtest: vcs0
[168.002664] Dynamic subtest vcs0: SUCCESS (0.053s)
[168.012273] Starting dynamic subtest: vcs1
[168.049292] Dynamic subtest vcs1: SUCCESS (0.046s)
[168.058637] Starting dynamic subtest: vecs0
[168.099555] Dynamic subtest vecs0: SUCCESS (0.050s)
[168.108800] Starting dynamic subtest: vecs1
[168.148138] Dynamic subtest vecs1: SUCCESS (0.048s)
[168.157779] Starting dynamic subtest: ccs0
[168.197167] Dynamic subtest ccs0: SUCCESS (0.048s)
[168.198205] Subtest u-submit-golden-slice: SUCCESS (0.376s)
[168.661965] [035/131] (857s left) gem_compute (compute-square)
[168.729288] Starting subtest: compute-square
[168.763383] Subtest compute-square: FAIL (0.018s)
[168.830869] [036/131] (857s left) gem_readwrite (new-obj)
[168.899065] Subtest new-obj: SKIP (0.000s)
[168.959755] [037/131] (857s left) kms_pm_dc (dc3co-vpb-simulation)
[171.979056] Starting subtest: dc3co-vpb-simulation
[171.980764] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[172.085314] [038/131] (854s left) prime_mmap_coherency (read)
[172.193638] Starting subtest: read
[177.595159] Subtest read: SUCCESS (5.400s)
[177.719761] [039/131] (848s left) gem_create (hog-create)
[177.793406] Starting subtest: hog-create
[177.794372] Starting dynamic subtest: lmem0
[210.065456] Dynamic subtest lmem0: SUCCESS (32.272s)
[210.075088] Starting dynamic subtest: smem0
[242.341407] Dynamic subtest smem0: SUCCESS (32.276s)
[242.342470] Subtest hog-create: SUCCESS (64.548s)
[242.634882] [040/131] (783s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[244.658478] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[245.704631] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.046s)
[245.918282] [041/131] (780s left) i915_pm_rps (thresholds-idle)
[245.997244] Starting subtest: thresholds-idle
[245.999115] Subtest thresholds-idle: SKIP (0.001s)
[246.084886] [042/131] (780s left) kms_color (ctm-0-25)
[248.096259] Starting subtest: ctm-0-25
[248.097215] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.711140] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.614s)
[249.721927] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.084452] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.373s)
[251.094685] Starting dynamic subtest: pipe-C-HDMI-A-1
[252.446237] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.361s)
[252.457203] Starting dynamic subtest: pipe-D-HDMI-A-1
[253.827722] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.381s)
[253.828592] Subtest ctm-0-25: SUCCESS (5.731s)
[253.998108] [043/131] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[256.011763] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[256.013529] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[256.195441] [044/131] (770s left) kms_cursor_crc (cursor-random-64x21)
[258.375335] Starting subtest: cursor-random-64x21
[258.379435] Starting dynamic subtest: pipe-A-HDMI-A-1
[262.995587] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.616s)
[263.030074] Starting dynamic subtest: pipe-D-HDMI-A-1
[267.416937] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.395s)
[267.417925] Subtest cursor-random-64x21: SUCCESS (9.041s)
[267.819696] [045/131] (759s left) kms_force_connector_basic (force-edid)
[267.989115] Starting subtest: force-edid
[268.124728] Subtest force-edid: SUCCESS (0.135s)
[269.353795] [046/131] (757s left) kms_flip (2x-nonexisting-fb)
[271.363119] Starting subtest: 2x-nonexisting-fb
[271.385380] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[271.505375] [047/131] (755s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[273.554166] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[273.610130] [048/131] (753s left) gem_mmap_gtt (big-copy-xy)
[273.693410] Subtest big-copy-XY: SKIP (0.000s)
[273.765194] [049/131] (753s left) kms_hdr (static-toggle)
[275.771338] Starting subtest: static-toggle
[275.773931] Subtest static-toggle: SKIP (0.000s)
[275.888027] [050/131] (751s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[277.929363] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[277.931341] Starting dynamic subtest: pipe-A-HDMI-A-1
[277.940168] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[277.949741] Starting dynamic subtest: pipe-B-HDMI-A-1
[277.958286] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[277.967777] Starting dynamic subtest: pipe-C-HDMI-A-1
[277.976135] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[277.985290] Starting dynamic subtest: pipe-D-HDMI-A-1
[277.994802] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[277.996573] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[278.157940] [051/131] (749s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[280.179869] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[280.181527] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[280.364944] [052/131] (747s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[282.393329] Starting subtest: y-tiled-8bpp-rotate-180
[282.395250] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[282.597162] [053/131] (744s left) gem_eio (in-flight-external)
[282.890124] Starting subtest: in-flight-external
[283.894263] Subtest in-flight-external: SUCCESS (1.005s)
[285.971270] [054/131] (741s left) kms_psr (fbc-psr-dpms)
[288.023167] Subtest fbc-psr-dpms: SKIP (0.000s)
[288.093830] [055/131] (739s left) gem_render_copy (yf-tiled)
[288.204719] Starting subtest: yf-tiled
[288.207108] Subtest yf-tiled: SKIP (0.000s)
[288.456584] [056/131] (739s left) gem_exec_whisper (basic-fds-all)
[288.537088] Starting subtest: basic-fds-all
[310.692237] Subtest basic-fds-all: SUCCESS (22.153s)
[310.954902] [057/131] (716s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[311.028276] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[311.130730] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[311.267722] [058/131] (716s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[313.268401] Starting subtest: bad-rotation-90-y-tiled-ccs
[313.270436] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.279138] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[313.289078] Starting dynamic subtest: pipe-B-HDMI-A-1
[313.297729] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[313.307762] Starting dynamic subtest: pipe-C-HDMI-A-1
[313.316076] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[313.326067] Starting dynamic subtest: pipe-D-HDMI-A-1
[313.335440] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[313.337193] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[313.540914] [059/131] (714s left) syncobj_wait (single-wait-submitted)
[313.612375] Starting subtest: single-wait-submitted
[313.714750] Subtest single-wait-submitted: SUCCESS (0.102s)
[313.839698] [060/131] (714s left) kms_pm_rpm (legacy-planes-dpms)
[319.049261] Starting subtest: legacy-planes-dpms
[319.051274] Starting dynamic subtest: plane-43
[327.652820] Dynamic subtest plane-43: SUCCESS (8.604s)
[327.697717] Starting dynamic subtest: plane-53
[336.192391] Dynamic subtest plane-53: SUCCESS (8.537s)
[336.239609] Starting dynamic subtest: plane-63
[344.723308] Dynamic subtest plane-63: SUCCESS (8.528s)
[344.771968] Starting dynamic subtest: plane-73
[353.286379] Dynamic subtest plane-73: SUCCESS (8.560s)
[353.288228] Subtest legacy-planes-dpms: SUCCESS (34.242s)
[354.518123] [061/131] (673s left) kms_cursor_crc (cursor-sliding-128x42)
[356.760954] Starting subtest: cursor-sliding-128x42
[356.765546] Starting dynamic subtest: pipe-A-HDMI-A-1
[361.017874] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.252s)
[361.049459] Starting dynamic subtest: pipe-D-HDMI-A-1
[365.270179] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.229s)
[365.271171] Subtest cursor-sliding-128x42: SUCCESS (8.509s)
[365.627707] [062/131] (662s left) gem_lmem_swapping (heavy-multi)
[370.924922] Starting subtest: heavy-multi
[370.926481] Starting dynamic subtest: lmem0
[375.438500] Dynamic subtest lmem0: SUCCESS (4.513s)
[375.439424] Subtest heavy-multi: SUCCESS (4.514s)
[376.643996] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[376.646121] [063/131] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[382.684235] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[382.686174] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[382.789216] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)] new: kernel.kmod_is_loaded.i915: true
[382.792473] [064/131] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[384.815039] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[384.816967] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[384.966906] [065/131] (643s left) kms_frontbuffer_tracking (psr-2p-rte)
[387.011417] Starting subtest: psr-2p-rte
[387.013189] Subtest psr-2p-rte: SKIP (0.000s)
[387.206995] [066/131] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[389.243499] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[389.245365] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[389.430396] [067/131] (639s left) kms_getfb (getfb-handle-protection)
[391.471296] Starting subtest: getfb-handle-protection
[391.486250] Subtest getfb-handle-protection: SUCCESS (0.016s)
[391.682875] [068/131] (637s left) perf_pmu (busy-accuracy-98)
[391.769842] Starting subtest: busy-accuracy-98
[391.770777] Starting dynamic subtest: rcs0
[394.835622] Dynamic subtest rcs0: SUCCESS (3.064s)
[394.845249] Starting dynamic subtest: bcs0
[397.890435] Dynamic subtest bcs0: SUCCESS (3.054s)
[397.899769] Starting dynamic subtest: vcs0
[400.953406] Dynamic subtest vcs0: SUCCESS (3.062s)
[400.963037] Starting dynamic subtest: vcs1
[404.012367] Dynamic subtest vcs1: SUCCESS (3.058s)
[404.021897] Starting dynamic subtest: vecs0
[407.069412] Dynamic subtest vecs0: SUCCESS (3.056s)
[407.079082] Starting dynamic subtest: vecs1
[410.127369] Dynamic subtest vecs1: SUCCESS (3.057s)
[410.136921] Starting dynamic subtest: ccs0
[413.186374] Dynamic subtest ccs0: SUCCESS (3.058s)
[413.187279] Subtest busy-accuracy-98: SUCCESS (21.416s)
[413.350938] [069/131] (615s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[415.370930] Starting subtest: x-tiled-32bpp-rotate-270
[415.443363] Subtest x-tiled-32bpp-rotate-270: SKIP (0.071s)
[415.663068] [070/131] (613s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[415.740174] Subtest writes-after-reads: SKIP (0.000s)
[415.820081] [071/131] (613s left) gem_mmap_gtt (cpuset-big-copy-odd)
[415.895266] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[415.968039] [072/131] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[417.978304] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[417.980144] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[418.120994] [073/131] (611s left) i915_suspend (sysfs-reader)
[418.228432] Starting subtest: sysfs-reader
[438.955607] Subtest sysfs-reader: SUCCESS (5.535s)
[447.026145] [074/131] (590s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[447.105653] Starting subtest: single-wait-for-submit-available-signaled
[447.106741] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[447.249931] [075/131] (590s left) kms_tiled_display (basic-test-pattern)
[449.897387] Subtest basic-test-pattern: SKIP (0.000s)
[449.967662] [076/131] (587s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[451.740243] Starting subtest: cursorA-vs-flipB-toggle
[451.742245] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[451.846354] [077/131] (585s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[453.636602] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[453.638367] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[453.840064] [078/131] (583s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[455.597984] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[455.815781] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.214s)
[456.001344] [079/131] (581s left) gem_mmap (short-mmap)
[456.071714] Subtest short-mmap: SKIP (0.000s)
[456.164258] [080/131] (581s left) gem_exec_fence (long-history)
[456.685711] Starting subtest: long-history
[463.211327] Subtest long-history: SUCCESS (6.478s)
[464.395510] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[464.397635] [081/131] (573s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[466.417768] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[466.420102] Starting dynamic subtest: pipe-A-HDMI-A-1
[466.442122] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[466.453580] Starting dynamic subtest: pipe-B-HDMI-A-1
[466.475658] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[466.487150] Starting dynamic subtest: pipe-C-HDMI-A-1
[466.512718] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[466.524790] Starting dynamic subtest: pipe-D-HDMI-A-1
[466.548020] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[466.549753] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[466.698650] [082/131] (571s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[468.727402] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[468.729359] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[468.936752] [083/131] (569s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[470.957757] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[470.960095] Starting dynamic subtest: pipe-A-valid-mode
[471.008736] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s)
[471.010478] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.051s)
[471.163356] [084/131] (566s left) kms_chamelium_audio (dp-audio-edid)
[473.284214] Subtest dp-audio-edid: SKIP (0.000s)
[473.402528] [085/131] (564s left) kms_cursor_edge_walk (256x256-left-edge)
[475.418738] Starting subtest: 256x256-left-edge
[475.421131] Starting dynamic subtest: pipe-A-HDMI-A-1
[478.768145] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.344s)
[478.783624] Starting dynamic subtest: pipe-D-HDMI-A-1
[482.003465] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.233s)
[482.004481] Subtest 256x256-left-edge: SUCCESS (6.582s)
[482.186150] [086/131] (555s left) kms_frontbuffer_tracking (psr-slowdraw)
[484.208656] Starting subtest: psr-slowdraw
[484.210606] Subtest psr-slowdraw: SKIP (0.000s)
[484.385235] [087/131] (553s left) kms_getfb (getfb-handle-not-fb)
[486.406837] Starting subtest: getfb-handle-not-fb
[486.407704] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[486.602600] [088/131] (551s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[488.627758] Starting subtest: primary-y-tiled-reflect-x-0
[488.723844] Subtest primary-y-tiled-reflect-x-0: SKIP (0.094s)
[488.927385] [089/131] (549s left) kms_psr (fbc-psr2-dpms)
[490.942420] Subtest fbc-psr2-dpms: SKIP (0.000s)
[491.003764] [090/131] (547s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[493.032808] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[493.035177] Starting dynamic subtest: pipe-A-valid-mode
[493.084079] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[493.085872] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.050s)
[493.283415] [091/131] (545s left) kms_writeback (writeback-check-output)
[495.304254] Subtest writeback-check-output: SKIP (0.000s)
[495.449051] [092/131] (543s left) gem_softpin (evict-active)
[495.540688] Starting subtest: evict-active
[495.561951] Subtest evict-active: SUCCESS (0.021s)
[495.692356] [093/131] (543s left) gem_softpin (reverse)
[495.778458] Starting subtest: reverse
[495.789333] Subtest reverse: SUCCESS (0.011s)
[495.931988] [094/131] (543s left) kms_addfb_basic (small-bo)
[497.954828] Starting subtest: small-bo
[497.955729] Subtest small-bo: SUCCESS (0.000s)
[498.159108] [095/131] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[500.187705] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[500.189569] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[500.378084] [096/131] (538s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[500.463297] Starting subtest: etime-single-wait-all-for-submit-submitted
[500.571020] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[500.717570] [097/131] (538s left) gem_ctx_param (basic)
[500.794885] Starting subtest: basic
[500.797284] Subtest basic: SUCCESS (0.001s)
[500.941494] [098/131] (538s left) kms_psr (fbc-pr-no-drrs)
[502.967419] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[503.044562] [099/131] (536s left) kms_pm_rpm (system-suspend-modeset)
[508.171347] Starting subtest: system-suspend-modeset
[529.872997] Subtest system-suspend-modeset: SUCCESS (7.046s)
[534.050615] [100/131] (508s left) fbdev (read)
[534.107040] Starting subtest: read
[537.150610] Subtest read: SUCCESS (3.042s)
[537.222486] [101/131] (505s left) kms_chamelium_hpd (common-hpd-after-suspend)
[539.076210] Subtest common-hpd-after-suspend: SKIP (0.000s)
[539.182488] [102/131] (503s left) i915_pm_rc6_residency (rc6-idle)
[539.266330] Starting subtest: rc6-idle
[539.306408] Starting dynamic subtest: gt0-rcs0
[563.746745] Dynamic subtest gt0-rcs0: SUCCESS (24.237s)
[563.761420] Starting dynamic subtest: gt0-bcs0
[588.153592] Dynamic subtest gt0-bcs0: SUCCESS (24.396s)
[588.168042] Starting dynamic subtest: gt0-vcs0
[612.548470] Dynamic subtest gt0-vcs0: SUCCESS (24.385s)
[612.561116] Starting dynamic subtest: gt0-vecs0
[636.978640] Dynamic subtest gt0-vecs0: SUCCESS (24.421s)
[636.990788] Starting dynamic subtest: gt0-ccs0
[661.453305] Dynamic subtest gt0-ccs0: SUCCESS (24.476s)
[661.460290] Subtest rc6-idle: SUCCESS (121.968s)
[661.604085] [103/131] (381s left) gem_exec_balancer (bonded-semaphore)
[661.692164] Starting subtest: bonded-semaphore
[661.694044] Subtest bonded-semaphore: SKIP (0.000s)
[662.072323] [104/131] (380s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[664.095927] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[667.154857] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.058s)
[667.390800] [105/131] (375s left) gem_exec_fence (syncobj-repeat)
[667.910818] Starting subtest: syncobj-repeat
[668.216347] Subtest syncobj-repeat: SUCCESS (0.305s)
[668.634982] [106/131] (374s left) kms_big_fb (linear-16bpp-rotate-180)
[670.666448] Starting subtest: linear-16bpp-rotate-180
[672.522221] Subtest linear-16bpp-rotate-180: SUCCESS (1.855s)
[672.756117] [107/131] (370s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[674.778045] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[674.779856] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[674.991827] [108/131] (368s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[675.073267] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[675.074301] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[675.219262] [109/131] (367s left) kms_draw_crc (draw-method-mmap-cpu)
[677.240301] Starting subtest: draw-method-mmap-cpu
[677.241170] Starting dynamic subtest: xrgb8888-untiled
[677.539273] Dynamic subtest xrgb8888-untiled: SUCCESS (0.298s)
[677.586535] Starting dynamic subtest: rgb565-untiled
[677.872925] Dynamic subtest rgb565-untiled: SUCCESS (0.329s)
[677.915348] Starting dynamic subtest: xrgb2101010-untiled
[678.172661] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.295s)
[678.213011] Starting dynamic subtest: xbgr16161616f-untiled
[678.506172] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.329s)
[678.550865] Starting dynamic subtest: xrgb8888-xtiled
[678.704967] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.195s)
[678.728439] Starting dynamic subtest: rgb565-xtiled
[678.871902] Dynamic subtest rgb565-xtiled: SUCCESS (0.165s)
[678.888112] Starting dynamic subtest: xrgb2101010-xtiled
[679.023076] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[679.039447] Starting dynamic subtest: xbgr16161616f-xtiled
[679.172998] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.145s)
[679.215006] Starting dynamic subtest: xrgb8888-4tiled
[679.373022] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.196s)
[679.419122] Starting dynamic subtest: rgb565-4tiled
[679.572108] Dynamic subtest rgb565-4tiled: SUCCESS (0.195s)
[679.587254] Starting dynamic subtest: xrgb2101010-4tiled
[679.723020] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.149s)
[679.766253] Starting dynamic subtest: xbgr16161616f-4tiled
[679.906443] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.179s)
[679.912457] Subtest draw-method-mmap-cpu: SUCCESS (2.668s)
[680.096510] [110/131] (363s left) gem_vm_create (create-ext)
[680.182120] Starting subtest: create-ext
[680.188338] Subtest create-ext: SUCCESS (0.006s)
[680.338970] [111/131] (363s left) kms_flip (absolute-wf_vblank)
[682.351860] Starting subtest: absolute-wf_vblank
[682.356039] Starting dynamic subtest: A-HDMI-A1
[690.106169] Dynamic subtest A-HDMI-A1: SUCCESS (7.749s)
[690.121267] Starting dynamic subtest: B-HDMI-A1
[697.788756] Dynamic subtest B-HDMI-A1: SUCCESS (7.679s)
[697.803144] Starting dynamic subtest: C-HDMI-A1
[705.473329] Dynamic subtest C-HDMI-A1: SUCCESS (7.681s)
[705.487765] Starting dynamic subtest: D-HDMI-A1
[713.158261] Dynamic subtest D-HDMI-A1: SUCCESS (7.682s)
[713.160455] Subtest absolute-wf_vblank: SUCCESS (30.802s)
[713.369292] [112/131] (330s left) kms_plane_lowres (tiling-y)
[715.388383] Starting subtest: tiling-y
[715.390316] Subtest tiling-y: SKIP (0.000s)
[715.514107] [113/131] (328s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[717.562122] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[717.563872] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[717.725653] [114/131] (325s left) perf (low-oa-exponent-permissions)
[718.101452] Starting subtest: low-oa-exponent-permissions
[718.145119] Subtest low-oa-exponent-permissions: SUCCESS (0.044s)
[718.200657] [115/131] (325s left) perf (invalid-oa-exponent)
[718.409183] Starting subtest: invalid-oa-exponent
[718.429748] Subtest invalid-oa-exponent: SUCCESS (0.020s)
[718.482753] [116/131] (325s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[720.502384] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[720.504835] Starting dynamic subtest: pipe-A-HDMI-A-1
[724.407246] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.898s)
[724.422917] Starting dynamic subtest: pipe-B-HDMI-A-1
[725.086097] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.674s)
[725.126945] Starting dynamic subtest: pipe-C-HDMI-A-1
[725.794692] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.700s)
[725.836933] Starting dynamic subtest: pipe-D-HDMI-A-1
[726.502346] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.700s)
[726.504074] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (5.995s)
[726.760336] [117/131] (317s left) syncobj_wait (wait-for-submit-snapshot)
[726.839350] Starting subtest: wait-for-submit-snapshot
[726.922424] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[727.075214] [118/131] (316s left) kms_plane_scaling (invalid-num-scalers)
[729.092364] Starting subtest: invalid-num-scalers
[729.099021] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[729.116640] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.018s)
[729.132781] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[729.156106] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.033s)
[729.172440] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[729.194774] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.034s)
[729.211360] Starting dynamic subtest: pipe-D-HDMI-A-1-invalid-num-scalers
[729.234420] Dynamic subtest pipe-D-HDMI-A-1-invalid-num-scalers: SUCCESS (0.034s)
[729.235272] Subtest invalid-num-scalers: SUCCESS (0.141s)
[729.353878] [119/131] (314s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[729.433213] Starting subtest: multi-wait-all-for-submit-available-submitted
[729.434150] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[729.600585] [120/131] (314s left) kms_psr (pr-primary-render)
[731.622065] Subtest pr-primary-render: SKIP (0.000s)
[731.687111] [121/131] (312s left) gem_exec_params (no-bsd)
[731.785506] Starting subtest: no-bsd
[731.788108] Subtest no-bsd: SUCCESS (0.002s)
[731.966449] [122/131] (312s left) api_intel_allocator (simple-allocator)
[732.047274] Starting subtest: simple-allocator
[732.048225] Starting dynamic subtest: basic
[732.077679] Dynamic subtest basic: SUCCESS (0.030s)
[732.091116] Starting dynamic subtest: parallel-one
[732.265275] Dynamic subtest parallel-one: SUCCESS (0.186s)
[732.278142] Starting dynamic subtest: print
[732.279088] Dynamic subtest print: SUCCESS (0.000s)
[732.292054] Starting dynamic subtest: reuse
[732.293308] Dynamic subtest reuse: SUCCESS (0.000s)
[732.305761] Starting dynamic subtest: reserve
[732.306946] Dynamic subtest reserve: SUCCESS (0.000s)
[732.318892] Starting dynamic subtest: fork-reopen-allocator
[732.320015] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[732.321189] Subtest simple-allocator: SUCCESS (0.237s)
[732.438124] [123/131] (311s left) api_intel_bb (object-reloc-purge-cache)
[732.521342] Starting subtest: object-reloc-purge-cache
[732.524469] Subtest object-reloc-purge-cache: SKIP (0.002s)
[732.694344] [124/131] (311s left) gem_eio (in-flight-internal-1us)
[732.975824] Starting subtest: in-flight-internal-1us
[734.740154] Subtest in-flight-internal-1us: SUCCESS (1.764s)
[736.846133] [125/131] (307s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[738.884841] Starting subtest: 4-tiled-8bpp-rotate-270
[738.940728] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.055s)
[739.155823] [126/131] (305s left) sysfs_heartbeat_interval (idempotent)
[739.239248] Starting subtest: idempotent
[739.240187] Starting dynamic subtest: vecs0
[739.241093] Dynamic subtest vecs0: SUCCESS (0.001s)
[739.254135] Starting dynamic subtest: ccs0
[739.255102] Dynamic subtest ccs0: SUCCESS (0.001s)
[739.267936] Starting dynamic subtest: vcs0
[739.268862] Dynamic subtest vcs0: SUCCESS (0.001s)
[739.281346] Starting dynamic subtest: bcs0
[739.282464] Dynamic subtest bcs0: SUCCESS (0.001s)
[739.295289] Starting dynamic subtest: vecs1
[739.296504] Dynamic subtest vecs1: SUCCESS (0.001s)
[739.309249] Starting dynamic subtest: rcs0
[739.310503] Dynamic subtest rcs0: SUCCESS (0.001s)
[739.323829] Starting dynamic subtest: vcs1
[739.324767] Dynamic subtest vcs1: SUCCESS (0.001s)
[739.325615] Subtest idempotent: SUCCESS (0.013s)
[739.374588] [127/131] (305s left) gem_mmap (pf-nonblock)
[739.454188] Subtest pf-nonblock: SKIP (0.000s)
[739.558358] [128/131] (305s left) gem_workarounds (reset-fd)
[739.651607] Starting subtest: reset-fd
[739.898353] Subtest reset-fd: SUCCESS (0.246s)
[740.082187] [129/131] (304s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[742.106173] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[742.108011] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[742.304632] [130/131] (302s left) gem_shrink (reclaim)
[742.397948] Starting subtest: reclaim
[744.660788] Subtest reclaim: SUCCESS (2.262s)
[744.790382] [131/131] (300s left) kms_feature_discovery (display-3x)
[746.840174] Starting subtest: display-3x
[746.842041] Subtest display-3x: SKIP (0.000s)
[747.035725] Closing watchdogs
results: parsing output: 0/ for test: kms_lease
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gen7_exec_parse
results: parsing output: 3/ for test: syncobj_eventfd
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: gem_tiled_blits
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_pipe_crc_basic
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: i915_hangman
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: gem_fence_thrash
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_chamelium_edid
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: kms_async_flips
results: parsing output: 30/ for test: kms_content_protection
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_fence_thrash
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_compute
results: parsing output: 35/ for test: gem_readwrite
results: parsing output: 36/ for test: kms_pm_dc
results: parsing output: 37/ for test: prime_mmap_coherency
results: parsing output: 38/ for test: gem_create
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_pm_rps
results: parsing output: 41/ for test: kms_color
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_force_connector_basic
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_hdr
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: gem_exec_whisper
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_getfb
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_suspend
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_tiled_display
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_mmap
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_chamelium_audio
results: parsing output: 84/ for test: kms_cursor_edge_walk
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_writeback
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: fbdev
results: parsing output: 100/ for test: kms_chamelium_hpd
results: parsing output: 101/ for test: i915_pm_rc6_residency
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_draw_crc
results: parsing output: 109/ for test: gem_vm_create
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_plane_lowres
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: api_intel_allocator
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: sysfs_heartbeat_interval
results: parsing output: 126/ for test: gem_mmap
results: parsing output: 127/ for test: gem_workarounds
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_shrink
results: parsing output: 130/ for test: kms_feature_discovery
Done.