[57.754061] Initializing watchdogs
[57.754111]   /dev/watchdog0
[57.769590] [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]
[57.774091] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.776342] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.779685] [001/156] (960s left) syncobj_wait (invalid-signal-one-illegal-handle)
[57.865131] Starting subtest: invalid-signal-one-illegal-handle
[57.867365] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[57.979882] [002/156] (960s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[58.088814] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[58.093300] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[58.180856] [003/156] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[58.274862] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[58.277265] Starting dynamic subtest: pipe-A-eDP-1
[58.336390] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[58.343660] Starting dynamic subtest: pipe-B-eDP-1
[58.401255] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[58.410076] Starting dynamic subtest: pipe-C-eDP-1
[58.467749] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[58.476148] Starting dynamic subtest: pipe-D-eDP-1
[58.532775] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[58.536642] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[60.769106] [004/156] (957s left) gem_exec_suspend (basic-s3)
[60.837134] Starting subtest: basic-S3
[60.839244] Starting dynamic subtest: smem
[80.873584] Dynamic subtest smem: SUCCESS (6.443s)
[80.876736] Subtest basic-S3: SUCCESS (6.444s)
[89.085676] [005/156] (937s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[89.207754] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[89.212284] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[89.297560] [006/156] (937s left) gem_ctx_create (basic)
[89.365514] Starting subtest: basic
[89.367474] Subtest basic: SUCCESS (0.000s)
[89.557593] [007/156] (936s left) gem_render_copy (linear-to-vebox-y-tiled)
[89.618589] Starting subtest: linear-to-vebox-y-tiled
[89.623466] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[89.799246] [008/156] (936s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[89.892674] Starting subtest: hdr-rgb565-draw-pwrite
[89.896652] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[89.985123] [009/156] (936s left) gem_render_copy (yf-tiled-to-vebox-linear)
[90.040253] Starting subtest: yf-tiled-to-vebox-linear
[90.045224] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[90.221267] [010/156] (936s left) gem_fenced_exec_thrash (too-many-fences)
[90.280055] Subtest too-many-fences: SKIP (0.000s)
[90.335305] [011/156] (936s left) gem_render_copy_redux (interruptible)
[90.389132] Starting subtest: interruptible
[90.664677] Subtest interruptible: SUCCESS (0.273s)
[90.768448] [012/156] (935s left) perf_pmu (multi-client)
[90.807947] Starting subtest: multi-client
[90.810297] Starting dynamic subtest: rcs0
[91.873530] Dynamic subtest rcs0: SUCCESS (1.058s)
[91.884874] Starting dynamic subtest: bcs0
[92.929250] Dynamic subtest bcs0: SUCCESS (1.048s)
[92.940597] Starting dynamic subtest: vcs0
[93.992649] Dynamic subtest vcs0: SUCCESS (1.056s)
[94.003007] Starting dynamic subtest: vcs1
[95.911935] Dynamic subtest vcs1: SUCCESS (1.910s)
[95.922264] Starting dynamic subtest: vecs0
[97.895794] Dynamic subtest vecs0: SUCCESS (1.974s)
[97.905266] Starting dynamic subtest: ccs0
[99.939770] Dynamic subtest ccs0: SUCCESS (2.038s)
[99.942456] Subtest multi-client: SUCCESS (9.090s)
[100.070102] [013/156] (926s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[100.171677] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[100.176214] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[100.289734] [014/156] (926s left) gem_exec_fence (invalid-timeline-fence-array)
[100.885484] Starting subtest: invalid-timeline-fence-array
[100.890637] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[102.004721] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[102.008248] [015/156] (924s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[102.095787] Starting subtest: invalidate-primary-flip-overlay
[112.816699] Subtest invalidate-primary-flip-overlay: SUCCESS (10.709s)
[112.920152] [016/156] (913s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[113.022760] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[113.026215] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[113.117790] [017/156] (913s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[113.208303] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[113.211765] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[113.282092] [018/156] (913s left) i915_pm_rps (fence-order)
[113.340752] Starting subtest: fence-order
[116.752724] Subtest fence-order: SUCCESS (3.411s)
[116.877893] [019/156] (910s left) kms_color (ctm-negative)
[116.974970] Starting subtest: ctm-negative
[116.977242] Starting dynamic subtest: pipe-A-eDP-1
[117.685146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[117.694462] Starting dynamic subtest: pipe-B-eDP-1
[119.154588] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[119.164325] Starting dynamic subtest: pipe-C-eDP-1
[120.531648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[120.541642] Starting dynamic subtest: pipe-D-eDP-1
[121.881579] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[121.883984] Subtest ctm-negative: SUCCESS (4.909s)
[122.691432] [020/156] (904s left) gem_exec_gttfill (basic)
[122.749601] Starting subtest: basic
[125.258019] Subtest basic: SUCCESS (2.508s)
[125.449251] [021/156] (901s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[125.611669] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[125.616116] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[125.717843] [022/156] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[125.823567] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[125.827817] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[125.910865] [023/156] (901s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[126.008218] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[126.012430] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[126.091768] [024/156] (901s left) kms_psr (fbc-pr-primary-page-flip)
[126.191989] Starting subtest: fbc-pr-primary-page-flip
[126.196107] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[126.284741] [025/156] (901s left) gem_lmem_swapping (random-engines)
[126.337585] Subtest random-engines: SKIP (0.000s)
[126.384410] [026/156] (900s left) kms_vblank (ts-continuation-dpms-suspend)
[126.483036] Starting subtest: ts-continuation-dpms-suspend
[126.484669] Starting dynamic subtest: pipe-A-eDP-1
[144.078051] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.309s)
[144.092825] Starting dynamic subtest: pipe-D-eDP-1
[162.046425] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.879s)
[162.048400] Subtest ts-continuation-dpms-suspend: SUCCESS (5.191s)
[167.878131] [027/156] (864s left) gem_pread (display)
[167.935346] Subtest display: SKIP (0.000s)
[167.997732] [028/156] (864s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[168.105127] Starting subtest: fbc-psr2-sprite-plane-onoff
[168.107992] Starting dynamic subtest: eDP-1
[168.112772] Dynamic subtest eDP-1: SKIP (0.000s)
[168.117432] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[168.191447] [029/156] (864s left) gem_exec_balancer (smoke)
[168.262044] Starting subtest: smoke
[190.966887] Subtest smoke: SUCCESS (22.609s)
[192.384251] [030/156] (840s left) kms_setmode (invalid-clone-single-crtc)
[192.451990] Starting subtest: invalid-clone-single-crtc
[192.459447] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[192.554287] [031/156] (840s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[192.673157] Starting subtest: 4-tiled-16bpp-rotate-0
[193.963626] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.290s)
[194.103603] [032/156] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[194.201841] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[194.205487] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[194.290740] [033/156] (838s left) gem_exec_schedule (semaphore-codependency)
[194.364206] Starting subtest: semaphore-codependency
[194.371507] Subtest semaphore-codependency: SUCCESS (0.013s)
[194.722129] [034/156] (837s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[194.820663] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[194.824912] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[194.932217] [035/156] (837s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[195.020682] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[195.046988] Starting dynamic subtest: pipe-A-plane-0
[195.313918] Dynamic subtest pipe-A-plane-0: SUCCESS (0.267s)
[195.325014] Starting dynamic subtest: pipe-A-plane-3
[195.526292] Dynamic subtest pipe-A-plane-3: SUCCESS (0.211s)
[196.661605] Starting dynamic subtest: pipe-B-plane-0
[196.930234] Dynamic subtest pipe-B-plane-0: SUCCESS (0.278s)
[196.940852] Starting dynamic subtest: pipe-B-plane-3
[197.152517] Dynamic subtest pipe-B-plane-3: SUCCESS (0.222s)
[197.464717] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.441s)
[198.343415] [036/156] (834s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[198.398586] Starting subtest: legacy-engines-hostile-preempt
[198.400986] Starting dynamic subtest: render
[198.489587] Dynamic subtest render: SUCCESS (0.090s)
[198.500175] Starting dynamic subtest: bsd1
[200.263194] Dynamic subtest bsd1: SUCCESS (1.769s)
[200.274169] Starting dynamic subtest: bsd2
[202.272555] Dynamic subtest bsd2: SUCCESS (2.010s)
[202.283309] Starting dynamic subtest: blt
[202.353686] Dynamic subtest blt: SUCCESS (0.079s)
[202.365675] Starting dynamic subtest: vebox
[204.300248] Dynamic subtest vebox: SUCCESS (1.945s)
[204.303215] Subtest legacy-engines-hostile-preempt: SUCCESS (5.902s)
[204.383863] [037/156] (828s left) prime_vgem (basic-fence-blt)
[204.451873] Starting subtest: basic-fence-blt
[204.545449] Subtest basic-fence-blt: SUCCESS (0.094s)
[204.706698] [038/156] (828s left) kms_content_protection (mei-interface)
[204.859721] Starting subtest: mei-interface
[204.864287] Subtest mei-interface: SKIP (0.001s)
[204.996882] [039/156] (827s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render)
[205.088247] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render
[205.092554] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[205.175635] [040/156] (827s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[205.269340] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[205.271665] Starting dynamic subtest: pipe-A-eDP-1
[205.294890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[205.306627] Starting dynamic subtest: pipe-B-eDP-1
[205.324673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[205.333960] Starting dynamic subtest: pipe-C-eDP-1
[205.351830] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[205.360854] Starting dynamic subtest: pipe-D-eDP-1
[205.379272] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[205.382757] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[207.615434] [041/156] (825s left) gem_mmap_wc (write-prefaulted)
[207.668606] Subtest write-prefaulted: SKIP (0.000s)
[207.733847] [042/156] (825s left) kms_pm_rpm (drm-resources-equal)
[209.467351] Starting subtest: drm-resources-equal
[214.723222] Subtest drm-resources-equal: SUCCESS (5.260s)
[214.819760] [043/156] (818s left) i915_query (query-topology-matches-eu-total)
[214.877950] Starting subtest: query-topology-matches-eu-total
[214.880179] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[214.981602] [044/156] (818s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[215.077572] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[215.081940] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[215.187354] [045/156] (817s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[215.279897] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[215.284328] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[215.379125] [046/156] (817s left) api_intel_allocator (two-level-inception-interruptible)
[215.440659] Starting subtest: two-level-inception-interruptible
[220.901627] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[220.981787] [047/156] (812s left) kms_flip (wf_vblank-ts-check)
[221.093148] Starting subtest: wf_vblank-ts-check
[221.095587] Starting dynamic subtest: A-eDP1
[230.032693] Dynamic subtest A-eDP1: SUCCESS (8.907s)
[230.046500] Starting dynamic subtest: B-eDP1
[238.955761] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[238.972745] Starting dynamic subtest: C-eDP1
[247.879963] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[247.892363] Starting dynamic subtest: D-eDP1
[256.815958] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[256.818904] Subtest wf_vblank-ts-check: SUCCESS (35.688s)
[257.993757] [048/156] (775s left) gem_mmap_gtt (hang-busy)
[258.049099] Subtest hang-busy: SKIP (0.000s)
[258.115175] [049/156] (775s left) gen7_exec_parse (basic-allocation)
[258.175815] Subtest basic-allocation: SKIP (0.000s)
[258.236251] [050/156] (775s left) kms_hdr (brightness-with-hdr)
[258.336749] Starting subtest: brightness-with-hdr
[258.338975] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[258.343047] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[258.354103] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[258.358201] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[258.362505] Subtest brightness-with-hdr: SKIP (0.002s)
[258.413372] [051/156] (775s left) gem_ctx_exec (basic-invalid-context)
[258.474298] Starting subtest: basic-invalid-context
[258.478889] Subtest basic-invalid-context: SUCCESS (0.004s)
[258.602633] [052/156] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[258.699315] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[265.762433] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.068s)
[265.880561] [053/156] (767s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[265.979022] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[265.981290] Starting dynamic subtest: pipe-A-eDP-1
[266.004901] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.016871] Starting dynamic subtest: pipe-B-eDP-1
[266.038645] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.048098] Starting dynamic subtest: pipe-C-eDP-1
[266.069461] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.078710] Starting dynamic subtest: pipe-D-eDP-1
[266.100417] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.104774] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[268.266372] [054/156] (765s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[268.366271] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[268.370673] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[268.453842] [055/156] (765s left) syncobj_timeline (reset-multiple-signaled)
[268.506988] Starting subtest: reset-multiple-signaled
[268.509225] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[268.617155] [056/156] (765s left) gen7_exec_parse (basic-rejected)
[268.674733] Subtest basic-rejected: SKIP (0.000s)
[268.744716] [057/156] (764s left) kms_flip (modeset-vs-vblank-race)
[268.838225] Starting subtest: modeset-vs-vblank-race
[268.840150] Starting dynamic subtest: A-eDP1
[273.666128] Dynamic subtest A-eDP1: SUCCESS (4.829s)
[273.676994] Starting dynamic subtest: B-eDP1
[278.492991] Dynamic subtest B-eDP1: SUCCESS (4.823s)
[278.503971] Starting dynamic subtest: C-eDP1
[283.213208] Dynamic subtest C-eDP1: SUCCESS (4.717s)
[283.224920] Starting dynamic subtest: D-eDP1
[287.862429] Dynamic subtest D-eDP1: SUCCESS (4.648s)
[287.867710] Subtest modeset-vs-vblank-race: SUCCESS (19.029s)
[289.039081] [058/156] (744s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[289.147261] Starting subtest: psrhdr-1p-rte
[289.151230] Subtest psrhdr-1p-rte: SKIP (0.000s)
[289.235903] [059/156] (744s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[291.474269] Starting subtest: modeset-lpsp-stress-no-wait
[301.419436] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.946s)
[301.504526] [060/156] (732s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[301.600638] Starting subtest: psr2-cursor-plane-move-continuous-sf
[301.602825] Starting dynamic subtest: pipe-A-eDP-1
[311.959703] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.357s)
[311.969772] Starting dynamic subtest: pipe-B-eDP-1
[323.053686] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.092s)
[323.056394] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.451s)
[323.877650] [061/156] (710s left) gem_mmap_wc (read)
[323.933020] Subtest read: SKIP (0.000s)
[324.000145] [062/156] (709s left) gem_exec_reloc (basic-wc)
[324.057593] Subtest basic-wc: SKIP (0.000s)
[324.144156] [063/156] (709s left) dmabuf_sync_file (import-multiple-read-only)
[324.186586] Starting subtest: import-multiple-read-only
[324.188476] Subtest import-multiple-read-only: SUCCESS (0.003s)
[324.241180] [064/156] (709s left) kms_big_fb (linear-8bpp-rotate-90)
[324.345886] Starting subtest: linear-8bpp-rotate-90
[324.370449] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[324.476061] [065/156] (709s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[324.576352] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[324.580514] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[324.694740] [066/156] (709s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[324.791367] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[324.794886] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[324.887146] [067/156] (709s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[324.992614] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[324.996000] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[325.095849] [068/156] (709s left) gem_exec_parallel (engines)
[325.149480] Starting subtest: engines
[325.151485] Starting dynamic subtest: basic
[327.245949] Dynamic subtest basic: SUCCESS (2.093s)
[327.258954] Starting dynamic subtest: contexts
[331.658519] Dynamic subtest contexts: SUCCESS (4.410s)
[331.670957] Starting dynamic subtest: fds
[335.388597] Dynamic subtest fds: SUCCESS (3.726s)
[335.402173] Starting dynamic subtest: userptr
[337.230493] Dynamic subtest userptr: SUCCESS (1.839s)
[337.233467] Subtest engines: SUCCESS (12.077s)
[337.439804] [069/156] (696s left) gem_mmap_wc (write-read)
[337.486632] Subtest write-read: SKIP (0.000s)
[337.552033] [070/156] (696s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[337.607688] Starting subtest: invalid-multi-wait-all-unsubmitted
[337.610052] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[337.714224] [071/156] (696s left) kms_plane_alpha_blend (alpha-basic)
[337.815906] Starting subtest: alpha-basic
[338.114187] Starting dynamic subtest: pipe-A-eDP-1
[340.038029] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.920s)
[340.065950] Starting dynamic subtest: pipe-D-eDP-1
[342.790393] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.730s)
[342.792629] Subtest alpha-basic: SUCCESS (4.973s)
[343.665763] [072/156] (690s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[343.775070] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[343.779369] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[343.860246] [073/156] (690s left) gem_exec_async (concurrent-writes)
[343.926547] Starting subtest: concurrent-writes
[343.928842] Starting dynamic subtest: rcs0
[343.943419] Dynamic subtest rcs0: SUCCESS (0.017s)
[343.954051] Starting dynamic subtest: bcs0
[343.956255] Dynamic subtest bcs0: SUCCESS (0.006s)
[343.966566] Starting dynamic subtest: vcs0
[343.968849] Dynamic subtest vcs0: SUCCESS (0.004s)
[343.978885] Starting dynamic subtest: vcs1
[343.981115] Dynamic subtest vcs1: SUCCESS (0.006s)
[343.990776] Starting dynamic subtest: vecs0
[343.993018] Dynamic subtest vecs0: SUCCESS (0.005s)
[344.004030] Starting dynamic subtest: ccs0
[344.006201] Dynamic subtest ccs0: SUCCESS (0.006s)
[344.008410] Subtest concurrent-writes: SUCCESS (0.048s)
[344.221728] [074/156] (690s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[344.331161] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[345.134351] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[345.321759] [075/156] (689s left) gem_softpin (evict-active)
[345.383152] Starting subtest: evict-active
[345.385495] Subtest evict-active: SUCCESS (0.005s)
[345.501746] [076/156] (689s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[345.596609] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[345.601007] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[345.682422] [077/156] (688s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[345.771400] Starting subtest: random-ccs-data-yf-tiled-ccs
[345.773717] Starting dynamic subtest: pipe-A-eDP-1
[345.799256] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[345.809749] Starting dynamic subtest: pipe-B-eDP-1
[345.833674] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.843660] Starting dynamic subtest: pipe-C-eDP-1
[345.867403] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[345.877400] Starting dynamic subtest: pipe-D-eDP-1
[345.901499] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[345.905992] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[348.101492] [078/156] (686s left) kms_psr (fbc-psr-cursor-plane-move)
[348.191840] Starting subtest: fbc-psr-cursor-plane-move
[348.194165] Starting dynamic subtest: eDP-1
[348.198519] Dynamic subtest eDP-1: SKIP (0.000s)
[348.202750] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[348.267129] [079/156] (686s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[348.367853] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[348.372280] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[348.479097] [080/156] (686s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[348.588720] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[348.592624] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[348.680902] [081/156] (686s left) kms_addfb_basic (unused-offsets)
[348.737446] Starting subtest: unused-offsets
[348.739336] Subtest unused-offsets: SUCCESS (0.000s)
[348.876784] [082/156] (685s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[348.977634] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[348.982051] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[349.076421] [083/156] (685s left) syncobj_timeline (invalid-transfer-bad-pad)
[349.136046] Starting subtest: invalid-transfer-bad-pad
[349.137672] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[349.241336] [084/156] (685s left) gem_userptr_blits (stress-mm-invalidate-close)
[349.304676] Starting subtest: stress-mm-invalidate-close
[351.453013] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[351.574637] [085/156] (683s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[351.684087] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[351.688095] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[351.810524] [086/156] (683s left) tools_test (tools_test)
[351.863280] Starting subtest: tools_test
[351.919739] Subtest tools_test: SUCCESS (0.074s)
[351.983302] [087/156] (683s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[352.035236] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[352.138267] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[352.217748] [088/156] (682s left) gem_exec_balancer (hang)
[352.491887] Starting subtest: hang
[354.260798] Subtest hang: SUCCESS (1.772s)
[354.387534] [089/156] (680s left) syncobj_timeline (wait-for-submit-snapshot)
[354.436208] Starting subtest: wait-for-submit-snapshot
[354.517969] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[354.596486] [090/156] (680s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[354.689976] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[354.692217] Starting dynamic subtest: pipe-A-eDP-1
[355.601494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.904s)
[355.612554] Starting dynamic subtest: pipe-B-eDP-1
[357.242200] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.637s)
[357.253845] Starting dynamic subtest: pipe-C-eDP-1
[358.733612] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.492s)
[358.744636] Starting dynamic subtest: pipe-D-eDP-1
[360.245244] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s)
[360.247431] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.547s)
[361.437139] [091/156] (673s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[361.541577] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[361.545615] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[361.642729] [092/156] (673s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[361.744893] Starting subtest: extended-pageflip-modeset-hang-oldfb
[361.747131] Starting dynamic subtest: pipe-A
[369.652473] Dynamic subtest pipe-A: SUCCESS (7.909s)
[369.665702] Starting dynamic subtest: pipe-D
[378.264015] Dynamic subtest pipe-D: SUCCESS (8.606s)
[378.266404] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.521s)
[379.108501] [093/156] (656s left) i915_drm_fdinfo (idle)
[379.158211] Starting subtest: idle
[379.160801] Starting dynamic subtest: rcs0
[379.706733] Dynamic subtest rcs0: SUCCESS (0.549s)
[379.718809] Starting dynamic subtest: bcs0
[380.216386] Dynamic subtest bcs0: SUCCESS (0.505s)
[380.229537] Starting dynamic subtest: vcs0
[380.722783] Dynamic subtest vcs0: SUCCESS (0.503s)
[380.733496] Starting dynamic subtest: vcs1
[381.227846] Dynamic subtest vcs1: SUCCESS (0.503s)
[381.238204] Starting dynamic subtest: vecs0
[381.734341] Dynamic subtest vecs0: SUCCESS (0.503s)
[381.745381] Starting dynamic subtest: ccs0
[382.240067] Dynamic subtest ccs0: SUCCESS (0.503s)
[382.243092] Subtest idle: SUCCESS (3.083s)
[382.318810] [094/156] (653s left) syncobj_timeline (device-submit-unordered)
[382.370607] Starting subtest: device-submit-unordered
[382.373345] Subtest device-submit-unordered: SUCCESS (0.001s)
[382.469967] [095/156] (652s left) vgem_basic (busy-fence)
[382.511684] Starting subtest: busy-fence
[382.513551] Subtest busy-fence: SUCCESS (0.000s)
[382.567775] [096/156] (652s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[382.676202] Starting subtest: y-tiled-32bpp-rotate-270
[382.680536] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[382.772728] [097/156] (652s left) fbdev (eof)
[382.814860] Starting subtest: eof
[382.817157] Subtest eof: SUCCESS (0.000s)
[382.887281] [098/156] (652s left) kms_chamelium_frames (dp-crc-multiple)
[383.274541] Subtest dp-crc-multiple: SKIP (0.000s)
[384.116483] [099/156] (651s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[384.505443] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[385.346480] [100/156] (650s left) gem_exec_parallel (fds)
[385.412565] Starting subtest: fds
[385.414971] Starting dynamic subtest: rcs0
[387.949555] Dynamic subtest rcs0: SUCCESS (2.538s)
[387.963094] Starting dynamic subtest: bcs0
[391.225976] Dynamic subtest bcs0: SUCCESS (3.274s)
[391.236957] Starting dynamic subtest: vcs0
[395.408413] Dynamic subtest vcs0: SUCCESS (4.180s)
[395.421610] Starting dynamic subtest: vcs1
[399.516519] Dynamic subtest vcs1: SUCCESS (4.105s)
[399.528664] Starting dynamic subtest: vecs0
[403.484237] Dynamic subtest vecs0: SUCCESS (3.967s)
[403.496793] Starting dynamic subtest: ccs0
[406.783796] Dynamic subtest ccs0: SUCCESS (3.297s)
[406.786663] Subtest fds: SUCCESS (21.372s)
[406.983718] [101/156] (628s left) kms_psr (psr2-primary-blt)
[407.078003] Starting subtest: psr2-primary-blt
[407.080440] Starting dynamic subtest: eDP-1
[408.846612] Dynamic subtest eDP-1: SUCCESS (1.767s)
[408.849002] Subtest psr2-primary-blt: SUCCESS (1.768s)
[409.719947] [102/156] (625s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[409.816559] Starting subtest: fbcpsr-rgb565-draw-blt
[416.963338] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.151s)
[417.101188] [103/156] (618s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[417.219027] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[417.268856] [104/156] (618s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[417.370563] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[417.374540] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[417.466122] [105/156] (618s left) gem_userptr_blits (unsync-unmap-cycles)
[417.536235] Subtest unsync-unmap-cycles: SKIP (0.000s)
[417.668553] [106/156] (618s left) kms_legacy_colorkey (invalid-plane)
[417.757015] Starting subtest: invalid-plane
[417.759292] Starting dynamic subtest: zero-id
[417.761507] Dynamic subtest zero-id: SUCCESS (0.000s)
[417.772842] Starting dynamic subtest: outrange-id
[417.775064] Dynamic subtest outrange-id: SUCCESS (0.000s)
[417.777221] Subtest invalid-plane: SUCCESS (0.001s)
[417.833768] [107/156] (618s left) kms_flip (flip-vs-suspend-interruptible)
[417.925172] Starting subtest: flip-vs-suspend-interruptible
[417.927127] Starting dynamic subtest: A-eDP1
[531.507888] Dynamic subtest A-eDP1: SUCCESS (11.820s)
[531.510410] Subtest flip-vs-suspend-interruptible: SUCCESS (11.822s)
[542.715464] [108/156] (504s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[542.828665] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[542.833075] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[542.927348] [109/156] (504s left) syncobj_wait (wait-for-submit-complex)
[542.981694] Starting subtest: wait-for-submit-complex
[543.042856] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[543.122279] [110/156] (503s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[543.211722] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[543.214025] Starting dynamic subtest: pipe-A
[543.555989] Dynamic subtest pipe-A: SUCCESS (0.340s)
[543.569374] Starting dynamic subtest: pipe-B
[544.984699] Dynamic subtest pipe-B: SUCCESS (1.413s)
[544.995131] Starting dynamic subtest: pipe-C
[546.427080] Dynamic subtest pipe-C: SUCCESS (1.428s)
[546.446956] Starting dynamic subtest: pipe-D
[547.868457] Dynamic subtest pipe-D: SUCCESS (1.429s)
[547.871003] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.618s)
[549.056913] [111/156] (498s left) gem_exec_whisper (basic-forked-all)
[549.124284] Starting subtest: basic-forked-all
[562.039769] Subtest basic-forked-all: SUCCESS (12.877s)
[562.244375] [112/156] (484s left) i915_hangman (engine-engine-hang)
[562.314199] Starting subtest: engine-engine-hang
[562.316122] Starting dynamic subtest: rcs0
[564.011672] Dynamic subtest rcs0: SUCCESS (1.694s)
[564.024348] Starting dynamic subtest: bcs0
[565.996580] Dynamic subtest bcs0: SUCCESS (1.981s)
[566.010102] Starting dynamic subtest: vcs0
[567.979724] Dynamic subtest vcs0: SUCCESS (1.980s)
[567.992106] Starting dynamic subtest: vcs1
[569.964067] Dynamic subtest vcs1: SUCCESS (1.981s)
[569.978115] Starting dynamic subtest: vecs0
[572.012294] Dynamic subtest vecs0: SUCCESS (2.045s)
[572.025337] Starting dynamic subtest: ccs0
[573.996172] Dynamic subtest ccs0: SUCCESS (1.980s)
[573.999124] Subtest engine-engine-hang: SUCCESS (11.677s)
[574.155155] [113/156] (473s left) kms_feature_discovery (display-3x)
[574.249618] Starting subtest: display-3x
[574.253932] Subtest display-3x: SKIP (0.000s)
[574.325565] [114/156] (472s left) api_intel_bb (object-reloc-purge-cache)
[574.392113] Starting subtest: object-reloc-purge-cache
[574.396248] Subtest object-reloc-purge-cache: SKIP (0.003s)
[574.502727] [115/156] (472s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[574.596320] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[574.600520] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[574.688457] [116/156] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[574.777141] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[574.781408] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[574.881697] [117/156] (472s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[574.991109] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[574.995455] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[575.098538] [118/156] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[575.201095] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[575.204542] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[575.309639] [119/156] (472s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[575.416229] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[575.419777] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[575.526856] [120/156] (472s left) gem_ctx_param (invalid-get-engines)
[575.582650] Starting subtest: invalid-get-engines
[575.584823] Subtest invalid-get-engines: SUCCESS (0.001s)
[575.680939] [121/156] (471s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[575.779802] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[579.674968] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.899s)
[580.821337] [122/156] (466s left) i915_suspend (fence-restore-tiled2untiled)
[580.883553] Starting subtest: fence-restore-tiled2untiled
[580.888311] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[580.979337] [123/156] (466s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[581.080139] Starting subtest: 4-tiled-64bpp-rotate-180
[582.749560] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.669s)
[582.931358] [124/156] (464s left) gem_exec_reloc (basic-write-read)
[582.983515] Subtest basic-write-read: SKIP (0.000s)
[583.057088] [125/156] (464s left) perf_pmu (busy-no-semaphores)
[583.092480] Starting subtest: busy-no-semaphores
[583.094606] Starting dynamic subtest: rcs0
[583.649894] Dynamic subtest rcs0: SUCCESS (0.556s)
[583.662945] Starting dynamic subtest: bcs0
[584.199643] Dynamic subtest bcs0: SUCCESS (0.547s)
[584.213815] Starting dynamic subtest: vcs0
[584.751246] Dynamic subtest vcs0: SUCCESS (0.548s)
[584.764144] Starting dynamic subtest: vcs1
[586.515446] Dynamic subtest vcs1: SUCCESS (1.759s)
[586.526523] Starting dynamic subtest: vecs0
[588.560214] Dynamic subtest vecs0: SUCCESS (2.041s)
[588.574452] Starting dynamic subtest: ccs0
[590.546614] Dynamic subtest ccs0: SUCCESS (1.982s)
[590.549758] Subtest busy-no-semaphores: SUCCESS (7.453s)
[590.667603] [126/156] (457s left) gem_lmem_swapping (parallel-random)
[590.710708] Subtest parallel-random: SKIP (0.000s)
[590.753587] [127/156] (457s left) gem_eio (in-flight-1us)
[590.958382] Starting subtest: in-flight-1us
[599.501479] Subtest in-flight-1us: SUCCESS (8.539s)
[599.627272] [128/156] (448s left) kms_cursor_crc (cursor-offscreen-32x10)
[599.781010] Starting subtest: cursor-offscreen-32x10
[599.833568] Subtest cursor-offscreen-32x10: SKIP (0.046s)
[600.136235] [129/156] (447s left) kms_psr (pr-sprite-mmap-gtt)
[600.228105] Starting subtest: pr-sprite-mmap-gtt
[600.232365] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[600.303585] [130/156] (447s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[600.360800] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[600.362581] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[600.455997] [131/156] (447s left) kms_invalid_mode (bad-vtotal)
[600.554063] Starting subtest: bad-vtotal
[600.555893] Starting dynamic subtest: pipe-A-eDP-1
[600.837550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[600.850247] Starting dynamic subtest: pipe-B-eDP-1
[600.852526] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[600.865372] Starting dynamic subtest: pipe-C-eDP-1
[600.867733] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[600.892476] Starting dynamic subtest: pipe-D-eDP-1
[600.894969] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[600.897210] Subtest bad-vtotal: SUCCESS (0.289s)
[601.655668] [132/156] (446s left) kms_plane (plane-panning-top-left)
[601.755114] Starting subtest: plane-panning-top-left
[601.757400] Starting dynamic subtest: pipe-A
[603.428365] Dynamic subtest pipe-A: SUCCESS (1.672s)
[603.440055] Starting dynamic subtest: pipe-B
[605.777839] Dynamic subtest pipe-B: SUCCESS (2.346s)
[605.779831] Subtest plane-panning-top-left: SUCCESS (4.020s)
[606.585263] [133/156] (441s left) gem_softpin (allocator-nopin-reserve)
[606.646479] Starting subtest: allocator-nopin-reserve
[606.736233] Subtest allocator-nopin-reserve: SUCCESS (0.089s)
[606.878427] [134/156] (441s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[606.980315] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[611.279461] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.303s)
[612.498231] [135/156] (435s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[612.591468] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[619.660679] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.071s)
[619.776140] [136/156] (428s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[619.888910] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[619.982272] [137/156] (428s left) kms_cursor_legacy (single-move)
[620.105318] Starting subtest: single-move
[620.107522] Starting dynamic subtest: pipe-A
[625.544792] Dynamic subtest pipe-A: SUCCESS (5.380s)
[625.557799] Starting dynamic subtest: pipe-B
[630.926855] Dynamic subtest pipe-B: SUCCESS (5.380s)
[630.939393] Starting dynamic subtest: pipe-C
[636.306142] Dynamic subtest pipe-C: SUCCESS (5.378s)
[636.318427] Starting dynamic subtest: pipe-D
[641.686489] Dynamic subtest pipe-D: SUCCESS (5.378s)
[641.698230] Starting dynamic subtest: all-pipes
[647.076299] Dynamic subtest all-pipes: SUCCESS (5.385s)
[647.078283] Subtest single-move: SUCCESS (26.916s)
[647.170364] [138/156] (401s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[647.265238] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[647.269406] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[647.337097] [139/156] (401s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[647.430858] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[647.435146] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[647.532733] [140/156] (400s left) gem_exec_reloc (basic-range)
[647.598629] Subtest basic-range: SKIP (0.000s)
[647.672228] [141/156] (400s left) gem_exec_reloc (basic-gtt-wc)
[647.724369] Subtest basic-gtt-wc: SKIP (0.000s)
[647.790198] [142/156] (400s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[648.101211] Starting subtest: cursor-rapid-movement-max-size
[648.106893] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[648.234171] [143/156] (400s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[648.336868] Starting subtest: fbc-1p-pri-indfb-multidraw
[661.279560] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.948s)
[662.648646] [144/156] (385s left) prime_mmap_coherency (read)
[662.723883] Starting subtest: read
[668.152069] Subtest read: SUCCESS (5.377s)
[668.233539] [145/156] (380s left) gem_exec_capture (userptr)
[668.292074] Starting subtest: userptr
[669.127732] Subtest userptr: SUCCESS (0.834s)
[669.261746] [146/156] (379s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[669.350382] Starting subtest: primary-y-tiled-reflect-x-0
[669.421123] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s)
[669.526942] [147/156] (379s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[669.628167] Starting subtest: x-tiled-16bpp-rotate-90
[669.650575] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[669.776974] [148/156] (379s left) kms_addfb_basic (unused-pitches)
[669.826658] Starting subtest: unused-pitches
[669.828909] Subtest unused-pitches: SUCCESS (0.000s)
[669.970141] [149/156] (378s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[670.063793] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[670.067651] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[670.158968] [150/156] (378s left) gem_exec_schedule (implicit-write-read)
[670.214994] Starting subtest: implicit-write-read
[670.217201] Starting dynamic subtest: rcs0
[670.325207] Dynamic subtest rcs0: SUCCESS (0.113s)
[670.338185] Starting dynamic subtest: vcs0
[670.404553] Dynamic subtest vcs0: SUCCESS (0.079s)
[670.418260] Starting dynamic subtest: vcs1
[670.487534] Dynamic subtest vcs1: SUCCESS (0.082s)
[670.500661] Starting dynamic subtest: vecs0
[670.572798] Dynamic subtest vecs0: SUCCESS (0.083s)
[670.585909] Starting dynamic subtest: ccs0
[670.667287] Dynamic subtest ccs0: SUCCESS (0.092s)
[670.669588] Subtest implicit-write-read: SUCCESS (0.456s)
[672.099031] [151/156] (376s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt)
[672.197375] Starting subtest: fbchdr-rgb565-draw-mmap-gtt
[672.201360] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[672.295610] [152/156] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[672.401662] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[679.827227] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.431s)
[679.963556] [153/156] (369s left) kms_flip (dpms-off-confusion)
[680.055590] Starting subtest: dpms-off-confusion
[680.057913] Starting dynamic subtest: A-eDP1
[688.806434] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[688.824357] Starting dynamic subtest: B-eDP1
[697.447113] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[697.458710] Starting dynamic subtest: C-eDP1
[706.095707] Dynamic subtest C-eDP1: SUCCESS (8.634s)
[706.108394] Starting dynamic subtest: D-eDP1
[714.732479] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[714.734970] Subtest dpms-off-confusion: SUCCESS (34.628s)
[715.887467] [154/156] (333s left) gem_exec_parallel (contexts)
[715.940171] Starting subtest: contexts
[715.942631] Starting dynamic subtest: rcs0
[719.396610] Dynamic subtest rcs0: SUCCESS (3.453s)
[719.407567] Starting dynamic subtest: bcs0
[723.201618] Dynamic subtest bcs0: SUCCESS (3.801s)
[723.213290] Starting dynamic subtest: vcs0
[727.557683] Dynamic subtest vcs0: SUCCESS (4.352s)
[727.568915] Starting dynamic subtest: vcs1
[731.562084] Dynamic subtest vcs1: SUCCESS (3.978s)
[731.575196] Starting dynamic subtest: vecs0
[735.583262] Dynamic subtest vecs0: SUCCESS (4.040s)
[735.596063] Starting dynamic subtest: ccs0
[739.379510] Dynamic subtest ccs0: SUCCESS (3.794s)
[739.382070] Subtest contexts: SUCCESS (23.432s)
[739.591221] [155/156] (309s left) gem_madvise (dontneed-before-pwrite)
[739.624293] Starting subtest: dontneed-before-pwrite
[739.652827] Subtest dontneed-before-pwrite: SKIP (0.023s)
[739.720694] [156/156] (309s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[739.844619] Starting subtest: cursor-tearing-framebuffer-change
[739.846922] Starting dynamic subtest: pipe-A-eDP-1
[740.413721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[740.426450] Starting dynamic subtest: pipe-D-eDP-1
[741.647435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[741.649821] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.802s)
[742.467900] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_suspend
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ctx_create
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: gem_fenced_exec_thrash
results: parsing output: 10/ for test: gem_render_copy_redux
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: kms_psr_stress_test
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: i915_pm_rps
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: gem_exec_gttfill
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_lmem_swapping
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: gem_pread
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_setmode
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: i915_query
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: api_intel_allocator
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: gen7_exec_parse
results: parsing output: 49/ for test: kms_hdr
results: parsing output: 50/ for test: gem_ctx_exec
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: dmabuf_sync_file
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_parallel
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_plane_alpha_blend
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: gem_exec_async
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: tools_test
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_busy
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: fbdev
results: parsing output: 97/ for test: kms_chamelium_frames
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: gem_exec_parallel
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_tiled_display
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_legacy_colorkey
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: kms_feature_discovery
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_suspend
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_invalid_mode
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: gem_softpin
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_addfb_basic
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_psr2_sf
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_exec_reloc
results: parsing output: 140/ for test: gem_exec_reloc
results: parsing output: 141/ for test: kms_cursor_crc
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: prime_mmap_coherency
results: parsing output: 144/ for test: gem_exec_capture
results: parsing output: 145/ for test: kms_rotation_crc
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_addfb_basic
results: parsing output: 148/ for test: kms_big_fb
results: parsing output: 149/ for test: gem_exec_schedule
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: gem_exec_parallel
results: parsing output: 154/ for test: gem_madvise
results: parsing output: 155/ for test: kms_cursor_crc
Done.