[59.545811] Initializing watchdogs
[59.545855]   /dev/watchdog0
[59.560498] [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.564937] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.567269] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.570578] [001/131] (960s left) gem_create (create-ext-cpu-access-sanity-check)
[59.768667] Starting subtest: create-ext-cpu-access-sanity-check
[59.774488] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[59.840419] [002/131] (960s left) gem_mmap_gtt (basic-small-bo-tiledy)
[59.894202] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[59.951639] [003/131] (960s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[60.086402] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[60.091156] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[60.228751] [004/131] (959s left) core_hotunplug (unbind-rebind)
[60.319318] Starting subtest: unbind-rebind
[66.224685] Subtest unbind-rebind: SUCCESS (5.845s)
[66.261625] [005/131] (953s left) syncobj_wait (multi-wait-for-submit-signaled)
[68.204341] Starting subtest: multi-wait-for-submit-signaled
[68.206959] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[68.304242] [006/131] (951s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[68.368650] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[68.373562] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[68.545734] [007/131] (951s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[68.654270] Starting subtest: primary-y-tiled-reflect-x-0
[68.738758] Subtest primary-y-tiled-reflect-x-0: SKIP (0.082s)
[68.839064] [008/131] (951s left) gem_exec_whisper (basic-queues-forked)
[68.900093] Starting subtest: basic-queues-forked
[93.468053] Subtest basic-queues-forked: SUCCESS (24.530s)
[93.668094] [009/131] (926s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[93.778255] Starting subtest: y-tiled-8bpp-rotate-180
[93.782379] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[93.876408] [010/131] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[93.972227] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[93.976681] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[94.066725] [011/131] (926s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[94.121595] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[94.226588] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[94.297232] [012/131] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[94.388595] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[94.393131] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[94.491632] [013/131] (926s left) kms_psr (psr-dpms)
[94.577951] Starting subtest: psr-dpms
[94.580158] Starting dynamic subtest: eDP-1
[97.542295] Dynamic subtest eDP-1: SUCCESS (2.963s)
[97.544624] Subtest psr-dpms: SUCCESS (2.964s)
[98.388701] [014/131] (922s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[98.502320] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[98.504734] Starting dynamic subtest: pipe-A-eDP-1
[98.528716] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.539220] Starting dynamic subtest: pipe-B-eDP-1
[98.561058] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.568993] Starting dynamic subtest: pipe-C-eDP-1
[98.590702] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.600701] Starting dynamic subtest: pipe-D-eDP-1
[98.622423] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.626851] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[100.695227] [015/131] (919s left) vgem_basic (busy-fence)
[100.790492] Starting subtest: busy-fence
[100.792452] Subtest busy-fence: SUCCESS (0.000s)
[100.845033] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[100.847796] [016/131] (919s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[100.951310] Starting subtest: fbc-tiling-linear
[104.713931] Subtest fbc-tiling-linear: SUCCESS (3.765s)
[105.905798] [017/131] (914s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[105.998621] Starting subtest: extended-modeset-hang-oldfb-with-reset
[106.001097] Starting dynamic subtest: pipe-A
[117.575646] Dynamic subtest pipe-A: SUCCESS (11.570s)
[117.586038] Starting dynamic subtest: pipe-D
[129.837583] Dynamic subtest pipe-D: SUCCESS (12.260s)
[129.840054] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.834s)
[130.653757] [018/131] (890s left) gem_mmap_wc (write)
[130.705256] Subtest write: SKIP (0.000s)
[130.764193] [019/131] (889s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[130.850376] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[135.305101] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.457s)
[136.449755] [020/131] (884s left) gem_ctx_sseu (mmap-args)
[136.504987] Subtest mmap-args: SKIP (0.000s)
[136.578481] [021/131] (884s left) gem_eio (wait-wedge-10ms)
[136.784409] Starting subtest: wait-wedge-10ms
[138.380920] Subtest wait-wedge-10ms: SUCCESS (1.595s)
[138.546653] [022/131] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[138.654126] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[138.658341] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[138.752837] [023/131] (882s left) gem_exec_balancer (parallel-ordering)
[139.004073] Starting subtest: parallel-ordering
[139.934362] Subtest parallel-ordering: SUCCESS (0.930s)
[140.082217] [024/131] (880s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[140.176335] Starting subtest: plane-lut1d-pre-ctm3x4
[140.343725] Starting dynamic subtest: pipe-A-plane-0
[140.488187] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[140.498106] Starting dynamic subtest: pipe-A-plane-1
[140.633687] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[140.644827] Starting dynamic subtest: pipe-A-plane-2
[140.765958] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[141.979095] Starting dynamic subtest: pipe-B-plane-0
[142.116598] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[142.125399] Starting dynamic subtest: pipe-B-plane-1
[142.261127] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[142.269938] Starting dynamic subtest: pipe-B-plane-2
[142.405743] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[143.568969] Starting dynamic subtest: pipe-C-plane-0
[143.717108] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[143.734421] Starting dynamic subtest: pipe-C-plane-1
[143.861254] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[143.871170] Starting dynamic subtest: pipe-C-plane-2
[143.994751] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[145.243316] Starting dynamic subtest: pipe-D-plane-0
[145.368756] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[145.378556] Starting dynamic subtest: pipe-D-plane-1
[145.501997] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[145.511911] Starting dynamic subtest: pipe-D-plane-2
[145.635318] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[145.935386] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.759s)
[146.787630] [025/131] (874s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[146.894367] Starting subtest: fbc-psr2-cursor-plane-update-sf
[146.896810] Starting dynamic subtest: pipe-A-eDP-1
[146.966588] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[146.975897] Starting dynamic subtest: pipe-B-eDP-1
[148.058698] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[148.063250] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.169s)
[149.248823] [026/131] (871s left) kms_atomic_interruptible (universal-setplane-cursor)
[149.344975] Starting subtest: universal-setplane-cursor
[149.347299] Starting dynamic subtest: pipe-A-eDP-1
[156.743055] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.395s)
[156.745382] Subtest universal-setplane-cursor: SUCCESS (7.396s)
[157.590694] [027/131] (863s left) syncobj_timeline (invalid-signal-zero-handles)
[157.653183] Starting subtest: invalid-signal-zero-handles
[157.655619] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[157.764765] [028/131] (863s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[157.865340] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[157.869712] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[157.967815] [029/131] (863s left) kms_pm_backlight (brightness-with-dpms)
[158.054260] Starting subtest: brightness-with-dpms
[158.104653] Starting dynamic subtest: eDP-1
[160.531209] Dynamic subtest eDP-1: SUCCESS (2.424s)
[160.533690] Subtest brightness-with-dpms: SUCCESS (2.475s)
[161.384638] [030/131] (859s left) kms_psr (psr2-cursor-mmap-gtt)
[161.488123] Starting subtest: psr2-cursor-mmap-gtt
[161.490398] Starting dynamic subtest: eDP-1
[163.135631] Dynamic subtest eDP-1: SUCCESS (1.648s)
[163.137907] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.648s)
[163.935652] [031/131] (857s left) gem_exec_fence (keep-in-fence)
[164.108702] Starting subtest: keep-in-fence
[164.111245] Starting dynamic subtest: rcs0
[164.174435] Dynamic subtest rcs0: SUCCESS (0.065s)
[164.185785] Starting dynamic subtest: bcs0
[164.227426] Dynamic subtest bcs0: SUCCESS (0.051s)
[164.238811] Starting dynamic subtest: vcs0
[165.320759] Dynamic subtest vcs0: SUCCESS (1.090s)
[165.332768] Starting dynamic subtest: vcs1
[167.303621] Dynamic subtest vcs1: SUCCESS (1.981s)
[167.314546] Starting dynamic subtest: vecs0
[169.287383] Dynamic subtest vecs0: SUCCESS (1.982s)
[169.299436] Starting dynamic subtest: ccs0
[169.530235] Dynamic subtest ccs0: SUCCESS (0.243s)
[169.532997] Subtest keep-in-fence: SUCCESS (5.422s)
[171.413648] [032/131] (849s left) syncobj_basic (bad-destroy)
[171.488105] Starting subtest: bad-destroy
[171.490459] Subtest bad-destroy: SUCCESS (0.000s)
[171.603249] [033/131] (849s left) drm_read (empty-block)
[171.754292] Starting subtest: empty-block
[172.753866] Subtest empty-block: SUCCESS (1.002s)
[172.897855] [034/131] (848s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[172.999312] Starting subtest: x-tiled-64bpp-rotate-90
[173.023862] Subtest x-tiled-64bpp-rotate-90: SKIP (0.024s)
[173.151457] [035/131] (848s left) syncobj_timeline (signal-array)
[173.205988] Starting subtest: signal-array
[173.208282] Subtest signal-array: SUCCESS (0.000s)
[173.298382] [036/131] (848s left) kms_getfb (getfb-handle-protection)
[173.406592] Starting subtest: getfb-handle-protection
[173.430646] Subtest getfb-handle-protection: SUCCESS (0.026s)
[173.549012] [037/131] (847s left) kms_flip (flip-vs-dpms-on-nop)
[173.648273] Starting subtest: flip-vs-dpms-on-nop
[173.650222] Starting dynamic subtest: A-eDP1
[175.524701] Dynamic subtest A-eDP1: SUCCESS (1.878s)
[175.535972] Starting dynamic subtest: B-eDP1
[177.354685] Dynamic subtest B-eDP1: SUCCESS (1.828s)
[177.366231] Starting dynamic subtest: C-eDP1
[179.175675] Dynamic subtest C-eDP1: SUCCESS (1.819s)
[179.186805] Starting dynamic subtest: D-eDP1
[181.014679] Dynamic subtest D-eDP1: SUCCESS (1.837s)
[181.017107] Subtest flip-vs-dpms-on-nop: SUCCESS (7.371s)
[182.197255] [038/131] (839s left) drm_read (short-buffer-block)
[182.362451] Starting subtest: short-buffer-block
[182.364788] Subtest short-buffer-block: SUCCESS (0.000s)
[182.485722] [039/131] (839s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[182.551810] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[182.616415] [040/131] (839s left) gen7_exec_parse (basic-rejected)
[182.683616] Subtest basic-rejected: SKIP (0.000s)
[182.755436] [041/131] (838s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[182.854837] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[183.247416] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[185.977227] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.729s)
[185.989354] Starting dynamic subtest: pipe-A-eDP-1-4
[188.152094] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[188.163829] Starting dynamic subtest: pipe-A-eDP-1-4
[190.162084] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[190.173446] Starting dynamic subtest: pipe-A-eDP-1-x
[192.351597] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[192.730081] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[195.513528] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[195.523259] Starting dynamic subtest: pipe-B-eDP-1-4
[197.698641] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s)
[197.708166] Starting dynamic subtest: pipe-B-eDP-1-4
[199.708709] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[199.720302] Starting dynamic subtest: pipe-B-eDP-1-x
[201.899083] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[202.271637] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[205.041126] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[205.053373] Starting dynamic subtest: pipe-C-eDP-1-4
[207.226357] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[207.235487] Starting dynamic subtest: pipe-C-eDP-1-4
[209.237116] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[209.248745] Starting dynamic subtest: pipe-C-eDP-1-x
[211.415055] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[211.783099] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[214.569801] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[214.581110] Starting dynamic subtest: pipe-D-eDP-1-4
[216.766187] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.196s)
[216.776640] Starting dynamic subtest: pipe-D-eDP-1-4
[218.776083] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[218.795805] Starting dynamic subtest: pipe-D-eDP-1-x
[220.966568] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[220.968950] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.111s)
[222.155080] [042/131] (799s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[222.251344] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[229.408287] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.158s)
[229.531216] [043/131] (792s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[229.632267] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[230.456566] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[230.615588] [044/131] (791s left) kms_plane (pixel-format-4-tiled-modifier)
[230.718873] Starting subtest: pixel-format-4-tiled-modifier
[230.744509] Starting dynamic subtest: pipe-A-plane-0
[231.421835] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[231.432573] Starting dynamic subtest: pipe-A-plane-3
[231.843911] Dynamic subtest pipe-A-plane-3: SUCCESS (0.420s)
[231.852957] Starting dynamic subtest: pipe-A-plane-5
[231.856448] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[232.994492] Starting dynamic subtest: pipe-B-plane-0
[233.747880] Dynamic subtest pipe-B-plane-0: SUCCESS (0.766s)
[233.757249] Starting dynamic subtest: pipe-B-plane-3
[234.148956] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[234.160641] Starting dynamic subtest: pipe-B-plane-5
[234.166655] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[234.458994] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.740s)
[235.274167] [045/131] (786s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[235.642500] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[236.479591] [046/131] (785s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[236.574072] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[236.578071] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[236.644148] [047/131] (785s left) kms_plane_multiple (2x-tiling-none)
[236.722269] Starting subtest: 2x-tiling-none
[236.726186] Subtest 2x-tiling-none: SKIP (0.000s)
[236.803864] [048/131] (785s left) gem_exec_schedule (u-submit-early-slice)
[236.875141] Starting subtest: u-submit-early-slice
[236.877140] Starting dynamic subtest: rcs0
[236.910767] Dynamic subtest rcs0: SUCCESS (0.041s)
[236.921036] Starting dynamic subtest: bcs0
[236.955338] Dynamic subtest bcs0: SUCCESS (0.044s)
[236.965917] Starting dynamic subtest: vcs0
[236.998759] Dynamic subtest vcs0: SUCCESS (0.043s)
[237.008066] Starting dynamic subtest: vcs1
[237.038968] Dynamic subtest vcs1: SUCCESS (0.040s)
[237.049222] Starting dynamic subtest: vecs0
[237.080619] Dynamic subtest vecs0: SUCCESS (0.041s)
[237.090045] Starting dynamic subtest: ccs0
[237.124617] Dynamic subtest ccs0: SUCCESS (0.043s)
[237.126843] Subtest u-submit-early-slice: SUCCESS (0.256s)
[238.361737] [049/131] (783s left) gem_mmap_gtt (zero-extend)
[238.423538] Subtest zero-extend: SKIP (0.000s)
[238.477332] [050/131] (783s left) prime_vgem (fence-write-hang)
[238.560459] Subtest fence-write-hang: SKIP (0.000s)
[238.657981] [051/131] (783s left) kms_vblank (ts-continuation-idle-hang)
[238.757056] Starting subtest: ts-continuation-idle-hang
[238.759289] Starting dynamic subtest: pipe-A-eDP-1
[265.039407] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.280s)
[265.053847] Starting dynamic subtest: pipe-D-eDP-1
[289.031780] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.990s)
[289.034103] Subtest ts-continuation-idle-hang: SUCCESS (50.274s)
[289.863699] [052/131] (732s left) gem_mmap_wc (bad-object)
[289.913592] Subtest bad-object: SKIP (0.000s)
[289.972401] [053/131] (732s left) kms_chamelium_color (ctm-0-25)
[290.056204] Subtest ctm-0-25: SKIP (0.000s)
[290.100985] [054/131] (732s left) gem_mmap_gtt (medium-copy-xy)
[290.160241] Subtest medium-copy-XY: SKIP (0.000s)
[290.223397] [055/131] (732s left) kms_joiner (invalid-modeset-big-joiner)
[290.319465] Starting subtest: invalid-modeset-big-joiner
[290.323730] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[290.382236] [056/131] (731s left) gem_exec_params (sol-reset-invalid)
[290.439941] Starting subtest: sol-reset-invalid
[290.445068] Subtest sol-reset-invalid: SUCCESS (0.002s)
[292.358893] [057/131] (729s left) gem_exec_parallel (contexts)
[292.417766] Starting subtest: contexts
[292.420301] Starting dynamic subtest: rcs0
[296.453099] Dynamic subtest rcs0: SUCCESS (4.034s)
[296.467657] Starting dynamic subtest: bcs0
[300.798137] Dynamic subtest bcs0: SUCCESS (4.342s)
[300.807096] Starting dynamic subtest: vcs0
[304.783597] Dynamic subtest vcs0: SUCCESS (3.983s)
[304.793979] Starting dynamic subtest: vcs1
[310.661313] Dynamic subtest vcs1: SUCCESS (5.874s)
[310.672917] Starting dynamic subtest: vecs0
[314.965463] Dynamic subtest vecs0: SUCCESS (4.302s)
[314.974382] Starting dynamic subtest: ccs0
[319.153231] Dynamic subtest ccs0: SUCCESS (4.187s)
[319.155661] Subtest contexts: SUCCESS (26.736s)
[319.355721] [058/131] (703s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[319.448229] Starting subtest: fbc-pr-sprite-mmap-gtt
[319.452779] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[319.521276] [059/131] (702s left) i915_drm_fdinfo (all-busy-check-all)
[319.570236] Starting subtest: all-busy-check-all
[319.577288] Subtest all-busy-check-all: SKIP (0.004s)
[319.658956] [060/131] (702s left) kms_vrr (seamless-rr-switch-drrs)
[319.785559] Starting subtest: seamless-rr-switch-drrs
[319.791836] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[319.854327] [061/131] (702s left) gem_exec_whisper (basic-fds-all)
[319.915766] Starting subtest: basic-fds-all
[331.281396] Subtest basic-fds-all: SUCCESS (11.365s)
[331.468055] [062/131] (691s left) gem_exec_reloc (basic-cpu-read-active)
[331.529925] Subtest basic-cpu-read-active: SKIP (0.000s)
[331.612033] [063/131] (690s left) gem_ctx_param (invalid-param-get)
[331.664845] Starting subtest: invalid-param-get
[331.667148] Subtest invalid-param-get: SUCCESS (0.001s)
[331.774219] [064/131] (690s left) gem_exec_schedule (fairslice)
[331.852930] Starting subtest: fairslice
[331.855253] Starting dynamic subtest: rcs0
[333.880277] Dynamic subtest rcs0: SUCCESS (2.031s)
[333.889919] Starting dynamic subtest: bcs0
[335.904015] Dynamic subtest bcs0: SUCCESS (2.023s)
[335.917864] Starting dynamic subtest: vcs0
[337.927142] Dynamic subtest vcs0: SUCCESS (2.020s)
[337.937936] Starting dynamic subtest: vcs1
[339.945015] Dynamic subtest vcs1: SUCCESS (2.019s)
[339.954572] Starting dynamic subtest: vecs0
[341.964721] Dynamic subtest vecs0: SUCCESS (2.018s)
[341.975619] Starting dynamic subtest: ccs0
[343.985628] Dynamic subtest ccs0: SUCCESS (2.021s)
[343.987885] Subtest fairslice: SUCCESS (12.137s)
[344.281661] [065/131] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[344.397437] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[344.401612] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[344.482537] [066/131] (678s left) kms_psr (pr-sprite-mmap-gtt)
[344.577347] Starting subtest: pr-sprite-mmap-gtt
[344.581513] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[344.648027] [067/131] (678s left) syncobj_wait (wait-all-interrupted)
[344.710391] Starting subtest: wait-all-interrupted
[344.818815] Subtest wait-all-interrupted: SUCCESS (0.108s)
[344.904740] [068/131] (677s left) gem_spin_batch (legacy-resubmit-new)
[344.969880] Starting subtest: legacy-resubmit-new
[344.972385] Starting dynamic subtest: default
[344.977683] Dynamic subtest default: SUCCESS (0.006s)
[344.989636] Starting dynamic subtest: render
[344.992247] Dynamic subtest render: SUCCESS (0.003s)
[345.001275] Starting dynamic subtest: bsd
[345.003694] Dynamic subtest bsd: SUCCESS (0.004s)
[345.012333] Starting dynamic subtest: bsd1
[345.014255] Dynamic subtest bsd1: SUCCESS (0.004s)
[345.022483] Starting dynamic subtest: bsd2
[345.024465] Dynamic subtest bsd2: SUCCESS (0.002s)
[345.032637] Starting dynamic subtest: blt
[345.034662] Dynamic subtest blt: SUCCESS (0.005s)
[345.043046] Starting dynamic subtest: vebox
[345.044993] Dynamic subtest vebox: SUCCESS (0.004s)
[345.047061] Subtest legacy-resubmit-new: SUCCESS (0.033s)
[346.350047] [069/131] (676s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[346.414415] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[346.419116] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[346.608780] [070/131] (676s left) gem_ccs (block-copy-compressed)
[346.663682] Starting subtest: block-copy-compressed
[346.668376] Subtest block-copy-compressed: SKIP (0.000s)
[346.772248] [071/131] (676s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[346.830629] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[346.938585] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[347.027783] [072/131] (675s left) syncobj_timeline (multi-wait-all-signaled)
[347.081065] Starting subtest: multi-wait-all-signaled
[347.083435] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[347.178915] [073/131] (675s left) kms_flip (2x-flip-vs-fences-interruptible)
[347.274081] Starting subtest: 2x-flip-vs-fences-interruptible
[347.278416] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[347.382385] [074/131] (675s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[347.477799] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[347.480139] Starting dynamic subtest: pipe-A-eDP-1
[353.349777] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.877s)
[353.360074] Starting dynamic subtest: pipe-B-eDP-1
[360.026635] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.671s)
[360.029089] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.553s)
[360.892528] [075/131] (662s left) gem_exec_parallel (basic)
[360.961228] Starting subtest: basic
[360.963530] Starting dynamic subtest: rcs0
[362.332708] Dynamic subtest rcs0: SUCCESS (1.371s)
[362.341803] Starting dynamic subtest: bcs0
[363.815214] Dynamic subtest bcs0: SUCCESS (1.481s)
[363.826897] Starting dynamic subtest: vcs0
[365.347297] Dynamic subtest vcs0: SUCCESS (1.528s)
[365.359237] Starting dynamic subtest: vcs1
[367.302031] Dynamic subtest vcs1: SUCCESS (1.953s)
[367.315084] Starting dynamic subtest: vecs0
[369.287341] Dynamic subtest vecs0: SUCCESS (1.983s)
[369.298262] Starting dynamic subtest: ccs0
[370.784329] Dynamic subtest ccs0: SUCCESS (1.496s)
[370.787162] Subtest basic: SUCCESS (9.824s)
[370.973475] [076/131] (652s left) gem_userptr_blits (usage-restrictions)
[371.052700] Starting subtest: usage-restrictions
[371.054647] Subtest usage-restrictions: SUCCESS (0.000s)
[371.179153] [077/131] (651s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[371.279728] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[371.281968] Starting dynamic subtest: pipe-A
[371.299345] Dynamic subtest pipe-A: SKIP (0.016s)
[371.310590] Starting dynamic subtest: pipe-B
[371.329138] Dynamic subtest pipe-B: SKIP (0.029s)
[371.340864] Starting dynamic subtest: pipe-C
[371.358670] Dynamic subtest pipe-C: SKIP (0.029s)
[371.369738] Starting dynamic subtest: pipe-D
[371.387679] Dynamic subtest pipe-D: SKIP (0.028s)
[371.391901] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.105s)
[371.494567] [078/131] (651s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[371.598220] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[371.602462] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.690077] [079/131] (651s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[371.790047] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[371.792345] Starting dynamic subtest: pipe-A-eDP-1
[371.863957] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[371.873859] Starting dynamic subtest: pipe-B-eDP-1
[372.974274] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[372.978571] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.188s)
[374.162654] [080/131] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[374.263424] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[374.267743] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[374.365632] [081/131] (648s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[374.453159] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[374.457660] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[375.594408] [082/131] (647s left) kms_cursor_crc (cursor-sliding-64x64)
[375.772879] Starting subtest: cursor-sliding-64x64
[375.775641] Starting dynamic subtest: pipe-A-eDP-1
[378.971478] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.196s)
[379.001840] Starting dynamic subtest: pipe-D-eDP-1
[382.879986] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.889s)
[382.882348] Subtest cursor-sliding-64x64: SUCCESS (7.109s)
[383.745813] [083/131] (639s left) prime_busy (after)
[383.805453] Starting subtest: after
[383.810257] Starting dynamic subtest: rcs0
[383.842508] Dynamic subtest rcs0: SUCCESS (0.035s)
[383.852948] Starting dynamic subtest: bcs0
[383.891376] Dynamic subtest bcs0: SUCCESS (0.048s)
[383.900840] Starting dynamic subtest: vcs0
[383.931319] Dynamic subtest vcs0: SUCCESS (0.039s)
[383.940077] Starting dynamic subtest: vcs1
[383.972710] Dynamic subtest vcs1: SUCCESS (0.041s)
[383.981661] Starting dynamic subtest: vecs0
[384.012369] Dynamic subtest vecs0: SUCCESS (0.039s)
[384.020724] Starting dynamic subtest: ccs0
[384.053776] Dynamic subtest ccs0: SUCCESS (0.041s)
[384.162297] Subtest after: SUCCESS (0.356s)
[384.252598] [084/131] (639s left) i915_pm_rpm (sysfs-read)
[386.477230] Starting subtest: sysfs-read
[387.624056] Subtest sysfs-read: SUCCESS (1.145s)
[388.005187] [085/131] (635s left) gen3_render_tiledy_blits
[388.119191] [086/131] (635s left) kms_cursor_crc (cursor-random-max-size)
[388.428895] Starting subtest: cursor-random-max-size
[388.435279] Subtest cursor-random-max-size: SKIP (0.000s)
[388.570692] [087/131] (634s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[388.694391] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[420.472463] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.777s)
[421.336507] [088/131] (602s left) gem_exec_balancer (parallel)
[421.601023] Starting subtest: parallel
[422.511156] Subtest parallel: SUCCESS (0.910s)
[423.344932] [089/131] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[423.462323] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[423.466798] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[423.570480] [090/131] (600s left) i915_drm_fdinfo (virtual-busy-hang-all)
[423.610133] Starting subtest: virtual-busy-hang-all
[423.614623] Subtest virtual-busy-hang-all: SKIP (0.000s)
[423.675352] [091/131] (600s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[423.785756] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[424.598846] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.815s)
[424.753241] [092/131] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[424.850070] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[431.794657] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.946s)
[431.917772] [093/131] (591s left) kms_pipe_crc_basic (suspend-read-crc)
[432.013127] Starting subtest: suspend-read-crc
[432.015374] Starting dynamic subtest: pipe-A-eDP-1
[449.199757] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.640s)
[449.210352] Starting dynamic subtest: pipe-B-eDP-1
[467.241240] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.084s)
[467.252854] Starting dynamic subtest: pipe-C-eDP-1
[485.194768] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.000s)
[485.212173] Starting dynamic subtest: pipe-D-eDP-1
[503.245807] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.070s)
[503.248219] Subtest suspend-read-crc: SUCCESS (11.799s)
[504.104644] [094/131] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[504.216104] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[504.220572] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[504.327638] [095/131] (519s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[504.434251] Starting subtest: yf-tiled-64bpp-rotate-270
[504.438715] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[504.535270] [096/131] (519s left) syncobj_wait (invalid-reset-zero-handles)
[504.588603] Starting subtest: invalid-reset-zero-handles
[504.590656] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[504.680887] [097/131] (519s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[504.795045] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[504.799643] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[504.963909] [098/131] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[505.060410] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[512.485554] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.277s)
[512.588115] [099/131] (511s left) gem_exec_schedule (pi-shared-iova)
[512.768962] Starting subtest: pi-shared-iova
[512.771271] Starting dynamic subtest: rcs0
[512.843562] Dynamic subtest rcs0: SUCCESS (0.075s)
[512.857732] Starting dynamic subtest: vcs0
[512.904318] Dynamic subtest vcs0: SUCCESS (0.059s)
[512.916125] Starting dynamic subtest: vcs1
[512.965496] Dynamic subtest vcs1: SUCCESS (0.058s)
[512.980184] Starting dynamic subtest: vecs0
[513.022478] Dynamic subtest vecs0: SUCCESS (0.056s)
[513.037102] Starting dynamic subtest: ccs0
[513.082100] Dynamic subtest ccs0: SUCCESS (0.058s)
[513.084851] Subtest pi-shared-iova: SUCCESS (0.312s)
[514.470937] [100/131] (509s left) kms_dsc (dsc-basic)
[514.560503] Starting subtest: dsc-basic
[514.573723] Subtest dsc-basic: SKIP (0.000s)
[514.640971] [101/131] (509s left) perf_pmu (init-sema)
[514.681852] Starting subtest: init-sema
[514.684157] Starting dynamic subtest: rcs0
[514.686403] Dynamic subtest rcs0: SUCCESS (0.002s)
[514.698876] Starting dynamic subtest: bcs0
[514.700995] Dynamic subtest bcs0: SUCCESS (0.000s)
[514.711515] Starting dynamic subtest: vcs0
[514.713623] Dynamic subtest vcs0: SUCCESS (0.001s)
[514.723474] Starting dynamic subtest: vcs1
[514.726063] Dynamic subtest vcs1: SUCCESS (0.000s)
[514.736528] Starting dynamic subtest: vecs0
[514.738625] Dynamic subtest vecs0: SUCCESS (0.001s)
[514.748061] Starting dynamic subtest: ccs0
[514.750147] Dynamic subtest ccs0: SUCCESS (0.000s)
[514.752266] Subtest init-sema: SUCCESS (0.008s)
[514.795943] [102/131] (509s left) gem_caching (writes)
[514.862475] Subtest writes: SKIP (0.000s)
[514.930729] [103/131] (509s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[515.015911] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[515.026812] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[515.115770] [104/131] (509s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[515.212530] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[521.983310] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.736s)
[522.099646] [105/131] (502s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[522.180973] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[522.183340] Starting dynamic subtest: pipe-A-eDP-1
[522.240627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[522.538435] Starting dynamic subtest: pipe-B-eDP-1
[523.302648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.771s)
[523.600549] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.417s)
[524.466767] [106/131] (499s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[524.599908] Starting subtest: dp-mst-lic-type-0-hdcp14
[524.604595] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[524.720221] [107/131] (499s left) gem_eio (wait-immediate)
[524.949629] Starting subtest: wait-immediate
[525.313910] Subtest wait-immediate: SUCCESS (0.364s)
[525.467084] [108/131] (498s left) kms_sequence (get-idle)
[525.553584] Starting subtest: get-idle
[525.555607] Starting dynamic subtest: pipe-A-eDP-1
[527.363604] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.804s)
[527.374226] Starting dynamic subtest: pipe-B-eDP-1
[529.839508] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.470s)
[529.849787] Starting dynamic subtest: pipe-C-eDP-1
[532.270944] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s)
[532.282226] Starting dynamic subtest: pipe-D-eDP-1
[534.704865] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s)
[534.707098] Subtest get-idle: SUCCESS (9.138s)
[535.509006] [109/131] (488s left) syncobj_wait (reset-unsignaled)
[535.558840] Starting subtest: reset-unsignaled
[535.560766] Subtest reset-unsignaled: SUCCESS (0.000s)
[535.662761] [110/131] (488s left) api_intel_bb (intel-bb-blit-none)
[535.726076] Starting subtest: intel-bb-blit-none
[539.765069] Subtest intel-bb-blit-none: SUCCESS (4.038s)
[539.918600] [111/131] (484s left) gem_vm_create (invalid-create)
[539.982968] Starting subtest: invalid-create
[539.985383] Subtest invalid-create: SUCCESS (0.001s)
[540.096481] [112/131] (484s left) gem_ctx_persistence (heartbeat-close)
[540.151028] Starting subtest: heartbeat-close
[540.155490] Subtest heartbeat-close: SKIP (0.000s)
[540.262937] [113/131] (484s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[540.375744] Starting subtest: 4-tiled-32bpp-rotate-0
[541.832907] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.457s)
[541.963770] [114/131] (482s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[542.055903] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[542.057828] Starting dynamic subtest: pipe-A-eDP-1
[542.076027] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[542.092058] Starting dynamic subtest: pipe-B-eDP-1
[542.109200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[542.118363] Starting dynamic subtest: pipe-C-eDP-1
[542.135743] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[542.146009] Starting dynamic subtest: pipe-D-eDP-1
[542.163259] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[542.166618] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[544.365932] [115/131] (480s left) gem_ctx_persistence (engines-hang)
[544.433876] Starting subtest: engines-hang
[544.436287] Starting dynamic subtest: rcs0
[544.556191] Dynamic subtest rcs0: SUCCESS (0.122s)
[544.569229] Starting dynamic subtest: bcs0
[544.647313] Dynamic subtest bcs0: SUCCESS (0.089s)
[544.660267] Starting dynamic subtest: vcs0
[544.741207] Dynamic subtest vcs0: SUCCESS (0.091s)
[544.756533] Starting dynamic subtest: vcs1
[544.833357] Dynamic subtest vcs1: SUCCESS (0.089s)
[544.846242] Starting dynamic subtest: vecs0
[544.929462] Dynamic subtest vecs0: SUCCESS (0.094s)
[544.943249] Starting dynamic subtest: ccs0
[545.019960] Dynamic subtest ccs0: SUCCESS (0.089s)
[545.022402] Subtest engines-hang: SUCCESS (0.587s)
[545.106859] [116/131] (479s left) kms_chamelium_edid (hdmi-edid-read)
[545.492532] Subtest hdmi-edid-read: SKIP (0.000s)
[546.272967] [117/131] (478s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[546.361814] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[550.901751] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.543s)
[552.092083] [118/131] (472s left) kms_async_flips (test-time-stamp)
[552.197813] Starting subtest: test-time-stamp
[552.571602] Starting dynamic subtest: pipe-A-eDP-1
[553.376142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[553.757392] Starting dynamic subtest: pipe-B-eDP-1
[554.512591] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[554.895115] Starting dynamic subtest: pipe-C-eDP-1
[555.653965] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[556.032783] Starting dynamic subtest: pipe-D-eDP-1
[556.793401] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[556.795647] Subtest test-time-stamp: SUCCESS (4.595s)
[557.951415] [119/131] (467s left) kms_lease (lease-unleased-connector)
[558.057484] Starting subtest: lease-unleased-connector
[558.059558] Starting dynamic subtest: pipe-A-eDP-1
[558.064493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[558.074622] Starting dynamic subtest: pipe-B-eDP-1
[558.076879] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[558.086882] Starting dynamic subtest: pipe-C-eDP-1
[558.089140] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[558.098851] Starting dynamic subtest: pipe-D-eDP-1
[558.100682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[558.102492] Subtest lease-unleased-connector: SUCCESS (0.034s)
[558.207640] [120/131] (466s left) syncobj_wait (multi-wait-for-submit-submitted)
[558.276221] Starting subtest: multi-wait-for-submit-submitted
[558.383849] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[558.459949] [121/131] (466s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[558.555541] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[558.559464] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[558.630069] [122/131] (466s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[558.728202] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[558.730490] Starting dynamic subtest: pipe-A
[559.821611] Dynamic subtest pipe-A: SUCCESS (1.095s)
[559.832094] Starting dynamic subtest: pipe-B
[562.005920] Dynamic subtest pipe-B: SUCCESS (2.182s)
[562.025743] Starting dynamic subtest: pipe-C
[563.253432] Dynamic subtest pipe-C: SUCCESS (1.244s)
[563.264656] Starting dynamic subtest: pipe-D
[564.410822] Dynamic subtest pipe-D: SUCCESS (1.156s)
[564.413098] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.683s)
[565.615785] [123/131] (459s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[565.729879] Starting subtest: psr-modesetfrombusy
[571.886581] Subtest psr-modesetfrombusy: SUCCESS (6.160s)
[572.018070] [124/131] (453s left) gem_userptr_blits (create-destroy-unsync)
[572.074289] Subtest create-destroy-unsync: SKIP (0.000s)
[572.184931] [125/131] (453s left) i915_pm_rps (thresholds-park)
[572.251493] Starting subtest: thresholds-park
[572.255339] Subtest thresholds-park: SKIP (0.001s)
[572.332799] [126/131] (452s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[572.425932] Starting subtest: plane-all-modeset-transition-fencing
[572.429538] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[572.513287] [127/131] (452s left) kms_psr (fbc-psr-no-drrs)
[572.601167] Starting subtest: fbc-psr-no-drrs
[572.603148] Starting dynamic subtest: eDP-1
[572.606536] Dynamic subtest eDP-1: SKIP (0.000s)
[572.609933] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[572.675214] [128/131] (452s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[572.763066] Starting subtest: bad-pixel-format-y-tiled-ccs
[572.764966] Starting dynamic subtest: pipe-A-eDP-1
[572.784548] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[572.796442] Starting dynamic subtest: pipe-B-eDP-1
[572.814523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[572.823693] Starting dynamic subtest: pipe-C-eDP-1
[572.841641] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[572.851346] Starting dynamic subtest: pipe-D-eDP-1
[572.869736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[572.873184] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[574.952381] [129/131] (450s left) kms_cursor_crc (cursor-dpms)
[575.094538] Starting subtest: cursor-dpms
[575.096651] Starting dynamic subtest: pipe-A-eDP-1
[578.112629] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.018s)
[578.123284] Starting dynamic subtest: pipe-D-eDP-1
[581.787717] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.670s)
[581.789955] Subtest cursor-dpms: SUCCESS (6.691s)
[582.626884] [130/131] (442s left) gem_mmap_gtt (fault-concurrent-x)
[582.673184] Subtest fault-concurrent-X: SKIP (0.000s)
[582.732774] [131/131] (442s left) kms_flip (nonblocking-read)
[582.832757] Starting subtest: nonblocking-read
[582.834942] Subtest nonblocking-read: SUCCESS (0.000s)
[582.933806] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: core_hotunplug
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_rotation_crc
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_busy
results: parsing output: 17/ for test: gem_mmap_wc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_sseu
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_color_pipeline
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_atomic_interruptible
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_pm_backlight
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: syncobj_basic
results: parsing output: 32/ for test: drm_read
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: drm_read
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gen7_exec_parse
results: parsing output: 40/ for test: kms_async_flips
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: kms_plane_multiple
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: prime_vgem
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_mmap_wc
results: parsing output: 52/ for test: kms_chamelium_color
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: gem_exec_params
results: parsing output: 56/ for test: gem_exec_parallel
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: kms_vrr
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_spin_batch
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_ccs
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: gem_exec_parallel
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: prime_busy
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: gen3_render_tiledy_blits
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_pipe_crc_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_dsc
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: gem_caching
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_atomic_transition
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: kms_sequence
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: api_intel_bb
results: parsing output: 110/ for test: gem_vm_create
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: kms_lease
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_flip
Done.