[57.117356] Initializing watchdogs
[57.117402]   /dev/watchdog0
[57.132431] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.136874] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.138904] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.140701] [001/131] (960s left) gem_eio (wait-1us)
[57.290949] Starting subtest: wait-1us
[57.494924] Subtest wait-1us: SUCCESS (0.205s)
[57.651478] [002/131] (960s left) kms_psr (fbc-psr-cursor-plane-onoff)
[57.736093] Starting subtest: fbc-psr-cursor-plane-onoff
[57.737078] Starting dynamic subtest: eDP-1
[57.738923] Dynamic subtest eDP-1: SKIP (0.000s)
[57.740743] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[57.822827] [003/131] (959s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[57.922528] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[57.924449] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[58.030346] [004/131] (959s left) gem_ctx_param (invalid-set-ringsize)
[58.074399] Starting subtest: invalid-set-ringsize
[58.075454] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[58.140496] [005/131] (959s left) gem_create (create-valid-nonaligned)
[58.196318] Starting subtest: create-valid-nonaligned
[58.197463] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[58.396868] [006/131] (959s left) gem_exec_whisper (basic-contexts-forked)
[58.458934] Starting subtest: basic-contexts-forked
[83.205088] Subtest basic-contexts-forked: SUCCESS (24.743s)
[83.397284] [007/131] (934s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[83.452347] Starting subtest: y-tiled-to-vebox-x-tiled
[83.454065] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[83.639130] [008/131] (934s left) gem_mmap_wc (set-cache-level)
[83.699591] Subtest set-cache-level: SKIP (0.000s)
[83.759345] [009/131] (934s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[83.884202] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[83.886726] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[84.035200] [010/131] (933s left) perf_pmu (multi-client)
[84.065156] Starting subtest: multi-client
[84.066103] Starting dynamic subtest: rcs0
[85.127732] Dynamic subtest rcs0: SUCCESS (1.060s)
[85.134668] Starting dynamic subtest: bcs0
[86.180462] Dynamic subtest bcs0: SUCCESS (1.051s)
[86.188615] Starting dynamic subtest: vcs0
[87.233767] Dynamic subtest vcs0: SUCCESS (1.051s)
[87.243084] Starting dynamic subtest: vcs1
[88.913070] Dynamic subtest vcs1: SUCCESS (1.678s)
[88.922508] Starting dynamic subtest: vecs0
[90.893276] Dynamic subtest vecs0: SUCCESS (1.979s)
[90.901543] Starting dynamic subtest: ccs0
[92.942445] Dynamic subtest ccs0: SUCCESS (2.048s)
[92.943609] Subtest multi-client: SUCCESS (8.875s)
[93.060174] [011/131] (924s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[93.152611] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[100.083332] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.931s)
[100.214970] [012/131] (917s left) gem_softpin (allocator-nopin)
[100.271541] Starting subtest: allocator-nopin
[100.381221] Subtest allocator-nopin: SUCCESS (0.108s)
[100.550317] [013/131] (917s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[100.661911] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[117.800023] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.137s)
[118.598225] [014/131] (899s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[118.689241] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[118.690128] Starting dynamic subtest: pipe-A-eDP-1
[118.712046] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[118.719388] Starting dynamic subtest: pipe-B-eDP-1
[118.741095] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[118.747791] Starting dynamic subtest: pipe-C-eDP-1
[118.769833] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[118.777060] Starting dynamic subtest: pipe-D-eDP-1
[118.798136] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[118.799788] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[120.857222] [015/131] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[120.953600] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[120.955284] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[121.079258] [016/131] (897s left) perf (whitelisted-registers-userspace-config)
[121.204815] Starting subtest: whitelisted-registers-userspace-config
[121.205674] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[121.237845] [017/131] (896s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[121.321635] Starting subtest: fbc-pr-cursor-mmap-cpu
[121.323473] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[121.394624] [018/131] (896s left) gem_mmap_gtt (ptrace)
[121.434764] Subtest ptrace: SKIP (0.000s)
[121.491830] [019/131] (896s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[121.572905] Starting subtest: psr-rgb101010-draw-pwrite
[129.027481] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.455s)
[129.156734] [020/131] (889s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[129.237839] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[129.238942] Starting dynamic subtest: pipe-A-eDP-1
[129.248432] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.256133] Starting dynamic subtest: pipe-B-eDP-1
[129.264862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.271727] Starting dynamic subtest: pipe-C-eDP-1
[129.280171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.286922] Starting dynamic subtest: pipe-D-eDP-1
[129.295361] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.297046] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[131.453455] [021/131] (886s left) kms_vblank (wait-busy)
[131.536167] Starting subtest: wait-busy
[131.537035] Starting dynamic subtest: pipe-A-eDP-1
[133.415706] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[133.424284] Starting dynamic subtest: pipe-D-eDP-1
[135.989482] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.574s)
[135.990374] Subtest wait-busy: SUCCESS (4.454s)
[136.804793] [022/131] (881s left) kms_rotation_crc (sprite-rotation-90)
[136.894129] Starting subtest: sprite-rotation-90
[136.895972] Subtest sprite-rotation-90: SKIP (0.001s)
[136.969535] [023/131] (881s left) vgem_slow (nohang)
[137.075775] Starting subtest: nohang
[147.573064] Subtest nohang: SUCCESS (10.495s)
[147.643830] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[147.645747] [024/131] (870s left) kms_sharpness_filter (filter-basic)
[147.738789] Starting subtest: filter-basic
[147.744498] Subtest filter-basic: SKIP (0.001s)
[147.829119] [025/131] (870s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[147.919635] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[147.921450] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[148.048909] [026/131] (870s left) kms_psr (fbc-pr-suspend)
[148.126748] Starting subtest: fbc-pr-suspend
[148.128626] Subtest fbc-pr-suspend: SKIP (0.000s)
[148.215209] [027/131] (870s left) kms_big_fb (y-tiled-addfb-size-overflow)
[148.313748] Starting subtest: y-tiled-addfb-size-overflow
[148.315467] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[148.447942] [028/131] (870s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[148.543484] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[148.545389] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[148.640802] [029/131] (869s left) gem_exec_parallel (engines)
[148.697574] Starting subtest: engines
[148.698559] Starting dynamic subtest: basic
[150.872833] Dynamic subtest basic: SUCCESS (2.172s)
[150.882936] Starting dynamic subtest: contexts
[155.381201] Dynamic subtest contexts: SUCCESS (4.506s)
[155.391267] Starting dynamic subtest: fds
[159.237110] Dynamic subtest fds: SUCCESS (3.854s)
[159.246831] Starting dynamic subtest: userptr
[160.944079] Dynamic subtest userptr: SUCCESS (1.705s)
[160.945239] Subtest engines: SUCCESS (12.244s)
[161.138998] [030/131] (857s left) kms_invalid_mode (clock-too-high)
[161.232595] Starting subtest: clock-too-high
[161.233583] Starting dynamic subtest: pipe-A-eDP-1
[161.235564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.246257] Starting dynamic subtest: pipe-B-eDP-1
[161.248380] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.257395] Starting dynamic subtest: pipe-C-eDP-1
[161.259306] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.265819] Starting dynamic subtest: pipe-D-eDP-1
[161.267626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.269431] Subtest clock-too-high: SKIP (0.003s)
[161.312791] [031/131] (857s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[161.411499] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[162.324592] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.913s)
[162.487116] [032/131] (856s left) gem_lmem_swapping (parallel-random-engines)
[162.529032] Subtest parallel-random-engines: SKIP (0.000s)
[162.571803] [033/131] (856s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[162.658227] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[162.659156] Starting dynamic subtest: pipe-A-eDP-1
[162.681418] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[162.689460] Starting dynamic subtest: pipe-B-eDP-1
[162.711148] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[162.718061] Starting dynamic subtest: pipe-C-eDP-1
[162.738740] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[162.745553] Starting dynamic subtest: pipe-D-eDP-1
[162.765949] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[162.767521] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[164.892399] [034/131] (853s left) syncobj_eventfd (binary-wait)
[164.939693] Starting subtest: binary-wait
[164.950201] Subtest binary-wait: SUCCESS (0.011s)
[165.029997] [035/131] (853s left) gem_exec_params (invalid-flag)
[165.080499] Starting subtest: invalid-flag
[165.081616] Subtest invalid-flag: SUCCESS (0.000s)
[165.194306] [036/131] (853s left) kms_vrr (seamless-rr-switch-vrr)
[165.279881] Starting subtest: seamless-rr-switch-vrr
[165.282495] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[165.372702] [037/131] (853s left) gem_partial_pwrite_pread (reads-snoop)
[165.425955] Subtest reads-snoop: SKIP (0.000s)
[165.488261] [038/131] (853s left) kms_cursor_crc (cursor-alpha-opaque)
[165.579585] Starting subtest: cursor-alpha-opaque
[165.580541] Starting dynamic subtest: pipe-A-eDP-1
[166.186739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[166.194511] Starting dynamic subtest: pipe-D-eDP-1
[167.450576] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.263s)
[167.451548] Subtest cursor-alpha-opaque: SUCCESS (1.872s)
[168.257284] [039/131] (850s left) perf (per-context-mode-unprivileged)
[168.362374] Starting subtest: per-context-mode-unprivileged
[168.364284] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[168.395460] [040/131] (850s left) perf_pmu (enable-race)
[168.426898] Starting subtest: enable-race
[168.428163] Starting dynamic subtest: rcs0
[181.202965] Dynamic subtest rcs0: SUCCESS (12.776s)
[181.212338] Starting dynamic subtest: bcs0
[193.947401] Dynamic subtest bcs0: SUCCESS (12.742s)
[193.959385] Starting dynamic subtest: vcs0
[209.943378] Dynamic subtest vcs0: SUCCESS (15.991s)
[209.953292] Starting dynamic subtest: vcs1
[225.879392] Dynamic subtest vcs1: SUCCESS (15.934s)
[225.888734] Starting dynamic subtest: vecs0
[241.945859] Dynamic subtest vecs0: SUCCESS (16.064s)
[241.956068] Starting dynamic subtest: ccs0
[254.686879] Dynamic subtest ccs0: SUCCESS (12.742s)
[254.688124] Subtest enable-race: SUCCESS (86.260s)
[254.805629] [041/131] (764s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[254.902720] Starting subtest: x-tiled-8bpp-rotate-90
[254.926111] Subtest x-tiled-8bpp-rotate-90: SKIP (0.023s)
[255.070081] [042/131] (763s left) gem_exec_reloc (basic-gtt-wc-active)
[255.125372] Subtest basic-gtt-wc-active: SKIP (0.000s)
[255.202569] [043/131] (763s left) gen9_exec_parse (allowed-single)
[255.256142] Subtest allowed-single: SKIP (0.000s)
[255.314291] [044/131] (763s left) syncobj_timeline (single-wait-available-signaled)
[255.360930] Starting subtest: single-wait-available-signaled
[255.362175] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[255.467285] [045/131] (763s left) gem_basic (multigpu-create-close)
[255.511975] Starting subtest: multigpu-create-close
[255.513967] Subtest multigpu-create-close: SKIP (0.000s)
[255.613411] [046/131] (763s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[255.694477] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[255.695456] Starting dynamic subtest: pipe-A
[256.034580] Dynamic subtest pipe-A: SUCCESS (0.341s)
[256.043361] Starting dynamic subtest: pipe-B
[257.437739] Dynamic subtest pipe-B: SUCCESS (1.402s)
[257.446536] Starting dynamic subtest: pipe-C
[258.873797] Dynamic subtest pipe-C: SUCCESS (1.435s)
[258.882705] Starting dynamic subtest: pipe-D
[260.297889] Dynamic subtest pipe-D: SUCCESS (1.423s)
[260.298925] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.605s)
[261.474394] [047/131] (757s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[262.991740] Starting subtest: dpms-mode-unset-non-lpsp
[264.138071] Subtest dpms-mode-unset-non-lpsp: SKIP (1.146s)
[264.532339] [048/131] (754s left) kms_cursor_edge_walk (256x256-right-edge)
[264.621527] Starting subtest: 256x256-right-edge
[264.622532] Starting dynamic subtest: pipe-A-eDP-1
[268.062523] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s)
[268.069672] Starting dynamic subtest: pipe-D-eDP-1
[271.187531] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[271.188358] Subtest 256x256-right-edge: SUCCESS (6.567s)
[272.027366] [049/131] (747s left) kms_properties (connector-properties-atomic)
[272.116280] Starting subtest: connector-properties-atomic
[272.117232] Starting dynamic subtest: pipe-A-eDP-1
[279.891275] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.774s)
[279.898524] Starting dynamic subtest: pipe-None-DP-1
[279.900730] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[279.907656] Starting dynamic subtest: pipe-None-HDMI-A-1
[279.909563] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[279.916446] Starting dynamic subtest: pipe-None-DP-2
[279.918714] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[279.925435] Starting dynamic subtest: pipe-None-HDMI-A-2
[279.927112] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[279.933623] Starting dynamic subtest: pipe-None-DP-3
[279.935402] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[279.941876] Starting dynamic subtest: pipe-None-DP-4
[279.943675] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[279.944596] Subtest connector-properties-atomic: SUCCESS (7.784s)
[280.757649] [050/131] (738s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[280.846543] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[287.512416] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.667s)
[287.688317] [051/131] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[287.787815] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[294.215302] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.429s)
[294.368438] [052/131] (724s left) kms_joiner (invalid-modeset-ultra-joiner)
[294.465541] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[294.538444] [053/131] (724s left) syncobj_timeline (wait-delayed-signal)
[294.594721] Starting subtest: wait-delayed-signal
[294.699994] Subtest wait-delayed-signal: SUCCESS (0.103s)
[294.790783] [054/131] (724s left) gem_eio (in-flight-10ms)
[295.013281] Starting subtest: in-flight-10ms
[303.917269] Subtest in-flight-10ms: SUCCESS (8.904s)
[304.111891] [055/131] (715s left) kms_busy (extended-pageflip-hang-oldfb)
[304.196371] Starting subtest: extended-pageflip-hang-oldfb
[304.197317] Starting dynamic subtest: pipe-A
[304.609935] Dynamic subtest pipe-A: SUCCESS (0.412s)
[304.618749] Starting dynamic subtest: pipe-D
[305.701957] Dynamic subtest pipe-D: SUCCESS (1.089s)
[305.702941] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.507s)
[306.574661] [056/131] (712s left) kms_chamelium_color (gamma)
[306.663490] Subtest gamma: SKIP (0.000s)
[306.703191] [057/131] (712s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[306.785297] Starting subtest: stress-xrgb8888-yftiled
[306.787116] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[306.852909] [058/131] (712s left) kms_addfb_basic (addfb25-4-tiled)
[306.945710] Starting subtest: addfb25-4-tiled
[306.946665] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[307.077345] [059/131] (712s left) gem_userptr_blits (unsync-unmap-after-close)
[307.139205] Subtest unsync-unmap-after-close: SKIP (0.000s)
[307.276216] [060/131] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[307.374883] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[314.036909] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.662s)
[314.169474] [061/131] (705s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[314.260200] Starting subtest: primary-y-tiled-reflect-x-180
[314.322161] Subtest primary-y-tiled-reflect-x-180: SKIP (0.061s)
[314.431591] [062/131] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[314.524368] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[318.445244] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.921s)
[319.584708] [063/131] (700s left) gem_exec_params (sol-reset-not-gen7)
[319.644102] Starting subtest: sol-reset-not-gen7
[319.646468] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[319.799289] [064/131] (699s left) kms_big_fb (linear-8bpp-rotate-0)
[319.900279] Starting subtest: linear-8bpp-rotate-0
[321.136176] Subtest linear-8bpp-rotate-0: SUCCESS (1.236s)
[321.271017] [065/131] (698s left) kms_atomic (test-only)
[321.347534] Starting subtest: test-only
[321.396627] Starting dynamic subtest: pipe-A-eDP-1
[323.837680] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.441s)
[323.838588] Subtest test-only: SUCCESS (2.491s)
[324.660580] [066/131] (695s left) gem_workarounds (suspend-resume-context)
[324.733632] Starting subtest: suspend-resume-context
[340.728440] Subtest suspend-resume-context: SUCCESS (1.647s)
[348.899095] [067/131] (678s left) gem_exec_fence (basic-busy)
[349.078376] Starting subtest: basic-busy
[349.079486] Starting dynamic subtest: rcs0
[349.186078] Dynamic subtest rcs0: SUCCESS (0.107s)
[349.197311] Starting dynamic subtest: bcs0
[349.251281] Dynamic subtest bcs0: SUCCESS (0.063s)
[349.264535] Starting dynamic subtest: vcs0
[349.312452] Dynamic subtest vcs0: SUCCESS (0.059s)
[349.325053] Starting dynamic subtest: vcs1
[349.380257] Dynamic subtest vcs1: SUCCESS (0.065s)
[349.396725] Starting dynamic subtest: vecs0
[349.442336] Dynamic subtest vecs0: SUCCESS (0.060s)
[349.454336] Starting dynamic subtest: ccs0
[349.510394] Dynamic subtest ccs0: SUCCESS (0.065s)
[349.511864] Subtest basic-busy: SUCCESS (0.433s)
[351.401023] [068/131] (676s left) gem_ctx_shared (exec-shared-gtt)
[351.462053] Starting subtest: exec-shared-gtt
[351.463482] Starting dynamic subtest: rcs0
[351.474194] Dynamic subtest rcs0: SUCCESS (0.012s)
[351.483111] Starting dynamic subtest: bcs0
[351.484028] Dynamic subtest bcs0: SUCCESS (0.008s)
[351.491917] Starting dynamic subtest: vcs0
[351.494188] Dynamic subtest vcs0: SUCCESS (0.010s)
[351.502331] Starting dynamic subtest: vcs1
[351.505496] Dynamic subtest vcs1: SUCCESS (0.011s)
[351.514912] Starting dynamic subtest: vecs0
[351.515841] Dynamic subtest vecs0: SUCCESS (0.008s)
[351.524501] Starting dynamic subtest: ccs0
[351.525363] Dynamic subtest ccs0: SUCCESS (0.007s)
[351.526206] Subtest exec-shared-gtt: SUCCESS (0.061s)
[351.716400] [069/131] (676s left) api_intel_allocator (open-vm)
[351.771344] Starting subtest: open-vm
[351.777721] Subtest open-vm: SUCCESS (0.008s)
[351.923882] [070/131] (675s left) kms_prop_blob (invalid-set-prop)
[351.980838] Starting subtest: invalid-set-prop
[351.981740] Subtest invalid-set-prop: SUCCESS (0.000s)
[352.099178] [071/131] (675s left) kms_color (legacy-gamma-reset)
[352.191670] Starting subtest: legacy-gamma-reset
[352.192655] Starting dynamic subtest: pipe-A-eDP-1
[352.562896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[352.573005] Starting dynamic subtest: pipe-B-eDP-1
[352.575071] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[352.583054] Starting dynamic subtest: pipe-C-eDP-1
[352.586508] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[352.594402] Starting dynamic subtest: pipe-D-eDP-1
[352.598107] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[352.598981] Subtest legacy-gamma-reset: SUCCESS (0.409s)
[353.429638] [072/131] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[353.524317] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[353.526181] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[353.635210] [073/131] (674s left) i915_pm_rpm (sysfs-read)
[355.347727] Starting subtest: sysfs-read
[356.506122] Subtest sysfs-read: SUCCESS (1.154s)
[356.870045] [074/131] (671s left) gem_ctx_persistence (hostile)
[356.924247] Starting subtest: hostile
[367.079282] Subtest hostile: SUCCESS (10.146s)
[367.207483] [075/131] (660s left) kms_frontbuffer_tracking (fbc-1p-rte)
[367.302365] Starting subtest: fbc-1p-rte
[372.757114] Subtest fbc-1p-rte: SUCCESS (5.456s)
[373.973000] [076/131] (654s left) kms_plane_multiple (tiling-x)
[374.063142] Starting subtest: tiling-x
[374.064061] Starting dynamic subtest: pipe-A-eDP-1
[377.795807] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.731s)
[377.804201] Starting dynamic subtest: pipe-B-eDP-1
[382.150384] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.353s)
[382.159115] Starting dynamic subtest: pipe-C-eDP-1
[386.500182] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.346s)
[386.510759] Starting dynamic subtest: pipe-D-eDP-1
[390.822687] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.321s)
[390.823744] Subtest tiling-x: SUCCESS (16.757s)
[391.656952] [077/131] (636s left) gem_exec_fence (submit67)
[391.835111] Starting subtest: submit67
[391.837398] Subtest submit67: SKIP (0.000s)
[393.361961] [078/131] (634s left) kms_flip (bo-too-big)
[393.446123] Starting subtest: bo-too-big
[393.448337] Starting dynamic subtest: A-eDP1
[394.793764] Dynamic subtest A-eDP1: SUCCESS (1.345s)
[394.803850] Starting dynamic subtest: B-eDP1
[396.127961] Dynamic subtest B-eDP1: SUCCESS (1.333s)
[396.137994] Starting dynamic subtest: C-eDP1
[397.465757] Dynamic subtest C-eDP1: SUCCESS (1.337s)
[397.474545] Starting dynamic subtest: D-eDP1
[398.805511] Dynamic subtest D-eDP1: SUCCESS (1.338s)
[398.809890] Subtest bo-too-big: SUCCESS (5.361s)
[400.052050] [079/131] (628s left) kms_cursor_crc (cursor-onscreen-max-size)
[400.344609] Starting subtest: cursor-onscreen-max-size
[400.347786] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[400.497490] [080/131] (627s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[400.588113] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[400.589134] Starting dynamic subtest: pipe-A
[400.925651] Dynamic subtest pipe-A: SUCCESS (0.338s)
[400.936083] Starting dynamic subtest: pipe-B
[402.303493] Dynamic subtest pipe-B: SUCCESS (1.377s)
[402.312293] Starting dynamic subtest: pipe-C
[403.732663] Dynamic subtest pipe-C: SUCCESS (1.428s)
[403.743082] Starting dynamic subtest: pipe-D
[405.176493] Dynamic subtest pipe-D: SUCCESS (1.442s)
[405.177342] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.589s)
[406.357496] [081/131] (621s left) prime_mmap (test_dup)
[406.403741] Starting subtest: test_dup
[406.404683] Starting dynamic subtest: test_dup-smem
[406.452817] Dynamic subtest test_dup-smem: SUCCESS (0.050s)
[406.453824] Subtest test_dup: SUCCESS (0.051s)
[406.531017] [082/131] (621s left) syncobj_wait (multi-wait-for-submit-signaled)
[406.581383] Starting subtest: multi-wait-for-submit-signaled
[406.582315] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[406.695583] [083/131] (621s left) gem_pread (snoop)
[406.741590] Subtest snoop: SKIP (0.000s)
[406.796967] [084/131] (621s left) gem_exec_params (invalid-bsd-ring)
[406.849202] Starting subtest: invalid-bsd-ring
[406.850243] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[406.970571] [085/131] (621s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[407.048339] Starting subtest: multiplane-rotation-cropping-bottom
[414.366057] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.318s)
[414.501609] [086/131] (613s left) kms_force_connector_basic (force-load-detect)
[414.570153] Starting subtest: force-load-detect
[414.571985] Subtest force-load-detect: SKIP (0.000s)
[414.703473] [087/131] (613s left) kms_psr (psr2-primary-blt)
[414.799926] Starting subtest: psr2-primary-blt
[414.800846] Starting dynamic subtest: eDP-1
[416.528511] Dynamic subtest eDP-1: SUCCESS (1.728s)
[416.529431] Subtest psr2-primary-blt: SUCCESS (1.729s)
[417.429944] [088/131] (611s left) kms_addfb_basic (bad-pitch-1024)
[417.485769] Starting subtest: bad-pitch-1024
[417.486754] Subtest bad-pitch-1024: SUCCESS (0.000s)
[417.649848] [089/131] (610s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[417.732984] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[417.733988] Starting dynamic subtest: pipe-A-default-mode
[418.017278] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[418.019134] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.284s)
[418.849399] [090/131] (609s left) dumb_buffer (invalid-bpp)
[418.890649] Starting subtest: invalid-bpp
[418.891439] Subtest invalid-bpp: SUCCESS (0.000s)
[418.998108] [091/131] (609s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[424.015726] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[424.016744] Starting dynamic subtest: pipe-A-eDP-1
[424.827500] Dynamic subtest pipe-A-eDP-1: SKIP (0.810s)
[424.837492] Starting dynamic subtest: pipe-B-eDP-1
[425.953232] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[425.955105] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.938s)
[427.160736] [092/131] (601s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[427.256663] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[431.667396] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.410s)
[432.863972] [093/131] (595s left) kms_feature_discovery (display)
[432.954845] Starting subtest: display
[432.955661] Subtest display: SUCCESS (0.000s)
[433.033836] [094/131] (595s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[433.087057] Starting subtest: etime-multi-wait-available-unsubmitted
[433.189726] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.101s)
[433.284723] [095/131] (595s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[433.385820] Starting subtest: 4-tiled-64bpp-rotate-270
[433.406325] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[433.572531] [096/131] (595s left) gem_exec_flush (basic-uc-set-default)
[433.639182] Starting subtest: basic-uc-set-default
[439.091698] Subtest basic-uc-set-default: SUCCESS (5.452s)
[439.294528] [097/131] (589s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[439.389020] Starting subtest: fbcpsr-tiling-4
[446.423423] Subtest fbcpsr-tiling-4: SUCCESS (7.035s)
[446.591163] [098/131] (582s left) gem_exec_schedule (preempt-engines)
[446.667281] Starting subtest: preempt-engines
[446.668244] Starting dynamic subtest: rcs0
[448.925034] Dynamic subtest rcs0: SUCCESS (2.256s)
[448.936424] Starting dynamic subtest: bcs0
[451.174694] Dynamic subtest bcs0: SUCCESS (2.249s)
[451.185756] Starting dynamic subtest: vcs0
[453.493486] Dynamic subtest vcs0: SUCCESS (2.316s)
[453.502479] Starting dynamic subtest: vcs1
[455.762913] Dynamic subtest vcs1: SUCCESS (2.267s)
[455.772351] Starting dynamic subtest: vecs0
[458.031581] Dynamic subtest vecs0: SUCCESS (2.267s)
[458.042858] Starting dynamic subtest: ccs0
[460.319818] Dynamic subtest ccs0: SUCCESS (2.286s)
[460.321098] Subtest preempt-engines: SUCCESS (13.653s)
[460.623556] [099/131] (568s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[460.680009] Starting subtest: multi-wait-all-for-submit-available-signaled
[460.680886] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[460.801509] [100/131] (568s left) gem_exec_params (invalid-bsd1-flag-on-render)
[460.849452] Starting subtest: invalid-bsd1-flag-on-render
[460.850668] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[460.961644] [101/131] (567s left) kms_psr (psr2-sprite-plane-move)
[461.050874] Starting subtest: psr2-sprite-plane-move
[461.051768] Starting dynamic subtest: eDP-1
[462.784037] Dynamic subtest eDP-1: SUCCESS (1.732s)
[462.784969] Subtest psr2-sprite-plane-move: SUCCESS (1.733s)
[463.654013] [102/131] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[463.747242] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[463.749013] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[463.856897] [103/131] (565s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[463.939106] Starting subtest: blocking-absolute-wf_vblank-interruptible
[463.941319] Starting dynamic subtest: A-eDP1
[472.697694] Dynamic subtest A-eDP1: SUCCESS (8.756s)
[472.708377] Starting dynamic subtest: B-eDP1
[481.431728] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[481.443205] Starting dynamic subtest: C-eDP1
[490.153384] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[490.164514] Starting dynamic subtest: D-eDP1
[498.874661] Dynamic subtest D-eDP1: SUCCESS (8.719s)
[498.877846] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.937s)
[500.095839] [104/131] (528s left) i915_drm_fdinfo (memory-info-resident)
[500.127642] Starting subtest: memory-info-resident
[500.129202] Starting dynamic subtest: smem0
[502.911879] Dynamic subtest smem0: SUCCESS (2.783s)
[502.913504] Subtest memory-info-resident: SUCCESS (2.784s)
[502.993642] [105/131] (526s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[503.084648] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[503.086353] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[503.196513] [106/131] (525s left) gem_exec_balancer (full)
[503.241354] Starting subtest: full
[508.113229] Subtest full: SUCCESS (4.871s)
[508.456998] [107/131] (520s left) gem_exec_reloc (basic-write-gtt-noreloc)
[508.503274] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[508.567370] [108/131] (520s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[508.666205] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[515.272031] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.603s)
[515.403413] [109/131] (513s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[515.501779] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[519.773532] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.272s)
[520.913787] [110/131] (508s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[521.005363] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[521.007515] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[521.130359] [111/131] (508s left) kms_flip (2x-flip-vs-fences-interruptible)
[521.221289] Starting subtest: 2x-flip-vs-fences-interruptible
[521.223399] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[521.319295] [112/131] (508s left) perf (short-reads)
[521.397904] Starting subtest: short-reads
[521.414173] Subtest short-reads: SUCCESS (0.016s)
[521.449971] [113/131] (507s left) gem_ccs (suspend-resume)
[521.495414] Starting subtest: suspend-resume
[521.497620] Subtest suspend-resume: SKIP (0.000s)
[521.617242] [114/131] (507s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[521.704329] Starting subtest: fb-8bpc-vs-panel-8bpc
[521.705405] Starting dynamic subtest: pipe-A-eDP-1
[523.077511] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.373s)
[523.078873] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.375s)
[523.896344] [115/131] (505s left) kms_chamelium_frames (dp-frame-dump)
[524.266665] Subtest dp-frame-dump: SKIP (0.000s)
[525.075026] [116/131] (504s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[525.163642] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[525.164667] Starting dynamic subtest: pipe-A-default-mode
[525.457419] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[525.459551] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.293s)
[526.344311] [117/131] (503s left) api_intel_bb (lot-of-buffers)
[526.389889] Starting subtest: lot-of-buffers
[527.422253] Subtest lot-of-buffers: SUCCESS (1.031s)
[527.872799] [118/131] (501s left) gem_render_copy (yf-tiled-ccs-to-linear)
[527.927819] Starting subtest: yf-tiled-ccs-to-linear
[527.929622] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[528.123253] [119/131] (501s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[528.489647] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[529.340833] [120/131] (500s left) i915_query (engine-info-invalid)
[529.392047] Starting subtest: engine-info-invalid
[529.392884] Subtest engine-info-invalid: SUCCESS (0.000s)
[529.528703] [121/131] (500s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[529.585138] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[529.586406] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[529.714540] [122/131] (499s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[529.796250] Starting subtest: bad-rotation-90-yf-tiled-ccs
[529.797104] Starting dynamic subtest: pipe-A-eDP-1
[529.805787] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[529.815431] Starting dynamic subtest: pipe-B-eDP-1
[529.823835] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[529.832126] Starting dynamic subtest: pipe-C-eDP-1
[529.840346] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[529.848968] Starting dynamic subtest: pipe-D-eDP-1
[529.857082] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[529.858704] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[531.972636] [123/131] (497s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[536.932052] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[536.933084] Starting dynamic subtest: pipe-A-eDP-1
[554.116324] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.180s)
[554.126860] Starting dynamic subtest: pipe-B-eDP-1
[571.236324] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.114s)
[571.237624] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.301s)
[572.056624] [124/131] (457s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[572.146961] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[572.147890] Starting dynamic subtest: pipe-A-default-mode
[572.431491] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[572.433314] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.284s)
[573.290907] [125/131] (456s left) gem_exec_whisper (basic-queues-priority)
[573.352336] Starting subtest: basic-queues-priority
[596.399492] Subtest basic-queues-priority: SUCCESS (23.044s)
[596.588969] [126/131] (433s left) gem_sync (basic-all)
[596.640315] Starting subtest: basic-all
[599.743732] Subtest basic-all: SUCCESS (3.104s)
[599.940172] [127/131] (429s left) gem_ppgtt (shrink-vs-evict-any)
[599.983143] Starting subtest: shrink-vs-evict-any
[605.252072] Subtest shrink-vs-evict-any: SUCCESS (5.265s)
[605.341122] [128/131] (424s left) vgem_basic (bad-pad)
[605.380110] Starting subtest: bad-pad
[605.381390] Subtest bad-pad: SUCCESS (0.000s)
[605.442798] [129/131] (424s left) gem_exec_schedule (smoketest)
[605.618804] Starting subtest: smoketest
[605.619730] Starting dynamic subtest: rcs0
[611.151966] Dynamic subtest rcs0: SUCCESS (5.508s)
[611.169044] Starting dynamic subtest: bcs0
[616.671914] Dynamic subtest bcs0: SUCCESS (5.518s)
[616.682638] Starting dynamic subtest: vcs0
[622.164873] Dynamic subtest vcs0: SUCCESS (5.486s)
[622.179006] Starting dynamic subtest: vcs1
[627.657143] Dynamic subtest vcs1: SUCCESS (5.492s)
[627.678432] Starting dynamic subtest: vecs0
[633.144091] Dynamic subtest vecs0: SUCCESS (5.491s)
[633.155443] Starting dynamic subtest: ccs0
[638.642627] Dynamic subtest ccs0: SUCCESS (5.501s)
[638.643505] Subtest smoketest: SUCCESS (33.004s)
[638.817401] [130/131] (391s left) i915_module_load (reload-no-display)
[638.844670] Starting subtest: reload-no-display
[645.206769] Subtest reload-no-display: SUCCESS (6.360s)
[645.229018] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[645.229896] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[645.231913] [131/131] (384s left) gem_wait (write-wait)
[646.592997] Starting subtest: write-wait
[646.594126] Starting dynamic subtest: all-engines
[647.698469] Dynamic subtest all-engines: SUCCESS (1.106s)
[647.716928] Starting dynamic subtest: rcs0
[648.758472] Dynamic subtest rcs0: SUCCESS (1.057s)
[648.775881] Starting dynamic subtest: bcs0
[649.816991] Dynamic subtest bcs0: SUCCESS (1.056s)
[649.833461] Starting dynamic subtest: vcs0
[650.873071] Dynamic subtest vcs0: SUCCESS (1.054s)
[650.889983] Starting dynamic subtest: vcs1
[651.928011] Dynamic subtest vcs1: SUCCESS (1.053s)
[651.943891] Starting dynamic subtest: vecs0
[652.981704] Dynamic subtest vecs0: SUCCESS (1.051s)
[652.997936] Starting dynamic subtest: ccs0
[654.038478] Dynamic subtest ccs0: SUCCESS (1.054s)
[654.041834] Subtest write-wait: SUCCESS (7.448s)
[654.234248] [FACT gem_wait (write-wait)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[654.235476] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.i915: true
[654.236150] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: gem_create
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_softpin
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: vgem_slow
results: parsing output: 23/ for test: kms_sharpness_filter
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_parallel
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: syncobj_eventfd
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: gem_partial_pwrite_pread
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_basic
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: kms_cursor_edge_walk
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_joiner
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: kms_pipe_stress
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: gem_workarounds
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_multiple
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: prime_mmap
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_pread
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: kms_force_connector_basic
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: dumb_buffer
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_feature_discovery
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: kms_dither
results: parsing output: 114/ for test: kms_chamelium_frames
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: gem_sync
results: parsing output: 126/ for test: gem_ppgtt
results: parsing output: 127/ for test: vgem_basic
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: i915_module_load
results: parsing output: 130/ for test: gem_wait
Done.