[60.268133] Initializing watchdogs
[60.268179]   /dev/watchdog0
[60.281443] [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]
[60.285690] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.287821] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.290879] [001/133] (960s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[60.437197] Starting subtest: basic-flip-after-cursor-legacy
[61.421413] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.976s)
[62.233563] [002/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[62.322791] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[69.405754] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (7.066s)
[69.561933] [003/133] (951s left) gem_exec_schedule (u-fairslice-all)
[69.640590] Starting subtest: u-fairslice-all
[71.698390] Subtest u-fairslice-all: SUCCESS (2.059s)
[71.988868] [004/133] (948s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[72.081933] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[72.084393] Starting dynamic subtest: pipe-A
[72.454070] Dynamic subtest pipe-A: SUCCESS (0.373s)
[72.461749] Starting dynamic subtest: pipe-B
[73.875199] Dynamic subtest pipe-B: SUCCESS (1.419s)
[73.883506] Starting dynamic subtest: pipe-C
[75.331974] Dynamic subtest pipe-C: SUCCESS (1.455s)
[75.339509] Starting dynamic subtest: pipe-D
[76.756767] Dynamic subtest pipe-D: SUCCESS (1.423s)
[76.759078] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.673s)
[77.915654] [005/133] (943s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[78.040645] Starting subtest: cursor-vs-flip-varying-size
[108.896230] Subtest cursor-vs-flip-varying-size: SUCCESS (30.840s)
[109.747206] [006/133] (911s left) kms_cursor_crc (cursor-sliding-256x256)
[109.974955] Starting subtest: cursor-sliding-256x256
[109.979932] Starting dynamic subtest: pipe-A-eDP-1
[113.188325] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s)
[113.214263] Starting dynamic subtest: pipe-D-eDP-1
[117.075485] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.865s)
[117.077461] Subtest cursor-sliding-256x256: SUCCESS (7.099s)
[117.931892] [007/133] (903s left) gem_ctx_engines (execute-one)
[118.000552] Starting subtest: execute-one
[120.277046] Subtest execute-one: SUCCESS (2.276s)
[120.460270] [008/133] (900s left) gem_ringfill (basic-all)
[125.913328] Starting subtest: basic-all
[127.074701] Subtest basic-all: SUCCESS (1.162s)
[127.190099] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[127.193264] [009/133] (893s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[127.297164] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[127.301403] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[127.416053] [010/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[127.510298] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[127.514475] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[127.602619] [011/133] (893s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[127.696308] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[127.698617] Starting dynamic subtest: pipe-A-eDP-1
[127.723881] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[127.733478] Starting dynamic subtest: pipe-B-eDP-1
[127.756468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[127.763558] Starting dynamic subtest: pipe-C-eDP-1
[127.786557] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[127.793782] Starting dynamic subtest: pipe-D-eDP-1
[127.817142] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[127.821290] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[129.983118] [012/133] (891s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[130.086089] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[136.872058] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.788s)
[136.984207] [013/133] (884s left) gen9_exec_parse (allowed-single)
[137.047585] Subtest allowed-single: SKIP (0.000s)
[137.106990] [014/133] (884s left) gem_basic (multigpu-create-close)
[137.156761] Starting subtest: multigpu-create-close
[137.161246] Subtest multigpu-create-close: SKIP (0.000s)
[137.263597] [015/133] (884s left) syncobj_timeline (wait-all-interrupted)
[137.313769] Starting subtest: wait-all-interrupted
[137.419364] Subtest wait-all-interrupted: SUCCESS (0.106s)
[137.506265] [016/133] (883s left) perf_pmu (busy-no-semaphores)
[137.552215] Starting subtest: busy-no-semaphores
[137.554811] Starting dynamic subtest: rcs0
[138.122882] Dynamic subtest rcs0: SUCCESS (0.568s)
[138.133326] Starting dynamic subtest: bcs0
[138.671949] Dynamic subtest bcs0: SUCCESS (0.547s)
[138.681676] Starting dynamic subtest: vcs0
[139.221856] Dynamic subtest vcs0: SUCCESS (0.547s)
[139.232670] Starting dynamic subtest: vcs1
[140.441631] Dynamic subtest vcs1: SUCCESS (1.217s)
[140.452946] Starting dynamic subtest: vecs0
[142.425665] Dynamic subtest vecs0: SUCCESS (1.981s)
[142.437051] Starting dynamic subtest: ccs0
[144.410849] Dynamic subtest ccs0: SUCCESS (1.984s)
[144.414019] Subtest busy-no-semaphores: SUCCESS (6.858s)
[144.527985] [017/133] (876s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[144.638919] Starting subtest: y-tiled-8bpp-rotate-270
[144.643048] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[144.727885] [018/133] (876s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[144.787308] Starting subtest: y-tiled-ccs-to-x-tiled
[144.791754] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[144.972075] [019/133] (876s left) gem_userptr_blits (huge-split)
[145.047854] Starting subtest: huge-split
[145.056850] Subtest huge-split: SUCCESS (0.009s)
[145.183810] [020/133] (876s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[145.273481] Starting subtest: async-flip-with-page-flip-events-tiled
[145.669961] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[148.404966] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.736s)
[148.413562] Starting dynamic subtest: pipe-A-eDP-1-4
[150.602504] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s)
[150.613689] Starting dynamic subtest: pipe-A-eDP-1-4
[152.612306] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[152.622911] Starting dynamic subtest: pipe-A-eDP-1-x
[154.802345] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[155.181185] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[157.941031] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.765s)
[157.949690] Starting dynamic subtest: pipe-B-eDP-1-4
[160.126395] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[160.134911] Starting dynamic subtest: pipe-B-eDP-1-4
[162.137085] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[162.145585] Starting dynamic subtest: pipe-B-eDP-1-x
[164.315600] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[164.678539] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[167.468077] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[167.476748] Starting dynamic subtest: pipe-C-eDP-1-4
[169.642892] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[169.651687] Starting dynamic subtest: pipe-C-eDP-1-4
[171.653131] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[171.661333] Starting dynamic subtest: pipe-C-eDP-1-x
[173.866116] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.212s)
[174.242342] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[177.005484] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.769s)
[177.018530] Starting dynamic subtest: pipe-D-eDP-1-4
[179.169245] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[179.182295] Starting dynamic subtest: pipe-D-eDP-1-4
[181.180089] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[181.190871] Starting dynamic subtest: pipe-D-eDP-1-x
[183.358289] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[183.360569] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.085s)
[184.588790] [021/133] (836s left) kms_plane_cursor (viewport)
[184.681437] Starting subtest: viewport
[184.685756] Starting dynamic subtest: pipe-A-eDP-1-size-64
[187.177324] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.497s)
[187.238056] Starting dynamic subtest: pipe-A-eDP-1-size-128
[189.723709] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[189.783635] Starting dynamic subtest: pipe-A-eDP-1-size-256
[192.214263] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.439s)
[192.559942] Starting dynamic subtest: pipe-B-eDP-1-size-64
[195.772993] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.221s)
[195.832196] Starting dynamic subtest: pipe-B-eDP-1-size-128
[198.462100] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.637s)
[198.520877] Starting dynamic subtest: pipe-B-eDP-1-size-256
[201.039914] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.526s)
[201.396677] Starting dynamic subtest: pipe-C-eDP-1-size-64
[204.288326] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.904s)
[204.325566] Starting dynamic subtest: pipe-C-eDP-1-size-128
[206.411132] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[206.447279] Starting dynamic subtest: pipe-C-eDP-1-size-256
[208.555457] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[208.885901] Starting dynamic subtest: pipe-D-eDP-1-size-64
[211.647530] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.772s)
[211.685232] Starting dynamic subtest: pipe-D-eDP-1-size-128
[213.793069] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[213.829307] Starting dynamic subtest: pipe-D-eDP-1-size-256
[215.971075] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[216.289916] Subtest viewport: SUCCESS (31.606s)
[217.107741] [022/133] (804s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[217.180747] Starting subtest: invalid-bsd2-flag-on-vebox
[217.183225] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[217.294431] [023/133] (804s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[217.403226] Starting subtest: 4-tiled-8bpp-rotate-270
[217.426741] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[217.539946] [024/133] (804s left) kms_big_fb (linear-32bpp-rotate-0)
[217.638896] Starting subtest: linear-32bpp-rotate-0
[219.218052] Subtest linear-32bpp-rotate-0: SUCCESS (1.579s)
[219.341230] [025/133] (802s left) gem_mmap (bad-size)
[219.398640] Subtest bad-size: SKIP (0.000s)
[219.461216] [026/133] (802s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[219.557190] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[219.559281] Starting dynamic subtest: pipe-A-default-mode
[220.697224] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[220.701583] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.140s)
[220.845078] [027/133] (800s left) syncobj_timeline (invalid-wait-bad-flags)
[220.906227] Starting subtest: invalid-wait-bad-flags
[220.908458] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[221.003862] [028/133] (800s left) syncobj_timeline (multi-wait-all-signaled)
[221.064277] Starting subtest: multi-wait-all-signaled
[221.066586] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[221.180650] [029/133] (800s left) kms_lease (invalid-create-leases)
[221.275487] Starting subtest: invalid-create-leases
[221.280187] Subtest invalid-create-leases: SUCCESS (0.005s)
[221.389146] [030/133] (800s left) gem_linear_blits (normal)
[221.772650] Starting subtest: normal
[225.730722] Subtest normal: SUCCESS (3.956s)
[225.984776] [031/133] (796s left) gem_userptr_blits (unsync-unmap-cycles)
[226.089061] Subtest unsync-unmap-cycles: SKIP (0.000s)
[226.202662] [032/133] (795s left) gem_exec_reloc (basic-gtt-read-active)
[226.256723] Subtest basic-gtt-read-active: SKIP (0.000s)
[226.326872] [033/133] (795s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[226.425071] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[226.427197] Starting dynamic subtest: pipe-A-eDP-1
[226.449209] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[226.464872] Starting dynamic subtest: pipe-B-eDP-1
[226.485064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[226.493541] Starting dynamic subtest: pipe-C-eDP-1
[226.514323] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[226.522254] Starting dynamic subtest: pipe-D-eDP-1
[226.543284] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[226.547110] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[228.738664] [034/133] (793s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[228.800038] Starting subtest: single-wait-all-for-submit-unsubmitted
[228.906048] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[228.980447] [035/133] (793s left) kms_pm_rpm (modeset-lpsp)
[231.138455] Starting subtest: modeset-lpsp
[232.577545] Subtest modeset-lpsp: SUCCESS (1.443s)
[232.664951] [036/133] (789s left) kms_vrr (negative-basic)
[232.755690] Starting subtest: negative-basic
[232.762091] Starting dynamic subtest: pipe-A-eDP-1
[238.180358] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.417s)
[238.470147] Subtest negative-basic: SUCCESS (5.715s)
[239.268531] [037/133] (782s left) kms_flip (flip-vs-wf_vblank-interruptible)
[239.366369] Starting subtest: flip-vs-wf_vblank-interruptible
[239.368595] Starting dynamic subtest: A-eDP1
[241.313659] Dynamic subtest A-eDP1: SUCCESS (1.945s)
[241.322976] Starting dynamic subtest: B-eDP1
[243.251620] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[243.264615] Starting dynamic subtest: C-eDP1
[245.166535] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[245.175807] Starting dynamic subtest: D-eDP1
[247.097940] Dynamic subtest D-eDP1: SUCCESS (1.929s)
[247.103053] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.736s)
[248.233619] [038/133] (774s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[248.330377] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[248.332715] Starting dynamic subtest: pipe-A-eDP-1
[248.428289] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[248.439499] Starting dynamic subtest: pipe-B-eDP-1
[249.617338] Dynamic subtest pipe-B-eDP-1: SKIP (1.188s)
[249.621974] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.289s)
[250.817092] [039/133] (771s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[250.922496] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[251.989447] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.067s)
[252.112570] [040/133] (770s left) gem_exec_fence (syncobj-timeline-export)
[252.684718] Starting subtest: syncobj-timeline-export
[252.690597] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[253.991614] [041/133] (768s left) kms_psr (fbc-psr-primary-mmap-gtt)
[254.084100] Starting subtest: fbc-psr-primary-mmap-gtt
[254.086354] Starting dynamic subtest: eDP-1
[254.090713] Dynamic subtest eDP-1: SKIP (0.000s)
[254.095115] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[254.156394] [042/133] (768s left) i915_hangman (gt-engine-hang)
[254.222303] Starting subtest: gt-engine-hang
[254.224617] Starting dynamic subtest: rcs0
[257.842584] Dynamic subtest rcs0: SUCCESS (3.617s)
[257.854540] Starting dynamic subtest: bcs0
[259.892071] Dynamic subtest bcs0: SUCCESS (2.046s)
[259.904096] Starting dynamic subtest: vcs0
[261.876370] Dynamic subtest vcs0: SUCCESS (1.981s)
[261.889806] Starting dynamic subtest: vcs1
[263.859866] Dynamic subtest vcs1: SUCCESS (1.980s)
[263.873634] Starting dynamic subtest: vecs0
[265.843553] Dynamic subtest vecs0: SUCCESS (1.981s)
[265.855876] Starting dynamic subtest: ccs0
[267.892690] Dynamic subtest ccs0: SUCCESS (2.046s)
[267.895588] Subtest gt-engine-hang: SUCCESS (13.669s)
[267.986329] [043/133] (754s left) gem_mmap_gtt (basic-read)
[268.056148] Subtest basic-read: SKIP (0.000s)
[268.123160] [044/133] (754s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[268.244683] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[268.251639] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[268.387737] [045/133] (754s left) gem_exec_whisper (basic-sync)
[268.449242] Starting subtest: basic-sync
[275.053675] Subtest basic-sync: SUCCESS (6.604s)
[275.255283] [046/133] (747s left) kms_psr (psr2-basic)
[275.346530] Starting subtest: psr2-basic
[275.348733] Starting dynamic subtest: eDP-1
[276.988998] Dynamic subtest eDP-1: SUCCESS (1.641s)
[276.991245] Subtest psr2-basic: SUCCESS (1.643s)
[277.790341] [047/133] (744s left) gem_pxp (create-regular-context-1)
[277.916569] Starting subtest: create-regular-context-1
[277.919072] Subtest create-regular-context-1: SUCCESS (0.002s)
[278.017647] [048/133] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[278.121248] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[278.125625] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[278.200517] [049/133] (744s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[278.292229] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[278.294491] Starting dynamic subtest: pipe-A-eDP-1
[278.316971] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[278.326856] Starting dynamic subtest: pipe-B-eDP-1
[278.346169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[278.354069] Starting dynamic subtest: pipe-C-eDP-1
[278.374228] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[278.382107] Starting dynamic subtest: pipe-D-eDP-1
[278.403415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[278.407704] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[280.566313] [050/133] (742s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[280.656882] Starting subtest: 2x-absolute-wf_vblank-interruptible
[280.668576] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[280.747338] [051/133] (742s left) kms_fbcon_fbt (psr)
[280.805818] Starting subtest: psr
[288.194998] Subtest psr: SUCCESS (7.387s)
[288.275402] [052/133] (734s left) gem_exec_balancer (sliced)
[288.342906] Starting subtest: sliced
[288.347458] Subtest sliced: SKIP (0.000s)
[288.636940] [053/133] (734s left) perf_pmu (semaphore-wait-idle)
[288.679953] Starting subtest: semaphore-wait-idle
[288.681903] Starting dynamic subtest: rcs0
[289.195725] Dynamic subtest rcs0: SUCCESS (0.515s)
[289.207120] Starting dynamic subtest: bcs0
[289.709315] Dynamic subtest bcs0: SUCCESS (0.511s)
[289.720876] Starting dynamic subtest: vcs0
[290.222792] Dynamic subtest vcs0: SUCCESS (0.510s)
[290.234553] Starting dynamic subtest: vcs1
[290.736240] Dynamic subtest vcs1: SUCCESS (0.510s)
[290.748120] Starting dynamic subtest: vecs0
[291.251478] Dynamic subtest vecs0: SUCCESS (0.511s)
[291.263556] Starting dynamic subtest: ccs0
[291.767428] Dynamic subtest ccs0: SUCCESS (0.512s)
[291.770395] Subtest semaphore-wait-idle: SUCCESS (3.089s)
[292.960215] [054/133] (729s left) kms_content_protection (uevent)
[293.093711] Starting subtest: uevent
[293.098241] Subtest uevent: SKIP (0.000s)
[293.227549] [055/133] (729s left) gem_madvise (dontneed-before-pwrite)
[293.273831] Starting subtest: dontneed-before-pwrite
[293.297636] Subtest dontneed-before-pwrite: SKIP (0.025s)
[293.362645] [056/133] (729s left) i915_suspend (fence-restore-tiled2untiled)
[293.416606] Starting subtest: fence-restore-tiled2untiled
[293.420814] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[293.525822] [057/133] (729s left) gem_ctx_param (invalid-size-get)
[293.578319] Starting subtest: invalid-size-get
[293.580582] Subtest invalid-size-get: SUCCESS (0.001s)
[293.690739] [058/133] (729s left) kms_psr (fbc-pr-basic)
[293.789120] Starting subtest: fbc-pr-basic
[293.793589] Subtest fbc-pr-basic: SKIP (0.000s)
[293.895848] [059/133] (729s left) prime_vgem (fence-write-hang)
[293.980502] Subtest fence-write-hang: SKIP (0.000s)
[294.085127] [060/133] (729s left) gem_mmap_wc (coherency)
[294.138894] Subtest coherency: SKIP (0.000s)
[294.193931] [061/133] (729s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[294.280456] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[294.282449] Starting dynamic subtest: pipe-A-eDP-1
[294.301491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[294.315900] Starting dynamic subtest: pipe-B-eDP-1
[294.333887] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[294.341728] Starting dynamic subtest: pipe-C-eDP-1
[294.359618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[294.367308] Starting dynamic subtest: pipe-D-eDP-1
[294.384940] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[294.388357] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[296.570219] [062/133] (726s left) kms_getfb (getfb2-handle-not-fb)
[296.662911] Starting subtest: getfb2-handle-not-fb
[296.665122] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[296.773575] [063/133] (726s left) device_reset (unbind-cold-reset-rebind)
[296.816233] Starting subtest: unbind-cold-reset-rebind
[296.821607] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[296.877408] [064/133] (726s left) gem_spin_batch (legacy)
[296.930530] Starting subtest: legacy
[296.932856] Starting dynamic subtest: default
[300.178209] Dynamic subtest default: SUCCESS (3.235s)
[300.196808] Starting dynamic subtest: render
[303.406483] Dynamic subtest render: SUCCESS (3.233s)
[303.417878] Starting dynamic subtest: bsd
[306.643500] Dynamic subtest bsd: SUCCESS (3.234s)
[306.654659] Starting dynamic subtest: bsd1
[309.877537] Dynamic subtest bsd1: SUCCESS (3.231s)
[309.888829] Starting dynamic subtest: bsd2
[313.111675] Dynamic subtest bsd2: SUCCESS (3.231s)
[313.122632] Starting dynamic subtest: blt
[316.348044] Dynamic subtest blt: SUCCESS (3.233s)
[316.359732] Starting dynamic subtest: vebox
[319.584779] Dynamic subtest vebox: SUCCESS (3.234s)
[319.587229] Subtest legacy: SUCCESS (22.651s)
[319.979193] [065/133] (703s left) gem_exec_schedule (preempt-contexts)
[320.057660] Starting subtest: preempt-contexts
[320.059883] Starting dynamic subtest: rcs0
[320.133971] Dynamic subtest rcs0: SUCCESS (0.083s)
[320.144594] Starting dynamic subtest: bcs0
[320.224636] Dynamic subtest bcs0: SUCCESS (0.090s)
[320.235744] Starting dynamic subtest: vcs0
[320.280664] Dynamic subtest vcs0: SUCCESS (0.054s)
[320.289925] Starting dynamic subtest: vcs1
[320.345763] Dynamic subtest vcs1: SUCCESS (0.065s)
[320.355286] Starting dynamic subtest: vecs0
[320.415051] Dynamic subtest vecs0: SUCCESS (0.069s)
[320.424446] Starting dynamic subtest: ccs0
[320.494982] Dynamic subtest ccs0: SUCCESS (0.079s)
[320.497300] Subtest preempt-contexts: SUCCESS (0.445s)
[321.975747] [066/133] (701s left) kms_invalid_mode (bad-htotal)
[322.081453] Starting subtest: bad-htotal
[322.083792] Starting dynamic subtest: pipe-A-eDP-1
[322.369620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[322.378816] Starting dynamic subtest: pipe-B-eDP-1
[322.381089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[322.389443] Starting dynamic subtest: pipe-C-eDP-1
[322.391819] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.400184] Starting dynamic subtest: pipe-D-eDP-1
[322.402698] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.405059] Subtest bad-htotal: SUCCESS (0.292s)
[323.196281] [067/133] (700s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[323.295825] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[323.300447] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[323.405796] [068/133] (700s left) kms_psr (psr-primary-blt)
[323.488853] Starting subtest: psr-primary-blt
[323.491132] Starting dynamic subtest: eDP-1
[325.198878] Dynamic subtest eDP-1: SUCCESS (1.710s)
[325.201191] Subtest psr-primary-blt: SUCCESS (1.711s)
[326.077987] [069/133] (697s left) kms_properties (colorop-properties-atomic)
[326.169625] Starting subtest: colorop-properties-atomic
[326.171738] Starting dynamic subtest: pipe-A-eDP-1
[326.530836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s)
[326.540377] Starting dynamic subtest: pipe-B-eDP-1
[327.632462] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.099s)
[327.641238] Starting dynamic subtest: pipe-C-eDP-1
[328.652834] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.020s)
[328.662855] Starting dynamic subtest: pipe-D-eDP-1
[329.690890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[329.693200] Subtest colorop-properties-atomic: SUCCESS (3.523s)
[330.492559] [070/133] (693s left) gem_sync (basic-many-each)
[330.569975] Starting subtest: basic-many-each
[332.831886] Subtest basic-many-each: SUCCESS (2.274s)
[333.013497] [071/133] (690s left) kms_feature_discovery (display-3x)
[333.102781] Starting subtest: display-3x
[333.107137] Subtest display-3x: SKIP (0.000s)
[333.180246] [072/133] (690s left) perf_pmu (interrupts-sync)
[333.218826] Starting subtest: interrupts-sync
[334.314242] Subtest interrupts-sync: SUCCESS (1.094s)
[334.421313] [073/133] (689s left) gem_ctx_param (non-root-set)
[334.461837] Starting subtest: non-root-set
[334.488482] Subtest non-root-set: SUCCESS (0.027s)
[334.581131] [074/133] (689s left) vgem_basic (bad-fence)
[334.620055] Starting subtest: bad-fence
[334.622317] Subtest bad-fence: SUCCESS (0.000s)
[334.676434] [075/133] (689s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[334.774172] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[334.778222] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[334.876268] [076/133] (688s left) kms_psr (fbc-psr2-cursor-blt)
[334.967814] Starting subtest: fbc-psr2-cursor-blt
[334.970064] Starting dynamic subtest: eDP-1
[334.974116] Dynamic subtest eDP-1: SKIP (0.000s)
[334.978176] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[335.038987] [077/133] (688s left) kms_cursor_crc (cursor-onscreen-32x10)
[335.200216] Starting subtest: cursor-onscreen-32x10
[335.246556] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[335.501404] [078/133] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[335.595068] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[340.837361] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.244s)
[342.000170] [079/133] (681s left) gem_exec_schedule (fairslice)
[342.067300] Starting subtest: fairslice
[342.069635] Starting dynamic subtest: rcs0
[344.079655] Dynamic subtest rcs0: SUCCESS (2.018s)
[344.088714] Starting dynamic subtest: bcs0
[346.096178] Dynamic subtest bcs0: SUCCESS (2.018s)
[346.107529] Starting dynamic subtest: vcs0
[348.118847] Dynamic subtest vcs0: SUCCESS (2.018s)
[348.128232] Starting dynamic subtest: vcs1
[350.134100] Dynamic subtest vcs1: SUCCESS (2.016s)
[350.143733] Starting dynamic subtest: vecs0
[352.152255] Dynamic subtest vecs0: SUCCESS (2.019s)
[352.160622] Starting dynamic subtest: ccs0
[354.176016] Dynamic subtest ccs0: SUCCESS (2.022s)
[354.177835] Subtest fairslice: SUCCESS (12.116s)
[354.473890] [080/133] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[354.570642] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[354.574906] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[354.677909] [081/133] (669s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[354.802449] Starting subtest: flip-vs-cursor-crc-legacy
[355.466542] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.660s)
[356.321546] [082/133] (667s left) gem_ctx_shared (q-smoketest)
[356.394422] Starting subtest: Q-smoketest
[356.396597] Starting dynamic subtest: rcs0
[361.944664] Dynamic subtest rcs0: SUCCESS (5.502s)
[361.960693] Starting dynamic subtest: bcs0
[367.437715] Dynamic subtest bcs0: SUCCESS (5.492s)
[367.447934] Starting dynamic subtest: vcs0
[372.920637] Dynamic subtest vcs0: SUCCESS (5.480s)
[372.935661] Starting dynamic subtest: vcs1
[378.413796] Dynamic subtest vcs1: SUCCESS (5.494s)
[378.429615] Starting dynamic subtest: vecs0
[383.897162] Dynamic subtest vecs0: SUCCESS (5.484s)
[383.907198] Starting dynamic subtest: ccs0
[389.378012] Dynamic subtest ccs0: SUCCESS (5.478s)
[389.380060] Subtest Q-smoketest: SUCCESS (32.937s)
[389.525622] [083/133] (634s left) kms_chamelium_frames (hdmi-frame-dump)
[389.916367] Subtest hdmi-frame-dump: SKIP (0.000s)
[390.723141] [084/133] (633s left) gem_flink_race (flink_close)
[390.766101] Starting subtest: flink_close
[395.856923] Subtest flink_close: SUCCESS (5.090s)
[395.936080] [085/133] (628s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[396.040993] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[396.043366] Starting dynamic subtest: pipe-A-eDP-1
[396.064170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[396.075622] Starting dynamic subtest: pipe-B-eDP-1
[396.095477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[396.104714] Starting dynamic subtest: pipe-C-eDP-1
[396.124576] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[396.133701] Starting dynamic subtest: pipe-D-eDP-1
[396.153666] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[396.155877] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[398.206963] [086/133] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[398.312640] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[398.316786] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[398.411993] [087/133] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[398.524188] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[405.554847] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.035s)
[405.655128] [088/133] (618s left) gem_pxp (reject-modify-context-protection-off-3)
[405.734251] Starting subtest: reject-modify-context-protection-off-3
[405.736527] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[405.829968] [089/133] (618s left) syncobj_eventfd (invalid-illegal-handle)
[405.885200] Starting subtest: invalid-illegal-handle
[405.887443] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[405.989445] [090/133] (618s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[406.077495] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[406.079755] Starting dynamic subtest: pipe-A-eDP-1
[406.101595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[406.111742] Starting dynamic subtest: pipe-B-eDP-1
[406.131720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[406.139918] Starting dynamic subtest: pipe-C-eDP-1
[406.161136] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[406.169356] Starting dynamic subtest: pipe-D-eDP-1
[406.191073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[406.195347] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[408.372957] [091/133] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[408.476762] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[408.481198] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[408.580909] [092/133] (615s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[408.676521] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[413.265652] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.593s)
[414.391123] [093/133] (610s left) gem_mmap_gtt (big-bo-tiledy)
[414.459145] Subtest big-bo-tiledY: SKIP (0.000s)
[414.514851] [094/133] (610s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[414.617910] Starting subtest: bo-too-small-due-to-tiling
[414.622208] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[414.731740] [095/133] (609s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[414.853489] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[426.009029] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.155s)
[426.805744] [096/133] (597s left) api_intel_bb (object-noreloc-purge-cache-simple)
[426.872457] Starting subtest: object-noreloc-purge-cache-simple
[426.874911] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[427.008064] [097/133] (597s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[427.082413] Subtest untiled-to-tiled: SKIP (0.000s)
[427.155610] [098/133] (597s left) gem_ctx_persistence (file)
[427.203410] Starting subtest: file
[427.311578] Subtest file: SUCCESS (0.111s)
[427.433660] [099/133] (597s left) kms_plane (pixel-format-linear-modifier)
[427.531999] Starting subtest: pixel-format-linear-modifier
[427.558991] Starting dynamic subtest: pipe-A-plane-0
[431.125212] Dynamic subtest pipe-A-plane-0: SUCCESS (3.566s)
[431.134025] Starting dynamic subtest: pipe-A-plane-3
[432.802992] Dynamic subtest pipe-A-plane-3: SUCCESS (1.677s)
[432.813748] Starting dynamic subtest: pipe-A-plane-5
[433.014528] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[434.089334] Starting dynamic subtest: pipe-B-plane-0
[437.615669] Dynamic subtest pipe-B-plane-0: SUCCESS (3.533s)
[437.626735] Starting dynamic subtest: pipe-B-plane-3
[439.315952] Dynamic subtest pipe-B-plane-3: SUCCESS (1.698s)
[439.328822] Starting dynamic subtest: pipe-B-plane-5
[439.526981] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[439.835282] Subtest pixel-format-linear-modifier: SUCCESS (12.302s)
[440.659360] [100/133] (584s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[440.995910] Starting subtest: cursor-rapid-movement-max-size
[441.002463] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[441.138709] [101/133] (583s left) kms_pipe_crc_basic (hang-read-crc)
[441.227093] Starting subtest: hang-read-crc
[441.229366] Starting dynamic subtest: pipe-A-eDP-1
[443.338368] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[443.348533] Starting dynamic subtest: pipe-B-eDP-1
[446.107249] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[446.118179] Starting dynamic subtest: pipe-C-eDP-1
[448.732138] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s)
[448.742020] Starting dynamic subtest: pipe-D-eDP-1
[451.404200] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.671s)
[451.406528] Subtest hang-read-crc: SUCCESS (10.177s)
[452.227897] [102/133] (572s left) gem_mmap_offset (clear-via-pagefault)
[452.298707] Starting subtest: clear-via-pagefault
[452.300780] Starting dynamic subtest: smem0
[485.468690] Dynamic subtest smem0: SUCCESS (33.163s)
[485.471082] Subtest clear-via-pagefault: SUCCESS (33.165s)
[485.571901] [103/133] (539s left) i915_pm_rps (min-max-config-loaded)
[485.632830] Starting subtest: min-max-config-loaded
[485.637408] Subtest min-max-config-loaded: SKIP (0.001s)
[485.747690] [104/133] (539s left) gem_exec_flush (basic-batch-kernel-default-uc)
[485.813884] Starting subtest: basic-batch-kernel-default-uc
[492.012377] Subtest basic-batch-kernel-default-uc: SUCCESS (6.200s)
[492.199917] [105/133] (532s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[492.259599] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[492.262538] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[492.366859] [106/133] (532s left) kms_vblank (wait-forked)
[492.454836] Starting subtest: wait-forked
[492.456743] Starting dynamic subtest: pipe-A-eDP-1
[494.268351] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[494.282606] Starting dynamic subtest: pipe-D-eDP-1
[496.809785] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[496.812185] Subtest wait-forked: SUCCESS (4.357s)
[497.695166] [107/133] (527s left) gem_exec_flush (basic-wb-rw-before-default)
[497.748340] Starting subtest: basic-wb-rw-before-default
[503.206238] Subtest basic-wb-rw-before-default: SUCCESS (5.458s)
[503.395348] [108/133] (521s left) kms_plane_scaling (planes-scaler-unity-scaling)
[503.489940] Starting subtest: planes-scaler-unity-scaling
[503.492167] Starting dynamic subtest: pipe-A
[503.553465] Dynamic subtest pipe-A: SUCCESS (0.065s)
[503.564149] Starting dynamic subtest: pipe-B
[504.714251] Dynamic subtest pipe-B: SUCCESS (1.160s)
[504.723306] Starting dynamic subtest: pipe-C
[505.832232] Dynamic subtest pipe-C: SUCCESS (1.116s)
[505.841190] Starting dynamic subtest: pipe-D
[506.958064] Dynamic subtest pipe-D: SUCCESS (1.125s)
[506.960592] Subtest planes-scaler-unity-scaling: SUCCESS (3.470s)
[508.116601] [109/133] (517s left) kms_psr (psr-cursor-plane-move)
[508.211549] Starting subtest: psr-cursor-plane-move
[508.213833] Starting dynamic subtest: eDP-1
[509.904167] Dynamic subtest eDP-1: SUCCESS (1.692s)
[509.906045] Subtest psr-cursor-plane-move: SUCCESS (1.693s)
[510.769326] [110/133] (514s left) gem_madvise (dontneed-before-exec)
[510.812372] Starting subtest: dontneed-before-exec
[510.835940] Subtest dontneed-before-exec: SKIP (0.023s)
[510.901564] [111/133] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[511.003286] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[511.007588] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[511.127630] [112/133] (514s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[511.223258] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[511.235530] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[511.330281] [113/133] (514s left) syncobj_basic (bad-pad-handle-to-fd)
[511.380708] Starting subtest: bad-pad-handle-to-fd
[511.382961] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[511.498426] [114/133] (513s left) gem_userptr_blits (sync-unmap-cycles)
[511.562100] Starting subtest: sync-unmap-cycles
[516.937791] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[517.055898] [115/133] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[517.150684] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[517.154298] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[517.244900] [116/133] (508s left) kms_async_flips (test-time-stamp)
[517.326842] Starting subtest: test-time-stamp
[517.700321] Starting dynamic subtest: pipe-A-eDP-1
[518.470727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[518.869675] Starting dynamic subtest: pipe-B-eDP-1
[519.624309] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[519.989735] Starting dynamic subtest: pipe-C-eDP-1
[520.757075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[521.124701] Starting dynamic subtest: pipe-D-eDP-1
[521.882573] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[521.884950] Subtest test-time-stamp: SUCCESS (4.555s)
[523.054621] [117/133] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[523.146705] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[523.150797] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[523.244214] [118/133] (502s left) kms_addfb_basic (bad-pitch-1024)
[523.296151] Starting subtest: bad-pitch-1024
[523.298347] Subtest bad-pitch-1024: SUCCESS (0.000s)
[523.432990] [119/133] (502s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[523.525802] Starting subtest: plane-lut1d-post-ctm3x4
[523.649864] Starting dynamic subtest: pipe-A-plane-0
[523.981467] Dynamic subtest pipe-A-plane-0: FAIL (0.159s)
[523.990310] Starting dynamic subtest: pipe-A-plane-1
[524.168393] Dynamic subtest pipe-A-plane-1: FAIL (0.170s)
[524.176943] Starting dynamic subtest: pipe-A-plane-2
[524.373399] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[525.344568] Starting dynamic subtest: pipe-B-plane-0
[525.748527] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[525.759374] Starting dynamic subtest: pipe-B-plane-1
[526.074067] Dynamic subtest pipe-B-plane-1: FAIL (0.167s)
[526.084837] Starting dynamic subtest: pipe-B-plane-2
[526.395976] Dynamic subtest pipe-B-plane-2: FAIL (0.176s)
[527.072771] Starting dynamic subtest: pipe-C-plane-0
[527.592570] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[527.604947] Starting dynamic subtest: pipe-C-plane-1
[527.996736] Dynamic subtest pipe-C-plane-1: FAIL (0.618s)
[528.007942] Starting dynamic subtest: pipe-C-plane-2
[528.371385] Dynamic subtest pipe-C-plane-2: FAIL (0.173s)
[529.190232] Starting dynamic subtest: pipe-D-plane-0
[529.778173] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[529.797473] Starting dynamic subtest: pipe-D-plane-1
[530.256056] Dynamic subtest pipe-D-plane-1: FAIL (0.631s)
[530.274914] Starting dynamic subtest: pipe-D-plane-2
[530.725053] Dynamic subtest pipe-D-plane-2: FAIL (0.602s)
[530.856810] Subtest plane-lut1d-post-ctm3x4: FAIL (7.330s)
[531.665115] [120/133] (494s left) perf (short-reads)
[531.822709] Starting subtest: short-reads
[531.837649] Subtest short-reads: SUCCESS (0.016s)
[531.878590] [121/133] (493s left) gem_ctx_param (invalid-get-no-zeromap)
[531.942379] Starting subtest: invalid-get-no-zeromap
[531.944613] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[532.053763] [122/133] (493s left) gem_exec_reloc (basic-wc-cpu-active)
[532.127511] Subtest basic-wc-cpu-active: SKIP (0.000s)
[532.194764] [123/133] (493s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[532.582159] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[533.370071] [124/133] (492s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[533.464483] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[533.468926] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[533.569593] [125/133] (492s left) i915_drm_fdinfo (busy)
[533.611326] Starting subtest: busy
[533.613582] Starting dynamic subtest: rcs0
[533.636812] Dynamic subtest rcs0: SKIP (0.023s)
[533.647694] Starting dynamic subtest: bcs0
[533.651681] Dynamic subtest bcs0: SKIP (0.000s)
[533.660445] Starting dynamic subtest: vcs0
[533.664810] Dynamic subtest vcs0: SKIP (0.000s)
[533.673076] Starting dynamic subtest: vcs1
[533.677699] Dynamic subtest vcs1: SKIP (0.000s)
[533.690571] Starting dynamic subtest: vecs0
[533.694601] Dynamic subtest vecs0: SKIP (0.000s)
[533.702801] Starting dynamic subtest: ccs0
[533.706765] Dynamic subtest ccs0: SKIP (0.000s)
[533.710678] Subtest busy: SKIP (0.028s)
[533.747979] [126/133] (492s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[533.848631] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[533.850979] Starting dynamic subtest: pipe-A-default-mode
[536.561473] Dynamic subtest pipe-A-default-mode: SUCCESS (2.711s)
[536.563872] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.714s)
[537.397088] [127/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[537.489790] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[544.567917] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.081s)
[544.715975] [128/133] (481s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[544.813062] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[548.785819] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.976s)
[549.934443] [129/133] (476s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[550.033532] Starting subtest: primary-yf-tiled-reflect-x-270
[550.037769] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[550.108686] [130/133] (475s left) kms_vblank (accuracy-idle)
[550.201451] Starting subtest: accuracy-idle
[550.203639] Starting dynamic subtest: pipe-A-eDP-1
[551.969226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[551.991791] Starting dynamic subtest: pipe-D-eDP-1
[554.372059] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.400s)
[554.374392] Subtest accuracy-idle: SUCCESS (4.172s)
[555.202293] [131/133] (470s left) gem_exec_whisper (basic-normal-all)
[555.272825] Starting subtest: basic-normal-all
[557.709087] Subtest basic-normal-all: SUCCESS (2.439s)
[557.896484] [132/133] (468s left) gem_exec_balancer (individual)
[557.950075] Starting subtest: individual
[559.892480] Subtest individual: SUCCESS (1.940s)
[560.206501] [133/133] (465s left) kms_pm_dc (dc5-dpms)
[561.304033] Starting subtest: dc5-dpms
[563.375490] Subtest dc5-dpms: SUCCESS (2.070s)
[563.449264] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: gem_ctx_engines
results: parsing output: 7/ for test: gem_ringfill
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: gem_basic
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_plane_cursor
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_mmap
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: gem_linear_blits
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: i915_hangman
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_fbcon_fbt
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: gem_madvise
results: parsing output: 55/ for test: i915_suspend
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: device_reset
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_properties
results: parsing output: 69/ for test: gem_sync
results: parsing output: 70/ for test: kms_feature_discovery
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: vgem_basic
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: syncobj_eventfd
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: gem_set_tiling_vs_blt
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_pipe_crc_basic
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_madvise
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_color_pipeline
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: gem_ctx_param
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_pm_dc
Done.