[37.791206] Initializing watchdogs [37.791235] /dev/watchdog0 [37.797822] [001/130] (960s left) kms_psr (pr-sprite-mmap-cpu) [37.891872] Starting subtest: pr-sprite-mmap-cpu [37.896399] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [37.938693] [002/130] (960s left) gem_ctx_engines (invalid-engines) [37.997177] Starting subtest: invalid-engines [38.056668] Subtest invalid-engines: FAIL (0.023s) [38.179433] [003/130] (960s left) syncobj_basic (create-signaled) [38.226561] Starting subtest: create-signaled [38.229152] Subtest create-signaled: SUCCESS (0.000s) [38.291765] [004/130] (960s left) gem_userptr_blits (unsync-unmap-after-close) [38.346727] Subtest unsync-unmap-after-close: SKIP (0.000s) [38.431834] [005/130] (959s left) gem_mmap_gtt (cpuset-big-copy) [38.469870] Subtest cpuset-big-copy: SKIP (0.000s) [38.505894] [006/130] (959s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [38.579439] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [38.581410] Starting dynamic subtest: pipe-A-eDP-1 [38.601035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [38.608592] Starting dynamic subtest: pipe-B-eDP-1 [38.626357] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [38.630740] Starting dynamic subtest: pipe-C-eDP-1 [38.648658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [38.653063] Starting dynamic subtest: pipe-D-eDP-1 [38.671522] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [38.674958] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.002s) [40.906985] [007/130] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [41.007267] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [41.011379] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [41.075205] [008/130] (957s left) gem_exec_fence (keep-in-fence) [41.237349] Starting subtest: keep-in-fence [41.240211] Starting dynamic subtest: rcs0 [41.314651] Dynamic subtest rcs0: SUCCESS (0.079s) [41.322663] Starting dynamic subtest: bcs0 [41.371406] Dynamic subtest bcs0: SUCCESS (0.056s) [41.379171] Starting dynamic subtest: vcs0 [43.375743] Dynamic subtest vcs0: SUCCESS (2.004s) [43.383433] Starting dynamic subtest: vcs1 [45.356207] Dynamic subtest vcs1: SUCCESS (1.980s) [45.365362] Starting dynamic subtest: vecs0 [47.339325] Dynamic subtest vecs0: SUCCESS (1.983s) [47.348850] Starting dynamic subtest: ccs0 [47.541135] Dynamic subtest ccs0: SUCCESS (0.202s) [47.543730] Subtest keep-in-fence: SUCCESS (6.305s) [49.448309] [009/130] (948s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [51.522379] Starting subtest: modeset-non-lpsp-stress-no-wait [51.588407] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.063s) [51.875344] [010/130] (946s left) gem_exec_reloc (basic-write-cpu-active) [51.930224] Subtest basic-write-cpu-active: SKIP (0.000s) [51.974977] [011/130] (946s left) kms_prop_blob (invalid-get-prop) [52.026302] Starting subtest: invalid-get-prop [52.028391] Subtest invalid-get-prop: SUCCESS (0.000s) [52.091866] [012/130] (946s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [52.186833] Starting subtest: fbc-modesetfrombusy [55.089325] Subtest fbc-modesetfrombusy: SUCCESS (2.855s) [55.181802] [013/130] (943s left) prime_mmap_coherency (read) [55.231593] Starting subtest: read [60.662932] Subtest read: SUCCESS (5.374s) [60.773359] [014/130] (937s left) gen9_exec_parse (basic-rejected-ctx-param) [60.827537] Subtest basic-rejected-ctx-param: SKIP (0.000s) [60.874583] [015/130] (937s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [60.925154] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [60.927620] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [60.977963] [016/130] (937s left) i915_hangman (engine-engine-hang) [61.023837] Starting subtest: engine-engine-hang [61.025681] Starting dynamic subtest: rcs0 [62.346353] Dynamic subtest rcs0: SUCCESS (1.314s) [62.352517] Starting dynamic subtest: bcs0 [64.330283] Dynamic subtest bcs0: SUCCESS (1.973s) [64.338974] Starting dynamic subtest: vcs0 [66.312869] Dynamic subtest vcs0: SUCCESS (1.975s) [66.321683] Starting dynamic subtest: vcs1 [68.360884] Dynamic subtest vcs1: SUCCESS (2.042s) [68.369795] Starting dynamic subtest: vecs0 [70.344744] Dynamic subtest vecs0: SUCCESS (1.979s) [70.351309] Starting dynamic subtest: ccs0 [72.328703] Dynamic subtest ccs0: SUCCESS (1.980s) [72.331465] Subtest engine-engine-hang: SUCCESS (11.264s) [72.380851] [017/130] (926s left) gem_mmap_wc (write-read-distinct) [72.430931] Subtest write-read-distinct: SKIP (0.000s) [72.467797] [018/130] (926s left) perf_pmu (init-busy) [72.497398] Starting subtest: init-busy [72.499739] Starting dynamic subtest: rcs0 [72.502156] Dynamic subtest rcs0: SUCCESS (0.002s) [72.509495] Starting dynamic subtest: bcs0 [72.511418] Dynamic subtest bcs0: SUCCESS (0.000s) [72.516584] Starting dynamic subtest: vcs0 [72.518489] Dynamic subtest vcs0: SUCCESS (0.001s) [72.523522] Starting dynamic subtest: vcs1 [72.525453] Dynamic subtest vcs1: SUCCESS (0.001s) [72.530443] Starting dynamic subtest: vecs0 [72.532402] Dynamic subtest vecs0: SUCCESS (0.000s) [72.537373] Starting dynamic subtest: ccs0 [72.539307] Dynamic subtest ccs0: SUCCESS (0.000s) [72.541264] Subtest init-busy: SUCCESS (0.004s) [72.597752] [019/130] (926s left) gem_exec_reloc (basic-write-wc-active) [72.651388] Subtest basic-write-wc-active: SKIP (0.000s) [72.695909] [020/130] (926s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [72.789741] Starting subtest: bad-pixel-format-yf-tiled-ccs [72.791920] Starting dynamic subtest: pipe-A-eDP-1 [72.814115] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [72.821551] Starting dynamic subtest: pipe-B-eDP-1 [72.842628] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [72.848914] Starting dynamic subtest: pipe-C-eDP-1 [72.870153] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [72.876177] Starting dynamic subtest: pipe-D-eDP-1 [72.898217] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [72.902343] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.002s) [75.148359] [021/130] (923s left) kms_dp_linktrain_fallback (dp-fallback) [75.242786] Starting subtest: dp-fallback [75.249844] Subtest dp-fallback: SKIP (0.000s) [75.291313] [022/130] (923s left) gem_userptr_blits (coherency-sync) [75.347202] Starting subtest: coherency-sync [75.595708] Subtest coherency-sync: SKIP (0.225s) [75.670367] [023/130] (923s left) kms_color (ctm-green-to-red) [75.808067] Starting subtest: ctm-green-to-red [75.810360] Starting dynamic subtest: pipe-A-eDP-1 [76.462239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.650s) [76.469903] Starting dynamic subtest: pipe-B-eDP-1 [77.851392] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s) [77.860382] Starting dynamic subtest: pipe-C-eDP-1 [79.213637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s) [79.220601] Starting dynamic subtest: pipe-D-eDP-1 [80.568340] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s) [80.570553] Subtest ctm-green-to-red: SUCCESS (4.755s) [81.485622] [024/130] (917s left) kms_psr (fbc-pr-primary-page-flip) [81.579860] Starting subtest: fbc-pr-primary-page-flip [81.584346] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [81.626680] [025/130] (917s left) syncobj_wait (wait-for-submit-snapshot) [81.678745] Starting subtest: wait-for-submit-snapshot [81.761092] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [81.812882] [026/130] (917s left) kms_psr (psr-primary-page-flip) [81.899844] Starting subtest: psr-primary-page-flip [81.902141] Starting dynamic subtest: eDP-1 [83.716063] Dynamic subtest eDP-1: SUCCESS (1.810s) [83.718672] Subtest psr-primary-page-flip: SUCCESS (1.811s) [84.619774] [027/130] (914s left) kms_vrr (flip-basic) [84.703790] Starting subtest: flip-basic [84.710713] Subtest flip-basic: SKIP (0.000s) [84.750570] [028/130] (914s left) gem_eio (create) [84.945743] Starting subtest: create [85.215811] Subtest create: SUCCESS (0.269s) [85.328548] [029/130] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [85.428025] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [85.432165] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [85.512902] [030/130] (913s left) kms_async_flips (test-time-stamp) [85.592418] Starting subtest: test-time-stamp [85.955360] Starting dynamic subtest: pipe-A-eDP-1 [86.803498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s) [87.150092] Starting dynamic subtest: pipe-B-eDP-1 [88.011861] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.863s) [88.370073] Starting dynamic subtest: pipe-C-eDP-1 [89.228498] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.860s) [89.575649] Starting dynamic subtest: pipe-D-eDP-1 [90.447339] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.875s) [90.449942] Subtest test-time-stamp: SUCCESS (4.849s) [91.661326] [031/130] (907s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [91.753184] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [91.755790] Starting dynamic subtest: pipe-A-default-mode [92.043175] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [92.048375] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.284s) [92.940907] [032/130] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [93.040832] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [93.045261] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [93.108953] [033/130] (905s left) kms_cursor_crc (cursor-onscreen-32x32) [93.225108] Starting subtest: cursor-onscreen-32x32 [93.258773] Subtest cursor-onscreen-32x32: SKIP (0.030s) [93.488815] [034/130] (905s left) kms_rotation_crc (bad-pixel-format) [93.581771] Starting subtest: bad-pixel-format [93.586266] Subtest bad-pixel-format: SKIP (0.001s) [93.629617] [035/130] (905s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [93.678142] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s) [93.715408] [036/130] (905s left) gem_exec_fence (syncobj-timeline-chain-engines) [94.201622] Starting subtest: syncobj-timeline-chain-engines [94.300469] Subtest syncobj-timeline-chain-engines: SUCCESS (0.100s) [95.488320] [037/130] (903s left) gem_exec_reloc (basic-wc) [95.544451] Subtest basic-wc: SKIP (0.000s) [95.607474] [038/130] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [95.697323] Starting subtest: fbc-1p-primscrn-spr-indfb-move [98.962029] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.267s) [99.100140] [039/130] (900s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [99.147661] Starting subtest: yf-tiled-to-vebox-y-tiled [99.152111] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [99.305088] [040/130] (899s left) gem_exec_fair (basic-none) [99.375515] Subtest basic-none: SKIP (0.000s) [99.415102] [041/130] (899s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [99.521053] Starting subtest: cursorB-vs-flipB-legacy [99.525588] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [99.607147] [042/130] (899s left) perf (non-zero-reason) [99.745939] Starting subtest: non-zero-reason [99.748580] Starting dynamic subtest: 0-rcs0 [105.535325] Dynamic subtest 0-rcs0: SUCCESS (5.788s) [105.544388] Starting dynamic subtest: 1-vecs0 [109.616049] Dynamic subtest 1-vecs0: SUCCESS (4.080s) [109.619188] Subtest non-zero-reason: SUCCESS (9.868s) [109.640121] [043/130] (889s left) kms_cursor_crc (cursor-offscreen-128x42) [109.826539] Starting subtest: cursor-offscreen-128x42 [109.863992] Subtest cursor-offscreen-128x42: SKIP (0.031s) [110.009639] [044/130] (889s left) kms_chamelium_hpd (dp-hpd-fast) [110.389284] Subtest dp-hpd-fast: SKIP (0.000s) [111.225727] [045/130] (887s left) gem_exec_balancer (nop) [111.266316] Starting subtest: nop [157.608189] Subtest nop: SUCCESS (46.337s) [157.836384] [046/130] (841s left) vgem_basic (mmap) [157.870873] Starting subtest: mmap [157.882773] Subtest mmap: SUCCESS (0.014s) [157.915730] [047/130] (841s left) kms_properties (invalid-properties-atomic) [158.012654] Starting subtest: invalid-properties-atomic [158.237044] Subtest invalid-properties-atomic: SUCCESS (0.222s) [158.287920] [048/130] (840s left) kms_flip (2x-flip-vs-fences) [158.374850] Starting subtest: 2x-flip-vs-fences [158.379145] Subtest 2x-flip-vs-fences: SKIP (0.000s) [158.433717] [049/130] (840s left) gem_mmap_offset (close-race) [158.482739] Starting subtest: close-race [178.557186] Subtest close-race: SUCCESS (20.075s) [178.626344] [050/130] (820s left) kms_getfb (getfb2-handle-not-fb) [178.677344] Starting subtest: getfb2-handle-not-fb [178.719765] Subtest getfb2-handle-not-fb: SUCCESS (0.045s) [178.813018] [051/130] (820s left) kms_cursor_crc (cursor-suspend) [178.915881] Starting subtest: cursor-suspend [178.918196] Starting dynamic subtest: pipe-A-eDP-1 [211.187712] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.879s) [211.197258] Starting dynamic subtest: pipe-D-eDP-1 [244.170751] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.337s) [244.173183] Subtest cursor-suspend: SUCCESS (6.218s) [245.039760] [052/130] (813s left) kms_addfb_basic (unused-handle) [245.099005] Starting subtest: unused-handle [245.101945] Subtest unused-handle: SUCCESS (0.000s) [245.221313] [053/130] (813s left) gem_eio (wait-wedge-1us) [245.444300] Starting subtest: wait-wedge-1us [247.410095] Subtest wait-wedge-1us: SUCCESS (1.912s) [247.524070] [054/130] (810s left) debugfs_test (read_all_entries_display_on) [247.612286] Starting subtest: read_all_entries_display_on [247.903564] Subtest read_all_entries_display_on: SUCCESS (0.284s) [248.017557] [055/130] (810s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [248.129120] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [248.134445] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [248.217535] [056/130] (810s left) kms_psr (psr-cursor-plane-onoff) [248.299357] Starting subtest: psr-cursor-plane-onoff [248.301823] Starting dynamic subtest: eDP-1 [250.106249] Dynamic subtest eDP-1: SUCCESS (1.772s) [250.109480] Subtest psr-cursor-plane-onoff: SUCCESS (1.773s) [251.022539] [057/130] (807s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [251.120793] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [253.652738] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.505s) [253.767725] [058/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [253.859295] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [253.863245] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [253.936016] [059/130] (804s left) gem_mmap_gtt (basic-small-bo-tiledy) [253.983233] Subtest basic-small-bo-tiledY: SKIP (0.000s) [254.022277] [060/130] (804s left) syncobj_timeline (multi-wait-available-submitted-signaled) [254.069429] Starting subtest: multi-wait-available-submitted-signaled [254.071343] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [254.127287] [061/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [254.211801] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [254.215574] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [254.281851] [062/130] (804s left) kms_lease (lease-invalid-connector) [254.365821] Starting subtest: lease-invalid-connector [254.367828] Starting dynamic subtest: pipe-A-eDP-1 [254.369749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [254.377550] Starting dynamic subtest: pipe-B-eDP-1 [254.379243] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [254.385718] Starting dynamic subtest: pipe-C-eDP-1 [254.387677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [254.394460] Starting dynamic subtest: pipe-D-eDP-1 [254.396183] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [254.397979] Subtest lease-invalid-connector: SUCCESS (0.002s) [254.416980] [063/130] (804s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [254.508761] Starting subtest: basic-max-pipe-crc-check [254.512695] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [254.532171] [064/130] (804s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [254.630764] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [260.497496] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.830s) [260.588101] [065/130] (798s left) prime_mmap (test_errors) [260.646158] Starting subtest: test_errors [260.648299] Starting dynamic subtest: test_errors-smem [260.718357] Dynamic subtest test_errors-smem: SUCCESS (0.073s) [260.721239] Subtest test_errors: SUCCESS (0.074s) [260.789197] [066/130] (798s left) api_intel_bb (blit-noreloc-keep-cache) [260.828855] Starting subtest: blit-noreloc-keep-cache [260.836658] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s) [260.924341] [067/130] (797s left) gem_basic (create-fd-close) [260.975917] Starting subtest: create-fd-close [260.980760] Subtest create-fd-close: SUCCESS (0.000s) [261.047073] [068/130] (797s left) gem_exec_alignment (single) [261.096448] Starting subtest: single [261.100945] Subtest single: SUCCESS (0.002s) [261.164770] [069/130] (797s left) kms_getfb (getfb-handle-protection) [261.214818] Starting subtest: getfb-handle-protection [261.233726] Subtest getfb-handle-protection: SUCCESS (0.020s) [261.309433] [070/130] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [261.402603] Starting subtest: psr-2p-scndscrn-spr-indfb-move [261.406967] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [261.487455] [071/130] (797s left) kms_universal_plane (cursor-fb-leak) [261.575759] Starting subtest: cursor-fb-leak [261.577783] Starting dynamic subtest: pipe-A-eDP-1 [261.868519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [261.877612] Starting dynamic subtest: pipe-B-eDP-1 [263.272782] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s) [263.282091] Starting dynamic subtest: pipe-C-eDP-1 [264.667414] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s) [264.676732] Starting dynamic subtest: pipe-D-eDP-1 [266.069761] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.395s) [266.072278] Subtest cursor-fb-leak: SUCCESS (4.477s) [267.269640] [072/130] (791s left) intel_hwmon (hwmon-write) [267.324911] Subtest hwmon-write: SKIP (0.000s) [267.365555] [073/130] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [267.465744] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [267.469746] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [267.534847] [074/130] (791s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [272.662702] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [272.665825] Starting dynamic subtest: pipe-A-eDP-1 [284.755286] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.094s) [284.763136] Starting dynamic subtest: pipe-B-eDP-1 [296.845051] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.088s) [296.847913] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.185s) [297.735861] [075/130] (761s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [297.824697] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [302.080596] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.258s) [302.206747] [076/130] (756s left) prime_vgem (fence-read-hang) [302.276314] Subtest fence-read-hang: SKIP (0.000s) [302.347289] [077/130] (756s left) gem_tiled_pread_pwrite [302.435880] [078/130] (756s left) kms_plane (plane-position-hole-dpms) [302.524213] Starting subtest: plane-position-hole-dpms [303.001118] Starting dynamic subtest: pipe-A-plane-1 [305.498784] Dynamic subtest pipe-A-plane-1: SUCCESS (2.494s) [305.506206] Starting dynamic subtest: pipe-A-plane-2 [307.990839] Dynamic subtest pipe-A-plane-2: SUCCESS (2.492s) [307.999964] Starting dynamic subtest: pipe-A-plane-3 [310.479734] Dynamic subtest pipe-A-plane-3: SUCCESS (2.485s) [310.488935] Starting dynamic subtest: pipe-A-plane-4 [312.911277] Dynamic subtest pipe-A-plane-4: SUCCESS (2.432s) [312.920029] Starting dynamic subtest: pipe-A-plane-5 [312.931935] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [314.161804] Starting dynamic subtest: pipe-B-plane-1 [316.622447] Dynamic subtest pipe-B-plane-1: SUCCESS (2.465s) [316.630424] Starting dynamic subtest: pipe-B-plane-2 [319.125272] Dynamic subtest pipe-B-plane-2: SUCCESS (2.503s) [319.132489] Starting dynamic subtest: pipe-B-plane-3 [321.626614] Dynamic subtest pipe-B-plane-3: SUCCESS (2.498s) [321.634699] Starting dynamic subtest: pipe-B-plane-4 [324.109820] Dynamic subtest pipe-B-plane-4: SUCCESS (2.483s) [324.117812] Starting dynamic subtest: pipe-B-plane-5 [324.130569] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s) [324.132864] Subtest plane-position-hole-dpms: SUCCESS (21.600s) [324.998125] [079/130] (734s left) gem_partial_pwrite_pread (reads-uncached) [325.050779] Subtest reads-uncached: SKIP (0.000s) [325.091634] [080/130] (733s left) kms_psr (fbc-psr2-primary-render) [325.181327] Starting subtest: fbc-psr2-primary-render [325.183668] Starting dynamic subtest: eDP-1 [325.187854] Dynamic subtest eDP-1: SKIP (0.000s) [325.192012] Subtest fbc-psr2-primary-render: SKIP (0.001s) [325.232253] [081/130] (733s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [325.319260] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [325.321910] Starting dynamic subtest: pipe-A-eDP-1 [325.345035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [325.353523] Starting dynamic subtest: pipe-B-eDP-1 [325.375518] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [325.383629] Starting dynamic subtest: pipe-C-eDP-1 [325.405766] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [325.413214] Starting dynamic subtest: pipe-D-eDP-1 [325.435787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [325.439914] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [327.687225] [082/130] (731s left) syncobj_timeline (invalid-signal-illegal-handle) [327.734752] Starting subtest: invalid-signal-illegal-handle [327.736788] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [327.801116] [083/130] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [327.893693] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [332.875297] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.983s) [332.968546] [084/130] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [333.058109] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [333.062384] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [333.123154] [085/130] (726s left) gem_ctx_param (vm) [333.166647] Starting subtest: vm [333.207460] Subtest vm: SUCCESS (0.040s) [333.321579] [086/130] (725s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [333.408384] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [333.410746] Starting dynamic subtest: pipe-A-eDP-1 [333.437212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [333.446244] Starting dynamic subtest: pipe-B-eDP-1 [333.470193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [333.477817] Starting dynamic subtest: pipe-C-eDP-1 [333.502523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [333.510973] Starting dynamic subtest: pipe-D-eDP-1 [333.535556] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [333.540023] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s) [335.754667] [087/130] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [335.851133] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [335.855895] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [335.937844] [088/130] (723s left) gem_mmap_wc (write-read) [335.979594] Subtest write-read: SKIP (0.000s) [336.014981] [089/130] (723s left) gem_reg_read (bad-register) [336.077054] Starting subtest: bad-register [336.079357] Subtest bad-register: SUCCESS (0.000s) [336.142143] [090/130] (723s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [336.233563] Starting subtest: yf-tiled-64bpp-rotate-180 [336.238051] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [336.300075] [091/130] (722s left) kms_cursor_legacy (cursor-vs-flip-toggle) [336.406978] Starting subtest: cursor-vs-flip-toggle [365.717527] Subtest cursor-vs-flip-toggle: SUCCESS (29.314s) [366.599990] [092/130] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [366.696493] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [366.700952] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [366.762772] [093/130] (692s left) drm_fdinfo (virtual-busy-hang-all) [366.794780] Starting subtest: virtual-busy-hang-all [366.799792] Subtest virtual-busy-hang-all: SKIP (0.000s) [366.843241] [094/130] (692s left) gem_userptr_blits (set-cache-level) [366.899024] Starting subtest: set-cache-level [366.904018] Subtest set-cache-level: SKIP (0.000s) [366.989555] [095/130] (692s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [367.035652] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [367.144584] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s) [367.200729] [096/130] (692s left) gem_render_copy_redux (flink) [367.241033] Starting subtest: flink [368.028481] Subtest flink: SUCCESS (0.788s) [368.135270] [097/130] (691s left) gem_ctx_persistence (legacy-engines-mixed) [368.184651] Starting subtest: legacy-engines-mixed [368.186872] Starting dynamic subtest: render [368.274929] Dynamic subtest render: SUCCESS (0.091s) [368.283784] Starting dynamic subtest: bsd1 [368.342061] Dynamic subtest bsd1: SUCCESS (0.066s) [368.349728] Starting dynamic subtest: bsd2 [368.403539] Dynamic subtest bsd2: SUCCESS (0.060s) [368.411358] Starting dynamic subtest: blt [368.463950] Dynamic subtest blt: SUCCESS (0.058s) [368.472249] Starting dynamic subtest: vebox [368.533153] Dynamic subtest vebox: SUCCESS (0.067s) [368.535580] Subtest legacy-engines-mixed: SUCCESS (0.350s) [368.590059] [098/130] (690s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [368.680801] Starting subtest: missing-ccs-buffer-y-tiled-ccs [368.682730] Starting dynamic subtest: pipe-A-eDP-1 [368.701330] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [368.709552] Starting dynamic subtest: pipe-B-eDP-1 [368.726872] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [368.733310] Starting dynamic subtest: pipe-C-eDP-1 [368.750525] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [368.756647] Starting dynamic subtest: pipe-D-eDP-1 [368.774852] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [368.778452] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [371.016865] [099/130] (688s left) kms_flip (basic-plain-flip) [371.109445] Starting subtest: basic-plain-flip [371.111471] Starting dynamic subtest: A-eDP1 [372.856666] Dynamic subtest A-eDP1: SUCCESS (1.744s) [372.865152] Starting dynamic subtest: B-eDP1 [374.583773] Dynamic subtest B-eDP1: SUCCESS (1.726s) [374.593339] Starting dynamic subtest: C-eDP1 [376.300348] Dynamic subtest C-eDP1: SUCCESS (1.715s) [376.309792] Starting dynamic subtest: D-eDP1 [378.027896] Dynamic subtest D-eDP1: SUCCESS (1.727s) [378.033613] Subtest basic-plain-flip: SUCCESS (6.923s) [379.270996] [100/130] (680s left) gem_exec_schedule (timeslicing) [379.338530] Starting subtest: timeslicing [379.340376] Starting dynamic subtest: rcs0 [379.345196] Dynamic subtest rcs0: SUCCESS (0.020s) [379.352216] Starting dynamic subtest: bcs0 [379.365198] Dynamic subtest bcs0: SUCCESS (0.020s) [379.371952] Starting dynamic subtest: vcs0 [379.384997] Dynamic subtest vcs0: SUCCESS (0.020s) [379.391673] Starting dynamic subtest: vcs1 [379.404022] Dynamic subtest vcs1: SUCCESS (0.019s) [379.410826] Starting dynamic subtest: vecs0 [379.423589] Dynamic subtest vecs0: SUCCESS (0.019s) [379.430288] Starting dynamic subtest: ccs0 [379.447290] Dynamic subtest ccs0: SUCCESS (0.023s) [379.449777] Subtest timeslicing: SUCCESS (0.122s) [381.297672] [101/130] (678s left) gem_softpin (allocator-nopin) [381.352180] Starting subtest: allocator-nopin [381.425067] Subtest allocator-nopin: SUCCESS (0.073s) [381.533766] [102/130] (677s left) kms_big_fb (linear-8bpp-rotate-270) [381.630983] Starting subtest: linear-8bpp-rotate-270 [381.650092] Subtest linear-8bpp-rotate-270: SKIP (0.019s) [381.753023] [103/130] (677s left) syncobj_timeline (signal-array) [381.807061] Starting subtest: signal-array [381.809014] Subtest signal-array: SUCCESS (0.000s) [381.873456] [104/130] (677s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [381.923661] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [382.032761] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [382.087113] [105/130] (677s left) kms_pm_dc (dc6-psr) [383.182397] Starting subtest: dc6-psr [383.205957] Subtest dc6-psr: SKIP (0.024s) [383.283871] [106/130] (676s left) perf (oa-exponents) [383.362435] Starting subtest: oa-exponents [383.365061] Starting dynamic subtest: 0-rcs0 [385.135682] Dynamic subtest 0-rcs0: SUCCESS (1.771s) [385.142679] Starting dynamic subtest: 1-vcs0 [386.938196] Dynamic subtest 1-vcs0: SUCCESS (1.802s) [386.940440] Subtest oa-exponents: SUCCESS (3.574s) [386.960682] [107/130] (672s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [387.056649] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [387.703687] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s) [387.816315] [108/130] (671s left) gem_exec_whisper (basic-contexts-forked-all) [387.862433] Starting subtest: basic-contexts-forked-all [408.329344] Subtest basic-contexts-forked-all: SUCCESS (20.459s) [408.486936] [109/130] (651s left) kms_flip (plain-flip-ts-check) [408.575580] Starting subtest: plain-flip-ts-check [408.578035] Starting dynamic subtest: A-eDP1 [417.550877] Dynamic subtest A-eDP1: SUCCESS (8.972s) [417.559066] Starting dynamic subtest: B-eDP1 [426.511563] Dynamic subtest B-eDP1: SUCCESS (8.958s) [426.519831] Starting dynamic subtest: C-eDP1 [435.459703] Dynamic subtest C-eDP1: SUCCESS (8.944s) [435.470415] Starting dynamic subtest: D-eDP1 [444.420336] Dynamic subtest D-eDP1: SUCCESS (8.957s) [444.425568] Subtest plain-flip-ts-check: SUCCESS (35.842s) [445.641086] [110/130] (613s left) kms_hdmi_inject (inject-audio) [445.977067] Starting subtest: inject-audio [446.228204] Subtest inject-audio: SUCCESS (0.251s) [446.877233] [111/130] (612s left) kms_flip (2x-flip-vs-suspend) [446.976345] Starting subtest: 2x-flip-vs-suspend [446.990877] Subtest 2x-flip-vs-suspend: SKIP (0.014s) [447.048317] [112/130] (612s left) gem_exec_schedule (out-order) [447.124966] Starting subtest: out-order [447.127614] Starting dynamic subtest: rcs0 [447.211080] Dynamic subtest rcs0: SUCCESS (0.094s) [447.222496] Starting dynamic subtest: vcs0 [447.284353] Dynamic subtest vcs0: SUCCESS (0.074s) [447.297501] Starting dynamic subtest: vcs1 [447.355863] Dynamic subtest vcs1: SUCCESS (0.071s) [447.366890] Starting dynamic subtest: vecs0 [447.424404] Dynamic subtest vecs0: SUCCESS (0.068s) [447.436176] Starting dynamic subtest: ccs0 [447.504024] Dynamic subtest ccs0: SUCCESS (0.079s) [447.507087] Subtest out-order: SUCCESS (0.387s) [448.375473] [113/130] (611s left) vgem_basic (bad-handle) [448.414492] Starting subtest: bad-handle [448.416681] Subtest bad-handle: SUCCESS (0.000s) [448.449592] [114/130] (611s left) gem_ctx_param (set-priority-range) [448.492547] Starting subtest: set-priority-range [448.504027] Subtest set-priority-range: SUCCESS (0.010s) [448.586739] [115/130] (611s left) i915_pm_rps (thresholds-idle-park) [448.637201] Starting subtest: thresholds-idle-park [448.641605] Subtest thresholds-idle-park: SKIP (0.000s) [448.696256] [116/130] (610s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [448.783409] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [448.788284] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [448.846637] [117/130] (610s left) i915_pm_rc6_residency (media-rc6-accuracy) [448.891081] Starting subtest: media-rc6-accuracy [448.896534] Subtest media-rc6-accuracy: SKIP (0.000s) [448.959898] [118/130] (610s left) gem_exec_whisper (basic-queues-priority-all) [449.012132] Starting subtest: basic-queues-priority-all [470.576032] Subtest basic-queues-priority-all: SUCCESS (21.559s) [470.733626] [119/130] (588s left) kms_pm_backlight (bad-brightness) [470.810262] Starting subtest: bad-brightness [470.863732] Starting dynamic subtest: eDP-1 [471.168882] Dynamic subtest eDP-1: SUCCESS (0.305s) [471.171410] Subtest bad-brightness: SUCCESS (0.358s) [472.071810] [120/130] (587s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [472.170416] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [473.001392] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.832s) [473.102026] [121/130] (586s left) gem_pxp (create-regular-context-2) [475.675597] Subtest create-regular-context-2: SKIP (0.000s) [475.729778] [122/130] (584s left) core_setmaster (master-drop-set-root) [476.443839] Starting subtest: master-drop-set-root [476.451857] Subtest master-drop-set-root: SUCCESS (0.006s) [476.476671] [123/130] (583s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [476.573785] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [476.578146] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [476.638353] [124/130] (583s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [476.718807] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [476.721116] Starting dynamic subtest: pipe-A [477.961640] Dynamic subtest pipe-A: SUCCESS (1.243s) [477.970099] Starting dynamic subtest: pipe-B [480.293083] Dynamic subtest pipe-B: SUCCESS (2.332s) [480.303210] Starting dynamic subtest: pipe-C [481.541755] Dynamic subtest pipe-C: SUCCESS (1.248s) [481.550408] Starting dynamic subtest: pipe-D [482.758900] Dynamic subtest pipe-D: SUCCESS (1.217s) [482.761203] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.042s) [483.974706] [125/130] (575s left) kms_psr (fbc-psr-dpms) [484.056422] Starting subtest: fbc-psr-dpms [484.058947] Starting dynamic subtest: eDP-1 [484.063660] Dynamic subtest eDP-1: SKIP (0.000s) [484.068304] Subtest fbc-psr-dpms: SKIP (0.001s) [484.105186] [126/130] (575s left) perf_pmu (frequency) [484.139141] Starting subtest: frequency [484.141226] Starting dynamic subtest: gt0 [486.224128] Dynamic subtest gt0: SUCCESS (2.078s) [486.233547] Starting dynamic subtest: idle-gt0 [486.747975] Dynamic subtest idle-gt0: SUCCESS (0.523s) [486.756342] Starting dynamic subtest: gt1 [491.311298] Dynamic subtest gt1: SUCCESS (4.561s) [491.321514] Starting dynamic subtest: idle-gt1 [491.814484] Dynamic subtest idle-gt1: SUCCESS (0.504s) [491.817074] Subtest frequency: SUCCESS (7.677s) [491.891479] [127/130] (567s left) gem_barrier_race (remote-request) [491.951116] Starting subtest: remote-request [491.953444] Starting dynamic subtest: rcs0 [497.003094] Dynamic subtest rcs0: SUCCESS (5.059s) [497.004890] Subtest remote-request: SUCCESS (5.060s) [497.131157] [128/130] (562s left) gem_tiled_partial_pwrite_pread (writes) [497.182543] Subtest writes: SKIP (0.000s) [497.223650] [129/130] (562s left) kms_chamelium_edid (vga-edid-read) [497.606767] Subtest vga-edid-read: SKIP (0.000s) [498.484026] [130/130] (561s left) gem_render_copy (yf-tiled) [498.545414] Starting subtest: yf-tiled [498.550429] Subtest yf-tiled: SKIP (0.000s) [498.702551] Closing watchdogs Done.