[58.312857] Initializing watchdogs
[58.312904]   /dev/watchdog0
[58.327387] [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]
[58.331974] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.334194] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.337720] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[58.612613] Starting subtest: cursor-offscreen-256x85
[58.666145] Subtest cursor-offscreen-256x85: SKIP (0.050s)
[58.859589] [002/134] (960s left) gem_mmap_gtt (cpuset-big-copy-odd)
[58.922815] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[58.990405] [003/134] (959s left) gem_ctx_engines (execute-allforone)
[59.060828] Starting subtest: execute-allforone
[59.073828] Subtest execute-allforone: SUCCESS (0.013s)
[60.965678] [004/134] (957s left) perf_pmu (busy-idle)
[61.007382] Starting subtest: busy-idle
[61.009731] Starting dynamic subtest: rcs0
[61.732147] Dynamic subtest rcs0: SUCCESS (0.725s)
[61.742459] Starting dynamic subtest: bcs0
[62.394377] Dynamic subtest bcs0: SUCCESS (0.662s)
[62.403908] Starting dynamic subtest: vcs0
[63.893825] Dynamic subtest vcs0: SUCCESS (1.497s)
[63.904422] Starting dynamic subtest: vcs1
[65.940935] Dynamic subtest vcs1: SUCCESS (2.046s)
[65.953522] Starting dynamic subtest: vecs0
[67.923984] Dynamic subtest vecs0: SUCCESS (1.981s)
[67.934203] Starting dynamic subtest: ccs0
[68.606477] Dynamic subtest ccs0: SUCCESS (0.683s)
[68.608951] Subtest busy-idle: SUCCESS (7.601s)
[68.734323] [005/134] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[68.844132] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[69.499997] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.658s)
[69.703092] [006/134] (949s left) api_intel_bb (lot-of-buffers)
[69.767972] Starting subtest: lot-of-buffers
[70.782896] Subtest lot-of-buffers: SUCCESS (1.015s)
[71.044840] [007/134] (948s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[71.110449] Starting subtest: yf-tiled-to-vebox-x-tiled
[71.115257] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[71.313738] [008/134] (947s left) kms_plane (plane-panning-top-left)
[71.415025] Starting subtest: plane-panning-top-left
[71.417663] Starting dynamic subtest: pipe-A
[73.110450] Dynamic subtest pipe-A: SUCCESS (1.695s)
[73.119891] Starting dynamic subtest: pipe-B
[75.524523] Dynamic subtest pipe-B: SUCCESS (2.415s)
[75.526906] Subtest plane-panning-top-left: SUCCESS (4.112s)
[76.344353] [009/134] (942s left) kms_psr (fbc-psr-cursor-plane-onoff)
[76.452131] Starting subtest: fbc-psr-cursor-plane-onoff
[76.454053] Starting dynamic subtest: eDP-1
[76.458073] Dynamic subtest eDP-1: SKIP (0.000s)
[76.462065] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[76.529953] [010/134] (942s left) kms_cursor_crc (cursor-tearing-position-change)
[76.644094] Starting subtest: cursor-tearing-position-change
[76.646279] Starting dynamic subtest: pipe-A-eDP-1
[77.209215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[77.218058] Starting dynamic subtest: pipe-D-eDP-1
[78.454190] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[78.456187] Subtest cursor-tearing-position-change: SUCCESS (1.808s)
[79.305194] [011/134] (939s left) kms_frontbuffer_tracking (basic)
[79.410803] Starting subtest: basic
[82.753998] Subtest basic: SUCCESS (3.347s)
[82.891413] [012/134] (936s left) gem_spin_batch (spin-each)
[82.962865] Starting subtest: spin-each
[86.226966] Subtest spin-each: SUCCESS (3.256s)
[86.968040] [013/134] (932s left) gem_exec_reloc (basic-gtt-cpu)
[87.044685] Subtest basic-gtt-cpu: SKIP (0.000s)
[87.130854] [014/134] (932s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[87.238250] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[87.266677] Starting dynamic subtest: pipe-A-plane-0
[87.567545] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[87.576791] Starting dynamic subtest: pipe-A-plane-3
[87.799520] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[87.808482] Starting dynamic subtest: pipe-A-plane-5
[87.812619] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[88.888642] Starting dynamic subtest: pipe-B-plane-0
[89.181786] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[89.191071] Starting dynamic subtest: pipe-B-plane-3
[89.415221] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[89.422875] Starting dynamic subtest: pipe-B-plane-5
[89.427233] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[89.730136] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.490s)
[90.575810] [015/134] (928s left) gem_render_copy (y-tiled-ccs-to-linear)
[90.645274] Starting subtest: y-tiled-ccs-to-linear
[90.649959] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[90.841237] [016/134] (928s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[90.949724] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[90.954202] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[91.081218] [017/134] (928s left) kms_psr (pr-sprite-render)
[91.173507] Starting subtest: pr-sprite-render
[91.177496] Subtest pr-sprite-render: SKIP (0.000s)
[91.253650] [018/134] (928s left) gen9_exec_parse (shadow-peek)
[91.324354] Subtest shadow-peek: SKIP (0.000s)
[91.404027] [019/134] (928s left) perf (invalid-remove-userspace-config)
[91.530583] Starting subtest: invalid-remove-userspace-config
[91.540257] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[91.580163] [020/134] (927s left) gem_ctx_param (invalid-size-set)
[91.638337] Starting subtest: invalid-size-set
[91.640771] Subtest invalid-size-set: SUCCESS (0.001s)
[91.763254] [021/134] (927s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[91.857956] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[91.860057] Starting dynamic subtest: pipe-A-eDP-1
[91.878123] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.887451] Starting dynamic subtest: pipe-B-eDP-1
[91.904989] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.912446] Starting dynamic subtest: pipe-C-eDP-1
[91.929276] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.936189] Starting dynamic subtest: pipe-D-eDP-1
[91.953745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.957049] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[94.153656] [022/134] (925s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[94.224325] Starting subtest: invalid-bsd2-flag-on-blt
[94.226627] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[94.344778] [023/134] (925s left) gem_render_copy (yf-tiled-ccs-to-linear)
[94.409047] Starting subtest: yf-tiled-ccs-to-linear
[94.413670] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[94.623235] [024/134] (925s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[94.676488] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[94.784842] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[94.870715] [025/134] (924s left) gem_exec_fence (invalid-timeline-fence-array)
[95.448580] Starting subtest: invalid-timeline-fence-array
[95.454671] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[97.008031] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[97.011125] [026/134] (922s left) kms_chamelium_edid (dp-edid-read)
[97.413644] Subtest dp-edid-read: SKIP (0.000s)
[98.238472] [027/134] (921s left) gem_exec_params (invalid-bsd1-flag-on-render)
[98.313040] Starting subtest: invalid-bsd1-flag-on-render
[98.315543] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[98.443492] [028/134] (921s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[98.553721] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[99.564934] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[99.743398] [029/134] (920s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[99.837095] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[99.839049] Starting dynamic subtest: pipe-A-eDP-1
[99.857129] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.866714] Starting dynamic subtest: pipe-B-eDP-1
[99.884457] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.891280] Starting dynamic subtest: pipe-C-eDP-1
[99.908106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.914811] Starting dynamic subtest: pipe-D-eDP-1
[99.932415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.935878] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[102.126383] [030/134] (917s left) gem_eio (kms)
[102.401747] Starting subtest: kms
[123.134357] Subtest kms: SUCCESS (20.731s)
[124.322843] [031/134] (895s left) kms_cursor_legacy (torture-move)
[124.449656] Starting subtest: torture-move
[124.452088] Starting dynamic subtest: pipe-A
[130.395062] Dynamic subtest pipe-A: SUCCESS (5.940s)
[130.405962] Starting dynamic subtest: pipe-B
[138.033450] Dynamic subtest pipe-B: SUCCESS (7.638s)
[138.044876] Starting dynamic subtest: pipe-C
[144.180993] Dynamic subtest pipe-C: SUCCESS (6.146s)
[144.195470] Starting dynamic subtest: pipe-D
[151.184667] Dynamic subtest pipe-D: SUCCESS (7.005s)
[151.193300] Starting dynamic subtest: all-pipes
[157.699972] Dynamic subtest all-pipes: SUCCESS (6.512s)
[157.702466] Subtest torture-move: SUCCESS (33.248s)
[157.882511] [032/134] (862s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[157.975666] Starting subtest: bad-pixel-format-yf-tiled-ccs
[157.977970] Starting dynamic subtest: pipe-A-eDP-1
[158.000589] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.011265] Starting dynamic subtest: pipe-B-eDP-1
[158.032987] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.041347] Starting dynamic subtest: pipe-C-eDP-1
[158.062630] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.070661] Starting dynamic subtest: pipe-D-eDP-1
[158.092977] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.097055] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[160.283581] [033/134] (859s left) gem_exec_capture (pi)
[160.335213] Starting subtest: pi
[160.337568] Starting dynamic subtest: rcs0
[164.676506] Dynamic subtest rcs0: SUCCESS (4.341s)
[164.686759] Starting dynamic subtest: bcs0
[168.841540] Dynamic subtest bcs0: SUCCESS (4.163s)
[168.852589] Starting dynamic subtest: vcs0
[173.068686] Dynamic subtest vcs0: SUCCESS (4.227s)
[173.080041] Starting dynamic subtest: vcs1
[177.354939] Dynamic subtest vcs1: SUCCESS (4.285s)
[177.366220] Starting dynamic subtest: vecs0
[181.605850] Dynamic subtest vecs0: SUCCESS (4.250s)
[181.618032] Starting dynamic subtest: ccs0
[185.911065] Dynamic subtest ccs0: SUCCESS (4.305s)
[185.913570] Subtest pi: SUCCESS (25.576s)
[186.001926] [034/134] (834s left) syncobj_timeline (wait-all-snapshot)
[186.113422] Starting subtest: wait-all-snapshot
[186.195489] Subtest wait-all-snapshot: SUCCESS (0.081s)
[186.297744] [035/134] (833s left) kms_async_flips (test-cursor-atomic)
[186.405711] Starting subtest: test-cursor-atomic
[186.409746] Subtest test-cursor-atomic: SKIP (0.000s)
[187.595946] [036/134] (832s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[187.705766] Starting subtest: x-tiled-32bpp-rotate-180
[189.228542] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.523s)
[189.386988] [037/134] (830s left) i915_pm_freq_api (freq-reset)
[189.460917] Starting subtest: freq-reset
[189.463069] Starting dynamic subtest: gt0
[189.659771] Dynamic subtest gt0: SUCCESS (0.196s)
[189.668017] Starting dynamic subtest: gt1
[189.820397] Dynamic subtest gt1: SUCCESS (0.160s)
[189.823140] Subtest freq-reset: SUCCESS (0.358s)
[189.905748] [038/134] (830s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[190.003314] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[194.291557] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.292s)
[195.510688] [039/134] (824s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[195.615693] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[195.617964] Starting dynamic subtest: pipe-A-eDP-1
[195.642150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[195.651626] Starting dynamic subtest: pipe-B-eDP-1
[195.674462] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[195.682742] Starting dynamic subtest: pipe-C-eDP-1
[195.706611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[195.714763] Starting dynamic subtest: pipe-D-eDP-1
[195.738366] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[195.742715] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[197.863007] [040/134] (822s left) gem_mmap (short-mmap)
[197.926340] Subtest short-mmap: SKIP (0.000s)
[197.997899] [041/134] (822s left) vgem_basic (dmabuf-export)
[198.037999] Starting subtest: dmabuf-export
[198.100382] Subtest dmabuf-export: SUCCESS (0.064s)
[198.247281] [042/134] (822s left) gem_render_copy (y-tiled)
[198.308233] Starting subtest: y-tiled
[198.312824] Subtest y-tiled: SKIP (0.000s)
[198.502788] [043/134] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[198.593224] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[206.337911] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.747s)
[206.499371] [044/134] (814s left) gem_exec_schedule (implicit-write-read)
[206.571352] Starting subtest: implicit-write-read
[206.573192] Starting dynamic subtest: rcs0
[206.666846] Dynamic subtest rcs0: SUCCESS (0.103s)
[206.679022] Starting dynamic subtest: vcs0
[206.748933] Dynamic subtest vcs0: SUCCESS (0.082s)
[206.760559] Starting dynamic subtest: vcs1
[206.822645] Dynamic subtest vcs1: SUCCESS (0.073s)
[206.833955] Starting dynamic subtest: vecs0
[206.908144] Dynamic subtest vecs0: SUCCESS (0.085s)
[206.920552] Starting dynamic subtest: ccs0
[207.019188] Dynamic subtest ccs0: SUCCESS (0.110s)
[207.021874] Subtest implicit-write-read: SUCCESS (0.457s)
[208.003574] [045/134] (812s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[208.112797] Starting subtest: 4-tiled-64bpp-rotate-90
[208.133559] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[208.263609] [046/134] (812s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[208.352398] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[208.354647] Starting dynamic subtest: A-eDP1
[217.308970] Dynamic subtest A-eDP1: SUCCESS (8.955s)
[217.318072] Starting dynamic subtest: B-eDP1
[226.238091] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[226.247989] Starting dynamic subtest: C-eDP1
[235.165049] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[235.175807] Starting dynamic subtest: D-eDP1
[244.141614] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[244.143764] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.747s)
[245.336409] [047/134] (775s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[245.440087] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[245.444395] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[245.531739] [048/134] (775s left) kms_color_pipeline (plane-lut1d)
[245.630991] Starting subtest: plane-lut1d
[245.648014] Starting dynamic subtest: pipe-A-eDP-1
[246.394323] Dynamic subtest pipe-A-eDP-1: FAIL (0.355s)
[247.100721] Starting dynamic subtest: pipe-B-eDP-1
[247.895867] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[248.436118] Starting dynamic subtest: pipe-C-eDP-1
[249.253358] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[249.759071] Starting dynamic subtest: pipe-D-eDP-1
[250.589089] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[250.591201] Subtest plane-lut1d: FAIL (4.658s)
[251.164901] [049/134] (769s left) i915_pm_rc6_residency (rc6-accuracy)
[251.225962] Starting subtest: rc6-accuracy
[251.228312] Starting dynamic subtest: gt0
[254.398212] Dynamic subtest gt0: SUCCESS (3.169s)
[254.409644] Starting dynamic subtest: gt1
[257.621056] Dynamic subtest gt1: SUCCESS (3.169s)
[257.623308] Subtest rc6-accuracy: SUCCESS (6.343s)
[257.670803] [050/134] (763s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[257.800578] Starting subtest: basic-flip-before-cursor-atomic
[258.716025] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[259.572382] [051/134] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[259.691331] Starting subtest: psr-2p-primscrn-spr-indfb-move
[259.695734] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[259.828051] [052/134] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[259.925056] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[259.929266] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[260.044077] [053/134] (760s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[265.060339] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[265.064968] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[265.903185] [054/134] (755s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[265.962117] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[266.065258] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[266.158046] [055/134] (754s left) gem_mmap_wc (bad-size)
[266.220574] Subtest bad-size: SKIP (0.000s)
[266.288143] [056/134] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[266.392481] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[266.396691] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[266.499536] [057/134] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[266.615410] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[266.619740] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[266.736802] [058/134] (754s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[266.858520] Starting subtest: cursorA-vs-flipB-atomic
[266.863079] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[267.030132] [059/134] (754s left) sysfs_heartbeat_interval (nopreempt)
[267.093301] Starting subtest: nopreempt
[267.095311] Starting dynamic subtest: vecs0
[276.909972] Dynamic subtest vecs0: SUCCESS (9.813s)
[276.921046] Starting dynamic subtest: ccs0
[280.948515] Dynamic subtest ccs0: SUCCESS (4.038s)
[280.959764] Starting dynamic subtest: vcs0
[290.930142] Dynamic subtest vcs0: SUCCESS (9.981s)
[290.941743] Starting dynamic subtest: bcs0
[294.950764] Dynamic subtest bcs0: SUCCESS (4.017s)
[294.965416] Starting dynamic subtest: rcs0
[299.063024] Dynamic subtest rcs0: SUCCESS (4.111s)
[299.074768] Starting dynamic subtest: vcs1
[308.904523] Dynamic subtest vcs1: SUCCESS (9.836s)
[308.907096] Subtest nopreempt: SUCCESS (41.809s)
[308.994540] [060/134] (712s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[309.112329] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[309.116672] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[309.256090] [061/134] (712s left) gem_wait (busy)
[309.323484] Starting subtest: busy
[309.325976] Starting dynamic subtest: all-engines
[310.931914] Dynamic subtest all-engines: SUCCESS (1.607s)
[310.943982] Starting dynamic subtest: rcs0
[311.473026] Dynamic subtest rcs0: SUCCESS (0.540s)
[311.484802] Starting dynamic subtest: bcs0
[312.013242] Dynamic subtest bcs0: SUCCESS (0.540s)
[312.024159] Starting dynamic subtest: vcs0
[313.942144] Dynamic subtest vcs0: SUCCESS (1.926s)
[313.953756] Starting dynamic subtest: vcs1
[315.924292] Dynamic subtest vcs1: SUCCESS (1.980s)
[315.935928] Starting dynamic subtest: vecs0
[317.907935] Dynamic subtest vecs0: SUCCESS (1.981s)
[317.919992] Starting dynamic subtest: ccs0
[318.449224] Dynamic subtest ccs0: SUCCESS (0.540s)
[318.451643] Subtest busy: SUCCESS (9.127s)
[318.671527] [062/134] (702s left) kms_setmode (clone-exclusive-crtc)
[318.732186] Starting subtest: clone-exclusive-crtc
[318.738735] Subtest clone-exclusive-crtc: SKIP (0.000s)
[318.856051] [063/134] (702s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[323.891652] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[323.896037] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[324.743915] [064/134] (696s left) sw_sync (sync_merge_same)
[324.786090] Starting subtest: sync_merge_same
[324.788464] Subtest sync_merge_same: SUCCESS (0.000s)
[324.854995] [065/134] (696s left) kms_hdr (static-toggle)
[324.953871] Starting subtest: static-toggle
[324.960155] Subtest static-toggle: SKIP (0.000s)
[325.040665] [066/134] (696s left) gem_exec_await (wide-contexts)
[325.230670] Starting subtest: wide-contexts
[348.688392] Subtest wide-contexts: SUCCESS (23.441s)
[348.879610] [067/134] (672s left) kms_invalid_mode (uint-max-clock)
[349.036796] Starting subtest: uint-max-clock
[349.039046] Starting dynamic subtest: pipe-A-eDP-1
[349.329399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[349.338678] Starting dynamic subtest: pipe-B-eDP-1
[349.340965] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[349.349159] Starting dynamic subtest: pipe-C-eDP-1
[349.351084] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[349.359713] Starting dynamic subtest: pipe-D-eDP-1
[349.361877] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[349.364073] Subtest uint-max-clock: SUCCESS (0.304s)
[350.184686] [068/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[350.290735] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[353.949783] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.664s)
[355.162401] [069/134] (666s left) kms_pm_rpm (modeset-non-lpsp)
[357.029442] Starting subtest: modeset-non-lpsp
[358.174404] Subtest modeset-non-lpsp: SKIP (1.145s)
[358.573606] [070/134] (663s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[358.670100] Starting subtest: fbc-pr-cursor-mmap-cpu
[358.674194] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[358.759436] [071/134] (662s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[358.858961] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[362.831491] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.975s)
[363.976110] [072/134] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[364.088815] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[364.093150] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[364.228793] [073/134] (657s left) i915_pm_rps (thresholds-idle)
[364.291947] Starting subtest: thresholds-idle
[364.296038] Subtest thresholds-idle: SKIP (0.000s)
[364.421165] [074/134] (657s left) kms_vblank (query-idle-hang)
[364.519993] Starting subtest: query-idle-hang
[364.522335] Starting dynamic subtest: pipe-A-eDP-1
[390.667600] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.148s)
[390.682155] Starting dynamic subtest: pipe-D-eDP-1
[405.722259] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.052s)
[405.724574] Subtest query-idle-hang: SUCCESS (41.205s)
[406.627229] [075/134] (615s left) perf_pmu (most-busy-idle-check-all)
[406.671984] Starting subtest: most-busy-idle-check-all
[406.674347] Starting dynamic subtest: rcs0
[407.892858] Dynamic subtest rcs0: SUCCESS (1.221s)
[407.902888] Starting dynamic subtest: bcs0
[409.876346] Dynamic subtest bcs0: SUCCESS (1.981s)
[409.888789] Starting dynamic subtest: vcs0
[411.924396] Dynamic subtest vcs0: SUCCESS (2.045s)
[411.936750] Starting dynamic subtest: vcs1
[413.908776] Dynamic subtest vcs1: SUCCESS (1.982s)
[413.920837] Starting dynamic subtest: vecs0
[415.893021] Dynamic subtest vecs0: SUCCESS (1.981s)
[415.905669] Starting dynamic subtest: ccs0
[417.941373] Dynamic subtest ccs0: SUCCESS (2.046s)
[417.944362] Subtest most-busy-idle-check-all: SUCCESS (11.271s)
[418.078280] [076/134] (603s left) kms_atomic_interruptible (universal-setplane-cursor)
[418.195791] Starting subtest: universal-setplane-cursor
[418.198094] Starting dynamic subtest: pipe-A-eDP-1
[425.627910] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s)
[425.630374] Subtest universal-setplane-cursor: SUCCESS (7.430s)
[426.498257] [077/134] (595s left) gem_userptr_blits (process-exit-busy)
[426.578302] Starting subtest: process-exit-busy
[426.594019] Subtest process-exit-busy: SUCCESS (0.017s)
[426.758942] [078/134] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[426.859653] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[426.863723] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[427.010049] [079/134] (594s left) gem_lmem_swapping (heavy-verify-multi)
[427.050506] Subtest heavy-verify-multi: SKIP (0.000s)
[427.091656] [080/134] (594s left) gen9_exec_parse (bb-start-cmd)
[427.148617] Subtest bb-start-cmd: SKIP (0.000s)
[427.214895] [081/134] (594s left) fbdev (unaligned-read)
[427.247725] Starting subtest: unaligned-read
[427.265296] Subtest unaligned-read: SUCCESS (0.019s)
[427.351287] [082/134] (594s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[427.739333] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[428.580507] [083/134] (593s left) gem_ppgtt (blt-vs-render-ctx0)
[428.636602] Starting subtest: blt-vs-render-ctx0
[461.377875] Subtest blt-vs-render-ctx0: SUCCESS (32.739s)
[461.548625] [084/134] (560s left) core_setmaster_vs_auth
[461.801277] [085/134] (560s left) prime_busy (hang)
[461.872445] Starting subtest: hang
[461.874820] Starting dynamic subtest: rcs0
[488.438091] Dynamic subtest rcs0: SUCCESS (26.556s)
[488.446851] Starting dynamic subtest: bcs0
[495.595187] Dynamic subtest bcs0: SUCCESS (7.155s)
[495.604284] Starting dynamic subtest: vcs0
[502.558561] Dynamic subtest vcs0: SUCCESS (6.972s)
[502.567812] Starting dynamic subtest: vcs1
[509.536449] Dynamic subtest vcs1: SUCCESS (6.977s)
[509.545262] Starting dynamic subtest: vecs0
[516.577782] Dynamic subtest vecs0: SUCCESS (7.038s)
[516.586703] Starting dynamic subtest: ccs0
[530.411685] Dynamic subtest ccs0: SUCCESS (13.833s)
[530.414088] Subtest hang: SUCCESS (68.538s)
[530.582297] [086/134] (491s left) gem_eio (unwedge-stress)
[530.779563] Starting subtest: unwedge-stress
[530.781602] Starting dynamic subtest: render
[535.267775] Dynamic subtest render: SUCCESS (4.488s)
[535.278847] Starting dynamic subtest: bsd1
[553.312174] Dynamic subtest bsd1: SUCCESS (18.042s)
[553.326267] Starting dynamic subtest: bsd2
[571.398761] Dynamic subtest bsd2: SUCCESS (18.086s)
[571.415316] Starting dynamic subtest: blt
[571.419663] Dynamic subtest blt: SKIP (0.000s)
[571.428484] Starting dynamic subtest: vebox
[589.315176] Dynamic subtest vebox: SUCCESS (17.914s)
[589.317833] Subtest unwedge-stress: SUCCESS (58.536s)
[590.910844] [087/134] (431s left) kms_cursor_crc (cursor-random-256x256)
[591.165424] Starting subtest: cursor-random-256x256
[591.167711] Starting dynamic subtest: pipe-A-eDP-1
[594.542477] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.374s)
[594.572810] Starting dynamic subtest: pipe-D-eDP-1
[598.581841] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.014s)
[598.583787] Subtest cursor-random-256x256: SUCCESS (7.416s)
[599.454518] [088/134] (422s left) syncobj_timeline (multi-wait-submitted-signaled)
[599.517503] Starting subtest: multi-wait-submitted-signaled
[599.519859] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[599.625602] [089/134] (422s left) kms_dsc (dsc-with-formats)
[599.725064] Starting subtest: dsc-with-formats
[599.766647] Subtest dsc-with-formats: SKIP (0.001s)
[599.819810] [090/134] (422s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[599.920986] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[606.539836] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.620s)
[606.699079] [091/134] (415s left) api_intel_allocator (reopen-fork)
[606.760822] Starting subtest: reopen-fork
[610.245512] Subtest reopen-fork: SUCCESS (3.486s)
[610.335711] [092/134] (412s left) gem_exec_whisper (basic-fds-priority-all)
[610.396656] Starting subtest: basic-fds-priority-all
[634.028246] Subtest basic-fds-priority-all: SUCCESS (23.628s)
[634.235477] [093/134] (388s left) gem_exec_fence (basic-wait-all)
[634.296568] Starting subtest: basic-wait-all
[634.408585] Subtest basic-wait-all: SUCCESS (0.112s)
[636.041762] [094/134] (386s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[636.142092] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[636.144176] Starting dynamic subtest: pipe-A-eDP-1
[636.198029] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[636.207307] Starting dynamic subtest: pipe-B-eDP-1
[636.264181] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[636.275038] Starting dynamic subtest: pipe-C-eDP-1
[636.332608] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[636.343517] Starting dynamic subtest: pipe-D-eDP-1
[636.400360] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[636.404825] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[638.353167] [095/134] (384s left) kms_psr (fbc-psr2-no-drrs)
[638.457988] Starting subtest: fbc-psr2-no-drrs
[638.460189] Starting dynamic subtest: eDP-1
[638.464131] Dynamic subtest eDP-1: SKIP (0.000s)
[638.468172] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[638.547461] [096/134] (384s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[638.648370] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[638.652694] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[638.783086] [097/134] (383s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[638.877342] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[638.881663] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[639.012839] [098/134] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[639.129179] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[642.767376] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.641s)
[643.966281] [099/134] (378s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[644.067920] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[644.070349] Starting dynamic subtest: pipe-A
[644.090159] Dynamic subtest pipe-A: SKIP (0.019s)
[644.099699] Starting dynamic subtest: pipe-B
[644.124748] Dynamic subtest pipe-B: SKIP (0.033s)
[644.136272] Starting dynamic subtest: pipe-C
[644.161392] Dynamic subtest pipe-C: SKIP (0.037s)
[644.172112] Starting dynamic subtest: pipe-D
[644.195050] Dynamic subtest pipe-D: SKIP (0.033s)
[644.199087] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.125s)
[644.315998] [100/134] (378s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[644.410879] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[644.414763] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[644.493679] [101/134] (378s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[644.615468] Starting subtest: flip-vs-cursor-busy-crc-atomic
[645.456888] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.840s)
[646.282545] [102/134] (376s left) core_getstats (basic)
[646.338777] Starting subtest: basic
[646.340984] Subtest basic: SUCCESS (0.000s)
[646.454885] [103/134] (376s left) gem_mmap_gtt (hang-busy)
[646.509323] Subtest hang-busy: SKIP (0.000s)
[646.564492] [104/134] (376s left) kms_flip (flip-vs-expired-vblank-interruptible)
[646.668339] Starting subtest: flip-vs-expired-vblank-interruptible
[646.670579] Starting dynamic subtest: A-eDP1
[655.388688] Dynamic subtest A-eDP1: SUCCESS (8.718s)
[655.401321] Starting dynamic subtest: B-eDP1
[664.043752] Dynamic subtest B-eDP1: SUCCESS (8.618s)
[664.054713] Starting dynamic subtest: C-eDP1
[672.685809] Dynamic subtest C-eDP1: SUCCESS (8.629s)
[672.698009] Starting dynamic subtest: D-eDP1
[681.320698] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[681.323094] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.609s)
[682.458486] [105/134] (340s left) gem_exec_schedule (preempt-queue-contexts)
[682.540303] Subtest preempt-queue-contexts: SKIP (0.000s)
[682.846388] [106/134] (340s left) perf (oa-formats)
[682.963805] Starting subtest: oa-formats
[682.966730] Starting dynamic subtest: 0-rcs0
[682.979544] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[682.990140] Starting dynamic subtest: 1-vecs0
[683.002093] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[683.004398] Subtest oa-formats: SUCCESS (0.039s)
[683.046453] [107/134] (340s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[683.145423] Starting subtest: fbcpsr-modesetfrombusy
[689.337985] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.197s)
[689.521911] [108/134] (333s left) kms_flip (2x-dpms-vs-vblank-race)
[689.623896] Starting subtest: 2x-dpms-vs-vblank-race
[689.633535] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[689.774939] [109/134] (333s left) gem_exec_params (readonly)
[689.835990] Starting subtest: readonly
[689.841474] Subtest readonly: SUCCESS (0.003s)
[689.989179] [110/134] (333s left) kms_vblank (invalid)
[690.087150] Starting subtest: invalid
[690.088942] Starting dynamic subtest: pipe-A-eDP-1
[690.486765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[690.489035] Subtest invalid: SUCCESS (0.399s)
[691.357038] [111/134] (331s left) gem_exec_reloc (basic-cpu-read-noreloc)
[691.438868] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[691.529970] [112/134] (331s left) gem_ctx_persistence (engines-hostile)
[691.599522] Starting subtest: engines-hostile
[691.601961] Starting dynamic subtest: rcs0
[691.692316] Dynamic subtest rcs0: SUCCESS (0.091s)
[691.705119] Starting dynamic subtest: bcs0
[691.801065] Dynamic subtest bcs0: SUCCESS (0.107s)
[691.813280] Starting dynamic subtest: vcs0
[691.918228] Dynamic subtest vcs0: SUCCESS (0.115s)
[691.930859] Starting dynamic subtest: vcs1
[692.034370] Dynamic subtest vcs1: SUCCESS (0.114s)
[692.047389] Starting dynamic subtest: vecs0
[692.152701] Dynamic subtest vecs0: SUCCESS (0.117s)
[692.165101] Starting dynamic subtest: ccs0
[692.267164] Dynamic subtest ccs0: SUCCESS (0.113s)
[692.269216] Subtest engines-hostile: SUCCESS (0.669s)
[692.357156] [113/134] (331s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[692.463174] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[692.466575] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[692.593405] [114/134] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[692.699636] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[692.703140] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[692.810303] [115/134] (330s left) gem_caching (writes)
[692.880542] Subtest writes: SKIP (0.000s)
[692.969158] [116/134] (330s left) kms_pm_backlight (fade-with-suspend)
[693.068877] Starting subtest: fade-with-suspend
[710.015086] Starting dynamic subtest: eDP-1
[712.697104] Dynamic subtest eDP-1: SUCCESS (2.683s)
[712.699364] Subtest fade-with-suspend: SUCCESS (4.939s)
[718.561505] [117/134] (310s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[718.666806] Starting subtest: coverage-vs-premult-vs-constant
[718.965399] Starting dynamic subtest: pipe-A-eDP-1
[719.567046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[719.577321] Starting dynamic subtest: pipe-D-eDP-1
[720.857745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[720.860175] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.190s)
[721.722124] [118/134] (306s left) kms_lease (master-vs-lease)
[721.819254] Starting subtest: master-vs-lease
[721.821577] Subtest master-vs-lease: SUCCESS (0.002s)
[721.957610] [119/134] (306s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[722.056379] Starting subtest: psr-rgb565-draw-mmap-wc
[728.816195] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.759s)
[728.958265] [120/134] (299s left) kms_addfb_basic (addfb25-4-tiled)
[729.059996] Starting subtest: addfb25-4-tiled
[729.062168] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[729.168001] [121/134] (299s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[729.263509] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[729.267634] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[729.347548] [122/134] (299s left) kms_plane_multiple (2x-tiling-x)
[729.445642] Starting subtest: 2x-tiling-x
[729.449975] Subtest 2x-tiling-x: SKIP (0.000s)
[729.544738] [123/134] (299s left) kms_psr (psr2-primary-render)
[729.643470] Starting subtest: psr2-primary-render
[729.645634] Starting dynamic subtest: eDP-1
[731.334153] Dynamic subtest eDP-1: SUCCESS (1.692s)
[731.336419] Subtest psr2-primary-render: SUCCESS (1.693s)
[732.220662] [124/134] (296s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[732.285425] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[732.393860] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[732.483842] [125/134] (296s left) gem_exec_balancer (full)
[732.556849] Starting subtest: full
[737.479723] Subtest full: SUCCESS (4.924s)
[737.830545] [126/134] (291s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[737.939626] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[737.944214] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[738.060584] [127/134] (290s left) gem_mmap_wc (write-read)
[738.123461] Subtest write-read: SKIP (0.000s)
[738.191697] [128/134] (290s left) gem_ctx_persistence (process)
[738.245263] Starting subtest: process
[738.514150] Subtest process: SUCCESS (0.268s)
[738.603665] [129/134] (290s left) gem_ctx_param (non-root-set)
[738.657027] Starting subtest: non-root-set
[738.684516] Subtest non-root-set: SUCCESS (0.028s)
[738.794518] [130/134] (290s left) sw_sync (timeline_closed)
[738.829983] Starting subtest: timeline_closed
[738.831859] Subtest timeline_closed: SUCCESS (0.000s)
[738.902331] [131/134] (290s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[738.986274] Starting subtest: primary-4-tiled-reflect-x-180
[746.076036] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.090s)
[747.307479] [132/134] (281s left) gem_exec_parallel (basic)
[747.375251] Starting subtest: basic
[747.377562] Starting dynamic subtest: rcs0
[748.822080] Dynamic subtest rcs0: SUCCESS (1.446s)
[748.834743] Starting dynamic subtest: bcs0
[750.321302] Dynamic subtest bcs0: SUCCESS (1.497s)
[750.334666] Starting dynamic subtest: vcs0
[753.589219] Dynamic subtest vcs0: SUCCESS (3.265s)
[753.602344] Starting dynamic subtest: vcs1
[755.573785] Dynamic subtest vcs1: SUCCESS (1.982s)
[755.585027] Starting dynamic subtest: vecs0
[757.621220] Dynamic subtest vecs0: SUCCESS (2.044s)
[757.632962] Starting dynamic subtest: ccs0
[759.115204] Dynamic subtest ccs0: SUCCESS (1.493s)
[759.117885] Subtest basic: SUCCESS (11.741s)
[759.329977] [133/134] (269s left) kms_content_protection (uevent-hdcp14)
[759.467381] Starting subtest: uevent-hdcp14
[759.472078] Subtest uevent-hdcp14: SKIP (0.000s)
[759.625469] [134/134] (269s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[759.692703] Starting subtest: multi-wait-all-for-submit-available-signaled
[759.695010] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[759.816490] 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.