Lines Matching refs:TAG

162     private static final String TAG = "BackupManagerService";
366 Slog.d(TAG, "Provisioning change: was=" + wasProvisioned
373 if (MORE_DEBUG) Slog.d(TAG, "Now provisioned, so starting backups");
678 Slog.v(TAG, "Backup requested but no transport available");
697 if (DEBUG) Slog.v(TAG, "clearing pending backups");
723 Slog.e(TAG, "Transport became unavailable attempting backup");
727 Slog.v(TAG, "Backup requested but nothing pending");
745 if (MORE_DEBUG) Slog.v(TAG, "Got next step for " + task + ", executing");
748 Slog.e(TAG, "Invalid backup task in flight, obj=" + msg.obj);
759 Slog.e(TAG, "Invalid completion in flight, obj=" + msg.obj);
789 Slog.d(TAG, "MSG_RUN_RESTORE observer=" + params.observer);
862 Slog.e(TAG, "Error from transport getting set list");
868 Slog.e(TAG, "Unable to report listing to observer");
870 Slog.e(TAG, "Restore observer threw", e);
897 Slog.w(TAG, "Restore session timed out; aborting");
911 Slog.i(TAG, "Full backup/restore timed out waiting for user confirmation");
928 Slog.d(TAG, "couldn't find params for token " + msg.arg1);
997 Slog.e(TAG, "SELinux restorecon failed on " + mBaseStateDir);
1011 Slog.e(TAG, "Unable to read backup pw version");
1017 Slog.w(TAG, "Error closing pw version files");
1037 Slog.e(TAG, "Unable to read saved backup pw hash");
1043 Slog.w(TAG, "Unable to close streams");
1092 if (DEBUG) Slog.v(TAG, "Starting with transport " + mCurrentTransport);
1098 Slog.v(TAG, "Found transports: " + ((hosts == null) ? "null" : hosts.size()));
1104 Slog.v(TAG, " " + transport.packageName + "/" + transport.name);
1125 if (MORE_DEBUG) Slog.v(TAG, "Init pending at scheduled backup");
1130 Slog.e(TAG, "Run init intent cancelled");
1138 if (DEBUG) Slog.v(TAG, "Running a backup pass");
1148 Slog.i(TAG, "Backup time but one already running");
1151 Slog.w(TAG, "Backup pass but e=" + mEnabled + " p=" + mProvisioned);
1163 if (DEBUG) Slog.v(TAG, "Running a device init");
1177 if (MORE_DEBUG) Slog.v(TAG, "` tracking");
1200 Slog.v(TAG, "No ancestral data");
1202 Slog.w(TAG, "Unable to read token file", e);
1237 if (MORE_DEBUG) Slog.v(TAG, " + " + pkg);
1240 if (MORE_DEBUG) Slog.v(TAG, " - " + pkg);
1247 Slog.e(TAG, "Error renaming " + tempProcessedFile + " to " + mEverStored);
1250 Slog.e(TAG, "Error in processed file", e);
1294 Slog.e(TAG, "Unknown backup schedule version " + version);
1317 Slog.i(TAG, "Package " + pkgName
1323 Slog.i(TAG, "Package " + pkgName
1335 Slog.i(TAG, "New full backup app " + app.packageName + " found");
1345 Slog.e(TAG, "Unable to read backup schedule", e);
1403 Slog.e(TAG, "Unable to write backup schedule!", e);
1422 Slog.i(TAG, "Found stale backup journal, scheduling");
1426 if (MORE_DEBUG) Slog.i(TAG, " " + packageName);
1432 Slog.e(TAG, "Can't read " + f, e);
1452 Slog.e(TAG, "Invalid key spec for PBKDF2!");
1454 Slog.e(TAG, "PBKDF2 unavailable!");
1548 Slog.e(TAG, "Unable to write backup pw version; password not changed");
1555 Slog.w(TAG, "Unable to close pw version record");
1564 Slog.e(TAG, "Unable to clear backup password");
1599 Slog.e(TAG, "Unable to set backup password");
1617 if (DEBUG) Slog.w(TAG, "Backup password mismatch; aborting");
1627 if (MORE_DEBUG) Slog.i(TAG, "recordInitPendingLocked: " + isPending
1712 if (DEBUG) Slog.v(TAG, "Registering transport "
1746 Slog.e(TAG, "Unable to register transport as " + name);
1755 if (MORE_DEBUG) Slog.d(TAG, "Received broadcast " + intent);
1783 Slog.i(TAG, "Package " + pkgName + " changed; rechecking");
1785 Slog.i(TAG, " * " + components[i]);
1809 Slog.i(TAG, "Checking need to rebind " + className);
1836 Slog.i(TAG, "Yes, need to recheck binding");
1844 Slog.w(TAG, "Can't find changed package " + pkgName);
1890 Slog.i(TAG, "Transport package changed; rebinding");
1901 Slog.w(TAG, "Can't resolve new app " + packageName);
1931 if (DEBUG) Slog.v(TAG, "Connected to transport " + component);
1938 Slog.e(TAG, "Unable to register transport " + component);
1945 if (DEBUG) Slog.v(TAG, "Disconnected from transport " + component);
1975 Slog.w(TAG, "Transport package " + info.packageName + " not privileged");
1978 Slog.w(TAG, "Problem resolving transport package " + info.packageName);
1987 Slog.i(TAG, "Binding to transport host " + svcName);
2016 if (MORE_DEBUG) Slog.v(TAG, "addPackageParticipantsLocked: #" + packageNames.length);
2021 if (MORE_DEBUG) Slog.v(TAG, "addPackageParticipantsLocked: all");
2029 Slog.v(TAG, "Examining " + packageName + " for backup agent");
2041 if (MORE_DEBUG) Slog.v(TAG, "Agent found; added");
2044 if (MORE_DEBUG) Slog.i(TAG, "Scheduling backup for new app " + pkg.packageName);
2053 Slog.w(TAG, "removePackageParticipants with null list");
2057 if (MORE_DEBUG) Slog.v(TAG, "removePackageParticipantsLocked: uid=" + oldUid
2065 if (MORE_DEBUG) Slog.v(TAG, " last one of this uid; purging set");
2081 if (MORE_DEBUG) Slog.v(TAG, " removing participant " + packageName);
2131 Slog.e(TAG, "Can't log backup of " + packageName + " to " + mEverStored);
2140 if (DEBUG) Slog.v(TAG, "Removing backed-up knowledge of " + packageName);
2141 if (MORE_DEBUG) Slog.v(TAG, "New set:");
2154 if (MORE_DEBUG) Slog.v(TAG, " " + s);
2166 Slog.w(TAG, "Error rewriting " + mEverStored, e);
2195 if (DEBUG) Slog.v(TAG, "Ancestral packages: " + mAncestralPackages.size());
2198 if (MORE_DEBUG) Slog.v(TAG, " " + pkgName);
2203 Slog.w(TAG, "Unable to write token file:", e);
2212 Slog.w(TAG, "Requested unavailable transport: " + transportName);
2226 Slog.d(TAG, "awaiting agent for " + app);
2237 Slog.w(TAG, "Interrupted: " + e);
2245 Slog.w(TAG, "Timeout waiting for agent " + app);
2249 if (DEBUG) Slog.i(TAG, "got agent " + mConnectedAgent);
2265 if (MORE_DEBUG) Slog.i(TAG, "allowClearUserData=false so not wiping "
2270 Slog.w(TAG, "Tried to clear data for " + packageName + " but not found");
2316 Slog.i(TAG, "App in ever-stored, so using current token");
2321 if (MORE_DEBUG) Slog.i(TAG, "getAvailableRestoreToken() == " + token);
2340 if (MORE_DEBUG) Slog.v(TAG, "starting timeout: token=" + Integer.toHexString(token)
2352 if (MORE_DEBUG) Slog.i(TAG, "Blocking until operation complete for "
2378 if (MORE_DEBUG) Slog.v(TAG, "operation " + Integer.toHexString(token)
2389 if (op == null) Slog.w(TAG, "Timeout of token " + Integer.toHexString(token)
2394 if (DEBUG) Slog.v(TAG, "TIMEOUT: token=" + Integer.toHexString(token));
2416 private static final String TAG = "PerformBackupTask";
2467 Slog.e(TAG, "Duplicate finish");
2494 Slog.w(TAG, "Backup begun with an empty queue - nothing to do.");
2512 Slog.i(TAG, "Metadata in queue; eliding");
2519 if (DEBUG) Slog.v(TAG, "Beginning backup of " + mQueue.size() + " targets");
2528 Slog.i(TAG, "Initializing (wiping) backup state and transport storage");
2538 Slog.e(TAG, "Transport error in initializeDevice()");
2567 Slog.e(TAG, "Error in backup thread", e);
2593 if (MORE_DEBUG) Slog.i(TAG, "queue now empty");
2602 Slog.d(TAG, "starting key/value backup of " + request);
2617 Slog.i(TAG, "Package " + request.packageName
2628 Slog.i(TAG, "Package " + request.packageName
2662 Slog.d(TAG, "error in bind/backup", ex);
2667 Slog.d(TAG, "Package does not exist; skipping");
2682 if (MORE_DEBUG) Slog.i(TAG, "Agent failure for " + request.packageName
2713 Slog.e(TAG, "Unable to remove backup journal file " + mJournal);
2739 if (MORE_DEBUG) Slog.d(TAG, "Server requires init; rerunning");
2747 Slog.i(BackupManagerService.TAG, "Backup pass finished.");
2761 if (DEBUG) Slog.d(TAG, "invokeAgentForBackup on " + packageName);
2767 if (MORE_DEBUG) Slog.d(TAG, "data file: " + mBackupDataName);
2798 Slog.e(TAG, "SELinux restorecon failed on " + mBackupDataName);
2812 Slog.e(TAG, "Error invoking for backup on " + packageName);
2832 Slog.w(TAG, "Error conveying failure to " + mCurrentPackage.packageName);
2843 Slog.e(TAG, "Unable to use SHA-1!");
2864 Slog.i(TAG, "Checking widget update: state=" + (widgetState != null)
2926 Slog.i(TAG, "Callback after agent teardown: " + pkg);
2973 Slog.w(TAG, "Unable to save widget state for " + pkgName);
2977 Slog.w(TAG, "Unable to roll back!");
2982 if (MORE_DEBUG) Slog.v(TAG, "operationComplete(): sending data to transport for "
3014 if (MORE_DEBUG) Slog.i(TAG, "no backup data written; not calling transport");
3037 Slog.e(TAG, "Transport error backing up " + pkgName, e);
3066 Slog.e(TAG, "Timeout backing up " + mCurrentPackage.packageName);
3075 if (MORE_DEBUG) Slog.i(TAG, "Reverting backup queue - restaging everything");
3084 Slog.w(TAG, "Unable to contact transport for recommended backoff");
3126 if (MORE_DEBUG) Slog.i(TAG, " => executing next step on "
3146 if (MORE_DEBUG) Slog.i(TAG, "Initiating bind of OBB service on " + this);
3171 Slog.w(TAG, "Unable to back up OBBs for " + pkg, e);
3180 Slog.w(TAG, "I/O error closing down OBB backup", e);
3195 Slog.w(TAG, "Unable to restore OBBs for " + pkgName, e);
3202 if (MORE_DEBUG) Slog.i(TAG, "...waiting for OBB service binding...");
3207 if (MORE_DEBUG) Slog.i(TAG, "Connected to OBB service; continuing");
3215 if (MORE_DEBUG) Slog.i(TAG, "OBB service connection " + mService
3225 if (MORE_DEBUG) Slog.i(TAG, "OBB service connection disconnected on " + this);
3260 if (MORE_DEBUG) Slog.d(TAG, "Killing agent host process");
3263 if (MORE_DEBUG) Slog.d(TAG, "Not killing after operation: " + app.processName);
3266 Slog.d(TAG, "Lost app trying to shut down");
3323 if (MORE_DEBUG) Slog.d(TAG, "Writing manifest for " + mPackage.packageName);
3346 if (DEBUG) Slog.d(TAG, "Calling doFullBackup() on " + mPackage.packageName);
3350 Slog.e(TAG, "Error running full backup for " + mPackage.packageName);
3352 Slog.e(TAG, "Remote agent vanished during full backup of "
3374 Slog.d(TAG, "Binding to full backup agent : " + pkg.packageName);
3385 Slog.v(TAG, "preflight returned " + result);
3416 Slog.i(TAG, "Caught exception reading from agent", e);
3421 Slog.e(TAG, "Full backup failed on package " + pkg.packageName);
3425 Slog.d(TAG, "Full package backup success: " + pkg.packageName);
3430 Slog.e(TAG, "Error backing up " + pkg.packageName, e);
3441 Slog.w(TAG, "Error bringing down backup stack");
3446 Slog.w(TAG, "Unable to bind to full agent for " + pkg.packageName);
3469 if (MORE_DEBUG) Log.i(TAG, "obb dir: " + obbDir.getAbsolutePath());
3592 Slog.w(TAG, "full backup observer went away: startBackup");
3604 Slog.w(TAG, "full backup observer went away: backupPackage");
3615 Slog.w(TAG, "full backup observer went away: endBackup");
3631 Slog.e(TAG, "Unable to communicate with mount service: " + e.getMessage());
3692 Slog.w(TAG, "Unknown package " + pkgName + ", skipping");
3775 Slog.w(TAG, "Error attempting to finalize backup stream");
3781 Slog.i(TAG, "--- Performing full-dataset adb backup ---");
3810 Slog.i(TAG, "Adding widget participants to backup set:");
3817 Slog.i(TAG, sb.toString());
3853 Slog.e(TAG, "Unencrypted backup of encrypted device; aborting");
3862 if (DEBUG) Slog.w(TAG, "Backup password mismatch; aborting");
3917 Slog.e(TAG, "Unable to emit archive header", e);
3927 Slog.e(TAG, "Unable to find shared-storage backup handler");
3955 Slog.e(TAG, "App died during full backup");
3957 Slog.e(TAG, "Internal exception during full backup", e);
3974 if (DEBUG) Slog.d(TAG, "Full backup pass complete.");
3982 static final String TAG = "PFTBT";
4009 Slog.d(TAG, "Ignoring opted-out package " + pkg);
4017 Slog.d(TAG, "Ignoring non-agent system package " + pkg);
4025 Slog.d(TAG, "Ignoring stopped package " + pkg);
4031 Slog.i(TAG, "Requested package " + pkg + " not found; ignoring");
4055 Slog.i(TAG, "full backup requested but e=" + mEnabled
4064 Slog.w(TAG, "Transport not present; full data backup not performed");
4073 Slog.i(TAG, "Initiating full-data transport backup of "
4115 Slog.i(TAG, "Full backup task told to stop");
4121 Slog.v(TAG, "in.read(buffer) from app: " + nRead);
4147 Slog.i(TAG, "Done trying to send backup data: result=" + result);
4151 Slog.e(TAG, "Error " + result
4159 Slog.i(TAG, "Transport suggested backoff=" + backoff);
4173 Slog.i(TAG, "Transport rejected backup of "
4181 Slog.w(TAG, "Transport failed; aborting backup: " + result);
4196 Slog.i(TAG, "Full backup completed.");
4199 Slog.w(TAG, "Exception trying full transport backup", e);
4230 Slog.w(TAG, "Unable to close pipe!");
4239 Slog.w(TAG, "Unable to close pipe!");
4265 Slog.d(TAG, "Preflighting full payload of " + pkg.packageName);
4273 Slog.v(TAG, "Got preflight response; size=" + totalSize);
4278 Slog.w(TAG, "Exception preflighting " + pkg.packageName + ": " + e.getMessage());
4293 Slog.i(TAG, "Preflight op complete, result=" + result);
4302 Slog.i(TAG, "Preflight timeout; failing");
4332 Slog.e(TAG, "Exception during full package backup of " + mTarget);
4338 Slog.w(TAG, "Error closing transport pipe in runner");
4369 Slog.i(TAG, "Full backup queue empty; not scheduling");
4416 Slog.w(TAG, "Transport not present; full data backup not performed");
4427 Slog.i(TAG, "Full backup requested but dataset not yet initialized");
4432 Slog.w(TAG, "Unable to contact transport");
4459 Slog.i(TAG, "beginFullBackup but e=" + mEnabled
4468 if (DEBUG) Slog.i(TAG, "Deferring scheduled full backups in battery saver mode");
4474 Slog.i(TAG, "Beginning scheduled full backup operation");
4480 Slog.e(TAG, "Backup triggered but one already/still running!");
4487 Slog.i(TAG, "Backup queue empty; doing nothing");
4499 Slog.i(TAG, "Preconditions not met; not running full backup");
4515 Slog.i(TAG, "Device ready but too early to back up next app");
4524 Slog.i(TAG, "Nothing pending full backup; rescheduling +" + latency);
4553 Slog.i(TAG, "Telling running backup to stop");
4563 static final String TAG = "RestoreEngine";
4736 Slog.w(TAG, "Restore engine used after halting");
4743 Slog.v(TAG, "Reading tar header for restoring file");
4757 Slog.w(TAG, "Expected data for " + mOnlyPackage
4774 if (DEBUG) Slog.d(TAG, "Saw new package; finalizing old one");
4809 if (DEBUG) Slog.d(TAG, "APK file; installing");
4832 if (DEBUG) Slog.d(TAG, "apk present but ACCEPT");
4845 Slog.e(TAG, "Invalid policy from manifest");
4859 Slog.i(TAG, "Reusing existing agent instance");
4862 if (DEBUG) Slog.d(TAG, "Need to launch agent for " + pkg);
4874 if (DEBUG) Slog.d(TAG, "Clearing app data preparatory to full restore");
4877 if (MORE_DEBUG) Slog.d(TAG, "backup agent ("
4883 Slog.d(TAG, "We've initialized this app already; no clear required");
4899 Slog.e(TAG, "Unable to create agent for " + pkg);
4909 Slog.e(TAG, "Restoring data for " + pkg
4925 if (DEBUG) Slog.d(TAG, "Restoring OBB file for " + pkg
4931 if (MORE_DEBUG) Slog.d(TAG, "Invoking agent to restore file "
4938 Slog.d(TAG, "system process agent - spinning a thread");
4950 Slog.d(TAG, "Couldn't establish restore");
4956 Slog.e(TAG, "Agent crashed during full restore");
4964 Slog.v(TAG, " copying to restore agent: "
4984 Slog.e(TAG, "Failed to write to restore pipe", e);
5002 Slog.w(TAG, "Agent failure; ending restore");
5023 if (MORE_DEBUG) Slog.d(TAG, "[discarding file content]");
5037 if (DEBUG) Slog.w(TAG, "io exception on restore socket read", e);
5045 Slog.i(TAG, "No [more] data for this package; tearing down");
5068 Slog.w(TAG, "Couldn't close agent pipes", e);
5154 if (DEBUG) Slog.d(TAG, "Installing from backup: " + info.packageName);
5194 Slog.w(TAG, "Restore stream claimed to include apk for "
5205 Slog.w(TAG, "Restore stream contains apk of package "
5216 Slog.w(TAG, "Installed app " + info.packageName
5221 Slog.w(TAG, "Installed app " + info.packageName
5228 Slog.w(TAG, "Install of package " + info.packageName
5244 Slog.e(TAG, "Unable to transcribe restored apk for install");
5260 Slog.i(TAG, "Skipping tar padding: " + needed + " bytes");
5305 Slog.i(TAG, "Got widget metadata for " + info.packageName);
5314 Slog.i(TAG, "Ignoring metadata blob "
5324 Slog.w(TAG, "Metadata mismatch: package " + info.packageName
5328 Slog.w(TAG, "Unsupported metadata version " + version);
5342 Slog.i(TAG, " readAppManifest() looking for " + info.size + " bytes, "
5401 Slog.i(TAG, "Sig + version match; taking data");
5408 Slog.i(TAG, "Data version " + version
5414 Slog.i(TAG, "Data requires newer version "
5420 Slog.w(TAG, "Restore manifest signatures do not match "
5424 Slog.w(TAG, "Package " + info.packageName
5428 if (DEBUG) Slog.i(TAG, "Restore manifest from "
5436 if (DEBUG) Slog.i(TAG, "Package " + info.packageName
5445 Slog.i(TAG, "Cannot restore package " + info.packageName
5449 Slog.i(TAG, "Missing signature on backed-up package "
5453 Slog.i(TAG, "Expected package " + info.packageName
5457 Slog.i(TAG, "Unknown restore manifest version " + version
5461 Slog.w(TAG, "Corrupt restore manifest for package " + info.packageName);
5463 Slog.w(TAG, e.getMessage());
5515 Slog.i(TAG, b.toString());
5560 Slog.w(TAG, "Directory entry with nonzero size in header");
5567 if (MORE_DEBUG) Slog.w(TAG, "Saw type=0 in tar header block, info=" + info);
5571 Slog.e(TAG, "Unknown tar entity type: " + typeChar);
5585 if (DEBUG) Slog.i(TAG, "File in shared storage: " + info.path);
5614 Slog.e(TAG, "Parse error in header: " + e.getMessage());
5628 Slog.i(TAG, "Dropping cache file path " + info.path);
5640 Slog.i(TAG, "Dropping no_backup file path " + info.path);
5649 Slog.w(TAG, "Dropping invalid path " + info.path);
5681 if (MORE_DEBUG) Slog.i(TAG, " ... readExactly(" + size + ") called");
5686 if (MORE_DEBUG) Slog.w(TAG, "- wanted exactly " + size + " but got only " + soFar);
5690 if (MORE_DEBUG) Slog.v(TAG, " + got " + nRead + "; now wanting " + (size - soFar));
5708 Slog.w(TAG, "Suspiciously large pax header size " + info.size
5751 if (DEBUG) Slog.i(TAG, "Unhandled pax key: " + key);
5790 Slog.w(TAG, "full restore observer went away: startRestore");
5802 Slog.w(TAG, "full restore observer went away: restorePackage");
5813 Slog.w(TAG, "full restore observer went away: endRestore");
5903 Slog.i(TAG, "--- Performing full-dataset restore ---");
5916 if (DEBUG) Slog.w(TAG, "Backup password mismatch; aborting");
5956 } else Slog.w(TAG, "Archive is encrypted but no password given");
5957 } else Slog.w(TAG, "Wrong header version: " + s);
5958 } else Slog.w(TAG, "Didn't read the right header magic");
5961 Slog.w(TAG, "Invalid restore data; aborting.");
5973 if (MORE_DEBUG) Slog.v(TAG, "Done consuming input tarfile, total bytes=" + mBytes);
5975 Slog.e(TAG, "Unable to read restore input");
5985 Slog.w(TAG, "Close of restore data pipe threw", e);
5997 Slog.d(TAG, "Full restore pass complete.");
6053 } else if (doLog) Slog.w(TAG, "Incorrect password");
6055 if (doLog) Slog.e(TAG, "Needed parameter spec unavailable!", e);
6061 if (doLog) Slog.w(TAG, "Incorrect password");
6063 if (doLog) Slog.w(TAG, "Invalid block size in master key");
6065 if (doLog) Slog.e(TAG, "Needed decryption algorithm unavailable!");
6067 if (doLog) Slog.e(TAG, "Needed padding mechanism unavailable!");
6069 if (doLog) Slog.w(TAG, "Illegal password; aborting");
6099 } else Slog.w(TAG, "Unsupported encryption method: " + encryptionName);
6101 Slog.w(TAG, "Can't parse restore data header");
6103 Slog.w(TAG, "Can't read input header");
6129 if (DEBUG) Slog.d(TAG, "Saw new package; finalizing old one");
6164 if (DEBUG) Slog.d(TAG, "APK file; installing");
6187 if (DEBUG) Slog.d(TAG, "apk present but ACCEPT");
6200 Slog.e(TAG, "Invalid policy from manifest");
6209 Slog.w(TAG, "Dropping invalid path " + info.path);
6217 Slog.i(TAG, "Reusing existing agent instance");
6220 if (DEBUG) Slog.d(TAG, "Need to launch agent for " + pkg);
6232 if (DEBUG) Slog.d(TAG, "Clearing app data preparatory to full restore");
6235 if (DEBUG) Slog.d(TAG, "backup agent ("
6240 if (DEBUG) Slog.d(TAG, "We've initialized this app already; no clear required");
6255 if (DEBUG) Slog.d(TAG, "Unable to create agent for " + pkg);
6265 Slog.e(TAG, "Restoring data for " + pkg
6281 if (DEBUG) Slog.d(TAG, "Restoring OBB file for " + pkg
6287 if (DEBUG) Slog.d(TAG, "Invoking agent to restore file "
6294 Slog.d(TAG, "system process agent - spinning a thread");
6306 Slog.d(TAG, "Couldn't establish restore");
6312 Slog.e(TAG, "Agent crashed during full restore");
6336 Slog.e(TAG, "Failed to write to restore pipe", e);
6366 if (DEBUG) Slog.d(TAG, "[discarding file content]");
6380 if (DEBUG) Slog.w(TAG, "io exception on restore socket read", e);
6400 Slog.w(TAG, "Couldn't close agent pipes", e);
6417 if (DEBUG) Slog.d(TAG, "Killing host process");
6420 if (DEBUG) Slog.d(TAG, "Not killing after full restore");
6423 Slog.d(TAG, "Lost app trying to shut down");
6502 if (DEBUG) Slog.d(TAG, "Installing from backup: " + info.packageName);
6542 Slog.w(TAG, "Restore stream claimed to include apk for "
6553 Slog.w(TAG, "Restore stream contains apk of package "
6564 Slog.w(TAG, "Installed app " + info.packageName
6569 Slog.w(TAG, "Installed app " + info.packageName
6576 Slog.w(TAG, "Install of package " + info.packageName
6592 Slog.e(TAG, "Unable to transcribe restored apk for install");
6650 Slog.i(TAG, "Got widget metadata for " + info.packageName);
6659 Slog.i(TAG, "Ignoring metadata blob "
6669 Slog.w(TAG, "Metadata mismatch: package " + info.packageName
6673 Slog.w(TAG, "Unsupported metadata version " + version);
6742 Slog.i(TAG, "Sig + version match; taking data");
6748 Slog.d(TAG, "Data version " + version
6754 Slog.w(TAG, "Restore manifest signatures do not match "
6758 Slog.w(TAG, "Package " + info.packageName
6762 if (DEBUG) Slog.i(TAG, "Restore manifest from "
6769 if (DEBUG) Slog.i(TAG, "Package " + info.packageName
6775 Slog.i(TAG, "Cannot restore package " + info.packageName
6779 Slog.i(TAG, "Missing signature on backed-up package "
6783 Slog.i(TAG, "Expected package " + info.packageName
6787 Slog.i(TAG, "Unknown restore manifest version " + version
6791 Slog.w(TAG, "Corrupt restore manifest for package " + info.packageName);
6793 Slog.w(TAG, e.getMessage());
6845 Slog.i(TAG, b.toString());
6889 Slog.w(TAG, "Directory entry with nonzero size in header");
6896 if (DEBUG) Slog.w(TAG, "Saw type=0 in tar header block, info=" + info);
6900 Slog.e(TAG, "Unknown tar entity type: " + typeChar);
6914 if (DEBUG) Slog.i(TAG, "File in shared storage: " + info.path);
6940 Slog.e(TAG, "Parse error in header: " + e.getMessage());
6977 if (MORE_DEBUG) Slog.w(TAG, "- wanted exactly " + size + " but got only " + soFar);
6998 Slog.w(TAG, "Suspiciously large pax header size " + info.size
7041 if (DEBUG) Slog.i(TAG, "Unhandled pax key: " + key);
7079 Slog.w(TAG, "full restore observer went away: startRestore");
7091 Slog.w(TAG, "full restore observer went away: restorePackage");
7102 Slog.w(TAG, "full restore observer went away: endRestore");
7123 if (MORE_DEBUG) Slog.v(TAG, "System app " + target.packageName + " - skipping sig check");
7130 if (MORE_DEBUG) Slog.v(TAG, "signaturesMatch(): stored=" + storedSigHashes
7177 Slog.w(TAG, "No SHA-256 algorithm found!");
7194 if (MORE_DEBUG) Slog.v(TAG, "System app " + target.packageName + " - skipping sig check");
7201 if (MORE_DEBUG) Slog.v(TAG, "signaturesMatch(): stored=" + storedSigs
7346 Slog.i(TAG, "Full restore; asking about " + filterSet.length + " apps");
7393 Slog.v(TAG, "Restore; accept set size is " + mAcceptSet.size());
7395 Slog.v(TAG, " " + info.packageName);
7412 if (MORE_DEBUG) Slog.v(TAG, "*** Executing restore step " + mState);
7437 Slog.e(TAG, "Duplicate finish");
7507 Slog.e(TAG, "Transport error " + mStatus + "; no restore possible");
7515 Slog.e(TAG, "No restore metadata available; halting");
7521 Slog.e(TAG, "Required metadata but got " + desc.getPackageName());
7533 Slog.v(TAG, "initiating restore for PMBA");
7549 Slog.e(TAG, "No restore metadata available, so not restoring");
7564 Slog.e(TAG, "Unable to contact transport for restore");
7581 Slog.e(TAG, "Failure getting next package name");
7588 Slog.v(TAG, "No more packages; finishing restore");
7597 Slog.i(TAG, "Next restore package: " + mRestoreDescription);
7603 Slog.e(TAG, "No metadata for " + pkgName);
7616 Slog.e(TAG, "Package not present: " + pkgName);
7631 Slog.w(TAG, "Package " + pkgName + ": " + message);
7637 if (DEBUG) Slog.v(TAG, "Version " + metaInfo.versionCode
7643 if (MORE_DEBUG) Slog.v(TAG, "Package " + pkgName
7657 Slog.e(TAG, "Unrecognized restore type " + type);
7662 Slog.e(TAG, "Can't get next target from transport; ending restore");
7682 Slog.i(TAG, "Data exists for package " + packageName
7693 Slog.w(TAG, "Signature mismatch restoring " + packageName);
7705 Slog.w(TAG, "Can't find backup agent for " + packageName);
7717 Slog.e(TAG, "Error when attempting restore: " + e.toString());
7727 if (DEBUG) Slog.d(TAG, "initiateOneRestore packageName=" + packageName);
7752 if (MORE_DEBUG) Slog.e(TAG, "SElinux restorecon failed for " + downloadFile);
7758 Slog.e(TAG, "Error getting restore data for " + packageName);
7789 Slog.i(TAG, "Restoring widget state for " + packageName);
7823 Slog.e(TAG, "Unable to call app for restore: " + packageName, e);
7849 Slog.i(TAG, "Spinning threads for stream restore of "
7860 Slog.e(TAG, "Unable to construct pipes for stream restore!");
7875 Slog.e(TAG, "Unable to finalize restore of " + packageName);
7884 final String TAG = "StreamFeederThread";
7930 Slog.v(TAG, " <- transport provided chunk size " + result);
7942 Slog.v(TAG, " -> wrote " + n + " to engine, left=" + toCopy);
7948 Slog.i(TAG, "Got clean full-restore EOF for "
7956 Slog.e(TAG, "Error " + result + " streaming restore for "
7962 if (MORE_DEBUG) Slog.v(TAG, "Done copying to engine, falling through");
7967 Slog.e(TAG, "Unable to route data for restore");
7975 Slog.e(TAG, "Transport failed during restore");
7990 Slog.i(TAG, "engine thread finished; proceeding");
8063 if (MORE_DEBUG) Slog.d(TAG, "finishing restore mObserver=" + mObserver);
8068 Slog.e(TAG, "Error finishing restore", e);
8076 Slog.d(TAG, "Restore observer died at restoreFinished");
8086 if (MORE_DEBUG) Slog.v(TAG, "finishing PM token " + mPmToken);
8109 Slog.i(TAG, "Restore complete.");
8168 if (DEBUG) Slog.d(TAG, "Restore complete, killing host process of "
8190 Slog.i(TAG, "operationComplete() during restore: target="
8237 Slog.e(TAG, "Unexpected restore callback into state " + mState);
8250 Slog.e(TAG, "Timeout restoring application " + mCurrentPackage.packageName);
8259 if (MORE_DEBUG) Slog.i(TAG, " => executing next step on "
8272 Slog.w(TAG, "Restore observer went away: startRestore");
8284 Slog.d(TAG, "Restore observer died in onUpdate");
8296 Slog.w(TAG, "Restore observer went away: endRestore");
8325 Slog.e(TAG, "Transport threw attempting to clear data for " + mPackage);
8352 Slog.e(TAG, "Requested init for " + transportName + " but not found");
8356 Slog.i(TAG, "Initializing (wiping) backup transport storage: " + transportName);
8367 Slog.i(TAG, "Device init successful");
8378 Slog.e(TAG, "Transport error in initializeDevice()");
8385 Slog.w(TAG, "Init failed on " + transportName + " resched in " + delay);
8393 Slog.e(TAG, "Unexpected error performing init", e);
8411 Slog.w(TAG, "dataChanged but no participant pkg='" + packageName + "'"
8423 if (MORE_DEBUG) Slog.d(TAG, "Now staging backup of " + packageName);
8474 Slog.e(TAG, "Can't write " + str + " to backup journal", e);
8490 Slog.v(TAG, "dataChanged(" + packageName + ") ignored because it's user "
8498 Slog.w(TAG, "dataChanged but no participant pkg='" + packageName + "'"
8512 if (DEBUG) Slog.v(TAG, "clearBackupData() of " + packageName + " on " + transportName);
8517 Slog.d(TAG, "No such package '" + packageName + "' - not clearing backup data");
8530 if (MORE_DEBUG) Slog.v(TAG, "Privileged caller, allowing clear of other apps");
8544 if (MORE_DEBUG) Slog.v(TAG, "Found the app - running clear process");
8571 if (DEBUG) Slog.v(TAG, "Not running backup while in battery save mode");
8574 if (DEBUG) Slog.v(TAG, "Scheduling immediate backup pass");
8581 Slog.e(TAG, "run-backup intent cancelled!");
8628 Slog.i(TAG, "Full backup not supported before setup");
8632 if (DEBUG) Slog.v(TAG, "Requesting full backup: apks=" + includeApks
8635 Slog.i(TAG, "Beginning full backup...");
8645 if (DEBUG) Slog.d(TAG, "Starting backup confirmation UI, token=" + token);
8647 Slog.e(TAG, "Unable to launch full backup confirmation");
8661 if (DEBUG) Slog.d(TAG, "Waiting for full backup completion...");
8670 Slog.d(TAG, "Full backup processing complete.");
8684 Slog.i(TAG, "Full backup not currently possible -- key/value backup not yet run?");
8687 Slog.d(TAG, "fullTransportBackup()");
8711 Slog.d(TAG, "Done with full transport backup.");
8729 Slog.i(TAG, "Full restore not permitted before setup");
8733 Slog.i(TAG, "Beginning full restore...");
8742 if (DEBUG) Slog.d(TAG, "Starting restore confirmation UI, token=" + token);
8744 Slog.e(TAG, "Unable to launch full restore confirmation");
8758 if (DEBUG) Slog.d(TAG, "Waiting for full restore completion...");
8764 Slog.w(TAG, "Error trying to close fd after full restore: " + e);
8767 Slog.i(TAG, "Full restore processing complete.");
8786 if (MORE_DEBUG) Slog.d(TAG, "Posting conf timeout msg after "
8814 if (DEBUG) Slog.d(TAG, "acknowledgeFullBackupOrRestore : token=" + token
8841 if (MORE_DEBUG) Slog.d(TAG, "Sending conf message with verb " + verb);
8846 Slog.w(TAG, "User rejected full backup/restore operation");
8851 Slog.w(TAG, "Attempted to ack full backup/restore with invalid token");
8864 Slog.i(TAG, "Backup enabled => " + enable);
8882 if (MORE_DEBUG) Slog.i(TAG, "Opting out of backup");
8915 Slog.i(TAG, "Auto restore => " + doAutoRestore);
8948 if (MORE_DEBUG) Slog.v(TAG, "... getCurrentTransport() returning " + mCurrentTransport);
8983 Slog.v(TAG, "selectBackupTransport() set " + mCurrentTransport
9004 if (MORE_DEBUG) Slog.d(TAG, "getConfigurationIntent() returning config intent "
9030 if (MORE_DEBUG) Slog.d(TAG, "getDestinationString() returning " + text);
9051 if (MORE_DEBUG) Slog.d(TAG, "getDataManagementIntent() returning intent "
9074 if (MORE_DEBUG) Slog.d(TAG, "getDataManagementLabel() returning " + text);
9090 Slog.d(TAG, "agentConnected pkg=" + packageName + " agent=" + agentBinder);
9095 Slog.w(TAG, "Non-system process uid=" + Binder.getCallingUid()
9112 Slog.w(TAG, "Non-system process uid=" + Binder.getCallingUid()
9123 Slog.w(TAG, "Non-system process uid=" + Binder.getCallingUid()
9131 if (DEBUG) Slog.v(TAG, "restoreAtInstall pkg=" + packageName
9135 if (MORE_DEBUG) Slog.i(TAG, "No restore set");
9142 if (DEBUG) Slog.w(TAG, "No transport");
9148 Slog.w(TAG, "Non-restorable state: auto=" + mAutoRestore);
9164 Slog.d(TAG, "Restore at install of " + packageName);
9172 Slog.e(TAG, "Unable to contact transport");
9180 if (DEBUG) Slog.v(TAG, "Finishing install immediately");
9189 if (DEBUG) Slog.v(TAG, "beginRestoreSession: pkg=" + packageName
9201 Slog.w(TAG, "Asked to restore nonexistent pkg " + packageName);
9218 if (DEBUG) Slog.d(TAG, "restoring self on current transport; no permission needed");
9223 Slog.d(TAG, "Restore session requested but one already active");
9235 Slog.e(TAG, "ending non-current restore session");
9237 if (DEBUG) Slog.v(TAG, "Clearing restore session and halting timeout");
9248 Slog.v(TAG, "opComplete: " + Integer.toHexString(token) + " result=" + result);
9271 private static final String TAG = "RestoreSession";
9301 Slog.i(TAG, "Session already timed out");
9308 Slog.w(TAG, "Null transport getting restore sets");
9324 Slog.e(TAG, "Error in getAvailableRestoreSets", e);
9335 if (DEBUG) Slog.d(TAG, "restoreAll token=" + Long.toHexString(token)
9343 Slog.i(TAG, "Session already timed out");
9348 Slog.e(TAG, "Ignoring restoreAll() with no restore set");
9353 Slog.e(TAG, "Ignoring restoreAll() on single-package session");
9362 Slog.e(TAG, "Unable to contact transport for restore");
9375 Slog.d(TAG, "restoreAll() kicking off");
9387 Slog.w(TAG, "Restore token " + Long.toHexString(token) + " not found");
9417 Slog.d(TAG, b.toString());
9425 Slog.i(TAG, "Session already timed out");
9430 Slog.e(TAG, "Ignoring restoreAll() with no restore set");
9435 Slog.e(TAG, "Ignoring restoreAll() on single-package session");
9444 Slog.e(TAG, "Unable to contact transport for restore");
9457 Slog.d(TAG, "restoreSome() of " + packages.length + " packages");
9469 Slog.w(TAG, "Restore token " + Long.toHexString(token) + " not found");
9474 if (DEBUG) Slog.v(TAG, "restorePackage pkg=" + packageName + " obs=" + observer);
9481 Slog.i(TAG, "Session already timed out");
9487 Slog.e(TAG, "Ignoring attempt to restore pkg=" + packageName
9497 Slog.w(TAG, "Asked to restore nonexistent pkg " + packageName);
9507 Slog.w(TAG, "restorePackage: bad packageName=" + packageName
9518 if (DEBUG) Slog.v(TAG, "restorePackage pkg=" + packageName
9525 if (DEBUG) Slog.w(TAG, "No data available for this package; not restoring");
9534 Slog.e(TAG, "Unable to contact transport for restore");
9544 Slog.d(TAG, "restorePackage() : " + packageName);
9579 if (DEBUG) Slog.d(TAG, "endRestoreSession");
9582 Slog.i(TAG, "Session already timed out");
9595 mContext.enforceCallingOrSelfPermission(android.Manifest.permission.DUMP, TAG);
9653 Slog.e(TAG, "Error in transport", e);