[48.870993] Initializing watchdogs [48.871169] /dev/watchdog0 [48.880346] [001/170] (960s left) i915_module_load (load) [49.009678] Starting subtest: load [50.925435] Subtest load: SUCCESS (1.914s) [50.978213] [002/170] (958s left) core_auth (basic-auth) [51.321632] Starting subtest: basic-auth [51.324808] Subtest basic-auth: SUCCESS (0.001s) [51.381988] [003/170] (958s left) debugfs_test (read_all_entries) [51.512705] Starting subtest: read_all_entries [51.574694] Subtest read_all_entries: SUCCESS (0.061s) [52.593566] [004/170] (956s left) debugfs_test (basic-hwmon) [52.721943] Starting subtest: basic-hwmon [52.725209] Subtest basic-hwmon: SKIP (0.000s) [53.744360] [005/170] (955s left) fbdev (eof) [53.885160] Starting subtest: eof [53.887246] Subtest eof: SUCCESS (0.000s) [53.944415] [006/170] (955s left) fbdev (info) [54.062331] Starting subtest: info [54.064379] Subtest info: SUCCESS (0.000s) [54.131660] [007/170] (955s left) fbdev (nullptr) [54.251401] Starting subtest: nullptr [54.253136] Subtest nullptr: SUCCESS (0.000s) [54.311070] [008/170] (955s left) fbdev (read) [54.433373] Starting subtest: read [54.636990] Subtest read: SUCCESS (0.203s) [54.692961] [009/170] (954s left) fbdev (write) [54.816171] Starting subtest: write [54.916366] Subtest write: SUCCESS (0.100s) [54.975892] [010/170] (954s left) gem_basic (bad-close) [55.100918] Starting subtest: bad-close [55.104297] Subtest bad-close: SUCCESS (0.000s) [55.175345] [011/170] (954s left) gem_basic (create-close) [55.298453] Starting subtest: create-close [55.301891] Subtest create-close: SUCCESS (0.000s) [55.374624] [012/170] (954s left) gem_basic (create-fd-close) [55.498555] Starting subtest: create-fd-close [55.502069] Subtest create-fd-close: SUCCESS (0.000s) [55.574479] [013/170] (954s left) gem_busy (busy@all-engines) [55.709188] Starting subtest: busy [55.710971] Starting dynamic subtest: all-engines [55.745193] Dynamic subtest all-engines: SUCCESS (0.035s) [55.747147] Subtest busy: SUCCESS (0.036s) [56.087032] [014/170] (953s left) gem_close_race (basic-process) [56.228922] Starting subtest: basic-process [56.273251] Subtest basic-process: SUCCESS (0.044s) [56.456418] [015/170] (953s left) gem_close_race (basic-threads) [56.592823] Starting subtest: basic-threads [57.736571] Subtest basic-threads: SUCCESS (1.143s) [57.921385] [016/170] (951s left) gem_ctx_create (basic) [58.056062] Starting subtest: basic [58.057928] Subtest basic: SUCCESS (0.000s) [58.237146] [017/170] (951s left) gem_ctx_create (basic-files) [58.368186] Starting subtest: basic-files [60.391533] Subtest basic-files: SUCCESS (2.023s) [60.794527] [018/170] (948s left) gem_ctx_exec (basic) [60.926568] Starting subtest: basic [60.928295] Subtest basic: SUCCESS (0.002s) [60.980780] [019/170] (948s left) gem_exec_basic (basic) [61.115967] Starting subtest: basic [61.117786] Starting dynamic subtest: rcs0-smem [61.119451] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [61.127063] Starting dynamic subtest: vcs0-smem [61.128729] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [61.130344] Subtest basic: SUCCESS (0.002s) [61.312969] [020/170] (948s left) gem_exec_create (basic) [61.451369] Starting subtest: basic [61.453138] Starting dynamic subtest: smem [63.490430] Dynamic subtest smem: SUCCESS (2.040s) [63.492401] Subtest basic: SUCCESS (2.040s) [63.674199] [021/170] (946s left) gem_exec_fence (basic-busy) [63.945512] Starting subtest: basic-busy [63.947214] Starting dynamic subtest: rcs0 [63.957921] Dynamic subtest rcs0: SUCCESS (0.015s) [63.965893] Starting dynamic subtest: vcs0 [63.969107] Dynamic subtest vcs0: SUCCESS (0.010s) [63.970816] Subtest basic-busy: SUCCESS (0.025s) [64.476467] [022/170] (945s left) gem_exec_fence (basic-wait) [64.739908] Starting subtest: basic-wait [64.741736] Starting dynamic subtest: rcs0 [64.750122] Dynamic subtest rcs0: SUCCESS (0.014s) [64.758823] Starting dynamic subtest: vcs0 [64.762791] Dynamic subtest vcs0: SUCCESS (0.011s) [64.764781] Subtest basic-wait: SUCCESS (0.025s) [65.221894] [023/170] (944s left) gem_exec_fence (basic-await) [65.486279] Starting subtest: basic-await [65.488401] Starting dynamic subtest: rcs0 [65.561882] Dynamic subtest rcs0: SUCCESS (0.072s) [65.571490] Starting dynamic subtest: vcs0 [65.633517] Dynamic subtest vcs0: SUCCESS (0.074s) [65.635774] Subtest basic-await: SUCCESS (0.147s) [66.087102] [024/170] (943s left) gem_exec_fence (nb-await) [66.371409] Starting subtest: nb-await [66.373372] Starting dynamic subtest: rcs0 [66.423444] Dynamic subtest rcs0: SUCCESS (0.054s) [66.434797] Starting dynamic subtest: vcs0 [66.478596] Dynamic subtest vcs0: SUCCESS (0.056s) [66.480679] Subtest nb-await: SUCCESS (0.110s) [66.935078] [025/170] (942s left) gem_exec_gttfill (basic) [67.068627] Starting subtest: basic [74.567253] Subtest basic: SUCCESS (7.499s) [74.753860] [026/170] (935s left) gem_exec_parallel (engines) [74.979798] Starting subtest: engines [74.981787] Starting dynamic subtest: basic [76.741291] Dynamic subtest basic: SUCCESS (1.761s) [76.751342] Starting dynamic subtest: contexts [78.860211] Dynamic subtest contexts: SUCCESS (2.116s) [78.869973] Starting dynamic subtest: fds [78.873222] Dynamic subtest fds: SKIP (0.001s) [78.881889] Starting dynamic subtest: userptr [80.804149] Dynamic subtest userptr: SUCCESS (1.946s) [80.805820] Subtest engines: SUCCESS (5.825s) [80.989861] [027/170] (928s left) gem_exec_store (basic) [81.125841] Starting subtest: basic [81.145100] Subtest basic: SUCCESS (0.019s) [81.324991] [028/170] (928s left) gem_flink_basic (bad-flink) [81.448750] Starting subtest: bad-flink [81.450455] Subtest bad-flink: SUCCESS (0.000s) [81.523893] [029/170] (928s left) gem_flink_basic (bad-open) [81.646846] Starting subtest: bad-open [81.648629] Subtest bad-open: SUCCESS (0.000s) [81.722209] [030/170] (928s left) gem_flink_basic (basic) [81.841499] Starting subtest: basic [81.843441] Subtest basic: SUCCESS (0.000s) [81.924124] [031/170] (928s left) gem_flink_basic (double-flink) [82.045196] Starting subtest: double-flink [82.047504] Subtest double-flink: SUCCESS (0.000s) [82.122344] [032/170] (927s left) gem_flink_basic (flink-lifetime) [82.244877] Starting subtest: flink-lifetime [82.247424] Subtest flink-lifetime: SUCCESS (0.001s) [82.321695] [033/170] (927s left) gem_huc_copy (huc-copy) [82.448928] Subtest huc-copy: SKIP (0.000s) [82.471853] [034/170] (927s left) gem_linear_blits (basic) [82.730231] Starting subtest: basic [82.742480] Subtest basic: SUCCESS (0.012s) [82.855078] [035/170] (927s left) gem_mmap (basic) [83.073635] Starting subtest: basic [83.082213] Subtest basic: SUCCESS (0.001s) [83.153448] [036/170] (927s left) gem_mmap_gtt (basic) [83.282723] Starting subtest: basic [83.284472] Subtest basic: SUCCESS (0.001s) [83.356786] [037/170] (926s left) gem_render_linear_blits (basic) [83.482237] Starting subtest: basic [83.519329] Subtest basic: SUCCESS (0.037s) [83.573984] [038/170] (926s left) gem_render_tiled_blits (basic) [83.699825] Starting subtest: basic [83.734932] Subtest basic: SUCCESS (0.036s) [83.768944] [039/170] (926s left) gem_ringfill (basic-all) [83.944808] Starting subtest: basic-all [85.056635] Subtest basic-all: SUCCESS (1.114s) [85.133989] [040/170] (925s left) gem_softpin (allocator-basic) [85.261889] Subtest allocator-basic: SKIP (0.000s) [85.332787] [041/170] (924s left) gem_softpin (allocator-basic-reserve) [85.457468] Subtest allocator-basic-reserve: SKIP (0.000s) [85.532861] [042/170] (924s left) gem_softpin (safe-alignment) [85.660093] Starting subtest: safe-alignment [85.661814] Subtest safe-alignment: SUCCESS (0.006s) [85.747038] [043/170] (924s left) gem_sync (basic-all) [85.885505] Starting subtest: basic-all [87.967217] Subtest basic-all: SUCCESS (2.081s) [88.161485] [044/170] (922s left) gem_sync (basic-each) [88.294626] Starting subtest: basic-each [90.345096] Subtest basic-each: SUCCESS (2.051s) [90.522718] [045/170] (919s left) gem_tiled_blits (basic) [90.778122] Starting subtest: basic [90.798636] Subtest basic: SUCCESS (0.021s) [90.906711] [046/170] (919s left) gem_tiled_fence_blits (basic) [91.267083] Starting subtest: basic [91.278382] Subtest basic: SUCCESS (0.012s) [91.388323] [047/170] (919s left) gem_tiled_pread_basic [91.852738] [048/170] (918s left) gem_wait (busy@all-engines) [91.992807] Starting subtest: busy [91.996607] Starting dynamic subtest: all-engines [92.506959] Dynamic subtest all-engines: SUCCESS (0.514s) [92.508765] Subtest busy: SUCCESS (0.514s) [92.718711] [049/170] (917s left) gem_wait (wait@all-engines) [92.857784] Starting subtest: wait [92.859721] Starting dynamic subtest: all-engines [93.873885] Dynamic subtest all-engines: SUCCESS (1.016s) [93.875601] Subtest wait: SUCCESS (1.016s) [94.082802] [050/170] (916s left) i915_getparams_basic (basic-eu-total) [94.205496] Starting subtest: basic-eu-total [94.208776] Subtest basic-eu-total: SUCCESS (0.000s) [94.281341] [051/170] (916s left) i915_getparams_basic (basic-subslice-total) [94.403118] Starting subtest: basic-subslice-total [94.406253] Subtest basic-subslice-total: SUCCESS (0.000s) [94.463084] [052/170] (916s left) i915_hangman (error-state-basic) [94.588771] Starting subtest: error-state-basic [94.597825] Subtest error-state-basic: SUCCESS (0.008s) [94.631362] [053/170] (915s left) i915_pciid [94.830315] [054/170] (915s left) kms_addfb_basic (addfb25-bad-modifier) [94.959980] Starting subtest: addfb25-bad-modifier [94.961999] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [95.942724] [055/170] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [96.068244] Starting subtest: addfb25-framebuffer-vs-set-tiling [96.069903] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [97.056489] [056/170] (913s left) kms_addfb_basic (addfb25-modifier-no-flag) [97.179806] Starting subtest: addfb25-modifier-no-flag [97.181594] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [98.169141] [057/170] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy) [98.291772] Starting subtest: addfb25-x-tiled-legacy [98.293394] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [99.268601] [058/170] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [99.393152] Starting subtest: addfb25-x-tiled-mismatch-legacy [99.394855] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [100.382193] [059/170] (910s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [101.021970] Starting subtest: addfb25-yf-tiled-legacy [101.024134] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [101.513278] [060/170] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy) [102.148718] Starting subtest: addfb25-y-tiled-legacy [102.150656] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [102.627752] [061/170] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [103.275116] Starting subtest: addfb25-y-tiled-small-legacy [103.278680] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [103.742160] [062/170] (907s left) kms_addfb_basic (bad-pitch-0) [103.866986] Starting subtest: bad-pitch-0 [103.868675] Subtest bad-pitch-0: SUCCESS (0.000s) [104.857452] [063/170] (905s left) kms_addfb_basic (bad-pitch-1024) [104.982185] Starting subtest: bad-pitch-1024 [104.983788] Subtest bad-pitch-1024: SUCCESS (0.000s) [106.004188] [064/170] (904s left) kms_addfb_basic (bad-pitch-128) [106.127194] Starting subtest: bad-pitch-128 [106.128887] Subtest bad-pitch-128: SUCCESS (0.000s) [107.129973] [065/170] (903s left) kms_addfb_basic (bad-pitch-256) [107.259560] Starting subtest: bad-pitch-256 [107.261310] Subtest bad-pitch-256: SUCCESS (0.000s) [108.250495] [066/170] (902s left) kms_addfb_basic (bad-pitch-32) [108.373637] Starting subtest: bad-pitch-32 [108.375320] Subtest bad-pitch-32: SUCCESS (0.000s) [109.364280] [067/170] (901s left) kms_addfb_basic (bad-pitch-63) [109.488240] Starting subtest: bad-pitch-63 [109.489857] Subtest bad-pitch-63: SUCCESS (0.000s) [110.462632] [068/170] (900s left) kms_addfb_basic (bad-pitch-65536) [110.586101] Starting subtest: bad-pitch-65536 [110.587712] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.609842] [069/170] (899s left) kms_addfb_basic (bad-pitch-999) [111.733076] Starting subtest: bad-pitch-999 [111.734804] Subtest bad-pitch-999: SUCCESS (0.000s) [112.707364] [070/170] (898s left) kms_addfb_basic (basic) [112.831497] Starting subtest: basic [112.833290] Subtest basic: SUCCESS (0.000s) [113.804824] [071/170] (897s left) kms_addfb_basic (basic-x-tiled-legacy) [113.932168] Starting subtest: basic-x-tiled-legacy [113.933787] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [114.919561] [072/170] (896s left) kms_addfb_basic (basic-y-tiled-legacy) [115.044155] Starting subtest: basic-y-tiled-legacy [115.045760] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [116.017490] [073/170] (895s left) kms_addfb_basic (bo-too-small) [116.662879] Starting subtest: bo-too-small [116.664823] Subtest bo-too-small: SUCCESS (0.000s) [117.132140] [074/170] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.784271] Starting subtest: bo-too-small-due-to-tiling [117.786063] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [118.264170] [075/170] (892s left) kms_addfb_basic (clobberred-modifier) [118.387837] Starting subtest: clobberred-modifier [118.389563] Subtest clobberred-modifier: SUCCESS (0.000s) [119.394242] [076/170] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [119.522255] Starting subtest: framebuffer-vs-set-tiling [119.523897] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [120.491859] [077/170] (890s left) kms_addfb_basic (invalid-get-prop) [120.616988] Starting subtest: invalid-get-prop [120.618820] Subtest invalid-get-prop: SUCCESS (0.000s) [121.606825] [078/170] (889s left) kms_addfb_basic (invalid-get-prop-any) [121.732963] Starting subtest: invalid-get-prop-any [121.734673] Subtest invalid-get-prop-any: SUCCESS (0.000s) [122.770964] [079/170] (888s left) kms_addfb_basic (invalid-set-prop) [122.896773] Starting subtest: invalid-set-prop [122.898475] Subtest invalid-set-prop: SUCCESS (0.000s) [123.922424] [080/170] (887s left) kms_addfb_basic (invalid-set-prop-any) [124.146407] Starting subtest: invalid-set-prop-any [124.243890] Subtest invalid-set-prop-any: SUCCESS (0.000s) [125.082956] [081/170] (886s left) kms_addfb_basic (no-handle) [125.207437] Starting subtest: no-handle [125.209140] Subtest no-handle: SUCCESS (0.000s) [126.230584] [082/170] (885s left) kms_addfb_basic (size-max) [126.902846] Starting subtest: size-max [126.904708] Subtest size-max: SUCCESS (0.000s) [127.376979] [083/170] (883s left) kms_addfb_basic (small-bo) [128.037272] Starting subtest: small-bo [128.039143] Subtest small-bo: SUCCESS (0.000s) [128.509535] [084/170] (882s left) kms_addfb_basic (tile-pitch-mismatch) [128.638370] Starting subtest: tile-pitch-mismatch [128.640154] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [129.657866] [085/170] (881s left) kms_addfb_basic (too-high) [130.324281] Starting subtest: too-high [130.326151] Subtest too-high: SUCCESS (0.001s) [130.788229] [086/170] (880s left) kms_addfb_basic (too-wide) [131.443251] Starting subtest: too-wide [131.444970] Subtest too-wide: SUCCESS (0.000s) [131.920498] [087/170] (879s left) kms_addfb_basic (unused-handle) [132.046495] Starting subtest: unused-handle [132.048172] Subtest unused-handle: SUCCESS (0.000s) [133.067066] [088/170] (878s left) kms_addfb_basic (unused-modifier) [133.201695] Starting subtest: unused-modifier [133.203463] Subtest unused-modifier: SUCCESS (0.000s) [134.214886] [089/170] (877s left) kms_addfb_basic (unused-offsets) [134.341888] Starting subtest: unused-offsets [134.343688] Subtest unused-offsets: SUCCESS (0.000s) [135.378983] [090/170] (876s left) kms_addfb_basic (unused-pitches) [135.506448] Starting subtest: unused-pitches [135.508127] Subtest unused-pitches: SUCCESS (0.000s) [136.509989] [091/170] (874s left) kms_busy (basic) [137.180213] Starting subtest: basic [137.181916] Starting dynamic subtest: flip [137.901865] Dynamic subtest flip: SUCCESS (0.720s) [137.925714] Starting dynamic subtest: modeset [138.662276] Dynamic subtest modeset: SUCCESS (0.743s) [138.663942] Subtest basic: SUCCESS (1.482s) [139.211707] [092/170] (872s left) kms_chamelium_hpd (dp-hpd-fast) [139.974925] Subtest dp-hpd-fast: SKIP (0.000s) [140.317624] [093/170] (871s left) kms_chamelium_edid (dp-edid-read) [141.077918] Subtest dp-edid-read: SKIP (0.000s) [141.419997] [094/170] (870s left) kms_chamelium_frames (dp-crc-fast) [142.180835] Subtest dp-crc-fast: SKIP (0.000s) [142.522941] [095/170] (869s left) kms_chamelium_hpd (hdmi-hpd-fast) [143.300056] Subtest hdmi-hpd-fast: SKIP (0.000s) [143.658120] [096/170] (867s left) kms_chamelium_edid (hdmi-edid-read) [144.402233] Subtest hdmi-edid-read: SKIP (0.000s) [144.730405] [097/170] (866s left) kms_chamelium_frames (hdmi-crc-fast) [145.490677] Subtest hdmi-crc-fast: SKIP (0.000s) [145.839393] [098/170] (865s left) kms_chamelium_hpd (vga-hpd-fast) [146.601631] Subtest vga-hpd-fast: SKIP (0.000s) [146.958098] [099/170] (864s left) kms_chamelium_edid (vga-edid-read) [147.734763] Subtest vga-edid-read: SKIP (0.000s) [148.094415] [100/170] (863s left) kms_prop_blob (basic) [148.223161] Starting subtest: basic [148.224885] Subtest basic: SUCCESS (0.000s) [148.290915] [101/170] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [148.961615] Starting subtest: basic-busy-flip-before-cursor-atomic [150.010364] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.044s) [150.564718] [102/170] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [151.225790] Starting subtest: basic-busy-flip-before-cursor-legacy [152.265482] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.035s) [152.818541] [103/170] (858s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [153.510837] Starting subtest: basic-flip-after-cursor-atomic [154.537306] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.024s) [155.080884] [104/170] (856s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [155.745614] Starting subtest: basic-flip-after-cursor-legacy [156.784144] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.039s) [157.331256] [105/170] (854s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [158.020537] Starting subtest: basic-flip-after-cursor-varying-size [159.091276] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.072s) [159.635872] [106/170] (852s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [160.329620] Starting subtest: basic-flip-before-cursor-atomic [161.370510] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.044s) [161.917103] [107/170] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [162.590834] Starting subtest: basic-flip-before-cursor-legacy [163.618279] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.026s) [164.164415] [108/170] (847s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [164.845887] Starting subtest: basic-flip-before-cursor-varying-size [165.920772] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.079s) [166.469993] [109/170] (845s left) kms_flip (basic-flip-vs-dpms) [166.996113] Starting subtest: basic-flip-vs-dpms [166.997753] Starting dynamic subtest: A-VGA1 [167.813098] Dynamic subtest A-VGA1: SUCCESS (0.819s) [167.826455] Starting dynamic subtest: B-VGA1 [168.452421] Dynamic subtest B-VGA1: SUCCESS (0.644s) [168.462212] Starting dynamic subtest: A-HDMI-A1 [169.172166] Dynamic subtest A-HDMI-A1: SUCCESS (0.690s) [169.194863] Starting dynamic subtest: B-HDMI-A1 [169.886298] Dynamic subtest B-HDMI-A1: SUCCESS (0.738s) [169.887907] Subtest basic-flip-vs-dpms: SUCCESS (2.898s) [170.456883] [110/170] (841s left) kms_flip (basic-flip-vs-modeset) [170.981320] Starting subtest: basic-flip-vs-modeset [170.982927] Starting dynamic subtest: A-VGA1 [171.722996] Dynamic subtest A-VGA1: SUCCESS (0.747s) [171.738598] Starting dynamic subtest: B-VGA1 [172.446799] Dynamic subtest B-VGA1: SUCCESS (0.726s) [172.462606] Starting dynamic subtest: A-HDMI-A1 [173.295049] Dynamic subtest A-HDMI-A1: SUCCESS (0.843s) [173.314681] Starting dynamic subtest: B-HDMI-A1 [174.115474] Dynamic subtest B-HDMI-A1: SUCCESS (0.808s) [174.117074] Subtest basic-flip-vs-modeset: SUCCESS (3.145s) [174.697083] [111/170] (837s left) kms_flip (basic-flip-vs-wf_vblank) [175.215190] Starting subtest: basic-flip-vs-wf_vblank [175.216858] Starting dynamic subtest: A-VGA1 [176.280441] Dynamic subtest A-VGA1: SUCCESS (1.071s) [176.296619] Starting dynamic subtest: B-VGA1 [177.288129] Dynamic subtest B-VGA1: SUCCESS (1.005s) [177.301577] Starting dynamic subtest: A-HDMI-A1 [178.527045] Dynamic subtest A-HDMI-A1: SUCCESS (1.221s) [178.547603] Starting dynamic subtest: B-HDMI-A1 [179.784487] Dynamic subtest B-HDMI-A1: SUCCESS (1.232s) [179.791046] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.577s) [180.434346] [112/170] (831s left) kms_flip (basic-plain-flip) [180.966182] Starting subtest: basic-plain-flip [180.967817] Starting dynamic subtest: A-VGA1 [181.752562] Dynamic subtest A-VGA1: SUCCESS (0.791s) [181.774139] Starting dynamic subtest: B-VGA1 [182.470292] Dynamic subtest B-VGA1: SUCCESS (0.719s) [182.485608] Starting dynamic subtest: A-HDMI-A1 [183.254203] Dynamic subtest A-HDMI-A1: SUCCESS (0.771s) [183.268558] Starting dynamic subtest: B-HDMI-A1 [184.076285] Dynamic subtest B-HDMI-A1: SUCCESS (0.811s) [184.082230] Subtest basic-plain-flip: SUCCESS (3.120s) [184.705764] [113/170] (827s left) kms_force_connector_basic (force-connector-state) [184.899328] Starting subtest: force-connector-state [185.726182] Subtest force-connector-state: SUCCESS (0.827s) [186.499764] [114/170] (825s left) kms_force_connector_basic (force-edid) [186.693787] Starting subtest: force-edid [187.025722] Subtest force-edid: SUCCESS (0.335s) [187.698209] [115/170] (824s left) kms_force_connector_basic (force-load-detect) [187.894585] Starting subtest: force-load-detect [188.129740] Subtest force-load-detect: SUCCESS (0.233s) [188.677618] [116/170] (823s left) kms_force_connector_basic (prune-stale-modes) [188.865591] Starting subtest: prune-stale-modes [189.192249] Subtest prune-stale-modes: SUCCESS (0.326s) [189.873889] [117/170] (822s left) kms_frontbuffer_tracking (basic) [190.560994] Starting subtest: basic [190.863828] Subtest basic: SKIP (0.298s) [191.354571] [118/170] (820s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [192.039615] Starting subtest: compare-crc-sanitycheck [192.041271] Starting dynamic subtest: pipe-A-HDMI-A-1 [192.453704] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.411s) [192.470558] Starting dynamic subtest: pipe-B-HDMI-A-1 [192.887873] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.433s) [192.889646] Subtest compare-crc-sanitycheck: SUCCESS (0.849s) [193.431465] [119/170] (818s left) kms_pipe_crc_basic (hang-read-crc) [194.126624] Starting subtest: hang-read-crc [194.128312] Starting dynamic subtest: pipe-A-HDMI-A-1 [195.194033] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.075s) [195.210550] Starting dynamic subtest: pipe-B-HDMI-A-1 [196.336946] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.141s) [196.338938] Subtest hang-read-crc: SUCCESS (2.220s) [196.883724] [120/170] (815s left) kms_pipe_crc_basic (nonblocking-crc) [197.573622] Starting subtest: nonblocking-crc [197.575308] Starting dynamic subtest: pipe-A-HDMI-A-1 [198.123681] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.551s) [198.140211] Starting dynamic subtest: pipe-B-HDMI-A-1 [198.745365] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.619s) [198.747541] Subtest nonblocking-crc: SUCCESS (1.175s) [199.306751] [121/170] (812s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [199.998664] Starting subtest: nonblocking-crc-frame-sequence [200.000416] Starting dynamic subtest: pipe-A-HDMI-A-1 [200.564814] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.571s) [200.581613] Starting dynamic subtest: pipe-B-HDMI-A-1 [201.176910] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.609s) [201.178875] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.184s) [201.716266] [122/170] (810s left) kms_pipe_crc_basic (read-crc) [202.396868] Starting subtest: read-crc [202.398580] Starting dynamic subtest: pipe-A-HDMI-A-1 [202.891949] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.500s) [202.910619] Starting dynamic subtest: pipe-B-HDMI-A-1 [203.469320] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.572s) [203.471040] Subtest read-crc: SUCCESS (1.078s) [204.023208] [123/170] (808s left) kms_pipe_crc_basic (read-crc-frame-sequence) [204.707316] Starting subtest: read-crc-frame-sequence [204.730318] Starting dynamic subtest: pipe-A-HDMI-A-1 [205.187367] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.475s) [205.209851] Starting dynamic subtest: pipe-B-HDMI-A-1 [205.889383] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.520s) [206.041809] Subtest read-crc-frame-sequence: SUCCESS (0.999s) [206.707881] [124/170] (806s left) kms_psr (primary_page_flip) [206.839808] Subtest primary_page_flip: SKIP (0.000s) [206.873078] [125/170] (805s left) kms_psr (cursor_plane_move) [207.001222] Subtest cursor_plane_move: SKIP (0.000s) [207.038113] [126/170] (805s left) kms_psr (sprite_plane_onoff) [207.166869] Subtest sprite_plane_onoff: SKIP (0.000s) [207.204958] [127/170] (805s left) kms_psr (primary_mmap_gtt) [207.332907] Subtest primary_mmap_gtt: SKIP (0.000s) [207.370732] [128/170] (805s left) kms_setmode (basic-clone-single-crtc) [207.501158] Starting subtest: basic-clone-single-crtc [207.506055] Subtest basic-clone-single-crtc: SKIP (0.000s) [207.566774] [129/170] (805s left) i915_pm_backlight (basic-brightness) [208.245976] Subtest basic-brightness: SKIP (0.000s) [208.501741] [130/170] (804s left) i915_pm_rpm (basic-pci-d3-state) [220.507140] Subtest basic-pci-d3-state: SKIP (0.000s) [220.760974] [131/170] (792s left) i915_pm_rpm (basic-rte) [220.884607] Starting subtest: basic-rte [232.787154] Subtest basic-rte: SKIP (11.884s) [233.052584] [132/170] (779s left) i915_pm_rps (basic-api) [233.184979] Subtest basic-api: SKIP (0.000s) [233.222059] [133/170] (779s left) prime_self_import (basic-llseek-bad) [233.345541] Starting subtest: basic-llseek-bad [233.349089] Subtest basic-llseek-bad: SUCCESS (0.002s) [233.417617] [134/170] (779s left) prime_self_import (basic-llseek-size) [233.540962] Starting subtest: basic-llseek-size [233.544330] Subtest basic-llseek-size: SUCCESS (0.003s) [233.616772] [135/170] (779s left) prime_self_import (basic-with_fd_dup) [233.741044] Starting subtest: basic-with_fd_dup [233.744709] Subtest basic-with_fd_dup: SUCCESS (0.003s) [233.816476] [136/170] (779s left) prime_self_import (basic-with_one_bo) [233.941431] Starting subtest: basic-with_one_bo [233.944939] Subtest basic-with_one_bo: SUCCESS (0.004s) [234.001189] [137/170] (779s left) prime_self_import (basic-with_one_bo_two_files) [234.122408] Starting subtest: basic-with_one_bo_two_files [234.126545] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [234.200434] [138/170] (778s left) prime_self_import (basic-with_two_bos) [234.322304] Starting subtest: basic-with_two_bos [234.326427] Subtest basic-with_two_bos: SUCCESS (0.003s) [234.400433] [139/170] (778s left) prime_vgem (basic-fence-flip) [234.543687] Starting subtest: basic-fence-flip [235.623333] Subtest basic-fence-flip: SUCCESS (1.078s) [236.186937] [140/170] (776s left) prime_vgem (basic-fence-mmap) [236.334098] Starting subtest: basic-fence-mmap [236.373699] Subtest basic-fence-mmap: SUCCESS (0.040s) [236.452876] [141/170] (776s left) prime_vgem (basic-fence-read) [236.600083] Starting subtest: basic-fence-read [236.668773] Subtest basic-fence-read: SUCCESS (0.069s) [236.754742] [142/170] (776s left) prime_vgem (basic-gtt) [236.883550] Starting subtest: basic-gtt [236.898743] Subtest basic-gtt: SUCCESS (0.018s) [236.988579] [143/170] (776s left) prime_vgem (basic-read) [237.134679] Starting subtest: basic-read [237.162937] Subtest basic-read: SUCCESS (0.031s) [237.252758] [144/170] (775s left) prime_vgem (basic-write) [237.400665] Starting subtest: basic-write [237.430719] Subtest basic-write: SUCCESS (0.033s) [237.502561] [145/170] (775s left) vgem_basic (setversion) [237.641808] Starting subtest: setversion [237.646679] Subtest setversion: SUCCESS (0.000s) [237.701739] [146/170] (775s left) vgem_basic (create) [237.843912] Starting subtest: create [237.845999] Subtest create: SUCCESS (0.001s) [237.903763] [147/170] (775s left) vgem_basic (debugfs) [238.042284] Starting subtest: debugfs [238.044422] Subtest debugfs: SUCCESS (0.001s) [238.102870] [148/170] (775s left) vgem_basic (dmabuf-export) [238.245800] Starting subtest: dmabuf-export [238.249846] Subtest dmabuf-export: SUCCESS (0.003s) [238.318433] [149/170] (775s left) vgem_basic (dmabuf-fence) [238.459814] Starting subtest: dmabuf-fence [238.461822] Subtest dmabuf-fence: SUCCESS (0.001s) [238.518871] [150/170] (774s left) vgem_basic (dmabuf-fence-before) [238.659151] Starting subtest: dmabuf-fence-before [238.661136] Subtest dmabuf-fence-before: SUCCESS (0.001s) [238.718541] [151/170] (774s left) vgem_basic (dmabuf-mmap) [238.857764] Starting subtest: dmabuf-mmap [238.880480] Subtest dmabuf-mmap: SUCCESS (0.025s) [238.934131] [152/170] (774s left) vgem_basic (mmap) [239.073368] Starting subtest: mmap [239.087022] Subtest mmap: SUCCESS (0.016s) [239.151306] [153/170] (774s left) vgem_basic (second-client) [239.289254] Starting subtest: second-client [239.336668] Subtest second-client: SUCCESS (0.049s) [239.398640] [154/170] (774s left) vgem_basic (sysfs) [239.523795] Starting subtest: sysfs [239.525837] Subtest sysfs: SUCCESS (0.001s) [239.583345] [155/170] (773s left) core_hotunplug (unbind-rebind) [239.770152] Starting subtest: unbind-rebind [241.176483] Subtest unbind-rebind: SUCCESS (1.406s) [241.250134] [156/170] (772s left) vgem_basic (unload) [241.434208] Starting subtest: unload [270.331819] Subtest unload: SUCCESS (28.896s) [270.446939] [157/170] (743s left) i915_module_load (reload) [270.568197] Starting subtest: reload [273.177858] Subtest reload: SUCCESS (2.609s) [273.210739] [158/170] (740s left) gem_lmem_swapping (basic) [273.461810] Subtest basic: SKIP (0.000s) [273.504745] [159/170] (740s left) gem_lmem_swapping (parallel-random-engines) [273.636249] Subtest parallel-random-engines: SKIP (0.000s) [273.670751] [160/170] (739s left) gem_lmem_swapping (random-engines) [273.804779] Subtest random-engines: SKIP (0.000s) [273.837140] [161/170] (739s left) gem_lmem_swapping (verify-random) [273.968628] Subtest verify-random: SKIP (0.000s) [274.003218] [162/170] (739s left) i915_pm_rpm (module-reload) [286.027315] Subtest module-reload: SKIP (0.000s) [286.312293] [163/170] (727s left) i915_selftest (live) [287.138804] Starting subtest: live [287.140919] Starting dynamic subtest: sanitycheck [287.915942] Dynamic subtest sanitycheck: SUCCESS (0.777s) [287.927756] Starting dynamic subtest: uncore [288.658991] Dynamic subtest uncore: SUCCESS (0.742s) [288.670483] Starting dynamic subtest: workarounds [289.350054] Dynamic subtest workarounds: SUCCESS (0.690s) [289.359559] Starting dynamic subtest: gt_engines [290.115118] Dynamic subtest gt_engines: SUCCESS (0.742s) [290.139122] Starting dynamic subtest: gt_timelines [295.259465] Dynamic subtest gt_timelines: SUCCESS (5.164s) [295.268158] Starting dynamic subtest: gt_contexts [296.012166] Dynamic subtest gt_contexts: SUCCESS (0.751s) [296.024821] Starting dynamic subtest: gt_lrc [296.737108] Dynamic subtest gt_lrc: SUCCESS (0.723s) [296.749117] Starting dynamic subtest: gt_mocs [297.485115] Dynamic subtest gt_mocs: SUCCESS (0.746s) [297.496509] Starting dynamic subtest: gt_pm [298.736209] Dynamic subtest gt_pm: SUCCESS (1.249s) [298.748127] Starting dynamic subtest: gt_heartbeat [299.540169] Dynamic subtest gt_heartbeat: SUCCESS (0.803s) [299.551768] Starting dynamic subtest: gt_tlb [300.278180] Dynamic subtest gt_tlb: SUCCESS (0.736s) [300.289632] Starting dynamic subtest: requests [304.620308] Dynamic subtest requests: SUCCESS (4.341s) [304.632077] Starting dynamic subtest: migrate [305.331083] Dynamic subtest migrate: SUCCESS (0.710s) [305.344856] Starting dynamic subtest: active [306.056306] Dynamic subtest active: SUCCESS (0.724s) [306.065118] Starting dynamic subtest: objects [308.254526] Dynamic subtest objects: SUCCESS (2.197s) [308.265490] Starting dynamic subtest: mman [314.361974] Dynamic subtest mman: SUCCESS (6.107s) [314.373790] Starting dynamic subtest: dmabuf [315.163025] Dynamic subtest dmabuf: SUCCESS (0.800s) [315.173538] Starting dynamic subtest: vma [315.910030] Dynamic subtest vma: SUCCESS (0.746s) [315.920543] Starting dynamic subtest: coherency [317.762958] Dynamic subtest coherency: SUCCESS (1.851s) [317.773740] Starting dynamic subtest: gtt [321.802960] Dynamic subtest gtt: SUCCESS (4.039s) [321.814640] Starting dynamic subtest: gem [322.697306] Dynamic subtest gem: SUCCESS (0.893s) [322.708948] Starting dynamic subtest: evict [323.430119] Dynamic subtest evict: SUCCESS (0.731s) [323.441256] Starting dynamic subtest: hugepages [324.152188] Dynamic subtest hugepages: SUCCESS (0.720s) [324.163861] Starting dynamic subtest: gem_contexts [328.001140] Dynamic subtest gem_contexts: SUCCESS (3.847s) [328.012924] Starting dynamic subtest: client [328.693989] Dynamic subtest client: SUCCESS (0.692s) [328.705956] Starting dynamic subtest: gem_migrate [329.454091] Dynamic subtest gem_migrate: SUCCESS (0.759s) [329.465345] Starting dynamic subtest: reset [330.313049] Dynamic subtest reset: SUCCESS (0.857s) [330.325087] Starting dynamic subtest: memory_region [331.080108] Dynamic subtest memory_region: SUCCESS (0.766s) [331.091904] Starting dynamic subtest: hangcheck [333.351976] Dynamic subtest hangcheck: SUCCESS (2.271s) [333.363845] Starting dynamic subtest: execlists [334.064309] Dynamic subtest execlists: SUCCESS (0.711s) [334.072398] Starting dynamic subtest: ring_submission [334.816924] Dynamic subtest ring_submission: SUCCESS (0.751s) [334.828396] Starting dynamic subtest: perf [335.520534] Dynamic subtest perf: SUCCESS (0.702s) [335.530918] Starting dynamic subtest: slpc [336.272111] Dynamic subtest slpc: SUCCESS (0.750s) [336.283499] Starting dynamic subtest: guc [337.023060] Dynamic subtest guc: SUCCESS (0.749s) [337.035791] Starting dynamic subtest: guc_multi_lrc [337.785170] Dynamic subtest guc_multi_lrc: SUCCESS (0.761s) [337.796769] Starting dynamic subtest: guc_hang [338.576171] Dynamic subtest guc_hang: SUCCESS (0.790s) [338.588601] Starting dynamic subtest: late_gt_pm [339.311636] Dynamic subtest late_gt_pm: SUCCESS (0.734s) [339.314927] Subtest live: SUCCESS (52.173s) [339.462878] [164/170] (674s left) dmabuf (all-tests) [339.600703] Starting subtest: all-tests [339.602683] Starting dynamic subtest: sanitycheck [339.673137] Dynamic subtest sanitycheck: SUCCESS (0.069s) [339.683967] Starting dynamic subtest: dma_fence [339.853578] Dynamic subtest dma_fence: SUCCESS (0.180s) [339.873423] Starting dynamic subtest: dma_fence_chain [356.720990] Dynamic subtest dma_fence_chain: SUCCESS (16.865s) [356.735638] Starting dynamic subtest: dma_fence_unwrap [356.789304] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s) [356.802135] Starting dynamic subtest: dma_resv [356.866078] Dynamic subtest dma_resv: SUCCESS (0.076s) [356.868691] Subtest all-tests: SUCCESS (17.265s) [356.889686] [165/170] (656s left) i915_suspend (basic-s2idle-without-i915) [357.011445] Starting subtest: basic-s2idle-without-i915 [376.185246] Subtest basic-s2idle-without-i915: SUCCESS (3.705s) [379.425631] [166/170] (652s left) i915_suspend (basic-s3-without-i915) [379.556132] Starting subtest: basic-s3-without-i915 [397.384924] Subtest basic-s3-without-i915: SUCCESS (2.596s) [404.095325] [167/170] (649s left) gem_exec_suspend (basic-s0) [404.251260] Starting subtest: basic-S0 [404.254544] Starting dynamic subtest: smem [421.500984] Dynamic subtest smem: SUCCESS (7.222s) [421.502634] Subtest basic-S0: SUCCESS (7.223s) [424.285792] [168/170] (642s left) gem_exec_suspend (basic-s3) [424.425247] Starting subtest: basic-S3 [424.427520] Starting dynamic subtest: smem [441.743882] Dynamic subtest smem: SUCCESS (2.067s) [441.745649] Subtest basic-S3: SUCCESS (2.069s) [448.940819] [169/170] (640s left) kms_chamelium_hpd (common-hpd-after-suspend) [449.750263] Subtest common-hpd-after-suspend: SKIP (0.000s) [450.097884] [170/170] (638s left) kms_pipe_crc_basic (suspend-read-crc) [450.808643] Starting subtest: suspend-read-crc [450.810325] Starting dynamic subtest: pipe-A-HDMI-A-1 [468.956073] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.114s) [468.973338] Starting dynamic subtest: pipe-B-HDMI-A-1 [486.953073] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.185s) [486.955212] Subtest suspend-read-crc: SUCCESS (4.306s) [494.299584] Closing watchdogs Done.