* merged dpkg-log branch
[ntk/apt.git] / apt-pkg / acquire-worker.cc
1 // -*- mode: cpp; mode: fold -*-
2 // Description /*{{{*/
3 // $Id: acquire-worker.cc,v 1.34 2001/05/22 04:42:54 jgg Exp $
4 /* ######################################################################
5
6 Acquire Worker
7
8 The worker process can startup either as a Configuration prober
9 or as a queue runner. As a configuration prober it only reads the
10 configuration message and
11
12 ##################################################################### */
13 /*}}}*/
14 // Include Files /*{{{*/
15 #include <apt-pkg/acquire-worker.h>
16 #include <apt-pkg/acquire-item.h>
17 #include <apt-pkg/configuration.h>
18 #include <apt-pkg/error.h>
19 #include <apt-pkg/fileutl.h>
20 #include <apt-pkg/strutl.h>
21
22 #include <apti18n.h>
23
24 #include <iostream>
25 #include <sstream>
26 #include <fstream>
27
28 #include <sys/stat.h>
29 #include <unistd.h>
30 #include <fcntl.h>
31 #include <signal.h>
32 #include <stdio.h>
33 #include <errno.h>
34 /*}}}*/
35
36 using namespace std;
37
38 // Worker::Worker - Constructor for Queue startup /*{{{*/
39 // ---------------------------------------------------------------------
40 /* */
41 pkgAcquire::Worker::Worker(Queue *Q,MethodConfig *Cnf,
42 pkgAcquireStatus *Log) : Log(Log)
43 {
44 OwnerQ = Q;
45 Config = Cnf;
46 Access = Cnf->Access;
47 CurrentItem = 0;
48 TotalSize = 0;
49 CurrentSize = 0;
50
51 Construct();
52 }
53 /*}}}*/
54 // Worker::Worker - Constructor for method config startup /*{{{*/
55 // ---------------------------------------------------------------------
56 /* */
57 pkgAcquire::Worker::Worker(MethodConfig *Cnf)
58 {
59 OwnerQ = 0;
60 Config = Cnf;
61 Access = Cnf->Access;
62 CurrentItem = 0;
63 TotalSize = 0;
64 CurrentSize = 0;
65
66 Construct();
67 }
68 /*}}}*/
69 // Worker::Construct - Constructor helper /*{{{*/
70 // ---------------------------------------------------------------------
71 /* */
72 void pkgAcquire::Worker::Construct()
73 {
74 NextQueue = 0;
75 NextAcquire = 0;
76 Process = -1;
77 InFd = -1;
78 OutFd = -1;
79 OutReady = false;
80 InReady = false;
81 Debug = _config->FindB("Debug::pkgAcquire::Worker",false);
82 }
83 /*}}}*/
84 // Worker::~Worker - Destructor /*{{{*/
85 // ---------------------------------------------------------------------
86 /* */
87 pkgAcquire::Worker::~Worker()
88 {
89 close(InFd);
90 close(OutFd);
91
92 if (Process > 0)
93 {
94 /* Closing of stdin is the signal to exit and die when the process
95 indicates it needs cleanup */
96 if (Config->NeedsCleanup == false)
97 kill(Process,SIGINT);
98 ExecWait(Process,Access.c_str(),true);
99 }
100 }
101 /*}}}*/
102 // Worker::Start - Start the worker process /*{{{*/
103 // ---------------------------------------------------------------------
104 /* This forks the method and inits the communication channel */
105 bool pkgAcquire::Worker::Start()
106 {
107 // Get the method path
108 string Method = _config->FindDir("Dir::Bin::Methods") + Access;
109 if (FileExists(Method) == false)
110 return _error->Error(_("The method driver %s could not be found."),Method.c_str());
111
112 if (Debug == true)
113 clog << "Starting method '" << Method << '\'' << endl;
114
115 // Create the pipes
116 int Pipes[4] = {-1,-1,-1,-1};
117 if (pipe(Pipes) != 0 || pipe(Pipes+2) != 0)
118 {
119 _error->Errno("pipe","Failed to create IPC pipe to subprocess");
120 for (int I = 0; I != 4; I++)
121 close(Pipes[I]);
122 return false;
123 }
124 for (int I = 0; I != 4; I++)
125 SetCloseExec(Pipes[I],true);
126
127 // Fork off the process
128 Process = ExecFork();
129 if (Process == 0)
130 {
131 // Setup the FDs
132 dup2(Pipes[1],STDOUT_FILENO);
133 dup2(Pipes[2],STDIN_FILENO);
134 SetCloseExec(STDOUT_FILENO,false);
135 SetCloseExec(STDIN_FILENO,false);
136 SetCloseExec(STDERR_FILENO,false);
137
138 const char *Args[2];
139 Args[0] = Method.c_str();
140 Args[1] = 0;
141 execv(Args[0],(char **)Args);
142 cerr << "Failed to exec method " << Args[0] << endl;
143 _exit(100);
144 }
145
146 // Fix up our FDs
147 InFd = Pipes[0];
148 OutFd = Pipes[3];
149 SetNonBlock(Pipes[0],true);
150 SetNonBlock(Pipes[3],true);
151 close(Pipes[1]);
152 close(Pipes[2]);
153 OutReady = false;
154 InReady = true;
155
156 // Read the configuration data
157 if (WaitFd(InFd) == false ||
158 ReadMessages() == false)
159 return _error->Error(_("Method %s did not start correctly"),Method.c_str());
160
161 RunMessages();
162 if (OwnerQ != 0)
163 SendConfiguration();
164
165 return true;
166 }
167 /*}}}*/
168 // Worker::ReadMessages - Read all pending messages into the list /*{{{*/
169 // ---------------------------------------------------------------------
170 /* */
171 bool pkgAcquire::Worker::ReadMessages()
172 {
173 if (::ReadMessages(InFd,MessageQueue) == false)
174 return MethodFailure();
175 return true;
176 }
177 /*}}}*/
178 // Worker::RunMessage - Empty the message queue /*{{{*/
179 // ---------------------------------------------------------------------
180 /* This takes the messages from the message queue and runs them through
181 the parsers in order. */
182 bool pkgAcquire::Worker::RunMessages()
183 {
184 while (MessageQueue.empty() == false)
185 {
186 string Message = MessageQueue.front();
187 MessageQueue.erase(MessageQueue.begin());
188
189 if (Debug == true)
190 clog << " <- " << Access << ':' << QuoteString(Message,"\n") << endl;
191
192 // Fetch the message number
193 char *End;
194 int Number = strtol(Message.c_str(),&End,10);
195 if (End == Message.c_str())
196 return _error->Error("Invalid message from method %s: %s",Access.c_str(),Message.c_str());
197
198 string URI = LookupTag(Message,"URI");
199 pkgAcquire::Queue::QItem *Itm = 0;
200 if (URI.empty() == false)
201 Itm = OwnerQ->FindItem(URI,this);
202
203 // Determine the message number and dispatch
204 switch (Number)
205 {
206 // 100 Capabilities
207 case 100:
208 if (Capabilities(Message) == false)
209 return _error->Error("Unable to process Capabilities message from %s",Access.c_str());
210 break;
211
212 // 101 Log
213 case 101:
214 if (Debug == true)
215 clog << " <- (log) " << LookupTag(Message,"Message") << endl;
216 break;
217
218 // 102 Status
219 case 102:
220 Status = LookupTag(Message,"Message");
221 break;
222
223 // 200 URI Start
224 case 200:
225 {
226 if (Itm == 0)
227 {
228 _error->Error("Method gave invalid 200 URI Start message");
229 break;
230 }
231
232 CurrentItem = Itm;
233 CurrentSize = 0;
234 TotalSize = atoi(LookupTag(Message,"Size","0").c_str());
235 ResumePoint = atoi(LookupTag(Message,"Resume-Point","0").c_str());
236 Itm->Owner->Start(Message,atoi(LookupTag(Message,"Size","0").c_str()));
237
238 // Display update before completion
239 if (Log != 0 && Log->MorePulses == true)
240 Log->Pulse(Itm->Owner->GetOwner());
241
242 if (Log != 0)
243 Log->Fetch(*Itm);
244
245 break;
246 }
247
248 // 201 URI Done
249 case 201:
250 {
251 if (Itm == 0)
252 {
253 _error->Error("Method gave invalid 201 URI Done message");
254 break;
255 }
256
257 pkgAcquire::Item *Owner = Itm->Owner;
258 pkgAcquire::ItemDesc Desc = *Itm;
259
260 // Display update before completion
261 if (Log != 0 && Log->MorePulses == true)
262 Log->Pulse(Owner->GetOwner());
263
264 OwnerQ->ItemDone(Itm);
265 if (TotalSize != 0 &&
266 (unsigned)atoi(LookupTag(Message,"Size","0").c_str()) != TotalSize)
267 _error->Warning("Bizarre Error - File size is not what the server reported %s %lu",
268 LookupTag(Message,"Size","0").c_str(),TotalSize);
269
270 // see if there is a hash to verify
271 string RecivedHash;
272 HashString expectedHash(Owner->HashSum());
273 if(!expectedHash.empty())
274 {
275 string hashTag = expectedHash.HashType()+"-Hash";
276 RecivedHash = expectedHash.HashType() + ":" + LookupTag(Message, hashTag.c_str());
277 if(_config->FindB("Debug::pkgAcquire::Auth", false) == true)
278 {
279 clog << "201 URI Done: " << Owner->DescURI() << endl
280 << "RecivedHash: " << RecivedHash << endl
281 << "ExpectedHash: " << expectedHash.toStr()
282 << endl << endl;
283 }
284 }
285 Owner->Done(Message,atoi(LookupTag(Message,"Size","0").c_str()),
286 RecivedHash.c_str(), Config);
287 ItemDone();
288
289 // Log that we are done
290 if (Log != 0)
291 {
292 if (StringToBool(LookupTag(Message,"IMS-Hit"),false) == true ||
293 StringToBool(LookupTag(Message,"Alt-IMS-Hit"),false) == true)
294 {
295 /* Hide 'hits' for local only sources - we also manage to
296 hide gets */
297 if (Config->LocalOnly == false)
298 Log->IMSHit(Desc);
299 }
300 else
301 Log->Done(Desc);
302 }
303 break;
304 }
305
306 // 400 URI Failure
307 case 400:
308 {
309 if (Itm == 0)
310 {
311 _error->Error("Method gave invalid 400 URI Failure message");
312 break;
313 }
314
315 // Display update before completion
316 if (Log != 0 && Log->MorePulses == true)
317 Log->Pulse(Itm->Owner->GetOwner());
318
319 pkgAcquire::Item *Owner = Itm->Owner;
320 pkgAcquire::ItemDesc Desc = *Itm;
321 OwnerQ->ItemDone(Itm);
322
323 // set some status
324 if(LookupTag(Message,"FailReason") == "Timeout" ||
325 LookupTag(Message,"FailReason") == "TmpResolveFailure" ||
326 LookupTag(Message,"FailReason") == "ConnectionRefused")
327 Owner->Status = pkgAcquire::Item::StatTransientNetworkError;
328
329 Owner->Failed(Message,Config);
330 ItemDone();
331
332 if (Log != 0)
333 Log->Fail(Desc);
334
335 break;
336 }
337
338 // 401 General Failure
339 case 401:
340 _error->Error("Method %s General failure: %s",Access.c_str(),LookupTag(Message,"Message").c_str());
341 break;
342
343 // 403 Media Change
344 case 403:
345 MediaChange(Message);
346 break;
347 }
348 }
349 return true;
350 }
351 /*}}}*/
352 // Worker::Capabilities - 100 Capabilities handler /*{{{*/
353 // ---------------------------------------------------------------------
354 /* This parses the capabilities message and dumps it into the configuration
355 structure. */
356 bool pkgAcquire::Worker::Capabilities(string Message)
357 {
358 if (Config == 0)
359 return true;
360
361 Config->Version = LookupTag(Message,"Version");
362 Config->SingleInstance = StringToBool(LookupTag(Message,"Single-Instance"),false);
363 Config->Pipeline = StringToBool(LookupTag(Message,"Pipeline"),false);
364 Config->SendConfig = StringToBool(LookupTag(Message,"Send-Config"),false);
365 Config->LocalOnly = StringToBool(LookupTag(Message,"Local-Only"),false);
366 Config->NeedsCleanup = StringToBool(LookupTag(Message,"Needs-Cleanup"),false);
367 Config->Removable = StringToBool(LookupTag(Message,"Removable"),false);
368
369 // Some debug text
370 if (Debug == true)
371 {
372 clog << "Configured access method " << Config->Access << endl;
373 clog << "Version:" << Config->Version <<
374 " SingleInstance:" << Config->SingleInstance <<
375 " Pipeline:" << Config->Pipeline <<
376 " SendConfig:" << Config->SendConfig <<
377 " LocalOnly: " << Config->LocalOnly <<
378 " NeedsCleanup: " << Config->NeedsCleanup <<
379 " Removable: " << Config->Removable << endl;
380 }
381
382 return true;
383 }
384 /*}}}*/
385 // Worker::MediaChange - Request a media change /*{{{*/
386 // ---------------------------------------------------------------------
387 /* */
388 bool pkgAcquire::Worker::MediaChange(string Message)
389 {
390 int status_fd = _config->FindI("APT::Status-Fd",-1);
391 if(status_fd > 0)
392 {
393 string Media = LookupTag(Message,"Media");
394 string Drive = LookupTag(Message,"Drive");
395 ostringstream msg,status;
396 ioprintf(msg,_("Please insert the disc labeled: "
397 "'%s' "
398 "in the drive '%s' and press enter."),
399 Media.c_str(),Drive.c_str());
400 status << "media-change: " // message
401 << Media << ":" // media
402 << Drive << ":" // drive
403 << msg.str() // l10n message
404 << endl;
405 write(status_fd, status.str().c_str(), status.str().size());
406 }
407
408 if (Log == 0 || Log->MediaChange(LookupTag(Message,"Media"),
409 LookupTag(Message,"Drive")) == false)
410 {
411 char S[300];
412 snprintf(S,sizeof(S),"603 Media Changed\nFailed: true\n\n");
413 if (Debug == true)
414 clog << " -> " << Access << ':' << QuoteString(S,"\n") << endl;
415 OutQueue += S;
416 OutReady = true;
417 return true;
418 }
419
420 char S[300];
421 snprintf(S,sizeof(S),"603 Media Changed\n\n");
422 if (Debug == true)
423 clog << " -> " << Access << ':' << QuoteString(S,"\n") << endl;
424 OutQueue += S;
425 OutReady = true;
426 return true;
427 }
428 /*}}}*/
429 // Worker::SendConfiguration - Send the config to the method /*{{{*/
430 // ---------------------------------------------------------------------
431 /* */
432 bool pkgAcquire::Worker::SendConfiguration()
433 {
434 if (Config->SendConfig == false)
435 return true;
436
437 if (OutFd == -1)
438 return false;
439
440 string Message = "601 Configuration\n";
441 Message.reserve(2000);
442
443 /* Write out all of the configuration directives by walking the
444 configuration tree */
445 const Configuration::Item *Top = _config->Tree(0);
446 for (; Top != 0;)
447 {
448 if (Top->Value.empty() == false)
449 {
450 string Line = "Config-Item: " + QuoteString(Top->FullTag(),"=\"\n") + "=";
451 Line += QuoteString(Top->Value,"\n") + '\n';
452 Message += Line;
453 }
454
455 if (Top->Child != 0)
456 {
457 Top = Top->Child;
458 continue;
459 }
460
461 while (Top != 0 && Top->Next == 0)
462 Top = Top->Parent;
463 if (Top != 0)
464 Top = Top->Next;
465 }
466 Message += '\n';
467
468 if (Debug == true)
469 clog << " -> " << Access << ':' << QuoteString(Message,"\n") << endl;
470 OutQueue += Message;
471 OutReady = true;
472
473 return true;
474 }
475 /*}}}*/
476 // Worker::QueueItem - Add an item to the outbound queue /*{{{*/
477 // ---------------------------------------------------------------------
478 /* Send a URI Acquire message to the method */
479 bool pkgAcquire::Worker::QueueItem(pkgAcquire::Queue::QItem *Item)
480 {
481 if (OutFd == -1)
482 return false;
483
484 string Message = "600 URI Acquire\n";
485 Message.reserve(300);
486 Message += "URI: " + Item->URI;
487 Message += "\nFilename: " + Item->Owner->DestFile;
488 Message += Item->Owner->Custom600Headers();
489 Message += "\n\n";
490
491 if (Debug == true)
492 clog << " -> " << Access << ':' << QuoteString(Message,"\n") << endl;
493 OutQueue += Message;
494 OutReady = true;
495
496 return true;
497 }
498 /*}}}*/
499 // Worker::OutFdRead - Out bound FD is ready /*{{{*/
500 // ---------------------------------------------------------------------
501 /* */
502 bool pkgAcquire::Worker::OutFdReady()
503 {
504 int Res;
505 do
506 {
507 Res = write(OutFd,OutQueue.c_str(),OutQueue.length());
508 }
509 while (Res < 0 && errno == EINTR);
510
511 if (Res <= 0)
512 return MethodFailure();
513
514 // Hmm.. this should never happen.
515 if (Res < 0)
516 return true;
517
518 OutQueue.erase(0,Res);
519 if (OutQueue.empty() == true)
520 OutReady = false;
521
522 return true;
523 }
524 /*}}}*/
525 // Worker::InFdRead - In bound FD is ready /*{{{*/
526 // ---------------------------------------------------------------------
527 /* */
528 bool pkgAcquire::Worker::InFdReady()
529 {
530 if (ReadMessages() == false)
531 return false;
532 RunMessages();
533 return true;
534 }
535 /*}}}*/
536 // Worker::MethodFailure - Called when the method fails /*{{{*/
537 // ---------------------------------------------------------------------
538 /* This is called when the method is belived to have failed, probably because
539 read returned -1. */
540 bool pkgAcquire::Worker::MethodFailure()
541 {
542 _error->Error("Method %s has died unexpectedly!",Access.c_str());
543
544 ExecWait(Process,Access.c_str(),true);
545 Process = -1;
546 close(InFd);
547 close(OutFd);
548 InFd = -1;
549 OutFd = -1;
550 OutReady = false;
551 InReady = false;
552 OutQueue = string();
553 MessageQueue.erase(MessageQueue.begin(),MessageQueue.end());
554
555 return false;
556 }
557 /*}}}*/
558 // Worker::Pulse - Called periodically /*{{{*/
559 // ---------------------------------------------------------------------
560 /* */
561 void pkgAcquire::Worker::Pulse()
562 {
563 if (CurrentItem == 0)
564 return;
565
566 struct stat Buf;
567 if (stat(CurrentItem->Owner->DestFile.c_str(),&Buf) != 0)
568 return;
569 CurrentSize = Buf.st_size;
570
571 // Hmm? Should not happen...
572 if (CurrentSize > TotalSize && TotalSize != 0)
573 TotalSize = CurrentSize;
574 }
575 /*}}}*/
576 // Worker::ItemDone - Called when the current item is finished /*{{{*/
577 // ---------------------------------------------------------------------
578 /* */
579 void pkgAcquire::Worker::ItemDone()
580 {
581 CurrentItem = 0;
582 CurrentSize = 0;
583 TotalSize = 0;
584 Status = string();
585 }
586 /*}}}*/