[89.380482] Initializing watchdogs
[89.380649]   /dev/watchdog0
[89.423581] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.438510] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.445681] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.454266] [001/133] (960s left) kms_busy (extended-modeset-hang-newfb)
[89.680743] Starting subtest: extended-modeset-hang-newfb
[89.686364] Starting dynamic subtest: pipe-A
[97.948023] Dynamic subtest pipe-A: SUCCESS (8.263s)
[98.016227] Starting dynamic subtest: pipe-C
[105.932343] Dynamic subtest pipe-C: SUCCESS (7.967s)
[105.936150] Subtest extended-modeset-hang-newfb: SUCCESS (16.250s)
[106.294674] [002/133] (943s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[106.488797] Starting subtest: plane-upscale-factor-0-25-with-rotation
[106.493654] Starting dynamic subtest: pipe-A
[111.017566] Dynamic subtest pipe-A: SKIP (4.523s)
[111.050785] Starting dynamic subtest: pipe-B
[115.631795] Dynamic subtest pipe-B: SKIP (4.612s)
[115.666374] Starting dynamic subtest: pipe-C
[120.267770] Dynamic subtest pipe-C: SKIP (4.627s)
[120.275164] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (13.767s)
[120.907117] [003/133] (929s left) gem_pxp (fail-invalid-protected-context)
[123.605254] Starting subtest: fail-invalid-protected-context
[123.611532] Subtest fail-invalid-protected-context: SKIP (0.000s)
[123.758773] [004/133] (926s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[123.966346] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[126.010201] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.041s)
[126.245963] [005/133] (924s left) kms_properties (colorop-properties-legacy)
[126.450898] Starting subtest: colorop-properties-legacy
[126.454317] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.973460] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.516s)
[127.011509] Starting dynamic subtest: pipe-A-HDMI-A-2
[127.328392] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.346s)
[127.349071] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.661380] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.324s)
[127.693499] Starting dynamic subtest: pipe-B-HDMI-A-2
[128.002260] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.338s)
[128.068171] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.338978] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.328s)
[128.408051] Starting dynamic subtest: pipe-C-HDMI-A-2
[128.676647] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.328s)
[128.680205] Subtest colorop-properties-legacy: SUCCESS (2.228s)
[128.999575] [006/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[129.227262] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[132.258181] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.029s)
[132.576677] [007/133] (918s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[132.772917] Starting subtest: basic-modeset-with-all-modifiers-formats
[133.383194] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-RGB565
[133.698141] Dynamic subtest pipe-A-HDMI-A-1-yf-RGB565: SUCCESS (0.312s)
[133.715934] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-XRGB8888
[133.746064] Dynamic subtest pipe-A-HDMI-A-1-yf-XRGB8888: SUCCESS (0.046s)
[133.764235] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-XRGB2101010
[133.795820] Dynamic subtest pipe-A-HDMI-A-1-yf-XRGB2101010: SUCCESS (0.047s)
[133.815483] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-YUYV
[133.863027] Dynamic subtest pipe-A-HDMI-A-1-yf-YUYV: SUCCESS (0.063s)
[133.881973] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-XYUV8888
[133.928891] Dynamic subtest pipe-A-HDMI-A-1-yf-XYUV8888: SUCCESS (0.063s)
[133.951223] Starting dynamic subtest: pipe-A-HDMI-A-1-y-RGB565
[134.195738] Dynamic subtest pipe-A-HDMI-A-1-y-RGB565: SUCCESS (0.263s)
[134.215112] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XRGB8888
[134.263039] Dynamic subtest pipe-A-HDMI-A-1-y-XRGB8888: SUCCESS (0.063s)
[134.281040] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XRGB2101010
[134.314060] Dynamic subtest pipe-A-HDMI-A-1-y-XRGB2101010: SUCCESS (0.047s)
[134.332928] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XRGB16161616F
[134.382326] Dynamic subtest pipe-A-HDMI-A-1-y-XRGB16161616F: SUCCESS (0.063s)
[134.401336] Starting dynamic subtest: pipe-A-HDMI-A-1-y-YUYV
[134.429049] Dynamic subtest pipe-A-HDMI-A-1-y-YUYV: SUCCESS (0.046s)
[134.452311] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XYUV8888
[134.482307] Dynamic subtest pipe-A-HDMI-A-1-y-XYUV8888: SUCCESS (0.046s)
[134.502171] Starting dynamic subtest: pipe-A-HDMI-A-1-x-RGB565
[134.594943] Dynamic subtest pipe-A-HDMI-A-1-x-RGB565: SUCCESS (0.110s)
[134.613639] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB8888
[134.646067] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB8888: SUCCESS (0.046s)
[134.668489] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB2101010
[134.698565] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB2101010: SUCCESS (0.046s)
[134.717389] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB16161616F
[134.744501] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB16161616F: SUCCESS (0.045s)
[134.763270] Starting dynamic subtest: pipe-A-HDMI-A-1-x-YUYV
[134.797873] Dynamic subtest pipe-A-HDMI-A-1-x-YUYV: SUCCESS (0.047s)
[134.817895] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XYUV8888
[134.845088] Dynamic subtest pipe-A-HDMI-A-1-x-XYUV8888: SUCCESS (0.044s)
[135.308865] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.533s)
[135.668510] [008/133] (915s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[135.859345] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[135.865717] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[136.016209] [009/133] (914s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[136.140439] Starting subtest: rel-constants-invalid-rel-gen5
[136.143772] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s)
[136.302786] [010/133] (914s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[136.490135] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[136.496826] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[136.649196] [011/133] (914s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[136.866930] Starting subtest: fbcpsr-indfb-scaledprimary
[136.874486] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[137.033886] [012/133] (914s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[137.222428] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[137.226949] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[148.274557] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.049s)
[148.293828] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[159.468758] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.190s)
[159.492288] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[170.658695] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.181s)
[170.662038] Subtest 2x-flip-vs-absolute-wf_vblank: SUCCESS (33.441s)
[171.320696] [013/133] (879s left) gem_exec_schedule (promotion)
[171.468112] Starting subtest: promotion
[171.472165] Starting dynamic subtest: rcs0
[171.603913] Dynamic subtest rcs0: SUCCESS (0.130s)
[171.628180] Starting dynamic subtest: bcs0
[171.756409] Dynamic subtest bcs0: SUCCESS (0.147s)
[171.776310] Starting dynamic subtest: vcs0
[171.897749] Dynamic subtest vcs0: SUCCESS (0.136s)
[171.922953] Starting dynamic subtest: vecs0
[172.031041] Dynamic subtest vecs0: SUCCESS (0.124s)
[172.034588] Subtest promotion: SUCCESS (0.563s)
[172.441392] [014/133] (878s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[172.561241] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[172.686604] [015/133] (878s left) gem_ctx_shared (disjoint-timelines)
[172.809920] Starting subtest: disjoint-timelines
[172.899480] Subtest disjoint-timelines: SUCCESS (0.083s)
[173.192136] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[173.199359] [016/133] (878s left) gem_userptr_blits (map-fixed-invalidate)
[173.344428] Starting subtest: map-fixed-invalidate
[173.348239] Starting dynamic subtest: gtt
[173.586210] Dynamic subtest gtt: SUCCESS (0.246s)
[173.606125] Starting dynamic subtest: wb
[173.764356] Dynamic subtest wb: SUCCESS (0.165s)
[173.784612] Starting dynamic subtest: wc
[173.955695] Dynamic subtest wc: SUCCESS (0.161s)
[174.024411] Starting dynamic subtest: uc
[174.159991] Dynamic subtest uc: SUCCESS (0.159s)
[174.230730] Subtest map-fixed-invalidate: SUCCESS (0.744s)
[174.716164] [017/133] (877s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[175.203811] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[175.271038] Starting dynamic subtest: pipe-A-valid-mode
[175.931621] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.986s)
[175.936640] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.991s)
[176.302485] [018/133] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[176.524486] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[176.530947] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[176.699396] [019/133] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[176.908741] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[176.915763] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[177.099508] [020/133] (875s left) gem_ctx_persistence (engines-hang)
[177.229730] Starting subtest: engines-hang
[177.234073] Starting dynamic subtest: rcs0
[177.246149] Dynamic subtest rcs0: SUCCESS (0.015s)
[177.268281] Starting dynamic subtest: bcs0
[177.274358] Dynamic subtest bcs0: SKIP (0.020s)
[177.295894] Starting dynamic subtest: vcs0
[177.307088] Dynamic subtest vcs0: SUCCESS (0.036s)
[177.326809] Starting dynamic subtest: vecs0
[177.346252] Dynamic subtest vecs0: SUCCESS (0.035s)
[177.349858] Subtest engines-hang: SUCCESS (0.124s)
[177.517335] [021/133] (874s left) i915_pm_rpm (sysfs-read)
[179.437538] Starting subtest: sysfs-read
[179.697687] Subtest sysfs-read: SUCCESS (0.206s)
[180.044756] [022/133] (872s left) prime_vgem (coherency-blt)
[180.184235] Starting subtest: coherency-blt
[183.319796] Subtest coherency-blt: SUCCESS (3.132s)
[183.507413] [023/133] (868s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[183.619549] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[183.622744] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.002s)
[183.791356] [024/133] (868s left) gen9_exec_parse (batch-without-end)
[183.913223] Starting subtest: batch-without-end
[183.922175] Subtest batch-without-end: SUCCESS (0.004s)
[184.207319] [025/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[184.420388] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[187.452148] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SUCCESS (3.025s)
[187.691147] [026/133] (865s left) gem_partial_pwrite_pread (writes-after-reads-display)
[187.810280] Starting subtest: writes-after-reads-display
[209.499156] Subtest writes-after-reads-display: SUCCESS (21.689s)
[209.700473] [027/133] (843s left) gem_wait (wait)
[209.842050] Starting subtest: wait
[209.845255] Starting dynamic subtest: all-engines
[210.890476] Dynamic subtest all-engines: SUCCESS (1.041s)
[210.912486] Starting dynamic subtest: rcs0
[211.919907] Dynamic subtest rcs0: SUCCESS (1.022s)
[211.941317] Starting dynamic subtest: bcs0
[212.952573] Dynamic subtest bcs0: SUCCESS (1.024s)
[212.974879] Starting dynamic subtest: vcs0
[213.970162] Dynamic subtest vcs0: SUCCESS (1.028s)
[213.992318] Starting dynamic subtest: vecs0
[215.002586] Dynamic subtest vecs0: SUCCESS (1.024s)
[215.006551] Subtest wait: SUCCESS (5.156s)
[215.327459] [028/133] (837s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[215.543511] Starting subtest: 4-tiled-32bpp-rotate-180
[215.552117] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[215.741197] [029/133] (837s left) kms_plane_multiple (tiling-yf)
[215.929067] Starting subtest: tiling-yf
[215.932273] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.865251] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.934s)
[217.894249] Starting dynamic subtest: pipe-A-HDMI-A-2
[219.753218] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.883s)
[219.790317] Starting dynamic subtest: pipe-B-HDMI-A-1
[221.627882] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.871s)
[221.661776] Starting dynamic subtest: pipe-B-HDMI-A-2
[223.406117] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.770s)
[223.435039] Starting dynamic subtest: pipe-C-HDMI-A-1
[225.219697] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.710s)
[225.305124] Starting dynamic subtest: pipe-C-HDMI-A-2
[226.920278] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.792s)
[226.928070] Subtest tiling-yf: SUCCESS (10.994s)
[227.261742] [030/133] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[227.484510] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[227.490953] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[227.674244] [031/133] (825s left) kms_color (ctm-0-75)
[227.862742] Starting subtest: ctm-0-75
[227.865977] Starting dynamic subtest: pipe-A-HDMI-A-1
[230.651524] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.784s)
[230.673843] Starting dynamic subtest: pipe-A-HDMI-A-2
[233.174411] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.516s)
[233.196078] Starting dynamic subtest: pipe-B-HDMI-A-1
[235.624181] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.442s)
[235.666359] Starting dynamic subtest: pipe-B-HDMI-A-2
[238.041100] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.417s)
[238.061463] Starting dynamic subtest: pipe-C-HDMI-A-1
[240.502998] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.458s)
[240.543228] Starting dynamic subtest: pipe-C-HDMI-A-2
[242.919150] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.409s)
[242.923929] Subtest ctm-0-75: SUCCESS (15.054s)
[243.258166] [032/133] (810s left) kms_chamelium_frames (dp-crc-single)
[243.877231] Subtest dp-crc-single: SKIP (0.000s)
[244.185742] [033/133] (809s left) kms_draw_crc (draw-method-render)
[244.393230] Starting subtest: draw-method-render
[244.396736] Starting dynamic subtest: xrgb8888-untiled
[244.938706] Dynamic subtest xrgb8888-untiled: SUCCESS (0.546s)
[244.962065] Starting dynamic subtest: rgb565-untiled
[245.237160] Dynamic subtest rgb565-untiled: SUCCESS (0.294s)
[245.258788] Starting dynamic subtest: xrgb2101010-untiled
[245.539177] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[245.563691] Starting dynamic subtest: xbgr16161616f-untiled
[245.873642] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.330s)
[245.896977] Starting dynamic subtest: xrgb8888-xtiled
[246.074420] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.196s)
[246.096792] Starting dynamic subtest: rgb565-xtiled
[246.256578] Dynamic subtest rgb565-xtiled: SUCCESS (0.179s)
[246.278943] Starting dynamic subtest: xrgb2101010-xtiled
[246.422071] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.162s)
[246.446552] Starting dynamic subtest: xbgr16161616f-xtiled
[246.605340] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.179s)
[246.627390] Starting dynamic subtest: xrgb8888-ytiled
[246.807117] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.197s)
[246.830757] Starting dynamic subtest: rgb565-ytiled
[246.989940] Dynamic subtest rgb565-ytiled: SUCCESS (0.179s)
[247.013991] Starting dynamic subtest: xrgb2101010-ytiled
[247.155953] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.162s)
[247.179031] Starting dynamic subtest: xbgr16161616f-ytiled
[247.338729] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.182s)
[247.342433] Subtest draw-method-render: SUCCESS (2.951s)
[247.636299] [034/133] (806s left) gem_softpin (safe-alignment)
[247.762128] Starting subtest: safe-alignment
[247.793061] Subtest safe-alignment: SUCCESS (0.030s)
[247.987929] [035/133] (805s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[248.211837] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[248.218332] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[248.414520] [036/133] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[248.632934] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[248.640473] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[248.804403] [037/133] (805s left) gem_ctx_persistence (many-contexts)
[248.920984] Starting subtest: many-contexts
[281.701192] Subtest many-contexts: SUCCESS (32.779s)
[281.888178] [038/133] (772s left) gem_reg_read (bad-register)
[282.023958] Starting subtest: bad-register
[282.028534] Subtest bad-register: SUCCESS (0.000s)
[282.144717] [039/133] (772s left) kms_pm_dc (dc5-psr)
[283.351414] Starting subtest: dc5-psr
[283.359683] Subtest dc5-psr: SKIP (0.000s)
[283.545107] [040/133] (770s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[283.746263] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[287.129450] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.383s)
[287.502647] [041/133] (766s left) gem_ctx_engines (none)
[287.645071] Starting subtest: none
[287.648359] Subtest none: SUCCESS (0.003s)
[287.938126] [042/133] (766s left) kms_addfb_basic (no-handle)
[288.053436] Starting subtest: no-handle
[288.056600] Subtest no-handle: SUCCESS (0.000s)
[288.337295] [043/133] (766s left) i915_drm_fdinfo (busy-idle)
[288.462794] Starting subtest: busy-idle
[288.466349] Starting dynamic subtest: rcs0
[289.098568] Dynamic subtest rcs0: SUCCESS (0.635s)
[289.119656] Starting dynamic subtest: bcs0
[289.731053] Dynamic subtest bcs0: SUCCESS (0.631s)
[289.753284] Starting dynamic subtest: vcs0
[290.368749] Dynamic subtest vcs0: SUCCESS (0.632s)
[290.390895] Starting dynamic subtest: vecs0
[290.996691] Dynamic subtest vecs0: SUCCESS (0.627s)
[291.002586] Subtest busy-idle: SUCCESS (2.538s)
[291.135275] [044/133] (763s left) perf_pmu (busy-start)
[291.245699] Starting subtest: busy-start
[291.250494] Starting dynamic subtest: rcs0
[293.771171] Dynamic subtest rcs0: SUCCESS (2.522s)
[293.794391] Starting dynamic subtest: bcs0
[296.300102] Dynamic subtest bcs0: SUCCESS (2.525s)
[296.322865] Starting dynamic subtest: vcs0
[298.829939] Dynamic subtest vcs0: SUCCESS (2.525s)
[298.852712] Starting dynamic subtest: vecs0
[301.353981] Dynamic subtest vecs0: SUCCESS (2.517s)
[301.357420] Subtest busy-start: SUCCESS (10.104s)
[301.536914] [045/133] (753s left) kms_selftest (drm_dp_mst_helper)
[301.648653] Starting subtest: drm_dp_mst_helper
[301.690484] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[301.762286] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.072s)
[301.792147] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[301.868498] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.093s)
[301.896140] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[301.959115] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.088s)
[301.964028] Subtest drm_dp_mst_helper: SUCCESS (0.309s)
[302.206159] [046/133] (752s left) gem_exec_schedule (pi-userfault)
[302.468780] Starting subtest: pi-userfault
[302.473073] Starting dynamic subtest: rcs0
[302.483047] Dynamic subtest rcs0: SUCCESS (0.013s)
[302.521325] Starting dynamic subtest: bcs0
[302.524713] Dynamic subtest bcs0: SUCCESS (0.009s)
[302.559489] Starting dynamic subtest: vcs0
[302.563533] Dynamic subtest vcs0: SUCCESS (0.010s)
[302.601381] Starting dynamic subtest: vecs0
[302.605436] Dynamic subtest vecs0: SUCCESS (0.007s)
[302.609630] Subtest pi-userfault: SUCCESS (0.052s)
[302.804688] [047/133] (752s left) gem_userptr_blits (input-checking)
[302.932112] Starting subtest: input-checking
[302.937036] Subtest input-checking: SUCCESS (0.000s)
[303.152358] [048/133] (752s left) kms_psr (fbc-pr-primary-page-flip)
[303.358767] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[303.484989] [049/133] (751s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[303.678546] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[303.804529] [050/133] (751s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[304.019854] Starting subtest: y-tiled-8bpp-rotate-270
[304.344234] Subtest y-tiled-8bpp-rotate-270: SKIP (0.322s)
[304.636692] [051/133] (750s left) kms_psr (pr-primary-page-flip)
[304.831081] Subtest pr-primary-page-flip: SKIP (0.000s)
[304.953101] [052/133] (750s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[305.168561] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[307.638476] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.473s)
[307.851231] [053/133] (747s left) syncobj_wait (multi-wait-submitted-signaled)
[307.963973] Starting subtest: multi-wait-submitted-signaled
[307.967400] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[308.149240] [054/133] (747s left) gem_flink_basic (basic)
[308.257539] Starting subtest: basic
[308.261839] Subtest basic: SUCCESS (0.000s)
[308.435964] [055/133] (747s left) kms_invalid_mode (zero-clock)
[308.656293] Starting subtest: zero-clock
[308.660996] Starting dynamic subtest: pipe-A-HDMI-A-1
[309.059043] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.430s)
[309.153321] Starting dynamic subtest: pipe-A-HDMI-A-2
[309.157722] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[309.204310] Starting dynamic subtest: pipe-B-HDMI-A-1
[309.208480] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[309.231224] Starting dynamic subtest: pipe-B-HDMI-A-2
[309.234750] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[309.258409] Starting dynamic subtest: pipe-C-HDMI-A-1
[309.261716] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[309.283933] Starting dynamic subtest: pipe-C-HDMI-A-2
[309.286894] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[309.289990] Subtest zero-clock: SUCCESS (0.470s)
[309.453102] [056/133] (746s left) sysfs_preempt_timeout (idempotent)
[309.571320] Starting subtest: idempotent
[309.577080] Starting dynamic subtest: vecs0
[309.580858] Dynamic subtest vecs0: SUCCESS (0.002s)
[309.605031] Starting dynamic subtest: vcs0
[309.609371] Dynamic subtest vcs0: SUCCESS (0.002s)
[309.632084] Starting dynamic subtest: bcs0
[309.635527] Dynamic subtest bcs0: SUCCESS (0.002s)
[309.658521] Starting dynamic subtest: rcs0
[309.662526] Dynamic subtest rcs0: SUCCESS (0.002s)
[309.666619] Subtest idempotent: SUCCESS (0.023s)
[309.785580] [057/133] (746s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[309.979968] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[310.217733] Starting dynamic subtest: pipe-A-plane-0
[310.915996] Dynamic subtest pipe-A-plane-0: SUCCESS (0.698s)
[310.940584] Starting dynamic subtest: pipe-A-plane-1
[311.583842] Dynamic subtest pipe-A-plane-1: SUCCESS (0.663s)
[311.607269] Starting dynamic subtest: pipe-A-plane-2
[312.067136] Dynamic subtest pipe-A-plane-2: SUCCESS (0.480s)
[312.089941] Starting dynamic subtest: pipe-A-plane-3
[312.565523] Dynamic subtest pipe-A-plane-3: SUCCESS (0.497s)
[312.966588] Starting dynamic subtest: pipe-B-plane-0
[313.613090] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[313.637649] Starting dynamic subtest: pipe-B-plane-1
[314.262732] Dynamic subtest pipe-B-plane-1: SUCCESS (0.647s)
[314.286358] Starting dynamic subtest: pipe-B-plane-2
[314.745994] Dynamic subtest pipe-B-plane-2: SUCCESS (0.480s)
[314.769203] Starting dynamic subtest: pipe-B-plane-3
[315.229949] Dynamic subtest pipe-B-plane-3: SUCCESS (0.480s)
[315.519044] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.483s)
[315.818103] [058/133] (740s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[316.029409] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[316.039186] Starting dynamic subtest: A-HDMI-A1
[317.474360] Dynamic subtest A-HDMI-A1: SUCCESS (1.434s)
[317.497628] Starting dynamic subtest: B-HDMI-A1
[318.426509] Dynamic subtest B-HDMI-A1: SUCCESS (0.945s)
[318.458635] Starting dynamic subtest: C-HDMI-A1
[319.398120] Dynamic subtest C-HDMI-A1: SUCCESS (0.970s)
[319.427085] Starting dynamic subtest: A-HDMI-A2
[320.402450] Dynamic subtest A-HDMI-A2: SUCCESS (0.994s)
[320.428424] Starting dynamic subtest: B-HDMI-A2
[321.346070] Dynamic subtest B-HDMI-A2: SUCCESS (0.940s)
[321.382762] Starting dynamic subtest: C-HDMI-A2
[322.292151] Dynamic subtest C-HDMI-A2: SUCCESS (0.943s)
[322.296445] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.264s)
[322.678881] [059/133] (733s left) gem_basic (bad-close)
[322.795318] Starting subtest: bad-close
[322.802646] Subtest bad-close: SUCCESS (0.000s)
[322.967515] [060/133] (733s left) kms_chamelium_color (ctm-0-75)
[323.171896] Subtest ctm-0-75: SKIP (0.000s)
[323.295695] [061/133] (733s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[323.499626] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[323.503267] Starting dynamic subtest: pipe-A
[328.234099] Dynamic subtest pipe-A: SKIP (4.728s)
[328.290465] Starting dynamic subtest: pipe-B
[332.815103] Dynamic subtest pipe-B: SKIP (4.584s)
[332.841198] Starting dynamic subtest: pipe-C
[337.399791] Dynamic subtest pipe-C: SKIP (4.577s)
[337.408084] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (13.898s)
[337.959366] [062/133] (718s left) kms_psr (psr2-no-drrs)
[338.213376] Subtest psr2-no-drrs: SKIP (0.000s)
[338.341806] [063/133] (718s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[338.468989] Starting subtest: single-wait-for-submit-available-submitted
[338.473695] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[338.660680] [064/133] (718s left) kms_big_fb (x-tiled-addfb)
[338.873623] Starting subtest: x-tiled-addfb
[338.877112] Subtest x-tiled-addfb: SUCCESS (0.000s)
[339.060796] [065/133] (717s left) gem_exec_reloc (basic-range-active)
[339.199800] Starting subtest: basic-range-active
[339.299641] Subtest basic-range-active: SUCCESS (0.098s)
[339.594490] [066/133] (717s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[339.821885] Starting subtest: bad-pixel-format-y-tiled-ccs
[339.826907] Starting dynamic subtest: pipe-A-HDMI-A-1
[339.874231] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[339.896603] Starting dynamic subtest: pipe-A-HDMI-A-2
[339.925229] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.006s)
[339.988317] Starting dynamic subtest: pipe-B-HDMI-A-1
[340.014094] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[340.037141] Starting dynamic subtest: pipe-B-HDMI-A-2
[340.066122] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[340.088973] Starting dynamic subtest: pipe-C-HDMI-A-1
[340.116952] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.004s)
[340.139014] Starting dynamic subtest: pipe-C-HDMI-A-2
[340.166430] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[340.169116] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.064s)
[340.895316] [067/133] (716s left) syncobj_timeline (reset-during-wait-for-submit)
[341.015448] Starting subtest: reset-during-wait-for-submit
[341.116837] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[341.302538] [068/133] (716s left) api_intel_bb (blit-reloc-purge-cache)
[341.417348] Starting subtest: blit-reloc-purge-cache
[341.437565] Subtest blit-reloc-purge-cache: SUCCESS (0.023s)
[341.630192] [069/133] (715s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[341.815215] Starting subtest: cursorA-vs-flipB-varying-size
[353.190212] Subtest cursorA-vs-flipB-varying-size: SUCCESS (11.370s)
[353.531352] [070/133] (704s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[353.744255] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[353.751769] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[353.930594] [071/133] (703s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[354.137315] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[354.259334] [072/133] (703s left) dmabuf_sync_file (import-multiple-read-only)
[354.389234] Starting subtest: import-multiple-read-only
[354.400349] Subtest import-multiple-read-only: SUCCESS (0.018s)
[354.582121] [073/133] (703s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[354.782832] Starting subtest: cursorA-vs-flipA-legacy
[366.103636] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.333s)
[366.458548] [074/133] (691s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[366.663911] Starting subtest: 2x-plain-flip-ts-check-interruptible
[366.667880] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[377.712162] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.042s)
[377.740420] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[388.715900] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.995s)
[388.746764] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[399.710163] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.982s)
[399.713932] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (33.047s)
[400.368455] [075/133] (657s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[400.570996] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[400.824861] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.248s)
[401.099701] [076/133] (657s left) api_intel_bb (object-reloc-purge-cache)
[401.212281] Starting subtest: object-reloc-purge-cache
[401.227450] Subtest object-reloc-purge-cache: SUCCESS (0.015s)
[401.407200] [077/133] (656s left) syncobj_basic (bad-destroy-pad)
[401.518105] Starting subtest: bad-destroy-pad
[401.521921] Subtest bad-destroy-pad: SUCCESS (0.000s)
[401.683465] [078/133] (656s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[401.795961] Starting subtest: invalid-bsd1-flag-on-vebox
[401.799396] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[401.964320] [079/133] (656s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[402.077272] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[402.179207] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[402.372245] [080/133] (656s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[402.485583] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[402.588066] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[402.748856] [081/133] (655s left) i915_power (sanity)
[402.857927] Starting subtest: sanity
[406.883867] Subtest sanity: SUCCESS (4.022s)
[407.065379] [082/133] (651s left) syncobj_basic (bad-flags-fd-to-handle)
[407.178716] Starting subtest: bad-flags-fd-to-handle
[407.183118] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[407.366761] [083/133] (651s left) kms_cursor_crc (cursor-offscreen-64x64)
[407.559629] Starting subtest: cursor-offscreen-64x64
[407.609091] Starting dynamic subtest: pipe-A-HDMI-A-1
[410.470867] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.861s)
[410.609807] Starting dynamic subtest: pipe-C-HDMI-A-1
[413.105338] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.557s)
[413.108497] Subtest cursor-offscreen-64x64: SUCCESS (5.547s)
[413.465343] [084/133] (645s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[413.675190] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[413.683273] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[413.863749] [085/133] (645s left) gem_exec_fence (invalid-timeline-fence-array)
[414.549211] Starting subtest: invalid-timeline-fence-array
[414.559744] Subtest invalid-timeline-fence-array: SUCCESS (0.011s)
[414.859483] [086/133] (644s left) gem_exec_balancer (bonded-sync)
[414.992112] Starting subtest: bonded-sync
[419.421122] Subtest bonded-sync: SUCCESS (4.430s)
[419.730409] [087/133] (639s left) gem_workarounds (suspend-resume-fd)
[419.874929] Starting subtest: suspend-resume-fd
[436.738639] Subtest suspend-resume-fd: SUCCESS (1.281s)
[444.988190] [088/133] (622s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[445.283986] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[445.290782] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[445.541424] [089/133] (622s left) kms_hdr (invalid-metadata-sizes)
[445.747354] Starting subtest: invalid-metadata-sizes
[445.765777] Subtest invalid-metadata-sizes: SKIP (0.002s)
[445.954597] [090/133] (621s left) gem_softpin (evict-snoop)
[446.102229] Starting subtest: evict-snoop
[446.111670] Subtest evict-snoop: SKIP (0.000s)
[446.281863] [091/133] (621s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[446.485230] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[449.250677] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SUCCESS (2.770s)
[449.535923] [092/133] (618s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[452.175200] Starting subtest: verify-pxp-stale-buf-optout-execution
[452.182892] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[452.378915] [093/133] (615s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[452.559750] Starting subtest: cursor-vs-flip-toggle
[498.630413] Subtest cursor-vs-flip-toggle: SUCCESS (46.071s)
[498.976237] [094/133] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[499.192589] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[499.200391] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[499.374229] [095/133] (569s left) gem_userptr_blits (invalid-null-pointer)
[499.508838] Starting subtest: invalid-null-pointer
[499.512165] Subtest invalid-null-pointer: SUCCESS (0.004s)
[499.721008] [096/133] (568s left) kms_cursor_crc (cursor-random-32x10)
[499.966802] Starting subtest: cursor-random-32x10
[500.088879] Subtest cursor-random-32x10: SKIP (0.172s)
[500.273980] [097/133] (568s left) syncobj_wait (single-wait-for-submit-signaled)
[500.396585] Starting subtest: single-wait-for-submit-signaled
[500.400225] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[500.589450] [098/133] (568s left) gem_exec_whisper (basic-fds-priority-all)
[500.725722] Starting subtest: basic-fds-priority-all
[518.446824] Subtest basic-fds-priority-all: SUCCESS (17.716s)
[518.754295] [099/133] (550s left) gem_exec_flush (basic-uc-set-default)
[518.889796] Starting subtest: basic-uc-set-default
[524.307829] Subtest basic-uc-set-default: SUCCESS (5.422s)
[524.606743] [100/133] (544s left) gem_eio (in-flight-contexts-immediate)
[524.743657] Starting subtest: in-flight-contexts-immediate
[536.571198] Subtest in-flight-contexts-immediate: SUCCESS (11.820s)
[536.856642] [101/133] (532s left) kms_vrr (flip-basic-fastset)
[537.046841] Starting subtest: flip-basic-fastset
[537.060527] Subtest flip-basic-fastset: SKIP (0.000s)
[537.223858] [102/133] (531s left) kms_addfb_basic (small-bo)
[537.415511] Starting subtest: small-bo
[537.419334] Subtest small-bo: SUCCESS (0.000s)
[537.592524] [103/133] (531s left) kms_content_protection (atomic-dpms-hdcp14)
[537.796256] Starting subtest: atomic-dpms-hdcp14
[537.836490] Subtest atomic-dpms-hdcp14: SKIP (0.032s)
[538.035586] [104/133] (531s left) gem_exec_suspend (basic-s3)
[538.176818] Starting subtest: basic-S3
[538.181770] Starting dynamic subtest: smem