[115.237387] Initializing watchdogs
[115.237434]   /dev/watchdog0
[115.250069] [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]
[115.253907] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[115.256019] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[115.259226] [001/129] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[115.422083] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[115.426776] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[116.539880] [002/129] (959s left) prime_vgem (fence-wait)
[116.663256] Starting subtest: fence-wait
[116.665317] Starting dynamic subtest: rcs0
[117.707529] Dynamic subtest rcs0: SUCCESS (1.043s)
[117.717039] Starting dynamic subtest: bcs0
[118.774787] Dynamic subtest bcs0: SUCCESS (1.066s)
[118.783245] Starting dynamic subtest: vcs0
[119.822420] Dynamic subtest vcs0: SUCCESS (1.045s)
[119.831641] Starting dynamic subtest: vcs1
[120.927343] Dynamic subtest vcs1: SUCCESS (1.105s)
[120.936037] Starting dynamic subtest: vecs0
[121.973057] Dynamic subtest vecs0: SUCCESS (1.044s)
[121.981962] Starting dynamic subtest: ccs0
[123.018259] Dynamic subtest ccs0: SUCCESS (1.042s)
[123.020914] Subtest fence-wait: SUCCESS (6.349s)
[123.130812] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[123.135786] [003/129] (952s left) kms_rmfb (rmfb-ioctl)
[123.245916] Starting subtest: rmfb-ioctl
[123.248261] Starting dynamic subtest: pipe-A-eDP-1
[123.360730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.114s)
[123.369733] Starting dynamic subtest: pipe-B-eDP-1
[124.500649] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[124.509254] Starting dynamic subtest: pipe-C-eDP-1
[125.622822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[125.631251] Starting dynamic subtest: pipe-D-eDP-1
[126.749187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[126.751577] Subtest rmfb-ioctl: SUCCESS (3.502s)
[127.946312] [004/129] (947s left) kms_flip (2x-dpms-vs-vblank-race)
[128.044971] Starting subtest: 2x-dpms-vs-vblank-race
[128.055728] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[128.126630] [005/129] (947s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[128.234677] Starting subtest: 4-tiled-64bpp-rotate-0
[130.499409] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.264s)
[130.702429] [006/129] (945s left) kms_flip (2x-absolute-wf_vblank)
[130.801247] Starting subtest: 2x-absolute-wf_vblank
[130.812482] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[130.906027] [007/129] (945s left) gem_exec_whisper (basic-queues)
[130.975050] Starting subtest: basic-queues
[135.994698] Subtest basic-queues: SUCCESS (5.019s)
[136.169482] [008/129] (939s left) kms_addfb_basic (addfb25-modifier-no-flag)
[136.267986] Starting subtest: addfb25-modifier-no-flag
[136.270298] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[136.380794] [009/129] (939s left) gem_exec_schedule (preemptive-hang)
[136.560411] Starting subtest: preemptive-hang
[136.563054] Starting dynamic subtest: rcs0
[146.061503] Dynamic subtest rcs0: SUCCESS (9.500s)
[146.068158] Starting dynamic subtest: bcs0
[155.020791] Dynamic subtest bcs0: SUCCESS (8.958s)
[155.028992] Starting dynamic subtest: vcs0
[164.046562] Dynamic subtest vcs0: SUCCESS (9.023s)
[164.053594] Starting dynamic subtest: vcs1
[173.069357] Dynamic subtest vcs1: SUCCESS (9.022s)
[173.076248] Starting dynamic subtest: vecs0
[182.027984] Dynamic subtest vecs0: SUCCESS (8.957s)
[182.038811] Starting dynamic subtest: ccs0
[191.050667] Dynamic subtest ccs0: SUCCESS (9.025s)
[191.052938] Subtest preemptive-hang: SUCCESS (54.486s)
[191.300634] [010/129] (884s left) gem_mmap_gtt (basic-wc)
[191.348171] Subtest basic-wc: SKIP (0.000s)
[191.409676] [011/129] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[191.510842] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[191.514864] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[191.609096] [012/129] (884s left) perf_pmu (render-node-busy)
[191.686437] Starting subtest: render-node-busy
[191.688961] Starting dynamic subtest: rcs0
[192.301772] Dynamic subtest rcs0: SUCCESS (0.615s)
[192.311763] Starting dynamic subtest: bcs0
[192.862675] Dynamic subtest bcs0: SUCCESS (0.561s)
[192.872631] Starting dynamic subtest: vcs0
[194.922263] Dynamic subtest vcs0: SUCCESS (2.057s)
[194.932289] Starting dynamic subtest: vcs1
[196.905864] Dynamic subtest vcs1: SUCCESS (1.983s)
[196.915622] Starting dynamic subtest: vecs0
[198.953796] Dynamic subtest vecs0: SUCCESS (2.047s)
[198.963337] Starting dynamic subtest: ccs0
[199.515657] Dynamic subtest ccs0: SUCCESS (0.563s)
[199.518088] Subtest render-node-busy: SUCCESS (7.829s)
[199.582496] [013/129] (876s left) kms_invalid_mode (bad-htotal)
[199.673169] Starting subtest: bad-htotal
[199.675474] Starting dynamic subtest: pipe-A-eDP-1
[199.957628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[199.966060] Starting dynamic subtest: pipe-B-eDP-1
[199.967862] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[199.974271] Starting dynamic subtest: pipe-C-eDP-1
[199.976101] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[199.982795] Starting dynamic subtest: pipe-D-eDP-1
[199.984934] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[199.987075] Subtest bad-htotal: SUCCESS (0.287s)
[200.772643] [014/129] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[200.890475] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[200.894985] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[200.980295] [015/129] (875s left) kms_hdr (static-toggle-dpms)
[201.084027] Starting subtest: static-toggle-dpms
[201.091083] Subtest static-toggle-dpms: SKIP (0.000s)
[201.148318] [016/129] (875s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[201.253921] Starting subtest: x-tiled-64bpp-rotate-180
[203.499295] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.245s)
[203.714821] [017/129] (872s left) kms_frontbuffer_tracking (fbc-1p-rte)
[203.814648] Starting subtest: fbc-1p-rte
[208.199143] Subtest fbc-1p-rte: SUCCESS (4.390s)
[208.374214] [018/129] (867s left) syncobj_timeline (wait-for-submit-complex)
[208.432128] Starting subtest: wait-for-submit-complex
[208.493513] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[208.559546] [019/129] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[208.655992] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[208.660094] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[208.754290] [020/129] (867s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[208.848972] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[208.852590] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[208.952291] [021/129] (867s left) gen3_mixed_blits
[209.070652] [022/129] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[209.168680] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[209.172195] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[209.274745] [023/129] (867s left) kms_flip (flip-vs-rmfb-interruptible)
[209.375490] Starting subtest: flip-vs-rmfb-interruptible
[209.379512] Starting dynamic subtest: A-eDP1
[218.081690] Dynamic subtest A-eDP1: SUCCESS (8.704s)
[218.091021] Starting dynamic subtest: B-eDP1
[226.706232] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[226.715486] Starting dynamic subtest: C-eDP1
[235.318450] Dynamic subtest C-eDP1: SUCCESS (8.611s)
[235.326288] Starting dynamic subtest: D-eDP1
[243.943958] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[243.948585] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.568s)
[245.105855] [024/129] (831s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[245.204056] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[245.206293] Starting dynamic subtest: pipe-A-eDP-1
[245.230918] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.239033] Starting dynamic subtest: pipe-B-eDP-1
[245.262826] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.269347] Starting dynamic subtest: pipe-C-eDP-1
[245.294420] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.301518] Starting dynamic subtest: pipe-D-eDP-1
[245.326205] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.330385] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[247.358904] [025/129] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[247.466504] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[250.194850] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.732s)
[250.336013] [026/129] (826s left) gem_userptr_blits (forbidden-operations)
[250.399952] Starting subtest: forbidden-operations
[250.403714] Subtest forbidden-operations: SKIP (0.000s)
[250.537816] [027/129] (826s left) kms_flip (2x-plain-flip-interruptible)
[250.642751] Starting subtest: 2x-plain-flip-interruptible
[250.658437] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[250.757581] [028/129] (825s left) gem_workarounds (basic-read-context)
[250.828471] Starting subtest: basic-read-context
[250.838555] Subtest basic-read-context: SUCCESS (0.009s)
[250.963469] [029/129] (825s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[251.030441] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[251.104414] [030/129] (825s left) sw_sync (alloc_fence)
[251.136852] Starting subtest: alloc_fence
[251.138690] Subtest alloc_fence: SUCCESS (0.000s)
[251.181962] [031/129] (825s left) kms_addfb_basic (too-high)
[251.274980] Starting subtest: too-high
[251.277481] Subtest too-high: SUCCESS (0.000s)
[251.390316] [032/129] (825s left) drm_fdinfo (virtual-busy-idle)
[251.430537] Starting subtest: virtual-busy-idle
[251.434355] Subtest virtual-busy-idle: SKIP (0.000s)
[251.484843] [033/129] (825s left) gem_softpin (zero)
[251.548447] Starting subtest: zero
[251.552323] Subtest zero: SUCCESS (0.004s)
[251.665652] [034/129] (825s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[251.754949] Starting subtest: fbc-pr-sprite-mmap-cpu
[251.758851] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[251.819424] [035/129] (825s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[251.944133] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[252.095826] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.153s)
[252.230052] [036/129] (824s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[252.323934] Starting subtest: 2x-plain-flip-ts-check-interruptible
[252.336913] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[252.449842] [037/129] (824s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[252.549737] Starting subtest: crc-primary-basic-yf-tiled-ccs
[252.551574] Starting dynamic subtest: pipe-A-eDP-1
[252.571471] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[252.581457] Starting dynamic subtest: pipe-B-eDP-1
[252.598626] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[252.605576] Starting dynamic subtest: pipe-C-eDP-1
[252.622653] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[252.629064] Starting dynamic subtest: pipe-D-eDP-1
[252.646673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[252.649944] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[254.744467] [038/129] (822s left) gem_exec_fence (syncobj-invalid-wait)
[255.169382] Starting subtest: syncobj-invalid-wait
[255.172085] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[257.007664] [039/129] (820s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[257.247971] Starting subtest: parallel-dmabuf-import-out-fence
[258.264144] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.014s)
[258.343879] [040/129] (818s left) gem_close_race (basic-process)
[258.412379] Starting subtest: basic-process
[258.485918] Subtest basic-process: SUCCESS (0.073s)
[258.667351] [041/129] (818s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[263.694281] Starting subtest: psr2-plane-move-sf-dmg-area
[263.696645] Starting dynamic subtest: pipe-A-eDP-1
[268.877548] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.183s)
[268.885903] Starting dynamic subtest: pipe-B-eDP-1
[274.091677] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.212s)
[274.094059] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.398s)
[274.960944] [042/129] (802s left) kms_cursor_legacy (forked-bo)
[275.095554] Starting subtest: forked-bo
[275.097473] Starting dynamic subtest: pipe-A
[280.577953] Dynamic subtest pipe-A: SUCCESS (5.480s)
[280.585738] Starting dynamic subtest: pipe-B
[286.088080] Dynamic subtest pipe-B: SUCCESS (5.505s)
[286.098355] Starting dynamic subtest: pipe-C
[291.584612] Dynamic subtest pipe-C: SUCCESS (5.496s)
[291.595479] Starting dynamic subtest: pipe-D
[297.077736] Dynamic subtest pipe-D: SUCCESS (5.491s)
[297.087850] Starting dynamic subtest: all-pipes
[302.609448] Dynamic subtest all-pipes: SUCCESS (5.530s)
[302.611672] Subtest forked-bo: SUCCESS (27.510s)
[302.737241] [043/129] (774s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[302.843664] Starting subtest: psr-rgb565-draw-blt
[307.665862] Subtest psr-rgb565-draw-blt: SUCCESS (4.826s)
[307.795117] [044/129] (769s left) kms_lease (lease-unleased-connector)
[307.902923] Starting subtest: lease-unleased-connector
[307.905359] Starting dynamic subtest: pipe-A-eDP-1
[307.915660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.010s)
[307.924259] Starting dynamic subtest: pipe-B-eDP-1
[307.926518] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[307.934993] Starting dynamic subtest: pipe-C-eDP-1
[307.937256] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[307.945905] Starting dynamic subtest: pipe-D-eDP-1
[307.948201] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[307.950456] Subtest lease-unleased-connector: SUCCESS (0.046s)
[308.058838] [045/129] (769s left) gen9_exec_parse (bb-start-out)
[308.126189] Subtest bb-start-out: SKIP (0.000s)
[308.185580] [046/129] (769s left) kms_chamelium_hpd (hdmi-hpd)
[308.581107] Subtest hdmi-hpd: SKIP (0.000s)
[309.419609] [047/129] (767s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[309.486524] Starting subtest: multi-wait-for-submit-available-signaled
[309.488464] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[309.593970] [048/129] (767s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[309.657659] Starting subtest: invalid-multi-wait-all-unsubmitted
[309.659974] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[309.763844] [049/129] (767s left) kms_psr (fbc-psr2-sprite-plane-move)
[309.867978] Starting subtest: fbc-psr2-sprite-plane-move
[309.869938] Starting dynamic subtest: eDP-1
[309.874078] Dynamic subtest eDP-1: SKIP (0.000s)
[309.878229] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[309.935735] [050/129] (767s left) kms_psr (pr-primary-render)
[310.033530] Starting subtest: pr-primary-render
[310.038309] Subtest pr-primary-render: SKIP (0.000s)
[310.111238] [051/129] (767s left) kms_feature_discovery (display-1x)
[310.215929] Starting subtest: display-1x
[310.218161] Subtest display-1x: SUCCESS (0.000s)
[310.279647] [052/129] (767s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[310.385691] Starting subtest: psr-2p-primscrn-cur-indfb-move
[310.388967] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[310.491678] [053/129] (767s left) gem_mmap_gtt (basic-write-read-distinct)
[310.546093] Subtest basic-write-read-distinct: SKIP (0.000s)
[310.607322] [054/129] (766s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[310.713076] Starting subtest: plane-primary-toggle-with-vblank-wait
[310.714944] Starting dynamic subtest: pipe-A-eDP-1
[310.896352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s)
[311.194032] Starting dynamic subtest: pipe-B-eDP-1
[312.144068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.958s)
[312.428941] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.715s)
[313.284379] [055/129] (764s left) kms_chamelium_color (ctm-0-75)
[313.383177] Subtest ctm-0-75: SKIP (0.000s)
[313.426183] [056/129] (764s left) gem_userptr_blits (sync-unmap-after-close)
[313.490684] Starting subtest: sync-unmap-after-close
[313.503782] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[313.640367] [057/129] (763s left) dmabuf_sync_file (export-before-signal)
[313.674354] Starting subtest: export-before-signal
[313.676602] Subtest export-before-signal: SUCCESS (0.001s)
[313.720881] [058/129] (763s left) gem_gtt_cpu_tlb
[313.848196] [059/129] (763s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[313.903643] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[314.004509] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[314.071072] [060/129] (763s left) kms_vblank (wait-busy)
[314.170125] Starting subtest: wait-busy
[314.172325] Starting dynamic subtest: pipe-A-eDP-1
[316.060755] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[316.074694] Starting dynamic subtest: pipe-D-eDP-1
[318.651173] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.589s)
[318.653462] Subtest wait-busy: SUCCESS (4.481s)
[319.437770] [061/129] (758s left) gem_exec_flush (basic-wb-prw-default)
[319.496993] Starting subtest: basic-wb-prw-default
[324.975880] Subtest basic-wb-prw-default: SUCCESS (5.478s)
[325.157725] [062/129] (752s left) kms_plane (pixel-format-source-clamping)
[325.254082] Starting subtest: pixel-format-source-clamping
[325.290074] Starting dynamic subtest: pipe-A-plane-0
[329.934782] Dynamic subtest pipe-A-plane-0: SUCCESS (4.644s)
[329.944139] Starting dynamic subtest: pipe-A-plane-3
[332.178602] Dynamic subtest pipe-A-plane-3: SUCCESS (2.244s)
[332.186243] Starting dynamic subtest: pipe-A-plane-5
[332.188144] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[333.224982] Starting dynamic subtest: pipe-B-plane-0
[337.820414] Dynamic subtest pipe-B-plane-0: SUCCESS (4.600s)
[337.828283] Starting dynamic subtest: pipe-B-plane-3
[340.029321] Dynamic subtest pipe-B-plane-3: SUCCESS (2.211s)
[340.036715] Starting dynamic subtest: pipe-B-plane-5
[340.038361] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[340.337529] Subtest pixel-format-source-clamping: SUCCESS (15.081s)
[341.187275] [063/129] (736s left) kms_cursor_crc (cursor-offscreen-512x512)
[341.437567] Starting subtest: cursor-offscreen-512x512
[341.442093] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[341.575276] [064/129] (736s left) gem_exec_reloc (basic-wc-gtt)
[341.638992] Subtest basic-wc-gtt: SKIP (0.000s)
[341.724520] [065/129] (736s left) gem_exec_nop (basic-sequential)
[341.792350] Starting subtest: basic-sequential
[358.035880] Subtest basic-sequential: SUCCESS (16.251s)
[358.252792] [066/129] (719s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[358.360821] Starting subtest: primary-y-tiled-reflect-x-90
[358.365194] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[358.427515] [067/129] (719s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[358.525261] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[359.467668] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.944s)
[359.607655] [068/129] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[359.716189] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[359.720200] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[359.818937] [069/129] (718s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[359.923464] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[359.934566] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[360.007821] [070/129] (718s left) gem_mmap_offset (oob-read)
[360.066284] Starting subtest: oob-read
[360.068106] Subtest oob-read: SUCCESS (0.001s)
[360.166387] [071/129] (717s left) api_intel_allocator (open-vm)
[360.231591] Starting subtest: open-vm
[360.235442] Subtest open-vm: SUCCESS (0.006s)
[360.362294] [072/129] (717s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[360.460627] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[360.464091] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[360.570676] [073/129] (717s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[360.663754] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[360.665743] Starting dynamic subtest: pipe-A-eDP-1
[360.685117] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.693909] Starting dynamic subtest: pipe-B-eDP-1
[360.711870] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.719094] Starting dynamic subtest: pipe-C-eDP-1
[360.737174] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.744634] Starting dynamic subtest: pipe-D-eDP-1
[360.763919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.767736] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[362.829720] [074/129] (715s left) kms_vblank (query-idle-hang)
[362.935350] Starting subtest: query-idle-hang
[362.937667] Starting dynamic subtest: pipe-A-eDP-1
[389.727266] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.788s)
[389.740851] Starting dynamic subtest: pipe-D-eDP-1
[404.704783] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[404.707114] Subtest query-idle-hang: SUCCESS (41.765s)
[405.569458] [075/129] (672s left) gem_userptr_blits (map-fixed-invalidate)
[405.638189] Starting subtest: map-fixed-invalidate
[405.642147] Subtest map-fixed-invalidate: SKIP (0.000s)
[405.748838] [076/129] (672s left) gem_mmap_gtt (cpuset-basic-small-copy)
[405.809943] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[405.867169] [077/129] (672s left) gem_ctx_persistence (heartbeat-hostile)
[405.923046] Starting subtest: heartbeat-hostile
[405.927432] Subtest heartbeat-hostile: SKIP (0.000s)
[406.019850] [078/129] (672s left) i915_pm_rc6_residency (rc6-fence)
[406.077586] Starting subtest: rc6-fence
[406.114793] Starting dynamic subtest: gt0
[418.431518] Dynamic subtest gt0: SUCCESS (12.316s)
[418.442041] Starting dynamic subtest: gt1
[432.937754] Dynamic subtest gt1: SUCCESS (14.501s)
[432.940353] Subtest rc6-fence: SUCCESS (26.860s)
[433.010398] [079/129] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[433.125724] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[437.821283] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.698s)
[437.949858] [080/129] (640s left) kms_plane_scaling (planes-upscale-factor-0-25)
[438.055081] Starting subtest: planes-upscale-factor-0-25
[438.057297] Starting dynamic subtest: pipe-A
[438.119024] Dynamic subtest pipe-A: SUCCESS (0.064s)
[438.126713] Starting dynamic subtest: pipe-B
[439.246977] Dynamic subtest pipe-B: SUCCESS (1.126s)
[439.254841] Starting dynamic subtest: pipe-C
[440.347966] Dynamic subtest pipe-C: SUCCESS (1.101s)
[440.355632] Starting dynamic subtest: pipe-D
[441.479397] Dynamic subtest pipe-D: SUCCESS (1.130s)
[441.481738] Subtest planes-upscale-factor-0-25: SUCCESS (3.424s)
[442.618091] [081/129] (635s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[442.722491] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[442.726883] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[442.807559] [082/129] (635s left) gem_exec_fence (basic-await)
[442.984982] Starting subtest: basic-await
[442.987411] Starting dynamic subtest: rcs0
[443.064042] Dynamic subtest rcs0: SUCCESS (0.079s)
[443.075937] Starting dynamic subtest: bcs0
[443.142644] Dynamic subtest bcs0: SUCCESS (0.078s)
[443.152787] Starting dynamic subtest: vcs0
[443.220852] Dynamic subtest vcs0: SUCCESS (0.077s)
[443.231965] Starting dynamic subtest: vcs1
[443.298097] Dynamic subtest vcs1: SUCCESS (0.076s)
[443.306261] Starting dynamic subtest: vecs0
[443.377979] Dynamic subtest vecs0: SUCCESS (0.079s)
[443.388975] Starting dynamic subtest: ccs0
[443.455178] Dynamic subtest ccs0: SUCCESS (0.076s)
[443.457658] Subtest basic-await: SUCCESS (0.471s)
[445.020905] [083/129] (633s left) gem_ringfill (engines-basic)
[450.924760] Starting subtest: engines-basic
[450.927554] Starting dynamic subtest: rcs0
[451.010419] Dynamic subtest rcs0: SUCCESS (0.085s)
[451.021814] Starting dynamic subtest: bcs0
[451.056530] Dynamic subtest bcs0: SUCCESS (0.045s)
[451.066220] Starting dynamic subtest: vcs0
[451.098971] Dynamic subtest vcs0: SUCCESS (0.041s)
[451.108757] Starting dynamic subtest: vcs1
[451.142059] Dynamic subtest vcs1: SUCCESS (0.041s)
[451.151184] Starting dynamic subtest: vecs0
[451.184866] Dynamic subtest vecs0: SUCCESS (0.041s)
[451.193878] Starting dynamic subtest: ccs0
[451.229075] Dynamic subtest ccs0: SUCCESS (0.043s)
[451.231403] Subtest engines-basic: SUCCESS (0.307s)
[451.300639] [084/129] (627s left) kms_async_flips (test-cursor-atomic)
[451.403287] Starting subtest: test-cursor-atomic
[451.407622] Subtest test-cursor-atomic: SKIP (0.000s)
[452.550207] [085/129] (626s left) syncobj_wait (wait-all-for-submit-complex)
[452.598991] Starting subtest: wait-all-for-submit-complex
[452.813070] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[452.883562] [086/129] (625s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[452.991073] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[452.995430] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[453.096164] [087/129] (625s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[453.203793] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[457.574653] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.374s)
[457.716216] [088/129] (620s left) kms_frontbuffer_tracking (fbc-stridechange)
[457.820270] Starting subtest: fbc-stridechange
[460.115747] Subtest fbc-stridechange: SUCCESS (2.299s)
[460.284201] [089/129] (618s left) gem_lmem_swapping (smem-oom)
[460.330454] Subtest smem-oom: SKIP (0.000s)
[460.366612] [090/129] (618s left) kms_draw_crc (draw-method-render)
[460.458776] Starting subtest: draw-method-render
[460.460950] Starting dynamic subtest: xrgb8888-untiled
[460.685100] Dynamic subtest xrgb8888-untiled: SUCCESS (0.228s)
[460.693570] Starting dynamic subtest: rgb565-untiled
[460.895853] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[460.903703] Starting dynamic subtest: xrgb2101010-untiled
[461.106671] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[461.115779] Starting dynamic subtest: xbgr16161616f-untiled
[461.373392] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.266s)
[461.383608] Starting dynamic subtest: xrgb8888-xtiled
[461.495824] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[461.505778] Starting dynamic subtest: rgb565-xtiled
[461.617617] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[461.627612] Starting dynamic subtest: xrgb2101010-xtiled
[461.728996] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[461.737535] Starting dynamic subtest: xbgr16161616f-xtiled
[461.884764] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.155s)
[461.892553] Starting dynamic subtest: xrgb8888-4tiled
[462.007147] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[462.017269] Starting dynamic subtest: rgb565-4tiled
[462.118174] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s)
[462.131866] Starting dynamic subtest: xrgb2101010-4tiled
[462.229643] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[462.242882] Starting dynamic subtest: xbgr16161616f-4tiled
[462.373614] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[462.375604] Subtest draw-method-render: SUCCESS (1.917s)
[462.525106] [091/129] (616s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[462.638909] Starting subtest: y-tiled-32bpp-rotate-270
[462.642667] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[462.748271] [092/129] (616s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[462.847749] Starting subtest: multiplane-rotation-cropping-bottom
[469.996652] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.148s)
[470.114670] [093/129] (608s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[475.073255] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[475.077725] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[475.926161] [094/129] (602s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[475.994022] Starting subtest: yf-tiled-ccs-to-yf-tiled
[475.998684] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[476.172863] [095/129] (602s left) gem_ctx_sseu (invalid-args)
[476.225318] Subtest invalid-args: SKIP (0.000s)
[476.332470] [096/129] (602s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[476.710134] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[477.531348] [097/129] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[477.629320] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[477.633608] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[477.727912] [098/129] (601s left) kms_psr (fbc-psr-primary-page-flip)
[477.828397] Starting subtest: fbc-psr-primary-page-flip
[477.830551] Starting dynamic subtest: eDP-1
[477.834752] Dynamic subtest eDP-1: SKIP (0.000s)
[477.839298] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[477.891166] [099/129] (601s left) kms_plane_scaling (planes-downscale-factor-0-5)
[477.979764] Starting subtest: planes-downscale-factor-0-5
[477.982076] Starting dynamic subtest: pipe-A
[477.990958] Dynamic subtest pipe-A: SKIP (0.005s)
[478.000629] Starting dynamic subtest: pipe-B
[478.010112] Dynamic subtest pipe-B: SKIP (0.015s)
[478.018247] Starting dynamic subtest: pipe-C
[478.027574] Dynamic subtest pipe-C: SKIP (0.019s)
[478.036837] Starting dynamic subtest: pipe-D
[478.044939] Dynamic subtest pipe-D: SKIP (0.017s)
[478.048605] Subtest planes-downscale-factor-0-5: SKIP (0.058s)
[478.133249] [100/129] (601s left) kms_pm_rpm (modeset-lpsp-stress)
[480.082076] Starting subtest: modeset-lpsp-stress
[496.873604] Subtest modeset-lpsp-stress: SUCCESS (16.794s)
[496.954044] [101/129] (582s left) i915_pm_rps (engine-order)
[497.026642] Starting subtest: engine-order
[501.517066] Subtest engine-order: SUCCESS (4.489s)
[501.587834] [102/129] (577s left) gen7_exec_parse (bitmasks)
[501.651416] Subtest bitmasks: SKIP (0.000s)
[501.715723] [103/129] (577s left) drm_read (empty-block)
[501.885268] Starting subtest: empty-block
[502.883328] Subtest empty-block: SUCCESS (1.000s)
[503.011479] [104/129] (576s left) sysfs_preempt_timeout (invalid)
[503.074405] Starting subtest: invalid
[503.076603] Starting dynamic subtest: vecs0
[503.078725] Dynamic subtest vecs0: SUCCESS (0.000s)
[503.086723] Starting dynamic subtest: ccs0
[503.088788] Dynamic subtest ccs0: SUCCESS (0.000s)
[503.096177] Starting dynamic subtest: vcs0
[503.098211] Dynamic subtest vcs0: SUCCESS (0.000s)
[503.105467] Starting dynamic subtest: bcs0
[503.107594] Dynamic subtest bcs0: SUCCESS (0.000s)
[503.114796] Starting dynamic subtest: rcs0
[503.116944] Dynamic subtest rcs0: SUCCESS (0.000s)
[503.124068] Starting dynamic subtest: vcs1
[503.126139] Dynamic subtest vcs1: SUCCESS (0.000s)
[503.128252] Subtest invalid: SUCCESS (0.005s)
[503.191686] [105/129] (576s left) gem_ctx_persistence (process)
[503.240950] Starting subtest: process
[503.441941] Subtest process: SUCCESS (0.201s)
[503.513177] [106/129] (575s left) gem_mmap_wc (coherency)
[503.571073] Subtest coherency: SKIP (0.000s)
[503.623164] [107/129] (575s left) kms_psr (psr2-sprite-render)
[503.722900] Starting subtest: psr2-sprite-render
[503.725207] Starting dynamic subtest: eDP-1
[505.412057] Dynamic subtest eDP-1: SUCCESS (1.690s)
[505.414720] Subtest psr2-sprite-render: SUCCESS (1.691s)
[506.272888] [108/129] (573s left) api_intel_bb (object-reloc-purge-cache)
[506.327122] Starting subtest: object-reloc-purge-cache
[506.331229] Subtest object-reloc-purge-cache: SKIP (0.002s)
[506.438804] [109/129] (573s left) kms_plane_alpha_blend (alpha-7efc)
[506.544122] Starting subtest: alpha-7efc
[506.944302] Starting dynamic subtest: pipe-A-eDP-1
[507.518191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[507.543218] Starting dynamic subtest: pipe-D-eDP-1
[508.757505] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[508.759837] Subtest alpha-7efc: SUCCESS (2.210s)
[509.533155] [110/129] (569s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[509.642887] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[510.854330] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.604s)
[510.886865] [111/129] (568s left) intel_hwmon (hwmon-write)
[510.942876] Subtest hwmon-write: SKIP (0.000s)
[511.003377] [112/129] (568s left) gem_tiled_swapping (non-threaded)
[511.066079] Subtest non-threaded: SKIP (0.000s)
[511.122954] [113/129] (568s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[511.182481] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[511.184522] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[511.274641] [114/129] (568s left) fbdev (unaligned-write)
[511.318571] Starting subtest: unaligned-write
[511.419733] Subtest unaligned-write: SUCCESS (0.100s)
[511.475359] [115/129] (568s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[511.561777] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[511.563729] Starting dynamic subtest: pipe-A-default-mode
[511.851211] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[511.855595] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.284s)
[512.656943] [116/129] (567s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[512.759115] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[512.761384] Starting dynamic subtest: pipe-A-eDP-1
[512.784187] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[512.793782] Starting dynamic subtest: pipe-B-eDP-1
[512.815343] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[512.823716] Starting dynamic subtest: pipe-C-eDP-1
[512.846100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[512.855086] Starting dynamic subtest: pipe-D-eDP-1
[512.877403] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[512.881522] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[514.906111] [117/129] (564s left) kms_3d
[517.222681] [118/129] (562s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[517.325260] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[517.329328] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[517.421280] [119/129] (562s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[517.643696] Starting subtest: cursor-rapid-movement-512x512
[517.648576] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[517.796301] [120/129] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[517.908906] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[522.729298] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.824s)
[522.835336] [121/129] (557s left) prime_mmap (test_reprime)
[522.899850] Starting subtest: test_reprime
[522.902068] Starting dynamic subtest: test_reprime-smem
[522.932733] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[522.935079] Subtest test_reprime: SUCCESS (0.034s)
[523.036018] [122/129] (556s left) syncobj_wait (wait-any-interrupted)
[523.102459] Starting subtest: wait-any-interrupted
[523.206467] Subtest wait-any-interrupted: SUCCESS (0.102s)
[523.280175] [123/129] (556s left) gem_exec_schedule (lateslice)
[523.354308] Starting subtest: lateslice
[523.356358] Starting dynamic subtest: rcs0
[523.364520] Dynamic subtest rcs0: SUCCESS (0.020s)
[523.372488] Starting dynamic subtest: bcs0
[523.384386] Dynamic subtest bcs0: SUCCESS (0.019s)
[523.392269] Starting dynamic subtest: vcs0
[523.400201] Dynamic subtest vcs0: SUCCESS (0.016s)
[523.408198] Starting dynamic subtest: vcs1
[523.416317] Dynamic subtest vcs1: SUCCESS (0.015s)
[523.424106] Starting dynamic subtest: vecs0
[523.433186] Dynamic subtest vecs0: SUCCESS (0.016s)
[523.440938] Starting dynamic subtest: ccs0
[523.451719] Dynamic subtest ccs0: SUCCESS (0.018s)
[523.453866] Subtest lateslice: SUCCESS (0.108s)
[524.986353] [124/129] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[525.098100] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[525.102251] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[525.205044] [125/129] (554s left) kms_content_protection (dp-mst-type-1)
[525.366715] Starting subtest: dp-mst-type-1
[525.371234] Subtest dp-mst-type-1: SKIP (0.000s)
[525.494922] [126/129] (554s left) gem_ctx_exec (basic-invalid-context)
[525.557887] Starting subtest: basic-invalid-context
[525.563399] Subtest basic-invalid-context: SUCCESS (0.005s)
[525.708271] [127/129] (554s left) gem_request_retire (retire-vma-not-inactive)
[525.760418] Starting subtest: retire-vma-not-inactive
[525.822099] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[525.965778] [128/129] (554s left) perf_pmu (busy-double-start)
[526.008535] Starting subtest: busy-double-start
[526.010183] Starting dynamic subtest: rcs0
[529.644873] Dynamic subtest rcs0: FAIL (3.571s)
[529.654279] Starting dynamic subtest: bcs0
[533.145979] Dynamic subtest bcs0: SUCCESS (3.566s)
[533.155556] Starting dynamic subtest: vcs0
[537.515322] Dynamic subtest vcs0: FAIL (4.298s)
[537.525728] Starting dynamic subtest: vcs1
[541.482802] Dynamic subtest vcs1: FAIL (3.966s)
[541.492198] Starting dynamic subtest: vecs0
[545.513483] Dynamic subtest vecs0: FAIL (4.031s)
[545.522813] Starting dynamic subtest: ccs0
[549.081679] Dynamic subtest ccs0: FAIL (3.565s)
[549.083962] Subtest busy-double-start: FAIL (23.002s)
[549.126656] [129/129] (531s left) gem_exec_store (cachelines)
[549.189608] Starting subtest: cachelines
[549.191944] Starting dynamic subtest: rcs0
[549.291231] Dynamic subtest rcs0: SUCCESS (0.101s)
[549.302652] Starting dynamic subtest: bcs0
[549.344748] Dynamic subtest bcs0: SUCCESS (0.052s)
[549.354523] Starting dynamic subtest: vcs0
[549.402950] Dynamic subtest vcs0: SUCCESS (0.056s)
[549.412554] Starting dynamic subtest: vcs1
[549.460293] Dynamic subtest vcs1: SUCCESS (0.056s)
[549.468286] Starting dynamic subtest: vecs0
[549.509811] Dynamic subtest vecs0: SUCCESS (0.048s)
[549.517221] Starting dynamic subtest: ccs0
[549.568487] Dynamic subtest ccs0: SUCCESS (0.057s)
[549.571049] Subtest cachelines: SUCCESS (0.379s)
[549.744404] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: kms_rmfb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_hdr
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gen3_mixed_blits
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_workarounds
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: drm_fdinfo
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_pxp
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: gem_close_race
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_lease
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_feature_discovery
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: kms_chamelium_color
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: dmabuf_sync_file
results: parsing output: 57/ for test: gem_gtt_cpu_tlb
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_flush
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_exec_nop
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_mmap_offset
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: i915_pm_rc6_residency
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_ringfill
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_lmem_swapping
results: parsing output: 89/ for test: kms_draw_crc
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_ctx_sseu
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: i915_pm_rps
results: parsing output: 101/ for test: gen7_exec_parse
results: parsing output: 102/ for test: drm_read
results: parsing output: 103/ for test: sysfs_preempt_timeout
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_plane_alpha_blend
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: intel_hwmon
results: parsing output: 111/ for test: gem_tiled_swapping
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: fbdev
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_3d
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: gem_ctx_exec
results: parsing output: 126/ for test: gem_request_retire
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: gem_exec_store
Done.