[55.215099] Initializing watchdogs [55.215152] /dev/watchdog0 [55.223848] [001/130] (960s left) api_intel_allocator (reopen-fork) [55.289399] Starting subtest: reopen-fork [58.628663] Subtest reopen-fork: SUCCESS (3.286s) [58.683341] [002/130] (957s left) gem_wait (invalid-buf) [58.751363] Starting subtest: invalid-buf [58.753745] Subtest invalid-buf: SUCCESS (0.000s) [58.984882] [003/130] (956s left) gem_mmap (basic-small-bo) [59.045328] Subtest basic-small-bo: SKIP (0.000s) [59.085744] [004/130] (956s left) kms_getfb (getfb2-handle-zero) [59.141190] Starting subtest: getfb2-handle-zero [59.143681] Subtest getfb2-handle-zero: SUCCESS (0.000s) [59.236189] [005/130] (956s left) kms_pm_rpm (universal-planes-dpms) [61.099464] Starting subtest: universal-planes-dpms [61.102996] Starting dynamic subtest: plane-32 [69.388602] Dynamic subtest plane-32: SUCCESS (8.243s) [69.398065] Starting dynamic subtest: plane-41 [78.001686] Dynamic subtest plane-41: SUCCESS (8.598s) [78.010711] Starting dynamic subtest: plane-50 [86.663998] Dynamic subtest plane-50: SUCCESS (8.654s) [86.673718] Starting dynamic subtest: plane-59 [94.953071] Dynamic subtest plane-59: SUCCESS (8.286s) [94.962054] Starting dynamic subtest: plane-68 [103.259940] Dynamic subtest plane-68: SUCCESS (8.303s) [103.268956] Starting dynamic subtest: plane-77 [111.840674] Dynamic subtest plane-77: SUCCESS (8.579s) [111.843190] Subtest universal-planes-dpms: SUCCESS (50.666s) [112.177182] [006/130] (903s left) gem_exec_params (invalid-bsd-ring) [112.236719] Starting subtest: invalid-bsd-ring [112.238795] Subtest invalid-bsd-ring: SUCCESS (0.000s) [112.318394] [007/130] (903s left) gem_exec_balancer (parallel-contexts) [112.575755] Starting subtest: parallel-contexts [114.915102] Subtest parallel-contexts: SUCCESS (2.321s) [115.977300] [008/130] (900s left) syncobj_wait (multi-wait-signaled) [116.027565] Starting subtest: multi-wait-signaled [116.029707] Subtest multi-wait-signaled: SUCCESS (0.000s) [116.092908] [009/130] (899s left) gem_create (create-clear) [116.158444] Starting subtest: create-clear [116.161394] Starting dynamic subtest: smem0 [148.925696] Dynamic subtest smem0: SUCCESS (32.760s) [148.927633] Subtest create-clear: SUCCESS (32.761s) [149.093122] [010/130] (866s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [154.129536] Starting subtest: psr2-cursor-plane-move-continuous-sf [154.135094] Starting dynamic subtest: pipe-A-eDP-1 [165.226443] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.092s) [165.235088] Starting dynamic subtest: pipe-B-eDP-1 [176.243606] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.015s) [176.246052] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.112s) [177.014878] [011/130] (839s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [177.115947] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [177.118303] Starting dynamic subtest: pipe-A-eDP-1 [177.143448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [177.151507] Starting dynamic subtest: pipe-B-eDP-1 [177.175873] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [177.182454] Starting dynamic subtest: pipe-C-eDP-1 [177.207085] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [177.213391] Starting dynamic subtest: pipe-D-eDP-1 [177.237643] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [177.242146] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.002s) [179.263260] [012/130] (836s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [179.370491] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [184.450413] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.083s) [184.576401] [013/130] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [184.696292] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [184.701016] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [184.781237] [014/130] (831s left) kms_cursor_crc (cursor-rapid-movement-256x85) [184.995027] Starting subtest: cursor-rapid-movement-256x85 [185.035166] Subtest cursor-rapid-movement-256x85: SKIP (0.035s) [185.181341] [015/130] (830s left) kms_async_flips (test-time-stamp-atomic) [185.282121] Starting subtest: test-time-stamp-atomic [185.665144] Starting dynamic subtest: pipe-A-eDP-1 [186.430153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s) [186.793659] Starting dynamic subtest: pipe-B-eDP-1 [187.554485] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s) [187.917130] Starting dynamic subtest: pipe-C-eDP-1 [188.674656] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s) [189.036516] Starting dynamic subtest: pipe-D-eDP-1 [189.805756] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s) [189.808314] Subtest test-time-stamp-atomic: SUCCESS (4.521s) [190.934825] [016/130] (825s left) gem_userptr_blits (stress-purge) [190.999636] Starting subtest: stress-purge [196.386549] Subtest stress-purge: SUCCESS (5.387s) [196.518278] [017/130] (819s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [196.662685] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [196.664713] Starting dynamic subtest: pipe-A-default-mode [196.952733] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [196.957503] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.285s) [197.761752] [018/130] (818s left) gem_render_copy (y-tiled) [197.821274] Starting subtest: y-tiled [197.826217] Subtest y-tiled: SKIP (0.000s) [197.988833] [019/130] (818s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [198.088550] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [200.769271] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.685s) [200.897066] [020/130] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [200.999248] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [201.002977] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [201.082450] [021/130] (815s left) kms_flip (dpms-off-confusion-interruptible) [201.180995] Starting subtest: dpms-off-confusion-interruptible [201.185144] Starting dynamic subtest: A-eDP1 [209.807046] Dynamic subtest A-eDP1: SUCCESS (8.623s) [209.815422] Starting dynamic subtest: B-eDP1 [218.428291] Dynamic subtest B-eDP1: SUCCESS (8.621s) [218.435754] Starting dynamic subtest: C-eDP1 [227.040325] Dynamic subtest C-eDP1: SUCCESS (8.611s) [227.049493] Starting dynamic subtest: D-eDP1 [235.669449] Dynamic subtest D-eDP1: SUCCESS (8.628s) [235.673936] Subtest dpms-off-confusion-interruptible: SUCCESS (34.491s) [236.817148] [022/130] (779s left) gem_ctx_shared (create-shared-gtt) [236.880420] Starting subtest: create-shared-gtt [239.033883] Subtest create-shared-gtt: SUCCESS (2.152s) [239.850679] [023/130] (776s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation) [239.951113] Starting subtest: plane-downscale-factor-0-25-with-rotation [239.953429] Starting dynamic subtest: pipe-A [239.968295] Dynamic subtest pipe-A: SKIP (0.011s) [239.976076] Starting dynamic subtest: pipe-B [239.988424] Dynamic subtest pipe-B: SKIP (0.021s) [239.995794] Starting dynamic subtest: pipe-C [240.013143] Dynamic subtest pipe-C: SKIP (0.022s) [240.020329] Starting dynamic subtest: pipe-D [240.035383] Dynamic subtest pipe-D: SKIP (0.021s) [240.039862] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.077s) [240.095049] [024/130] (776s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [240.217064] Starting subtest: flip-vs-cursor-busy-crc-atomic [241.048841] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.830s) [241.836730] [025/130] (774s left) kms_big_fb (x-tiled-64bpp-rotate-180) [241.947405] Starting subtest: x-tiled-64bpp-rotate-180 [243.490092] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.544s) [243.649610] [026/130] (772s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [243.745363] Starting subtest: fbc-psr2-cursor-mmap-cpu [243.747720] Starting dynamic subtest: eDP-1 [243.751900] Dynamic subtest eDP-1: SKIP (0.000s) [243.756105] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [243.798542] [027/130] (772s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [243.866784] Starting subtest: invalid-multi-wait-unsubmitted-signaled [243.869316] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [243.934754] [028/130] (772s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [246.070930] Starting subtest: dpms-mode-unset-non-lpsp [247.217974] Subtest dpms-mode-unset-non-lpsp: SKIP (1.145s) [247.550915] [029/130] (768s left) gem_exec_fence (syncobj-timeline-invalid-flags) [248.144356] Starting subtest: syncobj-timeline-invalid-flags [248.147135] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [249.988555] [030/130] (766s left) gem_pwrite (basic-exhaustion) [250.040173] Subtest basic-exhaustion: SKIP (0.000s) [250.077161] [031/130] (766s left) perf_pmu (busy) [250.113994] Starting subtest: busy [250.116374] Starting dynamic subtest: rcs0 [250.744328] Dynamic subtest rcs0: SUCCESS (0.630s) [250.755271] Starting dynamic subtest: bcs0 [251.314460] Dynamic subtest bcs0: SUCCESS (0.569s) [251.325507] Starting dynamic subtest: vcs0 [252.909630] Dynamic subtest vcs0: SUCCESS (1.592s) [252.918812] Starting dynamic subtest: vcs1 [254.955693] Dynamic subtest vcs1: SUCCESS (2.045s) [254.966630] Starting dynamic subtest: vecs0 [256.940209] Dynamic subtest vecs0: SUCCESS (1.983s) [256.950941] Starting dynamic subtest: ccs0 [257.505652] Dynamic subtest ccs0: SUCCESS (0.566s) [257.508970] Subtest busy: SUCCESS (7.392s) [257.577770] [032/130] (758s left) i915_pm_freq_api (freq-suspend) [257.641742] Starting subtest: freq-suspend [257.644045] Starting dynamic subtest: gt0 [273.105508] Dynamic subtest gt0: SUCCESS (1.230s) [273.117603] Starting dynamic subtest: gt1 [289.042715] Dynamic subtest gt1: SUCCESS (1.113s) [289.045375] Subtest freq-suspend: SUCCESS (2.344s) [290.109909] [033/130] (756s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [290.213511] Starting subtest: primary-yf-tiled-reflect-x-270 [290.219074] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [290.269028] [034/130] (756s left) kms_psr (psr-sprite-plane-onoff) [290.369530] Starting subtest: psr-sprite-plane-onoff [290.372395] Starting dynamic subtest: eDP-1 [292.171449] Dynamic subtest eDP-1: SUCCESS (1.753s) [292.174400] Subtest psr-sprite-plane-onoff: SUCCESS (1.754s) [293.003353] [035/130] (753s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [293.091264] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [293.094020] Starting dynamic subtest: pipe-A-eDP-1 [293.118797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [293.128576] Starting dynamic subtest: pipe-B-eDP-1 [293.152645] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [293.161980] Starting dynamic subtest: pipe-C-eDP-1 [293.187630] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [293.196912] Starting dynamic subtest: pipe-D-eDP-1 [293.220652] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [293.226286] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [295.305474] [036/130] (751s left) kms_properties (invalid-properties-legacy) [295.411313] Starting subtest: invalid-properties-legacy [295.521765] Subtest invalid-properties-legacy: SUCCESS (0.107s) [295.576021] [037/130] (751s left) fbdev (info) [295.612072] Starting subtest: info [295.614488] Subtest info: SUCCESS (0.000s) [295.654024] [038/130] (751s left) kms_cursor_edge_walk (128x128-top-bottom) [295.753395] Starting subtest: 128x128-top-bottom [295.756051] Starting dynamic subtest: pipe-A-eDP-1 [299.232143] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s) [299.242739] Starting dynamic subtest: pipe-D-eDP-1 [302.353467] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.095s) [302.356145] Subtest 128x128-top-bottom: SUCCESS (6.533s) [303.163890] [039/130] (743s left) gem_ctx_param (invalid-size-get) [303.224433] Starting subtest: invalid-size-get [303.227257] Subtest invalid-size-get: SUCCESS (0.002s) [303.307093] [040/130] (743s left) gem_softpin (softpin) [303.375262] Starting subtest: softpin [335.771038] Subtest softpin: SUCCESS (32.349s) [335.888086] [041/130] (711s left) gem_media_fill (media-fill) [335.961744] Subtest media-fill: SKIP (0.000s) [336.049235] [042/130] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [336.166654] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [336.171724] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [336.258138] [043/130] (710s left) syncobj_wait (single-wait-for-submit-unsubmitted) [336.325274] Starting subtest: single-wait-for-submit-unsubmitted [336.429916] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s) [336.488486] [044/130] (710s left) kms_content_protection (dp-mst-type-0) [336.640658] Starting subtest: dp-mst-type-0 [336.646518] Subtest dp-mst-type-0: SKIP (0.000s) [336.754100] [045/130] (710s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [336.886325] Starting subtest: short-flip-after-cursor-atomic-transitions [337.833950] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.947s) [338.625944] [046/130] (708s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [338.731318] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [338.733728] Starting dynamic subtest: pipe-A-default-mode [339.018946] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [339.024480] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.283s) [339.850210] [047/130] (707s left) kms_big_fb (y-tiled-16bpp-rotate-180) [339.972625] Starting subtest: y-tiled-16bpp-rotate-180 [339.977765] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [340.068943] [048/130] (707s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [340.174321] Starting subtest: psr-rgb101010-draw-mmap-wc [344.946642] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.777s) [345.040410] [049/130] (702s left) i915_pm_rpm (gem-execbuf-stress) [347.072433] Starting subtest: gem-execbuf-stress [347.075477] Starting dynamic subtest: smem0 [359.880924] Dynamic subtest smem0: SUCCESS (12.803s) [359.893466] Starting dynamic subtest: extra-wait-smem0 [421.995647] Dynamic subtest extra-wait-smem0: SUCCESS (62.106s) [421.998466] Subtest gem-execbuf-stress: SUCCESS (74.915s) [422.338520] [050/130] (624s left) sw_sync (sync_merge_same) [422.380055] Starting subtest: sync_merge_same [422.383394] Subtest sync_merge_same: SUCCESS (0.000s) [422.416856] [051/130] (624s left) gem_sync (basic-store-each) [422.501567] Starting subtest: basic-store-each [424.806417] Subtest basic-store-each: SUCCESS (2.317s) [424.975098] [052/130] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [425.090536] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [425.095643] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [425.183163] [053/130] (622s left) kms_plane_scaling (planes-downscale-factor-0-5) [425.276970] Starting subtest: planes-downscale-factor-0-5 [425.279345] Starting dynamic subtest: pipe-A [425.289231] Dynamic subtest pipe-A: SKIP (0.005s) [425.299017] Starting dynamic subtest: pipe-B [425.309559] Dynamic subtest pipe-B: SKIP (0.018s) [425.318725] Starting dynamic subtest: pipe-C [425.328844] Dynamic subtest pipe-C: SKIP (0.016s) [425.340210] Starting dynamic subtest: pipe-D [425.349337] Dynamic subtest pipe-D: SKIP (0.016s) [425.354290] Subtest planes-downscale-factor-0-5: SKIP (0.056s) [425.432144] [054/130] (621s left) perf (gen12-group-concurrent-oa-buffer-read) [425.567242] Starting subtest: gen12-group-concurrent-oa-buffer-read [435.609500] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.039s) [435.641853] [055/130] (611s left) gem_mmap (short-mmap) [435.709377] Subtest short-mmap: SKIP (0.000s) [435.752022] [056/130] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [435.864416] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [440.506509] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.646s) [440.615192] [057/130] (606s left) kms_big_fb (linear-16bpp-rotate-270) [440.727254] Starting subtest: linear-16bpp-rotate-270 [440.746109] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [440.851607] [058/130] (606s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [440.949382] Starting subtest: fbc-psr2-sprite-mmap-gtt [440.952063] Starting dynamic subtest: eDP-1 [440.957299] Dynamic subtest eDP-1: SKIP (0.000s) [440.961970] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s) [441.005316] [059/130] (606s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [441.095574] Starting subtest: bad-aux-stride-y-tiled-ccs [441.098346] Starting dynamic subtest: pipe-A-eDP-1 [441.126139] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [441.136501] Starting dynamic subtest: pipe-B-eDP-1 [441.162953] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [441.171968] Starting dynamic subtest: pipe-C-eDP-1 [441.198248] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [441.206724] Starting dynamic subtest: pipe-D-eDP-1 [441.232553] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [441.237641] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s) [443.235015] [060/130] (604s left) kms_flip (flip-vs-suspend-interruptible) [443.342704] Starting subtest: flip-vs-suspend-interruptible [443.345450] Starting dynamic subtest: A-eDP1 [492.053835] Dynamic subtest A-eDP1: SUCCESS (4.296s) [492.068515] Starting dynamic subtest: B-eDP1 [541.058326] Dynamic subtest B-eDP1: SUCCESS (4.269s) [541.074175] Starting dynamic subtest: C-eDP1 [590.059766] Dynamic subtest C-eDP1: SUCCESS (4.205s) [590.076009] Starting dynamic subtest: D-eDP1 [639.074574] Dynamic subtest D-eDP1: SUCCESS (4.246s) [639.079132] Subtest flip-vs-suspend-interruptible: SUCCESS (17.027s) [640.297354] [061/130] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [640.404687] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [640.408910] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [640.477594] [062/130] (585s left) gem_pxp (reject-modify-context-protection-on) [640.607467] Starting subtest: reject-modify-context-protection-on [640.609962] Subtest reject-modify-context-protection-on: SUCCESS (0.001s) [641.717872] [063/130] (584s left) gem_softpin (allocator-nopin) [641.788977] Starting subtest: allocator-nopin [641.861743] Subtest allocator-nopin: SUCCESS (0.070s) [641.969077] [064/130] (584s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [642.027828] Starting subtest: single-wait-all-for-submit-available-signaled [642.030303] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [642.111671] [065/130] (584s left) kms_addfb_basic (unused-offsets) [642.169716] Starting subtest: unused-offsets [642.172216] Subtest unused-offsets: SUCCESS (0.000s) [642.299024] [066/130] (583s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [642.405187] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [642.409742] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [643.499159] [067/130] (582s left) gem_mmap_gtt (basic-read-write) [643.577116] Subtest basic-read-write: SKIP (0.000s) [643.613904] [068/130] (582s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [643.671555] Starting subtest: multi-wait-available-unsubmitted-signaled [643.673955] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [643.743786] [069/130] (582s left) kms_chamelium_hpd (dp-hpd-after-suspend) [644.138349] Subtest dp-hpd-after-suspend: SKIP (0.000s) [644.926260] [070/130] (581s left) gem_eio (create-ext) [645.181112] Starting subtest: create-ext [645.542477] Subtest create-ext: SUCCESS (0.355s) [645.687698] [071/130] (580s left) gem_exec_whisper (basic-queues-forked-all) [645.762157] Starting subtest: basic-queues-forked-all [666.769642] Subtest basic-queues-forked-all: SUCCESS (20.885s) [666.934697] [072/130] (559s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [666.996655] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [667.105349] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [667.164992] [073/130] (559s left) api_intel_bb (misplaced-blitter) [667.223973] Starting subtest: misplaced-blitter [667.236579] Subtest misplaced-blitter: SUCCESS (0.015s) [667.350670] [074/130] (559s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [667.476013] Starting subtest: cursorB-vs-flipA-atomic [667.480783] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [667.570384] [075/130] (559s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [672.545398] Starting subtest: pr-overlay-plane-update-sf-dmg-area [672.550139] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s) [673.385640] [076/130] (553s left) perf_pmu (invalid-open) [673.429693] Starting subtest: invalid-open [673.432094] Subtest invalid-open: SUCCESS (0.000s) [673.508584] [077/130] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [673.617950] Starting subtest: fbcpsr-1p-rte [678.478193] Subtest fbcpsr-1p-rte: SUCCESS (4.869s) [678.606778] [078/130] (548s left) gem_mmap_offset (clear-via-pagefault) [678.677508] Starting subtest: clear-via-pagefault [678.679765] Starting dynamic subtest: smem0 [711.708474] Dynamic subtest smem0: SUCCESS (33.017s) [711.711081] Subtest clear-via-pagefault: SUCCESS (33.019s) [711.798435] [079/130] (514s left) kms_invalid_mode (bad-vsync-start) [711.907174] Starting subtest: bad-vsync-start [711.909480] Starting dynamic subtest: pipe-A-eDP-1 [712.191464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [712.207542] Starting dynamic subtest: pipe-B-eDP-1 [712.209661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [712.222069] Starting dynamic subtest: pipe-C-eDP-1 [712.224770] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [712.241286] Starting dynamic subtest: pipe-D-eDP-1 [712.243719] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [712.245746] Subtest bad-vsync-start: SUCCESS (0.288s) [713.023026] [080/130] (513s left) gem_readwrite (write-bad-handle) [713.085939] Subtest write-bad-handle: SKIP (0.000s) [713.128961] [081/130] (513s left) gem_userptr_blits (input-checking) [713.190242] Starting subtest: input-checking [713.192624] Subtest input-checking: SUCCESS (0.000s) [713.310125] [082/130] (513s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [713.413436] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [718.663424] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.250s) [718.779348] [083/130] (508s left) gem_exec_fence (basic-busy) [718.950136] Starting subtest: basic-busy [718.952765] Starting dynamic subtest: rcs0 [719.042388] Dynamic subtest rcs0: SUCCESS (0.092s) [719.054716] Starting dynamic subtest: bcs0 [719.101136] Dynamic subtest bcs0: SUCCESS (0.057s) [719.112670] Starting dynamic subtest: vcs0 [719.154341] Dynamic subtest vcs0: SUCCESS (0.051s) [719.165444] Starting dynamic subtest: vcs1 [719.210048] Dynamic subtest vcs1: SUCCESS (0.054s) [719.221059] Starting dynamic subtest: vecs0 [719.271280] Dynamic subtest vecs0: SUCCESS (0.060s) [719.282473] Starting dynamic subtest: ccs0 [719.336441] Dynamic subtest ccs0: SUCCESS (0.063s) [719.338876] Subtest basic-busy: SUCCESS (0.387s) [721.664752] [084/130] (505s left) gem_softpin (evict-single-offset) [721.728490] Starting subtest: evict-single-offset [747.558366] Subtest evict-single-offset: SUCCESS (25.827s) [747.618414] [085/130] (479s left) gem_busy (parallel) [747.843711] Starting subtest: parallel [747.846335] Starting dynamic subtest: rcs0 [749.542773] Dynamic subtest rcs0: SUCCESS (1.697s) [749.556139] Starting dynamic subtest: bcs0 [751.526625] Dynamic subtest bcs0: SUCCESS (1.982s) [751.540170] Starting dynamic subtest: vcs0 [753.510918] Dynamic subtest vcs0: SUCCESS (1.982s) [753.522621] Starting dynamic subtest: vcs1 [755.558390] Dynamic subtest vcs1: SUCCESS (2.045s) [755.571820] Starting dynamic subtest: vecs0 [757.542238] Dynamic subtest vecs0: SUCCESS (1.982s) [757.555145] Starting dynamic subtest: ccs0 [759.526816] Dynamic subtest ccs0: SUCCESS (1.983s) [759.529932] Subtest parallel: SUCCESS (11.684s) [759.724051] [086/130] (467s left) syncobj_timeline (wait-all-delayed-signal) [759.794406] Starting subtest: wait-all-delayed-signal [759.897967] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [759.955452] [087/130] (466s left) kms_universal_plane (cursor-fb-leak) [760.067065] Starting subtest: cursor-fb-leak [760.069442] Starting dynamic subtest: pipe-A-eDP-1 [760.382451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.314s) [760.393096] Starting dynamic subtest: pipe-B-eDP-1 [761.672329] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s) [761.682721] Starting dynamic subtest: pipe-C-eDP-1 [762.999752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.326s) [763.010092] Starting dynamic subtest: pipe-D-eDP-1 [764.322152] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s) [764.324751] Subtest cursor-fb-leak: SUCCESS (4.255s) [765.462093] [088/130] (461s left) gem_reg_read (timestamp-monotonic) [765.528820] Starting subtest: timestamp-monotonic [769.558479] Subtest timestamp-monotonic: SUCCESS (4.030s) [769.615586] [089/130] (457s left) kms_flip (2x-flip-vs-panning) [769.725050] Starting subtest: 2x-flip-vs-panning [769.736365] Subtest 2x-flip-vs-panning: SKIP (0.011s) [769.798439] [090/130] (457s left) kms_psr (pr-sprite-mmap-gtt) [769.890030] Starting subtest: pr-sprite-mmap-gtt [769.894475] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [769.946535] [091/130] (457s left) perf (non-system-wide-paranoid) [770.059345] Starting subtest: non-system-wide-paranoid [770.089073] Subtest non-system-wide-paranoid: SUCCESS (0.030s) [770.110470] [092/130] (456s left) kms_vblank (ts-continuation-idle) [770.197033] Starting subtest: ts-continuation-idle [770.199297] Starting dynamic subtest: pipe-A-eDP-1 [770.596756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s) [770.612841] Starting dynamic subtest: pipe-D-eDP-1 [771.662079] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.063s) [771.664518] Subtest ts-continuation-idle: SUCCESS (1.464s) [772.512715] [093/130] (454s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [772.615115] Starting subtest: modeset-transition-nonblocking-fencing [772.617038] Starting dynamic subtest: 1x-outputs [783.139246] Dynamic subtest 1x-outputs: SUCCESS (10.524s) [783.405552] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.788s) [784.241469] [094/130] (442s left) kms_plane_alpha_blend (constant-alpha-min) [784.339965] Starting subtest: constant-alpha-min [784.636941] Starting dynamic subtest: pipe-A-eDP-1 [785.339625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s) [785.351973] Starting dynamic subtest: pipe-D-eDP-1 [786.820459] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s) [786.822643] Subtest constant-alpha-min: SUCCESS (2.479s) [787.603226] [095/130] (439s left) kms_psr (psr2-sprite-render) [787.710978] Starting subtest: psr2-sprite-render [787.713178] Starting dynamic subtest: eDP-1 [789.397219] Dynamic subtest eDP-1: SUCCESS (1.685s) [789.399653] Subtest psr2-sprite-render: SUCCESS (1.686s) [790.243740] [096/130] (436s left) intel_hwmon (hwmon-read) [790.309073] Subtest hwmon-read: SKIP (0.000s) [790.356307] [097/130] (436s left) perf (low-oa-exponent-permissions) [790.443306] Starting subtest: low-oa-exponent-permissions [790.479563] Subtest low-oa-exponent-permissions: SUCCESS (0.036s) [790.502557] [098/130] (436s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [790.604058] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [790.606261] Starting dynamic subtest: pipe-A-eDP-1 [790.615286] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [790.625740] Starting dynamic subtest: pipe-B-eDP-1 [790.634496] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [790.644014] Starting dynamic subtest: pipe-C-eDP-1 [790.652622] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [790.662215] Starting dynamic subtest: pipe-D-eDP-1 [790.670867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [790.675072] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [792.798102] [099/130] (434s left) kms_flip (2x-plain-flip-ts-check-interruptible) [792.901532] Starting subtest: 2x-plain-flip-ts-check-interruptible [792.914217] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [792.991136] [100/130] (434s left) gem_ctx_param (invalid-param-get) [793.058387] Starting subtest: invalid-param-get [793.060754] Subtest invalid-param-get: SUCCESS (0.001s) [793.160062] [101/130] (434s left) gem_exec_parallel (fds) [793.229763] Starting subtest: fds [793.232296] Starting dynamic subtest: rcs0 [795.836223] Dynamic subtest rcs0: SUCCESS (2.603s) [795.848675] Starting dynamic subtest: bcs0 [799.660501] Dynamic subtest bcs0: SUCCESS (3.823s) [799.673084] Starting dynamic subtest: vcs0 [803.746362] Dynamic subtest vcs0: SUCCESS (4.084s) [803.759688] Starting dynamic subtest: vcs1 [807.799226] Dynamic subtest vcs1: SUCCESS (4.049s) [807.816725] Starting dynamic subtest: vecs0 [811.859135] Dynamic subtest vecs0: SUCCESS (4.057s) [811.872123] Starting dynamic subtest: ccs0 [815.603851] Dynamic subtest ccs0: SUCCESS (3.742s) [815.606973] Subtest fds: SUCCESS (22.368s) [815.774510] [102/130] (411s left) gem_exec_schedule (u-fairslice-all) [815.857452] Starting subtest: u-fairslice-all [817.933813] Subtest u-fairslice-all: SUCCESS (2.079s) [818.215280] [103/130] (409s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [818.328142] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [818.332039] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [818.408569] [104/130] (408s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [818.537400] Starting subtest: 2x-long-cursor-vs-flip-legacy [818.542168] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [818.667054] [105/130] (408s left) kms_pm_dc (dc5-dpms) [819.788212] Starting subtest: dc5-dpms [821.893053] Subtest dc5-dpms: SUCCESS (2.104s) [821.950634] [106/130] (405s left) gem_exec_schedule (manyslice) [822.030537] Starting subtest: manyslice [822.032816] Starting dynamic subtest: rcs0 [827.163976] Dynamic subtest rcs0: SUCCESS (5.141s) [827.180246] Starting dynamic subtest: bcs0 [833.288668] Dynamic subtest bcs0: SUCCESS (6.121s) [833.307110] Starting dynamic subtest: vcs0 [838.854402] Dynamic subtest vcs0: SUCCESS (5.563s) [838.870776] Starting dynamic subtest: vcs1 [844.941690] Dynamic subtest vcs1: SUCCESS (6.083s) [844.959627] Starting dynamic subtest: vecs0 [850.506777] Dynamic subtest vecs0: SUCCESS (5.563s) [850.517627] Starting dynamic subtest: ccs0 [857.194876] Dynamic subtest ccs0: SUCCESS (6.685s) [857.197304] Subtest manyslice: SUCCESS (35.164s) [857.477574] [107/130] (369s left) drm_fdinfo (basics) [857.521618] Starting subtest: basics [857.523761] Subtest basics: SUCCESS (0.000s) [857.569385] [108/130] (369s left) gem_mmap_wc (read-write-distinct) [857.638993] Subtest read-write-distinct: SKIP (0.000s) [857.685836] [109/130] (369s left) kms_cursor_crc (cursor-onscreen-512x512) [857.950778] Starting subtest: cursor-onscreen-512x512 [857.955389] Subtest cursor-onscreen-512x512: SKIP (0.001s) [858.122645] [110/130] (369s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [858.255221] Starting subtest: cursorA-vs-flipA-legacy [869.392240] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.137s) [870.156720] [111/130] (357s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [870.252617] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [874.806112] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.557s) [874.914179] [112/130] (352s left) gem_partial_pwrite_pread (write-display) [874.977738] Subtest write-display: SKIP (0.000s) [875.036786] [113/130] (352s left) kms_big_fb (linear-32bpp-rotate-90) [875.153145] Starting subtest: linear-32bpp-rotate-90 [875.173324] Subtest linear-32bpp-rotate-90: SKIP (0.020s) [875.276274] [114/130] (352s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [875.387017] Starting subtest: y-tiled-addfb-size-offset-overflow [875.391361] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [875.482004] [115/130] (352s left) kms_chamelium_color (gamma) [875.585197] Subtest gamma: SKIP (0.000s) [875.610885] [116/130] (351s left) gem_exec_reloc (basic-wc-read) [875.682003] Subtest basic-wc-read: SKIP (0.000s) [875.745773] [117/130] (351s left) gen9_exec_parse (basic-rejected-ctx-param) [875.812070] Subtest basic-rejected-ctx-param: SKIP (0.000s) [875.880098] [118/130] (351s left) kms_dsc (dsc-basic) [875.987555] Starting subtest: dsc-basic [875.998214] Subtest dsc-basic: SKIP (0.000s) [876.042579] [119/130] (351s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [876.142438] Starting subtest: basic-max-pipe-crc-check [876.146638] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [876.170580] [120/130] (351s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [876.237022] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [876.346280] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s) [876.405068] [121/130] (351s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [876.508767] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [876.513164] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [876.582651] [122/130] (351s left) gem_exec_schedule (preempt-user) [876.653608] Starting subtest: preempt-user [876.655952] Starting dynamic subtest: rcs0 [876.666205] Dynamic subtest rcs0: SUCCESS (0.021s) [876.676668] Starting dynamic subtest: bcs0 [876.684785] Dynamic subtest bcs0: SUCCESS (0.017s) [876.697974] Starting dynamic subtest: vcs0 [876.703792] Dynamic subtest vcs0: SUCCESS (0.019s) [876.713928] Starting dynamic subtest: vcs1 [876.724294] Dynamic subtest vcs1: SUCCESS (0.019s) [876.735234] Starting dynamic subtest: vecs0 [876.750950] Dynamic subtest vecs0: SUCCESS (0.026s) [876.761603] Starting dynamic subtest: ccs0 [876.770278] Dynamic subtest ccs0: SUCCESS (0.019s) [876.772587] Subtest preempt-user: SUCCESS (0.126s) [878.654062] [123/130] (349s left) gem_mmap_gtt (basic-small-copy-xy) [878.715759] Subtest basic-small-copy-XY: SKIP (0.000s) [878.769695] [124/130] (349s left) gem_ctx_persistence (heartbeat-many) [878.834281] Starting subtest: heartbeat-many [878.839115] Subtest heartbeat-many: SKIP (0.000s) [878.924320] [125/130] (348s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [879.032406] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [882.477020] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.449s) [882.585458] [126/130] (345s left) gem_lmem_swapping (parallel-random) [882.628415] Subtest parallel-random: SKIP (0.000s) [882.646739] [127/130] (345s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [882.736392] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [882.747455] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [882.810256] [128/130] (345s left) prime_vgem (busy) [882.882989] Starting subtest: busy [882.884974] Starting dynamic subtest: rcs0 [882.984945] Dynamic subtest rcs0: SUCCESS (0.101s) [882.994969] Starting dynamic subtest: bcs0 [883.077770] Dynamic subtest bcs0: SUCCESS (0.092s) [883.088091] Starting dynamic subtest: vcs0 [883.123763] Dynamic subtest vcs0: SUCCESS (0.045s) [883.133582] Starting dynamic subtest: vcs1 [883.168496] Dynamic subtest vcs1: SUCCESS (0.044s) [883.178476] Starting dynamic subtest: vecs0 [883.215778] Dynamic subtest vecs0: SUCCESS (0.046s) [883.225681] Starting dynamic subtest: ccs0 [883.261832] Dynamic subtest ccs0: SUCCESS (0.045s) [883.263821] Subtest busy: SUCCESS (0.379s) [883.388428] [129/130] (344s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [883.491435] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [883.494808] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [883.565011] [130/130] (344s left) kms_color (ctm-0-75) [883.655619] Starting subtest: ctm-0-75 [883.657622] Starting dynamic subtest: pipe-A-eDP-1 [888.347276] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.689s) [888.363934] Starting dynamic subtest: pipe-B-eDP-1 [893.669363] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.322s) [893.680784] Starting dynamic subtest: pipe-C-eDP-1 [898.923120] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.254s) [898.934365] Starting dynamic subtest: pipe-D-eDP-1 [904.217239] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.294s) [904.219743] Subtest ctm-0-75: SUCCESS (20.562s) [905.045603] Closing watchdogs Done.