[60.457228] Initializing watchdogs
[60.457326]   /dev/watchdog0
[60.472110] [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]
[60.476341] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.479753] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.483730] [001/133] (960s left) syncobj_timeline (invalid-transfer-bad-pad)
[60.552086] Starting subtest: invalid-transfer-bad-pad
[60.554444] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[60.662883] [002/133] (960s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[60.928900] Starting subtest: parallel-dmabuf-import-out-fence
[62.007935] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.079s)
[62.128578] [003/133] (958s left) api_intel_allocator (reloc-allocator)
[62.197238] Starting subtest: reloc-allocator
[62.199627] Starting dynamic subtest: basic
[62.202022] Dynamic subtest basic: SUCCESS (0.005s)
[62.211397] Starting dynamic subtest: parallel-one
[62.213584] Dynamic subtest parallel-one: SUCCESS (0.008s)
[62.220140] Starting dynamic subtest: print
[62.222434] Dynamic subtest print: SUCCESS (0.000s)
[62.228904] Starting dynamic subtest: reuse
[62.230917] Dynamic subtest reuse: SUCCESS (0.000s)
[62.237051] Starting dynamic subtest: fork-reopen-allocator
[62.238948] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[62.240871] Subtest reloc-allocator: SUCCESS (0.027s)
[62.354403] [004/133] (958s left) i915_selftest (live)
[63.964033] Starting subtest: live
[63.966828] Starting dynamic subtest: sanitycheck
[68.275537] Dynamic subtest sanitycheck: SUCCESS (4.311s)
[68.283958] Starting dynamic subtest: uncore
[72.536707] Dynamic subtest uncore: SUCCESS (4.260s)
[72.545493] Starting dynamic subtest: workarounds
[75.597342] Dynamic subtest workarounds: SUCCESS (3.060s)
[75.605613] Starting dynamic subtest: gt_engines
[78.611923] Dynamic subtest gt_engines: SUCCESS (3.014s)
[78.620786] Starting dynamic subtest: gt_timelines
[94.354878] Dynamic subtest gt_timelines: SUCCESS (15.741s)
[94.362713] Starting dynamic subtest: gt_contexts
[97.052674] Dynamic subtest gt_contexts: SUCCESS (2.697s)
[97.060664] Starting dynamic subtest: gt_lrc
[103.155614] Dynamic subtest gt_lrc: SUCCESS (6.102s)
[103.163671] Starting dynamic subtest: gt_mocs
[106.057702] Dynamic subtest gt_mocs: SUCCESS (2.901s)
[106.066626] Starting dynamic subtest: gt_pm
[112.763573] Dynamic subtest gt_pm: SUCCESS (6.706s)
[112.771322] Starting dynamic subtest: gt_heartbeat
[117.037026] Dynamic subtest gt_heartbeat: SUCCESS (4.273s)
[117.045637] Starting dynamic subtest: gt_tlb
[126.387345] Dynamic subtest gt_tlb: SUCCESS (9.348s)
[126.395703] Starting dynamic subtest: requests
[137.883050] Dynamic subtest requests: SUCCESS (11.495s)
[137.891134] Starting dynamic subtest: migrate
[143.609680] Dynamic subtest migrate: SUCCESS (5.726s)
[143.617871] Starting dynamic subtest: active
[147.852880] Dynamic subtest active: SUCCESS (4.242s)
[147.861426] Starting dynamic subtest: objects
[152.462956] Dynamic subtest objects: SUCCESS (4.609s)
[152.471904] Starting dynamic subtest: mman
[155.741422] Dynamic subtest mman: SUCCESS (3.276s)
[155.749284] Starting dynamic subtest: dmabuf
[160.015967] Dynamic subtest dmabuf: SUCCESS (4.273s)
[160.024840] Starting dynamic subtest: vma
[164.303257] Dynamic subtest vma: SUCCESS (4.286s)
[164.316352] Starting dynamic subtest: coherency
[169.263803] Dynamic subtest coherency: SUCCESS (4.959s)
[169.272591] Starting dynamic subtest: gtt
[179.185683] Dynamic subtest gtt: SUCCESS (9.919s)
[179.196531] Starting dynamic subtest: gem
[184.636014] Dynamic subtest gem: SUCCESS (5.425s)
[184.641999] Starting dynamic subtest: evict
[190.043996] Dynamic subtest evict: SUCCESS (5.430s)
[190.052863] Starting dynamic subtest: hugepages
[200.688708] Dynamic subtest hugepages: SUCCESS (10.644s)
[200.697928] Starting dynamic subtest: gem_contexts
[227.428263] Dynamic subtest gem_contexts: SUCCESS (26.738s)
[227.440834] Starting dynamic subtest: client
[231.715523] Dynamic subtest client: SUCCESS (4.286s)
[231.728530] Starting dynamic subtest: gem_migrate
[234.332962] Dynamic subtest gem_migrate: SUCCESS (2.616s)
[234.339062] Starting dynamic subtest: reset
[238.626598] Dynamic subtest reset: SUCCESS (4.292s)
[238.639426] Starting dynamic subtest: memory_region
[242.961458] Dynamic subtest memory_region: SUCCESS (4.333s)
[242.969966] Starting dynamic subtest: hangcheck
[255.763425] Dynamic subtest hangcheck: SUCCESS (12.801s)
[255.772245] Starting dynamic subtest: execlists
[258.372911] Dynamic subtest execlists: SUCCESS (2.608s)
[258.381558] Starting dynamic subtest: ring_submission
[262.685070] Dynamic subtest ring_submission: SUCCESS (4.310s)
[262.696269] Starting dynamic subtest: perf
[266.987132] Dynamic subtest perf: SUCCESS (4.300s)
[266.994803] Starting dynamic subtest: slpc
[279.066288] Dynamic subtest slpc: SUCCESS (12.077s)
[279.074579] Starting dynamic subtest: guc
[282.934396] Dynamic subtest guc: SUCCESS (3.866s)
[282.942320] Starting dynamic subtest: guc_multi_lrc
[285.529456] Dynamic subtest guc_multi_lrc: SUCCESS (2.592s)
[285.537840] Starting dynamic subtest: guc_hang
[290.415215] Dynamic subtest guc_hang: SUCCESS (4.884s)
[290.423955] Starting dynamic subtest: late_gt_pm
[294.739041] Dynamic subtest late_gt_pm: SUCCESS (4.322s)
[294.741682] Subtest live: SUCCESS (230.770s)
[294.768621] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[294.771921] [005/133] (726s left) kms_rotation_crc (multiplane-rotation)
[296.308419] Starting subtest: multiplane-rotation
[313.778284] Subtest multiplane-rotation: SUCCESS (17.471s)
[313.875295] [FACT kms_rotation_crc (multiplane-rotation)] new: kernel.kmod_is_loaded.i915: true
[313.878716] [006/133] (707s left) gem_userptr_blits (create-destroy-sync)
[313.948541] Starting subtest: create-destroy-sync
[318.957567] Subtest create-destroy-sync: SUCCESS (5.007s)
[319.086894] [007/133] (702s left) sw_sync (sync_merge)
[319.123506] Starting subtest: sync_merge
[319.125636] Subtest sync_merge: SUCCESS (0.000s)
[319.180089] [008/133] (702s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[319.281098] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[319.283349] Starting dynamic subtest: pipe-A-eDP-1
[319.303203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[319.313455] Starting dynamic subtest: pipe-B-eDP-1
[319.332998] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[319.340776] Starting dynamic subtest: pipe-C-eDP-1
[319.360654] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[319.368617] Starting dynamic subtest: pipe-D-eDP-1
[319.387227] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[319.389070] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[321.583308] [009/133] (699s left) gem_exec_schedule (u-submit-golden-slice)
[321.650057] Starting subtest: u-submit-golden-slice
[321.652125] Starting dynamic subtest: rcs0
[321.676247] Dynamic subtest rcs0: SUCCESS (0.036s)
[321.684830] Starting dynamic subtest: bcs0
[321.705333] Dynamic subtest bcs0: SUCCESS (0.028s)
[321.713908] Starting dynamic subtest: vcs0
[321.738184] Dynamic subtest vcs0: SUCCESS (0.032s)
[321.746657] Starting dynamic subtest: vcs1
[321.774456] Dynamic subtest vcs1: SUCCESS (0.036s)
[321.781662] Starting dynamic subtest: vecs0
[321.800515] Dynamic subtest vecs0: SUCCESS (0.025s)
[321.807763] Starting dynamic subtest: ccs0
[321.832795] Dynamic subtest ccs0: SUCCESS (0.032s)
[321.834977] Subtest u-submit-golden-slice: SUCCESS (0.193s)
[322.981638] [010/133] (698s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[323.040157] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[323.109274] [011/133] (698s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[323.235075] Starting subtest: basic-flip-before-cursor-atomic
[324.193927] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.960s)
[325.021418] [012/133] (696s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[325.128227] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[325.132513] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[325.195388] [013/133] (696s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[325.255087] Starting subtest: single-wait-all-for-submit-available-signaled
[325.257314] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[325.356498] [014/133] (696s left) i915_pm_rpm (gem-execbuf-stress)
[327.109255] Starting subtest: gem-execbuf-stress
[327.111526] Starting dynamic subtest: smem0
[340.039069] Dynamic subtest smem0: SUCCESS (12.931s)
[340.050236] Starting dynamic subtest: extra-wait-smem0
[402.123873] Dynamic subtest extra-wait-smem0: SUCCESS (62.078s)
[402.127095] Subtest gem-execbuf-stress: SUCCESS (75.016s)
[402.509361] [015/133] (618s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[402.614310] Starting subtest: drrs-dirtyfb-ioctl
[402.627642] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[402.725207] [016/133] (618s left) kms_hdr (static-toggle-suspend)
[402.822060] Starting subtest: static-toggle-suspend
[402.828450] Subtest static-toggle-suspend: SKIP (0.000s)
[402.891411] [017/133] (618s left) kms_content_protection (mei-interface)
[403.031313] Starting subtest: mei-interface
[403.035477] Subtest mei-interface: SKIP (0.001s)
[403.137775] [018/133] (618s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[403.227193] Starting subtest: psr-rgb565-draw-mmap-cpu
[409.987779] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.763s)
[410.089599] [019/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[410.193644] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[410.197585] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[410.268253] [020/133] (611s left) gem_exec_fence (submit-chain)
[410.465833] Starting subtest: submit-chain
[410.482362] Subtest submit-chain: SUCCESS (0.017s)
[411.978380] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[411.982511] [021/133] (609s left) gem_userptr_blits (readonly-pwrite-unsync)
[412.040672] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[412.149374] [022/133] (609s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[412.249026] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[412.253492] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[413.331248] [023/133] (608s left) gem_exec_nop (basic-sequential)
[413.400066] Starting subtest: basic-sequential
[428.431561] Subtest basic-sequential: SUCCESS (15.041s)
[428.695346] [024/133] (593s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[428.818859] Starting subtest: fbc-psr2-cursor-plane-update-sf
[428.821216] Starting dynamic subtest: pipe-A-eDP-1
[428.903275] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[428.913483] Starting dynamic subtest: pipe-B-eDP-1
[430.013231] Dynamic subtest pipe-B-eDP-1: SKIP (1.106s)
[430.017752] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.197s)
[431.291697] [025/133] (590s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[431.364073] Subtest writes-after-reads-uncached: SKIP (0.000s)
[431.430831] [026/133] (590s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[431.549194] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[431.553819] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[431.667510] [027/133] (590s left) kms_flip (modeset-vs-vblank-race-interruptible)
[431.765174] Starting subtest: modeset-vs-vblank-race-interruptible
[431.767474] Starting dynamic subtest: A-eDP1
[436.414721] Dynamic subtest A-eDP1: SUCCESS (4.648s)
[436.427091] Starting dynamic subtest: B-eDP1
[441.067240] Dynamic subtest B-eDP1: SUCCESS (4.649s)
[441.077617] Starting dynamic subtest: C-eDP1
[445.596176] Dynamic subtest C-eDP1: SUCCESS (4.526s)
[445.605472] Starting dynamic subtest: D-eDP1
[450.138389] Dynamic subtest D-eDP1: SUCCESS (4.541s)
[450.144252] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.376s)
[451.309909] [028/133] (570s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[451.404792] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[458.194867] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.796s)
[458.322447] [029/133] (563s left) kms_pm_rpm (legacy-planes-dpms)
[460.049978] Starting subtest: legacy-planes-dpms
[460.052377] Starting dynamic subtest: plane-65
[468.342847] Dynamic subtest plane-65: SUCCESS (8.294s)
[468.353838] Starting dynamic subtest: plane-95
[476.754920] Dynamic subtest plane-95: SUCCESS (8.410s)
[476.765645] Starting dynamic subtest: plane-125
[485.089028] Dynamic subtest plane-125: SUCCESS (8.331s)
[485.100071] Starting dynamic subtest: plane-135
[493.376892] Dynamic subtest plane-135: SUCCESS (8.285s)
[493.379783] Subtest legacy-planes-dpms: SUCCESS (33.330s)
[493.743006] [030/133] (528s left) perf (sysctl-defaults)
[493.816679] Starting subtest: sysctl-defaults
[493.819323] Subtest sysctl-defaults: SUCCESS (0.000s)
[493.947418] [031/133] (528s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[493.994631] Starting subtest: multi-wait-available-unsubmitted-signaled
[493.996843] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[494.101283] [032/133] (528s left) kms_getfb (getfb-handle-closed)
[494.194064] Starting subtest: getfb-handle-closed
[494.196247] Subtest getfb-handle-closed: SUCCESS (0.000s)
[494.299259] [033/133] (527s left) gem_exec_reloc (basic-gtt-active)
[494.361252] Subtest basic-gtt-active: SKIP (0.000s)
[494.440308] [034/133] (527s left) gem_exec_fence (syncobj-timeline-wait)
[494.959428] Starting subtest: syncobj-timeline-wait
[495.891394] Subtest syncobj-timeline-wait: SUCCESS (0.932s)
[498.016908] [035/133] (524s left) kms_getfb (getfb2-handle-protection)
[498.115882] Starting subtest: getfb2-handle-protection
[498.140077] Subtest getfb2-handle-protection: SUCCESS (0.025s)
[498.265429] [036/133] (524s left) kms_cursor_crc (cursor-onscreen-512x512)
[498.542578] Starting subtest: cursor-onscreen-512x512
[498.546770] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[498.701166] [037/133] (523s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[498.801136] Starting subtest: coverage-vs-premult-vs-constant
[499.081424] Starting dynamic subtest: pipe-A-eDP-1
[499.645039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[499.653821] Starting dynamic subtest: pipe-D-eDP-1
[500.941106] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.296s)
[500.943525] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.142s)
[501.802645] [038/133] (520s left) gem_exec_schedule (preempt-user)
[501.875694] Starting subtest: preempt-user
[501.877928] Starting dynamic subtest: rcs0
[501.893128] Dynamic subtest rcs0: SUCCESS (0.025s)
[501.903144] Starting dynamic subtest: bcs0
[501.914894] Dynamic subtest bcs0: SUCCESS (0.021s)
[501.922617] Starting dynamic subtest: vcs0
[501.936465] Dynamic subtest vcs0: SUCCESS (0.021s)
[501.944198] Starting dynamic subtest: vcs1
[501.956973] Dynamic subtest vcs1: SUCCESS (0.020s)
[501.964655] Starting dynamic subtest: vecs0
[501.976594] Dynamic subtest vecs0: SUCCESS (0.019s)
[501.984192] Starting dynamic subtest: ccs0
[501.995773] Dynamic subtest ccs0: SUCCESS (0.018s)
[501.998040] Subtest preempt-user: SUCCESS (0.128s)
[503.964430] [039/133] (518s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[504.057182] Starting subtest: plane-lut1d-ctm3x4
[504.241948] Starting dynamic subtest: pipe-A-plane-0
[504.397075] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[504.405892] Starting dynamic subtest: pipe-A-plane-1
[504.552734] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[504.562118] Starting dynamic subtest: pipe-A-plane-2
[504.685987] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[505.887722] Starting dynamic subtest: pipe-B-plane-0
[506.048443] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[506.057140] Starting dynamic subtest: pipe-B-plane-1
[506.193230] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[506.203464] Starting dynamic subtest: pipe-B-plane-2
[506.326176] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[507.518537] Starting dynamic subtest: pipe-C-plane-0
[507.656256] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[507.666079] Starting dynamic subtest: pipe-C-plane-1
[507.800682] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[507.808868] Starting dynamic subtest: pipe-C-plane-2
[507.945070] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[509.152293] Starting dynamic subtest: pipe-D-plane-0
[509.301074] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[509.309869] Starting dynamic subtest: pipe-D-plane-1
[509.456476] Dynamic subtest pipe-D-plane-1: SUCCESS (0.154s)
[509.464571] Starting dynamic subtest: pipe-D-plane-2
[509.601171] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[509.889351] Subtest plane-lut1d-ctm3x4: SUCCESS (5.829s)
[510.729082] [040/133] (511s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[510.825904] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[517.354106] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.532s)
[517.463920] [041/133] (505s left) kms_hdmi_inject (inject-audio)
[517.808290] Starting subtest: inject-audio
[518.082056] Subtest inject-audio: SUCCESS (0.277s)
[518.717306] [042/133] (503s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[518.827980] Starting subtest: y-tiled-16bpp-rotate-270
[518.832560] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[518.923555] [043/133] (503s left) gem_render_copy (y-tiled-to-vebox-linear)
[518.990269] Starting subtest: y-tiled-to-vebox-linear
[518.995126] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[519.174456] [044/133] (503s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[519.255512] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[519.257965] Starting dynamic subtest: pipe-A
[519.317679] Dynamic subtest pipe-A: SUCCESS (0.065s)
[519.325876] Starting dynamic subtest: pipe-B
[520.469254] Dynamic subtest pipe-B: SUCCESS (1.150s)
[520.478610] Starting dynamic subtest: pipe-C
[521.632435] Dynamic subtest pipe-C: SUCCESS (1.162s)
[521.640820] Starting dynamic subtest: pipe-D
[522.744937] Dynamic subtest pipe-D: SUCCESS (1.112s)
[522.747312] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.492s)
[523.887931] [045/133] (498s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[523.972281] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[523.974644] Starting dynamic subtest: pipe-A-eDP-1
[524.476604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.475s)
[524.485398] Starting dynamic subtest: pipe-B-eDP-1
[525.853597] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.376s)
[525.863630] Starting dynamic subtest: pipe-C-eDP-1
[527.264222] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.412s)
[527.274655] Starting dynamic subtest: pipe-D-eDP-1
[528.631967] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s)
[528.634053] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.632s)
[529.761954] [046/133] (493s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[529.862428] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[529.866914] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[529.933854] [047/133] (492s left) i915_hangman (hangcheck-unterminated)
[529.998785] Starting subtest: hangcheck-unterminated
[541.877118] Subtest hangcheck-unterminated: SUCCESS (11.878s)
[541.997314] [048/133] (480s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[542.391840] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[543.163861] [049/133] (479s left) kms_properties (crtc-properties-atomic)
[543.262220] Starting subtest: crtc-properties-atomic
[543.264195] Starting dynamic subtest: pipe-A-eDP-1
[543.699523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[543.708864] Starting dynamic subtest: pipe-B-eDP-1
[544.880312] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[544.889332] Starting dynamic subtest: pipe-C-eDP-1
[545.998064] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[546.006853] Starting dynamic subtest: pipe-D-eDP-1
[547.195049] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s)
[547.197257] Subtest crtc-properties-atomic: SUCCESS (3.932s)
[548.054701] [050/133] (474s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[548.154679] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[554.837896] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.686s)
[554.962314] [051/133] (468s left) gem_mmap_gtt (big-bo-tiledx)
[555.014614] Subtest big-bo-tiledX: SKIP (0.000s)
[555.074111] [052/133] (467s left) kms_plane_cursor (viewport)
[555.162258] Starting subtest: viewport
[555.166699] Starting dynamic subtest: pipe-A-eDP-1-size-64
[557.796871] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.634s)
[557.860774] Starting dynamic subtest: pipe-A-eDP-1-size-128
[560.298102] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s)
[560.357059] Starting dynamic subtest: pipe-A-eDP-1-size-256
[562.800082] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[563.158528] Starting dynamic subtest: pipe-B-eDP-1-size-64
[566.274169] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.125s)
[566.344378] Starting dynamic subtest: pipe-B-eDP-1-size-128
[568.743550] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.415s)
[568.804079] Starting dynamic subtest: pipe-B-eDP-1-size-256
[571.288306] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s)
[571.656249] Starting dynamic subtest: pipe-C-eDP-1-size-64
[574.480984] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.837s)
[574.518449] Starting dynamic subtest: pipe-C-eDP-1-size-128
[576.648272] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[576.685205] Starting dynamic subtest: pipe-C-eDP-1-size-256
[578.804653] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[579.131749] Starting dynamic subtest: pipe-D-eDP-1-size-64
[581.985684] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.864s)
[582.023042] Starting dynamic subtest: pipe-D-eDP-1-size-128
[584.141419] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.125s)
[584.179691] Starting dynamic subtest: pipe-D-eDP-1-size-256
[586.273831] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.103s)
[586.592960] Subtest viewport: SUCCESS (31.430s)
[587.466516] [053/133] (435s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[587.573224] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[591.963347] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.393s)
[593.080433] [054/133] (430s left) gem_mmap_gtt (bad-object)
[593.128868] Subtest bad-object: SKIP (0.000s)
[593.181798] [055/133] (429s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[593.273353] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[593.277760] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[593.374092] [056/133] (429s left) gem_vm_create (invalid-destroy)
[593.438637] Starting subtest: invalid-destroy
[593.441607] Subtest invalid-destroy: SUCCESS (0.002s)
[593.533468] [057/133] (429s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[593.620375] Starting subtest: modeset-transition-nonblocking-fencing
[593.622595] Starting dynamic subtest: 1x-outputs
[604.718226] Dynamic subtest 1x-outputs: SUCCESS (11.099s)
[604.720595] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.100s)
[605.562606] [058/133] (417s left) syncobj_basic (bad-destroy)
[605.621703] Starting subtest: bad-destroy
[605.623648] Subtest bad-destroy: SUCCESS (0.000s)
[605.722831] [059/133] (417s left) kms_psr (fbc-psr-primary-mmap-cpu)
[605.813821] Starting subtest: fbc-psr-primary-mmap-cpu
[605.816191] Starting dynamic subtest: eDP-1
[605.820453] Dynamic subtest eDP-1: SKIP (0.000s)
[605.824683] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[605.886735] [060/133] (417s left) kms_draw_crc (draw-method-render)
[605.970180] Starting subtest: draw-method-render
[605.972031] Starting dynamic subtest: xrgb8888-untiled
[606.235475] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[606.244232] Starting dynamic subtest: rgb565-untiled
[606.479846] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[606.491235] Starting dynamic subtest: xrgb2101010-untiled
[606.702074] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[606.718658] Starting dynamic subtest: xbgr16161616f-untiled
[606.958386] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.253s)
[606.975183] Starting dynamic subtest: xrgb8888-xtiled
[607.124384] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[607.132908] Starting dynamic subtest: rgb565-xtiled
[607.234811] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[607.243252] Starting dynamic subtest: xrgb2101010-xtiled
[607.346225] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[607.354441] Starting dynamic subtest: xbgr16161616f-xtiled
[607.480541] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[607.493311] Starting dynamic subtest: xrgb8888-4tiled
[607.612821] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[607.622937] Starting dynamic subtest: rgb565-4tiled
[607.746090] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[607.754784] Starting dynamic subtest: xrgb2101010-4tiled
[607.879631] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[607.890119] Starting dynamic subtest: xbgr16161616f-4tiled
[608.001724] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[608.003565] Subtest draw-method-render: SUCCESS (2.034s)
[608.118375] [061/133] (415s left) kms_flip (2x-flip-vs-modeset)
[608.215461] Starting subtest: 2x-flip-vs-modeset
[608.237058] Subtest 2x-flip-vs-modeset: SKIP (0.023s)
[608.328080] [062/133] (415s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[608.385961] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[608.490098] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[608.565467] [063/133] (414s left) kms_sequence (get-forked-busy)
[608.641022] Starting subtest: get-forked-busy
[608.643468] Starting dynamic subtest: pipe-A-eDP-1
[610.577974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[610.589303] Starting dynamic subtest: pipe-B-eDP-1
[613.146381] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.566s)
[613.155093] Starting dynamic subtest: pipe-C-eDP-1
[615.711167] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.562s)
[615.720159] Starting dynamic subtest: pipe-D-eDP-1
[618.311788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[618.314085] Subtest get-forked-busy: SUCCESS (9.671s)
[619.159379] [064/133] (404s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[619.225813] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[619.301244] [065/133] (404s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[619.383216] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[619.385371] Starting dynamic subtest: pipe-A-eDP-1
[619.407041] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[619.416722] Starting dynamic subtest: pipe-B-eDP-1
[619.437219] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[619.445312] Starting dynamic subtest: pipe-C-eDP-1
[619.465901] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[619.473701] Starting dynamic subtest: pipe-D-eDP-1
[619.494968] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[619.498984] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[621.657286] [066/133] (401s left) kms_lease (lease-invalid-crtc)
[621.751257] Starting subtest: lease-invalid-crtc
[621.753459] Starting dynamic subtest: pipe-A-eDP-1
[621.755791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[621.764574] Starting dynamic subtest: pipe-B-eDP-1
[621.766920] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[621.774543] Starting dynamic subtest: pipe-C-eDP-1
[621.776480] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[621.784362] Starting dynamic subtest: pipe-D-eDP-1
[621.786603] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[621.788857] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[621.824954] [067/133] (401s left) gem_exec_await (wide-contexts)
[622.054979] Starting subtest: wide-contexts
[645.922441] Subtest wide-contexts: SUCCESS (23.864s)
[646.111746] [068/133] (377s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[646.244072] Starting subtest: fbc-psr2-primary-mmap-gtt
[646.246654] Starting dynamic subtest: eDP-1
[646.250838] Dynamic subtest eDP-1: SKIP (0.000s)
[646.255413] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[646.314721] [069/133] (377s left) gem_tiled_pread_pwrite
[646.446661] [070/133] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[646.543249] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[646.547371] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[646.668707] [071/133] (377s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[647.041232] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[647.838501] [072/133] (376s left) perf (invalid-oa-metric-set-id)
[647.963852] Starting subtest: invalid-oa-metric-set-id
[647.972623] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[648.023314] [073/133] (375s left) i915_drm_fdinfo (busy)
[648.066727] Starting subtest: busy
[648.069034] Starting dynamic subtest: rcs0
[648.105479] Dynamic subtest rcs0: SKIP (0.037s)
[648.117027] Starting dynamic subtest: bcs0
[648.121525] Dynamic subtest bcs0: SKIP (0.000s)
[648.129995] Starting dynamic subtest: vcs0
[648.133895] Dynamic subtest vcs0: SKIP (0.000s)
[648.142367] Starting dynamic subtest: vcs1
[648.146867] Dynamic subtest vcs1: SKIP (0.000s)
[648.155673] Starting dynamic subtest: vecs0
[648.160322] Dynamic subtest vecs0: SKIP (0.000s)
[648.169154] Starting dynamic subtest: ccs0
[648.173525] Dynamic subtest ccs0: SKIP (0.000s)
[648.178032] Subtest busy: SKIP (0.044s)
[648.217883] [074/133] (375s left) gem_exec_flush (basic-wb-pro-default)
[648.285715] Starting subtest: basic-wb-pro-default
[653.741705] Subtest basic-wb-pro-default: SUCCESS (5.457s)
[653.940526] [075/133] (370s left) perf_pmu (semaphore-busy)
[653.975875] Starting subtest: semaphore-busy
[653.978124] Starting dynamic subtest: rcs0
[655.621807] Dynamic subtest rcs0: SUCCESS (1.642s)
[655.632282] Starting dynamic subtest: bcs0
[657.258221] Dynamic subtest bcs0: SUCCESS (1.633s)
[657.268595] Starting dynamic subtest: vcs0
[661.393490] Dynamic subtest vcs0: SUCCESS (4.132s)
[661.411033] Starting dynamic subtest: vcs1
[667.409271] Dynamic subtest vcs1: SUCCESS (6.013s)
[667.420757] Starting dynamic subtest: vecs0
[673.424435] Dynamic subtest vecs0: SUCCESS (6.011s)
[673.435892] Starting dynamic subtest: ccs0
[676.499946] Dynamic subtest ccs0: SUCCESS (3.072s)
[676.502722] Subtest semaphore-busy: SUCCESS (22.522s)
[676.613473] [076/133] (347s left) gem_userptr_blits (usage-restrictions)
[676.679660] Starting subtest: usage-restrictions
[676.681570] Subtest usage-restrictions: SUCCESS (0.000s)
[676.793884] [077/133] (347s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[676.896691] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[684.011869] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.118s)
[684.145599] [078/133] (339s left) kms_addfb_basic (bad-pitch-128)
[684.207015] Starting subtest: bad-pitch-128
[684.209469] Subtest bad-pitch-128: SUCCESS (0.000s)
[684.351542] [079/133] (339s left) intel_hwmon (hwmon-read)
[684.405791] Subtest hwmon-read: SKIP (0.000s)
[684.462202] [080/133] (339s left) device_reset (unbind-reset-rebind)
[684.522478] Starting subtest: unbind-reset-rebind
[687.531792] Subtest unbind-reset-rebind: SUCCESS (3.004s)
[687.576705] [081/133] (336s left) fbdev (nullptr)
[687.619719] Starting subtest: nullptr
[687.622064] Subtest nullptr: SUCCESS (0.000s)
[687.694198] [082/133] (336s left) kms_pm_backlight (fade-with-dpms)
[687.792968] Starting subtest: fade-with-dpms
[689.958874] Starting dynamic subtest: eDP-1
[692.437097] Dynamic subtest eDP-1: SUCCESS (2.479s)
[692.439592] Subtest fade-with-dpms: SUCCESS (4.646s)
[693.249458] [083/133] (331s left) syncobj_timeline (etime-single-wait-submitted)
[693.308386] Starting subtest: etime-single-wait-submitted
[693.408254] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[693.487547] [084/133] (330s left) api_intel_bb (render)
[693.546444] Starting subtest: render
[693.548770] Starting dynamic subtest: render-none-512
[693.653682] Dynamic subtest render-none-512: SUCCESS (0.106s)
[693.666549] Starting dynamic subtest: render-none-1024
[694.095801] Dynamic subtest render-none-1024: SUCCESS (0.440s)
[694.108186] Starting dynamic subtest: render-x-512
[694.184848] Dynamic subtest render-x-512: SUCCESS (0.089s)
[694.194399] Starting dynamic subtest: render-x-1024
[694.523741] Dynamic subtest render-x-1024: SUCCESS (0.336s)
[694.533400] Starting dynamic subtest: render-y-512
[694.606565] Dynamic subtest render-y-512: SUCCESS (0.083s)
[694.617265] Starting dynamic subtest: render-y-1024
[694.983832] Dynamic subtest render-y-1024: SUCCESS (0.375s)
[694.986672] Subtest render: SUCCESS (1.437s)
[695.086104] [085/133] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[695.191305] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[695.195277] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[695.286172] [086/133] (329s left) gem_render_copy (yf-tiled)
[695.335048] Starting subtest: yf-tiled
[695.339424] Subtest yf-tiled: SKIP (0.000s)
[695.514842] [087/133] (328s left) gem_exec_balancer (full-late-pulse)
[695.572936] Starting subtest: full-late-pulse
[699.768926] Subtest full-late-pulse: SUCCESS (4.196s)
[700.112239] [088/133] (324s left) gem_exec_schedule (pi-distinct-iova)
[700.298255] Starting subtest: pi-distinct-iova
[700.301102] Starting dynamic subtest: rcs0
[700.416638] Dynamic subtest rcs0: SUCCESS (0.121s)
[700.429750] Starting dynamic subtest: vcs0
[700.515150] Dynamic subtest vcs0: SUCCESS (0.097s)
[700.527294] Starting dynamic subtest: vcs1
[700.602616] Dynamic subtest vcs1: SUCCESS (0.087s)
[700.615032] Starting dynamic subtest: vecs0
[700.691446] Dynamic subtest vecs0: SUCCESS (0.088s)
[700.703678] Starting dynamic subtest: ccs0
[700.798102] Dynamic subtest ccs0: SUCCESS (0.105s)
[700.800607] Subtest pi-distinct-iova: SUCCESS (0.505s)
[702.006547] [089/133] (322s left) kms_psr (pr-cursor-mmap-cpu)
[702.092582] Starting subtest: pr-cursor-mmap-cpu
[702.096891] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[702.162999] [090/133] (322s left) gem_request_retire (retire-vma-not-inactive)
[702.211194] Starting subtest: retire-vma-not-inactive
[702.272102] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[702.396412] [091/133] (322s left) gem_ctx_create (basic-files)
[702.453878] Starting subtest: basic-files
[704.460684] Subtest basic-files: SUCCESS (2.009s)
[705.925440] [092/133] (318s left) kms_flip (2x-blocking-wf_vblank)
[706.020935] Starting subtest: 2x-blocking-wf_vblank
[706.031650] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[706.110334] [093/133] (318s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[706.205634] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[706.208368] Starting dynamic subtest: pipe-A-default-mode
[707.329028] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[707.333129] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.122s)
[707.465858] [094/133] (317s left) gem_ctx_persistence (engines-hostile)
[707.515448] Starting subtest: engines-hostile
[707.518225] Starting dynamic subtest: rcs0
[707.593106] Dynamic subtest rcs0: SUCCESS (0.077s)
[707.605795] Starting dynamic subtest: bcs0
[707.684729] Dynamic subtest bcs0: SUCCESS (0.090s)
[707.696943] Starting dynamic subtest: vcs0
[707.774279] Dynamic subtest vcs0: SUCCESS (0.087s)
[707.786517] Starting dynamic subtest: vcs1
[707.865698] Dynamic subtest vcs1: SUCCESS (0.089s)
[707.877637] Starting dynamic subtest: vecs0
[707.958757] Dynamic subtest vecs0: SUCCESS (0.091s)
[707.971275] Starting dynamic subtest: ccs0
[708.052704] Dynamic subtest ccs0: SUCCESS (0.092s)
[708.055266] Subtest engines-hostile: SUCCESS (0.539s)
[708.135391] [095/133] (316s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[708.225403] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[708.228840] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[708.316776] [096/133] (316s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[708.408162] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[708.411530] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[708.502222] [097/133] (316s left) gem_lmem_swapping (parallel-random)
[708.550693] Subtest parallel-random: SKIP (0.000s)
[708.597356] [098/133] (316s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[708.680290] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[713.243354] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.565s)
[714.396077] [099/133] (310s left) perf_pmu (init-wait)
[714.446510] Starting subtest: init-wait
[714.448841] Starting dynamic subtest: rcs0
[714.451523] Dynamic subtest rcs0: SUCCESS (0.001s)
[714.461165] Starting dynamic subtest: bcs0
[714.463048] Dynamic subtest bcs0: SUCCESS (0.000s)
[714.471754] Starting dynamic subtest: vcs0
[714.473650] Dynamic subtest vcs0: SUCCESS (0.001s)
[714.482136] Starting dynamic subtest: vcs1
[714.484017] Dynamic subtest vcs1: SUCCESS (0.001s)
[714.492931] Starting dynamic subtest: vecs0
[714.495122] Dynamic subtest vecs0: SUCCESS (0.001s)
[714.503707] Starting dynamic subtest: ccs0
[714.505606] Dynamic subtest ccs0: SUCCESS (0.000s)
[714.507516] Subtest init-wait: SUCCESS (0.007s)
[714.547900] [100/133] (310s left) vgem_basic (dmabuf-fence)
[714.593128] Starting subtest: dmabuf-fence
[714.595041] Subtest dmabuf-fence: SUCCESS (0.000s)
[714.647102] [101/133] (310s left) gem_fence_thrash (bo-copy)
[714.684620] Starting subtest: bo-copy
[714.696571] Subtest bo-copy: SKIP (0.012s)
[714.755477] [102/133] (310s left) kms_psr (psr2-cursor-plane-move)
[714.869922] Starting subtest: psr2-cursor-plane-move
[714.872109] Starting dynamic subtest: eDP-1
[716.558653] Dynamic subtest eDP-1: SUCCESS (1.689s)
[716.561042] Subtest psr2-cursor-plane-move: SUCCESS (1.690s)
[717.364625] [103/133] (307s left) kms_vblank (ts-continuation-dpms-suspend)
[717.463264] Starting subtest: ts-continuation-dpms-suspend
[717.465513] Starting dynamic subtest: pipe-A-eDP-1
[734.586080] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.968s)
[734.604441] Starting dynamic subtest: pipe-D-eDP-1
[752.607089] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.511s)
[752.609407] Subtest ts-continuation-dpms-suspend: SUCCESS (4.482s)
[753.403909] [104/133] (271s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[753.507346] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[753.533154] Starting dynamic subtest: pipe-A-plane-0
[753.822217] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[753.836359] Starting dynamic subtest: pipe-A-plane-3
[754.056100] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[755.203397] Starting dynamic subtest: pipe-B-plane-0
[755.490797] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[755.501814] Starting dynamic subtest: pipe-B-plane-3
[755.746883] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[756.057618] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.547s)
[756.870123] [105/133] (268s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[756.958983] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[756.963314] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[757.058329] [106/133] (268s left) gen9_exec_parse (bb-oversize)
[757.115789] Subtest bb-oversize: SKIP (0.000s)
[757.183181] [107/133] (268s left) gem_mmap_gtt (basic-write-gtt)
[757.231344] Subtest basic-write-gtt: SKIP (0.000s)
[757.288148] [108/133] (268s left) kms_panel_fitting (legacy)
[757.373307] Starting subtest: legacy
[757.375604] Starting dynamic subtest: pipe-A-eDP-1
[757.913103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[757.942793] Starting dynamic subtest: pipe-B-eDP-1
[759.444865] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.510s)
[759.471710] Starting dynamic subtest: pipe-C-eDP-1
[760.957219] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.492s)
[760.984362] Starting dynamic subtest: pipe-D-eDP-1
[762.493758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.517s)
[762.496020] Subtest legacy: SUCCESS (5.119s)
[763.732343] [109/133] (261s left) syncobj_timeline (wait-delayed-signal)
[763.792147] Starting subtest: wait-delayed-signal
[763.895118] Subtest wait-delayed-signal: SUCCESS (0.104s)
[763.971105] [110/133] (261s left) perf_pmu (busy-accuracy-2)
[764.008985] Starting subtest: busy-accuracy-2
[764.011283] Starting dynamic subtest: rcs0
[767.052282] Dynamic subtest rcs0: SUCCESS (3.041s)
[767.065157] Starting dynamic subtest: bcs0
[770.108105] Dynamic subtest bcs0: SUCCESS (3.053s)
[770.120923] Starting dynamic subtest: vcs0
[773.154113] Dynamic subtest vcs0: SUCCESS (3.041s)
[773.167266] Starting dynamic subtest: vcs1
[776.203684] Dynamic subtest vcs1: SUCCESS (3.046s)
[776.216105] Starting dynamic subtest: vecs0
[779.248768] Dynamic subtest vecs0: SUCCESS (3.042s)
[779.259003] Starting dynamic subtest: ccs0
[782.308858] Dynamic subtest ccs0: SUCCESS (3.056s)
[782.311405] Subtest busy-accuracy-2: SUCCESS (18.291s)
[782.444406] [111/133] (243s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[782.536510] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[782.538486] Starting dynamic subtest: pipe-A-eDP-1
[783.732190] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.197s)
[783.745587] Starting dynamic subtest: pipe-B-eDP-1
[786.091720] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.357s)
[786.104036] Starting dynamic subtest: pipe-C-eDP-1
[788.392291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.299s)
[788.403661] Starting dynamic subtest: pipe-D-eDP-1
[790.714475] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.320s)
[790.716890] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.179s)
[791.884885] [112/133] (233s left) gem_ctx_persistence (heartbeat-close)
[791.941035] Starting subtest: heartbeat-close
[791.945850] Subtest heartbeat-close: SKIP (0.000s)
[792.044068] [113/133] (233s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[792.137943] Starting subtest: x-tiled-64bpp-rotate-180
[793.572108] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.434s)
[793.729834] [114/133] (231s left) gem_ctx_param (invalid-ctx-get)
[793.787578] Starting subtest: invalid-ctx-get
[793.789941] Subtest invalid-ctx-get: SUCCESS (0.000s)
[793.871622] [115/133] (231s left) kms_cursor_crc (cursor-random-32x32)
[794.023038] Starting subtest: cursor-random-32x32
[794.069760] Subtest cursor-random-32x32: SKIP (0.041s)
[794.333444] [116/133] (231s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[794.444268] Starting subtest: basic-flip-before-cursor-varying-size
[795.377330] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[796.225798] [117/133] (229s left) gem_userptr_blits (relocations)
[796.285857] Starting subtest: relocations
[796.290115] Subtest relocations: SKIP (0.001s)
[796.415296] [118/133] (229s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[796.507481] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[797.541831] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[797.664846] [119/133] (228s left) gem_spin_batch (user-each)
[797.747281] Starting subtest: user-each
[801.016457] Subtest user-each: SUCCESS (3.262s)
[801.649748] [120/133] (224s left) kms_cursor_edge_walk (256x256-top-edge)
[801.741898] Starting subtest: 256x256-top-edge
[801.744073] Starting dynamic subtest: pipe-A-eDP-1
[805.186422] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[805.196937] Starting dynamic subtest: pipe-D-eDP-1
[808.299460] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[808.301887] Subtest 256x256-top-edge: SUCCESS (6.555s)
[809.114636] [121/133] (216s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[809.220997] Starting subtest: 4-tiled-32bpp-rotate-180
[810.544985] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.323s)
[810.669529] [122/133] (215s left) gem_mmap_offset (clear-via-pagefault)
[810.722622] Starting subtest: clear-via-pagefault
[810.724314] Starting dynamic subtest: smem0
[842.714266] Dynamic subtest smem0: SUCCESS (31.975s)
[842.716376] Subtest clear-via-pagefault: SUCCESS (31.977s)
[842.848926] [123/133] (183s left) gem_userptr_blits (invalid-null-pointer)
[842.918573] Starting subtest: invalid-null-pointer
[842.920555] Subtest invalid-null-pointer: SUCCESS (0.001s)
[843.037072] [124/133] (183s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[843.123691] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[843.128114] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[843.217358] [125/133] (182s left) gem_ctx_shared (detached-shared-gtt)
[843.281653] Starting subtest: detached-shared-gtt
[845.435961] Subtest detached-shared-gtt: SUCCESS (2.151s)
[845.827825] [126/133] (180s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[845.937528] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[846.916090] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s)
[847.040928] [127/133] (179s left) kms_psr (fbc-pr-no-drrs)
[847.125029] Starting subtest: fbc-pr-no-drrs
[847.129138] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[847.197318] [128/133] (179s left) gem_create (create-ext-placement-sanity-check)
[847.360783] Starting subtest: create-ext-placement-sanity-check
[847.363223] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[847.480842] [129/133] (178s left) kms_properties (colorop-properties-legacy)
[847.565340] Starting subtest: colorop-properties-legacy
[847.567501] Starting dynamic subtest: pipe-A-eDP-1
[847.928509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s)
[847.939430] Starting dynamic subtest: pipe-B-eDP-1
[848.992748] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.063s)
[849.003614] Starting dynamic subtest: pipe-C-eDP-1
[850.024387] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.029s)
[850.037714] Starting dynamic subtest: pipe-D-eDP-1
[851.046017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.024s)
[851.048492] Subtest colorop-properties-legacy: SUCCESS (3.486s)
[851.856047] [130/133] (174s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[851.952345] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[856.415391] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.469s)
[857.559181] [131/133] (168s left) gem_ppgtt (shrink-vs-evict-pinned)
[857.632649] Starting subtest: shrink-vs-evict-pinned
[865.486628] Subtest shrink-vs-evict-pinned: SUCCESS (7.856s)
[865.582075] [132/133] (160s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[865.676714] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[865.681214] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[865.788874] [133/133] (160s left) kms_plane (plane-panning-bottom-right-suspend)
[865.886438] Starting subtest: plane-panning-bottom-right-suspend
[865.888646] Starting dynamic subtest: pipe-A
[883.448017] Dynamic subtest pipe-A: SUCCESS (3.648s)
[883.460385] Starting dynamic subtest: pipe-B
[902.435395] Dynamic subtest pipe-B: SUCCESS (3.565s)
[902.438118] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.216s)
[903.233017] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: api_intel_allocator
results: parsing output: 3/ for test: i915_selftest
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_pm_rpm
results: parsing output: 14/ for test: kms_dirtyfb
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_nop
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: gem_partial_pwrite_pread
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_getfb
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_color_pipeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_hdmi_inject
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: kms_chamelium_edid
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_plane_cursor
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_vm_create
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: syncobj_basic
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_draw_crc
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_sequence
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: gem_exec_await
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_tiled_pread_pwrite
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: intel_hwmon
results: parsing output: 79/ for test: device_reset
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: kms_pm_backlight
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_ctx_create
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_panel_fitting
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_spin_batch
results: parsing output: 119/ for test: kms_cursor_edge_walk
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_properties
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_ppgtt
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane
Done.