[58.189991] Initializing watchdogs
[58.190068]   /dev/watchdog0
[58.205279] [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]
[58.209901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.212181] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.215972] [001/133] (960s left) kms_cursor_crc (cursor-random-32x32)
[58.407875] Starting subtest: cursor-random-32x32
[58.467296] Subtest cursor-random-32x32: SKIP (0.055s)
[58.757415] [002/133] (959s left) gem_exec_schedule (timeslicing)
[58.827175] Starting subtest: timeslicing
[58.829130] Starting dynamic subtest: rcs0
[58.841122] Dynamic subtest rcs0: SUCCESS (0.021s)
[58.849203] Starting dynamic subtest: bcs0
[58.861077] Dynamic subtest bcs0: SUCCESS (0.020s)
[58.870406] Starting dynamic subtest: vcs0
[58.881781] Dynamic subtest vcs0: SUCCESS (0.020s)
[58.889121] Starting dynamic subtest: vcs1
[58.902193] Dynamic subtest vcs1: SUCCESS (0.020s)
[58.909254] Starting dynamic subtest: vecs0
[58.921928] Dynamic subtest vecs0: SUCCESS (0.019s)
[58.929385] Starting dynamic subtest: ccs0
[58.941882] Dynamic subtest ccs0: SUCCESS (0.020s)
[58.944291] Subtest timeslicing: SUCCESS (0.122s)
[60.930579] [003/133] (957s left) kms_plane (plane-panning-top-left)
[61.031992] Starting subtest: plane-panning-top-left
[61.034319] Starting dynamic subtest: pipe-A
[63.092455] Dynamic subtest pipe-A: SUCCESS (2.050s)
[63.100878] Starting dynamic subtest: pipe-B
[65.366685] Dynamic subtest pipe-B: SUCCESS (2.262s)
[65.368685] Subtest plane-panning-top-left: SUCCESS (4.314s)
[66.171124] [004/133] (952s left) kms_busy (basic)
[66.278256] Starting subtest: basic
[66.280696] Starting dynamic subtest: flip
[66.888360] Dynamic subtest flip: SUCCESS (0.606s)
[66.896870] Starting dynamic subtest: modeset
[70.307309] Dynamic subtest modeset: SUCCESS (3.411s)
[70.309783] Subtest basic: SUCCESS (4.018s)
[71.109474] [005/133] (947s left) kms_addfb_basic (basic-x-tiled-legacy)
[71.165905] Starting subtest: basic-x-tiled-legacy
[71.170904] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[71.292224] [006/133] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[71.399944] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[75.738947] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.337s)
[76.943981] [007/133] (942s left) gem_vm_create (execbuf)
[77.011636] Starting subtest: execbuf
[77.018532] Subtest execbuf: SUCCESS (0.007s)
[77.141846] [008/133] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[77.239832] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[85.898036] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.656s)
[86.033089] [009/133] (933s left) gem_ctx_param (basic-default)
[86.093909] Starting subtest: basic-default
[86.096386] Subtest basic-default: SUCCESS (0.000s)
[86.167657] [010/133] (932s left) kms_properties (crtc-properties-atomic)
[86.253069] Starting subtest: crtc-properties-atomic
[86.255432] Starting dynamic subtest: pipe-A-eDP-1
[86.701361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[86.710103] Starting dynamic subtest: pipe-B-eDP-1
[87.895620] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s)
[87.903698] Starting dynamic subtest: pipe-C-eDP-1
[89.038787] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s)
[89.049937] Starting dynamic subtest: pipe-D-eDP-1
[90.160381] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[90.162694] Subtest crtc-properties-atomic: SUCCESS (3.908s)
[90.971995] [011/133] (928s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[91.071084] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[91.073404] Starting dynamic subtest: pipe-A-default-mode
[93.803805] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s)
[93.805680] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.731s)
[94.671385] [012/133] (924s left) gem_pread (bench)
[94.740226] Subtest bench: SKIP (0.000s)
[94.807232] [013/133] (924s left) prime_mmap_coherency (write)
[94.864672] Starting subtest: write
[100.241180] Subtest write: SUCCESS (5.373s)
[100.374030] [014/133] (918s left) gem_exec_reloc (basic-cpu)
[100.442071] Subtest basic-cpu: SKIP (0.000s)
[100.513886] [015/133] (918s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[100.624542] Starting subtest: fbc-tiling-linear
[104.307927] Subtest fbc-tiling-linear: SUCCESS (3.686s)
[105.466931] [016/133] (913s left) kms_psr (fbc-psr2-basic)
[105.565194] Starting subtest: fbc-psr2-basic
[105.567541] Starting dynamic subtest: eDP-1
[105.571914] Dynamic subtest eDP-1: SKIP (0.000s)
[105.576415] Subtest fbc-psr2-basic: SKIP (0.001s)
[105.639410] [017/133] (913s left) kms_chamelium_frames (dp-crc-single)
[106.018395] Subtest dp-crc-single: SKIP (0.000s)
[106.859515] [018/133] (912s left) kms_vblank (wait-forked)
[106.951133] Starting subtest: wait-forked
[106.953022] Starting dynamic subtest: pipe-A-eDP-1
[108.770882] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[108.784752] Starting dynamic subtest: pipe-D-eDP-1
[111.291955] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.518s)
[111.294159] Subtest wait-forked: SUCCESS (4.341s)
[112.161829] [019/133] (907s left) i915_hangman (gt-engine-hang)
[112.221326] Starting subtest: gt-engine-hang
[112.223486] Starting dynamic subtest: rcs0
[113.846057] Dynamic subtest rcs0: SUCCESS (1.624s)
[113.856964] Starting dynamic subtest: bcs0
[115.891067] Dynamic subtest bcs0: SUCCESS (2.043s)
[115.901665] Starting dynamic subtest: vcs0
[117.876498] Dynamic subtest vcs0: SUCCESS (1.983s)
[117.887737] Starting dynamic subtest: vcs1
[119.861172] Dynamic subtest vcs1: SUCCESS (1.983s)
[119.872239] Starting dynamic subtest: vecs0
[121.908346] Dynamic subtest vecs0: SUCCESS (2.045s)
[121.919534] Starting dynamic subtest: ccs0
[123.892900] Dynamic subtest ccs0: SUCCESS (1.982s)
[123.895721] Subtest gt-engine-hang: SUCCESS (11.671s)
[124.033998] [020/133] (895s left) syncobj_eventfd (timeline-wait-signaled)
[124.093900] Starting subtest: timeline-wait-signaled
[124.096138] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[124.195978] [021/133] (895s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[124.301095] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[124.305149] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[124.377270] [022/133] (895s left) api_intel_allocator (fork-simple-stress)
[124.434847] Starting subtest: fork-simple-stress
[129.833109] Subtest fork-simple-stress: SUCCESS (5.398s)
[129.960153] [023/133] (889s left) gem_mmap_wc (coherency)
[130.036477] Subtest coherency: SKIP (0.000s)
[130.102990] [024/133] (889s left) gem_exec_schedule (pi-common)
[130.280400] Starting subtest: pi-common
[130.282630] Starting dynamic subtest: rcs0
[130.396350] Dynamic subtest rcs0: SUCCESS (0.119s)
[130.405605] Starting dynamic subtest: bcs0
[130.429434] Dynamic subtest bcs0: SUCCESS (0.032s)
[130.438044] Starting dynamic subtest: vcs0
[130.460572] Dynamic subtest vcs0: SUCCESS (0.031s)
[130.468533] Starting dynamic subtest: vcs1
[130.491409] Dynamic subtest vcs1: SUCCESS (0.030s)
[130.499807] Starting dynamic subtest: vecs0
[130.522658] Dynamic subtest vecs0: SUCCESS (0.031s)
[130.530577] Starting dynamic subtest: ccs0
[130.555221] Dynamic subtest ccs0: SUCCESS (0.032s)
[130.557360] Subtest pi-common: SUCCESS (0.278s)
[130.797801] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[130.801407] [025/133] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[130.925366] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[130.929484] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[131.069267] [026/133] (888s left) gem_mmap (basic)
[131.125158] Subtest basic: SKIP (0.000s)
[131.190632] [027/133] (888s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[131.292410] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[131.296747] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[131.393303] [028/133] (888s left) syncobj_wait (invalid-reset-one-illegal-handle)
[131.466827] Starting subtest: invalid-reset-one-illegal-handle
[131.468753] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[131.564764] [029/133] (888s left) gem_readwrite (new-obj)
[131.614298] Subtest new-obj: SKIP (0.000s)
[131.676555] [030/133] (888s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[131.790977] Starting subtest: yf-tiled-8bpp-rotate-0
[131.794634] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[131.896223] [031/133] (888s left) sysfs_heartbeat_interval (invalid)
[131.953183] Starting subtest: invalid
[131.955117] Starting dynamic subtest: vecs0
[131.957114] Dynamic subtest vecs0: SUCCESS (0.000s)
[131.965573] Starting dynamic subtest: ccs0
[131.967485] Dynamic subtest ccs0: SUCCESS (0.000s)
[131.974953] Starting dynamic subtest: vcs0
[131.976662] Dynamic subtest vcs0: SUCCESS (0.000s)
[131.983719] Starting dynamic subtest: bcs0
[131.985398] Dynamic subtest bcs0: SUCCESS (0.000s)
[131.992467] Starting dynamic subtest: rcs0
[131.994123] Dynamic subtest rcs0: SUCCESS (0.000s)
[132.001219] Starting dynamic subtest: vcs1
[132.002850] Dynamic subtest vcs1: SUCCESS (0.000s)
[132.004506] Subtest invalid: SUCCESS (0.004s)
[132.071693] [032/133] (887s left) gem_sync (basic-all)
[132.150187] Starting subtest: basic-all
[134.554856] Subtest basic-all: SUCCESS (2.411s)
[134.742788] [033/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[134.842284] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[134.846486] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[134.933718] [034/133] (885s left) kms_hdr (bpc-switch-suspend)
[135.024190] Starting subtest: bpc-switch-suspend
[136.119144] Starting dynamic subtest: pipe-A-eDP-1
[155.502558] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.718s)
[155.505099] Subtest bpc-switch-suspend: SUCCESS (5.815s)
[155.618891] [035/133] (864s left) gem_spin_batch (legacy-resubmit)
[155.714620] Starting subtest: legacy-resubmit
[155.716670] Starting dynamic subtest: default
[155.718691] Dynamic subtest default: SUCCESS (0.006s)
[155.729073] Starting dynamic subtest: render
[155.731492] Dynamic subtest render: SUCCESS (0.001s)
[155.740535] Starting dynamic subtest: bsd
[155.742805] Dynamic subtest bsd: SUCCESS (0.003s)
[155.751766] Starting dynamic subtest: bsd1
[155.754081] Dynamic subtest bsd1: SUCCESS (0.003s)
[155.762674] Starting dynamic subtest: bsd2
[155.764999] Dynamic subtest bsd2: SUCCESS (0.001s)
[155.773472] Starting dynamic subtest: blt
[155.775737] Dynamic subtest blt: SUCCESS (0.002s)
[155.784445] Starting dynamic subtest: vebox
[155.786778] Dynamic subtest vebox: SUCCESS (0.003s)
[155.789079] Subtest legacy-resubmit: SUCCESS (0.024s)
[155.981199] [036/133] (864s left) kms_vrr (seamless-rr-switch-drrs)
[156.068696] Starting subtest: seamless-rr-switch-drrs
[156.075274] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[156.141240] [037/133] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[156.243119] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[156.247406] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[156.353506] [038/133] (863s left) gem_exec_balancer (bonded-semaphore)
[156.414028] Starting subtest: bonded-semaphore
[156.418715] Subtest bonded-semaphore: SKIP (0.000s)
[156.731793] [039/133] (863s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[156.776011] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[156.824673] [040/133] (863s left) kms_content_protection (dp-mst-lic-type-1)
[156.968356] Starting subtest: dp-mst-lic-type-1
[156.973122] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[157.094624] [041/133] (863s left) kms_atomic (plane-overlay-legacy)
[157.195276] Starting subtest: plane-overlay-legacy
[157.197817] Starting dynamic subtest: pipe-A-eDP-1
[157.642231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[157.644711] Subtest plane-overlay-legacy: SUCCESS (0.435s)
[158.490185] [042/133] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[158.578227] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[165.430618] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.748s)
[165.546549] [043/133] (854s left) kms_plane_multiple (tiling-x)
[165.643339] Starting subtest: tiling-x
[165.645243] Starting dynamic subtest: pipe-A-eDP-1
[169.418313] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.747s)
[169.427328] Starting dynamic subtest: pipe-B-eDP-1
[173.848178] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.409s)
[173.857706] Starting dynamic subtest: pipe-C-eDP-1
[178.207348] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.344s)
[178.217463] Starting dynamic subtest: pipe-D-eDP-1
[182.555119] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.340s)
[182.557475] Subtest tiling-x: SUCCESS (16.845s)
[183.369622] [044/133] (837s left) gem_mmap_offset (close-race)
[183.426846] Starting subtest: close-race
[203.531623] Subtest close-race: SUCCESS (20.090s)
[203.672486] [045/133] (816s left) perf_pmu (semaphore-busy)
[203.713582] Starting subtest: semaphore-busy
[203.715908] Starting dynamic subtest: rcs0
[205.367628] Dynamic subtest rcs0: SUCCESS (1.648s)
[205.377340] Starting dynamic subtest: bcs0
[207.003006] Dynamic subtest bcs0: SUCCESS (1.632s)
[207.014646] Starting dynamic subtest: vcs0
[211.070952] Dynamic subtest vcs0: SUCCESS (4.063s)
[211.082824] Starting dynamic subtest: vcs1
[217.023311] Dynamic subtest vcs1: SUCCESS (5.947s)
[217.035315] Starting dynamic subtest: vecs0
[223.039093] Dynamic subtest vecs0: SUCCESS (6.009s)
[223.051096] Starting dynamic subtest: ccs0
[225.102054] Dynamic subtest ccs0: FAIL (2.005s)
[225.104213] Subtest semaphore-busy: FAIL (21.319s)
[225.188735] [046/133] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[225.301410] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[225.305401] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.406964] [047/133] (795s left) gem_exec_reloc (basic-write-cpu-noreloc)
[225.465028] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[225.551474] [048/133] (795s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[225.663807] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[226.444316] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[226.609871] [049/133] (794s left) kms_flip (dpms-off-confusion-interruptible)
[226.704256] Starting subtest: dpms-off-confusion-interruptible
[226.706654] Starting dynamic subtest: A-eDP1
[235.415713] Dynamic subtest A-eDP1: SUCCESS (8.705s)
[235.424924] Starting dynamic subtest: B-eDP1
[244.042818] Dynamic subtest B-eDP1: SUCCESS (8.621s)
[244.055100] Starting dynamic subtest: C-eDP1
[252.663145] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[252.672529] Starting dynamic subtest: D-eDP1
[261.304861] Dynamic subtest D-eDP1: SUCCESS (8.644s)
[261.309663] Subtest dpms-off-confusion-interruptible: SUCCESS (34.598s)
[262.473607] [050/133] (758s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[262.574460] Starting subtest: crc-primary-basic-y-tiled-ccs
[262.576772] Starting dynamic subtest: pipe-A-eDP-1
[262.599858] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.611780] Starting dynamic subtest: pipe-B-eDP-1
[262.633523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.642213] Starting dynamic subtest: pipe-C-eDP-1
[262.663180] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.671443] Starting dynamic subtest: pipe-D-eDP-1
[262.692997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.697324] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[264.754930] [051/133] (756s left) gem_exec_gttfill (multigpu-basic)
[264.932176] Starting subtest: multigpu-basic
[277.719644] Subtest multigpu-basic: SUCCESS (12.793s)
[277.780144] [052/133] (743s left) kms_cursor_crc (cursor-alpha-opaque)
[277.930340] Starting subtest: cursor-alpha-opaque
[277.932314] Starting dynamic subtest: pipe-A-eDP-1
[278.578336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.647s)
[278.587876] Starting dynamic subtest: pipe-D-eDP-1
[279.825452] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[279.827822] Subtest cursor-alpha-opaque: SUCCESS (1.897s)
[280.623071] [053/133] (740s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[280.727918] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[288.009577] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.285s)
[288.110960] [054/133] (732s left) kms_flip (flip-vs-suspend-interruptible)
[288.211560] Starting subtest: flip-vs-suspend-interruptible
[288.213804] Starting dynamic subtest: A-eDP1
[337.336567] Dynamic subtest A-eDP1: SUCCESS (4.497s)
[337.347200] Starting dynamic subtest: B-eDP1
[386.333755] Dynamic subtest B-eDP1: SUCCESS (4.529s)
[386.346466] Starting dynamic subtest: C-eDP1
[435.328727] Dynamic subtest C-eDP1: SUCCESS (4.465s)
[435.339000] Starting dynamic subtest: D-eDP1
[484.351511] Dynamic subtest D-eDP1: SUCCESS (4.485s)
[484.354249] Subtest flip-vs-suspend-interruptible: SUCCESS (17.988s)
[485.567745] [055/133] (535s left) kms_psr (pr-cursor-plane-onoff)
[485.677393] Starting subtest: pr-cursor-plane-onoff
[485.682771] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[485.755200] [056/133] (535s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[485.845981] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[485.848260] Starting dynamic subtest: pipe-A-eDP-1
[491.809146] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.829s)
[491.820193] Starting dynamic subtest: pipe-B-eDP-1
[498.529958] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.653s)
[498.532508] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.485s)
[499.419014] [057/133] (521s left) kms_dp_link_training (uhbr-sst)
[499.516621] Starting subtest: uhbr-sst
[499.525656] Subtest uhbr-sst: SKIP (0.000s)
[499.590549] [058/133] (521s left) gem_ctx_persistence (processes)
[499.643772] Starting subtest: processes
[501.555862] Subtest processes: SUCCESS (1.902s)
[501.636753] [059/133] (519s left) gem_exec_reloc (basic-write-wc-active)
[501.691593] Subtest basic-write-wc-active: SKIP (0.000s)
[501.764542] [060/133] (519s left) kms_addfb_basic (bad-pitch-128)
[501.819711] Starting subtest: bad-pitch-128
[501.821683] Subtest bad-pitch-128: SUCCESS (0.000s)
[501.953622] [061/133] (519s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[502.060746] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[506.460554] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.390s)
[507.641077] [062/133] (513s left) syncobj_timeline (wait-all-complex)
[507.707202] Starting subtest: wait-all-complex
[507.926197] Subtest wait-all-complex: SUCCESS (0.217s)
[508.018222] [063/133] (513s left) gem_eio (in-flight-10ms)
[508.253197] Starting subtest: in-flight-10ms
[516.608134] Subtest in-flight-10ms: SUCCESS (8.343s)
[516.767442] [064/133] (504s left) kms_big_fb (linear-32bpp-rotate-90)
[516.880578] Starting subtest: linear-32bpp-rotate-90
[516.900861] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[516.991129] [065/133] (504s left) syncobj_timeline (reset-multiple-signaled)
[517.053013] Starting subtest: reset-multiple-signaled
[517.056107] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[517.172849] [066/133] (504s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[517.290430] Starting subtest: 2x-long-flip-vs-cursor-legacy
[517.295333] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[517.438522] [067/133] (504s left) gem_ctx_shared (q-smoketest)
[517.494687] Starting subtest: Q-smoketest
[517.497177] Starting dynamic subtest: rcs0
[523.082135] Dynamic subtest rcs0: SUCCESS (5.534s)
[523.093513] Starting dynamic subtest: bcs0
[528.601930] Dynamic subtest bcs0: SUCCESS (5.518s)
[528.612540] Starting dynamic subtest: vcs0
[534.090775] Dynamic subtest vcs0: SUCCESS (5.487s)
[534.101669] Starting dynamic subtest: vcs1
[539.592667] Dynamic subtest vcs1: SUCCESS (5.494s)
[539.602861] Starting dynamic subtest: vecs0
[545.078637] Dynamic subtest vecs0: SUCCESS (5.482s)
[545.089851] Starting dynamic subtest: ccs0
[550.594934] Dynamic subtest ccs0: SUCCESS (5.505s)
[550.597386] Subtest Q-smoketest: SUCCESS (33.028s)
[550.735719] [068/133] (470s left) kms_plane_alpha_blend (alpha-transparent-fb)
[550.842428] Starting subtest: alpha-transparent-fb
[551.138771] Starting dynamic subtest: pipe-A-eDP-1
[551.784788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s)
[551.796034] Starting dynamic subtest: pipe-D-eDP-1
[553.112379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[553.115240] Subtest alpha-transparent-fb: SUCCESS (2.270s)
[553.919892] [069/133] (467s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[554.041987] Starting subtest: cursorB-vs-flipA-atomic-transitions
[554.046892] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[554.186926] [070/133] (467s left) gem_exec_reloc (basic-wc-gtt-active)
[554.247646] Subtest basic-wc-gtt-active: SKIP (0.000s)
[554.318792] [071/133] (467s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[554.427837] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[565.609178] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.176s)
[566.460144] [072/133] (455s left) gem_exec_whisper (basic-forked)
[566.531206] Starting subtest: basic-forked
[574.603095] Subtest basic-forked: SUCCESS (8.065s)
[574.790111] [073/133] (447s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[574.890659] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[574.904206] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[574.984033] [074/133] (446s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[575.073254] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[575.078502] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[575.178534] [075/133] (446s left) syncobj_wait (single-wait-all-submitted)
[575.233904] Starting subtest: single-wait-all-submitted
[575.341139] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[575.424301] [076/133] (446s left) i915_suspend (debugfs-reader)
[575.486827] Starting subtest: debugfs-reader
[593.306088] Subtest debugfs-reader: SUCCESS (3.111s)
[593.464671] [077/133] (428s left) kms_cursor_edge_walk (128x128-top-edge)
[593.561263] Starting subtest: 128x128-top-edge
[593.564110] Starting dynamic subtest: pipe-A-eDP-1
[597.090400] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[597.102048] Starting dynamic subtest: pipe-D-eDP-1
[600.270280] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[600.273165] Subtest 128x128-top-edge: SUCCESS (6.548s)
[601.086047] [078/133] (421s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[601.174364] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[601.176586] Starting dynamic subtest: pipe-A-eDP-1
[601.927981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[601.938999] Starting dynamic subtest: pipe-B-eDP-1
[603.766708] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.816s)
[603.778139] Starting dynamic subtest: pipe-C-eDP-1
[605.608016] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[605.619093] Starting dynamic subtest: pipe-D-eDP-1
[607.456997] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.835s)
[607.459228] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.215s)
[608.587391] [079/133] (413s left) gen9_exec_parse (basic-rejected)
[608.658325] Subtest basic-rejected: SKIP (0.000s)
[608.730707] [080/133] (413s left) api_intel_bb (object-noreloc-keep-cache-simple)
[608.798335] Starting subtest: object-noreloc-keep-cache-simple
[608.802053] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[608.889127] [081/133] (413s left) kms_selftest (drm_cmdline_parser)
[608.928310] Starting subtest: drm_cmdline_parser
[608.974286] Starting dynamic subtest: drm_test_cmdline_force_d_only
[609.056652] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.084s)
[609.067046] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[609.137025] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.079s)
[609.147130] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[609.228627] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.090s)
[609.239226] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[609.319998] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.089s)
[609.330083] Starting dynamic subtest: drm_test_cmdline_force_e_only
[609.407501] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.086s)
[609.418359] Starting dynamic subtest: drm_test_cmdline_res
[609.503353] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.094s)
[609.513377] Starting dynamic subtest: drm_test_cmdline_res_vesa
[609.597190] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.094s)
[609.606894] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[609.682098] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.083s)
[609.692129] Starting dynamic subtest: drm_test_cmdline_res_rblank
[609.780017] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.097s)
[609.790570] Starting dynamic subtest: drm_test_cmdline_res_bpp
[609.866053] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.085s)
[609.882222] Starting dynamic subtest: drm_test_cmdline_res_refresh
[609.954070] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.085s)
[609.965780] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[610.041779] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.087s)
[610.052576] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[610.126029] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.082s)
[610.135614] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[610.212734] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.085s)
[610.223826] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[610.292552] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.080s)
[610.302857] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[610.393658] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.099s)
[610.405218] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[610.483832] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.089s)
[610.493596] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[610.567735] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.082s)
[610.577382] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[610.658507] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.091s)
[610.669806] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[610.746523] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.087s)
[610.757841] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[610.829565] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.081s)
[610.840675] Starting dynamic subtest: drm_test_cmdline_name
[610.906756] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.077s)
[610.916790] Starting dynamic subtest: drm_test_cmdline_name_bpp
[610.994060] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.084s)
[611.003763] Starting dynamic subtest: drm_test_cmdline_name_option
[611.087674] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.092s)
[611.097890] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[611.183843] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.095s)
[611.193910] Starting dynamic subtest: drm_test_cmdline_rotate_0
[611.269799] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.084s)
[611.280074] Starting dynamic subtest: drm_test_cmdline_rotate_90
[611.357693] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.087s)
[611.368331] Starting dynamic subtest: drm_test_cmdline_rotate_180
[611.438071] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.078s)
[611.447715] Starting dynamic subtest: drm_test_cmdline_rotate_270
[611.528326] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.088s)
[611.538199] Starting dynamic subtest: drm_test_cmdline_hmirror
[611.623128] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.092s)
[611.632346] Starting dynamic subtest: drm_test_cmdline_vmirror
[611.716857] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.094s)
[611.727659] Starting dynamic subtest: drm_test_cmdline_margin_options
[611.815989] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.096s)
[611.825654] Starting dynamic subtest: drm_test_cmdline_multiple_options
[611.907697] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.090s)
[611.918130] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[611.994539] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.083s)
[612.003892] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[612.079775] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.083s)
[612.089346] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[612.161116] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.081s)
[612.170980] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[612.258897] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.096s)
[612.268842] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[612.353968] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.094s)
[612.364141] Starting dynamic subtest: drm_test_cmdline_invalid
[612.461117] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.106s)
[612.470941] Starting dynamic subtest: drm_test_cmdline_tv_options
[612.567728] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.105s)
[612.569755] Subtest drm_cmdline_parser: SUCCESS (3.624s)
[612.737398] [082/133] (409s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[612.842871] Starting subtest: x-tiled-16bpp-rotate-270
[612.864367] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s)
[612.984264] [083/133] (409s left) gen3_render_tiledx_blits
[613.116780] [084/133] (409s left) perf (whitelisted-registers-userspace-config)
[613.245584] Starting subtest: whitelisted-registers-userspace-config
[613.247451] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[613.292563] [085/133] (409s left) gem_exec_fence (parallel)
[613.475376] Starting subtest: parallel
[613.478359] Starting dynamic subtest: rcs0
[615.636727] Dynamic subtest rcs0: SUCCESS (2.156s)
[615.647633] Starting dynamic subtest: bcs0
[617.791796] Dynamic subtest bcs0: SUCCESS (2.149s)
[617.802683] Starting dynamic subtest: vcs0
[619.944978] Dynamic subtest vcs0: SUCCESS (2.149s)
[619.955718] Starting dynamic subtest: vcs1
[622.098774] Dynamic subtest vcs1: SUCCESS (2.150s)
[622.109132] Starting dynamic subtest: vecs0
[624.250486] Dynamic subtest vecs0: SUCCESS (2.149s)
[624.260696] Starting dynamic subtest: ccs0
[626.404608] Dynamic subtest ccs0: SUCCESS (2.152s)
[626.407087] Subtest parallel: SUCCESS (12.909s)
[627.370885] [086/133] (395s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[627.471217] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[627.475528] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[627.566239] [087/133] (394s left) dumb_buffer (map-uaf)
[627.616518] Starting subtest: map-uaf
[627.619325] Subtest map-uaf: SUCCESS (0.004s)
[627.718244] [088/133] (394s left) kms_psr (psr-sprite-render)
[627.820131] Starting subtest: psr-sprite-render
[627.822824] Starting dynamic subtest: eDP-1
[629.571145] Dynamic subtest eDP-1: SUCCESS (1.748s)
[629.573956] Subtest psr-sprite-render: SUCCESS (1.750s)
[630.402815] [089/133] (392s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[630.463323] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[630.564693] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[630.655951] [090/133] (392s left) gem_linear_blits (normal)
[630.875792] Starting subtest: normal
[635.275633] Subtest normal: SUCCESS (4.400s)
[635.411331] [091/133] (387s left) perf_pmu (init-wait)
[635.502183] Starting subtest: init-wait
[635.505125] Starting dynamic subtest: rcs0
[635.508041] Dynamic subtest rcs0: SUCCESS (0.001s)
[635.519968] Starting dynamic subtest: bcs0
[635.522200] Dynamic subtest bcs0: SUCCESS (0.001s)
[635.532195] Starting dynamic subtest: vcs0
[635.534615] Dynamic subtest vcs0: SUCCESS (0.001s)
[635.544658] Starting dynamic subtest: vcs1
[635.547322] Dynamic subtest vcs1: SUCCESS (0.000s)
[635.559815] Starting dynamic subtest: vecs0
[635.562328] Dynamic subtest vecs0: SUCCESS (0.001s)
[635.572358] Starting dynamic subtest: ccs0
[635.574820] Dynamic subtest ccs0: SUCCESS (0.001s)
[635.577173] Subtest init-wait: SUCCESS (0.008s)
[635.621033] [092/133] (387s left) i915_drm_fdinfo (context-close-stress)
[635.676364] Starting subtest: context-close-stress
[646.423691] Subtest context-close-stress: SUCCESS (10.745s)
[646.519774] [093/133] (376s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[646.805088] Starting subtest: 2x-long-cursor-vs-flip-legacy
[646.810280] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[646.964009] [094/133] (375s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[647.060491] Starting subtest: bad-aux-stride-y-tiled-ccs
[647.063110] Starting dynamic subtest: pipe-A-eDP-1
[647.091104] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[647.101592] Starting dynamic subtest: pipe-B-eDP-1
[647.127045] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[647.136696] Starting dynamic subtest: pipe-C-eDP-1
[647.162329] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[647.172074] Starting dynamic subtest: pipe-D-eDP-1
[647.199106] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[647.204256] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[649.384030] [095/133] (373s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[649.481812] Starting subtest: 4-tiled-16bpp-rotate-270
[649.502162] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[649.612637] [096/133] (373s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[649.713309] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[649.716112] Starting dynamic subtest: pipe-A-eDP-1
[649.782896] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[649.792943] Starting dynamic subtest: pipe-B-eDP-1
[649.859586] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[649.871176] Starting dynamic subtest: pipe-C-eDP-1
[649.937054] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[649.947906] Starting dynamic subtest: pipe-D-eDP-1
[650.014360] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[650.019331] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[652.037832] [097/133] (370s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[652.147700] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[652.150182] Starting dynamic subtest: pipe-A-eDP-1
[652.221156] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[652.234891] Starting dynamic subtest: pipe-B-eDP-1
[653.313096] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[653.317823] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.170s)
[654.497333] [098/133] (368s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[654.623560] Starting subtest: cursorB-vs-flipB-atomic
[654.628653] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[654.768975] [099/133] (368s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[654.863848] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[654.868542] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[654.949007] [100/133] (368s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[655.013385] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[655.018983] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[655.198996] [101/133] (367s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[655.293989] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[659.755600] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.466s)
[660.914792] [102/133] (362s left) gem_pxp (reject-modify-context-protection-off-3)
[661.050184] Starting subtest: reject-modify-context-protection-off-3
[661.053222] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[661.157279] [103/133] (362s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[661.250852] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[661.256233] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[662.331221] [104/133] (360s left) syncobj_wait (single-wait-submitted)
[662.402845] Starting subtest: single-wait-submitted
[662.509049] Subtest single-wait-submitted: SUCCESS (0.105s)
[662.618099] [105/133] (360s left) kms_legacy_colorkey (basic)
[662.736177] Starting subtest: basic
[662.738995] Starting dynamic subtest: pipe-A
[662.779635] Dynamic subtest pipe-A: SUCCESS (0.046s)
[662.792630] Starting dynamic subtest: pipe-B
[662.794867] Dynamic subtest pipe-B: SUCCESS (0.000s)
[662.804948] Starting dynamic subtest: pipe-C
[662.807369] Dynamic subtest pipe-C: SUCCESS (0.000s)
[662.817470] Starting dynamic subtest: pipe-D
[662.820036] Dynamic subtest pipe-D: SUCCESS (0.000s)
[662.822577] Subtest basic: SUCCESS (0.051s)
[662.862899] [106/133] (360s left) prime_mmap (test_aperture_limit)
[662.915994] Starting subtest: test_aperture_limit
[662.918146] Starting dynamic subtest: test_aperture_limit-smem
[662.926106] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[662.931355] Subtest test_aperture_limit: SKIP (0.008s)
[663.001740] [107/133] (360s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[664.554209] Starting subtest: dpms-mode-unset-lpsp
[668.634628] Subtest dpms-mode-unset-lpsp: SUCCESS (4.079s)
[669.027243] [108/133] (354s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[669.095397] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[669.153883] [109/133] (354s left) dmabuf_sync_file (import-multiple-read-write)
[669.204769] Starting subtest: import-multiple-read-write
[669.207350] Subtest import-multiple-read-write: SUCCESS (0.004s)
[669.273912] [110/133] (354s left) gem_partial_pwrite_pread (write-snoop)
[669.332335] Subtest write-snoop: SKIP (0.000s)
[669.423798] [111/133] (354s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[669.516075] Starting subtest: primary-yf-tiled-reflect-x-0
[669.579123] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[669.685600] [112/133] (353s left) kms_psr (psr2-sprite-mmap-cpu)
[669.776315] Starting subtest: psr2-sprite-mmap-cpu
[669.779034] Starting dynamic subtest: eDP-1
[671.531228] Dynamic subtest eDP-1: SUCCESS (1.754s)
[671.533781] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.755s)
[672.392232] [113/133] (351s left) gem_create (create-ext-placement-sanity-check)
[672.557888] Starting subtest: create-ext-placement-sanity-check
[672.560200] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[672.665069] [114/133] (351s left) kms_color_pipeline (plane-ctm3x4)
[672.762360] Starting subtest: plane-ctm3x4
[672.886145] Starting dynamic subtest: pipe-A-plane-0
[673.018529] Dynamic subtest pipe-A-plane-0: SUCCESS (0.133s)
[673.028883] Starting dynamic subtest: pipe-A-plane-1
[673.140807] Dynamic subtest pipe-A-plane-1: SUCCESS (0.121s)
[673.151213] Starting dynamic subtest: pipe-A-plane-2
[673.296789] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[674.477169] Starting dynamic subtest: pipe-B-plane-0
[674.592336] Dynamic subtest pipe-B-plane-0: SUCCESS (0.122s)
[674.605352] Starting dynamic subtest: pipe-B-plane-1
[674.724892] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[674.737167] Starting dynamic subtest: pipe-B-plane-2
[674.857984] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[676.016115] Starting dynamic subtest: pipe-C-plane-0
[676.129893] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[676.143744] Starting dynamic subtest: pipe-C-plane-1
[676.239757] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[676.250945] Starting dynamic subtest: pipe-C-plane-2
[676.352067] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[677.567146] Starting dynamic subtest: pipe-D-plane-0
[677.670501] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[677.681077] Starting dynamic subtest: pipe-D-plane-1
[677.791564] Dynamic subtest pipe-D-plane-1: SUCCESS (0.122s)
[677.803407] Starting dynamic subtest: pipe-D-plane-2
[677.902573] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[678.200280] Subtest plane-ctm3x4: SUCCESS (5.439s)
[679.033654] [115/133] (344s left) syncobj_timeline (invalid-query-illegal-handle)
[679.091210] Starting subtest: invalid-query-illegal-handle
[679.094171] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[679.198710] [116/133] (344s left) kms_psr (fbc-psr-cursor-plane-onoff)
[679.293371] Starting subtest: fbc-psr-cursor-plane-onoff
[679.296184] Starting dynamic subtest: eDP-1
[679.301679] Dynamic subtest eDP-1: SKIP (0.000s)
[679.307114] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[679.367049] [117/133] (344s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[679.453182] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[679.455976] Starting dynamic subtest: pipe-A
[679.515391] Dynamic subtest pipe-A: SUCCESS (0.064s)
[679.528314] Starting dynamic subtest: pipe-B
[680.667348] Dynamic subtest pipe-B: SUCCESS (1.150s)
[680.678327] Starting dynamic subtest: pipe-C
[681.777848] Dynamic subtest pipe-C: SUCCESS (1.108s)
[681.788152] Starting dynamic subtest: pipe-D
[682.908162] Dynamic subtest pipe-D: SUCCESS (1.129s)
[682.911001] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.457s)
[684.069838] [118/133] (339s left) kms_addfb_basic (bad-pitch-1024)
[684.122560] Starting subtest: bad-pitch-1024
[684.125023] Subtest bad-pitch-1024: SUCCESS (0.000s)
[684.245815] [119/133] (339s left) gem_exec_balancer (parallel-keep-submit-fence)
[684.515714] Starting subtest: parallel-keep-submit-fence
[685.996060] Subtest parallel-keep-submit-fence: SUCCESS (1.480s)
[686.092719] [120/133] (337s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[686.211999] Starting subtest: 2x-long-flip-vs-cursor-atomic
[686.217110] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[686.360675] [121/133] (337s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[686.458226] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[686.463967] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[686.550584] [122/133] (337s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[686.649586] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[686.674359] Starting dynamic subtest: pipe-A-plane-0
[687.352678] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[687.363204] Starting dynamic subtest: pipe-A-plane-3
[687.763156] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[688.859001] Starting dynamic subtest: pipe-B-plane-0
[689.583586] Dynamic subtest pipe-B-plane-0: SUCCESS (0.733s)
[689.594304] Starting dynamic subtest: pipe-B-plane-3
[690.072972] Dynamic subtest pipe-B-plane-3: SUCCESS (0.488s)
[690.396086] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.746s)
[691.255718] [123/133] (332s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[691.363204] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[691.367929] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[691.460449] [124/133] (332s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[693.392873] Starting subtest: modeset-lpsp-stress-no-wait
[703.332185] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.939s)
[703.412766] [125/133] (320s left) i915_pm_rpm (gem-execbuf-stress)
[705.465714] Starting subtest: gem-execbuf-stress
[705.468838] Starting dynamic subtest: smem0
[718.410718] Dynamic subtest smem0: SUCCESS (12.939s)
[718.424873] Starting dynamic subtest: extra-wait-smem0
[780.400713] Dynamic subtest extra-wait-smem0: SUCCESS (61.961s)
[780.403756] Subtest gem-execbuf-stress: SUCCESS (74.906s)
[780.793832] [126/133] (243s left) kms_invalid_mode (bad-vtotal)
[780.894845] Starting subtest: bad-vtotal
[780.897306] Starting dynamic subtest: pipe-A-eDP-1
[781.179280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[781.190882] Starting dynamic subtest: pipe-B-eDP-1
[781.193115] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[781.203405] Starting dynamic subtest: pipe-C-eDP-1
[781.205865] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[781.217843] Starting dynamic subtest: pipe-D-eDP-1
[781.220614] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[781.223678] Subtest bad-vtotal: SUCCESS (0.294s)
[782.005192] [127/133] (242s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[782.404325] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[783.223650] [128/133] (241s left) drm_read (empty-block)
[783.374538] Starting subtest: empty-block
[784.374485] Subtest empty-block: SUCCESS (1.000s)
[784.510639] [129/133] (239s left) gem_mmap_gtt (basic)
[784.574073] Subtest basic: SKIP (0.000s)
[784.663640] [130/133] (239s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[784.717175] Starting subtest: single-wait-for-submit-unsubmitted
[784.820646] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[784.912122] [131/133] (239s left) gem_ctx_persistence (engines-queued)
[784.972353] Starting subtest: engines-queued
[784.975190] Starting dynamic subtest: rcs0
[785.056738] Dynamic subtest rcs0: SUCCESS (0.084s)
[785.070670] Starting dynamic subtest: bcs0
[785.103342] Dynamic subtest bcs0: SUCCESS (0.044s)
[785.115950] Starting dynamic subtest: vcs0
[786.215586] Dynamic subtest vcs0: SUCCESS (1.110s)
[786.229950] Starting dynamic subtest: vcs1
[788.200146] Dynamic subtest vcs1: SUCCESS (1.984s)
[788.214346] Starting dynamic subtest: vecs0
[790.246020] Dynamic subtest vecs0: SUCCESS (2.046s)
[790.258231] Starting dynamic subtest: ccs0
[790.411131] Dynamic subtest ccs0: SUCCESS (0.163s)
[790.413996] Subtest engines-queued: SUCCESS (5.445s)
[790.524771] [132/133] (234s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[790.626130] Starting subtest: fbc-dirtyfb-ioctl
[790.629192] Starting dynamic subtest: A-eDP-1
[793.224844] Dynamic subtest A-eDP-1: SUCCESS (2.603s)
[793.227379] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.605s)
[794.106053] [133/133] (230s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[794.234992] Starting subtest: cursor-vs-flip-legacy
[824.073164] Subtest cursor-vs-flip-legacy: SUCCESS (29.855s)
[824.912786] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_busy
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_vm_create
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: prime_mmap_coherency
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: i915_hangman
results: parsing output: 19/ for test: syncobj_eventfd
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_readwrite
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: gem_sync
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_hdr
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: kms_atomic
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_exec_gttfill
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_dp_link_training
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: kms_plane_alpha_blend
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: i915_suspend
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gen3_render_tiledx_blits
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: dumb_buffer
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_linear_blits
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_legacy_colorkey
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: dmabuf_sync_file
results: parsing output: 109/ for test: gem_partial_pwrite_pread
results: parsing output: 110/ for test: kms_rotation_crc
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_create
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: drm_read
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: kms_dirtyfb
results: parsing output: 132/ for test: kms_cursor_legacy
Done.