[57.614330] Initializing watchdogs
[57.614377]   /dev/watchdog0
[57.629464] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.633733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.636177] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.639914] [001/133] (960s left) perf_pmu (interrupts)
[57.708936] Starting subtest: interrupts
[58.820621] Subtest interrupts: SUCCESS (1.111s)
[58.938247] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[58.941608] [002/133] (959s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[59.049600] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[59.053796] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[59.125659] [003/133] (959s left) api_intel_bb (reset-bb)
[59.173566] Starting subtest: reset-bb
[59.175748] Subtest reset-bb: SUCCESS (0.004s)
[59.287021] [004/133] (958s left) kms_big_fb (linear-8bpp-rotate-270)
[59.401074] Starting subtest: linear-8bpp-rotate-270
[59.438082] Subtest linear-8bpp-rotate-270: SKIP (0.036s)
[59.549183] [005/133] (958s left) gem_exec_schedule (implicit-write-read)
[59.622252] Starting subtest: implicit-write-read
[59.624576] Starting dynamic subtest: rcs0
[59.726666] Dynamic subtest rcs0: SUCCESS (0.113s)
[59.741793] Starting dynamic subtest: vcs0
[59.823127] Dynamic subtest vcs0: SUCCESS (0.096s)
[59.834274] Starting dynamic subtest: vcs1
[59.900544] Dynamic subtest vcs1: SUCCESS (0.077s)
[59.909664] Starting dynamic subtest: vecs0
[59.974359] Dynamic subtest vecs0: SUCCESS (0.074s)
[59.984909] Starting dynamic subtest: ccs0
[60.054488] Dynamic subtest ccs0: SUCCESS (0.080s)
[60.056820] Subtest implicit-write-read: SUCCESS (0.441s)
[61.434607] [006/133] (956s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[61.528359] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[61.532869] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[62.659127] [007/133] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[62.768818] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[62.773263] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[62.868481] [008/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[62.963402] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[62.967458] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[63.055766] [009/133] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[63.162440] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[63.166747] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[63.280950] [010/133] (955s left) kms_psr (pr-dpms)
[63.374932] Starting subtest: pr-dpms
[63.379242] Subtest pr-dpms: SKIP (0.000s)
[63.448840] [011/133] (955s left) syncobj_wait (wait-all-complex)
[63.509415] Starting subtest: wait-all-complex
[63.726342] Subtest wait-all-complex: SUCCESS (0.215s)
[63.809683] [012/133] (954s left) kms_getfb (getfb2-into-addfb2)
[63.900385] Starting subtest: getfb2-into-addfb2
[63.902727] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[63.995886] [013/133] (954s left) prime_self_import (basic-with_one_bo)
[64.027945] Starting subtest: basic-with_one_bo
[64.049796] Subtest basic-with_one_bo: SUCCESS (0.022s)
[64.163306] [014/133] (954s left) gem_exec_balancer (bonded-dual)
[64.225670] Starting subtest: bonded-dual
[64.230281] Subtest bonded-dual: SKIP (0.000s)
[64.515922] [015/133] (954s left) gen9_exec_parse (bb-chained)
[64.573419] Subtest bb-chained: SKIP (0.000s)
[64.631536] [016/133] (954s left) gem_partial_pwrite_pread (writes-after-reads)
[64.694150] Subtest writes-after-reads: SKIP (0.000s)
[64.765031] [017/133] (954s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[64.818585] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[64.888827] [018/133] (953s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[65.155327] Starting subtest: parallel-dmabuf-import-out-fence
[66.280037] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.122s)
[66.383674] [019/133] (952s left) gem_fence_thrash (bo-write-verify-threaded-x)
[66.422575] Starting subtest: bo-write-verify-threaded-x
[66.444938] Subtest bo-write-verify-threaded-x: SKIP (0.021s)
[66.500166] [020/133] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[66.612751] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[66.616954] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[66.713280] [021/133] (952s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[66.804901] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[66.807257] Starting dynamic subtest: pipe-A-default-mode
[69.536204] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s)
[69.538609] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.731s)
[70.416175] [022/133] (948s left) gem_eio (suspend)
[70.653707] Starting subtest: suspend
[82.939781] Subtest suspend: SUCCESS (12.284s)
[93.145949] [023/133] (935s left) perf (gen12-unprivileged-single-ctx-counters)
[93.282569] Starting subtest: gen12-unprivileged-single-ctx-counters
[93.284479] Starting dynamic subtest: rcs0
[93.622326] Dynamic subtest rcs0: SUCCESS (0.340s)
[93.624658] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.341s)
[93.675910] [024/133] (935s left) kms_big_fb (4-tiled-addfb-size-overflow)
[93.793342] Starting subtest: 4-tiled-addfb-size-overflow
[93.795698] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[93.900575] [025/133] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[94.011113] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[94.015403] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[94.105980] [026/133] (935s left) gem_ctx_persistence (engines-cleanup)
[94.160896] Starting subtest: engines-cleanup
[94.163040] Starting dynamic subtest: rcs0
[94.223416] Dynamic subtest rcs0: SUCCESS (0.062s)
[94.237517] Starting dynamic subtest: bcs0
[94.267649] Dynamic subtest bcs0: SUCCESS (0.043s)
[94.277680] Starting dynamic subtest: vcs0
[94.309551] Dynamic subtest vcs0: SUCCESS (0.041s)
[94.319931] Starting dynamic subtest: vcs1
[94.328997] Dynamic subtest vcs1: SUCCESS (0.019s)
[94.337774] Starting dynamic subtest: vecs0
[94.398110] Dynamic subtest vecs0: SUCCESS (0.069s)
[94.410203] Starting dynamic subtest: ccs0
[94.421332] Dynamic subtest ccs0: SUCCESS (0.022s)
[94.423304] Subtest engines-cleanup: SUCCESS (0.261s)
[94.533877] [027/133] (934s left) kms_psr (psr-primary-mmap-gtt)
[94.637905] Starting subtest: psr-primary-mmap-gtt
[94.639884] Starting dynamic subtest: eDP-1
[96.072316] Dynamic subtest eDP-1: SKIP (1.431s)
[96.077292] Subtest psr-primary-mmap-gtt: SKIP (1.432s)
[96.243103] [028/133] (933s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[96.357078] Starting subtest: yf-tiled-8bpp-rotate-180
[96.361390] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[96.442193] [029/133] (932s left) syncobj_wait (invalid-signal-one-illegal-handle)
[96.504705] Starting subtest: invalid-signal-one-illegal-handle
[96.506562] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[96.618229] [030/133] (932s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[97.002375] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[97.811636] [031/133] (931s left) kms_psr (fbc-psr-sprite-blt)
[97.901247] Starting subtest: fbc-psr-sprite-blt
[97.903599] Starting dynamic subtest: eDP-1
[97.907821] Dynamic subtest eDP-1: SKIP (0.000s)
[97.911809] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[97.977469] [032/133] (931s left) gem_exec_params (no-blt)
[98.035859] Starting subtest: no-blt
[98.038162] Subtest no-blt: SUCCESS (0.002s)
[98.157772] [033/133] (931s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[98.271040] Starting subtest: y-tiled-64bpp-rotate-270
[98.275259] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[98.370903] [034/133] (931s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[98.422702] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[98.425068] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[98.543205] [035/133] (931s left) gem_mmap_offset (ptrace)
[98.597675] Starting subtest: ptrace
[98.599947] Starting dynamic subtest: smem0-wb
[98.613242] Dynamic subtest smem0-wb: SUCCESS (0.015s)
[98.622912] Starting dynamic subtest: smem0-wc
[98.633176] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[98.642388] Starting dynamic subtest: smem0-uc
[98.653059] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[98.655167] Subtest ptrace: SUCCESS (0.058s)
[98.768028] [036/133] (930s left) gem_exec_whisper (basic-sync)
[98.831013] Starting subtest: basic-sync
[107.847888] Subtest basic-sync: SUCCESS (9.020s)
[108.035884] [037/133] (921s left) kms_psr (psr2-sprite-blt)
[108.140561] Starting subtest: psr2-sprite-blt
[108.142801] Starting dynamic subtest: eDP-1
[109.832129] Dynamic subtest eDP-1: SUCCESS (1.692s)
[109.834621] Subtest psr2-sprite-blt: SUCCESS (1.693s)
[110.692890] [038/133] (919s left) i915_suspend (sysfs-reader)
[110.760814] Starting subtest: sysfs-reader
[129.314551] Subtest sysfs-reader: SUCCESS (3.552s)
[139.469382] [039/133] (900s left) gem_busy (busy)
[139.550104] Starting subtest: busy
[139.552508] Starting dynamic subtest: all-engines
[139.619254] Dynamic subtest all-engines: SUCCESS (0.069s)
[139.631524] Starting dynamic subtest: rcs0
[141.318266] Dynamic subtest rcs0: SUCCESS (1.697s)
[141.330340] Starting dynamic subtest: bcs0
[141.367153] Dynamic subtest bcs0: SUCCESS (0.048s)
[141.378149] Starting dynamic subtest: vcs0
[141.408175] Dynamic subtest vcs0: SUCCESS (0.040s)
[141.418508] Starting dynamic subtest: vcs1
[143.418493] Dynamic subtest vcs1: SUCCESS (1.956s)
[143.430988] Starting dynamic subtest: vecs0
[145.348154] Dynamic subtest vecs0: SUCCESS (1.979s)
[145.360031] Starting dynamic subtest: ccs0
[147.384372] Dynamic subtest ccs0: SUCCESS (1.987s)
[147.387309] Subtest busy: SUCCESS (7.782s)
[147.692116] [040/133] (892s left) gem_exec_flush (basic-uc-pro-default)
[147.751801] Starting subtest: basic-uc-pro-default
[153.243678] Subtest basic-uc-pro-default: SUCCESS (5.474s)
[153.432752] [041/133] (886s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[153.531892] Starting subtest: plane-primary-overlay-mutable-zpos
[157.029200] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.494s)
[158.207760] [042/133] (881s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[158.347726] Starting subtest: dp-mst-lic-type-0-hdcp14
[158.352517] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[158.498525] [043/133] (881s left) kms_plane_multiple (tiling-yf)
[158.592165] Starting subtest: tiling-yf
[158.596269] Subtest tiling-yf: SKIP (0.000s)
[158.667584] [044/133] (881s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[158.791722] Starting subtest: cursorB-vs-flipB-legacy
[158.796256] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[158.940528] [045/133] (881s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[159.037712] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[159.041732] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.135083] [046/133] (881s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[159.245790] Starting subtest: fbc-psr2-cursor-plane-update-sf
[159.247744] Starting dynamic subtest: pipe-A-eDP-1
[159.320226] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[159.330218] Starting dynamic subtest: pipe-B-eDP-1
[160.489823] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[160.494076] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.246s)
[161.681862] [047/133] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[161.780270] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[168.858650] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.082s)
[168.961374] [048/133] (871s left) gem_compute (compute-square)
[169.007842] Starting subtest: compute-square
[169.011379] Subtest compute-square: SUCCESS (0.007s)
[169.128768] [049/133] (871s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[169.228006] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[170.205980] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.979s)
[170.331890] [050/133] (870s left) syncobj_wait (wait-delayed-signal)
[170.390063] Starting subtest: wait-delayed-signal
[170.494124] Subtest wait-delayed-signal: SUCCESS (0.103s)
[170.569996] [051/133] (869s left) gem_render_tiled_blits (basic)
[170.630877] Subtest basic: SKIP (0.000s)
[170.713294] [052/133] (869s left) syncobj_timeline (invalid-query-bad-pad)
[170.756266] Starting subtest: invalid-query-bad-pad
[170.758574] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[170.851332] [053/133] (869s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[171.255163] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[172.038776] [054/133] (868s left) gem_exec_await (wide-contexts)
[172.229133] Starting subtest: wide-contexts
[195.298131] Subtest wide-contexts: SUCCESS (23.065s)
[195.497547] [055/133] (845s left) gem_userptr_blits (sd-probe)
[195.601907] Starting subtest: sd-probe
[195.603832] Subtest sd-probe: SUCCESS (0.000s)
[195.720043] [056/133] (844s left) kms_properties (get_properties-sanity-atomic)
[195.825280] Starting subtest: get_properties-sanity-atomic
[195.827599] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[195.915231] [057/133] (844s left) kms_panel_fitting (atomic-fastset)
[195.997644] Starting subtest: atomic-fastset
[195.999962] Starting dynamic subtest: pipe-A-eDP-1
[196.141391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s)
[196.152915] Starting dynamic subtest: pipe-B-eDP-1
[197.321862] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[197.333546] Starting dynamic subtest: pipe-C-eDP-1
[198.512477] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.190s)
[198.524399] Starting dynamic subtest: pipe-D-eDP-1
[199.651478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[199.653764] Subtest atomic-fastset: SUCCESS (3.656s)
[200.894455] [058/133] (839s left) gem_ctx_persistence (legacy-engines-mixed)
[200.960738] Starting subtest: legacy-engines-mixed
[200.963021] Starting dynamic subtest: render
[201.033143] Dynamic subtest render: SUCCESS (0.071s)
[201.048634] Starting dynamic subtest: bsd1
[201.073672] Dynamic subtest bsd1: SUCCESS (0.038s)
[201.084295] Starting dynamic subtest: bsd2
[201.120023] Dynamic subtest bsd2: SUCCESS (0.044s)
[201.131571] Starting dynamic subtest: blt
[201.161772] Dynamic subtest blt: SUCCESS (0.040s)
[201.174420] Starting dynamic subtest: vebox
[201.211171] Dynamic subtest vebox: SUCCESS (0.047s)
[201.213930] Subtest legacy-engines-mixed: SUCCESS (0.251s)
[201.300294] [059/133] (839s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[201.399093] Starting subtest: psr-rgb101010-draw-mmap-gtt
[201.403106] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[201.506407] [060/133] (839s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[201.598528] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[201.600854] Starting dynamic subtest: pipe-A-eDP-1
[201.627150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[201.642052] Starting dynamic subtest: pipe-B-eDP-1
[201.664982] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[201.677958] Starting dynamic subtest: pipe-C-eDP-1
[201.700950] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[201.711648] Starting dynamic subtest: pipe-D-eDP-1
[201.734412] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[201.738239] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[203.853862] [061/133] (836s left) prime_vgem (basic-write)
[203.935625] Starting subtest: basic-write
[203.941511] Subtest basic-write: SKIP (0.006s)
[204.057013] [062/133] (836s left) kms_pm_rpm (package-g7)
[205.611201] Starting subtest: package-g7
[205.616237] Subtest package-g7: SKIP (0.000s)
[206.405293] [063/133] (834s left) kms_addfb_basic (unused-handle)
[206.470722] Starting subtest: unused-handle
[206.472667] Subtest unused-handle: SUCCESS (0.000s)
[206.603680] [064/133] (834s left) syncobj_timeline (reset-during-wait-for-submit)
[206.676455] Starting subtest: reset-during-wait-for-submit
[206.781309] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[206.859779] [065/133] (834s left) perf (missing-sample-flags)
[206.989372] Starting subtest: missing-sample-flags
[206.991794] Subtest missing-sample-flags: SUCCESS (0.000s)
[207.043096] [066/133] (834s left) gem_exec_schedule (u-semaphore-codependency)
[207.115577] Starting subtest: u-semaphore-codependency
[207.120724] Subtest u-semaphore-codependency: SUCCESS (0.012s)
[207.459614] [067/133] (833s left) kms_lease (simple-lease)
[207.552947] Starting subtest: simple-lease
[207.555261] Starting dynamic subtest: pipe-A-eDP-1
[208.066036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.514s)
[208.077192] Starting dynamic subtest: pipe-B-eDP-1
[209.530273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s)
[209.542228] Starting dynamic subtest: pipe-C-eDP-1
[210.944598] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.412s)
[210.956242] Starting dynamic subtest: pipe-D-eDP-1
[212.343894] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[212.346115] Subtest simple-lease: SUCCESS (4.793s)
[213.146576] [068/133] (827s left) kms_color_pipeline (plane-lut1d-lut1d)
[213.255391] Starting subtest: plane-lut1d-lut1d
[213.403057] Starting dynamic subtest: pipe-A-plane-0
[213.578444] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[213.600357] Starting dynamic subtest: pipe-A-plane-1
[213.745198] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[213.756229] Starting dynamic subtest: pipe-A-plane-2
[213.900937] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[215.154784] Starting dynamic subtest: pipe-B-plane-0
[215.344545] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[215.356331] Starting dynamic subtest: pipe-B-plane-1
[215.478343] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[215.489523] Starting dynamic subtest: pipe-B-plane-2
[215.622632] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[216.778910] Starting dynamic subtest: pipe-C-plane-0
[216.914358] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[216.925179] Starting dynamic subtest: pipe-C-plane-1
[217.069798] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[217.080657] Starting dynamic subtest: pipe-C-plane-2
[217.214260] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[218.445079] Starting dynamic subtest: pipe-D-plane-0
[218.589641] Dynamic subtest pipe-D-plane-0: SUCCESS (0.154s)
[218.600937] Starting dynamic subtest: pipe-D-plane-1
[218.733941] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[218.746178] Starting dynamic subtest: pipe-D-plane-2
[218.878728] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[219.164991] Subtest plane-lut1d-lut1d: SUCCESS (5.910s)
[219.986899] [069/133] (821s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[220.082791] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[220.085141] Starting dynamic subtest: pipe-A
[220.149156] Dynamic subtest pipe-A: SUCCESS (0.066s)
[220.167334] Starting dynamic subtest: pipe-B
[221.315964] Dynamic subtest pipe-B: SUCCESS (1.166s)
[221.330051] Starting dynamic subtest: pipe-C
[222.418468] Dynamic subtest pipe-C: SUCCESS (1.101s)
[222.430390] Starting dynamic subtest: pipe-D
[223.548130] Dynamic subtest pipe-D: SUCCESS (1.129s)
[223.550543] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.466s)
[224.708522] [070/133] (816s left) syncobj_wait (single-wait-submitted)
[224.775543] Starting subtest: single-wait-submitted
[224.881620] Subtest single-wait-submitted: SUCCESS (0.107s)
[224.959640] [071/133] (816s left) kms_addfb_basic (bad-pitch-32)
[225.029509] Starting subtest: bad-pitch-32
[225.031414] Subtest bad-pitch-32: SUCCESS (0.000s)
[225.182938] [072/133] (816s left) gem_exec_schedule (fifo)
[225.258813] Starting subtest: fifo
[225.260722] Starting dynamic subtest: rcs0
[225.351306] Dynamic subtest rcs0: SUCCESS (0.101s)
[225.364636] Starting dynamic subtest: vcs0
[225.433996] Dynamic subtest vcs0: SUCCESS (0.082s)
[225.450964] Starting dynamic subtest: vcs1
[225.519089] Dynamic subtest vcs1: SUCCESS (0.084s)
[225.533123] Starting dynamic subtest: vecs0
[225.595561] Dynamic subtest vecs0: SUCCESS (0.076s)
[225.608957] Starting dynamic subtest: ccs0
[225.676554] Dynamic subtest ccs0: SUCCESS (0.079s)
[225.678935] Subtest fifo: SUCCESS (0.427s)
[227.444112] [073/133] (813s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[227.509133] Starting subtest: y-tiled-to-vebox-x-tiled
[227.513530] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[227.711129] [074/133] (813s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[227.829416] Starting subtest: cursor-tearing-framebuffer-change
[227.831648] Starting dynamic subtest: pipe-A-eDP-1
[228.406750] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[228.418990] Starting dynamic subtest: pipe-D-eDP-1
[229.650108] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[229.652102] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.819s)
[230.485423] [075/133] (810s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[230.580401] Starting subtest: fbc-psr2-cursor-plane-onoff
[230.582653] Starting dynamic subtest: eDP-1
[230.586887] Dynamic subtest eDP-1: SKIP (0.000s)
[230.591041] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[230.655207] [076/133] (810s left) i915_drm_fdinfo (isolation)
[230.704905] Starting subtest: isolation
[230.707035] Starting dynamic subtest: rcs0
[230.730241] Dynamic subtest rcs0: SKIP (0.025s)
[230.743231] Starting dynamic subtest: bcs0
[230.747416] Dynamic subtest bcs0: SKIP (0.000s)
[230.757765] Starting dynamic subtest: vcs0
[230.761820] Dynamic subtest vcs0: SKIP (0.000s)
[230.775366] Starting dynamic subtest: vcs1
[230.779672] Dynamic subtest vcs1: SKIP (0.000s)
[230.790229] Starting dynamic subtest: vecs0
[230.794259] Dynamic subtest vecs0: SKIP (0.000s)
[230.804370] Starting dynamic subtest: ccs0
[230.808375] Dynamic subtest ccs0: SKIP (0.000s)
[230.812436] Subtest isolation: SKIP (0.030s)
[230.852280] [077/133] (810s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[230.943160] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[235.246906] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.307s)
[236.389373] [078/133] (805s left) gem_exec_fence (syncobj-invalid-wait)
[236.822598] Starting subtest: syncobj-invalid-wait
[236.825003] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[238.421577] [079/133] (803s left) perf_pmu (faulting-read)
[238.469531] Starting subtest: faulting-read
[238.471714] Starting dynamic subtest: wb
[238.473876] Dynamic subtest wb: SUCCESS (0.001s)
[238.484625] Starting dynamic subtest: wc
[238.486849] Dynamic subtest wc: SUCCESS (0.000s)
[238.497155] Starting dynamic subtest: uc
[238.499265] Dynamic subtest uc: SUCCESS (0.000s)
[238.501405] Subtest faulting-read: SUCCESS (0.003s)
[238.559605] [080/133] (803s left) syncobj_eventfd (invalid-bad-pad)
[238.611228] Starting subtest: invalid-bad-pad
[238.613561] Subtest invalid-bad-pad: SUCCESS (0.000s)
[238.704194] [081/133] (803s left) kms_flip (flip-vs-fences)
[238.815075] Starting subtest: flip-vs-fences
[238.818964] Subtest flip-vs-fences: SKIP (0.000s)
[238.916419] [082/133] (802s left) kms_plane (plane-panning-bottom-right)
[239.012015] Starting subtest: plane-panning-bottom-right
[239.013878] Starting dynamic subtest: pipe-A
[240.727384] Dynamic subtest pipe-A: SUCCESS (1.714s)
[240.739294] Starting dynamic subtest: pipe-B
[243.128067] Dynamic subtest pipe-B: SUCCESS (2.400s)
[243.130304] Subtest plane-panning-bottom-right: SUCCESS (4.118s)
[244.030173] [083/133] (797s left) gem_exec_flush (basic-wb-rw-before-default)
[244.090942] Starting subtest: basic-wb-rw-before-default
[249.575689] Subtest basic-wb-rw-before-default: SUCCESS (5.460s)
[249.739986] [084/133] (792s left) syncobj_basic (create-signaled)
[249.790235] Starting subtest: create-signaled
[249.792428] Subtest create-signaled: SUCCESS (0.000s)
[249.896796] [085/133] (791s left) kms_invalid_mode (clock-too-high)
[249.993442] Starting subtest: clock-too-high
[249.995608] Starting dynamic subtest: pipe-A-eDP-1
[250.280194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[250.291672] Starting dynamic subtest: pipe-B-eDP-1
[250.295966] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[250.306365] Starting dynamic subtest: pipe-C-eDP-1
[250.310994] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[250.322900] Starting dynamic subtest: pipe-D-eDP-1
[250.327243] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.329368] Subtest clock-too-high: SUCCESS (0.291s)
[251.147672] [086/133] (790s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[251.229504] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[251.231690] Starting dynamic subtest: pipe-A-eDP-1
[251.241098] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.254329] Starting dynamic subtest: pipe-B-eDP-1
[251.264037] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.276680] Starting dynamic subtest: pipe-C-eDP-1
[251.285451] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.295555] Starting dynamic subtest: pipe-D-eDP-1
[251.303918] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.308001] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[253.496704] [087/133] (788s left) i915_pm_rc6_residency (media-rc6-accuracy)
[253.549576] Starting subtest: media-rc6-accuracy
[253.553964] Subtest media-rc6-accuracy: SKIP (0.000s)
[253.644771] [088/133] (788s left) kms_atomic_transition (plane-all-transition)
[253.738669] Starting subtest: plane-all-transition
[253.740926] Starting dynamic subtest: pipe-A-eDP-1
[256.232302] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[256.556122] Starting dynamic subtest: pipe-B-eDP-1
[259.750954] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s)
[260.061459] Subtest plane-all-transition: SUCCESS (6.324s)
[260.903156] [089/133] (781s left) vgem_basic (second-client)
[260.963058] Starting subtest: second-client
[260.984954] Subtest second-client: SUCCESS (0.021s)
[261.059192] [090/133] (781s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[261.172932] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[262.287554] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.116s)
[262.421015] [091/133] (779s left) kms_flip (2x-flip-vs-suspend-interruptible)
[262.506638] Starting subtest: 2x-flip-vs-suspend-interruptible
[262.510154] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[262.600394] [092/133] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[262.705490] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[262.709136] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[262.803813] [093/133] (779s left) kms_vblank (wait-forked-busy)
[262.891875] Starting subtest: wait-forked-busy
[262.893738] Starting dynamic subtest: pipe-A-eDP-1
[264.768260] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[264.786089] Starting dynamic subtest: pipe-D-eDP-1
[267.342921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.570s)
[267.344951] Subtest wait-forked-busy: SUCCESS (4.450s)
[268.155266] [094/133] (774s left) kms_fbcon_fbt (fbc)
[268.200762] Starting subtest: fbc
[274.568858] Subtest fbc: SUCCESS (6.367s)
[275.672752] [095/133] (766s left) kms_dp_linktrain_fallback (dsc-fallback)
[275.774674] Starting subtest: dsc-fallback
[275.781091] Subtest dsc-fallback: SKIP (0.000s)
[275.864413] [096/133] (766s left) gem_ctx_shared (disjoint-timelines)
[275.929007] Starting subtest: disjoint-timelines
[275.949366] Subtest disjoint-timelines: SUCCESS (0.020s)
[276.188010] [097/133] (766s left) api_intel_bb (crc32)
[276.240038] Starting subtest: crc32
[276.242351] Starting dynamic subtest: rcs0-smem0
[276.567967] Dynamic subtest rcs0-smem0: SUCCESS (0.327s)
[276.580964] Starting dynamic subtest: bcs0-smem0
[276.939228] Dynamic subtest bcs0-smem0: SUCCESS (0.368s)
[276.952748] Starting dynamic subtest: vcs0-smem0
[277.302114] Dynamic subtest vcs0-smem0: SUCCESS (0.360s)
[277.314411] Starting dynamic subtest: vcs1-smem0
[277.724835] Dynamic subtest vcs1-smem0: SUCCESS (0.419s)
[277.738103] Starting dynamic subtest: vecs0-smem0
[278.068848] Dynamic subtest vecs0-smem0: SUCCESS (0.341s)
[278.082723] Starting dynamic subtest: ccs0-smem0
[278.402388] Dynamic subtest ccs0-smem0: SUCCESS (0.330s)
[278.405421] Subtest crc32: SUCCESS (2.164s)
[278.530524] [098/133] (763s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[278.633382] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[278.637961] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[278.727859] [099/133] (763s left) gem_softpin (allocator-nopin)
[278.782822] Starting subtest: allocator-nopin
[278.883536] Subtest allocator-nopin: SUCCESS (0.100s)
[279.002713] [100/133] (763s left) sriov_basic (enable-vfs-bind-unbind-each)
[279.064924] Starting subtest: enable-vfs-bind-unbind-each
[279.067350] Starting dynamic subtest: numvfs-1
[279.148628] Dynamic subtest numvfs-1: FAIL (0.031s)
[279.161839] Starting dynamic subtest: numvfs-2
[279.235915] Dynamic subtest numvfs-2: FAIL (0.004s)
[279.248697] Starting dynamic subtest: numvfs-3
[279.321940] Dynamic subtest numvfs-3: FAIL (0.004s)
[279.334640] Starting dynamic subtest: numvfs-4
[279.406187] Dynamic subtest numvfs-4: FAIL (0.004s)
[279.420039] Starting dynamic subtest: numvfs-5
[279.493908] Dynamic subtest numvfs-5: FAIL (0.004s)
[279.505618] Starting dynamic subtest: numvfs-6
[279.578623] Dynamic subtest numvfs-6: FAIL (0.004s)
[279.590109] Starting dynamic subtest: numvfs-7
[279.663988] Dynamic subtest numvfs-7: FAIL (0.004s)
[279.676219] Starting dynamic subtest: numvfs-random
[279.754258] Dynamic subtest numvfs-random: FAIL (0.004s)
[279.756365] Subtest enable-vfs-bind-unbind-each: FAIL (0.063s)
[279.801157] [101/133] (762s left) kms_flip (2x-plain-flip)
[279.900870] Starting subtest: 2x-plain-flip
[279.909756] Subtest 2x-plain-flip: SKIP (0.011s)
[279.992270] [102/133] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[280.088790] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[280.092358] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[280.181406] [103/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[280.276819] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[280.280202] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[280.372214] [104/133] (762s left) kms_cursor_crc (cursor-onscreen-512x170)
[280.663742] Starting subtest: cursor-onscreen-512x170
[280.667373] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[280.802239] [105/133] (761s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[280.899716] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[280.901613] Starting dynamic subtest: pipe-A-eDP-1
[281.039406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[281.052099] Starting dynamic subtest: pipe-B-eDP-1
[281.070151] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[281.082858] Starting dynamic subtest: pipe-C-eDP-1
[281.098779] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[281.108803] Starting dynamic subtest: pipe-D-eDP-1
[281.125867] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[281.127792] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s)
[283.359659] [106/133] (759s left) kms_addfb_basic (invalid-get-prop-any)
[283.419709] Starting subtest: invalid-get-prop-any
[283.421626] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[283.560142] [107/133] (759s left) dmabuf_sync_file (export-basic)
[283.599874] Starting subtest: export-basic
[283.602075] Subtest export-basic: SUCCESS (0.001s)
[283.660755] [108/133] (759s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[283.793276] Starting subtest: protected-encrypted-src-copy-not-readible
[283.915901] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.124s)
[284.048676] [109/133] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[284.145001] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[284.149304] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[284.253800] [110/133] (758s left) kms_plane_alpha_blend (coverage-7efc)
[284.349547] Starting subtest: coverage-7efc
[284.636229] Starting dynamic subtest: pipe-A-eDP-1
[285.202901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[285.233714] Starting dynamic subtest: pipe-D-eDP-1
[286.573099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[286.575523] Subtest coverage-7efc: SUCCESS (2.225s)
[287.407109] [111/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[287.511936] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[287.516286] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[287.615791] [112/133] (755s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[287.703901] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[287.715151] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[287.797752] [113/133] (755s left) kms_force_connector_basic (force-connector-state)
[287.886162] Starting subtest: force-connector-state
[288.494944] Subtest force-connector-state: SUCCESS (0.611s)
[289.480404] [114/133] (753s left) gem_reg_read (timestamp-moving)
[289.541082] Starting subtest: timestamp-moving
[290.541419] Subtest timestamp-moving: SUCCESS (1.001s)
[290.629156] [115/133] (752s left) kms_feature_discovery (dp-mst)
[290.740724] Starting subtest: dp-mst
[290.745234] Subtest dp-mst: SKIP (0.000s)
[290.827742] [116/133] (752s left) syncobj_basic (bad-create-flags)
[290.890197] Starting subtest: bad-create-flags
[290.892512] Subtest bad-create-flags: SUCCESS (0.000s)
[290.998702] [117/133] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[291.094197] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[291.098388] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[291.181475] [118/133] (752s left) syncobj_timeline (wait-all-for-submit-complex)
[291.233373] Starting subtest: wait-all-for-submit-complex
[291.447595] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[291.539459] [119/133] (751s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[291.780963] Starting subtest: cursor-rapid-movement-256x85
[291.840595] Subtest cursor-rapid-movement-256x85: SKIP (0.054s)
[291.999891] [120/133] (751s left) gem_mmap_offset (partial-remap)
[292.062042] Starting subtest: partial-remap
[292.064494] Starting dynamic subtest: smem0
[292.076745] Dynamic subtest smem0: SUCCESS (0.007s)
[292.078886] Subtest partial-remap: SUCCESS (0.010s)
[292.181457] [121/133] (751s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[292.280119] Starting subtest: fbc-farfromfence-mmap-gtt
[292.284394] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[292.376684] [122/133] (751s left) gem_exec_whisper (basic-contexts-priority)
[292.430670] Starting subtest: basic-contexts-priority
[316.120285] Subtest basic-contexts-priority: SUCCESS (23.636s)
[316.260010] [123/133] (727s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[316.351663] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[316.353496] Starting dynamic subtest: pipe-A-eDP-1
[318.499142] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.149s)
[318.510485] Starting dynamic subtest: pipe-B-eDP-1
[320.834805] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.332s)
[320.846796] Starting dynamic subtest: pipe-C-eDP-1
[322.962746] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.128s)
[322.974296] Starting dynamic subtest: pipe-D-eDP-1
[325.110159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.146s)
[325.111909] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.761s)
[326.334249] [124/133] (717s left) kms_selftest (drm_format_helper)
[326.383234] Starting subtest: drm_format_helper
[326.441885] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[326.554536] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.112s)
[326.567024] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[326.647390] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.093s)
[326.658836] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[326.747647] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.100s)
[326.759757] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[326.841361] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.092s)
[326.853492] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[326.924549] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.081s)
[326.935686] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[327.031683] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.105s)
[327.044207] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[327.131224] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.099s)
[327.144151] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[327.215253] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.084s)
[327.227089] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[327.301880] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.083s)
[327.313607] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[327.398897] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.096s)
[327.410873] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[327.487425] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.089s)
[327.501661] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[327.594844] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.105s)
[327.607061] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[327.687389] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.091s)
[327.698949] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[327.770766] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.085s)
[327.783218] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[327.866385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.093s)
[327.876656] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[327.954379] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.086s)
[327.970803] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[328.046040] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.092s)
[328.047879] Subtest drm_format_helper: SUCCESS (1.663s)
[328.202021] [125/133] (715s left) template (b)
[328.259426] Starting subtest: B
[328.261115] Subtest B: SUCCESS (0.000s)
[328.354011] [126/133] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[328.453032] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[335.487611] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.036s)
[335.603684] [127/133] (708s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[335.705451] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[335.707683] Starting dynamic subtest: pipe-A-eDP-1
[352.178714] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.477s)
[352.190102] Starting dynamic subtest: pipe-B-eDP-1
[369.385366] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.203s)
[369.387593] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.682s)
[370.224427] [128/133] (673s left) kms_addfb_basic (legacy-format)
[370.286408] Starting subtest: legacy-format
[370.313484] Subtest legacy-format: SUCCESS (0.025s)
[370.453925] [129/133] (673s left) i915_pm_freq_api (freq-basic-api)
[370.523565] Starting subtest: freq-basic-api
[370.525724] Starting dynamic subtest: gt0
[370.527935] Dynamic subtest gt0: SUCCESS (0.003s)
[370.539335] Starting dynamic subtest: gt1
[370.541159] Dynamic subtest gt1: SUCCESS (0.003s)
[370.542970] Subtest freq-basic-api: SUCCESS (0.007s)
[370.644267] [130/133] (673s left) kms_getfb (getfb-addfb-different-handles)
[370.738333] Starting subtest: getfb-addfb-different-handles
[370.740532] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[370.847311] [131/133] (673s left) kms_pm_dc (dc5-psr)
[371.951040] Starting subtest: dc5-psr
[374.846228] Subtest dc5-psr: SUCCESS (2.894s)
[375.738488] [132/133] (668s left) sysfs_heartbeat_interval (mixed)
[375.798546] Starting subtest: mixed
[375.800753] Starting dynamic subtest: vecs0
[380.990443] Dynamic subtest vecs0: SUCCESS (5.194s)
[381.004360] Starting dynamic subtest: ccs0
[386.188114] Dynamic subtest ccs0: SUCCESS (5.195s)
[386.200070] Starting dynamic subtest: vcs0
[391.399406] Dynamic subtest vcs0: SUCCESS (5.209s)
[391.416230] Starting dynamic subtest: bcs0
[396.562421] Dynamic subtest bcs0: SUCCESS (5.160s)
[396.576069] Starting dynamic subtest: rcs0
[401.755266] Dynamic subtest rcs0: SUCCESS (5.191s)
[401.768667] Starting dynamic subtest: vcs1
[406.988311] Dynamic subtest vcs1: SUCCESS (5.231s)
[406.991151] Subtest mixed: SUCCESS (31.191s)
[407.075616] [133/133] (636s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[407.175110] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[407.201933] Starting dynamic subtest: pipe-A-plane-0
[407.847093] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[407.859546] Starting dynamic subtest: pipe-A-plane-3
[408.268065] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[409.382570] Starting dynamic subtest: pipe-B-plane-0
[409.996022] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[410.018374] Starting dynamic subtest: pipe-B-plane-3
[410.405981] Dynamic subtest pipe-B-plane-3: SUCCESS (0.408s)
[410.729853] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.556s)
[411.531565] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: api_intel_bb
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: prime_self_import
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gen9_exec_parse
results: parsing output: 15/ for test: gem_partial_pwrite_pread
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: gem_fence_thrash
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: gem_busy
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: kms_atomic
results: parsing output: 41/ for test: kms_content_protection
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_compute
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: gem_render_tiled_blits
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_chamelium_frames
results: parsing output: 53/ for test: gem_exec_await
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_properties
results: parsing output: 56/ for test: kms_panel_fitting
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: prime_vgem
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: kms_color_pipeline
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: syncobj_eventfd
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: syncobj_basic
results: parsing output: 84/ for test: kms_invalid_mode
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: i915_pm_rc6_residency
results: parsing output: 87/ for test: kms_atomic_transition
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_fbcon_fbt
results: parsing output: 94/ for test: kms_dp_linktrain_fallback
results: parsing output: 95/ for test: gem_ctx_shared
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: sriov_basic
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane_alpha_blend
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_force_connector_basic
results: parsing output: 113/ for test: gem_reg_read
results: parsing output: 114/ for test: kms_feature_discovery
results: parsing output: 115/ for test: syncobj_basic
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_selftest
results: parsing output: 124/ for test: template
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: i915_pm_freq_api
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: kms_pm_dc
results: parsing output: 131/ for test: sysfs_heartbeat_interval
results: parsing output: 132/ for test: kms_plane
Done.