[58.507122] Initializing watchdogs
[58.507191]   /dev/watchdog0
[58.519819] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.523586] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.525714] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.528985] [001/130] (960s left) kms_psr (pr-sprite-mmap-gtt)
[58.677428] Starting subtest: pr-sprite-mmap-gtt
[58.682087] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[58.741186] [002/130] (960s left) kms_selftest (drm_format_helper)
[58.781063] Starting subtest: drm_format_helper
[58.788896] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[58.931166] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.143s)
[58.938793] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[59.032674] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.100s)
[59.040178] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[59.146411] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.115s)
[59.154467] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[59.287285] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.139s)
[59.295414] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[59.431675] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.146s)
[59.439133] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[59.578394] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.145s)
[59.585738] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[59.723089] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.144s)
[59.728813] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[59.835346] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.113s)
[59.842101] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[59.987667] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.152s)
[59.995831] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[60.129863] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.140s)
[60.137642] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[60.267335] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.137s)
[60.275277] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[60.393520] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.127s)
[60.401773] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[60.512496] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.119s)
[60.520720] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[60.603910] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.090s)
[60.611821] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[60.748246] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.143s)
[60.756369] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[60.853524] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.106s)
[60.861709] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list
[60.981835] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.129s)
[60.989577] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[61.147208] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.165s)
[61.149589] Subtest drm_format_helper: SUCCESS (2.369s)
[61.328827] [003/130] (957s left) gem_exec_balancer (full-pulse)
[61.390741] Starting subtest: full-pulse
[65.653105] Subtest full-pulse: SUCCESS (4.262s)
[65.979811] [004/130] (953s left) kms_addfb_basic (clobberred-modifier)
[66.044218] Starting subtest: clobberred-modifier
[66.048990] Subtest clobberred-modifier: SKIP (0.000s)
[66.162019] [005/130] (952s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[66.225847] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[66.269929] [006/130] (952s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[66.359974] Starting subtest: primary-yf-tiled-reflect-x-0
[66.428667] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.066s)
[66.518639] [007/130] (952s left) gem_mmap_wc (pf-nonblock)
[66.570033] Subtest pf-nonblock: SKIP (0.000s)
[66.631408] [008/130] (952s left) gem_render_linear_blits (basic)
[66.693409] Starting subtest: basic
[66.715726] Subtest basic: SUCCESS (0.022s)
[66.811201] [009/130] (952s left) kms_big_fb (linear-64bpp-rotate-180)
[66.916833] Starting subtest: linear-64bpp-rotate-180
[69.224282] Subtest linear-64bpp-rotate-180: SUCCESS (2.307s)
[69.437070] [010/130] (949s left) api_intel_bb (offset-control)
[69.494305] Starting subtest: offset-control
[69.500187] Subtest offset-control: SUCCESS (0.008s)
[69.669657] [011/130] (949s left) perf (blocking)
[69.775247] Starting subtest: blocking
[69.777100] Starting dynamic subtest: 0-rcs0
[79.807798] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[79.814991] Starting dynamic subtest: 1-vcs1
[89.828700] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[89.830908] Subtest blocking: SUCCESS (20.053s)
[89.866724] [012/130] (929s left) gem_create (create-ext-placement-sanity-check)
[90.042491] Starting subtest: create-ext-placement-sanity-check
[90.047949] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[90.152189] [013/130] (929s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[90.260165] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[90.264582] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[90.372178] [014/130] (929s left) gem_exec_params (cliprects_ptr-dirt)
[90.433873] Starting subtest: cliprects_ptr-dirt
[90.436240] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[90.559177] [015/130] (928s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[90.654020] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[90.656506] Starting dynamic subtest: pipe-A
[90.668307] Dynamic subtest pipe-A: SKIP (0.008s)
[90.676828] Starting dynamic subtest: pipe-B
[90.688600] Dynamic subtest pipe-B: SKIP (0.022s)
[90.695610] Starting dynamic subtest: pipe-C
[90.709610] Dynamic subtest pipe-C: SKIP (0.020s)
[90.716336] Starting dynamic subtest: pipe-D
[90.727977] Dynamic subtest pipe-D: SKIP (0.019s)
[90.731730] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.069s)
[90.828208] [016/130] (928s left) kms_atomic_transition (modeset-transition-nonblocking)
[90.926129] Starting subtest: modeset-transition-nonblocking
[90.928515] Starting dynamic subtest: 1x-outputs
[101.488784] Dynamic subtest 1x-outputs: SUCCESS (10.561s)
[101.755807] Subtest modeset-transition-nonblocking: SUCCESS (10.828s)
[102.607625] [017/130] (916s left) i915_selftest (mock)
[104.572074] Starting subtest: mock
[104.574396] Starting dynamic subtest: sanitycheck
[105.157997] Dynamic subtest sanitycheck: SUCCESS (0.586s)
[105.166399] Starting dynamic subtest: shmem
[105.702407] Dynamic subtest shmem: SUCCESS (0.544s)
[105.711043] Starting dynamic subtest: fence
[113.123858] Dynamic subtest fence: SUCCESS (7.420s)
[113.132545] Starting dynamic subtest: scatterlist
[114.734722] Dynamic subtest scatterlist: SUCCESS (1.610s)
[114.742074] Starting dynamic subtest: syncmap
[118.214976] Dynamic subtest syncmap: SUCCESS (3.480s)
[118.222615] Starting dynamic subtest: uncore
[118.812369] Dynamic subtest uncore: SUCCESS (0.597s)
[118.819296] Starting dynamic subtest: ring
[119.354677] Dynamic subtest ring: SUCCESS (0.532s)
[119.365893] Starting dynamic subtest: engine
[119.967343] Dynamic subtest engine: SUCCESS (0.622s)
[119.975943] Starting dynamic subtest: timelines
[123.463367] Dynamic subtest timelines: SUCCESS (3.495s)
[123.473371] Starting dynamic subtest: requests
[126.840241] Dynamic subtest requests: SUCCESS (3.377s)
[126.848485] Starting dynamic subtest: objects
[127.564786] Dynamic subtest objects: SUCCESS (0.725s)
[127.573318] Starting dynamic subtest: phys
[128.244119] Dynamic subtest phys: SUCCESS (0.679s)
[128.250678] Starting dynamic subtest: dmabuf
[128.976961] Dynamic subtest dmabuf: SUCCESS (0.732s)
[128.985052] Starting dynamic subtest: vma
[133.870087] Dynamic subtest vma: SUCCESS (4.893s)
[133.879451] Starting dynamic subtest: evict
[135.052318] Dynamic subtest evict: SUCCESS (1.181s)
[135.060219] Starting dynamic subtest: gtt
[138.133184] Dynamic subtest gtt: SUCCESS (3.080s)
[138.141891] Starting dynamic subtest: hugepages
[138.924375] Dynamic subtest hugepages: SUCCESS (0.790s)
[138.933070] Starting dynamic subtest: memory_region
[142.500874] Dynamic subtest memory_region: SUCCESS (3.576s)
[142.503271] Subtest mock: SUCCESS (37.929s)
[142.522495] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[142.525372] [018/130] (877s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[145.840238] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[146.818292] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.978s)
[147.639845] [FACT kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)] new: kernel.kmod_is_loaded.amdgpu: true
[147.639956] [FACT kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)] new: kernel.kmod_is_loaded.i915: true
[147.641885] [FACT kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)] new: kernel.kmod_is_loaded.xe: true
[147.645377] [019/130] (871s left) kms_hdr (bpc-switch-dpms)
[147.750899] Starting subtest: bpc-switch-dpms
[148.812839] Starting dynamic subtest: pipe-A-eDP-1
[153.312086] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.499s)
[153.314513] Subtest bpc-switch-dpms: SUCCESS (5.560s)
[153.449163] [020/130] (866s left) gem_userptr_blits (dmabuf-unsync)
[153.523343] Subtest dmabuf-unsync: SKIP (0.000s)
[153.661202] [021/130] (865s left) gem_ctx_persistence (many-contexts)
[153.722169] Starting subtest: many-contexts
[191.417903] Subtest many-contexts: SUCCESS (37.693s)
[191.491298] [022/130] (828s left) gem_flink_basic (bad-flink)
[191.552623] Starting subtest: bad-flink
[191.554949] Subtest bad-flink: SUCCESS (0.000s)
[191.640957] [023/130] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[191.748479] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[196.550017] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.803s)
[196.665794] [024/130] (823s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[196.763238] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[197.597967] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.836s)
[197.761385] [025/130] (822s left) gem_exec_schedule (lateslice)
[197.837047] Starting subtest: lateslice
[197.839499] Starting dynamic subtest: rcs0
[197.845939] Dynamic subtest rcs0: SUCCESS (0.018s)
[197.855708] Starting dynamic subtest: bcs0
[197.861469] Dynamic subtest bcs0: SUCCESS (0.015s)
[197.868761] Starting dynamic subtest: vcs0
[197.877919] Dynamic subtest vcs0: SUCCESS (0.016s)
[197.884890] Starting dynamic subtest: vcs1
[197.893459] Dynamic subtest vcs1: SUCCESS (0.015s)
[197.900441] Starting dynamic subtest: vecs0
[197.908718] Dynamic subtest vecs0: SUCCESS (0.015s)
[197.915776] Starting dynamic subtest: ccs0
[197.924376] Dynamic subtest ccs0: SUCCESS (0.016s)
[197.926711] Subtest lateslice: SUCCESS (0.097s)
[200.021403] [026/130] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[200.128238] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[203.595044] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.471s)
[203.736331] [027/130] (816s left) kms_cursor_crc (cursor-sliding-max-size)
[204.002850] Starting subtest: cursor-sliding-max-size
[204.008349] Subtest cursor-sliding-max-size: SKIP (0.000s)
[204.147939] [028/130] (815s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[204.690670] Starting subtest: syncobj-timeline-multiple-ext-nodes
[204.693265] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[205.984131] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[205.987418] [029/130] (813s left) gem_mmap (bad-object)
[206.051334] Subtest bad-object: SKIP (0.000s)
[206.112105] [030/130] (813s left) gem_sync (basic-all)
[206.190520] Starting subtest: basic-all
[209.783466] Subtest basic-all: SUCCESS (3.603s)
[209.961439] [031/130] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[210.055498] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[210.059754] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[210.154358] [032/130] (809s left) gem_reg_read (timestamp-monotonic)
[210.221870] Starting subtest: timestamp-monotonic
[215.056414] Subtest timestamp-monotonic: SUCCESS (4.833s)
[215.124271] [033/130] (804s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[215.229069] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[215.231380] Starting dynamic subtest: pipe-A-eDP-1
[215.254099] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.263976] Starting dynamic subtest: pipe-B-eDP-1
[215.285286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.292656] Starting dynamic subtest: pipe-C-eDP-1
[215.314346] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.321444] Starting dynamic subtest: pipe-D-eDP-1
[215.343203] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.347556] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.002s)
[217.390601] [034/130] (802s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[217.494855] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[217.498786] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.589248] [035/130] (802s left) syncobj_timeline (multi-wait-for-submit-signaled)
[217.648967] Starting subtest: multi-wait-for-submit-signaled
[217.651458] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[217.736254] [036/130] (802s left) kms_plane_scaling (intel-max-src-size)
[217.834629] Starting subtest: intel-max-src-size
[217.841226] Subtest intel-max-src-size: SKIP (0.000s)
[217.913361] [037/130] (802s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[218.013304] Starting subtest: fbcpsr-modesetfrombusy
[222.183917] Subtest fbcpsr-modesetfrombusy: SUCCESS (4.175s)
[222.315238] [038/130] (797s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[222.357034] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[222.389135] [039/130] (797s left) gem_exec_schedule (preempt)
[222.462332] Starting subtest: preempt
[222.464196] Starting dynamic subtest: rcs0
[222.479876] Dynamic subtest rcs0: SUCCESS (0.021s)
[222.489556] Starting dynamic subtest: bcs0
[222.499134] Dynamic subtest bcs0: SUCCESS (0.019s)
[222.509149] Starting dynamic subtest: vcs0
[222.516727] Dynamic subtest vcs0: SUCCESS (0.018s)
[222.524168] Starting dynamic subtest: vcs1
[222.533542] Dynamic subtest vcs1: SUCCESS (0.017s)
[222.540453] Starting dynamic subtest: vecs0
[222.552898] Dynamic subtest vecs0: SUCCESS (0.019s)
[222.559780] Starting dynamic subtest: ccs0
[222.571837] Dynamic subtest ccs0: SUCCESS (0.018s)
[222.573774] Subtest preempt: SUCCESS (0.113s)
[224.013841] [040/130] (796s left) syncobj_timeline (host-signal-points)
[224.067030] Starting subtest: host-signal-points
[224.072077] Subtest host-signal-points: SUCCESS (0.005s)
[224.154352] [041/130] (796s left) gem_sync (basic-store-all)
[224.224975] Starting subtest: basic-store-all
[228.330403] Subtest basic-store-all: SUCCESS (4.116s)
[228.518764] [042/130] (791s left) gem_mmap_gtt (basic-small-bo)
[228.584550] Subtest basic-small-bo: SKIP (0.000s)
[228.635786] [043/130] (791s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[228.744630] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[232.319571] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.579s)
[232.474028] [044/130] (787s left) gem_exec_params (invalid-ring2)
[232.543455] Starting subtest: invalid-ring2
[232.545461] Subtest invalid-ring2: SUCCESS (0.000s)
[232.640984] [045/130] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[232.738500] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[232.742151] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[232.839882] [046/130] (787s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[232.939310] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[237.689470] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.752s)
[237.842917] [047/130] (782s left) gem_spin_batch (engines)
[237.914069] Starting subtest: engines
[237.916401] Starting dynamic subtest: rcs0
[241.153112] Dynamic subtest rcs0: SUCCESS (3.234s)
[241.163318] Starting dynamic subtest: bcs0
[244.386209] Dynamic subtest bcs0: SUCCESS (3.233s)
[244.395895] Starting dynamic subtest: vcs0
[247.621229] Dynamic subtest vcs0: SUCCESS (3.233s)
[247.630329] Starting dynamic subtest: vcs1
[250.858151] Dynamic subtest vcs1: SUCCESS (3.236s)
[250.867800] Starting dynamic subtest: vecs0
[254.093710] Dynamic subtest vecs0: SUCCESS (3.235s)
[254.102717] Starting dynamic subtest: ccs0
[257.326851] Dynamic subtest ccs0: SUCCESS (3.231s)
[257.329572] Subtest engines: SUCCESS (19.408s)
[257.570394] [048/130] (762s left) kms_psr (psr-primary-mmap-cpu)
[257.678254] Starting subtest: psr-primary-mmap-cpu
[257.680624] Starting dynamic subtest: eDP-1
[259.429056] Dynamic subtest eDP-1: SUCCESS (1.749s)
[259.431552] Subtest psr-primary-mmap-cpu: SUCCESS (1.750s)
[260.293619] [049/130] (760s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[260.400485] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[263.932049] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.536s)
[264.072814] [050/130] (756s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[264.189026] Starting subtest: flip-vs-cursor-crc-legacy
[264.796055] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.607s)
[265.644688] [051/130] (754s left) syncobj_timeline (signal-point-0)
[265.713436] Starting subtest: signal-point-0
[265.715887] Subtest signal-point-0: SUCCESS (0.000s)
[265.837042] [052/130] (754s left) vgem_basic (bad-flag)
[265.881247] Starting subtest: bad-flag
[265.883490] Subtest bad-flag: SUCCESS (0.000s)
[265.930265] [053/130] (754s left) kms_cursor_crc (cursor-random-512x512)
[266.171154] Starting subtest: cursor-random-512x512
[266.175685] Subtest cursor-random-512x512: SKIP (0.001s)
[266.311655] [054/130] (754s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[266.368980] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[266.478253] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.109s)
[266.547438] [055/130] (754s left) kms_vblank (wait-busy-hang)
[266.640075] Starting subtest: wait-busy-hang
[266.642338] Starting dynamic subtest: pipe-A-eDP-1
[292.709855] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.066s)
[292.725684] Starting dynamic subtest: pipe-D-eDP-1
[307.681316] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.969s)
[307.683736] Subtest wait-busy-hang: SUCCESS (41.038s)
[308.496968] [056/130] (712s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[308.590306] Starting subtest: fbc-psr-cursor-mmap-gtt
[308.592704] Starting dynamic subtest: eDP-1
[308.597067] Dynamic subtest eDP-1: SKIP (0.000s)
[308.601409] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[308.657923] [057/130] (712s left) kms_fb_coherency (memset-crc)
[308.760322] Starting subtest: memset-crc
[308.762301] Starting dynamic subtest: mmap-offset-wc
[309.133337] Dynamic subtest mmap-offset-wc: SUCCESS (0.375s)
[309.422186] Starting dynamic subtest: mmap-offset-uc
[315.416226] Dynamic subtest mmap-offset-uc: SUCCESS (6.002s)
[315.697243] Subtest memset-crc: SUCCESS (6.938s)
[316.543760] [058/130] (704s left) drm_fdinfo (isolation)
[316.589603] Starting subtest: isolation
[316.591860] Starting dynamic subtest: rcs0
[316.631866] Dynamic subtest rcs0: SKIP (0.038s)
[316.642022] Starting dynamic subtest: bcs0
[316.646246] Dynamic subtest bcs0: SKIP (0.001s)
[316.653565] Starting dynamic subtest: vcs0
[316.657787] Dynamic subtest vcs0: SKIP (0.000s)
[316.665366] Starting dynamic subtest: vcs1
[316.669660] Dynamic subtest vcs1: SKIP (0.000s)
[316.677119] Starting dynamic subtest: vecs0
[316.681333] Dynamic subtest vecs0: SKIP (0.000s)
[316.689195] Starting dynamic subtest: ccs0
[316.693645] Dynamic subtest ccs0: SKIP (0.000s)
[316.698109] Subtest isolation: SKIP (0.043s)
[316.729630] [059/130] (704s left) gem_busy (parallel)
[316.914864] Starting subtest: parallel
[316.917205] Starting dynamic subtest: rcs0
[318.891983] Dynamic subtest rcs0: SUCCESS (1.975s)
[318.902953] Starting dynamic subtest: bcs0
[320.939660] Dynamic subtest bcs0: SUCCESS (2.047s)
[320.949967] Starting dynamic subtest: vcs0
[322.922764] Dynamic subtest vcs0: SUCCESS (1.981s)
[322.933316] Starting dynamic subtest: vcs1
[324.906207] Dynamic subtest vcs1: SUCCESS (1.982s)
[324.916261] Starting dynamic subtest: vecs0
[326.953775] Dynamic subtest vecs0: SUCCESS (2.046s)
[326.963595] Starting dynamic subtest: ccs0
[328.938642] Dynamic subtest ccs0: SUCCESS (1.983s)
[328.942177] Subtest parallel: SUCCESS (12.023s)
[329.192544] [060/130] (691s left) gem_ctx_param (invalid-set-ringsize)
[329.249682] Starting subtest: invalid-set-ringsize
[329.251928] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[329.321064] [061/130] (691s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[329.430419] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[332.390327] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.963s)
[332.518306] [062/130] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[332.631768] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[332.635291] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[332.739346] [063/130] (688s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[332.837060] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[332.839045] Starting dynamic subtest: pipe-A-default-mode
[335.533756] Dynamic subtest pipe-A-default-mode: SUCCESS (2.694s)
[335.536191] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.695s)
[336.357938] [064/130] (684s left) api_intel_bb (full-batch)
[336.411432] Starting subtest: full-batch
[336.416658] Subtest full-batch: SUCCESS (0.005s)
[336.529223] [065/130] (684s left) sw_sync (alloc_timeline)
[336.568193] Starting subtest: alloc_timeline
[336.570386] Subtest alloc_timeline: SUCCESS (0.000s)
[336.612029] [066/130] (684s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[336.713338] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[337.891679] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.180s)
[338.051613] [067/130] (683s left) drm_mm (drm_mm)
[338.089315] Starting subtest: drm_mm
[338.110593] Starting dynamic subtest: drm_test_mm_init
[338.241255] Dynamic subtest drm_test_mm_init: SUCCESS (0.128s)
[338.250558] Starting dynamic subtest: drm_test_mm_debug
[338.385887] Dynamic subtest drm_test_mm_debug: SUCCESS (0.144s)
[338.395716] Starting dynamic subtest: drm_test_mm_align32
[338.524603] Dynamic subtest drm_test_mm_align32: SUCCESS (0.138s)
[338.537398] Starting dynamic subtest: drm_test_mm_align64
[338.638768] Dynamic subtest drm_test_mm_align64: SUCCESS (0.116s)
[338.648257] Starting dynamic subtest: drm_test_mm_lowest
[338.753750] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.112s)
[338.762174] Starting dynamic subtest: drm_test_mm_highest
[338.868790] Dynamic subtest drm_test_mm_highest: SUCCESS (0.114s)
[338.870872] Subtest drm_mm: SUCCESS (0.780s)
[339.029835] [068/130] (682s left) kms_flip (2x-blocking-wf_vblank)
[339.123154] Starting subtest: 2x-blocking-wf_vblank
[339.133856] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[339.258573] [069/130] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[339.361131] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[339.363377] Starting dynamic subtest: pipe-A
[339.372437] Dynamic subtest pipe-A: SKIP (0.004s)
[339.380704] Starting dynamic subtest: pipe-B
[339.389654] Dynamic subtest pipe-B: SKIP (0.018s)
[339.397656] Starting dynamic subtest: pipe-C
[339.410249] Dynamic subtest pipe-C: SKIP (0.019s)
[339.417849] Starting dynamic subtest: pipe-D
[339.426073] Dynamic subtest pipe-D: SKIP (0.016s)
[339.430174] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.059s)
[339.520418] [070/130] (681s left) gem_exec_fence (expired-history)
[339.923288] Starting subtest: expired-history
[346.699941] Subtest expired-history: SUCCESS (6.777s)
[347.292582] [071/130] (674s left) gem_exec_schedule (u-semaphore-resolve)
[347.364239] Starting subtest: u-semaphore-resolve
[347.412059] Subtest u-semaphore-resolve: SUCCESS (0.053s)
[347.768177] [072/130] (673s left) perf_pmu (enable-race)
[347.804694] Starting subtest: enable-race
[347.806788] Starting dynamic subtest: rcs0
[360.595341] Dynamic subtest rcs0: SUCCESS (12.791s)
[360.603864] Starting dynamic subtest: bcs0
[373.347079] Dynamic subtest bcs0: SUCCESS (12.750s)
[373.354637] Starting dynamic subtest: vcs0
[388.904768] Dynamic subtest vcs0: SUCCESS (15.555s)
[388.913745] Starting dynamic subtest: vcs1
[404.905534] Dynamic subtest vcs1: SUCCESS (15.998s)
[404.914735] Starting dynamic subtest: vecs0
[420.905051] Dynamic subtest vecs0: SUCCESS (15.998s)
[420.915761] Starting dynamic subtest: ccs0
[433.732515] Dynamic subtest ccs0: SUCCESS (12.827s)
[433.734989] Subtest enable-race: SUCCESS (85.929s)
[433.833689] [073/130] (587s left) sw_sync (sync_expired_merge)
[433.870081] Starting subtest: sync_expired_merge
[434.945280] Subtest sync_expired_merge: SUCCESS (1.074s)
[435.000278] [074/130] (586s left) kms_flip (2x-modeset-vs-vblank-race)
[435.098205] Starting subtest: 2x-modeset-vs-vblank-race
[435.108579] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[435.209776] [075/130] (586s left) kms_cursor_crc (cursor-offscreen-64x64)
[435.366621] Starting subtest: cursor-offscreen-64x64
[435.371487] Starting dynamic subtest: pipe-A-eDP-1
[437.333963] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.963s)
[437.365521] Starting dynamic subtest: pipe-D-eDP-1
[439.978734] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s)
[439.981082] Subtest cursor-offscreen-64x64: SUCCESS (4.609s)
[440.793600] [076/130] (580s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[440.910136] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[442.111606] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.203s)
[442.378909] [077/130] (579s left) kms_joiner (basic-max-non-joiner)
[442.486258] Starting subtest: basic-max-non-joiner
[442.490665] Subtest basic-max-non-joiner: SKIP (0.000s)
[442.544456] [078/130] (579s left) kms_getfb (getfb-handle-valid)
[442.611550] Starting subtest: getfb-handle-valid
[442.613803] Subtest getfb-handle-valid: SUCCESS (0.000s)
[442.715964] [079/130] (578s left) kms_color (invalid-ctm-matrix-sizes)
[442.821116] Starting subtest: invalid-ctm-matrix-sizes
[442.823368] Starting dynamic subtest: pipe-A
[442.825632] Dynamic subtest pipe-A: SUCCESS (0.002s)
[442.833272] Starting dynamic subtest: pipe-B
[442.835137] Dynamic subtest pipe-B: SUCCESS (0.002s)
[442.842710] Starting dynamic subtest: pipe-C
[442.844991] Dynamic subtest pipe-C: SUCCESS (0.003s)
[442.852625] Starting dynamic subtest: pipe-D
[442.854559] Dynamic subtest pipe-D: SUCCESS (0.005s)
[442.856487] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[442.902244] [080/130] (578s left) gem_wait (await)
[442.965232] Starting subtest: await
[442.967327] Starting dynamic subtest: all-engines
[444.089051] Dynamic subtest all-engines: SUCCESS (1.126s)
[444.108441] Starting dynamic subtest: rcs0
[445.148441] Dynamic subtest rcs0: SUCCESS (1.057s)
[445.163441] Starting dynamic subtest: bcs0
[446.208434] Dynamic subtest bcs0: SUCCESS (1.058s)
[446.223505] Starting dynamic subtest: vcs0
[447.262194] Dynamic subtest vcs0: SUCCESS (1.052s)
[447.275933] Starting dynamic subtest: vcs1
[448.316330] Dynamic subtest vcs1: SUCCESS (1.052s)
[448.330553] Starting dynamic subtest: vecs0
[449.368109] Dynamic subtest vecs0: SUCCESS (1.050s)
[449.380917] Starting dynamic subtest: ccs0
[450.424339] Dynamic subtest ccs0: SUCCESS (1.055s)
[450.426833] Subtest await: SUCCESS (7.462s)
[450.621101] [081/130] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[450.728748] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[450.733271] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[450.823629] [082/130] (570s left) syncobj_timeline (invalid-signal-illegal-point)
[450.880349] Starting subtest: invalid-signal-illegal-point
[450.882203] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[450.973647] [083/130] (570s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[451.028464] Subtest writes-after-reads-snoop: SKIP (0.000s)
[451.088637] [084/130] (570s left) gem_mmap_wc (write-cpu-read-wc)
[451.150413] Subtest write-cpu-read-wc: SKIP (0.000s)
[451.196743] [085/130] (570s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[451.572831] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[452.391883] [086/130] (569s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[452.483930] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[452.488647] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[453.638127] [087/130] (568s left) prime_mmap (test_map_unmap)
[453.690737] Starting subtest: test_map_unmap
[453.693492] Starting dynamic subtest: test_map_unmap-smem
[453.722938] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[453.725376] Subtest test_map_unmap: SUCCESS (0.034s)
[453.825954] [088/130] (568s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[453.942541] Starting subtest: flip-vs-cursor-legacy
[460.738825] Subtest flip-vs-cursor-legacy: SUCCESS (6.793s)
[461.562735] [089/130] (560s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[461.661061] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[461.663151] Starting dynamic subtest: pipe-A-eDP-1
[463.010837] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.347s)
[463.299487] Starting dynamic subtest: pipe-B-eDP-1
[464.342748] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[464.617795] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.953s)
[465.444368] [090/130] (556s left) kms_flip (dpms-off-confusion-interruptible)
[465.553467] Starting subtest: dpms-off-confusion-interruptible
[465.555620] Starting dynamic subtest: A-eDP1
[474.247511] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[474.255893] Starting dynamic subtest: B-eDP1
[482.885607] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[482.894294] Starting dynamic subtest: C-eDP1
[491.506457] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[491.515582] Starting dynamic subtest: D-eDP1
[500.128451] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[500.134497] Subtest dpms-off-confusion-interruptible: SUCCESS (34.579s)
[501.291866] [091/130] (520s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[501.411338] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[501.415498] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[501.526431] [092/130] (520s left) gem_pxp (create-regular-context-2)
[501.656930] Starting subtest: create-regular-context-2
[501.659328] Subtest create-regular-context-2: SUCCESS (0.002s)
[501.762793] [093/130] (520s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[501.852090] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[501.854283] Starting dynamic subtest: pipe-A-default-mode
[502.139696] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[502.144156] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.285s)
[502.926158] [094/130] (519s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[503.027850] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[503.031909] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[503.122171] [095/130] (519s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[503.217088] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[503.219393] Starting dynamic subtest: pipe-A-eDP-1
[503.263269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.045s)
[503.273445] Starting dynamic subtest: pipe-B-eDP-1
[503.308487] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.044s)
[503.317050] Starting dynamic subtest: pipe-C-eDP-1
[503.354415] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.045s)
[503.363228] Starting dynamic subtest: pipe-D-eDP-1
[503.401689] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.046s)
[503.404063] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.184s)
[505.567687] [096/130] (516s left) kms_cursor_legacy (torture-move)
[505.688568] Starting subtest: torture-move
[505.690900] Starting dynamic subtest: pipe-A
[511.401345] Dynamic subtest pipe-A: SUCCESS (5.709s)
[511.411711] Starting dynamic subtest: pipe-B
[517.991878] Dynamic subtest pipe-B: SUCCESS (6.589s)
[518.001731] Starting dynamic subtest: pipe-C
[524.618740] Dynamic subtest pipe-C: SUCCESS (6.626s)
[524.629760] Starting dynamic subtest: pipe-D
[530.742895] Dynamic subtest pipe-D: SUCCESS (6.122s)
[530.753484] Starting dynamic subtest: all-pipes
[538.600385] Dynamic subtest all-pipes: SUCCESS (7.855s)
[538.603042] Subtest torture-move: SUCCESS (32.910s)
[538.739081] [097/130] (483s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[538.842194] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[538.846597] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[538.948844] [098/130] (483s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[539.063775] Starting subtest: psr-rgb565-draw-pwrite
[544.025991] Subtest psr-rgb565-draw-pwrite: SUCCESS (4.964s)
[544.133077] [099/130] (478s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[544.201277] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[544.205822] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[544.379253] [100/130] (477s left) kms_chamelium_frames (dp-frame-dump)
[544.772681] Subtest dp-frame-dump: SKIP (0.000s)
[545.611116] [101/130] (476s left) kms_psr (fbc-pr-suspend)
[545.708268] Starting subtest: fbc-pr-suspend
[545.712473] Subtest fbc-pr-suspend: SKIP (0.000s)
[545.776220] [102/130] (476s left) kms_lease (lease-again)
[545.879157] Starting subtest: lease-again
[545.881447] Starting dynamic subtest: pipe-A-eDP-1
[545.883703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[545.892602] Starting dynamic subtest: pipe-B-eDP-1
[545.894854] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[545.902998] Starting dynamic subtest: pipe-C-eDP-1
[545.905194] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[545.912842] Starting dynamic subtest: pipe-D-eDP-1
[545.914992] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[545.917175] Subtest lease-again: SUCCESS (0.012s)
[545.988113] [103/130] (476s left) syncobj_wait (multi-wait-submitted-signaled)
[546.049836] Starting subtest: multi-wait-submitted-signaled
[546.051847] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[546.129236] [104/130] (476s left) gem_softpin (noreloc-s3)
[546.193554] Starting subtest: noreloc-S3
[566.732727] Subtest noreloc-S3: SUCCESS (5.420s)
[566.862972] [105/130] (470s left) sw_sync (sync_multi_producer_single_consumer)
[566.900535] Starting subtest: sync_multi_producer_single_consumer
[567.977874] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[568.033978] [106/130] (469s left) i915_query (query-garbage)
[568.097794] Starting subtest: query-garbage
[568.100058] Subtest query-garbage: SUCCESS (0.000s)
[568.200600] [107/130] (469s left) kms_prop_blob (blob-multiple)
[568.263711] Starting subtest: blob-multiple
[568.266042] Subtest blob-multiple: SUCCESS (0.002s)
[568.369533] [108/130] (469s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[568.467814] Starting subtest: y-tiled-64bpp-rotate-180
[568.472333] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[568.558614] [109/130] (469s left) gem_exec_whisper (basic-fds-all)
[568.626019] Starting subtest: basic-fds-all
[579.572375] Subtest basic-fds-all: SUCCESS (10.940s)
[579.750337] [110/130] (458s left) gen9_exec_parse (bb-start-out)
[579.808778] Subtest bb-start-out: SKIP (0.000s)
[579.893632] [111/130] (457s left) kms_atomic (atomic-invalid-params)
[579.997499] Starting subtest: atomic-invalid-params
[579.999750] Starting dynamic subtest: pipe-A-eDP-1
[580.412929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[580.415373] Subtest atomic-invalid-params: SUCCESS (0.414s)
[581.194754] [112/130] (456s left) kms_chamelium_color (ctm-negative)
[581.290683] Subtest ctm-negative: SKIP (0.000s)
[581.329523] [113/130] (456s left) kms_getfb (getfb-handle-closed)
[581.387691] Starting subtest: getfb-handle-closed
[581.389886] Subtest getfb-handle-closed: SUCCESS (0.000s)
[581.501952] [114/130] (456s left) kms_pm_dc (dc6-dpms)
[582.605572] Starting subtest: dc6-dpms
[589.587031] Subtest dc6-dpms: FAIL (6.645s)
[589.623362] [115/130] (448s left) kms_psr2_su (page_flip-xrgb8888)
[589.679509] Subtest page_flip-XRGB8888: SKIP (0.000s)
[589.741925] [116/130] (448s left) kms_pipe_crc_basic (read-crc)
[589.835203] Starting subtest: read-crc
[589.837537] Starting dynamic subtest: pipe-A-eDP-1
[590.538216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[590.553056] Starting dynamic subtest: pipe-B-eDP-1
[591.914811] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[591.924851] Starting dynamic subtest: pipe-C-eDP-1
[593.213355] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[593.222636] Starting dynamic subtest: pipe-D-eDP-1
[594.522009] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[594.524055] Subtest read-crc: SUCCESS (4.684s)
[595.374080] [117/130] (442s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[595.470557] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[595.475157] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[596.603707] [118/130] (441s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[601.642550] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[601.647358] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[602.498971] [119/130] (435s left) sriov_basic (bind-unbind-vf)
[602.552519] Starting subtest: bind-unbind-vf
[602.554403] Starting dynamic subtest: vf-1
[602.628458] Dynamic subtest vf-1: FAIL (0.004s)
[602.637571] Starting dynamic subtest: vf-2
[602.710323] Dynamic subtest vf-2: FAIL (0.003s)
[602.720140] Starting dynamic subtest: vf-3
[602.793733] Dynamic subtest vf-3: FAIL (0.003s)
[602.802494] Starting dynamic subtest: vf-4
[602.874621] Dynamic subtest vf-4: FAIL (0.003s)
[602.883595] Starting dynamic subtest: vf-5
[602.956039] Dynamic subtest vf-5: FAIL (0.003s)
[602.966307] Starting dynamic subtest: vf-6
[603.039160] Dynamic subtest vf-6: FAIL (0.003s)
[603.048862] Starting dynamic subtest: vf-7
[603.123872] Dynamic subtest vf-7: FAIL (0.003s)
[603.133931] Starting dynamic subtest: vf-random
[603.208750] Dynamic subtest vf-random: FAIL (0.003s)
[603.218728] Starting dynamic subtest: vf-last
[603.292129] Dynamic subtest vf-last: FAIL (0.507s)
[603.294458] Subtest bind-unbind-vf: FAIL (0.539s)
[603.327608] [120/130] (434s left) gem_exec_reloc (basic-write-read-noreloc)
[603.396459] Subtest basic-write-read-noreloc: SKIP (0.000s)
[603.466548] [121/130] (434s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[608.466940] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[608.471558] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[609.296420] [122/130] (428s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[609.391507] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[609.393786] Starting dynamic subtest: pipe-A-eDP-1
[609.416169] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[609.425115] Starting dynamic subtest: pipe-B-eDP-1
[609.446669] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[609.454600] Starting dynamic subtest: pipe-C-eDP-1
[609.476270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[609.484104] Starting dynamic subtest: pipe-D-eDP-1
[609.506182] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[609.510619] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[611.553967] [123/130] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[611.665957] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[611.670103] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[611.785364] [124/130] (426s left) perf (non-zero-reason)
[611.900139] Starting subtest: non-zero-reason
[611.902275] Starting dynamic subtest: 0-rcs0
[617.348541] Dynamic subtest 0-rcs0: SUCCESS (5.448s)
[617.359409] Starting dynamic subtest: 1-vcs1
[621.287482] Dynamic subtest 1-vcs1: SUCCESS (3.938s)
[621.290360] Subtest non-zero-reason: SUCCESS (9.388s)
[621.330862] [125/130] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[621.437472] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[626.955584] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.520s)
[627.068345] [126/130] (411s left) i915_pm_rps (thresholds-idle)
[627.124989] Starting subtest: thresholds-idle
[627.129763] Subtest thresholds-idle: SKIP (0.000s)
[627.200689] [127/130] (411s left) kms_sequence (queue-busy)
[627.300336] Starting subtest: queue-busy
[627.302532] Starting dynamic subtest: pipe-A-eDP-1
[629.233238] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[629.242642] Starting dynamic subtest: pipe-B-eDP-1
[631.783114] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.548s)
[631.793121] Starting dynamic subtest: pipe-C-eDP-1
[634.396100] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[634.406007] Starting dynamic subtest: pipe-D-eDP-1
[636.921969] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[636.924379] Subtest queue-busy: SUCCESS (9.622s)
[637.704002] [128/130] (400s left) gem_eio (hibernate)
[637.929471] Starting subtest: hibernate
[652.849720] Subtest hibernate: SUCCESS (14.921s)
[652.938560] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         2439 [max: 8192]
 direct dependencies:                 29182 [max: 524288]
 indirect dependencies:              246060
 all direct dependencies:            643782
 dependency chains:                   46158 [max: 524288]
 dependency chain hlocks used:       205876 [max: 2621440]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     432
 in-softirq chains:                     957
 in-process chains:                   44769
 stack-trace entries:                366274 [max: 524288]
 number of stack traces:              16331
 number of stack hash chains:         10328
 combined max dependencies:      1391353596
 hardirq-safe locks:                    139
 hardirq-unsafe locks:                 1400
 softirq-safe locks:                    275
 softirq-unsafe locks:                 1294
 irq-safe locks:                        300
 irq-unsafe locks:                     1400
 hardirq-read-safe locks:                 5
 hardirq-read-unsafe locks:             472
 softirq-read-safe locks:                 9
 softirq-read-unsafe locks:             467
 irq-read-safe locks:                     9
 irq-read-unsafe locks:                 472
 uncategorized locks:                   404
 unused locks:                            1
 max locking depth:                      17
 max bfs queue depth:                   441
 max lock class index:                 2438
 debug_locks:                             0

 zapped classes:                        525
 zapped lock chains:                   7367
 large chain blocks:                      1

[652.950332] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_selftest
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: gem_render_linear_blits
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: gem_create
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_atomic_transition
results: parsing output: 16/ for test: i915_selftest
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_hdr
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: gem_flink_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: gem_mmap
results: parsing output: 29/ for test: gem_sync
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_reg_read
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_sync
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: vgem_basic
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_fb_coherency
results: parsing output: 57/ for test: drm_fdinfo
results: parsing output: 58/ for test: gem_busy
results: parsing output: 59/ for test: gem_ctx_param
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: drm_mm
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_joiner
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: kms_color
results: parsing output: 79/ for test: gem_wait
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_partial_pwrite_pread
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: prime_mmap
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_atomic_transition
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_chamelium_frames
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: kms_prop_blob
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: kms_atomic
results: parsing output: 111/ for test: kms_chamelium_color
results: parsing output: 112/ for test: kms_getfb
results: parsing output: 113/ for test: kms_pm_dc
results: parsing output: 114/ for test: kms_psr2_su
results: parsing output: 115/ for test: kms_pipe_crc_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: sriov_basic
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_pm_rps
results: parsing output: 126/ for test: kms_sequence
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 129/ for test: i915_pm_freq_api
results: no output, setting notrun
Done.