[57.111532] Initializing watchdogs
[57.111580]   /dev/watchdog0
[57.125812] [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.131438] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.134576] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.137889] [001/133] (960s left) gem_ctx_sseu (invalid-args)
[57.222685] Subtest invalid-args: SKIP (0.000s)
[57.287104] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[57.393477] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[57.397645] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[57.493557] [003/133] (960s left) kms_legacy_colorkey (invalid-plane)
[57.596794] Starting subtest: invalid-plane
[57.598781] Starting dynamic subtest: zero-id
[57.600780] Dynamic subtest zero-id: SUCCESS (0.000s)
[57.608448] Starting dynamic subtest: outrange-id
[57.610675] Dynamic subtest outrange-id: SUCCESS (0.000s)
[57.612853] Subtest invalid-plane: SUCCESS (0.000s)
[57.679909] [004/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[57.767407] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[65.182530] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.460s)
[65.300727] [005/133] (952s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[65.402557] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[65.404818] Starting dynamic subtest: pipe-A-eDP-1
[65.428344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.437226] Starting dynamic subtest: pipe-B-eDP-1
[65.459399] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.466123] Starting dynamic subtest: pipe-C-eDP-1
[65.488240] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.494815] Starting dynamic subtest: pipe-D-eDP-1
[65.517531] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.522140] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[67.705825] [006/133] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[67.871472] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[67.875876] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[68.062954] [007/133] (949s left) kms_vblank (wait-forked)
[68.168325] Starting subtest: wait-forked
[68.170221] Starting dynamic subtest: pipe-A-eDP-1
[69.972835] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.806s)
[69.989241] Starting dynamic subtest: pipe-D-eDP-1
[72.489708] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.521s)
[72.492264] Subtest wait-forked: SUCCESS (4.331s)
[73.345776] [008/133] (944s left) gem_mmap_gtt (zero-extend)
[73.416593] Subtest zero-extend: SKIP (0.000s)
[73.475396] [009/133] (944s left) gem_userptr_blits (access-control)
[73.539860] Starting subtest: access-control
[73.544463] Subtest access-control: SKIP (0.000s)
[73.650589] [010/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[73.749163] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[73.753548] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[73.871211] [011/133] (944s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[73.972581] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[73.977091] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[74.060489] [012/133] (944s left) syncobj_wait (multi-wait-all-submitted-signaled)
[74.110501] Starting subtest: multi-wait-all-submitted-signaled
[74.218617] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[74.301708] [013/133] (943s left) gem_spin_batch (spin-all)
[74.362078] Starting subtest: spin-all
[74.375514] Subtest spin-all: SUCCESS (0.012s)
[75.960733] [014/133] (942s left) gem_exec_params (larger-than-life-batch)
[76.015064] Starting subtest: larger-than-life-batch
[78.220423] Subtest larger-than-life-batch: SUCCESS (2.206s)
[78.979390] [015/133] (939s left) kms_invalid_mode (bad-vsync-start)
[79.123308] Starting subtest: bad-vsync-start
[79.125656] Starting dynamic subtest: pipe-A-eDP-1
[79.408638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[79.417723] Starting dynamic subtest: pipe-B-eDP-1
[79.420065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[79.427173] Starting dynamic subtest: pipe-C-eDP-1
[79.429503] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[79.436765] Starting dynamic subtest: pipe-D-eDP-1
[79.439102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[79.441440] Subtest bad-vsync-start: SUCCESS (0.290s)
[80.268141] [016/133] (937s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[80.382073] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[80.386567] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[80.483351] [017/133] (937s left) gen7_exec_parse (chained-batch)
[80.540895] Subtest chained-batch: SKIP (0.000s)
[80.601813] [018/133] (937s left) perf (blocking)
[80.750514] Starting subtest: blocking
[80.752975] Starting dynamic subtest: 0-rcs0
[90.778838] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[90.786392] Starting dynamic subtest: 1-vcs1
[100.800281] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[100.802855] Subtest blocking: SUCCESS (20.046s)
[100.843980] [019/133] (917s left) gem_ppgtt (blt-vs-render-ctx0)
[100.916659] Starting subtest: blt-vs-render-ctx0
[133.682342] Subtest blt-vs-render-ctx0: SUCCESS (32.763s)
[133.802652] [020/133] (884s left) kms_psr (psr-sprite-plane-move)
[133.939143] Starting subtest: psr-sprite-plane-move
[133.941323] Starting dynamic subtest: eDP-1
[135.707906] Dynamic subtest eDP-1: SUCCESS (1.768s)
[135.710265] Subtest psr-sprite-plane-move: SUCCESS (1.769s)
[136.525783] [021/133] (881s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[136.647951] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[145.786337] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.137s)
[146.651124] [022/133] (871s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[146.751479] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[146.755518] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[146.841214] [023/133] (871s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[146.932741] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[146.935027] Starting dynamic subtest: pipe-A-eDP-1
[146.957582] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.968096] Starting dynamic subtest: pipe-B-eDP-1
[146.990043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.997161] Starting dynamic subtest: pipe-C-eDP-1
[147.018089] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.025092] Starting dynamic subtest: pipe-D-eDP-1
[147.047077] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.051375] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[149.219231] [024/133] (869s left) kms_psr (fbc-psr2-cursor-render)
[149.304876] Starting subtest: fbc-psr2-cursor-render
[149.307227] Starting dynamic subtest: eDP-1
[149.311573] Dynamic subtest eDP-1: SKIP (0.000s)
[149.315981] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[149.372452] [025/133] (869s left) kms_prime (basic-modeset-hybrid)
[149.461957] Subtest basic-modeset-hybrid: SKIP (0.000s)
[149.613843] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[149.617556] [026/133] (868s left) syncobj_timeline (signal-array)
[149.668417] Starting subtest: signal-array
[149.670771] Subtest signal-array: SUCCESS (0.000s)
[149.781980] [027/133] (868s left) i915_pm_rpm (debugfs-read)
[152.007219] Starting subtest: debugfs-read
[153.176819] Subtest debugfs-read: SUCCESS (1.168s)
[153.545919] [028/133] (865s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[153.644838] Starting subtest: y-tiled-16bpp-rotate-270
[153.649226] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[153.737654] [029/133] (864s left) kms_cursor_crc (cursor-sliding-128x128)
[153.954690] Starting subtest: cursor-sliding-128x128
[153.959453] Starting dynamic subtest: pipe-A-eDP-1
[157.193094] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[157.220487] Starting dynamic subtest: pipe-D-eDP-1
[161.099499] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.885s)
[161.101933] Subtest cursor-sliding-128x128: SUCCESS (7.143s)
[161.933343] [030/133] (856s left) gem_exec_balancer (parallel-keep-in-fence)
[162.194674] Starting subtest: parallel-keep-in-fence
[163.334465] Subtest parallel-keep-in-fence: SUCCESS (1.140s)
[163.449931] [031/133] (855s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[163.511735] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[163.592432] [032/133] (855s left) gem_pxp (fail-invalid-protected-context)
[163.710198] Starting subtest: fail-invalid-protected-context
[163.712610] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[163.813768] [033/133] (855s left) gem_exec_schedule (semaphore-user)
[163.889880] Starting subtest: semaphore-user
[163.937881] Subtest semaphore-user: SUCCESS (0.057s)
[165.963754] [034/133] (852s left) kms_pm_backlight (bad-brightness)
[166.060065] Starting subtest: bad-brightness
[166.119544] Starting dynamic subtest: eDP-1
[166.430245] Dynamic subtest eDP-1: SUCCESS (0.309s)
[166.432617] Subtest bad-brightness: SUCCESS (0.371s)
[167.245327] [035/133] (851s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[167.311081] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[167.393621] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.029s)
[167.433242] [036/133] (851s left) kms_color (deep-color)
[167.527305] Starting subtest: deep-color
[168.624232] Starting dynamic subtest: pipe-A-eDP-1-gamma
[169.341106] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.718s)
[169.350810] Starting dynamic subtest: pipe-A-eDP-1-degamma
[170.831275] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.488s)
[170.840247] Starting dynamic subtest: pipe-A-eDP-1-ctm
[172.256635] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.425s)
[173.015237] Starting dynamic subtest: pipe-B-eDP-1-gamma
[173.733196] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.726s)
[173.742917] Starting dynamic subtest: pipe-B-eDP-1-degamma
[175.191482] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.456s)
[175.200433] Starting dynamic subtest: pipe-B-eDP-1-ctm
[176.635175] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.444s)
[177.417437] Starting dynamic subtest: pipe-C-eDP-1-gamma
[178.110525] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.699s)
[178.119253] Starting dynamic subtest: pipe-C-eDP-1-degamma
[179.490916] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.382s)
[179.507488] Starting dynamic subtest: pipe-C-eDP-1-ctm
[180.912075] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.418s)
[181.719055] Starting dynamic subtest: pipe-D-eDP-1-gamma
[182.418063] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.708s)
[182.426475] Starting dynamic subtest: pipe-D-eDP-1-degamma
[183.887025] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.468s)
[183.896213] Starting dynamic subtest: pipe-D-eDP-1-ctm
[185.296727] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.407s)
[185.299129] Subtest deep-color: SUCCESS (17.769s)
[186.153368] [037/133] (832s left) gem_exec_balancer (full-pulse)
[186.227636] Starting subtest: full-pulse
[190.750722] Subtest full-pulse: SUCCESS (4.522s)
[191.076992] [038/133] (827s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[191.201242] Starting subtest: 2x-cursor-vs-flip-legacy
[191.205633] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[191.348834] [039/133] (827s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[191.407264] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[191.515240] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[191.587946] [040/133] (827s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[191.681532] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[191.685766] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[191.791567] [041/133] (827s left) gem_exec_schedule (noreorder-priority)
[191.973778] Starting subtest: noreorder-priority
[191.976034] Starting dynamic subtest: rcs0
[193.122035] Dynamic subtest rcs0: SUCCESS (1.148s)
[193.134284] Starting dynamic subtest: vcs0
[194.895900] Dynamic subtest vcs0: SUCCESS (1.771s)
[194.906347] Starting dynamic subtest: vcs1
[196.861911] Dynamic subtest vcs1: SUCCESS (1.963s)
[196.873745] Starting dynamic subtest: vecs0
[198.910046] Dynamic subtest vecs0: SUCCESS (2.046s)
[198.921280] Starting dynamic subtest: ccs0
[200.057951] Dynamic subtest ccs0: SUCCESS (1.148s)
[200.060363] Subtest noreorder-priority: SUCCESS (8.085s)
[200.248206] [042/133] (818s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[200.355385] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[200.359950] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[200.440196] [043/133] (818s left) sw_sync (sync_busy_fork_unixsocket)
[200.481327] Starting subtest: sync_busy_fork_unixsocket
[200.488060] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[200.549306] [044/133] (818s left) kms_pm_dc (dc6-psr)
[201.651025] Starting subtest: dc6-psr
[204.535257] Subtest dc6-psr: SUCCESS (2.884s)
[205.386628] [045/133] (813s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[205.482402] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[205.484611] Starting dynamic subtest: pipe-A-eDP-1
[205.784464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.274s)
[205.792651] Starting dynamic subtest: pipe-B-eDP-1
[207.044379] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[207.055314] Starting dynamic subtest: pipe-C-eDP-1
[208.268171] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[208.277066] Starting dynamic subtest: pipe-D-eDP-1
[209.494899] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[209.497295] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.982s)
[210.695359] [046/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[210.804569] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[210.808700] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[210.892401] [047/133] (808s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[210.983560] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[210.988043] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[211.064724] [048/133] (808s left) kms_flip (flip-vs-wf_vblank-interruptible)
[211.154082] Starting subtest: flip-vs-wf_vblank-interruptible
[211.156384] Starting dynamic subtest: A-eDP1
[213.045873] Dynamic subtest A-eDP1: SUCCESS (1.891s)
[213.055443] Starting dynamic subtest: B-eDP1
[214.970551] Dynamic subtest B-eDP1: SUCCESS (1.922s)
[214.981323] Starting dynamic subtest: C-eDP1
[216.892119] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[216.901917] Starting dynamic subtest: D-eDP1
[218.833019] Dynamic subtest D-eDP1: SUCCESS (1.940s)
[218.837851] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.685s)
[220.067542] [049/133] (799s left) perf_pmu (busy-accuracy-2)
[220.112975] Starting subtest: busy-accuracy-2
[220.115427] Starting dynamic subtest: rcs0
[223.160695] Dynamic subtest rcs0: SUCCESS (3.045s)
[223.171926] Starting dynamic subtest: bcs0
[226.221166] Dynamic subtest bcs0: SUCCESS (3.058s)
[226.231523] Starting dynamic subtest: vcs0
[229.270208] Dynamic subtest vcs0: SUCCESS (3.047s)
[229.278958] Starting dynamic subtest: vcs1
[232.323076] Dynamic subtest vcs1: SUCCESS (3.050s)
[232.333010] Starting dynamic subtest: vecs0
[235.369223] Dynamic subtest vecs0: SUCCESS (3.044s)
[235.379698] Starting dynamic subtest: ccs0
[238.428385] Dynamic subtest ccs0: SUCCESS (3.057s)
[238.430799] Subtest busy-accuracy-2: SUCCESS (18.314s)
[238.544385] [050/133] (781s left) i915_suspend (basic-s3-without-i915)
[238.587652] Starting subtest: basic-s3-without-i915
[241.919151] Subtest basic-s3-without-i915: SKIP (3.327s)
[243.553975] [051/133] (776s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[243.665260] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[243.667568] Starting dynamic subtest: A-eDP1
[247.319250] Dynamic subtest A-eDP1: SUCCESS (3.653s)
[247.327790] Starting dynamic subtest: B-eDP1
[250.512455] Dynamic subtest B-eDP1: SUCCESS (3.191s)
[250.520015] Starting dynamic subtest: C-eDP1
[253.711455] Dynamic subtest C-eDP1: SUCCESS (3.199s)
[253.719634] Starting dynamic subtest: D-eDP1
[256.808075] Dynamic subtest D-eDP1: SUCCESS (3.097s)
[256.810765] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.147s)
[257.609984] [052/133] (762s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[257.666126] Starting subtest: multi-wait-for-submit-submitted-signaled
[257.668304] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[257.764759] [053/133] (761s left) gem_mmap_gtt (basic-copy)
[257.816434] Subtest basic-copy: SKIP (0.000s)
[257.874786] [054/133] (761s left) gem_ctx_persistence (engines-queued)
[257.936991] Starting subtest: engines-queued
[257.939564] Starting dynamic subtest: rcs0
[258.022914] Dynamic subtest rcs0: SUCCESS (0.085s)
[258.035876] Starting dynamic subtest: bcs0
[258.067765] Dynamic subtest bcs0: SUCCESS (0.044s)
[258.076805] Starting dynamic subtest: vcs0
[259.895362] Dynamic subtest vcs0: SUCCESS (1.824s)
[259.907076] Starting dynamic subtest: vcs1
[261.876676] Dynamic subtest vcs1: SUCCESS (1.978s)
[261.889026] Starting dynamic subtest: vecs0
[263.861085] Dynamic subtest vecs0: SUCCESS (1.981s)
[263.872562] Starting dynamic subtest: ccs0
[264.049071] Dynamic subtest ccs0: SUCCESS (0.187s)
[264.052030] Subtest engines-queued: SUCCESS (6.112s)
[264.174253] [055/133] (755s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[264.282075] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[264.286471] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[264.352212] [056/133] (755s left) kms_cursor_edge_walk (128x128-right-edge)
[264.450396] Starting subtest: 128x128-right-edge
[264.452765] Starting dynamic subtest: pipe-A-eDP-1
[267.888190] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.434s)
[267.896064] Starting dynamic subtest: pipe-D-eDP-1
[271.002054] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[271.004394] Subtest 128x128-right-edge: SUCCESS (6.552s)
[271.823391] [057/133] (748s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[271.933498] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[272.889871] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.956s)
[273.017991] [058/133] (746s left) gem_mmap_wc (set-cache-level)
[273.069474] Subtest set-cache-level: SKIP (0.000s)
[273.126447] [059/133] (746s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[273.214934] Starting subtest: fbc-rgb101010-draw-pwrite
[278.573285] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.359s)
[279.689454] [060/133] (740s left) kms_prop_blob (invalid-set-prop-any)
[279.755395] Starting subtest: invalid-set-prop-any
[279.757354] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[279.869947] [061/133] (740s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[279.938892] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[279.943053] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[280.129127] [062/133] (739s left) gem_tiled_fence_blits (normal)
[280.193219] Subtest normal: SKIP (0.000s)
[280.259308] [063/133] (739s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[280.369932] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[281.005377] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[281.168995] [064/133] (738s left) gem_pxp (reject-modify-context-protection-off-2)
[281.308987] Starting subtest: reject-modify-context-protection-off-2
[281.311509] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[281.413257] [065/133] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[281.524541] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[281.528726] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[281.631824] [066/133] (738s left) kms_chamelium_hpd (dp-hpd-storm)
[282.022854] Subtest dp-hpd-storm: SKIP (0.000s)
[282.794553] [067/133] (737s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[282.895139] Starting subtest: addfb25-y-tiled-small-legacy
[282.899503] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[282.999532] [068/133] (737s left) dumb_buffer (map-invalid-size)
[283.056101] Starting subtest: map-invalid-size
[283.058362] Subtest map-invalid-size: SUCCESS (0.000s)
[283.171947] [069/133] (737s left) gem_watchdog (default-virtual)
[283.237691] Starting subtest: default-virtual
[289.266761] Subtest default-virtual: SUCCESS (6.038s)
[289.371387] [070/133] (731s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[289.480377] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[296.376085] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.895s)
[296.502418] [071/133] (723s left) gem_render_copy (linear)
[296.554924] Starting subtest: linear
[296.557340] Starting dynamic subtest: smem
[296.595394] Dynamic subtest smem: SUCCESS (0.040s)
[296.598044] Subtest linear: SUCCESS (0.041s)
[296.812348] [072/133] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[296.914420] Starting subtest: psr-2p-primscrn-cur-indfb-move
[296.918689] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[297.009415] [073/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[297.113993] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[306.585515] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.474s)
[306.734605] [074/133] (713s left) kms_chamelium_color (ctm-max)
[306.832429] Subtest ctm-max: SKIP (0.000s)
[306.877536] [075/133] (713s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[306.927339] Starting subtest: single-wait-all-for-submit-unsubmitted
[307.034368] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[307.113883] [076/133] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[307.217419] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[314.487541] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.272s)
[314.611703] [077/133] (706s left) syncobj_wait (wait-any-snapshot)
[314.669983] Starting subtest: wait-any-snapshot
[314.752839] Subtest wait-any-snapshot: SUCCESS (0.082s)
[314.829699] [078/133] (705s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[314.931637] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[316.021782] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[316.133068] [079/133] (704s left) kms_feature_discovery (psr1)
[316.242329] Starting subtest: psr1
[316.244289] Subtest psr1: SUCCESS (0.000s)
[316.314268] [080/133] (704s left) gem_busy (semaphore)
[316.538598] Subtest semaphore: SKIP (0.000s)
[316.724141] [081/133] (704s left) api_intel_bb (object-reloc-keep-cache)
[316.781980] Starting subtest: object-reloc-keep-cache
[316.786124] Subtest object-reloc-keep-cache: SKIP (0.002s)
[316.906405] [082/133] (703s left) kms_pipe_crc_basic (read-crc)
[316.994190] Starting subtest: read-crc
[316.996539] Starting dynamic subtest: pipe-A-eDP-1
[317.685715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s)
[317.695657] Starting dynamic subtest: pipe-B-eDP-1
[319.087568] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[319.097210] Starting dynamic subtest: pipe-C-eDP-1
[320.372530] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.282s)
[320.381471] Starting dynamic subtest: pipe-D-eDP-1
[321.716360] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[321.718624] Subtest read-crc: SUCCESS (4.722s)
[322.571475] [083/133] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[322.678291] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[322.682200] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[322.782275] [084/133] (698s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[322.842730] Starting subtest: legacy-engines-hostile-preempt
[322.845087] Starting dynamic subtest: render
[322.927282] Dynamic subtest render: SUCCESS (0.084s)
[322.940430] Starting dynamic subtest: bsd1
[324.880168] Dynamic subtest bsd1: SUCCESS (1.948s)
[324.890640] Starting dynamic subtest: bsd2
[326.937523] Dynamic subtest bsd2: SUCCESS (2.055s)
[326.948019] Starting dynamic subtest: blt
[326.995770] Dynamic subtest blt: SUCCESS (0.056s)
[327.006199] Starting dynamic subtest: vebox
[328.916259] Dynamic subtest vebox: SUCCESS (1.917s)
[328.918820] Subtest legacy-engines-hostile-preempt: SUCCESS (6.073s)
[328.994939] [085/133] (692s left) kms_content_protection (atomic-dpms-hdcp14)
[329.142899] Starting subtest: atomic-dpms-hdcp14
[329.147965] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[329.277149] [086/133] (691s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[329.368099] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[329.372040] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[329.441606] [087/133] (691s left) i915_drm_fdinfo (isolation)
[329.482433] Starting subtest: isolation
[329.484736] Starting dynamic subtest: rcs0
[329.514870] Dynamic subtest rcs0: SKIP (0.032s)
[329.523298] Starting dynamic subtest: bcs0
[329.527160] Dynamic subtest bcs0: SKIP (0.000s)
[329.534832] Starting dynamic subtest: vcs0
[329.539097] Dynamic subtest vcs0: SKIP (0.000s)
[329.546688] Starting dynamic subtest: vcs1
[329.550606] Dynamic subtest vcs1: SKIP (0.000s)
[329.558177] Starting dynamic subtest: vecs0
[329.562233] Dynamic subtest vecs0: SKIP (0.000s)
[329.570450] Starting dynamic subtest: ccs0
[329.574349] Dynamic subtest ccs0: SKIP (0.000s)
[329.578261] Subtest isolation: SKIP (0.037s)
[329.614382] [088/133] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[329.708024] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[329.712066] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[329.793351] [089/133] (691s left) syncobj_wait (invalid-wait-illegal-handle)
[329.835177] Starting subtest: invalid-wait-illegal-handle
[329.837367] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[329.925788] [090/133] (691s left) kms_plane_multiple (tiling-none)
[330.008814] Starting subtest: tiling-none
[330.010688] Starting dynamic subtest: pipe-A-eDP-1
[333.784054] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.773s)
[333.792574] Starting dynamic subtest: pipe-B-eDP-1
[338.280873] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.495s)
[338.289984] Starting dynamic subtest: pipe-C-eDP-1
[342.662460] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.378s)
[342.671613] Starting dynamic subtest: pipe-D-eDP-1
[346.983411] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.322s)
[346.985679] Subtest tiling-none: SUCCESS (16.974s)
[347.794055] [091/133] (673s left) kms_psr (fbc-psr-sprite-render)
[347.902142] Starting subtest: fbc-psr-sprite-render
[347.904379] Starting dynamic subtest: eDP-1
[347.908572] Dynamic subtest eDP-1: SKIP (0.000s)
[347.912870] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[347.974697] [092/133] (673s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[348.023412] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[348.086687] [093/133] (673s left) kms_psr (psr2-dpms)
[348.183307] Starting subtest: psr2-dpms
[348.185457] Starting dynamic subtest: eDP-1
[351.009062] Dynamic subtest eDP-1: SUCCESS (2.824s)
[351.011207] Subtest psr2-dpms: SUCCESS (2.825s)
[351.887444] [094/133] (669s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[351.993999] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[352.002130] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[352.113314] [095/133] (669s left) gem_exec_fence (keep-in-fence)
[352.278529] Starting subtest: keep-in-fence
[352.280975] Starting dynamic subtest: rcs0
[352.333308] Dynamic subtest rcs0: SUCCESS (0.055s)
[352.343804] Starting dynamic subtest: bcs0
[352.387519] Dynamic subtest bcs0: SUCCESS (0.052s)
[352.398774] Starting dynamic subtest: vcs0
[353.944472] Dynamic subtest vcs0: SUCCESS (1.553s)
[353.955730] Starting dynamic subtest: vcs1
[355.927452] Dynamic subtest vcs1: SUCCESS (1.981s)
[355.939085] Starting dynamic subtest: vecs0
[357.911218] Dynamic subtest vecs0: SUCCESS (1.981s)
[357.922806] Starting dynamic subtest: ccs0
[358.152929] Dynamic subtest ccs0: SUCCESS (0.240s)
[358.155953] Subtest keep-in-fence: SUCCESS (5.875s)
[359.918750] [096/133] (661s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[360.046353] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[360.050692] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[360.152243] [097/133] (661s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[360.254825] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[360.258643] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[360.349275] [098/133] (661s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[360.459068] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[360.461293] Starting dynamic subtest: pipe-A-eDP-1
[360.484706] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.501800] Starting dynamic subtest: pipe-B-eDP-1
[360.522393] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.531318] Starting dynamic subtest: pipe-C-eDP-1
[360.552142] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.560182] Starting dynamic subtest: pipe-D-eDP-1
[360.581258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.585194] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[362.744012] [099/133] (658s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[362.841041] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[362.845328] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[362.912651] [100/133] (658s left) kms_atomic_interruptible (legacy-pageflip)
[362.998331] Starting subtest: legacy-pageflip
[363.000626] Starting dynamic subtest: pipe-A-eDP-1
[370.382705] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s)
[370.385101] Subtest legacy-pageflip: SUCCESS (7.384s)
[371.218388] [101/133] (650s left) perf_pmu (busy-idle-no-semaphores)
[371.269356] Starting subtest: busy-idle-no-semaphores
[371.271833] Starting dynamic subtest: rcs0
[371.920359] Dynamic subtest rcs0: SUCCESS (0.652s)
[371.931804] Starting dynamic subtest: bcs0
[372.571400] Dynamic subtest bcs0: SUCCESS (0.648s)
[372.583098] Starting dynamic subtest: vcs0
[373.223488] Dynamic subtest vcs0: SUCCESS (0.649s)
[373.235022] Starting dynamic subtest: vcs1
[374.526608] Dynamic subtest vcs1: SUCCESS (1.300s)
[374.537870] Starting dynamic subtest: vecs0
[376.510013] Dynamic subtest vecs0: SUCCESS (1.981s)
[376.537359] Starting dynamic subtest: ccs0
[378.559323] Dynamic subtest ccs0: SUCCESS (2.047s)
[378.562307] Subtest busy-idle-no-semaphores: SUCCESS (7.293s)
[378.701543] [102/133] (643s left) syncobj_timeline (invalid-transfer-bad-pad)
[378.762224] Starting subtest: invalid-transfer-bad-pad
[378.764565] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[378.855917] [103/133] (642s left) gem_exec_parallel (fds)
[378.921949] Starting subtest: fds
[378.924306] Starting dynamic subtest: rcs0
[382.113512] Dynamic subtest rcs0: SUCCESS (3.193s)
[382.124776] Starting dynamic subtest: bcs0
[385.475804] Dynamic subtest bcs0: SUCCESS (3.359s)
[385.485082] Starting dynamic subtest: vcs0
[389.228347] Dynamic subtest vcs0: SUCCESS (3.749s)
[389.240578] Starting dynamic subtest: vcs1
[393.237226] Dynamic subtest vcs1: SUCCESS (4.006s)
[393.247279] Starting dynamic subtest: vecs0
[397.185392] Dynamic subtest vecs0: SUCCESS (3.945s)
[397.194054] Starting dynamic subtest: ccs0
[401.032930] Dynamic subtest ccs0: SUCCESS (3.845s)
[401.035859] Subtest fds: SUCCESS (22.114s)
[401.255293] [104/133] (620s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[401.358150] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[401.362182] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[401.452847] [105/133] (620s left) gem_exec_schedule (u-submit-golden-slice)
[401.526374] Starting subtest: u-submit-golden-slice
[401.528407] Starting dynamic subtest: rcs0
[401.557384] Dynamic subtest rcs0: SUCCESS (0.039s)
[401.567248] Starting dynamic subtest: bcs0
[401.585544] Dynamic subtest bcs0: SUCCESS (0.027s)
[401.597491] Starting dynamic subtest: vcs0
[401.615817] Dynamic subtest vcs0: SUCCESS (0.030s)
[401.624452] Starting dynamic subtest: vcs1
[401.647619] Dynamic subtest vcs1: SUCCESS (0.031s)
[401.658068] Starting dynamic subtest: vecs0
[401.676770] Dynamic subtest vecs0: SUCCESS (0.028s)
[401.685271] Starting dynamic subtest: ccs0
[401.706185] Dynamic subtest ccs0: SUCCESS (0.029s)
[401.708551] Subtest u-submit-golden-slice: SUCCESS (0.189s)
[402.990719] [106/133] (618s left) kms_plane (plane-position-hole)
[403.094683] Starting subtest: plane-position-hole
[403.615077] Starting dynamic subtest: pipe-A-plane-1
[404.912484] Dynamic subtest pipe-A-plane-1: SUCCESS (1.298s)
[404.921801] Starting dynamic subtest: pipe-A-plane-2
[406.258632] Dynamic subtest pipe-A-plane-2: SUCCESS (1.345s)
[406.268284] Starting dynamic subtest: pipe-A-plane-3
[407.595104] Dynamic subtest pipe-A-plane-3: SUCCESS (1.336s)
[407.605200] Starting dynamic subtest: pipe-A-plane-4
[408.892179] Dynamic subtest pipe-A-plane-4: SUCCESS (1.295s)
[408.901672] Starting dynamic subtest: pipe-A-plane-5
[408.918223] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[410.047037] Starting dynamic subtest: pipe-B-plane-1
[411.387728] Dynamic subtest pipe-B-plane-1: SUCCESS (1.350s)
[411.397838] Starting dynamic subtest: pipe-B-plane-2
[412.669491] Dynamic subtest pipe-B-plane-2: SUCCESS (1.279s)
[412.680991] Starting dynamic subtest: pipe-B-plane-3
[413.929297] Dynamic subtest pipe-B-plane-3: SUCCESS (1.261s)
[413.937847] Starting dynamic subtest: pipe-B-plane-4
[415.176624] Dynamic subtest pipe-B-plane-4: SUCCESS (1.244s)
[415.185934] Starting dynamic subtest: pipe-B-plane-5
[415.200908] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[415.203141] Subtest plane-position-hole: SUCCESS (12.105s)
[415.974360] [107/133] (605s left) kms_getfb (getfb-addfb-different-handles)
[416.070031] Starting subtest: getfb-addfb-different-handles
[416.072310] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[416.172622] [108/133] (605s left) kms_sequence (get-forked)
[416.270341] Starting subtest: get-forked
[416.272608] Starting dynamic subtest: pipe-A-eDP-1
[418.151405] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[418.161495] Starting dynamic subtest: pipe-B-eDP-1
[420.748156] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.593s)
[420.757260] Starting dynamic subtest: pipe-C-eDP-1
[423.235203] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.488s)
[423.244688] Starting dynamic subtest: pipe-D-eDP-1
[425.770627] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[425.773088] Subtest get-forked: SUCCESS (9.502s)
[426.606090] [109/133] (595s left) gem_create (create-massive)
[426.662523] Starting subtest: create-massive
[426.664565] Subtest create-massive: SUCCESS (0.000s)
[426.857534] [110/133] (595s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[426.903300] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[426.978191] [111/133] (595s left) kms_async_flips (invalid-async-flip)
[427.085069] Starting subtest: invalid-async-flip
[427.466713] Starting dynamic subtest: pipe-A-eDP-1
[428.335497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.868s)
[428.691920] Starting dynamic subtest: pipe-B-eDP-1
[429.466038] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.781s)
[429.824964] Starting dynamic subtest: pipe-C-eDP-1
[430.591623] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s)
[430.947783] Starting dynamic subtest: pipe-D-eDP-1
[431.716810] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[431.719207] Subtest invalid-async-flip: SUCCESS (4.635s)
[432.879576] [112/133] (589s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[432.935632] Subtest writes-after-reads-uncached: SKIP (0.000s)
[433.010060] [113/133] (589s left) kms_psr (pr-suspend)
[433.096207] Starting subtest: pr-suspend
[433.100532] Subtest pr-suspend: SKIP (0.000s)
[433.178883] [114/133] (589s left) kms_properties (invalid-properties-atomic)
[433.273155] Starting subtest: invalid-properties-atomic
[433.574232] Subtest invalid-properties-atomic: SUCCESS (0.301s)
[433.645107] [115/133] (588s left) gem_readwrite (new-obj)
[433.700055] Subtest new-obj: SKIP (0.000s)
[433.778424] [116/133] (588s left) kms_properties (crtc-properties-legacy)
[433.869201] Starting subtest: crtc-properties-legacy
[433.871458] Starting dynamic subtest: pipe-A-eDP-1
[434.313399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[434.322500] Starting dynamic subtest: pipe-B-eDP-1
[435.433883] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s)
[435.443523] Starting dynamic subtest: pipe-C-eDP-1
[436.552728] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[436.562124] Starting dynamic subtest: pipe-D-eDP-1
[437.675427] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[437.677862] Subtest crtc-properties-legacy: SUCCESS (3.809s)
[438.502956] [117/133] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[438.601300] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[438.605693] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[438.699216] [118/133] (583s left) tools_test (tools_test)
[438.749945] Starting subtest: tools_test
[438.799573] Subtest tools_test: SUCCESS (0.063s)
[438.860689] [119/133] (583s left) kms_cursor_legacy (single-move)
[438.973340] Starting subtest: single-move
[438.975607] Starting dynamic subtest: pipe-A
[444.355768] Dynamic subtest pipe-A: SUCCESS (5.379s)
[444.367650] Starting dynamic subtest: pipe-B
[449.738546] Dynamic subtest pipe-B: SUCCESS (5.379s)
[449.749385] Starting dynamic subtest: pipe-C
[455.120703] Dynamic subtest pipe-C: SUCCESS (5.379s)
[455.131844] Starting dynamic subtest: pipe-D
[460.502862] Dynamic subtest pipe-D: SUCCESS (5.379s)
[460.514070] Starting dynamic subtest: all-pipes
[465.892341] Dynamic subtest all-pipes: SUCCESS (5.386s)
[465.894877] Subtest single-move: SUCCESS (26.917s)
[466.037472] [120/133] (556s left) kms_cursor_crc (cursor-onscreen-32x10)
[466.209118] Starting subtest: cursor-onscreen-32x10
[466.257456] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[466.539083] [121/133] (555s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[466.636080] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[466.640082] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[466.707813] [122/133] (555s left) gem_ctx_create (basic)
[466.767607] Starting subtest: basic
[466.770220] Subtest basic: SUCCESS (0.000s)
[466.953720] [123/133] (555s left) sw_sync (timeline_closed)
[466.996474] Starting subtest: timeline_closed
[466.998765] Subtest timeline_closed: SUCCESS (0.000s)
[467.054452] [124/133] (555s left) syncobj_wait (wait-zero-handles)
[467.116540] Starting subtest: wait-zero-handles
[467.118701] Subtest wait-zero-handles: SUCCESS (0.000s)
[467.213707] [125/133] (555s left) api_intel_allocator (execbuf-with-allocator)
[467.265263] Starting subtest: execbuf-with-allocator
[467.268678] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[467.402860] [126/133] (555s left) syncobj_timeline (host-signal-points)
[467.458484] Starting subtest: host-signal-points
[467.463503] Subtest host-signal-points: SUCCESS (0.004s)
[467.573086] [127/133] (555s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[467.671658] Starting subtest: 4-tiled-64bpp-rotate-270
[467.692033] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[467.805548] [128/133] (555s left) gem_exec_whisper (basic-sync-all)
[467.863435] Starting subtest: basic-sync-all
[474.121656] Subtest basic-sync-all: SUCCESS (6.256s)
[474.305728] [129/133] (548s left) kms_psr (fbc-pr-primary-mmap-gtt)
[474.400955] Starting subtest: fbc-pr-primary-mmap-gtt
[474.405555] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[474.476964] [130/133] (548s left) i915_pm_freq_api (freq-suspend)
[474.540776] Starting subtest: freq-suspend
[474.543246] Starting dynamic subtest: gt0
[490.969900] Dynamic subtest gt0: SUCCESS (1.421s)
[490.982484] Starting dynamic subtest: gt1
[506.954335] Dynamic subtest gt1: SUCCESS (1.211s)
[506.956473] Subtest freq-suspend: SUCCESS (2.636s)
[508.028138] [131/133] (515s left) sw_sync (sync_busy)
[508.071262] Starting subtest: sync_busy
[508.073542] Subtest sync_busy: SUCCESS (0.002s)
[508.131360] [132/133] (515s left) kms_chamelium_edid (vga-edid-read)
[508.515084] Subtest vga-edid-read: SKIP (0.000s)
[509.345421] [133/133] (514s left) kms_addfb_basic (too-high)
[509.427617] Starting subtest: too-high
[509.429916] Subtest too-high: SUCCESS (0.001s)
[509.523545] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_sseu
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_legacy_colorkey
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_spin_batch
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: gem_ppgtt
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_prime
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: i915_pm_rpm
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_pm_backlight
results: parsing output: 34/ for test: sriov_basic
results: parsing output: 35/ for test: kms_color
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_pm_dc
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: i915_suspend
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_prop_blob
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: gem_tiled_fence_blits
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: dumb_buffer
results: parsing output: 68/ for test: gem_watchdog
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_chamelium_color
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: kms_pipe_crc_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_plane_multiple
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_pipe_b_c_ivb
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_psr2_sf
results: parsing output: 99/ for test: kms_atomic_interruptible
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_exec_parallel
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: kms_sequence
results: parsing output: 108/ for test: gem_create
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_properties
results: parsing output: 114/ for test: gem_readwrite
results: parsing output: 115/ for test: kms_properties
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: tools_test
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: gem_ctx_create
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: api_intel_allocator
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: kms_chamelium_edid
results: parsing output: 132/ for test: kms_addfb_basic
Done.