framework.dart 10.4 KB
Newer Older
Ian Hickson's avatar
Ian Hickson committed
1
// Copyright 2014 The Flutter Authors. All rights reserved.
2 3 4 5 6 7 8 9 10 11
// Use of this source code is governed by a BSD-style license that can be
// found in the LICENSE file.

import 'dart:async';
import 'dart:convert';
import 'dart:developer';
import 'dart:io';
import 'dart:isolate';

import 'package:logging/logging.dart';
12
import 'package:path/path.dart' as path;
13
import 'package:process/process.dart';
14
import 'package:stack_trace/stack_trace.dart';
15

16 17
import 'devices.dart';
import 'host_agent.dart';
18
import 'running_processes.dart';
19
import 'task_result.dart';
20 21
import 'utils.dart';

22 23 24 25 26 27 28 29
/// Identifiers for devices that should never be rebooted.
final Set<String> noRebootForbidList = <String>{
  '822ef7958bba573829d85eef4df6cbdd86593730', // 32bit iPhone requires manual intervention on reboot.
};

/// The maximum number of test runs before a device must be rebooted.
///
/// This number was chosen arbitrarily.
30
const int maximumRuns = 30;
31

32 33
/// Represents a unit of work performed in the CI environment that can
/// succeed, fail and be retried independently of others.
34
typedef TaskFunction = Future<TaskResult> Function();
35 36 37 38 39

bool _isTaskRegistered = false;

/// Registers a [task] to run, returns the result when it is complete.
///
40
/// The task does not run immediately but waits for the request via the
41 42
/// VM service protocol to run it.
///
43
/// It is OK for a [task] to perform many things. However, only one task can be
44
/// registered per Dart VM.
45 46 47 48
///
/// If no `processManager` is provided, a default [LocalProcessManager] is created
/// for the task.
Future<TaskResult> task(TaskFunction task, { ProcessManager? processManager }) async {
49
  if (_isTaskRegistered)
50
    throw StateError('A task is already registered');
51 52
  _isTaskRegistered = true;

53 54
  processManager ??= const LocalProcessManager();

55
  // TODO(ianh): allow overriding logging.
56 57 58 59 60
  Logger.root.level = Level.ALL;
  Logger.root.onRecord.listen((LogRecord rec) {
    print('${rec.level.name}: ${rec.time}: ${rec.message}');
  });

61
  final _TaskRunner runner = _TaskRunner(task, processManager);
62 63 64 65 66
  runner.keepVmAliveUntilTaskRunRequested();
  return runner.whenDone;
}

class _TaskRunner {
67
  _TaskRunner(this.task, this.processManager) {
68 69
    registerExtension('ext.cocoonRunTask',
        (String method, Map<String, String> parameters) async {
70 71
      final Duration? taskTimeout = parameters.containsKey('timeoutInMinutes')
        ? Duration(minutes: int.parse(parameters['timeoutInMinutes']!))
72
        : null;
73
      final bool runFlutterConfig = parameters['runFlutterConfig'] != 'false'; // used by tests to avoid changing the configuration
74
      final bool runProcessCleanup = parameters['runProcessCleanup'] != 'false';
75 76 77 78 79 80 81
      final String? localEngine = parameters['localEngine'];
      final TaskResult result = await run(
        taskTimeout,
        runProcessCleanup: runProcessCleanup,
        runFlutterConfig: runFlutterConfig,
        localEngine: localEngine,
      );
82
      return ServiceExtensionResponse.result(json.encode(result.toJson()));
83
    });
84 85
    registerExtension('ext.cocoonRunnerReady',
        (String method, Map<String, String> parameters) async {
86
      return ServiceExtensionResponse.result('"ready"');
87 88 89
    });
  }

90
  final TaskFunction task;
91
  final ProcessManager processManager;
92

93
  Future<Device?> _getWorkingDeviceIfAvailable() async {
94 95 96 97 98 99 100
    try {
      return await devices.workingDevice;
    } on DeviceException {
      return null;
    }
  }

101
  // TODO(ianh): workaround for https://github.com/dart-lang/sdk/issues/23797
102 103
  RawReceivePort? _keepAlivePort;
  Timer? _startTaskTimeout;
104 105 106 107 108 109
  bool _taskStarted = false;

