[68.260721] Initializing watchdogs [68.260846] /dev/watchdog0 [68.283559] [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) [68.291215] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [68.294945] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [68.298590] [001/133] (960s left) i915_pm_rps (basic-api) [68.373623] Starting subtest: basic-api [68.377472] Subtest basic-api: SUCCESS (0.004s) [68.495407] [002/133] (960s left) gem_softpin (safe-alignment) [68.553852] Starting subtest: safe-alignment [68.561974] Subtest safe-alignment: SUCCESS (0.010s) [68.697223] [003/133] (960s left) gem_exec_whisper (basic-fds-forked) [68.762445] Starting subtest: basic-fds-forked [71.200763] Subtest basic-fds-forked: SUCCESS (2.436s) [71.425081] [004/133] (957s left) syncobj_wait (single-wait-signaled) [71.480532] Starting subtest: single-wait-signaled [71.481572] Subtest single-wait-signaled: SUCCESS (0.000s) [71.590953] [005/133] (957s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [72.094489] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [72.095529] Starting dynamic subtest: pipe-A [72.098637] Dynamic subtest pipe-A: SKIP (0.001s) [72.112121] Starting dynamic subtest: pipe-B [72.115103] Dynamic subtest pipe-B: SKIP (0.001s) [72.117094] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.003s) [72.707675] [006/133] (956s left) gen9_exec_parse (cmd-crossing-page) [72.765366] Subtest cmd-crossing-page: SKIP (0.000s) [72.819079] [007/133] (956s left) gem_flink_race (flink_name) [72.872957] Starting subtest: flink_name [78.250317] Subtest flink_name: SUCCESS (5.374s) [78.383338] [008/133] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [78.882049] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [78.884404] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [79.480778] [009/133] (949s left) api_intel_bb (render) [79.582082] Starting subtest: render [79.583934] Starting dynamic subtest: render-none-512 [79.678547] Dynamic subtest render-none-512: SUCCESS (0.097s) [79.688531] Starting dynamic subtest: render-none-reloc-512 [79.763835] Dynamic subtest render-none-reloc-512: SUCCESS (0.084s) [79.776041] Starting dynamic subtest: render-none-1024 [80.095601] Dynamic subtest render-none-1024: SUCCESS (0.331s) [80.107840] Starting dynamic subtest: render-none-reloc-1024 [80.422176] Dynamic subtest render-none-reloc-1024: SUCCESS (0.326s) [80.433349] Starting dynamic subtest: render-x-512 [80.498762] Dynamic subtest render-x-512: SUCCESS (0.076s) [80.509097] Starting dynamic subtest: render-x-reloc-512 [80.573159] Dynamic subtest render-x-reloc-512: SUCCESS (0.074s) [80.583291] Starting dynamic subtest: render-x-1024 [80.866158] Dynamic subtest render-x-1024: SUCCESS (0.292s) [80.876276] Starting dynamic subtest: render-x-reloc-1024 [81.156258] Dynamic subtest render-x-reloc-1024: SUCCESS (0.288s) [81.166401] Starting dynamic subtest: render-y-512 [81.229366] Dynamic subtest render-y-512: SUCCESS (0.074s) [81.239472] Starting dynamic subtest: render-y-reloc-512 [81.303656] Dynamic subtest render-y-reloc-512: SUCCESS (0.074s) [81.313735] Starting dynamic subtest: render-y-1024 [81.592677] Dynamic subtest render-y-1024: SUCCESS (0.288s) [81.602797] Starting dynamic subtest: render-y-reloc-1024 [81.899848] Dynamic subtest render-y-reloc-1024: SUCCESS (0.307s) [81.901156] Subtest render: SUCCESS (2.318s) [82.049131] [010/133] (947s left) gem_mmap_gtt (basic-small-copy-xy) [82.104851] Starting subtest: basic-small-copy-XY [82.765480] Subtest basic-small-copy-XY: SUCCESS (0.661s) [82.916422] [011/133] (946s left) gem_exec_fence (basic-busy-all) [83.068569] Starting subtest: basic-busy-all [83.100924] Subtest basic-busy-all: SUCCESS (0.032s) [83.644564] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [83.647103] [012/133] (945s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [84.157946] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [84.160112] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [84.763445] [013/133] (944s left) kms_atomic_transition (plane-toggle-modeset-transition) [85.263029] Starting subtest: plane-toggle-modeset-transition [85.264134] Starting dynamic subtest: pipe-A-HDMI-A-1 [86.259918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.994s) [86.272782] Starting dynamic subtest: pipe-B-HDMI-A-1 [87.199116] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.936s) [87.200310] Subtest plane-toggle-modeset-transition: SUCCESS (1.936s) [87.922485] [014/133] (941s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [88.438349] Starting subtest: fbcpsr-rgb565-draw-pwrite [88.440438] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s) [89.047626] [015/133] (940s left) kms_flip (2x-modeset-vs-vblank-race) [89.546161] Starting subtest: 2x-modeset-vs-vblank-race [89.548608] Starting dynamic subtest: AB-VGA1-HDMI-A1 [100.537616] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.988s) [100.540426] Subtest 2x-modeset-vs-vblank-race: SUCCESS (10.992s) [101.359942] [016/133] (928s left) gem_mmap_gtt (basic-small-bo-tiledy) [101.431160] Starting subtest: basic-small-bo-tiledY [101.685727] Subtest basic-small-bo-tiledY: SUCCESS (0.255s) [101.851435] [017/133] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [102.446240] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [102.448424] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [103.038792] [018/133] (926s left) perf (polling-small-buf) [103.211492] Subtest polling-small-buf: SKIP (0.000s) [103.264713] [019/133] (926s left) gem_ctx_param (non-root-set) [103.321430] Starting subtest: non-root-set [103.342171] Subtest non-root-set: SUCCESS (0.022s) [103.453021] [020/133] (926s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [103.959730] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [103.964251] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.001s) [104.574961] [021/133] (925s left) kms_vblank (wait-forked-hang) [105.066292] Starting subtest: wait-forked-hang [105.067381] Starting dynamic subtest: pipe-A-HDMI-A-1 [110.987480] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.919s) [111.000448] Starting dynamic subtest: pipe-B-HDMI-A-1 [116.923935] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.934s) [116.925084] Subtest wait-forked-hang: SUCCESS (11.859s) [117.636093] [022/133] (912s left) gem_mmap_gtt (cpuset-medium-copy-odd) [117.694935] Starting subtest: cpuset-medium-copy-odd [119.337468] Subtest cpuset-medium-copy-odd: SUCCESS (1.643s) [119.487163] [023/133] (910s left) kms_joiner (invalid-modeset-force-ultra-joiner) [120.069934] Starting subtest: invalid-modeset-force-ultra-joiner [120.072133] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [120.686480] [024/133] (909s left) kms_pm_rpm (basic-rte) [120.740256] Starting subtest: basic-rte [132.527362] Subtest basic-rte: SKIP (11.783s) [132.834111] [025/133] (897s left) gem_exec_fence (syncobj-wait) [133.045397] Starting subtest: syncobj-wait [133.082926] Subtest syncobj-wait: SUCCESS (0.037s) [133.473580] [026/133] (896s left) kms_getfb (getfb-repeated-different-handles) [133.963596] Starting subtest: getfb-repeated-different-handles [133.964607] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [134.569407] [027/133] (895s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [134.624572] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s) [134.686796] [028/133] (895s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [134.745509] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s) [134.794570] [029/133] (895s left) kms_cursor_crc (cursor-sliding-512x512) [135.290043] Starting subtest: cursor-sliding-512x512 [135.293423] Subtest cursor-sliding-512x512: SKIP (0.001s) [135.901918] [030/133] (894s left) api_intel_allocator (reserve-simple) [135.958475] Starting subtest: reserve-simple [135.961476] Subtest reserve-simple: SUCCESS (0.004s) [136.115752] [031/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [136.607142] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [136.609204] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [137.212919] [032/133] (893s left) kms_big_fb (4-tiled-8bpp-rotate-270) [137.713183] Starting subtest: 4-tiled-8bpp-rotate-270 [137.715242] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s) [138.311789] [033/133] (892s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [138.804131] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [140.293812] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (1.491s) [140.922227] [034/133] (889s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [141.491645] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [141.895516] [035/133] (888s left) gem_pwrite (basic-self) [141.951108] Starting subtest: basic-self [142.038513] Subtest basic-self: SUCCESS (0.087s) [142.173526] [036/133] (888s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [142.666678] Starting subtest: basic-flip-before-cursor-atomic [143.648194] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.981s) [144.364505] [037/133] (886s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [144.423426] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [144.476887] [038/133] (886s left) kms_pm_backlight (bad-brightness) [144.965244] Subtest bad-brightness: SKIP (0.000s) [145.257333] [039/133] (885s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [145.746840] Starting subtest: 2x-long-cursor-vs-flip-legacy [145.750800] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s) [146.362696] [040/133] (884s left) kms_big_fb (y-tiled-32bpp-rotate-0) [146.856954] Starting subtest: y-tiled-32bpp-rotate-0 [146.859319] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [147.463861] [041/133] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [147.956315] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [147.958415] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [148.557730] [042/133] (882s left) kms_psr (fbc-psr-primary-mmap-cpu) [149.052374] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [149.351401] [043/133] (881s left) kms_sequence (get-forked-busy) [149.838687] Starting subtest: get-forked-busy [149.841689] Starting dynamic subtest: pipe-A-HDMI-A-1 [152.250457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.409s) [152.264260] Starting dynamic subtest: pipe-B-HDMI-A-1 [154.721319] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.468s) [154.722383] Subtest get-forked-busy: SUCCESS (4.883s) [155.435421] [044/133] (875s left) kms_concurrent (multi-plane-atomic-lowres) [155.927516] Starting subtest: multi-plane-atomic-lowres [155.930919] Starting dynamic subtest: pipe-A-HDMI-A-1 [156.427259] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.498s) [156.428470] Subtest multi-plane-atomic-lowres: SUCCESS (0.501s) [157.146653] [045/133] (873s left) gem_exec_schedule (reorder-wide) [157.225416] Subtest reorder-wide: SKIP (0.000s) [157.461754] [046/133] (873s left) prime_vgem (basic-write) [157.532208] Starting subtest: basic-write [157.551133] Subtest basic-write: SUCCESS (0.019s) [157.692549] [047/133] (873s left) kms_hdmi_inject (inject-4k) [157.825864] Starting subtest: inject-4k [157.828165] Subtest inject-4k: SKIP (0.000s) [158.057020] [048/133] (873s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [158.111875] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s) [158.170224] [049/133] (873s left) syncobj_timeline (invalid-query-zero-handles) [158.229413] Starting subtest: invalid-query-zero-handles [158.230498] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [158.341992] [050/133] (872s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [158.402235] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [158.508301] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [158.624220] [051/133] (872s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [158.679731] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s) [158.734827] [052/133] (872s left) kms_pipe_crc_basic (nonblocking-crc) [159.227150] Starting subtest: nonblocking-crc [159.228234] Starting dynamic subtest: pipe-A-HDMI-A-1 [159.803522] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.576s) [159.816959] Starting dynamic subtest: pipe-B-HDMI-A-1 [160.398587] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.592s) [160.399642] Subtest nonblocking-crc: SUCCESS (1.173s) [161.122421] [053/133] (870s left) gem_ctx_shared (q-smoketest) [161.184916] Subtest Q-smoketest: SKIP (0.000s) [161.306796] [054/133] (870s left) kms_async_flips (async-flip-dpms) [161.794839] Starting subtest: async-flip-dpms [161.940245] Starting dynamic subtest: pipe-A-HDMI-A-1 [174.123920] Dynamic subtest pipe-A-HDMI-A-1: SKIP (12.182s) [174.287266] Starting dynamic subtest: pipe-B-HDMI-A-1 [186.446019] Dynamic subtest pipe-B-HDMI-A-1: SKIP (12.170s) [186.448601] Subtest async-flip-dpms: SKIP (24.653s) [187.294602] [055/133] (844s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [187.355340] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s) [187.421328] [056/133] (844s left) kms_psr (psr-cursor-plane-move) [187.907289] Subtest psr-cursor-plane-move: SKIP (0.000s) [188.200301] [057/133] (843s left) syncobj_wait (invalid-signal-illegal-handle) [188.261609] Starting subtest: invalid-signal-illegal-handle [188.262770] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [188.391480] [058/133] (843s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [188.885449] Starting subtest: psr-rgb101010-draw-mmap-cpu [188.887475] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [189.488902] [059/133] (842s left) prime_mmap (test_aperture_limit) [189.548482] Starting subtest: test_aperture_limit [189.549529] Starting dynamic subtest: test_aperture_limit-smem [189.558280] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.010s) [189.559348] Subtest test_aperture_limit: SUCCESS (0.012s) [189.687711] [060/133] (842s left) gem_mmap_gtt (basic-write-read) [189.745204] Starting subtest: basic-write-read [189.759564] Subtest basic-write-read: SUCCESS (0.015s) [189.907063] [061/133] (841s left) gem_huc_copy (huc-copy) [189.963895] Subtest huc-copy: SKIP (0.000s) [190.034396] [062/133] (841s left) gem_exec_reloc (basic-gtt-wc-active) [190.094907] Starting subtest: basic-gtt-wc-active [190.204219] Subtest basic-gtt-wc-active: SUCCESS (0.110s) [191.219733] [063/133] (840s left) kms_color (ctm-negative) [191.708782] Starting subtest: ctm-negative [191.709936] Starting dynamic subtest: pipe-A-HDMI-A-1 [192.166804] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.458s) [192.178705] Starting dynamic subtest: pipe-B-HDMI-A-1 [192.675784] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.506s) [192.676950] Subtest ctm-negative: SUCCESS (0.968s) [193.395115] [064/133] (838s left) syncobj_basic (bad-create-flags) [193.454729] Starting subtest: bad-create-flags [193.455833] Subtest bad-create-flags: SUCCESS (0.000s) [193.579887] [065/133] (838s left) gem_exec_schedule (preemptive-hang) [193.651413] Subtest preemptive-hang: SKIP (0.000s) [193.883833] [066/133] (838s left) gem_mmap_offset (open-flood) [193.940361] Starting subtest: open-flood [215.450514] Subtest open-flood: SUCCESS (21.512s) [215.600441] [067/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [216.094800] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [216.096991] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [216.699511] [068/133] (815s left) syncobj_wait (wait-for-submit-snapshot) [216.755192] Starting subtest: wait-for-submit-snapshot [216.836776] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [216.951528] [069/133] (815s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [217.516273] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [217.921339] [070/133] (814s left) kms_flip (dpms-off-confusion-interruptible) [218.424392] Starting subtest: dpms-off-confusion-interruptible [218.427159] Starting dynamic subtest: A-VGA1 [226.159412] Dynamic subtest A-VGA1: SUCCESS (7.733s) [226.174051] Starting dynamic subtest: B-VGA1 [233.836866] Dynamic subtest B-VGA1: SUCCESS (7.675s) [233.851296] Starting dynamic subtest: A-HDMI-A1 [241.563294] Dynamic subtest A-HDMI-A1: SUCCESS (7.723s) [241.577277] Starting dynamic subtest: B-HDMI-A1 [249.315205] Dynamic subtest B-HDMI-A1: SUCCESS (7.748s) [249.316302] Subtest dpms-off-confusion-interruptible: SUCCESS (30.891s) [250.102221] [071/133] (782s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [250.590620] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [250.592837] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s) [251.200209] [072/133] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [251.693126] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [251.695305] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [252.300777] [073/133] (780s left) perf (non-system-wide-paranoid) [252.472274] Subtest non-system-wide-paranoid: SKIP (0.000s) [252.529337] [074/133] (779s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [253.018281] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [253.308118] [075/133] (779s left) kms_pm_rpm (pm-caching) [265.091981] Subtest pm-caching: SKIP (0.000s) [265.382524] [076/133] (767s left) perf (short-reads) [265.525358] Subtest short-reads: SKIP (0.000s) [265.582269] [077/133] (767s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [266.065595] Starting subtest: plane-all-transition-nonblocking-fencing [266.066760] Starting dynamic subtest: pipe-A-HDMI-A-1 [267.234339] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.167s) [267.331969] Starting dynamic subtest: pipe-B-HDMI-A-1 [268.640703] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.322s) [268.724085] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (2.658s) [269.423714] [078/133] (763s left) gem_busy (busy) [269.495191] Starting subtest: busy [269.496318] Starting dynamic subtest: all-engines [269.520869] Dynamic subtest all-engines: SUCCESS (0.027s) [269.537338] Starting dynamic subtest: rcs0 [269.545482] Dynamic subtest rcs0: SUCCESS (0.023s) [269.562854] Starting dynamic subtest: bcs0 [269.568551] Dynamic subtest bcs0: SUCCESS (0.021s) [269.591923] Starting dynamic subtest: vcs0 [269.593542] Dynamic subtest vcs0: SUCCESS (0.023s) [269.594663] Subtest busy: SUCCESS (0.102s) [269.975682] [079/133] (762s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [270.467414] Starting subtest: extended-pageflip-modeset-hang-oldfb [270.468508] Starting dynamic subtest: pipe-A [276.924967] Dynamic subtest pipe-A: SUCCESS (6.457s) [276.939784] Starting dynamic subtest: pipe-B [282.950420] Dynamic subtest pipe-B: SUCCESS (6.022s) [282.951454] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (12.485s) [283.667829] [080/133] (749s left) kms_fb_coherency (memset-crc) [284.159249] Starting subtest: memset-crc [284.160332] Starting dynamic subtest: mmap-gtt [284.513753] Dynamic subtest mmap-gtt: SUCCESS (0.353s) [284.611815] Starting dynamic subtest: mmap-offset-wc [284.985644] Dynamic subtest mmap-offset-wc: SUCCESS (0.388s) [285.065052] Starting dynamic subtest: mmap-offset-uc [285.453558] Dynamic subtest mmap-offset-uc: SUCCESS (0.399s) [285.551076] Starting dynamic subtest: mmap-legacy-wc [285.898744] Dynamic subtest mmap-legacy-wc: SUCCESS (0.358s) [285.982139] Subtest memset-crc: SUCCESS (1.823s) [286.696425] [081/133] (746s left) gem_vm_create (invalid-create) [286.755567] Subtest invalid-create: SKIP (0.000s) [286.824717] [082/133] (746s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [287.325407] Starting subtest: yf-tiled-8bpp-rotate-270 [287.327455] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [287.941098] [083/133] (745s left) gem_ctx_persistence (saturated-hostile) [288.002346] Subtest saturated-hostile: SKIP (0.000s) [288.068682] [084/133] (744s left) gem_exec_fence (syncobj-timeline-export) [288.388377] Starting subtest: syncobj-timeline-export [288.391133] Subtest syncobj-timeline-export: SUCCESS (0.003s) [288.656366] [085/133] (744s left) syncobj_timeline (wait-zero-handles) [288.712303] Starting subtest: wait-zero-handles [288.713395] Subtest wait-zero-handles: SUCCESS (0.000s) [288.822604] [086/133] (744s left) kms_big_fb (linear-32bpp-rotate-0) [289.326400] Starting subtest: linear-32bpp-rotate-0 [290.819189] Subtest linear-32bpp-rotate-0: SUCCESS (1.494s) [291.467383] [087/133] (741s left) kms_psr (psr-sprite-blt) [291.955407] Subtest psr-sprite-blt: SKIP (0.000s) [292.274972] [088/133] (741s left) gem_eio (wait-10ms) [292.338709] Starting subtest: wait-10ms [292.382241] Subtest wait-10ms: SUCCESS (0.041s) [293.423086] [089/133] (739s left) gem_pxp (verify-pxp-stale-buf-execution) [295.994733] Starting subtest: verify-pxp-stale-buf-execution [295.996917] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [296.126132] [090/133] (737s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [296.615382] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [296.921593] [091/133] (736s left) gem_exec_balancer (nop) [296.987593] Subtest nop: SKIP (0.000s) [297.107983] [092/133] (736s left) kms_psr (fbc-pr-primary-mmap-cpu) [297.597364] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [297.901027] [093/133] (735s left) kms_big_fb (4-tiled-16bpp-rotate-180) [298.397977] Starting subtest: 4-tiled-16bpp-rotate-180 [298.401303] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s) [299.003319] [094/133] (734s left) gem_fenced_exec_thrash (no-spare-fences-busy) [299.065471] Starting subtest: no-spare-fences-busy [301.221745] Subtest no-spare-fences-busy: SUCCESS (2.157s) [301.397554] [095/133] (732s left) gem_mmap_gtt (basic-read-write) [301.458077] Starting subtest: basic-read-write [301.472361] Subtest basic-read-write: SUCCESS (0.015s) [301.615188] [096/133] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [302.103327] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [302.105358] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [302.713970] [097/133] (731s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [303.198928] Starting subtest: short-flip-before-cursor-atomic-transitions [304.196234] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.994s) [304.890452] [098/133] (728s left) kms_cursor_legacy (forked-bo) [305.380257] Starting subtest: forked-bo [305.381358] Starting dynamic subtest: pipe-A [310.815416] Dynamic subtest pipe-A: SUCCESS (5.432s) [310.827553] Starting dynamic subtest: pipe-B [316.263461] Dynamic subtest pipe-B: SUCCESS (5.446s) [316.277127] Starting dynamic subtest: all-pipes [321.716593] Dynamic subtest all-pipes: SUCCESS (5.452s) [321.717752] Subtest forked-bo: SUCCESS (16.336s) [322.321316] [099/133] (711s left) prime_mmap (test_map_unmap) [322.380214] Starting subtest: test_map_unmap [322.381298] Starting dynamic subtest: test_map_unmap-smem [322.382315] Dynamic subtest test_map_unmap-smem: SUCCESS (0.003s) [322.384342] Subtest test_map_unmap: SUCCESS (0.004s) [322.515883] [100/133] (711s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [322.577518] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [322.580311] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [322.820621] [101/133] (711s left) dmabuf (all-tests) [322.883030] Starting subtest: all-tests [322.884145] Starting dynamic subtest: sanitycheck [322.985266] Dynamic subtest sanitycheck: SUCCESS (0.100s) [322.999342] Starting dynamic subtest: dma_fence [323.215503] Dynamic subtest dma_fence: SUCCESS (0.229s) [323.233883] Starting dynamic subtest: dma_fence_chain [333.925236] Dynamic subtest dma_fence_chain: SUCCESS (10.704s) [333.941529] Starting dynamic subtest: dma_fence_unwrap [334.014226] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s) [334.029702] Starting dynamic subtest: dma_resv [334.096330] Dynamic subtest dma_resv: SUCCESS (0.079s) [334.097704] Subtest all-tests: SUCCESS (11.216s) [334.213907] [102/133] (699s left) kms_flip (plain-flip-fb-recreate-interruptible) [334.707655] Starting subtest: plain-flip-fb-recreate-interruptible [334.710453] Starting dynamic subtest: A-VGA1 [342.730788] Dynamic subtest A-VGA1: SUCCESS (8.021s) [342.747960] Starting dynamic subtest: B-VGA1 [350.711368] Dynamic subtest B-VGA1: SUCCESS (7.977s) [350.726722] Starting dynamic subtest: A-HDMI-A1 [358.746846] Dynamic subtest A-HDMI-A1: SUCCESS (8.032s) [358.760986] Starting dynamic subtest: B-HDMI-A1 [366.781473] Dynamic subtest B-HDMI-A1: SUCCESS (8.032s) [366.785023] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.076s) [367.553408] [103/133] (666s left) kms_psr (fbc-psr2-no-drrs) [368.045535] Subtest fbc-psr2-no-drrs: SKIP (0.000s) [368.362255] [104/133] (665s left) perf_pmu (busy-check-all) [368.420387] Starting subtest: busy-check-all [368.421502] Starting dynamic subtest: rcs0 [368.941609] Dynamic subtest rcs0: SUCCESS (0.520s) [368.957488] Starting dynamic subtest: bcs0 [369.466462] Dynamic subtest bcs0: SUCCESS (0.522s) [369.481537] Starting dynamic subtest: vcs0 [370.492393] Dynamic subtest vcs0: SUCCESS (1.023s) [370.495799] Subtest busy-check-all: SUCCESS (2.073s) [370.629307] [105/133] (663s left) kms_psr (fbc-psr-suspend) [371.121681] Subtest fbc-psr-suspend: SKIP (0.000s) [371.421674] [106/133] (662s left) gem_mmap_gtt (basic) [371.477251] Starting subtest: basic [371.478459] Subtest basic: SUCCESS (0.001s) [371.620292] [107/133] (662s left) perf_pmu (init-busy) [371.677773] Starting subtest: init-busy [371.680190] Starting dynamic subtest: rcs0 [371.681196] Dynamic subtest rcs0: SUCCESS (0.001s) [371.697568] Starting dynamic subtest: bcs0 [371.698932] Dynamic subtest bcs0: SUCCESS (0.000s) [371.719736] Starting dynamic subtest: vcs0 [371.721079] Dynamic subtest vcs0: SUCCESS (0.001s) [371.722338] Subtest init-busy: SUCCESS (0.006s) [371.799791] [108/133] (662s left) i915_suspend (debugfs-reader) [371.857411] Starting subtest: debugfs-reader [390.791123] Subtest debugfs-reader: SUCCESS (2.525s) [402.864721] [109/133] (643s left) gem_ctx_freq (sysfs) [402.932216] Starting subtest: sysfs [402.933344] Starting dynamic subtest: gt0 [407.927208] Dynamic subtest gt0: SUCCESS (4.866s) [407.930775] Subtest sysfs: SUCCESS (4.869s) [408.075130] [110/133] (638s left) kms_plane_multiple (tiling-y) [408.571631] Starting subtest: tiling-y [408.573813] Subtest tiling-y: SKIP (0.000s) [409.194318] [111/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [409.697312] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [409.699598] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [410.310714] [112/133] (636s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [410.368472] Starting subtest: etime-single-wait-all-available-unsubmitted [410.476650] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s) [410.615969] [113/133] (636s left) i915_drm_fdinfo (isolation) [410.677730] Subtest isolation: SKIP (0.000s) [410.747977] [114/133] (635s left) gem_exec_reloc (basic-softpin) [410.807361] Starting subtest: basic-softpin [410.808487] Subtest basic-softpin: SUCCESS (0.001s) [411.864217] [115/133] (634s left) kms_frontbuffer_tracking (fbc-2p-rte) [412.369459] Starting subtest: fbc-2p-rte [412.371571] Subtest fbc-2p-rte: SKIP (0.000s) [412.993645] [116/133] (633s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [413.050952] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [413.121093] [117/133] (633s left) gem_render_copy (y-tiled) [413.189666] Starting subtest: y-tiled [413.190684] Starting dynamic subtest: smem [413.253685] Dynamic subtest smem: SUCCESS (0.064s) [413.254832] Subtest y-tiled: SUCCESS (0.066s) [413.497968] [118/133] (633s left) syncobj_timeline (wait-any-snapshot) [413.560415] Starting subtest: wait-any-snapshot [413.641787] Subtest wait-any-snapshot: SUCCESS (0.081s) [413.782561] [119/133] (633s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [413.839997] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [413.841135] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [413.970001] [120/133] (633s left) gem_busy (close-race) [414.035761] Starting subtest: close-race [436.170168] Subtest close-race: SUCCESS (22.057s) [436.554636] [121/133] (610s left) kms_flip (2x-dpms-vs-vblank-race) [437.136144] Starting subtest: 2x-dpms-vs-vblank-race [437.138997] Starting dynamic subtest: AB-VGA1-HDMI-A1 [447.878818] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.738s) [447.881539] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.741s) [448.627746] [122/133] (598s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [449.146277] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [450.238415] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.092s) [450.872171] [123/133] (596s left) perf_pmu (frequency) [450.934238] Starting subtest: frequency [450.936812] Starting dynamic subtest: gt0 [453.030284] Dynamic subtest gt0: SUCCESS (2.090s) [453.054191] Starting dynamic subtest: idle-gt0 [453.537393] Dynamic subtest idle-gt0: SUCCESS (0.505s) [453.538496] Subtest frequency: SUCCESS (2.603s) [453.652828] [124/133] (593s left) kms_lease (lease-unleased-connector) [454.139760] Starting subtest: lease-unleased-connector [454.140807] Starting dynamic subtest: pipe-A-HDMI-A-1 [454.200457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.060s) [454.217320] Starting dynamic subtest: pipe-B-HDMI-A-1 [454.265009] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.061s) [454.266100] Subtest lease-unleased-connector: SUCCESS (0.127s) [454.884538] [125/133] (592s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [455.378717] Starting subtest: psr-rgb565-draw-render [455.380870] Subtest psr-rgb565-draw-render: SKIP (0.000s) [455.984827] [126/133] (591s left) i915_hangman (engine-engine-error) [456.047447] Subtest engine-engine-error: SKIP (0.000s) [456.125214] [127/133] (591s left) gem_exec_fence (basic-wait) [456.297079] Subtest basic-wait: SKIP (0.000s) [456.703598] [128/133] (590s left) kms_cursor_crc (cursor-rapid-movement-max-size) [457.201864] Starting subtest: cursor-rapid-movement-max-size [457.204970] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [457.814122] [129/133] (589s left) kms_cursor_crc (cursor-offscreen-128x42) [458.301464] Starting subtest: cursor-offscreen-128x42 [458.359374] Subtest cursor-offscreen-128x42: SKIP (0.055s) [458.959195] [130/133] (588s left) gem_ctx_engines (invalid-engines) [459.029769] Starting subtest: invalid-engines [459.037109] Subtest invalid-engines: SUCCESS (0.008s) [459.316187] [131/133] (588s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [459.816534] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [459.818678] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [460.442253] [132/133] (587s left) gem_flink_race (flink_close) [460.496360] Starting subtest: flink_close [465.534534] Subtest flink_close: SUCCESS (5.035s) [465.669397] [133/133] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [466.160756] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [466.162755] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [466.764705] 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.