[71.294339] Initializing watchdogs [71.294469] /dev/watchdog0 [71.315604] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300) [71.323059] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [71.327149] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.330238] [001/133] (960s left) i915_pm_rps (basic-api) [71.401857] Starting subtest: basic-api [71.405408] Subtest basic-api: SUCCESS (0.004s) [71.517421] [002/133] (960s left) gem_softpin (safe-alignment) [71.577806] Starting subtest: safe-alignment [71.585383] Subtest safe-alignment: SUCCESS (0.009s) [71.733516] [003/133] (960s left) gem_exec_whisper (basic-fds-forked) [71.800245] Starting subtest: basic-fds-forked [74.194078] Subtest basic-fds-forked: SUCCESS (2.393s) [74.429739] [004/133] (957s left) syncobj_wait (single-wait-signaled) [74.486357] Starting subtest: single-wait-signaled [74.487365] Subtest single-wait-signaled: SUCCESS (0.000s) [74.612179] [005/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [75.109677] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [75.110707] Starting dynamic subtest: pipe-A [75.114047] Dynamic subtest pipe-A: SKIP (0.002s) [75.126289] Starting dynamic subtest: pipe-B [75.129704] Dynamic subtest pipe-B: SKIP (0.001s) [75.131801] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.003s) [75.711953] [006/133] (956s left) gen9_exec_parse (cmd-crossing-page) [75.773944] Subtest cmd-crossing-page: SKIP (0.000s) [75.827175] [007/133] (956s left) gem_flink_race (flink_name) [75.888781] Starting subtest: flink_name [81.259330] Subtest flink_name: SUCCESS (5.373s) [81.402110] [008/133] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [81.901225] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [81.904195] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [82.500329] [009/133] (949s left) api_intel_bb (render) [82.557332] Starting subtest: render [82.559380] Starting dynamic subtest: render-none-512 [82.647946] Dynamic subtest render-none-512: SUCCESS (0.091s) [82.658287] Starting dynamic subtest: render-none-reloc-512 [82.731745] Dynamic subtest render-none-reloc-512: SUCCESS (0.083s) [82.742228] Starting dynamic subtest: render-none-1024 [83.067288] Dynamic subtest render-none-1024: SUCCESS (0.335s) [83.077550] Starting dynamic subtest: render-none-reloc-1024 [83.396044] Dynamic subtest render-none-reloc-1024: SUCCESS (0.328s) [83.406708] Starting dynamic subtest: render-x-512 [83.472153] Dynamic subtest render-x-512: SUCCESS (0.076s) [83.482867] Starting dynamic subtest: render-x-reloc-512 [83.546520] Dynamic subtest render-x-reloc-512: SUCCESS (0.074s) [83.557653] Starting dynamic subtest: render-x-1024 [83.834154] Dynamic subtest render-x-1024: SUCCESS (0.287s) [83.845031] Starting dynamic subtest: render-x-reloc-1024 [84.124365] Dynamic subtest render-x-reloc-1024: SUCCESS (0.290s) [84.135043] Starting dynamic subtest: render-y-512 [84.200888] Dynamic subtest render-y-512: SUCCESS (0.076s) [84.211748] Starting dynamic subtest: render-y-reloc-512 [84.275803] Dynamic subtest render-y-reloc-512: SUCCESS (0.074s) [84.286395] Starting dynamic subtest: render-y-1024 [84.563283] Dynamic subtest render-y-1024: SUCCESS (0.287s) [84.573812] Starting dynamic subtest: render-y-reloc-1024 [84.856793] Dynamic subtest render-y-reloc-1024: SUCCESS (0.293s) [84.858056] Subtest render: SUCCESS (2.300s) [85.013429] [010/133] (947s left) gem_mmap_gtt (basic-small-copy-xy) [85.068264] Starting subtest: basic-small-copy-XY [85.840369] Subtest basic-small-copy-XY: SUCCESS (0.773s) [85.976563] [011/133] (946s left) gem_exec_fence (basic-busy-all) [86.133276] Starting subtest: basic-busy-all [86.169728] Subtest basic-busy-all: SUCCESS (0.037s) [86.723274] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [86.725836] [012/133] (945s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [87.237928] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [87.240064] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [87.845103] [013/133] (944s left) kms_atomic_transition (plane-toggle-modeset-transition) [88.345813] Starting subtest: plane-toggle-modeset-transition [88.346974] Starting dynamic subtest: pipe-A-HDMI-A-1 [89.379749] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.033s) [89.392464] Starting dynamic subtest: pipe-B-HDMI-A-1 [90.338679] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.955s) [90.339834] Subtest plane-toggle-modeset-transition: SUCCESS (1.993s) [91.067247] [014/133] (941s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [91.564948] Starting subtest: fbcpsr-rgb565-draw-pwrite [91.567033] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s) [92.167326] [015/133] (940s left) kms_flip (2x-modeset-vs-vblank-race) [92.666172] Starting subtest: 2x-modeset-vs-vblank-race [92.667497] Starting dynamic subtest: AB-VGA1-HDMI-A1 [103.534646] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.868s) [103.537523] Subtest 2x-modeset-vs-vblank-race: SUCCESS (10.871s) [104.357015] [016/133] (928s left) gem_mmap_gtt (basic-small-bo-tiledy) [104.427022] Starting subtest: basic-small-bo-tiledY [104.668403] Subtest basic-small-bo-tiledY: SUCCESS (0.241s) [104.817936] [017/133] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [105.411150] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [105.413246] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [106.018742] [018/133] (926s left) perf (polling-small-buf) [106.209582] Subtest polling-small-buf: SKIP (0.000s) [106.265748] [019/133] (926s left) gem_ctx_param (non-root-set) [106.321596] Starting subtest: non-root-set [106.342421] Subtest non-root-set: SUCCESS (0.021s) [106.487113] [020/133] (926s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [106.992986] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [106.997413] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.001s) [107.601273] [021/133] (925s left) kms_vblank (wait-forked-hang) [108.098545] Starting subtest: wait-forked-hang [108.099984] Starting dynamic subtest: pipe-A-HDMI-A-1 [113.984766] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.886s) [113.998411] Starting dynamic subtest: pipe-B-HDMI-A-1 [119.921679] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.934s) [119.922742] Subtest wait-forked-hang: SUCCESS (11.826s) [120.638638] [022/133] (912s left) gem_mmap_gtt (cpuset-medium-copy-odd) [120.694820] Starting subtest: cpuset-medium-copy-odd [122.339105] Subtest cpuset-medium-copy-odd: SUCCESS (1.645s) [122.528855] [023/133] (910s left) kms_joiner (invalid-modeset-force-ultra-joiner) [123.119782] Starting subtest: invalid-modeset-force-ultra-joiner [123.122995] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [123.729597] [024/133] (909s left) kms_pm_rpm (basic-rte) [123.782961] Starting subtest: basic-rte [135.564052] Subtest basic-rte: SKIP (11.776s) [135.867841] [025/133] (897s left) gem_exec_fence (syncobj-wait) [136.070516] Starting subtest: syncobj-wait [136.118869] Subtest syncobj-wait: SUCCESS (0.048s) [136.507977] [026/133] (896s left) kms_getfb (getfb-repeated-different-handles) [137.000281] Starting subtest: getfb-repeated-different-handles [137.004119] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [137.607920] [027/133] (895s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [137.666024] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s) [137.733078] [028/133] (895s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [137.792152] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s) [137.847330] [029/133] (895s left) kms_cursor_crc (cursor-sliding-512x512) [138.349355] Starting subtest: cursor-sliding-512x512 [138.351494] Subtest cursor-sliding-512x512: SKIP (0.001s) [138.964263] [030/133] (894s left) api_intel_allocator (reserve-simple) [139.022956] Starting subtest: reserve-simple [139.025929] Subtest reserve-simple: SUCCESS (0.004s) [139.197739] [031/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [139.697152] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [139.699173] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [140.298092] [032/133] (893s left) kms_big_fb (4-tiled-8bpp-rotate-270) [140.795862] Starting subtest: 4-tiled-8bpp-rotate-270 [140.798140] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s) [141.395820] [033/133] (892s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [141.887920] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [143.374890] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (1.490s) [144.010323] [034/133] (889s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [144.588242] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [144.995198] [035/133] (888s left) gem_pwrite (basic-self) [145.054818] Starting subtest: basic-self [145.144218] Subtest basic-self: SUCCESS (0.089s) [145.285787] [036/133] (888s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [145.770682] Starting subtest: basic-flip-before-cursor-atomic [146.746685] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.975s) [147.455996] [037/133] (886s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [147.514465] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [147.583973] [038/133] (886s left) kms_pm_backlight (bad-brightness) [148.073115] Subtest bad-brightness: SKIP (0.000s) [148.387099] [039/133] (885s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [148.874339] Starting subtest: 2x-long-cursor-vs-flip-legacy [148.876401] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s) [149.487775] [040/133] (884s left) kms_big_fb (y-tiled-32bpp-rotate-0) [149.984718] Starting subtest: y-tiled-32bpp-rotate-0 [149.986990] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [150.583314] [041/133] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [151.083437] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [151.087947] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [151.683089] [042/133] (882s left) kms_psr (fbc-psr-primary-mmap-cpu) [152.177438] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [152.474391] [043/133] (881s left) kms_sequence (get-forked-busy) [152.962996] Starting subtest: get-forked-busy [152.964160] Starting dynamic subtest: pipe-A-HDMI-A-1 [155.372669] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.409s) [155.386816] Starting dynamic subtest: pipe-B-HDMI-A-1 [157.819416] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.443s) [157.820524] Subtest get-forked-busy: SUCCESS (4.857s) [158.533868] [044/133] (875s left) kms_concurrent (multi-plane-atomic-lowres) [159.019692] Starting subtest: multi-plane-atomic-lowres [159.022952] Starting dynamic subtest: pipe-A-HDMI-A-1 [159.525226] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.504s) [159.526330] Subtest multi-plane-atomic-lowres: SUCCESS (0.507s) [160.243206] [045/133] (873s left) gem_exec_schedule (reorder-wide) [160.326612] Subtest reorder-wide: SKIP (0.000s) [160.561623] [046/133] (873s left) prime_vgem (basic-write) [160.629338] Starting subtest: basic-write [160.649286] Subtest basic-write: SUCCESS (0.020s) [160.804637] [047/133] (873s left) kms_hdmi_inject (inject-4k) [160.938210] Starting subtest: inject-4k [160.940360] Subtest inject-4k: SKIP (0.000s) [161.161481] [048/133] (873s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [161.219377] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s) [161.283561] [049/133] (873s left) syncobj_timeline (invalid-query-zero-handles) [161.345979] Starting subtest: invalid-query-zero-handles [161.347223] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [161.473648] [050/133] (872s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [161.532212] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [161.634261] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s) [161.772914] [051/133] (872s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [161.829121] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s) [161.900390] [052/133] (872s left) kms_pipe_crc_basic (nonblocking-crc) [162.390630] Starting subtest: nonblocking-crc [162.391688] Starting dynamic subtest: pipe-A-HDMI-A-1 [162.952832] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.560s) [162.966684] Starting dynamic subtest: pipe-B-HDMI-A-1 [163.530276] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.575s) [163.531318] Subtest nonblocking-crc: SUCCESS (1.141s) [164.243983] [053/133] (870s left) gem_ctx_shared (q-smoketest) [164.307177] Subtest Q-smoketest: SKIP (0.000s) [164.427808] [054/133] (870s left) kms_async_flips (async-flip-dpms) [164.921319] Starting subtest: async-flip-dpms [165.060079] Starting dynamic subtest: pipe-A-HDMI-A-1 [177.246551] Dynamic subtest pipe-A-HDMI-A-1: SKIP (12.183s) [177.410357] Starting dynamic subtest: pipe-B-HDMI-A-1 [189.539337] Dynamic subtest pipe-B-HDMI-A-1: SKIP (12.140s) [189.541877] Subtest async-flip-dpms: SKIP (24.618s) [190.404950] [055/133] (844s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [190.461430] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s) [190.530122] [056/133] (844s left) kms_psr (psr-cursor-plane-move) [191.018157] Subtest psr-cursor-plane-move: SKIP (0.000s) [191.312314] [057/133] (843s left) syncobj_wait (invalid-signal-illegal-handle) [191.372751] Starting subtest: invalid-signal-illegal-handle [191.373815] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [191.501776] [058/133] (843s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [191.995237] Starting subtest: psr-rgb101010-draw-mmap-cpu [191.997278] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [192.601683] [059/133] (842s left) prime_mmap (test_aperture_limit) [192.657732] Starting subtest: test_aperture_limit [192.658787] Starting dynamic subtest: test_aperture_limit-smem [192.667139] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.011s) [192.668200] Subtest test_aperture_limit: SUCCESS (0.013s) [192.813577] [060/133] (842s left) gem_mmap_gtt (basic-write-read) [192.869747] Starting subtest: basic-write-read [192.883338] Subtest basic-write-read: SUCCESS (0.015s) [193.031663] [061/133] (841s left) gem_huc_copy (huc-copy) [193.088657] Subtest huc-copy: SKIP (0.000s) [193.162976] [062/133] (841s left) gem_exec_reloc (basic-gtt-wc-active) [193.224180] Starting subtest: basic-gtt-wc-active [193.334763] Subtest basic-gtt-wc-active: SUCCESS (0.110s) [194.360715] [063/133] (840s left) kms_color (ctm-negative) [194.855327] Starting subtest: ctm-negative [194.856908] Starting dynamic subtest: pipe-A-HDMI-A-1 [195.325909] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.470s) [195.338408] Starting dynamic subtest: pipe-B-HDMI-A-1 [195.833092] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.506s) [195.834132] Subtest ctm-negative: SUCCESS (0.980s) [196.548272] [064/133] (838s left) syncobj_basic (bad-create-flags) [196.603805] Starting subtest: bad-create-flags [196.604935] Subtest bad-create-flags: SUCCESS (0.000s) [196.731889] [065/133] (838s left) gem_exec_schedule (preemptive-hang) [196.800696] Subtest preemptive-hang: SKIP (0.000s) [197.031151] [066/133] (838s left) gem_mmap_offset (open-flood) [197.091254] Starting subtest: open-flood [218.603414] Subtest open-flood: SUCCESS (21.513s) [218.717478] [067/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [219.215351] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [219.217355] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [219.817519] [068/133] (815s left) syncobj_wait (wait-for-submit-snapshot) [219.878563] Starting subtest: wait-for-submit-snapshot [219.961651] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [220.101344] [069/133] (815s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [220.666707] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [221.073544] [070/133] (814s left) kms_flip (dpms-off-confusion-interruptible) [221.568671] Starting subtest: dpms-off-confusion-interruptible [221.569794] Starting dynamic subtest: A-VGA1 [229.306881] Dynamic subtest A-VGA1: SUCCESS (7.738s) [229.322167] Starting dynamic subtest: B-VGA1 [236.981871] Dynamic subtest B-VGA1: SUCCESS (7.672s) [236.996308] Starting dynamic subtest: A-HDMI-A1 [244.705732] Dynamic subtest A-HDMI-A1: SUCCESS (7.720s) [244.720055] Starting dynamic subtest: B-HDMI-A1 [252.456028] Dynamic subtest B-HDMI-A1: SUCCESS (7.748s) [252.459220] Subtest dpms-off-confusion-interruptible: SUCCESS (30.890s) [253.268723] [071/133] (782s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [253.757136] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [253.759289] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s) [254.360843] [072/133] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [254.855276] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [254.857315] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [255.458588] [073/133] (780s left) perf (non-system-wide-paranoid) [255.629849] Subtest non-system-wide-paranoid: SKIP (0.000s) [255.688452] [074/133] (779s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [256.176246] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [256.482188] [075/133] (779s left) kms_pm_rpm (pm-caching) [268.265364] Subtest pm-caching: SKIP (0.000s) [268.562354] [076/133] (767s left) perf (short-reads) [268.683797] Subtest short-reads: SKIP (0.000s) [268.751661] [077/133] (767s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [269.241221] Starting subtest: plane-all-transition-nonblocking-fencing [269.242322] Starting dynamic subtest: pipe-A-HDMI-A-1 [270.409875] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.167s) [270.505940] Starting dynamic subtest: pipe-B-HDMI-A-1 [271.835594] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.340s) [271.918704] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (2.676s) [272.627472] [078/133] (763s left) gem_busy (busy) [272.701678] Starting subtest: busy [272.702788] Starting dynamic subtest: all-engines [272.725965] Dynamic subtest all-engines: SUCCESS (0.027s) [272.744419] Starting dynamic subtest: rcs0 [272.745473] Dynamic subtest rcs0: SUCCESS (0.018s) [272.765318] Starting dynamic subtest: bcs0 [272.766320] Dynamic subtest bcs0: SUCCESS (0.018s) [272.778643] Starting dynamic subtest: vcs0 [272.789495] Dynamic subtest vcs0: SUCCESS (0.022s) [272.792302] Subtest busy: SUCCESS (0.092s) [273.177669] [079/133] (762s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [273.663664] Starting subtest: extended-pageflip-modeset-hang-oldfb [273.664769] Starting dynamic subtest: pipe-A [279.944561] Dynamic subtest pipe-A: SUCCESS (6.280s) [279.959268] Starting dynamic subtest: pipe-B [285.955480] Dynamic subtest pipe-B: SUCCESS (6.007s) [285.956553] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (12.294s) [286.679301] [080/133] (749s left) kms_fb_coherency (memset-crc) [287.206724] Starting subtest: memset-crc [287.207994] Starting dynamic subtest: mmap-gtt [287.508543] Dynamic subtest mmap-gtt: SUCCESS (0.344s) [287.621203] Starting dynamic subtest: mmap-offset-wc [287.958098] Dynamic subtest mmap-offset-wc: SUCCESS (0.359s) [288.063053] Starting dynamic subtest: mmap-offset-uc [288.416815] Dynamic subtest mmap-offset-uc: SUCCESS (0.375s) [288.524708] Starting dynamic subtest: mmap-legacy-wc [288.861426] Dynamic subtest mmap-legacy-wc: SUCCESS (0.358s) [288.944379] Subtest memset-crc: SUCCESS (1.781s) [289.673490] [081/133] (746s left) gem_vm_create (invalid-create) [289.735684] Subtest invalid-create: SKIP (0.000s) [289.807810] [082/133] (746s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [290.300198] Starting subtest: yf-tiled-8bpp-rotate-270 [290.302291] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [290.909393] [083/133] (745s left) gem_ctx_persistence (saturated-hostile) [290.970906] Subtest saturated-hostile: SKIP (0.000s) [291.038458] [084/133] (745s left) gem_exec_fence (syncobj-timeline-export) [291.347591] Starting subtest: syncobj-timeline-export [291.350125] Subtest syncobj-timeline-export: SUCCESS (0.003s) [291.625406] [085/133] (744s left) syncobj_timeline (wait-zero-handles) [291.680448] Starting subtest: wait-zero-handles [291.681425] Subtest wait-zero-handles: SUCCESS (0.000s) [291.792083] [086/133] (744s left) kms_big_fb (linear-32bpp-rotate-0) [292.294167] Starting subtest: linear-32bpp-rotate-0 [293.768324] Subtest linear-32bpp-rotate-0: SUCCESS (1.475s) [294.422831] [087/133] (741s left) kms_psr (psr-sprite-blt) [294.908339] Subtest psr-sprite-blt: SKIP (0.000s) [295.213189] [088/133] (741s left) gem_eio (wait-10ms) [295.278523] Starting subtest: wait-10ms [295.324318] Subtest wait-10ms: SUCCESS (0.046s) [296.336115] [089/133] (740s left) gem_pxp (verify-pxp-stale-buf-execution) [298.908374] Starting subtest: verify-pxp-stale-buf-execution [298.910631] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [299.044274] [090/133] (737s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [299.534569] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [299.838561] [091/133] (736s left) gem_exec_balancer (nop) [299.897256] Subtest nop: SKIP (0.000s) [300.025865] [092/133] (736s left) kms_psr (fbc-pr-primary-mmap-cpu) [300.512645] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [300.815862] [093/133] (735s left) kms_big_fb (4-tiled-16bpp-rotate-180) [301.312030] Starting subtest: 4-tiled-16bpp-rotate-180 [301.314267] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s) [301.919275] [094/133] (734s left) gem_fenced_exec_thrash (no-spare-fences-busy) [301.981962] Starting subtest: no-spare-fences-busy [304.161722] Subtest no-spare-fences-busy: SUCCESS (2.181s) [304.315916] [095/133] (732s left) gem_mmap_gtt (basic-read-write) [304.372107] Starting subtest: basic-read-write [304.385308] Subtest basic-read-write: SUCCESS (0.015s) [304.536685] [096/133] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [305.027943] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [305.030135] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [305.630329] [097/133] (731s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [306.127613] Starting subtest: short-flip-before-cursor-atomic-transitions [307.141414] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.016s) [307.870795] [098/133] (729s left) kms_cursor_legacy (forked-bo) [308.356583] Starting subtest: forked-bo [308.357731] Starting dynamic subtest: pipe-A [313.796913] Dynamic subtest pipe-A: SUCCESS (5.437s) [313.809920] Starting dynamic subtest: pipe-B [319.269627] Dynamic subtest pipe-B: SUCCESS (5.469s) [319.282303] Starting dynamic subtest: all-pipes [324.714958] Dynamic subtest all-pipes: SUCCESS (5.444s) [324.716362] Subtest forked-bo: SUCCESS (16.358s) [325.331585] [099/133] (711s left) prime_mmap (test_map_unmap) [325.387243] Starting subtest: test_map_unmap [325.388329] Starting dynamic subtest: test_map_unmap-smem [325.390961] Dynamic subtest test_map_unmap-smem: SUCCESS (0.003s) [325.392104] Subtest test_map_unmap: SUCCESS (0.004s) [325.531273] [100/133] (711s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [325.596240] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [325.598519] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [325.814637] [101/133] (711s left) dmabuf (all-tests) [325.875924] Starting subtest: all-tests [325.877153] Starting dynamic subtest: sanitycheck [325.974232] Dynamic subtest sanitycheck: SUCCESS (0.098s) [325.990234] Starting dynamic subtest: dma_fence [326.232378] Dynamic subtest dma_fence: SUCCESS (0.255s) [326.247770] Starting dynamic subtest: dma_fence_chain [336.919343] Dynamic subtest dma_fence_chain: SUCCESS (10.684s) [336.934234] Starting dynamic subtest: dma_fence_unwrap [337.030319] Dynamic subtest dma_fence_unwrap: SUCCESS (0.108s) [337.044642] Starting dynamic subtest: dma_resv [337.137253] Dynamic subtest dma_resv: SUCCESS (0.105s) [337.138718] Subtest all-tests: SUCCESS (11.263s) [337.258594] [102/133] (699s left) kms_flip (plain-flip-fb-recreate-interruptible) [337.751073] Starting subtest: plain-flip-fb-recreate-interruptible [337.753975] Starting dynamic subtest: A-VGA1 [345.758409] Dynamic subtest A-VGA1: SUCCESS (8.006s) [345.773317] Starting dynamic subtest: B-VGA1 [353.733724] Dynamic subtest B-VGA1: SUCCESS (7.972s) [353.748863] Starting dynamic subtest: A-HDMI-A1 [361.740233] Dynamic subtest A-HDMI-A1: SUCCESS (8.004s) [361.755201] Starting dynamic subtest: B-HDMI-A1 [369.776381] Dynamic subtest B-HDMI-A1: SUCCESS (8.033s) [369.780326] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.027s) [370.535756] [103/133] (666s left) kms_psr (fbc-psr2-no-drrs) [371.025970] Subtest fbc-psr2-no-drrs: SKIP (0.000s) [371.322770] [104/133] (665s left) perf_pmu (busy-check-all) [371.383773] Starting subtest: busy-check-all [371.384844] Starting dynamic subtest: rcs0 [371.904691] Dynamic subtest rcs0: SUCCESS (0.520s) [371.920895] Starting dynamic subtest: bcs0 [372.425679] Dynamic subtest bcs0: SUCCESS (0.518s) [372.444628] Starting dynamic subtest: vcs0 [373.449567] Dynamic subtest vcs0: SUCCESS (1.020s) [373.453036] Subtest busy-check-all: SUCCESS (2.067s) [373.591766] [105/133] (663s left) kms_psr (fbc-psr-suspend) [374.078260] Subtest fbc-psr-suspend: SKIP (0.000s) [374.383984] [106/133] (663s left) gem_mmap_gtt (basic) [374.438427] Starting subtest: basic [374.439439] Subtest basic: SUCCESS (0.001s) [374.587805] [107/133] (662s left) perf_pmu (init-busy) [374.647656] Starting subtest: init-busy [374.648788] Starting dynamic subtest: rcs0 [374.649845] Dynamic subtest rcs0: SUCCESS (0.001s) [374.666823] Starting dynamic subtest: bcs0 [374.668390] Dynamic subtest bcs0: SUCCESS (0.000s) [374.687027] Starting dynamic subtest: vcs0 [374.688503] Dynamic subtest vcs0: SUCCESS (0.000s) [374.689790] Subtest init-busy: SUCCESS (0.006s) [374.790896] [108/133] (662s left) i915_suspend (debugfs-reader) [374.848684] Starting subtest: debugfs-reader [393.279239] Subtest debugfs-reader: SUCCESS (2.545s) [405.367809] [109/133] (644s left) gem_ctx_freq (sysfs) [405.439322] Starting subtest: sysfs [405.440548] Starting dynamic subtest: gt0 [410.442218] Dynamic subtest gt0: SUCCESS (4.899s) [410.445906] Subtest sysfs: SUCCESS (4.902s) [410.578654] [110/133] (639s left) kms_plane_multiple (tiling-y) [411.077838] Starting subtest: tiling-y [411.079958] Subtest tiling-y: SKIP (0.000s) [411.693809] [111/133] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [412.191430] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [412.193657] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [412.790133] [112/133] (636s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [412.851471] Starting subtest: etime-single-wait-all-available-unsubmitted [412.960804] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s) [413.109747] [113/133] (636s left) i915_drm_fdinfo (isolation) [413.165754] Subtest isolation: SKIP (0.000s) [413.256239] [114/133] (636s left) gem_exec_reloc (basic-softpin) [413.317695] Starting subtest: basic-softpin [413.318764] Subtest basic-softpin: SUCCESS (0.001s) [414.365805] [115/133] (635s left) kms_frontbuffer_tracking (fbc-2p-rte) [414.859603] Starting subtest: fbc-2p-rte [414.861730] Subtest fbc-2p-rte: SKIP (0.000s) [415.472953] [116/133] (634s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [415.531590] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [415.601299] [117/133] (634s left) gem_render_copy (y-tiled) [415.665706] Starting subtest: y-tiled [415.666760] Starting dynamic subtest: smem [415.731649] Dynamic subtest smem: SUCCESS (0.064s) [415.734647] Subtest y-tiled: SUCCESS (0.066s) [415.975646] [118/133] (634s left) syncobj_timeline (wait-any-snapshot) [416.030938] Starting subtest: wait-any-snapshot [416.114062] Subtest wait-any-snapshot: SUCCESS (0.082s) [416.245853] [119/133] (633s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [416.303028] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [416.304136] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [416.440278] [120/133] (633s left) gem_busy (close-race) [416.508131] Starting subtest: close-race [438.638192] Subtest close-race: SUCCESS (22.078s) [439.040657] [121/133] (611s left) kms_flip (2x-dpms-vs-vblank-race) [439.614371] Starting subtest: 2x-dpms-vs-vblank-race [439.617268] Starting dynamic subtest: AB-VGA1-HDMI-A1 [450.428672] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.809s) [450.429673] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.813s) [451.176478] [122/133] (599s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [451.691805] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [452.800599] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.109s) [453.436703] [123/133] (596s left) perf_pmu (frequency) [453.495030] Starting subtest: frequency [453.497643] Starting dynamic subtest: gt0 [455.607773] Dynamic subtest gt0: SUCCESS (2.107s) [455.628613] Starting dynamic subtest: idle-gt0 [456.114242] Dynamic subtest idle-gt0: SUCCESS (0.504s) [456.115616] Subtest frequency: SUCCESS (2.619s) [456.247213] [124/133] (594s left) kms_lease (lease-unleased-connector) [456.732906] Starting subtest: lease-unleased-connector [456.733957] Starting dynamic subtest: pipe-A-HDMI-A-1 [456.796259] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.060s) [456.811668] Starting dynamic subtest: pipe-B-HDMI-A-1 [456.853537] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.057s) [456.854703] Subtest lease-unleased-connector: SUCCESS (0.123s) [457.468167] [125/133] (593s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [457.964786] Starting subtest: psr-rgb565-draw-render [457.966863] Subtest psr-rgb565-draw-render: SKIP (0.000s) [458.578966] [126/133] (592s left) i915_hangman (engine-engine-error) [458.639261] Subtest engine-engine-error: SKIP (0.000s) [458.726692] [127/133] (591s left) gem_exec_fence (basic-wait) [458.902113] Subtest basic-wait: SKIP (0.000s) [459.309924] [128/133] (591s left) kms_cursor_crc (cursor-rapid-movement-max-size) [459.803605] Starting subtest: cursor-rapid-movement-max-size [459.806713] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [460.391833] [129/133] (590s left) kms_cursor_crc (cursor-offscreen-128x42) [460.889444] Starting subtest: cursor-offscreen-128x42 [460.945689] Subtest cursor-offscreen-128x42: SKIP (0.056s) [461.561455] [130/133] (589s left) gem_ctx_engines (invalid-engines) [461.627208] Starting subtest: invalid-engines [461.632549] Subtest invalid-engines: SUCCESS (0.005s) [461.906915] [131/133] (588s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [462.400902] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [462.403120] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [463.006199] [132/133] (587s left) gem_flink_race (flink_close) [463.059467] Starting subtest: flink_close [468.097650] Subtest flink_close: SUCCESS (5.035s) [468.232924] [133/133] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [468.731607] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [468.734604] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [469.343359] Closing watchdogs results: parsing output: 0/ for test: i915_pm_rps results: parsing output: 1/ for test: gem_softpin results: parsing output: 2/ for test: gem_exec_whisper results: parsing output: 3/ for test: syncobj_wait results: parsing output: 4/ for test: kms_plane_scaling results: parsing output: 5/ for test: gen9_exec_parse results: parsing output: 6/ for test: gem_flink_race results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: api_intel_bb results: parsing output: 9/ for test: gem_mmap_gtt results: parsing output: 10/ for test: gem_exec_fence results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_atomic_transition results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_flip results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: gem_ctx_param results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_vblank results: parsing output: 21/ for test: gem_mmap_gtt results: parsing output: 22/ for test: kms_joiner results: parsing output: 23/ for test: kms_pm_rpm results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: kms_getfb results: parsing output: 26/ for test: kms_flip_scaled_crc results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: api_intel_allocator results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_chamelium_hpd results: parsing output: 34/ for test: gem_pwrite results: parsing output: 35/ for test: kms_cursor_legacy results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_pm_backlight results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: kms_sequence results: parsing output: 43/ for test: kms_concurrent results: parsing output: 44/ for test: gem_exec_schedule results: parsing output: 45/ for test: prime_vgem results: parsing output: 46/ for test: kms_hdmi_inject results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: kms_pipe_crc_basic results: parsing output: 52/ for test: gem_ctx_shared results: parsing output: 53/ for test: kms_async_flips results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: syncobj_wait results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: prime_mmap results: parsing output: 59/ for test: gem_mmap_gtt results: parsing output: 60/ for test: gem_huc_copy results: parsing output: 61/ for test: gem_exec_reloc results: parsing output: 62/ for test: kms_color results: parsing output: 63/ for test: syncobj_basic results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: gem_mmap_offset results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_chamelium_edid results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: kms_plane results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: perf results: parsing output: 73/ for test: kms_psr2_sf results: parsing output: 74/ for test: kms_pm_rpm results: parsing output: 75/ for test: perf results: parsing output: 76/ for test: kms_atomic_transition results: parsing output: 77/ for test: gem_busy results: parsing output: 78/ for test: kms_busy results: parsing output: 79/ for test: kms_fb_coherency results: parsing output: 80/ for test: gem_vm_create results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: gem_ctx_persistence results: parsing output: 83/ for test: gem_exec_fence results: parsing output: 84/ for test: syncobj_timeline results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: gem_eio results: parsing output: 88/ for test: gem_pxp results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: gem_exec_balancer results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: gem_fenced_exec_thrash results: parsing output: 94/ for test: gem_mmap_gtt results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: prime_mmap results: parsing output: 99/ for test: gem_render_copy results: parsing output: 100/ for test: dmabuf results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: perf_pmu results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: gem_mmap_gtt results: parsing output: 106/ for test: perf_pmu results: parsing output: 107/ for test: i915_suspend results: parsing output: 108/ for test: gem_ctx_freq results: parsing output: 109/ for test: kms_plane_multiple results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: i915_drm_fdinfo results: parsing output: 113/ for test: gem_exec_reloc results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_flip_scaled_crc results: parsing output: 116/ for test: gem_render_copy results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gem_busy results: parsing output: 120/ for test: kms_flip results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: perf_pmu results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: i915_hangman results: parsing output: 126/ for test: gem_exec_fence results: parsing output: 127/ for test: kms_cursor_crc results: parsing output: 128/ for test: kms_cursor_crc results: parsing output: 129/ for test: gem_ctx_engines results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_flink_race results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.