  final Completer<TaskResult> _completer = Completer<TaskResult>();

  static final Logger logger = Logger('TaskRunner');

110 111 112
  /// Signals that this task runner finished running the task.
  Future<TaskResult> get whenDone => _completer.future;

113
  Future<TaskResult> run(Duration? taskTimeout, {
114 115
    bool runFlutterConfig = true,
    bool runProcessCleanup = true,
116
    required String? localEngine,
117
  }) async {
118 119
    try {
      _taskStarted = true;
120
      print('Running task with a timeout of $taskTimeout.');
121
      final String exe = Platform.isWindows ? '.exe' : '';
122
      late Set<RunningProcessInfo> beforeRunningDartInstances;
123 124 125 126
      if (runProcessCleanup) {
        section('Checking running Dart$exe processes');
        beforeRunningDartInstances = await getRunningProcesses(
          processName: 'dart$exe',
127 128 129
          processManager: processManager,
        );
        final Set<RunningProcessInfo> allProcesses = await getRunningProcesses(processManager: processManager);
130 131 132 133 134
        beforeRunningDartInstances.forEach(print);
        for (final RunningProcessInfo info in allProcesses) {
          if (info.commandLine.contains('iproxy')) {
            print('[LEAK]: ${info.commandLine} ${info.creationDate} ${info.pid} ');
          }
135 136
        }
      }
137 138

      if (runFlutterConfig) {
139
        print('Enabling configs for macOS, Linux, Windows, and Web...');
140 141 142 143 144 145 146
        final int configResult = await exec(path.join(flutterDirectory.path, 'bin', 'flutter'), <String>[
          'config',
          '-v',
          '--enable-macos-desktop',
          '--enable-windows-desktop',
          '--enable-linux-desktop',
          '--enable-web',
147
          if (localEngine != null) ...<String>['--local-engine', localEngine],
148 149 150 151
        ], canFail: true);
        if (configResult != 0) {
          print('Failed to enable configuration, tasks may not run.');
        }
152 153
      }

154
      final Device? device = await _getWorkingDeviceIfAvailable();
155 156 157 158

      // Some tests assume the phone is in home
      await device?.home();

159 160
      late TaskResult result;
      IOSink? sink;
161 162
      try {
        if (device != null && device.canStreamLogs && hostAgent.dumpDirectory != null) {
163
          sink = File(path.join(hostAgent.dumpDirectory!.path, '${device.deviceId}.log')).openWrite();
164 165
          await device.startLoggingToSink(sink);
        }
166

167 168 169 170 171 172 173 174
        Future<TaskResult> futureResult = _performTask();
        if (taskTimeout != null)
          futureResult = futureResult.timeout(taskTimeout);

        result = await futureResult;
      } finally {
        if (device != null && device.canStreamLogs) {
          await device.stopLoggingToSink();
175
          await sink?.close();
176 177
        }
      }
178

179
      if (runProcessCleanup) {
180 181
        section('Terminating lingering Dart$exe processes after task...');
        final Set<RunningProcessInfo> afterRunningDartInstances = await getRunningProcesses(
182
          processName: 'dart$exe',
183 184
          processManager: processManager,
        );
185 186 187 188 189 190
        for (final RunningProcessInfo info in afterRunningDartInstances) {
          if (!beforeRunningDartInstances.contains(info)) {
            print('$info was leaked by this test.');
            if (result is TaskResultCheckProcesses) {
              result = TaskResult.failure('This test leaked dart processes');
            }
191
            if (await info.terminate(processManager: processManager)) {
192
              print('Killed process id ${info.pid}.');
193 194
            } else {
              print('Failed to kill process ${info.pid}.');
195
            }
196 197 198
          }
        }
      }
199 200
      _completer.complete(result);
      return result;
201
    } on TimeoutException catch (err, stackTrace) {
202
      print('Task timed out in framework.dart after $taskTimeout.');
203 204
      print(err);
      print(stackTrace);
205
      return TaskResult.failure('Task timed out after $taskTimeout');
206
    } finally {
207 208
      await checkForRebootRequired();
      await forceQuitRunningProcesses();
209 210 211 212
      _closeKeepAlivePort();
    }
  }

213 214 215 216 217 218 219 220 221 222
  Future<void> checkForRebootRequired() async {
    print('Checking for reboot');
    try {
      final Device device = await devices.workingDevice;
      if (noRebootForbidList.contains(device.deviceId)) {
        return;
      }
      final File rebootFile = _rebootFile();
      int runCount;
      if (rebootFile.existsSync()) {
223
        runCount = int.tryParse(rebootFile.readAsStringSync().trim()) ?? 0;
224 225 226
      } else {
        runCount = 0;
      }
227
      if (runCount < maximumRuns) {
228 229 230 231 232 233 234 235 236 237 238 239 240 241 242
        rebootFile
          ..createSync()
          ..writeAsStringSync((runCount + 1).toString());
        return;
      }
      rebootFile.deleteSync();
      print('rebooting');
      await device.reboot();
    } on TimeoutException {
      // Could not find device in order to reboot.
    } on DeviceException {
      // No attached device needed to reboot.
    }
  }

243 244 245
  /// Causes the Dart VM to stay alive until a request to run the task is
  /// received via the VM service protocol.
  void keepVmAliveUntilTaskRunRequested() {
246
    if (_taskStarted)
247
      throw StateError('Task already started.');
248 249 250

    // Merely creating this port object will cause the VM to stay alive and keep
    // the VM service server running until the port is disposed of.
251
    _keepAlivePort = RawReceivePort();
252 253

    // Timeout if nothing bothers to connect and ask us to run the task.
254
    const Duration taskStartTimeout = Duration(seconds: 60);
255
    _startTaskTimeout = Timer(taskStartTimeout, () {
256 257 258 259 260 261 262 263
      if (!_taskStarted) {
        logger.severe('Task did not start in $taskStartTimeout.');
        _closeKeepAlivePort();
        exitCode = 1;
      }
    });
  }

264
  /// Disables the keepalive port, allowing the VM to exit.
265 266 267 268 269
  void _closeKeepAlivePort() {
    _startTaskTimeout?.cancel();
    _keepAlivePort?.close();
  }

270
  Future<TaskResult> _performTask() {
271
    final Completer<TaskResult> completer = Completer<TaskResult>();
272 273 274
    Chain.capture(() async {
      completer.complete(await task());
    }, onError: (dynamic taskError, Chain taskErrorStack) {
275
      final String message = 'Task failed: $taskError';
276 277 278 279
      stderr
        ..writeln(message)
        ..writeln('\nStack trace:')
        ..writeln(taskErrorStack.terse);
280 281 282 283 284
      // IMPORTANT: We're completing the future _successfully_ but with a value
      // that indicates a task failure. This is intentional. At this point we
      // are catching errors coming from arbitrary (and untrustworthy) task
      // code. Our goal is to convert the failure into a readable message.
      // Propagating it further is not useful.
285
      if (!completer.isCompleted)
286
        completer.complete(TaskResult.failure(message));
287 288
    });
    return completer.future;
289 290
  }
}
291 292 293

File _rebootFile() {
  if (Platform.isLinux || Platform.isMacOS) {
294
    return File(path.join(Platform.environment['HOME']!, '.reboot-count'));
295 296 297 298
  }
  if (!Platform.isWindows) {
    throw StateError('Unexpected platform ${Platform.operatingSystem}');
  }
299
  return File(path.join(Platform.environment['USERPROFILE']!, '.reboot-count'));
300
}