[58.647301] Initializing watchdogs
[58.647344]   /dev/watchdog0
[58.661889] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.666633] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.668901] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.672282] [001/132] (960s left) kms_addfb_basic (bad-pitch-256)
[58.748587] Starting subtest: bad-pitch-256
[58.750809] Subtest bad-pitch-256: SUCCESS (0.000s)
[58.891806] [002/132] (960s left) gem_ctx_shared (create-shared-gtt)
[58.962074] Starting subtest: create-shared-gtt
[61.106950] Subtest create-shared-gtt: SUCCESS (2.151s)
[61.449247] [003/132] (957s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[61.568994] Starting subtest: basic-busy-flip-before-cursor-legacy
[61.573667] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[61.707761] [004/132] (957s left) kms_joiner (invalid-modeset-big-joiner)
[61.821071] Starting subtest: invalid-modeset-big-joiner
[61.825262] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[61.893154] [005/132] (957s left) prime_mmap (test_forked)
[61.948780] Starting subtest: test_forked
[61.950755] Starting dynamic subtest: test_forked-smem
[61.986860] Dynamic subtest test_forked-smem: SUCCESS (0.040s)
[61.989316] Subtest test_forked: SUCCESS (0.041s)
[62.106067] [006/132] (957s left) gem_exec_whisper (basic-fds-all)
[62.168519] Starting subtest: basic-fds-all
[74.274027] Subtest basic-fds-all: SUCCESS (12.119s)
[74.473032] [007/132] (944s left) kms_rotation_crc (primary-rotation-180)
[74.562991] Starting subtest: primary-rotation-180
[81.607279] Subtest primary-rotation-180: SUCCESS (7.049s)
[82.800681] [008/132] (936s left) gem_exec_create (basic)
[82.865609] Starting subtest: basic
[82.868083] Starting dynamic subtest: smem
[86.274825] Dynamic subtest smem: SUCCESS (3.407s)
[86.277749] Subtest basic: SUCCESS (3.408s)
[86.454119] [009/132] (933s left) kms_psr (psr2-primary-blt)
[86.551074] Starting subtest: psr2-primary-blt
[86.553499] Starting dynamic subtest: eDP-1
[88.292916] Dynamic subtest eDP-1: SUCCESS (1.742s)
[88.295188] Subtest psr2-primary-blt: SUCCESS (1.743s)
[89.192881] [010/132] (930s left) kms_vrr (lobf)
[89.288118] Starting subtest: lobf
[89.292461] Subtest lobf: SKIP (0.000s)
[89.381455] [011/132] (930s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[89.487883] Starting subtest: yf-tiled-64bpp-rotate-90
[89.492253] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[89.591710] [012/132] (930s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[89.696632] Starting subtest: fbcpsr-tiling-y
[89.701600] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[89.793896] [013/132] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[89.891271] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[89.895436] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[90.003053] [014/132] (929s left) perf_pmu (init-busy)
[90.042981] Starting subtest: init-busy
[90.045345] Starting dynamic subtest: rcs0
[90.047651] Dynamic subtest rcs0: SUCCESS (0.002s)
[90.056462] Starting dynamic subtest: bcs0
[90.058360] Dynamic subtest bcs0: SUCCESS (0.001s)
[90.066218] Starting dynamic subtest: vcs0
[90.068073] Dynamic subtest vcs0: SUCCESS (0.001s)
[90.075686] Starting dynamic subtest: vcs1
[90.077629] Dynamic subtest vcs1: SUCCESS (0.001s)
[90.085469] Starting dynamic subtest: vecs0
[90.087357] Dynamic subtest vecs0: SUCCESS (0.001s)
[90.095296] Starting dynamic subtest: ccs0
[90.097089] Dynamic subtest ccs0: SUCCESS (0.000s)
[90.098887] Subtest init-busy: SUCCESS (0.006s)
[90.157933] [015/132] (929s left) gen7_exec_parse (chained-batch)
[90.210494] Subtest chained-batch: SKIP (0.000s)
[90.275357] [016/132] (929s left) device_reset (unbind-reset-rebind)
[90.321816] Starting subtest: unbind-reset-rebind
[95.326062] Subtest unbind-reset-rebind: SUCCESS (5.001s)
[95.363127] [017/132] (924s left) core_setmaster_vs_auth
[95.527334] [018/132] (924s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[95.630641] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[95.635092] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[95.730995] [019/132] (924s left) kms_flip (wf_vblank-ts-check)
[95.819212] Starting subtest: wf_vblank-ts-check
[95.821556] Starting dynamic subtest: A-eDP1
[104.817523] Dynamic subtest A-eDP1: SUCCESS (8.997s)
[104.827840] Starting dynamic subtest: B-eDP1
[113.748948] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[113.758329] Starting dynamic subtest: C-eDP1
[122.664699] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[122.673873] Starting dynamic subtest: D-eDP1
[131.592485] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[131.595071] Subtest wf_vblank-ts-check: SUCCESS (35.775s)
[132.835200] [020/132] (887s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[132.933289] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[132.937276] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[133.040927] [021/132] (886s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[133.131150] Starting subtest: fbc-psr-cursor-mmap-cpu
[133.133512] Starting dynamic subtest: eDP-1
[133.137935] Dynamic subtest eDP-1: SKIP (0.000s)
[133.142492] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[133.204285] [022/132] (886s left) syncobj_timeline (single-wait-available-submitted)
[133.252037] Starting subtest: single-wait-available-submitted
[133.254288] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[133.345807] [023/132] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[133.446288] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[137.724670] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.284s)
[138.927975] [024/132] (881s left) gem_render_copy (yf-tiled)
[138.982380] Starting subtest: yf-tiled
[138.986709] Subtest yf-tiled: SKIP (0.000s)
[139.174988] [025/132] (880s left) gem_exec_fence (parallel)
[139.342664] Starting subtest: parallel
[139.345122] Starting dynamic subtest: rcs0
[141.493456] Dynamic subtest rcs0: SUCCESS (2.154s)
[141.505174] Starting dynamic subtest: bcs0
[143.648177] Dynamic subtest bcs0: SUCCESS (2.154s)
[143.660433] Starting dynamic subtest: vcs0
[145.800985] Dynamic subtest vcs0: SUCCESS (2.152s)
[145.813842] Starting dynamic subtest: vcs1
[147.957112] Dynamic subtest vcs1: SUCCESS (2.156s)
[147.966693] Starting dynamic subtest: vecs0
[150.105594] Dynamic subtest vecs0: SUCCESS (2.148s)
[150.115456] Starting dynamic subtest: ccs0
[152.258135] Dynamic subtest ccs0: SUCCESS (2.152s)
[152.260201] Subtest parallel: SUCCESS (12.919s)
[153.366078] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[153.377255] [026/132] (866s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[153.486566] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[153.490631] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[153.577795] [027/132] (866s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[153.678185] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[153.704593] Starting dynamic subtest: pipe-A-plane-0
[153.982597] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s)
[153.993504] Starting dynamic subtest: pipe-A-plane-3
[154.193799] Dynamic subtest pipe-A-plane-3: SUCCESS (0.211s)
[155.301917] Starting dynamic subtest: pipe-B-plane-0
[155.585247] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[155.596565] Starting dynamic subtest: pipe-B-plane-3
[155.793220] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[156.104562] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.427s)
[156.973648] [028/132] (863s left) gem_eio (in-flight-10ms)
[157.203778] Starting subtest: in-flight-10ms
[166.252722] Subtest in-flight-10ms: SUCCESS (9.049s)
[166.425130] [029/132] (853s left) kms_big_fb (linear-8bpp-rotate-0)
[166.532898] Starting subtest: linear-8bpp-rotate-0
[167.804407] Subtest linear-8bpp-rotate-0: SUCCESS (1.272s)
[167.927894] [030/132] (852s left) kms_sequence (get-forked-busy)
[168.030769] Starting subtest: get-forked-busy
[168.032660] Starting dynamic subtest: pipe-A-eDP-1
[169.944935] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.914s)
[169.955779] Starting dynamic subtest: pipe-B-eDP-1
[172.550342] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.603s)
[172.560971] Starting dynamic subtest: pipe-C-eDP-1
[175.174291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.625s)
[175.185931] Starting dynamic subtest: pipe-D-eDP-1
[177.719132] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[177.721114] Subtest get-forked-busy: SUCCESS (9.687s)
[178.515693] [031/132] (841s left) gem_exec_schedule (smoketest-all)
[178.582650] Starting subtest: smoketest-all
[210.953380] Subtest smoketest-all: SUCCESS (32.326s)
[212.387643] [032/132] (808s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[212.487073] Starting subtest: read-crc-frame-sequence
[212.489080] Starting dynamic subtest: pipe-A-eDP-1
[213.207432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[213.218847] Starting dynamic subtest: pipe-B-eDP-1
[214.574213] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.361s)
[214.585071] Starting dynamic subtest: pipe-C-eDP-1
[215.874770] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s)
[215.885798] Starting dynamic subtest: pipe-D-eDP-1
[217.200728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[217.203138] Subtest read-crc-frame-sequence: SUCCESS (4.715s)
[218.033635] [033/132] (802s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[218.130568] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[218.132558] Starting dynamic subtest: pipe-A-eDP-1
[218.849341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[218.861116] Starting dynamic subtest: pipe-B-eDP-1
[220.646471] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.796s)
[220.657195] Starting dynamic subtest: pipe-C-eDP-1
[222.397330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.750s)
[222.410275] Starting dynamic subtest: pipe-D-eDP-1
[224.138949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.741s)
[224.141272] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.003s)
[225.305080] [034/132] (795s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[225.356120] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[225.358493] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[225.450094] [035/132] (795s left) gem_flink_basic (basic)
[225.503816] Starting subtest: basic
[225.506236] Subtest basic: SUCCESS (0.000s)
[225.622292] [036/132] (795s left) kms_content_protection (atomic-dpms)
[225.769342] Starting subtest: atomic-dpms
[225.773462] Subtest atomic-dpms: SKIP (0.000s)
[225.897089] [037/132] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[225.986687] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[225.990766] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[226.082389] [038/132] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[226.179652] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[226.183841] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[226.272751] [039/132] (794s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[226.370468] Starting subtest: drrs-dirtyfb-ioctl
[226.381943] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[226.473133] [040/132] (794s left) gem_exec_params (invalid-ring)
[226.532614] Starting subtest: invalid-ring
[226.534344] Subtest invalid-ring: SUCCESS (0.000s)
[226.645013] [041/132] (794s left) perf (low-oa-exponent-permissions)
[226.770495] Starting subtest: low-oa-exponent-permissions
[226.804554] Subtest low-oa-exponent-permissions: SUCCESS (0.035s)
[226.853954] [042/132] (794s left) gem_ctx_sseu (engines)
[226.913209] Subtest engines: SKIP (0.000s)
[226.977387] [043/132] (793s left) kms_cursor_crc (cursor-onscreen-64x21)
[227.160941] Starting subtest: cursor-onscreen-64x21
[227.207648] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[227.460658] [044/132] (793s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[227.551546] Starting subtest: bad-rotation-90-y-tiled-ccs
[227.553311] Starting dynamic subtest: pipe-A-eDP-1
[227.573531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[227.583696] Starting dynamic subtest: pipe-B-eDP-1
[227.601240] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[227.610305] Starting dynamic subtest: pipe-C-eDP-1
[227.627721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[227.636842] Starting dynamic subtest: pipe-D-eDP-1
[227.654969] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[227.658403] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[229.856859] [045/132] (791s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[229.977883] Starting subtest: cursorB-vs-flipB-legacy
[229.982474] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[230.136273] [046/132] (790s left) sw_sync (sync_random_merge)
[230.175788] Starting subtest: sync_random_merge
[230.218185] Subtest sync_random_merge: SUCCESS (0.045s)
[230.294149] [047/132] (790s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[230.347749] Starting subtest: etime-multi-wait-all-available-unsubmitted
[230.453730] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[230.546540] [048/132] (790s left) kms_flip (2x-plain-flip)
[230.648332] Starting subtest: 2x-plain-flip
[230.659387] Subtest 2x-plain-flip: SKIP (0.010s)
[230.753882] [049/132] (790s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[230.842996] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[230.847533] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[230.925568] [050/132] (790s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[231.305603] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[232.099558] [051/132] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[232.210854] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[239.540791] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.333s)
[239.678324] [052/132] (781s left) gem_lmem_swapping (parallel-multi)
[239.719707] Subtest parallel-multi: SKIP (0.000s)
[239.761869] [053/132] (781s left) gem_workarounds (reset)
[239.828499] Starting subtest: reset
[240.013177] Subtest reset: SUCCESS (0.184s)
[240.142800] [054/132] (781s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[240.266728] Starting subtest: flip-vs-cursor-varying-size
[249.251313] Subtest flip-vs-cursor-varying-size: SUCCESS (8.982s)
[250.062312] [055/132] (771s left) i915_hangman (engine-error-state-capture)
[250.127346] Starting subtest: engine-error-state-capture
[250.129757] Starting dynamic subtest: rcs0
[253.280533] Dynamic subtest rcs0: SUCCESS (3.153s)
[253.293948] Starting dynamic subtest: bcs0
[259.295028] Dynamic subtest bcs0: SUCCESS (6.013s)
[259.307582] Starting dynamic subtest: vcs0
[265.183494] Dynamic subtest vcs0: SUCCESS (5.885s)
[265.196468] Starting dynamic subtest: vcs1
[270.240415] Dynamic subtest vcs1: SUCCESS (5.054s)
[270.253102] Starting dynamic subtest: vecs0
[276.193305] Dynamic subtest vecs0: SUCCESS (5.950s)
[276.206537] Starting dynamic subtest: ccs0
[281.246921] Dynamic subtest ccs0: SUCCESS (5.051s)
[281.250062] Subtest engine-error-state-capture: SUCCESS (31.123s)
[281.333181] [056/132] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[281.445279] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[281.449541] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[281.558076] [057/132] (739s left) kms_draw_crc (draw-method-mmap-gtt)
[281.650798] Starting subtest: draw-method-mmap-gtt
[281.655492] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[281.746556] [058/132] (739s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[281.835321] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[281.837654] Starting dynamic subtest: pipe-A-eDP-1
[281.863055] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.875595] Starting dynamic subtest: pipe-B-eDP-1
[281.899575] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.909967] Starting dynamic subtest: pipe-C-eDP-1
[281.933971] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.943654] Starting dynamic subtest: pipe-D-eDP-1
[281.968109] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.972182] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[284.105796] [059/132] (737s left) kms_cursor_edge_walk (64x64-top-edge)
[284.188127] Starting subtest: 64x64-top-edge
[284.190268] Starting dynamic subtest: pipe-A-eDP-1
[287.674474] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[287.685551] Starting dynamic subtest: pipe-D-eDP-1
[290.780494] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.104s)
[290.782706] Subtest 64x64-top-edge: SUCCESS (6.593s)
[291.596642] [060/132] (730s left) gem_exec_balancer (full-pulse)
[291.666184] Starting subtest: full-pulse
[296.180093] Subtest full-pulse: SUCCESS (4.513s)
[296.513129] [061/132] (725s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[296.620919] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[297.656676] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.036s)
[297.782588] [062/132] (723s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[297.886371] Starting subtest: basic-modeset-with-all-modifiers-formats
[298.264474] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[299.078098] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.815s)
[299.089285] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[299.100055] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[299.109599] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[299.122263] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[299.134966] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[299.277781] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[299.289356] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[299.300040] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[299.309730] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[299.322223] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[299.333295] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[299.344267] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[299.354232] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[299.366567] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[299.376638] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[299.388787] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[299.398623] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[299.411074] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[299.421109] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[299.433234] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[299.442596] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[299.455539] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[299.465259] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[299.611106] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[299.620934] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[299.633395] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[299.644106] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[299.655717] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[299.665811] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[299.678032] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[299.689975] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[299.700105] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[299.710137] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[299.722270] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[299.732266] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[299.744463] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[299.754551] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[299.767041] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[299.778726] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[299.788969] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.020s)
[299.798569] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[299.956079] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[299.966776] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[299.978292] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[299.989068] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[300.000337] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[300.010355] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[300.023035] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[300.036593] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[300.045161] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[300.055205] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[300.066748] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[300.076282] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[300.089959] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[300.105930] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[300.111162] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[300.120721] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[300.133447] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[300.513918] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.627s)
[301.364131] [063/132] (720s left) api_intel_bb (reset-bb)
[301.412123] Starting subtest: reset-bb
[301.414474] Subtest reset-bb: SUCCESS (0.004s)
[301.533874] [064/132] (720s left) kms_hdr (invalid-hdr)
[301.618990] Starting subtest: invalid-hdr
[301.621132] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[306.767992] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.144s)
[306.784847] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[310.759218] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (3.976s)
[310.768841] Subtest invalid-hdr: SUCCESS (9.151s)
[310.904191] [065/132] (710s left) kms_properties (colorop-properties-atomic)
[311.005209] Starting subtest: colorop-properties-atomic
[311.007476] Starting dynamic subtest: pipe-A-eDP-1
[312.375237] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.371s)
[312.386584] Starting dynamic subtest: pipe-B-eDP-1
[313.419613] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s)
[313.429838] Starting dynamic subtest: pipe-C-eDP-1
[314.458993] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.039s)
[314.472758] Starting dynamic subtest: pipe-D-eDP-1
[315.496965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.036s)
[315.499026] Subtest colorop-properties-atomic: SUCCESS (4.491s)
[316.298919] [066/132] (705s left) i915_drm_fdinfo (busy)
[316.338258] Starting subtest: busy
[316.340585] Starting dynamic subtest: rcs0
[316.353765] Dynamic subtest rcs0: SKIP (0.014s)
[316.364862] Starting dynamic subtest: bcs0
[316.369516] Dynamic subtest bcs0: SKIP (0.009s)
[316.379126] Starting dynamic subtest: vcs0
[316.383803] Dynamic subtest vcs0: SKIP (0.001s)
[316.393775] Starting dynamic subtest: vcs1
[316.398223] Dynamic subtest vcs1: SKIP (0.000s)
[316.407449] Starting dynamic subtest: vecs0
[316.411920] Dynamic subtest vecs0: SKIP (0.000s)
[316.421241] Starting dynamic subtest: ccs0
[316.425678] Dynamic subtest ccs0: SKIP (0.000s)
[316.430140] Subtest busy: SKIP (0.030s)
[316.468199] [067/132] (705s left) kms_psr (fbc-psr2-cursor-blt)
[316.561118] Starting subtest: fbc-psr2-cursor-blt
[316.563361] Starting dynamic subtest: eDP-1
[316.567483] Dynamic subtest eDP-1: SKIP (0.000s)
[316.571624] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[316.632931] [068/132] (705s left) gem_exec_params (invalid-ring2)
[316.689986] Starting subtest: invalid-ring2
[316.692239] Subtest invalid-ring2: SUCCESS (0.000s)
[316.792637] [069/132] (705s left) gem_spin_batch (user-each)
[316.848878] Starting subtest: user-each
[320.213863] Subtest user-each: SUCCESS (3.358s)
[320.397745] [070/132] (701s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[320.507876] Starting subtest: fbc-pr-cursor-mmap-cpu
[320.512386] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[320.582606] [071/132] (701s left) gem_render_tiled_blits (basic)
[320.642060] Subtest basic: SKIP (0.000s)
[320.724352] [072/132] (701s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[320.827865] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[320.832421] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[320.939696] [073/132] (701s left) gem_mmap (bad-offset)
[320.995927] Subtest bad-offset: SKIP (0.000s)
[321.059603] [074/132] (701s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[321.148163] Starting subtest: plane-downscale-factor-0-75-with-rotation
[321.150460] Starting dynamic subtest: pipe-A
[321.387066] Dynamic subtest pipe-A: SUCCESS (0.242s)
[321.396873] Starting dynamic subtest: pipe-B
[322.686064] Dynamic subtest pipe-B: SUCCESS (1.298s)
[322.696195] Starting dynamic subtest: pipe-C
[324.015639] Dynamic subtest pipe-C: SUCCESS (1.329s)
[324.026917] Starting dynamic subtest: pipe-D
[325.328861] Dynamic subtest pipe-D: SUCCESS (1.312s)
[325.331067] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.185s)
[326.508426] [075/132] (695s left) perf (rc6-disable)
[326.609527] Starting subtest: rc6-disable
[326.797781] Subtest rc6-disable: SUCCESS (0.188s)
[326.850708] [076/132] (695s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[326.948109] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[326.950318] Starting dynamic subtest: pipe-A-eDP-1
[326.972285] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.983722] Starting dynamic subtest: pipe-B-eDP-1
[327.004502] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.014276] Starting dynamic subtest: pipe-C-eDP-1
[327.035997] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.045406] Starting dynamic subtest: pipe-D-eDP-1
[327.068062] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.072395] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[329.268915] [077/132] (693s left) kms_addfb_basic (bad-pitch-0)
[329.326061] Starting subtest: bad-pitch-0
[329.328336] Subtest bad-pitch-0: SUCCESS (0.000s)
[329.468168] [078/132] (692s left) sriov_basic (enable-vfs-bind-unbind-each)
[329.525481] Starting subtest: enable-vfs-bind-unbind-each
[329.527878] Starting dynamic subtest: numvfs-1
[329.599037] Dynamic subtest numvfs-1: FAIL (0.013s)
[329.609099] Starting dynamic subtest: numvfs-2
[329.684566] Dynamic subtest numvfs-2: FAIL (0.006s)
[329.696308] Starting dynamic subtest: numvfs-3
[329.770612] Dynamic subtest numvfs-3: FAIL (0.004s)
[329.782421] Starting dynamic subtest: numvfs-4
[329.851912] Dynamic subtest numvfs-4: FAIL (0.004s)
[329.862258] Starting dynamic subtest: numvfs-5
[329.931385] Dynamic subtest numvfs-5: FAIL (0.004s)
[329.941300] Starting dynamic subtest: numvfs-6
[330.011180] Dynamic subtest numvfs-6: FAIL (0.003s)
[330.021642] Starting dynamic subtest: numvfs-7
[330.090709] Dynamic subtest numvfs-7: FAIL (0.004s)
[330.100747] Starting dynamic subtest: numvfs-random
[330.174730] Dynamic subtest numvfs-random: FAIL (0.004s)
[330.176823] Subtest enable-vfs-bind-unbind-each: FAIL (0.048s)
[330.217144] [079/132] (692s left) kms_properties (connector-properties-legacy)
[330.317321] Starting subtest: connector-properties-legacy
[330.319271] Starting dynamic subtest: pipe-A-eDP-1
[338.235485] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.917s)
[338.246323] Starting dynamic subtest: pipe-None-DP-1
[338.250792] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[338.260433] Starting dynamic subtest: pipe-None-HDMI-A-1
[338.264775] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[338.274401] Starting dynamic subtest: pipe-None-DP-2
[338.278598] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[338.288512] Starting dynamic subtest: pipe-None-HDMI-A-2
[338.292762] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[338.302593] Starting dynamic subtest: pipe-None-DP-3
[338.306877] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[338.316465] Starting dynamic subtest: pipe-None-DP-4
[338.320833] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[338.322636] Subtest connector-properties-legacy: SUCCESS (7.928s)
[339.109894] [080/132] (683s left) kms_async_flips (invalid-async-flip)
[339.208194] Starting subtest: invalid-async-flip
[339.590300] Starting dynamic subtest: pipe-A-eDP-1
[340.441676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[340.807539] Starting dynamic subtest: pipe-B-eDP-1
[341.576358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[341.935459] Starting dynamic subtest: pipe-C-eDP-1
[342.696445] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[343.051612] Starting dynamic subtest: pipe-D-eDP-1
[343.839649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.799s)
[343.841896] Subtest invalid-async-flip: SUCCESS (4.634s)
[345.002764] [081/132] (677s left) vgem_basic (bad-fence)
[345.054747] Starting subtest: bad-fence
[345.056705] Subtest bad-fence: SUCCESS (0.000s)
[345.125235] [082/132] (677s left) gem_ctx_persistence (engines-hostile)
[345.191552] Starting subtest: engines-hostile
[345.194067] Starting dynamic subtest: rcs0
[345.327397] Dynamic subtest rcs0: SUCCESS (0.135s)
[345.340459] Starting dynamic subtest: bcs0
[345.429255] Dynamic subtest bcs0: SUCCESS (0.099s)
[345.441062] Starting dynamic subtest: vcs0
[345.526878] Dynamic subtest vcs0: SUCCESS (0.096s)
[345.538043] Starting dynamic subtest: vcs1
[345.634719] Dynamic subtest vcs1: SUCCESS (0.106s)
[345.646724] Starting dynamic subtest: vecs0
[345.726198] Dynamic subtest vecs0: SUCCESS (0.089s)
[345.739102] Starting dynamic subtest: ccs0
[345.816303] Dynamic subtest ccs0: SUCCESS (0.088s)
[345.819037] Subtest engines-hostile: SUCCESS (0.625s)
[345.909362] [083/132] (676s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[345.963527] Subtest no-spare-fences-busy: SKIP (0.000s)
[346.035463] [084/132] (676s left) gem_mmap (pf-nonblock)
[346.085547] Subtest pf-nonblock: SKIP (0.000s)
[346.149575] [085/132] (676s left) gem_exec_schedule (preempt-contexts)
[346.221080] Starting subtest: preempt-contexts
[346.222977] Starting dynamic subtest: rcs0
[346.275550] Dynamic subtest rcs0: SUCCESS (0.060s)
[346.286618] Starting dynamic subtest: bcs0
[346.335640] Dynamic subtest bcs0: SUCCESS (0.058s)
[346.352185] Starting dynamic subtest: vcs0
[346.381817] Dynamic subtest vcs0: SUCCESS (0.045s)
[346.393120] Starting dynamic subtest: vcs1
[346.429098] Dynamic subtest vcs1: SUCCESS (0.047s)
[346.439695] Starting dynamic subtest: vecs0
[346.472438] Dynamic subtest vecs0: SUCCESS (0.043s)
[346.483904] Starting dynamic subtest: ccs0
[346.532305] Dynamic subtest ccs0: SUCCESS (0.059s)
[346.534196] Subtest preempt-contexts: SUCCESS (0.317s)
[348.412914] [086/132] (674s left) kms_psr (psr2-cursor-blt)
[348.507189] Starting subtest: psr2-cursor-blt
[348.509428] Starting dynamic subtest: eDP-1
[350.169153] Dynamic subtest eDP-1: SUCCESS (1.661s)
[350.171409] Subtest psr2-cursor-blt: SUCCESS (1.662s)
[350.965346] [087/132] (671s left) kms_color (degamma)
[351.062204] Starting subtest: degamma
[351.064426] Starting dynamic subtest: pipe-A-eDP-1
[351.780543] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[351.792909] Starting dynamic subtest: pipe-B-eDP-1
[353.175639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s)
[353.189281] Starting dynamic subtest: pipe-C-eDP-1
[354.556026] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[354.567992] Starting dynamic subtest: pipe-D-eDP-1
[355.886554] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[355.888782] Subtest degamma: SUCCESS (4.825s)
[356.689999] [088/132] (666s left) kms_vblank (query-forked-hang)
[356.786329] Starting subtest: query-forked-hang
[356.788605] Starting dynamic subtest: pipe-A-eDP-1
[363.727431] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.940s)
[363.744007] Starting dynamic subtest: pipe-D-eDP-1
[370.766197] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.036s)
[370.768087] Subtest query-forked-hang: SUCCESS (13.980s)
[371.564922] [089/132] (651s left) gem_exec_balancer (waits)
[371.621720] Starting subtest: waits
[378.175661] Subtest waits: SUCCESS (6.548s)
[378.469879] [090/132] (644s left) gem_sync (basic-all)
[378.537612] Starting subtest: basic-all
[382.255130] Subtest basic-all: SUCCESS (3.727s)
[382.446328] [091/132] (640s left) api_intel_bb (blit-reloc-keep-cache)
[382.506169] Starting subtest: blit-reloc-keep-cache
[382.510459] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[382.646332] [092/132] (640s left) gem_softpin (32b-excludes-last-page)
[382.703504] Starting subtest: 32b-excludes-last-page
[382.710238] Subtest 32b-excludes-last-page: SUCCESS (0.007s)
[382.844187] [093/132] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[382.935507] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[390.241234] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.310s)
[390.377537] [094/132] (632s left) fbdev (pan)
[390.411057] Starting subtest: pan
[390.437916] Subtest pan: SUCCESS (0.027s)
[390.524035] [095/132] (632s left) gem_fence_thrash (bo-write-verify-threaded-none)
[390.555381] Starting subtest: bo-write-verify-threaded-none
[390.579882] Subtest bo-write-verify-threaded-none: SKIP (0.021s)
[390.650273] [096/132] (632s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[390.750244] Starting subtest: primary-y-tiled-reflect-x-180
[390.823555] Subtest primary-y-tiled-reflect-x-180: SKIP (0.072s)
[390.928429] [097/132] (632s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[391.027457] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[391.031722] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[391.131651] [098/132] (632s left) kms_psr (psr-sprite-plane-move)
[391.223690] Starting subtest: psr-sprite-plane-move
[391.225503] Starting dynamic subtest: eDP-1
[393.023845] Dynamic subtest eDP-1: SUCCESS (1.801s)
[393.026306] Subtest psr-sprite-plane-move: SUCCESS (1.802s)
[393.879135] [099/132] (629s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[393.940140] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[393.942476] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[394.062365] [100/132] (629s left) gem_exec_fence (syncobj-timeline-wait)
[394.649858] Starting subtest: syncobj-timeline-wait
[396.320082] Subtest syncobj-timeline-wait: SUCCESS (1.674s)
[398.360564] [101/132] (625s left) gem_exec_schedule (semaphore-user)
[398.427054] Starting subtest: semaphore-user
[398.484860] Subtest semaphore-user: SUCCESS (0.062s)
[400.367390] [102/132] (623s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[400.461193] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[400.463540] Starting dynamic subtest: pipe-A-eDP-1
[432.488060] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.075s)
[432.499977] Starting dynamic subtest: pipe-B-eDP-1
[465.385427] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.713s)
[465.398281] Starting dynamic subtest: pipe-C-eDP-1
[498.395396] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.615s)
[498.409465] Starting dynamic subtest: pipe-D-eDP-1
[531.360836] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.584s)
[531.363655] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.992s)
[532.612387] [103/132] (490s left) perf_pmu (rc6)
[532.660368] Starting subtest: rc6
[532.663052] Starting dynamic subtest: gt0
[539.062558] Dynamic subtest gt0: SUCCESS (6.361s)
[539.076964] Starting dynamic subtest: runtime-pm-gt0
[546.849567] Dynamic subtest runtime-pm-gt0: SUCCESS (7.762s)
[546.864116] Starting dynamic subtest: runtime-pm-long-gt0
[559.286657] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.420s)
[559.301348] Starting dynamic subtest: other-idle-gt0
[565.633303] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[565.648200] Starting dynamic subtest: gt1
[571.979807] Dynamic subtest gt1: SUCCESS (6.339s)
[571.994893] Starting dynamic subtest: runtime-pm-gt1
[579.431680] Dynamic subtest runtime-pm-gt1: SUCCESS (7.446s)
[579.444606] Starting dynamic subtest: runtime-pm-long-gt1
[591.873437] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.433s)
[591.888307] Starting dynamic subtest: other-idle-gt1
[598.216318] Dynamic subtest other-idle-gt1: SUCCESS (6.404s)
[598.219266] Subtest rc6: SUCCESS (65.527s)
[599.486561] [104/132] (424s left) kms_cursor_crc (cursor-random-256x256)
[599.751426] Starting subtest: cursor-random-256x256
[599.756500] Starting dynamic subtest: pipe-A-eDP-1
[603.117710] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.389s)
[603.147739] Starting dynamic subtest: pipe-D-eDP-1
[607.170390] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.057s)
[607.173060] Subtest cursor-random-256x256: SUCCESS (7.473s)
[607.960041] [105/132] (415s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[608.052898] Starting subtest: y-tiled-16bpp-rotate-180
[608.057908] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[608.119546] [106/132] (415s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[608.237685] Starting subtest: short-flip-after-cursor-atomic-transitions
[609.199246] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.963s)
[609.984824] [107/132] (413s left) kms_chamelium_frames (dp-crc-fast)
[610.386186] Subtest dp-crc-fast: SKIP (0.000s)
[611.212856] [108/132] (412s left) gem_wait (write-wait)
[611.276637] Starting subtest: write-wait
[611.279075] Starting dynamic subtest: all-engines
[612.382786] Dynamic subtest all-engines: SUCCESS (1.112s)
[612.403171] Starting dynamic subtest: rcs0
[613.447067] Dynamic subtest rcs0: SUCCESS (1.064s)
[613.465787] Starting dynamic subtest: bcs0
[614.509871] Dynamic subtest bcs0: SUCCESS (1.063s)
[614.531130] Starting dynamic subtest: vcs0
[615.572102] Dynamic subtest vcs0: SUCCESS (1.061s)
[615.591141] Starting dynamic subtest: vcs1
[616.629929] Dynamic subtest vcs1: SUCCESS (1.058s)
[616.649488] Starting dynamic subtest: vecs0
[617.690269] Dynamic subtest vecs0: SUCCESS (1.059s)
[617.709223] Starting dynamic subtest: ccs0
[618.752563] Dynamic subtest ccs0: SUCCESS (1.061s)
[618.755636] Subtest write-wait: SUCCESS (7.494s)
[618.934735] [109/132] (404s left) kms_plane_cursor (viewport)
[619.038293] Starting subtest: viewport
[619.043569] Starting dynamic subtest: pipe-A-eDP-1-size-64
[621.536880] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.502s)
[621.598815] Starting dynamic subtest: pipe-A-eDP-1-size-128
[624.123738] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.540s)
[624.183706] Starting dynamic subtest: pipe-A-eDP-1-size-256
[626.690359] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[627.043907] Starting dynamic subtest: pipe-B-eDP-1-size-64
[630.195884] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.163s)
[630.257629] Starting dynamic subtest: pipe-B-eDP-1-size-128
[632.786368] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[632.847684] Starting dynamic subtest: pipe-B-eDP-1-size-256
[635.365160] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.526s)
[635.735940] Starting dynamic subtest: pipe-C-eDP-1-size-64
[638.597824] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.878s)
[638.643890] Starting dynamic subtest: pipe-C-eDP-1-size-128
[640.763751] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[640.803212] Starting dynamic subtest: pipe-C-eDP-1-size-256
[642.933585] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.139s)
[643.268079] Starting dynamic subtest: pipe-D-eDP-1-size-64
[646.172815] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.916s)
[646.213617] Starting dynamic subtest: pipe-D-eDP-1-size-128
[648.383296] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[648.426478] Starting dynamic subtest: pipe-D-eDP-1-size-256
[650.663053] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.249s)
[650.987546] Subtest viewport: SUCCESS (31.954s)
[651.825769] [110/132] (371s left) i915_suspend (basic-s2idle-without-i915)
[651.863408] Starting subtest: basic-s2idle-without-i915
[671.589359] Subtest basic-s2idle-without-i915: SUCCESS (4.003s)
[671.736761] [111/132] (352s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[671.821671] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[671.903155] [112/132] (351s left) gem_workarounds (suspend-resume-fd)
[671.964583] Starting subtest: suspend-resume-fd
[688.217612] Subtest suspend-resume-fd: SUCCESS (1.138s)
[688.319323] [113/132] (335s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[688.428453] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[689.478514] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.058s)
[689.580516] [114/132] (334s left) kms_addfb_basic (bo-too-small)
[689.685351] Starting subtest: bo-too-small
[689.687175] Subtest bo-too-small: SUCCESS (0.000s)
[689.757052] [115/132] (334s left) gem_exec_reloc (basic-write-gtt)
[689.812400] Subtest basic-write-gtt: SKIP (0.000s)
[689.896175] [116/132] (334s left) gem_exec_flush (basic-wb-pro-default)
[689.953391] Starting subtest: basic-wb-pro-default
[695.387973] Subtest basic-wb-pro-default: SUCCESS (5.458s)
[695.555837] [117/132] (328s left) gem_ctx_engines (execute-oneforall)
[695.613523] Starting subtest: execute-oneforall
[696.147338] Subtest execute-oneforall: SUCCESS (0.539s)
[697.151011] [118/132] (326s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[697.249689] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[697.254732] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[697.325879] [119/132] (326s left) sw_sync (timeline_closed)
[697.360338] Starting subtest: timeline_closed
[697.362769] Subtest timeline_closed: SUCCESS (0.000s)
[697.403295] [120/132] (326s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[697.494679] Starting subtest: fbcpsr-rgb565-draw-pwrite
[704.638688] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.160s)
[704.731407] [121/132] (319s left) kms_pm_dc (dc5-retention-flops)
[705.824613] Starting subtest: dc5-retention-flops
[705.830231] Subtest dc5-retention-flops: SKIP (0.000s)
[705.876201] [122/132] (318s left) kms_lease (lease-invalid-plane)
[705.956181] Starting subtest: lease-invalid-plane
[705.958441] Starting dynamic subtest: pipe-A-eDP-1
[705.960984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[705.971389] Starting dynamic subtest: pipe-B-eDP-1
[705.973583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[705.984096] Starting dynamic subtest: pipe-C-eDP-1
[705.986596] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[705.996240] Starting dynamic subtest: pipe-D-eDP-1
[705.998575] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[706.000892] Subtest lease-invalid-plane: SUCCESS (0.004s)
[706.041410] [123/132] (318s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[706.133349] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[706.137940] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[706.198840] [124/132] (318s left) sw_sync (sync_busy_fork_unixsocket)
[706.235936] Starting subtest: sync_busy_fork_unixsocket
[706.241421] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[706.284196] [125/132] (318s left) syncobj_timeline (invalid-transfer-non-existent-point)
[706.346581] Starting subtest: invalid-transfer-non-existent-point
[706.349561] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[706.411391] [126/132] (318s left) gem_mmap_offset (pf-nonblock)
[706.476031] Starting subtest: pf-nonblock
[706.482376] Subtest pf-nonblock: SUCCESS (0.010s)
[706.575378] [127/132] (317s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[706.671351] Starting subtest: fbc-indfb-scaledprimary
[709.572904] Subtest fbc-indfb-scaledprimary: SUCCESS (2.910s)
[710.739804] [128/132] (313s left) kms_plane_scaling (planes-upscale-20x20)
[710.826332] Starting subtest: planes-upscale-20x20
[710.829283] Starting dynamic subtest: pipe-A
[710.885660] Dynamic subtest pipe-A: SUCCESS (0.063s)
[710.898003] Starting dynamic subtest: pipe-B
[712.062078] Dynamic subtest pipe-B: SUCCESS (1.176s)
[712.075328] Starting dynamic subtest: pipe-C
[713.164254] Dynamic subtest pipe-C: SUCCESS (1.102s)
[713.175686] Starting dynamic subtest: pipe-D
[714.293376] Dynamic subtest pipe-D: SUCCESS (1.129s)
[714.296366] Subtest planes-upscale-20x20: SUCCESS (3.474s)
[715.426496] [129/132] (309s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[715.528440] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[715.533475] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[715.575555] [130/132] (309s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[715.662428] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[715.665039] Starting dynamic subtest: pipe-A-default-mode
[716.808558] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[716.815485] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.145s)
[716.931883] [131/132] (307s left) kms_flip (2x-flip-vs-panning-vs-hang)
[717.025692] Starting subtest: 2x-flip-vs-panning-vs-hang
[717.030739] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[717.108058] [132/132] (307s left) i915_pm_rpm (debugfs-forcewake-user)
[719.132718] Starting subtest: debugfs-forcewake-user
[730.541220] Subtest debugfs-forcewake-user: SUCCESS (11.313s)
[730.894979] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: gem_ctx_shared
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: prime_mmap
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_rotation_crc
results: parsing output: 7/ for test: gem_exec_create
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_vrr
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gen7_exec_parse
results: parsing output: 15/ for test: device_reset
results: parsing output: 16/ for test: core_setmaster_vs_auth
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_sequence
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_pipe_crc_basic
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_flink_basic
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_dirtyfb
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_ctx_sseu
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: gem_workarounds
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: i915_hangman
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_draw_crc
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_cursor_edge_walk
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_hdr
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: gem_spin_batch
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_render_tiled_blits
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_mmap
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: sriov_basic
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_fenced_exec_thrash
results: parsing output: 83/ for test: gem_mmap
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: kms_vblank
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: fbdev
results: parsing output: 94/ for test: gem_fence_thrash
results: parsing output: 95/ for test: kms_rotation_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_chamelium_frames
results: parsing output: 107/ for test: gem_wait
results: parsing output: 108/ for test: kms_plane_cursor
results: parsing output: 109/ for test: i915_suspend
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_workarounds
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: gem_exec_flush
results: parsing output: 116/ for test: gem_ctx_engines
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sw_sync
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_pm_dc
results: parsing output: 121/ for test: kms_lease
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gem_mmap_offset
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: i915_pm_rpm
Done.