[57.872779] Initializing watchdogs
[57.872826]   /dev/watchdog0
[57.886720] [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.890992] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.893217] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.896829] [001/132] (960s left) gem_exec_params (invalid-bsd2-flag-on-render)
[57.991640] Starting subtest: invalid-bsd2-flag-on-render
[57.994156] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[58.083874] [002/132] (960s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[58.134032] Starting subtest: rel-constants-invalid-rel-gen5
[58.136428] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[58.246981] [003/132] (960s left) kms_chamelium_frames (dp-frame-dump)
[58.628891] Subtest dp-frame-dump: SKIP (0.000s)
[59.460094] [004/132] (959s left) gem_lmem_swapping (basic)
[59.508213] Subtest basic: SKIP (0.000s)
[59.544756] [005/132] (958s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[59.593729] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[59.699727] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[59.770030] [006/132] (958s left) gem_mmap_gtt (hang)
[59.818821] Subtest hang: SKIP (0.000s)
[59.875992] [007/132] (958s left) gem_ringfill (basic-all)
[65.946104] Starting subtest: basic-all
[67.102803] Subtest basic-all: SUCCESS (1.153s)
[67.654658] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[67.658259] [008/132] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[67.859102] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[71.470595] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.616s)
[72.686281] [009/132] (946s left) kms_frontbuffer_tracking (psr-suspend)
[72.802847] Starting subtest: psr-suspend
[111.504222] Subtest psr-suspend: SUCCESS (8.001s)
[111.644753] [010/132] (907s left) kms_psr (fbc-psr2-primary-blt)
[111.758145] Starting subtest: fbc-psr2-primary-blt
[111.760931] Starting dynamic subtest: eDP-1
[111.766587] Dynamic subtest eDP-1: SKIP (0.000s)
[111.771951] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[111.833697] [011/132] (907s left) gem_partial_pwrite_pread (writes-after-reads)
[111.902964] Subtest writes-after-reads: SKIP (0.000s)
[111.974644] [012/132] (906s left) kms_prop_blob (blob-multiple)
[112.029951] Starting subtest: blob-multiple
[112.032904] Subtest blob-multiple: SUCCESS (0.002s)
[112.131145] [013/132] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[112.226958] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[112.232065] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[112.324511] [014/132] (906s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[112.428337] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[113.429592] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.002s)
[113.540692] [015/132] (905s left) kms_lease (atomic-implicit-crtc)
[113.648952] Starting subtest: atomic-implicit-crtc
[113.651472] Starting dynamic subtest: pipe-A-eDP-1
[113.662884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[113.671486] Starting dynamic subtest: pipe-B-eDP-1
[113.682937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[113.691131] Starting dynamic subtest: pipe-C-eDP-1
[113.701927] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[113.709617] Starting dynamic subtest: pipe-D-eDP-1
[113.720759] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[113.722848] Subtest atomic-implicit-crtc: SUCCESS (0.030s)
[113.784923] [016/132] (905s left) kms_psr (psr2-sprite-mmap-cpu)
[113.881969] Starting subtest: psr2-sprite-mmap-cpu
[113.884509] Starting dynamic subtest: eDP-1
[115.602932] Dynamic subtest eDP-1: SUCCESS (1.717s)
[115.605527] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.718s)
[116.471389] [017/132] (902s left) perf_pmu (invalid-open)
[116.521925] Starting subtest: invalid-open
[116.525009] Subtest invalid-open: SUCCESS (0.000s)
[116.621181] [018/132] (902s left) kms_psr (pr-primary-blt)
[116.710006] Starting subtest: pr-primary-blt
[116.714908] Subtest pr-primary-blt: SKIP (0.000s)
[116.780375] [019/132] (902s left) syncobj_wait (multi-wait-for-submit-signaled)
[116.841143] Starting subtest: multi-wait-for-submit-signaled
[116.843947] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[116.938059] [020/132] (902s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[117.029647] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[117.032151] Starting dynamic subtest: pipe-A
[117.051991] Dynamic subtest pipe-A: SKIP (0.016s)
[117.060829] Starting dynamic subtest: pipe-B
[117.084038] Dynamic subtest pipe-B: SKIP (0.032s)
[117.095012] Starting dynamic subtest: pipe-C
[117.114458] Dynamic subtest pipe-C: SKIP (0.032s)
[117.122795] Starting dynamic subtest: pipe-D
[117.148896] Dynamic subtest pipe-D: SKIP (0.032s)
[117.153443] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.114s)
[117.238674] [021/132] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[117.330674] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[117.335879] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[117.422893] [022/132] (901s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[117.526069] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[117.530541] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[117.595619] [023/132] (901s left) kms_dp_link_training (uhbr-sst)
[117.690326] Starting subtest: uhbr-sst
[117.699500] Subtest uhbr-sst: SKIP (0.000s)
[117.761670] [024/132] (901s left) kms_content_protection (type1)
[117.899343] Starting subtest: type1
[117.904633] Subtest type1: SKIP (0.000s)
[118.012784] [025/132] (901s left) gem_exec_whisper (basic-normal)
[118.076884] Starting subtest: basic-normal
[121.764386] Subtest basic-normal: SUCCESS (3.688s)
[121.952986] [026/132] (897s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[122.053424] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[122.058757] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[122.135024] [027/132] (897s left) kms_invalid_mode (bad-vsync-start)
[122.224835] Starting subtest: bad-vsync-start
[122.227688] Starting dynamic subtest: pipe-A-eDP-1
[122.506984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[122.521486] Starting dynamic subtest: pipe-B-eDP-1
[122.524260] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[122.538463] Starting dynamic subtest: pipe-C-eDP-1
[122.540798] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[122.553447] Starting dynamic subtest: pipe-D-eDP-1
[122.556143] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[122.558903] Subtest bad-vsync-start: SUCCESS (0.288s)
[123.303155] [028/132] (896s left) kms_pm_rpm (dpms-non-lpsp)
[124.854889] Starting subtest: dpms-non-lpsp
[124.860909] Subtest dpms-non-lpsp: SKIP (0.001s)
[125.557235] [029/132] (894s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[125.641618] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[125.643855] Starting dynamic subtest: pipe-A-eDP-1
[127.743851] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.104s)
[127.752343] Starting dynamic subtest: pipe-B-eDP-1
[129.882926] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.138s)
[129.891381] Starting dynamic subtest: pipe-C-eDP-1
[131.919532] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.035s)
[131.928506] Starting dynamic subtest: pipe-D-eDP-1
[133.989394] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.069s)
[133.991926] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.350s)
[135.176474] [030/132] (884s left) gem_mmap_offset (mmap-unmap)
[135.242294] Starting subtest: mmap-unmap
[135.244710] Starting dynamic subtest: smem0
[157.761297] Dynamic subtest smem0: SUCCESS (22.522s)
[157.764113] Subtest mmap-unmap: SUCCESS (22.523s)
[157.903639] [031/132] (861s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[159.758915] Starting subtest: gem-execbuf-stress-pc8
[159.799347] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[160.221513] [032/132] (859s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[160.325039] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[167.670154] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.352s)
[167.794586] [033/132] (851s left) kms_cursor_edge_walk (64x64-top-edge)
[167.896993] Starting subtest: 64x64-top-edge
[167.899894] Starting dynamic subtest: pipe-A-eDP-1
[171.380639] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[171.390144] Starting dynamic subtest: pipe-D-eDP-1
[174.512510] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[174.515044] Subtest 64x64-top-edge: SUCCESS (6.619s)
[175.313760] [034/132] (844s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[175.412814] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[182.739153] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.331s)
[182.854737] [035/132] (836s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[182.989836] Starting subtest: cursorA-vs-flipB-toggle
[182.995032] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[183.141269] [036/132] (836s left) gem_busy (close-race)
[183.201807] Starting subtest: close-race
[208.645028] Subtest close-race: SUCCESS (25.442s)
[208.987344] [037/132] (810s left) kms_plane_multiple (tiling-x)
[209.138873] Starting subtest: tiling-x
[209.141073] Starting dynamic subtest: pipe-A-eDP-1
[212.963848] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.827s)
[212.974402] Starting dynamic subtest: pipe-B-eDP-1
[217.388928] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.421s)
[217.398702] Starting dynamic subtest: pipe-C-eDP-1
[221.696912] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.305s)
[221.707001] Starting dynamic subtest: pipe-D-eDP-1
[226.053341] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.358s)
[226.055531] Subtest tiling-x: SUCCESS (16.917s)
[226.866970] [038/132] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[226.978713] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[226.983988] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[227.078071] [039/132] (792s left) gem_exec_reloc (basic-write-cpu-noreloc)
[227.142363] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[227.209018] [040/132] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[227.307414] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[227.312412] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[227.407735] [041/132] (792s left) gem_exec_schedule (semaphore-noskip)
[227.499796] Starting subtest: semaphore-noskip
[227.933164] Subtest semaphore-noskip: SUCCESS (0.441s)
[228.274544] [042/132] (791s left) prime_mmap (test_dup)
[228.335544] Starting subtest: test_dup
[228.337562] Starting dynamic subtest: test_dup-smem
[228.366055] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[228.368876] Subtest test_dup: SUCCESS (0.033s)
[228.439631] [043/132] (791s left) gem_lmem_swapping (verify)
[228.487066] Subtest verify: SKIP (0.000s)
[228.531386] [044/132] (791s left) syncobj_wait (single-wait-submitted)
[228.593049] Starting subtest: single-wait-submitted
[228.697134] Subtest single-wait-submitted: SUCCESS (0.104s)
[228.772021] [045/132] (791s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[228.856902] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[228.861667] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[228.932474] [046/132] (791s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[229.024273] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[233.387112] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.365s)
[234.583713] [047/132] (785s left) prime_mmap (test_forked)
[234.638693] Starting subtest: test_forked
[234.640691] Starting dynamic subtest: test_forked-smem
[234.673811] Dynamic subtest test_forked-smem: SUCCESS (0.037s)
[234.676486] Subtest test_forked: SUCCESS (0.039s)
[234.772559] [048/132] (785s left) gem_fence_thrash (bo-write-verify-y)
[234.811925] Starting subtest: bo-write-verify-y
[234.832698] Subtest bo-write-verify-y: SKIP (0.020s)
[234.893467] [049/132] (785s left) i915_selftest (live)
[238.185735] Starting subtest: live
[238.188829] Starting dynamic subtest: sanitycheck
[243.347275] Dynamic subtest sanitycheck: SUCCESS (5.165s)
[243.357241] Starting dynamic subtest: uncore
[246.834458] Dynamic subtest uncore: SUCCESS (3.486s)
[246.844426] Starting dynamic subtest: workarounds
[250.726929] Dynamic subtest workarounds: SUCCESS (3.891s)
[250.736853] Starting dynamic subtest: gt_engines
[254.566137] Dynamic subtest gt_engines: SUCCESS (3.837s)
[254.577435] Starting dynamic subtest: gt_timelines
[270.867522] Dynamic subtest gt_timelines: SUCCESS (16.300s)
[270.878764] Starting dynamic subtest: gt_contexts
[274.467511] Dynamic subtest gt_contexts: SUCCESS (3.599s)
[274.478016] Starting dynamic subtest: gt_lrc
[281.367605] Dynamic subtest gt_lrc: SUCCESS (6.898s)
[281.378992] Starting dynamic subtest: gt_mocs
[285.143032] Dynamic subtest gt_mocs: SUCCESS (3.774s)
[285.153593] Starting dynamic subtest: gt_pm
[290.679454] Dynamic subtest gt_pm: SUCCESS (5.535s)
[290.695028] Starting dynamic subtest: gt_heartbeat
[294.177830] Dynamic subtest gt_heartbeat: SUCCESS (3.496s)
[294.188014] Starting dynamic subtest: gt_tlb
[304.352100] Dynamic subtest gt_tlb: SUCCESS (10.172s)
[304.362269] Starting dynamic subtest: requests
[316.742820] Dynamic subtest requests: SUCCESS (12.389s)
[316.751708] Starting dynamic subtest: migrate
[323.328113] Dynamic subtest migrate: SUCCESS (6.584s)
[323.338423] Starting dynamic subtest: active
[328.472291] Dynamic subtest active: SUCCESS (5.143s)
[328.481822] Starting dynamic subtest: objects
[332.514531] Dynamic subtest objects: SUCCESS (4.042s)
[332.524692] Starting dynamic subtest: mman
[336.672499] Dynamic subtest mman: SUCCESS (4.155s)
[336.682977] Starting dynamic subtest: dmabuf
[340.262592] Dynamic subtest dmabuf: SUCCESS (3.588s)
[340.274826] Starting dynamic subtest: vma
[343.774909] Dynamic subtest vma: SUCCESS (3.510s)
[343.785262] Starting dynamic subtest: coherency
[348.496151] Dynamic subtest coherency: SUCCESS (4.720s)
[348.506572] Starting dynamic subtest: gtt
[359.002724] Dynamic subtest gtt: SUCCESS (10.504s)
[359.012790] Starting dynamic subtest: gem
[365.270937] Dynamic subtest gem: SUCCESS (6.267s)
[365.281491] Starting dynamic subtest: evict
[370.108112] Dynamic subtest evict: SUCCESS (4.836s)
[370.117709] Starting dynamic subtest: hugepages
[379.636368] Dynamic subtest hugepages: SUCCESS (9.528s)
[379.646525] Starting dynamic subtest: gem_contexts
[407.228116] Dynamic subtest gem_contexts: SUCCESS (27.591s)
[407.237857] Starting dynamic subtest: client
[410.805709] Dynamic subtest client: SUCCESS (3.577s)
[410.815992] Starting dynamic subtest: gem_migrate
[415.895071] Dynamic subtest gem_migrate: SUCCESS (5.089s)
[415.904703] Starting dynamic subtest: reset
[419.443464] Dynamic subtest reset: SUCCESS (3.547s)
[419.452282] Starting dynamic subtest: memory_region
[422.967670] Dynamic subtest memory_region: SUCCESS (3.521s)
[422.983529] Starting dynamic subtest: hangcheck
[436.612460] Dynamic subtest hangcheck: SUCCESS (13.643s)
[436.621639] Starting dynamic subtest: execlists
[440.146654] Dynamic subtest execlists: SUCCESS (3.533s)
[440.163197] Starting dynamic subtest: ring_submission
[443.674543] Dynamic subtest ring_submission: SUCCESS (3.525s)
[443.684933] Starting dynamic subtest: perf
[447.310591] Dynamic subtest perf: SUCCESS (3.635s)
[447.326901] Starting dynamic subtest: slpc
[460.168413] Dynamic subtest slpc: SUCCESS (12.855s)
[460.178397] Starting dynamic subtest: guc
[464.832145] Dynamic subtest guc: SUCCESS (4.661s)
[464.842712] Starting dynamic subtest: guc_multi_lrc
[468.364446] Dynamic subtest guc_multi_lrc: SUCCESS (3.531s)
[468.374967] Starting dynamic subtest: guc_hang
[474.152398] Dynamic subtest guc_hang: SUCCESS (5.787s)
[474.162683] Starting dynamic subtest: late_gt_pm
[479.244423] Dynamic subtest late_gt_pm: SUCCESS (5.091s)
[479.247438] Subtest live: SUCCESS (241.068s)
[479.276860] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[479.277700] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[479.281393] [050/132] (541s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[481.747814] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[481.753187] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[481.851676] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[481.852837] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)] new: kernel.kmod_is_loaded.i915: true
[481.856729] [051/132] (538s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[481.919984] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[481.922981] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[482.019128] [052/132] (538s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[482.080266] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[482.082977] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[482.166394] [053/132] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[482.257878] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[482.262906] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[482.363977] [054/132] (538s left) kms_vrr (flip-basic)
[482.455129] Starting subtest: flip-basic
[482.462602] Subtest flip-basic: SKIP (0.000s)
[482.525283] [055/132] (538s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[482.620717] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[489.699176] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.082s)
[489.841529] [056/132] (530s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[489.940233] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[489.942970] Starting dynamic subtest: pipe-A-eDP-1
[492.233386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.294s)
[492.241931] Starting dynamic subtest: pipe-B-eDP-1
[494.416624] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.182s)
[494.425155] Starting dynamic subtest: pipe-C-eDP-1
[496.515009] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.097s)
[496.524895] Starting dynamic subtest: pipe-D-eDP-1
[498.500405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.982s)
[498.503010] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.561s)
[499.664157] [057/132] (521s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[499.756618] Starting subtest: pixel-format-linear-modifier-source-clamping
[499.783169] Starting dynamic subtest: pipe-A-plane-0
[503.484505] Dynamic subtest pipe-A-plane-0: SUCCESS (3.700s)
[503.495163] Starting dynamic subtest: pipe-A-plane-3
[505.271705] Dynamic subtest pipe-A-plane-3: SUCCESS (1.788s)
[506.348657] Starting dynamic subtest: pipe-B-plane-0
[509.996721] Dynamic subtest pipe-B-plane-0: SUCCESS (3.655s)
[510.005430] Starting dynamic subtest: pipe-B-plane-3
[511.763784] Dynamic subtest pipe-B-plane-3: SUCCESS (1.766s)
[512.084267] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.329s)
[512.929142] [058/132] (507s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[513.019845] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[513.030160] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[513.107155] [059/132] (507s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[513.204907] Starting subtest: y-tiled-16bpp-rotate-180
[513.210273] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[513.312516] [060/132] (507s left) kms_flip (basic-flip-vs-dpms)
[513.396908] Starting subtest: basic-flip-vs-dpms
[513.399321] Starting dynamic subtest: A-eDP1
[515.931012] Dynamic subtest A-eDP1: SUCCESS (2.531s)
[515.940010] Starting dynamic subtest: B-eDP1
[518.091954] Dynamic subtest B-eDP1: SUCCESS (2.159s)
[518.102303] Starting dynamic subtest: C-eDP1
[520.168606] Dynamic subtest C-eDP1: SUCCESS (2.075s)
[520.178153] Starting dynamic subtest: D-eDP1
[522.249922] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[522.252356] Subtest basic-flip-vs-dpms: SUCCESS (8.856s)
[523.051470] [061/132] (497s left) kms_pm_rpm (pm-caching)
[524.786623] Starting subtest: pm-caching
[524.791799] Subtest pm-caching: SKIP (0.000s)
[525.292882] [062/132] (495s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[525.379783] Starting subtest: compare-crc-sanitycheck-nv12
[525.381857] Starting dynamic subtest: pipe-A-eDP-1
[526.025273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s)
[526.036829] Starting dynamic subtest: pipe-B-eDP-1
[527.240077] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[527.251195] Starting dynamic subtest: pipe-C-eDP-1
[528.429627] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.188s)
[528.440541] Starting dynamic subtest: pipe-D-eDP-1
[529.657455] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[529.659998] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.277s)
[530.512481] [063/132] (490s left) kms_color (deep-color)
[530.603647] Starting subtest: deep-color
[531.687885] Starting dynamic subtest: pipe-A-eDP-1-gamma
[532.401935] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.716s)
[532.416474] Starting dynamic subtest: pipe-A-eDP-1-degamma
[533.899578] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.494s)
[533.908616] Starting dynamic subtest: pipe-A-eDP-1-ctm
[535.315041] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.417s)
[536.077986] Starting dynamic subtest: pipe-B-eDP-1-gamma
[536.785693] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.715s)
[536.795135] Starting dynamic subtest: pipe-B-eDP-1-degamma
[538.254253] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.466s)
[538.268812] Starting dynamic subtest: pipe-B-eDP-1-ctm
[539.712406] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.454s)
[540.476169] Starting dynamic subtest: pipe-C-eDP-1-gamma
[541.190062] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.719s)
[541.199565] Starting dynamic subtest: pipe-C-eDP-1-degamma
[542.642498] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.453s)
[542.652966] Starting dynamic subtest: pipe-C-eDP-1-ctm
[544.061315] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.419s)
[544.865302] Starting dynamic subtest: pipe-D-eDP-1-gamma
[545.553026] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.695s)
[545.564819] Starting dynamic subtest: pipe-D-eDP-1-degamma
[546.923900] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.367s)
[546.932654] Starting dynamic subtest: pipe-D-eDP-1-ctm
[548.367936] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.446s)
[548.370745] Subtest deep-color: SUCCESS (17.768s)
[549.211515] [064/132] (471s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[549.331930] Starting subtest: x-tiled-8bpp-rotate-0
[550.559072] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.230s)
[550.702908] [065/132] (470s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[550.801278] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[550.803786] Starting dynamic subtest: pipe-A-eDP-1
[556.689928] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.893s)
[556.700931] Starting dynamic subtest: pipe-B-eDP-1
[563.352776] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.663s)
[563.355368] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.559s)
[564.231046] [066/132] (456s left) gem_mmap (basic)
[564.296770] Subtest basic: SKIP (0.000s)
[564.352999] [067/132] (456s left) gen9_exec_parse (bb-secure)
[564.415042] Subtest bb-secure: SKIP (0.000s)
[564.465502] [068/132] (456s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[564.564637] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[564.570003] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[564.666662] [069/132] (456s left) i915_drm_fdinfo (virtual-busy-idle)
[564.709772] Starting subtest: virtual-busy-idle
[564.714943] Subtest virtual-busy-idle: SKIP (0.000s)
[564.774855] [070/132] (456s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[564.871907] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[564.876626] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[565.962540] [071/132] (455s left) drm_read (empty-block)
[566.104349] Starting subtest: empty-block
[567.104964] Subtest empty-block: SUCCESS (1.000s)
[567.256066] [072/132] (454s left) perf_pmu (busy-accuracy-98)
[567.293460] Starting subtest: busy-accuracy-98
[567.295993] Starting dynamic subtest: rcs0
[570.334005] Dynamic subtest rcs0: SUCCESS (3.037s)
[570.344007] Starting dynamic subtest: bcs0
[573.386127] Dynamic subtest bcs0: SUCCESS (3.049s)
[573.396539] Starting dynamic subtest: vcs0
[576.432673] Dynamic subtest vcs0: SUCCESS (3.045s)
[576.442722] Starting dynamic subtest: vcs1
[579.480631] Dynamic subtest vcs1: SUCCESS (3.045s)
[579.491014] Starting dynamic subtest: vecs0
[582.520838] Dynamic subtest vecs0: SUCCESS (3.039s)
[582.530974] Starting dynamic subtest: ccs0
[585.573484] Dynamic subtest ccs0: SUCCESS (3.051s)
[585.576357] Subtest busy-accuracy-98: SUCCESS (18.279s)
[585.689315] [073/132] (435s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[585.796024] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[585.800981] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[585.891505] [074/132] (435s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[586.129617] Starting subtest: cursor-rapid-movement-256x256
[586.135120] Starting dynamic subtest: pipe-A-eDP-1
[586.672158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[586.717648] Starting dynamic subtest: pipe-D-eDP-1
[587.901984] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.189s)
[587.904482] Subtest cursor-rapid-movement-256x256: SUCCESS (1.770s)
[588.728897] [075/132] (432s left) gem_ccs (block-copy-uncompressed)
[588.782764] Starting subtest: block-copy-uncompressed
[588.784938] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[588.802929] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[588.813707] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[588.819981] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[588.829148] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[588.836782] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[588.845919] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[588.854357] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[588.856571] Subtest block-copy-uncompressed: SUCCESS (0.073s)
[588.965959] [076/132] (432s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[589.056172] Starting subtest: fbcpsr-shrfb-scaledprimary
[594.829282] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.776s)
[594.952006] [077/132] (426s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[595.331857] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[596.172527] [078/132] (425s left) prime_vgem (fence-write-hang)
[596.244827] Subtest fence-write-hang: SKIP (0.000s)
[596.356655] [079/132] (425s left) kms_cursor_crc (cursor-offscreen-256x256)
[596.575178] Starting subtest: cursor-offscreen-256x256
[596.577791] Starting dynamic subtest: pipe-A-eDP-1
[598.525076] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[598.554867] Starting dynamic subtest: pipe-D-eDP-1
[601.123921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[601.126292] Subtest cursor-offscreen-256x256: SUCCESS (4.547s)
[601.965477] [080/132] (419s left) kms_async_flips (invalid-async-flip-atomic)
[602.075957] Starting subtest: invalid-async-flip-atomic
[602.456648] Starting dynamic subtest: pipe-A-eDP-1
[603.290945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[603.648870] Starting dynamic subtest: pipe-B-eDP-1
[604.425317] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[604.784271] Starting dynamic subtest: pipe-C-eDP-1
[605.543022] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[605.899889] Starting dynamic subtest: pipe-D-eDP-1
[606.669058] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[606.671883] Subtest invalid-async-flip-atomic: SUCCESS (4.595s)
[607.847195] [081/132] (413s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[607.966075] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[608.012438] [082/132] (413s left) kms_async_flips (async-flip-hang)
[608.102678] Starting subtest: async-flip-hang
[608.486769] Starting dynamic subtest: pipe-A-eDP-1
[624.165169] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.676s)
[624.553894] Starting dynamic subtest: pipe-B-eDP-1
[640.096864] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.547s)
[640.471563] Starting dynamic subtest: pipe-C-eDP-1
[656.092153] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.627s)
[656.467360] Starting dynamic subtest: pipe-D-eDP-1
[672.093000] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.631s)
[672.096042] Subtest async-flip-hang: SUCCESS (63.993s)
[673.279263] [083/132] (348s left) gem_exec_reloc (basic-cpu-active)
[673.339866] Subtest basic-cpu-active: SKIP (0.000s)
[673.397535] [084/132] (348s left) kms_force_connector_basic (prune-stale-modes)
[673.476830] Starting subtest: prune-stale-modes
[673.917941] Subtest prune-stale-modes: SUCCESS (0.444s)
[674.059577] [085/132] (347s left) gem_exec_suspend (basic)
[674.123267] Starting subtest: basic
[674.125578] Starting dynamic subtest: smem
[675.653161] Dynamic subtest smem: SUCCESS (1.528s)
[675.656121] Subtest basic: SUCCESS (1.530s)
[675.838912] [086/132] (346s left) gem_ctx_persistence (legacy-engines-persistence)
[675.912619] Starting subtest: legacy-engines-persistence
[675.915308] Starting dynamic subtest: render
[676.746393] Dynamic subtest render: SUCCESS (0.833s)
[676.758399] Starting dynamic subtest: bsd1
[677.513490] Dynamic subtest bsd1: SUCCESS (0.764s)
[677.525687] Starting dynamic subtest: bsd2
[678.277560] Dynamic subtest bsd2: SUCCESS (0.761s)
[678.289934] Starting dynamic subtest: blt
[679.027031] Dynamic subtest blt: SUCCESS (0.746s)
[679.038183] Starting dynamic subtest: vebox
[679.803753] Dynamic subtest vebox: SUCCESS (0.775s)
[679.806500] Subtest legacy-engines-persistence: SUCCESS (3.892s)
[679.884308] [087/132] (342s left) gem_exec_reloc (basic-concurrent0)
[679.954980] Subtest basic-concurrent0: SKIP (0.000s)
[680.026209] [088/132] (342s left) kms_psr (psr-sprite-plane-onoff)
[680.131835] Starting subtest: psr-sprite-plane-onoff
[680.134381] Starting dynamic subtest: eDP-1
[681.917782] Dynamic subtest eDP-1: SUCCESS (1.784s)
[681.920119] Subtest psr-sprite-plane-onoff: SUCCESS (1.785s)
[682.714530] [089/132] (339s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[682.801969] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[682.807044] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[682.913582] [090/132] (339s left) syncobj_timeline (invalid-query-bad-pad)
[682.978070] Starting subtest: invalid-query-bad-pad
[682.981134] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[683.078482] [091/132] (339s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[683.177848] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[683.183051] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[683.269285] [092/132] (339s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[683.364876] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[684.487194] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.123s)
[684.597350] [093/132] (337s left) gem_exec_balancer (smoke)
[684.649857] Starting subtest: smoke
[707.212149] Subtest smoke: SUCCESS (22.563s)
[708.101195] [094/132] (314s left) gem_pread (self)
[708.159620] Subtest self: SKIP (0.000s)
[708.257192] [095/132] (314s left) kms_flip (2x-flip-vs-panning-vs-hang)
[708.346465] Starting subtest: 2x-flip-vs-panning-vs-hang
[708.354001] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s)
[708.435782] [096/132] (314s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[708.525276] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[708.530356] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[708.597038] [097/132] (313s left) drm_mm (drm_mm)
[708.638875] Starting subtest: drm_mm
[708.702840] Starting dynamic subtest: drm_test_mm_init
[708.788812] Dynamic subtest drm_test_mm_init: SUCCESS (0.086s)
[708.800725] Starting dynamic subtest: drm_test_mm_debug
[708.872531] Dynamic subtest drm_test_mm_debug: SUCCESS (0.082s)
[708.883346] Starting dynamic subtest: drm_test_mm_align32
[708.961697] Dynamic subtest drm_test_mm_align32: SUCCESS (0.086s)
[708.971377] Starting dynamic subtest: drm_test_mm_align64
[709.046514] Dynamic subtest drm_test_mm_align64: SUCCESS (0.086s)
[709.056310] Starting dynamic subtest: drm_test_mm_lowest
[709.127757] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.082s)
[709.137981] Starting dynamic subtest: drm_test_mm_highest
[709.231340] Dynamic subtest drm_test_mm_highest: SUCCESS (0.102s)
[709.233731] Subtest drm_mm: SUCCESS (0.596s)
[709.374868] [098/132] (313s left) gem_mmap_wc (set-cache-level)
[709.428939] Subtest set-cache-level: SKIP (0.000s)
[709.490678] [099/132] (313s left) i915_drm_fdinfo (busy-idle-check-all)
[709.535021] Starting subtest: busy-idle-check-all
[709.537762] Starting dynamic subtest: rcs0
[709.542835] Dynamic subtest rcs0: SKIP (0.004s)
[709.557115] Starting dynamic subtest: bcs0
[709.560762] Dynamic subtest bcs0: SKIP (0.000s)
[709.569914] Starting dynamic subtest: vcs0
[709.573815] Dynamic subtest vcs0: SKIP (0.000s)
[709.582790] Starting dynamic subtest: vcs1
[709.586686] Dynamic subtest vcs1: SKIP (0.000s)
[709.595760] Starting dynamic subtest: vecs0
[709.599666] Dynamic subtest vecs0: SKIP (0.000s)
[709.611925] Starting dynamic subtest: ccs0
[709.616401] Dynamic subtest ccs0: SKIP (0.000s)
[709.620862] Subtest busy-idle-check-all: SKIP (0.009s)
[709.658895] [100/132] (313s left) gem_create (hog-create)
[709.737935] Starting subtest: hog-create
[709.740556] Starting dynamic subtest: smem0
[743.619459] Dynamic subtest smem0: SUCCESS (33.880s)
[743.622480] Subtest hog-create: SUCCESS (33.882s)
[743.808049] [101/132] (278s left) api_intel_bb (full-batch)
[743.867120] Starting subtest: full-batch
[743.874994] Subtest full-batch: SUCCESS (0.010s)
[743.966880] [102/132] (278s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[744.062202] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[744.067939] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[744.136940] [103/132] (278s left) kms_cursor_legacy (forked-bo)
[744.252528] Starting subtest: forked-bo
[744.255136] Starting dynamic subtest: pipe-A
[749.708318] Dynamic subtest pipe-A: SUCCESS (5.454s)
[749.722125] Starting dynamic subtest: pipe-B
[755.181846] Dynamic subtest pipe-B: SUCCESS (5.471s)
[755.192164] Starting dynamic subtest: pipe-C
[760.656718] Dynamic subtest pipe-C: SUCCESS (5.473s)
[760.672248] Starting dynamic subtest: pipe-D
[766.125497] Dynamic subtest pipe-D: SUCCESS (5.467s)
[766.136491] Starting dynamic subtest: all-pipes
[771.627110] Dynamic subtest all-pipes: SUCCESS (5.500s)
[771.629788] Subtest forked-bo: SUCCESS (27.374s)
[771.769411] [104/132] (251s left) prime_mmap (test_correct)
[771.850046] Starting subtest: test_correct
[771.852848] Starting dynamic subtest: test_correct-smem
[771.909842] Dynamic subtest test_correct-smem: SUCCESS (0.061s)
[771.912668] Subtest test_correct: SUCCESS (0.063s)
[772.025703] [105/132] (250s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[772.130980] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[772.135863] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[772.226638] [106/132] (250s left) gem_exec_balancer (full-late-pulse)
[772.288279] Starting subtest: full-late-pulse
[777.442322] Subtest full-late-pulse: SUCCESS (5.154s)
[777.773561] [107/132] (245s left) kms_cdclk (plane-scaling)
[777.882142] Starting subtest: plane-scaling
[777.885079] Starting dynamic subtest: pipe-A-eDP-1
[778.167129] Dynamic subtest pipe-A-eDP-1: SKIP (0.284s)
[778.178271] Starting dynamic subtest: pipe-B-eDP-1
[778.183872] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[778.193428] Starting dynamic subtest: pipe-C-eDP-1
[778.198866] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[778.207923] Starting dynamic subtest: pipe-D-eDP-1
[778.212915] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[778.218079] Subtest plane-scaling: SKIP (0.291s)
[778.981146] [108/132] (244s left) gem_userptr_blits (input-checking)
[779.045774] Starting subtest: input-checking
[779.048396] Subtest input-checking: SUCCESS (0.000s)
[779.181427] [109/132] (243s left) gem_spin_batch (spin-each)
[779.245811] Starting subtest: spin-each
[782.518510] Subtest spin-each: SUCCESS (3.265s)
[782.754582] [110/132] (240s left) sw_sync (sync_multi_consumer)
[782.794564] Starting subtest: sync_multi_consumer
[783.354343] Subtest sync_multi_consumer: SUCCESS (0.561s)
[783.426109] [111/132] (239s left) gem_exec_reloc (basic-wc-gtt-active)
[783.489134] Subtest basic-wc-gtt-active: SKIP (0.000s)
[783.567860] [112/132] (239s left) gem_userptr_blits (nohangcheck)
[783.638137] Starting subtest: nohangcheck
[783.996117] Subtest nohangcheck: SUCCESS (0.357s)
[784.106698] [113/132] (239s left) kms_plane (plane-position-hole)
[784.196089] Starting subtest: plane-position-hole
[784.690966] Starting dynamic subtest: pipe-A-plane-1
[785.958650] Dynamic subtest pipe-A-plane-1: SUCCESS (1.270s)
[785.969343] Starting dynamic subtest: pipe-A-plane-2
[787.217773] Dynamic subtest pipe-A-plane-2: SUCCESS (1.255s)
[787.228435] Starting dynamic subtest: pipe-A-plane-3
[788.524431] Dynamic subtest pipe-A-plane-3: SUCCESS (1.308s)
[788.536126] Starting dynamic subtest: pipe-A-plane-4
[789.817809] Dynamic subtest pipe-A-plane-4: SUCCESS (1.290s)
[789.828481] Starting dynamic subtest: pipe-A-plane-5
[789.842929] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[791.055360] Starting dynamic subtest: pipe-B-plane-1
[792.331823] Dynamic subtest pipe-B-plane-1: SUCCESS (1.282s)
[792.342168] Starting dynamic subtest: pipe-B-plane-2
[793.655902] Dynamic subtest pipe-B-plane-2: SUCCESS (1.326s)
[793.667534] Starting dynamic subtest: pipe-B-plane-3
[794.919677] Dynamic subtest pipe-B-plane-3: SUCCESS (1.262s)
[794.931912] Starting dynamic subtest: pipe-B-plane-4
[796.269668] Dynamic subtest pipe-B-plane-4: SUCCESS (1.348s)
[796.279986] Starting dynamic subtest: pipe-B-plane-5
[796.296371] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[796.299006] Subtest plane-position-hole: SUCCESS (12.100s)
[797.090020] [114/132] (226s left) sw_sync (sync_expired_merge)
[797.125678] Starting subtest: sync_expired_merge
[798.199387] Subtest sync_expired_merge: SUCCESS (1.074s)
[798.263757] [115/132] (225s left) gem_ctx_persistence (engines-mixed-process)
[798.320857] Starting subtest: engines-mixed-process
[798.323594] Starting dynamic subtest: rcs0
[799.618555] Dynamic subtest rcs0: SUCCESS (1.297s)
[799.630130] Starting dynamic subtest: bcs0
[801.588587] Dynamic subtest bcs0: SUCCESS (1.968s)
[801.598838] Starting dynamic subtest: vcs0
[803.575130] Dynamic subtest vcs0: SUCCESS (1.985s)
[803.585441] Starting dynamic subtest: vcs1
[805.588426] Dynamic subtest vcs1: SUCCESS (2.015s)
[805.601173] Starting dynamic subtest: vecs0
[807.628146] Dynamic subtest vecs0: SUCCESS (2.038s)
[807.639753] Starting dynamic subtest: ccs0
[809.599098] Dynamic subtest ccs0: SUCCESS (1.970s)
[809.601651] Subtest engines-mixed-process: SUCCESS (11.279s)
[809.678788] [116/132] (213s left) kms_addfb_basic (bad-pitch-999)
[809.730361] Starting subtest: bad-pitch-999
[809.732932] Subtest bad-pitch-999: SUCCESS (0.000s)
[809.872341] [117/132] (213s left) gem_exec_fence (submit3)
[810.051015] Starting subtest: submit3
[810.056984] Subtest submit3: SKIP (0.000s)
[811.656498] [118/132] (211s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[811.709305] Starting subtest: single-wait-for-submit-available-signaled
[811.711703] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[811.797557] [119/132] (211s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[811.855986] Starting subtest: etime-single-wait-all-for-submit-submitted
[811.961166] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[812.042800] [120/132] (211s left) gem_exec_schedule (noreorder)
[812.225154] Starting subtest: noreorder
[812.227736] Starting dynamic subtest: rcs0
[812.282561] Dynamic subtest rcs0: SUCCESS (0.061s)
[812.295124] Starting dynamic subtest: vcs0
[813.643045] Dynamic subtest vcs0: SUCCESS (1.357s)
[813.654139] Starting dynamic subtest: vcs1
[815.594743] Dynamic subtest vcs1: SUCCESS (1.949s)
[815.607130] Starting dynamic subtest: vecs0
[817.602200] Dynamic subtest vecs0: SUCCESS (2.004s)
[817.614393] Starting dynamic subtest: ccs0
[817.673914] Dynamic subtest ccs0: SUCCESS (0.071s)
[817.676786] Subtest noreorder: SUCCESS (5.455s)
[817.878127] [121/132] (205s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[817.974964] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[824.889834] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.919s)
[824.991911] [122/132] (198s left) gem_eio (wait-wedge-immediate)
[825.207455] Starting subtest: wait-wedge-immediate
[826.695951] Subtest wait-wedge-immediate: SUCCESS (1.487s)
[826.838545] [123/132] (196s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[826.894431] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[826.985237] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.030s)
[827.029540] [124/132] (196s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[827.126541] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[827.806136] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s)
[827.968639] [125/132] (195s left) sysfs_heartbeat_interval (nopreempt)
[828.031913] Starting subtest: nopreempt
[828.034597] Starting dynamic subtest: vecs0
[837.634770] Dynamic subtest vecs0: SUCCESS (9.602s)
[837.651792] Starting dynamic subtest: ccs0
[841.665150] Dynamic subtest ccs0: SUCCESS (4.031s)
[841.678362] Starting dynamic subtest: vcs0
[851.585683] Dynamic subtest vcs0: SUCCESS (9.917s)
[851.598113] Starting dynamic subtest: bcs0
[855.478149] Dynamic subtest bcs0: SUCCESS (3.892s)
[855.490902] Starting dynamic subtest: rcs0
[859.542328] Dynamic subtest rcs0: SUCCESS (4.063s)
[859.555578] Starting dynamic subtest: vcs1
[869.636066] Dynamic subtest vcs1: SUCCESS (10.091s)
[869.639314] Subtest nopreempt: SUCCESS (41.607s)
[869.718099] [126/132] (154s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[869.814729] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[869.817441] Starting dynamic subtest: pipe-A-eDP-1
[869.841945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[869.855148] Starting dynamic subtest: pipe-B-eDP-1
[869.877938] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[869.891058] Starting dynamic subtest: pipe-C-eDP-1
[869.913859] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[869.923925] Starting dynamic subtest: pipe-D-eDP-1
[869.946439] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[869.949063] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[872.074627] [127/132] (151s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[872.188649] Starting subtest: flip-vs-cursor-busy-crc-atomic
[872.991938] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.802s)
[873.876265] [128/132] (150s left) kms_psr (fbc-psr-cursor-plane-onoff)
[873.969331] Starting subtest: fbc-psr-cursor-plane-onoff
[873.972156] Starting dynamic subtest: eDP-1
[873.978161] Dynamic subtest eDP-1: SKIP (0.000s)
[873.983970] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[874.047696] [129/132] (149s left) gem_pxp (protected-raw-src-copy-not-readible)
[874.170852] Starting subtest: protected-raw-src-copy-not-readible
[874.228610] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[874.350371] [130/132] (149s left) perf (missing-sample-flags)
[874.495739] Starting subtest: missing-sample-flags
[874.497861] Subtest missing-sample-flags: SUCCESS (0.000s)
[874.559190] [131/132] (149s left) syncobj_wait (wait-all-delayed-signal)
[874.618621] Starting subtest: wait-all-delayed-signal
[874.718907] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[874.814599] [132/132] (149s left) template (b)
[874.881993] Starting subtest: B
[874.884135] Subtest B: SUCCESS (0.000s)
[874.989016] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_chamelium_frames
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_ringfill
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_prop_blob
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_dp_link_training
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_pm_rpm
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_mmap_offset
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: gem_busy
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: prime_mmap
results: parsing output: 47/ for test: gem_fence_thrash
results: parsing output: 48/ for test: i915_selftest
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_vrr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: gem_mmap
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: drm_read
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: prime_vgem
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_tiled_display
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_force_connector_basic
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: gem_pread
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: drm_mm
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: gem_create
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: prime_mmap
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_cdclk
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: gem_spin_batch
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: sw_sync
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: sriov_basic
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: sysfs_heartbeat_interval
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: template
Done.