[40.778758] Initializing watchdogs
[40.778887]   /dev/watchdog0
[40.793415] [001/143] (960s left) gem_exec_async (forked-writes)
[40.854412] Starting subtest: forked-writes
[40.856907] Starting dynamic subtest: rcs0
[40.898895] Dynamic subtest rcs0: SUCCESS (0.045s)
[40.917036] Starting dynamic subtest: bcs0
[40.942857] Dynamic subtest bcs0: SUCCESS (0.043s)
[40.950789] Starting dynamic subtest: vcs0
[40.969292] Dynamic subtest vcs0: SUCCESS (0.026s)
[40.976738] Starting dynamic subtest: vcs1
[40.996765] Dynamic subtest vcs1: SUCCESS (0.027s)
[41.004624] Starting dynamic subtest: vecs0
[41.015746] Dynamic subtest vecs0: SUCCESS (0.019s)
[41.022786] Starting dynamic subtest: ccs0
[41.061799] Dynamic subtest ccs0: SUCCESS (0.044s)
[41.063779] Subtest forked-writes: SUCCESS (0.206s)
[41.294460] [002/143] (960s left) gen3_render_tiledx_blits
[41.395905] [003/143] (959s left) kms_cursor_crc (cursor-alpha-transparent)
[41.462574] Starting subtest: cursor-alpha-transparent
[41.465059] Starting dynamic subtest: pipe-A-eDP-1
[42.235540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s)
[42.245804] Starting dynamic subtest: pipe-D-eDP-1
[43.652868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[43.655820] Subtest cursor-alpha-transparent: SUCCESS (2.187s)
[44.524742] [004/143] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[44.613023] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[44.617463] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[44.693676] [005/143] (956s left) i915_pm_freq_api (freq-suspend)
[44.762749] Starting subtest: freq-suspend
[44.765345] Starting dynamic subtest: gt0
[62.062282] Dynamic subtest gt0: SUCCESS (1.304s)
[62.073353] Starting dynamic subtest: gt1
[78.056694] Dynamic subtest gt1: SUCCESS (1.244s)
[78.058789] Subtest freq-suspend: SUCCESS (2.550s)
[78.126107] [006/143] (954s left) i915_query (test-query-geometry-subslices)
[78.203733] Starting subtest: test-query-geometry-subslices
[78.205988] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[78.270936] [007/143] (953s left) gem_ctx_persistence (heartbeat-hostile)
[78.359837] Starting subtest: heartbeat-hostile
[78.365420] Subtest heartbeat-hostile: SKIP (0.000s)
[78.424130] [008/143] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[78.512381] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[78.517103] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[78.589997] [009/143] (953s left) kms_ccs (pipe-a-bad-pixel-format-y-tiled-gen12-rc-ccs)
[78.653583] Starting subtest: pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs
[78.658481] Subtest pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[79.860768] [010/143] (952s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[79.919707] Subtest writes-after-reads-uncached: SKIP (0.000s)
[79.976727] [011/143] (952s left) gem_exec_fair (basic-none-rrul)
[80.070860] Subtest basic-none-rrul: SKIP (0.000s)
[80.118969] [012/143] (952s left) kms_atomic_transition (modeset-transition-fencing)
[80.222891] Starting subtest: modeset-transition-fencing
[80.225233] Starting dynamic subtest: 1x-outputs
[92.371014] Dynamic subtest 1x-outputs: SUCCESS (12.146s)
[92.673648] Subtest modeset-transition-fencing: SUCCESS (12.450s)
[93.556336] [013/143] (938s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[93.652535] Starting subtest: y-tiled-16bpp-rotate-270
[93.656667] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[93.722609] [014/143] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[93.797332] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[93.801559] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[93.886500] [015/143] (938s left) gem_exec_schedule (thriceslice)
[93.957857] Starting subtest: thriceslice
[93.959883] Starting dynamic subtest: rcs0
[94.000373] Dynamic subtest rcs0: SUCCESS (0.056s)
[94.015471] Starting dynamic subtest: bcs0
[94.040068] Dynamic subtest bcs0: SUCCESS (0.039s)
[94.054611] Starting dynamic subtest: vcs0
[94.095934] Dynamic subtest vcs0: SUCCESS (0.055s)
[94.110858] Starting dynamic subtest: vcs1
[94.128989] Dynamic subtest vcs1: SUCCESS (0.033s)
[94.143014] Starting dynamic subtest: vecs0
[94.164218] Dynamic subtest vecs0: SUCCESS (0.034s)
[94.179824] Starting dynamic subtest: ccs0
[94.197202] Dynamic subtest ccs0: SUCCESS (0.033s)
[94.199927] Subtest thriceslice: SUCCESS (0.254s)
[95.203656] [016/143] (937s left) gen9_exec_parse (bb-start-cmd)
[95.281110] Subtest bb-start-cmd: SKIP (0.000s)
[95.320113] [017/143] (937s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[95.733456] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[95.739670] Subtest pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[96.570630] [018/143] (935s left) perf_pmu (render-node-busy)
[96.652486] Starting subtest: render-node-busy
[96.655172] Starting dynamic subtest: rcs0
[97.240424] Dynamic subtest rcs0: SUCCESS (0.590s)
[97.256142] Starting dynamic subtest: bcs0
[97.798369] Dynamic subtest bcs0: SUCCESS (0.558s)
[97.814117] Starting dynamic subtest: vcs0
[99.199095] Dynamic subtest vcs0: SUCCESS (1.399s)
[99.215583] Starting dynamic subtest: vcs1
[101.182711] Dynamic subtest vcs1: SUCCESS (1.983s)
[101.198481] Starting dynamic subtest: vecs0
[103.166544] Dynamic subtest vecs0: SUCCESS (1.984s)
[103.182003] Starting dynamic subtest: ccs0
[103.728203] Dynamic subtest ccs0: SUCCESS (0.562s)
[103.731514] Subtest render-node-busy: SUCCESS (7.079s)
[103.801873] [019/143] (928s left) gem_workarounds (reset-context)
[103.886993] Starting subtest: reset-context
[104.042747] Subtest reset-context: SUCCESS (0.155s)
[104.148872] [020/143] (928s left) drm_fdinfo (memory-info-purgeable)
[104.215099] Starting subtest: memory-info-purgeable
[104.217669] Starting dynamic subtest: smem0
[104.253506] Dynamic subtest smem0: SKIP (0.036s)
[104.258022] Subtest memory-info-purgeable: SKIP (0.036s)
[104.322435] [021/143] (928s left) core_setmaster (master-drop-set-root)
[104.893082] Starting subtest: master-drop-set-root
[104.903767] Subtest master-drop-set-root: SUCCESS (0.011s)
[104.924808] [022/143] (927s left) kms_plane_multiple (tiling-y)
[105.008245] Starting subtest: tiling-y
[105.012203] Subtest tiling-y: SKIP (0.000s)
[105.066035] [023/143] (927s left) gem_ctx_shared (q-independent)
[105.115242] Starting subtest: Q-independent
[105.117693] Starting dynamic subtest: rcs0
[105.205312] Dynamic subtest rcs0: SUCCESS (0.090s)
[105.221975] Starting dynamic subtest: vcs0
[105.279218] Dynamic subtest vcs0: SUCCESS (0.074s)
[105.295687] Starting dynamic subtest: vcs1
[105.344787] Dynamic subtest vcs1: SUCCESS (0.065s)
[105.360450] Starting dynamic subtest: vecs0
[105.393441] Dynamic subtest vecs0: SUCCESS (0.048s)
[105.409481] Starting dynamic subtest: ccs0
[105.443445] Dynamic subtest ccs0: SUCCESS (0.050s)
[105.445524] Subtest Q-independent: SUCCESS (0.328s)
[107.289681] [024/143] (925s left) kms_scaling_modes (scaling-mode-full)
[107.364617] Starting subtest: scaling-mode-full
[107.367148] Starting dynamic subtest: pipe-A-eDP-1
[107.454404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[107.468380] Starting dynamic subtest: pipe-B-eDP-1
[108.728460] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.273s)
[108.744234] Starting dynamic subtest: pipe-C-eDP-1
[109.986556] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.256s)
[109.999010] Starting dynamic subtest: pipe-D-eDP-1
[111.213592] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[111.216247] Subtest scaling-mode-full: SUCCESS (3.852s)
[112.506823] [025/143] (920s left) kms_pm_rpm (legacy-planes)
[114.320524] Starting subtest: legacy-planes
[114.324026] Starting dynamic subtest: plane-40
[138.313015] Dynamic subtest plane-40: SUCCESS (23.992s)
[138.331450] Starting dynamic subtest: plane-49
[162.579735] Dynamic subtest plane-49: SUCCESS (24.266s)
[162.596709] Starting dynamic subtest: plane-58
[186.771542] Dynamic subtest plane-58: SUCCESS (24.166s)
[186.789082] Starting dynamic subtest: plane-67
[211.154946] Dynamic subtest plane-67: SUCCESS (24.406s)
[211.157719] Subtest legacy-planes: SUCCESS (96.834s)
[211.944104] [026/143] (820s left) gem_exec_reloc (basic-gtt)
[212.000899] Subtest basic-gtt: SKIP (0.000s)
[212.063491] [027/143] (820s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[212.103443] Starting subtest: invalid-single-wait-all-unsubmitted
[212.106177] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[212.160865] [028/143] (820s left) kms_force_connector_basic (force-connector-state)
[212.215248] Starting subtest: force-connector-state
[212.781959] Subtest force-connector-state: SUCCESS (0.566s)
[213.743734] [029/143] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[213.840064] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[216.610022] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.777s)
[216.755693] [030/143] (816s left) kms_psr (fbc-psr2-primary-render)
[216.837476] Starting subtest: fbc-psr2-primary-render
[216.839651] Starting dynamic subtest: eDP-1
[216.843920] Dynamic subtest eDP-1: SKIP (0.000s)
[216.847929] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[216.941017] [031/143] (815s left) vgem_basic (dmabuf-fence)
[217.033998] Starting subtest: dmabuf-fence
[217.035989] Subtest dmabuf-fence: SUCCESS (0.002s)
[217.077232] [032/143] (815s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[217.148356] Starting subtest: fbc-tiling-linear
[219.849862] Subtest fbc-tiling-linear: SUCCESS (2.702s)
[219.971991] [033/143] (812s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[220.026496] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[220.131126] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[220.203900] [034/143] (812s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-mc-ccs)
[220.605345] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-mc-ccs
[220.610849] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[221.493981] [035/143] (811s left) kms_legacy_colorkey (basic)
[221.576054] Starting subtest: basic
[221.578747] Starting dynamic subtest: pipe-A
[221.622504] Dynamic subtest pipe-A: SUCCESS (0.046s)
[221.640824] Starting dynamic subtest: pipe-B
[221.642902] Dynamic subtest pipe-B: SUCCESS (0.001s)
[221.659024] Starting dynamic subtest: pipe-C
[221.661951] Dynamic subtest pipe-C: SUCCESS (0.001s)
[221.673670] Starting dynamic subtest: pipe-D
[221.676583] Dynamic subtest pipe-D: SUCCESS (0.001s)
[221.679102] Subtest basic: SUCCESS (0.050s)
[221.699677] [036/143] (811s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-mc-ccs)
[222.085660] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs
[222.154328] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.068s)
[222.941067] [037/143] (810s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-rc-ccs)
[223.373478] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs
[223.379161] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[224.196009] [038/143] (808s left) gem_pread (snoop)
[224.259594] Subtest snoop: SKIP (0.000s)
[224.307067] [039/143] (808s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[224.361701] Starting subtest: x-tiled-64bpp-rotate-0
[225.937910] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.578s)
[226.156327] [040/143] (806s left) kms_feature_discovery (display-3x)
[226.232776] Starting subtest: display-3x
[226.237636] Subtest display-3x: SKIP (0.000s)
[226.299061] [041/143] (806s left) vgem_basic (debugfs)
[226.362955] Starting subtest: debugfs
[226.365453] Subtest debugfs: SUCCESS (0.001s)
[226.413290] [042/143] (806s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[226.475654] Starting subtest: plane-downscale-factor-0-5-with-rotation
[226.477749] Starting dynamic subtest: pipe-A-eDP-1
[226.521502] Dynamic subtest pipe-A-eDP-1: SKIP (0.043s)
[226.536393] Starting dynamic subtest: pipe-B-eDP-1
[226.568566] Dynamic subtest pipe-B-eDP-1: SKIP (0.039s)
[226.586328] Starting dynamic subtest: pipe-C-eDP-1
[226.605128] Dynamic subtest pipe-C-eDP-1: SKIP (0.038s)
[226.621826] Starting dynamic subtest: pipe-D-eDP-1
[226.653050] Dynamic subtest pipe-D-eDP-1: SKIP (0.047s)
[226.657768] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.176s)
[226.745677] [043/143] (806s left) gem_create (create-valid-nonaligned)
[226.803264] Starting subtest: create-valid-nonaligned
[226.806098] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[226.990437] [044/143] (806s left) kms_psr2_sf (fbc-overlay-plane-move-continuous-exceed-sf)
[232.191177] Starting subtest: fbc-overlay-plane-move-continuous-exceed-sf
[232.193773] Starting dynamic subtest: pipe-A-eDP-1
[233.020654] Dynamic subtest pipe-A-eDP-1: SKIP (0.825s)
[233.031514] Starting dynamic subtest: pipe-B-eDP-1
[234.250910] Dynamic subtest pipe-B-eDP-1: SKIP (1.228s)
[234.255763] Subtest fbc-overlay-plane-move-continuous-exceed-sf: SKIP (2.059s)
[235.574045] [045/143] (797s left) i915_query (query-garbage)
[235.620605] Starting subtest: query-garbage
[235.622834] Subtest query-garbage: SUCCESS (0.000s)
[235.675908] [046/143] (797s left) gem_exec_balancer (full-late-pulse)
[235.723088] Starting subtest: full-late-pulse
[239.805336] Subtest full-late-pulse: SUCCESS (4.085s)
[240.049263] [047/143] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[240.128397] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[244.665591] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.543s)
[244.785551] [048/143] (788s left) gem_eio (hibernate)
[245.031048] Starting subtest: hibernate
[259.048353] Subtest hibernate: SUCCESS (14.018s)
[263.177968] [049/143] (774s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[263.255632] Starting subtest: invalid-bsd1-flag-on-vebox
[263.258122] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[263.366686] [050/143] (773s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[263.450835] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[264.426165] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[264.526962] [051/143] (772s left) v3d/v3d_perfmon (create-two-perfmon)
[264.621174] Subtest create-two-perfmon: SKIP (0.000s)
[264.677168] [052/143] (772s left) kms_addfb_basic (no-handle)
[264.734824] Starting subtest: no-handle
[264.736624] Subtest no-handle: SUCCESS (0.000s)
[264.820166] [053/143] (772s left) syncobj_wait (multi-wait-for-submit-signaled)
[264.871839] Starting subtest: multi-wait-for-submit-signaled
[264.873803] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[264.928947] [054/143] (772s left) debugfs_test (read_all_entries_display_off)
[265.005641] Starting subtest: read_all_entries_display_off
[266.122201] Subtest read_all_entries_display_off: SUCCESS (1.116s)
[266.427007] [055/143] (771s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[266.471496] Starting subtest: single-wait-for-submit-available-signaled
[266.473779] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[266.535404] [056/143] (770s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[266.991327] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[266.997699] Subtest pipe-D-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[267.797741] [057/143] (769s left) gem_spin_batch (engines)
[267.846489] Starting subtest: engines
[267.849045] Starting dynamic subtest: rcs0
[271.082501] Dynamic subtest rcs0: SUCCESS (3.234s)
[271.100577] Starting dynamic subtest: bcs0
[274.373484] Dynamic subtest bcs0: SUCCESS (3.239s)
[274.391643] Starting dynamic subtest: vcs0
[277.614837] Dynamic subtest vcs0: SUCCESS (3.239s)
[277.633215] Starting dynamic subtest: vcs1
[280.855735] Dynamic subtest vcs1: SUCCESS (3.239s)
[280.874705] Starting dynamic subtest: vecs0
[284.038356] Dynamic subtest vecs0: SUCCESS (3.233s)
[284.055942] Starting dynamic subtest: ccs0
[287.329672] Dynamic subtest ccs0: SUCCESS (3.238s)
[287.332428] Subtest engines: SUCCESS (19.431s)
[287.496456] [058/143] (750s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[287.592354] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[287.596861] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.670800] [059/143] (749s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-ccs)
[288.036330] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-ccs
[288.041491] Subtest pipe-A-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[288.950388] [060/143] (748s left) gem_exec_store (cachelines)
[289.037068] Starting subtest: cachelines
[289.039572] Starting dynamic subtest: rcs0
[289.105495] Dynamic subtest rcs0: SUCCESS (0.068s)
[289.124873] Starting dynamic subtest: bcs0
[289.174526] Dynamic subtest bcs0: SUCCESS (0.068s)
[289.192503] Starting dynamic subtest: vcs0
[289.235359] Dynamic subtest vcs0: SUCCESS (0.059s)
[289.251976] Starting dynamic subtest: vcs1
[289.298364] Dynamic subtest vcs1: SUCCESS (0.061s)
[289.315134] Starting dynamic subtest: vecs0
[289.354623] Dynamic subtest vecs0: SUCCESS (0.055s)
[289.371124] Starting dynamic subtest: ccs0
[289.423713] Dynamic subtest ccs0: SUCCESS (0.068s)
[289.426602] Subtest cachelines: SUCCESS (0.387s)
[289.609520] [061/143] (748s left) i915_hangman (detector)
[289.666783] Starting subtest: detector
[289.669225] Starting dynamic subtest: rcs0
[301.149823] Dynamic subtest rcs0: SUCCESS (11.483s)
[301.169771] Starting dynamic subtest: bcs0
[313.181303] Dynamic subtest bcs0: SUCCESS (12.030s)
[313.202525] Starting dynamic subtest: vcs0
[325.149174] Dynamic subtest vcs0: SUCCESS (11.966s)
[325.167683] Starting dynamic subtest: vcs1
[337.116756] Dynamic subtest vcs1: SUCCESS (11.966s)
[337.135011] Starting dynamic subtest: vecs0
[349.150327] Dynamic subtest vecs0: SUCCESS (12.032s)
[349.168326] Starting dynamic subtest: ccs0
[361.181267] Dynamic subtest ccs0: SUCCESS (12.029s)
[361.184567] Subtest detector: SUCCESS (71.516s)
[361.296251] [062/143] (676s left) kms_chamelium_color (ctm-0-50)
[361.371720] Subtest ctm-0-50: SKIP (0.000s)
[361.399346] [063/143] (676s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-mtl-mc-ccs)
[361.798590] Starting subtest: pipe-B-random-ccs-data-4-tiled-mtl-mc-ccs
[362.976863] Subtest pipe-B-random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (1.179s)
[364.156791] [064/143] (673s left) kms_vblank (query-busy-hang)
[364.250964] Starting subtest: query-busy-hang
[364.253387] Starting dynamic subtest: pipe-A-eDP-1
[378.089836] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.840s)
[378.111637] Starting dynamic subtest: pipe-D-eDP-1
[393.074134] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[393.076895] Subtest query-busy-hang: SUCCESS (28.824s)
[393.983922] [065/143] (643s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[394.069541] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[394.074626] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[394.142609] [066/143] (643s left) kms_cursor_crc (cursor-sliding-32x32)
[394.241059] Starting subtest: cursor-sliding-32x32
[394.286026] Subtest cursor-sliding-32x32: SKIP (0.040s)
[394.570084] [067/143] (643s left) gem_userptr_blits (dmabuf-sync)
[394.669539] Starting subtest: dmabuf-sync
[394.677326] Subtest dmabuf-sync: SKIP (0.004s)
[394.784048] [068/143] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[394.884442] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[394.888929] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[394.967975] [069/143] (642s left) kms_cursor_crc (cursor-onscreen-256x256)
[395.178935] Starting subtest: cursor-onscreen-256x256
[395.183822] Starting dynamic subtest: pipe-A-eDP-1
[397.630409] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.446s)
[397.666023] Starting dynamic subtest: pipe-D-eDP-1
[400.803600] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.148s)
[400.806227] Subtest cursor-onscreen-256x256: SUCCESS (5.621s)
[401.691326] [070/143] (636s left) syncobj_wait (single-wait-all-for-submit-signaled)
[401.750243] Starting subtest: single-wait-all-for-submit-signaled
[401.753460] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[401.805907] [071/143] (636s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[401.888441] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[401.890837] Starting dynamic subtest: pipe-A-eDP-1
[401.898792] Dynamic subtest pipe-A-eDP-1: SKIP (0.004s)
[401.907014] Starting dynamic subtest: pipe-B-eDP-1
[401.911765] Dynamic subtest pipe-B-eDP-1: SKIP (0.014s)
[401.919466] Starting dynamic subtest: pipe-C-eDP-1
[401.927878] Dynamic subtest pipe-C-eDP-1: SKIP (0.014s)
[401.939579] Starting dynamic subtest: pipe-D-eDP-1
[401.944373] Dynamic subtest pipe-D-eDP-1: SKIP (0.013s)
[401.948969] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.051s)
[402.016336] [072/143] (635s left) gem_linear_blits (normal)
[402.442395] Starting subtest: normal
[408.942804] Subtest normal: SUCCESS (6.499s)
[409.110974] [073/143] (628s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[409.273074] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[409.278409] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[409.456571] [074/143] (628s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[409.522610] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[409.527122] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[409.624943] [075/143] (628s left) gem_pwrite (basic-self)
[409.676618] Subtest basic-self: SKIP (0.000s)
[409.713756] [076/143] (628s left) gem_create (busy-create)
[409.768139] Starting subtest: busy-create
[409.770710] Starting dynamic subtest: smem0
[443.172370] Dynamic subtest smem0: SUCCESS (33.403s)
[443.175457] Subtest busy-create: SUCCESS (33.405s)
[443.362979] [077/143] (594s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[443.703997] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[444.580481] [078/143] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[444.676001] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[444.681429] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[444.769384] [079/143] (593s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-ccs)
[445.164097] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-ccs
[445.170335] Subtest pipe-B-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[446.013928] [080/143] (592s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[446.430533] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[446.436027] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s)
[447.296994] [081/143] (590s left) kms_getfb (getfb2-handle-protection)
[447.372454] Starting subtest: getfb2-handle-protection
[447.403435] Subtest getfb2-handle-protection: SUCCESS (0.032s)
[447.507218] [082/143] (590s left) kms_psr (psr-dpms)
[447.593933] Starting subtest: psr-dpms
[447.596680] Starting dynamic subtest: eDP-1
[450.734028] Dynamic subtest eDP-1: SUCCESS (3.139s)
[450.736723] Subtest psr-dpms: SUCCESS (3.140s)
[451.645334] [083/143] (586s left) dmabuf_sync_file (export-wait-after-attach)
[451.713322] Starting subtest: export-wait-after-attach
[451.715638] Subtest export-wait-after-attach: SUCCESS (0.001s)
[451.772152] [084/143] (586s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs)
[451.842800] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs
[451.848422] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[453.055513] [085/143] (585s left) gem_create (create-ext-placement-each)
[453.229730] Starting subtest: create-ext-placement-each
[453.232529] Subtest create-ext-placement-each: SUCCESS (0.000s)
[453.331213] [086/143] (585s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[453.439162] Starting subtest: x-tiled-16bpp-rotate-90
[453.455710] Subtest x-tiled-16bpp-rotate-90: SKIP (0.018s)
[453.558951] [087/143] (584s left) kms_flip (2x-flip-vs-panning-interruptible)
[453.611264] Starting subtest: 2x-flip-vs-panning-interruptible
[453.626063] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.013s)
[453.698308] [088/143] (584s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[453.771981] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[453.776078] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[453.853818] [089/143] (584s left) prime_udl
[453.945146] [090/143] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[454.020860] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[454.024866] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[454.109749] [091/143] (584s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-rc-ccs)
[454.499644] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs
[454.504810] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[455.416995] [092/143] (583s left) kms_flip (2x-flip-vs-wf_vblank)
[455.506125] Starting subtest: 2x-flip-vs-wf_vblank
[455.516389] Subtest 2x-flip-vs-wf_vblank: SKIP (0.013s)
[455.590842] [093/143] (583s left) kms_rotation_crc (sprite-rotation-270)
[455.692443] Starting subtest: sprite-rotation-270
[455.697165] Subtest sprite-rotation-270: SKIP (0.001s)
[455.748497] [094/143] (582s left) syncobj_wait (wait-any-complex)
[455.827827] Starting subtest: wait-any-complex
[455.891748] Subtest wait-any-complex: SUCCESS (0.063s)
[455.969790] [095/143] (582s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[456.429578] Starting subtest: pipe-D-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[456.436085] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[457.272510] [096/143] (581s left) gem_exec_fence (nb-await)
[457.467096] Starting subtest: nb-await
[457.469949] Starting dynamic subtest: rcs0
[457.545156] Dynamic subtest rcs0: SUCCESS (0.078s)
[457.564811] Starting dynamic subtest: bcs0
[457.612488] Dynamic subtest bcs0: SUCCESS (0.063s)
[457.631324] Starting dynamic subtest: vcs0
[457.675333] Dynamic subtest vcs0: SUCCESS (0.062s)
[457.694961] Starting dynamic subtest: vcs1
[457.739316] Dynamic subtest vcs1: SUCCESS (0.062s)
[457.757563] Starting dynamic subtest: vecs0
[457.803462] Dynamic subtest vecs0: SUCCESS (0.062s)
[457.822348] Starting dynamic subtest: ccs0
[457.866311] Dynamic subtest ccs0: SUCCESS (0.063s)
[457.868879] Subtest nb-await: SUCCESS (0.400s)
[459.269657] [097/143] (579s left) kms_feature_discovery (display)
[459.377391] Starting subtest: display
[459.379789] Subtest display: SUCCESS (0.000s)
[459.446025] [098/143] (579s left) vc4/vc4_tiling (set-bad-flags)
[459.501632] Subtest set-bad-flags: SKIP (0.000s)
[459.540869] [099/143] (579s left) v3d/v3d_get_param (get-bad-param)
[459.612733] Subtest get-bad-param: SKIP (0.000s)
[459.663331] [100/143] (579s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[459.768898] Starting subtest: basic-flip-after-cursor-varying-size
[460.860848] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.089s)
[461.762906] [101/143] (577s left) gem_vm_create (isolation)
[461.834470] Starting subtest: isolation
[461.849755] Subtest isolation: SUCCESS (0.016s)
[461.943634] [102/143] (576s left) api_intel_allocator (fork-simple-stress)
[462.007582] Starting subtest: fork-simple-stress
[467.398149] Subtest fork-simple-stress: SUCCESS (5.395s)
[467.508609] [103/143] (571s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[467.617200] Starting subtest: cursorA-vs-flipB-varying-size
[467.622111] Subtest cursorA-vs-flipB-varying-size: SKIP (0.003s)
[467.762086] [104/143] (571s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[467.843308] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[472.689971] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.852s)
[472.778718] [105/143] (566s left) gem_exec_schedule (fairslice-all)
[472.852174] Starting subtest: fairslice-all
[474.997094] Subtest fairslice-all: SUCCESS (2.157s)
[476.211196] [106/143] (562s left) tools_test (sysfs_l3_parity)
[476.285521] Starting subtest: sysfs_l3_parity
[476.344733] Subtest sysfs_l3_parity: SKIP (0.077s)
[476.401645] [107/143] (562s left) syncobj_basic (bad-flags-fd-to-handle)
[476.445551] Starting subtest: bad-flags-fd-to-handle
[476.448078] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[476.511712] [108/143] (562s left) gem_mmap_wc (write-cpu-read-wc)
[476.579711] Subtest write-cpu-read-wc: SKIP (0.000s)
[476.626879] [109/143] (562s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-mtl-rc-ccs)
[477.036011] Starting subtest: pipe-D-crc-primary-basic-4-tiled-mtl-rc-ccs
[478.010813] Subtest pipe-D-crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (0.975s)
[479.229573] [110/143] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[479.291606] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[479.296319] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[479.372915] [111/143] (559s left) kms_frontbuffer_tracking (fbc-2p-rte)
[479.436096] Starting subtest: fbc-2p-rte
[479.440524] Subtest fbc-2p-rte: SKIP (0.000s)
[479.521923] [112/143] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[479.574899] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[479.579316] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[479.662949] [113/143] (559s left) kms_chamelium_frames (dp-frame-dump)
[480.025761] Subtest dp-frame-dump: SKIP (0.000s)
[480.930164] [114/143] (558s left) gem_lmem_swapping (heavy-random)
[481.007623] Subtest heavy-random: SKIP (0.000s)
[481.052651] [115/143] (558s left) kms_lease (lease-revoke)
[481.139261] Starting subtest: lease-revoke
[481.141912] Starting dynamic subtest: pipe-A-eDP-1
[481.182849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[481.202736] Starting dynamic subtest: pipe-B-eDP-1
[481.205196] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[481.222349] Starting dynamic subtest: pipe-C-eDP-1
[481.229342] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[481.251700] Starting dynamic subtest: pipe-D-eDP-1
[481.260042] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.030s)
[481.262551] Subtest lease-revoke: SUCCESS (0.121s)
[481.373805] [116/143] (557s left) prime_mmap (test_refcounting)
[481.431491] Starting subtest: test_refcounting
[481.434206] Starting dynamic subtest: test_refcounting-smem
[481.466148] Dynamic subtest test_refcounting-smem: SUCCESS (0.039s)
[481.468824] Subtest test_refcounting: SUCCESS (0.039s)
[481.563527] [117/143] (557s left) sw_sync (sync_merge_invalid)
[481.618584] Starting subtest: sync_merge_invalid
[481.623378] Subtest sync_merge_invalid: SUCCESS (0.004s)
[481.655342] [118/143] (557s left) vc4/vc4_create_bo (create-bo-0)
[481.716048] Subtest create-bo-0: SKIP (0.000s)
[481.768063] [119/143] (557s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[481.808045] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[481.915223] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[481.991633] [120/143] (557s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[482.056576] Starting subtest: single-wait-all-for-submit-available-submitted
[482.058925] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[482.130901] [121/143] (557s left) kms_cursor_edge_walk (128x128-right-edge)
[482.208581] Starting subtest: 128x128-right-edge
[482.211061] Starting dynamic subtest: pipe-A-eDP-1
[485.741007] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.533s)
[485.761019] Starting dynamic subtest: pipe-D-eDP-1
[489.010607] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.266s)
[489.013212] Subtest 128x128-right-edge: SUCCESS (6.804s)
[489.890589] [122/143] (549s left) kms_atomic (crtc-invalid-params)
[489.962505] Starting subtest: crtc-invalid-params
[489.964885] Starting dynamic subtest: pipe-A-eDP-1
[490.327905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s)
[490.330498] Subtest crtc-invalid-params: SUCCESS (0.364s)
[491.264075] [123/143] (548s left) gem_lmem_swapping (massive)
[491.337075] Subtest massive: SKIP (0.000s)
[491.369093] [124/143] (548s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[491.470505] Subtest bad-multisync-out-sync: SKIP (0.000s)
[491.530222] [125/143] (548s left) gem_exec_fence (syncobj-unused-fence)
[491.973231] Starting subtest: syncobj-unused-fence
[491.977972] Subtest syncobj-unused-fence: SUCCESS (0.008s)
[493.239024] [126/143] (546s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[493.315490] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[493.320370] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[493.408582] [127/143] (546s left) kms_addfb_basic (bad-pitch-63)
[493.463190] Starting subtest: bad-pitch-63
[493.465859] Subtest bad-pitch-63: SUCCESS (0.000s)
[493.563876] [128/143] (546s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[493.646322] Starting subtest: fbc-pr-sprite-mmap-gtt
[493.651373] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[493.762820] [129/143] (546s left) kms_flip (flip-vs-panning)
[493.847094] Starting subtest: flip-vs-panning
[493.849560] Starting dynamic subtest: A-eDP1
[502.660771] Dynamic subtest A-eDP1: SUCCESS (8.811s)
[502.679958] Starting dynamic subtest: B-eDP1
[511.492350] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[511.510992] Starting dynamic subtest: C-eDP1
[520.315169] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[520.334489] Starting dynamic subtest: D-eDP1
[529.084017] Dynamic subtest D-eDP1: SUCCESS (8.768s)
[529.093020] Subtest flip-vs-panning: SUCCESS (35.249s)
[530.367405] [130/143] (509s left) gem_mmap_gtt (cpuset-big-copy-xy)
[530.418498] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[530.457194] [131/143] (509s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[530.526585] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[530.531304] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.624857] [132/143] (509s left) perf (gen12-invalid-class-instance)
[530.756338] Starting subtest: gen12-invalid-class-instance
[530.767072] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[530.802855] [133/143] (509s left) kms_vrr (flip-basic-fastset)
[530.854837] Starting subtest: flip-basic-fastset
[530.859652] Subtest flip-basic-fastset: SKIP (0.000s)
[530.921835] [134/143] (508s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[531.018945] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[535.448163] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (4.432s)
[535.555031] [135/143] (504s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[535.607197] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[535.609881] Starting dynamic subtest: pipe-A-default-mode
[536.805269] Dynamic subtest pipe-A-default-mode: SKIP (1.192s)
[536.811204] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.194s)
[536.932583] [136/143] (503s left) kms_psr (pr-primary-render)
[536.996827] Starting subtest: pr-primary-render
[537.001698] Subtest pr-primary-render: SKIP (0.000s)
[537.098638] [137/143] (502s left) syncobj_eventfd (binary-wait-before-signal)
[537.140416] Starting subtest: binary-wait-before-signal
[537.167635] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[537.243219] [138/143] (502s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[537.632192] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[537.637553] Subtest pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[538.495805] [139/143] (501s left) gem_pxp (hw-rejects-pxp-context)
[541.124463] Starting subtest: hw-rejects-pxp-context
[541.127621] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[541.171001] [140/143] (498s left) kms_prop_blob (invalid-set-prop)
[541.238508] Starting subtest: invalid-set-prop
[541.240487] Subtest invalid-set-prop: SUCCESS (0.000s)
[541.311693] [141/143] (498s left) gem_eio (wait-wedge-immediate)
[541.561552] Starting subtest: wait-wedge-immediate
[543.265940] Subtest wait-wedge-immediate: SUCCESS (1.705s)
[543.387981] [142/143] (496s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[543.451784] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[543.455808] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[543.542846] [143/143] (496s left) kms_psr (pr-cursor-render)
[543.604862] Starting subtest: pr-cursor-render
[543.609733] Subtest pr-cursor-render: SKIP (0.000s)
[543.702252] Closing watchdogs
Done.