[61.872619] Initializing watchdogs
[61.872668]   /dev/watchdog0
[61.888111] [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]
[61.892620] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.895392] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.898688] [001/133] (960s left) syncobj_timeline (single-wait-all-available-signaled)
[61.972667] Starting subtest: single-wait-all-available-signaled
[61.975261] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[62.068896] [002/133] (960s left) kms_big_fb (4-tiled-addfb)
[62.167309] Starting subtest: 4-tiled-addfb
[62.169141] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[62.263665] [003/133] (960s left) gem_exec_whisper (basic-contexts-all)
[62.345158] Starting subtest: basic-contexts-all
[73.367242] Subtest basic-contexts-all: SUCCESS (11.004s)
[73.545945] [004/133] (948s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[73.665076] Starting subtest: y-tiled-32bpp-rotate-270
[73.669291] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[73.756568] [005/133] (948s left) gem_pwrite (basic-random)
[73.816744] Subtest basic-random: SKIP (0.000s)
[73.869453] [006/133] (948s left) kms_frontbuffer_tracking (fbc-tiling-y)
[73.965610] Starting subtest: fbc-tiling-y
[73.970057] Subtest fbc-tiling-y: SKIP (0.000s)
[74.070211] [007/133] (948s left) dumb_buffer (invalid-bpp)
[74.137038] Starting subtest: invalid-bpp
[74.139826] Subtest invalid-bpp: SUCCESS (0.000s)
[74.239719] [008/133] (948s left) kms_plane_lowres (tiling-none)
[74.330296] Starting subtest: tiling-none
[74.332485] Starting dynamic subtest: pipe-A-eDP-1
[74.336775] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.638053] Starting dynamic subtest: pipe-B-eDP-1
[74.642569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.652428] Starting dynamic subtest: pipe-C-eDP-1
[74.656849] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.665742] Starting dynamic subtest: pipe-D-eDP-1
[74.670373] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.674742] Subtest tiling-none: SKIP (0.305s)
[75.480148] [009/133] (947s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[75.539304] Starting subtest: x-tiled-to-vebox-y-tiled
[75.543869] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[75.719514] [010/133] (947s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[75.776109] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[75.881852] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[75.972264] [011/133] (946s left) kms_cursor_legacy (forked-bo)
[76.092924] Starting subtest: forked-bo
[76.095088] Starting dynamic subtest: pipe-A
[81.601553] Dynamic subtest pipe-A: SUCCESS (5.505s)
[81.615625] Starting dynamic subtest: pipe-B
[87.079356] Dynamic subtest pipe-B: SUCCESS (5.473s)
[87.089486] Starting dynamic subtest: pipe-C
[92.574752] Dynamic subtest pipe-C: SUCCESS (5.492s)
[92.584950] Starting dynamic subtest: pipe-D
[98.118069] Dynamic subtest pipe-D: SUCCESS (5.543s)
[98.129185] Starting dynamic subtest: all-pipes
[103.613048] Dynamic subtest all-pipes: SUCCESS (5.493s)
[103.615388] Subtest forked-bo: SUCCESS (27.511s)
[103.759583] [012/133] (919s left) gem_madvise (dontneed-after-mmap)
[103.805430] Starting subtest: dontneed-after-mmap
[103.824768] Subtest dontneed-after-mmap: SUCCESS (0.021s)
[103.928640] [013/133] (918s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[103.972676] Starting subtest: etime-multi-wait-all-submitted-signaled
[104.081740] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.109s)
[104.155908] [014/133] (918s left) kms_flip (wf_vblank-ts-check-interruptible)
[104.247649] Starting subtest: wf_vblank-ts-check-interruptible
[104.249948] Starting dynamic subtest: A-eDP1
[113.219920] Dynamic subtest A-eDP1: SUCCESS (8.970s)
[113.229121] Starting dynamic subtest: B-eDP1
[122.153529] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[122.162275] Starting dynamic subtest: C-eDP1
[131.063495] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[131.074625] Starting dynamic subtest: D-eDP1
[139.989737] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[139.994893] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.743s)
[141.258906] [015/133] (881s left) gem_spin_batch (spin-each)
[141.330547] Starting subtest: spin-each
[144.595290] Subtest spin-each: SUCCESS (3.262s)
[144.932449] [016/133] (878s left) kms_psr (fbc-psr2-sprite-blt)
[145.028591] Starting subtest: fbc-psr2-sprite-blt
[145.030761] Starting dynamic subtest: eDP-1
[145.034809] Dynamic subtest eDP-1: SKIP (0.000s)
[145.038765] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[145.098168] [017/133] (877s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[145.191770] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[145.220689] Starting dynamic subtest: pipe-A-plane-0
[145.509409] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[145.518876] Starting dynamic subtest: pipe-A-plane-3
[145.742836] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[145.750983] Starting dynamic subtest: pipe-A-plane-5
[145.755461] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[146.813760] Starting dynamic subtest: pipe-B-plane-0
[147.093582] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[147.103371] Starting dynamic subtest: pipe-B-plane-3
[147.337599] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[147.347144] Starting dynamic subtest: pipe-B-plane-5
[147.351317] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[147.651746] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.460s)
[148.493944] [018/133] (874s left) gem_workarounds (reset-context)
[148.560098] Starting subtest: reset-context
[148.720162] Subtest reset-context: SUCCESS (0.160s)
[148.835184] [019/133] (874s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[148.939239] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[148.943094] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[149.007575] [020/133] (874s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[149.105197] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[155.884081] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.781s)
[156.026576] [021/133] (867s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[156.130984] Starting subtest: primary-yf-tiled-reflect-x-0
[156.190447] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[156.291303] [022/133] (866s left) kms_chamelium_color (ctm-0-75)
[156.396341] Subtest ctm-0-75: SKIP (0.000s)
[156.441908] [023/133] (866s left) kms_content_protection (atomic)
[156.580798] Starting subtest: atomic
[156.585290] Subtest atomic: SKIP (0.000s)
[156.704345] [024/133] (866s left) gem_ctx_param (invalid-param-get)
[156.764904] Starting subtest: invalid-param-get
[156.767190] Subtest invalid-param-get: SUCCESS (0.001s)
[156.883151] [025/133] (866s left) syncobj_wait (wait-for-submit-delayed-submit)
[156.939060] Starting subtest: wait-for-submit-delayed-submit
[157.043450] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[157.133045] [026/133] (866s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[157.233183] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[157.235551] Starting dynamic subtest: pipe-A-eDP-1
[157.259160] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[157.270718] Starting dynamic subtest: pipe-B-eDP-1
[157.293158] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[157.301642] Starting dynamic subtest: pipe-C-eDP-1
[157.323306] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[157.331897] Starting dynamic subtest: pipe-D-eDP-1
[157.353668] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[157.358074] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[159.475692] [027/133] (863s left) gem_exec_balancer (semaphore)
[159.552650] Starting subtest: semaphore
[160.919317] Subtest semaphore: SUCCESS (1.365s)
[161.240671] [028/133] (862s left) gem_ctx_persistence (file)
[161.299310] Starting subtest: file
[161.425473] Subtest file: SUCCESS (0.126s)
[161.554421] [029/133] (861s left) kms_async_flips (test-time-stamp-atomic)
[161.651957] Starting subtest: test-time-stamp-atomic
[162.029645] Starting dynamic subtest: pipe-A-eDP-1
[162.795194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s)
[163.174522] Starting dynamic subtest: pipe-B-eDP-1
[163.931520] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[164.307765] Starting dynamic subtest: pipe-C-eDP-1
[165.066632] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[165.429834] Starting dynamic subtest: pipe-D-eDP-1
[166.199662] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[166.202099] Subtest test-time-stamp-atomic: SUCCESS (4.548s)
[167.363588] [030/133] (856s left) kms_plane (planar-pixel-format-settings)
[167.452644] Starting subtest: planar-pixel-format-settings
[167.530964] Subtest planar-pixel-format-settings: SUCCESS (0.077s)
[167.625940] [031/133] (856s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[167.732756] Starting subtest: primary-4-tiled-reflect-x-0
[174.773095] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.041s)
[175.936275] [032/133] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[176.027367] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[176.031491] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[176.121232] [033/133] (847s left) gem_exec_reloc (basic-cpu-gtt)
[176.186645] Subtest basic-cpu-gtt: SKIP (0.000s)
[176.252163] [034/133] (847s left) kms_universal_plane (universal-plane-sanity)
[176.334388] Starting subtest: universal-plane-sanity
[176.336755] Starting dynamic subtest: pipe-A-eDP-1
[176.933099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[176.943349] Starting dynamic subtest: pipe-B-eDP-1
[178.155664] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[178.165889] Starting dynamic subtest: pipe-C-eDP-1
[179.358053] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[179.371214] Starting dynamic subtest: pipe-D-eDP-1
[180.585517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[180.587768] Subtest universal-plane-sanity: SUCCESS (4.249s)
[181.441690] [035/133] (842s left) gem_mmap_offset (mmap-boundaries)
[181.516247] Starting subtest: mmap-boundaries
[181.518710] Starting dynamic subtest: smem0
[181.794383] Dynamic subtest smem0: SUCCESS (0.278s)
[181.797248] Subtest mmap-boundaries: SUCCESS (0.278s)
[181.902195] [036/133] (841s left) gem_wait (busy)
[181.972244] Starting subtest: busy
[181.974700] Starting dynamic subtest: all-engines
[183.893527] Dynamic subtest all-engines: SUCCESS (1.919s)
[183.905703] Starting dynamic subtest: rcs0
[184.436804] Dynamic subtest rcs0: SUCCESS (0.543s)
[184.447877] Starting dynamic subtest: bcs0
[184.978270] Dynamic subtest bcs0: SUCCESS (0.540s)
[184.989408] Starting dynamic subtest: vcs0
[186.903370] Dynamic subtest vcs0: SUCCESS (1.923s)
[186.915236] Starting dynamic subtest: vcs1
[188.885249] Dynamic subtest vcs1: SUCCESS (1.979s)
[188.895850] Starting dynamic subtest: vecs0
[190.933311] Dynamic subtest vecs0: SUCCESS (2.046s)
[190.944048] Starting dynamic subtest: ccs0
[191.474371] Dynamic subtest ccs0: SUCCESS (0.541s)
[191.477159] Subtest busy: SUCCESS (9.502s)
[191.671404] [037/133] (832s left) gem_create (create-valid-nonaligned)
[191.727850] Starting subtest: create-valid-nonaligned
[191.729829] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[191.933852] [038/133] (831s left) gem_media_fill (media-fill)
[192.002946] Subtest media-fill: SKIP (0.000s)
[192.123282] [039/133] (831s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[192.176706] Starting subtest: invalid-multi-wait-all-unsubmitted
[192.179023] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[192.275707] [040/133] (831s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[192.375739] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[192.378070] Starting dynamic subtest: pipe-A-eDP-1
[192.495676] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[192.507274] Starting dynamic subtest: pipe-B-eDP-1
[193.627163] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[193.631812] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.253s)
[194.820289] [041/133] (829s left) gem_create (create-ext-placement-all)
[194.990451] Starting subtest: create-ext-placement-all
[194.993461] Subtest create-ext-placement-all: SUCCESS (0.000s)
[195.089821] [042/133] (828s left) i915_pm_freq_api (freq-reset)
[195.157231] Starting subtest: freq-reset
[195.159482] Starting dynamic subtest: gt0
[195.333339] Dynamic subtest gt0: SUCCESS (0.173s)
[195.342976] Starting dynamic subtest: gt1
[195.485076] Dynamic subtest gt1: SUCCESS (0.151s)
[195.488153] Subtest freq-reset: SUCCESS (0.326s)
[195.562721] [043/133] (828s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[195.659940] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[195.661863] Starting dynamic subtest: pipe-A-eDP-1
[196.573583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.907s)
[196.588248] Starting dynamic subtest: pipe-B-eDP-1
[198.217820] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.642s)
[198.227665] Starting dynamic subtest: pipe-C-eDP-1
[199.782462] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.563s)
[199.791795] Starting dynamic subtest: pipe-D-eDP-1
[201.308509] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[201.310743] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.643s)
[202.554242] [044/133] (821s left) kms_flip (dpms-off-confusion-interruptible)
[202.655151] Starting subtest: dpms-off-confusion-interruptible
[202.657451] Starting dynamic subtest: A-eDP1
[211.344036] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[211.354365] Starting dynamic subtest: B-eDP1
[219.981650] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[219.992539] Starting dynamic subtest: C-eDP1
[228.595602] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[228.605314] Starting dynamic subtest: D-eDP1
[237.230590] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[237.235934] Subtest dpms-off-confusion-interruptible: SUCCESS (34.581s)
[238.395289] [045/133] (785s left) kms_chamelium_edid (hdmi-mode-timings)
[238.779877] Subtest hdmi-mode-timings: SKIP (0.000s)
[239.597790] [046/133] (784s left) gem_exec_reloc (basic-scanout)
[239.669344] Subtest basic-scanout: SKIP (0.000s)
[239.744159] [047/133] (784s left) api_intel_allocator (default-alignment)
[239.803201] Starting subtest: default-alignment
[239.808097] Subtest default-alignment: SUCCESS (0.004s)
[239.933686] [048/133] (784s left) gem_exec_schedule (u-independent)
[240.003477] Starting subtest: u-independent
[240.005777] Starting dynamic subtest: rcs0
[241.877317] Dynamic subtest rcs0: SUCCESS (1.879s)
[241.890027] Starting dynamic subtest: vcs0
[243.937268] Dynamic subtest vcs0: SUCCESS (2.058s)
[243.950199] Starting dynamic subtest: vcs1
[245.921373] Dynamic subtest vcs1: SUCCESS (1.981s)
[245.933117] Starting dynamic subtest: vecs0
[247.899538] Dynamic subtest vecs0: SUCCESS (1.976s)
[247.911469] Starting dynamic subtest: ccs0
[249.941354] Dynamic subtest ccs0: SUCCESS (2.041s)
[249.944064] Subtest u-independent: SUCCESS (9.944s)
[250.247327] [049/133] (774s left) gen7_exec_parse (cmd-crossing-page)
[250.306707] Subtest cmd-crossing-page: SKIP (0.000s)
[250.374053] [050/133] (774s left) kms_vblank (query-idle)
[250.483958] Starting subtest: query-idle
[250.486113] Starting dynamic subtest: pipe-A-eDP-1
[252.226138] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[252.242394] Starting dynamic subtest: pipe-D-eDP-1
[254.664983] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[254.667291] Subtest query-idle: SUCCESS (4.184s)
[255.480072] [051/133] (768s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[255.538742] Starting subtest: y-tiled-to-vebox-x-tiled
[255.542749] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[255.739404] [052/133] (768s left) gem_exec_balancer (hog)
[255.804957] Starting subtest: hog
[255.809499] Subtest hog: SKIP (0.000s)
[256.103577] [053/133] (768s left) kms_atomic_interruptible (legacy-pageflip)
[256.207833] Starting subtest: legacy-pageflip
[256.210211] Starting dynamic subtest: pipe-A-eDP-1
[263.622058] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.411s)
[263.624094] Subtest legacy-pageflip: SUCCESS (7.412s)
[264.437569] [054/133] (760s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[264.531516] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[264.535890] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[264.633939] [055/133] (759s left) gem_exec_params (invalid-flag)
[264.697320] Starting subtest: invalid-flag
[264.699845] Subtest invalid-flag: SUCCESS (0.000s)
[264.799662] [056/133] (759s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[264.896268] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[264.898408] Starting dynamic subtest: A-eDP1
[268.485169] Dynamic subtest A-eDP1: SUCCESS (3.585s)
[268.494949] Starting dynamic subtest: B-eDP1
[271.695227] Dynamic subtest B-eDP1: SUCCESS (3.210s)
[271.704666] Starting dynamic subtest: C-eDP1
[274.785883] Dynamic subtest C-eDP1: SUCCESS (3.089s)
[274.795834] Starting dynamic subtest: D-eDP1
[277.911930] Dynamic subtest D-eDP1: SUCCESS (3.125s)
[277.914326] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.018s)
[278.709830] [057/133] (745s left) gen3_render_mixed_blits
[278.823387] [058/133] (745s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[278.875040] Starting subtest: invalid-smem-bo-on-discrete
[278.879486] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[279.016965] [059/133] (745s left) kms_flip (2x-flip-vs-rmfb)
[279.108757] Starting subtest: 2x-flip-vs-rmfb
[279.120107] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[279.199686] [060/133] (745s left) kms_dsc (dsc-fractional-bpp)
[279.289059] Starting subtest: dsc-fractional-bpp
[279.302415] Subtest dsc-fractional-bpp: SKIP (0.000s)
[279.367593] [061/133] (745s left) i915_drm_fdinfo (memory-info-idle)
[279.414930] Starting subtest: memory-info-idle
[279.417158] Starting dynamic subtest: smem0
[279.449616] Dynamic subtest smem0: SUCCESS (0.036s)
[279.452255] Subtest memory-info-idle: SUCCESS (0.037s)
[279.525949] [062/133] (745s left) perf_pmu (semaphore-wait-idle)
[279.574191] Starting subtest: semaphore-wait-idle
[279.576085] Starting dynamic subtest: rcs0
[280.087069] Dynamic subtest rcs0: SUCCESS (0.512s)
[280.099299] Starting dynamic subtest: bcs0
[280.603252] Dynamic subtest bcs0: SUCCESS (0.511s)
[280.614368] Starting dynamic subtest: vcs0
[281.116601] Dynamic subtest vcs0: SUCCESS (0.510s)
[281.128747] Starting dynamic subtest: vcs1
[281.630691] Dynamic subtest vcs1: SUCCESS (0.511s)
[281.642432] Starting dynamic subtest: vecs0
[282.143275] Dynamic subtest vecs0: SUCCESS (0.510s)
[282.154219] Starting dynamic subtest: ccs0
[282.661609] Dynamic subtest ccs0: SUCCESS (0.515s)
[282.664934] Subtest semaphore-wait-idle: SUCCESS (3.089s)
[284.001291] [063/133] (740s left) kms_psr (psr2-cursor-plane-onoff)
[284.097267] Starting subtest: psr2-cursor-plane-onoff
[284.099587] Starting dynamic subtest: eDP-1
[285.779947] Dynamic subtest eDP-1: SUCCESS (1.683s)
[285.782663] Subtest psr2-cursor-plane-onoff: SUCCESS (1.684s)
[286.577967] [064/133] (738s left) perf (blocking)
[286.702370] Starting subtest: blocking
[286.704818] Starting dynamic subtest: 0-rcs0
[296.721392] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[296.731757] Starting dynamic subtest: 1-vcs0
[306.746931] Dynamic subtest 1-vcs0: SUCCESS (10.024s)
[306.750110] Subtest blocking: SUCCESS (20.042s)
[306.794401] [065/133] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[306.890438] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[306.894745] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.992730] [066/133] (718s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[307.057973] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[307.060503] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[307.169729] [067/133] (717s left) kms_properties (connector-properties-atomic)
[307.270394] Starting subtest: connector-properties-atomic
[307.272717] Starting dynamic subtest: pipe-A-eDP-1
[315.090537] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.818s)
[315.100605] Starting dynamic subtest: pipe-None-DP-1
[315.105114] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[315.113679] Starting dynamic subtest: pipe-None-HDMI-A-1
[315.117979] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[315.126648] Starting dynamic subtest: pipe-None-DP-2
[315.130682] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[315.139522] Starting dynamic subtest: pipe-None-HDMI-A-2
[315.144061] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[315.152692] Starting dynamic subtest: pipe-None-DP-3
[315.157231] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[315.165892] Starting dynamic subtest: pipe-None-DP-4
[315.170228] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[315.172414] Subtest connector-properties-atomic: SUCCESS (7.831s)
[315.958915] [068/133] (709s left) perf (invalid-create-userspace-config)
[316.060104] Starting subtest: invalid-create-userspace-config
[316.062462] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[316.103815] [069/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[316.221193] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[316.225403] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[316.312863] [070/133] (708s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[316.419881] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[316.424234] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[316.529972] [071/133] (708s left) kms_invalid_mode (bad-htotal)
[316.623333] Starting subtest: bad-htotal
[316.625592] Starting dynamic subtest: pipe-A-eDP-1
[316.916381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[316.926421] Starting dynamic subtest: pipe-B-eDP-1
[316.928384] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[316.936739] Starting dynamic subtest: pipe-C-eDP-1
[316.938663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[316.947077] Starting dynamic subtest: pipe-D-eDP-1
[316.949273] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[316.951552] Subtest bad-htotal: SUCCESS (0.302s)
[317.803101] [072/133] (707s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[317.866696] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[317.868989] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[317.957162] [073/133] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[318.060774] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[324.885052] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.829s)
[325.009939] [074/133] (700s left) kms_force_connector_basic (force-connector-state)
[325.094807] Starting subtest: force-connector-state
[325.707257] Subtest force-connector-state: SUCCESS (0.616s)
[326.687456] [075/133] (698s left) kms_plane_alpha_blend (alpha-transparent-fb)
[326.769055] Starting subtest: alpha-transparent-fb
[327.046707] Starting dynamic subtest: pipe-A-eDP-1
[327.659382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[327.668482] Starting dynamic subtest: pipe-D-eDP-1
[328.979855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[328.982129] Subtest alpha-transparent-fb: SUCCESS (2.210s)
[329.773600] [076/133] (695s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[329.869217] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[329.873208] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[329.954661] [077/133] (695s left) gem_exec_schedule (preempt-contexts)
[330.020093] Starting subtest: preempt-contexts
[330.022229] Starting dynamic subtest: rcs0
[330.068586] Dynamic subtest rcs0: SUCCESS (0.054s)
[330.078044] Starting dynamic subtest: bcs0
[330.126455] Dynamic subtest bcs0: SUCCESS (0.057s)
[330.141728] Starting dynamic subtest: vcs0
[330.187573] Dynamic subtest vcs0: SUCCESS (0.059s)
[330.197042] Starting dynamic subtest: vcs1
[330.233454] Dynamic subtest vcs1: SUCCESS (0.046s)
[330.243239] Starting dynamic subtest: vecs0
[330.277259] Dynamic subtest vecs0: SUCCESS (0.043s)
[330.286268] Starting dynamic subtest: ccs0
[330.330116] Dynamic subtest ccs0: SUCCESS (0.052s)
[330.332420] Subtest preempt-contexts: SUCCESS (0.317s)
[331.941035] [078/133] (693s left) gem_busy (parallel)
[332.121757] Starting subtest: parallel
[332.123934] Starting dynamic subtest: rcs0
[333.909795] Dynamic subtest rcs0: SUCCESS (1.787s)
[333.921192] Starting dynamic subtest: bcs0
[335.895535] Dynamic subtest bcs0: SUCCESS (1.983s)
[335.906737] Starting dynamic subtest: vcs0
[337.877979] Dynamic subtest vcs0: SUCCESS (1.980s)
[337.890091] Starting dynamic subtest: vcs1
[339.927035] Dynamic subtest vcs1: SUCCESS (2.046s)
[339.938326] Starting dynamic subtest: vecs0
[341.909932] Dynamic subtest vecs0: SUCCESS (1.980s)
[341.921271] Starting dynamic subtest: ccs0
[343.894373] Dynamic subtest ccs0: SUCCESS (1.981s)
[343.897179] Subtest parallel: SUCCESS (11.773s)
[344.158436] [079/133] (681s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[344.255071] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[344.257191] Starting dynamic subtest: pipe-A
[344.276431] Dynamic subtest pipe-A: SKIP (0.018s)
[344.285963] Starting dynamic subtest: pipe-B
[344.307769] Dynamic subtest pipe-B: SKIP (0.031s)
[344.316833] Starting dynamic subtest: pipe-C
[344.341289] Dynamic subtest pipe-C: SKIP (0.032s)
[344.350029] Starting dynamic subtest: pipe-D
[344.375265] Dynamic subtest pipe-D: SKIP (0.032s)
[344.379434] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.116s)
[344.468446] [080/133] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[344.566292] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[367.247166] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.683s)
[367.368070] [081/133] (658s left) gem_render_copy_redux (normal)
[367.446607] Starting subtest: normal
[367.751040] Subtest normal: SUCCESS (0.304s)
[367.877444] [082/133] (657s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[367.943170] Starting subtest: map-fixed-invalidate-overlap
[367.946648] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[368.067153] [083/133] (657s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[368.122932] Starting subtest: multi-wait-all-for-submit-unsubmitted
[368.231513] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[368.304697] [084/133] (657s left) kms_psr (fbc-psr-suspend)
[368.405245] Starting subtest: fbc-psr-suspend
[368.407147] Starting dynamic subtest: eDP-1
[368.410544] Dynamic subtest eDP-1: SKIP (0.000s)
[368.414015] Subtest fbc-psr-suspend: SKIP (0.001s)
[368.500598] [085/133] (657s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[368.612130] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[369.427044] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.816s)
[369.590351] [086/133] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[369.690189] Starting subtest: psr-2p-primscrn-spr-indfb-move
[369.694180] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[369.778454] [087/133] (656s left) tools_test (tools_test)
[369.828085] Starting subtest: tools_test
[369.887745] Subtest tools_test: SUCCESS (0.077s)
[369.945477] [088/133] (656s left) kms_pm_rpm (basic-pci-d3-state)
[372.084085] Starting subtest: basic-pci-d3-state
[373.595667] Subtest basic-pci-d3-state: SUCCESS (1.514s)
[373.698768] [089/133] (652s left) kms_hdr (brightness-with-hdr)
[373.800851] Starting subtest: brightness-with-hdr
[373.806850] Subtest brightness-with-hdr: SKIP (0.000s)
[373.871242] [090/133] (652s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[373.940641] Subtest writes-after-reads: SKIP (0.000s)
[374.024455] [091/133] (652s left) gem_userptr_blits (stress-mm-invalidate-close)
[374.096331] Starting subtest: stress-mm-invalidate-close
[376.244032] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[376.355532] [092/133] (649s left) gem_exec_reloc (basic-write-read-active)
[376.413571] Subtest basic-write-read-active: SKIP (0.000s)
[376.473166] [093/133] (649s left) kms_color (ctm-signed)
[376.574869] Starting subtest: ctm-signed
[376.577044] Starting dynamic subtest: pipe-A-eDP-1
[378.708251] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.134s)
[378.718534] Starting dynamic subtest: pipe-B-eDP-1
[381.521872] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.810s)
[381.531634] Starting dynamic subtest: pipe-C-eDP-1
[384.284567] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[384.294669] Starting dynamic subtest: pipe-D-eDP-1
[387.066285] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[387.068596] Subtest ctm-signed: SUCCESS (10.493s)
[387.860702] [094/133] (638s left) gem_exec_create (forked)
[387.925418] Starting subtest: forked
[387.927699] Starting dynamic subtest: smem
[409.879532] Dynamic subtest smem: SUCCESS (21.951s)
[409.882393] Subtest forked: SUCCESS (21.953s)
[410.064320] [095/133] (616s left) i915_pm_rc6_residency (rc6-accuracy)
[410.121157] Starting subtest: rc6-accuracy
[410.123355] Starting dynamic subtest: gt0
[413.294531] Dynamic subtest gt0: SUCCESS (3.169s)
[413.304551] Starting dynamic subtest: gt1
[416.465683] Dynamic subtest gt1: SUCCESS (3.168s)
[416.468071] Subtest rc6-accuracy: SUCCESS (6.343s)
[416.539645] [096/133] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[416.660143] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[416.664489] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[416.768047] [097/133] (609s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[416.867065] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[416.869335] Starting dynamic subtest: pipe-A-eDP-1
[416.929602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[417.229919] Starting dynamic subtest: pipe-B-eDP-1
[418.034428] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.813s)
[418.333744] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.467s)
[419.166837] [098/133] (607s left) perf (non-zero-reason)
[419.256896] Starting subtest: non-zero-reason
[419.259317] Starting dynamic subtest: 0-rcs0
[424.689048] Dynamic subtest 0-rcs0: SUCCESS (5.430s)
[424.700773] Starting dynamic subtest: 1-vcs0
[428.610814] Dynamic subtest 1-vcs0: SUCCESS (3.920s)
[428.613754] Subtest non-zero-reason: SUCCESS (9.352s)
[428.652229] [099/133] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[428.765557] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[428.769946] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[428.869657] [100/133] (597s left) i915_pm_rps (thresholds)
[428.928214] Starting subtest: thresholds
[428.932707] Subtest thresholds: SKIP (0.001s)
[429.026838] [101/133] (597s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[429.136295] Starting subtest: cursorA-vs-flipA-legacy
[440.263744] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.124s)
[441.079784] [102/133] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[441.193632] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[441.198086] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[441.296168] [103/133] (585s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[441.338353] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[441.393979] [104/133] (585s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[441.493827] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[441.497816] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[441.596320] [105/133] (585s left) sysfs_heartbeat_interval (mixed)
[441.657536] Starting subtest: mixed
[441.659946] Starting dynamic subtest: vecs0
[446.901272] Dynamic subtest vecs0: SUCCESS (5.242s)
[446.913579] Starting dynamic subtest: ccs0
[452.096620] Dynamic subtest ccs0: SUCCESS (5.193s)
[452.108236] Starting dynamic subtest: vcs0
[457.313489] Dynamic subtest vcs0: SUCCESS (5.215s)
[457.326890] Starting dynamic subtest: bcs0
[462.572030] Dynamic subtest bcs0: SUCCESS (5.254s)
[462.591028] Starting dynamic subtest: rcs0
[467.797023] Dynamic subtest rcs0: SUCCESS (5.222s)
[467.808501] Starting dynamic subtest: vcs1
[473.017599] Dynamic subtest vcs1: SUCCESS (5.219s)
[473.020041] Subtest mixed: SUCCESS (31.359s)
[473.093285] [106/133] (553s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[473.397426] Starting subtest: cursor-rapid-movement-512x170
[473.401578] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[473.540541] [107/133] (553s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[473.642985] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[473.645231] Starting dynamic subtest: pipe-A-eDP-1
[473.667392] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[473.679023] Starting dynamic subtest: pipe-B-eDP-1
[473.700351] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[473.709654] Starting dynamic subtest: pipe-C-eDP-1
[473.731113] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[473.739967] Starting dynamic subtest: pipe-D-eDP-1
[473.761799] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[473.765815] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[475.853113] [108/133] (550s left) drm_read (empty-nonblock)
[475.990523] Starting subtest: empty-nonblock
[475.992808] Subtest empty-nonblock: SUCCESS (0.000s)
[476.113282] [109/133] (550s left) kms_prime (basic-crc-hybrid)
[476.197851] Subtest basic-crc-hybrid: SKIP (0.000s)
[476.371815] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[476.375265] [110/133] (550s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[476.492464] Starting subtest: basic-busy-flip-before-cursor-atomic
[476.496976] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[476.639562] [111/133] (550s left) kms_psr (fbc-psr-primary-mmap-gtt)
[476.727859] Starting subtest: fbc-psr-primary-mmap-gtt
[476.730090] Starting dynamic subtest: eDP-1
[476.734154] Dynamic subtest eDP-1: SKIP (0.000s)
[476.738213] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[476.806326] [112/133] (550s left) gem_ctx_persistence (engines-mixed)
[476.863051] Starting subtest: engines-mixed
[476.864950] Starting dynamic subtest: rcs0
[476.929646] Dynamic subtest rcs0: SUCCESS (0.066s)
[476.941877] Starting dynamic subtest: bcs0
[476.971171] Dynamic subtest bcs0: SUCCESS (0.040s)
[476.981318] Starting dynamic subtest: vcs0
[477.014106] Dynamic subtest vcs0: SUCCESS (0.041s)
[477.024235] Starting dynamic subtest: vcs1
[477.055450] Dynamic subtest vcs1: SUCCESS (0.040s)
[477.065018] Starting dynamic subtest: vecs0
[477.105295] Dynamic subtest vecs0: SUCCESS (0.049s)
[477.117942] Starting dynamic subtest: ccs0
[477.163441] Dynamic subtest ccs0: SUCCESS (0.057s)
[477.165652] Subtest engines-mixed: SUCCESS (0.301s)
[477.247840] [113/133] (549s left) kms_cursor_edge_walk (256x256-left-edge)
[477.337429] Starting subtest: 256x256-left-edge
[477.339369] Starting dynamic subtest: pipe-A-eDP-1
[480.792898] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[480.803226] Starting dynamic subtest: pipe-D-eDP-1
[483.991070] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.195s)
[483.993061] Subtest 256x256-left-edge: SUCCESS (6.652s)
[484.875693] [114/133] (542s left) gem_exec_fence (submit3)
[485.050028] Starting subtest: submit3
[485.054859] Subtest submit3: SKIP (0.000s)
[487.010525] [115/133] (540s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[487.120281] Starting subtest: yf-tiled-32bpp-rotate-0
[487.124528] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[487.234601] [116/133] (539s left) kms_cursor_crc (cursor-offscreen-512x170)
[487.564323] Starting subtest: cursor-offscreen-512x170
[487.568603] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[487.709826] [117/133] (539s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[487.802530] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[494.456848] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.657s)
[494.559316] [118/133] (532s left) api_intel_bb (intel-bb-blit-x)
[494.620046] Starting subtest: intel-bb-blit-x
[498.352389] Subtest intel-bb-blit-x: SUCCESS (3.732s)
[498.502918] [119/133] (528s left) gem_exec_reloc (basic-gtt-read-active)
[498.558947] Subtest basic-gtt-read-active: SKIP (0.000s)
[498.625590] [120/133] (528s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[498.723145] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[498.727261] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[498.824442] [121/133] (528s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[498.940030] Starting subtest: yf-tiled-64bpp-rotate-180
[498.944533] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[499.024413] [122/133] (528s left) kms_chamelium_hpd (dp-hpd-fast)
[499.401882] Subtest dp-hpd-fast: SKIP (0.000s)
[500.238298] [123/133] (527s left) gem_exec_async (concurrent-writes)
[500.309085] Starting subtest: concurrent-writes
[500.311525] Starting dynamic subtest: rcs0
[500.327389] Dynamic subtest rcs0: SUCCESS (0.018s)
[500.339727] Starting dynamic subtest: bcs0
[500.342065] Dynamic subtest bcs0: SUCCESS (0.006s)
[500.351683] Starting dynamic subtest: vcs0
[500.353598] Dynamic subtest vcs0: SUCCESS (0.006s)
[500.362773] Starting dynamic subtest: vcs1
[500.364974] Dynamic subtest vcs1: SUCCESS (0.006s)
[500.374068] Starting dynamic subtest: vecs0
[500.376250] Dynamic subtest vecs0: SUCCESS (0.006s)
[500.385089] Starting dynamic subtest: ccs0
[500.387254] Dynamic subtest ccs0: SUCCESS (0.006s)
[500.389407] Subtest concurrent-writes: SUCCESS (0.052s)
[500.590422] [124/133] (526s left) prime_self_import (basic-with_two_bos)
[500.630553] Starting subtest: basic-with_two_bos
[500.642025] Subtest basic-with_two_bos: SUCCESS (0.013s)
[500.737854] [125/133] (526s left) perf_pmu (multi-client)
[500.780404] Starting subtest: multi-client
[500.782582] Starting dynamic subtest: rcs0
[501.849234] Dynamic subtest rcs0: SUCCESS (1.068s)
[501.859529] Starting dynamic subtest: bcs0
[502.901529] Dynamic subtest bcs0: SUCCESS (1.050s)
[502.922024] Starting dynamic subtest: vcs0
[503.958294] Dynamic subtest vcs0: SUCCESS (1.054s)
[503.970938] Starting dynamic subtest: vcs1
[505.933559] Dynamic subtest vcs1: SUCCESS (1.972s)
[505.945818] Starting dynamic subtest: vecs0
[507.916581] Dynamic subtest vecs0: SUCCESS (1.980s)
[507.928741] Starting dynamic subtest: ccs0
[509.901446] Dynamic subtest ccs0: SUCCESS (1.982s)
[509.904391] Subtest multi-client: SUCCESS (9.122s)
[510.022298] [126/133] (517s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[510.119858] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[510.122132] Starting dynamic subtest: pipe-A-default-mode
[512.858603] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[512.861079] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.739s)
[513.657505] [127/133] (513s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[513.745974] Starting subtest: fbc-pr-cursor-mmap-cpu
[513.750697] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[513.820481] [128/133] (513s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[513.911916] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[513.914162] Starting dynamic subtest: pipe-A-eDP-1
[513.971211] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[513.980747] Starting dynamic subtest: pipe-B-eDP-1
[514.036709] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[514.046931] Starting dynamic subtest: pipe-C-eDP-1
[514.104425] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[514.115018] Starting dynamic subtest: pipe-D-eDP-1
[514.170697] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[514.174989] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[516.145756] [129/133] (511s left) kms_lease (lease-invalid-crtc)
[516.243877] Starting subtest: lease-invalid-crtc
[516.246220] Starting dynamic subtest: pipe-A-eDP-1
[516.248553] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[516.258064] Starting dynamic subtest: pipe-B-eDP-1
[516.260348] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[516.269405] Starting dynamic subtest: pipe-C-eDP-1
[516.271799] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[516.281137] Starting dynamic subtest: pipe-D-eDP-1
[516.283397] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[516.285726] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[516.325589] [130/133] (511s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[516.423688] Starting subtest: x-tiled-8bpp-rotate-90
[516.445678] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[516.573257] [131/133] (511s left) gem_sync (basic-each)
[516.648649] Starting subtest: basic-each
[519.065303] Subtest basic-each: SUCCESS (2.426s)
[519.254667] [132/133] (508s left) syncobj_wait (multi-wait-submitted)
[519.302090] Starting subtest: multi-wait-submitted
[519.410058] Subtest multi-wait-submitted: SUCCESS (0.107s)
[519.487975] [133/133] (508s left) gem_exec_create (madvise)
[519.546615] Starting subtest: madvise
[519.548973] Starting dynamic subtest: smem
[540.946219] Dynamic subtest smem: SUCCESS (21.396s)
[540.949031] Subtest madvise: SUCCESS (21.397s)
[541.714453] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_pwrite
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: dumb_buffer
results: parsing output: 7/ for test: kms_plane_lowres
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_madvise
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: gem_create
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: i915_pm_freq_api
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_chamelium_edid
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gen7_exec_parse
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gen3_render_mixed_blits
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_force_connector_basic
results: parsing output: 74/ for test: kms_plane_alpha_blend
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_busy
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy_redux
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: tools_test
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: kms_hdr
results: parsing output: 89/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: gem_exec_create
results: parsing output: 94/ for test: i915_pm_rc6_residency
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic_transition
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_pm_rps
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: sysfs_heartbeat_interval
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_prime
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_cursor_edge_walk
results: parsing output: 113/ for test: gem_exec_fence
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: gem_exec_async
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_sync
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: gem_exec_create
Done.