[57.065930] Initializing watchdogs
[57.066102]   /dev/watchdog0
[57.081837] [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]
[57.086345] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.088584] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.092087] [001/133] (960s left) gem_exec_reloc (basic-write-read)
[57.182449] Subtest basic-write-read: SKIP (0.000s)
[57.245758] [002/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[57.302952] Starting subtest: invalid-multi-wait-unsubmitted
[57.304945] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[57.421598] [003/133] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[57.516845] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[57.519129] Starting dynamic subtest: pipe-A-eDP-1
[57.528123] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.535357] Starting dynamic subtest: pipe-B-eDP-1
[57.544260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.551133] Starting dynamic subtest: pipe-C-eDP-1
[57.559777] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.566613] Starting dynamic subtest: pipe-D-eDP-1
[57.575222] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.579475] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[60.013138] [004/133] (957s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[60.081875] Starting subtest: y-tiled-ccs-to-yf-tiled
[60.086504] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[60.254916] [005/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[60.347030] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[60.351507] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[60.453055] [006/133] (957s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[60.557098] Starting subtest: 4-tiled-64bpp-rotate-180
[62.247188] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.691s)
[62.422332] [007/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[62.518932] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[62.522452] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[62.612642] [008/133] (955s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[62.711926] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[62.715326] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[62.787636] [009/133] (955s left) gem_exec_balancer (fairslice)
[62.838406] Starting subtest: fairslice
[65.751112] Subtest fairslice: SUCCESS (2.910s)
[66.069075] [010/133] (951s left) kms_invalid_mode (bad-htotal)
[66.167342] Starting subtest: bad-htotal
[66.169810] Starting dynamic subtest: pipe-A-eDP-1
[66.457983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[66.470794] Starting dynamic subtest: pipe-B-eDP-1
[66.472804] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[66.479833] Starting dynamic subtest: pipe-C-eDP-1
[66.482210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[66.493543] Starting dynamic subtest: pipe-D-eDP-1
[66.496076] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[66.498579] Subtest bad-htotal: SUCCESS (0.294s)
[67.275147] [011/133] (950s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[67.432053] Starting subtest: yf-tiled-32bpp-rotate-180
[67.436591] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[67.598014] [012/133] (950s left) kms_content_protection (atomic-hdcp14)
[67.779774] Starting subtest: atomic-hdcp14
[67.784558] Subtest atomic-hdcp14: SKIP (0.000s)
[68.037508] [013/133] (950s left) i915_selftest (mock)
[71.275869] Starting subtest: mock
[71.278460] Starting dynamic subtest: sanitycheck
[71.953326] Dynamic subtest sanitycheck: SUCCESS (0.678s)
[71.962043] Starting dynamic subtest: shmem
[72.617211] Dynamic subtest shmem: SUCCESS (0.663s)
[72.625872] Starting dynamic subtest: fence
[79.997982] Dynamic subtest fence: SUCCESS (7.379s)
[80.005035] Starting dynamic subtest: scatterlist
[81.663942] Dynamic subtest scatterlist: SUCCESS (1.665s)
[81.672726] Starting dynamic subtest: syncmap
[84.808902] Dynamic subtest syncmap: SUCCESS (3.144s)
[84.817881] Starting dynamic subtest: uncore
[85.496194] Dynamic subtest uncore: SUCCESS (0.687s)
[85.504804] Starting dynamic subtest: ring
[86.149177] Dynamic subtest ring: SUCCESS (0.652s)
[86.162764] Starting dynamic subtest: engine
[86.880434] Dynamic subtest engine: SUCCESS (0.730s)
[86.889427] Starting dynamic subtest: timelines
[90.694529] Dynamic subtest timelines: SUCCESS (3.811s)
[90.702159] Starting dynamic subtest: requests
[94.231705] Dynamic subtest requests: SUCCESS (3.537s)
[94.238795] Starting dynamic subtest: objects
[94.981062] Dynamic subtest objects: SUCCESS (0.749s)
[94.989974] Starting dynamic subtest: phys
[95.744218] Dynamic subtest phys: SUCCESS (0.762s)
[95.753070] Starting dynamic subtest: dmabuf
[96.492035] Dynamic subtest dmabuf: SUCCESS (0.747s)
[96.500953] Starting dynamic subtest: vma
[102.243228] Dynamic subtest vma: SUCCESS (5.750s)
[102.251936] Starting dynamic subtest: evict
[103.648072] Dynamic subtest evict: SUCCESS (1.404s)
[103.655796] Starting dynamic subtest: gtt
[106.983500] Dynamic subtest gtt: SUCCESS (3.335s)
[106.990816] Starting dynamic subtest: hugepages
[107.921570] Dynamic subtest hugepages: SUCCESS (0.938s)
[107.930085] Starting dynamic subtest: memory_region
[110.451613] Dynamic subtest memory_region: SUCCESS (2.529s)
[110.454077] Subtest mock: SUCCESS (39.176s)
[110.481061] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[110.484107] [014/133] (907s left) fbdev (unaligned-read)
[112.018180] Starting subtest: unaligned-read
[112.032404] Subtest unaligned-read: SUCCESS (0.016s)
[112.072895] [FACT fbdev (unaligned-read)] new: kernel.kmod_is_loaded.i915: true
[112.076419] [015/133] (906s left) perf_pmu (busy-accuracy-50)
[112.123486] Starting subtest: busy-accuracy-50
[112.125871] Starting dynamic subtest: rcs0
[113.660307] Dynamic subtest rcs0: SUCCESS (1.534s)
[113.670737] Starting dynamic subtest: bcs0
[115.209732] Dynamic subtest bcs0: SUCCESS (1.549s)
[115.219730] Starting dynamic subtest: vcs0
[116.778148] Dynamic subtest vcs0: SUCCESS (1.538s)
[116.785624] Starting dynamic subtest: vcs1
[118.292614] Dynamic subtest vcs1: SUCCESS (1.543s)
[118.302458] Starting dynamic subtest: vecs0
[119.836111] Dynamic subtest vecs0: SUCCESS (1.542s)
[119.845824] Starting dynamic subtest: ccs0
[121.382741] Dynamic subtest ccs0: SUCCESS (1.546s)
[121.384995] Subtest busy-accuracy-50: SUCCESS (9.257s)
[121.497167] [016/133] (896s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[121.598900] Starting subtest: plane-upscale-factor-0-25-with-rotation
[121.601214] Starting dynamic subtest: pipe-A
[121.834536] Dynamic subtest pipe-A: SUCCESS (0.238s)
[121.843467] Starting dynamic subtest: pipe-B
[123.163059] Dynamic subtest pipe-B: SUCCESS (1.328s)
[123.171962] Starting dynamic subtest: pipe-C
[124.494424] Dynamic subtest pipe-C: SUCCESS (1.331s)
[124.508116] Starting dynamic subtest: pipe-D
[125.826573] Dynamic subtest pipe-D: SUCCESS (1.331s)
[125.828916] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.231s)
[127.004966] [017/133] (891s left) gem_userptr_blits (sync-unmap-cycles)
[127.068108] Starting subtest: sync-unmap-cycles
[132.445578] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[132.580352] [018/133] (885s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[132.693168] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[132.696816] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[132.796462] [019/133] (885s left) gem_ctx_param (basic-default)
[132.851118] Starting subtest: basic-default
[132.853066] Subtest basic-default: SUCCESS (0.000s)
[132.922180] [020/133] (885s left) syncobj_basic (bad-pad-handle-to-fd)
[132.967415] Starting subtest: bad-pad-handle-to-fd
[132.969130] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[133.064083] [021/133] (885s left) perf_pmu (render-node-busy-idle)
[133.143871] Starting subtest: render-node-busy-idle
[133.146631] Starting dynamic subtest: rcs0
[133.812329] Dynamic subtest rcs0: SUCCESS (0.667s)
[133.822973] Starting dynamic subtest: bcs0
[134.471606] Dynamic subtest bcs0: SUCCESS (0.659s)
[134.482074] Starting dynamic subtest: vcs0
[135.893910] Dynamic subtest vcs0: SUCCESS (1.419s)
[135.903044] Starting dynamic subtest: vcs1
[137.878881] Dynamic subtest vcs1: SUCCESS (1.983s)
[137.891211] Starting dynamic subtest: vecs0
[139.926310] Dynamic subtest vecs0: SUCCESS (2.046s)
[139.936901] Starting dynamic subtest: ccs0
[140.589309] Dynamic subtest ccs0: SUCCESS (0.664s)
[140.592024] Subtest render-node-busy-idle: SUCCESS (7.446s)
[140.668027] [022/133] (877s left) kms_cursor_edge_walk (128x128-left-edge)
[140.773935] Starting subtest: 128x128-left-edge
[140.776347] Starting dynamic subtest: pipe-A-eDP-1
[144.271921] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s)
[144.281925] Starting dynamic subtest: pipe-D-eDP-1
[147.387466] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[147.389747] Subtest 128x128-left-edge: SUCCESS (6.614s)
[148.208363] [023/133] (870s left) kms_addfb_basic (unused-modifier)
[148.271986] Starting subtest: unused-modifier
[148.274426] Subtest unused-modifier: SUCCESS (0.000s)
[148.410296] [024/133] (870s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[148.514568] Starting subtest: fbc-farfromfence-mmap-gtt
[148.519094] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[148.612449] [025/133] (869s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[148.708936] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[149.532265] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[149.735263] [026/133] (868s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[149.787102] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[149.791373] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[149.967093] [027/133] (868s left) kms_lease (lease-revoke)
[150.061363] Starting subtest: lease-revoke
[150.063674] Starting dynamic subtest: pipe-A-eDP-1
[150.091545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.029s)
[150.100908] Starting dynamic subtest: pipe-B-eDP-1
[150.125635] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[150.134915] Starting dynamic subtest: pipe-C-eDP-1
[150.150242] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[150.158634] Starting dynamic subtest: pipe-D-eDP-1
[150.178074] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[150.180499] Subtest lease-revoke: SUCCESS (0.117s)
[150.309404] [028/133] (868s left) kms_properties (colorop-properties-atomic)
[150.402691] Starting subtest: colorop-properties-atomic
[150.405099] Starting dynamic subtest: pipe-A-eDP-1
[150.737760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[150.745901] Starting dynamic subtest: pipe-B-eDP-1
[151.782605] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.044s)
[151.791457] Starting dynamic subtest: pipe-C-eDP-1
[152.817761] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[152.830378] Starting dynamic subtest: pipe-D-eDP-1
[153.841737] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.023s)
[153.844101] Subtest colorop-properties-atomic: SUCCESS (3.439s)
[154.640985] [029/133] (864s left) gem_exec_whisper (basic-forked-all)
[154.699950] Starting subtest: basic-forked-all
[167.897482] Subtest basic-forked-all: SUCCESS (13.192s)
[168.078968] [030/133] (850s left) syncobj_timeline (signal-array)
[168.138257] Starting subtest: signal-array
[168.140660] Subtest signal-array: SUCCESS (0.000s)
[168.226833] [031/133] (850s left) kms_flip (2x-busy-flip)
[168.320577] Starting subtest: 2x-busy-flip
[168.329625] Subtest 2x-busy-flip: SKIP (0.011s)
[168.411966] [032/133] (850s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[168.508964] Starting subtest: fbc-rgb565-draw-mmap-gtt
[168.513308] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[168.594285] [033/133] (850s left) kms_psr (psr2-primary-render)
[168.696497] Starting subtest: psr2-primary-render
[168.699186] Starting dynamic subtest: eDP-1
[170.425870] Dynamic subtest eDP-1: SUCCESS (1.731s)
[170.427877] Subtest psr2-primary-render: SUCCESS (1.732s)
[171.295375] [034/133] (847s left) gem_exec_reloc (basic-wc-cpu)
[171.357364] Subtest basic-wc-cpu: SKIP (0.000s)
[171.437114] [035/133] (847s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[171.551321] Starting subtest: flip-vs-cursor-toggle
[180.191491] Subtest flip-vs-cursor-toggle: SUCCESS (8.639s)
[181.021007] [036/133] (837s left) kms_getfb (getfb-reject-nv12)
[181.125308] Starting subtest: getfb-reject-nv12
[181.127700] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[181.226973] [037/133] (837s left) kms_sequence (get-forked-busy)
[181.322992] Starting subtest: get-forked-busy
[181.325349] Starting dynamic subtest: pipe-A-eDP-1
[183.261810] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[183.272209] Starting dynamic subtest: pipe-B-eDP-1
[185.846891] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[185.856108] Starting dynamic subtest: pipe-C-eDP-1
[188.451421] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s)
[188.460914] Starting dynamic subtest: pipe-D-eDP-1
[191.080680] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[191.083084] Subtest get-forked-busy: SUCCESS (9.759s)
[191.872248] [038/133] (827s left) gen7_exec_parse (basic-rejected)
[191.940830] Subtest basic-rejected: SKIP (0.000s)
[192.013279] [039/133] (827s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[192.126258] Starting subtest: cursorA-vs-flipA-varying-size
[203.287636] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.159s)
[204.115192] [040/133] (815s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[204.170015] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[204.273884] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[204.351055] [041/133] (814s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[204.479366] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[215.667807] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.188s)
[216.454824] [042/133] (802s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[216.768728] Starting subtest: cursor-rapid-movement-max-size
[216.775124] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[216.896748] [043/133] (802s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[216.993327] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[217.019097] Starting dynamic subtest: pipe-A-plane-0
[217.718653] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[217.727316] Starting dynamic subtest: pipe-A-plane-3
[218.173999] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[219.242749] Starting dynamic subtest: pipe-B-plane-0
[219.902690] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[219.913880] Starting dynamic subtest: pipe-B-plane-3
[220.335661] Dynamic subtest pipe-B-plane-3: SUCCESS (0.431s)
[220.643395] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.652s)
[221.509883] [044/133] (797s left) i915_drm_fdinfo (virtual-busy-all)
[221.556616] Starting subtest: virtual-busy-all
[221.561074] Subtest virtual-busy-all: SKIP (0.000s)
[221.621019] [045/133] (797s left) syncobj_basic (bad-fd-to-handle)
[221.668728] Starting subtest: bad-fd-to-handle
[221.670678] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[221.751805] [046/133] (797s left) sriov_basic (enable-vfs-bind-unbind-each)
[221.814854] Starting subtest: enable-vfs-bind-unbind-each
[221.816764] Starting dynamic subtest: numvfs-1
[221.896063] Dynamic subtest numvfs-1: FAIL (0.029s)
[221.906420] Starting dynamic subtest: numvfs-2
[221.976757] Dynamic subtest numvfs-2: FAIL (0.004s)
[221.985739] Starting dynamic subtest: numvfs-3
[222.054853] Dynamic subtest numvfs-3: FAIL (0.005s)
[222.063272] Starting dynamic subtest: numvfs-4
[222.134784] Dynamic subtest numvfs-4: FAIL (0.004s)
[222.144996] Starting dynamic subtest: numvfs-5
[222.217143] Dynamic subtest numvfs-5: FAIL (0.004s)
[222.226434] Starting dynamic subtest: numvfs-6
[222.298095] Dynamic subtest numvfs-6: FAIL (0.004s)
[222.307938] Starting dynamic subtest: numvfs-7
[222.379935] Dynamic subtest numvfs-7: FAIL (0.004s)
[222.389687] Starting dynamic subtest: numvfs-random
[222.458951] Dynamic subtest numvfs-random: FAIL (0.004s)
[222.461032] Subtest enable-vfs-bind-unbind-each: FAIL (0.064s)
[222.497018] [047/133] (796s left) kms_chamelium_hpd (dp-hpd)
[222.911939] Subtest dp-hpd: SKIP (0.000s)
[223.727882] [048/133] (795s left) gem_exec_whisper (basic-queues-priority)
[223.781032] Starting subtest: basic-queues-priority
[247.130012] Subtest basic-queues-priority: SUCCESS (23.345s)
[247.324898] [049/133] (772s left) api_intel_allocator (reserve-simple)
[247.373855] Starting subtest: reserve-simple
[247.380317] Subtest reserve-simple: SUCCESS (0.007s)
[247.491987] [050/133] (772s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[247.586840] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[247.589153] Starting dynamic subtest: pipe-A-eDP-1
[247.609585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[247.620199] Starting dynamic subtest: pipe-B-eDP-1
[247.637784] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[247.645878] Starting dynamic subtest: pipe-C-eDP-1
[247.664193] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[247.672137] Starting dynamic subtest: pipe-D-eDP-1
[247.690108] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[247.691836] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[249.909854] [051/133] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[250.026470] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[250.030823] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[250.133640] [052/133] (769s left) gem_exec_fence (basic-await)
[250.312064] Starting subtest: basic-await
[250.314824] Starting dynamic subtest: rcs0
[250.387372] Dynamic subtest rcs0: SUCCESS (0.075s)
[250.399198] Starting dynamic subtest: bcs0
[250.461336] Dynamic subtest bcs0: SUCCESS (0.072s)
[250.472690] Starting dynamic subtest: vcs0
[250.534936] Dynamic subtest vcs0: SUCCESS (0.071s)
[250.545508] Starting dynamic subtest: vcs1
[250.607997] Dynamic subtest vcs1: SUCCESS (0.072s)
[250.619524] Starting dynamic subtest: vecs0
[250.682234] Dynamic subtest vecs0: SUCCESS (0.072s)
[250.694562] Starting dynamic subtest: ccs0
[250.755059] Dynamic subtest ccs0: SUCCESS (0.071s)
[250.757878] Subtest basic-await: SUCCESS (0.444s)
[252.962542] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[252.966025] [053/133] (766s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[253.084021] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[260.147909] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.070s)
[260.264140] [054/133] (759s left) kms_psr (pr-suspend)
[260.361283] Starting subtest: pr-suspend
[260.365587] Subtest pr-suspend: SKIP (0.000s)
[260.434033] [055/133] (759s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[260.521335] Starting subtest: multiplane-rotation-cropping-bottom
[277.957527] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.438s)
[278.084576] [056/133] (741s left) kms_vblank (ts-continuation-dpms-suspend)
[278.181615] Starting subtest: ts-continuation-dpms-suspend
[278.183540] Starting dynamic subtest: pipe-A-eDP-1
[296.001020] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.432s)
[296.015658] Starting dynamic subtest: pipe-D-eDP-1
[313.950719] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.885s)
[313.952608] Subtest ts-continuation-dpms-suspend: SUCCESS (5.321s)
[323.769484] [057/133] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[323.887205] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[330.662232] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.772s)
[330.793189] [058/133] (698s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[330.887644] Starting subtest: compare-crc-sanitycheck-nv12
[330.889556] Starting dynamic subtest: pipe-A-eDP-1
[331.583008] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[331.592562] Starting dynamic subtest: pipe-B-eDP-1
[332.903926] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[332.914093] Starting dynamic subtest: pipe-C-eDP-1
[334.141097] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[334.151218] Starting dynamic subtest: pipe-D-eDP-1
[335.378081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[335.380435] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.490s)
[336.208282] [059/133] (692s left) gem_media_fill (media-fill)
[336.276290] Subtest media-fill: SKIP (0.000s)
[336.395630] [060/133] (692s left) gem_pread (self)
[336.457484] Subtest self: SKIP (0.000s)
[336.516390] [061/133] (692s left) kms_color_pipeline (plane-ctm3x4)
[336.609635] Starting subtest: plane-ctm3x4
[336.792543] Starting dynamic subtest: pipe-A-plane-0
[336.978070] Dynamic subtest pipe-A-plane-0: SUCCESS (0.186s)
[336.988097] Starting dynamic subtest: pipe-A-plane-1
[337.122219] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[337.132192] Starting dynamic subtest: pipe-A-plane-2
[337.255558] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[338.422215] Starting dynamic subtest: pipe-B-plane-0
[338.582152] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[338.591899] Starting dynamic subtest: pipe-B-plane-1
[338.747856] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[338.757692] Starting dynamic subtest: pipe-B-plane-2
[338.880752] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[340.054030] Starting dynamic subtest: pipe-C-plane-0
[340.201192] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[340.213671] Starting dynamic subtest: pipe-C-plane-1
[340.345819] Dynamic subtest pipe-C-plane-1: SUCCESS (0.142s)
[340.357979] Starting dynamic subtest: pipe-C-plane-2
[340.467997] Dynamic subtest pipe-C-plane-2: SUCCESS (0.121s)
[341.687786] Starting dynamic subtest: pipe-D-plane-0
[341.814650] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[341.824069] Starting dynamic subtest: pipe-D-plane-1
[341.935813] Dynamic subtest pipe-D-plane-1: SUCCESS (0.121s)
[341.945309] Starting dynamic subtest: pipe-D-plane-2
[342.069220] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[342.358010] Subtest plane-ctm3x4: SUCCESS (5.747s)
[343.229966] [062/133] (685s left) gem_exec_alignment (many)
[343.295555] Starting subtest: many
[367.573508] Subtest many: SUCCESS (24.275s)
[368.212233] [063/133] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[368.377854] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[368.381804] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[368.475926] [064/133] (660s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[368.565480] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[368.567727] Starting dynamic subtest: pipe-A
[368.962676] Dynamic subtest pipe-A: SUCCESS (0.399s)
[368.972344] Starting dynamic subtest: pipe-B
[370.484397] Dynamic subtest pipe-B: SUCCESS (1.519s)
[370.494044] Starting dynamic subtest: pipe-C
[371.905680] Dynamic subtest pipe-C: SUCCESS (1.420s)
[371.916107] Starting dynamic subtest: pipe-D
[373.326700] Dynamic subtest pipe-D: SUCCESS (1.420s)
[373.328903] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.764s)
[374.477317] [065/133] (654s left) gem_exec_schedule (preemptive-hang)
[374.669967] Starting subtest: preemptive-hang
[374.672228] Starting dynamic subtest: rcs0
[383.538417] Dynamic subtest rcs0: SUCCESS (8.867s)
[383.550717] Starting dynamic subtest: bcs0
[392.502086] Dynamic subtest bcs0: SUCCESS (8.961s)
[392.511689] Starting dynamic subtest: vcs0
[401.519142] Dynamic subtest vcs0: SUCCESS (9.011s)
[401.531673] Starting dynamic subtest: vcs1
[410.478306] Dynamic subtest vcs1: SUCCESS (8.956s)
[410.489778] Starting dynamic subtest: vecs0
[419.496562] Dynamic subtest vecs0: SUCCESS (9.016s)
[419.509118] Starting dynamic subtest: ccs0
[428.524709] Dynamic subtest ccs0: SUCCESS (9.028s)
[428.527400] Subtest preemptive-hang: SUCCESS (53.850s)
[428.786466] [066/133] (600s left) gem_ctx_persistence (engines-hang)
[428.850719] Starting subtest: engines-hang
[428.852951] Starting dynamic subtest: rcs0
[428.921309] Dynamic subtest rcs0: SUCCESS (0.073s)
[428.933546] Starting dynamic subtest: bcs0
[429.024174] Dynamic subtest bcs0: SUCCESS (0.101s)
[429.036865] Starting dynamic subtest: vcs0
[429.132117] Dynamic subtest vcs0: SUCCESS (0.106s)
[429.144178] Starting dynamic subtest: vcs1
[429.238996] Dynamic subtest vcs1: SUCCESS (0.105s)
[429.250988] Starting dynamic subtest: vecs0
[429.342982] Dynamic subtest vecs0: SUCCESS (0.102s)
[429.354733] Starting dynamic subtest: ccs0
[429.453119] Dynamic subtest ccs0: SUCCESS (0.108s)
[429.455531] Subtest engines-hang: SUCCESS (0.606s)
[429.536084] [067/133] (599s left) gem_exec_schedule (deep)
[429.717965] Starting subtest: deep
[429.720332] Starting dynamic subtest: rcs0
[436.075263] Dynamic subtest rcs0: SKIP (6.355s)
[436.087436] Starting dynamic subtest: vcs0
[446.450474] Dynamic subtest vcs0: SUCCESS (10.377s)
[446.464547] Starting dynamic subtest: vcs1
[457.646162] Dynamic subtest vcs1: SUCCESS (11.193s)
[457.659838] Starting dynamic subtest: vecs0
[468.816116] Dynamic subtest vecs0: SUCCESS (11.168s)
[468.829311] Starting dynamic subtest: ccs0
[480.943046] Dynamic subtest ccs0: SUCCESS (12.122s)
[480.946466] Subtest deep: SUCCESS (51.223s)
[482.020088] [068/133] (547s left) gem_wait (busy)
[482.093099] Starting subtest: busy
[482.095470] Starting dynamic subtest: all-engines
[483.331555] Dynamic subtest all-engines: SUCCESS (1.237s)
[483.342953] Starting dynamic subtest: rcs0
[483.873789] Dynamic subtest rcs0: SUCCESS (0.541s)
[483.885857] Starting dynamic subtest: bcs0
[484.414766] Dynamic subtest bcs0: SUCCESS (0.540s)
[484.428205] Starting dynamic subtest: vcs0
[486.339516] Dynamic subtest vcs0: SUCCESS (1.922s)
[486.352347] Starting dynamic subtest: vcs1
[488.323449] Dynamic subtest vcs1: SUCCESS (1.981s)
[488.336099] Starting dynamic subtest: vecs0
[490.371888] Dynamic subtest vecs0: SUCCESS (2.046s)
[490.384753] Starting dynamic subtest: ccs0
[490.914325] Dynamic subtest ccs0: SUCCESS (0.540s)
[490.917005] Subtest busy: SUCCESS (8.820s)
[491.107298] [069/133] (538s left) gem_madvise (dontneed-before-mmap)
[491.151987] Starting subtest: dontneed-before-mmap
[491.166352] Subtest dontneed-before-mmap: SUCCESS (0.017s)
[491.262743] [070/133] (538s left) gem_exec_flush (basic-uc-rw-default)
[491.322891] Starting subtest: basic-uc-rw-default
[496.780486] Subtest basic-uc-rw-default: SUCCESS (5.457s)
[496.966361] [071/133] (532s left) gem_mmap_gtt (basic)
[497.025482] Subtest basic: SKIP (0.000s)
[497.084736] [072/133] (532s left) kms_tv_load_detect (load-detect)
[497.142823] Subtest load-detect: SKIP (0.000s)
[497.204257] [073/133] (532s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[497.309546] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[497.313841] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[497.412952] [074/133] (532s left) gem_wait (invalid-buf)
[497.466269] Starting subtest: invalid-buf
[497.468554] Subtest invalid-buf: SUCCESS (0.000s)
[497.708213] [075/133] (531s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[497.802751] Starting subtest: bad-aux-stride-y-tiled-ccs
[497.805012] Starting dynamic subtest: pipe-A-eDP-1
[497.827947] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[497.838446] Starting dynamic subtest: pipe-B-eDP-1
[497.860322] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[497.869869] Starting dynamic subtest: pipe-C-eDP-1
[497.891099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[497.900206] Starting dynamic subtest: pipe-D-eDP-1
[497.923045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[497.927703] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[500.048325] [076/133] (529s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[500.160380] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[500.164703] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[500.263975] [077/133] (529s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[500.358145] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[500.362318] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[500.447934] [078/133] (529s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[500.554926] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[507.149786] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.596s)
[507.288930] [079/133] (522s left) kms_properties (invalid-properties-legacy)
[507.392670] Starting subtest: invalid-properties-legacy
[507.498248] Subtest invalid-properties-legacy: SUCCESS (0.106s)
[507.572219] [080/133] (522s left) gem_mmap_gtt (basic-read-write-distinct)
[507.631531] Subtest basic-read-write-distinct: SKIP (0.000s)
[507.698691] [081/133] (522s left) kms_display_modes (extended-mode-basic)
[507.801540] Starting subtest: extended-mode-basic
[507.806071] Subtest extended-mode-basic: SKIP (0.000s)
[507.850166] [082/133] (522s left) kms_flip (blocking-absolute-wf_vblank)
[507.942765] Starting subtest: blocking-absolute-wf_vblank
[507.945126] Starting dynamic subtest: A-eDP1
[516.733697] Dynamic subtest A-eDP1: SUCCESS (8.789s)
[516.746224] Starting dynamic subtest: B-eDP1
[525.464448] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[525.481588] Starting dynamic subtest: C-eDP1
[534.189500] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[534.206446] Starting dynamic subtest: D-eDP1
[542.927279] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[542.929702] Subtest blocking-absolute-wf_vblank: SUCCESS (34.982s)
[544.138861] [083/133] (485s left) kms_psr2_su (page_flip-xrgb8888)
[544.196806] Subtest page_flip-XRGB8888: SKIP (0.000s)
[544.255076] [084/133] (485s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[544.301405] Starting subtest: multi-wait-for-submit-available-submitted
[544.304418] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[544.398251] [085/133] (485s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[544.491901] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[544.503126] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[544.589756] [086/133] (485s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[544.674052] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[544.678632] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[544.750740] [087/133] (485s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[544.857691] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[544.859919] Starting dynamic subtest: pipe-A-eDP-1
[544.884728] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[544.895561] Starting dynamic subtest: pipe-B-eDP-1
[544.918952] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[544.928644] Starting dynamic subtest: pipe-C-eDP-1
[544.951787] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[544.960767] Starting dynamic subtest: pipe-D-eDP-1
[544.984304] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[544.988663] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[547.098771] [088/133] (483s left) kms_chamelium_frames (hdmi-frame-dump)
[547.503097] Subtest hdmi-frame-dump: SKIP (0.000s)
[548.355305] [089/133] (481s left) gem_mmap_offset (mmap-unmap)
[548.418019] Starting subtest: mmap-unmap
[548.420105] Starting dynamic subtest: smem0
[571.429854] Dynamic subtest smem0: SUCCESS (23.013s)
[571.432863] Subtest mmap-unmap: SUCCESS (23.014s)
[571.562097] [090/133] (458s left) i915_module_load (reload)
[571.605991] Starting subtest: reload
[575.768808] Subtest reload: SUCCESS (4.162s)
[575.808059] [091/133] (454s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[577.385786] Starting subtest: flip-vs-cursor-busy-crc-atomic
[578.230116] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.843s)
[579.040832] [092/133] (451s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[579.129560] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[579.131797] Starting dynamic subtest: pipe-A-eDP-1
[579.187719] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[579.197543] Starting dynamic subtest: pipe-B-eDP-1
[579.254360] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[579.264289] Starting dynamic subtest: pipe-C-eDP-1
[579.320478] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[579.330537] Starting dynamic subtest: pipe-D-eDP-1
[579.389022] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[579.393251] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[581.436945] [093/133] (449s left) kms_psr (fbc-psr-cursor-render)
[581.527049] Starting subtest: fbc-psr-cursor-render
[581.529511] Starting dynamic subtest: eDP-1
[581.533727] Dynamic subtest eDP-1: SKIP (0.000s)
[581.537781] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[581.599801] [094/133] (448s left) kms_dsc (dsc-basic)
[581.696568] Starting subtest: dsc-basic
[581.710013] Subtest dsc-basic: SKIP (0.000s)
[581.774011] [095/133] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[581.876595] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[591.253016] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.377s)
[591.421300] [096/133] (439s left) kms_flip (flip-vs-dpms-on-nop)
[591.523974] Starting subtest: flip-vs-dpms-on-nop
[591.526299] Starting dynamic subtest: A-eDP1
[593.364963] Dynamic subtest A-eDP1: SUCCESS (1.840s)
[593.376528] Starting dynamic subtest: B-eDP1
[595.204898] Dynamic subtest B-eDP1: SUCCESS (1.838s)
[595.215602] Starting dynamic subtest: C-eDP1
[597.035951] Dynamic subtest C-eDP1: SUCCESS (1.828s)
[597.046678] Starting dynamic subtest: D-eDP1
[598.866400] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[598.871434] Subtest flip-vs-dpms-on-nop: SUCCESS (7.348s)
[600.058639] [097/133] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[600.153206] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[600.157268] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[600.251140] [098/133] (430s left) gem_exec_schedule (promotion)
[600.320550] Starting subtest: promotion
[600.322486] Starting dynamic subtest: rcs0
[600.427806] Dynamic subtest rcs0: SUCCESS (0.111s)
[600.440684] Starting dynamic subtest: vcs0
[600.517723] Dynamic subtest vcs0: SUCCESS (0.088s)
[600.529238] Starting dynamic subtest: vcs1
[600.599545] Dynamic subtest vcs1: SUCCESS (0.081s)
[600.610917] Starting dynamic subtest: vecs0
[600.685968] Dynamic subtest vecs0: SUCCESS (0.086s)
[600.698143] Starting dynamic subtest: ccs0
[600.780982] Dynamic subtest ccs0: SUCCESS (0.094s)
[600.783525] Subtest promotion: SUCCESS (0.465s)
[602.466933] [099/133] (428s left) syncobj_wait (multi-wait-all-signaled)
[602.512037] Starting subtest: multi-wait-all-signaled
[602.514536] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[602.615328] [100/133] (428s left) gem_mmap_gtt (basic-write-gtt)
[602.666437] Subtest basic-write-gtt: SKIP (0.000s)
[602.735048] [101/133] (428s left) gem_sync (basic-store-all)
[602.810625] Starting subtest: basic-store-all
[605.143113] Subtest basic-store-all: SUCCESS (2.341s)
[605.330027] [102/133] (425s left) kms_addfb_basic (legacy-format)
[605.405154] Starting subtest: legacy-format
[605.429565] Subtest legacy-format: SUCCESS (0.022s)
[605.581036] [103/133] (425s left) syncobj_timeline (32bits-limit)
[605.636755] Starting subtest: 32bits-limit
[605.639016] Subtest 32bits-limit: SUCCESS (0.001s)
[605.762518] [104/133] (425s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[605.870983] Starting subtest: fbcpsr-stridechange
[612.089211] Subtest fbcpsr-stridechange: SUCCESS (6.220s)
[612.238960] [105/133] (418s left) kms_prime (basic-modeset-hybrid)
[612.329535] Subtest basic-modeset-hybrid: SKIP (0.000s)
[612.435409] [106/133] (418s left) kms_pm_rpm (dpms-lpsp)
[614.461100] Starting subtest: dpms-lpsp
[614.768242] Subtest dpms-lpsp: SUCCESS (0.309s)
[614.856388] [107/133] (416s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[614.979832] Starting subtest: cursor-vs-flip-varying-size
[645.897964] Subtest cursor-vs-flip-varying-size: SUCCESS (30.914s)
[646.750506] [108/133] (384s left) kms_addfb_basic (clobberred-modifier)
[646.814702] Starting subtest: clobberred-modifier
[646.818414] Subtest clobberred-modifier: SKIP (0.000s)
[646.957675] [109/133] (384s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[647.057113] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[647.061206] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[647.163047] [110/133] (384s left) kms_cursor_crc (cursor-onscreen-32x10)
[647.316365] Starting subtest: cursor-onscreen-32x10
[647.365907] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[647.634185] [111/133] (383s left) api_intel_bb (object-reloc-keep-cache)
[647.696927] Starting subtest: object-reloc-keep-cache
[647.700778] Subtest object-reloc-keep-cache: SKIP (0.002s)
[647.821903] [112/133] (383s left) gem_exec_create (basic)
[647.873690] Starting subtest: basic
[647.875621] Starting dynamic subtest: smem
[651.336373] Dynamic subtest smem: SUCCESS (3.462s)
[651.339594] Subtest basic: SUCCESS (3.464s)
[651.536588] [113/133] (379s left) gem_exec_fence (parallel)
[651.719045] Starting subtest: parallel
[651.721465] Starting dynamic subtest: rcs0
[653.872200] Dynamic subtest rcs0: SUCCESS (2.154s)
[653.881453] Starting dynamic subtest: bcs0
[656.025616] Dynamic subtest bcs0: SUCCESS (2.152s)
[656.036322] Starting dynamic subtest: vcs0
[658.176261] Dynamic subtest vcs0: SUCCESS (2.150s)
[658.186210] Starting dynamic subtest: vcs1
[660.326241] Dynamic subtest vcs1: SUCCESS (2.149s)
[660.336558] Starting dynamic subtest: vecs0
[662.481436] Dynamic subtest vecs0: SUCCESS (2.154s)
[662.492267] Starting dynamic subtest: ccs0
[664.630506] Dynamic subtest ccs0: SUCCESS (2.148s)
[664.632371] Subtest parallel: SUCCESS (12.912s)
[665.439613] [114/133] (365s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[665.552565] Starting subtest: pr-primary-plane-update-sf-dmg-area
[665.557084] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[665.636201] [115/133] (365s left) kms_psr (fbc-pr-sprite-render)
[665.743861] Starting subtest: fbc-pr-sprite-render
[665.748193] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[665.843684] [116/133] (365s left) i915_pm_rpm (gem-evict-pwrite)
[667.465019] Starting subtest: gem-evict-pwrite
[667.470080] Subtest gem-evict-pwrite: SKIP (0.000s)
[668.094886] [117/133] (363s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[668.202116] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[668.205982] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[668.300668] [118/133] (363s left) core_getversion (all-cards)
[668.343879] Starting subtest: all-cards
[668.351919] Subtest all-cards: SUCCESS (0.011s)
[668.396350] [119/133] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[668.490478] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[668.494940] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[668.599521] [120/133] (363s left) gem_eio (wait-10ms)
[668.831344] Starting subtest: wait-10ms
[669.193024] Subtest wait-10ms: SUCCESS (0.362s)
[669.326210] [121/133] (362s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[669.424956] Starting subtest: y-tiled-8bpp-rotate-90
[669.428665] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[669.516431] [122/133] (362s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[669.634604] Starting subtest: 2x-long-cursor-vs-flip-atomic
[669.638199] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[669.780830] [123/133] (361s left) gem_eio (throttle)
[669.995510] Starting subtest: throttle
[670.328326] Subtest throttle: SUCCESS (0.334s)
[670.443828] [124/133] (361s left) gem_ctx_exec (basic-invalid-context)
[670.504053] Starting subtest: basic-invalid-context
[670.508090] Subtest basic-invalid-context: SUCCESS (0.006s)
[670.620056] [125/133] (361s left) gem_softpin (allocator-evict)
[670.677401] Starting subtest: allocator-evict
[670.679526] Starting dynamic subtest: rcs0
[693.766168] Dynamic subtest rcs0: SUCCESS (23.085s)
[693.778324] Starting dynamic subtest: bcs0
[717.791082] Dynamic subtest bcs0: SUCCESS (24.020s)
[717.805983] Starting dynamic subtest: vcs0
[741.581462] Dynamic subtest vcs0: SUCCESS (23.787s)
[741.594028] Starting dynamic subtest: vcs1
[765.316290] Dynamic subtest vcs1: SUCCESS (23.730s)
[765.328216] Starting dynamic subtest: vecs0
[789.216295] Dynamic subtest vecs0: SUCCESS (23.896s)
[789.229765] Starting dynamic subtest: ccs0
[813.457576] Dynamic subtest ccs0: SUCCESS (24.238s)
[813.460706] Subtest allocator-evict: SUCCESS (142.767s)
[813.553352] [126/133] (218s left) gem_mmap_wc (read)
[813.652832] Subtest read: SKIP (0.000s)
[813.710868] [127/133] (218s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[813.819792] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[813.823737] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[813.905350] [128/133] (218s left) gem_linear_blits (normal)
[814.068823] Starting subtest: normal
[818.272128] Subtest normal: SUCCESS (4.202s)
[818.447349] [129/133] (213s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[818.570215] Starting subtest: modeset-transition-nonblocking-fencing
[818.572333] Starting dynamic subtest: 1x-outputs
[829.764551] Dynamic subtest 1x-outputs: SUCCESS (11.195s)
[829.767218] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.197s)
[830.630019] [130/133] (201s left) gen3_render_tiledx_blits
[830.763959] [131/133] (201s left) gem_gtt_cpu_tlb
[830.878760] [132/133] (201s left) sysfs_timeslice_duration (duration)
[830.937623] Starting subtest: duration
[830.939553] Starting dynamic subtest: vecs0
[844.322326] Dynamic subtest vecs0: SUCCESS (13.385s)
[844.335345] Starting dynamic subtest: ccs0
[857.461443] Dynamic subtest ccs0: SUCCESS (13.138s)
[857.474258] Starting dynamic subtest: vcs0
[872.290042] Dynamic subtest vcs0: SUCCESS (14.824s)
[872.303255] Starting dynamic subtest: bcs0
[885.426798] Dynamic subtest bcs0: SUCCESS (13.135s)
[885.440179] Starting dynamic subtest: rcs0
[898.574167] Dynamic subtest rcs0: SUCCESS (13.142s)
[898.587075] Starting dynamic subtest: vcs1
[912.354140] Dynamic subtest vcs1: SUCCESS (13.778s)
[912.356906] Subtest duration: SUCCESS (81.418s)
[912.433976] [133/133] (119s left) gem_ctx_persistence (legacy-engines-queued)
[912.499565] Starting subtest: legacy-engines-queued
[912.501930] Starting dynamic subtest: render
[912.581299] Dynamic subtest render: SUCCESS (0.081s)
[912.596891] Starting dynamic subtest: bsd1
[914.275512] Dynamic subtest bsd1: SUCCESS (1.689s)
[914.288245] Starting dynamic subtest: bsd2
[915.297928] Dynamic subtest bsd2: SUCCESS (1.019s)
[915.310362] Starting dynamic subtest: blt
[915.338722] Dynamic subtest blt: SUCCESS (0.039s)
[915.348667] Starting dynamic subtest: vebox
[917.346151] Dynamic subtest vebox: SUCCESS (2.004s)
[917.349026] Subtest legacy-engines-queued: SUCCESS (4.847s)
[917.429108] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: i915_selftest
results: parsing output: 13/ for test: fbdev
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_cursor_edge_walk
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: gem_exec_whisper
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: kms_sequence
results: parsing output: 37/ for test: gen7_exec_parse
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: sriov_basic
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: gem_exec_whisper
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pipe_crc_basic
results: parsing output: 58/ for test: gem_media_fill
results: parsing output: 59/ for test: gem_pread
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: gem_exec_alignment
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: gem_madvise
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_tv_load_detect
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: kms_display_modes
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_psr2_su
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_chamelium_frames
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: i915_module_load
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_dsc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: gem_sync
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_prime
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_exec_create
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: core_getversion
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_eio
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: gem_ctx_exec
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_linear_blits
results: parsing output: 128/ for test: kms_atomic_transition
results: parsing output: 129/ for test: gen3_render_tiledx_blits
results: parsing output: 130/ for test: gem_gtt_cpu_tlb
results: parsing output: 131/ for test: sysfs_timeslice_duration
results: parsing output: 132/ for test: gem_ctx_persistence
Done.