[56.841656] Initializing watchdogs
[56.841703]   /dev/watchdog0
[56.856981] [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]
[56.861573] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.863860] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.867309] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[57.147005] Starting subtest: cursor-offscreen-256x85
[57.202669] Subtest cursor-offscreen-256x85: SKIP (0.052s)
[57.386128] [002/134] (960s left) gem_mmap_gtt (cpuset-big-copy-odd)
[57.449071] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[57.510565] [003/134] (959s left) gem_ctx_engines (execute-allforone)
[57.570482] Starting subtest: execute-allforone
[57.584113] Subtest execute-allforone: SUCCESS (0.014s)
[58.972911] [004/134] (958s left) perf_pmu (busy-idle)
[59.017130] Starting subtest: busy-idle
[59.019498] Starting dynamic subtest: rcs0
[59.718202] Dynamic subtest rcs0: SUCCESS (0.698s)
[59.728650] Starting dynamic subtest: bcs0
[60.393058] Dynamic subtest bcs0: SUCCESS (0.671s)
[60.403294] Starting dynamic subtest: vcs0
[61.913431] Dynamic subtest vcs0: SUCCESS (1.511s)
[61.921915] Starting dynamic subtest: vcs1
[63.896093] Dynamic subtest vcs1: SUCCESS (1.975s)
[63.905956] Starting dynamic subtest: vecs0
[65.943310] Dynamic subtest vecs0: SUCCESS (2.041s)
[65.953817] Starting dynamic subtest: ccs0
[66.618182] Dynamic subtest ccs0: SUCCESS (0.674s)
[66.620622] Subtest busy-idle: SUCCESS (7.576s)
[66.737396] [005/134] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[66.881277] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[67.831272] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.950s)
[68.075350] [006/134] (949s left) api_intel_bb (lot-of-buffers)
[68.196785] Starting subtest: lot-of-buffers
[69.382664] Subtest lot-of-buffers: SUCCESS (1.162s)
[69.829186] [007/134] (947s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[69.886165] Starting subtest: yf-tiled-to-vebox-x-tiled
[69.890309] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[70.080223] [008/134] (947s left) kms_plane (plane-panning-top-left)
[70.171649] Starting subtest: plane-panning-top-left
[70.173680] Starting dynamic subtest: pipe-A
[71.875659] Dynamic subtest pipe-A: SUCCESS (1.701s)
[71.884889] Starting dynamic subtest: pipe-B
[74.300584] Dynamic subtest pipe-B: SUCCESS (2.423s)
[74.303058] Subtest plane-panning-top-left: SUCCESS (4.126s)
[75.118525] [009/134] (942s left) kms_psr (fbc-psr-cursor-plane-onoff)
[75.222731] Starting subtest: fbc-psr-cursor-plane-onoff
[75.225038] Starting dynamic subtest: eDP-1
[75.229463] Dynamic subtest eDP-1: SKIP (0.000s)
[75.233863] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[75.305970] [010/134] (942s left) kms_cursor_crc (cursor-tearing-position-change)
[75.422480] Starting subtest: cursor-tearing-position-change
[75.424368] Starting dynamic subtest: pipe-A-eDP-1
[75.999299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[76.008177] Starting dynamic subtest: pipe-D-eDP-1
[77.253881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.254s)
[77.256198] Subtest cursor-tearing-position-change: SUCCESS (1.831s)
[78.104961] [011/134] (939s left) kms_frontbuffer_tracking (basic)
[78.217656] Starting subtest: basic
[81.523334] Subtest basic: SUCCESS (3.291s)
[81.671491] [012/134] (936s left) gem_spin_batch (spin-each)
[81.737280] Starting subtest: spin-each
[85.109067] Subtest spin-each: SUCCESS (3.352s)
[86.982833] [013/134] (930s left) gem_exec_reloc (basic-gtt-cpu)
[87.046821] Subtest basic-gtt-cpu: SKIP (0.000s)
[87.125612] [014/134] (930s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[87.221800] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[87.247954] Starting dynamic subtest: pipe-A-plane-0
[87.548830] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[87.563490] Starting dynamic subtest: pipe-A-plane-3
[87.782709] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[87.794627] Starting dynamic subtest: pipe-A-plane-5
[87.799238] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[88.923618] Starting dynamic subtest: pipe-B-plane-0
[89.217330] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[89.227545] Starting dynamic subtest: pipe-B-plane-3
[89.451100] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[89.459874] Starting dynamic subtest: pipe-B-plane-5
[89.463958] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[89.761521] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.535s)
[90.608684] [015/134] (927s left) gem_render_copy (y-tiled-ccs-to-linear)
[90.677587] Starting subtest: y-tiled-ccs-to-linear
[90.681928] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[90.869995] [016/134] (927s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[90.973668] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[90.978196] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[91.090333] [017/134] (926s left) kms_psr (pr-sprite-render)
[91.187128] Starting subtest: pr-sprite-render
[91.191284] Subtest pr-sprite-render: SKIP (0.000s)
[91.269963] [018/134] (926s left) gen9_exec_parse (shadow-peek)
[91.335894] Subtest shadow-peek: SKIP (0.000s)
[91.431246] [019/134] (926s left) perf (invalid-remove-userspace-config)
[91.562520] Starting subtest: invalid-remove-userspace-config
[91.572212] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[91.612117] [020/134] (926s left) gem_ctx_param (invalid-size-set)
[91.668653] Starting subtest: invalid-size-set
[91.671021] Subtest invalid-size-set: SUCCESS (0.001s)
[91.799086] [021/134] (926s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[91.890569] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[91.892618] Starting dynamic subtest: pipe-A-eDP-1
[91.912087] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.921375] Starting dynamic subtest: pipe-B-eDP-1
[91.939097] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.946202] Starting dynamic subtest: pipe-C-eDP-1
[91.963929] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.971160] Starting dynamic subtest: pipe-D-eDP-1
[91.989830] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.993641] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[94.181443] [022/134] (924s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[94.230980] Starting subtest: invalid-bsd2-flag-on-blt
[94.233146] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[94.363029] [023/134] (923s left) gem_render_copy (yf-tiled-ccs-to-linear)
[94.428694] Starting subtest: yf-tiled-ccs-to-linear
[94.433272] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[94.619953] [024/134] (923s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[94.682042] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[94.788626] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[94.873284] [025/134] (923s left) gem_exec_fence (invalid-timeline-fence-array)
[95.476297] Starting subtest: invalid-timeline-fence-array
[95.481441] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[97.002770] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[97.005913] [026/134] (921s left) kms_chamelium_edid (dp-edid-read)
[97.402842] Subtest dp-edid-read: SKIP (0.000s)
[98.176110] [027/134] (920s left) gem_exec_params (invalid-bsd1-flag-on-render)
[98.242920] Starting subtest: invalid-bsd1-flag-on-render
[98.245332] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[98.356120] [028/134] (920s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[98.458268] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[99.483350] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.025s)
[99.652029] [029/134] (918s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[99.752889] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[99.754912] Starting dynamic subtest: pipe-A-eDP-1
[99.774261] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.783552] Starting dynamic subtest: pipe-B-eDP-1
[99.801101] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.807992] Starting dynamic subtest: pipe-C-eDP-1
[99.825631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.832637] Starting dynamic subtest: pipe-D-eDP-1
[99.850240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.853847] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[102.072862] [030/134] (916s left) gem_eio (kms)
[102.341658] Starting subtest: kms
[123.051131] Subtest kms: SUCCESS (20.707s)
[124.260987] [031/134] (894s left) kms_cursor_legacy (torture-move)
[124.382412] Starting subtest: torture-move
[124.384591] Starting dynamic subtest: pipe-A
[130.799144] Dynamic subtest pipe-A: SUCCESS (6.411s)
[130.814334] Starting dynamic subtest: pipe-B
[138.262272] Dynamic subtest pipe-B: SUCCESS (7.462s)
[138.272629] Starting dynamic subtest: pipe-C
[144.193330] Dynamic subtest pipe-C: SUCCESS (5.928s)
[144.204097] Starting dynamic subtest: pipe-D
[150.688805] Dynamic subtest pipe-D: SUCCESS (6.492s)
[150.699520] Starting dynamic subtest: all-pipes
[156.386320] Dynamic subtest all-pipes: SUCCESS (5.695s)
[156.388705] Subtest torture-move: SUCCESS (31.995s)
[156.556365] [032/134] (862s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[156.656534] Starting subtest: bad-pixel-format-yf-tiled-ccs
[156.658719] Starting dynamic subtest: pipe-A-eDP-1
[156.681048] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.696155] Starting dynamic subtest: pipe-B-eDP-1
[156.717380] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.725176] Starting dynamic subtest: pipe-C-eDP-1
[156.746059] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.754047] Starting dynamic subtest: pipe-D-eDP-1
[156.775130] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.779405] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[158.941762] [033/134] (859s left) gem_exec_capture (pi)
[159.020122] Starting subtest: pi
[159.022062] Starting dynamic subtest: rcs0
[163.438705] Dynamic subtest rcs0: SUCCESS (4.419s)
[163.453151] Starting dynamic subtest: bcs0
[167.736275] Dynamic subtest bcs0: SUCCESS (4.295s)
[167.746059] Starting dynamic subtest: vcs0
[172.100332] Dynamic subtest vcs0: SUCCESS (4.361s)
[172.111672] Starting dynamic subtest: vcs1
[176.460233] Dynamic subtest vcs1: SUCCESS (4.366s)
[176.471894] Starting dynamic subtest: vecs0
[180.780073] Dynamic subtest vecs0: SUCCESS (4.332s)
[180.791702] Starting dynamic subtest: ccs0
[185.118138] Dynamic subtest ccs0: SUCCESS (4.348s)
[185.120427] Subtest pi: SUCCESS (26.128s)
[185.207423] [034/134] (833s left) syncobj_timeline (wait-all-snapshot)
[185.314075] Starting subtest: wait-all-snapshot
[185.396501] Subtest wait-all-snapshot: SUCCESS (0.082s)
[185.496914] [035/134] (833s left) kms_async_flips (test-cursor-atomic)
[185.605254] Starting subtest: test-cursor-atomic
[185.609739] Subtest test-cursor-atomic: SKIP (0.000s)
[186.839972] [036/134] (831s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[186.943076] Starting subtest: x-tiled-32bpp-rotate-180
[188.461951] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.523s)
[188.616712] [037/134] (830s left) i915_pm_freq_api (freq-reset)
[188.693041] Starting subtest: freq-reset
[188.695123] Starting dynamic subtest: gt0
[188.891238] Dynamic subtest gt0: SUCCESS (0.196s)
[188.901061] Starting dynamic subtest: gt1
[189.048375] Dynamic subtest gt1: SUCCESS (0.157s)
[189.051371] Subtest freq-reset: SUCCESS (0.354s)
[189.137588] [038/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[189.237311] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[193.507865] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.281s)
[194.717546] [039/134] (824s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[194.821686] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[194.823911] Starting dynamic subtest: pipe-A-eDP-1
[194.848832] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.859709] Starting dynamic subtest: pipe-B-eDP-1
[194.882784] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.891315] Starting dynamic subtest: pipe-C-eDP-1
[194.914163] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.922419] Starting dynamic subtest: pipe-D-eDP-1
[194.945646] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.949933] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[197.078350] [040/134] (821s left) gem_mmap (short-mmap)
[197.144182] Subtest short-mmap: SKIP (0.000s)
[197.206291] [041/134] (821s left) vgem_basic (dmabuf-export)
[197.250166] Starting subtest: dmabuf-export
[197.305774] Subtest dmabuf-export: SUCCESS (0.058s)
[197.430564] [042/134] (821s left) gem_render_copy (y-tiled)
[197.494623] Starting subtest: y-tiled
[197.499243] Subtest y-tiled: SKIP (0.000s)
[197.692583] [043/134] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[197.798466] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[205.479289] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.690s)
[205.641992] [044/134] (813s left) gem_exec_schedule (implicit-write-read)
[205.723825] Starting subtest: implicit-write-read
[205.725943] Starting dynamic subtest: rcs0
[205.817751] Dynamic subtest rcs0: SUCCESS (0.104s)
[205.830024] Starting dynamic subtest: vcs0
[205.896577] Dynamic subtest vcs0: SUCCESS (0.078s)
[205.908659] Starting dynamic subtest: vcs1
[205.976636] Dynamic subtest vcs1: SUCCESS (0.079s)
[205.987738] Starting dynamic subtest: vecs0
[206.057798] Dynamic subtest vecs0: SUCCESS (0.081s)
[206.068850] Starting dynamic subtest: ccs0
[206.145571] Dynamic subtest ccs0: SUCCESS (0.087s)
[206.147899] Subtest implicit-write-read: SUCCESS (0.432s)
[207.041776] [045/134] (812s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[207.137948] Starting subtest: 4-tiled-64bpp-rotate-90
[207.157038] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[207.313825] [046/134] (811s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[207.414106] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[207.416376] Starting dynamic subtest: A-eDP1
[216.301421] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[216.312157] Starting dynamic subtest: B-eDP1
[225.233150] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[225.243495] Starting dynamic subtest: C-eDP1
[234.139887] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[234.148989] Starting dynamic subtest: D-eDP1
[243.077431] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[243.082762] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.665s)
[244.342263] [047/134] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[244.447282] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[244.451384] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[244.579169] [048/134] (774s left) kms_color_pipeline (plane-lut1d)
[244.693563] Starting subtest: plane-lut1d
[244.707840] Starting dynamic subtest: pipe-A-eDP-1
[245.407583] Dynamic subtest pipe-A-eDP-1: FAIL (0.343s)
[246.098243] Starting dynamic subtest: pipe-B-eDP-1
[246.893632] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[247.427641] Starting dynamic subtest: pipe-C-eDP-1
[248.280449] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[248.763080] Starting dynamic subtest: pipe-D-eDP-1
[249.630764] Dynamic subtest pipe-D-eDP-1: FAIL (0.271s)
[249.632733] Subtest plane-lut1d: FAIL (4.625s)
[250.161631] [049/134] (769s left) i915_pm_rc6_residency (rc6-accuracy)
[250.214944] Starting subtest: rc6-accuracy
[250.216885] Starting dynamic subtest: gt0
[253.387304] Dynamic subtest gt0: SUCCESS (3.164s)
[253.396872] Starting dynamic subtest: gt1
[256.558257] Dynamic subtest gt1: SUCCESS (3.164s)
[256.560799] Subtest rc6-accuracy: SUCCESS (6.332s)
[256.648391] [050/134] (762s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[256.771476] Starting subtest: basic-flip-before-cursor-atomic
[257.688133] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[258.504458] [051/134] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[258.617634] Starting subtest: psr-2p-primscrn-spr-indfb-move
[258.621723] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[258.761960] [052/134] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[258.858329] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[258.862755] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[259.003316] [053/134] (760s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[263.991439] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[263.995999] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[264.848390] [054/134] (754s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[264.914416] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[265.019478] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[265.107323] [055/134] (754s left) gem_mmap_wc (bad-size)
[265.178780] Subtest bad-size: SKIP (0.000s)
[265.247834] [056/134] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[265.361226] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[265.365721] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[265.485803] [057/134] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[265.594263] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[265.598580] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[265.725378] [058/134] (753s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[265.850242] Starting subtest: cursorA-vs-flipB-atomic
[265.854426] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[266.007086] [059/134] (753s left) sysfs_heartbeat_interval (nopreempt)
[266.078452] Starting subtest: nopreempt
[266.080541] Starting dynamic subtest: vecs0
[275.919250] Dynamic subtest vecs0: SUCCESS (9.833s)
[275.930554] Starting dynamic subtest: ccs0
[280.036209] Dynamic subtest ccs0: SUCCESS (4.112s)
[280.047068] Starting dynamic subtest: vcs0
[289.885878] Dynamic subtest vcs0: SUCCESS (9.841s)
[289.897536] Starting dynamic subtest: bcs0
[293.940580] Dynamic subtest bcs0: SUCCESS (4.052s)
[293.952510] Starting dynamic subtest: rcs0
[298.038797] Dynamic subtest rcs0: SUCCESS (4.096s)
[298.049509] Starting dynamic subtest: vcs1
[307.951761] Dynamic subtest vcs1: SUCCESS (9.908s)
[307.954250] Subtest nopreempt: SUCCESS (41.854s)
[308.040084] [060/134] (711s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[308.152760] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[308.157237] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[308.294489] [061/134] (711s left) gem_wait (busy)
[308.362969] Starting subtest: busy
[308.365316] Starting dynamic subtest: all-engines
[309.911405] Dynamic subtest all-engines: SUCCESS (1.546s)
[309.923360] Starting dynamic subtest: rcs0
[310.452161] Dynamic subtest rcs0: SUCCESS (0.540s)
[310.463645] Starting dynamic subtest: bcs0
[310.991191] Dynamic subtest bcs0: SUCCESS (0.539s)
[311.002533] Starting dynamic subtest: vcs0
[312.919260] Dynamic subtest vcs0: SUCCESS (1.926s)
[312.930911] Starting dynamic subtest: vcs1
[314.903890] Dynamic subtest vcs1: SUCCESS (1.982s)
[314.915946] Starting dynamic subtest: vecs0
[316.887609] Dynamic subtest vecs0: SUCCESS (1.981s)
[316.899532] Starting dynamic subtest: ccs0
[317.428241] Dynamic subtest ccs0: SUCCESS (0.540s)
[317.430710] Subtest busy: SUCCESS (9.067s)
[317.639292] [062/134] (702s left) kms_setmode (clone-exclusive-crtc)
[317.705216] Starting subtest: clone-exclusive-crtc
[317.712103] Subtest clone-exclusive-crtc: SKIP (0.000s)
[317.827029] [063/134] (702s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[322.811770] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[322.816554] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[323.683926] [064/134] (696s left) sw_sync (sync_merge_same)
[323.726062] Starting subtest: sync_merge_same
[323.728584] Subtest sync_merge_same: SUCCESS (0.000s)
[323.798774] [065/134] (696s left) kms_hdr (static-toggle)
[323.897765] Starting subtest: static-toggle
[323.904669] Subtest static-toggle: SKIP (0.000s)
[323.982692] [066/134] (696s left) gem_exec_await (wide-contexts)
[324.189950] Starting subtest: wide-contexts
[347.708907] Subtest wide-contexts: SUCCESS (23.517s)
[347.913933] [067/134] (672s left) kms_invalid_mode (uint-max-clock)
[348.066933] Starting subtest: uint-max-clock
[348.069070] Starting dynamic subtest: pipe-A-eDP-1
[348.349542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[348.360054] Starting dynamic subtest: pipe-B-eDP-1
[348.361967] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[348.370434] Starting dynamic subtest: pipe-C-eDP-1
[348.372781] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[348.381672] Starting dynamic subtest: pipe-D-eDP-1
[348.383570] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[348.385496] Subtest uint-max-clock: SUCCESS (0.291s)
[349.205326] [068/134] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[349.307684] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[352.987888] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.683s)
[354.109112] [069/134] (666s left) kms_pm_rpm (modeset-non-lpsp)
[356.077919] Starting subtest: modeset-non-lpsp
[357.237443] Subtest modeset-non-lpsp: SKIP (1.159s)
[357.650963] [070/134] (662s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[357.755145] Starting subtest: fbc-pr-cursor-mmap-cpu
[357.759152] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[357.855074] [071/134] (662s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[357.963081] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[361.908598] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.947s)
[363.040630] [072/134] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[363.143882] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[363.147864] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[363.287499] [073/134] (656s left) i915_pm_rps (thresholds-idle)
[363.353709] Starting subtest: thresholds-idle
[363.358266] Subtest thresholds-idle: SKIP (0.000s)
[363.479969] [074/134] (656s left) kms_vblank (query-idle-hang)
[363.579298] Starting subtest: query-idle-hang
[363.581506] Starting dynamic subtest: pipe-A-eDP-1
[389.657776] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.071s)
[389.672583] Starting dynamic subtest: pipe-D-eDP-1
[404.696061] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.032s)
[404.698082] Subtest query-idle-hang: SUCCESS (41.107s)
[405.588369] [075/134] (614s left) perf_pmu (most-busy-idle-check-all)
[405.631331] Starting subtest: most-busy-idle-check-all
[405.633610] Starting dynamic subtest: rcs0
[406.873368] Dynamic subtest rcs0: SUCCESS (1.240s)
[406.885819] Starting dynamic subtest: bcs0
[408.920546] Dynamic subtest bcs0: SUCCESS (2.044s)
[408.933058] Starting dynamic subtest: vcs0
[410.904388] Dynamic subtest vcs0: SUCCESS (1.980s)
[410.916426] Starting dynamic subtest: vcs1
[412.887478] Dynamic subtest vcs1: SUCCESS (1.980s)
[412.899237] Starting dynamic subtest: vecs0
[414.936322] Dynamic subtest vecs0: SUCCESS (2.045s)
[414.947809] Starting dynamic subtest: ccs0
[416.920591] Dynamic subtest ccs0: SUCCESS (1.981s)
[416.923471] Subtest most-busy-idle-check-all: SUCCESS (11.288s)
[417.060211] [076/134] (603s left) kms_atomic_interruptible (universal-setplane-cursor)
[417.167627] Starting subtest: universal-setplane-cursor
[417.169845] Starting dynamic subtest: pipe-A-eDP-1
[424.582732] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.412s)
[424.585151] Subtest universal-setplane-cursor: SUCCESS (7.414s)
[425.458353] [077/134] (594s left) gem_userptr_blits (process-exit-busy)
[425.535651] Starting subtest: process-exit-busy
[425.550961] Subtest process-exit-busy: SUCCESS (0.015s)
[425.718544] [078/134] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[425.826870] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[425.831118] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[425.928313] [079/134] (594s left) gem_lmem_swapping (heavy-verify-multi)
[425.976290] Subtest heavy-verify-multi: SKIP (0.000s)
[426.014438] [080/134] (594s left) gen9_exec_parse (bb-start-cmd)
[426.083311] Subtest bb-start-cmd: SKIP (0.000s)
[426.167324] [081/134] (594s left) fbdev (unaligned-read)
[426.207796] Starting subtest: unaligned-read
[426.222775] Subtest unaligned-read: SUCCESS (0.015s)
[426.288836] [082/134] (594s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[426.672141] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[427.454591] [083/134] (593s left) gem_ppgtt (blt-vs-render-ctx0)
[427.512656] Starting subtest: blt-vs-render-ctx0
[460.355163] Subtest blt-vs-render-ctx0: SUCCESS (32.842s)
[460.516279] [084/134] (560s left) core_setmaster_vs_auth
[460.746978] [085/134] (560s left) prime_busy (hang)
[460.811165] Starting subtest: hang
[460.813532] Starting dynamic subtest: rcs0
[487.410619] Dynamic subtest rcs0: SUCCESS (26.596s)
[487.421023] Starting dynamic subtest: bcs0
[494.567239] Dynamic subtest bcs0: SUCCESS (7.157s)
[494.578840] Starting dynamic subtest: vcs0
[501.544713] Dynamic subtest vcs0: SUCCESS (6.973s)
[501.555862] Starting dynamic subtest: vcs1
[508.576343] Dynamic subtest vcs1: SUCCESS (7.034s)
[508.588026] Starting dynamic subtest: vecs0
[515.555726] Dynamic subtest vecs0: SUCCESS (6.974s)
[515.566455] Starting dynamic subtest: ccs0
[529.459753] Dynamic subtest ccs0: SUCCESS (13.901s)
[529.462157] Subtest hang: SUCCESS (68.642s)
[529.612109] [086/134] (491s left) gem_eio (unwedge-stress)
[529.793988] Starting subtest: unwedge-stress
[529.795881] Starting dynamic subtest: render
[534.222055] Dynamic subtest render: SUCCESS (4.425s)
[534.237450] Starting dynamic subtest: bsd1
[552.331645] Dynamic subtest bsd1: SUCCESS (18.107s)
[552.347790] Starting dynamic subtest: bsd2
[570.320067] Dynamic subtest bsd2: SUCCESS (17.985s)
[570.336181] Starting dynamic subtest: blt
[570.340411] Dynamic subtest blt: SKIP (0.000s)
[570.349052] Starting dynamic subtest: vebox
[588.394235] Dynamic subtest vebox: SUCCESS (18.071s)
[588.396525] Subtest unwedge-stress: SUCCESS (58.593s)
[589.979757] [087/134] (430s left) kms_cursor_crc (cursor-random-256x256)
[590.238591] Starting subtest: cursor-random-256x256
[590.240842] Starting dynamic subtest: pipe-A-eDP-1
[593.659196] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[593.688988] Starting dynamic subtest: pipe-D-eDP-1
[597.696055] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.013s)
[597.698427] Subtest cursor-random-256x256: SUCCESS (7.458s)
[598.557266] [088/134] (422s left) syncobj_timeline (multi-wait-submitted-signaled)
[598.627323] Starting subtest: multi-wait-submitted-signaled
[598.629367] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[598.761331] [089/134] (422s left) kms_dsc (dsc-with-formats)
[598.861067] Starting subtest: dsc-with-formats
[598.899715] Subtest dsc-with-formats: SKIP (0.001s)
[598.946115] [090/134] (422s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[599.042458] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[605.643077] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.602s)
[605.792134] [091/134] (415s left) api_intel_allocator (reopen-fork)
[605.851083] Starting subtest: reopen-fork
[609.226101] Subtest reopen-fork: SUCCESS (3.374s)
[609.331387] [092/134] (411s left) gem_exec_whisper (basic-fds-priority-all)
[609.392305] Starting subtest: basic-fds-priority-all
[633.024542] Subtest basic-fds-priority-all: SUCCESS (23.624s)
[633.220256] [093/134] (387s left) gem_exec_fence (basic-wait-all)
[633.278700] Starting subtest: basic-wait-all
[633.393590] Subtest basic-wait-all: SUCCESS (0.115s)
[635.034389] [094/134] (386s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[635.133232] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[635.135556] Starting dynamic subtest: pipe-A-eDP-1
[635.194634] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[635.205413] Starting dynamic subtest: pipe-B-eDP-1
[635.263990] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[635.274873] Starting dynamic subtest: pipe-C-eDP-1
[635.331972] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[635.342037] Starting dynamic subtest: pipe-D-eDP-1
[635.398836] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[635.402969] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[637.374361] [095/134] (383s left) kms_psr (fbc-psr2-no-drrs)
[637.470144] Starting subtest: fbc-psr2-no-drrs
[637.472304] Starting dynamic subtest: eDP-1
[637.476173] Dynamic subtest eDP-1: SKIP (0.000s)
[637.480176] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[637.553487] [096/134] (383s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[637.650520] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[637.654587] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[637.773416] [097/134] (383s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[637.863443] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[637.867829] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[637.975510] [098/134] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[638.079906] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[641.654717] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.577s)
[642.870060] [099/134] (378s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[642.974301] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[642.976661] Starting dynamic subtest: pipe-A
[642.995923] Dynamic subtest pipe-A: SKIP (0.019s)
[643.006117] Starting dynamic subtest: pipe-B
[643.032096] Dynamic subtest pipe-B: SKIP (0.034s)
[643.042193] Starting dynamic subtest: pipe-C
[643.066237] Dynamic subtest pipe-C: SKIP (0.034s)
[643.075282] Starting dynamic subtest: pipe-D
[643.100731] Dynamic subtest pipe-D: SKIP (0.033s)
[643.105208] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.123s)
[643.209189] [100/134] (378s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[643.310928] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[643.315201] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[643.397990] [101/134] (378s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[643.532305] Starting subtest: flip-vs-cursor-busy-crc-atomic
[644.347823] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.815s)
[645.173709] [102/134] (376s left) core_getstats (basic)
[645.229533] Starting subtest: basic
[645.231461] Subtest basic: SUCCESS (0.000s)
[645.338065] [103/134] (376s left) gem_mmap_gtt (hang-busy)
[645.395069] Subtest hang-busy: SKIP (0.000s)
[645.456615] [104/134] (376s left) kms_flip (flip-vs-expired-vblank-interruptible)
[645.545317] Starting subtest: flip-vs-expired-vblank-interruptible
[645.547721] Starting dynamic subtest: A-eDP1
[654.274116] Dynamic subtest A-eDP1: SUCCESS (8.726s)
[654.283724] Starting dynamic subtest: B-eDP1
[662.914415] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[662.927125] Starting dynamic subtest: C-eDP1
[671.533944] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[671.545136] Starting dynamic subtest: D-eDP1
[680.155527] Dynamic subtest D-eDP1: SUCCESS (8.618s)
[680.160953] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.611s)
[681.339807] [105/134] (340s left) gem_exec_schedule (preempt-queue-contexts)
[681.416637] Subtest preempt-queue-contexts: SKIP (0.000s)
[681.726470] [106/134] (339s left) perf (oa-formats)
[681.841866] Starting subtest: oa-formats
[681.844182] Starting dynamic subtest: 0-rcs0
[681.858592] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[681.868337] Starting dynamic subtest: 1-vcs0
[681.881195] Dynamic subtest 1-vcs0: SUCCESS (0.022s)
[681.883333] Subtest oa-formats: SUCCESS (0.040s)
[681.927403] [107/134] (339s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[682.028284] Starting subtest: fbcpsr-modesetfrombusy
[688.197126] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.174s)
[688.371326] [108/134] (333s left) kms_flip (2x-dpms-vs-vblank-race)
[688.472531] Starting subtest: 2x-dpms-vs-vblank-race
[688.484070] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[688.626459] [109/134] (333s left) gem_exec_params (readonly)
[688.681035] Starting subtest: readonly
[688.685233] Subtest readonly: SUCCESS (0.003s)
[688.836229] [110/134] (332s left) kms_vblank (invalid)
[688.933600] Starting subtest: invalid
[688.935414] Starting dynamic subtest: pipe-A-eDP-1
[689.342692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[689.344938] Subtest invalid: SUCCESS (0.410s)
[690.238830] [111/134] (331s left) gem_exec_reloc (basic-cpu-read-noreloc)
[690.312478] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[690.401704] [112/134] (331s left) gem_ctx_persistence (engines-hostile)
[690.461540] Starting subtest: engines-hostile
[690.463924] Starting dynamic subtest: rcs0
[690.568929] Dynamic subtest rcs0: SUCCESS (0.106s)
[690.581609] Starting dynamic subtest: bcs0
[690.642675] Dynamic subtest bcs0: SUCCESS (0.072s)
[690.659178] Starting dynamic subtest: vcs0
[690.769218] Dynamic subtest vcs0: SUCCESS (0.126s)
[690.783921] Starting dynamic subtest: vcs1
[690.883907] Dynamic subtest vcs1: SUCCESS (0.112s)
[690.896114] Starting dynamic subtest: vecs0
[691.013745] Dynamic subtest vecs0: SUCCESS (0.128s)
[691.024776] Starting dynamic subtest: ccs0
[691.132662] Dynamic subtest ccs0: SUCCESS (0.117s)
[691.135098] Subtest engines-hostile: SUCCESS (0.672s)
[691.222989] [113/134] (330s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[691.338726] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[691.342234] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[691.473633] [114/134] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[691.569129] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[691.572505] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[691.668386] [115/134] (330s left) gem_caching (writes)
[691.730353] Subtest writes: SKIP (0.000s)
[691.790899] [116/134] (330s left) kms_pm_backlight (fade-with-suspend)
[691.889093] Starting subtest: fade-with-suspend
[708.082256] Starting dynamic subtest: eDP-1
[710.779795] Dynamic subtest eDP-1: SUCCESS (2.619s)
[710.782141] Subtest fade-with-suspend: SUCCESS (3.970s)
[711.613075] [117/134] (310s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[711.738849] Starting subtest: coverage-vs-premult-vs-constant
[712.034823] Starting dynamic subtest: pipe-A-eDP-1
[712.678737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[712.689483] Starting dynamic subtest: pipe-D-eDP-1
[713.967740] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[713.970156] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.178s)
[714.862644] [118/134] (307s left) kms_lease (master-vs-lease)
[714.962811] Starting subtest: master-vs-lease
[714.965251] Subtest master-vs-lease: SUCCESS (0.002s)
[715.087726] [119/134] (307s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[715.196405] Starting subtest: psr-rgb565-draw-mmap-wc
[722.020648] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.747s)
[722.160399] [120/134] (300s left) kms_addfb_basic (addfb25-4-tiled)
[722.270271] Starting subtest: addfb25-4-tiled
[722.272119] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[722.390042] [121/134] (299s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[722.481699] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[722.485806] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[722.567593] [122/134] (299s left) kms_plane_multiple (2x-tiling-x)
[722.666343] Starting subtest: 2x-tiling-x
[722.670838] Subtest 2x-tiling-x: SKIP (0.000s)
[722.767028] [123/134] (299s left) kms_psr (psr2-primary-render)
[722.852685] Starting subtest: psr2-primary-render
[722.854892] Starting dynamic subtest: eDP-1
[724.567107] Dynamic subtest eDP-1: SUCCESS (1.703s)
[724.569399] Subtest psr2-primary-render: SUCCESS (1.704s)
[725.450133] [124/134] (296s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[725.521903] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[725.630637] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[725.722499] [125/134] (296s left) gem_exec_balancer (full)
[725.774530] Starting subtest: full
[730.633011] Subtest full: SUCCESS (4.840s)
[730.977620] [126/134] (291s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[731.087438] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[731.091426] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[731.231022] [127/134] (291s left) gem_mmap_wc (write-read)
[731.294061] Subtest write-read: SKIP (0.000s)
[731.355492] [128/134] (291s left) gem_ctx_persistence (process)
[731.421104] Starting subtest: process
[731.660296] Subtest process: SUCCESS (0.238s)
[731.753373] [129/134] (290s left) gem_ctx_param (non-root-set)
[731.809956] Starting subtest: non-root-set
[731.838069] Subtest non-root-set: SUCCESS (0.028s)
[731.946401] [130/134] (290s left) sw_sync (timeline_closed)
[731.978315] Starting subtest: timeline_closed
[731.980189] Subtest timeline_closed: SUCCESS (0.000s)
[732.052721] [131/134] (290s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[732.163267] Starting subtest: primary-4-tiled-reflect-x-180
[739.210607] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.035s)
[740.442538] [132/134] (282s left) gem_exec_parallel (basic)
[740.517028] Starting subtest: basic
[740.519704] Starting dynamic subtest: rcs0
[741.966346] Dynamic subtest rcs0: SUCCESS (1.449s)
[741.980038] Starting dynamic subtest: bcs0
[743.455403] Dynamic subtest bcs0: SUCCESS (1.487s)
[743.468313] Starting dynamic subtest: vcs0
[746.769091] Dynamic subtest vcs0: SUCCESS (3.311s)
[746.782458] Starting dynamic subtest: vcs1
[748.689736] Dynamic subtest vcs1: SUCCESS (1.917s)
[748.702768] Starting dynamic subtest: vecs0
[750.738077] Dynamic subtest vecs0: SUCCESS (2.046s)
[750.750651] Starting dynamic subtest: ccs0
[752.248990] Dynamic subtest ccs0: SUCCESS (1.509s)
[752.251509] Subtest basic: SUCCESS (11.732s)
[752.446611] [133/134] (270s left) kms_content_protection (uevent-hdcp14)
[752.593122] Starting subtest: uevent-hdcp14
[752.597830] Subtest uevent-hdcp14: SKIP (0.000s)
[752.762900] [134/134] (270s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[752.824874] Starting subtest: multi-wait-all-for-submit-available-signaled
[752.826881] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[752.950282] 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.