[59.404036] Initializing watchdogs
[59.404083]   /dev/watchdog0
[59.418588] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.422733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.424988] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.428653] [001/132] (960s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[59.549077] Starting subtest: plane-lut1d-ctm3x4-lut1d
[59.705298] Starting dynamic subtest: pipe-A-plane-0
[59.873444] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[59.882093] Starting dynamic subtest: pipe-A-plane-1
[60.007587] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[60.014281] Starting dynamic subtest: pipe-A-plane-2
[60.151261] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[61.297154] Starting dynamic subtest: pipe-B-plane-0
[61.455287] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[61.463474] Starting dynamic subtest: pipe-B-plane-1
[61.611475] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[61.619661] Starting dynamic subtest: pipe-B-plane-2
[61.756170] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[62.936484] Starting dynamic subtest: pipe-C-plane-0
[63.075594] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[63.085131] Starting dynamic subtest: pipe-C-plane-1
[63.209337] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[63.217821] Starting dynamic subtest: pipe-C-plane-2
[63.353877] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[64.551466] Starting dynamic subtest: pipe-D-plane-0
[64.712738] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[64.721603] Starting dynamic subtest: pipe-D-plane-1
[64.846421] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[64.853903] Starting dynamic subtest: pipe-D-plane-2
[64.992187] Dynamic subtest pipe-D-plane-2: SUCCESS (0.145s)
[65.282590] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.721s)
[66.134251] [002/132] (953s left) core_setmaster (master-drop-set-root)
[66.194902] Starting subtest: master-drop-set-root
[66.210497] Subtest master-drop-set-root: SUCCESS (0.016s)
[66.256678] [003/132] (953s left) gem_spin_batch (engines)
[66.317280] Starting subtest: engines
[66.319651] Starting dynamic subtest: rcs0
[69.649862] Dynamic subtest rcs0: SUCCESS (3.324s)
[69.658794] Starting dynamic subtest: bcs0
[72.886497] Dynamic subtest bcs0: SUCCESS (3.233s)
[72.895502] Starting dynamic subtest: vcs0
[76.124961] Dynamic subtest vcs0: SUCCESS (3.235s)
[76.134102] Starting dynamic subtest: vcs1
[79.360227] Dynamic subtest vcs1: SUCCESS (3.234s)
[79.369355] Starting dynamic subtest: vecs0
[82.593651] Dynamic subtest vecs0: SUCCESS (3.232s)
[82.602846] Starting dynamic subtest: ccs0
[85.829830] Dynamic subtest ccs0: SUCCESS (3.234s)
[85.832235] Subtest engines: SUCCESS (19.499s)
[86.075841] [004/132] (933s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[86.177462] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[86.205543] Starting dynamic subtest: pipe-A-plane-0
[86.505883] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[86.514409] Starting dynamic subtest: pipe-A-plane-3
[86.750143] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[86.757822] Starting dynamic subtest: pipe-A-plane-5
[86.761719] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[87.814171] Starting dynamic subtest: pipe-B-plane-0
[88.107459] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[88.116206] Starting dynamic subtest: pipe-B-plane-3
[88.352445] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[88.360885] Starting dynamic subtest: pipe-B-plane-5
[88.364764] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[88.667832] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.488s)
[89.505961] [005/132] (930s left) gem_partial_pwrite_pread (reads)
[89.565927] Subtest reads: SKIP (0.000s)
[89.628761] [006/132] (930s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[89.817828] Starting subtest: cursor-rapid-movement-128x128
[89.822317] Starting dynamic subtest: pipe-A-eDP-1
[90.402797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.580s)
[90.431173] Starting dynamic subtest: pipe-D-eDP-1
[91.584295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.161s)
[91.586572] Subtest cursor-rapid-movement-128x128: SUCCESS (1.765s)
[92.440683] [007/132] (927s left) kms_cdclk (mode-transition)
[92.536992] Starting subtest: mode-transition
[92.539377] Starting dynamic subtest: pipe-A-eDP-1
[92.825130] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[92.832652] Starting dynamic subtest: pipe-B-eDP-1
[92.837092] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[92.843998] Starting dynamic subtest: pipe-C-eDP-1
[92.848401] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[92.856214] Starting dynamic subtest: pipe-D-eDP-1
[92.860882] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[92.865522] Subtest mode-transition: SKIP (0.294s)
[93.689389] [008/132] (926s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[93.803411] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[93.808055] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[93.919685] [009/132] (926s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[94.311979] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[95.087339] [010/132] (925s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[95.171374] Starting subtest: plane-all-transition-nonblocking-fencing
[95.173828] Starting dynamic subtest: pipe-A-eDP-1
[97.666985] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[97.972524] Starting dynamic subtest: pipe-B-eDP-1
[101.238680] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.274s)
[101.547492] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.375s)
[102.358192] [011/132] (917s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[102.462519] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[107.037607] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.578s)
[108.166246] [012/132] (912s left) kms_rotation_crc (sprite-rotation-270)
[108.268767] Starting subtest: sprite-rotation-270
[108.273240] Subtest sprite-rotation-270: SKIP (0.001s)
[108.338520] [013/132] (912s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[108.433847] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[108.436059] Starting dynamic subtest: pipe-A-default-mode
[109.637922] Dynamic subtest pipe-A-default-mode: SKIP (1.199s)
[109.642407] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.201s)
[109.765773] [014/132] (910s left) drm_read (empty-nonblock)
[109.902888] Starting subtest: empty-nonblock
[109.905124] Subtest empty-nonblock: SUCCESS (0.000s)
[110.026611] [015/132] (910s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[110.121678] Starting subtest: crc-primary-basic-y-tiled-ccs
[110.123890] Starting dynamic subtest: pipe-A-eDP-1
[110.146631] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[110.154912] Starting dynamic subtest: pipe-B-eDP-1
[110.177162] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[110.183919] Starting dynamic subtest: pipe-C-eDP-1
[110.205764] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[110.212404] Starting dynamic subtest: pipe-D-eDP-1
[110.234270] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[110.238299] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s)
[112.302164] [016/132] (908s left) prime_vgem (fence-write-hang)
[112.425588] Subtest fence-write-hang: SKIP (0.000s)
[112.524939] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true
[112.528059] [017/132] (908s left) gem_eio (in-flight-10ms)
[112.738272] Starting subtest: in-flight-10ms
[120.671306] Subtest in-flight-10ms: SUCCESS (7.931s)
[120.838139] [018/132] (899s left) gem_ctx_isolation (nonpriv)
[120.907676] Starting subtest: nonpriv
[120.910149] Starting dynamic subtest: rcs0
[121.146650] Dynamic subtest rcs0: SUCCESS (0.239s)
[121.155084] Starting dynamic subtest: bcs0
[121.392625] Dynamic subtest bcs0: SUCCESS (0.244s)
[121.402244] Starting dynamic subtest: vcs0
[121.649589] Dynamic subtest vcs0: SUCCESS (0.257s)
[121.657127] Starting dynamic subtest: vcs1
[123.113946] Dynamic subtest vcs1: SUCCESS (1.463s)
[123.121260] Starting dynamic subtest: vecs0
[125.169839] Dynamic subtest vecs0: SUCCESS (2.055s)
[125.180064] Starting dynamic subtest: ccs0
[127.206110] Dynamic subtest ccs0: SUCCESS (2.036s)
[127.208337] Subtest nonpriv: SUCCESS (6.299s)
[127.452838] [019/132] (893s left) kms_pm_backlight (brightness-with-dpms)
[127.546694] Starting subtest: brightness-with-dpms
[127.597973] Starting dynamic subtest: eDP-1
[129.994398] Dynamic subtest eDP-1: SUCCESS (2.394s)
[129.996684] Subtest brightness-with-dpms: SUCCESS (2.447s)
[130.856651] [020/132] (889s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[130.961821] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[130.966332] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[131.044424] [021/132] (889s left) i915_query (query-topology-known-pci-ids)
[131.098839] Starting subtest: query-topology-known-pci-ids
[131.103230] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[131.181343] [022/132] (889s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[131.266696] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[131.268826] Starting dynamic subtest: pipe-A-eDP-1
[131.292973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.025s)
[131.302727] Starting dynamic subtest: pipe-B-eDP-1
[131.321952] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[131.329654] Starting dynamic subtest: pipe-C-eDP-1
[131.348395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[131.356110] Starting dynamic subtest: pipe-D-eDP-1
[131.375352] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[131.377437] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[133.534749] [023/132] (887s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[133.639228] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[133.641470] Starting dynamic subtest: pipe-A-eDP-1
[133.759082] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[133.769070] Starting dynamic subtest: pipe-B-eDP-1
[134.925105] Dynamic subtest pipe-B-eDP-1: SKIP (1.163s)
[134.929474] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.287s)
[136.112150] [024/132] (884s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[136.210986] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[136.215481] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[136.315852] [025/132] (884s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[136.397892] Starting subtest: basic-modeset-with-all-modifiers-formats
[136.781823] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[137.602495] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.822s)
[137.611047] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[137.624075] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[137.631332] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[137.646460] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[137.654082] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[137.802034] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[137.811189] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[137.823802] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[137.831076] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[137.846350] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[137.853699] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[137.868592] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[137.875896] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[137.890531] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[137.898069] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[137.913121] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[137.920390] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[137.935276] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[137.942991] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[137.957497] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.020s)
[137.964993] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[137.979727] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[137.987306] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[138.135493] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[138.144156] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[138.157645] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[138.165118] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[138.179797] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[138.187158] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[138.202213] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[138.211774] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[138.224223] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[138.231818] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[138.246535] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[138.253550] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[138.268426] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[138.275492] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[138.290997] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[138.298764] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[138.313087] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[138.320319] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[138.469518] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[138.477617] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[138.491277] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[138.498504] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[138.513388] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[138.520668] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[138.535741] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[138.542878] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[138.557700] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[138.567669] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[138.580148] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[138.586967] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[138.601684] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[138.608372] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[138.624252] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[138.630861] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[138.646558] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[139.026451] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.629s)
[139.799775] [026/132] (881s left) kms_draw_crc (draw-method-render)
[139.896154] Starting subtest: draw-method-render
[139.898042] Starting dynamic subtest: xrgb8888-untiled
[140.149386] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[140.156810] Starting dynamic subtest: rgb565-untiled
[140.382222] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[140.390372] Starting dynamic subtest: xrgb2101010-untiled
[140.616325] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[140.625067] Starting dynamic subtest: xbgr16161616f-untiled
[140.826587] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[140.834497] Starting dynamic subtest: xrgb8888-xtiled
[140.948857] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[140.956700] Starting dynamic subtest: rgb565-xtiled
[141.060467] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[141.068657] Starting dynamic subtest: xrgb2101010-xtiled
[141.170869] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[141.178434] Starting dynamic subtest: xbgr16161616f-xtiled
[141.304426] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[141.311997] Starting dynamic subtest: xrgb8888-4tiled
[141.426711] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[141.435921] Starting dynamic subtest: rgb565-4tiled
[141.559665] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[141.567513] Starting dynamic subtest: xrgb2101010-4tiled
[141.670804] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[141.678698] Starting dynamic subtest: xbgr16161616f-4tiled
[141.803976] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[141.805838] Subtest draw-method-render: SUCCESS (1.911s)
[141.930553] [027/132] (879s left) gem_exec_params (invalid-ring)
[141.981454] Starting subtest: invalid-ring
[141.983391] Subtest invalid-ring: SUCCESS (0.000s)
[142.071564] [028/132] (878s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[142.120358] Starting subtest: single-wait-all-for-submit-signaled
[142.122330] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[142.244905] [029/132] (878s left) kms_atomic_interruptible (universal-setplane-primary)
[142.334105] Starting subtest: universal-setplane-primary
[142.335890] Starting dynamic subtest: pipe-A-eDP-1
[149.699017] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.362s)
[149.701189] Subtest universal-setplane-primary: SUCCESS (7.363s)
[150.542053] [030/132] (870s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[150.643981] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[150.648312] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[150.771719] [031/132] (870s left) gem_exec_balancer (parallel-bb-first)
[151.020692] Starting subtest: parallel-bb-first
[151.923206] Subtest parallel-bb-first: SUCCESS (0.903s)
[152.953715] [032/132] (868s left) kms_chamelium_hpd (hdmi-hpd)
[153.334675] Subtest hdmi-hpd: SKIP (0.000s)
[154.146981] [033/132] (867s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[154.242284] Starting subtest: x-tiled-32bpp-rotate-180
[155.621569] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.378s)
[155.789790] [034/132] (865s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[155.843673] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[155.952570] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[156.030121] [035/132] (865s left) kms_cursor_edge_walk (256x256-right-edge)
[156.124284] Starting subtest: 256x256-right-edge
[156.126712] Starting dynamic subtest: pipe-A-eDP-1
[159.544795] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[159.553504] Starting dynamic subtest: pipe-D-eDP-1
[162.673874] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[162.676181] Subtest 256x256-right-edge: SUCCESS (6.552s)
[163.468396] [036/132] (857s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[163.565600] Starting subtest: 4-tiled-32bpp-rotate-0
[165.055726] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.489s)
[165.180898] [037/132] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[165.272503] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[165.275901] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[165.368383] [038/132] (856s left) gem_mmap (pf-nonblock)
[165.426086] Subtest pf-nonblock: SKIP (0.000s)
[165.490425] [039/132] (855s left) kms_flip (2x-flip-vs-panning)
[165.582499] Starting subtest: 2x-flip-vs-panning
[165.593510] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[165.670138] [040/132] (855s left) gem_exec_big (single)
[165.741514] Starting subtest: single
[170.509458] Subtest single: SUCCESS (4.765s)
[170.749861] [041/132] (850s left) syncobj_timeline (invalid-query-illegal-handle)
[170.852764] Starting subtest: invalid-query-illegal-handle
[170.854829] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[170.948222] [042/132] (850s left) gem_mmap_wc (write-cpu-read-wc)
[171.003372] Subtest write-cpu-read-wc: SKIP (0.000s)
[171.055646] [043/132] (850s left) syncobj_timeline (multi-wait-available-submitted)
[171.106077] Starting subtest: multi-wait-available-submitted
[171.108395] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[171.203766] [044/132] (850s left) gem_pxp (verify-pxp-stale-buf-execution)
[171.328069] Starting subtest: verify-pxp-stale-buf-execution
[172.396093] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.070s)
[172.508495] [045/132] (849s left) gem_mmap_gtt (medium-copy-odd)
[172.552853] Subtest medium-copy-odd: SKIP (0.000s)
[172.611695] [046/132] (849s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[172.664127] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[172.666318] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[172.764189] [047/132] (849s left) syncobj_wait (signal)
[172.816180] Starting subtest: signal
[172.818029] Subtest signal: SUCCESS (0.000s)
[172.907370] [048/132] (848s left) kms_lease (lease-invalid-crtc)
[173.005925] Starting subtest: lease-invalid-crtc
[173.008263] Starting dynamic subtest: pipe-A-eDP-1
[173.010511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[173.018979] Starting dynamic subtest: pipe-B-eDP-1
[173.021169] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[173.029065] Starting dynamic subtest: pipe-C-eDP-1
[173.030916] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[173.039034] Starting dynamic subtest: pipe-D-eDP-1
[173.041141] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[173.043216] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[173.082276] [049/132] (848s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[173.128568] Starting subtest: rel-constants-invalid-rel-gen5
[173.130916] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[173.250504] [050/132] (848s left) kms_psr (fbc-psr-primary-mmap-cpu)
[173.342450] Starting subtest: fbc-psr-primary-mmap-cpu
[173.344761] Starting dynamic subtest: eDP-1
[173.348524] Dynamic subtest eDP-1: SKIP (0.000s)
[173.351900] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[173.410954] [051/132] (848s left) gem_tiled_pread_basic (basic)
[173.473927] Subtest basic: SKIP (0.000s)
[173.545352] [052/132] (848s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[173.627388] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[173.629212] Starting dynamic subtest: pipe-A-eDP-1
[173.636755] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[173.646826] Starting dynamic subtest: pipe-B-eDP-1
[173.655110] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[173.662884] Starting dynamic subtest: pipe-C-eDP-1
[173.669807] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[173.676921] Starting dynamic subtest: pipe-D-eDP-1
[173.683913] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[173.687324] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[175.927943] [053/132] (846s left) prime_udl
[176.014762] [054/132] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[176.118878] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[176.123146] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[176.227995] [055/132] (845s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[176.321939] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[176.326397] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[176.415844] [056/132] (845s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[176.508703] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[180.869410] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.362s)
[182.032898] [057/132] (840s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[182.160268] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[183.592320] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.430s)
[184.385235] [058/132] (837s left) kms_content_protection (dp-mst-type-1)
[184.540093] Starting subtest: dp-mst-type-1
[184.544077] Subtest dp-mst-type-1: SKIP (0.000s)
[184.668730] [059/132] (837s left) kms_cursor_crc (cursor-onscreen-512x170)
[184.959621] Starting subtest: cursor-onscreen-512x170
[184.964083] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[185.084706] [060/132] (837s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[185.176373] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[192.254195] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.080s)
[192.355451] [061/132] (829s left) gem_exec_schedule (preempt-engines)
[192.443429] Starting subtest: preempt-engines
[192.445652] Starting dynamic subtest: rcs0
[194.698622] Dynamic subtest rcs0: SUCCESS (2.260s)
[194.707113] Starting dynamic subtest: bcs0
[196.916733] Dynamic subtest bcs0: SUCCESS (2.216s)
[196.931118] Starting dynamic subtest: vcs0
[199.199419] Dynamic subtest vcs0: SUCCESS (2.281s)
[199.213567] Starting dynamic subtest: vcs1
[201.476845] Dynamic subtest vcs1: SUCCESS (2.275s)
[201.485061] Starting dynamic subtest: vecs0
[203.743384] Dynamic subtest vecs0: SUCCESS (2.264s)
[203.756808] Starting dynamic subtest: ccs0
[206.073755] Dynamic subtest ccs0: SUCCESS (2.328s)
[206.076153] Subtest preempt-engines: SUCCESS (13.636s)
[206.376188] [062/132] (815s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[206.473271] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[206.477580] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[206.572787] [063/132] (815s left) gem_exec_whisper (basic-contexts-all)
[206.639899] Starting subtest: basic-contexts-all
[217.492086] Subtest basic-contexts-all: SUCCESS (10.850s)
[217.677590] [064/132] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[217.782215] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[217.786195] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.869927] [065/132] (804s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[217.979674] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[217.984266] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[218.138417] [066/132] (804s left) i915_suspend (fence-restore-tiled2untiled)
[218.190070] Starting subtest: fence-restore-tiled2untiled
[218.194432] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[218.292940] [067/132] (804s left) kms_psr (psr-cursor-blt)
[218.384301] Starting subtest: psr-cursor-blt
[218.386624] Starting dynamic subtest: eDP-1
[220.101493] Dynamic subtest eDP-1: SUCCESS (1.717s)
[220.103377] Subtest psr-cursor-blt: SUCCESS (1.718s)
[220.964037] [068/132] (801s left) gem_exec_schedule (deep)
[221.149221] Starting subtest: deep
[221.151728] Starting dynamic subtest: rcs0
[226.879354] Dynamic subtest rcs0: SKIP (5.728s)
[226.890893] Starting dynamic subtest: vcs0
[237.933504] Dynamic subtest vcs0: SUCCESS (11.054s)
[237.957949] Starting dynamic subtest: vcs1
[250.281030] Dynamic subtest vcs1: SUCCESS (12.345s)
[250.292928] Starting dynamic subtest: vecs0
[262.049022] Dynamic subtest vecs0: SUCCESS (11.766s)
[262.061186] Starting dynamic subtest: ccs0
[275.160283] Dynamic subtest ccs0: SUCCESS (13.110s)
[275.163042] Subtest deep: SUCCESS (54.009s)
[276.646747] [069/132] (746s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[276.787244] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[276.791820] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[276.944388] [070/132] (745s left) kms_psr (psr-primary-render)
[277.047899] Starting subtest: psr-primary-render
[277.050219] Starting dynamic subtest: eDP-1
[278.774351] Dynamic subtest eDP-1: SUCCESS (1.727s)
[278.776765] Subtest psr-primary-render: SUCCESS (1.728s)
[279.649827] [071/132] (743s left) gem_softpin (invalid)
[279.710680] Starting subtest: invalid
[279.724944] Subtest invalid: SUCCESS (0.014s)
[279.874971] [072/132] (742s left) sw_sync (sync_busy_fork_unixsocket)
[279.920588] Starting subtest: sync_busy_fork_unixsocket
[279.926206] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[280.003896] [073/132] (742s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[280.131913] Starting subtest: 2x-long-cursor-vs-flip-atomic
[280.136525] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[280.278236] [074/132] (742s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[280.338289] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[280.440859] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[280.534393] [075/132] (742s left) kms_psr (pr-primary-render)
[280.632314] Starting subtest: pr-primary-render
[280.636238] Subtest pr-primary-render: SKIP (0.000s)
[280.701084] [076/132] (742s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[280.771271] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[280.775861] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[280.954797] [077/132] (742s left) kms_atomic (plane-invalid-params)
[281.044722] Starting subtest: plane-invalid-params
[281.046892] Starting dynamic subtest: pipe-A-eDP-1
[281.437696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[281.439890] Subtest plane-invalid-params: SUCCESS (0.390s)
[282.246712] [078/132] (740s left) gem_ccs (block-copy-uncompressed)
[282.309225] Starting subtest: block-copy-uncompressed
[282.311349] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[282.340936] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.031s)
[282.352116] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[282.357799] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[282.366099] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[282.374069] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[282.382450] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[282.390605] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[282.392733] Subtest block-copy-uncompressed: SUCCESS (0.082s)
[282.516947] [079/132] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[282.612511] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[282.616928] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[282.721156] [080/132] (740s left) kms_getfb (getfb2-handle-closed)
[282.812095] Starting subtest: getfb2-handle-closed
[282.814385] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[282.932318] [081/132] (740s left) perf (invalid-create-userspace-config)
[283.064363] Starting subtest: invalid-create-userspace-config
[283.066660] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[283.104141] [082/132] (740s left) vgem_basic (bad-handle)
[283.148770] Starting subtest: bad-handle
[283.150454] Subtest bad-handle: SUCCESS (0.000s)
[283.207865] [083/132] (740s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[283.314551] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[283.316504] Starting dynamic subtest: pipe-A-eDP-1
[283.335562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.344627] Starting dynamic subtest: pipe-B-eDP-1
[283.362730] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.370821] Starting dynamic subtest: pipe-C-eDP-1
[283.388907] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.396829] Starting dynamic subtest: pipe-D-eDP-1
[283.415061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.418697] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[285.573534] [084/132] (737s left) kms_big_fb (linear-32bpp-rotate-0)
[285.684996] Starting subtest: linear-32bpp-rotate-0
[287.274759] Subtest linear-32bpp-rotate-0: SUCCESS (1.589s)
[287.405822] [085/132] (735s left) kms_vblank (ts-continuation-dpms-suspend)
[287.508240] Starting subtest: ts-continuation-dpms-suspend
[287.510056] Starting dynamic subtest: pipe-A-eDP-1
[304.454791] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.004s)
[304.472252] Starting dynamic subtest: pipe-D-eDP-1
[322.470769] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.493s)
[322.473213] Subtest ts-continuation-dpms-suspend: SUCCESS (4.501s)
[323.294046] [086/132] (700s left) i915_drm_fdinfo (virtual-idle)
[323.358046] Starting subtest: virtual-idle
[326.461383] Subtest virtual-idle: SUCCESS (3.054s)
[326.539110] [087/132] (696s left) gem_fenced_exec_thrash (no-spare-fences)
[326.603858] Subtest no-spare-fences: SKIP (0.000s)
[326.673967] [088/132] (696s left) gem_caching (writes)
[326.737571] Subtest writes: SKIP (0.000s)
[326.812563] [089/132] (696s left) kms_pm_rpm (package-g7)
[328.744487] Starting subtest: package-g7
[328.749135] Subtest package-g7: SKIP (0.000s)
[329.116473] [090/132] (694s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[329.215223] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[336.654995] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.401s)
[336.770028] [091/132] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[336.865328] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[336.869436] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.946884] [092/132] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[337.039510] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[344.329515] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.276s)
[344.432863] [093/132] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[344.541692] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[344.546081] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[344.647896] [094/132] (679s left) gem_exec_parallel (contexts)
[344.702182] Starting subtest: contexts
[344.704454] Starting dynamic subtest: rcs0
[347.561448] Dynamic subtest rcs0: SUCCESS (2.856s)
[347.571647] Starting dynamic subtest: bcs0
[351.282352] Dynamic subtest bcs0: SUCCESS (3.716s)
[351.292663] Starting dynamic subtest: vcs0
[355.740209] Dynamic subtest vcs0: SUCCESS (4.455s)
[355.750650] Starting dynamic subtest: vcs1
[359.853797] Dynamic subtest vcs1: SUCCESS (4.113s)
[359.865979] Starting dynamic subtest: vecs0
[363.833350] Dynamic subtest vecs0: SUCCESS (3.979s)
[363.846195] Starting dynamic subtest: ccs0
[367.569888] Dynamic subtest ccs0: SUCCESS (3.736s)
[367.572142] Subtest contexts: SUCCESS (22.867s)
[367.758515] [095/132] (656s left) kms_prop_blob (invalid-get-prop)
[367.839503] Starting subtest: invalid-get-prop
[367.841734] Subtest invalid-get-prop: SUCCESS (0.000s)
[367.943534] [096/132] (655s left) vgem_basic (dmabuf-fence)
[367.994288] Starting subtest: dmabuf-fence
[367.996511] Subtest dmabuf-fence: SUCCESS (0.000s)
[368.054077] [097/132] (655s left) gem_create (create-ext-set-pat)
[368.239645] Starting subtest: create-ext-set-pat
[368.242203] Subtest create-ext-set-pat: SUCCESS (0.001s)
[368.341738] [098/132] (655s left) gem_render_copy (y-tiled-ccs-to-linear)
[368.391582] Starting subtest: y-tiled-ccs-to-linear
[368.395993] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[368.576787] [099/132] (655s left) gen7_exec_parse (bitmasks)
[368.648136] Subtest bitmasks: SKIP (0.000s)
[368.716032] [100/132] (655s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[368.818405] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[368.822488] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[368.901429] [101/132] (655s left) i915_pm_rpm (gem-execbuf-stress)
[370.440709] Starting subtest: gem-execbuf-stress
[370.442686] Starting dynamic subtest: smem0
[383.394026] Dynamic subtest smem0: SUCCESS (12.952s)
[383.406736] Starting dynamic subtest: extra-wait-smem0
[445.150229] Dynamic subtest extra-wait-smem0: SUCCESS (61.748s)
[445.152927] Subtest gem-execbuf-stress: SUCCESS (74.707s)
[445.534296] [102/132] (578s left) kms_mmap_write_crc (main)
[445.626414] Starting subtest: main
[445.628666] Starting dynamic subtest: pipe-A-eDP-1
[449.073274] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[449.075711] Subtest main: SUCCESS (3.447s)
[449.960899] [103/132] (574s left) perf (global-sseu-config)
[450.056853] Starting subtest: global-sseu-config
[450.061553] Subtest global-sseu-config: SKIP (0.000s)
[450.105844] [104/132] (574s left) perf (polling-parameterized)
[450.177580] Starting subtest: polling-parameterized
[470.199158] Subtest polling-parameterized: SUCCESS (20.021s)
[470.249909] [105/132] (553s left) gem_exec_suspend (basic-s3-devices)
[470.321061] Starting subtest: basic-S3-devices
[470.323000] Starting dynamic subtest: smem
[482.273655] Dynamic subtest smem: SUCCESS (11.951s)
[482.276730] Subtest basic-S3-devices: SUCCESS (11.953s)
[482.461200] [106/132] (541s left) vgem_basic (sysfs)
[482.511155] Starting subtest: sysfs
[482.513330] Subtest sysfs: SUCCESS (0.000s)
[482.567596] [107/132] (541s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[482.668125] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[482.670346] Starting dynamic subtest: pipe-A-eDP-1
[482.689778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[482.707423] Starting dynamic subtest: pipe-B-eDP-1
[482.725876] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[482.735391] Starting dynamic subtest: pipe-C-eDP-1
[482.753871] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[482.763054] Starting dynamic subtest: pipe-D-eDP-1
[482.782165] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[482.784018] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[484.998733] [108/132] (539s left) kms_invalid_mode (uint-max-clock)
[485.091174] Starting subtest: uint-max-clock
[485.093389] Starting dynamic subtest: pipe-A-eDP-1
[485.378445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[485.388884] Starting dynamic subtest: pipe-B-eDP-1
[485.390777] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[485.400580] Starting dynamic subtest: pipe-C-eDP-1
[485.402850] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[485.417955] Starting dynamic subtest: pipe-D-eDP-1
[485.420891] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[485.423822] Subtest uint-max-clock: SUCCESS (0.295s)
[486.207276] [109/132] (538s left) i915_drm_fdinfo (most-busy-check-all)
[486.240953] Starting subtest: most-busy-check-all
[486.243291] Starting dynamic subtest: rcs0
[486.248191] Dynamic subtest rcs0: SKIP (0.004s)
[486.263960] Starting dynamic subtest: bcs0
[486.268507] Dynamic subtest bcs0: SKIP (0.000s)
[486.278369] Starting dynamic subtest: vcs0
[486.282651] Dynamic subtest vcs0: SKIP (0.000s)
[486.292249] Starting dynamic subtest: vcs1
[486.296529] Dynamic subtest vcs1: SKIP (0.000s)
[486.305828] Starting dynamic subtest: vecs0
[486.310238] Dynamic subtest vecs0: SKIP (0.000s)
[486.320200] Starting dynamic subtest: ccs0
[486.324351] Dynamic subtest ccs0: SKIP (0.000s)
[486.328648] Subtest most-busy-check-all: SKIP (0.009s)
[486.365372] [110/132] (538s left) syncobj_timeline (etime-single-wait-submitted)
[486.460652] Starting subtest: etime-single-wait-submitted
[486.564141] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[486.640725] [111/132] (537s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[486.753173] Starting subtest: psr2-plane-move-sf-dmg-area
[486.755434] Starting dynamic subtest: pipe-A-eDP-1
[491.276836] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.524s)
[491.287388] Starting dynamic subtest: pipe-B-eDP-1
[496.603150] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.324s)
[496.605488] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.851s)
[497.476554] [112/132] (527s left) gem_exec_fence (basic-wait-all)
[497.541877] Starting subtest: basic-wait-all
[497.620098] Subtest basic-wait-all: SUCCESS (0.078s)
[499.373483] [113/132] (525s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[499.475679] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[500.422097] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.945s)
[500.554489] [114/132] (524s left) vgem_basic (mmap)
[500.597597] Starting subtest: mmap
[500.604366] Subtest mmap: SUCCESS (0.010s)
[500.662188] [115/132] (523s left) gem_mmap_offset (isolation)
[500.716972] Starting subtest: isolation
[500.732038] Subtest isolation: SUCCESS (0.006s)
[500.810282] [116/132] (523s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[500.908604] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[500.912239] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[500.978806] [117/132] (523s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[501.062507] Starting subtest: fbc-psr2-primary-mmap-cpu
[501.064457] Starting dynamic subtest: eDP-1
[501.067996] Dynamic subtest eDP-1: SKIP (0.000s)
[501.071590] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[501.148496] [118/132] (523s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[501.240996] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[501.244853] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[501.347858] [119/132] (523s left) perf_pmu (render-node-busy)
[501.401925] Starting subtest: render-node-busy
[501.403818] Starting dynamic subtest: rcs0
[501.966203] Dynamic subtest rcs0: SUCCESS (0.563s)
[501.977542] Starting dynamic subtest: bcs0
[502.525031] Dynamic subtest bcs0: SUCCESS (0.556s)
[502.536679] Starting dynamic subtest: vcs0
[504.353456] Dynamic subtest vcs0: SUCCESS (1.824s)
[504.366190] Starting dynamic subtest: vcs1
[506.336711] Dynamic subtest vcs1: SUCCESS (1.980s)
[506.349661] Starting dynamic subtest: vecs0
[508.320592] Dynamic subtest vecs0: SUCCESS (1.980s)
[508.332178] Starting dynamic subtest: ccs0
[508.887821] Dynamic subtest ccs0: SUCCESS (0.565s)
[508.890319] Subtest render-node-busy: SUCCESS (7.485s)
[508.982583] [120/132] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[509.085534] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[509.089806] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[509.184442] [121/132] (515s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[509.278166] Starting subtest: plane-upscale-20x20-with-rotation
[509.280784] Starting dynamic subtest: pipe-A
[509.501943] Dynamic subtest pipe-A: SUCCESS (0.227s)
[509.513681] Starting dynamic subtest: pipe-B
[510.754858] Dynamic subtest pipe-B: SUCCESS (1.251s)
[510.765623] Starting dynamic subtest: pipe-C
[512.090476] Dynamic subtest pipe-C: SUCCESS (1.334s)
[512.100124] Starting dynamic subtest: pipe-D
[513.421422] Dynamic subtest pipe-D: SUCCESS (1.329s)
[513.423854] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.146s)
[514.599081] [122/132] (510s left) gem_eio (throttle)
[514.795719] Starting subtest: throttle
[515.097896] Subtest throttle: SUCCESS (0.300s)
[515.261428] [123/132] (509s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[515.781473] Starting subtest: syncobj-stationary-timeline-chain-engines
[515.907562] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.126s)
[517.434680] [124/132] (507s left) gem_eio (unwedge-stress)
[517.647967] Starting subtest: unwedge-stress
[517.649836] Starting dynamic subtest: render
[522.287073] Dynamic subtest render: SUCCESS (4.636s)
[522.303338] Starting dynamic subtest: bsd1
[540.787902] Dynamic subtest bsd1: SUCCESS (18.496s)
[540.805669] Starting dynamic subtest: bsd2
[558.737318] Dynamic subtest bsd2: SUCCESS (17.944s)
[558.753557] Starting dynamic subtest: blt
[558.757937] Dynamic subtest blt: SKIP (0.000s)
[558.767147] Starting dynamic subtest: vebox
[576.821691] Dynamic subtest vebox: SUCCESS (18.080s)
[576.824095] Subtest unwedge-stress: SUCCESS (59.161s)
[578.377087] [125/132] (446s left) kms_sequence (queue-idle)
[578.471059] Starting subtest: queue-idle
[578.473226] Starting dynamic subtest: pipe-A-eDP-1
[580.287562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[580.298714] Starting dynamic subtest: pipe-B-eDP-1
[582.775506] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.485s)
[582.786385] Starting dynamic subtest: pipe-C-eDP-1
[585.188193] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.411s)
[585.200394] Starting dynamic subtest: pipe-D-eDP-1
[587.620106] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[587.622275] Subtest queue-idle: SUCCESS (9.149s)
[588.444271] [126/132] (436s left) gem_exec_whisper (basic-queues-forked)
[588.512417] Starting subtest: basic-queues-forked
[612.405621] Subtest basic-queues-forked: SUCCESS (23.884s)
[612.604197] [127/132] (412s left) kms_flip (plain-flip-fb-recreate-interruptible)
[612.704912] Starting subtest: plain-flip-fb-recreate-interruptible
[612.707083] Starting dynamic subtest: A-eDP1
[621.535164] Dynamic subtest A-eDP1: SUCCESS (8.828s)
[621.546901] Starting dynamic subtest: B-eDP1
[630.363817] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[630.374606] Starting dynamic subtest: C-eDP1
[639.183545] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[639.193862] Starting dynamic subtest: D-eDP1
[648.006272] Dynamic subtest D-eDP1: SUCCESS (8.819s)
[648.010984] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.299s)
[649.197473] [128/132] (375s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[649.322162] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[649.326639] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[649.431499] [129/132] (375s left) gem_exec_schedule (submit-early-slice)
[649.500827] Starting subtest: submit-early-slice
[649.502756] Starting dynamic subtest: rcs0
[649.547993] Dynamic subtest rcs0: SUCCESS (0.051s)
[649.560929] Starting dynamic subtest: bcs0
[649.588190] Dynamic subtest bcs0: SUCCESS (0.040s)
[649.600703] Starting dynamic subtest: vcs0
[649.632015] Dynamic subtest vcs0: SUCCESS (0.043s)
[649.646253] Starting dynamic subtest: vcs1
[649.685147] Dynamic subtest vcs1: SUCCESS (0.052s)
[649.697367] Starting dynamic subtest: vecs0
[649.728157] Dynamic subtest vecs0: SUCCESS (0.043s)
[649.739340] Starting dynamic subtest: ccs0
[649.776286] Dynamic subtest ccs0: SUCCESS (0.047s)
[649.778699] Subtest submit-early-slice: SUCCESS (0.281s)
[651.383504] [130/132] (373s left) gem_ctx_shared (create-shared-gtt)
[651.433523] Starting subtest: create-shared-gtt
[653.593345] Subtest create-shared-gtt: SUCCESS (2.152s)
[653.903320] [131/132] (371s left) gem_mmap (bad-offset)
[653.969925] Subtest bad-offset: SKIP (0.000s)
[654.037116] [132/132] (371s left) api_intel_bb (purge-bb)
[654.093270] Starting subtest: purge-bb
[654.097957] Subtest purge-bb: SUCCESS (0.006s)
[654.217824] Closing watchdogs
results: parsing output: 0/ for test: kms_color_pipeline
results: parsing output: 1/ for test: core_setmaster
results: parsing output: 2/ for test: gem_spin_batch
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: gem_partial_pwrite_pread
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_cdclk
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_chamelium_frames
results: parsing output: 9/ for test: kms_atomic_transition
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: drm_read
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: gem_ctx_isolation
results: parsing output: 18/ for test: kms_pm_backlight
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: i915_query
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_draw_crc
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_atomic_interruptible
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_cursor_edge_walk
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: gem_exec_big
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_mmap_wc
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_tiled_pread_basic
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: prime_udl
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_content_protection
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_softpin
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: gem_ccs
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: gem_fenced_exec_thrash
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_parallel
results: parsing output: 94/ for test: kms_prop_blob
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: gem_create
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_mmap_write_crc
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: gem_exec_suspend
results: parsing output: 105/ for test: vgem_basic
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: vgem_basic
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_sequence
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_ctx_shared
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: api_intel_bb
Done.