[42.137633] Initializing watchdogs [42.137874] /dev/watchdog0 [42.148734] [001/171] (960s left) i915_module_load (load) [42.292896] Starting subtest: load [44.006950] Subtest load: SUCCESS (1.712s) [44.033539] [002/171] (958s left) core_auth (basic-auth) [44.393188] Starting subtest: basic-auth [44.395924] Subtest basic-auth: SUCCESS (0.002s) [44.479321] [003/171] (958s left) debugfs_test (read_all_entries) [44.739392] Starting subtest: read_all_entries [44.889576] Subtest read_all_entries: SUCCESS (0.149s) [45.010977] [004/171] (957s left) debugfs_test (basic-hwmon) [45.149546] Starting subtest: basic-hwmon [45.151792] Subtest basic-hwmon: SKIP (0.000s) [45.277797] [005/171] (957s left) fbdev (eof) [45.420868] Starting subtest: eof [45.422024] Subtest eof: SUCCESS (0.000s) [45.477106] [006/171] (957s left) fbdev (info) [45.603788] Starting subtest: info [45.604998] Subtest info: SUCCESS (0.000s) [45.677067] [007/171] (957s left) fbdev (nullptr) [45.820451] Starting subtest: nullptr [45.821599] Subtest nullptr: SUCCESS (0.000s) [45.876783] [008/171] (956s left) fbdev (read) [46.020371] Starting subtest: read [47.541256] Subtest read: SUCCESS (1.519s) [47.597714] [009/171] (955s left) fbdev (write) [47.740095] Starting subtest: write [48.547526] Subtest write: SUCCESS (0.807s) [48.613518] [010/171] (954s left) gem_basic (bad-close) [48.746124] Starting subtest: bad-close [48.749052] Subtest bad-close: SUCCESS (0.000s) [48.814796] [011/171] (954s left) gem_basic (create-close) [48.947300] Starting subtest: create-close [48.949698] Subtest create-close: SUCCESS (0.000s) [49.030738] [012/171] (953s left) gem_basic (create-fd-close) [49.162153] Starting subtest: create-fd-close [49.164398] Subtest create-fd-close: SUCCESS (0.000s) [49.245862] [013/171] (953s left) gem_busy (busy@all-engines) [49.395954] Starting subtest: busy [49.399763] Starting dynamic subtest: all-engines [49.454331] Dynamic subtest all-engines: SUCCESS (0.056s) [49.455448] Subtest busy: SUCCESS (0.058s) [49.781710] [014/171] (953s left) gem_close_race (basic-process) [49.936644] Starting subtest: basic-process [50.000119] Subtest basic-process: SUCCESS (0.062s) [50.180976] [015/171] (952s left) gem_close_race (basic-threads) [50.334482] Starting subtest: basic-threads [51.477740] Subtest basic-threads: SUCCESS (1.143s) [51.663813] [016/171] (951s left) gem_ctx_create (basic) [51.810493] Starting subtest: basic [51.812921] Subtest basic: SUCCESS (0.000s) [51.997503] [017/171] (951s left) gem_ctx_create (basic-files) [52.144701] Starting subtest: basic-files [54.169496] Subtest basic-files: SUCCESS (2.025s) [54.363910] [018/171] (948s left) gem_ctx_exec (basic) [54.502981] Starting subtest: basic [54.504145] Subtest basic: SUCCESS (0.005s) [54.583723] [019/171] (948s left) gem_exec_basic (basic) [54.718718] Starting subtest: basic [54.719781] Starting dynamic subtest: rcs0-smem [54.722753] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [54.733239] Starting dynamic subtest: bcs0-smem [54.734427] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [54.743236] Starting dynamic subtest: vcs0-smem [54.744354] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [54.752694] Starting dynamic subtest: vecs0-smem [54.753898] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [54.755066] Subtest basic: SUCCESS (0.014s) [54.930084] [020/171] (948s left) gem_exec_create (basic) [55.081021] Starting subtest: basic [55.082180] Starting dynamic subtest: smem [57.121687] Dynamic subtest smem: SUCCESS (2.039s) [57.122888] Subtest basic: SUCCESS (2.040s) [57.297843] [021/171] (945s left) gem_exec_fence (basic-busy) [57.576416] Starting subtest: basic-busy [57.577543] Starting dynamic subtest: rcs0 [57.596441] Dynamic subtest rcs0: SUCCESS (0.023s) [57.608640] Starting dynamic subtest: bcs0 [57.614025] Dynamic subtest bcs0: SUCCESS (0.016s) [57.624748] Starting dynamic subtest: vcs0 [57.626910] Dynamic subtest vcs0: SUCCESS (0.014s) [57.637950] Starting dynamic subtest: vecs0 [57.642230] Dynamic subtest vecs0: SUCCESS (0.016s) [57.643430] Subtest basic-busy: SUCCESS (0.070s) [58.281965] [022/171] (944s left) gem_exec_fence (basic-wait) [58.559872] Starting subtest: basic-wait [58.561149] Starting dynamic subtest: rcs0 [58.572290] Dynamic subtest rcs0: SUCCESS (0.016s) [58.585516] Starting dynamic subtest: bcs0 [58.592179] Dynamic subtest bcs0: SUCCESS (0.018s) [58.604533] Starting dynamic subtest: vcs0 [58.606246] Dynamic subtest vcs0: SUCCESS (0.013s) [58.618084] Starting dynamic subtest: vecs0 [58.619239] Dynamic subtest vecs0: SUCCESS (0.012s) [58.620374] Subtest basic-wait: SUCCESS (0.060s) [59.179545] [023/171] (943s left) gem_exec_fence (basic-await) [59.447706] Starting subtest: basic-await [59.449849] Starting dynamic subtest: rcs0 [59.546848] Dynamic subtest rcs0: SUCCESS (0.099s) [59.557208] Starting dynamic subtest: bcs0 [59.638157] Dynamic subtest bcs0: SUCCESS (0.090s) [59.648118] Starting dynamic subtest: vcs0 [59.731499] Dynamic subtest vcs0: SUCCESS (0.092s) [59.742155] Starting dynamic subtest: vecs0 [59.819589] Dynamic subtest vecs0: SUCCESS (0.089s) [59.820793] Subtest basic-await: SUCCESS (0.372s) [60.396192] [024/171] (942s left) gem_exec_fence (nb-await) [60.668939] Starting subtest: nb-await [60.670043] Starting dynamic subtest: rcs0 [60.737292] Dynamic subtest rcs0: SUCCESS (0.068s) [60.749943] Starting dynamic subtest: bcs0 [60.801619] Dynamic subtest bcs0: SUCCESS (0.063s) [60.813212] Starting dynamic subtest: vcs0 [60.864994] Dynamic subtest vcs0: SUCCESS (0.062s) [60.876966] Starting dynamic subtest: vecs0 [60.924846] Dynamic subtest vecs0: SUCCESS (0.063s) [60.926258] Subtest nb-await: SUCCESS (0.258s) [61.496667] [025/171] (941s left) gem_exec_gttfill (basic) [61.646468] Starting subtest: basic [73.591710] Subtest basic: SUCCESS (11.945s) [73.815801] [026/171] (929s left) gem_exec_parallel (engines) [74.065286] Starting subtest: engines [74.066539] Starting dynamic subtest: basic [76.958634] Dynamic subtest basic: SUCCESS (2.894s) [76.972226] Starting dynamic subtest: contexts [80.519154] Dynamic subtest contexts: SUCCESS (3.559s) [80.530788] Starting dynamic subtest: fds [84.656346] Dynamic subtest fds: SUCCESS (4.136s) [84.677673] Starting dynamic subtest: userptr [87.718256] Dynamic subtest userptr: SUCCESS (3.063s) [87.719473] Subtest engines: SUCCESS (13.654s) [87.901527] [027/171] (915s left) gem_exec_store (basic) [88.051307] Starting subtest: basic [88.102968] Subtest basic: SUCCESS (0.051s) [88.282054] [028/171] (914s left) gem_flink_basic (bad-flink) [88.413389] Starting subtest: bad-flink [88.414577] Subtest bad-flink: SUCCESS (0.000s) [88.482620] [029/171] (914s left) gem_flink_basic (bad-open) [88.612388] Starting subtest: bad-open [88.613669] Subtest bad-open: SUCCESS (0.000s) [88.681696] [030/171] (914s left) gem_flink_basic (basic) [88.812402] Starting subtest: basic [88.813517] Subtest basic: SUCCESS (0.000s) [88.899065] [031/171] (914s left) gem_flink_basic (double-flink) [89.032234] Starting subtest: double-flink [89.033444] Subtest double-flink: SUCCESS (0.001s) [89.113378] [032/171] (914s left) gem_flink_basic (flink-lifetime) [89.243216] Starting subtest: flink-lifetime [89.244409] Subtest flink-lifetime: SUCCESS (0.001s) [89.331379] [033/171] (914s left) gem_huc_copy (huc-copy) [89.468177] Starting subtest: huc-copy [89.470427] Subtest huc-copy: SKIP (0.000s) [89.548737] [034/171] (913s left) gem_linear_blits (basic) [89.834383] Starting subtest: basic [89.849227] Subtest basic: SUCCESS (0.014s) [89.980691] [035/171] (913s left) gem_mmap (basic) [90.210340] Starting subtest: basic [90.216132] Subtest basic: SUCCESS (0.001s) [90.282557] [036/171] (913s left) gem_mmap_gtt (basic) [90.416973] Starting subtest: basic [90.418143] Subtest basic: SUCCESS (0.001s) [90.469574] [037/171] (913s left) gem_render_linear_blits (basic) [90.607299] Starting subtest: basic [90.669276] Subtest basic: SUCCESS (0.059s) [90.720335] [038/171] (912s left) gem_render_tiled_blits (basic) [90.854465] Starting subtest: basic [90.936774] Subtest basic: SUCCESS (0.077s) [90.986719] [039/171] (912s left) gem_ringfill (basic-all) [91.327942] Starting subtest: basic-all [92.498949] Subtest basic-all: SUCCESS (1.169s) [92.583379] [040/171] (910s left) gem_softpin (allocator-basic) [92.721315] Starting subtest: allocator-basic [92.889974] Subtest allocator-basic: SUCCESS (0.166s) [93.000116] [041/171] (910s left) gem_softpin (allocator-basic-reserve) [93.139748] Starting subtest: allocator-basic-reserve [93.308642] Subtest allocator-basic-reserve: SUCCESS (0.167s) [93.397568] [042/171] (910s left) gem_softpin (safe-alignment) [93.532358] Starting subtest: safe-alignment [93.551156] Subtest safe-alignment: SUCCESS (0.018s) [93.647813] [043/171] (909s left) gem_sync (basic-all) [93.797055] Starting subtest: basic-all [96.421389] Subtest basic-all: SUCCESS (2.625s) [96.615772] [044/171] (907s left) gem_sync (basic-each) [96.766928] Starting subtest: basic-each [99.007675] Subtest basic-each: SUCCESS (2.243s) [99.200432] [045/171] (904s left) gem_tiled_blits (basic) [99.474678] Starting subtest: basic [99.509694] Subtest basic: SUCCESS (0.036s) [99.644720] [046/171] (904s left) gem_tiled_fence_blits (basic) [100.026234] Starting subtest: basic [100.056847] Subtest basic: SUCCESS (0.030s) [100.196974] [047/171] (903s left) gem_tiled_pread_basic [100.715385] [048/171] (903s left) gem_wait (busy@all-engines) [100.869780] Starting subtest: busy [100.872697] Starting dynamic subtest: all-engines [101.389153] Dynamic subtest all-engines: SUCCESS (0.520s) [101.390427] Subtest busy: SUCCESS (0.520s) [101.599699] [049/171] (902s left) gem_wait (wait@all-engines) [101.753685] Starting subtest: wait [101.754858] Starting dynamic subtest: all-engines [102.785229] Dynamic subtest all-engines: SUCCESS (1.031s) [102.786678] Subtest wait: SUCCESS (1.032s) [103.000587] [050/171] (900s left) i915_getparams_basic (basic-eu-total) [103.133159] Starting subtest: basic-eu-total [103.135296] Subtest basic-eu-total: SUCCESS (0.000s) [103.199629] [051/171] (900s left) i915_getparams_basic (basic-subslice-total) [103.330071] Starting subtest: basic-subslice-total [103.332372] Subtest basic-subslice-total: SUCCESS (0.000s) [103.398720] [052/171] (900s left) i915_hangman (error-state-basic) [103.547380] Starting subtest: error-state-basic [103.563036] Subtest error-state-basic: SUCCESS (0.012s) [103.632992] [053/171] (900s left) i915_pciid [103.831712] [054/171] (900s left) kms_addfb_basic (addfb25-bad-modifier) [103.966855] Starting subtest: addfb25-bad-modifier [103.969156] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [104.114299] [055/171] (899s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [104.251374] Starting subtest: addfb25-framebuffer-vs-set-tiling [104.252444] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.380898] [056/171] (899s left) kms_addfb_basic (addfb25-modifier-no-flag) [104.516955] Starting subtest: addfb25-modifier-no-flag [104.518120] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [104.647018] [057/171] (899s left) kms_addfb_basic (addfb25-x-tiled-legacy) [104.780952] Starting subtest: addfb25-x-tiled-legacy [104.782125] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s) [104.931101] [058/171] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [105.064555] Starting subtest: addfb25-x-tiled-mismatch-legacy [105.065810] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [105.214438] [059/171] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [105.415153] Starting subtest: addfb25-yf-tiled-legacy [105.416325] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [105.497669] [060/171] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [105.697425] Starting subtest: addfb25-y-tiled-legacy [105.698593] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [105.781096] [061/171] (898s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [105.980520] Starting subtest: addfb25-y-tiled-small-legacy [105.981673] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [106.064565] [062/171] (898s left) kms_addfb_basic (bad-pitch-0) [106.196467] Starting subtest: bad-pitch-0 [106.197815] Subtest bad-pitch-0: SUCCESS (0.000s) [106.348116] [063/171] (897s left) kms_addfb_basic (bad-pitch-1024) [106.478831] Starting subtest: bad-pitch-1024 [106.480702] Subtest bad-pitch-1024: SUCCESS (0.000s) [106.631262] [064/171] (897s left) kms_addfb_basic (bad-pitch-128) [106.761770] Starting subtest: bad-pitch-128 [106.763196] Subtest bad-pitch-128: SUCCESS (0.000s) [106.914261] [065/171] (897s left) kms_addfb_basic (bad-pitch-256) [107.044345] Starting subtest: bad-pitch-256 [107.045466] Subtest bad-pitch-256: SUCCESS (0.000s) [107.197586] [066/171] (896s left) kms_addfb_basic (bad-pitch-32) [107.330338] Starting subtest: bad-pitch-32 [107.331441] Subtest bad-pitch-32: SUCCESS (0.000s) [107.480938] [067/171] (896s left) kms_addfb_basic (bad-pitch-63) [107.613343] Starting subtest: bad-pitch-63 [107.614464] Subtest bad-pitch-63: SUCCESS (0.000s) [107.764447] [068/171] (896s left) kms_addfb_basic (bad-pitch-65536) [107.898981] Starting subtest: bad-pitch-65536 [107.900380] Subtest bad-pitch-65536: SUCCESS (0.001s) [108.047757] [069/171] (896s left) kms_addfb_basic (bad-pitch-999) [108.177804] Starting subtest: bad-pitch-999 [108.178935] Subtest bad-pitch-999: SUCCESS (0.000s) [108.331515] [070/171] (895s left) kms_addfb_basic (basic) [108.461449] Starting subtest: basic [108.462663] Subtest basic: SUCCESS (0.000s) [108.614581] [071/171] (895s left) kms_addfb_basic (basic-x-tiled-legacy) [108.748418] Starting subtest: basic-x-tiled-legacy [108.749593] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [108.898529] [072/171] (895s left) kms_addfb_basic (basic-y-tiled-legacy) [109.034113] Starting subtest: basic-y-tiled-legacy [109.036372] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [109.180849] [073/171] (895s left) kms_addfb_basic (bo-too-small) [109.379424] Starting subtest: bo-too-small [109.380585] Subtest bo-too-small: SUCCESS (0.001s) [109.464261] [074/171] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [109.657344] Starting subtest: bo-too-small-due-to-tiling [109.658544] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [109.747475] [075/171] (894s left) kms_addfb_basic (clobberred-modifier) [109.879280] Starting subtest: clobberred-modifier [109.880382] Subtest clobberred-modifier: SUCCESS (0.000s) [110.014310] [076/171] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [110.145489] Starting subtest: framebuffer-vs-set-tiling [110.146572] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [110.281210] [077/171] (894s left) kms_addfb_basic (invalid-get-prop) [110.412770] Starting subtest: invalid-get-prop [110.414106] Subtest invalid-get-prop: SUCCESS (0.000s) [110.564306] [078/171] (893s left) kms_addfb_basic (invalid-get-prop-any) [110.694469] Starting subtest: invalid-get-prop-any [110.695614] Subtest invalid-get-prop-any: SUCCESS (0.000s) [110.847655] [079/171] (893s left) kms_addfb_basic (invalid-set-prop) [110.979474] Starting subtest: invalid-set-prop [110.980635] Subtest invalid-set-prop: SUCCESS (0.000s) [111.130862] [080/171] (893s left) kms_addfb_basic (invalid-set-prop-any) [111.262450] Starting subtest: invalid-set-prop-any [111.263600] Subtest invalid-set-prop-any: SUCCESS (0.000s) [111.414413] [081/171] (893s left) kms_addfb_basic (no-handle) [111.546524] Starting subtest: no-handle [111.547741] Subtest no-handle: SUCCESS (0.000s) [111.697663] [082/171] (892s left) kms_addfb_basic (size-max) [111.891555] Starting subtest: size-max [111.892797] Subtest size-max: SUCCESS (0.001s) [111.981088] [083/171] (892s left) kms_addfb_basic (small-bo) [112.179204] Starting subtest: small-bo [112.180324] Subtest small-bo: SUCCESS (0.000s) [112.264250] [084/171] (892s left) kms_addfb_basic (tile-pitch-mismatch) [112.398908] Starting subtest: tile-pitch-mismatch [112.400193] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [112.547762] [085/171] (892s left) kms_addfb_basic (too-high) [112.745749] Starting subtest: too-high [112.748376] Subtest too-high: SUCCESS (0.003s) [112.831045] [086/171] (891s left) kms_addfb_basic (too-wide) [113.020849] Starting subtest: too-wide [113.022138] Subtest too-wide: SUCCESS (0.000s) [113.097601] [087/171] (891s left) kms_addfb_basic (unused-handle) [113.227296] Starting subtest: unused-handle [113.228354] Subtest unused-handle: SUCCESS (0.000s) [113.364408] [088/171] (891s left) kms_addfb_basic (unused-modifier) [113.495997] Starting subtest: unused-modifier [113.497279] Subtest unused-modifier: SUCCESS (0.000s) [113.631080] [089/171] (891s left) kms_addfb_basic (unused-offsets) [113.762367] Starting subtest: unused-offsets [113.763426] Subtest unused-offsets: SUCCESS (0.000s) [113.914273] [090/171] (890s left) kms_addfb_basic (unused-pitches) [114.043323] Starting subtest: unused-pitches [114.044454] Subtest unused-pitches: SUCCESS (0.000s) [114.197684] [091/171] (890s left) kms_busy (basic) [114.409523] Starting subtest: basic [114.413512] Starting dynamic subtest: flip [115.262510] Dynamic subtest flip: SUCCESS (0.849s) [115.282878] Starting dynamic subtest: modeset [116.609810] Dynamic subtest modeset: SUCCESS (1.346s) [116.612227] Subtest basic: SUCCESS (2.201s) [116.823158] [092/171] (887s left) kms_chamelium_hpd (dp-hpd-fast) [117.235100] Subtest dp-hpd-fast: SKIP (0.000s) [117.384203] [093/171] (887s left) kms_chamelium_edid (dp-edid-read) [117.804313] Subtest dp-edid-read: SKIP (0.000s) [117.924357] [094/171] (886s left) kms_chamelium_frames (dp-crc-fast) [118.331752] Subtest dp-crc-fast: SKIP (0.000s) [118.441427] [095/171] (886s left) kms_chamelium_hpd (hdmi-hpd-fast) [118.826410] Subtest hdmi-hpd-fast: SKIP (0.000s) [118.946373] [096/171] (885s left) kms_chamelium_edid (hdmi-edid-read) [119.371802] Subtest hdmi-edid-read: SKIP (0.000s) [119.510454] [097/171] (885s left) kms_chamelium_frames (hdmi-crc-fast) [119.931061] Subtest hdmi-crc-fast: SKIP (0.000s) [120.073991] [098/171] (884s left) kms_chamelium_hpd (vga-hpd-fast) [120.501156] Subtest vga-hpd-fast: SKIP (0.000s) [120.721276] [099/171] (884s left) kms_chamelium_edid (vga-edid-read) [121.139356] Subtest vga-edid-read: SKIP (0.000s) [121.309297] [100/171] (883s left) kms_prop_blob (basic) [121.441516] Starting subtest: basic [121.442905] Subtest basic: SUCCESS (0.000s) [121.521798] [101/171] (883s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [121.722163] Starting subtest: basic-busy-flip-before-cursor-atomic [121.724459] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [121.805412] [102/171] (883s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [122.001545] Starting subtest: basic-busy-flip-before-cursor-legacy [122.004408] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [122.072097] [103/171] (883s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [122.268836] Starting subtest: basic-flip-after-cursor-atomic [123.450440] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.183s) [123.640975] [104/171] (881s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [123.839217] Starting subtest: basic-flip-after-cursor-legacy [125.035308] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.196s) [125.235257] [105/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [125.437691] Starting subtest: basic-flip-after-cursor-varying-size [126.640780] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.203s) [126.817430] [106/171] (878s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [127.013057] Starting subtest: basic-flip-before-cursor-atomic [128.224405] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.212s) [128.401570] [107/171] (876s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [128.601058] Starting subtest: basic-flip-before-cursor-legacy [129.779694] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.178s) [129.977578] [108/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [130.178322] Starting subtest: basic-flip-before-cursor-varying-size [131.371821] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.193s) [131.569256] [109/171] (873s left) kms_flip (basic-flip-vs-dpms) [131.749212] Starting subtest: basic-flip-vs-dpms [131.755167] Starting dynamic subtest: A-HDMI-A2 [133.138053] Dynamic subtest A-HDMI-A2: SUCCESS (1.382s) [133.158890] Starting dynamic subtest: B-HDMI-A2 [134.261895] Dynamic subtest B-HDMI-A2: SUCCESS (1.120s) [134.276896] Starting dynamic subtest: C-HDMI-A2 [135.354111] Dynamic subtest C-HDMI-A2: SUCCESS (1.090s) [135.355111] Subtest basic-flip-vs-dpms: SUCCESS (3.602s) [135.529612] [110/171] (869s left) kms_flip (basic-flip-vs-modeset) [135.708162] Starting subtest: basic-flip-vs-modeset [135.714204] Starting dynamic subtest: A-HDMI-A2 [137.149963] Dynamic subtest A-HDMI-A2: SUCCESS (1.431s) [137.171035] Starting dynamic subtest: B-HDMI-A2 [138.205687] Dynamic subtest B-HDMI-A2: SUCCESS (1.059s) [138.230893] Starting dynamic subtest: C-HDMI-A2 [139.370776] Dynamic subtest C-HDMI-A2: SUCCESS (1.150s) [139.371871] Subtest basic-flip-vs-modeset: SUCCESS (3.661s) [139.582351] [111/171] (865s left) kms_flip (basic-flip-vs-wf_vblank) [139.764309] Starting subtest: basic-flip-vs-wf_vblank [139.770592] Starting dynamic subtest: A-HDMI-A2 [141.287898] Dynamic subtest A-HDMI-A2: SUCCESS (1.510s) [141.311510] Starting dynamic subtest: B-HDMI-A2 [142.656279] Dynamic subtest B-HDMI-A2: SUCCESS (1.372s) [142.678916] Starting dynamic subtest: C-HDMI-A2 [144.088799] Dynamic subtest C-HDMI-A2: SUCCESS (1.426s) [144.090873] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.318s) [144.495499] [112/171] (860s left) kms_flip (basic-plain-flip) [144.676924] Starting subtest: basic-plain-flip [144.683547] Starting dynamic subtest: A-HDMI-A2 [145.910905] Dynamic subtest A-HDMI-A2: SUCCESS (1.222s) [145.933884] Starting dynamic subtest: B-HDMI-A2 [147.075046] Dynamic subtest B-HDMI-A2: SUCCESS (1.151s) [147.100878] Starting dynamic subtest: C-HDMI-A2 [148.232683] Dynamic subtest C-HDMI-A2: SUCCESS (1.146s) [148.233721] Subtest basic-plain-flip: SUCCESS (3.556s) [148.637949] [113/171] (856s left) kms_force_connector_basic (force-connector-state) [148.888270] Starting subtest: force-connector-state [149.939448] Subtest force-connector-state: SUCCESS (1.052s) [150.420897] [114/171] (854s left) kms_force_connector_basic (force-edid) [150.668866] Starting subtest: force-edid [150.741804] Subtest force-edid: SUCCESS (0.071s) [151.020500] [115/171] (854s left) kms_force_connector_basic (force-load-detect) [151.272246] Starting subtest: force-load-detect [151.275237] Subtest force-load-detect: SKIP (0.000s) [151.553829] [116/171] (853s left) kms_force_connector_basic (prune-stale-modes) [151.804446] Starting subtest: prune-stale-modes [151.871232] Subtest prune-stale-modes: SUCCESS (0.066s) [152.153898] [117/171] (853s left) kms_frontbuffer_tracking (basic) [152.385289] Starting subtest: basic [155.216420] Subtest basic: SUCCESS (2.825s) [155.305618] [118/171] (850s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [155.524909] Starting subtest: compare-crc-sanitycheck [155.527151] Starting dynamic subtest: pipe-A-HDMI-A-2 [156.106812] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.573s) [156.131880] Starting dynamic subtest: pipe-B-HDMI-A-2 [157.013782] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.892s) [157.039890] Starting dynamic subtest: pipe-C-HDMI-A-2 [158.425907] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.395s) [158.427827] Subtest compare-crc-sanitycheck: SUCCESS (2.903s) [158.612057] [119/171] (846s left) kms_pipe_crc_basic (hang-read-crc) [158.828172] Starting subtest: hang-read-crc [158.834917] Starting dynamic subtest: pipe-A-HDMI-A-2 [160.386084] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.551s) [160.411922] Starting dynamic subtest: pipe-B-HDMI-A-2 [162.307914] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.906s) [162.334282] Starting dynamic subtest: pipe-C-HDMI-A-2 [165.082763] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.760s) [165.084811] Subtest hang-read-crc: SUCCESS (6.254s) [165.352299] [120/171] (840s left) kms_pipe_crc_basic (nonblocking-crc) [165.574109] Starting subtest: nonblocking-crc [165.576283] Starting dynamic subtest: pipe-A-HDMI-A-2 [166.362190] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.784s) [166.388897] Starting dynamic subtest: pipe-B-HDMI-A-2 [167.531388] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.152s) [167.561901] Starting dynamic subtest: pipe-C-HDMI-A-2 [169.062687] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.521s) [169.063765] Subtest nonblocking-crc: SUCCESS (3.491s) [169.252539] [121/171] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [169.474026] Starting subtest: nonblocking-crc-frame-sequence [169.480555] Starting dynamic subtest: pipe-A-HDMI-A-2 [170.255890] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.775s) [170.279896] Starting dynamic subtest: pipe-B-HDMI-A-2 [171.418100] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.148s) [171.445927] Starting dynamic subtest: pipe-C-HDMI-A-2 [172.831990] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.396s) [172.833131] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.356s) [173.024679] [122/171] (832s left) kms_pipe_crc_basic (read-crc) [173.234870] Starting subtest: read-crc [173.240668] Starting dynamic subtest: pipe-A-HDMI-A-2 [173.937543] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.696s) [173.964904] Starting dynamic subtest: pipe-B-HDMI-A-2 [175.145263] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.193s) [175.173886] Starting dynamic subtest: pipe-C-HDMI-A-2 [176.669649] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.507s) [176.670742] Subtest read-crc: SUCCESS (3.435s) [176.898061] [123/171] (828s left) kms_pipe_crc_basic (read-crc-frame-sequence) [177.111261] Starting subtest: read-crc-frame-sequence [177.117286] Starting dynamic subtest: pipe-A-HDMI-A-2 [177.808833] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.691s) [177.836884] Starting dynamic subtest: pipe-B-HDMI-A-2 [178.981157] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.153s) [179.006889] Starting dynamic subtest: pipe-C-HDMI-A-2 [180.137436] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.141s) [180.138507] Subtest read-crc-frame-sequence: SUCCESS (3.026s) [180.316754] [124/171] (825s left) kms_psr (primary_page_flip) [180.455765] Subtest primary_page_flip: SKIP (0.000s) [180.488184] [125/171] (825s left) kms_psr (cursor_plane_move) [180.619270] Subtest cursor_plane_move: SKIP (0.000s) [180.671917] [126/171] (825s left) kms_psr (sprite_plane_onoff) [180.805367] Subtest sprite_plane_onoff: SKIP (0.000s) [180.854943] [127/171] (824s left) kms_psr (primary_mmap_gtt) [180.985494] Subtest primary_mmap_gtt: SKIP (0.000s) [181.038069] [128/171] (824s left) kms_setmode (basic-clone-single-crtc) [181.171310] Starting subtest: basic-clone-single-crtc [181.174681] Subtest basic-clone-single-crtc: SKIP (0.000s) [181.249844] [129/171] (824s left) i915_pm_backlight (basic-brightness) [181.474556] Subtest basic-brightness: SKIP (0.000s) [181.521755] [130/171] (824s left) i915_pm_rpm (basic-pci-d3-state) [183.408228] Starting subtest: basic-pci-d3-state [184.149995] Subtest basic-pci-d3-state: SUCCESS (0.744s) [184.383463] [131/171] (821s left) i915_pm_rpm (basic-rte) [184.515431] Starting subtest: basic-rte [186.766158] Subtest basic-rte: SUCCESS (2.245s) [187.562796] [132/171] (818s left) i915_pm_rps (basic-api) [187.711414] Starting subtest: basic-api [187.722957] Subtest basic-api: SUCCESS (0.011s) [187.811500] [133/171] (818s left) prime_self_import (basic-llseek-bad) [187.942419] Starting subtest: basic-llseek-bad [187.949587] Subtest basic-llseek-bad: SUCCESS (0.006s) [188.027578] [134/171] (817s left) prime_self_import (basic-llseek-size) [188.159620] Starting subtest: basic-llseek-size [188.168331] Subtest basic-llseek-size: SUCCESS (0.008s) [188.244269] [135/171] (817s left) prime_self_import (basic-with_fd_dup) [188.374171] Starting subtest: basic-with_fd_dup [188.384149] Subtest basic-with_fd_dup: SUCCESS (0.010s) [188.460938] [136/171] (817s left) prime_self_import (basic-with_one_bo) [188.592252] Starting subtest: basic-with_one_bo [188.601373] Subtest basic-with_one_bo: SUCCESS (0.009s) [188.683175] [137/171] (817s left) prime_self_import (basic-with_one_bo_two_files) [188.811962] Starting subtest: basic-with_one_bo_two_files [188.821316] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s) [188.911147] [138/171] (817s left) prime_self_import (basic-with_two_bos) [189.036747] Starting subtest: basic-with_two_bos [189.046341] Subtest basic-with_two_bos: SUCCESS (0.009s) [189.127699] [139/171] (816s left) prime_vgem (basic-fence-flip) [189.281281] Starting subtest: basic-fence-flip [189.792234] Subtest basic-fence-flip: SUCCESS (0.510s) [189.878509] [140/171] (816s left) prime_vgem (basic-fence-mmap) [190.032506] Starting subtest: basic-fence-mmap [190.086143] Subtest basic-fence-mmap: SUCCESS (0.049s) [190.161865] [141/171] (815s left) prime_vgem (basic-fence-read) [190.315812] Starting subtest: basic-fence-read [190.406081] Subtest basic-fence-read: SUCCESS (0.088s) [190.478747] [142/171] (815s left) prime_vgem (basic-gtt) [190.629274] Starting subtest: basic-gtt [190.662159] Subtest basic-gtt: SUCCESS (0.033s) [190.744559] [143/171] (815s left) prime_vgem (basic-read) [190.902439] Starting subtest: basic-read [190.947231] Subtest basic-read: SUCCESS (0.046s) [191.044855] [144/171] (815s left) prime_vgem (basic-write) [191.198432] Starting subtest: basic-write [191.250738] Subtest basic-write: SUCCESS (0.052s) [191.327988] [145/171] (814s left) prime_vgem (basic-userptr) [191.479683] Starting subtest: basic-userptr [191.499640] Subtest basic-userptr: SKIP (0.020s) [191.599776] [146/171] (814s left) vgem_basic (setversion) [191.749403] Starting subtest: setversion [191.751561] Subtest setversion: SUCCESS (0.000s) [191.811213] [147/171] (814s left) vgem_basic (create) [191.949281] Starting subtest: create [191.950335] Subtest create: SUCCESS (0.001s) [192.011050] [148/171] (814s left) vgem_basic (debugfs) [192.149283] Starting subtest: debugfs [192.152244] Subtest debugfs: SUCCESS (0.002s) [192.211023] [149/171] (814s left) vgem_basic (dmabuf-export) [192.349587] Starting subtest: dmabuf-export [192.358264] Subtest dmabuf-export: SUCCESS (0.008s) [192.444665] [150/171] (813s left) vgem_basic (dmabuf-fence) [192.582588] Starting subtest: dmabuf-fence [192.585971] Subtest dmabuf-fence: SUCCESS (0.003s) [192.644616] [151/171] (813s left) vgem_basic (dmabuf-fence-before) [192.782757] Starting subtest: dmabuf-fence-before [192.785748] Subtest dmabuf-fence-before: SUCCESS (0.002s) [192.844494] [152/171] (813s left) vgem_basic (dmabuf-mmap) [192.983165] Starting subtest: dmabuf-mmap [193.014989] Subtest dmabuf-mmap: SUCCESS (0.032s) [193.077756] [153/171] (813s left) vgem_basic (mmap) [193.215991] Starting subtest: mmap [193.236640] Subtest mmap: SUCCESS (0.020s) [193.294395] [154/171] (813s left) vgem_basic (second-client) [193.433325] Starting subtest: second-client [193.481583] Subtest second-client: SUCCESS (0.048s) [193.544132] [155/171] (812s left) vgem_basic (sysfs) [193.682872] Starting subtest: sysfs [193.686643] Subtest sysfs: SUCCESS (0.004s) [193.744707] [156/171] (812s left) core_hotunplug (unbind-rebind) [193.933068] Starting subtest: unbind-rebind [195.516288] Subtest unbind-rebind: SUCCESS (1.583s) [195.579699] [157/171] (810s left) vgem_basic (unload) [195.890770] Starting subtest: unload [224.727687] Subtest unload: SUCCESS (28.837s) [224.848693] [158/171] (781s left) i915_module_load (reload) [224.983978] Starting subtest: reload [227.376350] Subtest reload: SUCCESS (2.391s) [227.427633] [159/171] (779s left) gem_lmem_swapping (basic) [227.748667] Subtest basic: SKIP (0.000s) [227.811892] [160/171] (778s left) gem_lmem_swapping (parallel-random-engines) [228.014796] Subtest parallel-random-engines: SKIP (0.000s) [228.056581] [161/171] (778s left) gem_lmem_swapping (random-engines) [228.194274] Subtest random-engines: SKIP (0.000s) [228.240148] [162/171] (778s left) gem_lmem_swapping (verify-random) [228.383736] Subtest verify-random: SKIP (0.000s) [228.423208] [163/171] (778s left) i915_pm_rpm (module-reload) [230.426229] Starting subtest: module-reload [238.715326] Subtest module-reload: SUCCESS (8.287s) [238.740047] [164/171] (768s left) i915_selftest (live) [238.896417] Starting subtest: live [238.899516] Starting dynamic subtest: sanitycheck [239.764640] Dynamic subtest sanitycheck: SUCCESS (0.863s) [239.780040] Starting dynamic subtest: uncore [240.514410] Dynamic subtest uncore: SUCCESS (0.749s) [240.529111] Starting dynamic subtest: workarounds [241.528263] Dynamic subtest workarounds: SUCCESS (1.013s) [241.542972] Starting dynamic subtest: gt_engines [242.756345] Dynamic subtest gt_engines: SUCCESS (1.227s) [242.769931] Starting dynamic subtest: gt_timelines [255.052050] Dynamic subtest gt_timelines: SUCCESS (12.293s) [255.062255] Starting dynamic subtest: gt_contexts [255.917245] Dynamic subtest gt_contexts: SUCCESS (0.865s) [255.931043] Starting dynamic subtest: gt_lrc [259.425974] Dynamic subtest gt_lrc: SUCCESS (3.507s) [259.436243] Starting dynamic subtest: gt_mocs [260.406603] Dynamic subtest gt_mocs: SUCCESS (0.980s) [260.416756] Starting dynamic subtest: gt_pm [267.555029] Dynamic subtest gt_pm: SUCCESS (7.146s) [267.565341] Starting dynamic subtest: gt_heartbeat [268.460223] Dynamic subtest gt_heartbeat: SUCCESS (0.906s) [268.475920] Starting dynamic subtest: requests [275.677979] Dynamic subtest requests: SUCCESS (7.216s) [275.688573] Starting dynamic subtest: migrate [279.557074] Dynamic subtest migrate: SUCCESS (3.878s) [279.567692] Starting dynamic subtest: active [280.328149] Dynamic subtest active: SUCCESS (0.771s) [280.342056] Starting dynamic subtest: objects [283.583024] Dynamic subtest objects: SUCCESS (3.253s) [283.594247] Starting dynamic subtest: mman [290.304982] Dynamic subtest mman: SUCCESS (6.721s) [290.315956] Starting dynamic subtest: dmabuf [291.210165] Dynamic subtest dmabuf: SUCCESS (0.905s) [291.225100] Starting dynamic subtest: vma [292.106427] Dynamic subtest vma: SUCCESS (0.895s) [292.121209] Starting dynamic subtest: coherency [295.023931] Dynamic subtest coherency: SUCCESS (2.915s) [295.034760] Starting dynamic subtest: gtt [305.165909] Dynamic subtest gtt: SUCCESS (10.141s) [305.176943] Starting dynamic subtest: gem [306.187425] Dynamic subtest gem: SUCCESS (1.021s) [306.199224] Starting dynamic subtest: evict [309.145673] Dynamic subtest evict: SUCCESS (2.956s) [309.156118] Starting dynamic subtest: hugepages [315.748287] Dynamic subtest hugepages: SUCCESS (6.603s) [315.760758] Starting dynamic subtest: gem_contexts [332.376355] Dynamic subtest gem_contexts: SUCCESS (16.626s) [332.387699] Starting dynamic subtest: client [333.209102] Dynamic subtest client: SUCCESS (0.833s) [333.224922] Starting dynamic subtest: gem_migrate [334.095380] Dynamic subtest gem_migrate: SUCCESS (0.885s) [334.111991] Starting dynamic subtest: reset [339.351951] Dynamic subtest reset: SUCCESS (5.255s) [339.363402] Starting dynamic subtest: memory_region [340.203061] Dynamic subtest memory_region: SUCCESS (0.851s) [340.217855] Starting dynamic subtest: hangcheck [363.984911] Dynamic subtest hangcheck: SUCCESS (23.780s) [363.995968] Starting dynamic subtest: execlists [373.789974] Dynamic subtest execlists: SUCCESS (9.804s) [373.800628] Starting dynamic subtest: ring_submission [374.602318] Dynamic subtest ring_submission: SUCCESS (0.812s) [374.615845] Starting dynamic subtest: perf [375.546797] Dynamic subtest perf: SUCCESS (0.943s) [375.561896] Starting dynamic subtest: slpc [376.357422] Dynamic subtest slpc: SUCCESS (0.810s) [376.375361] Starting dynamic subtest: guc [377.162824] Dynamic subtest guc: SUCCESS (0.804s) [377.178965] Starting dynamic subtest: guc_multi_lrc [378.137316] Dynamic subtest guc_multi_lrc: SUCCESS (0.975s) [378.158049] Starting dynamic subtest: guc_hang [379.097326] Dynamic subtest guc_hang: SUCCESS (0.954s) [379.125076] Starting dynamic subtest: late_gt_pm [380.034342] Dynamic subtest late_gt_pm: SUCCESS (0.939s) [380.035401] Subtest live: SUCCESS (141.136s) [380.105107] [165/171] (626s left) dmabuf (all-tests) [380.242368] Starting subtest: all-tests [380.247111] Starting dynamic subtest: sanitycheck [380.276945] Dynamic subtest sanitycheck: SUCCESS (0.030s) [380.287420] Starting dynamic subtest: dma_fence [380.414481] Dynamic subtest dma_fence: SUCCESS (0.136s) [380.427059] Starting dynamic subtest: dma_fence_chain [398.024697] Dynamic subtest dma_fence_chain: SUCCESS (17.606s) [398.039787] Starting dynamic subtest: dma_fence_unwrap [398.044588] Dynamic subtest dma_fence_unwrap: SUCCESS (0.022s) [398.061597] Starting dynamic subtest: dma_resv [398.075094] Dynamic subtest dma_resv: SUCCESS (0.018s) [398.076134] Subtest all-tests: SUCCESS (17.821s) [398.092163] [166/171] (608s left) i915_suspend (basic-s2idle-without-i915) [398.219562] Starting subtest: basic-s2idle-without-i915 [416.634325] Subtest basic-s2idle-without-i915: SUCCESS (3.960s) [422.895944] [167/171] (604s left) i915_suspend (basic-s3-without-i915) [423.027740] Starting subtest: basic-s3-without-i915 [443.256963] Subtest basic-s3-without-i915: SUCCESS (4.267s) [448.217894] [168/171] (599s left) gem_exec_suspend (basic-s0) [448.371359] Starting subtest: basic-S0 [448.377741] Starting dynamic subtest: smem [468.315137] Dynamic subtest smem: SUCCESS (4.526s) [468.316259] Subtest basic-S0: SUCCESS (4.528s) [473.476497] [169/171] (594s left) gem_exec_suspend (basic-s3) [473.623651] Starting subtest: basic-S3 [473.626322] Starting dynamic subtest: smem [495.619676] Dynamic subtest smem: SUCCESS (5.783s) [495.620749] Subtest basic-S3: SUCCESS (5.784s) [498.786893] [170/171] (588s left) kms_chamelium_hpd (common-hpd-after-suspend) [499.205642] Subtest common-hpd-after-suspend: SKIP (0.000s) [499.388644] [171/171] (588s left) kms_pipe_crc_basic (suspend-read-crc) [499.593326] Starting subtest: suspend-read-crc [499.600116] Starting dynamic subtest: pipe-A-HDMI-A-2 [520.366352] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.161s) [520.395522] Starting dynamic subtest: pipe-B-HDMI-A-2 [541.664605] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.717s) [541.694058] Starting dynamic subtest: pipe-C-HDMI-A-2 [564.031826] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.852s) [564.033102] Subtest suspend-read-crc: SUCCESS (14.770s) [569.209627] Closing watchdogs Done.