[36.733126] Initializing watchdogs [36.733156] /dev/watchdog0 [36.739171] [001/130] (960s left) gem_madvise (dontneed-before-exec) [36.776381] Starting subtest: dontneed-before-exec [36.803712] Subtest dontneed-before-exec: SKIP (0.026s) [36.847673] [002/130] (960s left) syncobj_wait (wait-any-interrupted) [36.895211] Starting subtest: wait-any-interrupted [36.996566] Subtest wait-any-interrupted: SUCCESS (0.102s) [37.053071] [003/130] (960s left) kms_writeback (writeback-check-output) [37.144434] Subtest writeback-check-output: SKIP (0.000s) [37.163135] [004/130] (960s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [42.325448] Starting subtest: psr2-overlay-plane-move-continuous-sf [42.327895] Starting dynamic subtest: pipe-A-eDP-1 [49.102902] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.776s) [49.110033] Starting dynamic subtest: pipe-B-eDP-1 [55.889250] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.783s) [55.891220] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.562s) [56.779210] [005/130] (940s left) device_reset (unbind-reset-rebind) [56.867786] Starting subtest: unbind-reset-rebind [59.859987] Subtest unbind-reset-rebind: SUCCESS (2.992s) [59.877752] [006/130] (937s left) kms_content_protection (dp-mst-type-1) [60.015564] Starting subtest: dp-mst-type-1 [60.020536] Subtest dp-mst-type-1: SKIP (0.000s) [60.145494] [007/130] (937s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [65.320407] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf [65.323045] Starting dynamic subtest: pipe-A-eDP-1 [66.157708] Dynamic subtest pipe-A-eDP-1: SKIP (0.834s) [66.165355] Starting dynamic subtest: pipe-B-eDP-1 [67.375034] Dynamic subtest pipe-B-eDP-1: SKIP (1.216s) [67.379454] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (2.052s) [68.621391] [008/130] (928s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [68.710736] Starting subtest: primary-y-tiled-reflect-x-270 [68.715390] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [68.759504] [009/130] (928s left) gem_render_copy (linear) [68.806724] Starting subtest: linear [68.809141] Starting dynamic subtest: smem [68.847250] Dynamic subtest smem: SUCCESS (0.040s) [68.850279] Subtest linear: SUCCESS (0.040s) [69.051698] [010/130] (928s left) gem_ctx_exec (basic-invalid-context) [69.097857] Starting subtest: basic-invalid-context [69.100798] Subtest basic-invalid-context: SUCCESS (0.004s) [69.204250] [011/130] (928s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [69.292876] Starting subtest: flip-primary-invalidate-overlay [80.652207] Subtest flip-primary-invalidate-overlay: SUCCESS (11.357s) [80.796749] [012/130] (916s left) gem_exec_balancer (nop) [80.842350] Starting subtest: nop [129.344909] Subtest nop: SUCCESS (48.501s) [129.577590] [013/130] (867s left) kms_cursor_legacy (torture-move) [129.695981] Starting subtest: torture-move [129.697912] Starting dynamic subtest: pipe-A [135.191041] Dynamic subtest pipe-A: SUCCESS (5.493s) [135.200548] Starting dynamic subtest: pipe-B [140.684479] Dynamic subtest pipe-B: SUCCESS (5.494s) [140.695671] Starting dynamic subtest: pipe-C [146.196622] Dynamic subtest pipe-C: SUCCESS (5.511s) [146.207285] Starting dynamic subtest: pipe-D [151.703105] Dynamic subtest pipe-D: SUCCESS (5.506s) [151.713786] Starting dynamic subtest: all-pipes [157.224116] Dynamic subtest all-pipes: SUCCESS (5.520s) [157.226989] Subtest torture-move: SUCCESS (27.526s) [157.352146] [014/130] (840s left) gem_mmap_gtt (fault-concurrent) [157.398643] Subtest fault-concurrent: SKIP (0.000s) [157.428734] [015/130] (840s left) kms_chamelium_color (ctm-negative) [157.523089] Subtest ctm-negative: SKIP (0.000s) [157.546116] [016/130] (839s left) testdisplay [157.846630] [017/130] (839s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [157.897264] Starting subtest: invalid-multi-wait-unsubmitted-submitted [157.899664] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [157.962225] [018/130] (839s left) gem_exec_balancer (sliced) [158.007855] Starting subtest: sliced [158.012124] Subtest sliced: SKIP (0.000s) [158.239804] [019/130] (839s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [158.314849] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [158.317237] Starting dynamic subtest: pipe-A-default-mode [158.599620] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [158.604617] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.282s) [159.498045] [020/130] (838s left) kms_universal_plane (disable-primary-vs-flip) [159.596782] Starting subtest: disable-primary-vs-flip [159.599122] Starting dynamic subtest: pipe-A-eDP-1 [161.170060] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.569s) [161.178474] Starting dynamic subtest: pipe-B-eDP-1 [163.467349] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.299s) [163.476513] Starting dynamic subtest: pipe-C-eDP-1 [165.776821] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.306s) [165.784746] Starting dynamic subtest: pipe-D-eDP-1 [168.077279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.301s) [168.079580] Subtest disable-primary-vs-flip: SUCCESS (8.478s) [168.970925] [021/130] (828s left) kms_lease (lease-revoke) [169.062854] Starting subtest: lease-revoke [169.065343] Starting dynamic subtest: pipe-A-eDP-1 [169.095729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s) [169.105184] Starting dynamic subtest: pipe-B-eDP-1 [169.125336] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.031s) [169.132160] Starting dynamic subtest: pipe-C-eDP-1 [169.151550] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.025s) [169.160942] Starting dynamic subtest: pipe-D-eDP-1 [169.177996] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s) [169.180672] Subtest lease-revoke: SUCCESS (0.114s) [169.259734] [022/130] (828s left) kms_cursor_crc (cursor-onscreen-256x85) [169.452563] Starting subtest: cursor-onscreen-256x85 [169.489674] Subtest cursor-onscreen-256x85: SKIP (0.033s) [169.619012] [023/130] (827s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [169.701872] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [169.704225] Starting dynamic subtest: pipe-A-eDP-1 [169.726792] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [169.734983] Starting dynamic subtest: pipe-B-eDP-1 [169.757347] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [169.764079] Starting dynamic subtest: pipe-C-eDP-1 [169.786901] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [169.793355] Starting dynamic subtest: pipe-D-eDP-1 [169.816226] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [169.820485] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s) [169.835755] [024/130] (827s left) gem_mmap_gtt (basic-small-copy-odd) [169.888180] Subtest basic-small-copy-odd: SKIP (0.000s) [169.926157] [025/130] (827s left) kms_psr (fbc-psr-sprite-blt) [170.008498] Starting subtest: fbc-psr-sprite-blt [170.010492] Starting dynamic subtest: eDP-1 [170.013949] Dynamic subtest eDP-1: SKIP (0.000s) [170.017391] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [170.058775] [026/130] (827s left) gem_vm_create (execbuf) [170.108568] Starting subtest: execbuf [170.114650] Subtest execbuf: SUCCESS (0.006s) [170.208280] [027/130] (827s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [170.286392] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [170.288465] Starting dynamic subtest: pipe-A [171.459837] Dynamic subtest pipe-A: SUCCESS (1.173s) [171.467047] Starting dynamic subtest: pipe-B [173.727560] Dynamic subtest pipe-B: SUCCESS (2.267s) [173.736264] Starting dynamic subtest: pipe-C [174.985807] Dynamic subtest pipe-C: SUCCESS (1.258s) [174.993944] Starting dynamic subtest: pipe-D [176.265116] Dynamic subtest pipe-D: SUCCESS (1.279s) [176.267544] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.978s) [177.482311] [028/130] (820s left) fbdev (write) [177.525026] Starting subtest: write [177.873540] Subtest write: SUCCESS (0.347s) [177.912267] [029/130] (819s left) i915_query (query-topology-unsupported) [177.952500] Starting subtest: query-topology-unsupported [177.957478] Subtest query-topology-unsupported: SKIP (0.000s) [178.016055] [030/130] (819s left) kms_big_fb (linear-64bpp-rotate-180) [178.114047] Starting subtest: linear-64bpp-rotate-180 [179.528430] Subtest linear-64bpp-rotate-180: SUCCESS (1.415s) [179.684439] [031/130] (817s left) gem_pxp (reject-modify-context-protection-off-3) [182.264289] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [182.314319] [032/130] (815s left) kms_busy (extended-modeset-hang-newfb-with-reset) [182.407541] Starting subtest: extended-modeset-hang-newfb-with-reset [182.409906] Starting dynamic subtest: pipe-A [196.292658] Dynamic subtest pipe-A: SUCCESS (13.883s) [196.298952] Starting dynamic subtest: pipe-D [211.140107] Dynamic subtest pipe-D: SUCCESS (14.844s) [211.142930] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (28.731s) [212.044944] [033/130] (785s left) gem_eio (in-flight-contexts-10ms) [212.218227] Starting subtest: in-flight-contexts-10ms [217.396483] Subtest in-flight-contexts-10ms: SUCCESS (5.178s) [217.535751] [034/130] (780s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [217.629702] Starting subtest: 4-tiled-addfb-size-offset-overflow [217.631656] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [217.692067] [035/130] (780s left) kms_dsc (dsc-with-formats) [217.778829] Starting subtest: dsc-with-formats [217.783323] Subtest dsc-with-formats: SKIP (0.001s) [217.832366] [036/130] (779s left) sysfs_heartbeat_interval (idempotent) [217.872822] Starting subtest: idempotent [217.875198] Starting dynamic subtest: vecs0 [217.877446] Dynamic subtest vecs0: SUCCESS (0.000s) [217.885034] Starting dynamic subtest: ccs0 [217.887118] Dynamic subtest ccs0: SUCCESS (0.001s) [217.893461] Starting dynamic subtest: vcs0 [217.895294] Dynamic subtest vcs0: SUCCESS (0.000s) [217.901097] Starting dynamic subtest: bcs0 [217.903409] Dynamic subtest bcs0: SUCCESS (0.000s) [217.909434] Starting dynamic subtest: rcs0 [217.911559] Dynamic subtest rcs0: SUCCESS (0.000s) [217.917600] Starting dynamic subtest: vcs1 [217.919695] Dynamic subtest vcs1: SUCCESS (0.000s) [217.921788] Subtest idempotent: SUCCESS (0.003s) [217.935082] [037/130] (779s left) kms_content_protection (dp-mst-lic-type-0) [218.067469] Starting subtest: dp-mst-lic-type-0 [218.072135] Subtest dp-mst-lic-type-0: SKIP (0.000s) [218.168234] [038/130] (779s left) gem_softpin (full) [218.217140] Starting subtest: full [218.222311] Subtest full: SUCCESS (0.005s) [218.334057] [039/130] (779s left) kms_plane_alpha_blend (alpha-basic) [218.427370] Starting subtest: alpha-basic [218.687487] Starting dynamic subtest: pipe-A-eDP-1 [220.594252] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.905s) [220.609937] Starting dynamic subtest: pipe-D-eDP-1 [223.306210] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.698s) [223.308764] Subtest alpha-basic: SUCCESS (4.876s) [224.202912] [040/130] (773s left) gem_exec_whisper (basic-queues-priority) [224.252878] Starting subtest: basic-queues-priority [248.347814] Subtest basic-queues-priority: SUCCESS (24.091s) [248.507500] [041/130] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [248.600495] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [248.604777] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [248.693054] [042/130] (749s left) kms_chamelium_audio (dp-audio-edid) [249.064572] Subtest dp-audio-edid: SKIP (0.000s) [249.909389] [043/130] (747s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [250.009271] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [250.013473] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [250.093315] [044/130] (747s left) kms_pm_dc (dc3co-vpb-simulation) [251.191266] Starting subtest: dc3co-vpb-simulation [260.347087] Subtest dc3co-vpb-simulation: SKIP (9.151s) [260.441329] [045/130] (737s left) gem_exec_reloc (basic-wc-noreloc) [260.493733] Subtest basic-wc-noreloc: SKIP (0.000s) [260.549208] [046/130] (737s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [260.655029] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [260.659139] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [260.725971] [047/130] (737s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [260.819870] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [260.824060] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [260.899650] [048/130] (737s left) gem_exec_whisper (basic-contexts) [260.948744] Starting subtest: basic-contexts [266.928792] Subtest basic-contexts: SUCCESS (5.979s) [267.089854] [049/130] (730s left) kms_async_flips (async-flip-with-page-flip-events) [267.182858] Starting subtest: async-flip-with-page-flip-events [267.541623] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs [268.373081] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.829s) [268.379753] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [268.516426] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SKIP (0.142s) [268.522589] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc [268.658989] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.143s) [268.665070] Starting dynamic subtest: pipe-A-eDP-1-4 [270.806333] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.149s) [270.815806] Starting dynamic subtest: pipe-A-eDP-1-x [272.972797] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.166s) [272.983811] Starting dynamic subtest: pipe-A-eDP-1-linear [275.173441] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.200s) [275.530030] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs [276.345426] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.825s) [276.352605] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [276.486668] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SKIP (0.142s) [276.494185] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc [276.621025] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.133s) [276.628180] Starting dynamic subtest: pipe-B-eDP-1-4 [278.769721] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.150s) [278.778435] Starting dynamic subtest: pipe-B-eDP-1-x [280.947066] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s) [280.956762] Starting dynamic subtest: pipe-B-eDP-1-linear [283.136463] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.189s) [283.486952] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs [284.316345] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.833s) [284.322869] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [284.457244] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SKIP (0.141s) [284.465171] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc [284.590348] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.133s) [284.600675] Starting dynamic subtest: pipe-C-eDP-1-4 [286.739050] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.150s) [286.748643] Starting dynamic subtest: pipe-C-eDP-1-x [288.905115] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s) [288.911942] Starting dynamic subtest: pipe-C-eDP-1-linear [291.083778] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.178s) [291.436662] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs [292.257490] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.826s) [292.265254] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [292.390968] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SKIP (0.132s) [292.398219] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc [292.523542] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.132s) [292.530107] Starting dynamic subtest: pipe-D-eDP-1-4 [294.671199] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.150s) [294.678286] Starting dynamic subtest: pipe-D-eDP-1-x [296.837834] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s) [296.847139] Starting dynamic subtest: pipe-D-eDP-1-linear [299.004017] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.166s) [299.006252] Subtest async-flip-with-page-flip-events: SUCCESS (31.818s) [300.232516] [050/130] (697s left) gem_exec_fence (syncobj-timeline-invalid-flags) [300.768059] Starting subtest: syncobj-timeline-invalid-flags [300.770548] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [302.448195] [051/130] (695s left) syncobj_timeline (multi-wait-submitted-signaled) [302.497767] Starting subtest: multi-wait-submitted-signaled [302.500044] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [302.563724] [052/130] (695s left) kms_flip (busy-flip) [302.662084] Starting subtest: busy-flip [302.664498] Starting dynamic subtest: A-eDP1 [304.390302] Dynamic subtest A-eDP1: SUCCESS (1.727s) [304.399346] Starting dynamic subtest: B-eDP1 [306.118368] Dynamic subtest B-eDP1: SUCCESS (1.727s) [306.125858] Starting dynamic subtest: C-eDP1 [307.834494] Dynamic subtest C-eDP1: SUCCESS (1.715s) [307.844639] Starting dynamic subtest: D-eDP1 [309.563153] Dynamic subtest D-eDP1: SUCCESS (1.727s) [309.568711] Subtest busy-flip: SUCCESS (6.905s) [310.794711] [053/130] (687s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [310.882966] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [310.885436] Starting dynamic subtest: pipe-A-default-mode [311.181078] Dynamic subtest pipe-A-default-mode: SKIP (0.293s) [311.186311] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.294s) [312.080104] [054/130] (685s left) gem_ctx_persistence (engines-mixed-process) [312.125829] Starting subtest: engines-mixed-process [312.128178] Starting dynamic subtest: rcs0 [313.367456] Dynamic subtest rcs0: SUCCESS (1.237s) [313.375592] Starting dynamic subtest: bcs0 [315.385264] Dynamic subtest bcs0: SUCCESS (2.020s) [315.394803] Starting dynamic subtest: vcs0 [317.393737] Dynamic subtest vcs0: SUCCESS (2.007s) [317.402576] Starting dynamic subtest: vcs1 [319.409489] Dynamic subtest vcs1: SUCCESS (2.015s) [319.420190] Starting dynamic subtest: vecs0 [321.399114] Dynamic subtest vecs0: SUCCESS (1.988s) [321.411544] Starting dynamic subtest: ccs0 [323.351354] Dynamic subtest ccs0: SUCCESS (1.949s) [323.353790] Subtest engines-mixed-process: SUCCESS (11.222s) [323.433540] [055/130] (674s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [323.487827] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [323.490064] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [323.545871] [056/130] (674s left) gem_exec_create (basic) [323.584251] Starting subtest: basic [323.586574] Starting dynamic subtest: smem [327.401393] Dynamic subtest smem: SUCCESS (3.814s) [327.404544] Subtest basic: SUCCESS (3.815s) [327.564168] [057/130] (670s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [327.689037] Starting subtest: basic-busy-flip-before-cursor-legacy [327.693574] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [327.766242] [058/130] (670s left) kms_plane (plane-panning-bottom-right) [327.856276] Starting subtest: plane-panning-bottom-right [327.858775] Starting dynamic subtest: pipe-A [329.554949] Dynamic subtest pipe-A: SUCCESS (1.695s) [329.561712] Starting dynamic subtest: pipe-B [332.048545] Dynamic subtest pipe-B: SUCCESS (2.494s) [332.050700] Subtest plane-panning-bottom-right: SUCCESS (4.190s) [332.936287] [059/130] (665s left) gem_tiled_fence_blits (normal) [332.995899] Subtest normal: SKIP (0.000s) [333.040080] [060/130] (665s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [333.130954] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [333.133264] Starting dynamic subtest: pipe-A [333.145700] Dynamic subtest pipe-A: SKIP (0.010s) [333.153914] Starting dynamic subtest: pipe-B [333.165914] Dynamic subtest pipe-B: SKIP (0.018s) [333.173256] Starting dynamic subtest: pipe-C [333.181975] Dynamic subtest pipe-C: SKIP (0.018s) [333.188576] Starting dynamic subtest: pipe-D [333.200393] Dynamic subtest pipe-D: SKIP (0.018s) [333.204060] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.064s) [333.262694] [061/130] (664s left) perf_pmu (event-wait) [333.293435] Starting subtest: event-wait [333.295558] Starting dynamic subtest: rcs0 [333.299469] Dynamic subtest rcs0: SKIP (0.000s) [333.303443] Subtest event-wait: SKIP (0.000s) [333.350812] [062/130] (664s left) kms_big_fb (y-tiled-16bpp-rotate-180) [333.447666] Starting subtest: y-tiled-16bpp-rotate-180 [333.451902] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [333.516177] [063/130] (664s left) gem_exec_reloc (basic-gtt-read) [333.562442] Subtest basic-gtt-read: SKIP (0.000s) [333.604213] [064/130] (664s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [333.691570] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [333.695843] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [333.761349] [065/130] (664s left) gen9_exec_parse (bb-oversize) [333.799080] Subtest bb-oversize: SKIP (0.000s) [333.846421] [066/130] (664s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [333.893396] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [333.897278] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [334.052814] [067/130] (664s left) syncobj_timeline (invalid-signal-bad-pad) [334.098395] Starting subtest: invalid-signal-bad-pad [334.100250] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [334.163380] [068/130] (664s left) i915_pm_rps (thresholds) [334.215202] Starting subtest: thresholds [334.220192] Subtest thresholds: SKIP (0.001s) [334.274613] [069/130] (664s left) gem_exec_params (cliprects_ptr-dirt) [334.329321] Starting subtest: cliprects_ptr-dirt [334.332151] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [334.398384] [070/130] (663s left) kms_rotation_crc (sprite-rotation-180) [334.486255] Starting subtest: sprite-rotation-180 [339.958706] Subtest sprite-rotation-180: SUCCESS (5.471s) [341.196598] [071/130] (657s left) syncobj_wait (wait-delayed-signal) [341.243682] Starting subtest: wait-delayed-signal [341.344850] Subtest wait-delayed-signal: SUCCESS (0.102s) [341.401215] [072/130] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [341.505509] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [346.017572] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.516s) [346.142802] [073/130] (652s left) i915_pm_rpm (gem-evict-pwrite) [347.663586] Starting subtest: gem-evict-pwrite [347.669374] Subtest gem-evict-pwrite: SKIP (0.000s) [348.442487] [074/130] (649s left) gem_userptr_blits (dmabuf-unsync) [348.504108] Subtest dmabuf-unsync: SKIP (0.000s) [348.607186] [075/130] (649s left) kms_force_connector_basic (prune-stale-modes) [348.672737] Starting subtest: prune-stale-modes [348.917172] Subtest prune-stale-modes: SKIP (0.240s) [349.044756] [076/130] (649s left) gem_exec_schedule (pi-ringfull) [349.221941] Starting subtest: pi-ringfull [349.225033] Starting dynamic subtest: rcs0 [349.323497] Dynamic subtest rcs0: FAIL (0.035s) [349.330461] Starting dynamic subtest: bcs0 [349.396701] Dynamic subtest bcs0: FAIL (0.027s) [349.404030] Starting dynamic subtest: vcs0 [349.458482] Dynamic subtest vcs0: FAIL (0.025s) [349.466471] Starting dynamic subtest: vcs1 [349.523723] Dynamic subtest vcs1: FAIL (0.023s) [349.531343] Starting dynamic subtest: vecs0 [349.590165] Dynamic subtest vecs0: FAIL (0.022s) [349.598558] Starting dynamic subtest: ccs0 [349.654931] Dynamic subtest ccs0: FAIL (0.022s) [349.656906] Subtest pi-ringfull: FAIL (0.155s) [359.612712] [077/130] (638s left) gem_userptr_blits (readonly-pwrite-unsync) [359.674943] Subtest readonly-pwrite-unsync: SKIP (0.000s) [359.776141] [078/130] (638s left) kms_big_fb (x-tiled-64bpp-rotate-270) [359.876387] Starting subtest: x-tiled-64bpp-rotate-270 [359.892942] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [359.997947] [079/130] (638s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [360.087034] Starting subtest: fbcpsr-rgb101010-draw-render [364.875851] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.790s) [364.974700] [080/130] (633s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [365.072898] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [365.076705] Starting dynamic subtest: pipe-A-eDP-1 [365.099495] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [365.106139] Starting dynamic subtest: pipe-B-eDP-1 [365.130254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [365.138473] Starting dynamic subtest: pipe-C-eDP-1 [365.162610] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [365.169684] Starting dynamic subtest: pipe-D-eDP-1 [365.194502] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [365.199114] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s) [365.214332] [081/130] (633s left) kms_getfb (getfb2-accept-ccs) [365.265829] Starting subtest: getfb2-accept-ccs [365.268218] Subtest getfb2-accept-ccs: SUCCESS (0.000s) [365.358200] [082/130] (633s left) kms_pm_rpm (system-suspend-modeset) [367.564539] Starting subtest: system-suspend-modeset [391.772094] Subtest system-suspend-modeset: SUCCESS (9.895s) [392.097058] [083/130] (620s left) gem_exec_parallel (basic) [392.152225] Starting subtest: basic [392.155043] Starting dynamic subtest: rcs0 [393.502213] Dynamic subtest rcs0: SUCCESS (1.349s) [393.510285] Starting dynamic subtest: bcs0 [394.828414] Dynamic subtest bcs0: SUCCESS (1.325s) [394.836340] Starting dynamic subtest: vcs0 [396.684970] Dynamic subtest vcs0: SUCCESS (1.853s) [396.693007] Starting dynamic subtest: vcs1 [398.670505] Dynamic subtest vcs1: SUCCESS (1.983s) [398.680569] Starting dynamic subtest: vecs0 [400.653420] Dynamic subtest vecs0: SUCCESS (1.981s) [400.662105] Starting dynamic subtest: ccs0 [402.061699] Dynamic subtest ccs0: SUCCESS (1.408s) [402.064081] Subtest basic: SUCCESS (9.906s) [402.227353] [084/130] (610s left) kms_psr (pr-primary-page-flip) [402.316621] Starting subtest: pr-primary-page-flip [402.321103] Subtest pr-primary-page-flip: SKIP (0.000s) [402.367500] [085/130] (610s left) perf (non-zero-reason) [402.470017] Starting subtest: non-zero-reason [402.472443] Starting dynamic subtest: 0-rcs0 [408.159622] Dynamic subtest 0-rcs0: SUCCESS (5.686s) [408.170698] Starting dynamic subtest: 1-vcs0 [412.201149] Dynamic subtest 1-vcs0: SUCCESS (4.041s) [412.204477] Subtest non-zero-reason: SUCCESS (9.728s) [412.224375] [086/130] (600s left) core_setmaster (master-drop-set-shared-fd) [412.914496] Starting subtest: master-drop-set-shared-fd [412.931801] Subtest master-drop-set-shared-fd: SUCCESS (0.017s) [412.949091] [087/130] (599s left) gem_exec_fence (parallel) [413.120417] Starting subtest: parallel [413.122814] Starting dynamic subtest: rcs0 [415.270927] Dynamic subtest rcs0: SUCCESS (2.151s) [415.278306] Starting dynamic subtest: bcs0 [417.420944] Dynamic subtest bcs0: SUCCESS (2.149s) [417.431027] Starting dynamic subtest: vcs0 [419.573132] Dynamic subtest vcs0: SUCCESS (2.151s) [419.582254] Starting dynamic subtest: vcs1 [421.721537] Dynamic subtest vcs1: SUCCESS (2.149s) [421.729279] Starting dynamic subtest: vecs0 [423.870657] Dynamic subtest vecs0: SUCCESS (2.148s) [423.878465] Starting dynamic subtest: ccs0 [426.020402] Dynamic subtest ccs0: SUCCESS (2.149s) [426.022428] Subtest parallel: SUCCESS (12.899s) [427.731153] [088/130] (585s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [427.847613] Starting subtest: nonblocking-modeset-vs-cursor-atomic [429.301486] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.455s) [430.196769] [089/130] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [430.293520] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [434.783835] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.493s) [434.907989] [090/130] (578s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [434.989845] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [434.992173] Starting dynamic subtest: pipe-A-eDP-1 [435.051557] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [435.060797] Starting dynamic subtest: pipe-B-eDP-1 [435.125397] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [435.133883] Starting dynamic subtest: pipe-C-eDP-1 [435.194517] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [435.203454] Starting dynamic subtest: pipe-D-eDP-1 [435.261500] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [435.265768] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [435.282024] [091/130] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [435.377046] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [435.381211] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [435.452313] [092/130] (577s left) gem_ctx_persistence (many-contexts) [435.493601] Starting subtest: many-contexts [473.188899] Subtest many-contexts: SUCCESS (37.690s) [473.245436] [093/130] (539s left) kms_frontbuffer_tracking (psr-slowdraw) [473.346384] Starting subtest: psr-slowdraw [496.060930] Subtest psr-slowdraw: SUCCESS (22.716s) [496.152337] [094/130] (516s left) gem_lmem_swapping (massive) [496.189593] Subtest massive: SKIP (0.000s) [496.214242] [095/130] (516s left) gem_mmap_wc (bad-size) [496.274323] Subtest bad-size: SKIP (0.000s) [496.311922] [096/130] (516s left) kms_psr (fbc-pr-sprite-blt) [496.399639] Starting subtest: fbc-pr-sprite-blt [496.404014] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [496.448061] [097/130] (516s left) kms_atomic (plane-primary-legacy) [496.537512] Starting subtest: plane-primary-legacy [496.539822] Starting dynamic subtest: pipe-A-eDP-1 [496.967596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s) [496.969507] Subtest plane-primary-legacy: SUCCESS (0.429s) [497.843715] [098/130] (515s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [497.939538] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [503.343631] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.408s) [503.431860] [099/130] (509s left) syncobj_timeline (wait-delayed-signal) [503.482634] Starting subtest: wait-delayed-signal [503.582509] Subtest wait-delayed-signal: SUCCESS (0.102s) [503.640937] [100/130] (509s left) gem_exec_schedule (preempt-user) [503.707895] Starting subtest: preempt-user [503.709774] Starting dynamic subtest: rcs0 [503.715981] Dynamic subtest rcs0: SUCCESS (0.018s) [503.723685] Starting dynamic subtest: bcs0 [503.729964] Dynamic subtest bcs0: SUCCESS (0.013s) [503.737523] Starting dynamic subtest: vcs0 [503.743359] Dynamic subtest vcs0: SUCCESS (0.014s) [503.753106] Starting dynamic subtest: vcs1 [503.758085] Dynamic subtest vcs1: SUCCESS (0.015s) [503.765244] Starting dynamic subtest: vecs0 [503.774900] Dynamic subtest vecs0: SUCCESS (0.016s) [503.782122] Starting dynamic subtest: ccs0 [503.791856] Dynamic subtest ccs0: SUCCESS (0.017s) [503.793985] Subtest preempt-user: SUCCESS (0.094s) [505.750841] [101/130] (507s left) sw_sync (sync_multi_consumer) [505.779384] Starting subtest: sync_multi_consumer [506.243563] Subtest sync_multi_consumer: SUCCESS (0.467s) [506.280534] [102/130] (506s left) api_intel_bb (blit-reloc-keep-cache) [506.328809] Starting subtest: blit-reloc-keep-cache [506.332941] Subtest blit-reloc-keep-cache: SKIP (0.000s) [506.425376] [103/130] (506s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [506.525242] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [511.226224] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.705s) [511.305729] [104/130] (501s left) gem_ctx_bad_destroy (invalid-default-ctx) [511.348908] Starting subtest: invalid-default-ctx [511.351512] Subtest invalid-default-ctx: SUCCESS (0.000s) [511.394667] [105/130] (501s left) kms_joiner (basic-force-big-joiner) [511.489026] Starting subtest: basic-force-big-joiner [511.491384] Starting dynamic subtest: single [515.096555] Dynamic subtest single: SUCCESS (3.613s) [515.098969] Subtest basic-force-big-joiner: SUCCESS (3.613s) [516.339609] [106/130] (496s left) syncobj_timeline (device-submit-unordered) [516.387534] Starting subtest: device-submit-unordered [516.389985] Subtest device-submit-unordered: SUCCESS (0.000s) [516.441032] [107/130] (496s left) gem_close_race (basic-process) [516.492650] Starting subtest: basic-process [516.543881] Subtest basic-process: SUCCESS (0.051s) [516.704926] [108/130] (496s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [516.786176] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [521.595602] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.813s) [521.719171] [109/130] (491s left) perf (non-system-wide-paranoid) [521.793461] Starting subtest: non-system-wide-paranoid [521.815523] Subtest non-system-wide-paranoid: SUCCESS (0.021s) [521.840380] [110/130] (491s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [521.952147] Starting subtest: cursorB-vs-flipB-legacy [521.957179] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [522.041248] [111/130] (491s left) gem_ctx_shared (single-timeline) [522.101925] Starting subtest: single-timeline [522.123021] Subtest single-timeline: SUCCESS (0.013s) [522.313026] [112/130] (490s left) kms_chamelium_hpd (hdmi-hpd) [522.700608] Subtest hdmi-hpd: SKIP (0.000s) [523.555929] [113/130] (489s left) gem_mmap_offset (clear) [523.606254] Starting subtest: clear [523.608726] Starting dynamic subtest: smem0 [546.695981] Dynamic subtest smem0: SUCCESS (23.081s) [546.698851] Subtest clear: SUCCESS (23.081s) [546.843936] [114/130] (466s left) syncobj_wait (invalid-wait-zero-handles) [546.901868] Starting subtest: invalid-wait-zero-handles [546.958805] Subtest invalid-wait-zero-handles: FAIL (0.003s) [546.977024] [115/130] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [547.079524] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [547.083461] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [547.160109] [116/130] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [547.254457] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [547.258406] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [547.319476] [117/130] (466s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [547.413302] Starting subtest: fbc-1p-pri-indfb-multidraw [558.121478] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (10.711s) [558.255722] [118/130] (455s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [558.340554] Starting subtest: fbc-psr2-cursor-mmap-cpu [558.342787] Starting dynamic subtest: eDP-1 [558.346934] Dynamic subtest eDP-1: SKIP (0.000s) [558.351084] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [558.391564] [119/130] (455s left) drm_fdinfo (virtual-busy-hang) [558.422800] Starting subtest: virtual-busy-hang [558.427049] Subtest virtual-busy-hang: SKIP (0.000s) [558.468910] [120/130] (454s left) kms_psr (psr-primary-blt) [558.549297] Starting subtest: psr-primary-blt [558.551224] Starting dynamic subtest: eDP-1 [560.344681] Dynamic subtest eDP-1: SUCCESS (1.793s) [560.346940] Subtest psr-primary-blt: SUCCESS (1.794s) [561.266887] [121/130] (452s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [561.372776] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [561.377418] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [561.448564] [122/130] (452s left) perf (invalid-oa-format-id) [561.517706] Starting subtest: invalid-oa-format-id [561.526668] Subtest invalid-oa-format-id: SUCCESS (0.007s) [561.542085] [123/130] (451s left) i915_module_load (reload) [561.569715] Starting subtest: reload [564.206220] Subtest reload: SUCCESS (2.641s) [564.219382] [124/130] (449s left) kms_setmode (invalid-clone-single-crtc-stealing) [565.620664] Starting subtest: invalid-clone-single-crtc-stealing [565.628493] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [565.725474] [125/130] (447s left) syncobj_eventfd (binary-wait) [565.773961] Starting subtest: binary-wait [565.782443] Subtest binary-wait: SUCCESS (0.010s) [565.832960] [126/130] (447s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [565.932646] Starting subtest: yf-tiled-16bpp-rotate-270 [565.937033] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [565.996463] [127/130] (447s left) gem_caching (writes) [566.049602] Subtest writes: SKIP (0.000s) [566.092960] [128/130] (447s left) kms_flip (flip-vs-rmfb-interruptible) [566.180926] Starting subtest: flip-vs-rmfb-interruptible [566.183227] Starting dynamic subtest: A-eDP1 [574.894833] Dynamic subtest A-eDP1: SUCCESS (8.711s) [574.905066] Starting dynamic subtest: B-eDP1 [583.596792] Dynamic subtest B-eDP1: SUCCESS (8.700s) [583.604322] Starting dynamic subtest: C-eDP1 [592.290378] Dynamic subtest C-eDP1: SUCCESS (8.692s) [592.297782] Starting dynamic subtest: D-eDP1 [600.994323] Dynamic subtest D-eDP1: SUCCESS (8.701s) [600.999095] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.813s) [602.223025] [129/130] (411s left) gem_close (basic) [602.275304] Starting subtest: basic [602.277325] Subtest basic: SUCCESS (0.000s) [602.352804] [130/130] (411s left) kms_cursor_crc (cursor-rapid-movement-512x512) [602.562182] Starting subtest: cursor-rapid-movement-512x512 [602.566412] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [602.709968] Closing watchdogs Done.