[45.827561] Initializing watchdogs
[45.827624]   /dev/watchdog0
[45.843192] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[45.849776] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.852431] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.854662] [001/132] (960s left) gem_exec_params (invalid-bsd2-flag-on-render)
[45.897534] Starting subtest: invalid-bsd2-flag-on-render
[45.898237] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[45.984395] [002/132] (960s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[46.020255] Starting subtest: rel-constants-invalid-rel-gen5
[46.021035] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[46.114507] [003/132] (960s left) kms_chamelium_frames (dp-frame-dump)
[46.255787] Subtest dp-frame-dump: SKIP (0.000s)
[46.354608] [004/132] (960s left) gem_lmem_swapping (basic)
[46.393967] Subtest basic: SKIP (0.000s)
[46.427550] [005/132] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[46.461499] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[46.570526] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[46.636855] [006/132] (959s left) gem_mmap_gtt (hang)
[46.669685] Starting subtest: hang
[51.958807] Subtest hang: SUCCESS (5.439s)
[52.049585] [007/132] (954s left) gem_ringfill (basic-all)
[52.273395] Starting subtest: basic-all
[53.375758] Subtest basic-all: SUCCESS (1.119s)
[53.477880] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[53.479352] [008/132] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[53.571784] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[54.735326] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.188s)
[54.851985] [009/132] (951s left) kms_frontbuffer_tracking (psr-suspend)
[54.941392] Starting subtest: psr-suspend
[54.942737] Subtest psr-suspend: SKIP (0.000s)
[55.032900] [010/132] (951s left) kms_psr (fbc-psr2-primary-blt)
[55.115940] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[55.158077] [011/132] (951s left) gem_partial_pwrite_pread (writes-after-reads)
[55.194150] Starting subtest: writes-after-reads
[67.094895] Subtest writes-after-reads: SUCCESS (12.000s)
[67.582663] [012/132] (939s left) kms_prop_blob (blob-multiple)
[67.967242] Starting subtest: blob-multiple
[67.967989] Subtest blob-multiple: SUCCESS (0.001s)
[68.029742] [013/132] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[68.129374] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[68.130741] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[68.220624] [014/132] (938s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[68.316720] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[68.318077] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[68.413147] [015/132] (938s left) kms_lease (atomic-implicit-crtc)
[68.497485] Starting subtest: atomic-implicit-crtc
[68.498177] Starting dynamic subtest: pipe-A-HDMI-A-1
[68.501448] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[68.507428] Starting dynamic subtest: pipe-B-HDMI-A-1
[68.510963] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s)
[68.519109] Starting dynamic subtest: pipe-C-HDMI-A-1
[68.522656] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.011s)
[68.530770] Starting dynamic subtest: pipe-D-HDMI-A-1
[68.534176] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.011s)
[68.534859] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[68.609730] [016/132] (938s left) kms_psr (psr2-sprite-mmap-cpu)
[68.695251] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[68.738101] [017/132] (938s left) perf_pmu (invalid-open)
[68.774057] Starting subtest: invalid-open
[68.774778] Subtest invalid-open: SUCCESS (0.000s)
[68.854671] [018/132] (938s left) kms_psr (pr-primary-blt)
[68.941502] Subtest pr-primary-blt: SKIP (0.000s)
[68.979898] [019/132] (938s left) syncobj_wait (multi-wait-for-submit-signaled)
[69.014435] Starting subtest: multi-wait-for-submit-signaled
[69.015176] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[69.084811] [020/132] (938s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[69.168567] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[69.169274] Starting dynamic subtest: pipe-A
[69.300424] Dynamic subtest pipe-A: SUCCESS (0.132s)
[69.306502] Starting dynamic subtest: pipe-B
[69.450647] Dynamic subtest pipe-B: SUCCESS (0.150s)
[69.456708] Starting dynamic subtest: pipe-C
[69.601386] Dynamic subtest pipe-C: SUCCESS (0.151s)
[69.611452] Starting dynamic subtest: pipe-D
[69.734801] Dynamic subtest pipe-D: SUCCESS (0.133s)
[69.735490] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.568s)
[69.897881] [021/132] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[69.989722] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[69.991103] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[70.097130] [022/132] (937s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[70.181887] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[70.224420] [023/132] (937s left) kms_dp_link_training (uhbr-sst)
[70.308527] Starting subtest: uhbr-sst
[70.309873] Subtest uhbr-sst: SKIP (0.000s)
[70.360844] [024/132] (936s left) kms_content_protection (type1)
[70.451375] Starting subtest: type1
[70.455526] Subtest type1: SKIP (0.003s)
[70.546505] [025/132] (936s left) gem_exec_whisper (basic-normal)
[70.589580] Starting subtest: basic-normal
[71.948203] Subtest basic-normal: SUCCESS (1.361s)
[72.132846] [026/132] (935s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[72.228414] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[72.824089] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.596s)
[72.941774] [027/132] (934s left) kms_invalid_mode (bad-vsync-start)
[73.028586] Starting subtest: bad-vsync-start
[73.029356] Starting dynamic subtest: pipe-A-HDMI-A-1
[73.081358] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.052s)
[73.088244] Starting dynamic subtest: pipe-B-HDMI-A-1
[73.088961] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[73.095387] Starting dynamic subtest: pipe-C-HDMI-A-1
[73.096087] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[73.103099] Starting dynamic subtest: pipe-D-HDMI-A-1
[73.103802] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[73.104484] Subtest bad-vsync-start: SUCCESS (0.059s)
[73.210092] [028/132] (934s left) kms_pm_rpm (dpms-non-lpsp)
[74.607875] Starting subtest: dpms-non-lpsp
[74.609767] Subtest dpms-non-lpsp: SKIP (0.001s)
[74.779978] [029/132] (932s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[74.865892] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[74.866660] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.873548] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[74.882175] Starting dynamic subtest: pipe-B-HDMI-A-1
[74.889127] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[74.897525] Starting dynamic subtest: pipe-C-HDMI-A-1
[74.904358] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[74.912430] Starting dynamic subtest: pipe-D-HDMI-A-1
[74.919554] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[74.920969] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[75.131848] [030/132] (932s left) gem_mmap_offset (mmap-unmap)
[75.164983] Starting subtest: mmap-unmap
[75.165726] Starting dynamic subtest: smem0
[107.376412] Dynamic subtest smem0: SUCCESS (32.203s)
[107.377211] Subtest mmap-unmap: SUCCESS (32.204s)
[107.448824] [031/132] (900s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[108.843484] Starting subtest: gem-execbuf-stress-pc8
[108.920947] Subtest gem-execbuf-stress-pc8: SKIP (0.068s)
[109.038393] [032/132] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[109.129558] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[109.130958] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[109.239084] [033/132] (898s left) kms_cursor_edge_walk (64x64-top-edge)
[109.322622] Starting subtest: 64x64-top-edge
[109.324127] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.052529] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.729s)
[111.060074] Starting dynamic subtest: pipe-D-HDMI-A-1
[112.702011] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.648s)
[112.702729] Subtest 64x64-top-edge: SUCCESS (3.380s)
[112.813273] [034/132] (894s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[112.904540] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[112.905925] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[113.008025] [035/132] (894s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[113.094082] Starting subtest: cursorA-vs-flipB-toggle
[113.096522] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[113.153729] [036/132] (894s left) gem_busy (close-race)
[113.194998] Starting subtest: close-race
[135.254736] Subtest close-race: SUCCESS (22.058s)
[135.613436] [037/132] (872s left) kms_plane_multiple (tiling-x)
[135.754721] Starting subtest: tiling-x
[135.756284] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.382416] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.627s)
[136.390785] Starting dynamic subtest: pipe-B-HDMI-A-1
[136.957105] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.572s)
[136.965894] Starting dynamic subtest: pipe-C-HDMI-A-1
[137.520198] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.561s)
[137.531109] Starting dynamic subtest: pipe-D-HDMI-A-1
[138.112685] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.590s)
[138.113507] Subtest tiling-x: SUCCESS (2.358s)
[138.261703] [038/132] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[138.357774] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[138.359184] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[138.453235] [039/132] (869s left) gem_exec_reloc (basic-write-cpu-noreloc)
[138.492112] Starting subtest: basic-write-cpu-noreloc
[138.494696] Subtest basic-write-cpu-noreloc: SUCCESS (0.003s)
[138.607750] [040/132] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[138.697935] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[138.699395] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[138.794388] [041/132] (869s left) gem_exec_schedule (semaphore-noskip)
[138.846900] Starting subtest: semaphore-noskip
[139.169857] Subtest semaphore-noskip: SUCCESS (0.315s)
[139.462300] [042/132] (868s left) prime_mmap (test_dup)
[139.496146] Starting subtest: test_dup
[139.496846] Starting dynamic subtest: test_dup-smem
[139.497522] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[139.498283] Subtest test_dup: SUCCESS (0.002s)
[139.592843] [043/132] (868s left) gem_lmem_swapping (verify)
[139.629813] Subtest verify: SKIP (0.000s)
[139.671127] [044/132] (868s left) syncobj_wait (single-wait-submitted)
[139.705304] Starting subtest: single-wait-submitted
[139.808760] Subtest single-wait-submitted: SUCCESS (0.103s)
[139.881497] [045/132] (868s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[139.968940] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[139.969755] Starting dynamic subtest: pipe-A-valid-mode
[140.833156] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.863s)
[140.833893] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.865s)
[140.979023] [046/132] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[141.074233] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[142.373168] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.299s)
[142.486110] [047/132] (865s left) prime_mmap (test_forked)
[142.520471] Starting subtest: test_forked
[142.521184] Starting dynamic subtest: test_forked-smem
[142.530377] Dynamic subtest test_forked-smem: SUCCESS (0.011s)
[142.531247] Subtest test_forked: SUCCESS (0.012s)
[142.614105] [048/132] (865s left) gem_fence_thrash (bo-write-verify-y)
[142.646934] Starting subtest: bo-write-verify-y
[143.790635] Subtest bo-write-verify-y: SUCCESS (1.136s)
[143.854371] [049/132] (864s left) i915_selftest (live)
[144.734867] Starting subtest: live
[144.736114] Starting dynamic subtest: sanitycheck
[145.960682] Dynamic subtest sanitycheck: SUCCESS (1.217s)
[145.967371] Starting dynamic subtest: uncore
[147.136661] Dynamic subtest uncore: SUCCESS (1.174s)
[147.146860] Starting dynamic subtest: workarounds
[148.639641] Dynamic subtest workarounds: SUCCESS (1.501s)
[148.650285] Starting dynamic subtest: gt_engines
[150.424809] Dynamic subtest gt_engines: SUCCESS (1.783s)
[150.431360] Starting dynamic subtest: gt_timelines
[159.001530] Dynamic subtest gt_timelines: SUCCESS (8.575s)
[159.011929] Starting dynamic subtest: gt_contexts
[160.291671] Dynamic subtest gt_contexts: SUCCESS (1.288s)
[160.298702] Starting dynamic subtest: gt_lrc
[164.445654] Dynamic subtest gt_lrc: SUCCESS (4.152s)
[164.460551] Starting dynamic subtest: gt_mocs
[165.775665] Dynamic subtest gt_mocs: SUCCESS (1.328s)
[165.786750] Starting dynamic subtest: gt_pm
[187.176625] Dynamic subtest gt_pm: SUCCESS (21.399s)
[187.183075] Starting dynamic subtest: gt_heartbeat
[188.417510] Dynamic subtest gt_heartbeat: SUCCESS (1.239s)
[188.424509] Starting dynamic subtest: gt_tlb
[191.843795] Dynamic subtest gt_tlb: SUCCESS (3.424s)
[191.850451] Starting dynamic subtest: requests
[200.452799] Dynamic subtest requests: SUCCESS (8.607s)
[200.463032] Starting dynamic subtest: migrate
[204.743707] Dynamic subtest migrate: SUCCESS (4.288s)
[204.754101] Starting dynamic subtest: active
[205.916592] Dynamic subtest active: SUCCESS (1.171s)
[205.923065] Starting dynamic subtest: objects
[207.594497] Dynamic subtest objects: SUCCESS (1.676s)
[207.604977] Starting dynamic subtest: mman
[212.250636] Dynamic subtest mman: SUCCESS (4.654s)
[212.261062] Starting dynamic subtest: dmabuf
[213.483549] Dynamic subtest dmabuf: SUCCESS (1.231s)
[213.493950] Starting dynamic subtest: vma
[214.700509] Dynamic subtest vma: SUCCESS (1.215s)
[214.707188] Starting dynamic subtest: coherency
[217.594643] Dynamic subtest coherency: SUCCESS (2.892s)
[217.601656] Starting dynamic subtest: gtt
[225.872647] Dynamic subtest gtt: SUCCESS (8.276s)
[225.879428] Starting dynamic subtest: gem
[228.011783] Dynamic subtest gem: SUCCESS (2.137s)
[228.018421] Starting dynamic subtest: evict
[230.191632] Dynamic subtest evict: SUCCESS (2.178s)
[230.198290] Starting dynamic subtest: hugepages
[237.863433] Dynamic subtest hugepages: SUCCESS (7.669s)
[237.869866] Starting dynamic subtest: gem_contexts
[253.314518] Dynamic subtest gem_contexts: SUCCESS (15.449s)
[253.321252] Starting dynamic subtest: client
[254.550734] Dynamic subtest client: SUCCESS (1.234s)
[254.557011] Starting dynamic subtest: gem_migrate
[255.754627] Dynamic subtest gem_migrate: SUCCESS (1.202s)
[255.761625] Starting dynamic subtest: reset
[260.701655] Dynamic subtest reset: SUCCESS (4.945s)
[260.708248] Starting dynamic subtest: memory_region
[261.890685] Dynamic subtest memory_region: SUCCESS (1.187s)
[261.897372] Starting dynamic subtest: hangcheck
[291.785470] Dynamic subtest hangcheck: SUCCESS (29.893s)
[291.792060] Starting dynamic subtest: execlists
[305.602718] Dynamic subtest execlists: SUCCESS (13.815s)
[305.609359] Starting dynamic subtest: ring_submission
[306.852682] Dynamic subtest ring_submission: SUCCESS (1.248s)
[306.859225] Starting dynamic subtest: perf
[308.170588] Dynamic subtest perf: SUCCESS (1.316s)
[308.181037] Starting dynamic subtest: slpc
[309.365725] Dynamic subtest slpc: SUCCESS (1.193s)
[309.378295] Starting dynamic subtest: guc
[310.538558] Dynamic subtest guc: SUCCESS (1.170s)
[310.545227] Starting dynamic subtest: guc_multi_lrc
[311.717576] Dynamic subtest guc_multi_lrc: SUCCESS (1.177s)
[311.723817] Starting dynamic subtest: guc_hang
[312.884626] Dynamic subtest guc_hang: SUCCESS (1.165s)
[312.891578] Starting dynamic subtest: late_gt_pm
[314.142701] Dynamic subtest late_gt_pm: SUCCESS (1.256s)
[314.143694] Subtest live: SUCCESS (169.400s)
[314.171793] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[314.172577] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[314.176798] [050/132] (694s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[315.262280] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[315.263719] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[315.354305] [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
[315.355938] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)] new: kernel.kmod_is_loaded.i915: true
[315.358233] [051/132] (692s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[315.394022] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[315.394756] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[315.450082] [052/132] (692s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[315.485261] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[315.485997] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[315.556012] [053/132] (692s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[315.646808] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[315.648224] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[315.753562] [054/132] (692s left) kms_vrr (flip-basic)
[315.841482] Starting subtest: flip-basic
[315.843738] Subtest flip-basic: SKIP (0.000s)
[315.901381] [055/132] (692s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[315.992417] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[315.993907] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[316.079138] [056/132] (692s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[316.169059] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[316.169904] Starting dynamic subtest: pipe-A-HDMI-A-1
[316.177050] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[316.183914] Starting dynamic subtest: pipe-B-HDMI-A-1
[316.191123] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[316.197731] Starting dynamic subtest: pipe-C-HDMI-A-1
[316.204893] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[316.211416] Starting dynamic subtest: pipe-D-HDMI-A-1
[316.218837] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[316.220203] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[316.400749] [057/132] (692s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[316.489398] Starting subtest: pixel-format-linear-modifier-source-clamping
[316.508556] Starting dynamic subtest: pipe-A-plane-0
[319.008714] Dynamic subtest pipe-A-plane-0: SUCCESS (2.500s)
[319.024966] Starting dynamic subtest: pipe-A-plane-3
[321.234385] Dynamic subtest pipe-A-plane-3: SUCCESS (2.223s)
[321.250773] Starting dynamic subtest: pipe-A-plane-5
[322.442693] Dynamic subtest pipe-A-plane-5: SUCCESS (1.206s)
[322.592219] Starting dynamic subtest: pipe-B-plane-0
[325.061621] Dynamic subtest pipe-B-plane-0: SUCCESS (2.475s)
[325.076290] Starting dynamic subtest: pipe-B-plane-3
[327.295377] Dynamic subtest pipe-B-plane-3: SUCCESS (2.231s)
[327.309924] Starting dynamic subtest: pipe-B-plane-5
[328.487242] Dynamic subtest pipe-B-plane-5: SUCCESS (1.189s)
[328.561346] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.071s)
[328.685480] [058/132] (679s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[328.780156] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[328.789873] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.009s)
[328.851625] [059/132] (679s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[328.950299] Starting subtest: y-tiled-16bpp-rotate-180
[330.067375] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.117s)
[330.196495] [060/132] (678s left) kms_flip (basic-flip-vs-dpms)
[330.285546] Starting subtest: basic-flip-vs-dpms
[330.287876] Starting dynamic subtest: A-HDMI-A1
[330.987347] Dynamic subtest A-HDMI-A1: SUCCESS (0.699s)
[330.997861] Starting dynamic subtest: B-HDMI-A1
[331.682169] Dynamic subtest B-HDMI-A1: SUCCESS (0.692s)
[331.691342] Starting dynamic subtest: C-HDMI-A1
[332.307774] Dynamic subtest C-HDMI-A1: SUCCESS (0.625s)
[332.316039] Starting dynamic subtest: D-HDMI-A1
[333.015267] Dynamic subtest D-HDMI-A1: SUCCESS (0.706s)
[333.017072] Subtest basic-flip-vs-dpms: SUCCESS (2.731s)
[333.167372] [061/132] (675s left) kms_pm_rpm (pm-caching)
[344.614086] Starting subtest: pm-caching
[350.835701] Subtest pm-caching: SUCCESS (6.205s)
[350.966932] [062/132] (657s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[351.056108] Starting subtest: compare-crc-sanitycheck-nv12
[351.057922] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.403861] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.346s)
[351.412048] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.725479] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.320s)
[351.733996] Starting dynamic subtest: pipe-C-HDMI-A-1
[352.049738] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.322s)
[352.057916] Starting dynamic subtest: pipe-D-HDMI-A-1
[352.370056] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.319s)
[352.370843] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.315s)
[352.505485] [063/132] (656s left) kms_color (deep-color)
[352.596049] Starting subtest: deep-color
[352.603178] Subtest deep-color: SKIP (0.003s)
[352.661607] [064/132] (656s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[352.757005] Starting subtest: x-tiled-8bpp-rotate-0
[353.758300] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.001s)
[353.870134] [065/132] (655s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[353.960357] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[354.006303] [066/132] (654s left) gem_mmap (basic)
[354.040269] Starting subtest: basic
[354.043684] Subtest basic: SUCCESS (0.000s)
[354.139794] [067/132] (654s left) gen9_exec_parse (bb-secure)
[354.178841] Subtest bb-secure: SKIP (0.000s)
[354.222959] [068/132] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[354.312781] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[354.314158] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[354.407276] [069/132] (654s left) i915_drm_fdinfo (virtual-busy-idle)
[354.444319] Starting subtest: virtual-busy-idle
[357.617761] Subtest virtual-busy-idle: SUCCESS (3.173s)
[357.686814] [070/132] (651s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[357.776017] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[357.777431] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[357.926886] [071/132] (651s left) drm_read (empty-block)
[358.047724] Starting subtest: empty-block
[359.056803] Subtest empty-block: SUCCESS (1.000s)
[359.160732] [072/132] (649s left) perf_pmu (busy-accuracy-98)
[359.197006] Starting subtest: busy-accuracy-98
[359.197802] Starting dynamic subtest: rcs0
[362.224649] Dynamic subtest rcs0: SUCCESS (3.023s)
[362.233683] Starting dynamic subtest: bcs0
[365.251923] Dynamic subtest bcs0: SUCCESS (3.027s)
[365.260478] Starting dynamic subtest: vcs0
[368.278354] Dynamic subtest vcs0: SUCCESS (3.026s)
[368.287049] Starting dynamic subtest: vcs1
[371.304725] Dynamic subtest vcs1: SUCCESS (3.024s)
[371.313132] Starting dynamic subtest: vecs0
[374.331925] Dynamic subtest vecs0: SUCCESS (3.026s)
[374.332930] Subtest busy-accuracy-98: SUCCESS (15.131s)
[374.401257] [073/132] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[374.495111] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[374.496580] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[374.587311] [074/132] (634s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[374.679449] Starting subtest: cursor-rapid-movement-256x256
[374.684013] Starting dynamic subtest: pipe-A-HDMI-A-1
[374.934845] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.250s)
[374.967501] Starting dynamic subtest: pipe-D-HDMI-A-1
[375.180593] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.220s)
[375.181298] Subtest cursor-rapid-movement-256x256: SUCCESS (0.502s)
[375.329879] [075/132] (633s left) gem_ccs (block-copy-uncompressed)
[375.369043] Starting subtest: block-copy-uncompressed
[375.370960] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[375.389465] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[375.397776] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[375.407197] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[375.407919] Subtest block-copy-uncompressed: SUCCESS (0.039s)
[375.514526] [076/132] (633s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[375.605818] Starting subtest: fbcpsr-shrfb-scaledprimary
[375.607263] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[375.706346] [077/132] (633s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[375.844399] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[375.930709] [078/132] (633s left) prime_vgem (fence-write-hang)
[376.004246] Subtest fence-write-hang: SKIP (0.000s)
[376.093738] [079/132] (633s left) kms_cursor_crc (cursor-offscreen-256x256)
[376.183298] Starting subtest: cursor-offscreen-256x256
[376.188061] Starting dynamic subtest: pipe-A-HDMI-A-1
[377.448632] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.260s)
[377.481545] Starting dynamic subtest: pipe-D-HDMI-A-1
[378.696839] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.221s)
[378.697559] Subtest cursor-offscreen-256x256: SUCCESS (2.513s)
[378.824388] [080/132] (630s left) kms_async_flips (invalid-async-flip-atomic)
[378.916076] Starting subtest: invalid-async-flip-atomic
[379.029015] Starting dynamic subtest: pipe-A-HDMI-A-1
[379.157367] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.128s)
[379.275092] Starting dynamic subtest: pipe-B-HDMI-A-1
[379.365236] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.097s)
[379.479674] Starting dynamic subtest: pipe-C-HDMI-A-1
[379.572622] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.101s)
[379.690995] Starting dynamic subtest: pipe-D-HDMI-A-1
[379.772944] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.090s)
[379.773738] Subtest invalid-async-flip-atomic: SUCCESS (0.858s)
[379.985662] [081/132] (629s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[380.111447] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[380.157601] [082/132] (629s left) kms_async_flips (async-flip-hang)
[380.245043] Starting subtest: async-flip-hang
[380.374438] Starting dynamic subtest: pipe-A-HDMI-A-1
[395.902135] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (15.493s)
[395.997748] Starting dynamic subtest: pipe-B-HDMI-A-1
[410.748769] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.722s)
[410.847620] Starting dynamic subtest: pipe-C-HDMI-A-1
[425.597173] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.723s)
[425.688455] Starting dynamic subtest: pipe-D-HDMI-A-1
[440.444665] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.729s)
[440.445483] Subtest async-flip-hang: SUCCESS (60.167s)
[440.649940] [083/132] (568s left) gem_exec_reloc (basic-cpu-active)
[440.690411] Starting subtest: basic-cpu-active
[440.821271] Subtest basic-cpu-active: SUCCESS (0.122s)
[440.937068] [084/132] (568s left) kms_force_connector_basic (prune-stale-modes)
[441.063455] Starting subtest: prune-stale-modes
[441.217977] Subtest prune-stale-modes: SUCCESS (0.155s)
[441.380528] [085/132] (568s left) gem_exec_suspend (basic)
[441.423119] Starting subtest: basic
[441.423921] Starting dynamic subtest: smem
[441.881951] Dynamic subtest smem: SUCCESS (0.458s)
[441.882744] Subtest basic: SUCCESS (0.460s)
[442.058356] [086/132] (567s left) gem_ctx_persistence (legacy-engines-persistence)
[442.097589] Starting subtest: legacy-engines-persistence
[442.098328] Starting dynamic subtest: render
[442.876680] Dynamic subtest render: SUCCESS (0.778s)
[442.887731] Starting dynamic subtest: bsd1
[443.642693] Dynamic subtest bsd1: SUCCESS (0.763s)
[443.653694] Starting dynamic subtest: bsd2
[444.411609] Dynamic subtest bsd2: SUCCESS (0.766s)
[444.422228] Starting dynamic subtest: blt
[445.180687] Dynamic subtest blt: SUCCESS (0.766s)
[445.191720] Starting dynamic subtest: vebox
[445.940533] Dynamic subtest vebox: SUCCESS (0.757s)
[445.941714] Subtest legacy-engines-persistence: SUCCESS (3.844s)
[446.010816] [087/132] (563s left) gem_exec_reloc (basic-concurrent0)
[446.049958] Starting subtest: basic-concurrent0
[451.483830] Subtest basic-concurrent0: SUCCESS (5.398s)
[451.563856] [088/132] (558s left) kms_psr (psr-sprite-plane-onoff)
[451.651716] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[451.693893] [089/132] (558s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[451.783758] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[454.262494] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.478s)
[454.372440] [090/132] (555s left) syncobj_timeline (invalid-query-bad-pad)
[454.408201] Starting subtest: invalid-query-bad-pad
[454.408989] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[454.465756] [091/132] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[454.563078] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[454.564570] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[454.655478] [092/132] (555s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[454.751844] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[455.429338] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.677s)
[455.548914] [093/132] (554s left) gem_exec_balancer (smoke)
[455.591850] Starting subtest: smoke
[478.702285] Subtest smoke: SUCCESS (23.077s)
[479.224596] [094/132] (530s left) gem_pread (self)
[479.260669] Starting subtest: self
[479.267233] Subtest self: SUCCESS (0.007s)
[479.370717] [095/132] (530s left) kms_flip (2x-flip-vs-panning-vs-hang)
[479.457550] Starting subtest: 2x-flip-vs-panning-vs-hang
[479.467100] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.009s)
[479.552730] [096/132] (530s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[479.638088] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[479.639521] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[479.694471] [097/132] (530s left) drm_mm (drm_mm)
[479.728233] Starting subtest: drm_mm
[479.737073] Starting dynamic subtest: drm_test_mm_init
[479.801997] Dynamic subtest drm_test_mm_init: SUCCESS (0.064s)
[479.817640] Starting dynamic subtest: drm_test_mm_debug
[479.873397] Dynamic subtest drm_test_mm_debug: SUCCESS (0.068s)
[479.892433] Starting dynamic subtest: drm_test_mm_align32
[479.950463] Dynamic subtest drm_test_mm_align32: SUCCESS (0.074s)
[479.968859] Starting dynamic subtest: drm_test_mm_align64
[480.025251] Dynamic subtest drm_test_mm_align64: SUCCESS (0.072s)
[480.044608] Starting dynamic subtest: drm_test_mm_lowest
[480.102237] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.073s)
[480.121428] Starting dynamic subtest: drm_test_mm_highest
[480.179185] Dynamic subtest drm_test_mm_highest: SUCCESS (0.074s)
[480.180465] Subtest drm_mm: SUCCESS (0.451s)
[480.316553] [098/132] (529s left) gem_mmap_wc (set-cache-level)
[480.351234] Starting subtest: set-cache-level
[480.351992] Subtest set-cache-level: SUCCESS (0.001s)
[480.446455] [099/132] (529s left) i915_drm_fdinfo (busy-idle-check-all)
[480.482285] Starting subtest: busy-idle-check-all
[480.483042] Starting dynamic subtest: rcs0
[481.106314] Dynamic subtest rcs0: SUCCESS (0.623s)
[481.117939] Starting dynamic subtest: bcs0
[481.728960] Dynamic subtest bcs0: SUCCESS (0.619s)
[481.740020] Starting dynamic subtest: vcs0
[482.355292] Dynamic subtest vcs0: SUCCESS (0.625s)
[482.366824] Starting dynamic subtest: vcs1
[482.977568] Dynamic subtest vcs1: SUCCESS (0.620s)
[482.990747] Starting dynamic subtest: vecs0
[483.603136] Dynamic subtest vecs0: SUCCESS (0.621s)
[483.604368] Subtest busy-idle-check-all: SUCCESS (3.121s)
[483.683340] [100/132] (526s left) gem_create (hog-create)
[483.721094] Starting subtest: hog-create
[483.721972] Starting dynamic subtest: smem0
[515.971678] Dynamic subtest smem0: SUCCESS (32.249s)
[515.972873] Subtest hog-create: SUCCESS (32.251s)
[516.164128] [101/132] (494s left) api_intel_bb (full-batch)
[516.198031] Starting subtest: full-batch
[516.200301] Subtest full-batch: SUCCESS (0.003s)
[516.303550] [102/132] (494s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[516.394948] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[516.396751] Starting dynamic subtest: pipe-A-valid-mode
[517.441251] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.044s)
[517.441971] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.046s)
[517.600992] [103/132] (492s left) kms_cursor_legacy (forked-bo)
[517.690054] Starting subtest: forked-bo
[517.690799] Starting dynamic subtest: pipe-A
[523.117040] Dynamic subtest pipe-A: SUCCESS (5.417s)
[523.133889] Starting dynamic subtest: pipe-B
[528.563877] Dynamic subtest pipe-B: SUCCESS (5.420s)
[528.572563] Starting dynamic subtest: pipe-C
[533.990945] Dynamic subtest pipe-C: SUCCESS (5.426s)
[534.001196] Starting dynamic subtest: pipe-D
[539.394898] Dynamic subtest pipe-D: SUCCESS (5.427s)
[539.405922] Starting dynamic subtest: all-pipes
[544.860747] Dynamic subtest all-pipes: SUCCESS (5.439s)
[544.861824] Subtest forked-bo: SUCCESS (27.137s)
[544.901648] [104/132] (465s left) prime_mmap (test_correct)
[544.935786] Starting subtest: test_correct
[544.936494] Starting dynamic subtest: test_correct-smem
[544.938297] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[544.939102] Subtest test_correct: SUCCESS (0.003s)
[545.029997] [105/132] (465s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[545.121859] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[545.123291] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[545.223971] [106/132] (465s left) gem_exec_balancer (full-late-pulse)
[545.267240] Starting subtest: full-late-pulse
[546.868119] Subtest full-late-pulse: SUCCESS (1.601s)
[547.052243] [107/132] (463s left) kms_cdclk (plane-scaling)
[547.086549] Subtest plane-scaling: SKIP (0.000s)
[547.137557] [108/132] (463s left) gem_userptr_blits (input-checking)
[547.175501] Starting subtest: input-checking
[547.176248] Subtest input-checking: SUCCESS (0.000s)
[547.289066] [109/132] (463s left) gem_spin_batch (spin-each)
[547.331877] Starting subtest: spin-each
[550.691224] Subtest spin-each: SUCCESS (3.340s)
[550.858325] [110/132] (459s left) sw_sync (sync_multi_consumer)
[550.891575] Starting subtest: sync_multi_consumer
[551.435831] Subtest sync_multi_consumer: SUCCESS (0.536s)
[551.490506] [111/132] (459s left) gem_exec_reloc (basic-wc-gtt-active)
[551.528538] Starting subtest: basic-wc-gtt-active
[551.659090] Subtest basic-wc-gtt-active: SUCCESS (0.122s)
[551.771613] [112/132] (458s left) gem_userptr_blits (nohangcheck)
[551.823089] Starting subtest: nohangcheck
[551.989597] Subtest nohangcheck: SUCCESS (0.166s)
[552.113779] [113/132] (458s left) kms_plane (plane-position-hole)
[552.199267] Starting subtest: plane-position-hole
[552.418325] Starting dynamic subtest: pipe-A-plane-1
[552.647717] Dynamic subtest pipe-A-plane-1: SUCCESS (0.228s)
[552.655761] Starting dynamic subtest: pipe-A-plane-2
[552.886760] Dynamic subtest pipe-A-plane-2: SUCCESS (0.238s)
[552.895017] Starting dynamic subtest: pipe-A-plane-3
[553.125801] Dynamic subtest pipe-A-plane-3: SUCCESS (0.238s)
[553.133973] Starting dynamic subtest: pipe-A-plane-4
[553.364483] Dynamic subtest pipe-A-plane-4: SUCCESS (0.238s)
[553.372823] Starting dynamic subtest: pipe-A-plane-5
[553.603338] Dynamic subtest pipe-A-plane-5: SUCCESS (0.238s)
[553.611279] Starting dynamic subtest: pipe-A-plane-6
[553.841485] Dynamic subtest pipe-A-plane-6: SUCCESS (0.237s)
[553.849556] Starting dynamic subtest: pipe-A-plane-7
[553.850942] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[554.031976] Starting dynamic subtest: pipe-B-plane-1
[554.258365] Dynamic subtest pipe-B-plane-1: SUCCESS (0.234s)
[554.266334] Starting dynamic subtest: pipe-B-plane-2
[554.473439] Dynamic subtest pipe-B-plane-2: SUCCESS (0.214s)
[554.481541] Starting dynamic subtest: pipe-B-plane-3
[554.688600] Dynamic subtest pipe-B-plane-3: SUCCESS (0.214s)
[554.696772] Starting dynamic subtest: pipe-B-plane-4
[554.903409] Dynamic subtest pipe-B-plane-4: SUCCESS (0.214s)
[554.911390] Starting dynamic subtest: pipe-B-plane-5
[555.117745] Dynamic subtest pipe-B-plane-5: SUCCESS (0.214s)
[555.127128] Starting dynamic subtest: pipe-B-plane-6
[555.351513] Dynamic subtest pipe-B-plane-6: SUCCESS (0.232s)
[555.359728] Starting dynamic subtest: pipe-B-plane-7
[555.361086] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[555.361771] Subtest plane-position-hole: SUCCESS (3.155s)
[555.488479] [114/132] (455s left) sw_sync (sync_expired_merge)
[555.522486] Starting subtest: sync_expired_merge
[556.605294] Subtest sync_expired_merge: SUCCESS (1.074s)
[556.665049] [115/132] (454s left) gem_ctx_persistence (engines-mixed-process)
[556.703208] Starting subtest: engines-mixed-process
[556.704042] Starting dynamic subtest: rcs0
[557.070753] Dynamic subtest rcs0: SUCCESS (0.367s)
[557.084991] Starting dynamic subtest: bcs0
[557.438816] Dynamic subtest bcs0: SUCCESS (0.366s)
[557.456827] Starting dynamic subtest: vcs0
[557.801978] Dynamic subtest vcs0: SUCCESS (0.361s)
[557.812922] Starting dynamic subtest: vcs1
[558.158926] Dynamic subtest vcs1: SUCCESS (0.355s)
[558.179032] Starting dynamic subtest: vecs0
[558.521035] Dynamic subtest vecs0: SUCCESS (0.359s)
[558.525361] Subtest engines-mixed-process: SUCCESS (1.819s)
[558.601234] [116/132] (452s left) kms_addfb_basic (bad-pitch-999)
[558.636705] Starting subtest: bad-pitch-999
[558.637405] Subtest bad-pitch-999: SUCCESS (0.000s)
[558.787486] [117/132] (452s left) gem_exec_fence (submit3)
[558.955361] Starting subtest: submit3
[558.956290] Starting dynamic subtest: rcs0
[558.962021] Dynamic subtest rcs0: SUCCESS (0.008s)
[558.980638] Starting dynamic subtest: bcs0
[558.981464] Dynamic subtest bcs0: SUCCESS (0.007s)
[558.991829] Starting dynamic subtest: vcs0
[558.992630] Dynamic subtest vcs0: SUCCESS (0.009s)
[559.002377] Starting dynamic subtest: vcs1
[559.003106] Dynamic subtest vcs1: SUCCESS (0.008s)
[559.011190] Starting dynamic subtest: vecs0
[559.011893] Dynamic subtest vecs0: SUCCESS (0.007s)
[559.012589] Subtest submit3: SUCCESS (0.047s)
[559.454706] [118/132] (451s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[559.489515] Starting subtest: single-wait-for-submit-available-signaled
[559.490303] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[559.553912] [119/132] (451s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[559.589392] Starting subtest: etime-single-wait-all-for-submit-submitted
[559.696836] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[559.767686] [120/132] (451s left) gem_exec_schedule (noreorder)
[559.934596] Starting subtest: noreorder
[559.935865] Starting dynamic subtest: rcs0
[559.984739] Dynamic subtest rcs0: SUCCESS (0.049s)
[560.005021] Starting dynamic subtest: bcs0
[560.046683] Dynamic subtest bcs0: SUCCESS (0.059s)
[560.067301] Starting dynamic subtest: vcs0
[560.103764] Dynamic subtest vcs0: SUCCESS (0.054s)
[560.124469] Starting dynamic subtest: vcs1
[560.154753] Dynamic subtest vcs1: SUCCESS (0.048s)
[560.173877] Starting dynamic subtest: vecs0
[560.211716] Dynamic subtest vecs0: SUCCESS (0.054s)
[560.213311] Subtest noreorder: SUCCESS (0.278s)
[560.400235] [121/132] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[560.495818] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[560.497230] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[560.587909] [122/132] (450s left) gem_eio (wait-wedge-immediate)
[560.635333] Starting subtest: wait-wedge-immediate
[560.884870] Subtest wait-wedge-immediate: SUCCESS (0.248s)
[561.003277] [123/132] (450s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[561.039064] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[561.070134] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.019s)
[561.122364] [124/132] (450s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[561.217204] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[561.218690] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[561.332741] [125/132] (449s left) sysfs_heartbeat_interval (nopreempt)
[561.371104] Starting subtest: nopreempt
[561.372956] Starting dynamic subtest: vecs0
[564.955429] Dynamic subtest vecs0: SUCCESS (3.583s)
[564.966354] Starting dynamic subtest: vcs0
[568.540605] Dynamic subtest vcs0: SUCCESS (3.582s)
[568.551702] Starting dynamic subtest: bcs0
[572.127577] Dynamic subtest bcs0: SUCCESS (3.585s)
[572.141665] Starting dynamic subtest: rcs0
[575.746794] Dynamic subtest rcs0: SUCCESS (3.617s)
[575.756885] Starting dynamic subtest: vcs1
[579.321317] Dynamic subtest vcs1: SUCCESS (3.573s)
[579.322254] Subtest nopreempt: SUCCESS (17.951s)
[579.395373] [126/132] (431s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[579.485104] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[579.486943] Starting dynamic subtest: pipe-A-HDMI-A-1
[579.494033] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[579.502523] Starting dynamic subtest: pipe-B-HDMI-A-1
[579.509799] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[579.518307] Starting dynamic subtest: pipe-C-HDMI-A-1
[579.525283] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[579.533180] Starting dynamic subtest: pipe-D-HDMI-A-1
[579.540288] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[579.541705] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[579.720338] [127/132] (431s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[579.806186] Starting subtest: flip-vs-cursor-busy-crc-atomic
[580.169890] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.362s)
[580.329437] [128/132] (431s left) kms_psr (fbc-psr-cursor-plane-onoff)
[580.416700] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[580.458246] [129/132] (431s left) gem_pxp (protected-raw-src-copy-not-readible)
[580.561208] Starting subtest: protected-raw-src-copy-not-readible
[580.607979] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.048s)
[580.719394] [130/132] (430s left) perf (missing-sample-flags)
[580.816008] Starting subtest: missing-sample-flags
[580.816766] Subtest missing-sample-flags: SUCCESS (0.000s)
[580.861781] [131/132] (430s left) syncobj_wait (wait-all-delayed-signal)
[580.896074] Starting subtest: wait-all-delayed-signal
[580.998486] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[581.118327] [132/132] (430s left) template (b)
[581.152919] Starting subtest: B
[581.153618] Subtest B: SUCCESS (0.000s)
[581.241621] 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.