[56.638585] Initializing watchdogs
[56.638634]   /dev/watchdog0
[56.654619] [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]
[56.659236] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.662479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.665961] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[56.785412] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[56.790039] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[56.864900] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-y)
[56.927937] Subtest fault-concurrent-Y: SKIP (0.000s)
[56.994986] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[57.093677] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[57.097737] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.185606] [004/133] (960s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[58.386592] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[58.699654] [005/133] (958s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[58.793784] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[58.795661] Starting dynamic subtest: pipe-A-eDP-1
[60.166812] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.373s)
[60.455192] Starting dynamic subtest: pipe-B-eDP-1
[61.499664] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[61.768797] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.975s)
[62.607616] [006/133] (954s left) gem_mmap_wc (read)
[62.667071] Subtest read: SKIP (0.000s)
[62.725829] [007/133] (954s left) kms_dsc (dsc-basic)
[62.821850] Starting subtest: dsc-basic
[62.834841] Subtest dsc-basic: SKIP (0.000s)
[62.895937] [008/133] (954s left) kms_addfb_basic (unused-offsets)
[62.953629] Starting subtest: unused-offsets
[62.955989] Subtest unused-offsets: SUCCESS (0.000s)
[63.094389] [009/133] (954s left) gem_pxp (create-valid-protected-context)
[63.225226] Starting subtest: create-valid-protected-context
[63.227754] Subtest create-valid-protected-context: SUCCESS (0.002s)
[63.326142] [010/133] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[63.411499] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[63.413594] Starting dynamic subtest: pipe-A-eDP-1
[64.329112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.912s)
[64.338482] Starting dynamic subtest: pipe-B-eDP-1
[65.942793] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.610s)
[65.952012] Starting dynamic subtest: pipe-C-eDP-1
[67.487155] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.545s)
[67.497125] Starting dynamic subtest: pipe-D-eDP-1
[68.973674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.486s)
[68.976086] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.555s)
[70.141961] [011/133] (947s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[70.243722] Starting subtest: fbcpsr-stridechange
[76.457073] Subtest fbcpsr-stridechange: SUCCESS (6.217s)
[76.588577] [012/133] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[76.693452] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[76.697669] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[76.788184] [013/133] (940s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[76.891623] Starting subtest: psr2-plane-move-sf-dmg-area
[76.893976] Starting dynamic subtest: pipe-A-eDP-1
[81.412901] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.526s)
[81.423532] Starting dynamic subtest: pipe-B-eDP-1
[86.737224] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.322s)
[86.739522] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.850s)
[87.623269] [014/133] (930s left) kms_cursor_edge_walk (64x64-top-edge)
[87.719781] Starting subtest: 64x64-top-edge
[87.722069] Starting dynamic subtest: pipe-A-eDP-1
[91.172056] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[91.181636] Starting dynamic subtest: pipe-D-eDP-1
[94.291435] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[94.293764] Subtest 64x64-top-edge: SUCCESS (6.573s)
[95.107205] [015/133] (922s left) vgem_basic (dmabuf-mmap)
[95.190776] Starting subtest: dmabuf-mmap
[95.197290] Subtest dmabuf-mmap: SUCCESS (0.009s)
[95.256634] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[95.259795] [016/133] (922s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[95.357358] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[95.359607] Starting dynamic subtest: pipe-A
[95.423361] Dynamic subtest pipe-A: SUCCESS (0.066s)
[95.433647] Starting dynamic subtest: pipe-B
[96.532737] Dynamic subtest pipe-B: SUCCESS (1.108s)
[96.542210] Starting dynamic subtest: pipe-C
[97.649243] Dynamic subtest pipe-C: SUCCESS (1.115s)
[97.657494] Starting dynamic subtest: pipe-D
[98.794880] Dynamic subtest pipe-D: SUCCESS (1.145s)
[98.797236] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.438s)
[99.951888] [017/133] (917s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[100.045426] Starting subtest: bad-rotation-90-yf-tiled-ccs
[100.047795] Starting dynamic subtest: pipe-A-eDP-1
[100.071163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.081554] Starting dynamic subtest: pipe-B-eDP-1
[100.103362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.112050] Starting dynamic subtest: pipe-C-eDP-1
[100.135478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.145205] Starting dynamic subtest: pipe-D-eDP-1
[100.166899] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.170978] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[102.327361] [018/133] (915s left) gem_ctx_exec (basic)
[102.390167] Starting subtest: basic
[102.399474] Subtest basic: SUCCESS (0.011s)
[102.531007] [019/133] (915s left) gem_exec_schedule (pi-shared-iova)
[102.722968] Starting subtest: pi-shared-iova
[102.725465] Starting dynamic subtest: rcs0
[102.807447] Dynamic subtest rcs0: SUCCESS (0.087s)
[102.818032] Starting dynamic subtest: vcs0
[102.865441] Dynamic subtest vcs0: SUCCESS (0.057s)
[102.880191] Starting dynamic subtest: vcs1
[102.919935] Dynamic subtest vcs1: SUCCESS (0.055s)
[102.928999] Starting dynamic subtest: vecs0
[102.980699] Dynamic subtest vecs0: SUCCESS (0.060s)
[102.993600] Starting dynamic subtest: ccs0
[103.039052] Dynamic subtest ccs0: SUCCESS (0.058s)
[103.041358] Subtest pi-shared-iova: SUCCESS (0.320s)
[104.364278] [020/133] (913s left) device_reset (unbind-reset-rebind)
[104.416815] Starting subtest: unbind-reset-rebind
[109.355085] Subtest unbind-reset-rebind: SUCCESS (4.933s)
[109.402486] [021/133] (908s left) syncobj_timeline (wait-all-snapshot)
[109.460244] Starting subtest: wait-all-snapshot
[109.540850] Subtest wait-all-snapshot: SUCCESS (0.082s)
[109.617064] [022/133] (908s left) gem_mmap_gtt (medium-copy-xy)
[109.674408] Subtest medium-copy-XY: SKIP (0.000s)
[109.731818] [023/133] (908s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[109.783277] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[109.785505] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[109.901933] [024/133] (908s left) perf_pmu (busy-check-all)
[109.939634] Starting subtest: busy-check-all
[109.941945] Starting dynamic subtest: rcs0
[110.495446] Dynamic subtest rcs0: SUCCESS (0.555s)
[110.507414] Starting dynamic subtest: bcs0
[111.044497] Dynamic subtest bcs0: SUCCESS (0.548s)
[111.057717] Starting dynamic subtest: vcs0
[112.353203] Dynamic subtest vcs0: SUCCESS (1.305s)
[112.365830] Starting dynamic subtest: vcs1
[114.335108] Dynamic subtest vcs1: SUCCESS (1.980s)
[114.347869] Starting dynamic subtest: vecs0
[116.318906] Dynamic subtest vecs0: SUCCESS (1.981s)
[116.331030] Starting dynamic subtest: ccs0
[116.874206] Dynamic subtest ccs0: SUCCESS (0.556s)
[116.876716] Subtest busy-check-all: SUCCESS (6.935s)
[116.989758] [025/133] (901s left) syncobj_timeline (invalid-query-illegal-handle)
[117.047106] Starting subtest: invalid-query-illegal-handle
[117.049430] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[117.156088] [026/133] (901s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[117.282180] Starting subtest: cursorA-vs-flipA-atomic-transitions
[128.474196] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.190s)
[129.340257] [027/133] (888s left) gem_tiled_swapping (non-threaded)
[129.410626] Subtest non-threaded: SKIP (0.000s)
[129.508836] [028/133] (888s left) kms_plane_multiple (tiling-x)
[129.599785] Starting subtest: tiling-x
[129.602077] Starting dynamic subtest: pipe-A-eDP-1
[133.443426] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.842s)
[133.453944] Starting dynamic subtest: pipe-B-eDP-1
[137.903290] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.459s)
[137.916037] Starting dynamic subtest: pipe-C-eDP-1
[142.256186] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.353s)
[142.266783] Starting dynamic subtest: pipe-D-eDP-1
[146.705438] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.448s)
[146.707655] Subtest tiling-x: SUCCESS (17.107s)
[147.498703] [029/133] (870s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[147.603899] Starting subtest: yf-tiled-16bpp-rotate-270
[147.608136] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[147.705614] [030/133] (870s left) kms_psr (pr-cursor-mmap-cpu)
[147.800716] Starting subtest: pr-cursor-mmap-cpu
[147.805212] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[147.872413] [031/133] (870s left) gem_ctx_param (invalid-get-ringsize)
[147.921785] Starting subtest: invalid-get-ringsize
[147.923956] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[148.044379] [032/133] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[148.141057] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[154.762474] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.620s)
[154.907296] [033/133] (863s left) gem_exec_whisper (basic-fds-all)
[154.970658] Starting subtest: basic-fds-all
[166.271780] Subtest basic-fds-all: SUCCESS (11.296s)
[166.470775] [034/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[166.580317] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[166.584578] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[166.682251] [035/133] (851s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[166.737338] Starting subtest: invalid-multi-wait-unsubmitted
[166.739188] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[166.834507] [036/133] (851s left) gem_mmap_offset (close-race)
[166.887030] Starting subtest: close-race
[187.002466] Subtest close-race: SUCCESS (20.114s)
[187.138421] [037/133] (831s left) kms_psr (psr-cursor-render)
[187.235120] Starting subtest: psr-cursor-render
[187.237432] Starting dynamic subtest: eDP-1
[188.927017] Dynamic subtest eDP-1: SUCCESS (1.691s)
[188.929435] Subtest psr-cursor-render: SUCCESS (1.692s)
[189.803449] [038/133] (828s left) perf_pmu (interrupts)
[189.840768] Starting subtest: interrupts
[190.915478] Subtest interrupts: SUCCESS (1.074s)
[191.030018] [039/133] (827s left) api_intel_allocator (alloc-simple)
[191.093117] Starting subtest: alloc-simple
[191.097796] Subtest alloc-simple: SUCCESS (0.004s)
[191.213846] [040/133] (827s left) kms_psr (psr-primary-blt)
[191.313036] Starting subtest: psr-primary-blt
[191.315307] Starting dynamic subtest: eDP-1
[193.011599] Dynamic subtest eDP-1: SUCCESS (1.698s)
[193.013865] Subtest psr-primary-blt: SUCCESS (1.699s)
[193.872236] [041/133] (825s left) kms_cursor_crc (cursor-random-512x170)
[194.161667] Starting subtest: cursor-random-512x170
[194.166168] Subtest cursor-random-512x170: SKIP (0.001s)
[194.311087] [042/133] (824s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[194.368192] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[194.475332] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[194.552652] [043/133] (824s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[196.492648] Starting subtest: gem-execbuf-stress-pc8
[196.532234] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[196.887291] [044/133] (822s left) gem_reg_read (bad-register)
[196.940588] Starting subtest: bad-register
[196.942840] Subtest bad-register: SUCCESS (0.000s)
[197.049143] [045/133] (822s left) gem_mmap_gtt (basic-small-copy-odd)
[197.109165] Subtest basic-small-copy-odd: SKIP (0.000s)
[197.169826] [046/133] (821s left) i915_hangman (gt-engine-hang)
[197.231653] Starting subtest: gt-engine-hang
[197.233540] Starting dynamic subtest: rcs0
[198.270369] Dynamic subtest rcs0: SUCCESS (1.038s)
[198.284263] Starting dynamic subtest: bcs0
[200.316818] Dynamic subtest bcs0: SUCCESS (2.044s)
[200.331085] Starting dynamic subtest: vcs0
[202.236986] Dynamic subtest vcs0: SUCCESS (1.917s)
[202.249854] Starting dynamic subtest: vcs1
[203.260616] Dynamic subtest vcs1: SUCCESS (1.021s)
[203.278036] Starting dynamic subtest: vecs0
[205.310841] Dynamic subtest vecs0: SUCCESS (2.047s)
[205.325119] Starting dynamic subtest: ccs0
[207.294370] Dynamic subtest ccs0: SUCCESS (1.981s)
[207.297490] Subtest gt-engine-hang: SUCCESS (10.064s)
[207.455657] [047/133] (811s left) fbdev (pan)
[207.491422] Starting subtest: pan
[207.511912] Subtest pan: SUCCESS (0.025s)
[207.586724] [048/133] (811s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[207.687057] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[208.792519] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.509s)
[208.833920] [049/133] (810s left) prime_self_import (basic-with_one_bo)
[208.867582] Starting subtest: basic-with_one_bo
[208.892026] Subtest basic-with_one_bo: SUCCESS (0.024s)
[209.026989] [050/133] (810s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[209.117781] Starting subtest: 2x-flip-vs-modeset-vs-hang
[209.121157] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[209.224978] [051/133] (810s left) kms_flip (2x-flip-vs-suspend)
[209.332516] Starting subtest: 2x-flip-vs-suspend
[209.335919] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[209.443849] [052/133] (809s left) i915_query (query-garbage)
[209.504228] Starting subtest: query-garbage
[209.506209] Subtest query-garbage: SUCCESS (0.000s)
[209.607531] [053/133] (809s left) kms_pm_dc (dc5-retention-flops)
[210.703088] Starting subtest: dc5-retention-flops
[210.707537] Subtest dc5-retention-flops: SKIP (0.000s)
[210.778469] [054/133] (808s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[210.878314] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[210.882428] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[210.985378] [055/133] (808s left) kms_atomic_interruptible (legacy-dpms)
[211.076356] Starting subtest: legacy-dpms
[211.078644] Starting dynamic subtest: pipe-A-eDP-1
[218.494776] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[218.497092] Subtest legacy-dpms: SUCCESS (7.418s)
[219.342650] [056/133] (800s left) gem_basic (create-close)
[219.396182] Starting subtest: create-close
[219.400605] Subtest create-close: SUCCESS (0.000s)
[219.499721] [057/133] (800s left) sysfs_timeslice_duration (idempotent)
[219.560280] Starting subtest: idempotent
[219.562550] Starting dynamic subtest: vecs0
[219.564893] Dynamic subtest vecs0: SUCCESS (0.000s)
[219.577608] Starting dynamic subtest: ccs0
[219.579482] Dynamic subtest ccs0: SUCCESS (0.000s)
[219.589532] Starting dynamic subtest: vcs0
[219.591357] Dynamic subtest vcs0: SUCCESS (0.000s)
[219.601536] Starting dynamic subtest: bcs0
[219.603434] Dynamic subtest bcs0: SUCCESS (0.000s)
[219.613061] Starting dynamic subtest: rcs0
[219.614889] Dynamic subtest rcs0: SUCCESS (0.000s)
[219.624820] Starting dynamic subtest: vcs1
[219.627082] Dynamic subtest vcs1: SUCCESS (0.000s)
[219.629290] Subtest idempotent: SUCCESS (0.006s)
[219.675528] [058/133] (799s left) kms_cursor_crc (cursor-offscreen-128x128)
[219.882151] Starting subtest: cursor-offscreen-128x128
[219.887260] Starting dynamic subtest: pipe-A-eDP-1
[221.822722] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[221.856664] Starting dynamic subtest: pipe-D-eDP-1
[224.440279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.595s)
[224.442151] Subtest cursor-offscreen-128x128: SUCCESS (4.556s)
[225.300273] [059/133] (794s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[225.406090] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[225.410500] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.513177] [060/133] (794s left) gem_pxp (regular-baseline-src-copy-readible)
[225.633903] Starting subtest: regular-baseline-src-copy-readible
[225.692306] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[225.828810] [061/133] (793s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[225.925180] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[225.929380] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[226.009577] [062/133] (793s left) gem_exec_schedule (fairslice)
[226.080717] Starting subtest: fairslice
[226.083045] Starting dynamic subtest: rcs0
[228.097140] Dynamic subtest rcs0: SUCCESS (2.019s)
[228.107681] Starting dynamic subtest: bcs0
[230.115408] Dynamic subtest bcs0: SUCCESS (2.020s)
[230.132578] Starting dynamic subtest: vcs0
[232.136470] Dynamic subtest vcs0: SUCCESS (2.020s)
[232.146635] Starting dynamic subtest: vcs1
[234.159672] Dynamic subtest vcs1: SUCCESS (2.021s)
[234.172127] Starting dynamic subtest: vecs0
[236.198292] Dynamic subtest vecs0: SUCCESS (2.019s)
[236.211627] Starting dynamic subtest: ccs0
[238.198432] Dynamic subtest ccs0: SUCCESS (2.018s)
[238.200702] Subtest fairslice: SUCCESS (12.123s)
[238.514029] [063/133] (781s left) kms_frontbuffer_tracking (psr-2p-rte)
[238.624429] Starting subtest: psr-2p-rte
[238.628515] Subtest psr-2p-rte: SKIP (0.000s)
[238.735045] [064/133] (781s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[238.821441] Starting subtest: plane-lut1d-pre-ctm3x4
[238.966798] Starting dynamic subtest: pipe-A-plane-0
[239.144260] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[239.155966] Starting dynamic subtest: pipe-A-plane-1
[239.299454] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[239.310595] Starting dynamic subtest: pipe-A-plane-2
[239.455069] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[240.704063] Starting dynamic subtest: pipe-B-plane-0
[240.872844] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[240.884175] Starting dynamic subtest: pipe-B-plane-1
[241.050769] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[241.061500] Starting dynamic subtest: pipe-B-plane-2
[241.217564] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[242.446886] Starting dynamic subtest: pipe-C-plane-0
[242.594067] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[242.606087] Starting dynamic subtest: pipe-C-plane-1
[242.747281] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[242.758127] Starting dynamic subtest: pipe-C-plane-2
[242.891730] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[244.060107] Starting dynamic subtest: pipe-D-plane-0
[244.207193] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[244.218017] Starting dynamic subtest: pipe-D-plane-1
[244.351945] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[244.363288] Starting dynamic subtest: pipe-D-plane-2
[244.518372] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[244.805061] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.985s)
[245.622883] [065/133] (774s left) gem_exec_balancer (semaphore)
[245.683137] Starting subtest: semaphore
[247.299304] Subtest semaphore: SUCCESS (1.615s)
[247.636663] [066/133] (772s left) kms_content_protection (dp-mst-type-0)
[247.786901] Starting subtest: dp-mst-type-0
[247.791253] Subtest dp-mst-type-0: SKIP (0.000s)
[247.913463] [067/133] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[248.005577] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[248.009734] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[248.100702] [068/133] (771s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[248.230263] Starting subtest: 2x-flip-vs-cursor-atomic
[248.234578] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[248.378901] [069/133] (771s left) kms_lease (lease-invalid-crtc)
[248.478727] Starting subtest: lease-invalid-crtc
[248.481102] Starting dynamic subtest: pipe-A-eDP-1
[248.483465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[248.493722] Starting dynamic subtest: pipe-B-eDP-1
[248.496024] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[248.506226] Starting dynamic subtest: pipe-C-eDP-1
[248.508481] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[248.518267] Starting dynamic subtest: pipe-D-eDP-1
[248.520047] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[248.521829] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[248.559365] [070/133] (771s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[248.676487] Starting subtest: cursor-vs-flip-atomic-transitions
[279.054856] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.378s)
[279.876294] [071/133] (740s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[279.937084] Starting subtest: yf-tiled-to-vebox-y-tiled
[279.941277] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[280.124136] [072/133] (740s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[280.212859] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[280.215210] Starting dynamic subtest: pipe-A-default-mode
[281.344681] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[281.349225] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.131s)
[281.504311] [073/133] (738s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[281.550856] Starting subtest: etime-single-wait-available-unsubmitted
[281.658533] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[281.737235] [074/133] (738s left) kms_chamelium_color (ctm-0-50)
[281.834318] Subtest ctm-0-50: SKIP (0.000s)
[281.880357] [075/133] (738s left) kms_invalid_mode (overflow-vrefresh)
[281.977433] Starting subtest: overflow-vrefresh
[281.979711] Starting dynamic subtest: pipe-A-eDP-1
[282.258489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[282.270193] Starting dynamic subtest: pipe-B-eDP-1
[282.272492] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[282.283056] Starting dynamic subtest: pipe-C-eDP-1
[282.284891] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[282.294664] Starting dynamic subtest: pipe-D-eDP-1
[282.296580] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[282.298488] Subtest overflow-vrefresh: SUCCESS (0.290s)
[283.160414] [076/133] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[283.265827] Starting subtest: psr-1p-primscrn-spr-indfb-move
[290.695351] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.433s)
[290.846325] [077/133] (729s left) gem_create (hog-create)
[290.907594] Starting subtest: hog-create
[290.909978] Starting dynamic subtest: smem0
[324.326212] Dynamic subtest smem0: SUCCESS (33.418s)
[324.328932] Subtest hog-create: SUCCESS (33.421s)
[324.528047] [078/133] (695s left) gem_unref_active_buffers
[324.732850] [079/133] (695s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[324.835385] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[324.839587] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[324.940692] [080/133] (695s left) kms_big_fb (y-tiled-addfb-size-overflow)
[325.044286] Starting subtest: y-tiled-addfb-size-overflow
[325.048273] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[325.142319] [081/133] (695s left) gem_exec_reloc (basic-write-cpu-active)
[325.193490] Subtest basic-write-cpu-active: SKIP (0.000s)
[325.272029] [082/133] (695s left) kms_pm_rpm (legacy-planes-dpms)
[327.504723] Starting subtest: legacy-planes-dpms
[327.506938] Starting dynamic subtest: plane-65
[335.818993] Dynamic subtest plane-65: SUCCESS (8.317s)
[335.834245] Starting dynamic subtest: plane-95
[344.174326] Dynamic subtest plane-95: SUCCESS (8.351s)
[344.187785] Starting dynamic subtest: plane-125
[352.783795] Dynamic subtest plane-125: SUCCESS (8.607s)
[352.795772] Starting dynamic subtest: plane-135
[361.094882] Dynamic subtest plane-135: SUCCESS (8.308s)
[361.097902] Subtest legacy-planes-dpms: SUCCESS (33.595s)
[361.483975] [083/133] (659s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[361.577210] Starting subtest: disable-crc-after-crtc
[361.579446] Starting dynamic subtest: pipe-A-eDP-1
[363.230316] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.651s)
[363.241120] Starting dynamic subtest: pipe-B-eDP-1
[365.509481] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.276s)
[365.521488] Starting dynamic subtest: pipe-C-eDP-1
[367.744508] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.236s)
[367.755633] Starting dynamic subtest: pipe-D-eDP-1
[370.027513] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.278s)
[370.029667] Subtest disable-crc-after-crtc: SUCCESS (8.449s)
[370.850948] [084/133] (649s left) prime_udl
[370.937263] [085/133] (649s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[371.042354] Starting subtest: fbcpsr-modesetfrombusy
[377.245015] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.208s)
[377.387298] [086/133] (643s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[377.493211] Starting subtest: x-tiled-8bpp-rotate-270
[377.515217] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[377.619840] [087/133] (643s left) gem_exec_fence (syncobj-repeat)
[378.094829] Starting subtest: syncobj-repeat
[378.288087] Subtest syncobj-repeat: SUCCESS (0.192s)
[379.434457] [088/133] (641s left) gem_softpin (zero)
[379.505032] Starting subtest: zero
[379.509554] Subtest zero: SUCCESS (0.005s)
[379.631242] [089/133] (641s left) gem_ctx_persistence (heartbeat-hostile)
[379.690720] Starting subtest: heartbeat-hostile
[379.695774] Subtest heartbeat-hostile: SKIP (0.000s)
[379.811527] [090/133] (641s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[379.908693] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[379.912817] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[380.010955] [091/133] (640s left) kms_chamelium_frames (hdmi-crc-multiple)
[380.398458] Subtest hdmi-crc-multiple: SKIP (0.000s)
[381.231377] [092/133] (639s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[381.325015] Starting subtest: async-flip-with-page-flip-events-linear
[381.708718] Starting dynamic subtest: pipe-A-eDP-1
[384.534722] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.826s)
[384.916215] Starting dynamic subtest: pipe-B-eDP-1
[387.663160] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[388.032669] Starting dynamic subtest: pipe-C-eDP-1
[390.804224] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.778s)
[391.179611] Starting dynamic subtest: pipe-D-eDP-1
[393.935682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[393.938166] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.612s)
[395.119457] [093/133] (625s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[395.227831] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[395.232161] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[395.301644] [094/133] (625s left) gem_exec_params (secure-non-master)
[395.359294] Starting subtest: secure-non-master
[395.363024] Subtest secure-non-master: SKIP (0.000s)
[395.461319] [095/133] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[395.552097] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[395.556226] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[395.654477] [096/133] (625s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[395.759245] Starting subtest: fbc-rgb101010-draw-render
[400.357720] Subtest fbc-rgb101010-draw-render: SUCCESS (4.602s)
[401.542401] [097/133] (619s left) api_intel_bb (reset-flags)
[401.608099] Starting subtest: reset-flags
[401.615327] Subtest reset-flags: SUCCESS (0.008s)
[401.741711] [098/133] (619s left) syncobj_wait (single-wait-submitted)
[401.799988] Starting subtest: single-wait-submitted
[401.907097] Subtest single-wait-submitted: SUCCESS (0.106s)
[401.985031] [099/133] (619s left) i915_query (engine-info)
[402.048482] Starting subtest: engine-info
[402.053339] Subtest engine-info: SUCCESS (0.004s)
[402.179638] [100/133] (619s left) perf_pmu (all-busy-check-all)
[402.220461] Starting subtest: all-busy-check-all
[403.295324] Subtest all-busy-check-all: SUCCESS (1.073s)
[403.411763] [101/133] (618s left) syncobj_basic (bad-flags-fd-to-handle)
[403.470972] Starting subtest: bad-flags-fd-to-handle
[403.473280] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[403.563704] [102/133] (617s left) gem_exec_schedule (u-submit-golden-slice)
[403.635379] Starting subtest: u-submit-golden-slice
[403.637562] Starting dynamic subtest: rcs0
[403.662651] Dynamic subtest rcs0: SUCCESS (0.034s)
[403.673422] Starting dynamic subtest: bcs0
[403.689372] Dynamic subtest bcs0: SUCCESS (0.026s)
[403.700301] Starting dynamic subtest: vcs0
[403.723318] Dynamic subtest vcs0: SUCCESS (0.033s)
[403.734129] Starting dynamic subtest: vcs1
[403.752505] Dynamic subtest vcs1: SUCCESS (0.028s)
[403.763428] Starting dynamic subtest: vecs0
[403.781424] Dynamic subtest vecs0: SUCCESS (0.028s)
[403.792774] Starting dynamic subtest: ccs0
[403.811686] Dynamic subtest ccs0: SUCCESS (0.030s)
[403.813999] Subtest u-submit-golden-slice: SUCCESS (0.183s)
[405.417263] [103/133] (616s left) i915_drm_fdinfo (memory-info-shared)
[405.455099] Starting subtest: memory-info-shared
[405.457328] Starting dynamic subtest: smem0
[405.486593] Dynamic subtest smem0: SUCCESS (0.031s)
[405.488987] Subtest memory-info-shared: SUCCESS (0.032s)
[405.570051] [104/133] (616s left) gem_mmap_wc (write-read-distinct)
[405.632577] Subtest write-read-distinct: SKIP (0.000s)
[405.690457] [105/133] (615s left) kms_selftest (drm_damage_helper)
[405.728336] Starting subtest: drm_damage_helper
[405.741056] Starting dynamic subtest: drm_test_damage_iter_no_damage
[405.833512] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.091s)
[405.845401] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[405.932690] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.097s)
[405.942733] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[406.030992] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.096s)
[406.042743] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[406.136624] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.107s)
[406.146843] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[406.226424] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.087s)
[406.237476] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[406.317441] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.090s)
[406.329219] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[406.401976] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.085s)
[406.413824] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[406.499628] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.097s)
[406.511158] Starting dynamic subtest: drm_test_damage_iter_single_damage
[406.597333] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.097s)
[406.608788] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[406.698476] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.100s)
[406.710364] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[406.781707] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.082s)
[406.793219] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[406.876496] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.094s)
[406.887529] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[406.966427] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.089s)
[406.980621] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[407.074551] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.106s)
[407.084683] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[407.150812] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.076s)
[407.162621] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[407.230567] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.079s)
[407.240688] Starting dynamic subtest: drm_test_damage_iter_damage
[407.321760] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.091s)
[407.331875] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[407.426830] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.103s)
[407.436787] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[407.520179] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.093s)
[407.531039] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[407.607179] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.087s)
[407.618494] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[407.688283] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.080s)
[407.690163] Subtest drm_damage_helper: SUCCESS (1.961s)
[407.859883] [106/133] (613s left) prime_mmap (test_correct_cpu_write)
[407.916069] Starting subtest: test_correct_cpu_write
[407.917866] Starting dynamic subtest: test_correct_cpu_write-smem
[407.919811] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[407.921621] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[408.032974] [107/133] (613s left) gen9_exec_parse (secure-batches)
[408.087832] Subtest secure-batches: SKIP (0.000s)
[408.156945] [108/133] (613s left) kms_atomic (plane-immutable-zpos)
[408.261457] Starting subtest: plane-immutable-zpos
[408.263311] Starting dynamic subtest: pipe-A-eDP-1
[408.906767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s)
[408.909494] Subtest plane-immutable-zpos: SUCCESS (0.644s)
[409.763138] [109/133] (612s left) gem_exec_nop (basic-parallel)
[409.828693] Starting subtest: basic-parallel
[425.311606] Subtest basic-parallel: SUCCESS (15.492s)
[425.553279] [110/133] (596s left) kms_psr (fbc-psr-sprite-render)
[425.648154] Starting subtest: fbc-psr-sprite-render
[425.650418] Starting dynamic subtest: eDP-1
[425.654731] Dynamic subtest eDP-1: SKIP (0.000s)
[425.659160] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[425.727315] [111/133] (596s left) gem_fenced_exec_thrash (2-spare-fences)
[425.782195] Subtest 2-spare-fences: SKIP (0.000s)
[425.851851] [112/133] (596s left) perf_pmu (idle)
[425.892164] Starting subtest: idle
[425.894516] Starting dynamic subtest: rcs0
[426.435831] Dynamic subtest rcs0: SUCCESS (0.543s)
[426.450080] Starting dynamic subtest: bcs0
[426.952292] Dynamic subtest bcs0: SUCCESS (0.514s)
[426.963692] Starting dynamic subtest: vcs0
[427.468914] Dynamic subtest vcs0: SUCCESS (0.513s)
[427.480176] Starting dynamic subtest: vcs1
[427.986673] Dynamic subtest vcs1: SUCCESS (0.514s)
[428.001234] Starting dynamic subtest: vecs0
[428.519047] Dynamic subtest vecs0: SUCCESS (0.530s)
[428.532836] Starting dynamic subtest: ccs0
[429.041704] Dynamic subtest ccs0: SUCCESS (0.519s)
[429.044619] Subtest idle: SUCCESS (3.151s)
[429.150983] [113/133] (592s left) kms_vblank (wait-busy-hang)
[429.244301] Starting subtest: wait-busy-hang
[429.246473] Starting dynamic subtest: pipe-A-eDP-1
[456.149853] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.905s)
[456.165926] Starting dynamic subtest: pipe-D-eDP-1
[481.068576] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.914s)
[481.070813] Subtest wait-busy-hang: SUCCESS (51.824s)
[481.934348] [114/133] (540s left) gem_exec_balancer (noheartbeat)
[482.192081] Starting subtest: noheartbeat
[482.196618] Subtest noheartbeat: SKIP (0.000s)
[482.296677] [115/133] (539s left) kms_hdr (brightness-with-hdr)
[482.387815] Starting subtest: brightness-with-hdr
[482.394390] Subtest brightness-with-hdr: SKIP (0.000s)
[482.475550] [116/133] (539s left) kms_flip (blocking-wf_vblank)
[482.572661] Starting subtest: blocking-wf_vblank
[482.574808] Starting dynamic subtest: A-eDP1
[491.482068] Dynamic subtest A-eDP1: SUCCESS (8.910s)
[491.496772] Starting dynamic subtest: B-eDP1
[500.404913] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[500.418616] Starting dynamic subtest: C-eDP1
[509.332954] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[509.347237] Starting dynamic subtest: D-eDP1
[518.267607] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[518.270083] Subtest blocking-wf_vblank: SUCCESS (35.698s)
[519.507642] [117/133] (502s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[519.593394] Starting subtest: pixel-format-linear-modifier-source-clamping
[519.621749] Starting dynamic subtest: pipe-A-plane-0
[520.199258] Dynamic subtest pipe-A-plane-0: SUCCESS (0.577s)
[520.210170] Starting dynamic subtest: pipe-A-plane-3
[520.621876] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[521.703198] Starting dynamic subtest: pipe-B-plane-0
[522.294560] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s)
[522.305796] Starting dynamic subtest: pipe-B-plane-3
[522.771281] Dynamic subtest pipe-B-plane-3: SUCCESS (0.475s)
[523.085746] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.491s)
[523.902052] [118/133] (498s left) gem_lmem_swapping (heavy-verify-multi)
[523.944375] Subtest heavy-verify-multi: SKIP (0.000s)
[523.986487] [119/133] (498s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[524.081312] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[528.596945] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.519s)
[529.789507] [120/133] (492s left) kms_big_fb (4-tiled-addfb-size-overflow)
[529.888791] Starting subtest: 4-tiled-addfb-size-overflow
[529.891195] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[529.988569] [121/133] (492s left) gem_vm_create (invalid-create)
[530.035663] Starting subtest: invalid-create
[530.040838] Subtest invalid-create: SUCCESS (0.002s)
[530.151894] [122/133] (492s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[530.235792] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[530.237977] Starting dynamic subtest: pipe-A-eDP-1
[530.262626] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.277636] Starting dynamic subtest: pipe-B-eDP-1
[530.301285] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.311392] Starting dynamic subtest: pipe-C-eDP-1
[530.335701] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.349467] Starting dynamic subtest: pipe-D-eDP-1
[530.373157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.377524] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[532.552442] [123/133] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[532.655734] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[539.740373] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.088s)
[539.854756] [124/133] (482s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[539.945704] Starting subtest: fbc-psr2-cursor-mmap-cpu
[539.947918] Starting dynamic subtest: eDP-1
[539.952022] Dynamic subtest eDP-1: SKIP (0.000s)
[539.956144] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[540.023900] [125/133] (482s left) syncobj_basic (bad-create-flags)
[540.074803] Starting subtest: bad-create-flags
[540.076936] Subtest bad-create-flags: SUCCESS (0.000s)
[540.161609] [126/133] (482s left) perf (enable-disable)
[540.288549] Starting subtest: enable-disable
[540.290725] Starting dynamic subtest: 0-rcs0
[542.554838] Dynamic subtest 0-rcs0: SUCCESS (2.267s)
[542.567551] Starting dynamic subtest: 1-vcs0
[547.063851] Dynamic subtest 1-vcs0: SUCCESS (4.507s)
[547.066183] Subtest enable-disable: SUCCESS (6.776s)
[547.109182] [127/133] (475s left) gem_ctx_shared (q-smoketest)
[547.173161] Starting subtest: Q-smoketest
[547.175177] Starting dynamic subtest: rcs0
[552.717863] Dynamic subtest rcs0: SUCCESS (5.502s)
[552.729737] Starting dynamic subtest: bcs0
[558.233378] Dynamic subtest bcs0: SUCCESS (5.511s)
[558.246286] Starting dynamic subtest: vcs0
[563.712189] Dynamic subtest vcs0: SUCCESS (5.477s)
[563.724864] Starting dynamic subtest: vcs1
[569.201486] Dynamic subtest vcs1: SUCCESS (5.484s)
[569.215345] Starting dynamic subtest: vecs0
[574.677054] Dynamic subtest vecs0: SUCCESS (5.481s)
[574.688594] Starting dynamic subtest: ccs0
[580.173584] Dynamic subtest ccs0: SUCCESS (5.490s)
[580.175653] Subtest Q-smoketest: SUCCESS (32.954s)
[580.318463] [128/133] (442s left) gem_exec_flush (basic-wb-rw-before-default)
[580.375136] Starting subtest: basic-wb-rw-before-default
[585.835477] Subtest basic-wb-rw-before-default: SUCCESS (5.460s)
[586.029788] [129/133] (436s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[586.129187] Starting subtest: psr-rgb565-draw-mmap-wc
[593.095177] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.969s)
[593.212440] [130/133] (429s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[593.310646] Starting subtest: crc-primary-basic-yf-tiled-ccs
[593.312970] Starting dynamic subtest: pipe-A-eDP-1
[593.335608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[593.349744] Starting dynamic subtest: pipe-B-eDP-1
[593.371643] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[593.381954] Starting dynamic subtest: pipe-C-eDP-1
[593.402537] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[593.412737] Starting dynamic subtest: pipe-D-eDP-1
[593.435358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[593.439396] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[595.602312] [131/133] (427s left) kms_cursor_legacy (forked-move)
[595.730719] Starting subtest: forked-move
[595.732828] Starting dynamic subtest: pipe-A
[601.214704] Dynamic subtest pipe-A: SUCCESS (5.482s)
[601.227763] Starting dynamic subtest: pipe-B
[606.708893] Dynamic subtest pipe-B: SUCCESS (5.490s)
[606.726265] Starting dynamic subtest: pipe-C
[612.185819] Dynamic subtest pipe-C: SUCCESS (5.474s)
[612.205541] Starting dynamic subtest: pipe-D
[617.666066] Dynamic subtest pipe-D: SUCCESS (5.478s)
[617.679492] Starting dynamic subtest: all-pipes
[623.178071] Dynamic subtest all-pipes: SUCCESS (5.509s)
[623.180512] Subtest forked-move: SUCCESS (27.446s)
[623.325900] [132/133] (399s left) prime_vgem (fence-wait)
[623.391668] Starting subtest: fence-wait
[623.393986] Starting dynamic subtest: rcs0
[624.442479] Dynamic subtest rcs0: SUCCESS (1.049s)
[624.453849] Starting dynamic subtest: bcs0
[625.499303] Dynamic subtest bcs0: SUCCESS (1.056s)
[625.510775] Starting dynamic subtest: vcs0
[626.543440] Dynamic subtest vcs0: SUCCESS (1.043s)
[626.557211] Starting dynamic subtest: vcs1
[627.584420] Dynamic subtest vcs1: SUCCESS (1.040s)
[627.597978] Starting dynamic subtest: vecs0
[628.628569] Dynamic subtest vecs0: SUCCESS (1.042s)
[628.641507] Starting dynamic subtest: ccs0
[629.670361] Dynamic subtest ccs0: SUCCESS (1.039s)
[629.673224] Subtest fence-wait: SUCCESS (6.278s)
[629.805841] [133/133] (393s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[629.915326] Starting subtest: 2x-absolute-wf_vblank-interruptible
[629.927186] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[630.026626] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: kms_dsc
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_ctx_exec
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: device_reset
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: gem_tiled_swapping
results: parsing output: 27/ for test: kms_plane_multiple
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: gem_reg_read
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: fbdev
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: i915_query
results: parsing output: 52/ for test: kms_pm_dc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_atomic_interruptible
results: parsing output: 55/ for test: gem_basic
results: parsing output: 56/ for test: sysfs_timeslice_duration
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_color
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: gem_unref_active_buffers
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: prime_udl
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: i915_drm_fdinfo
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_selftest
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: kms_atomic
results: parsing output: 108/ for test: gem_exec_nop
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_fenced_exec_thrash
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_vm_create
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: syncobj_basic
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_ctx_shared
results: parsing output: 127/ for test: gem_exec_flush
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: prime_vgem
results: parsing output: 132/ for test: kms_flip
Done.