[58.201322] Initializing watchdogs
[58.201368]   /dev/watchdog0
[58.215524] [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]
[58.219956] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.222194] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.225653] [001/133] (960s left) gem_exec_params (rel-constants-invalid)
[58.304758] Starting subtest: rel-constants-invalid
[58.307122] Subtest rel-constants-invalid: SUCCESS (0.000s)
[58.404335] [002/133] (960s left) perf_pmu (semaphore-wait-idle)
[58.441108] Starting subtest: semaphore-wait-idle
[58.443350] Starting dynamic subtest: rcs0
[58.956833] Dynamic subtest rcs0: SUCCESS (0.520s)
[58.966653] Starting dynamic subtest: bcs0
[59.474068] Dynamic subtest bcs0: SUCCESS (0.518s)
[59.483431] Starting dynamic subtest: vcs0
[59.987739] Dynamic subtest vcs0: SUCCESS (0.518s)
[59.997493] Starting dynamic subtest: vcs1
[60.503069] Dynamic subtest vcs1: SUCCESS (0.518s)
[60.512959] Starting dynamic subtest: vecs0
[61.016060] Dynamic subtest vecs0: SUCCESS (0.516s)
[61.025527] Starting dynamic subtest: ccs0
[61.528896] Dynamic subtest ccs0: SUCCESS (0.516s)
[61.531574] Subtest semaphore-wait-idle: SUCCESS (3.116s)
[62.943208] [003/133] (955s left) kms_plane_multiple (tiling-none)
[63.031375] Starting subtest: tiling-none
[63.033677] Starting dynamic subtest: pipe-A-eDP-1
[66.701609] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.685s)
[66.710609] Starting dynamic subtest: pipe-B-eDP-1
[71.125858] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.436s)
[71.135069] Starting dynamic subtest: pipe-C-eDP-1
[75.467010] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.346s)
[75.482516] Starting dynamic subtest: pipe-D-eDP-1
[79.835155] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.372s)
[79.837629] Subtest tiling-none: SUCCESS (16.843s)
[80.651987] [004/133] (938s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[80.742792] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[80.745098] Starting dynamic subtest: pipe-A-default-mode
[83.507116] Dynamic subtest pipe-A-default-mode: SUCCESS (2.762s)
[83.509391] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.763s)
[84.341933] [005/133] (934s left) kms_flip (plain-flip-fb-recreate-interruptible)
[84.436420] Starting subtest: plain-flip-fb-recreate-interruptible
[84.438619] Starting dynamic subtest: A-eDP1
[93.332605] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[93.343237] Starting dynamic subtest: B-eDP1
[102.160968] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[102.172165] Starting dynamic subtest: C-eDP1
[110.988948] Dynamic subtest C-eDP1: SUCCESS (8.825s)
[110.999933] Starting dynamic subtest: D-eDP1
[119.820104] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[119.824621] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.383s)
[120.992900] [006/133] (897s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[121.043284] Starting subtest: invalid-single-wait-all-unsubmitted
[121.045676] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[121.133469] [007/133] (897s left) syncobj_timeline (multi-wait-available-signaled)
[121.179665] Starting subtest: multi-wait-available-signaled
[121.181895] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[121.273790] [008/133] (897s left) kms_chamelium_edid (dp-edid-resolution-list)
[121.656985] Subtest dp-edid-resolution-list: SKIP (0.000s)
[122.502474] [009/133] (896s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[122.601938] Starting subtest: pr-overlay-plane-update-continuous-sf
[122.606299] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[122.672625] [010/133] (896s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[122.778302] Starting subtest: y-tiled-8bpp-rotate-0
[122.783060] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[122.874402] [011/133] (896s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[122.933876] Starting subtest: mixed-tiled-to-y-tiled-ccs
[122.938038] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[123.124448] [012/133] (896s left) gem_exec_schedule (u-submit-early-slice)
[123.192567] Starting subtest: u-submit-early-slice
[123.194549] Starting dynamic subtest: rcs0
[123.228562] Dynamic subtest rcs0: SUCCESS (0.042s)
[123.238111] Starting dynamic subtest: bcs0
[123.270031] Dynamic subtest bcs0: SUCCESS (0.041s)
[123.279406] Starting dynamic subtest: vcs0
[123.313492] Dynamic subtest vcs0: SUCCESS (0.043s)
[123.322939] Starting dynamic subtest: vcs1
[123.352385] Dynamic subtest vcs1: SUCCESS (0.038s)
[123.364628] Starting dynamic subtest: vecs0
[123.396554] Dynamic subtest vecs0: SUCCESS (0.044s)
[123.404688] Starting dynamic subtest: ccs0
[123.433064] Dynamic subtest ccs0: SUCCESS (0.036s)
[123.435265] Subtest u-submit-early-slice: SUCCESS (0.247s)
[124.965295] [013/133] (894s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[125.063537] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[126.153125] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.090s)
[126.275896] [014/133] (892s left) kms_universal_plane (universal-plane-functional)
[126.364058] Starting subtest: universal-plane-functional
[126.365888] Starting dynamic subtest: pipe-A-eDP-1
[130.420362] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.056s)
[130.429624] Starting dynamic subtest: pipe-B-eDP-1
[135.115075] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.692s)
[135.123243] Starting dynamic subtest: pipe-C-eDP-1
[139.470801] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.353s)
[139.479312] Starting dynamic subtest: pipe-D-eDP-1
[143.885824] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.413s)
[143.887762] Subtest universal-plane-functional: SUCCESS (17.519s)
[144.714461] [015/133] (874s left) prime_mmap (test_dup)
[144.782341] Starting subtest: test_dup
[144.784574] Starting dynamic subtest: test_dup-smem
[144.813607] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[144.815901] Subtest test_dup: SUCCESS (0.033s)
[144.884043] [016/133] (874s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[144.979209] Starting subtest: bad-rotation-90-y-tiled-ccs
[144.981521] Starting dynamic subtest: pipe-A-eDP-1
[145.003782] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.012461] Starting dynamic subtest: pipe-B-eDP-1
[145.034107] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.041203] Starting dynamic subtest: pipe-C-eDP-1
[145.061362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.068584] Starting dynamic subtest: pipe-D-eDP-1
[145.089979] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.094062] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[147.298927] [017/133] (872s left) kms_flip (flip-vs-expired-vblank-interruptible)
[147.397383] Starting subtest: flip-vs-expired-vblank-interruptible
[147.399693] Starting dynamic subtest: A-eDP1
[156.104655] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[156.115023] Starting dynamic subtest: B-eDP1
[164.736016] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[164.745293] Starting dynamic subtest: C-eDP1
[173.359131] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[173.370664] Starting dynamic subtest: D-eDP1
[181.993725] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[181.999109] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.604s)
[183.149461] [018/133] (836s left) kms_psr (fbc-psr2-sprite-plane-move)
[183.245158] Starting subtest: fbc-psr2-sprite-plane-move
[183.247478] Starting dynamic subtest: eDP-1
[183.251921] Dynamic subtest eDP-1: SKIP (0.000s)
[183.256426] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[183.314906] [019/133] (836s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[183.421232] Starting subtest: yf-tiled-64bpp-rotate-0
[183.425180] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[183.519462] [020/133] (835s left) gem_softpin (evict-prime)
[183.573050] Starting subtest: evict-prime
[183.575662] Starting dynamic subtest: rcs0
[184.730102] Dynamic subtest rcs0: SUCCESS (1.157s)
[184.741357] Starting dynamic subtest: bcs0
[185.855213] Dynamic subtest bcs0: SUCCESS (1.123s)
[185.865726] Starting dynamic subtest: vcs0
[187.859911] Dynamic subtest vcs0: SUCCESS (2.001s)
[187.871068] Starting dynamic subtest: vcs1
[189.844078] Dynamic subtest vcs1: SUCCESS (1.982s)
[189.853800] Starting dynamic subtest: vecs0
[191.903810] Dynamic subtest vecs0: SUCCESS (2.057s)
[191.914750] Starting dynamic subtest: ccs0
[193.026713] Dynamic subtest ccs0: SUCCESS (1.122s)
[193.036629] Starting dynamic subtest: all
[194.835740] Dynamic subtest all: SUCCESS (1.806s)
[194.838529] Subtest evict-prime: SUCCESS (11.263s)
[194.916388] [021/133] (824s left) kms_content_protection (dp-mst-lic-type-0)
[195.056743] Starting subtest: dp-mst-lic-type-0
[195.061190] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[195.159624] [022/133] (824s left) gem_exec_balancer (invalid-bonds)
[195.222565] Starting subtest: invalid-bonds
[195.227063] Subtest invalid-bonds: SKIP (0.000s)
[195.518586] [023/133] (824s left) gem_mmap (bad-offset)
[195.566787] Subtest bad-offset: SKIP (0.000s)
[195.637008] [024/133] (823s left) gem_exec_reloc (basic-write-wc)
[195.693613] Subtest basic-write-wc: SKIP (0.000s)
[195.777114] [025/133] (823s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[195.875743] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[195.879609] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[195.944379] [026/133] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[196.043153] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[196.047123] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[196.142746] [027/133] (823s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[196.240985] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[196.245263] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[196.361322] [028/133] (823s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[196.743340] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[197.561110] [029/133] (822s left) kms_psr (psr-sprite-blt)
[197.681158] Starting subtest: psr-sprite-blt
[197.683481] Starting dynamic subtest: eDP-1
[199.406580] Dynamic subtest eDP-1: SUCCESS (1.725s)
[199.408777] Subtest psr-sprite-blt: SUCCESS (1.726s)
[200.242893] [030/133] (819s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[200.338100] Starting subtest: basic-modeset-with-all-modifiers-formats
[200.711333] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[201.520347] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.811s)
[201.528803] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[201.542341] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[201.549759] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[201.564591] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[201.572017] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[201.720225] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[201.728317] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[201.742537] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[201.750380] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[201.764526] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[201.772071] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[201.786581] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[201.794168] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[201.808879] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[201.819040] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[201.831488] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.019s)
[201.840530] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[201.853220] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[201.860861] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[201.875798] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[201.883370] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[201.898029] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[201.905761] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[202.042579] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.143s)
[202.051019] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[202.064721] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[202.074526] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[202.086988] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[202.094932] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[202.109140] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[202.116648] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[202.131508] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.020s)
[202.141180] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[202.153321] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[202.161019] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[202.175848] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[202.183213] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[202.198069] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[202.205672] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[202.220025] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[202.227228] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[202.375895] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[202.384268] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[202.397921] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[202.405062] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[202.420256] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[202.427513] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[202.442272] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[202.449322] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[202.464697] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[202.471843] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[202.486845] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[202.494143] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[202.509234] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[202.516119] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[202.531103] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[202.538233] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[202.553502] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[202.937830] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.602s)
[203.722962] [031/133] (816s left) gem_exec_whisper (basic-fds-forked-all)
[203.780764] Starting subtest: basic-fds-forked-all
[223.968799] Subtest basic-fds-forked-all: SUCCESS (20.185s)
[224.166710] [032/133] (795s left) kms_big_fb (x-tiled-addfb)
[224.272847] Starting subtest: x-tiled-addfb
[224.274983] Subtest x-tiled-addfb: SUCCESS (0.000s)
[224.365076] [033/133] (795s left) perf (invalid-oa-format-id)
[224.484781] Starting subtest: invalid-oa-format-id
[224.498147] Subtest invalid-oa-format-id: SUCCESS (0.012s)
[224.549561] [034/133] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[224.649182] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[224.653161] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[224.766381] [035/133] (795s left) kms_addfb_basic (bad-pitch-0)
[224.824636] Starting subtest: bad-pitch-0
[224.827666] Subtest bad-pitch-0: SUCCESS (0.000s)
[224.965411] [036/133] (795s left) gem_exec_endless (dispatch)
[225.040545] Starting subtest: dispatch
[225.042964] Starting dynamic subtest: rcs0
[225.050383] Dynamic subtest rcs0: SUCCESS (0.005s)
[225.061423] Starting dynamic subtest: bcs0
[225.065802] Dynamic subtest bcs0: SUCCESS (0.005s)
[225.074361] Starting dynamic subtest: vcs0
[225.078621] Dynamic subtest vcs0: SUCCESS (0.005s)
[225.087282] Starting dynamic subtest: vcs1
[225.090745] Dynamic subtest vcs1: SUCCESS (0.005s)
[225.099570] Starting dynamic subtest: vecs0
[225.103074] Dynamic subtest vecs0: SUCCESS (0.012s)
[225.113858] Starting dynamic subtest: ccs0
[225.117408] Dynamic subtest ccs0: SUCCESS (0.012s)
[225.119009] Subtest dispatch: SUCCESS (0.054s)
[226.941533] [037/133] (793s left) kms_atomic (plane-immutable-zpos)
[227.039246] Starting subtest: plane-immutable-zpos
[227.041449] Starting dynamic subtest: pipe-A-eDP-1
[227.683114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[227.685808] Subtest plane-immutable-zpos: SUCCESS (0.644s)
[228.538046] [038/133] (791s left) kms_chamelium_color (ctm-0-25)
[228.638712] Subtest ctm-0-25: SKIP (0.000s)
[228.687836] [039/133] (791s left) gem_create (create-ext-cpu-access-big)
[228.843342] Starting subtest: create-ext-cpu-access-big
[228.848369] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[228.914826] [040/133] (791s left) perf (buffer-fill)
[229.008954] Starting subtest: buffer-fill
[229.011364] Starting dynamic subtest: 0-rcs0
[231.277908] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[231.286448] Starting dynamic subtest: 1-vecs0
[235.736106] Dynamic subtest 1-vecs0: SUCCESS (4.457s)
[235.738653] Subtest buffer-fill: SUCCESS (6.730s)
[235.783252] [041/133] (784s left) sw_sync (sync_multi_consumer_producer)
[235.818047] Starting subtest: sync_multi_consumer_producer
[236.153651] Subtest sync_multi_consumer_producer: SUCCESS (0.336s)
[236.213822] [042/133] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[236.312093] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[236.316283] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[236.413978] [043/133] (783s left) sysfs_timeslice_duration (idempotent)
[236.469890] Starting subtest: idempotent
[236.472234] Starting dynamic subtest: vecs0
[236.474509] Dynamic subtest vecs0: SUCCESS (0.000s)
[236.482799] Starting dynamic subtest: ccs0
[236.485116] Dynamic subtest ccs0: SUCCESS (0.000s)
[236.492951] Starting dynamic subtest: vcs0
[236.495167] Dynamic subtest vcs0: SUCCESS (0.000s)
[236.503061] Starting dynamic subtest: bcs0
[236.505268] Dynamic subtest bcs0: SUCCESS (0.000s)
[236.513371] Starting dynamic subtest: rcs0
[236.515571] Dynamic subtest rcs0: SUCCESS (0.000s)
[236.523216] Starting dynamic subtest: vcs1
[236.525355] Dynamic subtest vcs1: SUCCESS (0.000s)
[236.527586] Subtest idempotent: SUCCESS (0.006s)
[236.610939] [044/133] (783s left) syncobj_timeline (invalid-transfer-bad-pad)
[236.657671] Starting subtest: invalid-transfer-bad-pad
[236.659920] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[236.747149] [045/133] (783s left) syncobj_basic (bad-pad-handle-to-fd)
[236.806450] Starting subtest: bad-pad-handle-to-fd
[236.808679] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[236.917117] [046/133] (783s left) gem_softpin (evict-snoop-interruptible)
[236.971466] Starting subtest: evict-snoop-interruptible
[236.976049] Subtest evict-snoop-interruptible: SKIP (0.000s)
[237.092209] [047/133] (783s left) kms_psr (psr2-sprite-plane-move)
[237.187351] Starting subtest: psr2-sprite-plane-move
[237.189229] Starting dynamic subtest: eDP-1
[238.965418] Dynamic subtest eDP-1: SUCCESS (1.776s)
[238.967675] Subtest psr2-sprite-plane-move: SUCCESS (1.777s)
[239.799260] [048/133] (780s left) syncobj_wait (invalid-wait-bad-flags)
[239.856511] Starting subtest: invalid-wait-bad-flags
[239.858813] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[239.943765] [049/133] (780s left) gem_exec_fence (syncobj-timeline-signal)
[240.560779] Starting subtest: syncobj-timeline-signal
[240.568121] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[241.946327] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[241.949628] [050/133] (778s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[241.993087] Starting subtest: etime-multi-wait-all-submitted-signaled
[242.096246] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[242.175609] [051/133] (778s left) gem_userptr_blits (readonly-unsync)
[242.244236] Subtest readonly-unsync: SKIP (0.000s)
[242.365648] [052/133] (778s left) gem_mmap_wc (pf-nonblock)
[242.440700] Subtest pf-nonblock: SKIP (0.000s)
[242.495946] [053/133] (778s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[242.588910] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[242.602874] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[242.676892] [054/133] (778s left) gem_partial_pwrite_pread (write-uncached)
[242.743500] Subtest write-uncached: SKIP (0.000s)
[242.824100] [055/133] (778s left) gen9_exec_parse (bb-start-far)
[242.884089] Subtest bb-start-far: SKIP (0.000s)
[242.954675] [056/133] (777s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[243.483061] Starting subtest: syncobj-timeline-multiple-ext-nodes
[243.485455] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[244.952093] [057/133] (775s left) perf_pmu (render-node-busy)
[245.006986] Starting subtest: render-node-busy
[245.009385] Starting dynamic subtest: rcs0
[245.593222] Dynamic subtest rcs0: SUCCESS (0.586s)
[245.604619] Starting dynamic subtest: bcs0
[246.157702] Dynamic subtest bcs0: SUCCESS (0.562s)
[246.168990] Starting dynamic subtest: vcs0
[247.893961] Dynamic subtest vcs0: SUCCESS (1.732s)
[247.905577] Starting dynamic subtest: vcs1
[249.941229] Dynamic subtest vcs1: SUCCESS (2.044s)
[249.950929] Starting dynamic subtest: vecs0
[251.925050] Dynamic subtest vecs0: SUCCESS (1.981s)
[251.938511] Starting dynamic subtest: ccs0
[252.486640] Dynamic subtest ccs0: SUCCESS (0.560s)
[252.489379] Subtest render-node-busy: SUCCESS (7.481s)
[252.566956] [058/133] (768s left) gem_create (create-valid-nonaligned)
[252.626544] Starting subtest: create-valid-nonaligned
[252.628970] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[252.857071] [059/133] (768s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[252.918293] Starting subtest: etime-multi-wait-all-for-submit-submitted
[253.025047] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[253.107999] [060/133] (768s left) gem_exec_params (invalid-fence-in)
[253.169726] Starting subtest: invalid-fence-in
[253.172231] Subtest invalid-fence-in: SUCCESS (0.000s)
[253.285349] [061/133] (767s left) gem_exec_schedule (preempt)
[253.373616] Starting subtest: preempt
[253.375707] Starting dynamic subtest: rcs0
[253.402477] Dynamic subtest rcs0: SUCCESS (0.033s)
[253.413892] Starting dynamic subtest: bcs0
[253.437794] Dynamic subtest bcs0: SUCCESS (0.034s)
[253.446174] Starting dynamic subtest: vcs0
[253.470096] Dynamic subtest vcs0: SUCCESS (0.032s)
[253.478714] Starting dynamic subtest: vcs1
[253.498936] Dynamic subtest vcs1: SUCCESS (0.027s)
[253.508362] Starting dynamic subtest: vecs0
[253.525034] Dynamic subtest vecs0: SUCCESS (0.026s)
[253.533709] Starting dynamic subtest: ccs0
[253.557836] Dynamic subtest ccs0: SUCCESS (0.032s)
[253.560075] Subtest preempt: SUCCESS (0.189s)
[255.011858] [062/133] (766s left) kms_cursor_crc (cursor-onscreen-512x512)
[255.284814] Starting subtest: cursor-onscreen-512x512
[255.289127] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[255.427303] [063/133] (765s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[255.508697] Starting subtest: psr-dirtyfb-ioctl
[255.510961] Starting dynamic subtest: A-eDP-1
[259.440692] Dynamic subtest A-eDP-1: SUCCESS (3.930s)
[259.442865] Subtest psr-dirtyfb-ioctl: SUCCESS (3.931s)
[260.305171] [064/133] (760s left) perf (mi-rpc)
[260.390593] Starting subtest: mi-rpc
[260.394929] Subtest mi-rpc: SKIP (0.000s)
[260.434444] [065/133] (760s left) kms_frontbuffer_tracking (fbc-tiling-y)
[260.540682] Starting subtest: fbc-tiling-y
[260.545108] Subtest fbc-tiling-y: SKIP (0.000s)
[260.648660] [066/133] (760s left) gem_userptr_blits (coherency-unsync)
[260.716262] Subtest coherency-unsync: SKIP (0.000s)
[260.832190] [067/133] (760s left) kms_vrr (max-min)
[260.928200] Starting subtest: max-min
[260.934223] Subtest max-min: SKIP (0.000s)
[260.997671] [068/133] (760s left) syncobj_timeline (wait-any-interrupted)
[261.062417] Starting subtest: wait-any-interrupted
[261.165115] Subtest wait-any-interrupted: SUCCESS (0.102s)
[261.239830] [069/133] (760s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[261.341591] Starting subtest: plane-primary-toggle-with-vblank-wait
[261.343986] Starting dynamic subtest: pipe-A-eDP-1
[261.521521] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.179s)
[261.829348] Starting dynamic subtest: pipe-B-eDP-1
[262.707542] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.887s)
[263.006035] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.666s)
[263.878966] [070/133] (757s left) gem_fenced_exec_thrash (no-spare-fences)
[263.943334] Subtest no-spare-fences: SKIP (0.000s)
[264.019577] [071/133] (757s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[264.116705] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[264.118809] Starting dynamic subtest: pipe-A
[265.175880] Dynamic subtest pipe-A: SUCCESS (1.061s)
[265.183845] Starting dynamic subtest: pipe-B
[267.267751] Dynamic subtest pipe-B: SUCCESS (2.091s)
[267.276125] Starting dynamic subtest: pipe-C
[268.471054] Dynamic subtest pipe-C: SUCCESS (1.202s)
[268.481197] Starting dynamic subtest: pipe-D
[269.707830] Dynamic subtest pipe-D: SUCCESS (1.235s)
[269.710223] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.594s)
[270.892330] [072/133] (750s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[270.993868] Starting subtest: plane-lut1d-post-ctm3x4
[271.140332] Starting dynamic subtest: pipe-A-plane-0
[271.351645] Dynamic subtest pipe-A-plane-0: SUCCESS (0.211s)
[271.361242] Starting dynamic subtest: pipe-A-plane-1
[271.518277] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[271.526918] Starting dynamic subtest: pipe-A-plane-2
[271.707241] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[272.928543] Starting dynamic subtest: pipe-B-plane-0
[273.077674] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[273.086403] Starting dynamic subtest: pipe-B-plane-1
[273.244529] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[273.253511] Starting dynamic subtest: pipe-B-plane-2
[273.422131] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[274.637385] Starting dynamic subtest: pipe-C-plane-0
[274.786103] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[274.794634] Starting dynamic subtest: pipe-C-plane-1
[274.953519] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[274.962027] Starting dynamic subtest: pipe-C-plane-2
[275.122750] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[276.352041] Starting dynamic subtest: pipe-D-plane-0
[276.500664] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[276.509935] Starting dynamic subtest: pipe-D-plane-1
[276.645046] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[276.653867] Starting dynamic subtest: pipe-D-plane-2
[276.800521] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[277.088674] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.093s)
[277.945920] [073/133] (743s left) api_intel_bb (add-remove-objects)
[278.016704] Starting subtest: add-remove-objects
[278.021823] Subtest add-remove-objects: SUCCESS (0.006s)
[278.152301] [074/133] (743s left) gem_mmap_offset (close-race)
[278.203564] Starting subtest: close-race
[298.322342] Subtest close-race: SUCCESS (20.117s)
[298.484135] [075/133] (723s left) kms_pm_rpm (fences-dpms)
[300.041059] Starting subtest: fences-dpms
[300.045852] Subtest fences-dpms: SKIP (0.000s)
[300.776849] [076/133] (721s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[300.843104] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[300.906160] [077/133] (720s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.009975] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[301.779326] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.771s)
[301.955461] [078/133] (719s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[302.053249] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[302.055574] Starting dynamic subtest: pipe-A-eDP-1
[302.075866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[302.086393] Starting dynamic subtest: pipe-B-eDP-1
[302.105633] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[302.113378] Starting dynamic subtest: pipe-C-eDP-1
[302.132322] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[302.140097] Starting dynamic subtest: pipe-D-eDP-1
[302.159180] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[302.161075] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[304.246288] [079/133] (717s left) gem_exec_reloc (basic-cpu-active)
[304.308505] Subtest basic-cpu-active: SKIP (0.000s)
[304.374522] [080/133] (717s left) kms_lease (invalid-create-leases)
[304.460555] Starting subtest: invalid-create-leases
[304.465081] Subtest invalid-create-leases: SUCCESS (0.005s)
[304.584130] [081/133] (717s left) gem_ctx_exec (basic)
[304.632076] Starting subtest: basic
[304.637320] Subtest basic: SUCCESS (0.007s)
[304.743297] [082/133] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[304.848529] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[304.852940] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[304.946895] [083/133] (717s left) kms_flip (flip-vs-suspend)
[305.028076] Starting subtest: flip-vs-suspend
[305.030668] Starting dynamic subtest: A-eDP1
[421.737329] Dynamic subtest A-eDP1: SUCCESS (12.011s)
[421.739625] Subtest flip-vs-suspend: SUCCESS (12.014s)
[428.880227] [084/133] (600s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[428.981428] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[428.983472] Starting dynamic subtest: pipe-A-eDP-1
[428.991869] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.006110] Starting dynamic subtest: pipe-B-eDP-1
[429.014269] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.025502] Starting dynamic subtest: pipe-C-eDP-1
[429.033293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.041126] Starting dynamic subtest: pipe-D-eDP-1
[429.048903] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[429.052779] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[431.151466] [085/133] (598s left) api_intel_bb (object-noreloc-purge-cache-simple)
[431.200178] Starting subtest: object-noreloc-purge-cache-simple
[431.205918] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[431.325524] [086/133] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[431.419724] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[438.007859] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.747s)
[438.153225] [087/133] (591s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[438.244532] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[438.246782] Starting dynamic subtest: pipe-A
[438.589424] Dynamic subtest pipe-A: SUCCESS (0.351s)
[438.607341] Starting dynamic subtest: pipe-B
[440.016068] Dynamic subtest pipe-B: SUCCESS (1.444s)
[440.025134] Starting dynamic subtest: pipe-C
[441.415756] Dynamic subtest pipe-C: SUCCESS (1.413s)
[441.424909] Starting dynamic subtest: pipe-D
[442.846783] Dynamic subtest pipe-D: SUCCESS (1.443s)
[442.848970] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.655s)
[444.016657] [088/133] (585s left) kms_vblank (wait-idle-hang)
[444.113860] Starting subtest: wait-idle-hang
[444.115781] Starting dynamic subtest: pipe-A-eDP-1
[470.358344] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.282s)
[470.373202] Starting dynamic subtest: pipe-D-eDP-1
[485.380420] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.018s)
[485.382481] Subtest wait-idle-hang: SUCCESS (41.304s)
[486.236433] [089/133] (543s left) gem_basic (bad-close)
[486.286697] Starting subtest: bad-close
[486.290917] Subtest bad-close: SUCCESS (0.000s)
[486.388084] [090/133] (543s left) i915_hangman (gt-engine-error)
[486.445135] Starting subtest: gt-engine-error
[486.447265] Starting dynamic subtest: rcs0
[487.593773] Dynamic subtest rcs0: SUCCESS (1.147s)
[487.606692] Starting dynamic subtest: bcs0
[489.577909] Dynamic subtest bcs0: SUCCESS (1.981s)
[489.590625] Starting dynamic subtest: vcs0
[491.561386] Dynamic subtest vcs0: SUCCESS (1.981s)
[491.573395] Starting dynamic subtest: vcs1
[493.546229] Dynamic subtest vcs1: SUCCESS (1.982s)
[493.558629] Starting dynamic subtest: vecs0
[495.593922] Dynamic subtest vecs0: SUCCESS (2.045s)
[495.610724] Starting dynamic subtest: ccs0
[497.577899] Dynamic subtest ccs0: SUCCESS (1.981s)
[497.580464] Subtest gt-engine-error: SUCCESS (11.136s)
[497.701468] [091/133] (531s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[497.820783] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[497.825006] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[497.944175] [092/133] (531s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[498.068983] Starting subtest: cursorB-vs-flipB-toggle
[498.073196] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[498.213665] [093/133] (531s left) kms_hdmi_inject (inject-4k)
[498.555169] Starting subtest: inject-4k
[498.869152] Subtest inject-4k: SUCCESS (0.316s)
[499.381207] [094/133] (530s left) i915_suspend (debugfs-reader)
[499.440498] Starting subtest: debugfs-reader
[518.710547] Subtest debugfs-reader: SUCCESS (3.538s)
[529.944984] [095/133] (510s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[530.076070] Starting subtest: short-flip-after-cursor-atomic-transitions
[531.024692] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.949s)
[531.910360] [096/133] (509s left) kms_pm_rpm (basic-pci-d3-state)
[533.441801] Starting subtest: basic-pci-d3-state
[534.953873] Subtest basic-pci-d3-state: SUCCESS (1.515s)
[535.074714] [097/133] (505s left) gem_userptr_blits (huge-split)
[535.149249] Starting subtest: huge-split
[535.156498] Subtest huge-split: SUCCESS (0.007s)
[535.274685] [098/133] (505s left) kms_cursor_crc (cursor-suspend)
[535.401431] Starting subtest: cursor-suspend
[535.403883] Starting dynamic subtest: pipe-A-eDP-1
[569.212689] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.971s)
[569.222434] Starting dynamic subtest: pipe-D-eDP-1