[56.568581] Initializing watchdogs
[56.568653]   /dev/watchdog0
[56.583185] [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]
[56.587625] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.589933] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.593289] [001/133] (960s left) gem_exec_fence (syncobj-wait)
[57.065820] Starting subtest: syncobj-wait
[58.965852] Subtest syncobj-wait: SUCCESS (1.901s)
[60.962753] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[60.966009] [002/133] (956s left) kms_plane_alpha_blend (alpha-opaque-fb)
[61.074849] Starting subtest: alpha-opaque-fb
[61.373053] Starting dynamic subtest: pipe-A-eDP-1
[62.017771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[62.026505] Starting dynamic subtest: pipe-D-eDP-1
[63.380200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.361s)
[63.382626] Subtest alpha-opaque-fb: SUCCESS (2.306s)
[64.213429] [003/133] (952s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[64.608789] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[65.410536] [004/133] (951s left) i915_pm_rps (basic-api)
[65.483146] Starting subtest: basic-api
[65.487763] Subtest basic-api: SKIP (0.001s)
[65.600204] [005/133] (951s left) kms_content_protection (lic-type-0)
[65.747806] Starting subtest: lic-type-0
[65.752390] Subtest lic-type-0: SKIP (0.000s)
[65.896792] [006/133] (951s left) syncobj_timeline (wait-all-complex)
[65.955907] Starting subtest: wait-all-complex
[66.168435] Subtest wait-all-complex: SUCCESS (0.213s)
[66.259943] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[66.362903] Starting subtest: fbcpsr-2p-rte
[66.366245] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[66.485797] [008/133] (950s left) gem_softpin (evict-single-offset)
[66.541320] Starting subtest: evict-single-offset
[95.897619] Subtest evict-single-offset: SUCCESS (29.355s)
[95.994397] [009/133] (921s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[96.098809] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[96.103484] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[96.295267] [010/133] (921s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[96.417984] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[96.422235] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[96.557751] [011/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[96.668779] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[96.673063] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[96.796203] [012/133] (920s left) kms_cursor_edge_walk (64x64-right-edge)
[96.906053] Starting subtest: 64x64-right-edge
[96.908395] Starting dynamic subtest: pipe-A-eDP-1
[100.388963] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[100.398968] Starting dynamic subtest: pipe-D-eDP-1
[103.524213] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[103.526185] Subtest 64x64-right-edge: SUCCESS (6.616s)
[104.347597] [013/133] (913s left) api_intel_allocator (execbuf-with-allocator)
[104.411736] Starting subtest: execbuf-with-allocator
[104.414031] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[104.565707] [014/133] (913s left) syncobj_timeline (multi-wait-available-signaled)
[104.622362] Starting subtest: multi-wait-available-signaled
[104.624806] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[104.744282] [015/133] (912s left) gem_busy (extended)
[104.934828] Starting subtest: extended
[104.937682] Starting dynamic subtest: rcs0
[105.011710] Dynamic subtest rcs0: SUCCESS (0.077s)
[105.021889] Starting dynamic subtest: bcs0
[105.053511] Dynamic subtest bcs0: SUCCESS (0.041s)
[105.062763] Starting dynamic subtest: vcs0
[106.899638] Dynamic subtest vcs0: SUCCESS (1.845s)
[106.910585] Starting dynamic subtest: vcs1
[108.885628] Dynamic subtest vcs1: SUCCESS (1.982s)
[108.896732] Starting dynamic subtest: vecs0
[110.932430] Dynamic subtest vecs0: SUCCESS (2.046s)
[110.940542] Starting dynamic subtest: ccs0
[110.975825] Dynamic subtest ccs0: SUCCESS (0.044s)
[110.978172] Subtest extended: SUCCESS (6.042s)
[111.242311] [016/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[111.362605] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[111.366759] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[111.489060] [017/133] (906s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[111.595271] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[111.597546] Starting dynamic subtest: pipe-A-eDP-1
[111.669077] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[111.678777] Starting dynamic subtest: pipe-B-eDP-1
[112.804049] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[112.808448] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.213s)
[114.108737] [018/133] (903s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[114.211529] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[114.214057] Starting dynamic subtest: pipe-A-default-mode
[115.363747] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[115.367633] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.152s)
[115.566960] [019/133] (902s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[115.681387] Starting subtest: x-tiled-16bpp-rotate-180
[116.992870] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.313s)
[117.138181] [020/133] (900s left) gem_workarounds (suspend-resume)
[117.207112] Starting subtest: suspend-resume
[132.865925] Subtest suspend-resume: SUCCESS (1.294s)
[133.026659] [021/133] (884s left) kms_draw_crc (draw-method-blt)
[133.129719] Starting subtest: draw-method-blt
[133.131906] Starting dynamic subtest: xrgb8888-untiled
[133.349498] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[133.359357] Starting dynamic subtest: rgb565-untiled
[133.549726] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[133.559424] Starting dynamic subtest: xrgb2101010-untiled
[133.760875] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[133.770474] Starting dynamic subtest: xbgr16161616f-untiled
[133.960683] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[133.969954] Starting dynamic subtest: xrgb8888-xtiled
[134.071927] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[134.080540] Starting dynamic subtest: rgb565-xtiled
[134.182924] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[134.191343] Starting dynamic subtest: xrgb2101010-xtiled
[134.283209] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[134.291506] Starting dynamic subtest: xbgr16161616f-xtiled
[134.383004] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.100s)
[134.391890] Starting dynamic subtest: xrgb8888-4tiled
[134.494478] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[134.503334] Starting dynamic subtest: rgb565-4tiled
[134.605548] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[134.614482] Starting dynamic subtest: xrgb2101010-4tiled
[134.705971] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.100s)
[134.718865] Starting dynamic subtest: xbgr16161616f-4tiled
[134.805800] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[134.807779] Subtest draw-method-blt: SUCCESS (1.678s)
[134.948225] [022/133] (883s left) kms_pm_backlight (brightness-with-dpms)
[135.046669] Starting subtest: brightness-with-dpms
[135.097984] Starting dynamic subtest: eDP-1
[137.517100] Dynamic subtest eDP-1: SUCCESS (2.416s)
[137.519482] Subtest brightness-with-dpms: SUCCESS (2.469s)
[138.397762] [023/133] (879s left) kms_psr (fbc-psr-suspend)
[138.503597] Starting subtest: fbc-psr-suspend
[138.505544] Starting dynamic subtest: eDP-1
[138.509625] Dynamic subtest eDP-1: SKIP (0.000s)
[138.513672] Subtest fbc-psr-suspend: SKIP (0.001s)
[138.586677] [024/133] (879s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[138.687785] Starting subtest: y-tiled-64bpp-rotate-0
[138.692247] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[138.820382] [025/133] (879s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[138.922164] Starting subtest: fbc-rgb565-draw-pwrite
[143.455489] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.535s)
[144.603204] [026/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[144.704717] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[144.707231] Starting dynamic subtest: pipe-A-default-mode
[145.840104] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[145.844734] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.135s)
[146.045186] [027/133] (872s left) gem_mmap_gtt (basic-short)
[146.113447] Subtest basic-short: SKIP (0.000s)
[146.179606] [028/133] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[146.297323] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[153.682217] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.389s)
[153.866333] [029/133] (864s left) kms_getfb (getfb-reject-nv12)
[153.969527] Starting subtest: getfb-reject-nv12
[153.971748] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[154.115383] [030/133] (864s left) kms_big_fb (linear-16bpp-rotate-270)
[154.219815] Starting subtest: linear-16bpp-rotate-270
[154.238795] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[154.388304] [031/133] (863s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[154.513665] Starting subtest: 2x-long-cursor-vs-flip-atomic
[154.518295] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[154.668252] [032/133] (863s left) gem_lmem_swapping (heavy-verify-random)
[154.712800] Subtest heavy-verify-random: SKIP (0.000s)
[154.760964] [033/133] (863s left) gen9_exec_parse (valid-registers)
[154.813862] Subtest valid-registers: SKIP (0.000s)
[154.887277] [034/133] (863s left) kms_invalid_mode (zero-clock)
[154.982307] Starting subtest: zero-clock
[154.984380] Starting dynamic subtest: pipe-A-eDP-1
[155.270788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[155.281066] Starting dynamic subtest: pipe-B-eDP-1
[155.283330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[155.291770] Starting dynamic subtest: pipe-C-eDP-1
[155.294096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[155.302095] Starting dynamic subtest: pipe-D-eDP-1
[155.304057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[155.305972] Subtest zero-clock: SUCCESS (0.293s)
[156.095500] [035/133] (862s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[156.209699] Starting subtest: 4-tiled-32bpp-rotate-90
[156.229047] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[156.355137] [036/133] (862s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[156.467202] Starting subtest: primary-y-tiled-reflect-x-270
[156.471626] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[156.556160] [037/133] (862s left) gem_exec_capture (capture)
[156.622728] Starting subtest: capture
[156.625495] Starting dynamic subtest: rcs0-smem
[157.457890] Dynamic subtest rcs0-smem: SUCCESS (0.834s)
[157.466429] Starting dynamic subtest: bcs0-smem
[158.285013] Dynamic subtest bcs0-smem: SUCCESS (0.825s)
[158.295280] Starting dynamic subtest: vcs0-smem
[159.113137] Dynamic subtest vcs0-smem: SUCCESS (0.826s)
[159.121778] Starting dynamic subtest: vcs1-smem
[159.935137] Dynamic subtest vcs1-smem: SUCCESS (0.822s)
[159.943977] Starting dynamic subtest: vecs0-smem
[161.337100] Dynamic subtest vecs0-smem: FAIL (1.343s)
[161.347190] Starting dynamic subtest: ccs0-smem
[162.604002] Dynamic subtest ccs0-smem: SUCCESS (1.326s)
[162.606425] Subtest capture: FAIL (5.979s)
[162.781220] [038/133] (855s left) kms_cursor_crc (cursor-offscreen-256x85)
[163.030260] Starting subtest: cursor-offscreen-256x85
[163.075440] Subtest cursor-offscreen-256x85: SKIP (0.043s)
[163.279543] [039/133] (855s left) syncobj_timeline (invalid-transfer-non-existent-point)
[163.348109] Starting subtest: invalid-transfer-non-existent-point
[163.350591] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[163.475686] [040/133] (855s left) kms_plane_scaling (invalid-parameters)
[163.578748] Starting subtest: invalid-parameters
[163.580620] Starting dynamic subtest: less-than-1-height-src
[163.592384] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[163.604853] Starting dynamic subtest: less-than-1-width-src
[163.606787] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[163.608448] Subtest invalid-parameters: SUCCESS (0.026s)
[163.727462] [041/133] (855s left) kms_getfb (getfb-addfb-different-handles)
[163.833859] Starting subtest: getfb-addfb-different-handles
[163.835844] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[163.962568] [042/133] (854s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[164.081344] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[173.134326] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.060s)
[174.015651] [043/133] (844s left) kms_lease (simple-lease)
[174.116293] Starting subtest: simple-lease
[174.118836] Starting dynamic subtest: pipe-A-eDP-1
[174.618495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s)
[174.628235] Starting dynamic subtest: pipe-B-eDP-1
[176.033135] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.411s)
[176.042720] Starting dynamic subtest: pipe-C-eDP-1
[177.441536] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s)
[177.451048] Starting dynamic subtest: pipe-D-eDP-1
[178.835887] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.393s)
[178.838174] Subtest simple-lease: SUCCESS (4.723s)
[179.668656] [044/133] (839s left) gem_exec_whisper (basic-fds-priority-all)
[179.734819] Starting subtest: basic-fds-priority-all
[201.520842] Subtest basic-fds-priority-all: SUCCESS (21.789s)
[201.719025] [045/133] (817s left) kms_flip (2x-blocking-wf_vblank)
[201.818727] Starting subtest: 2x-blocking-wf_vblank
[201.829741] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[201.920698] [046/133] (817s left) core_auth (getclient-master-drop)
[201.958243] Starting subtest: getclient-master-drop
[201.975902] Subtest getclient-master-drop: SUCCESS (0.020s)
[202.083183] [047/133] (816s left) sysfs_defaults (readonly)
[202.155664] Starting subtest: readonly
[202.158207] Starting dynamic subtest: vecs0
[202.160923] Dynamic subtest vecs0: SUCCESS (0.000s)
[202.172156] Starting dynamic subtest: ccs0
[202.174378] Dynamic subtest ccs0: SUCCESS (0.000s)
[202.182959] Starting dynamic subtest: vcs0
[202.185262] Dynamic subtest vcs0: SUCCESS (0.000s)
[202.195913] Starting dynamic subtest: bcs0
[202.198005] Dynamic subtest bcs0: SUCCESS (0.000s)
[202.207053] Starting dynamic subtest: rcs0
[202.208943] Dynamic subtest rcs0: SUCCESS (0.000s)
[202.217286] Starting dynamic subtest: vcs1
[202.219620] Dynamic subtest vcs1: SUCCESS (0.000s)
[202.221772] Subtest readonly: SUCCESS (0.005s)
[202.291194] [048/133] (816s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[202.399277] Starting subtest: cursorA-vs-flipA-toggle
[213.531186] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.132s)
[214.404664] [049/133] (804s left) kms_color (ctm-signed)
[214.522136] Starting subtest: ctm-signed
[214.524161] Starting dynamic subtest: pipe-A-eDP-1
[216.651931] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s)
[216.661812] Starting dynamic subtest: pipe-B-eDP-1
[219.427544] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[219.436978] Starting dynamic subtest: pipe-C-eDP-1
[222.138677] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.710s)
[222.148268] Starting dynamic subtest: pipe-D-eDP-1
[224.806067] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s)
[224.808355] Subtest ctm-signed: SUCCESS (10.286s)
[225.644982] [050/133] (793s left) gem_cs_tlb (engines)
[225.711699] Starting subtest: engines
[225.714089] Starting dynamic subtest: rcs0
[227.869350] Dynamic subtest rcs0: SUCCESS (2.153s)
[227.878427] Starting dynamic subtest: bcs0
[230.023672] Dynamic subtest bcs0: SUCCESS (2.154s)
[230.032757] Starting dynamic subtest: vcs0
[232.177489] Dynamic subtest vcs0: SUCCESS (2.151s)
[232.186616] Starting dynamic subtest: vcs1
[234.333643] Dynamic subtest vcs1: SUCCESS (2.155s)
[234.344866] Starting dynamic subtest: vecs0
[236.487896] Dynamic subtest vecs0: SUCCESS (2.153s)
[236.496523] Starting dynamic subtest: ccs0
[238.642469] Dynamic subtest ccs0: SUCCESS (2.153s)
[238.645359] Subtest engines: SUCCESS (12.926s)
[238.791660] [051/133] (780s left) gem_eio (wait-wedge-immediate)
[239.029926] Starting subtest: wait-wedge-immediate
[240.323829] Subtest wait-wedge-immediate: SUCCESS (1.295s)
[240.508397] [052/133] (778s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[240.633864] Starting subtest: 2x-long-cursor-vs-flip-legacy
[240.638303] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[240.816847] [053/133] (778s left) gem_flink_basic (flink-lifetime)
[240.884040] Starting subtest: flink-lifetime
[240.886468] Subtest flink-lifetime: SUCCESS (0.002s)
[241.010863] [054/133] (778s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[241.063701] Subtest tiled-to-tiled: SKIP (0.000s)
[241.140092] [055/133] (778s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[241.250845] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[241.252626] Starting dynamic subtest: pipe-A-eDP-1
[241.272820] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[241.282853] Starting dynamic subtest: pipe-B-eDP-1
[241.301868] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[241.310851] Starting dynamic subtest: pipe-C-eDP-1
[241.329559] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[241.338832] Starting dynamic subtest: pipe-D-eDP-1
[241.359379] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[241.362886] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[243.504675] [056/133] (775s left) perf_pmu (multi-client)
[243.540330] Starting subtest: multi-client
[243.542615] Starting dynamic subtest: rcs0
[244.604210] Dynamic subtest rcs0: SUCCESS (1.062s)
[244.616359] Starting dynamic subtest: bcs0
[245.659264] Dynamic subtest bcs0: SUCCESS (1.052s)
[245.670349] Starting dynamic subtest: vcs0
[246.707192] Dynamic subtest vcs0: SUCCESS (1.045s)
[246.719031] Starting dynamic subtest: vcs1
[248.293962] Dynamic subtest vcs1: SUCCESS (1.584s)
[248.306364] Starting dynamic subtest: vecs0
[250.280004] Dynamic subtest vecs0: SUCCESS (1.983s)
[250.292133] Starting dynamic subtest: ccs0
[252.265751] Dynamic subtest ccs0: SUCCESS (1.983s)
[252.268341] Subtest multi-client: SUCCESS (8.725s)
[252.407397] [057/133] (767s left) device_reset (unbind-cold-reset-rebind)
[252.468812] Starting subtest: unbind-cold-reset-rebind
[252.473029] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[252.554847] [058/133] (766s left) kms_psr (fbc-psr-sprite-blt)
[252.686035] Starting subtest: fbc-psr-sprite-blt
[252.688388] Starting dynamic subtest: eDP-1
[252.692795] Dynamic subtest eDP-1: SKIP (0.000s)
[252.696849] Subtest fbc-psr-sprite-blt: SKIP (0.003s)
[252.775776] [059/133] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[252.883922] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[257.382971] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.502s)
[258.514739] [060/133] (761s left) gem_exec_fence (nb-await)
[258.684755] Starting subtest: nb-await
[258.687154] Starting dynamic subtest: rcs0
[258.749257] Dynamic subtest rcs0: SUCCESS (0.064s)
[258.765020] Starting dynamic subtest: bcs0
[258.808926] Dynamic subtest bcs0: SUCCESS (0.057s)
[258.821007] Starting dynamic subtest: vcs0
[258.868688] Dynamic subtest vcs0: SUCCESS (0.057s)
[258.880456] Starting dynamic subtest: vcs1
[258.928718] Dynamic subtest vcs1: SUCCESS (0.057s)
[258.940695] Starting dynamic subtest: vecs0
[258.990508] Dynamic subtest vecs0: SUCCESS (0.060s)
[259.002346] Starting dynamic subtest: ccs0
[259.048580] Dynamic subtest ccs0: SUCCESS (0.056s)
[259.051214] Subtest nb-await: SUCCESS (0.365s)
[261.398794] [061/133] (758s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[261.502273] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[261.515055] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[261.606442] [062/133] (758s left) kms_dp_aux_dev
[261.975854] [063/133] (757s left) gem_workarounds (reset-fd)
[262.047858] Starting subtest: reset-fd
[262.198448] Subtest reset-fd: SUCCESS (0.150s)
[262.363330] [064/133] (757s left) kms_plane_cursor (primary)
[262.468831] Starting subtest: primary
[262.472826] Starting dynamic subtest: pipe-A-eDP-1-size-64
[265.021458] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.552s)
[265.046086] Starting dynamic subtest: pipe-A-eDP-1-size-128
[267.633659] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[267.658828] Starting dynamic subtest: pipe-A-eDP-1-size-256
[270.234242] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s)
[270.552446] Starting dynamic subtest: pipe-B-eDP-1-size-64
[273.850468] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.307s)
[273.882885] Starting dynamic subtest: pipe-B-eDP-1-size-128
[276.405795] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[276.437281] Starting dynamic subtest: pipe-B-eDP-1-size-256
[278.984211] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[279.299581] Starting dynamic subtest: pipe-C-eDP-1-size-64
[282.215535] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.926s)
[282.245565] Starting dynamic subtest: pipe-C-eDP-1-size-128
[284.415768] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[284.443430] Starting dynamic subtest: pipe-C-eDP-1-size-256
[286.637698] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[286.954564] Starting dynamic subtest: pipe-D-eDP-1-size-64
[289.833497] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.890s)
[289.861080] Starting dynamic subtest: pipe-D-eDP-1-size-128
[292.046018] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.193s)
[292.078395] Starting dynamic subtest: pipe-D-eDP-1-size-256
[294.277635] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.213s)
[294.584519] Subtest primary: SUCCESS (32.115s)
[295.412345] [065/133] (724s left) gem_exec_schedule (preempt-queue-contexts-chain)
[295.496875] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[295.796878] [066/133] (724s left) gem_mmap_offset (blt-coherency)
[295.862576] Starting subtest: blt-coherency
[295.867190] Subtest blt-coherency: SUCCESS (0.007s)
[296.032762] [067/133] (723s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[296.122224] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[296.124577] Starting dynamic subtest: pipe-A-eDP-1
[296.148438] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.160743] Starting dynamic subtest: pipe-B-eDP-1
[296.182561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.192356] Starting dynamic subtest: pipe-C-eDP-1
[296.214105] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.223494] Starting dynamic subtest: pipe-D-eDP-1
[296.245644] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.249778] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[298.380508] [068/133] (721s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[298.485041] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[298.489144] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.596890] [069/133] (721s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[298.658462] Starting subtest: etime-single-wait-all-for-submit-submitted
[298.764955] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[298.867697] [070/133] (721s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[299.253917] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[300.077137] [071/133] (719s left) kms_flip (flip-vs-panning-vs-hang)
[300.164431] Starting subtest: flip-vs-panning-vs-hang
[300.166869] Starting dynamic subtest: A-eDP1
[339.736390] Dynamic subtest A-eDP1: SUCCESS (39.573s)
[339.748302] Starting dynamic subtest: D-eDP1
[379.740120] Dynamic subtest D-eDP1: SUCCESS (39.999s)
[379.745562] Subtest flip-vs-panning-vs-hang: SUCCESS (79.578s)
[381.027562] [072/133] (639s left) kms_psr (psr-sprite-plane-onoff)
[381.139796] Starting subtest: psr-sprite-plane-onoff
[381.142067] Starting dynamic subtest: eDP-1
[382.913193] Dynamic subtest eDP-1: SUCCESS (1.773s)
[382.915470] Subtest psr-sprite-plane-onoff: SUCCESS (1.774s)
[383.743963] [073/133] (636s left) gem_pwrite (basic-random)
[383.813093] Subtest basic-random: SKIP (0.000s)
[383.876367] [074/133] (636s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[383.980281] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[383.982381] Starting dynamic subtest: pipe-A-eDP-1
[384.001700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[384.012326] Starting dynamic subtest: pipe-B-eDP-1
[384.031391] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[384.040882] Starting dynamic subtest: pipe-C-eDP-1
[384.059561] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[384.069013] Starting dynamic subtest: pipe-D-eDP-1
[384.088116] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.036s)
[384.090323] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.102s)
[386.325863] [075/133] (633s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[386.425636] Starting subtest: modeset-transition-nonblocking-fencing
[386.427574] Starting dynamic subtest: 1x-outputs
[397.496253] Dynamic subtest 1x-outputs: SUCCESS (11.071s)
[397.499011] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.072s)
[398.373003] [076/133] (621s left) kms_vblank (ts-continuation-modeset-rpm)
[398.481641] Starting subtest: ts-continuation-modeset-rpm
[398.483804] Starting dynamic subtest: pipe-A-eDP-1
[401.056137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.576s)
[401.071443] Starting dynamic subtest: pipe-D-eDP-1
[403.302634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[403.304957] Subtest ts-continuation-modeset-rpm: SUCCESS (4.823s)
[404.108471] [077/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[404.212124] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[411.264760] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.055s)
[411.393029] [078/133] (608s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[411.497022] Starting subtest: yf-tiled-32bpp-rotate-270
[411.501356] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[411.620670] [079/133] (608s left) gem_userptr_blits (input-checking)
[411.680129] Starting subtest: input-checking
[411.682014] Subtest input-checking: SUCCESS (0.000s)
[411.823957] [080/133] (608s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[411.913378] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[411.915705] Starting dynamic subtest: pipe-A-eDP-1
[411.938555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.951274] Starting dynamic subtest: pipe-B-eDP-1
[411.972914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.982253] Starting dynamic subtest: pipe-C-eDP-1
[412.003835] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[412.012669] Starting dynamic subtest: pipe-D-eDP-1
[412.034256] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[412.038625] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[414.203386] [081/133] (606s left) kms_rotation_crc (bad-pixel-format)
[414.315860] Starting subtest: bad-pixel-format
[414.320374] Subtest bad-pixel-format: SKIP (0.003s)
[414.424229] [082/133] (606s left) kms_properties (get_properties-sanity-atomic)
[414.526466] Starting subtest: get_properties-sanity-atomic
[414.528621] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[414.614179] [083/133] (605s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[414.711502] Starting subtest: plane-all-modeset-transition-internal-panels
[414.713599] Starting dynamic subtest: pipe-A-eDP-1
[416.035209] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.324s)
[416.320184] Starting dynamic subtest: pipe-B-eDP-1
[417.354454] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.044s)
[417.625307] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.916s)
[418.469887] [084/133] (602s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[418.571573] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[418.573823] Starting dynamic subtest: pipe-A
[418.594155] Dynamic subtest pipe-A: SKIP (0.018s)
[418.607828] Starting dynamic subtest: pipe-B
[418.629311] Dynamic subtest pipe-B: SKIP (0.034s)
[418.638765] Starting dynamic subtest: pipe-C
[418.679734] Dynamic subtest pipe-C: SKIP (0.049s)
[418.689074] Starting dynamic subtest: pipe-D
[418.712196] Dynamic subtest pipe-D: SKIP (0.031s)
[418.716537] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.138s)
[418.847834] [085/133] (601s left) i915_suspend (debugfs-reader)
[418.911726] Starting subtest: debugfs-reader
[436.923307] Subtest debugfs-reader: SUCCESS (3.199s)
[437.126803] [086/133] (583s left) kms_psr (fbc-pr-cursor-render)
[437.242776] Starting subtest: fbc-pr-cursor-render
[437.246865] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[437.331774] [087/133] (583s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[437.438582] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[444.124396] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.686s)
[444.271348] [088/133] (576s left) gem_mmap_gtt (fault-concurrent-x)
[444.332554] Subtest fault-concurrent-X: SKIP (0.000s)
[444.412381] [089/133] (576s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[444.535880] Starting subtest: cursorA-vs-flipA-varying-size
[455.677114] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.139s)
[456.473159] [090/133] (564s left) template (b)
[456.536103] Starting subtest: B
[456.538353] Subtest B: SUCCESS (0.000s)
[456.641523] [091/133] (564s left) prime_mmap_kms (buffer-sharing)
[456.742623] Starting subtest: buffer-sharing
[457.169101] Subtest buffer-sharing: SUCCESS (0.425s)
[458.010316] [092/133] (563s left) gem_render_copy_redux (normal)
[458.088321] Starting subtest: normal
[458.341409] Subtest normal: SUCCESS (0.253s)
[458.490974] [093/133] (562s left) gem_exec_reloc (basic-write-wc-noreloc)
[458.564233] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[458.661924] [094/133] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[458.755308] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[458.759403] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[458.884899] [095/133] (562s left) gem_ctx_param (root-set)
[458.942737] Starting subtest: root-set
[458.944852] Subtest root-set: SUCCESS (0.001s)
[459.067019] [096/133] (562s left) gen9_exec_parse (bb-oversize)
[459.132674] Subtest bb-oversize: SKIP (0.000s)
[459.205136] [097/133] (562s left) kms_async_flips (alternate-sync-async-flip)
[459.298796] Starting subtest: alternate-sync-async-flip
[459.672344] Starting dynamic subtest: pipe-A-eDP-1
[462.479692] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.808s)
[462.858156] Starting dynamic subtest: pipe-B-eDP-1
[465.606112] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[465.974626] Starting dynamic subtest: pipe-C-eDP-1
[468.742887] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[469.113080] Starting dynamic subtest: pipe-D-eDP-1
[471.866441] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[471.868548] Subtest alternate-sync-async-flip: SUCCESS (12.571s)
[473.050988] [098/133] (548s left) kms_prop_blob (basic)
[473.118238] Starting subtest: basic
[473.120172] Subtest basic: SUCCESS (0.000s)
[473.230000] [099/133] (548s left) syncobj_wait (wait-all-snapshot)
[473.281398] Starting subtest: wait-all-snapshot
[473.362081] Subtest wait-all-snapshot: SUCCESS (0.081s)
[473.448195] [100/133] (548s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[473.549497] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[473.553924] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[473.666290] [101/133] (547s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[473.723895] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[473.726079] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[473.860067] [102/133] (547s left) sw_sync (sync_multi_consumer_producer)
[473.896114] Starting subtest: sync_multi_consumer_producer
[474.184373] Subtest sync_multi_consumer_producer: SUCCESS (0.288s)
[474.270119] [103/133] (547s left) core_auth (basic-auth)
[474.315083] Starting subtest: basic-auth
[474.317000] Subtest basic-auth: SUCCESS (0.001s)
[474.442052] [104/133] (547s left) kms_properties (get_properties-sanity-non-atomic)
[474.537322] Starting subtest: get_properties-sanity-non-atomic
[474.539543] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[474.626636] [105/133] (547s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[474.719876] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[474.732636] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[474.805556] [106/133] (546s left) syncobj_wait (single-wait-submitted)
[474.872296] Starting subtest: single-wait-submitted
[474.978494] Subtest single-wait-submitted: SUCCESS (0.105s)
[475.064295] [107/133] (546s left) gem_ctx_persistence (engines-queued)
[475.135224] Starting subtest: engines-queued
[475.137606] Starting dynamic subtest: rcs0
[475.294493] Dynamic subtest rcs0: SUCCESS (0.159s)
[475.307214] Starting dynamic subtest: bcs0
[475.326854] Dynamic subtest bcs0: SUCCESS (0.030s)
[475.336714] Starting dynamic subtest: vcs0
[477.036128] Dynamic subtest vcs0: SUCCESS (1.707s)
[477.049303] Starting dynamic subtest: vcs1
[479.020789] Dynamic subtest vcs1: SUCCESS (1.982s)
[479.034035] Starting dynamic subtest: vecs0
[481.067045] Dynamic subtest vecs0: SUCCESS (2.044s)
[481.079839] Starting dynamic subtest: ccs0
[481.265498] Dynamic subtest ccs0: SUCCESS (0.197s)
[481.268193] Subtest engines-queued: SUCCESS (6.133s)
[481.430154] [108/133] (540s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[481.493394] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[481.602802] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[481.694235] [109/133] (540s left) prime_vgem (basic-blt)
[481.791661] Starting subtest: basic-blt
[481.824554] Subtest basic-blt: SUCCESS (0.033s)
[481.995384] [110/133] (539s left) gem_exec_schedule (preempt-queue)
[482.078097] Subtest preempt-queue: SKIP (0.000s)
[482.382065] [111/133] (539s left) kms_selftest (drm_damage_helper)
[482.428290] Starting subtest: drm_damage_helper
[482.441620] Starting dynamic subtest: drm_test_damage_iter_no_damage
[482.586878] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.142s)
[482.598122] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[482.719634] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.131s)
[482.729620] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[482.859885] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.140s)
[482.870201] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[482.994867] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.134s)
[483.004218] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[483.094906] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.100s)
[483.104156] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[483.197979] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.100s)
[483.208826] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[483.309621] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.112s)
[483.320193] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[483.414912] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.104s)
[483.424180] Starting dynamic subtest: drm_test_damage_iter_single_damage
[483.519526] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.103s)
[483.530036] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[483.627632] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.108s)
[483.638173] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[483.736627] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.107s)
[483.747128] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[483.849014] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.113s)
[483.858633] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[483.974057] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.124s)
[483.983879] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[484.100053] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.124s)
[484.109769] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[484.221971] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.121s)
[484.231560] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[484.334502] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.111s)
[484.344676] Starting dynamic subtest: drm_test_damage_iter_damage
[484.445744] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.111s)
[484.456167] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[484.574983] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.127s)
[484.586080] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[484.680708] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.105s)
[484.691637] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[484.781678] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.099s)
[484.792625] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[484.887645] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.105s)
[484.889860] Subtest drm_damage_helper: SUCCESS (2.458s)
[485.080290] [112/133] (536s left) gem_ctx_persistence (process)
[485.148017] Starting subtest: process
[485.367781] Subtest process: SUCCESS (0.219s)
[485.474840] [113/133] (536s left) i915_hangman (hangcheck-unterminated)
[485.542521] Starting subtest: hangcheck-unterminated
[497.070102] Subtest hangcheck-unterminated: SUCCESS (11.528s)
[497.244025] [114/133] (524s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[497.356212] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[497.358605] Starting dynamic subtest: pipe-A-eDP-1
[497.381163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[497.402289] Starting dynamic subtest: pipe-B-eDP-1
[497.424476] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[497.437217] Starting dynamic subtest: pipe-C-eDP-1
[497.458560] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[497.468384] Starting dynamic subtest: pipe-D-eDP-1
[497.489671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[497.493843] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[499.530529] [115/133] (522s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[499.639181] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[499.643261] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[499.770476] [116/133] (522s left) prime_self_import (basic-llseek-bad)
[499.804644] Starting subtest: basic-llseek-bad
[499.831559] Subtest basic-llseek-bad: SUCCESS (0.029s)
[499.953538] [117/133] (522s left) gem_exec_alignment (pi)
[500.010978] Starting subtest: pi
[553.238583] Subtest pi: SUCCESS (53.222s)
[554.420310] [118/133] (467s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[554.570103] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[554.574237] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[554.678912] [119/133] (467s left) gem_pxp (regular-baseline-src-copy-readible)
[554.796841] Starting subtest: regular-baseline-src-copy-readible
[554.853952] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[555.005146] [120/133] (467s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[555.112730] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[555.116722] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[555.200683] [121/133] (467s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[555.323401] Starting subtest: flip-vs-cursor-crc-legacy
[556.029731] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.705s)
[556.844247] [122/133] (465s left) kms_psr (fbc-pr-sprite-blt)
[556.933550] Starting subtest: fbc-pr-sprite-blt
[556.938027] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[557.034016] [123/133] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[557.130248] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[557.134692] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[557.269396] [124/133] (465s left) gem_userptr_blits (set-cache-level)
[557.331384] Starting subtest: set-cache-level
[557.335396] Subtest set-cache-level: SKIP (0.000s)
[557.473176] [125/133] (465s left) syncobj_wait (reset-during-wait-for-submit)
[557.543355] Starting subtest: reset-during-wait-for-submit
[557.647914] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[557.750209] [126/133] (464s left) kms_cursor_crc (cursor-random-max-size)
[558.064081] Starting subtest: cursor-random-max-size
[558.070623] Subtest cursor-random-max-size: SKIP (0.000s)
[558.213626] [127/133] (464s left) perf_pmu (busy-check-all)
[558.261673] Starting subtest: busy-check-all
[558.263610] Starting dynamic subtest: rcs0
[558.809923] Dynamic subtest rcs0: SUCCESS (0.550s)
[558.822282] Starting dynamic subtest: bcs0
[559.360523] Dynamic subtest bcs0: SUCCESS (0.548s)
[559.373140] Starting dynamic subtest: vcs0
[561.102601] Dynamic subtest vcs0: SUCCESS (1.738s)
[561.116092] Starting dynamic subtest: vcs1
[563.087100] Dynamic subtest vcs1: SUCCESS (1.980s)
[563.100432] Starting dynamic subtest: vecs0
[565.070539] Dynamic subtest vecs0: SUCCESS (1.980s)
[565.083863] Starting dynamic subtest: ccs0
[565.626398] Dynamic subtest ccs0: SUCCESS (0.555s)
[565.628732] Subtest busy-check-all: SUCCESS (7.368s)
[565.740987] [128/133] (456s left) kms_psr (psr2-sprite-render)
[565.848136] Starting subtest: psr2-sprite-render
[565.850481] Starting dynamic subtest: eDP-1
[567.537928] Dynamic subtest eDP-1: SUCCESS (1.690s)
[567.540205] Subtest psr2-sprite-render: SUCCESS (1.691s)
[568.418140] [129/133] (454s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[568.530844] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[572.129631] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.603s)
[573.330727] [130/133] (449s left) gem_eio (in-flight-1us)
[573.556619] Starting subtest: in-flight-1us
[582.072761] Subtest in-flight-1us: SUCCESS (8.513s)
[582.269115] [131/133] (440s left) gem_exec_balancer (nohangcheck)
[582.533214] Starting subtest: nohangcheck
[583.409534] Subtest nohangcheck: SUCCESS (0.877s)
[583.553932] [132/133] (439s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[583.657121] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[583.659773] Starting dynamic subtest: pipe-A-eDP-1
[583.782528] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[583.793304] Starting dynamic subtest: pipe-B-eDP-1
[584.981445] Dynamic subtest pipe-B-eDP-1: SKIP (1.194s)
[584.985806] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.326s)
[586.278481] [133/133] (436s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[586.374677] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[593.473962] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.101s)
[593.634084] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_plane_alpha_blend
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: i915_pm_rps
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_edge_walk
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: gem_busy
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_workarounds
results: parsing output: 20/ for test: kms_draw_crc
results: parsing output: 21/ for test: kms_pm_backlight
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: gem_exec_capture
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_lease
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: core_auth
results: parsing output: 46/ for test: sysfs_defaults
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: gem_cs_tlb
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: gem_flink_basic
results: parsing output: 53/ for test: gem_set_tiling_vs_blt
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: device_reset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_dp_aux_dev
results: parsing output: 62/ for test: gem_workarounds
results: parsing output: 63/ for test: kms_plane_cursor
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_chamelium_frames
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_pwrite
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: kms_properties
results: parsing output: 82/ for test: kms_atomic_transition
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: i915_suspend
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: template
results: parsing output: 90/ for test: prime_mmap_kms
results: parsing output: 91/ for test: gem_render_copy_redux
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_ctx_param
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_prop_blob
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: core_auth
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: prime_vgem
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_selftest
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: i915_hangman
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: prime_self_import
results: parsing output: 116/ for test: gem_exec_alignment
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.