[57.179307] Initializing watchdogs
[57.179356]   /dev/watchdog0
[57.194192] [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.198824] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.201480] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.204837] [001/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[57.339408] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[57.343782] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[57.422189] [002/132] (960s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[57.513403] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[57.517999] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[58.642204] [003/132] (959s left) i915_drm_fdinfo (memory-info-idle)
[58.692404] Starting subtest: memory-info-idle
[58.694299] Starting dynamic subtest: smem0
[58.728087] Dynamic subtest smem0: SUCCESS (0.038s)
[58.730436] Subtest memory-info-idle: SUCCESS (0.038s)
[58.809263] [004/132] (959s left) kms_big_fb (linear-64bpp-rotate-270)
[58.916937] Starting subtest: linear-64bpp-rotate-270
[58.935508] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[59.046659] [005/132] (958s left) gem_ctx_persistence (userptr)
[59.105421] Starting subtest: userptr
[59.267491] Subtest userptr: SUCCESS (0.162s)
[59.369302] [006/132] (958s left) gem_exec_schedule (u-semaphore-codependency)
[59.453608] Starting subtest: u-semaphore-codependency
[59.463732] Subtest u-semaphore-codependency: SUCCESS (0.015s)
[59.796964] [007/132] (958s left) kms_psr (psr2-sprite-mmap-cpu)
[59.888965] Starting subtest: psr2-sprite-mmap-cpu
[59.891314] Starting dynamic subtest: eDP-1
[61.636137] Dynamic subtest eDP-1: SUCCESS (1.747s)
[61.638458] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.748s)
[62.504748] [008/132] (955s left) gem_exec_capture (capture-invisible)
[62.570162] Starting subtest: capture-invisible
[62.572833] Starting dynamic subtest: smem0
[62.577234] Dynamic subtest smem0: SKIP (0.000s)
[62.581731] Subtest capture-invisible: SKIP (0.000s)
[62.680130] [009/132] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[62.787056] Starting subtest: psr-rgb565-draw-mmap-gtt
[62.791466] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[62.903979] [010/132] (955s left) gem_exec_schedule (fairslice-all)
[62.976653] Starting subtest: fairslice-all
[65.032837] Subtest fairslice-all: SUCCESS (2.062s)
[66.320651] [011/132] (951s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[66.717215] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[67.514048] [012/132] (950s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[67.572624] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[67.575102] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.002s)
[67.668593] [013/132] (950s left) kms_vblank (accuracy-idle)
[67.768152] Starting subtest: accuracy-idle
[67.770115] Starting dynamic subtest: pipe-A-eDP-1
[69.527826] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.761s)
[69.542624] Starting dynamic subtest: pipe-D-eDP-1
[71.979356] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.448s)
[71.981400] Subtest accuracy-idle: SUCCESS (4.211s)
[72.803433] [014/132] (945s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[72.980528] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[74.188976] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.208s)
[74.309967] [015/132] (943s left) kms_content_protection (legacy-hdcp14)
[74.442337] Starting subtest: legacy-hdcp14
[74.446361] Subtest legacy-hdcp14: SKIP (0.000s)
[74.557029] [016/132] (943s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[74.648153] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[74.652133] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[74.722972] [017/132] (943s left) gem_lmem_swapping (heavy-multi)
[74.763292] Subtest heavy-multi: SKIP (0.000s)
[74.809849] [018/132] (943s left) syncobj_timeline (invalid-query-bad-pad)
[74.861436] Starting subtest: invalid-query-bad-pad
[74.863513] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[74.968427] [019/132] (943s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[75.068218] Starting subtest: fbcpsr-tiling-4
[82.189921] Subtest fbcpsr-tiling-4: SUCCESS (7.123s)
[82.323256] [020/132] (936s left) api_intel_bb (simple-bb-ctx)
[82.382866] Starting subtest: simple-bb-ctx
[82.390138] Subtest simple-bb-ctx: SUCCESS (0.007s)
[82.527565] [021/132] (935s left) kms_busy (basic-hang)
[82.619851] Starting subtest: basic-hang
[82.622098] Starting dynamic subtest: flip-pipe-A
[83.208423] Dynamic subtest flip-pipe-A: SUCCESS (0.588s)
[83.219840] Starting dynamic subtest: modeset-pipe-A
[86.621330] Dynamic subtest modeset-pipe-A: SUCCESS (3.413s)
[86.631581] Starting dynamic subtest: flip-pipe-D
[87.815271] Dynamic subtest flip-pipe-D: SUCCESS (1.190s)
[87.824789] Starting dynamic subtest: modeset-pipe-D
[91.266946] Dynamic subtest modeset-pipe-D: SUCCESS (3.452s)
[91.269411] Subtest basic-hang: SUCCESS (8.647s)
[92.073518] [022/132] (926s left) kms_getfb (getfb2-accept-nv12)
[92.169961] Starting subtest: getfb2-accept-nv12
[92.172295] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[92.280189] [023/132] (926s left) gem_mmap_gtt (ptrace)
[92.341257] Subtest ptrace: SKIP (0.000s)
[92.403806] [024/132] (926s left) gem_partial_pwrite_pread (reads-snoop)
[92.458230] Subtest reads-snoop: SKIP (0.000s)
[92.550295] [025/132] (926s left) kms_psr (pr-cursor-mmap-gtt)
[92.649018] Starting subtest: pr-cursor-mmap-gtt
[92.653243] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[92.718362] [026/132] (925s left) i915_pm_freq_api (freq-basic-api)
[92.776591] Starting subtest: freq-basic-api
[92.778814] Starting dynamic subtest: gt0
[92.781227] Dynamic subtest gt0: SUCCESS (0.003s)
[92.793864] Starting dynamic subtest: gt1
[92.795805] Dynamic subtest gt1: SUCCESS (0.003s)
[92.797705] Subtest freq-basic-api: SUCCESS (0.007s)
[92.861312] [027/132] (925s left) gen3_mixed_blits
[92.999888] [028/132] (925s left) kms_cursor_edge_walk (64x64-right-edge)
[93.088556] Starting subtest: 64x64-right-edge
[93.090522] Starting dynamic subtest: pipe-A-eDP-1
[96.541712] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[96.554606] Starting dynamic subtest: pipe-D-eDP-1
[99.664438] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[99.666778] Subtest 64x64-right-edge: SUCCESS (6.577s)
[100.466377] [029/132] (918s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[100.554209] Starting subtest: crc-primary-basic-yf-tiled-ccs
[100.556555] Starting dynamic subtest: pipe-A-eDP-1
[100.579873] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.588396] Starting dynamic subtest: pipe-B-eDP-1
[100.611267] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[100.619069] Starting dynamic subtest: pipe-C-eDP-1
[100.640758] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.648764] Starting dynamic subtest: pipe-D-eDP-1
[100.671295] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.675781] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[102.822102] [030/132] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[102.935968] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[109.491123] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.562s)
[109.603963] [031/132] (909s left) kms_cursor_crc (cursor-onscreen-512x170)
[109.898481] Starting subtest: cursor-onscreen-512x170
[109.902947] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[110.033916] [032/132] (908s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[110.128151] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[110.153741] Starting dynamic subtest: pipe-A-plane-0
[110.587331] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[110.599449] Starting dynamic subtest: pipe-A-plane-3
[110.853157] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s)
[110.861256] Starting dynamic subtest: pipe-A-plane-5
[110.864845] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[111.925482] Starting dynamic subtest: pipe-B-plane-0
[112.351054] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[112.359992] Starting dynamic subtest: pipe-B-plane-3
[112.606994] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[112.615977] Starting dynamic subtest: pipe-B-plane-5
[112.620631] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[112.916105] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.787s)
[113.793087] [033/132] (905s left) dmabuf (all-tests)
[113.840705] Starting subtest: all-tests
[113.845126] Subtest all-tests: SKIP (0.000s)
[113.897279] [034/132] (905s left) gem_softpin (32b-excludes-last-page)
[113.956051] Starting subtest: 32b-excludes-last-page
[113.961298] Subtest 32b-excludes-last-page: SUCCESS (0.006s)
[114.097653] [035/132] (904s left) prime_vgem (basic-write)
[114.207037] Starting subtest: basic-write
[114.214448] Subtest basic-write: SKIP (0.005s)
[114.327534] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[114.331722] [036/132] (904s left) kms_plane_alpha_blend (constant-alpha-max)
[114.431281] Starting subtest: constant-alpha-max
[114.727973] Starting dynamic subtest: pipe-A-eDP-1
[115.772943] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.042s)
[115.782158] Starting dynamic subtest: pipe-D-eDP-1
[117.421947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.648s)
[117.424360] Subtest constant-alpha-max: SUCCESS (2.991s)
[118.267050] [037/132] (900s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[118.368634] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[119.380423] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.013s)
[119.504138] [038/132] (899s left) gem_eio (in-flight-immediate)
[119.741926] Starting subtest: in-flight-immediate
[128.307256] Subtest in-flight-immediate: SUCCESS (8.564s)
[128.442729] [039/132] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[128.541433] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[128.545552] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[128.661722] [040/132] (890s left) kms_lease (lease-unleased-connector)
[128.762191] Starting subtest: lease-unleased-connector
[128.764447] Starting dynamic subtest: pipe-A-eDP-1
[128.766671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[128.776890] Starting dynamic subtest: pipe-B-eDP-1
[128.779058] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[128.788774] Starting dynamic subtest: pipe-C-eDP-1
[128.790923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[128.799747] Starting dynamic subtest: pipe-D-eDP-1
[128.801840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[128.803949] Subtest lease-unleased-connector: SUCCESS (0.030s)
[128.903914] [041/132] (890s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[129.005182] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[129.009642] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[129.098822] [042/132] (890s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[129.225079] Starting subtest: 2x-flip-vs-cursor-legacy
[129.228826] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[129.388488] [043/132] (890s left) kms_cursor_crc (cursor-random-64x64)
[129.565166] Starting subtest: cursor-random-64x64
[129.573599] Starting dynamic subtest: pipe-A-eDP-1
[132.953563] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.380s)
[132.988667] Starting dynamic subtest: pipe-D-eDP-1
[136.974311] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s)
[136.976590] Subtest cursor-random-64x64: SUCCESS (7.407s)
[137.832522] [044/132] (881s left) kms_psr (fbc-pr-cursor-render)
[137.923885] Starting subtest: fbc-pr-cursor-render
[137.928506] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[138.011166] [045/132] (881s left) gem_sync (basic-store-each)
[138.095055] Starting subtest: basic-store-each
[140.395140] Subtest basic-store-each: SUCCESS (2.311s)
[140.580963] [046/132] (878s left) gem_exec_suspend (basic-s4-devices)
[140.642333] Starting subtest: basic-S4-devices
[140.644785] Starting dynamic subtest: smem
[152.319557] Dynamic subtest smem: SUCCESS (11.675s)
[152.322442] Subtest basic-S4-devices: SUCCESS (11.677s)
[158.559979] [047/132] (867s left) syncobj_wait (reset-during-wait-for-submit)
[158.636784] Starting subtest: reset-during-wait-for-submit
[158.739400] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[158.829974] [048/132] (866s left) syncobj_basic (bad-pad-handle-to-fd)
[158.888972] Starting subtest: bad-pad-handle-to-fd
[158.891201] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[158.977236] [049/132] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[159.082812] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[166.226980] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.145s)
[166.356380] [050/132] (859s left) gem_exec_gttfill (basic)
[166.439713] Starting subtest: basic
[169.036074] Subtest basic: SUCCESS (2.595s)
[169.227353] [051/132] (856s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[169.380954] Starting subtest: fbc-psr2-primary-mmap-cpu
[169.383184] Starting dynamic subtest: eDP-1
[169.387182] Dynamic subtest eDP-1: SKIP (0.000s)
[169.391189] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[169.473489] [052/132] (856s left) syncobj_wait (wait-for-submit-snapshot)
[169.547184] Starting subtest: wait-for-submit-snapshot
[169.629539] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[169.707355] [053/132] (856s left) kms_addfb_basic (master-rmfb)
[169.784793] Starting subtest: master-rmfb
[169.787145] Subtest master-rmfb: SUCCESS (0.001s)
[169.920281] [054/132] (856s left) kms_color (invalid-degamma-lut-sizes)
[170.013703] Starting subtest: invalid-degamma-lut-sizes
[170.015953] Starting dynamic subtest: pipe-A
[170.308565] Dynamic subtest pipe-A: SUCCESS (0.296s)
[170.318870] Starting dynamic subtest: pipe-B
[170.321085] Dynamic subtest pipe-B: SUCCESS (0.000s)
[170.330756] Starting dynamic subtest: pipe-C
[170.332953] Dynamic subtest pipe-C: SUCCESS (0.000s)
[170.342770] Starting dynamic subtest: pipe-D
[170.344886] Dynamic subtest pipe-D: SUCCESS (0.000s)
[170.347124] Subtest invalid-degamma-lut-sizes: SUCCESS (0.300s)
[171.205053] [055/132] (854s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[171.324840] Starting subtest: basic-flip-after-cursor-atomic
[172.280760] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.955s)
[173.129086] [056/132] (852s left) syncobj_timeline (wait-any-complex)
[173.186465] Starting subtest: wait-any-complex
[173.247357] Subtest wait-any-complex: SUCCESS (0.062s)
[173.328388] [057/132] (852s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[173.432146] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[173.436072] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[173.528984] [058/132] (852s left) kms_pwrite_crc
[175.162138] [059/132] (851s left) kms_vrr (max-min)
[175.256172] Starting subtest: max-min
[175.262526] Subtest max-min: SKIP (0.000s)
[175.331793] [060/132] (850s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[175.441953] Starting subtest: y-tiled-16bpp-rotate-0
[175.446314] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[175.530766] [061/132] (850s left) gem_exec_parallel (fds)
[175.603517] Starting subtest: fds
[175.606074] Starting dynamic subtest: rcs0
[177.935347] Dynamic subtest rcs0: SUCCESS (2.328s)
[177.947661] Starting dynamic subtest: bcs0
[181.132594] Dynamic subtest bcs0: SUCCESS (3.194s)
[181.145583] Starting dynamic subtest: vcs0
[185.508432] Dynamic subtest vcs0: SUCCESS (4.373s)
[185.522222] Starting dynamic subtest: vcs1
[189.607084] Dynamic subtest vcs1: SUCCESS (4.095s)
[189.622492] Starting dynamic subtest: vecs0
[193.599074] Dynamic subtest vecs0: SUCCESS (3.990s)
[193.610327] Starting dynamic subtest: ccs0
[197.103066] Dynamic subtest ccs0: SUCCESS (3.503s)
[197.105883] Subtest fds: SUCCESS (21.496s)
[197.298624] [062/132] (829s left) kms_draw_crc (draw-method-mmap-wc)
[197.401289] Starting subtest: draw-method-mmap-wc
[197.403516] Starting dynamic subtest: xrgb8888-untiled
[197.669683] Dynamic subtest xrgb8888-untiled: SUCCESS (0.269s)
[197.680874] Starting dynamic subtest: rgb565-untiled
[197.891714] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[197.902173] Starting dynamic subtest: xrgb2101010-untiled
[198.092090] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[198.102624] Starting dynamic subtest: xbgr16161616f-untiled
[198.315080] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[198.325613] Starting dynamic subtest: xrgb8888-xtiled
[198.458174] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[198.468323] Starting dynamic subtest: rgb565-xtiled
[198.591515] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[198.601944] Starting dynamic subtest: xrgb2101010-xtiled
[198.713818] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[198.724419] Starting dynamic subtest: xbgr16161616f-xtiled
[198.846821] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[198.859508] Starting dynamic subtest: xrgb8888-4tiled
[199.024746] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.177s)
[199.034914] Starting dynamic subtest: rgb565-4tiled
[199.180376] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[199.192548] Starting dynamic subtest: xrgb2101010-4tiled
[199.336098] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[199.348670] Starting dynamic subtest: xbgr16161616f-4tiled
[199.513858] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.176s)
[199.516040] Subtest draw-method-mmap-wc: SUCCESS (2.115s)
[199.628824] [063/132] (826s left) gen7_exec_parse (oacontrol-tracking)
[199.697276] Subtest oacontrol-tracking: SKIP (0.000s)
[199.755089] [064/132] (826s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[199.854925] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[199.858333] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[199.948271] [065/132] (826s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[200.043104] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[200.046485] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[200.135345] [066/132] (826s left) gem_create (create-ext-cpu-access-big)
[200.315438] Starting subtest: create-ext-cpu-access-big
[200.320654] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[200.390383] [067/132] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[200.487765] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[200.491967] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[200.571780] [068/132] (825s left) gem_exec_schedule (independent)
[200.651411] Starting subtest: independent
[200.653388] Starting dynamic subtest: rcs0
[202.240311] Dynamic subtest rcs0: SUCCESS (1.598s)
[202.254173] Starting dynamic subtest: vcs0
[204.286966] Dynamic subtest vcs0: SUCCESS (2.044s)
[204.300995] Starting dynamic subtest: vcs1
[206.283034] Dynamic subtest vcs1: SUCCESS (1.994s)
[206.296856] Starting dynamic subtest: vecs0
[208.263475] Dynamic subtest vecs0: SUCCESS (1.978s)
[208.276936] Starting dynamic subtest: ccs0
[210.302878] Dynamic subtest ccs0: SUCCESS (2.038s)
[210.305564] Subtest independent: SUCCESS (9.662s)
[210.611037] [069/132] (815s left) gem_ctx_param (invalid-set-ringsize)
[210.684131] Starting subtest: invalid-set-ringsize
[210.686434] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[210.764646] [070/132] (815s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[210.879175] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[210.883374] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[210.957122] [071/132] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[211.057600] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[211.061725] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[211.158522] [072/132] (815s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[211.254983] Starting subtest: plane-upscale-20x20-with-rotation
[211.257339] Starting dynamic subtest: pipe-A
[211.480707] Dynamic subtest pipe-A: SUCCESS (0.228s)
[211.492622] Starting dynamic subtest: pipe-B
[212.743466] Dynamic subtest pipe-B: SUCCESS (1.261s)
[212.754562] Starting dynamic subtest: pipe-C
[214.074304] Dynamic subtest pipe-C: SUCCESS (1.330s)
[214.085323] Starting dynamic subtest: pipe-D
[215.393663] Dynamic subtest pipe-D: SUCCESS (1.319s)
[215.396095] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.141s)
[216.585510] [073/132] (810s left) gem_gtt_cpu_tlb
[216.697154] [074/132] (810s left) sw_sync (alloc_fence)
[216.735907] Starting subtest: alloc_fence
[216.738303] Subtest alloc_fence: SUCCESS (0.000s)
[216.798196] [075/132] (810s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[216.898060] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[216.902299] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[216.993154] [076/132] (809s left) prime_mmap (test_forked_cpu_write)
[217.047730] Starting subtest: test_forked_cpu_write
[217.049982] Starting dynamic subtest: test_forked_cpu_write-smem
[217.054988] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[217.057154] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[217.177745] [077/132] (809s left) kms_atomic (plane-overlay-legacy)
[217.281698] Starting subtest: plane-overlay-legacy
[217.284078] Starting dynamic subtest: pipe-A-eDP-1
[217.721621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[217.723799] Subtest plane-overlay-legacy: SUCCESS (0.442s)
[218.517481] [078/132] (808s left) kms_rotation_crc (bad-tiling)
[218.610066] Starting subtest: bad-tiling
[218.614233] Subtest bad-tiling: SKIP (0.001s)
[218.686312] [079/132] (808s left) kms_invalid_mode (uint-max-clock)
[218.790174] Starting subtest: uint-max-clock
[218.792381] Starting dynamic subtest: pipe-A-eDP-1
[219.077142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[219.088751] Starting dynamic subtest: pipe-B-eDP-1
[219.090925] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[219.103706] Starting dynamic subtest: pipe-C-eDP-1
[219.105931] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[219.116188] Starting dynamic subtest: pipe-D-eDP-1
[219.118461] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[219.120677] Subtest uint-max-clock: SUCCESS (0.295s)
[219.954837] [080/132] (807s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[220.047033] Starting subtest: primary-yf-tiled-reflect-x-0
[220.117826] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.070s)
[220.226021] [081/132] (806s left) gem_ctx_shared (exec-shared-gtt)
[220.296342] Starting subtest: exec-shared-gtt
[220.298724] Starting dynamic subtest: rcs0
[220.304089] Dynamic subtest rcs0: SUCCESS (0.008s)
[220.317840] Starting dynamic subtest: bcs0
[220.320176] Dynamic subtest bcs0: SUCCESS (0.006s)
[220.330722] Starting dynamic subtest: vcs0
[220.332658] Dynamic subtest vcs0: SUCCESS (0.006s)
[220.343321] Starting dynamic subtest: vcs1
[220.345543] Dynamic subtest vcs1: SUCCESS (0.007s)
[220.356082] Starting dynamic subtest: vecs0
[220.357888] Dynamic subtest vecs0: SUCCESS (0.006s)
[220.368272] Starting dynamic subtest: ccs0
[220.370084] Dynamic subtest ccs0: SUCCESS (0.008s)
[220.371853] Subtest exec-shared-gtt: SUCCESS (0.046s)
[220.543930] [082/132] (806s left) i915_pm_rps (thresholds-idle-park)
[220.608558] Starting subtest: thresholds-idle-park
[220.612943] Subtest thresholds-idle-park: SKIP (0.001s)
[220.711439] [083/132] (806s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[220.809486] Starting subtest: 4-tiled-32bpp-rotate-90
[220.829197] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[220.969729] [084/132] (806s left) i915_pm_rpm (gem-pread)
[222.493063] Starting subtest: gem-pread
[224.579253] Subtest gem-pread: SUCCESS (2.086s)
[224.679035] [085/132] (802s left) kms_chamelium_color (ctm-0-50)
[224.787236] Subtest ctm-0-50: SKIP (0.000s)
[224.835908] [086/132] (802s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[224.896607] Starting subtest: invalid-bsd1-flag-on-vebox
[224.899173] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[225.013901] [087/132] (802s left) kms_cursor_legacy (single-bo)
[225.132176] Starting subtest: single-bo
[225.134318] Starting dynamic subtest: pipe-A
[230.516278] Dynamic subtest pipe-A: SUCCESS (5.379s)
[230.529628] Starting dynamic subtest: pipe-B
[235.896039] Dynamic subtest pipe-B: SUCCESS (5.379s)
[235.909584] Starting dynamic subtest: pipe-C
[241.276042] Dynamic subtest pipe-C: SUCCESS (5.378s)
[241.288193] Starting dynamic subtest: pipe-D
[246.655924] Dynamic subtest pipe-D: SUCCESS (5.379s)
[246.668691] Starting dynamic subtest: all-pipes
[252.045196] Dynamic subtest all-pipes: SUCCESS (5.386s)
[252.047550] Subtest single-bo: SUCCESS (26.911s)
[252.192263] [088/132] (775s left) gem_exec_whisper (basic-fds-forked-all)
[252.262976] Starting subtest: basic-fds-forked-all
[272.348241] Subtest basic-fds-forked-all: SUCCESS (20.085s)
[272.556251] [089/132] (754s left) gem_exec_params (secure-non-root)
[272.624135] Starting subtest: secure-non-root
[272.628158] Subtest secure-non-root: SKIP (0.000s)
[272.731509] [090/132] (754s left) kms_pm_dc (dc5-psr)
[273.843159] Starting subtest: dc5-psr
[276.736779] Subtest dc5-psr: SUCCESS (2.893s)
[277.565089] [091/132] (749s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[277.627733] Starting subtest: etime-multi-wait-all-for-submit-submitted
[277.730808] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[277.811104] [092/132] (749s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[277.910370] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[277.912728] Starting dynamic subtest: pipe-A-eDP-1
[277.971787] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[277.982713] Starting dynamic subtest: pipe-B-eDP-1
[278.039267] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[278.050660] Starting dynamic subtest: pipe-C-eDP-1
[278.106726] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[278.118361] Starting dynamic subtest: pipe-D-eDP-1
[278.176270] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[278.180641] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[280.229259] [093/132] (747s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[280.327293] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[280.331632] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[280.421381] [094/132] (747s left) gem_busy (parallel)
[280.608642] Starting subtest: parallel
[280.610951] Starting dynamic subtest: rcs0
[282.303624] Dynamic subtest rcs0: SUCCESS (1.693s)
[282.318100] Starting dynamic subtest: bcs0
[284.287402] Dynamic subtest bcs0: SUCCESS (1.981s)
[284.301526] Starting dynamic subtest: vcs0
[286.271077] Dynamic subtest vcs0: SUCCESS (1.980s)
[286.285099] Starting dynamic subtest: vcs1
[288.318929] Dynamic subtest vcs1: SUCCESS (2.045s)
[288.332079] Starting dynamic subtest: vecs0
[290.303558] Dynamic subtest vecs0: SUCCESS (1.982s)
[290.324253] Starting dynamic subtest: ccs0
[292.287318] Dynamic subtest ccs0: SUCCESS (1.981s)
[292.290212] Subtest parallel: SUCCESS (11.679s)
[292.527384] [095/132] (735s left) gem_mmap (pf-nonblock)
[292.586597] Subtest pf-nonblock: SKIP (0.000s)
[292.650474] [096/132] (735s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[292.740923] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[292.745283] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[292.827218] [097/132] (734s left) syncobj_wait (wait-any-interrupted)
[292.890553] Starting subtest: wait-any-interrupted
[292.993846] Subtest wait-any-interrupted: SUCCESS (0.104s)
[293.074514] [098/132] (734s left) kms_plane_lowres (tiling-none)
[293.168482] Starting subtest: tiling-none
[293.170824] Starting dynamic subtest: pipe-A-eDP-1
[293.175320] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[293.470081] Starting dynamic subtest: pipe-B-eDP-1
[293.474657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.487447] Starting dynamic subtest: pipe-C-eDP-1
[293.491934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.502322] Starting dynamic subtest: pipe-D-eDP-1
[293.506285] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.510184] Subtest tiling-none: SKIP (0.297s)
[294.267973] [099/132] (733s left) api_intel_bb (blit-noreloc-keep-cache)
[294.334718] Starting subtest: blit-noreloc-keep-cache
[294.347711] Subtest blit-noreloc-keep-cache: SUCCESS (0.015s)
[294.471274] [100/132] (733s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[294.562150] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[294.564067] Starting dynamic subtest: pipe-A
[294.925177] Dynamic subtest pipe-A: SUCCESS (0.365s)
[294.943306] Starting dynamic subtest: pipe-B
[296.388573] Dynamic subtest pipe-B: SUCCESS (1.463s)
[296.400183] Starting dynamic subtest: pipe-C
[297.821821] Dynamic subtest pipe-C: SUCCESS (1.432s)
[297.833462] Starting dynamic subtest: pipe-D
[299.232156] Dynamic subtest pipe-D: SUCCESS (1.410s)
[299.234466] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.673s)
[300.386553] [101/132] (727s left) prime_vgem (wait)
[300.465709] Starting subtest: wait
[300.468021] Starting dynamic subtest: rcs0
[300.576071] Dynamic subtest rcs0: SUCCESS (0.113s)
[300.593689] Starting dynamic subtest: bcs0
[300.668832] Dynamic subtest bcs0: SUCCESS (0.092s)
[300.680407] Starting dynamic subtest: vcs0
[300.703984] Dynamic subtest vcs0: SUCCESS (0.034s)
[300.715784] Starting dynamic subtest: vcs1
[300.753513] Dynamic subtest vcs1: SUCCESS (0.049s)
[300.764336] Starting dynamic subtest: vecs0
[300.797062] Dynamic subtest vecs0: SUCCESS (0.042s)
[300.808252] Starting dynamic subtest: ccs0
[300.844130] Dynamic subtest ccs0: SUCCESS (0.046s)
[300.846372] Subtest wait: SUCCESS (0.383s)
[300.973349] [102/132] (727s left) gem_exec_fence (nb-await)
[301.159075] Starting subtest: nb-await
[301.161662] Starting dynamic subtest: rcs0
[301.225808] Dynamic subtest rcs0: SUCCESS (0.067s)
[301.239870] Starting dynamic subtest: bcs0
[301.284616] Dynamic subtest bcs0: SUCCESS (0.056s)
[301.297206] Starting dynamic subtest: vcs0
[301.343848] Dynamic subtest vcs0: SUCCESS (0.057s)
[301.356241] Starting dynamic subtest: vcs1
[301.402859] Dynamic subtest vcs1: SUCCESS (0.057s)
[301.415727] Starting dynamic subtest: vecs0
[301.461733] Dynamic subtest vecs0: SUCCESS (0.057s)
[301.484198] Starting dynamic subtest: ccs0
[301.520223] Dynamic subtest ccs0: SUCCESS (0.056s)
[301.522865] Subtest nb-await: SUCCESS (0.363s)
[303.383915] [103/132] (724s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[303.485993] Starting subtest: fbc-psr2-sprite-plane-onoff
[303.488287] Starting dynamic subtest: eDP-1
[303.492563] Dynamic subtest eDP-1: SKIP (0.000s)
[303.496874] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[303.562464] [104/132] (724s left) i915_query (query-garbage)
[303.615429] Starting subtest: query-garbage
[303.617355] Subtest query-garbage: SUCCESS (0.000s)
[303.733854] [105/132] (724s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[303.831159] Starting subtest: primary-4-tiled-reflect-x-180
[310.952019] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.123s)
[312.149283] [106/132] (716s left) gem_eio (in-flight-10ms)
[312.386636] Starting subtest: in-flight-10ms
[321.257998] Subtest in-flight-10ms: SUCCESS (8.872s)
[321.382967] [107/132] (706s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[321.485285] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[321.487540] Starting dynamic subtest: pipe-A-default-mode
[322.616085] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[322.620210] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.129s)
[322.752256] [108/132] (705s left) kms_chamelium_frames (dp-crc-single)
[323.132720] Subtest dp-crc-single: SKIP (0.000s)
[323.910643] [109/132] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[324.004331] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[331.096293] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.095s)
[331.233225] [110/132] (697s left) gem_pxp (reject-modify-context-protection-off-2)
[331.360874] Starting subtest: reject-modify-context-protection-off-2
[331.363409] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[331.490552] [111/132] (696s left) gem_tiled_pread_basic (basic)
[331.544521] Subtest basic: SKIP (0.000s)
[331.601751] [112/132] (696s left) perf_pmu (busy-start)
[331.641632] Starting subtest: busy-start
[331.644077] Starting dynamic subtest: rcs0
[334.191000] Dynamic subtest rcs0: SUCCESS (2.552s)
[334.204200] Starting dynamic subtest: bcs0
[336.740432] Dynamic subtest bcs0: SUCCESS (2.547s)
[336.754594] Starting dynamic subtest: vcs0
[340.286467] Dynamic subtest vcs0: SUCCESS (3.542s)
[340.300259] Starting dynamic subtest: vcs1
[344.318497] Dynamic subtest vcs1: SUCCESS (4.029s)
[344.332881] Starting dynamic subtest: vecs0
[348.286640] Dynamic subtest vecs0: SUCCESS (3.966s)
[348.300563] Starting dynamic subtest: ccs0
[350.836811] Dynamic subtest ccs0: SUCCESS (2.549s)
[350.839860] Subtest busy-start: SUCCESS (19.199s)
[350.936131] [113/132] (677s left) gem_spin_batch (resubmit-all)
[351.014447] Starting subtest: resubmit-all
[351.016829] Starting dynamic subtest: rcs0
[351.030569] Dynamic subtest rcs0: SUCCESS (0.016s)
[351.044560] Starting dynamic subtest: bcs0
[351.046820] Dynamic subtest bcs0: SUCCESS (0.003s)
[351.057656] Starting dynamic subtest: vcs0
[351.059603] Dynamic subtest vcs0: SUCCESS (0.002s)
[351.070341] Starting dynamic subtest: vcs1
[351.072264] Dynamic subtest vcs1: SUCCESS (0.002s)
[351.083057] Starting dynamic subtest: vecs0
[351.084980] Dynamic subtest vecs0: SUCCESS (0.003s)
[351.096438] Starting dynamic subtest: ccs0
[351.098732] Dynamic subtest ccs0: SUCCESS (0.002s)
[351.100713] Subtest resubmit-all: SUCCESS (0.031s)
[352.363242] [114/132] (676s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[352.422409] Starting subtest: invalid-multi-wait-all-unsubmitted
[352.424845] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[352.547439] [115/132] (676s left) gem_userptr_blits (create-destroy-unsync)
[352.606813] Subtest create-destroy-unsync: SKIP (0.000s)
[352.725435] [116/132] (675s left) gem_softpin (softpin)
[352.782520] Starting subtest: softpin
[385.113108] Subtest softpin: SUCCESS (32.324s)
[385.241879] [117/132] (643s left) syncobj_wait (multi-wait-for-submit-signaled)
[385.296810] Starting subtest: multi-wait-for-submit-signaled
[385.299257] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[385.416702] [118/132] (643s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[385.477153] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[385.547185] [119/132] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[385.645625] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[385.650093] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[385.764938] [120/132] (643s left) kms_vblank (ts-continuation-dpms-rpm)
[385.865109] Starting subtest: ts-continuation-dpms-rpm
[385.866964] Starting dynamic subtest: pipe-A-eDP-1
[388.337734] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.471s)
[388.358917] Starting dynamic subtest: pipe-D-eDP-1
[390.585350] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.247s)
[390.587809] Subtest ts-continuation-dpms-rpm: SUCCESS (4.722s)
[391.387926] [121/132] (637s left) syncobj_wait (wait-for-submit-delayed-submit)
[391.441240] Starting subtest: wait-for-submit-delayed-submit
[391.543418] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[391.622607] [122/132] (637s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[391.720246] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[391.722563] Starting dynamic subtest: pipe-A-eDP-1
[391.744946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[391.761838] Starting dynamic subtest: pipe-B-eDP-1
[391.783770] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[391.794611] Starting dynamic subtest: pipe-C-eDP-1
[391.816405] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[391.827513] Starting dynamic subtest: pipe-D-eDP-1
[391.849419] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[391.853877] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[394.051686] [123/132] (634s left) sysfs_heartbeat_interval (nopreempt)
[394.117728] Starting subtest: nopreempt
[394.120110] Starting dynamic subtest: vecs0
[403.322957] Dynamic subtest vecs0: SUCCESS (9.201s)
[403.337183] Starting dynamic subtest: ccs0
[407.422210] Dynamic subtest ccs0: SUCCESS (4.100s)
[407.436498] Starting dynamic subtest: vcs0
[417.277056] Dynamic subtest vcs0: SUCCESS (9.850s)
[417.289978] Starting dynamic subtest: bcs0
[421.266935] Dynamic subtest bcs0: SUCCESS (3.990s)
[421.281499] Starting dynamic subtest: rcs0
[425.384076] Dynamic subtest rcs0: SUCCESS (4.115s)
[425.397500] Starting dynamic subtest: vcs1
[435.332159] Dynamic subtest vcs1: SUCCESS (9.947s)
[435.334731] Subtest nopreempt: SUCCESS (41.213s)
[435.429074] [124/132] (593s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[435.529663] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[439.993831] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.468s)
[441.150214] [125/132] (587s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[441.252206] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[445.509209] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.261s)
[446.634750] [126/132] (582s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[446.732823] Starting subtest: 2x-plain-flip-ts-check-interruptible
[446.745091] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[446.825030] [127/132] (582s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[446.931167] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[453.832145] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.906s)
[453.947231] [128/132] (575s left) gem_busy (close-race)
[454.020060] Starting subtest: close-race
[477.311057] Subtest close-race: SUCCESS (23.288s)
[477.707452] [129/132] (551s left) gem_exec_balancer (noheartbeat)
[478.009046] Starting subtest: noheartbeat
[478.014144] Subtest noheartbeat: SKIP (0.000s)
[478.124940] [130/132] (551s left) gem_exec_reloc (basic-write-cpu-active)
[478.195470] Subtest basic-write-cpu-active: SKIP (0.000s)
[478.284732] [131/132] (551s left) kms_addfb_basic (too-wide)
[478.389868] Starting subtest: too-wide
[478.392120] Subtest too-wide: SUCCESS (0.000s)
[478.490278] [132/132] (550s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[478.608451] Starting subtest: cursorB-vs-flipB-varying-size
[478.612999] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[478.753653] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_exec_capture
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: kms_busy
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: gem_partial_pwrite_pread
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: i915_pm_freq_api
results: parsing output: 26/ for test: gen3_mixed_blits
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: dmabuf
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: kms_plane_alpha_blend
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_sync
results: parsing output: 45/ for test: gem_exec_suspend
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_gttfill
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pwrite_crc
results: parsing output: 58/ for test: kms_vrr
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: kms_draw_crc
results: parsing output: 62/ for test: gen7_exec_parse
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_create
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: gem_gtt_cpu_tlb
results: parsing output: 73/ for test: sw_sync
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: prime_mmap
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: i915_pm_rps
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_exec_whisper
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_pm_dc
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_busy
results: parsing output: 94/ for test: gem_mmap
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_plane_lowres
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: prime_vgem
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: kms_rotation_crc
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_chamelium_frames
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: gem_tiled_pread_basic
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_spin_batch
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: sysfs_heartbeat_interval
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_busy
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: kms_cursor_legacy
Done.