[47.201235] Initializing watchdogs [47.201512] /dev/watchdog0 [47.213418] [001/171] (960s left) i915_module_load (load) [47.571098] Starting subtest: load [49.429033] Subtest load: SUCCESS (1.853s) [49.460204] [002/171] (958s left) core_auth (basic-auth) [49.811310] Starting subtest: basic-auth [49.816046] Subtest basic-auth: SUCCESS (0.003s) [49.979690] [003/171] (957s left) debugfs_test (read_all_entries) [50.271059] Starting subtest: read_all_entries [50.441878] Subtest read_all_entries: SUCCESS (0.169s) [50.596605] [004/171] (957s left) debugfs_test (basic-hwmon) [50.761356] Starting subtest: basic-hwmon [50.764110] Subtest basic-hwmon: SKIP (0.000s) [50.912903] [005/171] (956s left) fbdev (eof) [51.069533] Starting subtest: eof [51.070720] Subtest eof: SUCCESS (0.001s) [51.129168] [006/171] (956s left) fbdev (info) [51.278881] Starting subtest: info [51.280105] Subtest info: SUCCESS (0.000s) [51.345883] [007/171] (956s left) fbdev (nullptr) [51.502417] Starting subtest: nullptr [51.503598] Subtest nullptr: SUCCESS (0.000s) [51.562908] [008/171] (956s left) fbdev (read) [51.720417] Starting subtest: read [53.283816] Subtest read: SUCCESS (1.562s) [53.348458] [009/171] (954s left) fbdev (write) [53.504580] Starting subtest: write [54.299715] Subtest write: SUCCESS (0.791s) [54.362378] [010/171] (953s left) gem_basic (bad-close) [54.514701] Starting subtest: bad-close [54.519678] Subtest bad-close: SUCCESS (0.000s) [54.581593] [011/171] (953s left) gem_basic (create-close) [54.728719] Starting subtest: create-close [54.732607] Subtest create-close: SUCCESS (0.000s) [54.815538] [012/171] (953s left) gem_basic (create-fd-close) [54.961521] Starting subtest: create-fd-close [54.964340] Subtest create-fd-close: SUCCESS (0.001s) [55.048953] [013/171] (952s left) gem_busy (busy@all-engines) [55.217311] Starting subtest: busy [55.219854] Starting dynamic subtest: all-engines [55.292976] Dynamic subtest all-engines: SUCCESS (0.075s) [55.294464] Subtest busy: SUCCESS (0.075s) [55.631751] [014/171] (952s left) gem_close_race (basic-process) [55.802270] Starting subtest: basic-process [55.879240] Subtest basic-process: SUCCESS (0.076s) [56.065235] [015/171] (951s left) gem_close_race (basic-threads) [56.234064] Starting subtest: basic-threads [57.385283] Subtest basic-threads: SUCCESS (1.151s) [57.565895] [016/171] (950s left) gem_ctx_create (basic) [57.731426] Starting subtest: basic [57.732844] Subtest basic: SUCCESS (0.000s) [57.916565] [017/171] (950s left) gem_ctx_create (basic-files) [58.081905] Starting subtest: basic-files [60.106838] Subtest basic-files: SUCCESS (2.026s) [60.300635] [018/171] (947s left) gem_ctx_exec (basic) [60.452060] Starting subtest: basic [60.457491] Subtest basic: SUCCESS (0.008s) [60.552266] [019/171] (947s left) gem_exec_basic (basic) [60.706390] Starting subtest: basic [60.708968] Starting dynamic subtest: rcs0-smem [60.712835] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [60.723190] Starting dynamic subtest: bcs0-smem [60.724302] Dynamic subtest bcs0-smem: SUCCESS (0.005s) [60.733780] Starting dynamic subtest: vcs0-smem [60.734940] Dynamic subtest vcs0-smem: SUCCESS (0.003s) [60.743918] Starting dynamic subtest: vecs0-smem [60.745175] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [60.746272] Subtest basic: SUCCESS (0.019s) [60.932967] [020/171] (947s left) gem_exec_create (basic) [61.099370] Starting subtest: basic [61.100892] Starting dynamic subtest: smem [63.153952] Dynamic subtest smem: SUCCESS (2.053s) [63.155806] Subtest basic: SUCCESS (2.054s) [63.348935] [021/171] (944s left) gem_exec_fence (basic-busy) [63.647184] Starting subtest: basic-busy [63.648753] Starting dynamic subtest: rcs0 [63.664487] Dynamic subtest rcs0: SUCCESS (0.019s) [63.681117] Starting dynamic subtest: bcs0 [63.684702] Dynamic subtest bcs0: SUCCESS (0.019s) [63.705069] Starting dynamic subtest: vcs0 [63.707439] Dynamic subtest vcs0: SUCCESS (0.018s) [63.717660] Starting dynamic subtest: vecs0 [63.720272] Dynamic subtest vecs0: SUCCESS (0.016s) [63.721861] Subtest basic-busy: SUCCESS (0.073s) [64.436188] [022/171] (943s left) gem_exec_fence (basic-wait) [64.730912] Starting subtest: basic-wait [64.733650] Starting dynamic subtest: rcs0 [64.752432] Dynamic subtest rcs0: SUCCESS (0.022s) [64.765817] Starting dynamic subtest: bcs0 [64.772768] Dynamic subtest bcs0: SUCCESS (0.019s) [64.788659] Starting dynamic subtest: vcs0 [64.789895] Dynamic subtest vcs0: SUCCESS (0.017s) [64.800327] Starting dynamic subtest: vecs0 [64.805477] Dynamic subtest vecs0: SUCCESS (0.017s) [64.806931] Subtest basic-wait: SUCCESS (0.076s) [65.415907] [023/171] (942s left) gem_exec_fence (basic-await) [65.714145] Starting subtest: basic-await [65.715320] Starting dynamic subtest: rcs0 [65.815064] Dynamic subtest rcs0: SUCCESS (0.103s) [65.825594] Starting dynamic subtest: bcs0 [65.916430] Dynamic subtest bcs0: SUCCESS (0.100s) [65.926541] Starting dynamic subtest: vcs0 [66.022991] Dynamic subtest vcs0: SUCCESS (0.105s) [66.033656] Starting dynamic subtest: vecs0 [66.128453] Dynamic subtest vecs0: SUCCESS (0.106s) [66.129782] Subtest basic-await: SUCCESS (0.417s) [66.734618] [024/171] (941s left) gem_exec_fence (nb-await) [67.029304] Starting subtest: nb-await [67.030841] Starting dynamic subtest: rcs0 [67.096162] Dynamic subtest rcs0: SUCCESS (0.068s) [67.107732] Starting dynamic subtest: bcs0 [67.169164] Dynamic subtest bcs0: SUCCESS (0.070s) [67.181607] Starting dynamic subtest: vcs0 [67.237090] Dynamic subtest vcs0: SUCCESS (0.071s) [67.252074] Starting dynamic subtest: vecs0 [67.314352] Dynamic subtest vecs0: SUCCESS (0.077s) [67.316065] Subtest nb-await: SUCCESS (0.287s) [67.915742] [025/171] (940s left) gem_exec_gttfill (basic) [68.087824] Starting subtest: basic [81.787839] Subtest basic: SUCCESS (13.701s) [82.004189] [026/171] (926s left) gem_exec_parallel (engines) [82.285999] Starting subtest: engines [82.287701] Starting dynamic subtest: basic [85.609092] Dynamic subtest basic: SUCCESS (3.324s) [85.621995] Starting dynamic subtest: contexts [89.503522] Dynamic subtest contexts: SUCCESS (3.894s) [89.531256] Starting dynamic subtest: fds [94.232798] Dynamic subtest fds: SUCCESS (4.727s) [94.248051] Starting dynamic subtest: userptr [97.796875] Dynamic subtest userptr: SUCCESS (3.563s) [97.798262] Subtest engines: SUCCESS (15.512s) [97.987949] [027/171] (910s left) gem_exec_store (basic) [98.157693] Starting subtest: basic [98.219334] Subtest basic: SUCCESS (0.061s) [98.400957] [028/171] (909s left) gem_flink_basic (bad-flink) [98.546432] Starting subtest: bad-flink [98.547697] Subtest bad-flink: SUCCESS (0.000s) [98.617984] [029/171] (909s left) gem_flink_basic (bad-open) [98.764646] Starting subtest: bad-open [98.765947] Subtest bad-open: SUCCESS (0.000s) [98.834507] [030/171] (909s left) gem_flink_basic (basic) [98.980549] Starting subtest: basic [98.981899] Subtest basic: SUCCESS (0.001s) [99.067713] [031/171] (909s left) gem_flink_basic (double-flink) [99.216265] Starting subtest: double-flink [99.217484] Subtest double-flink: SUCCESS (0.000s) [99.301236] [032/171] (909s left) gem_flink_basic (flink-lifetime) [99.448304] Starting subtest: flink-lifetime [99.451320] Subtest flink-lifetime: SUCCESS (0.004s) [99.534442] [033/171] (908s left) gem_huc_copy (huc-copy) [99.691422] Starting subtest: huc-copy [99.694447] Subtest huc-copy: SKIP (0.000s) [99.785965] [034/171] (908s left) gem_linear_blits (basic) [100.116607] Starting subtest: basic [100.133378] Subtest basic: SUCCESS (0.017s) [100.261772] [035/171] (908s left) gem_mmap (basic) [100.526206] Starting subtest: basic [100.532250] Subtest basic: SUCCESS (0.001s) [100.622283] [036/171] (907s left) gem_mmap_gtt (basic) [100.774723] Starting subtest: basic [100.775862] Subtest basic: SUCCESS (0.001s) [100.853206] [037/171] (907s left) gem_render_linear_blits (basic) [101.004654] Starting subtest: basic [101.081371] Subtest basic: SUCCESS (0.075s) [101.137410] [038/171] (907s left) gem_render_tiled_blits (basic) [101.289623] Starting subtest: basic [101.391490] Subtest basic: SUCCESS (0.096s) [101.436620] [039/171] (907s left) gem_ringfill (basic-all) [101.817270] Starting subtest: basic-all [103.017250] Subtest basic-all: SUCCESS (1.196s) [103.117845] [040/171] (905s left) gem_softpin (allocator-basic) [103.274830] Starting subtest: allocator-basic [103.484216] Subtest allocator-basic: SUCCESS (0.204s) [103.601623] [041/171] (905s left) gem_softpin (allocator-basic-reserve) [103.755135] Starting subtest: allocator-basic-reserve [103.952548] Subtest allocator-basic-reserve: SUCCESS (0.196s) [104.063953] [042/171] (904s left) gem_softpin (safe-alignment) [104.218788] Starting subtest: safe-alignment [104.241951] Subtest safe-alignment: SUCCESS (0.022s) [104.334843] [043/171] (904s left) gem_sync (basic-all) [104.503915] Starting subtest: basic-all [106.981377] Subtest basic-all: SUCCESS (2.477s) [107.169470] [044/171] (901s left) gem_sync (basic-each) [107.352060] Starting subtest: basic-each [109.817343] Subtest basic-each: SUCCESS (2.466s) [110.001046] [045/171] (898s left) gem_tiled_blits (basic) [110.314895] Starting subtest: basic [110.357732] Subtest basic: SUCCESS (0.042s) [110.493788] [046/171] (898s left) gem_tiled_fence_blits (basic) [110.929335] Starting subtest: basic [110.963511] Subtest basic: SUCCESS (0.032s) [111.097881] [047/171] (897s left) gem_tiled_pread_basic [111.653272] [048/171] (897s left) gem_wait (busy@all-engines) [111.830355] Starting subtest: busy [111.831565] Starting dynamic subtest: all-engines [112.352463] Dynamic subtest all-engines: SUCCESS (0.522s) [112.353623] Subtest busy: SUCCESS (0.523s) [112.567892] [049/171] (896s left) gem_wait (wait@all-engines) [112.744069] Starting subtest: wait [112.745891] Starting dynamic subtest: all-engines [113.777376] Dynamic subtest all-engines: SUCCESS (1.033s) [113.778644] Subtest wait: SUCCESS (1.033s) [114.001865] [050/171] (894s left) i915_getparams_basic (basic-eu-total) [114.153378] Starting subtest: basic-eu-total [114.155951] Subtest basic-eu-total: SUCCESS (0.000s) [114.234270] [051/171] (894s left) i915_getparams_basic (basic-subslice-total) [114.384369] Starting subtest: basic-subslice-total [114.386628] Subtest basic-subslice-total: SUCCESS (0.000s) [114.451707] [052/171] (894s left) i915_hangman (error-state-basic) [114.626373] Starting subtest: error-state-basic [114.654956] Subtest error-state-basic: SUCCESS (0.023s) [114.734816] [053/171] (894s left) i915_pciid [114.968066] [054/171] (894s left) kms_addfb_basic (addfb25-bad-modifier) [115.201168] Starting subtest: addfb25-bad-modifier [115.202284] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [115.399034] [055/171] (893s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [115.626701] Starting subtest: addfb25-framebuffer-vs-set-tiling [115.628062] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s) [115.866492] [056/171] (893s left) kms_addfb_basic (addfb25-modifier-no-flag) [116.086521] Starting subtest: addfb25-modifier-no-flag [116.087636] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [116.282475] [057/171] (892s left) kms_addfb_basic (addfb25-x-tiled-legacy) [116.511192] Starting subtest: addfb25-x-tiled-legacy [116.512425] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [116.731879] [058/171] (892s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [116.957423] Starting subtest: addfb25-x-tiled-mismatch-legacy [116.958653] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [117.182980] [059/171] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [117.531201] Starting subtest: addfb25-yf-tiled-legacy [117.532340] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [117.731640] [060/171] (891s left) kms_addfb_basic (addfb25-y-tiled-legacy) [118.129994] Starting subtest: addfb25-y-tiled-legacy [118.132848] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [118.341235] [061/171] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [118.647208] Starting subtest: addfb25-y-tiled-small-legacy [118.648426] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [118.799619] [062/171] (890s left) kms_addfb_basic (bad-pitch-0) [118.948099] Starting subtest: bad-pitch-0 [118.950891] Subtest bad-pitch-0: SUCCESS (0.000s) [119.249447] [063/171] (890s left) kms_addfb_basic (bad-pitch-1024) [119.400632] Starting subtest: bad-pitch-1024 [119.401836] Subtest bad-pitch-1024: SUCCESS (0.000s) [119.682665] [064/171] (889s left) kms_addfb_basic (bad-pitch-128) [119.836350] Starting subtest: bad-pitch-128 [119.837479] Subtest bad-pitch-128: SUCCESS (0.000s) [120.199356] [065/171] (889s left) kms_addfb_basic (bad-pitch-256) [120.352506] Starting subtest: bad-pitch-256 [120.353633] Subtest bad-pitch-256: SUCCESS (0.000s) [120.616210] [066/171] (888s left) kms_addfb_basic (bad-pitch-32) [120.773328] Starting subtest: bad-pitch-32 [120.774459] Subtest bad-pitch-32: SUCCESS (0.000s) [121.049101] [067/171] (888s left) kms_addfb_basic (bad-pitch-63) [121.205689] Starting subtest: bad-pitch-63 [121.206887] Subtest bad-pitch-63: SUCCESS (0.000s) [121.520081] [068/171] (887s left) kms_addfb_basic (bad-pitch-65536) [121.671587] Starting subtest: bad-pitch-65536 [121.672784] Subtest bad-pitch-65536: SUCCESS (0.001s) [121.966108] [069/171] (887s left) kms_addfb_basic (bad-pitch-999) [122.116968] Starting subtest: bad-pitch-999 [122.118167] Subtest bad-pitch-999: SUCCESS (0.000s) [122.399617] [070/171] (887s left) kms_addfb_basic (basic) [122.554945] Starting subtest: basic [122.557844] Subtest basic: SUCCESS (0.000s) [122.849681] [071/171] (886s left) kms_addfb_basic (basic-x-tiled-legacy) [123.216480] Starting subtest: basic-x-tiled-legacy [123.217694] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [123.299409] [072/171] (886s left) kms_addfb_basic (basic-y-tiled-legacy) [123.667834] Starting subtest: basic-y-tiled-legacy [123.670400] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [123.750569] [073/171] (885s left) kms_addfb_basic (bo-too-small) [123.979851] Starting subtest: bo-too-small [123.981110] Subtest bo-too-small: SUCCESS (0.001s) [124.182144] [074/171] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling) [124.414481] Starting subtest: bo-too-small-due-to-tiling [124.415639] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [124.633115] [075/171] (885s left) kms_addfb_basic (clobberred-modifier) [124.786838] Starting subtest: clobberred-modifier [124.788128] Subtest clobberred-modifier: SUCCESS (0.000s) [125.081864] [076/171] (884s left) kms_addfb_basic (framebuffer-vs-set-tiling) [125.435275] Starting subtest: framebuffer-vs-set-tiling [125.436468] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [125.516121] [077/171] (884s left) kms_addfb_basic (invalid-get-prop) [125.884787] Starting subtest: invalid-get-prop [125.886309] Subtest invalid-get-prop: SUCCESS (0.000s) [125.966330] [078/171] (883s left) kms_addfb_basic (invalid-get-prop-any) [126.338558] Starting subtest: invalid-get-prop-any [126.339798] Subtest invalid-get-prop-any: SUCCESS (0.000s) [126.432915] [079/171] (883s left) kms_addfb_basic (invalid-set-prop) [126.770864] Starting subtest: invalid-set-prop [126.772405] Subtest invalid-set-prop: SUCCESS (0.000s) [126.849457] [080/171] (882s left) kms_addfb_basic (invalid-set-prop-any) [127.215546] Starting subtest: invalid-set-prop-any [127.216921] Subtest invalid-set-prop-any: SUCCESS (0.000s) [127.299489] [081/171] (882s left) kms_addfb_basic (no-handle) [127.450641] Starting subtest: no-handle [127.451831] Subtest no-handle: SUCCESS (0.000s) [127.749671] [082/171] (882s left) kms_addfb_basic (size-max) [127.977798] Starting subtest: size-max [127.979244] Subtest size-max: SUCCESS (0.001s) [128.233152] [083/171] (881s left) kms_addfb_basic (small-bo) [128.460540] Starting subtest: small-bo [128.461797] Subtest small-bo: SUCCESS (0.000s) [128.699787] [084/171] (881s left) kms_addfb_basic (tile-pitch-mismatch) [129.070675] Starting subtest: tile-pitch-mismatch [129.072387] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [129.149902] [085/171] (880s left) kms_addfb_basic (too-high) [129.386791] Starting subtest: too-high [129.390245] Subtest too-high: SUCCESS (0.004s) [129.632998] [086/171] (880s left) kms_addfb_basic (too-wide) [129.855382] Starting subtest: too-wide [129.856547] Subtest too-wide: SUCCESS (0.001s) [130.083086] [087/171] (879s left) kms_addfb_basic (unused-handle) [130.237284] Starting subtest: unused-handle [130.238396] Subtest unused-handle: SUCCESS (0.000s) [130.549840] [088/171] (879s left) kms_addfb_basic (unused-modifier) [130.703240] Starting subtest: unused-modifier [130.704360] Subtest unused-modifier: SUCCESS (0.000s) [131.016814] [089/171] (879s left) kms_addfb_basic (unused-offsets) [131.169471] Starting subtest: unused-offsets [131.170823] Subtest unused-offsets: SUCCESS (0.000s) [131.483602] [090/171] (878s left) kms_addfb_basic (unused-pitches) [131.638976] Starting subtest: unused-pitches [131.640193] Subtest unused-pitches: SUCCESS (0.000s) [131.949626] [091/171] (878s left) kms_busy (basic) [132.203175] Starting subtest: basic [132.204326] Starting dynamic subtest: flip [133.108813] Dynamic subtest flip: SUCCESS (0.897s) [133.132963] Starting dynamic subtest: modeset [134.567856] Dynamic subtest modeset: SUCCESS (1.450s) [134.569407] Subtest basic: SUCCESS (2.357s) [134.793620] [092/171] (875s left) kms_chamelium_hpd (dp-hpd-fast) [135.273078] Subtest dp-hpd-fast: SKIP (0.000s) [135.451148] [093/171] (874s left) kms_chamelium_edid (dp-edid-read) [135.921046] Subtest dp-edid-read: SKIP (0.000s) [136.103120] [094/171] (874s left) kms_chamelium_frames (dp-crc-fast) [136.574217] Subtest dp-crc-fast: SKIP (0.000s) [136.751420] [095/171] (873s left) kms_chamelium_hpd (hdmi-hpd-fast) [137.220386] Subtest hdmi-hpd-fast: SKIP (0.000s) [137.399438] [096/171] (872s left) kms_chamelium_edid (hdmi-edid-read) [137.871472] Subtest hdmi-edid-read: SKIP (0.000s) [138.014138] [097/171] (872s left) kms_chamelium_frames (hdmi-crc-fast) [138.502867] Subtest hdmi-crc-fast: SKIP (0.000s) [138.678611] [098/171] (871s left) kms_chamelium_hpd (vga-hpd-fast) [139.152277] Subtest vga-hpd-fast: SKIP (0.000s) [139.294616] [099/171] (871s left) kms_chamelium_edid (vga-edid-read) [139.724602] Subtest vga-edid-read: SKIP (0.000s) [139.919391] [100/171] (870s left) kms_prop_blob (basic) [140.074233] Starting subtest: basic [140.075373] Subtest basic: SUCCESS (0.000s) [140.162768] [101/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [140.388717] Starting subtest: basic-busy-flip-before-cursor-atomic [140.391188] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [140.479454] [102/171] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [140.712184] Starting subtest: basic-busy-flip-before-cursor-legacy [140.714628] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [140.796327] [103/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [141.032668] Starting subtest: basic-flip-after-cursor-atomic [142.237698] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.205s) [142.398982] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [142.615446] Starting subtest: basic-flip-after-cursor-legacy [143.820083] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.201s) [143.975331] [105/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [144.199110] Starting subtest: basic-flip-after-cursor-varying-size [145.400299] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.206s) [145.616165] [106/171] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [145.852242] Starting subtest: basic-flip-before-cursor-atomic [147.109694] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.257s) [147.353331] [107/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [147.588170] Starting subtest: basic-flip-before-cursor-legacy [148.803979] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.212s) [149.022344] [108/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [149.258275] Starting subtest: basic-flip-before-cursor-varying-size [150.494762] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.227s) [150.706958] [109/171] (859s left) kms_flip (basic-flip-vs-dpms) [150.922436] Starting subtest: basic-flip-vs-dpms [150.931193] Starting dynamic subtest: A-HDMI-A2 [152.385173] Dynamic subtest A-HDMI-A2: SUCCESS (1.454s) [152.410963] Starting dynamic subtest: B-HDMI-A2 [153.577578] Dynamic subtest B-HDMI-A2: SUCCESS (1.179s) [153.606970] Starting dynamic subtest: C-HDMI-A2 [154.805300] Dynamic subtest C-HDMI-A2: SUCCESS (1.214s) [154.806435] Subtest basic-flip-vs-dpms: SUCCESS (3.880s) [155.083060] [110/171] (855s left) kms_flip (basic-flip-vs-modeset) [155.293179] Starting subtest: basic-flip-vs-modeset [155.299869] Starting dynamic subtest: A-HDMI-A2 [156.842694] Dynamic subtest A-HDMI-A2: SUCCESS (1.542s) [156.869957] Starting dynamic subtest: B-HDMI-A2 [158.073838] Dynamic subtest B-HDMI-A2: SUCCESS (1.221s) [158.094975] Starting dynamic subtest: C-HDMI-A2 [159.288364] Dynamic subtest C-HDMI-A2: SUCCESS (1.205s) [159.289640] Subtest basic-flip-vs-modeset: SUCCESS (3.995s) [159.521533] [111/171] (851s left) kms_flip (basic-flip-vs-wf_vblank) [159.738883] Starting subtest: basic-flip-vs-wf_vblank [159.746331] Starting dynamic subtest: A-HDMI-A2 [161.274389] Dynamic subtest A-HDMI-A2: SUCCESS (1.516s) [161.300975] Starting dynamic subtest: B-HDMI-A2 [162.714253] Dynamic subtest B-HDMI-A2: SUCCESS (1.433s) [162.737968] Starting dynamic subtest: C-HDMI-A2 [164.137887] Dynamic subtest C-HDMI-A2: SUCCESS (1.414s) [164.139099] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.391s) [164.565963] [112/171] (846s left) kms_flip (basic-plain-flip) [164.778500] Starting subtest: basic-plain-flip [164.787650] Starting dynamic subtest: A-HDMI-A2 [166.043450] Dynamic subtest A-HDMI-A2: SUCCESS (1.249s) [166.067025] Starting dynamic subtest: B-HDMI-A2 [167.193450] Dynamic subtest B-HDMI-A2: SUCCESS (1.132s) [167.216977] Starting dynamic subtest: C-HDMI-A2 [168.345440] Dynamic subtest C-HDMI-A2: SUCCESS (1.136s) [168.346727] Subtest basic-plain-flip: SUCCESS (3.560s) [168.770549] [113/171] (841s left) kms_force_connector_basic (force-connector-state) [169.015418] Starting subtest: force-connector-state [169.505243] Subtest force-connector-state: SUCCESS (0.493s) [170.076337] [114/171] (840s left) kms_force_connector_basic (force-edid) [170.337253] Starting subtest: force-edid [170.401295] Subtest force-edid: SUCCESS (0.064s) [170.709310] [115/171] (840s left) kms_force_connector_basic (force-load-detect) [170.982650] Starting subtest: force-load-detect [170.985912] Subtest force-load-detect: SKIP (0.000s) [171.276163] [116/171] (839s left) kms_force_connector_basic (prune-stale-modes) [171.561661] Starting subtest: prune-stale-modes [171.627919] Subtest prune-stale-modes: SUCCESS (0.068s) [171.909985] [117/171] (838s left) kms_frontbuffer_tracking (basic) [172.174495] Starting subtest: basic [175.079571] Subtest basic: SUCCESS (2.909s) [175.194498] [118/171] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [175.442100] Starting subtest: compare-crc-sanitycheck [175.445120] Starting dynamic subtest: pipe-A-HDMI-A-2 [176.044357] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.601s) [176.071969] Starting dynamic subtest: pipe-B-HDMI-A-2 [176.672036] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.625s) [176.696985] Starting dynamic subtest: pipe-C-HDMI-A-2 [177.331258] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.654s) [177.332883] Subtest compare-crc-sanitycheck: SUCCESS (1.885s) [177.539495] [119/171] (833s left) kms_pipe_crc_basic (hang-read-crc) [177.781305] Starting subtest: hang-read-crc [177.784830] Starting dynamic subtest: pipe-A-HDMI-A-2 [179.307856] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.523s) [179.332959] Starting dynamic subtest: pipe-B-HDMI-A-2 [180.843871] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.531s) [180.865979] Starting dynamic subtest: pipe-C-HDMI-A-2 [182.337478] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.496s) [182.338615] Subtest hang-read-crc: SUCCESS (4.557s) [182.620106] [120/171] (828s left) kms_pipe_crc_basic (nonblocking-crc) [182.877077] Starting subtest: nonblocking-crc [182.879932] Starting dynamic subtest: pipe-A-HDMI-A-2 [183.678357] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.801s) [183.702990] Starting dynamic subtest: pipe-B-HDMI-A-2 [184.469922] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.785s) [184.490181] Starting dynamic subtest: pipe-C-HDMI-A-2 [185.215250] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.740s) [185.216956] Subtest nonblocking-crc: SUCCESS (2.338s) [185.428243] [121/171] (825s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [185.678081] Starting subtest: nonblocking-crc-frame-sequence [185.679219] Starting dynamic subtest: pipe-A-HDMI-A-2 [186.466156] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.788s) [186.490961] Starting dynamic subtest: pipe-B-HDMI-A-2 [187.227167] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.747s) [187.248803] Starting dynamic subtest: pipe-C-HDMI-A-2 [188.115904] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.892s) [188.117049] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.440s) [188.319866] [122/171] (822s left) kms_pipe_crc_basic (read-crc) [188.562501] Starting subtest: read-crc [188.563657] Starting dynamic subtest: pipe-A-HDMI-A-2 [189.288904] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.724s) [189.310597] Starting dynamic subtest: pipe-B-HDMI-A-2 [190.020671] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.737s) [190.042959] Starting dynamic subtest: pipe-C-HDMI-A-2 [190.765627] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.735s) [190.766872] Subtest read-crc: SUCCESS (2.208s) [190.969365] [123/171] (820s left) kms_pipe_crc_basic (read-crc-frame-sequence) [191.212297] Starting subtest: read-crc-frame-sequence [191.213475] Starting dynamic subtest: pipe-A-HDMI-A-2 [191.920909] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.708s) [191.943983] Starting dynamic subtest: pipe-B-HDMI-A-2 [192.626945] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.706s) [192.651973] Starting dynamic subtest: pipe-C-HDMI-A-2 [193.387878] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.751s) [193.390117] Subtest read-crc-frame-sequence: SUCCESS (2.178s) [193.602128] [124/171] (817s left) kms_psr (primary_page_flip) [193.759742] Subtest primary_page_flip: SKIP (0.000s) [193.805480] [125/171] (817s left) kms_psr (cursor_plane_move) [193.960464] Subtest cursor_plane_move: SKIP (0.000s) [194.004726] [126/171] (817s left) kms_psr (sprite_plane_onoff) [194.158654] Subtest sprite_plane_onoff: SKIP (0.000s) [194.204733] [127/171] (816s left) kms_psr (primary_mmap_gtt) [194.358385] Subtest primary_mmap_gtt: SKIP (0.000s) [194.404850] [128/171] (816s left) kms_setmode (basic-clone-single-crtc) [194.558864] Starting subtest: basic-clone-single-crtc [194.562435] Subtest basic-clone-single-crtc: SKIP (0.000s) [194.651636] [129/171] (816s left) i915_pm_backlight (basic-brightness) [194.878781] Subtest basic-brightness: SKIP (0.000s) [194.921609] [130/171] (816s left) i915_pm_rpm (basic-pci-d3-state) [196.854152] Starting subtest: basic-pci-d3-state [197.331655] Subtest basic-pci-d3-state: SUCCESS (0.481s) [197.603941] [131/171] (813s left) i915_pm_rpm (basic-rte) [197.755285] Starting subtest: basic-rte [199.875185] Subtest basic-rte: SUCCESS (2.117s) [200.731904] [132/171] (810s left) i915_pm_rps (basic-api) [200.908527] Starting subtest: basic-api [200.921855] Subtest basic-api: SUCCESS (0.013s) [201.012773] [133/171] (810s left) prime_self_import (basic-llseek-bad) [201.163816] Starting subtest: basic-llseek-bad [201.171877] Subtest basic-llseek-bad: SUCCESS (0.007s) [201.262547] [134/171] (810s left) prime_self_import (basic-llseek-size) [201.412776] Starting subtest: basic-llseek-size [201.422471] Subtest basic-llseek-size: SUCCESS (0.010s) [201.512394] [135/171] (809s left) prime_self_import (basic-with_fd_dup) [201.662728] Starting subtest: basic-with_fd_dup [201.674190] Subtest basic-with_fd_dup: SUCCESS (0.011s) [201.763107] [136/171] (809s left) prime_self_import (basic-with_one_bo) [201.911717] Starting subtest: basic-with_one_bo [201.925638] Subtest basic-with_one_bo: SUCCESS (0.014s) [201.999462] [137/171] (809s left) prime_self_import (basic-with_one_bo_two_files) [202.146356] Starting subtest: basic-with_one_bo_two_files [202.154852] Subtest basic-with_one_bo_two_files: SUCCESS (0.008s) [202.245680] [138/171] (809s left) prime_self_import (basic-with_two_bos) [202.395749] Starting subtest: basic-with_two_bos [202.405943] Subtest basic-with_two_bos: SUCCESS (0.010s) [202.495633] [139/171] (808s left) prime_vgem (basic-fence-flip) [202.681077] Starting subtest: basic-fence-flip [203.226665] Subtest basic-fence-flip: SUCCESS (0.546s) [203.331379] [140/171] (808s left) prime_vgem (basic-fence-mmap) [203.515989] Starting subtest: basic-fence-mmap [203.575209] Subtest basic-fence-mmap: SUCCESS (0.057s) [203.663222] [141/171] (807s left) prime_vgem (basic-fence-read) [203.846594] Starting subtest: basic-fence-read [203.945715] Subtest basic-fence-read: SUCCESS (0.097s) [204.030171] [142/171] (807s left) prime_vgem (basic-gtt) [204.211675] Starting subtest: basic-gtt [204.248498] Subtest basic-gtt: SUCCESS (0.036s) [204.329574] [143/171] (807s left) prime_vgem (basic-read) [204.516430] Starting subtest: basic-read [204.573390] Subtest basic-read: SUCCESS (0.055s) [204.662668] [144/171] (806s left) prime_vgem (basic-write) [204.848119] Starting subtest: basic-write [204.912295] Subtest basic-write: SUCCESS (0.062s) [204.995853] [145/171] (806s left) prime_vgem (basic-userptr) [205.164950] Starting subtest: basic-userptr [205.185838] Subtest basic-userptr: SKIP (0.021s) [205.286412] [146/171] (806s left) vgem_basic (setversion) [205.447566] Starting subtest: setversion [205.449859] Subtest setversion: SUCCESS (0.000s) [205.512573] [147/171] (806s left) vgem_basic (create) [205.682349] Starting subtest: create [205.683526] Subtest create: SUCCESS (0.000s) [205.746306] [148/171] (805s left) vgem_basic (debugfs) [205.916367] Starting subtest: debugfs [205.917477] Subtest debugfs: SUCCESS (0.002s) [205.979310] [149/171] (805s left) vgem_basic (dmabuf-export) [206.147831] Starting subtest: dmabuf-export [206.156180] Subtest dmabuf-export: SUCCESS (0.009s) [206.247273] [150/171] (805s left) vgem_basic (dmabuf-fence) [206.414356] Starting subtest: dmabuf-fence [206.418106] Subtest dmabuf-fence: SUCCESS (0.004s) [206.479358] [151/171] (805s left) vgem_basic (dmabuf-fence-before) [206.647563] Starting subtest: dmabuf-fence-before [206.650789] Subtest dmabuf-fence-before: SUCCESS (0.003s) [206.712632] [152/171] (805s left) vgem_basic (dmabuf-mmap) [206.881583] Starting subtest: dmabuf-mmap [206.918148] Subtest dmabuf-mmap: SUCCESS (0.037s) [206.979366] [153/171] (804s left) vgem_basic (mmap) [207.153209] Starting subtest: mmap [207.186209] Subtest mmap: SUCCESS (0.032s) [207.245830] [154/171] (804s left) vgem_basic (second-client) [207.414753] Starting subtest: second-client [207.463089] Subtest second-client: SUCCESS (0.048s) [207.529381] [155/171] (804s left) vgem_basic (sysfs) [207.698464] Starting subtest: sysfs [207.699580] Subtest sysfs: SUCCESS (0.002s) [207.763117] [156/171] (804s left) core_hotunplug (unbind-rebind) [207.966488] Starting subtest: unbind-rebind [209.872831] Subtest unbind-rebind: SUCCESS (1.906s) [209.919379] [157/171] (802s left) vgem_basic (unload) [210.202651] Starting subtest: unload [239.115252] Subtest unload: SUCCESS (28.909s) [239.240637] [158/171] (772s left) i915_module_load (reload) [239.389566] Starting subtest: reload [242.138169] Subtest reload: SUCCESS (2.747s) [242.215065] [159/171] (769s left) gem_lmem_swapping (basic) [242.576879] Subtest basic: SKIP (0.000s) [242.655815] [160/171] (769s left) gem_lmem_swapping (parallel-random-engines) [242.952419] Subtest parallel-random-engines: SKIP (0.000s) [243.008133] [161/171] (769s left) gem_lmem_swapping (random-engines) [243.168546] Subtest random-engines: SKIP (0.000s) [243.221289] [162/171] (769s left) gem_lmem_swapping (verify-random) [243.386474] Subtest verify-random: SKIP (0.000s) [243.437964] [163/171] (768s left) i915_pm_rpm (module-reload) [245.617396] Starting subtest: module-reload [254.864379] Subtest module-reload: SUCCESS (9.246s) [254.895765] [164/171] (757s left) i915_selftest (live) [255.069389] Starting subtest: live [255.074981] Starting dynamic subtest: sanitycheck [256.081187] Dynamic subtest sanitycheck: SUCCESS (1.005s) [256.096120] Starting dynamic subtest: uncore [256.957328] Dynamic subtest uncore: SUCCESS (0.875s) [256.973429] Starting dynamic subtest: workarounds [258.178191] Dynamic subtest workarounds: SUCCESS (1.219s) [258.193932] Starting dynamic subtest: gt_engines [259.661832] Dynamic subtest gt_engines: SUCCESS (1.482s) [259.677159] Starting dynamic subtest: gt_timelines [274.262207] Dynamic subtest gt_timelines: SUCCESS (14.597s) [274.272284] Starting dynamic subtest: gt_contexts [275.338798] Dynamic subtest gt_contexts: SUCCESS (1.077s) [275.353969] Starting dynamic subtest: gt_lrc [279.069932] Dynamic subtest gt_lrc: SUCCESS (3.730s) [279.081425] Starting dynamic subtest: gt_mocs [280.101559] Dynamic subtest gt_mocs: SUCCESS (1.031s) [280.116921] Starting dynamic subtest: gt_pm [288.001355] Dynamic subtest gt_pm: SUCCESS (7.896s) [288.011794] Starting dynamic subtest: gt_heartbeat [289.012172] Dynamic subtest gt_heartbeat: SUCCESS (1.012s) [289.025972] Starting dynamic subtest: requests [296.683452] Dynamic subtest requests: SUCCESS (7.669s) [296.693389] Starting dynamic subtest: migrate [300.821530] Dynamic subtest migrate: SUCCESS (4.138s) [300.833198] Starting dynamic subtest: active [301.880250] Dynamic subtest active: SUCCESS (1.058s) [301.896095] Starting dynamic subtest: objects [305.662267] Dynamic subtest objects: SUCCESS (3.780s) [305.673621] Starting dynamic subtest: mman [313.487108] Dynamic subtest mman: SUCCESS (7.823s) [313.498214] Starting dynamic subtest: dmabuf [314.565496] Dynamic subtest dmabuf: SUCCESS (1.078s) [314.581125] Starting dynamic subtest: vma [315.590654] Dynamic subtest vma: SUCCESS (1.024s) [315.607354] Starting dynamic subtest: coherency [323.227737] Dynamic subtest coherency: SUCCESS (7.635s) [323.237536] Starting dynamic subtest: gtt [333.712877] Dynamic subtest gtt: SUCCESS (10.486s) [333.724658] Starting dynamic subtest: gem [334.844627] Dynamic subtest gem: SUCCESS (1.131s) [334.860149] Starting dynamic subtest: evict [338.569118] Dynamic subtest evict: SUCCESS (3.721s) [338.579691] Starting dynamic subtest: hugepages [345.463101] Dynamic subtest hugepages: SUCCESS (6.894s) [345.475217] Starting dynamic subtest: gem_contexts [363.565198] Dynamic subtest gem_contexts: SUCCESS (18.100s) [363.575653] Starting dynamic subtest: client [364.544501] Dynamic subtest client: SUCCESS (0.980s) [364.559944] Starting dynamic subtest: gem_migrate [365.521989] Dynamic subtest gem_migrate: SUCCESS (0.976s) [365.538165] Starting dynamic subtest: reset [370.922800] Dynamic subtest reset: SUCCESS (5.398s) [370.933595] Starting dynamic subtest: memory_region [371.841774] Dynamic subtest memory_region: SUCCESS (0.919s) [371.859088] Starting dynamic subtest: hangcheck [395.977078] Dynamic subtest hangcheck: SUCCESS (24.133s) [395.988339] Starting dynamic subtest: execlists [406.433643] Dynamic subtest execlists: SUCCESS (10.455s) [406.444169] Starting dynamic subtest: ring_submission [407.438488] Dynamic subtest ring_submission: SUCCESS (1.005s) [407.452989] Starting dynamic subtest: perf [408.423366] Dynamic subtest perf: SUCCESS (0.984s) [408.440995] Starting dynamic subtest: slpc [409.499749] Dynamic subtest slpc: SUCCESS (1.075s) [409.517099] Starting dynamic subtest: guc [410.556444] Dynamic subtest guc: SUCCESS (1.056s) [410.570965] Starting dynamic subtest: guc_multi_lrc [411.448689] Dynamic subtest guc_multi_lrc: SUCCESS (0.891s) [411.467151] Starting dynamic subtest: guc_hang [412.349514] Dynamic subtest guc_hang: SUCCESS (0.900s) [412.367969] Starting dynamic subtest: late_gt_pm [413.276949] Dynamic subtest late_gt_pm: SUCCESS (0.926s) [413.278138] Subtest live: SUCCESS (158.207s) [413.350911] [165/171] (598s left) dmabuf (all-tests) [413.515333] Starting subtest: all-tests [413.518820] Starting dynamic subtest: sanitycheck [413.547907] Dynamic subtest sanitycheck: SUCCESS (0.025s) [413.561735] Starting dynamic subtest: dma_fence [413.697693] Dynamic subtest dma_fence: SUCCESS (0.152s) [413.712132] Starting dynamic subtest: dma_fence_chain [435.734102] Dynamic subtest dma_fence_chain: SUCCESS (22.031s) [435.751833] Starting dynamic subtest: dma_fence_unwrap [435.761168] Dynamic subtest dma_fence_unwrap: SUCCESS (0.024s) [435.778061] Starting dynamic subtest: dma_resv [435.788451] Dynamic subtest dma_resv: SUCCESS (0.031s) [435.789650] Subtest all-tests: SUCCESS (22.273s) [435.818251] [166/171] (576s left) i915_suspend (basic-s2idle-without-i915) [435.967231] Starting subtest: basic-s2idle-without-i915 [454.849767] Subtest basic-s2idle-without-i915: SUCCESS (4.446s) [459.144904] [167/171] (571s left) i915_suspend (basic-s3-without-i915) [459.301748] Starting subtest: basic-s3-without-i915 [479.632343] Subtest basic-s3-without-i915: SUCCESS (4.702s) [482.904828] [168/171] (566s left) gem_exec_suspend (basic-s0) [483.097165] Starting subtest: basic-S0 [483.102499] Starting dynamic subtest: smem [505.301358] Dynamic subtest smem: SUCCESS (5.798s) [505.302701] Subtest basic-S0: SUCCESS (5.801s) [509.847202] [169/171] (560s left) gem_exec_suspend (basic-s3) [510.013143] Starting subtest: basic-S3 [510.017860] Starting dynamic subtest: smem [530.804524] Dynamic subtest smem: SUCCESS (6.080s) [530.805671] Subtest basic-S3: SUCCESS (6.083s) [536.313004] [170/171] (554s left) kms_chamelium_hpd (common-hpd-after-suspend) [536.759651] Subtest common-hpd-after-suspend: SKIP (0.000s) [536.940029] [171/171] (553s left) kms_pipe_crc_basic (suspend-read-crc) [537.173274] Starting subtest: suspend-read-crc [537.174562] Starting dynamic subtest: pipe-A-HDMI-A-2 [557.648021] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.574s) [557.675553] Starting dynamic subtest: pipe-B-HDMI-A-2 [578.583851] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.277s) [578.614415] Starting dynamic subtest: pipe-C-HDMI-A-2 [599.653084] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (4.410s) [599.654228] Subtest suspend-read-crc: SUCCESS (13.277s) [604.812809] Closing watchdogs Done.