[46.409659] Initializing watchdogs [46.409704] /dev/watchdog0 [46.414718] [001/130] (960s left) kms_invalid_mode (bad-hsync-end) [46.500943] Starting subtest: bad-hsync-end [46.501862] Starting dynamic subtest: pipe-A-HDMI-A-2 [46.532267] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.031s) [46.535736] Starting dynamic subtest: pipe-B-HDMI-A-2 [46.536522] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s) [46.537389] Subtest bad-hsync-end: SUCCESS (0.032s) [46.657712] [002/130] (960s left) kms_lease (master-vs-lease) [46.755854] Starting subtest: master-vs-lease [46.756581] Subtest master-vs-lease: SUCCESS (0.000s) [46.825997] [003/130] (960s left) sw_sync (timeline_closed_signaled) [46.864888] Starting subtest: timeline_closed_signaled [46.865620] Subtest timeline_closed_signaled: SUCCESS (0.000s) [46.923228] [004/130] (960s left) syncobj_wait (single-wait-all-signaled) [46.963189] Starting subtest: single-wait-all-signaled [46.964481] Subtest single-wait-all-signaled: SUCCESS (0.000s) [47.035559] [005/130] (959s left) gem_exec_whisper (basic-contexts) [47.077620] Starting subtest: basic-contexts [48.441183] Subtest basic-contexts: SUCCESS (1.363s) [48.628745] [006/130] (958s left) kms_flip (basic-flip-vs-modeset) [48.723696] Starting subtest: basic-flip-vs-modeset [48.724615] Starting dynamic subtest: A-HDMI-A2 [49.942596] Dynamic subtest A-HDMI-A2: SUCCESS (1.220s) [49.951877] Starting dynamic subtest: B-HDMI-A2 [51.097853] Dynamic subtest B-HDMI-A2: SUCCESS (1.162s) [51.098908] Subtest basic-flip-vs-modeset: SUCCESS (2.386s) [51.259021] [007/130] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [51.364888] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [51.366306] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [51.439199] [008/130] (955s left) gem_exec_suspend (basic) [51.482806] Starting subtest: basic [51.483634] Starting dynamic subtest: smem [51.818832] Dynamic subtest smem: SUCCESS (0.338s) [51.819696] Subtest basic: SUCCESS (0.338s) [51.994942] [009/130] (955s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [52.096632] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [52.130221] [010/130] (954s left) kms_psr (fbc-psr2-basic) [52.216872] Subtest fbc-psr2-basic: SKIP (0.000s) [52.238610] [011/130] (954s left) kms_cursor_legacy (forked-move) [52.325212] Starting subtest: forked-move [52.326187] Starting dynamic subtest: pipe-A [57.714336] Dynamic subtest pipe-A: SUCCESS (5.408s) [57.718053] Starting dynamic subtest: pipe-B [63.106466] Dynamic subtest pipe-B: SUCCESS (5.402s) [63.110503] Starting dynamic subtest: all-pipes [68.501565] Dynamic subtest all-pipes: SUCCESS (5.400s) [68.502305] Subtest forked-move: SUCCESS (16.211s) [68.577329] [012/130] (938s left) gem_exec_reloc (basic-concurrent0) [68.618613] Subtest basic-concurrent0: SKIP (0.000s) [68.700349] [013/130] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [68.802216] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [68.804188] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [68.895827] [014/130] (938s left) perf_pmu (all-busy-check-all) [68.938182] Starting subtest: all-busy-check-all [69.483975] Subtest all-busy-check-all: SUCCESS (0.545s) [69.559394] [015/130] (937s left) dumb_buffer (map-valid) [69.590076] Starting subtest: map-valid [69.591304] Subtest map-valid: SUCCESS (0.000s) [69.676391] [016/130] (937s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [69.773985] Starting subtest: short-flip-before-cursor-toggle [70.810439] Subtest short-flip-before-cursor-toggle: SUCCESS (1.036s) [70.937150] [017/130] (936s left) kms_color (invalid-degamma-lut-sizes) [71.032904] Starting subtest: invalid-degamma-lut-sizes [71.033803] Starting dynamic subtest: pipe-A [71.071384] Dynamic subtest pipe-A: SUCCESS (0.038s) [71.077071] Starting dynamic subtest: pipe-B [71.077861] Dynamic subtest pipe-B: SUCCESS (0.001s) [71.078602] Subtest invalid-degamma-lut-sizes: SUCCESS (0.039s) [71.174154] [018/130] (935s left) gem_render_copy_redux (flink) [71.215643] Starting subtest: flink [71.771745] Subtest flink: SUCCESS (0.556s) [71.896170] [019/130] (935s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [71.982838] Starting subtest: nonblocking-crc-frame-sequence [71.983542] Starting dynamic subtest: pipe-A-HDMI-A-2 [72.628819] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.645s) [72.635270] Starting dynamic subtest: pipe-B-HDMI-A-2 [73.169872] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.539s) [73.170759] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.186s) [73.266158] [020/130] (933s left) syncobj_wait (wait-for-submit-snapshot) [73.293266] Starting subtest: wait-for-submit-snapshot [73.375581] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [73.456296] [021/130] (933s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [73.559258] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [75.843700] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.286s) [75.980472] [022/130] (931s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [76.064943] Starting subtest: fbcpsr-shrfb-scaledprimary [76.066409] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [76.155044] [023/130] (931s left) kms_chamelium_hpd (hdmi-hpd-fast) [76.284692] Subtest hdmi-hpd-fast: SKIP (0.000s) [76.341461] [024/130] (930s left) kms_flip (flip-vs-suspend-interruptible) [76.432340] Starting subtest: flip-vs-suspend-interruptible [76.434080] Starting dynamic subtest: A-HDMI-A2 [128.071164] Dynamic subtest A-HDMI-A2: SUCCESS (6.274s) [128.076252] Starting dynamic subtest: B-HDMI-A2 [179.159352] Dynamic subtest B-HDMI-A2: SUCCESS (5.987s) [179.160220] Subtest flip-vs-suspend-interruptible: SUCCESS (12.263s) [186.278581] [025/130] (918s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [186.375643] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [186.377739] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [186.459608] [026/130] (918s left) kms_properties (crtc-properties-legacy) [186.555144] Starting subtest: crtc-properties-legacy [186.556109] Starting dynamic subtest: pipe-A-HDMI-A-2 [186.799919] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.243s) [186.808506] Starting dynamic subtest: pipe-B-HDMI-A-2 [187.038918] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.238s) [187.039788] Subtest crtc-properties-legacy: SUCCESS (0.483s) [187.151123] [027/130] (917s left) kms_vblank (wait-busy) [187.242233] Starting subtest: wait-busy [187.243171] Starting dynamic subtest: pipe-A-HDMI-A-2 [189.980186] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.736s) [189.987521] Starting dynamic subtest: pipe-B-HDMI-A-2 [192.613158] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.644s) [192.613941] Subtest wait-busy: SUCCESS (5.383s) [192.757709] [028/130] (912s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [192.844164] Starting subtest: fbc-dirtyfb-ioctl [192.844962] Starting dynamic subtest: A-HDMI-A-2 [194.192380] Dynamic subtest A-HDMI-A-2: SUCCESS (1.354s) [194.193401] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.354s) [194.309651] [029/130] (910s left) kms_cursor_crc (cursor-onscreen-64x21) [194.410885] Starting subtest: cursor-onscreen-64x21 [194.413671] Starting dynamic subtest: pipe-A-HDMI-A-2 [196.882763] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.478s) [196.905752] Starting dynamic subtest: pipe-B-HDMI-A-2 [199.287009] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.392s) [199.287836] Subtest cursor-onscreen-64x21: SUCCESS (4.892s) [199.434933] [030/130] (905s left) fbdev (pan) [199.463185] Starting subtest: pan [199.518001] Subtest pan: SUCCESS (0.054s) [199.604287] [031/130] (905s left) kms_cursor_crc (cursor-random-max-size) [199.703414] Starting subtest: cursor-random-max-size [199.706361] Subtest cursor-random-max-size: SKIP (0.000s) [199.814554] [032/130] (905s left) gem_exec_reloc (basic-write-cpu) [199.843101] Subtest basic-write-cpu: SKIP (0.000s) [199.886690] [033/130] (905s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [199.998580] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [200.000070] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [200.097509] [034/130] (904s left) prime_mmap (test_reprime) [200.133354] Starting subtest: test_reprime [200.134118] Starting dynamic subtest: test_reprime-smem [200.162696] Dynamic subtest test_reprime-smem: SUCCESS (0.029s) [200.163477] Subtest test_reprime: SUCCESS (0.030s) [200.246704] [035/130] (904s left) gen3_render_linear_blits [200.298830] [036/130] (904s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [200.389991] Starting subtest: yf-tiled-8bpp-rotate-90 [200.391692] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [200.475631] [037/130] (904s left) kms_async_flips (test-time-stamp) [200.571256] Starting subtest: test-time-stamp [200.727755] Starting dynamic subtest: pipe-A-HDMI-A-2 [200.842001] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.112s) [201.014559] Starting dynamic subtest: pipe-B-HDMI-A-2 [201.108994] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.097s) [201.110639] Subtest test-time-stamp: SUCCESS (0.537s) [201.348642] [038/130] (903s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [201.375530] Starting subtest: invalid-multi-wait-unsubmitted-submitted [201.376279] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [201.463730] [039/130] (903s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [201.559044] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [201.559864] Starting dynamic subtest: pipe-A-HDMI-A-2 [201.578612] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [201.583161] Starting dynamic subtest: pipe-B-HDMI-A-2 [201.600383] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [201.601697] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.003s) [201.754358] [040/130] (903s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [201.843813] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [201.863469] [041/130] (903s left) gem_lmem_swapping (heavy-random) [201.897077] Subtest heavy-random: SKIP (0.000s) [201.919655] [042/130] (903s left) syncobj_basic (bad-pad-handle-to-fd) [201.954291] Starting subtest: bad-pad-handle-to-fd [201.955060] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [202.037524] [043/130] (903s left) kms_psr (fbc-psr-sprite-mmap-gtt) [202.134216] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [202.177337] [044/130] (902s left) gem_exec_reloc (basic-gtt-wc-active) [202.213974] Subtest basic-gtt-wc-active: SKIP (0.000s) [202.273374] [045/130] (902s left) syncobj_timeline (wait-for-submit-delayed-submit) [202.299638] Starting subtest: wait-for-submit-delayed-submit [202.401981] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [202.491781] [046/130] (902s left) kms_big_fb (y-tiled-8bpp-rotate-180) [202.581766] Starting subtest: y-tiled-8bpp-rotate-180 [203.864067] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.284s) [204.000773] [047/130] (901s left) gem_lmem_swapping (verify-random) [204.031056] Subtest verify-random: SKIP (0.000s) [204.071405] [048/130] (901s left) api_intel_bb (offset-control) [204.105189] Starting subtest: offset-control [204.106985] Subtest offset-control: SUCCESS (0.003s) [204.236366] [049/130] (900s left) gem_mmap_offset (ptrace) [204.261676] Starting subtest: ptrace [204.262596] Starting dynamic subtest: smem0-gtt [204.285863] Dynamic subtest smem0-gtt: SUCCESS (0.023s) [204.290499] Starting dynamic subtest: smem0-wb [204.298967] Dynamic subtest smem0-wb: SUCCESS (0.013s) [204.303557] Starting dynamic subtest: smem0-wc [204.313558] Dynamic subtest smem0-wc: SUCCESS (0.014s) [204.318153] Starting dynamic subtest: smem0-uc [204.328647] Dynamic subtest smem0-uc: SUCCESS (0.015s) [204.329446] Subtest ptrace: SUCCESS (0.067s) [204.464536] [050/130] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [204.554135] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [204.555554] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [204.664126] [051/130] (900s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [207.208998] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s) [207.271241] [052/130] (898s left) kms_sequence (get-forked) [207.360267] Starting subtest: get-forked [207.361177] Starting dynamic subtest: pipe-A-HDMI-A-2 [209.930489] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.572s) [209.940036] Starting dynamic subtest: pipe-B-HDMI-A-2 [212.467175] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.537s) [212.468120] Subtest get-forked: SUCCESS (5.112s) [212.584605] [053/130] (892s left) syncobj_timeline (etime-multi-wait-all-submitted) [212.639255] Starting subtest: etime-multi-wait-all-submitted [212.741008] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [212.822975] [054/130] (892s left) gen9_exec_parse (bb-start-out) [212.852379] Subtest bb-start-out: SKIP (0.000s) [212.892594] [055/130] (892s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [212.983204] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [212.983975] Starting dynamic subtest: pipe-A-valid-mode [213.033440] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s) [213.035468] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.049s) [213.138654] [056/130] (892s left) kms_flip (2x-modeset-vs-vblank-race) [213.224800] Starting subtest: 2x-modeset-vs-vblank-race [213.226478] Subtest 2x-modeset-vs-vblank-race: SKIP (0.001s) [213.302701] [057/130] (892s left) perf (sysctl-defaults) [213.418654] Starting subtest: sysctl-defaults [213.419330] Subtest sysctl-defaults: SUCCESS (0.000s) [213.441165] [058/130] (891s left) gem_exec_balancer (indices) [213.466955] Starting subtest: indices [214.124278] Subtest indices: SUCCESS (0.657s) [214.910343] [059/130] (890s left) gem_softpin (evict-single-offset) [214.937350] Starting subtest: evict-single-offset [238.005424] Subtest evict-single-offset: SUCCESS (23.068s) [238.069424] [060/130] (867s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [238.188952] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [241.378265] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.190s) [241.534416] [061/130] (863s left) prime_self_import (export-vs-gem_close-race) [241.562071] Starting subtest: export-vs-gem_close-race [246.599854] Subtest export-vs-gem_close-race: SUCCESS (5.037s) [246.686699] [062/130] (858s left) gem_exec_schedule (thriceslice) [246.768934] Starting subtest: thriceslice [246.769648] Starting dynamic subtest: rcs0 [246.770342] Dynamic subtest rcs0: SUCCESS (0.003s) [246.775507] Starting dynamic subtest: bcs0 [246.776268] Dynamic subtest bcs0: SUCCESS (0.002s) [246.781864] Starting dynamic subtest: vcs0 [246.782589] Dynamic subtest vcs0: SUCCESS (0.002s) [246.787578] Starting dynamic subtest: vecs0 [246.788357] Dynamic subtest vecs0: SUCCESS (0.002s) [246.789168] Subtest thriceslice: SUCCESS (0.011s) [247.081651] [063/130] (858s left) gem_exec_fair (basic-pace-solo) [247.124659] Starting subtest: basic-pace-solo [247.125319] Starting dynamic subtest: rcs0 [251.485173] Dynamic subtest rcs0: FAIL (4.347s) [251.485843] Subtest basic-pace-solo: FAIL (4.348s) [251.656008] [064/130] (853s left) kms_vblank (wait-forked-busy-hang) [251.748044] Starting subtest: wait-forked-busy-hang [251.748794] Starting dynamic subtest: pipe-A-HDMI-A-2 [278.242580] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (26.500s) [278.250691] Starting dynamic subtest: pipe-B-HDMI-A-2 [292.556996] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (14.314s) [292.558030] Subtest wait-forked-busy-hang: SUCCESS (40.818s) [292.715522] [065/130] (812s left) gem_softpin (noreloc-s3) [292.746716] Starting subtest: noreloc-S3 [313.388005] Subtest noreloc-S3: SUCCESS (5.405s) [314.517999] [066/130] (807s left) i915_suspend (basic-s3-without-i915) [314.548441] Starting subtest: basic-s3-without-i915 [335.647702] Subtest basic-s3-without-i915: SUCCESS (4.875s) [337.693288] [067/130] (802s left) prime_mmap_coherency (read) [337.735345] Starting subtest: read [343.114015] Subtest read: SUCCESS (5.377s) [343.237408] [068/130] (796s left) core_getclient [343.333006] [069/130] (796s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [343.356517] Starting subtest: multi-wait-for-submit-available-submitted [343.357327] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [343.433848] [070/130] (796s left) gem_exec_create (madvise) [343.470814] Starting subtest: madvise [343.471742] Starting dynamic subtest: smem [363.623352] Dynamic subtest smem: SUCCESS (20.154s) [363.624273] Subtest madvise: SUCCESS (20.154s) [365.194248] [071/130] (774s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [365.283453] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [365.284258] Starting dynamic subtest: pipe-A-HDMI-A-2 [365.291737] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [365.297132] Starting dynamic subtest: pipe-B-HDMI-A-2 [365.304350] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [365.305650] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s) [365.488696] [072/130] (774s left) kms_pm_rpm (cursor) [366.902076] Starting subtest: cursor [368.502182] Subtest cursor: SUCCESS (1.601s) [368.726572] [073/130] (771s left) gem_ctx_persistence (heartbeat-hostile) [368.755448] Starting subtest: heartbeat-hostile [369.971697] Subtest heartbeat-hostile: SUCCESS (1.216s) [370.045673] [074/130] (770s left) i915_query (query-regions-unallocated) [370.073243] Starting subtest: query-regions-unallocated [370.074034] Subtest query-regions-unallocated: SUCCESS (0.000s) [370.148148] [075/130] (770s left) prime_vgem (sync) [370.258789] Starting subtest: sync [370.260112] Starting dynamic subtest: rcs0 [370.298555] Dynamic subtest rcs0: SUCCESS (0.040s) [370.316579] Starting dynamic subtest: bcs0 [370.350470] Dynamic subtest bcs0: SUCCESS (0.051s) [370.372063] Starting dynamic subtest: vcs0 [370.380434] Dynamic subtest vcs0: SUCCESS (0.029s) [370.398227] Starting dynamic subtest: vecs0 [370.402849] Dynamic subtest vecs0: SUCCESS (0.022s) [370.404001] Subtest sync: SUCCESS (0.145s) [370.530556] [076/130] (769s left) kms_hdr (brightness-with-hdr) [370.621589] Starting subtest: brightness-with-hdr [370.623939] Subtest brightness-with-hdr: SKIP (0.000s) [370.697824] [077/130] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [370.792618] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [370.794458] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [370.881165] [078/130] (769s left) syncobj_wait (invalid-reset-one-illegal-handle) [370.910169] Starting subtest: invalid-reset-one-illegal-handle [370.911108] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [370.980835] [079/130] (769s left) gem_exec_parallel (fds) [371.014426] Starting subtest: fds [371.015227] Starting dynamic subtest: rcs0 [372.630909] Dynamic subtest rcs0: SUCCESS (1.616s) [372.637626] Starting dynamic subtest: bcs0 [374.220624] Dynamic subtest bcs0: SUCCESS (1.590s) [374.226746] Starting dynamic subtest: vcs0 [375.786211] Dynamic subtest vcs0: SUCCESS (1.566s) [375.792258] Starting dynamic subtest: vecs0 [377.335514] Dynamic subtest vecs0: SUCCESS (1.549s) [377.336425] Subtest fds: SUCCESS (6.323s) [377.535334] [080/130] (762s left) kms_psr (psr-cursor-plane-move) [377.634583] Subtest psr-cursor-plane-move: SKIP (0.000s) [377.654341] [081/130] (762s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [377.754009] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [377.755688] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [377.852064] [082/130] (762s left) gem_ctx_freq (sysfs) [377.883163] Starting subtest: sysfs [377.884021] Starting dynamic subtest: gt0 [382.964851] Dynamic subtest gt0: SUCCESS (5.082s) [382.966594] Subtest sysfs: SUCCESS (5.083s) [383.038845] [083/130] (757s left) kms_cursor_legacy (flip-vs-cursor-atomic) [383.124796] Starting subtest: flip-vs-cursor-atomic [391.310193] Subtest flip-vs-cursor-atomic: SUCCESS (8.184s) [391.417552] [084/130] (748s left) kms_pm_dc (dc5-dpms) [392.513084] Starting subtest: dc5-dpms [393.886328] Subtest dc5-dpms: SUCCESS (1.372s) [394.001212] [085/130] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [394.089819] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [394.091619] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [394.179841] [086/130] (746s left) kms_psr (pr-sprite-plane-move) [394.273104] Subtest pr-sprite-plane-move: SKIP (0.000s) [394.301037] [087/130] (746s left) syncobj_wait (multi-wait-submitted-signaled) [394.335273] Starting subtest: multi-wait-submitted-signaled [394.336052] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [394.415784] [088/130] (746s left) kms_psr (fbc-psr2-primary-page-flip) [394.507368] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [394.521634] [089/130] (745s left) perf_pmu (busy-accuracy-98) [394.552336] Starting subtest: busy-accuracy-98 [394.553022] Starting dynamic subtest: rcs0 [397.576594] Dynamic subtest rcs0: SUCCESS (3.023s) [397.587808] Starting dynamic subtest: bcs0 [400.604218] Dynamic subtest bcs0: SUCCESS (3.027s) [400.614072] Starting dynamic subtest: vcs0 [403.631292] Dynamic subtest vcs0: SUCCESS (3.027s) [403.641690] Starting dynamic subtest: vecs0 [406.658176] Dynamic subtest vecs0: SUCCESS (3.027s) [406.659771] Subtest busy-accuracy-98: SUCCESS (12.105s) [406.732392] [090/130] (733s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [406.819573] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [406.820531] Starting dynamic subtest: pipe-A [408.745452] Dynamic subtest pipe-A: SUCCESS (1.925s) [408.759738] Starting dynamic subtest: pipe-B [410.645605] Dynamic subtest pipe-B: SUCCESS (1.899s) [410.647132] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.826s) [410.815011] [091/130] (729s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [410.903315] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [412.202897] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.299s) [412.360744] [092/130] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [412.447907] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [412.449512] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [412.580750] [093/130] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [412.674732] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [412.676113] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [412.770291] [094/130] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [412.864496] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [412.865875] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [412.977360] [095/130] (727s left) kms_flip (blocking-wf_vblank) [413.064407] Starting subtest: blocking-wf_vblank [413.065115] Starting dynamic subtest: A-HDMI-A2 [428.756459] Dynamic subtest A-HDMI-A2: SUCCESS (15.694s) [428.765380] Starting dynamic subtest: B-HDMI-A2 [444.386121] Dynamic subtest B-HDMI-A2: SUCCESS (15.632s) [444.387282] Subtest blocking-wf_vblank: SUCCESS (31.330s) [444.519009] [096/130] (696s left) i915_pm_rpm (gem-execbuf-stress) [445.925382] Starting subtest: gem-execbuf-stress [445.927016] Starting dynamic subtest: smem0 [448.475033] Dynamic subtest smem0: SUCCESS (2.550s) [448.497261] Starting dynamic subtest: extra-wait-smem0 [500.995027] Dynamic subtest extra-wait-smem0: SUCCESS (52.513s) [500.996736] Subtest gem-execbuf-stress: SUCCESS (55.066s) [501.219775] [097/130] (639s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [501.306627] Starting subtest: bad-rotation-90-y-tiled-ccs [501.307404] Starting dynamic subtest: pipe-A-HDMI-A-2 [501.314712] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [501.321005] Starting dynamic subtest: pipe-B-HDMI-A-2 [501.328003] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [501.329394] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.001s) [501.489733] [098/130] (639s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [501.569555] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [501.570354] Starting dynamic subtest: pipe-A-HDMI-A-2 [502.602025] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.026s) [502.612463] Starting dynamic subtest: pipe-B-HDMI-A-2 [503.327527] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.722s) [503.329185] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (1.753s) [503.531471] [099/130] (637s left) gem_exec_fence (keep-in-fence) [503.676608] Starting subtest: keep-in-fence [503.678312] Starting dynamic subtest: rcs0 [503.744638] Dynamic subtest rcs0: SUCCESS (0.067s) [503.755740] Starting dynamic subtest: bcs0 [503.778633] Dynamic subtest bcs0: SUCCESS (0.033s) [503.790476] Starting dynamic subtest: vcs0 [503.810660] Dynamic subtest vcs0: SUCCESS (0.031s) [503.822464] Starting dynamic subtest: vecs0 [503.842619] Dynamic subtest vecs0: SUCCESS (0.030s) [503.844265] Subtest keep-in-fence: SUCCESS (0.167s) [504.279757] [100/130] (636s left) gem_userptr_blits (userfault) [504.311679] Starting subtest: userfault [504.312466] Subtest userfault: SUCCESS (0.003s) [504.441920] [101/130] (636s left) vgem_basic (dmabuf-fence-before) [504.481916] Starting subtest: dmabuf-fence-before [504.482764] Subtest dmabuf-fence-before: SUCCESS (0.000s) [504.553580] [102/130] (636s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [504.705017] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [504.760557] [103/130] (636s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [504.847099] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [504.848960] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.001s) [504.959109] [104/130] (635s left) prime_vgem (fence-read-hang) [505.040517] Subtest fence-read-hang: SKIP (0.000s) [505.167300] [105/130] (635s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [505.190326] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [505.191042] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [505.268381] [106/130] (635s left) gem_userptr_blits (map-fixed-invalidate) [505.303382] Starting subtest: map-fixed-invalidate [505.304219] Starting dynamic subtest: gtt [505.353417] Dynamic subtest gtt: SUCCESS (0.050s) [505.359687] Starting dynamic subtest: wb [505.382055] Dynamic subtest wb: SUCCESS (0.028s) [505.388280] Starting dynamic subtest: wc [505.413025] Dynamic subtest wc: SUCCESS (0.030s) [505.419465] Starting dynamic subtest: uc [505.442940] Dynamic subtest uc: SUCCESS (0.029s) [505.443667] Subtest map-fixed-invalidate: SUCCESS (0.140s) [505.564094] [107/130] (635s left) kms_busy (extended-modeset-hang-oldfb) [505.650746] Starting subtest: extended-modeset-hang-oldfb [505.651631] Starting dynamic subtest: pipe-A [516.150854] Dynamic subtest pipe-A: SUCCESS (10.500s) [516.157524] Starting dynamic subtest: pipe-B [526.859863] Dynamic subtest pipe-B: SUCCESS (10.709s) [526.860905] Subtest extended-modeset-hang-oldfb: SUCCESS (21.211s) [527.035672] [108/130] (613s left) gem_ctx_shared (q-in-order) [527.064786] Starting subtest: Q-in-order [527.065769] Starting dynamic subtest: rcs0 [527.105980] Dynamic subtest rcs0: SUCCESS (0.041s) [527.116042] Starting dynamic subtest: bcs0 [527.149048] Dynamic subtest bcs0: SUCCESS (0.042s) [527.161709] Starting dynamic subtest: vcs0 [527.194223] Dynamic subtest vcs0: SUCCESS (0.044s) [527.207533] Starting dynamic subtest: vecs0 [527.240433] Dynamic subtest vecs0: SUCCESS (0.045s) [527.241961] Subtest Q-in-order: SUCCESS (0.176s) [527.435175] [109/130] (613s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [527.520502] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [527.521886] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [527.643149] [110/130] (613s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [527.736355] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [527.781018] [111/130] (613s left) perf (unprivileged-single-ctx-counters) [527.886977] Starting subtest: unprivileged-single-ctx-counters [527.888697] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [527.902001] [112/130] (613s left) syncobj_timeline (invalid-signal-illegal-point) [527.926533] Starting subtest: invalid-signal-illegal-point [527.927530] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [527.999936] [113/130] (613s left) gem_mmap_offset (isolation) [528.025345] Starting subtest: isolation [528.033348] Subtest isolation: SUCCESS (0.003s) [528.137969] [114/130] (612s left) gem_render_copy (yf-tiled-to-vebox-linear) [528.181051] Starting subtest: yf-tiled-to-vebox-linear [528.181982] Starting dynamic subtest: smem [528.243800] Dynamic subtest smem: SUCCESS (0.063s) [528.244609] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.063s) [528.440715] [115/130] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [528.527031] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [528.528412] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [528.638031] [116/130] (612s left) gem_exec_params (invalid-bsd2-flag-on-blt) [528.671811] Starting subtest: invalid-bsd2-flag-on-blt [528.672549] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [528.761791] [117/130] (612s left) gem_exec_schedule (pi-shared-iova) [528.920935] Starting subtest: pi-shared-iova [528.922503] Starting dynamic subtest: rcs0 [528.942061] Dynamic subtest rcs0: SUCCESS (0.021s) [528.948530] Starting dynamic subtest: bcs0 [528.953066] Dynamic subtest bcs0: SUCCESS (0.011s) [528.959524] Starting dynamic subtest: vcs0 [528.964294] Dynamic subtest vcs0: SUCCESS (0.011s) [528.970771] Starting dynamic subtest: vecs0 [528.975802] Dynamic subtest vecs0: SUCCESS (0.011s) [528.976532] Subtest pi-shared-iova: SUCCESS (0.056s) [529.160999] [118/130] (611s left) api_intel_bb (intel-bb-blit-none) [529.192002] Starting subtest: intel-bb-blit-none [532.272317] Subtest intel-bb-blit-none: SUCCESS (3.082s) [532.374055] [119/130] (608s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render) [532.458935] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render [534.400630] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (1.944s) [534.557179] [120/130] (606s left) kms_chamelium_color (ctm-green-to-red) [534.650404] Subtest ctm-green-to-red: SKIP (0.000s) [534.675643] [121/130] (606s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [534.767010] Starting subtest: fbc-rgb565-draw-mmap-gtt [537.016767] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (2.251s) [537.166754] [122/130] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [537.252690] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [537.254095] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [537.355871] [123/130] (603s left) gem_exec_balancer (bonded-dual) [537.385698] Starting subtest: bonded-dual [537.999828] Subtest bonded-dual: SUCCESS (0.614s) [538.803576] [124/130] (602s left) drm_fdinfo (all-busy-check-all) [538.832568] Starting subtest: all-busy-check-all [539.380608] Subtest all-busy-check-all: SUCCESS (0.547s) [539.460468] [125/130] (601s left) kms_plane (plane-panning-top-left) [539.543544] Starting subtest: plane-panning-top-left [539.544387] Starting dynamic subtest: pipe-A [540.079613] Dynamic subtest pipe-A: SUCCESS (0.533s) [540.090869] Starting dynamic subtest: pipe-B [540.498446] Dynamic subtest pipe-B: SUCCESS (0.417s) [540.499264] Subtest plane-panning-top-left: SUCCESS (0.954s) [540.632722] [126/130] (600s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [540.719761] Starting subtest: psr-rgb101010-draw-mmap-wc [540.721294] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s) [540.823433] [127/130] (600s left) prime_busy (before) [540.854400] Starting subtest: before [540.856820] Starting dynamic subtest: rcs0 [540.891483] Dynamic subtest rcs0: SUCCESS (0.034s) [540.902455] Starting dynamic subtest: bcs0 [540.939926] Dynamic subtest bcs0: SUCCESS (0.047s) [540.958721] Starting dynamic subtest: vcs0 [540.959497] Dynamic subtest vcs0: SUCCESS (0.019s) [540.966405] Starting dynamic subtest: vecs0 [540.978173] Dynamic subtest vecs0: SUCCESS (0.018s) [541.085287] Subtest before: SUCCESS (0.231s) [541.164523] [128/130] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [541.256060] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [541.258296] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [541.354790] [129/130] (600s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [541.440416] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [541.441903] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [541.552875] [130/130] (599s left) i915_getparams_basic (basic-eu-total) [541.584592] Starting subtest: basic-eu-total [541.586126] Subtest basic-eu-total: SUCCESS (0.000s) [541.675127] Closing watchdogs Done.