[57.646020] Initializing watchdogs
[57.646074]   /dev/watchdog0
[57.660318] [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.664482] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.666740] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.670386] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[57.804031] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[61.629696] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.829s)
[62.760631] [002/133] (955s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[62.815018] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[62.819731] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[63.003021] [003/133] (955s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[63.126403] Starting subtest: 2x-flip-vs-cursor-legacy
[63.131256] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[63.265291] [004/133] (955s left) gem_wait (wait)
[63.331559] Starting subtest: wait
[63.334039] Starting dynamic subtest: all-engines
[64.917248] Dynamic subtest all-engines: SUCCESS (1.584s)
[64.926900] Starting dynamic subtest: rcs0
[65.963934] Dynamic subtest rcs0: SUCCESS (1.047s)
[65.973430] Starting dynamic subtest: bcs0
[67.151760] Dynamic subtest bcs0: SUCCESS (1.186s)
[67.161501] Starting dynamic subtest: vcs0
[68.196253] Dynamic subtest vcs0: SUCCESS (1.044s)
[68.205331] Starting dynamic subtest: vcs1
[69.242826] Dynamic subtest vcs1: SUCCESS (1.045s)
[69.252796] Starting dynamic subtest: vecs0
[70.286562] Dynamic subtest vecs0: SUCCESS (1.043s)
[70.296220] Starting dynamic subtest: ccs0
[71.332737] Dynamic subtest ccs0: SUCCESS (1.045s)
[71.335355] Subtest wait: SUCCESS (8.001s)
[71.527925] [005/133] (946s left) kms_vrr (flip-suspend)
[71.624875] Starting subtest: flip-suspend
[71.631601] Subtest flip-suspend: SKIP (0.000s)
[71.692380] [006/133] (946s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[71.799108] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[78.875839] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.081s)
[78.996804] [007/133] (939s left) kms_chamelium_color (ctm-limited-range)
[79.101206] Subtest ctm-limited-range: SKIP (0.000s)
[79.141275] [008/133] (939s left) prime_vgem (basic-fence-read)
[79.248301] Starting subtest: basic-fence-read
[79.254933] Subtest basic-fence-read: SKIP (0.005s)
[79.347131] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[79.350162] [009/133] (939s left) gem_exec_params (invalid-bsd1-flag-on-render)
[79.408468] Starting subtest: invalid-bsd1-flag-on-render
[79.410875] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[79.563177] [010/133] (938s left) kms_psr (fbc-psr-primary-page-flip)
[79.646453] Starting subtest: fbc-psr-primary-page-flip
[79.648447] Starting dynamic subtest: eDP-1
[79.652629] Dynamic subtest eDP-1: SKIP (0.000s)
[79.656811] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[79.732045] [011/133] (938s left) kms_dp_link_training (non-uhbr-sst)
[79.831024] Starting subtest: non-uhbr-sst
[79.837941] Subtest non-uhbr-sst: SKIP (0.000s)
[79.898692] [012/133] (938s left) prime_busy (hang)
[79.971122] Starting subtest: hang
[79.973187] Starting dynamic subtest: rcs0
[106.423163] Dynamic subtest rcs0: SUCCESS (26.443s)
[106.429931] Starting dynamic subtest: bcs0
[113.568661] Dynamic subtest bcs0: SUCCESS (7.149s)
[113.575731] Starting dynamic subtest: vcs0
[120.546812] Dynamic subtest vcs0: SUCCESS (6.977s)
[120.553641] Starting dynamic subtest: vcs1
[127.588254] Dynamic subtest vcs1: SUCCESS (7.040s)
[127.602039] Starting dynamic subtest: vecs0
[134.559284] Dynamic subtest vecs0: SUCCESS (6.970s)
[134.566228] Starting dynamic subtest: ccs0
[148.399927] Dynamic subtest ccs0: SUCCESS (13.840s)
[148.402536] Subtest hang: SUCCESS (68.424s)
[148.506066] [013/133] (870s left) gem_workarounds (reset-context)
[148.568045] Starting subtest: reset-context
[148.716702] Subtest reset-context: SUCCESS (0.149s)
[148.834183] [014/133] (869s left) syncobj_wait (wait-any-snapshot)
[148.885867] Starting subtest: wait-any-snapshot
[148.967087] Subtest wait-any-snapshot: SUCCESS (0.082s)
[149.047186] [015/133] (869s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[149.136876] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[149.139267] Starting dynamic subtest: pipe-A-eDP-1
[149.196521] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[149.489000] Starting dynamic subtest: pipe-B-eDP-1
[150.302751] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.819s)
[150.590500] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.454s)
[151.452840] [016/133] (867s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[151.547605] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[151.552422] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[151.612085] [017/133] (867s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[151.711844] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[151.714049] Starting dynamic subtest: pipe-A-eDP-1
[183.966951] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.025s)
[183.975725] Starting dynamic subtest: pipe-B-eDP-1
[216.854821] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.664s)
[216.871358] Starting dynamic subtest: pipe-C-eDP-1
[249.852960] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.666s)
[249.863178] Starting dynamic subtest: pipe-D-eDP-1
[282.863339] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.728s)
[282.865862] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.086s)
[284.077238] [018/133] (734s left) kms_psr (psr-cursor-mmap-gtt)
[284.171015] Starting subtest: psr-cursor-mmap-gtt
[284.173467] Starting dynamic subtest: eDP-1
[285.875505] Dynamic subtest eDP-1: SUCCESS (1.701s)
[285.877862] Subtest psr-cursor-mmap-gtt: SUCCESS (1.701s)
[286.743369] [019/133] (732s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[286.848052] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[286.852481] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[286.919222] [020/133] (732s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[286.989167] Starting subtest: single-wait-for-submit-unsubmitted
[287.099397] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[287.190313] [021/133] (731s left) kms_chamelium_hpd (vga-hpd)
[287.585372] Subtest vga-hpd: SKIP (0.000s)
[288.353301] [022/133] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[288.452678] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[288.457014] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[288.561482] [023/133] (730s left) gem_exec_params (invalid-bsd-ring)
[288.631326] Starting subtest: invalid-bsd-ring
[288.633835] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[288.748674] [024/133] (730s left) kms_hdmi_inject (inject-audio)
[289.102784] Starting subtest: inject-audio
[289.378132] Subtest inject-audio: SUCCESS (0.277s)
[289.948066] [025/133] (729s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[290.046191] Starting subtest: primary-y-tiled-reflect-x-90
[290.050401] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[290.118064] [026/133] (729s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[290.207164] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[290.209541] Starting dynamic subtest: pipe-A-default-mode
[292.914004] Dynamic subtest pipe-A-default-mode: SUCCESS (2.703s)
[292.916160] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.704s)
[293.709758] [027/133] (725s left) kms_force_connector_basic (force-load-detect)
[293.786805] Starting subtest: force-load-detect
[293.791425] Subtest force-load-detect: SKIP (0.000s)
[293.915802] [028/133] (725s left) gem_exec_fence (syncobj-timeline-chain-engines)
[294.443898] Starting subtest: syncobj-timeline-chain-engines
[294.550223] Subtest syncobj-timeline-chain-engines: SUCCESS (0.110s)
[296.024784] [029/133] (723s left) gem_partial_pwrite_pread (reads-snoop)
[296.093572] Subtest reads-snoop: SKIP (0.000s)
[296.156122] [030/133] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[296.253320] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[300.673570] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.421s)
[301.819170] [031/133] (717s left) kms_psr (pr-sprite-plane-onoff)
[301.918147] Starting subtest: pr-sprite-plane-onoff
[301.922963] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[301.992841] [032/133] (717s left) perf (non-system-wide-paranoid)
[302.096428] Starting subtest: non-system-wide-paranoid
[302.120992] Subtest non-system-wide-paranoid: SUCCESS (0.025s)
[302.164795] [033/133] (717s left) kms_plane_alpha_blend (alpha-transparent-fb)
[302.270099] Starting subtest: alpha-transparent-fb
[302.554829] Starting dynamic subtest: pipe-A-eDP-1
[303.162472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[303.172388] Starting dynamic subtest: pipe-D-eDP-1
[304.595476] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[304.597727] Subtest alpha-transparent-fb: SUCCESS (2.321s)
[305.404275] [034/133] (714s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[305.511368] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[305.515454] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[305.617486] [035/133] (713s left) kms_big_fb (linear-64bpp-rotate-0)
[305.715542] Starting subtest: linear-64bpp-rotate-0
[307.318360] Subtest linear-64bpp-rotate-0: SUCCESS (1.602s)
[307.479810] [036/133] (712s left) kms_async_flips (async-flip-dpms)
[307.581513] Starting subtest: async-flip-dpms
[307.973090] Starting dynamic subtest: pipe-A-eDP-1
[311.863054] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.887s)
[312.244319] Starting dynamic subtest: pipe-B-eDP-1
[315.057780] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.822s)
[315.427931] Starting dynamic subtest: pipe-C-eDP-1
[318.264642] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.843s)
[318.645868] Starting dynamic subtest: pipe-D-eDP-1
[321.468794] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.827s)
[321.470988] Subtest async-flip-dpms: SUCCESS (13.882s)
[322.615485] [037/133] (697s left) gem_ctx_bad_destroy (invalid-ctx)
[322.675733] Starting subtest: invalid-ctx
[322.678191] Subtest invalid-ctx: SUCCESS (0.000s)
[322.771997] [038/133] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[322.867147] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[322.871431] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[322.958767] [039/133] (696s left) kms_vblank (query-forked-busy)
[323.048708] Starting subtest: query-forked-busy
[323.050953] Starting dynamic subtest: pipe-A-eDP-1
[324.929827] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[324.943996] Starting dynamic subtest: pipe-D-eDP-1
[327.452305] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.518s)
[327.454766] Subtest query-forked-busy: SUCCESS (4.403s)
[328.326108] [040/133] (691s left) gem_spin_batch (spin-all)
[328.392288] Starting subtest: spin-all
[328.405176] Subtest spin-all: SUCCESS (0.015s)
[329.982519] [041/133] (689s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[330.085290] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[330.089650] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[330.157517] [042/133] (689s left) kms_pm_rpm (package-g7)
[332.186413] Starting subtest: package-g7
[332.191398] Subtest package-g7: SKIP (0.000s)
[332.560498] [043/133] (687s left) kms_force_connector_basic (force-connector-state)
[332.651770] Starting subtest: force-connector-state
[333.261032] Subtest force-connector-state: SUCCESS (0.609s)
[334.228910] [044/133] (685s left) kms_cursor_crc (cursor-onscreen-32x32)
[334.388854] Starting subtest: cursor-onscreen-32x32
[334.435077] Subtest cursor-onscreen-32x32: SKIP (0.040s)
[334.722659] [045/133] (685s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[334.832195] Starting subtest: yf-tiled-32bpp-rotate-0
[334.836414] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[334.930253] [046/133] (685s left) syncobj_eventfd (timeline-wait)
[334.977134] Starting subtest: timeline-wait
[334.985619] Subtest timeline-wait: SUCCESS (0.010s)
[335.060280] [047/133] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[335.153200] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[341.764798] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.613s)
[341.903181] [048/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[341.994020] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[348.791461] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.798s)
[348.913724] [049/133] (671s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[349.014618] Starting subtest: psr-rgb565-draw-mmap-cpu
[355.673692] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.659s)
[355.788107] [050/133] (664s left) gem_ctx_isolation (preservation-reset)
[355.965655] Starting subtest: preservation-reset
[355.968072] Starting dynamic subtest: rcs0
[356.228217] Dynamic subtest rcs0: SUCCESS (0.266s)
[356.238440] Starting dynamic subtest: bcs0
[356.545691] Dynamic subtest bcs0: SUCCESS (0.316s)
[356.557159] Starting dynamic subtest: vcs0
[356.858182] Dynamic subtest vcs0: SUCCESS (0.311s)
[356.869644] Starting dynamic subtest: vcs1
[358.254606] Dynamic subtest vcs1: SUCCESS (1.394s)
[358.265232] Starting dynamic subtest: vecs0
[360.260934] Dynamic subtest vecs0: SUCCESS (2.005s)
[360.272049] Starting dynamic subtest: ccs0
[362.336409] Dynamic subtest ccs0: SUCCESS (2.073s)
[362.338915] Subtest preservation-reset: SUCCESS (6.374s)
[362.453181] [051/133] (657s left) gem_mmap_wc (bad-size)
[362.502386] Subtest bad-size: SKIP (0.000s)
[362.557239] [052/133] (657s left) gem_ctx_persistence (idempotent)
[362.611496] Starting subtest: idempotent
[362.613944] Subtest idempotent: SUCCESS (0.000s)
[362.707168] [053/133] (657s left) kms_frontbuffer_tracking (fbc-stridechange)
[362.810445] Starting subtest: fbc-stridechange
[366.038387] Subtest fbc-stridechange: SUCCESS (3.227s)
[367.233949] [054/133] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[367.336914] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[367.340920] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[367.442362] [055/133] (652s left) api_intel_allocator (two-level-inception-interruptible)
[367.501041] Starting subtest: two-level-inception-interruptible
[372.956682] Subtest two-level-inception-interruptible: SUCCESS (5.402s)
[373.025339] [056/133] (647s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[373.131261] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[373.135592] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[373.243268] [057/133] (647s left) kms_psr (psr-sprite-mmap-gtt)
[373.331291] Starting subtest: psr-sprite-mmap-gtt
[373.333517] Starting dynamic subtest: eDP-1
[374.823990] Dynamic subtest eDP-1: SKIP (1.488s)
[374.828586] Subtest psr-sprite-mmap-gtt: SKIP (1.491s)
[374.971349] [058/133] (645s left) i915_pm_freq_api (freq-suspend)
[375.043480] Starting subtest: freq-suspend
[375.045831] Starting dynamic subtest: gt0
[391.698234] Dynamic subtest gt0: SUCCESS (1.310s)
[391.712529] Starting dynamic subtest: gt1
[407.663326] Dynamic subtest gt1: SUCCESS (1.195s)
[407.666547] Subtest freq-suspend: SUCCESS (2.508s)
[408.751519] [059/133] (612s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[408.872942] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[408.875130] Starting dynamic subtest: pipe-A-eDP-1
[408.896624] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.906946] Starting dynamic subtest: pipe-B-eDP-1
[408.927792] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.936092] Starting dynamic subtest: pipe-C-eDP-1
[408.956732] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.964992] Starting dynamic subtest: pipe-D-eDP-1
[408.986802] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.990775] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[411.091495] [060/133] (610s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[411.202871] Starting subtest: y-tiled-16bpp-rotate-90
[411.206898] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[411.296410] [061/133] (610s left) kms_psr (fbc-pr-sprite-blt)
[411.387616] Starting subtest: fbc-pr-sprite-blt
[411.391753] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[411.457987] [062/133] (610s left) kms_atomic_transition (plane-all-transition)
[411.553688] Starting subtest: plane-all-transition
[411.555953] Starting dynamic subtest: pipe-A-eDP-1
[414.050357] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[414.356257] Starting dynamic subtest: pipe-B-eDP-1
[417.607262] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.258s)
[417.923457] Subtest plane-all-transition: SUCCESS (6.364s)
[418.803164] [063/133] (602s left) core_auth (getclient-simple)
[418.838235] Starting subtest: getclient-simple
[418.859278] Subtest getclient-simple: SUCCESS (0.020s)
[418.968230] [064/133] (602s left) syncobj_timeline (etime-single-wait-submitted)
[419.023158] Starting subtest: etime-single-wait-submitted
[419.132081] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[419.209610] [065/133] (602s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[419.304141] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[419.308260] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[419.402740] [066/133] (602s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[419.501085] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[426.209623] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.706s)
[426.308115] [067/133] (595s left) kms_cursor_crc (cursor-random-128x42)
[426.525535] Starting subtest: cursor-random-128x42
[426.568767] Subtest cursor-random-128x42: SKIP (0.041s)
[426.756071] [068/133] (595s left) prime_self_import (basic-llseek-bad)
[426.794453] Starting subtest: basic-llseek-bad
[426.806962] Subtest basic-llseek-bad: SUCCESS (0.012s)
[426.897614] [069/133] (595s left) prime_mmap (test_forked_cpu_write)
[426.966692] Starting subtest: test_forked_cpu_write
[426.968876] Starting dynamic subtest: test_forked_cpu_write-smem
[426.973937] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[426.976202] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[427.105839] [070/133] (594s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[427.172633] Subtest writes-after-reads-snoop: SKIP (0.000s)
[427.237705] [071/133] (594s left) kms_cursor_crc (cursor-sliding-256x256)
[427.478679] Starting subtest: cursor-sliding-256x256
[427.482935] Starting dynamic subtest: pipe-A-eDP-1
[430.776569] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.289s)
[430.803737] Starting dynamic subtest: pipe-D-eDP-1
[434.664850] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.864s)
[434.667064] Subtest cursor-sliding-256x256: SUCCESS (7.181s)
[435.514745] [072/133] (586s left) gem_exec_suspend (basic-s0)
[435.579687] Starting subtest: basic-S0
[435.581946] Starting dynamic subtest: smem
[455.643479] Dynamic subtest smem: SUCCESS (6.510s)
[455.646689] Subtest basic-S0: SUCCESS (6.513s)
[455.838761] [073/133] (566s left) prime_mmap_coherency (ioctl-errors)
[455.916126] Starting subtest: ioctl-errors
[471.685605] Subtest ioctl-errors: SUCCESS (15.757s)
[471.839196] [074/133] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[471.973589] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[471.976945] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[472.084891] [075/133] (550s left) gem_exec_schedule (noreorder-corked)
[472.278369] Starting subtest: noreorder-corked
[472.281055] Starting dynamic subtest: rcs0
[473.427998] Dynamic subtest rcs0: SUCCESS (1.150s)
[473.440371] Starting dynamic subtest: vcs0
[474.585233] Dynamic subtest vcs0: SUCCESS (1.154s)
[474.597399] Starting dynamic subtest: vcs1
[476.632550] Dynamic subtest vcs1: SUCCESS (2.043s)
[476.644854] Starting dynamic subtest: vecs0
[478.623163] Dynamic subtest vecs0: SUCCESS (1.988s)
[478.635137] Starting dynamic subtest: ccs0
[479.777688] Dynamic subtest ccs0: SUCCESS (1.153s)
[479.780230] Subtest noreorder-corked: SUCCESS (7.498s)
[479.963325] [076/133] (542s left) kms_plane_cursor (primary)
[480.058864] Starting subtest: primary
[480.063531] Starting dynamic subtest: pipe-A-eDP-1-size-64
[482.605125] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.545s)
[482.629403] Starting dynamic subtest: pipe-A-eDP-1-size-128
[485.185010] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s)
[485.210040] Starting dynamic subtest: pipe-A-eDP-1-size-256
[487.798496] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.595s)
[488.117591] Starting dynamic subtest: pipe-B-eDP-1-size-64
[491.376680] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.267s)
[491.406161] Starting dynamic subtest: pipe-B-eDP-1-size-128
[493.976161] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[494.000547] Starting dynamic subtest: pipe-B-eDP-1-size-256
[496.609341] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.616s)
[496.929650] Starting dynamic subtest: pipe-C-eDP-1-size-64
[499.799897] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.880s)
[499.828062] Starting dynamic subtest: pipe-C-eDP-1-size-128
[502.022223] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[502.049784] Starting dynamic subtest: pipe-C-eDP-1-size-256
[504.222351] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[504.543560] Starting dynamic subtest: pipe-D-eDP-1-size-64
[507.458466] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.926s)
[507.485248] Starting dynamic subtest: pipe-D-eDP-1-size-128
[509.614520] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s)
[509.641861] Starting dynamic subtest: pipe-D-eDP-1-size-256
[511.793960] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[512.101212] Subtest primary: SUCCESS (32.039s)
[512.905997] [077/133] (509s left) perf_pmu (busy-no-semaphores)
[512.961637] Starting subtest: busy-no-semaphores
[512.963941] Starting dynamic subtest: rcs0
[513.529370] Dynamic subtest rcs0: SUCCESS (0.566s)
[513.540616] Starting dynamic subtest: bcs0
[514.078254] Dynamic subtest bcs0: SUCCESS (0.546s)
[514.090905] Starting dynamic subtest: vcs0
[514.628899] Dynamic subtest vcs0: SUCCESS (0.548s)
[514.641317] Starting dynamic subtest: vcs1
[516.127678] Dynamic subtest vcs1: SUCCESS (1.494s)
[516.138967] Starting dynamic subtest: vecs0
[518.109455] Dynamic subtest vecs0: SUCCESS (1.979s)
[518.122516] Starting dynamic subtest: ccs0
[520.095304] Dynamic subtest ccs0: SUCCESS (1.982s)
[520.098060] Subtest busy-no-semaphores: SUCCESS (7.133s)
[520.215960] [078/133] (502s left) syncobj_timeline (single-wait-available-submitted)
[520.283286] Starting subtest: single-wait-available-submitted
[520.285672] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[520.398886] [079/133] (502s left) kms_chamelium_color (ctm-red-to-blue)
[520.491486] Subtest ctm-red-to-blue: SKIP (0.000s)
[520.538191] [080/133] (501s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[520.628879] Starting subtest: plane-lut1d-post-ctm3x4
[520.753043] Starting dynamic subtest: pipe-A-plane-0
[520.919231] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[520.929217] Starting dynamic subtest: pipe-A-plane-1
[521.097229] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[521.107888] Starting dynamic subtest: pipe-A-plane-2
[521.255440] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[522.457579] Starting dynamic subtest: pipe-B-plane-0
[522.603758] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[522.613518] Starting dynamic subtest: pipe-B-plane-1
[522.736659] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[522.746533] Starting dynamic subtest: pipe-B-plane-2
[522.881347] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[524.078553] Starting dynamic subtest: pipe-C-plane-0
[524.204627] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[524.220934] Starting dynamic subtest: pipe-C-plane-1
[524.348304] Dynamic subtest pipe-C-plane-1: SUCCESS (0.142s)
[524.358301] Starting dynamic subtest: pipe-C-plane-2
[524.514829] Dynamic subtest pipe-C-plane-2: SUCCESS (0.164s)
[525.658707] Starting dynamic subtest: pipe-D-plane-0
[525.783409] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[525.793561] Starting dynamic subtest: pipe-D-plane-1
[525.927768] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[525.940331] Starting dynamic subtest: pipe-D-plane-2
[526.061432] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[526.352469] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.720s)
[527.206022] [081/133] (495s left) gem_reg_read (timestamp-monotonic)
[527.258962] Starting subtest: timestamp-monotonic
[532.168314] Subtest timestamp-monotonic: SUCCESS (4.858s)
[532.211049] [082/133] (490s left) kms_atomic (plane-overlay-legacy)
[532.318776] Starting subtest: plane-overlay-legacy
[532.321083] Starting dynamic subtest: pipe-A-eDP-1
[532.801792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[532.804119] Subtest plane-overlay-legacy: SUCCESS (0.482s)
[533.600770] [083/133] (488s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[533.705177] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[534.704687] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s)
[534.817262] [084/133] (487s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[534.928440] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[534.931722] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[535.024764] [085/133] (487s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[535.132082] Starting subtest: yf-tiled-32bpp-rotate-90
[535.135620] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[535.237069] [086/133] (487s left) gem_barrier_race (remote-request)
[535.300649] Starting subtest: remote-request
[535.302517] Starting dynamic subtest: rcs0
[540.462710] Dynamic subtest rcs0: SUCCESS (5.162s)
[540.464610] Subtest remote-request: SUCCESS (5.164s)
[540.614087] [087/133] (482s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[540.744951] Starting subtest: flip-vs-cursor-crc-atomic
[541.399471] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.652s)
[542.211870] [088/133] (480s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[542.316141] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[542.318448] Starting dynamic subtest: pipe-A
[542.379244] Dynamic subtest pipe-A: SUCCESS (0.065s)
[542.388909] Starting dynamic subtest: pipe-B
[543.501691] Dynamic subtest pipe-B: SUCCESS (1.121s)
[543.514171] Starting dynamic subtest: pipe-C
[544.592143] Dynamic subtest pipe-C: SUCCESS (1.088s)
[544.602630] Starting dynamic subtest: pipe-D
[545.681339] Dynamic subtest pipe-D: SUCCESS (1.088s)
[545.683725] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.367s)
[546.904082] [089/133] (475s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[547.004080] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[547.006224] Starting dynamic subtest: pipe-A-eDP-1
[547.028156] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[547.040092] Starting dynamic subtest: pipe-B-eDP-1
[547.061371] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[547.071158] Starting dynamic subtest: pipe-C-eDP-1
[547.092404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[547.103420] Starting dynamic subtest: pipe-D-eDP-1
[547.124891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[547.128939] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[549.307509] [090/133] (473s left) gen9_exec_parse (bb-start-param)
[549.372317] Subtest bb-start-param: SKIP (0.000s)
[549.445253] [091/133] (473s left) dmabuf_sync_file (export-before-signal)
[549.485776] Starting subtest: export-before-signal
[549.487910] Subtest export-before-signal: SUCCESS (0.001s)
[549.541875] [092/133] (473s left) kms_invalid_mode (zero-clock)
[549.634255] Starting subtest: zero-clock
[549.636546] Starting dynamic subtest: pipe-A-eDP-1
[549.919687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[549.932558] Starting dynamic subtest: pipe-B-eDP-1
[549.934864] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[549.943928] Starting dynamic subtest: pipe-C-eDP-1
[549.946197] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[549.963164] Starting dynamic subtest: pipe-D-eDP-1
[549.966096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[549.968891] Subtest zero-clock: SUCCESS (0.296s)
[550.709121] [093/133] (472s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[552.748456] Starting subtest: dpms-mode-unset-lpsp
[556.804749] Subtest dpms-mode-unset-lpsp: SUCCESS (4.061s)
[557.203417] [094/133] (465s left) gem_media_vme
[557.352066] [095/133] (465s left) i915_drm_fdinfo (isolation)
[557.395944] Starting subtest: isolation
[557.398176] Starting dynamic subtest: rcs0
[557.445909] Dynamic subtest rcs0: SKIP (0.047s)
[557.458029] Starting dynamic subtest: bcs0
[557.461990] Dynamic subtest bcs0: SKIP (0.000s)
[557.471380] Starting dynamic subtest: vcs0
[557.475799] Dynamic subtest vcs0: SKIP (0.000s)
[557.484594] Starting dynamic subtest: vcs1
[557.488612] Dynamic subtest vcs1: SKIP (0.000s)
[557.497318] Starting dynamic subtest: vecs0
[557.501420] Dynamic subtest vecs0: SKIP (0.000s)
[557.510321] Starting dynamic subtest: ccs0
[557.514394] Dynamic subtest ccs0: SKIP (0.000s)
[557.518436] Subtest isolation: SKIP (0.055s)
[557.555486] [096/133] (465s left) gem_mmap_offset (perf)
[557.620629] Starting subtest: perf
[557.623002] Starting dynamic subtest: smem0
[557.959032] Dynamic subtest smem0: SUCCESS (0.337s)
[557.961553] Subtest perf: SUCCESS (0.338s)
[558.064767] [097/133] (465s left) i915_pm_rps (thresholds-idle-park)
[558.116566] Starting subtest: thresholds-idle-park
[558.121040] Subtest thresholds-idle-park: SKIP (0.000s)
[558.215515] [098/133] (464s left) sysfs_timeslice_duration (timeout)
[558.276993] Starting subtest: timeout
[558.279261] Starting dynamic subtest: vecs0
[567.576890] Dynamic subtest vecs0: SUCCESS (9.299s)
[567.589503] Starting dynamic subtest: ccs0
[568.835283] Dynamic subtest ccs0: SUCCESS (1.257s)
[568.847801] Starting dynamic subtest: vcs0
[578.654947] Dynamic subtest vcs0: SUCCESS (9.822s)
[578.666577] Starting dynamic subtest: bcs0
[579.263802] Dynamic subtest bcs0: SUCCESS (0.605s)
[579.276476] Starting dynamic subtest: rcs0
[580.537631] Dynamic subtest rcs0: SUCCESS (1.273s)
[580.552896] Starting dynamic subtest: vcs1
[589.593785] Dynamic subtest vcs1: SUCCESS (9.049s)
[589.596632] Subtest timeout: SUCCESS (31.318s)
[589.671903] [099/133] (433s left) gem_create (create-clear)
[589.730662] Starting subtest: create-clear
[589.732865] Starting dynamic subtest: smem0
[622.536360] Dynamic subtest smem0: SUCCESS (32.797s)
[622.538683] Subtest create-clear: SUCCESS (32.798s)
[622.724896] [100/133] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[622.838379] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[627.404360] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.571s)
[628.624731] [101/133] (394s left) kms_frontbuffer_tracking (basic)
[628.723585] Starting subtest: basic
[631.844463] Subtest basic: SUCCESS (3.123s)
[632.003700] [102/133] (391s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[632.072258] Starting subtest: stress-mm-invalidate-close-overlap
[634.274729] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[634.374851] [103/133] (389s left) kms_lease (simple-lease)
[634.476885] Starting subtest: simple-lease
[634.479459] Starting dynamic subtest: pipe-A-eDP-1
[634.978991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[634.989357] Starting dynamic subtest: pipe-B-eDP-1
[636.436250] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.454s)
[636.446518] Starting dynamic subtest: pipe-C-eDP-1
[637.878956] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.442s)
[637.889494] Starting dynamic subtest: pipe-D-eDP-1
[639.300859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s)
[639.303258] Subtest simple-lease: SUCCESS (4.824s)
[640.104125] [104/133] (383s left) gem_ctx_shared (exec-shared-gtt)
[640.166807] Starting subtest: exec-shared-gtt
[640.169184] Starting dynamic subtest: rcs0
[640.175183] Dynamic subtest rcs0: SUCCESS (0.008s)
[640.186404] Starting dynamic subtest: bcs0
[640.188512] Dynamic subtest bcs0: SUCCESS (0.005s)
[640.198354] Starting dynamic subtest: vcs0
[640.200625] Dynamic subtest vcs0: SUCCESS (0.007s)
[640.210197] Starting dynamic subtest: vcs1
[640.212428] Dynamic subtest vcs1: SUCCESS (0.009s)
[640.221987] Starting dynamic subtest: vecs0
[640.223805] Dynamic subtest vecs0: SUCCESS (0.011s)
[640.232761] Starting dynamic subtest: ccs0
[640.234681] Dynamic subtest ccs0: SUCCESS (0.006s)
[640.236591] Subtest exec-shared-gtt: SUCCESS (0.052s)
[640.418102] [105/133] (383s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[640.473027] Starting subtest: multi-wait-available-unsubmitted-submitted
[640.475140] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[640.571118] [106/133] (383s left) kms_hdr (invalid-metadata-sizes)
[640.662051] Starting subtest: invalid-metadata-sizes
[640.668444] Subtest invalid-metadata-sizes: SKIP (0.000s)
[640.736993] [107/133] (382s left) gem_exec_fence (concurrent)
[640.929644] Starting subtest: concurrent
[640.934250] Subtest concurrent: SKIP (0.000s)
[642.741586] [108/133] (380s left) gem_exec_balancer (bonded-false-hang)
[642.991727] Starting subtest: bonded-false-hang
[642.997432] Subtest bonded-false-hang: SKIP (0.000s)
[643.095872] [109/133] (380s left) i915_pm_rps (min-max-config-idle)
[643.163642] Starting subtest: min-max-config-idle
[643.167680] Subtest min-max-config-idle: SKIP (0.000s)
[643.264963] [110/133] (380s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[643.362547] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[643.390149] Starting dynamic subtest: pipe-A-plane-0
[644.023189] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[644.033988] Starting dynamic subtest: pipe-A-plane-3
[644.445379] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[645.551880] Starting dynamic subtest: pipe-B-plane-0
[646.221107] Dynamic subtest pipe-B-plane-0: SUCCESS (0.677s)
[646.231485] Starting dynamic subtest: pipe-B-plane-3
[646.643446] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[646.957438] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.592s)
[647.800045] [111/133] (375s left) gem_mmap_gtt (big-bo-tiledy)
[647.857120] Subtest big-bo-tiledY: SKIP (0.000s)
[647.918270] [112/133] (375s left) kms_content_protection (dp-mst-type-0-hdcp14)
[648.059472] Starting subtest: dp-mst-type-0-hdcp14
[648.064017] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[648.173431] [113/133] (375s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[648.225922] Starting subtest: multi-wait-all-available-submitted-signaled
[648.228244] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[648.320242] [114/133] (375s left) gem_exec_whisper (basic-queues-forked)
[648.376316] Starting subtest: basic-queues-forked
[672.805782] Subtest basic-queues-forked: SUCCESS (24.367s)
[672.939712] [115/133] (351s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[673.055948] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[679.671516] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.615s)
[679.823558] [116/133] (344s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[679.891785] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[679.965333] [117/133] (344s left) gem_mmap_wc (write-read-distinct)
[680.028679] Subtest write-read-distinct: SKIP (0.000s)
[680.095959] [118/133] (344s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[680.156459] Subtest writes-after-reads-uncached: SKIP (0.000s)
[680.223944] [119/133] (343s left) sw_sync (sync_busy)
[680.260979] Starting subtest: sync_busy
[680.262987] Subtest sync_busy: SUCCESS (0.002s)
[680.318238] [120/133] (343s left) kms_universal_plane (universal-plane-functional)
[680.414663] Starting subtest: universal-plane-functional
[680.416562] Starting dynamic subtest: pipe-A-eDP-1
[684.293595] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.880s)
[684.304701] Starting dynamic subtest: pipe-B-eDP-1
[688.908097] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.614s)
[688.921308] Starting dynamic subtest: pipe-C-eDP-1
[693.240349] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.332s)
[693.250727] Starting dynamic subtest: pipe-D-eDP-1
[697.566435] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.322s)
[697.568422] Subtest universal-plane-functional: SUCCESS (17.153s)
[698.398074] [121/133] (325s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[698.512050] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[698.514405] Starting dynamic subtest: pipe-A-eDP-1
[698.803717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.261s)
[698.818757] Starting dynamic subtest: pipe-B-eDP-1
[700.060976] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[700.072891] Starting dynamic subtest: pipe-C-eDP-1
[701.320115] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.260s)
[701.330011] Starting dynamic subtest: pipe-D-eDP-1
[702.513752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s)
[702.516565] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.973s)
[703.701396] [122/133] (320s left) syncobj_wait (multi-wait-all-submitted-signaled)
[703.759953] Starting subtest: multi-wait-all-submitted-signaled
[703.862599] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[703.942271] [123/133] (320s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[704.039737] Starting subtest: x-tiled-8bpp-rotate-0
[705.255368] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.216s)
[705.380549] [124/133] (318s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[705.472888] Starting subtest: fbcpsr-rgb101010-draw-blt
[712.138567] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.667s)
[712.275469] [125/133] (312s left) kms_properties (get_properties-sanity-non-atomic)
[712.373593] Starting subtest: get_properties-sanity-non-atomic
[712.375874] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[712.447616] [126/133] (311s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[712.587906] Starting subtest: multiplane-atomic-fence-wait
[712.917567] Subtest multiplane-atomic-fence-wait: SUCCESS (0.329s)
[714.097226] [127/133] (310s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[714.192252] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[714.194495] Starting dynamic subtest: pipe-A-eDP-1
[720.855118] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.667s)
[720.867749] Starting dynamic subtest: pipe-B-eDP-1
[727.809524] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.949s)
[727.811534] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.622s)
[728.616211] [128/133] (295s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[728.692373] Starting subtest: mixed-tiled-to-y-tiled-ccs
[728.696944] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[728.879025] [129/133] (295s left) gem_exec_fence (syncobj-timeline-signal)
[729.535436] Starting subtest: syncobj-timeline-signal
[729.540356] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[730.656212] [130/133] (293s left) kms_plane (plane-position-covered)
[730.757037] Starting subtest: plane-position-covered
[731.259232] Starting dynamic subtest: pipe-A-plane-1
[732.547553] Dynamic subtest pipe-A-plane-1: SUCCESS (1.289s)
[732.558663] Starting dynamic subtest: pipe-A-plane-2
[733.815859] Dynamic subtest pipe-A-plane-2: SUCCESS (1.264s)
[733.833131] Starting dynamic subtest: pipe-A-plane-3
[735.151242] Dynamic subtest pipe-A-plane-3: SUCCESS (1.337s)
[735.162756] Starting dynamic subtest: pipe-A-plane-4
[736.427607] Dynamic subtest pipe-A-plane-4: SUCCESS (1.275s)
[736.437619] Starting dynamic subtest: pipe-A-plane-5
[736.454660] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[737.660057] Starting dynamic subtest: pipe-B-plane-1
[738.972089] Dynamic subtest pipe-B-plane-1: SUCCESS (1.317s)
[738.982218] Starting dynamic subtest: pipe-B-plane-2
[740.217882] Dynamic subtest pipe-B-plane-2: SUCCESS (1.247s)
[740.230506] Starting dynamic subtest: pipe-B-plane-3
[741.549318] Dynamic subtest pipe-B-plane-3: SUCCESS (1.330s)
[741.560852] Starting dynamic subtest: pipe-B-plane-4
[742.829283] Dynamic subtest pipe-B-plane-4: SUCCESS (1.278s)
[742.840886] Starting dynamic subtest: pipe-B-plane-5
[742.854307] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[742.856548] Subtest plane-position-covered: SUCCESS (12.098s)
[743.686300] [131/133] (280s left) gem_shrink (reclaim)
[743.747914] Starting subtest: reclaim
[746.223456] Subtest reclaim: SUCCESS (2.432s)
[746.310984] [132/133] (278s left) gem_mmap_wc (write-gtt-read-wc)
[746.361775] Subtest write-gtt-read-wc: SKIP (0.000s)
[746.422430] [133/133] (278s left) gem_exec_schedule (u-fairslice-all)
[746.491611] Starting subtest: u-fairslice-all
[748.630995] Subtest u-fairslice-all: SUCCESS (2.093s)
[749.679437] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_chamelium_color
results: parsing output: 7/ for test: prime_vgem
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_dp_link_training
results: parsing output: 11/ for test: prime_busy
results: parsing output: 12/ for test: gem_workarounds
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_hdmi_inject
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_force_connector_basic
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_ctx_bad_destroy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: gem_spin_batch
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_force_connector_basic
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_eventfd
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_isolation
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: i915_pm_freq_api
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_atomic_transition
results: parsing output: 62/ for test: core_auth
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: prime_self_import
results: parsing output: 68/ for test: prime_mmap
results: parsing output: 69/ for test: gem_partial_pwrite_pread
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_exec_suspend
results: parsing output: 72/ for test: prime_mmap_coherency
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_plane_cursor
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: kms_color_pipeline
results: parsing output: 80/ for test: gem_reg_read
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_barrier_race
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: dmabuf_sync_file
results: parsing output: 91/ for test: kms_invalid_mode
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: gem_media_vme
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_mmap_offset
results: parsing output: 96/ for test: i915_pm_rps
results: parsing output: 97/ for test: sysfs_timeslice_duration
results: parsing output: 98/ for test: gem_create
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_userptr_blits
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: gem_ctx_shared
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_hdr
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: gem_partial_pwrite_pread
results: parsing output: 118/ for test: sw_sync
results: parsing output: 119/ for test: kms_universal_plane
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_properties
results: parsing output: 125/ for test: kms_explicit_fence
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: gem_shrink
results: parsing output: 131/ for test: gem_mmap_wc
results: parsing output: 132/ for test: gem_exec_schedule
Done.