[59.320773] Initializing watchdogs
[59.320821]   /dev/watchdog0
[59.335717] [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]
[59.340186] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.342406] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.345923] [001/133] (960s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[59.471432] Starting subtest: bo-too-small-due-to-tiling
[59.476108] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[59.587562] [002/133] (960s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[59.683790] Starting subtest: fbc-dirtyfb-ioctl
[59.686496] Starting dynamic subtest: A-eDP-1
[62.266352] Dynamic subtest A-eDP-1: SUCCESS (2.580s)
[62.268514] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.581s)
[63.059522] [003/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[63.175778] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[63.179851] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[63.266503] [004/133] (956s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[63.360150] Starting subtest: fbc-rgb565-draw-blt
[67.918070] Subtest fbc-rgb565-draw-blt: SUCCESS (4.558s)
[69.076778] [005/133] (950s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[69.178473] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[69.180924] Starting dynamic subtest: pipe-A-eDP-1
[69.204813] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[69.214352] Starting dynamic subtest: pipe-B-eDP-1
[69.239980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[69.248045] Starting dynamic subtest: pipe-C-eDP-1
[69.268301] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.275633] Starting dynamic subtest: pipe-D-eDP-1
[69.296989] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.301291] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[71.422200] [006/133] (948s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[71.540155] Starting subtest: cursorA-vs-flipA-varying-size
[82.739959] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.197s)
[83.565180] [007/133] (936s left) perf (non-sampling-read-error)
[83.687355] Starting subtest: non-sampling-read-error
[83.696630] Subtest non-sampling-read-error: SUCCESS (0.008s)
[83.741370] [008/133] (936s left) gem_exec_reloc (basic-gtt)
[83.792201] Subtest basic-gtt: SKIP (0.000s)
[83.858156] [009/133] (936s left) gem_exec_reloc (basic-cpu-gtt)
[83.911359] Subtest basic-cpu-gtt: SKIP (0.000s)
[83.968394] [010/133] (936s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[84.065713] Starting subtest: fbc-pr-cursor-plane-update-sf
[84.069649] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[84.133689] [011/133] (936s left) perf (invalid-remove-userspace-config)
[84.229041] Starting subtest: invalid-remove-userspace-config
[84.241951] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[84.283862] [012/133] (935s left) i915_pm_rpm (system-suspend-execbuf)
[86.007749] Starting subtest: system-suspend-execbuf
[146.331662] Subtest system-suspend-execbuf: SUCCESS (44.948s)
[146.729556] [013/133] (873s left) gem_exec_balancer (nohangcheck)
[147.000247] Starting subtest: nohangcheck
[147.916507] Subtest nohangcheck: SUCCESS (0.914s)
[148.016572] [014/133] (872s left) gem_exec_fence (syncobj-timeline-export)
[148.584150] Starting subtest: syncobj-timeline-export
[148.590175] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[150.290982] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[150.294529] [015/133] (870s left) kms_pm_rpm (pm-caching)
[152.328863] Starting subtest: pm-caching
[152.335227] Subtest pm-caching: SKIP (0.000s)
[152.716577] [016/133] (867s left) gem_spin_batch (resubmit-all)
[152.771287] Starting subtest: resubmit-all
[152.773785] Starting dynamic subtest: rcs0
[152.785738] Dynamic subtest rcs0: SUCCESS (0.015s)
[152.794880] Starting dynamic subtest: bcs0
[152.797173] Dynamic subtest bcs0: SUCCESS (0.003s)
[152.805521] Starting dynamic subtest: vcs0
[152.807650] Dynamic subtest vcs0: SUCCESS (0.002s)
[152.815692] Starting dynamic subtest: vcs1
[152.817875] Dynamic subtest vcs1: SUCCESS (0.002s)
[152.825930] Starting dynamic subtest: vecs0
[152.828072] Dynamic subtest vecs0: SUCCESS (0.001s)
[152.836385] Starting dynamic subtest: ccs0
[152.838502] Dynamic subtest ccs0: SUCCESS (0.002s)
[152.840623] Subtest resubmit-all: SUCCESS (0.028s)
[154.179897] [017/133] (866s left) kms_pm_backlight (fade)
[154.266341] Starting subtest: fade
[154.316329] Starting dynamic subtest: eDP-1
[156.797295] Dynamic subtest eDP-1: SUCCESS (2.478s)
[156.799607] Subtest fade: SUCCESS (2.530s)
[157.625219] [018/133] (862s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[157.719141] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[157.721426] Starting dynamic subtest: pipe-A
[157.783231] Dynamic subtest pipe-A: SUCCESS (0.066s)
[157.793783] Starting dynamic subtest: pipe-B
[158.957376] Dynamic subtest pipe-B: SUCCESS (1.173s)
[158.967232] Starting dynamic subtest: pipe-C
[160.067565] Dynamic subtest pipe-C: SUCCESS (1.108s)
[160.076156] Starting dynamic subtest: pipe-D
[161.195202] Dynamic subtest pipe-D: SUCCESS (1.126s)
[161.197644] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.477s)
[162.361238] [019/133] (858s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[162.479684] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[162.484482] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[162.592586] [020/133] (858s left) gem_mmap_gtt (basic-write-read)
[162.655730] Subtest basic-write-read: SKIP (0.000s)
[162.726458] [021/133] (857s left) kms_invalid_mode (clock-too-high)
[162.825905] Starting subtest: clock-too-high
[162.828179] Starting dynamic subtest: pipe-A-eDP-1
[162.832666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.842656] Starting dynamic subtest: pipe-B-eDP-1
[162.846819] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.855206] Starting dynamic subtest: pipe-C-eDP-1
[162.859496] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.867732] Starting dynamic subtest: pipe-D-eDP-1
[162.872172] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.876571] Subtest clock-too-high: SKIP (0.003s)
[162.915345] [022/133] (857s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[163.015000] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[163.019517] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[163.120133] [023/133] (857s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[163.174412] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[163.176771] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[163.276426] [024/133] (857s left) gem_ctx_persistence (engines-hostile)
[163.344803] Starting subtest: engines-hostile
[163.346711] Starting dynamic subtest: rcs0
[163.492477] Dynamic subtest rcs0: SUCCESS (0.147s)
[163.503377] Starting dynamic subtest: bcs0
[163.585399] Dynamic subtest bcs0: SUCCESS (0.092s)
[163.596508] Starting dynamic subtest: vcs0
[163.685664] Dynamic subtest vcs0: SUCCESS (0.099s)
[163.695247] Starting dynamic subtest: vcs1
[163.786650] Dynamic subtest vcs1: SUCCESS (0.100s)
[163.800116] Starting dynamic subtest: vecs0
[163.877751] Dynamic subtest vecs0: SUCCESS (0.090s)
[163.888733] Starting dynamic subtest: ccs0
[163.974010] Dynamic subtest ccs0: SUCCESS (0.095s)
[163.976367] Subtest engines-hostile: SUCCESS (0.629s)
[164.063848] [025/133] (856s left) gem_exec_whisper (basic-fds-forked)
[164.124371] Starting subtest: basic-fds-forked
[187.928223] Subtest basic-fds-forked: SUCCESS (23.786s)
[188.110039] [026/133] (832s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[188.158072] Starting subtest: etime-single-wait-available-unsubmitted
[188.262833] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[188.340826] [027/133] (832s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[188.445379] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[188.449600] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[188.515250] [028/133] (832s left) gem_exec_schedule (pi-common)
[188.704281] Starting subtest: pi-common
[188.706202] Starting dynamic subtest: rcs0
[188.740539] Dynamic subtest rcs0: SUCCESS (0.038s)
[188.749336] Starting dynamic subtest: bcs0
[188.791201] Dynamic subtest bcs0: SUCCESS (0.050s)
[188.802172] Starting dynamic subtest: vcs0
[188.832265] Dynamic subtest vcs0: SUCCESS (0.040s)
[188.841878] Starting dynamic subtest: vcs1
[188.866694] Dynamic subtest vcs1: SUCCESS (0.034s)
[188.879144] Starting dynamic subtest: vecs0
[188.897128] Dynamic subtest vecs0: SUCCESS (0.030s)
[188.909406] Starting dynamic subtest: ccs0
[188.926605] Dynamic subtest ccs0: SUCCESS (0.029s)
[188.928890] Subtest pi-common: SUCCESS (0.225s)
[189.145058] [029/133] (831s left) kms_cursor_crc (cursor-sliding-256x85)
[189.420957] Starting subtest: cursor-sliding-256x85
[189.470275] Subtest cursor-sliding-256x85: SKIP (0.043s)
[189.639779] [030/133] (831s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[189.740012] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[189.742246] Starting dynamic subtest: pipe-A-eDP-1
[189.765959] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[189.777714] Starting dynamic subtest: pipe-B-eDP-1
[189.800944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[189.811811] Starting dynamic subtest: pipe-C-eDP-1
[189.834773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[189.843428] Starting dynamic subtest: pipe-D-eDP-1
[189.867108] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[189.871075] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[192.037960] [031/133] (829s left) vgem_basic (bad-fence)
[192.080171] Starting subtest: bad-fence
[192.082413] Subtest bad-fence: SUCCESS (0.000s)
[192.139942] [032/133] (828s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[192.235605] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[192.244726] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[192.361417] [033/133] (828s left) gem_ccs (ctrl-surf-copy)
[192.437912] Starting subtest: ctrl-surf-copy
[192.442008] Subtest ctrl-surf-copy: SKIP (0.000s)
[192.541471] [034/133] (828s left) gem_softpin (noreloc)
[192.598000] Starting subtest: noreloc
[198.022536] Subtest noreloc: SUCCESS (5.420s)
[198.166358] [035/133] (823s left) gem_create (hog-create)
[198.225229] Starting subtest: hog-create
[198.227945] Starting dynamic subtest: smem0
[231.191952] Dynamic subtest smem0: SUCCESS (32.981s)
[231.194518] Subtest hog-create: SUCCESS (32.982s)
[231.378861] [036/133] (789s left) gem_mmap_gtt (hang-user)
[231.427949] Subtest hang-user: SKIP (0.000s)
[231.487229] [037/133] (789s left) kms_frontbuffer_tracking (psr-slowdraw)
[231.585973] Starting subtest: psr-slowdraw
[256.825345] Subtest psr-slowdraw: SUCCESS (25.244s)
[256.939520] [038/133] (764s left) kms_color (ctm-negative)
[257.036398] Starting subtest: ctm-negative
[257.038317] Starting dynamic subtest: pipe-A-eDP-1
[257.779040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[257.789123] Starting dynamic subtest: pipe-B-eDP-1
[259.247852] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s)
[259.257792] Starting dynamic subtest: pipe-C-eDP-1
[260.634128] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[260.644267] Starting dynamic subtest: pipe-D-eDP-1
[261.959998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[261.962363] Subtest ctm-negative: SUCCESS (4.924s)
[262.760040] [039/133] (758s left) kms_plane (pixel-format-y-tiled-modifier)
[262.852398] Starting subtest: pixel-format-y-tiled-modifier
[262.856528] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[262.935187] [040/133] (758s left) gem_userptr_blits (invalid-null-pointer)
[263.009559] Starting subtest: invalid-null-pointer
[263.012031] Subtest invalid-null-pointer: SUCCESS (0.003s)
[263.136492] [041/133] (758s left) kms_flip (bo-too-big-interruptible)
[263.231746] Starting subtest: bo-too-big-interruptible
[263.234127] Starting dynamic subtest: A-eDP1
[264.509856] Dynamic subtest A-eDP1: SUCCESS (1.278s)
[264.519354] Starting dynamic subtest: B-eDP1
[265.744182] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[265.753633] Starting dynamic subtest: C-eDP1
[266.989928] Dynamic subtest C-eDP1: SUCCESS (1.244s)
[266.999978] Starting dynamic subtest: D-eDP1
[268.326148] Dynamic subtest D-eDP1: SUCCESS (1.335s)
[268.331794] Subtest bo-too-big-interruptible: SUCCESS (5.100s)
[269.521581] [042/133] (752s left) sw_sync (sync_multi_consumer_producer)
[269.554696] Starting subtest: sync_multi_consumer_producer
[269.845445] Subtest sync_multi_consumer_producer: SUCCESS (0.293s)
[269.908621] [043/133] (751s left) perf_pmu (busy-accuracy-98)
[269.946627] Starting subtest: busy-accuracy-98
[269.949030] Starting dynamic subtest: rcs0
[272.981076] Dynamic subtest rcs0: SUCCESS (3.033s)
[272.992796] Starting dynamic subtest: bcs0
[276.035688] Dynamic subtest bcs0: SUCCESS (3.052s)
[276.047258] Starting dynamic subtest: vcs0
[279.081494] Dynamic subtest vcs0: SUCCESS (3.043s)
[279.092991] Starting dynamic subtest: vcs1
[282.123568] Dynamic subtest vcs1: SUCCESS (3.039s)
[282.135073] Starting dynamic subtest: vecs0
[285.167297] Dynamic subtest vecs0: SUCCESS (3.041s)
[285.179446] Starting dynamic subtest: ccs0
[288.219510] Dynamic subtest ccs0: SUCCESS (3.050s)
[288.221998] Subtest busy-accuracy-98: SUCCESS (18.270s)
[288.336864] [044/133] (733s left) gem_fence_thrash (bo-write-verify-threaded-none)
[288.379285] Starting subtest: bo-write-verify-threaded-none
[288.405136] Subtest bo-write-verify-threaded-none: SKIP (0.022s)
[288.466854] [045/133] (733s left) gem_exec_schedule (u-lateslice)
[288.545499] Starting subtest: u-lateslice
[288.548248] Starting dynamic subtest: rcs0
[288.565041] Dynamic subtest rcs0: SUCCESS (0.027s)
[288.576588] Starting dynamic subtest: bcs0
[288.589145] Dynamic subtest bcs0: SUCCESS (0.023s)
[288.598558] Starting dynamic subtest: vcs0
[288.611038] Dynamic subtest vcs0: SUCCESS (0.022s)
[288.620364] Starting dynamic subtest: vcs1
[288.632852] Dynamic subtest vcs1: SUCCESS (0.021s)
[288.642025] Starting dynamic subtest: vecs0
[288.658047] Dynamic subtest vecs0: SUCCESS (0.025s)
[288.667173] Starting dynamic subtest: ccs0
[288.683586] Dynamic subtest ccs0: SUCCESS (0.025s)
[288.685796] Subtest u-lateslice: SUCCESS (0.147s)
[290.286583] [046/133] (731s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[290.346700] Subtest writes-after-reads-snoop: SKIP (0.000s)
[290.423897] [047/133] (731s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[290.476004] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[290.478330] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[290.613546] [048/133] (731s left) gem_exec_suspend (basic-s4-devices)
[290.676953] Starting subtest: basic-S4-devices
[290.679352] Starting dynamic subtest: smem
[302.234721] Dynamic subtest smem: SUCCESS (11.552s)
[302.237523] Subtest basic-S4-devices: SUCCESS (11.554s)
[311.456604] [049/133] (719s left) syncobj_timeline (transfer-timeline-point)
[311.537630] Starting subtest: transfer-timeline-point
[311.540024] Subtest transfer-timeline-point: SUCCESS (0.000s)
[311.641367] [050/133] (719s left) i915_suspend (forcewake)
[311.705949] Starting subtest: forcewake
[343.922446] Subtest forcewake: SUCCESS (3.086s)
[352.006099] [051/133] (686s left) gem_eio (in-flight-external)
[352.266842] Starting subtest: in-flight-external
[353.390459] Subtest in-flight-external: SUCCESS (1.124s)
[353.524227] [052/133] (685s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[353.652342] Starting subtest: cursorA-vs-flipA-toggle
[364.861454] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.162s)
[365.663564] [053/133] (673s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[365.769580] Starting subtest: y-tiled-32bpp-rotate-0
[365.773883] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[365.857668] [054/133] (673s left) kms_chamelium_hpd (dp-hpd-fast)
[366.247175] Subtest dp-hpd-fast: SKIP (0.000s)
[367.083561] [055/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[367.182435] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[367.186704] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.284065] [056/133] (671s left) prime_vgem (busy)
[367.349938] Starting subtest: busy
[367.351840] Starting dynamic subtest: rcs0
[367.412006] Dynamic subtest rcs0: SUCCESS (0.064s)
[367.422084] Starting dynamic subtest: bcs0
[367.469486] Dynamic subtest bcs0: SUCCESS (0.056s)
[367.479451] Starting dynamic subtest: vcs0
[367.516086] Dynamic subtest vcs0: SUCCESS (0.046s)
[367.525896] Starting dynamic subtest: vcs1
[367.561825] Dynamic subtest vcs1: SUCCESS (0.045s)
[367.571862] Starting dynamic subtest: vecs0
[367.608104] Dynamic subtest vecs0: SUCCESS (0.045s)
[367.618673] Starting dynamic subtest: ccs0
[367.654466] Dynamic subtest ccs0: SUCCESS (0.045s)
[367.656606] Subtest busy: SUCCESS (0.307s)
[367.779644] [057/133] (671s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[367.849909] Starting subtest: yf-tiled-to-vebox-y-tiled
[367.854550] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[368.039309] [058/133] (671s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[368.132017] Starting subtest: fbc-modesetfrombusy
[371.875353] Subtest fbc-modesetfrombusy: SUCCESS (3.740s)
[373.065402] [059/133] (666s left) gem_ctx_persistence (processes)
[373.124493] Starting subtest: processes
[374.292340] Subtest processes: SUCCESS (1.166s)
[374.387511] [060/133] (665s left) gem_eio (kms)
[374.663239] Starting subtest: kms
[395.448962] Subtest kms: SUCCESS (20.776s)
[396.642364] [061/133] (642s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[396.743160] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[396.747652] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[396.831185] [062/133] (642s left) kms_vblank (query-busy)
[396.916725] Starting subtest: query-busy
[396.918544] Starting dynamic subtest: pipe-A-eDP-1
[398.790101] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[398.805448] Starting dynamic subtest: pipe-D-eDP-1
[401.380797] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.586s)
[401.382967] Subtest query-busy: SUCCESS (4.464s)
[402.180434] [063/133] (637s left) gen7_exec_parse (basic-allocation)
[402.257885] Subtest basic-allocation: SKIP (0.000s)
[402.332640] [064/133] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[402.446144] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[402.450503] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[402.554514] [065/133] (637s left) dmabuf_sync_file (export-basic)
[402.617173] Starting subtest: export-basic
[402.619464] Subtest export-basic: SUCCESS (0.001s)
[402.673773] [066/133] (636s left) kms_psr (fbc-psr2-primary-render)
[402.773709] Starting subtest: fbc-psr2-primary-render
[402.775846] Starting dynamic subtest: eDP-1
[402.779672] Dynamic subtest eDP-1: SKIP (0.000s)
[402.783495] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[402.858428] [067/133] (636s left) gem_exercise_blt (fast-copy-emit)
[402.921689] Starting subtest: fast-copy-emit
[402.924161] Starting dynamic subtest: linear-smem-smem-emit
[402.942410] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[402.952904] Starting dynamic subtest: xmajor-smem-smem-emit
[402.959911] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[402.969836] Starting dynamic subtest: tile4-smem-smem-emit
[402.977413] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[402.988771] Starting dynamic subtest: tile64-smem-smem-emit
[402.993975] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[402.996402] Subtest fast-copy-emit: SUCCESS (0.075s)
[403.109279] [068/133] (636s left) i915_getparams_basic (basic-subslice-total)
[403.160640] Starting subtest: basic-subslice-total
[403.164267] Subtest basic-subslice-total: SUCCESS (0.000s)
[403.247135] [069/133] (636s left) kms_content_protection (dp-mst-type-0-hdcp14)
[403.389546] Starting subtest: dp-mst-type-0-hdcp14
[403.393422] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[403.511958] [070/133] (636s left) kms_vblank (ts-continuation-modeset)
[403.596714] Starting subtest: ts-continuation-modeset
[403.598375] Starting dynamic subtest: pipe-A-eDP-1
[405.052167] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.456s)
[405.068883] Starting dynamic subtest: pipe-D-eDP-1
[407.212762] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s)
[407.215350] Subtest ts-continuation-modeset: SUCCESS (3.618s)
[408.013015] [071/133] (631s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[408.064325] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[408.172824] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[408.263586] [072/133] (631s left) gem_exec_fence (expired-history)
[408.701552] Starting subtest: expired-history
[416.031487] Subtest expired-history: SUCCESS (7.328s)
[416.649398] [073/133] (623s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[416.764889] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[417.914025] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.147s)
[418.055057] [074/133] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[418.180353] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[418.184030] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[418.292970] [075/133] (621s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[418.391711] Starting subtest: psr-rgb565-draw-mmap-cpu
[425.228598] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.839s)
[425.333242] [076/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[425.438000] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[425.441874] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[425.530160] [077/133] (614s left) sw_sync (sync_busy_fork)
[425.569318] Starting subtest: sync_busy_fork
[426.578393] Subtest sync_busy_fork: SUCCESS (1.010s)
[426.657600] [078/133] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[426.762444] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[433.650773] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.888s)
[433.769026] [079/133] (606s left) kms_draw_crc (draw-method-mmap-wc)
[433.871044] Starting subtest: draw-method-mmap-wc
[433.872889] Starting dynamic subtest: xrgb8888-untiled
[434.113715] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[434.124110] Starting dynamic subtest: rgb565-untiled
[434.336517] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[434.346756] Starting dynamic subtest: xrgb2101010-untiled
[434.558795] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[434.569345] Starting dynamic subtest: xbgr16161616f-untiled
[434.780418] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[434.790368] Starting dynamic subtest: xrgb8888-xtiled
[434.903084] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[434.918845] Starting dynamic subtest: rgb565-xtiled
[435.047389] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s)
[435.057509] Starting dynamic subtest: xrgb2101010-xtiled
[435.182769] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[435.192572] Starting dynamic subtest: xbgr16161616f-xtiled
[435.314465] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[435.326521] Starting dynamic subtest: xrgb8888-4tiled
[435.469587] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[435.479846] Starting dynamic subtest: rgb565-4tiled
[435.614129] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[435.624135] Starting dynamic subtest: xrgb2101010-4tiled
[435.759004] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[435.770836] Starting dynamic subtest: xbgr16161616f-4tiled
[435.937187] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.175s)
[435.939101] Subtest draw-method-mmap-wc: SUCCESS (2.069s)
[436.043303] [080/133] (604s left) kms_flip_tiling (flip-change-tiling)
[436.137890] Starting subtest: flip-change-tiling
[436.139772] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[436.334510] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.197s)
[436.347346] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[436.469630] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[436.482700] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[436.602834] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[436.615982] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[436.746547] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[436.759091] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[436.890339] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[436.903708] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[437.035098] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[437.048730] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[437.168582] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[437.180852] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[437.279892] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[437.292831] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[437.414422] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[437.427971] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[437.557661] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[437.571538] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[437.701495] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[437.714742] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[437.845976] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[437.858794] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[437.980835] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[437.993826] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[438.125696] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.141s)
[438.138538] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[438.235331] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[438.247097] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[438.380501] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[438.393164] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[438.524612] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[438.537830] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[438.668646] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[438.685454] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[438.813676] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[438.827143] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[438.957967] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[438.970745] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[439.102517] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[439.115689] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[439.224422] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[439.237403] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[439.368694] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[439.381486] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[439.513113] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[439.526305] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[439.657752] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[439.672957] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[439.802043] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[439.816384] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[439.946568] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[439.961849] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[440.118833] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.169s)
[440.131704] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[440.241369] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[440.255836] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[440.398773] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.153s)
[440.412142] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[440.541221] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[440.553717] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[440.686140] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[440.698388] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[440.841854] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.153s)
[440.854705] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[440.985856] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[440.999251] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[441.130666] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[441.146439] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[441.280211] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.147s)
[441.337991] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[442.575985] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.250s)
[442.589384] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[442.710701] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[442.723515] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[442.843989] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[442.856819] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[442.987365] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[443.000715] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[443.131508] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[443.144557] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[443.276130] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[443.289168] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[443.409661] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[443.421838] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[443.520733] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[443.533745] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[443.656121] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[443.678476] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[443.798798] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.141s)
[443.812951] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[443.943304] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[443.958963] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[444.087411] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[444.100862] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[444.221028] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[444.238585] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[444.366841] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.143s)
[444.380315] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[444.476755] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[444.491818] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[444.622260] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[444.637076] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[444.766188] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.141s)
[444.779990] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[444.909847] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[444.922793] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[445.043517] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[445.056312] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[445.188241] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[445.201792] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[445.332753] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[445.346103] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[445.455267] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[445.468320] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[445.599005] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[445.613542] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[445.743214] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[445.756368] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[445.887419] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[445.902574] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[446.032688] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[446.049004] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[446.177008] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[446.194070] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[446.321009] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[446.336846] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[446.454603] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[446.466815] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[446.599493] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[446.612697] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[446.743412] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[446.759033] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[446.888270] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[446.901842] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[447.032717] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[447.046028] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[447.188093] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s)
[447.204207] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[447.360571] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.170s)
[447.376792] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[447.482570] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[447.544887] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[448.818817] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.290s)
[448.832387] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[448.918293] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[448.931129] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[449.018504] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[449.031591] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[449.129682] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[449.141699] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[449.240648] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[449.260716] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[449.351868] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[449.365856] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[449.451903] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[449.464519] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[449.552329] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[449.564505] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[449.652555] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[449.665103] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[449.763120] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[449.775813] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[449.873884] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[449.886992] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[449.985043] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[449.996813] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[450.084847] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[450.097527] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[450.185345] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[450.197831] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[450.285670] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[450.298921] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[450.396630] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[450.409283] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[450.507477] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[450.521954] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[450.618611] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[450.631191] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[450.730001] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[450.743858] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[450.841601] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[450.854154] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[450.952377] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[450.973402] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[451.063561] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[451.077945] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[451.213062] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.147s)
[451.225543] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[451.363028] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.148s)
[451.376087] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[451.473897] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[451.487038] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[451.584854] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[451.597012] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[451.696243] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[451.708227] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[451.807369] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[451.819817] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[451.918605] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[451.944998] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[452.029924] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[452.043176] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[452.140855] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[452.153920] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[452.252070] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[452.265148] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[452.362982] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[452.375751] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[452.474386] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[452.487618] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[452.585181] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[452.603930] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[452.696914] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[452.739276] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[453.959348] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.228s)
[453.972560] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[454.070437] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[454.085433] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[454.192336] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.118s)
[454.207810] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[454.303234] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.108s)
[454.315894] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[454.414442] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[454.425107] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[454.525392] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[454.540433] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[454.636872] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.108s)
[454.655503] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[454.736977] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[454.749547] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[454.836863] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[454.849507] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[454.947536] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[454.960308] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[455.058132] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[455.070692] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[455.169070] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[455.181661] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[455.269455] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[455.282559] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[455.369838] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[455.382628] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[455.469595] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[455.482529] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[455.580493] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[455.593912] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[455.691062] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[455.703368] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[455.802461] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[455.814612] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[455.913693] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[455.927759] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[456.025334] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.108s)
[456.041571] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[456.136477] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[456.149548] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[456.258120] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.120s)
[456.271358] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[456.368828] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[456.380956] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[456.480220] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[456.492606] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[456.590999] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[456.603186] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[456.701915] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[456.714432] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[456.814260] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[456.827012] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[456.925389] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[456.938685] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[457.037157] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[457.050508] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[457.146804] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[457.159670] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[457.257661] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[457.272898] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[457.369344] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[457.386247] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[457.479700] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[457.493495] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[457.601980] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.121s)
[457.616370] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[457.712928] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[457.725713] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[457.824226] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[457.857297] Subtest flip-change-tiling: SUCCESS (21.716s)
[459.061832] [081/133] (581s left) gem_mmap_wc (read)
[459.133425] Subtest read: SKIP (0.000s)
[459.203820] [082/133] (581s left) syncobj_wait (wait-for-submit-delayed-submit)
[459.257625] Starting subtest: wait-for-submit-delayed-submit
[459.358847] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[459.456476] [083/133] (580s left) api_intel_allocator (reserve-simple)
[459.515266] Starting subtest: reserve-simple
[459.517729] Subtest reserve-simple: SUCCESS (0.003s)
[459.639394] [084/133] (580s left) gem_exec_parallel (fds)
[459.711405] Starting subtest: fds
[459.713833] Starting dynamic subtest: rcs0
[462.841474] Dynamic subtest rcs0: SUCCESS (3.128s)
[462.852909] Starting dynamic subtest: bcs0
[467.339742] Dynamic subtest bcs0: SUCCESS (4.497s)
[467.352939] Starting dynamic subtest: vcs0
[471.576010] Dynamic subtest vcs0: SUCCESS (4.235s)
[471.586402] Starting dynamic subtest: vcs1
[475.660094] Dynamic subtest vcs1: SUCCESS (4.082s)
[475.672062] Starting dynamic subtest: vecs0
[479.553055] Dynamic subtest vecs0: SUCCESS (3.891s)
[479.566337] Starting dynamic subtest: ccs0
[484.145545] Dynamic subtest ccs0: SUCCESS (4.590s)
[484.148423] Subtest fds: SUCCESS (24.435s)
[484.340908] [085/133] (556s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[484.431738] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[484.434060] Starting dynamic subtest: pipe-A-eDP-1
[484.492107] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[484.504406] Starting dynamic subtest: pipe-B-eDP-1
[484.561942] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[484.575472] Starting dynamic subtest: pipe-C-eDP-1
[484.632309] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[484.643823] Starting dynamic subtest: pipe-D-eDP-1
[484.701215] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[484.705813] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[486.640020] [086/133] (553s left) gem_exec_fence (syncobj-timeline-wait)
[487.208288] Starting subtest: syncobj-timeline-wait
[488.350530] Subtest syncobj-timeline-wait: SUCCESS (1.142s)
[490.376532] [087/133] (550s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[490.474557] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[490.476836] Starting dynamic subtest: pipe-A-eDP-1
[490.498754] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[490.511494] Starting dynamic subtest: pipe-B-eDP-1
[490.532889] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[490.543095] Starting dynamic subtest: pipe-C-eDP-1
[490.564961] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[490.575088] Starting dynamic subtest: pipe-D-eDP-1
[490.598034] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[490.602033] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[492.706126] [088/133] (547s left) gem_lmem_swapping (verify-random)
[492.753953] Subtest verify-random: SKIP (0.000s)
[492.802693] [089/133] (547s left) kms_atomic (plane-invalid-params-fence)
[492.900974] Starting subtest: plane-invalid-params-fence
[492.903256] Starting dynamic subtest: pipe-A-eDP-1
[493.261697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[493.263635] Subtest plane-invalid-params-fence: SUCCESS (0.361s)
[494.136141] [090/133] (546s left) gem_fenced_exec_thrash (2-spare-fences)
[494.200270] Subtest 2-spare-fences: SKIP (0.000s)
[494.279040] [091/133] (546s left) kms_getfb (getfb2-into-addfb2)
[494.374972] Starting subtest: getfb2-into-addfb2
[494.377083] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[494.473478] [092/133] (546s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[494.577506] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[494.579870] Starting dynamic subtest: pipe-A-eDP-1
[494.708643] Dynamic subtest pipe-A-eDP-1: SKIP (0.134s)
[494.721686] Starting dynamic subtest: pipe-B-eDP-1
[495.905664] Dynamic subtest pipe-B-eDP-1: SKIP (1.194s)
[495.909940] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.331s)
[497.107632] [093/133] (543s left) api_intel_bb (destroy-bb)
[497.178308] Starting subtest: destroy-bb
[497.192043] Subtest destroy-bb: SUCCESS (0.014s)
[497.306974] [094/133] (543s left) kms_3d (basic)
[497.360172] Starting subtest: basic
[499.341408] Subtest basic: SUCCESS (1.982s)
[499.823643] [095/133] (541s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[499.930860] Starting subtest: psr2-plane-move-sf-dmg-area
[499.933858] Starting dynamic subtest: pipe-A-eDP-1
[504.405271] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.482s)
[504.416518] Starting dynamic subtest: pipe-B-eDP-1
[509.608500] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.199s)
[509.610813] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.684s)
[510.453501] [096/133] (530s left) gen9_exec_parse (batch-without-end)
[510.509605] Subtest batch-without-end: SKIP (0.000s)
[510.584676] [097/133] (530s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[510.640892] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[510.701198] [098/133] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[510.787966] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[517.764222] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.976s)
[517.907702] [099/133] (523s left) kms_cursor_crc (cursor-offscreen-256x85)
[518.198846] Starting subtest: cursor-offscreen-256x85
[518.245383] Subtest cursor-offscreen-256x85: SKIP (0.044s)
[518.413458] [100/133] (522s left) kms_psr (psr-sprite-mmap-cpu)
[518.490838] Starting subtest: psr-sprite-mmap-cpu
[518.492938] Starting dynamic subtest: eDP-1
[520.230889] Dynamic subtest eDP-1: SUCCESS (1.739s)
[520.233027] Subtest psr-sprite-mmap-cpu: SUCCESS (1.740s)
[521.042811] [101/133] (520s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[521.144629] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[522.212195] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.067s)
[522.354957] [102/133] (518s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[522.457992] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[522.460273] Starting dynamic subtest: pipe-A-eDP-1
[522.479495] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[522.489716] Starting dynamic subtest: pipe-B-eDP-1
[522.508004] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[522.517449] Starting dynamic subtest: pipe-C-eDP-1
[522.534547] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[522.544086] Starting dynamic subtest: pipe-D-eDP-1
[522.562094] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[522.565624] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.012s)
[524.747678] [103/133] (516s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[524.842631] Starting subtest: pixel-format-linear-modifier-source-clamping
[524.869007] Starting dynamic subtest: pipe-A-plane-0
[528.580368] Dynamic subtest pipe-A-plane-0: SUCCESS (3.711s)
[528.590766] Starting dynamic subtest: pipe-A-plane-3
[530.413882] Dynamic subtest pipe-A-plane-3: SUCCESS (1.833s)
[531.512796] Starting dynamic subtest: pipe-B-plane-0
[535.103929] Dynamic subtest pipe-B-plane-0: SUCCESS (3.600s)
[535.118355] Starting dynamic subtest: pipe-B-plane-3
[536.915371] Dynamic subtest pipe-B-plane-3: SUCCESS (1.809s)
[537.249361] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.405s)
[538.079090] [104/133] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[538.188679] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[538.192976] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[538.287180] [105/133] (503s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[538.380037] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[538.382333] Starting dynamic subtest: pipe-A-default-mode
[541.101850] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[541.104372] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.723s)
[541.960586] [106/133] (499s left) kms_chamelium_frames (hdmi-crc-multiple)
[542.356138] Subtest hdmi-crc-multiple: SKIP (0.000s)
[543.136370] [107/133] (498s left) syncobj_wait (multi-wait-all-submitted)
[543.190490] Starting subtest: multi-wait-all-submitted
[543.292541] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[543.373019] [108/133] (498s left) kms_psr (psr2-cursor-mmap-gtt)
[543.465043] Starting subtest: psr2-cursor-mmap-gtt
[543.467379] Starting dynamic subtest: eDP-1
[545.184797] Dynamic subtest eDP-1: SUCCESS (1.721s)
[545.187230] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.722s)
[546.065389] [109/133] (495s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[546.159960] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[546.164480] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[546.247680] [110/133] (495s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[546.335030] Starting subtest: plane-all-transition-nonblocking-fencing
[546.337329] Starting dynamic subtest: pipe-A-eDP-1
[548.830127] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[549.139926] Starting dynamic subtest: pipe-B-eDP-1
[552.358561] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.229s)
[552.660516] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.324s)
[553.457611] [111/133] (488s left) syncobj_timeline (invalid-query-illegal-handle)
[553.524303] Starting subtest: invalid-query-illegal-handle
[553.526242] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[553.620494] [112/133] (488s left) prime_vgem (basic-read)
[553.699274] Starting subtest: basic-read
[553.740045] Subtest basic-read: SKIP (0.041s)
[553.878485] [113/133] (487s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[553.971971] Starting subtest: disable-crc-after-crtc
[553.974179] Starting dynamic subtest: pipe-A-eDP-1
[555.671188] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.700s)
[555.682636] Starting dynamic subtest: pipe-B-eDP-1
[558.078290] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.402s)
[558.089738] Starting dynamic subtest: pipe-C-eDP-1
[560.456449] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.378s)
[560.468665] Starting dynamic subtest: pipe-D-eDP-1
[562.765387] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.307s)
[562.767799] Subtest disable-crc-after-crtc: SUCCESS (8.793s)
[563.552855] [114/133] (478s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[563.615238] Starting subtest: invalid-bsd1-flag-on-vebox
[563.617148] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[563.719649] [115/133] (478s left) gem_pread (bench)
[563.770906] Subtest bench: SKIP (0.000s)
[563.827468] [116/133] (478s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[563.926667] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[570.973675] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.048s)
[571.125781] [117/133] (470s left) vgem_basic (debugfs)
[571.172702] Starting subtest: debugfs
[571.174993] Subtest debugfs: SUCCESS (0.000s)
[571.234689] [118/133] (470s left) gem_pxp (reject-modify-context-protection-on)
[571.362540] Starting subtest: reject-modify-context-protection-on
[571.365122] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[571.471045] [119/133] (470s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[571.578840] Starting subtest: x-tiled-8bpp-rotate-180
[572.837254] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.258s)
[572.958818] [120/133] (469s left) perf_pmu (busy-no-semaphores)
[572.993393] Starting subtest: busy-no-semaphores
[572.995337] Starting dynamic subtest: rcs0
[573.565161] Dynamic subtest rcs0: SUCCESS (0.569s)
[573.578341] Starting dynamic subtest: bcs0
[574.115823] Dynamic subtest bcs0: SUCCESS (0.547s)
[574.129448] Starting dynamic subtest: vcs0
[574.665515] Dynamic subtest vcs0: SUCCESS (0.547s)
[574.679258] Starting dynamic subtest: vcs1
[575.826358] Dynamic subtest vcs1: SUCCESS (1.158s)
[575.840002] Starting dynamic subtest: vecs0
[577.812088] Dynamic subtest vecs0: SUCCESS (1.982s)
[577.825674] Starting dynamic subtest: ccs0
[579.861220] Dynamic subtest ccs0: SUCCESS (2.045s)
[579.864322] Subtest busy-no-semaphores: SUCCESS (6.866s)
[579.992159] [121/133] (462s left) kms_getfb (getfb-handle-valid)
[580.084735] Starting subtest: getfb-handle-valid
[580.086991] Subtest getfb-handle-valid: SUCCESS (0.000s)
[580.183246] [122/133] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[580.274037] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[580.277929] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[580.366888] [123/133] (461s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[580.470300] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[580.474603] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[580.562867] [124/133] (461s left) gem_eio (in-flight-internal-10ms)
[580.778886] Starting subtest: in-flight-internal-10ms
[582.420550] Subtest in-flight-internal-10ms: SUCCESS (1.639s)
[582.561166] [125/133] (459s left) i915_drm_fdinfo (memory-info-shared)
[582.601292] Starting subtest: memory-info-shared
[582.603530] Starting dynamic subtest: smem0
[582.646517] Dynamic subtest smem0: SUCCESS (0.046s)
[582.649531] Subtest memory-info-shared: SUCCESS (0.047s)
[582.724242] [126/133] (459s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[582.811854] Starting subtest: fbc-psr-sprite-mmap-gtt
[582.814035] Starting dynamic subtest: eDP-1
[582.818205] Dynamic subtest eDP-1: SKIP (0.000s)
[582.822350] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[582.892226] [127/133] (459s left) gem_ctx_param (invalid-param-set)
[582.954621] Starting subtest: invalid-param-set
[582.956941] Subtest invalid-param-set: SUCCESS (0.000s)
[583.033203] [128/133] (459s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[583.137041] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[583.140942] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[583.228353] [129/133] (459s left) kms_psr (pr-suspend)
[583.326722] Starting subtest: pr-suspend
[583.330640] Subtest pr-suspend: SKIP (0.000s)
[583.428737] [130/133] (459s left) kms_lease (lease-invalid-plane)
[583.519143] Starting subtest: lease-invalid-plane
[583.521108] Starting dynamic subtest: pipe-A-eDP-1
[583.522983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[583.533380] Starting dynamic subtest: pipe-B-eDP-1
[583.535189] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[583.545176] Starting dynamic subtest: pipe-C-eDP-1
[583.547188] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[583.556982] Starting dynamic subtest: pipe-D-eDP-1
[583.558725] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[583.560569] Subtest lease-invalid-plane: SUCCESS (0.004s)
[583.598606] [131/133] (458s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[583.690986] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[583.694577] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[583.802749] [132/133] (458s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[583.998668] Starting subtest: cursor-rapid-movement-64x21
[584.047800] Subtest cursor-rapid-movement-64x21: SKIP (0.044s)
[584.289625] [133/133] (458s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[584.389599] Starting subtest: 4-tiled-8bpp-rotate-180
[585.603321] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[585.725286] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_dirtyfb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: i915_pm_rpm
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: kms_pm_backlight
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_invalid_mode
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: vgem_basic
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_ccs
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_color
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: gem_fence_thrash
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_suspend
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: i915_suspend
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: gen7_exec_parse
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: dmabuf_sync_file
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_exercise_blt
results: parsing output: 67/ for test: i915_getparams_basic
results: parsing output: 68/ for test: kms_content_protection
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_draw_crc
results: parsing output: 79/ for test: kms_flip_tiling
results: parsing output: 80/ for test: gem_mmap_wc
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: api_intel_allocator
results: parsing output: 83/ for test: gem_exec_parallel
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_atomic
results: parsing output: 89/ for test: gem_fenced_exec_thrash
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: api_intel_bb
results: parsing output: 93/ for test: kms_3d
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_atomic_transition
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: kms_pipe_crc_basic
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: gem_pread
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: vgem_basic
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: kms_big_fb
Done.