[46.900303] Initializing watchdogs [46.900405] /dev/watchdog0 [46.906438] [001/171] (960s left) i915_module_load (load) [46.973163] Starting subtest: load [47.913768] Subtest load: SUCCESS (0.936s) [47.935876] [002/171] (959s left) core_auth (basic-auth) [48.057329] Starting subtest: basic-auth [48.058421] Subtest basic-auth: SUCCESS (0.000s) [48.122628] [003/171] (959s left) debugfs_test (read_all_entries) [48.189398] Starting subtest: read_all_entries [48.227151] Subtest read_all_entries: SUCCESS (0.037s) [48.304452] [004/171] (959s left) debugfs_test (basic-hwmon) [48.367964] Starting subtest: basic-hwmon [48.370107] Subtest basic-hwmon: SKIP (0.000s) [48.437795] [005/171] (959s left) fbdev (eof) [48.510118] Starting subtest: eof [48.511280] Subtest eof: SUCCESS (0.000s) [48.554778] [006/171] (958s left) fbdev (info) [48.615974] Starting subtest: info [48.617021] Subtest info: SUCCESS (0.000s) [48.673508] [007/171] (958s left) fbdev (nullptr) [48.742845] Starting subtest: nullptr [48.744083] Subtest nullptr: SUCCESS (0.000s) [48.789671] [008/171] (958s left) fbdev (read) [48.859206] Starting subtest: read [48.957829] Subtest read: SUCCESS (0.098s) [49.005445] [009/171] (958s left) fbdev (write) [49.076813] Starting subtest: write [49.117255] Subtest write: SUCCESS (0.041s) [49.157639] [010/171] (958s left) gem_basic (bad-close) [49.220225] Starting subtest: bad-close [49.222428] Subtest bad-close: SUCCESS (0.000s) [49.271366] [011/171] (958s left) gem_basic (create-close) [49.335306] Starting subtest: create-close [49.337385] Subtest create-close: SUCCESS (0.000s) [49.405273] [012/171] (958s left) gem_basic (create-fd-close) [49.467643] Starting subtest: create-fd-close [49.469779] Subtest create-fd-close: SUCCESS (0.000s) [49.537493] [013/171] (958s left) gem_busy (busy@all-engines) [49.608939] Starting subtest: busy [49.610025] Starting dynamic subtest: all-engines [49.634375] Dynamic subtest all-engines: SUCCESS (0.025s) [49.635388] Subtest busy: SUCCESS (0.026s) [49.938345] [014/171] (957s left) gem_close_race (basic-process) [50.012391] Starting subtest: basic-process [50.050398] Subtest basic-process: SUCCESS (0.037s) [50.207265] [015/171] (957s left) gem_close_race (basic-threads) [50.280595] Starting subtest: basic-threads [51.476055] Subtest basic-threads: SUCCESS (1.195s) [51.639542] [016/171] (955s left) gem_ctx_create (basic) [51.708879] Starting subtest: basic [51.709951] Subtest basic: SUCCESS (0.000s) [51.876733] [017/171] (955s left) gem_ctx_create (basic-files) [51.946168] Starting subtest: basic-files [53.962813] Subtest basic-files: SUCCESS (2.017s) [54.165695] [018/171] (953s left) gem_ctx_exec (basic) [54.233867] Starting subtest: basic [54.236095] Subtest basic: SUCCESS (0.002s) [54.319783] [019/171] (953s left) gem_exec_basic (basic) [54.386689] Starting subtest: basic [54.387791] Starting dynamic subtest: rcs0-smem [54.388855] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [54.394188] Starting dynamic subtest: bcs0-smem [54.395272] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [54.400491] Starting dynamic subtest: vcs0-smem [54.401553] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [54.406761] Starting dynamic subtest: vecs0-smem [54.407789] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [54.408927] Subtest basic: SUCCESS (0.002s) [54.553372] [020/171] (953s left) gem_exec_create (basic) [54.626277] Starting subtest: basic [54.627300] Starting dynamic subtest: smem [56.672271] Dynamic subtest smem: SUCCESS (2.046s) [56.673310] Subtest basic: SUCCESS (2.046s) [56.841120] [021/171] (950s left) gem_exec_fence (basic-busy) [57.024936] Starting subtest: basic-busy [57.026075] Starting dynamic subtest: rcs0 [57.047615] Dynamic subtest rcs0: SUCCESS (0.023s) [57.055691] Starting dynamic subtest: bcs0 [57.080170] Dynamic subtest bcs0: SUCCESS (0.033s) [57.086063] Starting dynamic subtest: vcs0 [57.103718] Dynamic subtest vcs0: SUCCESS (0.023s) [57.110398] Starting dynamic subtest: vecs0 [57.137649] Dynamic subtest vecs0: SUCCESS (0.034s) [57.138937] Subtest basic-busy: SUCCESS (0.113s) [57.590964] [022/171] (950s left) gem_exec_fence (basic-wait) [57.774168] Starting subtest: basic-wait [57.775327] Starting dynamic subtest: rcs0 [57.808187] Dynamic subtest rcs0: SUCCESS (0.034s) [57.813743] Starting dynamic subtest: bcs0 [57.826188] Dynamic subtest bcs0: SUCCESS (0.018s) [57.831786] Starting dynamic subtest: vcs0 [57.859757] Dynamic subtest vcs0: SUCCESS (0.033s) [57.865945] Starting dynamic subtest: vecs0 [57.878201] Dynamic subtest vecs0: SUCCESS (0.019s) [57.879566] Subtest basic-wait: SUCCESS (0.105s) [58.306983] [023/171] (949s left) gem_exec_fence (basic-await) [58.488094] Starting subtest: basic-await [58.489264] Starting dynamic subtest: rcs0 [58.559016] Dynamic subtest rcs0: SUCCESS (0.071s) [58.564496] Starting dynamic subtest: bcs0 [58.630420] Dynamic subtest bcs0: SUCCESS (0.071s) [58.636092] Starting dynamic subtest: vcs0 [58.700732] Dynamic subtest vcs0: SUCCESS (0.071s) [58.706666] Starting dynamic subtest: vecs0 [58.770536] Dynamic subtest vecs0: SUCCESS (0.070s) [58.771663] Subtest basic-await: SUCCESS (0.283s) [59.205241] [024/171] (948s left) gem_exec_fence (nb-await) [59.386015] Starting subtest: nb-await [59.387210] Starting dynamic subtest: rcs0 [59.440470] Dynamic subtest rcs0: SUCCESS (0.054s) [59.446461] Starting dynamic subtest: bcs0 [59.493070] Dynamic subtest bcs0: SUCCESS (0.054s) [59.498945] Starting dynamic subtest: vcs0 [59.546592] Dynamic subtest vcs0: SUCCESS (0.053s) [59.552473] Starting dynamic subtest: vecs0 [59.599875] Dynamic subtest vecs0: SUCCESS (0.054s) [59.600948] Subtest nb-await: SUCCESS (0.214s) [60.037399] [025/171] (947s left) gem_exec_gttfill (basic) [60.107147] Starting subtest: basic [63.087753] Subtest basic: SUCCESS (2.980s) [63.251305] [026/171] (944s left) gem_exec_parallel (engines) [63.383558] Starting subtest: engines [63.384591] Starting dynamic subtest: basic [64.797261] Dynamic subtest basic: SUCCESS (1.413s) [64.804101] Starting dynamic subtest: contexts [66.364252] Dynamic subtest contexts: SUCCESS (1.567s) [66.371027] Starting dynamic subtest: fds [68.155224] Dynamic subtest fds: SUCCESS (1.790s) [68.161899] Starting dynamic subtest: userptr [69.571752] Dynamic subtest userptr: SUCCESS (1.417s) [69.573053] Subtest engines: SUCCESS (6.188s) [69.742567] [027/171] (938s left) gem_exec_store (basic) [69.814515] Starting subtest: basic [69.854772] Subtest basic: SUCCESS (0.040s) [70.018443] [028/171] (937s left) gem_flink_basic (bad-flink) [70.081342] Starting subtest: bad-flink [70.082423] Subtest bad-flink: SUCCESS (0.000s) [70.133810] [029/171] (937s left) gem_flink_basic (bad-open) [70.196474] Starting subtest: bad-open [70.197539] Subtest bad-open: SUCCESS (0.000s) [70.251106] [030/171] (937s left) gem_flink_basic (basic) [70.313146] Starting subtest: basic [70.314199] Subtest basic: SUCCESS (0.000s) [70.384829] [031/171] (937s left) gem_flink_basic (double-flink) [70.446196] Starting subtest: double-flink [70.447237] Subtest double-flink: SUCCESS (0.000s) [70.516834] [032/171] (937s left) gem_flink_basic (flink-lifetime) [70.578137] Starting subtest: flink-lifetime [70.579229] Subtest flink-lifetime: SUCCESS (0.001s) [70.650704] [033/171] (937s left) gem_huc_copy (huc-copy) [70.715993] Subtest huc-copy: SKIP (0.000s) [70.746607] [034/171] (937s left) gem_linear_blits (basic) [70.885124] Starting subtest: basic [70.892187] Subtest basic: SUCCESS (0.007s) [70.990619] [035/171] (936s left) gem_mmap (basic) [71.121638] Starting subtest: basic [71.126834] Subtest basic: SUCCESS (0.000s) [71.185404] [036/171] (936s left) gem_mmap_gtt (basic) [71.247374] Starting subtest: basic [71.248444] Subtest basic: SUCCESS (0.000s) [71.297712] [037/171] (936s left) gem_render_linear_blits (basic) [71.362625] Starting subtest: basic [71.378715] Subtest basic: SUCCESS (0.016s) [71.429689] [038/171] (936s left) gem_render_tiled_blits (basic) [71.495188] Starting subtest: basic [71.514783] Subtest basic: SUCCESS (0.019s) [71.545167] [039/171] (936s left) gem_ringfill (basic-all) [71.735146] Starting subtest: basic-all [72.841726] Subtest basic-all: SUCCESS (1.106s) [72.900041] [040/171] (935s left) gem_softpin (allocator-basic) [72.965307] Subtest allocator-basic: SKIP (0.000s) [73.016314] [041/171] (934s left) gem_softpin (allocator-basic-reserve) [73.080584] Subtest allocator-basic-reserve: SKIP (0.000s) [73.132890] [042/171] (934s left) gem_softpin (safe-alignment) [73.198521] Starting subtest: safe-alignment [73.205898] Subtest safe-alignment: SUCCESS (0.009s) [73.287567] [043/171] (934s left) gem_sync (basic-all) [73.359086] Starting subtest: basic-all [75.434857] Subtest basic-all: SUCCESS (2.075s) [75.599745] [044/171] (932s left) gem_sync (basic-each) [75.670050] Starting subtest: basic-each [77.736633] Subtest basic-each: SUCCESS (2.066s) [77.901100] [045/171] (930s left) gem_tiled_blits (basic) [78.029796] Starting subtest: basic [78.041565] Subtest basic: SUCCESS (0.011s) [78.140347] [046/171] (929s left) gem_tiled_fence_blits (basic) [78.341211] Starting subtest: basic [78.347344] Subtest basic: SUCCESS (0.006s) [78.457422] [047/171] (929s left) gem_tiled_pread_basic [78.751759] [048/171] (929s left) gem_wait (busy@all-engines) [78.824502] Starting subtest: busy [78.825659] Starting dynamic subtest: all-engines [79.338450] Dynamic subtest all-engines: SUCCESS (0.513s) [79.339751] Subtest busy: SUCCESS (0.513s) [79.515589] [049/171] (928s left) gem_wait (wait@all-engines) [79.587867] Starting subtest: wait [79.589024] Starting dynamic subtest: all-engines [80.602463] Dynamic subtest all-engines: SUCCESS (1.014s) [80.603665] Subtest wait: SUCCESS (1.014s) [80.781364] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [80.844412] Starting subtest: basic-eu-total [80.846493] Subtest basic-eu-total: SUCCESS (0.000s) [80.897914] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [80.958638] Starting subtest: basic-subslice-total [80.960866] Subtest basic-subslice-total: SUCCESS (0.000s) [81.014740] [052/171] (927s left) i915_hangman (error-state-basic) [81.082286] Starting subtest: error-state-basic [81.087600] Subtest error-state-basic: SUCCESS (0.005s) [81.164593] [053/171] (927s left) i915_pciid [81.281395] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier) [81.345620] Starting subtest: addfb25-bad-modifier [81.346872] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [81.430765] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [81.493944] Starting subtest: addfb25-framebuffer-vs-set-tiling [81.495012] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [81.581471] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag) [81.643075] Starting subtest: addfb25-modifier-no-flag [81.644129] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [81.730783] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [81.794019] Starting subtest: addfb25-x-tiled-legacy [81.795032] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [81.881321] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [81.943855] Starting subtest: addfb25-x-tiled-mismatch-legacy [81.944897] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [82.030640] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [82.114244] Starting subtest: addfb25-yf-tiled-legacy [82.115350] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [82.181418] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [82.276550] Starting subtest: addfb25-y-tiled-legacy [82.277608] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [82.347547] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [82.433176] Starting subtest: addfb25-y-tiled-small-legacy [82.435171] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [82.498501] [062/171] (925s left) kms_addfb_basic (bad-pitch-0) [82.560625] Starting subtest: bad-pitch-0 [82.561804] Subtest bad-pitch-0: SUCCESS (0.000s) [82.647462] [063/171] (925s left) kms_addfb_basic (bad-pitch-1024) [82.708354] Starting subtest: bad-pitch-1024 [82.709414] Subtest bad-pitch-1024: SUCCESS (0.000s) [82.797591] [064/171] (925s left) kms_addfb_basic (bad-pitch-128) [82.860431] Starting subtest: bad-pitch-128 [82.861490] Subtest bad-pitch-128: SUCCESS (0.000s) [82.947175] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [83.009136] Starting subtest: bad-pitch-256 [83.010210] Subtest bad-pitch-256: SUCCESS (0.000s) [83.096896] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [83.159327] Starting subtest: bad-pitch-32 [83.160441] Subtest bad-pitch-32: SUCCESS (0.000s) [83.247969] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [83.310939] Starting subtest: bad-pitch-63 [83.312035] Subtest bad-pitch-63: SUCCESS (0.000s) [83.397040] [068/171] (924s left) kms_addfb_basic (bad-pitch-65536) [83.460875] Starting subtest: bad-pitch-65536 [83.462028] Subtest bad-pitch-65536: SUCCESS (0.000s) [83.546866] [069/171] (924s left) kms_addfb_basic (bad-pitch-999) [83.608468] Starting subtest: bad-pitch-999 [83.609562] Subtest bad-pitch-999: SUCCESS (0.000s) [83.697076] [070/171] (924s left) kms_addfb_basic (basic) [83.758403] Starting subtest: basic [83.759494] Subtest basic: SUCCESS (0.000s) [83.847390] [071/171] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [83.910931] Starting subtest: basic-x-tiled-legacy [83.911916] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [83.996572] [072/171] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [84.061530] Starting subtest: basic-y-tiled-legacy [84.062587] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [84.150819] [073/171] (924s left) kms_addfb_basic (bo-too-small) [84.235784] Starting subtest: bo-too-small [84.236810] Subtest bo-too-small: SUCCESS (0.000s) [84.313938] [074/171] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [84.397638] Starting subtest: bo-too-small-due-to-tiling [84.398721] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [84.464165] [075/171] (924s left) kms_addfb_basic (clobberred-modifier) [84.525729] Starting subtest: clobberred-modifier [84.526767] Subtest clobberred-modifier: SUCCESS (0.000s) [84.614590] [076/171] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [84.677359] Starting subtest: framebuffer-vs-set-tiling [84.678374] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.763444] [077/171] (923s left) kms_addfb_basic (invalid-get-prop) [84.825498] Starting subtest: invalid-get-prop [84.826523] Subtest invalid-get-prop: SUCCESS (0.000s) [84.913812] [078/171] (923s left) kms_addfb_basic (invalid-get-prop-any) [84.976196] Starting subtest: invalid-get-prop-any [84.977240] Subtest invalid-get-prop-any: SUCCESS (0.000s) [85.082208] [079/171] (923s left) kms_addfb_basic (invalid-set-prop) [85.145577] Starting subtest: invalid-set-prop [85.146617] Subtest invalid-set-prop: SUCCESS (0.000s) [85.230298] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [85.294581] Starting subtest: invalid-set-prop-any [85.295582] Subtest invalid-set-prop-any: SUCCESS (0.000s) [85.397411] [081/171] (923s left) kms_addfb_basic (no-handle) [85.458485] Starting subtest: no-handle [85.459615] Subtest no-handle: SUCCESS (0.000s) [85.548853] [082/171] (923s left) kms_addfb_basic (size-max) [85.636316] Starting subtest: size-max [85.637404] Subtest size-max: SUCCESS (0.000s) [85.696919] [083/171] (922s left) kms_addfb_basic (small-bo) [85.781818] Starting subtest: small-bo [85.782844] Subtest small-bo: SUCCESS (0.000s) [85.846556] [084/171] (922s left) kms_addfb_basic (tile-pitch-mismatch) [85.908688] Starting subtest: tile-pitch-mismatch [85.909783] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [85.996137] [085/171] (922s left) kms_addfb_basic (too-high) [86.079543] Starting subtest: too-high [86.080635] Subtest too-high: SUCCESS (0.001s) [86.146950] [086/171] (922s left) kms_addfb_basic (too-wide) [86.229913] Starting subtest: too-wide [86.231037] Subtest too-wide: SUCCESS (0.000s) [86.296619] [087/171] (922s left) kms_addfb_basic (unused-handle) [86.360953] Starting subtest: unused-handle [86.361939] Subtest unused-handle: SUCCESS (0.000s) [86.446649] [088/171] (922s left) kms_addfb_basic (unused-modifier) [86.509311] Starting subtest: unused-modifier [86.510438] Subtest unused-modifier: SUCCESS (0.000s) [86.596513] [089/171] (922s left) kms_addfb_basic (unused-offsets) [86.659499] Starting subtest: unused-offsets [86.660499] Subtest unused-offsets: SUCCESS (0.000s) [86.746734] [090/171] (921s left) kms_addfb_basic (unused-pitches) [86.807578] Starting subtest: unused-pitches [86.808672] Subtest unused-pitches: SUCCESS (0.000s) [86.913294] [091/171] (921s left) kms_busy (basic) [87.000752] Starting subtest: basic [87.001836] Starting dynamic subtest: flip [87.504465] Dynamic subtest flip: SUCCESS (0.505s) [87.511441] Starting dynamic subtest: modeset [88.099712] Dynamic subtest modeset: SUCCESS (0.594s) [88.100759] Subtest basic: SUCCESS (1.100s) [88.234059] [092/171] (920s left) kms_chamelium_hpd (dp-hpd-fast) [88.360969] Subtest dp-hpd-fast: SKIP (0.000s) [88.445972] [093/171] (920s left) kms_chamelium_edid (dp-edid-read) [88.574173] Subtest dp-edid-read: SKIP (0.000s) [88.660151] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast) [88.789824] Subtest dp-crc-fast: SKIP (0.000s) [88.874102] [095/171] (919s left) kms_chamelium_hpd (hdmi-hpd-fast) [89.004466] Subtest hdmi-hpd-fast: SKIP (0.000s) [89.091346] [096/171] (919s left) kms_chamelium_edid (hdmi-edid-read) [89.219011] Subtest hdmi-edid-read: SKIP (0.000s) [89.308905] [097/171] (919s left) kms_chamelium_frames (hdmi-crc-fast) [89.452316] Subtest hdmi-crc-fast: SKIP (0.000s) [89.538504] [098/171] (919s left) kms_chamelium_hpd (vga-hpd-fast) [89.667110] Subtest vga-hpd-fast: SKIP (0.000s) [89.754506] [099/171] (919s left) kms_chamelium_edid (vga-edid-read) [89.884440] Subtest vga-edid-read: SKIP (0.000s) [89.973076] [100/171] (918s left) kms_prop_blob (basic) [90.036813] Starting subtest: basic [90.037950] Subtest basic: SUCCESS (0.000s) [90.092097] [101/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [90.175609] Starting subtest: basic-busy-flip-before-cursor-atomic [91.100453] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.924s) [91.231853] [102/171] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [91.316087] Starting subtest: basic-busy-flip-before-cursor-legacy [92.237789] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.922s) [92.371572] [103/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [92.461405] Starting subtest: basic-flip-after-cursor-atomic [93.407713] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.946s) [93.539834] [104/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [93.624183] Starting subtest: basic-flip-after-cursor-legacy [94.547137] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.923s) [94.681557] [105/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [94.767964] Starting subtest: basic-flip-after-cursor-varying-size [95.704458] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.936s) [95.834544] [106/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [95.916413] Starting subtest: basic-flip-before-cursor-atomic [96.840518] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.924s) [96.973829] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [97.057216] Starting subtest: basic-flip-before-cursor-legacy [97.981831] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.925s) [98.116154] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [98.199861] Starting subtest: basic-flip-before-cursor-varying-size [99.140561] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.940s) [99.278387] [109/171] (909s left) kms_flip (basic-flip-vs-dpms) [99.350735] Starting subtest: basic-flip-vs-dpms [99.352806] Starting dynamic subtest: A-VGA1 [100.292737] Dynamic subtest A-VGA1: SUCCESS (0.940s) [100.299752] Starting dynamic subtest: B-VGA1 [101.186832] Dynamic subtest B-VGA1: SUCCESS (0.894s) [101.193702] Starting dynamic subtest: C-VGA1 [102.083453] Dynamic subtest C-VGA1: SUCCESS (0.896s) [102.085460] Subtest basic-flip-vs-dpms: SUCCESS (2.735s) [102.221251] [110/171] (906s left) kms_flip (basic-flip-vs-modeset) [102.301583] Starting subtest: basic-flip-vs-modeset [102.303718] Starting dynamic subtest: A-VGA1 [103.159074] Dynamic subtest A-VGA1: SUCCESS (0.855s) [103.165943] Starting dynamic subtest: B-VGA1 [103.963821] Dynamic subtest B-VGA1: SUCCESS (0.805s) [103.970633] Starting dynamic subtest: C-VGA1 [104.761778] Dynamic subtest C-VGA1: SUCCESS (0.797s) [104.762793] Subtest basic-flip-vs-modeset: SUCCESS (2.462s) [104.892571] [111/171] (904s left) kms_flip (basic-flip-vs-wf_vblank) [104.970297] Starting subtest: basic-flip-vs-wf_vblank [104.972708] Starting dynamic subtest: A-VGA1 [106.116606] Dynamic subtest A-VGA1: SUCCESS (1.145s) [106.124494] Starting dynamic subtest: B-VGA1 [107.239351] Dynamic subtest B-VGA1: SUCCESS (1.122s) [107.247316] Starting dynamic subtest: C-VGA1 [108.362523] Dynamic subtest C-VGA1: SUCCESS (1.122s) [108.364990] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.396s) [108.532248] [112/171] (900s left) kms_flip (basic-plain-flip) [108.605370] Starting subtest: basic-plain-flip [108.606454] Starting dynamic subtest: A-VGA1 [109.477220] Dynamic subtest A-VGA1: SUCCESS (0.871s) [109.484798] Starting dynamic subtest: B-VGA1 [110.316692] Dynamic subtest B-VGA1: SUCCESS (0.839s) [110.323619] Starting dynamic subtest: C-VGA1 [111.158887] Dynamic subtest C-VGA1: SUCCESS (0.841s) [111.161146] Subtest basic-plain-flip: SUCCESS (2.557s) [111.329262] [113/171] (897s left) kms_force_connector_basic (force-connector-state) [111.402676] Starting subtest: force-connector-state [111.540404] Subtest force-connector-state: SUCCESS (0.137s) [111.724319] [114/171] (897s left) kms_force_connector_basic (force-edid) [111.797984] Starting subtest: force-edid [111.817296] Subtest force-edid: SUCCESS (0.019s) [111.907517] [115/171] (897s left) kms_force_connector_basic (force-load-detect) [111.981579] Starting subtest: force-load-detect [112.122685] Subtest force-load-detect: SUCCESS (0.141s) [112.304464] [116/171] (896s left) kms_force_connector_basic (prune-stale-modes) [112.378758] Starting subtest: prune-stale-modes [112.395765] Subtest prune-stale-modes: SUCCESS (0.017s) [112.487622] [117/171] (896s left) kms_frontbuffer_tracking (basic) [112.578782] Starting subtest: basic [114.406570] Subtest basic: SUCCESS (1.831s) [114.471720] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [114.559946] Starting subtest: compare-crc-sanitycheck-xr24 [114.560996] Starting dynamic subtest: pipe-A-VGA-1 [114.828898] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.268s) [114.835847] Starting dynamic subtest: pipe-B-VGA-1 [115.094886] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.265s) [115.102759] Starting dynamic subtest: pipe-C-VGA-1 [115.375243] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.278s) [115.376322] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.815s) [115.507790] [119/171] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [115.592620] Starting subtest: compare-crc-sanitycheck-nv12 [115.593825] Starting dynamic subtest: pipe-A-VGA-1 [115.596072] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [115.602792] Starting dynamic subtest: pipe-B-VGA-1 [115.604936] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [115.611458] Starting dynamic subtest: pipe-C-VGA-1 [115.613740] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [115.615931] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s) [115.657480] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc) [115.746231] Starting subtest: hang-read-crc [115.747305] Starting dynamic subtest: pipe-A-VGA-1 [116.476995] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.730s) [116.483748] Starting dynamic subtest: pipe-B-VGA-1 [117.214257] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.735s) [117.221507] Starting dynamic subtest: pipe-C-VGA-1 [117.959938] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.745s) [117.960920] Subtest hang-read-crc: SUCCESS (2.215s) [118.077719] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc) [118.163914] Starting subtest: nonblocking-crc [118.164985] Starting dynamic subtest: pipe-A-VGA-1 [118.601606] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.437s) [118.608339] Starting dynamic subtest: pipe-B-VGA-1 [119.028928] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s) [119.035976] Starting dynamic subtest: pipe-C-VGA-1 [119.470243] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.439s) [119.471338] Subtest nonblocking-crc: SUCCESS (1.306s) [119.587179] [122/171] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [119.677931] Starting subtest: nonblocking-crc-frame-sequence [119.680174] Starting dynamic subtest: pipe-A-VGA-1 [120.112398] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.431s) [120.119266] Starting dynamic subtest: pipe-B-VGA-1 [120.539196] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s) [120.548325] Starting dynamic subtest: pipe-C-VGA-1 [120.982120] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.442s) [120.983171] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.304s) [121.100677] [123/171] (888s left) kms_pipe_crc_basic (read-crc) [121.183923] Starting subtest: read-crc [121.184950] Starting dynamic subtest: pipe-A-VGA-1 [121.557808] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.373s) [121.564706] Starting dynamic subtest: pipe-B-VGA-1 [121.919030] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.360s) [121.925759] Starting dynamic subtest: pipe-C-VGA-1 [122.291063] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.371s) [122.292183] Subtest read-crc: SUCCESS (1.107s) [122.411899] [124/171] (886s left) kms_pipe_crc_basic (read-crc-frame-sequence) [122.497912] Starting subtest: read-crc-frame-sequence [122.498972] Starting dynamic subtest: pipe-A-VGA-1 [122.868409] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.369s) [122.875367] Starting dynamic subtest: pipe-B-VGA-1 [123.228860] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.360s) [123.237679] Starting dynamic subtest: pipe-C-VGA-1 [123.604152] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.373s) [123.605202] Subtest read-crc-frame-sequence: SUCCESS (1.106s) [123.722976] [125/171] (885s left) kms_psr (primary_page_flip) [123.787315] Subtest primary_page_flip: SKIP (0.000s) [123.817790] [126/171] (885s left) kms_psr (cursor_plane_move) [123.882202] Subtest cursor_plane_move: SKIP (0.000s) [123.900559] [127/171] (885s left) kms_psr (sprite_plane_onoff) [123.962996] Subtest sprite_plane_onoff: SKIP (0.000s) [123.984590] [128/171] (885s left) kms_psr (primary_mmap_gtt) [124.048223] Subtest primary_mmap_gtt: SKIP (0.000s) [124.068881] [129/171] (885s left) kms_setmode (basic-clone-single-crtc) [124.132093] Starting subtest: basic-clone-single-crtc [124.135212] Subtest basic-clone-single-crtc: SKIP (0.000s) [124.189830] [130/171] (885s left) i915_pm_backlight (basic-brightness) [124.275312] Subtest basic-brightness: SKIP (0.000s) [124.301102] [131/171] (885s left) i915_pm_rpm (basic-pci-d3-state) [125.668076] Starting subtest: basic-pci-d3-state [125.877540] Subtest basic-pci-d3-state: SUCCESS (0.208s) [126.123420] [132/171] (883s left) i915_pm_rpm (basic-rte) [126.187037] Starting subtest: basic-rte [127.698086] Subtest basic-rte: SUCCESS (1.508s) [128.145113] [133/171] (881s left) i915_pm_rps (basic-api) [128.211800] Starting subtest: basic-api [128.214231] Subtest basic-api: SUCCESS (0.002s) [128.278636] [134/171] (881s left) prime_self_import (basic-llseek-bad) [128.340992] Starting subtest: basic-llseek-bad [128.343067] Subtest basic-llseek-bad: SUCCESS (0.001s) [128.412392] [135/171] (880s left) prime_self_import (basic-llseek-size) [128.474129] Starting subtest: basic-llseek-size [128.476167] Subtest basic-llseek-size: SUCCESS (0.002s) [128.545103] [136/171] (880s left) prime_self_import (basic-with_fd_dup) [128.607400] Starting subtest: basic-with_fd_dup [128.609554] Subtest basic-with_fd_dup: SUCCESS (0.002s) [128.695578] [137/171] (880s left) prime_self_import (basic-with_one_bo) [128.756514] Starting subtest: basic-with_one_bo [128.758691] Subtest basic-with_one_bo: SUCCESS (0.003s) [128.809059] [138/171] (880s left) prime_self_import (basic-with_one_bo_two_files) [128.871260] Starting subtest: basic-with_one_bo_two_files [128.873208] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [128.947961] [139/171] (880s left) prime_self_import (basic-with_two_bos) [129.009491] Starting subtest: basic-with_two_bos [129.013325] Subtest basic-with_two_bos: SUCCESS (0.002s) [129.083619] [140/171] (880s left) prime_vgem (basic-fence-flip) [129.168089] Starting subtest: basic-fence-flip [129.496457] Subtest basic-fence-flip: SUCCESS (0.329s) [129.583720] [141/171] (879s left) prime_vgem (basic-fence-mmap) [129.650647] Starting subtest: basic-fence-mmap [129.673524] Subtest basic-fence-mmap: SUCCESS (0.023s) [129.747211] [142/171] (879s left) prime_vgem (basic-fence-read) [129.817141] Starting subtest: basic-fence-read [129.851609] Subtest basic-fence-read: SUCCESS (0.034s) [129.928317] [143/171] (879s left) prime_vgem (basic-gtt) [130.001262] Starting subtest: basic-gtt [130.012740] Subtest basic-gtt: SUCCESS (0.011s) [130.079588] [144/171] (879s left) prime_vgem (basic-read) [130.152397] Starting subtest: basic-read [130.169157] Subtest basic-read: SUCCESS (0.017s) [130.244649] [145/171] (879s left) prime_vgem (basic-write) [130.316904] Starting subtest: basic-write [130.334536] Subtest basic-write: SUCCESS (0.017s) [130.395322] [146/171] (879s left) vgem_basic (setversion) [130.464233] Starting subtest: setversion [130.466581] Subtest setversion: SUCCESS (0.000s) [130.512121] [147/171] (879s left) vgem_basic (create) [130.581063] Starting subtest: create [130.582185] Subtest create: SUCCESS (0.000s) [130.630294] [148/171] (878s left) vgem_basic (debugfs) [130.697474] Starting subtest: debugfs [130.698548] Subtest debugfs: SUCCESS (0.000s) [130.744771] [149/171] (878s left) vgem_basic (dmabuf-export) [130.814134] Starting subtest: dmabuf-export [130.816379] Subtest dmabuf-export: SUCCESS (0.002s) [130.878051] [150/171] (878s left) vgem_basic (dmabuf-fence) [130.947725] Starting subtest: dmabuf-fence [130.948842] Subtest dmabuf-fence: SUCCESS (0.001s) [130.995868] [151/171] (878s left) vgem_basic (dmabuf-fence-before) [131.064517] Starting subtest: dmabuf-fence-before [131.065592] Subtest dmabuf-fence-before: SUCCESS (0.000s) [131.111995] [152/171] (878s left) vgem_basic (dmabuf-mmap) [131.180645] Starting subtest: dmabuf-mmap [131.195481] Subtest dmabuf-mmap: SUCCESS (0.016s) [131.246570] [153/171] (878s left) vgem_basic (mmap) [131.314289] Starting subtest: mmap [131.324249] Subtest mmap: SUCCESS (0.011s) [131.363612] [154/171] (878s left) vgem_basic (second-client) [131.431071] Starting subtest: second-client [131.464747] Subtest second-client: SUCCESS (0.032s) [131.513805] [155/171] (878s left) vgem_basic (sysfs) [131.580578] Starting subtest: sysfs [131.581703] Subtest sysfs: SUCCESS (0.000s) [131.629915] [156/171] (878s left) core_hotunplug (unbind-rebind) [131.730373] Starting subtest: unbind-rebind [132.612546] Subtest unbind-rebind: SUCCESS (0.882s) [132.632757] [157/171] (877s left) vgem_basic (unload) [132.700469] Starting subtest: unload [161.629208] Subtest unload: SUCCESS (28.929s) [161.704972] [158/171] (848s left) i915_module_load (reload) [161.771124] Starting subtest: reload [163.642307] Subtest reload: SUCCESS (1.871s) [163.667928] [159/171] (846s left) gem_lmem_swapping (basic) [163.752959] Subtest basic: SKIP (0.000s) [163.784785] [160/171] (846s left) gem_lmem_swapping (parallel-random-engines) [163.850841] Subtest parallel-random-engines: SKIP (0.000s) [163.867999] [161/171] (845s left) gem_lmem_swapping (random-engines) [163.934469] Subtest random-engines: SKIP (0.000s) [163.952542] [162/171] (845s left) gem_lmem_swapping (verify-random) [164.021098] Subtest verify-random: SKIP (0.000s) [164.052789] [163/171] (845s left) i915_pm_rpm (module-reload) [165.901816] Starting subtest: module-reload [172.831216] Subtest module-reload: SUCCESS (6.929s) [172.845951] [164/171] (837s left) i915_selftest (live) [172.916128] Starting subtest: live [172.917367] Starting dynamic subtest: sanitycheck [173.460937] Dynamic subtest sanitycheck: SUCCESS (0.544s) [173.467326] Starting dynamic subtest: uncore [174.074488] Dynamic subtest uncore: SUCCESS (0.612s) [174.080721] Starting dynamic subtest: workarounds [174.857725] Dynamic subtest workarounds: SUCCESS (0.781s) [174.866067] Starting dynamic subtest: gt_engines [175.582233] Dynamic subtest gt_engines: SUCCESS (0.723s) [175.588150] Starting dynamic subtest: gt_timelines [181.431732] Dynamic subtest gt_timelines: SUCCESS (5.847s) [181.439223] Starting dynamic subtest: gt_contexts [182.151312] Dynamic subtest gt_contexts: SUCCESS (0.717s) [182.159118] Starting dynamic subtest: gt_lrc [182.826469] Dynamic subtest gt_lrc: SUCCESS (0.673s) [182.833454] Starting dynamic subtest: gt_mocs [183.509417] Dynamic subtest gt_mocs: SUCCESS (0.681s) [183.517724] Starting dynamic subtest: gt_pm [194.383918] Dynamic subtest gt_pm: SUCCESS (10.873s) [194.390098] Starting dynamic subtest: gt_heartbeat [195.205671] Dynamic subtest gt_heartbeat: SUCCESS (0.820s) [195.211264] Starting dynamic subtest: gt_tlb [195.843026] Dynamic subtest gt_tlb: SUCCESS (0.636s) [195.848875] Starting dynamic subtest: requests [202.199592] Dynamic subtest requests: SUCCESS (6.355s) [202.205811] Starting dynamic subtest: migrate [202.743895] Dynamic subtest migrate: SUCCESS (0.543s) [202.749730] Starting dynamic subtest: active [203.313057] Dynamic subtest active: SUCCESS (0.568s) [203.318761] Starting dynamic subtest: objects [204.371822] Dynamic subtest objects: SUCCESS (1.057s) [204.377359] Starting dynamic subtest: mman [208.481468] Dynamic subtest mman: SUCCESS (4.108s) [208.488048] Starting dynamic subtest: dmabuf [209.062988] Dynamic subtest dmabuf: SUCCESS (0.580s) [209.068441] Starting dynamic subtest: vma [209.620482] Dynamic subtest vma: SUCCESS (0.556s) [209.626420] Starting dynamic subtest: coherency [210.891350] Dynamic subtest coherency: SUCCESS (1.269s) [210.898154] Starting dynamic subtest: gtt [215.012573] Dynamic subtest gtt: SUCCESS (4.119s) [215.018589] Starting dynamic subtest: gem [215.776663] Dynamic subtest gem: SUCCESS (0.762s) [215.782378] Starting dynamic subtest: evict [216.444513] Dynamic subtest evict: SUCCESS (0.666s) [216.450599] Starting dynamic subtest: hugepages [217.678722] Dynamic subtest hugepages: SUCCESS (1.232s) [217.684640] Starting dynamic subtest: gem_contexts [222.582465] Dynamic subtest gem_contexts: SUCCESS (4.902s) [222.588151] Starting dynamic subtest: client [223.153926] Dynamic subtest client: SUCCESS (0.570s) [223.159711] Starting dynamic subtest: gem_migrate [223.710186] Dynamic subtest gem_migrate: SUCCESS (0.555s) [223.716726] Starting dynamic subtest: reset [225.523673] Dynamic subtest reset: SUCCESS (1.812s) [225.529447] Starting dynamic subtest: memory_region [226.218736] Dynamic subtest memory_region: SUCCESS (0.693s) [226.224310] Starting dynamic subtest: hangcheck [243.515685] Dynamic subtest hangcheck: SUCCESS (17.295s) [243.522766] Starting dynamic subtest: execlists [244.203769] Dynamic subtest execlists: SUCCESS (0.686s) [244.210616] Starting dynamic subtest: ring_submission [244.908171] Dynamic subtest ring_submission: SUCCESS (0.702s) [244.914163] Starting dynamic subtest: perf [245.699153] Dynamic subtest perf: SUCCESS (0.789s) [245.705241] Starting dynamic subtest: slpc [246.374633] Dynamic subtest slpc: SUCCESS (0.674s) [246.380699] Starting dynamic subtest: guc [247.055240] Dynamic subtest guc: SUCCESS (0.679s) [247.061916] Starting dynamic subtest: guc_multi_lrc [247.596648] Dynamic subtest guc_multi_lrc: SUCCESS (0.540s) [247.602339] Starting dynamic subtest: guc_hang [248.141032] Dynamic subtest guc_hang: SUCCESS (0.543s) [248.147291] Starting dynamic subtest: late_gt_pm [248.721905] Dynamic subtest late_gt_pm: SUCCESS (0.580s) [248.722992] Subtest live: SUCCESS (75.806s) [248.872704] [165/171] (761s left) dmabuf (all-tests) [248.943944] Starting subtest: all-tests [248.947460] Starting dynamic subtest: sanitycheck [249.009705] Dynamic subtest sanitycheck: SUCCESS (0.065s) [249.017642] Starting dynamic subtest: dma_fence [249.179837] Dynamic subtest dma_fence: SUCCESS (0.168s) [249.187663] Starting dynamic subtest: dma_fence_chain [260.764987] Dynamic subtest dma_fence_chain: SUCCESS (11.583s) [260.771733] Starting dynamic subtest: dma_fence_unwrap [260.831482] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s) [260.837311] Starting dynamic subtest: dma_resv [260.892491] Dynamic subtest dma_resv: SUCCESS (0.060s) [260.893605] Subtest all-tests: SUCCESS (11.949s) [260.905945] [166/171] (748s left) i915_suspend (basic-s2idle-without-i915) [260.967232] Starting subtest: basic-s2idle-without-i915 [277.543944] Subtest basic-s2idle-without-i915: SUCCESS (1.943s) [290.693161] [167/171] (746s left) i915_suspend (basic-s3-without-i915) [290.762477] Starting subtest: basic-s3-without-i915 [308.547678] Subtest basic-s3-without-i915: SUCCESS (1.832s) [321.692857] [168/171] (744s left) gem_exec_suspend (basic-s0) [321.775194] Starting subtest: basic-S0 [321.776197] Starting dynamic subtest: smem [338.496727] Dynamic subtest smem: SUCCESS (1.084s) [338.497852] Subtest basic-S0: SUCCESS (1.085s) [345.642556] [169/171] (743s left) gem_exec_suspend (basic-s3) [345.715264] Starting subtest: basic-S3 [345.716407] Starting dynamic subtest: smem [363.529044] Dynamic subtest smem: SUCCESS (1.133s) [363.530118] Subtest basic-S3: SUCCESS (1.134s) [369.645366] [170/171] (742s left) kms_chamelium_hpd (common-hpd-after-suspend) [369.776561] Subtest common-hpd-after-suspend: SKIP (0.000s) [369.862316] [171/171] (742s left) kms_pipe_crc_basic (suspend-read-crc) [369.947878] Starting subtest: suspend-read-crc [369.949036] Starting dynamic subtest: pipe-A-VGA-1 [387.667577] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.295s) [387.675984] Starting dynamic subtest: pipe-B-VGA-1 [405.686902] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.284s) [405.695430] Starting dynamic subtest: pipe-C-VGA-1 [423.691529] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.300s) [423.692800] Subtest suspend-read-crc: SUCCESS (3.884s) [427.784060] Closing watchdogs Done.