[59.569180] Initializing watchdogs
[59.569228]   /dev/watchdog0
[59.583247] [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]
[59.587533] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.589738] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.593190] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[59.871435] Starting subtest: cursor-offscreen-256x85
[59.933200] Subtest cursor-offscreen-256x85: SKIP (0.056s)
[60.145693] [002/134] (959s left) gem_mmap_gtt (cpuset-big-copy-odd)
[60.215058] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[60.295074] [003/134] (959s left) gem_ctx_engines (execute-allforone)
[60.363759] Starting subtest: execute-allforone
[60.378412] Subtest execute-allforone: SUCCESS (0.015s)
[62.034899] [004/134] (958s left) perf_pmu (busy-idle)
[62.069510] Starting subtest: busy-idle
[62.071765] Starting dynamic subtest: rcs0
[62.786191] Dynamic subtest rcs0: SUCCESS (0.717s)
[62.795196] Starting dynamic subtest: bcs0
[63.461704] Dynamic subtest bcs0: SUCCESS (0.674s)
[63.471629] Starting dynamic subtest: vcs0
[64.919429] Dynamic subtest vcs0: SUCCESS (1.455s)
[64.929717] Starting dynamic subtest: vcs1
[66.902190] Dynamic subtest vcs1: SUCCESS (1.982s)
[66.912325] Starting dynamic subtest: vecs0
[68.886306] Dynamic subtest vecs0: SUCCESS (1.983s)
[68.895390] Starting dynamic subtest: ccs0
[69.559069] Dynamic subtest ccs0: SUCCESS (0.672s)
[69.561915] Subtest busy-idle: SUCCESS (7.490s)
[69.696481] [005/134] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[69.804259] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[70.482555] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.680s)
[70.688257] [006/134] (949s left) api_intel_bb (lot-of-buffers)
[70.738662] Starting subtest: lot-of-buffers
[71.727796] Subtest lot-of-buffers: SUCCESS (0.990s)
[72.013245] [007/134] (948s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[72.080092] Starting subtest: yf-tiled-to-vebox-x-tiled
[72.084306] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[72.266391] [008/134] (948s left) kms_plane (plane-panning-top-left)
[72.354698] Starting subtest: plane-panning-top-left
[72.357176] Starting dynamic subtest: pipe-A
[74.019488] Dynamic subtest pipe-A: SUCCESS (1.663s)
[74.028133] Starting dynamic subtest: pipe-B
[76.412060] Dynamic subtest pipe-B: SUCCESS (2.391s)
[76.413999] Subtest plane-panning-top-left: SUCCESS (4.055s)
[77.295252] [009/134] (943s left) kms_psr (fbc-psr-cursor-plane-onoff)
[77.387285] Starting subtest: fbc-psr-cursor-plane-onoff
[77.389598] Starting dynamic subtest: eDP-1
[77.394156] Dynamic subtest eDP-1: SKIP (0.000s)
[77.398745] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[77.467129] [010/134] (942s left) kms_cursor_crc (cursor-tearing-position-change)
[77.576542] Starting subtest: cursor-tearing-position-change
[77.578693] Starting dynamic subtest: pipe-A-eDP-1
[78.147811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[78.156980] Starting dynamic subtest: pipe-D-eDP-1
[79.419305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[79.421956] Subtest cursor-tearing-position-change: SUCCESS (1.842s)
[80.254602] [011/134] (940s left) kms_frontbuffer_tracking (basic)
[80.365644] Starting subtest: basic
[83.546896] Subtest basic: SUCCESS (3.185s)
[83.681244] [012/134] (936s left) gem_spin_batch (spin-each)
[83.749975] Starting subtest: spin-each
[87.103838] Subtest spin-each: SUCCESS (3.355s)
[88.964852] [013/134] (931s left) gem_exec_reloc (basic-gtt-cpu)
[89.024387] Subtest basic-gtt-cpu: SKIP (0.000s)
[89.111297] [014/134] (931s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[89.233129] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[89.258803] Starting dynamic subtest: pipe-A-plane-0
[89.547880] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[89.557188] Starting dynamic subtest: pipe-A-plane-3
[89.781312] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[89.790994] Starting dynamic subtest: pipe-A-plane-5
[89.795567] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[90.851835] Starting dynamic subtest: pipe-B-plane-0
[91.133949] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[91.143295] Starting dynamic subtest: pipe-B-plane-3
[91.378086] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[91.387712] Starting dynamic subtest: pipe-B-plane-5
[91.392076] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[91.687198] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.454s)
[92.545714] [015/134] (928s left) gem_render_copy (y-tiled-ccs-to-linear)
[92.622079] Starting subtest: y-tiled-ccs-to-linear
[92.626807] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[92.813378] [016/134] (927s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[92.921880] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[92.925961] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[93.057630] [017/134] (927s left) kms_psr (pr-sprite-render)
[93.157950] Starting subtest: pr-sprite-render
[93.162333] Subtest pr-sprite-render: SKIP (0.000s)
[93.250158] [018/134] (927s left) gen9_exec_parse (shadow-peek)
[93.315362] Subtest shadow-peek: SKIP (0.000s)
[93.398174] [019/134] (927s left) perf (invalid-remove-userspace-config)
[93.522419] Starting subtest: invalid-remove-userspace-config
[93.529452] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[93.569237] [020/134] (927s left) gem_ctx_param (invalid-size-set)
[93.627669] Starting subtest: invalid-size-set
[93.629984] Subtest invalid-size-set: SUCCESS (0.001s)
[93.762667] [021/134] (927s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[93.843807] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[93.845923] Starting dynamic subtest: pipe-A-eDP-1
[93.865124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.875193] Starting dynamic subtest: pipe-B-eDP-1
[93.891742] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.898811] Starting dynamic subtest: pipe-C-eDP-1
[93.916066] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.922915] Starting dynamic subtest: pipe-D-eDP-1
[93.941477] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.945231] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[96.085719] [022/134] (924s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[96.153086] Starting subtest: invalid-bsd2-flag-on-blt
[96.155456] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[96.280095] [023/134] (924s left) gem_render_copy (yf-tiled-ccs-to-linear)
[96.346641] Starting subtest: yf-tiled-ccs-to-linear
[96.351163] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[96.549356] [024/134] (924s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[96.609584] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[96.714970] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[96.798167] [025/134] (924s left) gem_exec_fence (invalid-timeline-fence-array)
[97.374894] Starting subtest: invalid-timeline-fence-array
[97.385109] Subtest invalid-timeline-fence-array: SUCCESS (0.009s)
[98.998069] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[99.001147] [026/134] (922s left) kms_chamelium_edid (dp-edid-read)
[99.408197] Subtest dp-edid-read: SKIP (0.000s)
[100.193629] [027/134] (920s left) gem_exec_params (invalid-bsd1-flag-on-render)
[100.262696] Starting subtest: invalid-bsd1-flag-on-render
[100.265175] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[100.419933] [028/134] (920s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[100.538066] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[101.542191] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.004s)
[101.733983] [029/134] (919s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[101.833259] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[101.835095] Starting dynamic subtest: pipe-A-eDP-1
[101.854868] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.864674] Starting dynamic subtest: pipe-B-eDP-1
[101.881938] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.888972] Starting dynamic subtest: pipe-C-eDP-1
[101.906575] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.913453] Starting dynamic subtest: pipe-D-eDP-1
[101.931399] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.934788] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[103.992896] [030/134] (917s left) gem_eio (kms)
[104.245069] Starting subtest: kms
[124.027492] Subtest kms: SUCCESS (19.783s)
[125.211470] [031/134] (896s left) kms_cursor_legacy (torture-move)
[125.346439] Starting subtest: torture-move
[125.348650] Starting dynamic subtest: pipe-A
[131.741330] Dynamic subtest pipe-A: SUCCESS (6.392s)
[131.755511] Starting dynamic subtest: pipe-B
[139.193599] Dynamic subtest pipe-B: SUCCESS (7.451s)
[139.204202] Starting dynamic subtest: pipe-C
[146.216967] Dynamic subtest pipe-C: SUCCESS (7.023s)
[146.228128] Starting dynamic subtest: pipe-D
[153.223565] Dynamic subtest pipe-D: SUCCESS (7.005s)
[153.235038] Starting dynamic subtest: all-pipes
[160.448997] Dynamic subtest all-pipes: SUCCESS (7.222s)
[160.451650] Subtest torture-move: SUCCESS (35.100s)
[160.628332] [032/134] (860s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[160.728153] Starting subtest: bad-pixel-format-yf-tiled-ccs
[160.730442] Starting dynamic subtest: pipe-A-eDP-1
[160.753772] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.764236] Starting dynamic subtest: pipe-B-eDP-1
[160.786059] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.794113] Starting dynamic subtest: pipe-C-eDP-1
[160.815674] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.823574] Starting dynamic subtest: pipe-D-eDP-1
[160.845434] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.849499] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[162.985446] [033/134] (858s left) gem_exec_capture (pi)
[163.053187] Starting subtest: pi
[163.055551] Starting dynamic subtest: rcs0
[167.365736] Dynamic subtest rcs0: SUCCESS (4.314s)
[167.376869] Starting dynamic subtest: bcs0
[171.553723] Dynamic subtest bcs0: SUCCESS (4.186s)
[171.564831] Starting dynamic subtest: vcs0
[175.762519] Dynamic subtest vcs0: SUCCESS (4.207s)
[175.773111] Starting dynamic subtest: vcs1
[180.015056] Dynamic subtest vcs1: SUCCESS (4.251s)
[180.026113] Starting dynamic subtest: vecs0
[184.194674] Dynamic subtest vecs0: SUCCESS (4.179s)
[184.205804] Starting dynamic subtest: ccs0
[188.389695] Dynamic subtest ccs0: SUCCESS (4.194s)
[188.392301] Subtest pi: SUCCESS (25.338s)
[188.475393] [034/134] (832s left) syncobj_timeline (wait-all-snapshot)
[188.571102] Starting subtest: wait-all-snapshot
[188.652810] Subtest wait-all-snapshot: SUCCESS (0.081s)
[188.749429] [035/134] (832s left) kms_async_flips (test-cursor-atomic)
[188.857823] Starting subtest: test-cursor-atomic
[188.862487] Subtest test-cursor-atomic: SKIP (0.001s)
[190.108245] [036/134] (831s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[190.212407] Starting subtest: x-tiled-32bpp-rotate-180
[191.771216] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.560s)
[191.939106] [037/134] (829s left) i915_pm_freq_api (freq-reset)
[191.999332] Starting subtest: freq-reset
[192.001471] Starting dynamic subtest: gt0
[192.197156] Dynamic subtest gt0: SUCCESS (0.195s)
[192.205366] Starting dynamic subtest: gt1
[192.357120] Dynamic subtest gt1: SUCCESS (0.159s)
[192.359971] Subtest freq-reset: SUCCESS (0.356s)
[192.463440] [038/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[192.574280] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[196.892047] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.322s)
[198.042243] [039/134] (823s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[198.148462] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[198.150791] Starting dynamic subtest: pipe-A-eDP-1
[198.177039] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.188840] Starting dynamic subtest: pipe-B-eDP-1
[198.212639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.220154] Starting dynamic subtest: pipe-C-eDP-1
[198.243902] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.251812] Starting dynamic subtest: pipe-D-eDP-1
[198.276738] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.281502] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[200.489326] [040/134] (821s left) gem_mmap (short-mmap)
[200.557403] Subtest short-mmap: SKIP (0.000s)
[200.620930] [041/134] (820s left) vgem_basic (dmabuf-export)
[200.666651] Starting subtest: dmabuf-export
[200.725520] Subtest dmabuf-export: SUCCESS (0.061s)
[200.869898] [042/134] (820s left) gem_render_copy (y-tiled)
[200.934605] Starting subtest: y-tiled
[200.939275] Subtest y-tiled: SKIP (0.000s)
[201.129653] [043/134] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[201.234276] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[208.955085] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.725s)
[209.091704] [044/134] (812s left) gem_exec_schedule (implicit-write-read)
[209.172083] Starting subtest: implicit-write-read
[209.174067] Starting dynamic subtest: rcs0
[209.266056] Dynamic subtest rcs0: SUCCESS (0.104s)
[209.278841] Starting dynamic subtest: vcs0
[209.344523] Dynamic subtest vcs0: SUCCESS (0.079s)
[209.356294] Starting dynamic subtest: vcs1
[209.419728] Dynamic subtest vcs1: SUCCESS (0.075s)
[209.431299] Starting dynamic subtest: vecs0
[209.494455] Dynamic subtest vecs0: SUCCESS (0.074s)
[209.506113] Starting dynamic subtest: ccs0
[209.582935] Dynamic subtest ccs0: SUCCESS (0.088s)
[209.585629] Subtest implicit-write-read: SUCCESS (0.423s)
[211.024996] [045/134] (810s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[211.130706] Starting subtest: 4-tiled-64bpp-rotate-90
[211.153114] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[211.294142] [046/134] (810s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[211.398509] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[211.400768] Starting dynamic subtest: A-eDP1
[220.338538] Dynamic subtest A-eDP1: SUCCESS (8.939s)
[220.351256] Starting dynamic subtest: B-eDP1
[229.274502] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[229.284517] Starting dynamic subtest: C-eDP1
[238.192683] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[238.200853] Starting dynamic subtest: D-eDP1
[247.019379] Dynamic subtest D-eDP1: SUCCESS (8.825s)
[247.021368] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.623s)
[248.268202] [047/134] (773s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[248.371199] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[248.375186] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.492114] [048/134] (773s left) kms_color_pipeline (plane-lut1d)
[248.594017] Starting subtest: plane-lut1d
[248.606795] Starting dynamic subtest: pipe-A-eDP-1
[249.308974] Dynamic subtest pipe-A-eDP-1: FAIL (0.341s)
[250.026071] Starting dynamic subtest: pipe-B-eDP-1
[250.862469] Dynamic subtest pipe-B-eDP-1: FAIL (0.335s)
[251.463374] Starting dynamic subtest: pipe-C-eDP-1
[252.287505] Dynamic subtest pipe-C-eDP-1: FAIL (0.234s)
[252.796461] Starting dynamic subtest: pipe-D-eDP-1
[253.615773] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[253.618192] Subtest plane-lut1d: FAIL (4.720s)
[254.192260] [049/134] (767s left) i915_pm_rc6_residency (rc6-accuracy)
[254.244570] Starting subtest: rc6-accuracy
[254.246457] Starting dynamic subtest: gt0
[257.415898] Dynamic subtest gt0: SUCCESS (3.169s)
[257.424918] Starting dynamic subtest: gt1
[260.586965] Dynamic subtest gt1: SUCCESS (3.168s)
[260.589587] Subtest rc6-accuracy: SUCCESS (6.343s)
[260.676589] [050/134] (761s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[260.796439] Starting subtest: basic-flip-before-cursor-atomic
[261.715543] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.918s)
[262.522026] [051/134] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[262.629567] Starting subtest: psr-2p-primscrn-spr-indfb-move
[262.634302] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[262.757671] [052/134] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[262.863192] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[262.867133] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[263.001696] [053/134] (759s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[268.006085] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[268.010710] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[268.852938] [054/134] (753s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[268.904469] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[269.011105] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[269.100991] [055/134] (753s left) gem_mmap_wc (bad-size)
[269.161756] Subtest bad-size: SKIP (0.000s)
[269.231848] [056/134] (752s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[269.342469] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[269.347228] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[269.476420] [057/134] (752s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[269.575736] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[269.580229] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[269.712370] [058/134] (752s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[269.832570] Starting subtest: cursorA-vs-flipB-atomic
[269.836942] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[269.990755] [059/134] (752s left) sysfs_heartbeat_interval (nopreempt)
[270.054321] Starting subtest: nopreempt
[270.056341] Starting dynamic subtest: vecs0
[279.922026] Dynamic subtest vecs0: SUCCESS (9.863s)
[279.936101] Starting dynamic subtest: ccs0
[284.018855] Dynamic subtest ccs0: SUCCESS (4.096s)
[284.027270] Starting dynamic subtest: vcs0
[293.939331] Dynamic subtest vcs0: SUCCESS (9.916s)
[293.950471] Starting dynamic subtest: bcs0
[297.981825] Dynamic subtest bcs0: SUCCESS (4.042s)
[297.993083] Starting dynamic subtest: rcs0
[302.103783] Dynamic subtest rcs0: SUCCESS (4.121s)
[302.116773] Starting dynamic subtest: vcs1
[311.911931] Dynamic subtest vcs1: SUCCESS (9.803s)
[311.914546] Subtest nopreempt: SUCCESS (41.854s)
[312.000101] [060/134] (710s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[312.132821] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[312.137318] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[312.241497] [061/134] (710s left) gem_wait (busy)
[312.311464] Starting subtest: busy
[312.313828] Starting dynamic subtest: all-engines
[313.942654] Dynamic subtest all-engines: SUCCESS (1.629s)
[313.955453] Starting dynamic subtest: rcs0
[314.482592] Dynamic subtest rcs0: SUCCESS (0.539s)
[314.493207] Starting dynamic subtest: bcs0
[315.022070] Dynamic subtest bcs0: SUCCESS (0.539s)
[315.032698] Starting dynamic subtest: vcs0
[316.885704] Dynamic subtest vcs0: SUCCESS (1.861s)
[316.897056] Starting dynamic subtest: vcs1
[318.934063] Dynamic subtest vcs1: SUCCESS (2.046s)
[318.945573] Starting dynamic subtest: vecs0
[320.918280] Dynamic subtest vecs0: SUCCESS (1.981s)
[320.929403] Starting dynamic subtest: ccs0
[321.460104] Dynamic subtest ccs0: SUCCESS (0.541s)
[321.462838] Subtest busy: SUCCESS (9.148s)
[321.671300] [062/134] (700s left) kms_setmode (clone-exclusive-crtc)
[321.735773] Starting subtest: clone-exclusive-crtc
[321.742631] Subtest clone-exclusive-crtc: SKIP (0.000s)
[321.859610] [063/134] (700s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[326.961366] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[326.966191] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.004s)
[327.783133] [064/134] (694s left) sw_sync (sync_merge_same)
[327.824813] Starting subtest: sync_merge_same
[327.826705] Subtest sync_merge_same: SUCCESS (0.000s)
[327.903559] [065/134] (694s left) kms_hdr (static-toggle)
[327.990178] Starting subtest: static-toggle
[327.996376] Subtest static-toggle: SKIP (0.000s)
[328.076156] [066/134] (694s left) gem_exec_await (wide-contexts)
[328.280183] Starting subtest: wide-contexts
[351.606892] Subtest wide-contexts: SUCCESS (23.324s)
[351.809352] [067/134] (670s left) kms_invalid_mode (uint-max-clock)
[351.965309] Starting subtest: uint-max-clock
[351.967552] Starting dynamic subtest: pipe-A-eDP-1
[352.248578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[352.256776] Starting dynamic subtest: pipe-B-eDP-1
[352.258680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[352.266232] Starting dynamic subtest: pipe-C-eDP-1
[352.272642] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[352.280914] Starting dynamic subtest: pipe-D-eDP-1
[352.283283] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[352.285700] Subtest uint-max-clock: SUCCESS (0.291s)
[353.127393] [068/134] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[353.237107] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[356.866604] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.634s)
[358.004786] [069/134] (664s left) kms_pm_rpm (modeset-non-lpsp)
[360.061617] Starting subtest: modeset-non-lpsp
[361.228000] Subtest modeset-non-lpsp: SKIP (1.167s)
[361.626542] [070/134] (661s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[361.733052] Starting subtest: fbc-pr-cursor-mmap-cpu
[361.737195] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[361.818564] [071/134] (661s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[361.922169] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[365.883728] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.965s)
[367.101395] [072/134] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[367.202486] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[367.206540] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[367.335486] [073/134] (655s left) i915_pm_rps (thresholds-idle)
[367.398769] Starting subtest: thresholds-idle
[367.403254] Subtest thresholds-idle: SKIP (0.001s)
[367.524484] [074/134] (655s left) kms_vblank (query-idle-hang)
[367.612791] Starting subtest: query-idle-hang
[367.614587] Starting dynamic subtest: pipe-A-eDP-1
[393.679627] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.064s)
[393.692600] Starting dynamic subtest: pipe-D-eDP-1
[408.662198] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.982s)
[408.664632] Subtest query-idle-hang: SUCCESS (41.051s)
[409.576477] [075/134] (613s left) perf_pmu (most-busy-idle-check-all)
[409.627159] Starting subtest: most-busy-idle-check-all
[409.629316] Starting dynamic subtest: rcs0
[410.903150] Dynamic subtest rcs0: SUCCESS (1.275s)
[410.914345] Starting dynamic subtest: bcs0
[412.887674] Dynamic subtest bcs0: SUCCESS (1.981s)
[412.899903] Starting dynamic subtest: vcs0
[414.935027] Dynamic subtest vcs0: SUCCESS (2.044s)
[414.946937] Starting dynamic subtest: vcs1
[416.919170] Dynamic subtest vcs1: SUCCESS (1.981s)
[416.931363] Starting dynamic subtest: vecs0
[418.903427] Dynamic subtest vecs0: SUCCESS (1.981s)
[418.915249] Starting dynamic subtest: ccs0
[420.886787] Dynamic subtest ccs0: SUCCESS (1.980s)
[420.889249] Subtest most-busy-idle-check-all: SUCCESS (11.261s)
[421.002192] [076/134] (602s left) kms_atomic_interruptible (universal-setplane-cursor)
[421.122988] Starting subtest: universal-setplane-cursor
[421.125224] Starting dynamic subtest: pipe-A-eDP-1
[428.559811] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.437s)
[428.561959] Subtest universal-setplane-cursor: SUCCESS (7.439s)
[429.416585] [077/134] (593s left) gem_userptr_blits (process-exit-busy)
[429.497697] Starting subtest: process-exit-busy
[429.509864] Subtest process-exit-busy: SUCCESS (0.012s)
[429.660491] [078/134] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[429.752604] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[429.756935] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[429.882515] [079/134] (593s left) gem_lmem_swapping (heavy-verify-multi)
[429.930823] Subtest heavy-verify-multi: SKIP (0.000s)
[429.976641] [080/134] (593s left) gen9_exec_parse (bb-start-cmd)
[430.041337] Subtest bb-start-cmd: SKIP (0.000s)
[430.116523] [081/134] (593s left) fbdev (unaligned-read)
[430.160206] Starting subtest: unaligned-read
[430.174613] Subtest unaligned-read: SUCCESS (0.014s)
[430.241374] [082/134] (593s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[430.612918] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[431.412448] [083/134] (591s left) gem_ppgtt (blt-vs-render-ctx0)
[431.480159] Starting subtest: blt-vs-render-ctx0
[464.300222] Subtest blt-vs-render-ctx0: SUCCESS (32.820s)
[464.459591] [084/134] (558s left) core_setmaster_vs_auth
[464.680997] [085/134] (558s left) prime_busy (hang)
[464.738128] Starting subtest: hang
[464.740501] Starting dynamic subtest: rcs0
[490.415684] Dynamic subtest rcs0: SUCCESS (25.673s)
[490.425957] Starting dynamic subtest: bcs0
[497.573284] Dynamic subtest bcs0: SUCCESS (7.155s)
[497.583510] Starting dynamic subtest: vcs0
[504.548786] Dynamic subtest vcs0: SUCCESS (6.974s)
[504.559612] Starting dynamic subtest: vcs1
[511.585131] Dynamic subtest vcs1: SUCCESS (7.036s)
[511.596074] Starting dynamic subtest: vecs0
[518.562292] Dynamic subtest vecs0: SUCCESS (6.974s)
[518.572718] Starting dynamic subtest: ccs0
[532.396650] Dynamic subtest ccs0: SUCCESS (13.838s)
[532.399655] Subtest hang: SUCCESS (67.658s)
[532.564359] [086/134] (490s left) gem_eio (unwedge-stress)
[532.760726] Starting subtest: unwedge-stress
[532.763149] Starting dynamic subtest: render
[537.160221] Dynamic subtest render: SUCCESS (4.397s)
[537.174937] Starting dynamic subtest: bsd1
[555.295059] Dynamic subtest bsd1: SUCCESS (18.132s)
[555.309534] Starting dynamic subtest: bsd2
[573.286939] Dynamic subtest bsd2: SUCCESS (17.991s)
[573.302894] Starting dynamic subtest: blt
[573.307127] Dynamic subtest blt: SKIP (0.000s)
[573.315109] Starting dynamic subtest: vebox
[591.325076] Dynamic subtest vebox: SUCCESS (18.035s)
[591.327368] Subtest unwedge-stress: SUCCESS (58.560s)
[592.965092] [087/134] (430s left) kms_cursor_crc (cursor-random-256x256)
[593.214653] Starting subtest: cursor-random-256x256
[593.219990] Starting dynamic subtest: pipe-A-eDP-1
[596.604226] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.386s)
[596.632714] Starting dynamic subtest: pipe-D-eDP-1
[600.630076] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.000s)
[600.632299] Subtest cursor-random-256x256: SUCCESS (7.411s)
[601.497911] [088/134] (422s left) syncobj_timeline (multi-wait-submitted-signaled)
[601.574341] Starting subtest: multi-wait-submitted-signaled
[601.576711] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[601.700216] [089/134] (421s left) kms_dsc (dsc-with-formats)
[601.797281] Starting subtest: dsc-with-formats
[601.836317] Subtest dsc-with-formats: SKIP (0.001s)
[601.884059] [090/134] (421s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[601.981388] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[608.589817] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.610s)
[608.761043] [091/134] (414s left) api_intel_allocator (reopen-fork)
[608.831701] Starting subtest: reopen-fork
[612.479891] Subtest reopen-fork: SUCCESS (3.648s)
[612.578289] [092/134] (411s left) gem_exec_whisper (basic-fds-priority-all)
[612.646979] Starting subtest: basic-fds-priority-all
[636.145747] Subtest basic-fds-priority-all: SUCCESS (23.493s)
[636.344201] [093/134] (387s left) gem_exec_fence (basic-wait-all)
[636.413719] Starting subtest: basic-wait-all
[636.527306] Subtest basic-wait-all: SUCCESS (0.114s)
[638.031777] [094/134] (385s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[638.120898] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[638.123130] Starting dynamic subtest: pipe-A-eDP-1
[638.181667] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[638.192113] Starting dynamic subtest: pipe-B-eDP-1
[638.251323] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[638.261674] Starting dynamic subtest: pipe-C-eDP-1
[638.318503] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[638.328117] Starting dynamic subtest: pipe-D-eDP-1
[638.384517] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[638.388604] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[640.304745] [095/134] (383s left) kms_psr (fbc-psr2-no-drrs)
[640.406268] Starting subtest: fbc-psr2-no-drrs
[640.408518] Starting dynamic subtest: eDP-1
[640.413063] Dynamic subtest eDP-1: SKIP (0.000s)
[640.417415] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[640.506283] [096/134] (383s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[640.601426] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[640.605751] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[640.712463] [097/134] (383s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[640.806275] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[640.810237] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[640.924662] [098/134] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[641.008440] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[644.586658] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.581s)
[645.787914] [099/134] (378s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[645.888144] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[645.890383] Starting dynamic subtest: pipe-A
[645.910678] Dynamic subtest pipe-A: SKIP (0.017s)
[645.919598] Starting dynamic subtest: pipe-B
[645.940244] Dynamic subtest pipe-B: SKIP (0.031s)
[645.949237] Starting dynamic subtest: pipe-C
[645.971195] Dynamic subtest pipe-C: SKIP (0.031s)
[645.980211] Starting dynamic subtest: pipe-D
[646.003293] Dynamic subtest pipe-D: SKIP (0.031s)
[646.006991] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.112s)
[646.111727] [100/134] (377s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[646.212162] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[646.216212] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[646.294444] [101/134] (377s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[646.411484] Starting subtest: flip-vs-cursor-busy-crc-atomic
[647.253900] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.842s)
[648.116307] [102/134] (375s left) core_getstats (basic)
[648.178038] Starting subtest: basic
[648.180357] Subtest basic: SUCCESS (0.000s)
[648.322835] [103/134] (375s left) gem_mmap_gtt (hang-busy)
[648.385789] Subtest hang-busy: SKIP (0.000s)
[648.451329] [104/134] (375s left) kms_flip (flip-vs-expired-vblank-interruptible)
[648.545232] Starting subtest: flip-vs-expired-vblank-interruptible
[648.550585] Starting dynamic subtest: A-eDP1
[657.215376] Dynamic subtest A-eDP1: SUCCESS (8.668s)
[657.226216] Starting dynamic subtest: B-eDP1
[665.844558] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[665.854344] Starting dynamic subtest: C-eDP1
[674.468851] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[674.480423] Starting dynamic subtest: D-eDP1
[683.086370] Dynamic subtest D-eDP1: SUCCESS (8.614s)
[683.088761] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.542s)
[684.272644] [105/134] (339s left) gem_exec_schedule (preempt-queue-contexts)
[684.341600] Subtest preempt-queue-contexts: SKIP (0.000s)
[684.643073] [106/134] (339s left) perf (oa-formats)
[684.740820] Starting subtest: oa-formats
[684.743298] Starting dynamic subtest: 0-rcs0
[684.757820] Dynamic subtest 0-rcs0: SUCCESS (0.017s)
[684.768590] Starting dynamic subtest: 1-vecs0
[684.779966] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[684.782256] Subtest oa-formats: SUCCESS (0.039s)
[684.824302] [107/134] (339s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[684.917570] Starting subtest: fbcpsr-modesetfrombusy
[691.075074] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.161s)
[691.251226] [108/134] (333s left) kms_flip (2x-dpms-vs-vblank-race)
[691.356403] Starting subtest: 2x-dpms-vs-vblank-race
[691.366982] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[691.455838] [109/134] (332s left) gem_exec_params (readonly)
[691.503589] Starting subtest: readonly
[691.508353] Subtest readonly: SUCCESS (0.003s)
[691.638042] [110/134] (332s left) kms_vblank (invalid)
[691.726776] Starting subtest: invalid
[691.728652] Starting dynamic subtest: pipe-A-eDP-1
[692.124419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[692.126667] Subtest invalid: SUCCESS (0.397s)
[692.969579] [111/134] (331s left) gem_exec_reloc (basic-cpu-read-noreloc)
[693.034077] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[693.103198] [112/134] (331s left) gem_ctx_persistence (engines-hostile)
[693.164095] Starting subtest: engines-hostile
[693.166535] Starting dynamic subtest: rcs0
[693.253438] Dynamic subtest rcs0: SUCCESS (0.089s)
[693.263833] Starting dynamic subtest: bcs0
[693.432996] Dynamic subtest bcs0: SUCCESS (0.176s)
[693.443948] Starting dynamic subtest: vcs0
[693.683028] Dynamic subtest vcs0: SUCCESS (0.248s)
[693.695978] Starting dynamic subtest: vcs1
[693.930566] Dynamic subtest vcs1: SUCCESS (0.245s)
[693.943433] Starting dynamic subtest: vecs0
[694.144562] Dynamic subtest vecs0: SUCCESS (0.212s)
[694.157819] Starting dynamic subtest: ccs0
[694.311576] Dynamic subtest ccs0: SUCCESS (0.164s)
[694.314642] Subtest engines-hostile: SUCCESS (1.147s)
[694.412808] [113/134] (330s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[694.537248] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[694.541529] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[694.673519] [114/134] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[694.781353] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[694.785953] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[694.907583] [115/134] (329s left) gem_caching (writes)
[694.980154] Subtest writes: SKIP (0.000s)
[695.075209] [116/134] (329s left) kms_pm_backlight (fade-with-suspend)
[695.176325] Starting subtest: fade-with-suspend
[711.912763] Starting dynamic subtest: eDP-1
[714.597628] Dynamic subtest eDP-1: SUCCESS (2.682s)
[714.599960] Subtest fade-with-suspend: SUCCESS (4.249s)
[715.434723] [117/134] (309s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[715.536161] Starting subtest: coverage-vs-premult-vs-constant
[715.815604] Starting dynamic subtest: pipe-A-eDP-1
[716.381450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[716.392086] Starting dynamic subtest: pipe-D-eDP-1
[717.738925] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[717.741242] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.201s)
[718.609776] [118/134] (306s left) kms_lease (master-vs-lease)
[718.711896] Starting subtest: master-vs-lease
[718.714021] Subtest master-vs-lease: SUCCESS (0.001s)
[718.859483] [119/134] (305s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[718.956323] Starting subtest: psr-rgb565-draw-mmap-wc
[725.741101] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.781s)
[725.877503] [120/134] (298s left) kms_addfb_basic (addfb25-4-tiled)
[725.963621] Starting subtest: addfb25-4-tiled
[725.965540] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[726.082059] [121/134] (298s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[726.172352] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[726.176782] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[726.255749] [122/134] (298s left) kms_plane_multiple (2x-tiling-x)
[726.353992] Starting subtest: 2x-tiling-x
[726.358568] Subtest 2x-tiling-x: SKIP (0.000s)
[726.436596] [123/134] (298s left) kms_psr (psr2-primary-render)
[726.536669] Starting subtest: psr2-primary-render
[726.538932] Starting dynamic subtest: eDP-1
[728.305841] Dynamic subtest eDP-1: SUCCESS (1.766s)
[728.308072] Subtest psr2-primary-render: SUCCESS (1.768s)
[729.182943] [124/134] (295s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[729.248480] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[729.349369] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[729.441249] [125/134] (295s left) gem_exec_balancer (full)
[729.520939] Starting subtest: full
[733.885552] Subtest full: SUCCESS (4.363s)
[734.276062] [126/134] (290s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[734.379409] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[734.383586] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[734.508263] [127/134] (290s left) gem_mmap_wc (write-read)
[734.564577] Subtest write-read: SKIP (0.000s)
[734.642834] [128/134] (290s left) gem_ctx_persistence (process)
[734.716207] Starting subtest: process
[734.963737] Subtest process: SUCCESS (0.247s)
[735.052850] [129/134] (290s left) gem_ctx_param (non-root-set)
[735.104311] Starting subtest: non-root-set
[735.129822] Subtest non-root-set: SUCCESS (0.026s)
[735.236935] [130/134] (290s left) sw_sync (timeline_closed)
[735.273314] Starting subtest: timeline_closed
[735.275826] Subtest timeline_closed: SUCCESS (0.000s)
[735.341460] [131/134] (289s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[735.448100] Starting subtest: primary-4-tiled-reflect-x-180
[742.670842] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.223s)
[743.855048] [132/134] (281s left) gem_exec_parallel (basic)
[743.921691] Starting subtest: basic
[743.923981] Starting dynamic subtest: rcs0
[745.383913] Dynamic subtest rcs0: SUCCESS (1.461s)
[745.394464] Starting dynamic subtest: bcs0
[746.877450] Dynamic subtest bcs0: SUCCESS (1.491s)
[746.889350] Starting dynamic subtest: vcs0
[750.040664] Dynamic subtest vcs0: SUCCESS (3.159s)
[750.053983] Starting dynamic subtest: vcs1
[752.026111] Dynamic subtest vcs1: SUCCESS (1.982s)
[752.038171] Starting dynamic subtest: vecs0
[754.074424] Dynamic subtest vecs0: SUCCESS (2.045s)
[754.087567] Starting dynamic subtest: ccs0
[755.606637] Dynamic subtest ccs0: SUCCESS (1.530s)
[755.609821] Subtest basic: SUCCESS (11.683s)
[755.793341] [133/134] (269s left) kms_content_protection (uevent-hdcp14)
[755.941227] Starting subtest: uevent-hdcp14
[755.945837] Subtest uevent-hdcp14: SKIP (0.000s)
[756.103757] [134/134] (269s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[756.165284] Starting subtest: multi-wait-all-for-submit-available-signaled
[756.167481] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[756.287935] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_ctx_engines
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_async_flips
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: i915_pm_freq_api
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_mmap
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: i915_pm_rc6_residency
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: sysfs_heartbeat_interval
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_wait
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: sw_sync
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: gem_exec_await
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_pm_rps
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_atomic_interruptible
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: core_setmaster_vs_auth
results: parsing output: 84/ for test: prime_busy
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_dsc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: api_intel_allocator
results: parsing output: 91/ for test: gem_exec_whisper
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: core_getstats
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_caching
results: parsing output: 115/ for test: kms_pm_backlight
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: gem_exec_parallel
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: syncobj_timeline
Done.