[42.790812] Initializing watchdogs [42.790858] /dev/watchdog0 [42.796423] [001/130] (960s left) kms_psr (pr-suspend) [42.856915] Starting subtest: pr-suspend [42.858686] Subtest pr-suspend: SKIP (0.000s) [42.928254] [002/130] (960s left) gem_tiled_wb [50.875666] [003/130] (952s left) gem_userptr_blits (unsync-unmap-cycles) [50.925392] Subtest unsync-unmap-cycles: SKIP (0.000s) [51.025815] [004/130] (952s left) gem_exec_reloc (basic-range-active) [51.064935] Subtest basic-range-active: SKIP (0.000s) [51.111599] [005/130] (952s left) gem_spin_batch (spin-all) [51.156181] Starting subtest: spin-all [51.168793] Subtest spin-all: SUCCESS (0.013s) [51.399851] [006/130] (951s left) gem_render_copy (y-tiled-to-vebox-linear) [51.443295] Starting subtest: y-tiled-to-vebox-linear [51.444061] Starting dynamic subtest: smem [51.516138] Dynamic subtest smem: SUCCESS (0.073s) [51.516975] Subtest y-tiled-to-vebox-linear: SUCCESS (0.073s) [51.743162] [007/130] (951s left) kms_flip (plain-flip-ts-check-interruptible) [51.804927] Starting subtest: plain-flip-ts-check-interruptible [51.807437] Starting dynamic subtest: A-eDP1 [63.956496] Dynamic subtest A-eDP1: FAIL (12.039s) [63.966910] Starting dynamic subtest: B-eDP1 [69.896466] Dynamic subtest B-eDP1: FAIL (6.086s) [69.907224] Starting dynamic subtest: C-eDP1 [77.999567] Dynamic subtest C-eDP1: FAIL (8.153s) [78.000837] Subtest plain-flip-ts-check-interruptible: FAIL (26.288s) [79.074811] [008/130] (924s left) gem_ctx_isolation (nonpriv) [79.118389] Starting subtest: nonpriv [79.119200] Starting dynamic subtest: rcs0 [79.346049] Dynamic subtest rcs0: SUCCESS (0.228s) [79.351769] Starting dynamic subtest: bcs0 [79.570657] Dynamic subtest bcs0: SUCCESS (0.226s) [79.577437] Starting dynamic subtest: vcs0 [79.807208] Dynamic subtest vcs0: SUCCESS (0.237s) [79.812947] Starting dynamic subtest: vecs0 [80.037221] Dynamic subtest vecs0: SUCCESS (0.231s) [80.038024] Subtest nonpriv: SUCCESS (0.922s) [80.229424] [009/130] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [80.287106] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [84.860961] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (4.585s) [84.946329] [010/130] (918s left) sysfs_heartbeat_interval (mixed) [84.977504] Starting subtest: mixed [84.978326] Starting dynamic subtest: vecs0 [90.153325] Dynamic subtest vecs0: SUCCESS (5.181s) [90.160846] Starting dynamic subtest: vcs0 [95.302268] Dynamic subtest vcs0: SUCCESS (5.149s) [95.315459] Starting dynamic subtest: bcs0 [100.443211] Dynamic subtest bcs0: SUCCESS (5.139s) [100.453180] Starting dynamic subtest: rcs0 [105.576263] Dynamic subtest rcs0: SUCCESS (5.131s) [105.577787] Subtest mixed: SUCCESS (20.603s) [105.623561] [011/130] (897s left) kms_psr (fbc-psr-sprite-render) [105.681693] Starting subtest: fbc-psr-sprite-render [105.682577] Starting dynamic subtest: eDP-1 [105.683997] Dynamic subtest eDP-1: SKIP (0.000s) [105.685400] Subtest fbc-psr-sprite-render: SKIP (0.000s) [105.714819] [012/130] (897s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [105.779636] Starting subtest: yf-tiled-64bpp-rotate-0 [105.781067] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [105.818371] [013/130] (897s left) kms_atomic (crtc-invalid-params) [105.874692] Starting subtest: crtc-invalid-params [105.876672] Starting dynamic subtest: pipe-A-eDP-1 [106.380375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s) [106.381569] Subtest crtc-invalid-params: SUCCESS (0.505s) [107.302705] [014/130] (895s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [107.339015] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [107.339870] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [107.375582] [015/130] (895s left) syncobj_wait (invalid-wait-bad-flags) [107.408408] Starting subtest: invalid-wait-bad-flags [107.409177] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [107.444440] [016/130] (895s left) syncobj_timeline (multi-wait-submitted-signaled) [107.478061] Starting subtest: multi-wait-submitted-signaled [107.478908] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [107.502514] [017/130] (895s left) gem_eio (reset-stress) [107.642713] Starting subtest: reset-stress [142.040604] Subtest reset-stress: SUCCESS (34.394s) [142.110565] [018/130] (861s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [145.691900] Starting subtest: fbc-pr-plane-move-sf-dmg-area [145.698683] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.005s) [146.598287] [019/130] (856s left) syncobj_wait (invalid-signal-illegal-handle) [146.636738] Starting subtest: invalid-signal-illegal-handle [146.637614] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [146.673826] [020/130] (856s left) gem_exec_store (dword) [146.710097] Starting subtest: dword [146.711107] Starting dynamic subtest: rcs0 [146.760220] Dynamic subtest rcs0: SUCCESS (0.050s) [146.773959] Starting dynamic subtest: bcs0 [146.802129] Dynamic subtest bcs0: SUCCESS (0.041s) [146.818918] Starting dynamic subtest: vcs0 [146.845872] Dynamic subtest vcs0: SUCCESS (0.043s) [146.861294] Starting dynamic subtest: vecs0 [146.888260] Dynamic subtest vecs0: SUCCESS (0.042s) [146.889597] Subtest dword: SUCCESS (0.178s) [147.037837] [021/130] (856s left) gem_huc_copy (huc-copy) [147.076324] Starting subtest: huc-copy [147.077988] Subtest huc-copy: SUCCESS (0.003s) [147.135326] [022/130] (856s left) syncobj_eventfd (invalid-illegal-handle) [147.169919] Starting subtest: invalid-illegal-handle [147.170773] Subtest invalid-illegal-handle: SUCCESS (0.000s) [147.191628] [023/130] (856s left) gem_exec_reloc (basic-write-wc) [147.224562] Subtest basic-write-wc: SKIP (0.000s) [147.259047] [024/130] (856s left) kms_pm_rpm (modeset-non-lpsp) [148.456195] Starting subtest: modeset-non-lpsp [149.599196] Subtest modeset-non-lpsp: SKIP (1.141s) [149.933499] [025/130] (853s left) gem_mmap (short-mmap) [149.972495] Starting subtest: short-mmap [149.973324] Subtest short-mmap: SUCCESS (0.000s) [150.002607] [026/130] (853s left) kms_chamelium_color (ctm-max) [150.057691] Subtest ctm-max: SKIP (0.000s) [150.077076] [027/130] (853s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [150.107744] Starting subtest: no-spare-fences-busy-interruptible [152.339641] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.231s) [152.422144] [028/130] (850s left) kms_color (ctm-0-50) [152.480807] Starting subtest: ctm-0-50 [152.481853] Starting dynamic subtest: pipe-A-eDP-1 [156.469370] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.988s) [156.489686] Starting dynamic subtest: pipe-B-eDP-1 [161.136760] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.667s) [161.145777] Starting dynamic subtest: pipe-C-eDP-1 [165.683885] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.547s) [165.684725] Subtest ctm-0-50: SUCCESS (13.203s) [166.566711] [029/130] (836s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [166.634295] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [166.636580] Starting dynamic subtest: A-eDP1 [170.635608] Dynamic subtest A-eDP1: SUCCESS (3.998s) [170.653332] Starting dynamic subtest: B-eDP1 [174.212423] Dynamic subtest B-eDP1: SUCCESS (3.576s) [174.232523] Starting dynamic subtest: C-eDP1 [177.870735] Dynamic subtest C-eDP1: SUCCESS (3.657s) [177.873393] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (11.238s) [178.792199] [030/130] (824s left) gem_exec_reloc (basic-scanout) [178.833365] Subtest basic-scanout: SKIP (0.000s) [178.894884] [031/130] (824s left) i915_pm_rps (thresholds) [178.931494] Starting subtest: thresholds [178.933921] Subtest thresholds: SKIP (0.001s) [178.964929] [032/130] (824s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [179.025292] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [179.027159] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [179.064229] [033/130] (824s left) vgem_basic (second-client) [179.112575] Starting subtest: second-client [179.146645] Subtest second-client: SUCCESS (0.033s) [179.169178] [034/130] (824s left) syncobj_timeline (wait-any-snapshot) [179.202653] Starting subtest: wait-any-snapshot [179.286533] Subtest wait-any-snapshot: SUCCESS (0.083s) [179.331994] [035/130] (824s left) api_intel_allocator (default-alignment) [179.364591] Starting subtest: default-alignment [179.366278] Subtest default-alignment: SUCCESS (0.003s) [179.447503] [036/130] (824s left) kms_dp_aux_dev [179.571984] [037/130] (824s left) i915_pciid [179.640861] [038/130] (823s left) drm_fdinfo (virtual-idle) [179.673925] Starting subtest: virtual-idle [181.702952] Subtest virtual-idle: SUCCESS (2.019s) [181.742381] [039/130] (821s left) gem_busy (parallel) [181.912679] Starting subtest: parallel [181.914267] Starting dynamic subtest: rcs0 [181.992499] Dynamic subtest rcs0: SUCCESS (0.088s) [182.010577] Starting dynamic subtest: bcs0 [182.042422] Dynamic subtest bcs0: SUCCESS (0.049s) [182.061413] Starting dynamic subtest: vcs0 [182.091446] Dynamic subtest vcs0: SUCCESS (0.048s) [182.111426] Starting dynamic subtest: vecs0 [182.142145] Dynamic subtest vecs0: SUCCESS (0.050s) [182.143604] Subtest parallel: SUCCESS (0.238s) [182.327753] [040/130] (821s left) core_hotunplug (unbind-rebind) [182.404153] Starting subtest: unbind-rebind [187.111404] Subtest unbind-rebind: SUCCESS (4.707s) [187.133259] [041/130] (816s left) kms_psr (psr-sprite-mmap-gtt) [187.190036] Starting subtest: psr-sprite-mmap-gtt [187.190908] Starting dynamic subtest: eDP-1 [189.181534] Dynamic subtest eDP-1: SUCCESS (1.991s) [189.182823] Subtest psr-sprite-mmap-gtt: SUCCESS (1.992s) [190.054493] [042/130] (813s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [190.112834] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [194.077774] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (3.964s) [194.180679] [043/130] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [194.241262] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [194.242973] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [194.297198] [044/130] (809s left) perf_pmu (busy) [194.331976] Starting subtest: busy [194.332807] Starting dynamic subtest: rcs0 [194.906254] Dynamic subtest rcs0: SUCCESS (0.574s) [194.915655] Starting dynamic subtest: bcs0 [195.458369] Dynamic subtest bcs0: SUCCESS (0.551s) [195.469446] Starting dynamic subtest: vcs0 [196.009379] Dynamic subtest vcs0: SUCCESS (0.550s) [196.028135] Starting dynamic subtest: vecs0 [196.567296] Dynamic subtest vecs0: SUCCESS (0.557s) [196.569426] Subtest busy: SUCCESS (2.236s) [196.619339] [045/130] (807s left) gem_userptr_blits (map-fixed-invalidate-overlap) [196.663664] Starting subtest: map-fixed-invalidate-overlap [196.664419] Starting dynamic subtest: gtt [196.739609] Dynamic subtest gtt: SUCCESS (0.076s) [196.747823] Starting dynamic subtest: wb [196.783884] Dynamic subtest wb: SUCCESS (0.044s) [196.792550] Starting dynamic subtest: wc [196.827069] Dynamic subtest wc: SUCCESS (0.043s) [196.835250] Starting dynamic subtest: uc [196.870319] Dynamic subtest uc: SUCCESS (0.043s) [196.871167] Subtest map-fixed-invalidate-overlap: SUCCESS (0.207s) [196.940662] [046/130] (806s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [196.980108] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [196.981077] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [196.996753] [047/130] (806s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [197.050870] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [197.052946] Starting dynamic subtest: pipe-A-default-mode [198.349457] Dynamic subtest pipe-A-default-mode: SKIP (1.295s) [198.352026] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.297s) [198.449669] [048/130] (805s left) kms_cursor_crc (cursor-random-64x64) [198.509178] Starting subtest: cursor-random-64x64 [198.513048] Starting dynamic subtest: pipe-A-eDP-1 [202.479028] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.966s) [202.536675] Starting dynamic subtest: pipe-C-eDP-1 [207.153494] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.625s) [207.154311] Subtest cursor-random-64x64: SUCCESS (8.644s) [208.042065] [049/130] (795s left) gem_exec_reloc (basic-wc-cpu-noreloc) [208.078843] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [208.128540] [050/130] (795s left) kms_flip (dpms-off-confusion-interruptible) [208.188567] Starting subtest: dpms-off-confusion-interruptible [208.190404] Starting dynamic subtest: A-eDP1 [219.483627] Dynamic subtest A-eDP1: SUCCESS (11.291s) [219.504117] Starting dynamic subtest: B-eDP1 [230.751720] Dynamic subtest B-eDP1: SUCCESS (11.261s) [230.769511] Starting dynamic subtest: C-eDP1 [242.017772] Dynamic subtest C-eDP1: SUCCESS (11.244s) [242.018567] Subtest dpms-off-confusion-interruptible: SUCCESS (33.805s) [243.242116] [051/130] (760s left) kms_big_fb (x-tiled-16bpp-rotate-270) [243.304586] Starting subtest: x-tiled-16bpp-rotate-270 [243.346431] Subtest x-tiled-16bpp-rotate-270: SKIP (0.040s) [243.435279] [052/130] (760s left) kms_plane_scaling (intel-max-src-size) [243.492416] Starting subtest: intel-max-src-size [243.493416] Starting dynamic subtest: pipe-A-eDP-1 [243.562764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s) [243.564036] Subtest intel-max-src-size: SUCCESS (0.072s) [243.686835] [053/130] (760s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [243.744255] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [247.941523] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.196s) [248.047359] [054/130] (755s left) kms_chamelium_frames (hdmi-crc-single) [248.407231] Subtest hdmi-crc-single: SKIP (0.000s) [249.312353] [055/130] (754s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [249.379228] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [249.380680] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [249.427131] [056/130] (754s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [249.486474] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [254.511235] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (5.024s) [254.602407] [057/130] (749s left) gem_exec_flush (basic-wb-set-default) [254.643032] Starting subtest: basic-wb-set-default [260.058311] Subtest basic-wb-set-default: SUCCESS (5.402s) [260.200942] [058/130] (743s left) gem_exec_suspend (basic-s3-devices) [260.237172] Starting subtest: basic-S3-devices [260.238140] Starting dynamic subtest: smem [268.766353] Dynamic subtest smem: SUCCESS (8.528s) [268.767848] Subtest basic-S3-devices: SUCCESS (8.529s) [268.925203] [059/130] (735s left) gem_exec_alignment (single) [268.960824] Starting subtest: single [268.964317] Subtest single: SUCCESS (0.004s) [269.039341] [060/130] (735s left) syncobj_basic (bad-destroy) [269.070185] Starting subtest: bad-destroy [269.070953] Subtest bad-destroy: SUCCESS (0.000s) [269.100204] [061/130] (734s left) kms_psr (fbc-psr2-cursor-blt) [269.156382] Starting subtest: fbc-psr2-cursor-blt [269.157392] Starting dynamic subtest: eDP-1 [269.159131] Dynamic subtest eDP-1: SKIP (0.000s) [269.160571] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [269.179084] [062/130] (734s left) gem_ctx_persistence (smoketest) [269.213132] Starting subtest: smoketest [299.954424] Subtest smoketest: SUCCESS (30.734s) [299.990708] [063/130] (704s left) gem_ctx_shared (q-out-order) [300.027460] Starting subtest: Q-out-order [300.028372] Starting dynamic subtest: rcs0 [300.080271] Dynamic subtest rcs0: SUCCESS (0.052s) [300.095623] Starting dynamic subtest: bcs0 [300.133885] Dynamic subtest bcs0: SUCCESS (0.051s) [300.151026] Starting dynamic subtest: vcs0 [300.208117] Dynamic subtest vcs0: SUCCESS (0.074s) [300.222437] Starting dynamic subtest: vecs0 [300.280779] Dynamic subtest vecs0: SUCCESS (0.071s) [300.282663] Subtest Q-out-order: SUCCESS (0.254s) [300.496192] [064/130] (703s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [300.527374] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [300.528196] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [300.549327] [065/130] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [300.610519] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [303.814050] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.202s) [303.936713] [066/130] (700s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [307.542984] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [307.551716] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.006s) [308.460131] [067/130] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [308.525377] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [308.527114] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [308.585429] [068/130] (695s left) gem_exec_suspend (basic-s3) [308.624669] Starting subtest: basic-S3 [308.625682] Starting dynamic subtest: smem [327.079259] Dynamic subtest smem: SUCCESS (3.080s) [327.081036] Subtest basic-S3: SUCCESS (3.081s) [327.239653] [069/130] (692s left) kms_psr (fbc-pr-primary-render) [327.298586] Starting subtest: fbc-pr-primary-render [327.300667] Subtest fbc-pr-primary-render: SKIP (0.000s) [327.322639] [070/130] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [327.380354] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [327.382233] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [327.433103] [071/130] (692s left) gem_mmap_gtt (pf-nonblock) [327.463759] Starting subtest: pf-nonblock [327.466870] Subtest pf-nonblock: SUCCESS (0.003s) [327.492937] [072/130] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [327.548955] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [330.942148] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (3.405s) [331.026232] [073/130] (688s left) api_intel_allocator (standalone) [331.056946] Starting subtest: standalone [331.070878] Subtest standalone: SUCCESS (0.015s) [331.139740] [074/130] (688s left) perf (oa-formats) [331.231046] Starting subtest: oa-formats [331.232217] Starting dynamic subtest: 0-rcs0 [331.249088] Dynamic subtest 0-rcs0: SUCCESS (0.019s) [331.249797] Subtest oa-formats: SUCCESS (0.019s) [331.287095] [075/130] (688s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [331.340707] Starting subtest: compare-crc-sanitycheck-nv12 [331.341637] Starting dynamic subtest: pipe-A-eDP-1 [332.286711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.981s) [332.307482] Starting dynamic subtest: pipe-B-eDP-1 [333.733569] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s) [333.753035] Starting dynamic subtest: pipe-C-eDP-1 [335.153746] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s) [335.154509] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.936s) [336.054177] [076/130] (683s left) gem_set_tiling_vs_blt (untiled-to-tiled) [336.093161] Starting subtest: untiled-to-tiled [336.094725] Subtest untiled-to-tiled: SKIP (0.001s) [336.157300] [077/130] (683s left) gem_exec_gttfill (multigpu-basic) [336.308785] Starting subtest: multigpu-basic [347.329551] Subtest multigpu-basic: SUCCESS (11.143s) [347.359613] [078/130] (672s left) kms_cursor_crc (cursor-sliding-512x170) [347.465331] Starting subtest: cursor-sliding-512x170 [347.467232] Subtest cursor-sliding-512x170: SKIP (0.001s) [347.543611] [079/130] (671s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [347.600458] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [347.602102] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [348.789741] [080/130] (670s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [348.846337] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [348.847349] Starting dynamic subtest: pipe-A [348.959038] Dynamic subtest pipe-A: SUCCESS (0.112s) [348.983339] Starting dynamic subtest: pipe-B [350.249197] Dynamic subtest pipe-B: SUCCESS (1.293s) [350.271443] Starting dynamic subtest: pipe-C [351.518942] Dynamic subtest pipe-C: SUCCESS (1.273s) [351.520165] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (2.683s) [352.760119] [081/130] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [352.828192] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [352.830362] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [352.887756] [082/130] (666s left) gem_cs_tlb (engines) [352.921751] Starting subtest: engines [352.922821] Starting dynamic subtest: rcs0 [355.078007] Dynamic subtest rcs0: SUCCESS (2.152s) [355.088460] Starting dynamic subtest: bcs0 [357.226394] Dynamic subtest bcs0: SUCCESS (2.152s) [357.236803] Starting dynamic subtest: vcs0 [359.375642] Dynamic subtest vcs0: SUCCESS (2.152s) [359.385424] Starting dynamic subtest: vecs0 [361.525888] Dynamic subtest vecs0: SUCCESS (2.152s) [361.526700] Subtest engines: SUCCESS (8.610s) [361.607471] [083/130] (657s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [361.669296] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [361.670729] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [361.737651] [084/130] (657s left) kms_content_protection (dp-mst-type-0) [361.808050] Starting subtest: dp-mst-type-0 [361.809703] Subtest dp-mst-type-0: SKIP (0.000s) [361.851731] [085/130] (657s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [361.904282] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [361.906437] Starting dynamic subtest: pipe-A-eDP-1 [361.913219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [361.925308] Starting dynamic subtest: pipe-B-eDP-1 [361.931848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [361.942551] Starting dynamic subtest: pipe-C-eDP-1 [361.949375] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [361.950098] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.006s) [364.346248] [086/130] (655s left) gem_userptr_blits (input-checking) [364.389324] Starting subtest: input-checking [364.390032] Subtest input-checking: SUCCESS (0.000s) [364.456168] [087/130] (655s left) prime_vgem (wait) [364.501499] Starting subtest: wait [364.502415] Starting dynamic subtest: rcs0 [364.523829] Dynamic subtest rcs0: SUCCESS (0.022s) [364.538963] Starting dynamic subtest: bcs0 [364.567650] Dynamic subtest bcs0: SUCCESS (0.043s) [364.583441] Starting dynamic subtest: vcs0 [364.608775] Dynamic subtest vcs0: SUCCESS (0.040s) [364.623700] Starting dynamic subtest: vecs0 [364.650351] Dynamic subtest vecs0: SUCCESS (0.040s) [364.651737] Subtest wait: SUCCESS (0.149s) [364.734680] [088/130] (654s left) gem_exec_balancer (sliced) [364.772670] Starting subtest: sliced [364.774138] Subtest sliced: SKIP (0.000s) [365.767231] [089/130] (653s left) kms_sequence (queue-busy) [365.823062] Starting subtest: queue-busy [365.823981] Starting dynamic subtest: pipe-A-eDP-1 [368.518496] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.693s) [368.532694] Starting dynamic subtest: pipe-B-eDP-1 [371.967709] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.445s) [371.987199] Starting dynamic subtest: pipe-C-eDP-1 [375.421599] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.452s) [375.422435] Subtest queue-busy: SUCCESS (9.596s) [376.312119] [090/130] (643s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [376.377083] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [376.378348] Starting dynamic subtest: pipe-A-default-mode [376.697757] Dynamic subtest pipe-A-default-mode: SKIP (0.317s) [376.700025] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.320s) [377.589645] [091/130] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [377.659312] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [377.661386] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [377.716767] [092/130] (642s left) kms_hdr (bpc-switch-dpms) [377.772369] Starting subtest: bpc-switch-dpms [378.974637] Starting dynamic subtest: pipe-A-eDP-1 [384.044576] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.071s) [384.045892] Subtest bpc-switch-dpms: SUCCESS (6.272s) [384.096541] [093/130] (635s left) i915_suspend (fence-restore-tiled2untiled) [384.128200] Starting subtest: fence-restore-tiled2untiled [403.826301] Subtest fence-restore-tiled2untiled: SUCCESS (4.819s) [403.883379] [094/130] (630s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [403.940714] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [403.942194] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [403.996109] [095/130] (630s left) gem_exec_flush (basic-uc-ro-default) [404.031422] Starting subtest: basic-uc-ro-default [409.323444] Subtest basic-uc-ro-default: SUCCESS (5.390s) [409.454519] [096/130] (625s left) kms_big_fb (4-tiled-64bpp-rotate-0) [409.520170] Starting subtest: 4-tiled-64bpp-rotate-0 [409.521712] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s) [409.585346] [097/130] (624s left) vgem_basic (sysfs) [409.627249] Starting subtest: sysfs [409.628467] Subtest sysfs: SUCCESS (0.001s) [409.648240] [098/130] (624s left) drm_read (empty-nonblock) [409.741968] Starting subtest: empty-nonblock [409.743282] Subtest empty-nonblock: SUCCESS (0.000s) [409.832653] [099/130] (624s left) syncobj_wait (multi-wait-all-for-submit-submitted) [409.861704] Starting subtest: multi-wait-all-for-submit-submitted [409.963723] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s) [410.012119] [100/130] (624s left) kms_big_fb (linear-64bpp-rotate-180) [410.072972] Starting subtest: linear-64bpp-rotate-180 [412.466713] Subtest linear-64bpp-rotate-180: SUCCESS (2.423s) [412.544775] [101/130] (622s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [412.596266] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [412.596988] Starting dynamic subtest: pipe-A-eDP-1 [412.603635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [412.614362] Starting dynamic subtest: pipe-B-eDP-1 [412.621160] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [412.631194] Starting dynamic subtest: pipe-C-eDP-1 [412.637470] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [412.638182] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.009s) [415.076771] [102/130] (619s left) kms_big_fb (y-tiled-8bpp-rotate-180) [415.138903] Starting subtest: y-tiled-8bpp-rotate-180 [416.717680] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.589s) [416.805628] [103/130] (617s left) perf_pmu (init-wait) [416.838416] Starting subtest: init-wait [416.839253] Starting dynamic subtest: rcs0 [416.840177] Dynamic subtest rcs0: SUCCESS (0.001s) [416.852179] Starting dynamic subtest: bcs0 [416.852958] Dynamic subtest bcs0: SUCCESS (0.000s) [416.862105] Starting dynamic subtest: vcs0 [416.862973] Dynamic subtest vcs0: SUCCESS (0.001s) [416.871703] Starting dynamic subtest: vecs0 [416.872526] Dynamic subtest vecs0: SUCCESS (0.001s) [416.873425] Subtest init-wait: SUCCESS (0.006s) [416.898484] [104/130] (617s left) i915_pm_freq_api (freq-basic-api) [416.932980] Starting subtest: freq-basic-api [416.934236] Starting dynamic subtest: gt0 [416.938331] Dynamic subtest gt0: SUCCESS (0.005s) [416.939395] Subtest freq-basic-api: SUCCESS (0.006s) [416.960131] [105/130] (617s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [417.017944] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [423.416068] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.424s) [423.506101] [106/130] (611s left) kms_flip (2x-dpms-vs-vblank-race) [423.564956] Starting subtest: 2x-dpms-vs-vblank-race [423.569827] Subtest 2x-dpms-vs-vblank-race: SKIP (0.004s) [423.595792] [107/130] (611s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [423.652120] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [428.089374] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (4.446s) [428.174012] [108/130] (606s left) gem_spin_batch (resubmit-new) [428.207654] Starting subtest: resubmit-new [428.208643] Starting dynamic subtest: rcs0 [428.212573] Dynamic subtest rcs0: SUCCESS (0.004s) [428.230489] Starting dynamic subtest: bcs0 [428.231192] Dynamic subtest bcs0: SUCCESS (0.004s) [428.240435] Starting dynamic subtest: vcs0 [428.241212] Dynamic subtest vcs0: SUCCESS (0.004s) [428.250009] Starting dynamic subtest: vecs0 [428.250925] Dynamic subtest vecs0: SUCCESS (0.004s) [428.251705] Subtest resubmit-new: SUCCESS (0.020s) [428.421600] [109/130] (606s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [428.478927] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [428.479914] Starting dynamic subtest: pipe-A [428.523580] Dynamic subtest pipe-A: SKIP (0.045s) [428.534012] Starting dynamic subtest: pipe-B [428.587240] Dynamic subtest pipe-B: SKIP (0.062s) [428.597934] Starting dynamic subtest: pipe-C [428.649356] Dynamic subtest pipe-C: SKIP (0.062s) [428.650732] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.171s) [428.701751] [110/130] (605s left) gem_exec_params (cliprects_ptr-dirt) [428.732522] Starting subtest: cliprects_ptr-dirt [428.733370] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [428.803366] [111/130] (605s left) gem_exec_balancer (indices) [428.842675] Starting subtest: indices [429.716921] Subtest indices: SUCCESS (0.875s) [430.706847] [112/130] (604s left) gem_exec_await (wide-all) [430.765244] Starting subtest: wide-all [452.485715] Subtest wide-all: SUCCESS (21.720s) [452.661075] [113/130] (582s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [452.793496] Starting subtest: modeset-atomic-cursor-hotspot [452.795817] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [452.897503] [114/130] (581s left) kms_vrr (flip-dpms) [452.960221] Starting subtest: flip-dpms [452.962908] Subtest flip-dpms: SKIP (0.000s) [452.995162] [115/130] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [453.055166] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [457.594788] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.539s) [457.701545] [116/130] (577s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [457.755372] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [457.757913] Starting dynamic subtest: pipe-A-eDP-1 [457.765186] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [457.777652] Starting dynamic subtest: pipe-B-eDP-1 [457.784967] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [457.795470] Starting dynamic subtest: pipe-C-eDP-1 [457.802446] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [457.803796] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s) [460.195801] [117/130] (574s left) gem_exec_fair (basic-throttle) [460.243633] Subtest basic-throttle: SKIP (0.000s) [460.275303] [118/130] (574s left) kms_chamelium_audio (dp-audio-edid) [460.650910] Subtest dp-audio-edid: SKIP (0.000s) [461.534749] [119/130] (573s left) kms_cursor_legacy (flip-vs-cursor-legacy) [461.644752] Starting subtest: flip-vs-cursor-legacy [470.882535] Subtest flip-vs-cursor-legacy: SUCCESS (9.241s) [471.779046] [120/130] (563s left) gem_ppgtt (shrink-vs-evict-any) [471.813535] Starting subtest: shrink-vs-evict-any [477.429646] Subtest shrink-vs-evict-any: SUCCESS (5.584s) [477.485933] [121/130] (557s left) device_reset (unbind-reset-rebind) [477.528247] Starting subtest: unbind-reset-rebind [480.263973] Subtest unbind-reset-rebind: SUCCESS (2.728s) [480.301573] [122/130] (554s left) kms_joiner (invalid-modeset-force-ultra-joiner) [480.363920] Starting subtest: invalid-modeset-force-ultra-joiner [480.365873] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [480.392297] [123/130] (554s left) gem_mmap_gtt (cpuset-big-copy) [480.422746] Starting subtest: cpuset-big-copy [491.367757] Subtest cpuset-big-copy: SUCCESS (10.951s) [491.413898] [124/130] (543s left) gem_pxp (create-valid-protected-context) [494.033704] Subtest create-valid-protected-context: SKIP (0.000s) [494.062242] [125/130] (540s left) kms_pm_rpm (i2c) [495.608617] Starting subtest: i2c [501.994058] Subtest i2c: SUCCESS (6.381s) [502.148478] [126/130] (532s left) gem_exec_schedule (thriceslice) [502.190396] Starting subtest: thriceslice [502.191323] Starting dynamic subtest: rcs0 [502.219329] Dynamic subtest rcs0: SUCCESS (0.027s) [502.230733] Starting dynamic subtest: bcs0 [502.245778] Dynamic subtest bcs0: SUCCESS (0.025s) [502.267660] Starting dynamic subtest: vcs0 [502.277333] Dynamic subtest vcs0: SUCCESS (0.030s) [502.292045] Starting dynamic subtest: vecs0 [502.328935] Dynamic subtest vecs0: SUCCESS (0.050s) [502.330402] Subtest thriceslice: SUCCESS (0.138s) [502.602679] [127/130] (532s left) gen9_exec_parse (bb-secure) [502.638675] Subtest bb-secure: SKIP (0.000s) [502.678759] [128/130] (532s left) gem_userptr_blits (forbidden-operations) [502.711558] Starting subtest: forbidden-operations [502.713024] Subtest forbidden-operations: SKIP (0.000s) [502.803099] [129/130] (532s left) syncobj_wait (invalid-single-wait-unsubmitted) [502.834057] Starting subtest: invalid-single-wait-unsubmitted [502.834838] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [502.856371] [130/130] (532s left) kms_psr (psr-cursor-render) [502.910073] Starting subtest: psr-cursor-render [502.911184] Starting dynamic subtest: eDP-1 [504.914284] Dynamic subtest eDP-1: SUCCESS (2.004s) [504.915587] Subtest psr-cursor-render: SUCCESS (2.005s) [505.824869] Closing watchdogs Done.