[57.095867] Initializing watchdogs
[57.095917]   /dev/watchdog0
[57.110701] [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.115202] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.117388] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.120866] [001/133] (960s left) perf_pmu (busy)
[57.191805] Starting subtest: busy
[57.194237] Starting dynamic subtest: rcs0
[57.797241] Dynamic subtest rcs0: SUCCESS (0.604s)
[57.807567] Starting dynamic subtest: bcs0
[58.369265] Dynamic subtest bcs0: SUCCESS (0.572s)
[58.379139] Starting dynamic subtest: vcs0
[59.927176] Dynamic subtest vcs0: SUCCESS (1.555s)
[59.937539] Starting dynamic subtest: vcs1
[61.910861] Dynamic subtest vcs1: SUCCESS (1.982s)
[61.919397] Starting dynamic subtest: vecs0
[63.894565] Dynamic subtest vecs0: SUCCESS (1.982s)
[63.904517] Starting dynamic subtest: ccs0
[64.459059] Dynamic subtest ccs0: SUCCESS (0.564s)
[64.463442] Subtest busy: SUCCESS (7.266s)
[64.577201] [002/133] (953s left) gem_unfence_active_buffers
[64.738501] [003/133] (952s left) syncobj_timeline (reset-multiple-signaled)
[64.802086] Starting subtest: reset-multiple-signaled
[64.804528] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[64.912038] [004/133] (952s left) gem_fence_thrash (bo-write-verify-none)
[64.949604] Starting subtest: bo-write-verify-none
[64.975491] Subtest bo-write-verify-none: SKIP (0.024s)
[65.035972] [005/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[65.145757] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[72.208091] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.063s)
[72.364372] [006/133] (945s left) gem_ctx_persistence (heartbeat-close)
[72.431083] Starting subtest: heartbeat-close
[72.435666] Subtest heartbeat-close: SKIP (0.000s)
[72.554524] [007/133] (945s left) gem_ctx_param (root-set)
[72.614746] Starting subtest: root-set
[72.617198] Subtest root-set: SUCCESS (0.001s)
[72.721634] [008/133] (945s left) kms_getfb (getfb-handle-not-fb)
[72.820122] Starting subtest: getfb-handle-not-fb
[72.822438] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[72.919827] [009/133] (945s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[73.030571] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[73.034914] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[73.171993] [010/133] (944s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[73.413846] Starting subtest: cursor-rapid-movement-256x256
[73.416060] Starting dynamic subtest: pipe-A-eDP-1
[73.963660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[73.993219] Starting dynamic subtest: pipe-D-eDP-1
[75.204614] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[75.206975] Subtest cursor-rapid-movement-256x256: SUCCESS (1.791s)
[76.031306] [011/133] (941s left) gem_ctx_engines (execute-one)
[76.103643] Starting subtest: execute-one
[78.361859] Subtest execute-one: SUCCESS (2.259s)
[78.976114] [012/133] (939s left) kms_color (ctm-green-to-red)
[79.086624] Starting subtest: ctm-green-to-red
[79.088504] Starting dynamic subtest: pipe-A-eDP-1
[79.781137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s)
[79.790480] Starting dynamic subtest: pipe-B-eDP-1
[81.153218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.373s)
[81.162560] Starting dynamic subtest: pipe-C-eDP-1
[82.537662] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[82.545998] Starting dynamic subtest: pipe-D-eDP-1
[83.870619] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[83.873214] Subtest ctm-green-to-red: SUCCESS (4.784s)
[84.672790] [013/133] (933s left) kms_invalid_mode (clock-too-high)
[84.774809] Starting subtest: clock-too-high
[84.777234] Starting dynamic subtest: pipe-A-eDP-1
[84.781576] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[84.790260] Starting dynamic subtest: pipe-B-eDP-1
[84.794723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.802802] Starting dynamic subtest: pipe-C-eDP-1
[84.806871] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[84.815819] Starting dynamic subtest: pipe-D-eDP-1
[84.820031] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[84.824150] Subtest clock-too-high: SKIP (0.003s)
[84.858616] [014/133] (933s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[87.093953] Starting subtest: dpms-mode-unset-non-lpsp
[88.250169] Subtest dpms-mode-unset-non-lpsp: SKIP (1.157s)
[88.627925] [015/133] (929s left) kms_psr (psr-sprite-plane-onoff)
[88.727884] Starting subtest: psr-sprite-plane-onoff
[88.730282] Starting dynamic subtest: eDP-1
[90.464968] Dynamic subtest eDP-1: SUCCESS (1.738s)
[90.467274] Subtest psr-sprite-plane-onoff: SUCCESS (1.738s)
[91.277036] [016/133] (926s left) gem_spin_batch (resubmit)
[91.348375] Starting subtest: resubmit
[91.350663] Starting dynamic subtest: rcs0
[91.355416] Dynamic subtest rcs0: SUCCESS (0.007s)
[91.365518] Starting dynamic subtest: bcs0
[91.367336] Dynamic subtest bcs0: SUCCESS (0.003s)
[91.375114] Starting dynamic subtest: vcs0
[91.377195] Dynamic subtest vcs0: SUCCESS (0.003s)
[91.384601] Starting dynamic subtest: vcs1
[91.386680] Dynamic subtest vcs1: SUCCESS (0.003s)
[91.394519] Starting dynamic subtest: vecs0
[91.396624] Dynamic subtest vecs0: SUCCESS (0.003s)
[91.404092] Starting dynamic subtest: ccs0
[91.406193] Dynamic subtest ccs0: SUCCESS (0.003s)
[91.408322] Subtest resubmit: SUCCESS (0.022s)
[91.596984] [017/133] (926s left) gen9_exec_parse (batch-without-end)
[91.654566] Subtest batch-without-end: SKIP (0.000s)
[91.721565] [018/133] (926s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[91.772209] Starting subtest: single-wait-all-for-submit-unsubmitted
[91.873730] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[91.953220] [019/133] (926s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[92.052055] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[92.054394] Starting dynamic subtest: pipe-A-eDP-1
[97.982984] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.935s)
[97.992517] Starting dynamic subtest: pipe-B-eDP-1
[104.609951] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.628s)
[104.612408] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.565s)
[105.484667] [020/133] (912s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[105.595227] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[105.967721] Starting dynamic subtest: pipe-A-eDP-1
[108.823638] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[109.141165] Starting dynamic subtest: pipe-B-eDP-1
[111.899520] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[112.262630] Starting dynamic subtest: pipe-C-eDP-1
[115.079061] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[115.395229] Starting dynamic subtest: pipe-D-eDP-1
[118.209997] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[118.212463] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.563s)
[119.344717] [021/133] (899s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[119.440308] Starting subtest: fbc-pr-sprite-mmap-cpu
[119.444761] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[119.513714] [022/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[119.622209] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[127.153559] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.534s)
[127.299958] [023/133] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[127.403094] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[127.407306] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[127.510279] [024/133] (891s left) tools_test (tools_test)
[127.557558] Starting subtest: tools_test
[127.605885] Subtest tools_test: SUCCESS (0.063s)
[127.666192] [025/133] (890s left) gem_exec_schedule (pi-ringfull)
[127.851717] Starting subtest: pi-ringfull
[127.853867] Starting dynamic subtest: rcs0
[127.912252] Dynamic subtest rcs0: SUCCESS (0.065s)
[127.924418] Starting dynamic subtest: bcs0
[127.941510] Dynamic subtest bcs0: SUCCESS (0.029s)
[127.953684] Starting dynamic subtest: vcs0
[127.968366] Dynamic subtest vcs0: SUCCESS (0.026s)
[127.979429] Starting dynamic subtest: vcs1
[127.996108] Dynamic subtest vcs1: SUCCESS (0.027s)
[128.008283] Starting dynamic subtest: vecs0
[128.024145] Dynamic subtest vecs0: SUCCESS (0.027s)
[128.036546] Starting dynamic subtest: ccs0
[128.052287] Dynamic subtest ccs0: SUCCESS (0.028s)
[128.054497] Subtest pi-ringfull: SUCCESS (0.206s)
[128.298932] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[128.302238] [026/133] (890s left) kms_async_flips (test-cursor-atomic)
[128.403446] Starting subtest: test-cursor-atomic
[128.780564] Starting dynamic subtest: pipe-A-eDP-1
[129.565360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[129.963016] Starting dynamic subtest: pipe-B-eDP-1
[130.707468] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[131.090767] Starting dynamic subtest: pipe-C-eDP-1
[131.840359] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.757s)
[132.218340] Starting dynamic subtest: pipe-D-eDP-1
[132.978760] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[132.980899] Subtest test-cursor-atomic: SUCCESS (4.578s)
[134.149239] [027/133] (884s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[134.271536] Starting subtest: cursorA-vs-flipB-varying-size
[134.276280] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[134.417075] [028/133] (884s left) i915_drm_fdinfo (busy-idle)
[134.457662] Starting subtest: busy-idle
[134.459546] Starting dynamic subtest: rcs0
[134.478475] Dynamic subtest rcs0: SKIP (0.020s)
[134.486735] Starting dynamic subtest: bcs0
[134.490797] Dynamic subtest bcs0: SKIP (0.000s)
[134.499066] Starting dynamic subtest: vcs0
[134.503263] Dynamic subtest vcs0: SKIP (0.000s)
[134.511132] Starting dynamic subtest: vcs1
[134.515223] Dynamic subtest vcs1: SKIP (0.000s)
[134.528255] Starting dynamic subtest: vecs0
[134.532298] Dynamic subtest vecs0: SKIP (0.000s)
[134.540321] Starting dynamic subtest: ccs0
[134.544311] Dynamic subtest ccs0: SKIP (0.000s)
[134.548305] Subtest busy-idle: SKIP (0.024s)
[134.585180] [029/133] (884s left) gem_exec_parallel (engines)
[134.639659] Starting subtest: engines
[134.641963] Starting dynamic subtest: basic
[137.880976] Dynamic subtest basic: SUCCESS (3.239s)
[137.891612] Starting dynamic subtest: contexts
[142.234538] Dynamic subtest contexts: SUCCESS (4.352s)
[142.243114] Starting dynamic subtest: fds
[146.020587] Dynamic subtest fds: SUCCESS (3.784s)
[146.030638] Starting dynamic subtest: userptr
[147.926689] Dynamic subtest userptr: SUCCESS (1.904s)
[147.929656] Subtest engines: SUCCESS (13.285s)
[148.118105] [030/133] (870s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[148.213735] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[148.216038] Starting dynamic subtest: pipe-A
[148.233755] Dynamic subtest pipe-A: SKIP (0.017s)
[148.243407] Starting dynamic subtest: pipe-B
[148.267600] Dynamic subtest pipe-B: SKIP (0.032s)
[148.277923] Starting dynamic subtest: pipe-C
[148.299220] Dynamic subtest pipe-C: SKIP (0.030s)
[148.307800] Starting dynamic subtest: pipe-D
[148.328272] Dynamic subtest pipe-D: SKIP (0.031s)
[148.332056] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.112s)
[148.449176] [031/133] (870s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[148.509549] Starting subtest: wait-all-for-submit-delayed-submit
[148.610940] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[148.688262] [032/133] (870s left) perf (invalid-create-userspace-config)
[148.820918] Starting subtest: invalid-create-userspace-config
[148.823183] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[148.863637] [033/133] (870s left) gem_exec_fence (keep-in-fence)
[149.035648] Starting subtest: keep-in-fence
[149.037824] Starting dynamic subtest: rcs0
[149.100501] Dynamic subtest rcs0: SUCCESS (0.064s)
[149.110832] Starting dynamic subtest: bcs0
[149.152870] Dynamic subtest bcs0: SUCCESS (0.051s)
[149.162895] Starting dynamic subtest: vcs0
[150.936845] Dynamic subtest vcs0: SUCCESS (1.781s)
[150.947885] Starting dynamic subtest: vcs1
[152.919618] Dynamic subtest vcs1: SUCCESS (1.980s)
[152.930348] Starting dynamic subtest: vecs0
[154.902878] Dynamic subtest vecs0: SUCCESS (1.982s)
[154.914664] Starting dynamic subtest: ccs0
[155.171449] Dynamic subtest ccs0: SUCCESS (0.267s)
[155.173995] Subtest keep-in-fence: SUCCESS (6.136s)
[157.000662] [034/133] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[157.110133] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[164.522911] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.415s)
[164.657583] [035/133] (854s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[164.707272] Starting subtest: etime-single-wait-available-unsubmitted
[164.809617] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s)
[164.887928] [036/133] (854s left) kms_dsc (dsc-with-output-formats-with-bpc)
[164.993185] Starting subtest: dsc-with-output-formats-with-bpc
[165.049799] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[165.087107] [037/133] (853s left) gem_exec_reloc (basic-range)
[165.141509] Subtest basic-range: SKIP (0.000s)
[165.215806] [038/133] (853s left) gem_lmem_swapping (heavy-verify-multi)
[165.255829] Subtest heavy-verify-multi: SKIP (0.000s)
[165.301874] [039/133] (853s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[165.388657] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[166.544429] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.157s)
[166.668479] [040/133] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[166.755927] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[174.378431] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.623s)
[174.536885] [041/133] (844s left) gem_flink_basic (basic)
[174.601490] Starting subtest: basic
[174.603475] Subtest basic: SUCCESS (0.000s)
[174.709519] [042/133] (844s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[174.806410] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[174.808728] Starting dynamic subtest: pipe-A
[175.153393] Dynamic subtest pipe-A: SUCCESS (0.349s)
[175.162022] Starting dynamic subtest: pipe-B
[176.598364] Dynamic subtest pipe-B: SUCCESS (1.444s)
[176.608460] Starting dynamic subtest: pipe-C
[178.038688] Dynamic subtest pipe-C: SUCCESS (1.437s)
[178.048713] Starting dynamic subtest: pipe-D
[179.468120] Dynamic subtest pipe-D: SUCCESS (1.431s)
[179.470432] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.665s)
[180.665182] [043/133] (838s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[180.780502] Starting subtest: y-tiled-64bpp-rotate-180
[180.784664] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[180.883216] [044/133] (838s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[180.946169] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[180.950485] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[181.134565] [045/133] (838s left) gem_exec_params (invalid-ring2)
[181.182880] Starting subtest: invalid-ring2
[181.185208] Subtest invalid-ring2: SUCCESS (0.000s)
[181.272345] [046/133] (838s left) gem_exec_fence (basic-busy)
[181.444756] Starting subtest: basic-busy
[181.447180] Starting dynamic subtest: rcs0
[181.534843] Dynamic subtest rcs0: SUCCESS (0.090s)
[181.544943] Starting dynamic subtest: bcs0
[181.594521] Dynamic subtest bcs0: SUCCESS (0.058s)
[181.605955] Starting dynamic subtest: vcs0
[181.658267] Dynamic subtest vcs0: SUCCESS (0.062s)
[181.669054] Starting dynamic subtest: vcs1
[181.718486] Dynamic subtest vcs1: SUCCESS (0.058s)
[181.729189] Starting dynamic subtest: vecs0
[181.778051] Dynamic subtest vecs0: SUCCESS (0.058s)
[181.791410] Starting dynamic subtest: ccs0
[181.838312] Dynamic subtest ccs0: SUCCESS (0.057s)
[181.840825] Subtest basic-busy: SUCCESS (0.395s)
[183.886505] [047/133] (835s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[183.983128] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[183.985493] Starting dynamic subtest: pipe-A-eDP-1
[184.005552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[184.018776] Starting dynamic subtest: pipe-B-eDP-1
[184.038160] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[184.046985] Starting dynamic subtest: pipe-C-eDP-1
[184.066293] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[184.074689] Starting dynamic subtest: pipe-D-eDP-1
[184.093918] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[184.096080] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[186.225496] [048/133] (833s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[186.285156] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[186.338091] [049/133] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[186.444264] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[186.448574] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[186.537792] [050/133] (833s left) kms_vblank (query-forked-hang)
[186.645405] Starting subtest: query-forked-hang
[186.647791] Starting dynamic subtest: pipe-A-eDP-1
[200.671207] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.022s)
[200.685232] Starting dynamic subtest: pipe-D-eDP-1
[225.695215] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[225.697650] Subtest query-forked-hang: SUCCESS (39.050s)
[226.501007] [051/133] (793s left) gem_exec_reloc (basic-write-wc)
[226.568722] Subtest basic-write-wc: SKIP (0.000s)
[226.642218] [052/133] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[226.750399] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[226.754646] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[226.858239] [053/133] (792s left) kms_flip (basic-plain-flip)
[226.954511] Starting subtest: basic-plain-flip
[226.956790] Starting dynamic subtest: A-eDP1
[228.607755] Dynamic subtest A-eDP1: SUCCESS (1.652s)
[228.621163] Starting dynamic subtest: B-eDP1
[230.248451] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[230.266797] Starting dynamic subtest: C-eDP1
[231.976174] Dynamic subtest C-eDP1: SUCCESS (1.723s)
[231.985584] Starting dynamic subtest: D-eDP1
[233.611244] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[233.616409] Subtest basic-plain-flip: SUCCESS (6.660s)
[234.792496] [054/133] (784s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[234.881780] Starting subtest: flip-vs-dpms-off-vs-modeset
[234.884306] Starting dynamic subtest: A-eDP1
[238.532343] Dynamic subtest A-eDP1: SUCCESS (3.647s)
[238.545124] Starting dynamic subtest: B-eDP1
[241.739342] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[241.747901] Starting dynamic subtest: C-eDP1
[244.844490] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[244.854250] Starting dynamic subtest: D-eDP1
[247.952735] Dynamic subtest D-eDP1: SUCCESS (3.108s)
[247.955113] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.072s)
[248.772605] [055/133] (771s left) gem_exec_params (cliprects-invalid)
[248.843673] Starting subtest: cliprects-invalid
[248.845874] Subtest cliprects-invalid: SUCCESS (0.000s)
[248.949301] [056/133] (770s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[249.044668] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[249.049097] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[249.149514] [057/133] (770s left) kms_lease (lease-invalid-connector)
[249.248376] Starting subtest: lease-invalid-connector
[249.250706] Starting dynamic subtest: pipe-A-eDP-1
[249.252959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[249.261087] Starting dynamic subtest: pipe-B-eDP-1
[249.262883] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[249.271513] Starting dynamic subtest: pipe-C-eDP-1
[249.273575] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[249.281728] Starting dynamic subtest: pipe-D-eDP-1
[249.283624] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[249.285429] Subtest lease-invalid-connector: SUCCESS (0.004s)
[249.322134] [058/133] (770s left) gem_ctx_shared (single-timeline)
[249.385074] Starting subtest: single-timeline
[249.405483] Subtest single-timeline: SUCCESS (0.013s)
[249.638452] [059/133] (770s left) gem_exec_params (rel-constants-invalid-ring)
[249.703389] Starting subtest: rel-constants-invalid-ring
[249.705609] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[249.813090] [060/133] (770s left) gem_exec_balancer (parallel-bb-first)
[250.063311] Starting subtest: parallel-bb-first
[251.012952] Subtest parallel-bb-first: SUCCESS (0.949s)
[251.970433] [061/133] (768s left) gem_pxp (reject-modify-context-protection-off-3)
[252.099108] Starting subtest: reject-modify-context-protection-off-3
[252.101486] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[252.226795] [062/133] (767s left) gem_userptr_blits (readonly-unsync)
[252.297856] Subtest readonly-unsync: SKIP (0.000s)
[252.429465] [063/133] (767s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[252.536043] Starting subtest: x-tiled-64bpp-rotate-90
[252.558187] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[252.669937] [064/133] (767s left) i915_hangman (engine-error-state-capture)
[252.732293] Starting subtest: engine-error-state-capture
[252.734607] Starting dynamic subtest: rcs0
[255.861061] Dynamic subtest rcs0: SUCCESS (3.128s)
[255.873414] Starting dynamic subtest: bcs0
[261.878232] Dynamic subtest bcs0: SUCCESS (6.014s)
[261.889855] Starting dynamic subtest: vcs0
[267.829965] Dynamic subtest vcs0: SUCCESS (5.948s)
[267.841947] Starting dynamic subtest: vcs1
[272.821642] Dynamic subtest vcs1: SUCCESS (4.989s)
[272.833846] Starting dynamic subtest: vecs0
[277.813368] Dynamic subtest vecs0: SUCCESS (4.988s)
[277.825361] Starting dynamic subtest: ccs0
[282.869434] Dynamic subtest ccs0: SUCCESS (5.053s)
[282.872572] Subtest engine-error-state-capture: SUCCESS (30.136s)
[283.017288] [065/133] (737s left) api_intel_allocator (fork-simple-once)
[283.074238] Starting subtest: fork-simple-once
[283.089187] Subtest fork-simple-once: SUCCESS (0.017s)
[283.223889] [066/133] (737s left) kms_hdr (brightness-with-hdr)
[283.316143] Starting subtest: brightness-with-hdr
[283.322807] Subtest brightness-with-hdr: SKIP (0.000s)
[283.405150] [067/133] (736s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[283.506646] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[283.510855] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[283.603563] [068/133] (736s left) syncobj_wait (reset-signaled)
[283.657965] Starting subtest: reset-signaled
[283.660326] Subtest reset-signaled: SUCCESS (0.000s)
[283.746016] [069/133] (736s left) kms_psr (psr2-basic)
[283.845392] Starting subtest: psr2-basic
[283.847722] Starting dynamic subtest: eDP-1
[285.409990] Dynamic subtest eDP-1: SUCCESS (1.566s)
[285.412359] Subtest psr2-basic: SUCCESS (1.567s)
[286.206356] [070/133] (734s left) kms_cursor_crc (cursor-suspend)
[286.336776] Starting subtest: cursor-suspend
[286.338923] Starting dynamic subtest: pipe-A-eDP-1
[319.586045] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.304s)
[319.596397] Starting dynamic subtest: pipe-D-eDP-1
[353.559994] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.739s)
[353.562819] Subtest cursor-suspend: SUCCESS (7.046s)
[354.396246] [071/133] (666s left) device_reset (cold-reset-bound)
[354.454004] Starting subtest: cold-reset-bound
[354.458939] Subtest cold-reset-bound: SKIP (0.000s)
[354.523436] [072/133] (665s left) gem_busy (semaphore)
[354.709008] Subtest semaphore: SKIP (0.000s)
[354.917436] [073/133] (665s left) kms_panel_fitting (legacy)
[355.022478] Starting subtest: legacy
[355.024854] Starting dynamic subtest: pipe-A-eDP-1
[355.658619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[355.687184] Starting dynamic subtest: pipe-B-eDP-1
[357.281237] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.598s)
[357.309107] Starting dynamic subtest: pipe-C-eDP-1
[358.887909] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.582s)
[358.914167] Starting dynamic subtest: pipe-D-eDP-1
[360.412001] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[360.414703] Subtest legacy: SUCCESS (5.382s)
[361.636029] [074/133] (658s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[361.729947] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[361.732374] Starting dynamic subtest: pipe-A-eDP-1
[361.810193] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[361.823023] Starting dynamic subtest: pipe-B-eDP-1
[362.907672] Dynamic subtest pipe-B-eDP-1: SKIP (1.098s)
[362.911985] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.179s)
[364.107103] [075/133] (656s left) kms_plane_cursor (viewport)
[364.202700] Starting subtest: viewport
[364.207202] Starting dynamic subtest: pipe-A-eDP-1-size-64
[366.738153] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.533s)
[366.800778] Starting dynamic subtest: pipe-A-eDP-1-size-128
[369.364961] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.570s)
[369.422209] Starting dynamic subtest: pipe-A-eDP-1-size-256
[371.944191] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[372.297788] Starting dynamic subtest: pipe-B-eDP-1-size-64
[375.549785] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.261s)
[375.610195] Starting dynamic subtest: pipe-B-eDP-1-size-128
[378.175656] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[378.235548] Starting dynamic subtest: pipe-B-eDP-1-size-256
[380.811169] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.582s)
[381.161224] Starting dynamic subtest: pipe-C-eDP-1-size-64
[383.999197] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.848s)
[384.036779] Starting dynamic subtest: pipe-C-eDP-1-size-128
[386.168235] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[386.205354] Starting dynamic subtest: pipe-C-eDP-1-size-256
[388.368113] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[388.703656] Starting dynamic subtest: pipe-D-eDP-1-size-64
[391.600740] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.911s)
[391.638587] Starting dynamic subtest: pipe-D-eDP-1-size-128
[393.803312] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[393.840707] Starting dynamic subtest: pipe-D-eDP-1-size-256
[396.036891] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.202s)
[396.362938] Subtest viewport: SUCCESS (32.140s)
[397.176389] [076/133] (623s left) gem_exec_whisper (basic-fds)
[397.242083] Starting subtest: basic-fds
[403.121937] Subtest basic-fds: SUCCESS (5.874s)
[403.321692] [077/133] (617s left) kms_psr (psr-cursor-mmap-cpu)
[403.417094] Starting subtest: psr-cursor-mmap-cpu
[403.419631] Starting dynamic subtest: eDP-1
[405.164900] Dynamic subtest eDP-1: SUCCESS (1.747s)
[405.167818] Subtest psr-cursor-mmap-cpu: SUCCESS (1.748s)
[406.044730] [078/133] (614s left) gem_ctx_persistence (engines-persistence)
[406.104757] Starting subtest: engines-persistence
[406.107666] Starting dynamic subtest: rcs0
[406.885409] Dynamic subtest rcs0: SUCCESS (0.780s)
[406.896910] Starting dynamic subtest: bcs0
[407.637666] Dynamic subtest bcs0: SUCCESS (0.750s)
[407.649976] Starting dynamic subtest: vcs0
[408.405908] Dynamic subtest vcs0: SUCCESS (0.766s)
[408.418870] Starting dynamic subtest: vcs1
[409.182521] Dynamic subtest vcs1: SUCCESS (0.774s)
[409.195156] Starting dynamic subtest: vecs0
[409.945474] Dynamic subtest vecs0: SUCCESS (0.760s)
[409.957899] Starting dynamic subtest: ccs0
[410.696979] Dynamic subtest ccs0: SUCCESS (0.749s)
[410.700031] Subtest engines-persistence: SUCCESS (4.591s)
[410.821812] [079/133] (610s left) syncobj_eventfd (invalid-bad-pad)
[410.879067] Starting subtest: invalid-bad-pad
[410.882024] Subtest invalid-bad-pad: SUCCESS (0.000s)
[410.977514] [080/133] (609s left) kms_flip (absolute-wf_vblank)
[411.086016] Starting subtest: absolute-wf_vblank
[411.088936] Starting dynamic subtest: A-eDP1
[419.837849] Dynamic subtest A-eDP1: SUCCESS (8.715s)
[419.850413] Starting dynamic subtest: B-eDP1
[428.571088] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[428.592281] Starting dynamic subtest: C-eDP1
[437.310180] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[437.322215] Starting dynamic subtest: D-eDP1
[446.046749] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[446.049642] Subtest absolute-wf_vblank: SUCCESS (34.902s)
[447.223697] [081/133] (573s left) gem_pxp (fail-invalid-protected-context)
[447.337022] Starting subtest: fail-invalid-protected-context
[447.340013] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[447.446604] [082/133] (573s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[447.537177] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[447.541577] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[448.644456] [083/133] (572s left) kms_big_fb (linear-16bpp-rotate-90)
[448.759342] Starting subtest: linear-16bpp-rotate-90
[448.780051] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[448.909705] [084/133] (572s left) gem_exec_reloc (basic-softpin)
[448.969589] Subtest basic-softpin: SKIP (0.000s)
[449.028746] [085/133] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[449.130179] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[449.134974] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[449.213204] [086/133] (571s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[449.327875] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[449.332462] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[449.483655] [087/133] (571s left) prime_self_import (basic-llseek-size)
[449.522197] Starting subtest: basic-llseek-size
[449.533112] Subtest basic-llseek-size: SUCCESS (0.015s)
[449.632157] [088/133] (571s left) perf_pmu (semaphore-wait-idle)
[449.673969] Starting subtest: semaphore-wait-idle
[449.676635] Starting dynamic subtest: rcs0
[450.189513] Dynamic subtest rcs0: SUCCESS (0.514s)
[450.202359] Starting dynamic subtest: bcs0
[450.703663] Dynamic subtest bcs0: SUCCESS (0.510s)
[450.714850] Starting dynamic subtest: vcs0
[451.216660] Dynamic subtest vcs0: SUCCESS (0.510s)
[451.228455] Starting dynamic subtest: vcs1
[451.731751] Dynamic subtest vcs1: SUCCESS (0.511s)
[451.749957] Starting dynamic subtest: vecs0
[452.247918] Dynamic subtest vecs0: SUCCESS (0.512s)
[452.260109] Starting dynamic subtest: ccs0
[452.767496] Dynamic subtest ccs0: SUCCESS (0.516s)
[452.770192] Subtest semaphore-wait-idle: SUCCESS (3.093s)
[454.127553] [089/133] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[454.227639] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[454.232795] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[454.324655] [090/133] (566s left) sw_sync (alloc_fence_invalid_timeline)
[454.368574] Starting subtest: alloc_fence_invalid_timeline
[454.371165] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[454.428841] [091/133] (566s left) gem_mmap_offset (mmap-boundaries)
[454.501306] Starting subtest: mmap-boundaries
[454.503665] Starting dynamic subtest: smem0
[454.779917] Dynamic subtest smem0: SUCCESS (0.280s)
[454.782794] Subtest mmap-boundaries: SUCCESS (0.281s)
[454.889032] [092/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[454.984120] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[454.989698] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[455.084295] [093/133] (566s left) gen3_render_mixed_blits
[455.212719] [094/133] (566s left) gem_fence_thrash (bo-write-verify-x)
[455.259352] Starting subtest: bo-write-verify-x
[455.272193] Subtest bo-write-verify-x: SKIP (0.013s)
[455.339382] [095/133] (566s left) gem_lmem_swapping (verify-random)
[455.382892] Subtest verify-random: SKIP (0.000s)
[455.434411] [096/133] (566s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[455.540589] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[455.545361] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[455.632954] [097/133] (565s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[455.728155] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[455.733503] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[455.817875] [098/133] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[455.922360] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[455.926429] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[456.016132] [099/133] (565s left) kms_cursor_crc (cursor-onscreen-256x256)
[456.260951] Starting subtest: cursor-onscreen-256x256
[456.266537] Starting dynamic subtest: pipe-A-eDP-1
[458.478991] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.212s)
[458.510385] Starting dynamic subtest: pipe-D-eDP-1
[461.212504] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.707s)
[461.215207] Subtest cursor-onscreen-256x256: SUCCESS (4.948s)
[462.026804] [100/133] (559s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[462.134194] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[462.197478] [101/133] (559s left) i915_query (query-regions-unallocated)
[462.255732] Starting subtest: query-regions-unallocated
[462.258010] Subtest query-regions-unallocated: SUCCESS (0.000s)
[462.365145] [102/133] (559s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[462.480210] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[462.485483] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[462.597787] [103/133] (559s left) kms_psr (fbc-psr-cursor-plane-move)
[462.707054] Starting subtest: fbc-psr-cursor-plane-move
[462.710036] Starting dynamic subtest: eDP-1
[462.714931] Dynamic subtest eDP-1: SKIP (0.000s)
[462.719777] Subtest fbc-psr-cursor-plane-move: SKIP (0.002s)
[462.788158] [104/133] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[462.885191] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[462.890364] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[462.986152] [105/133] (559s left) gem_exec_schedule (submit-golden-slice)
[463.053976] Starting subtest: submit-golden-slice
[463.055902] Starting dynamic subtest: rcs0
[463.089114] Dynamic subtest rcs0: SUCCESS (0.040s)
[463.101161] Starting dynamic subtest: bcs0
[463.119141] Dynamic subtest bcs0: SUCCESS (0.029s)
[463.128222] Starting dynamic subtest: vcs0
[463.151373] Dynamic subtest vcs0: SUCCESS (0.031s)
[463.160494] Starting dynamic subtest: vcs1
[463.184504] Dynamic subtest vcs1: SUCCESS (0.033s)
[463.193798] Starting dynamic subtest: vecs0
[463.211678] Dynamic subtest vecs0: SUCCESS (0.026s)
[463.221800] Starting dynamic subtest: ccs0
[463.254626] Dynamic subtest ccs0: SUCCESS (0.041s)
[463.257089] Subtest submit-golden-slice: SUCCESS (0.206s)
[465.157002] [106/133] (556s left) kms_content_protection (suspend-resume)
[465.303197] Starting subtest: suspend-resume
[465.309073] Subtest suspend-resume: SKIP (0.000s)
[465.418228] [107/133] (556s left) api_intel_bb (render)
[465.465943] Starting subtest: render
[465.468226] Starting dynamic subtest: render-none-512
[465.565344] Dynamic subtest render-none-512: SUCCESS (0.102s)
[465.577385] Starting dynamic subtest: render-none-1024
[465.955964] Dynamic subtest render-none-1024: SUCCESS (0.388s)
[465.967975] Starting dynamic subtest: render-x-512
[466.091460] Dynamic subtest render-x-512: SUCCESS (0.134s)
[466.103413] Starting dynamic subtest: render-x-1024
[466.436505] Dynamic subtest render-x-1024: SUCCESS (0.344s)
[466.448609] Starting dynamic subtest: render-y-512
[466.522912] Dynamic subtest render-y-512: SUCCESS (0.086s)
[466.539143] Starting dynamic subtest: render-y-1024
[467.116432] Dynamic subtest render-y-1024: SUCCESS (0.591s)
[467.119355] Subtest render: SUCCESS (1.652s)
[467.221754] [108/133] (554s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[467.314718] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[467.317032] Starting dynamic subtest: pipe-A-eDP-1
[467.341023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.352875] Starting dynamic subtest: pipe-B-eDP-1
[467.375362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.384754] Starting dynamic subtest: pipe-C-eDP-1
[467.407737] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.416649] Starting dynamic subtest: pipe-D-eDP-1
[467.440009] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.444179] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[469.574670] [109/133] (552s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[469.674027] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[469.679208] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[470.806964] [110/133] (551s left) kms_rotation_crc (primary-rotation-180)
[470.905870] Starting subtest: primary-rotation-180
[477.936884] Subtest primary-rotation-180: SUCCESS (7.029s)
[479.091060] [111/133] (543s left) perf_pmu (init-wait)
[479.139308] Starting subtest: init-wait
[479.141836] Starting dynamic subtest: rcs0
[479.144371] Dynamic subtest rcs0: SUCCESS (0.001s)
[479.155183] Starting dynamic subtest: bcs0
[479.158049] Dynamic subtest bcs0: SUCCESS (0.001s)
[479.167698] Starting dynamic subtest: vcs0
[479.170111] Dynamic subtest vcs0: SUCCESS (0.001s)
[479.179661] Starting dynamic subtest: vcs1
[479.182091] Dynamic subtest vcs1: SUCCESS (0.001s)
[479.191312] Starting dynamic subtest: vecs0
[479.194008] Dynamic subtest vecs0: SUCCESS (0.001s)
[479.203298] Starting dynamic subtest: ccs0
[479.205696] Dynamic subtest ccs0: SUCCESS (0.001s)
[479.207831] Subtest init-wait: SUCCESS (0.008s)
[479.276979] [112/133] (543s left) gem_exec_reloc (basic-gtt-cpu-active)
[479.339743] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[479.412107] [113/133] (542s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[479.811932] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[480.602634] [114/133] (541s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[480.978033] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[481.828804] [115/133] (540s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[481.928852] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[481.933704] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[482.020022] [116/133] (540s left) i915_pm_rc6_residency (media-rc6-accuracy)
[482.076027] Starting subtest: media-rc6-accuracy
[482.080915] Subtest media-rc6-accuracy: SKIP (0.000s)
[482.173487] [117/133] (540s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[482.297599] Starting subtest: 2x-long-flip-vs-cursor-legacy
[482.302185] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[482.450262] [118/133] (540s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[482.556049] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[482.583089] Starting dynamic subtest: pipe-A-plane-0
[482.871745] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[482.881177] Starting dynamic subtest: pipe-A-plane-3
[483.104436] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[483.113898] Starting dynamic subtest: pipe-A-plane-5
[483.117405] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[484.227857] Starting dynamic subtest: pipe-B-plane-0
[484.520756] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[484.530418] Starting dynamic subtest: pipe-B-plane-3
[484.753708] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[484.763329] Starting dynamic subtest: pipe-B-plane-5
[484.768090] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[485.064928] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.507s)
[485.899790] [119/133] (536s left) syncobj_timeline (invalid-query-zero-handles)
[485.956941] Starting subtest: invalid-query-zero-handles
[485.959176] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[486.071112] [120/133] (536s left) kms_big_fb (4-tiled-addfb)
[486.171984] Starting subtest: 4-tiled-addfb
[486.174698] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[486.264727] [121/133] (536s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[486.355021] Starting subtest: 2x-plain-flip-ts-check-interruptible
[486.367201] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[486.444385] [122/133] (536s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[486.548617] Starting subtest: pr-overlay-plane-update-continuous-sf
[486.553759] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[486.615988] [123/133] (536s left) kms_pipe_crc_basic (read-crc)
[486.710089] Starting subtest: read-crc
[486.712186] Starting dynamic subtest: pipe-A-eDP-1
[487.426161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[487.437706] Starting dynamic subtest: pipe-B-eDP-1
[488.778895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[488.789502] Starting dynamic subtest: pipe-C-eDP-1
[490.181166] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[490.191061] Starting dynamic subtest: pipe-D-eDP-1
[491.492030] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[491.495075] Subtest read-crc: SUCCESS (4.781s)
[492.330562] [124/133] (530s left) kms_chamelium_audio (dp-audio-edid)
[492.731157] Subtest dp-audio-edid: SKIP (0.000s)
[493.544539] [125/133] (529s left) kms_fbcon_fbt (fbc)
[493.602888] Starting subtest: fbc
[499.901712] Subtest fbc: SUCCESS (6.296s)
[500.980501] [126/133] (521s left) gem_userptr_blits (unsync-unmap)
[501.044202] Subtest unsync-unmap: SKIP (0.000s)
[501.172719] [127/133] (521s left) kms_properties (plane-properties-atomic)
[501.268169] Starting subtest: plane-properties-atomic
[501.271077] Starting dynamic subtest: pipe-A-eDP-1
[501.817684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[501.827761] Starting dynamic subtest: pipe-B-eDP-1
[503.067810] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.247s)
[503.078448] Starting dynamic subtest: pipe-C-eDP-1
[504.289978] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[504.300231] Starting dynamic subtest: pipe-D-eDP-1
[505.527199] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[505.530033] Subtest plane-properties-atomic: SUCCESS (4.259s)
[506.329828] [128/133] (516s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[506.444012] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[506.448851] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[506.544217] [129/133] (516s left) kms_atomic_interruptible (legacy-pageflip)
[506.629470] Starting subtest: legacy-pageflip
[506.631798] Starting dynamic subtest: pipe-A-eDP-1
[514.075038] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.442s)
[514.077939] Subtest legacy-pageflip: SUCCESS (7.445s)
[514.910227] [130/133] (508s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[515.005572] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[515.007920] Starting dynamic subtest: pipe-A-default-mode
[516.167658] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[516.172409] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.161s)
[516.311923] [131/133] (506s left) sysfs_heartbeat_interval (idempotent)
[516.373659] Starting subtest: idempotent
[516.376409] Starting dynamic subtest: vecs0
[516.379091] Dynamic subtest vecs0: SUCCESS (0.001s)
[516.390207] Starting dynamic subtest: ccs0
[516.392614] Dynamic subtest ccs0: SUCCESS (0.001s)
[516.402224] Starting dynamic subtest: vcs0
[516.404908] Dynamic subtest vcs0: SUCCESS (0.000s)
[516.416144] Starting dynamic subtest: bcs0
[516.418200] Dynamic subtest bcs0: SUCCESS (0.001s)
[516.426767] Starting dynamic subtest: rcs0
[516.428905] Dynamic subtest rcs0: SUCCESS (0.001s)
[516.437962] Starting dynamic subtest: vcs1
[516.440182] Dynamic subtest vcs1: SUCCESS (0.000s)
[516.442690] Subtest idempotent: SUCCESS (0.008s)
[516.484139] [132/133] (506s left) kms_pm_rpm (system-suspend-modeset)
[518.207500] Starting subtest: system-suspend-modeset
[537.647288] Subtest system-suspend-modeset: SUCCESS (4.646s)
[538.025704] [133/133] (485s left) gem_vm_create (invalid-destroy)
[538.091234] Starting subtest: invalid-destroy
[538.093570] Subtest invalid-destroy: SUCCESS (0.002s)
[538.187328] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_unfence_active_buffers
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_fence_thrash
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: kms_getfb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: gem_ctx_engines
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: tools_test
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: gem_exec_parallel
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: gem_ctx_shared
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: i915_hangman
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_hdr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: device_reset
results: parsing output: 71/ for test: gem_busy
results: parsing output: 72/ for test: kms_panel_fitting
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_plane_cursor
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: syncobj_eventfd
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: prime_self_import
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gen3_render_mixed_blits
results: parsing output: 93/ for test: gem_fence_thrash
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_tiled_display
results: parsing output: 100/ for test: i915_query
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr
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_content_protection
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rc6_residency
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_pipe_crc_basic
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: kms_fbcon_fbt
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_atomic_interruptible
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: sysfs_heartbeat_interval
results: parsing output: 131/ for test: kms_pm_rpm
results: parsing output: 132/ for test: gem_vm_create
Done.