builder: mozilla-beta_win7-ix_test_pgo-media-tests
slave: t-w732-ix-102
starttime: 1451341168.04
results: failure (2)
buildid: 20151228111030
builduid: 45114fb5d66b44afb37216ecf901787c
revision: b86b3deb9b01

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:28.039201) =========
master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:28.039619) =========

========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:28.039969) =========
'cd'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['cd']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
C:\slave\test
program finished with exit code 0
elapsedTime=0.616000
basedir: 'C:\\slave\\test'
========= master_lag: 0.17 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:28.828813) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:28.829086) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:29.050905) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:29.051173) =========
'rm' '-rf' 'properties'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'properties']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
program finished with exit code 0
elapsedTime=0.203000
========= master_lag: 0.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:29.267318) =========

========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:29.267651) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:29.268027) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:29.268328) =========
'bash' '-c' 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
--14:19:29--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
           => `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]

    0K .......... .                                          100%    2.27 GB/s

14:19:29 (2.27 GB/s) - `archiver_client.py' saved [12141/12141]

program finished with exit code 0
elapsedTime=0.791000
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:30.073792) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-12-28 14:19:30.074109) =========
'rm' '-rf' 'scripts'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
program finished with exit code 0
elapsedTime=3.405000
========= master_lag: 2.89 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-12-28 14:19:36.366938) =========

========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-12-28 14:19:36.367307) =========
'bash' '-c' u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b86b3deb9b01 --destination scripts --debug'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b86b3deb9b01 --destination scripts --debug']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
2015-12-28 14:19:36,371 Setting DEBUG logging.
2015-12-28 14:19:36,371 attempt 1/10
2015-12-28 14:19:36,371 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b86b3deb9b01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-12-28 14:19:36,822 unpacking tar archive at: mozilla-beta-b86b3deb9b01/testing/mozharness/
program finished with exit code 0
elapsedTime=1.317000
========= master_lag: 1.96 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-12-28 14:19:39.641887) =========

========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:39.642161) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:39.696281) =========

========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:39.696544) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 14:19:39.697013) =========

========= Started 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 13 mins, 16 secs) (at 2015-12-28 14:19:39.697465) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/firefox_media_tests_buildbot.py' '--cfg' 'mediatests/buildbot_windows_config.py' '--blob-upload-branch' 'mozilla-beta' '--download-symbols' 'ondemand'
 in dir C:\slave\test\. (timeout 1800 secs) (maxTime 7200 secs)
 watching logfiles {}
 argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/firefox_media_tests_buildbot.py', '--cfg', 'mediatests/buildbot_windows_config.py', '--blob-upload-branch', 'mozilla-beta', '--download-symbols', 'ondemand']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  DevEnvDir=D:\msvs8\Common7\IDE
  FP_NO_HOST_CHECK=NO
  FrameworkDir=C:\WINDOWS\Microsoft.NET\Framework
  FrameworkSDKDir=D:\msvs8\SDK\v2.0
  FrameworkVersion=v2.0.50727
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LIBPATH=C:\WINDOWS\Microsoft.NET\Framework\v2.0.50727;D:\msvs8\VC\ATLMFC\LIB
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  MOZILLABUILD=D:\mozilla-build
  MOZILLABUILDDRIVE=C:
  MOZILLABUILDPATH=\mozilla-build\
  MOZ_AIRBAG=1
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_HIDE_RESULTS_TABLE=1
  MOZ_MSVCVERSION=8
  MOZ_NO_REMOTE=1
  MOZ_TOOLS=D:\mozilla-build\moztools
  MSVCDir=D:\msvs8\VC
  NO_EM_RESTART=1
  NO_FAIL_ON_TEST_ERRORS=1
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PROPERTIES_FILE=C:\slave\test/buildprops.json
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  VCINSTALLDIR=D:\msvs8\VC
  VCVARS=D:\msvs8\VC\bin\vcvars32.bat
  VSINSTALLDIR=D:\msvs8
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
  XPCOM_DEBUG_BREAK=warn
 using PTY: False
14:19:39     INFO - MultiFileLogger online at 20151228 14:19:39 in C:\slave\test
14:19:39     INFO - Run as scripts/scripts/firefox_media_tests_buildbot.py --cfg mediatests/buildbot_windows_config.py --blob-upload-branch mozilla-beta --download-symbols ondemand
14:19:39     INFO - Dumping config to C:\slave\test\logs\localconfig.json.
14:19:39     INFO - {'append_to_log': False,
14:19:39     INFO -  'base_work_dir': 'C:\\slave\\test',
14:19:39     INFO -  'blob_upload_branch': 'mozilla-beta',
14:19:39     INFO -  'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
14:19:39     INFO -  'buildbot_json_path': 'buildprops.json',
14:19:39     INFO -  'config_files': ('mediatests/buildbot_windows_config.py',),
14:19:39     INFO -  'default_actions': ('clobber',
14:19:39     INFO -                      'read-buildbot-config',
14:19:39     INFO -                      'checkout',
14:19:39     INFO -                      'download-and-extract',
14:19:39     INFO -                      'create-virtualenv',
14:19:39     INFO -                      'install',
14:19:39     INFO -                      'run-media-tests'),
14:19:39     INFO -  'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
14:19:39     INFO -  'download_minidump_stackwalk': True,
14:19:39     INFO -  'download_symbols': 'ondemand',
14:19:39     INFO -  'e10s': False,
14:19:39     INFO -  'exes': {'gittool.py': ('c:\\mozilla-build\\python27\\python.exe',
14:19:39     INFO -                          'C:\\slave\\test\\scripts\\external_tools\\gittool.py'),
14:19:39     INFO -           'hg': 'c:/mozilla-build/hg/hg',
14:19:39     INFO -           'hgtool.py': ('c:\\mozilla-build\\python27\\python.exe',
14:19:39     INFO -                         'C:\\slave\\test\\scripts\\external_tools\\hgtool.py'),
14:19:39     INFO -           'mozinstall': ('C:\\slave\\test/build/venv/scripts/python',
14:19:39     INFO -                          'C:\\slave\\test/build/venv/scripts/mozinstall-script.py'),
14:19:39     INFO -           'python': 'c:/mozilla-build/python27/python',
14:19:39     INFO -           'tooltool.py': ('c:\\mozilla-build\\python27\\python.exe',
14:19:39     INFO -                           'C:/mozilla-build/tooltool.py'),
14:19:39     INFO -           'virtualenv': ('c:/mozilla-build/python27/python',
14:19:39     INFO -                          'c:/mozilla-build/buildbotve/virtualenv.py')},
14:19:39     INFO -  'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
14:19:39     INFO -                 'http://pypi.pub.build.mozilla.org/pub'),
14:19:39     INFO -  'firefox_media_branch': 'master',
14:19:39     INFO -  'firefox_media_repo': 'https://github.com/mjzffr/firefox-media-tests.git',
14:19:39     INFO -  'firefox_media_rev': 'b11d6c3d7f6af166be314d2ac6673e78c1edb566',
14:19:39     INFO -  'firefox_ui_branch': 'mozilla-central',
14:19:39     INFO -  'firefox_ui_repo': 'https://github.com/mozilla/firefox-ui-tests.git',
14:19:39     INFO -  'firefox_ui_rev': '6d6d57917f85399e903ac69b7e4297091b2d474c',
14:19:39     INFO -  'in_tree_config': 'config/mozharness/marionette.py',
14:19:39     INFO -  'log_level': 'info',
14:19:39     INFO -  'log_to_console': True,
14:19:39     INFO -  'opt_config_files': (),
14:19:39     INFO -  'pip_index': False,
14:19:39     INFO -  'suite_definitions': {'media-tests': {'options': ()},
14:19:39     INFO -                        'media-youtube-tests': {'options': ('--tests=%(test_manifest)s',)}},
14:19:39     INFO -  'test_suite': 'media-tests',
14:19:39     INFO -  'test_timeout': 10000,
14:19:39     INFO -  'virtualenv_path': 'venv',
14:19:39     INFO -  'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
14:19:39     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
14:19:39     INFO -  'work_dir': 'build'}
14:19:39     INFO - #####
14:19:39     INFO - ##### Running clobber step.
14:19:39     INFO - #####
14:19:39     INFO - Running pre-action listener: _resource_record_pre_action
14:19:39     INFO - Running main action method: clobber
14:19:39     INFO - rmtree: C:\slave\test\build
14:19:39     INFO - Using _rmtree_windows ...
14:19:39     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
14:20:55     INFO - Running post-action listener: _resource_record_post_action
14:20:55     INFO - #####
14:20:55     INFO - ##### Running read-buildbot-config step.
14:20:55     INFO - #####
14:20:55     INFO - Running pre-action listener: _resource_record_pre_action
14:20:55     INFO - Running main action method: read_buildbot_config
14:20:55     INFO - Using buildbot properties:
14:20:55     INFO - {
14:20:55     INFO -     "properties": {
14:20:55     INFO -         "buildnumber": 1, 
14:20:55     INFO -         "product": "firefox", 
14:20:55     INFO -         "script_repo_revision": "production", 
14:20:55     INFO -         "branch": "mozilla-beta", 
14:20:55     INFO -         "repository": "", 
14:20:55     INFO -         "buildername": "Windows 7 32-bit mozilla-beta pgo test media-tests", 
14:20:55     INFO -         "buildid": "20151228111030", 
14:20:55     INFO -         "slavename": "t-w732-ix-102", 
14:20:55     INFO -         "pgo_build": "True", 
14:20:55     INFO -         "basedir": "C:\\slave\\test", 
14:20:55     INFO -         "project": "", 
14:20:55     INFO -         "platform": "win32", 
14:20:55     INFO -         "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 
14:20:55     INFO -         "slavebuilddir": "test", 
14:20:55     INFO -         "scheduler": "tests-mozilla-beta-win7-ix-pgo-unittest", 
14:20:55     INFO -         "repo_path": "releases/mozilla-beta", 
14:20:55     INFO -         "moz_repo_path": "", 
14:20:55     INFO -         "stage_platform": "win32-pgo", 
14:20:55     INFO -         "builduid": "45114fb5d66b44afb37216ecf901787c", 
14:20:55     INFO -         "revision": "b86b3deb9b01"
14:20:55     INFO -     }, 
14:20:55     INFO -     "sourcestamp": {
14:20:55     INFO -         "repository": "", 
14:20:55     INFO -         "hasPatch": false, 
14:20:55     INFO -         "project": "", 
14:20:55     INFO -         "branch": "mozilla-beta-win32-pgo-unittest", 
14:20:55     INFO -         "changes": [
14:20:55     INFO -             {
14:20:55     INFO -                 "category": null, 
14:20:55     INFO -                 "files": [
14:20:55     INFO -                     {
14:20:55     INFO -                         "url": null, 
14:20:55     INFO -                         "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451328810/firefox-44.0.en-US.win32.web-platform.tests.zip"
14:20:55     INFO -                     }, 
14:20:55     INFO -                     {
14:20:55     INFO -                         "url": null, 
14:20:55     INFO -                         "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451328810/firefox-44.0.en-US.win32.zip"
14:20:55     INFO -                     }
14:20:55     INFO -                 ], 
14:20:55     INFO -                 "repository": "", 
14:20:55     INFO -                 "rev": "4413def26994", 
14:20:55     INFO -                 "who": "sendchange-unittest", 
14:20:55     INFO -                 "when": 1451341123, 
14:20:55     INFO -                 "number": 7397648, 
14:20:55     INFO -                 "comments": "Bug 1232386 - Fix NativeObject::growSlotsStatic to recover from OOM. r=terrence a=ritu", 
14:20:55     INFO -                 "project": "", 
14:20:55     INFO -                 "at": "Mon 28 Dec 2015 14:18:43", 
14:20:55     INFO -                 "branch": "mozilla-beta-win32-pgo-unittest", 
14:20:55     INFO -                 "revlink": "", 
14:20:55     INFO -                 "properties": [
14:20:55     INFO -                     [
14:20:55     INFO -                         "buildid", 
14:20:55     INFO -                         "20151228105330", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ], 
14:20:55     INFO -                     [
14:20:55     INFO -                         "builduid", 
14:20:55     INFO -                         "6d65666499d14a4a941a7590d4129318", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ], 
14:20:55     INFO -                     [
14:20:55     INFO -                         "pgo_build", 
14:20:55     INFO -                         "True", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ]
14:20:55     INFO -                 ], 
14:20:55     INFO -                 "revision": "4413def26994"
14:20:55     INFO -             }, 
14:20:55     INFO -             {
14:20:55     INFO -                 "category": null, 
14:20:55     INFO -                 "files": [
14:20:55     INFO -                     {
14:20:55     INFO -                         "url": null, 
14:20:55     INFO -                         "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451329655/firefox-44.0.en-US.win32.web-platform.tests.zip"
14:20:55     INFO -                     }, 
14:20:55     INFO -                     {
14:20:55     INFO -                         "url": null, 
14:20:55     INFO -                         "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451329655/firefox-44.0.en-US.win32.zip"
14:20:55     INFO -                     }
14:20:55     INFO -                 ], 
14:20:55     INFO -                 "repository": "", 
14:20:55     INFO -                 "rev": "a7e4b6ab821f", 
14:20:55     INFO -                 "who": "sendchange-unittest", 
14:20:55     INFO -                 "when": 1451341154, 
14:20:55     INFO -                 "number": 7397654, 
14:20:55     INFO -                 "comments": "Bug 1200677 - Import navigation-redirect.https.html for non-e10s. r=jdm a=testonly", 
14:20:55     INFO -                 "project": "", 
14:20:55     INFO -                 "at": "Mon 28 Dec 2015 14:19:14", 
14:20:55     INFO -                 "branch": "mozilla-beta-win32-pgo-unittest", 
14:20:55     INFO -                 "revlink": "", 
14:20:55     INFO -                 "properties": [
14:20:55     INFO -                     [
14:20:55     INFO -                         "buildid", 
14:20:55     INFO -                         "20151228110735", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ], 
14:20:55     INFO -                     [
14:20:55     INFO -                         "builduid", 
14:20:55     INFO -                         "4d2c6207a5054d7f9cc8f5c8a092a1e4", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ], 
14:20:55     INFO -                     [
14:20:55     INFO -                         "pgo_build", 
14:20:55     INFO -                         "True", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ]
14:20:55     INFO -                 ], 
14:20:55     INFO -                 "revision": "a7e4b6ab821f"
14:20:55     INFO -             }, 
14:20:55     INFO -             {
14:20:55     INFO -                 "category": null, 
14:20:55     INFO -                 "files": [
14:20:55     INFO -                     {
14:20:55     INFO -                         "url": null, 
14:20:55     INFO -                         "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451329830/firefox-44.0.en-US.win32.web-platform.tests.zip"
14:20:55     INFO -                     }, 
14:20:55     INFO -                     {
14:20:55     INFO -                         "url": null, 
14:20:55     INFO -                         "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451329830/firefox-44.0.en-US.win32.zip"
14:20:55     INFO -                     }
14:20:55     INFO -                 ], 
14:20:55     INFO -                 "repository": "", 
14:20:55     INFO -                 "rev": "b86b3deb9b01", 
14:20:55     INFO -                 "who": "sendchange-unittest", 
14:20:55     INFO -                 "when": 1451341141, 
14:20:55     INFO -                 "number": 7397652, 
14:20:55     INFO -                 "comments": "Bug 1234310 - Enable navigation-redirect.https.html for e10s. r=ehsan a=sylvestre", 
14:20:55     INFO -                 "project": "", 
14:20:55     INFO -                 "at": "Mon 28 Dec 2015 14:19:01", 
14:20:55     INFO -                 "branch": "mozilla-beta-win32-pgo-unittest", 
14:20:55     INFO -                 "revlink": "", 
14:20:55     INFO -                 "properties": [
14:20:55     INFO -                     [
14:20:55     INFO -                         "buildid", 
14:20:55     INFO -                         "20151228111030", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ], 
14:20:55     INFO -                     [
14:20:55     INFO -                         "builduid", 
14:20:55     INFO -                         "45114fb5d66b44afb37216ecf901787c", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ], 
14:20:55     INFO -                     [
14:20:55     INFO -                         "pgo_build", 
14:20:55     INFO -                         "True", 
14:20:55     INFO -                         "Change"
14:20:55     INFO -                     ]
14:20:55     INFO -                 ], 
14:20:55     INFO -                 "revision": "b86b3deb9b01"
14:20:55     INFO -             }
14:20:55     INFO -         ], 
14:20:55     INFO -         "revision": "b86b3deb9b01"
14:20:55     INFO -     }
14:20:55     INFO - }
14:20:55     INFO - Found test url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451329830/firefox-44.0.en-US.win32.web-platform.tests.zip.
14:20:55     INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1451329830/firefox-44.0.en-US.win32.zip.
14:20:55     INFO - Running post-action listener: _resource_record_post_action
14:20:55     INFO - #####
14:20:55     INFO - ##### Running checkout step.
14:20:55     INFO - #####
14:20:55     INFO - Running pre-action listener: _pre_checkout
14:20:55     INFO - Running pre-action listener: _resource_record_pre_action
14:20:55     INFO - Running main action method: checkout
14:20:55     INFO - retry: Calling _get_revision with args: (<mozharness.base.vcs.gittool.GittoolVCS object at 0x01D1D2B0>, 'C:\\slave\\test\\build\\firefox-media-tests'), kwargs: {}, attempt #1
14:20:55     INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'C:\\slave\\test\\scripts\\external_tools\\gittool.py', '-b', 'master', '-r', 'b11d6c3d7f6af166be314d2ac6673e78c1edb566', 'https://github.com/mjzffr/firefox-media-tests.git', 'C:\\slave\\test\\build\\firefox-media-tests']
14:20:55     INFO - Copy/paste: c:\mozilla-build\python27\python.exe C:\slave\test\scripts\external_tools\gittool.py -b master -r b11d6c3d7f6af166be314d2ac6673e78c1edb566 https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:20:55     INFO - Using env: {'PATH': 'C:\\Program Files\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;c:\\Program Files\\Microsoft Windows Performance Toolkit\\;c:\\mozilla-build\\hg\\;C:\\mozilla-build\\hg;C:/mozilla-build/Git/bin',
14:20:55     INFO -  'SYSTEMROOT': 'C:\\windows'}
14:20:55     INFO -  2015-12-28 14:20:55,723 Checking dest C:\slave\test\build\firefox-media-tests
14:20:55     INFO -  2015-12-28 14:20:55,723 command: START
14:20:55     INFO -  2015-12-28 14:20:55,723 command: git clone -q --no-checkout --branch master https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:20:55     INFO -  2015-12-28 14:20:55,723 command: cwd: C:\slave\test
14:20:55     INFO -  2015-12-28 14:20:55,723 command: output:
14:20:55     INFO -  2015-12-28 14:20:55,726 command: END (0.00s elapsed)
14:20:55     INFO -  Traceback (most recent call last):
14:20:55     INFO -    File "C:\slave\test\scripts\external_tools\gittool.py", line 91, in <module>
14:20:55     INFO -      clean_dest=options.clean,
14:20:55     INFO -    File "<string>", line 220, in git
14:20:55     INFO -    File "<string>", line 343, in clone
14:20:55     INFO -    File "<string>", line 47, in run_cmd
14:20:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 506, in check_call
14:20:55     INFO -      retcode = call(*popenargs, **kwargs)
14:20:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 493, in call
14:20:55     INFO -      return Popen(*popenargs, **kwargs).wait()
14:20:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 679, in __init__
14:20:55     INFO -      errread, errwrite)
14:20:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 896, in _execute_child
14:20:55     INFO -      startupinfo)
14:20:55     INFO -  WindowsError: [Error 2] The system cannot find the file specified
14:20:55    ERROR - Return code: 1
14:20:55     INFO - rmtree: C:\slave\test\build\firefox-media-tests
14:20:55     INFO - Using _rmtree_windows ...
14:20:55     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\firefox-media-tests',), kwargs: {}, attempt #1
14:20:55     INFO - retry: attempt #1 caught exception: Unable to checkout
14:20:55     INFO - retry: Failed, sleeping 60 seconds before retrying
14:21:55     INFO - retry: Calling _get_revision with args: (<mozharness.base.vcs.gittool.GittoolVCS object at 0x01D1D2B0>, 'C:\\slave\\test\\build\\firefox-media-tests'), kwargs: {}, attempt #2
14:21:55     INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'C:\\slave\\test\\scripts\\external_tools\\gittool.py', '-b', 'master', '-r', 'b11d6c3d7f6af166be314d2ac6673e78c1edb566', 'https://github.com/mjzffr/firefox-media-tests.git', 'C:\\slave\\test\\build\\firefox-media-tests']
14:21:55     INFO - Copy/paste: c:\mozilla-build\python27\python.exe C:\slave\test\scripts\external_tools\gittool.py -b master -r b11d6c3d7f6af166be314d2ac6673e78c1edb566 https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:21:55     INFO - Using env: {'PATH': 'C:\\Program Files\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;c:\\Program Files\\Microsoft Windows Performance Toolkit\\;c:\\mozilla-build\\hg\\;C:\\mozilla-build\\hg;C:/mozilla-build/Git/bin',
14:21:55     INFO -  'SYSTEMROOT': 'C:\\windows'}
14:21:55     INFO -  2015-12-28 14:21:55,927 Checking dest C:\slave\test\build\firefox-media-tests
14:21:55     INFO -  2015-12-28 14:21:55,927 command: START
14:21:55     INFO -  2015-12-28 14:21:55,928 command: git clone -q --no-checkout --branch master https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:21:55     INFO -  2015-12-28 14:21:55,928 command: cwd: C:\slave\test
14:21:55     INFO -  2015-12-28 14:21:55,928 command: output:
14:21:55     INFO -  2015-12-28 14:21:55,930 command: END (0.00s elapsed)
14:21:55     INFO -  Traceback (most recent call last):
14:21:55     INFO -    File "C:\slave\test\scripts\external_tools\gittool.py", line 91, in <module>
14:21:55     INFO -      clean_dest=options.clean,
14:21:55     INFO -    File "<string>", line 220, in git
14:21:55     INFO -    File "<string>", line 343, in clone
14:21:55     INFO -    File "<string>", line 47, in run_cmd
14:21:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 506, in check_call
14:21:55     INFO -      retcode = call(*popenargs, **kwargs)
14:21:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 493, in call
14:21:55     INFO -      return Popen(*popenargs, **kwargs).wait()
14:21:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 679, in __init__
14:21:55     INFO -      errread, errwrite)
14:21:55     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 896, in _execute_child
14:21:55     INFO -      startupinfo)
14:21:55     INFO -  WindowsError: [Error 2] The system cannot find the file specified
14:21:55    ERROR - Return code: 1
14:21:55     INFO - rmtree: C:\slave\test\build\firefox-media-tests
14:21:55     INFO - Using _rmtree_windows ...
14:21:55     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\firefox-media-tests',), kwargs: {}, attempt #1
14:21:55     INFO - retry: attempt #2 caught exception: Unable to checkout
14:21:55     INFO - retry: Failed, sleeping 120 seconds before retrying
14:23:56     INFO - retry: Calling _get_revision with args: (<mozharness.base.vcs.gittool.GittoolVCS object at 0x01D1D2B0>, 'C:\\slave\\test\\build\\firefox-media-tests'), kwargs: {}, attempt #3
14:23:56     INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'C:\\slave\\test\\scripts\\external_tools\\gittool.py', '-b', 'master', '-r', 'b11d6c3d7f6af166be314d2ac6673e78c1edb566', 'https://github.com/mjzffr/firefox-media-tests.git', 'C:\\slave\\test\\build\\firefox-media-tests']
14:23:56     INFO - Copy/paste: c:\mozilla-build\python27\python.exe C:\slave\test\scripts\external_tools\gittool.py -b master -r b11d6c3d7f6af166be314d2ac6673e78c1edb566 https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:23:56     INFO - Using env: {'PATH': 'C:\\Program Files\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;c:\\Program Files\\Microsoft Windows Performance Toolkit\\;c:\\mozilla-build\\hg\\;C:\\mozilla-build\\hg;C:/mozilla-build/Git/bin',
14:23:56     INFO -  'SYSTEMROOT': 'C:\\windows'}
14:23:56     INFO -  2015-12-28 14:23:56,102 Checking dest C:\slave\test\build\firefox-media-tests
14:23:56     INFO -  2015-12-28 14:23:56,102 command: START
14:23:56     INFO -  2015-12-28 14:23:56,104 command: git clone -q --no-checkout --branch master https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:23:56     INFO -  2015-12-28 14:23:56,104 command: cwd: C:\slave\test
14:23:56     INFO -  2015-12-28 14:23:56,104 command: output:
14:23:56     INFO -  2015-12-28 14:23:56,105 command: END (0.00s elapsed)
14:23:56     INFO -  Traceback (most recent call last):
14:23:56     INFO -    File "C:\slave\test\scripts\external_tools\gittool.py", line 91, in <module>
14:23:56     INFO -      clean_dest=options.clean,
14:23:56     INFO -    File "<string>", line 220, in git
14:23:56     INFO -    File "<string>", line 343, in clone
14:23:56     INFO -    File "<string>", line 47, in run_cmd
14:23:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 506, in check_call
14:23:56     INFO -      retcode = call(*popenargs, **kwargs)
14:23:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 493, in call
14:23:56     INFO -      return Popen(*popenargs, **kwargs).wait()
14:23:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 679, in __init__
14:23:56     INFO -      errread, errwrite)
14:23:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 896, in _execute_child
14:23:56     INFO -      startupinfo)
14:23:56     INFO -  WindowsError: [Error 2] The system cannot find the file specified
14:23:56    ERROR - Return code: 1
14:23:56     INFO - rmtree: C:\slave\test\build\firefox-media-tests
14:23:56     INFO - Using _rmtree_windows ...
14:23:56     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\firefox-media-tests',), kwargs: {}, attempt #1
14:23:56     INFO - retry: attempt #3 caught exception: Unable to checkout
14:23:56     INFO - retry: Failed, sleeping 240 seconds before retrying
14:27:56     INFO - retry: Calling _get_revision with args: (<mozharness.base.vcs.gittool.GittoolVCS object at 0x01D1D2B0>, 'C:\\slave\\test\\build\\firefox-media-tests'), kwargs: {}, attempt #4
14:27:56     INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'C:\\slave\\test\\scripts\\external_tools\\gittool.py', '-b', 'master', '-r', 'b11d6c3d7f6af166be314d2ac6673e78c1edb566', 'https://github.com/mjzffr/firefox-media-tests.git', 'C:\\slave\\test\\build\\firefox-media-tests']
14:27:56     INFO - Copy/paste: c:\mozilla-build\python27\python.exe C:\slave\test\scripts\external_tools\gittool.py -b master -r b11d6c3d7f6af166be314d2ac6673e78c1edb566 https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:27:56     INFO - Using env: {'PATH': 'C:\\Program Files\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;c:\\Program Files\\Microsoft Windows Performance Toolkit\\;c:\\mozilla-build\\hg\\;C:\\mozilla-build\\hg;C:/mozilla-build/Git/bin',
14:27:56     INFO -  'SYSTEMROOT': 'C:\\windows'}
14:27:56     INFO -  2015-12-28 14:27:56,328 Checking dest C:\slave\test\build\firefox-media-tests
14:27:56     INFO -  2015-12-28 14:27:56,328 command: START
14:27:56     INFO -  2015-12-28 14:27:56,328 command: git clone -q --no-checkout --branch master https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:27:56     INFO -  2015-12-28 14:27:56,328 command: cwd: C:\slave\test
14:27:56     INFO -  2015-12-28 14:27:56,328 command: output:
14:27:56     INFO -  2015-12-28 14:27:56,331 command: END (0.00s elapsed)
14:27:56     INFO -  Traceback (most recent call last):
14:27:56     INFO -    File "C:\slave\test\scripts\external_tools\gittool.py", line 91, in <module>
14:27:56     INFO -      clean_dest=options.clean,
14:27:56     INFO -    File "<string>", line 220, in git
14:27:56     INFO -    File "<string>", line 343, in clone
14:27:56     INFO -    File "<string>", line 47, in run_cmd
14:27:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 506, in check_call
14:27:56     INFO -      retcode = call(*popenargs, **kwargs)
14:27:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 493, in call
14:27:56     INFO -      return Popen(*popenargs, **kwargs).wait()
14:27:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 679, in __init__
14:27:56     INFO -      errread, errwrite)
14:27:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 896, in _execute_child
14:27:56     INFO -      startupinfo)
14:27:56     INFO -  WindowsError: [Error 2] The system cannot find the file specified
14:27:56    ERROR - Return code: 1
14:27:56     INFO - rmtree: C:\slave\test\build\firefox-media-tests
14:27:56     INFO - Using _rmtree_windows ...
14:27:56     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\firefox-media-tests',), kwargs: {}, attempt #1
14:27:56     INFO - retry: attempt #4 caught exception: Unable to checkout
14:27:56     INFO - retry: Failed, sleeping 300 seconds before retrying
14:32:56     INFO - retry: Calling _get_revision with args: (<mozharness.base.vcs.gittool.GittoolVCS object at 0x01D1D2B0>, 'C:\\slave\\test\\build\\firefox-media-tests'), kwargs: {}, attempt #5
14:32:56     INFO - Running command: ['c:\\mozilla-build\\python27\\python.exe', 'C:\\slave\\test\\scripts\\external_tools\\gittool.py', '-b', 'master', '-r', 'b11d6c3d7f6af166be314d2ac6673e78c1edb566', 'https://github.com/mjzffr/firefox-media-tests.git', 'C:\\slave\\test\\build\\firefox-media-tests']
14:32:56     INFO - Copy/paste: c:\mozilla-build\python27\python.exe C:\slave\test\scripts\external_tools\gittool.py -b master -r b11d6c3d7f6af166be314d2ac6673e78c1edb566 https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:32:56     INFO - Using env: {'PATH': 'C:\\Program Files\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;c:\\Program Files\\Microsoft Windows Performance Toolkit\\;c:\\mozilla-build\\hg\\;C:\\mozilla-build\\hg;C:/mozilla-build/Git/bin',
14:32:56     INFO -  'SYSTEMROOT': 'C:\\windows'}
14:32:56     INFO -  2015-12-28 14:32:56,483 Checking dest C:\slave\test\build\firefox-media-tests
14:32:56     INFO -  2015-12-28 14:32:56,483 command: START
14:32:56     INFO -  2015-12-28 14:32:56,483 command: git clone -q --no-checkout --branch master https://github.com/mjzffr/firefox-media-tests.git C:\slave\test\build\firefox-media-tests
14:32:56     INFO -  2015-12-28 14:32:56,483 command: cwd: C:\slave\test
14:32:56     INFO -  2015-12-28 14:32:56,483 command: output:
14:32:56     INFO -  2015-12-28 14:32:56,486 command: END (0.00s elapsed)
14:32:56     INFO -  Traceback (most recent call last):
14:32:56     INFO -    File "C:\slave\test\scripts\external_tools\gittool.py", line 91, in <module>
14:32:56     INFO -      clean_dest=options.clean,
14:32:56     INFO -    File "<string>", line 220, in git
14:32:56     INFO -    File "<string>", line 343, in clone
14:32:56     INFO -    File "<string>", line 47, in run_cmd
14:32:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 506, in check_call
14:32:56     INFO -      retcode = call(*popenargs, **kwargs)
14:32:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 493, in call
14:32:56     INFO -      return Popen(*popenargs, **kwargs).wait()
14:32:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 679, in __init__
14:32:56     INFO -      errread, errwrite)
14:32:56     INFO -    File "c:\mozilla-build\python27\lib\subprocess.py", line 896, in _execute_child
14:32:56     INFO -      startupinfo)
14:32:56     INFO -  WindowsError: [Error 2] The system cannot find the file specified
14:32:56    ERROR - Return code: 1
14:32:56     INFO - rmtree: C:\slave\test\build\firefox-media-tests
14:32:56     INFO - Using _rmtree_windows ...
14:32:56     INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\firefox-media-tests',), kwargs: {}, attempt #1
14:32:56     INFO - retry: attempt #5 caught exception: Unable to checkout
14:32:56    FATAL - Automation Error: Can't checkout https://github.com/mjzffr/firefox-media-tests.git!
14:32:56    FATAL - Caught exception: Unable to checkout
14:32:56    FATAL - Caught exception: Unable to checkout
14:32:56    FATAL - Caught exception: Unable to checkout
14:32:56    FATAL - Caught exception: Unable to checkout
14:32:56    FATAL - Caught exception: Unable to checkout
14:32:56    FATAL - Running post_fatal callback...
14:32:56    FATAL - Exiting -1
14:32:56     INFO - Running post-action listener: _resource_record_post_action
14:32:56     INFO - Running post-run listener: _resource_record_post_run
14:32:56     INFO - Running post-run listener: _upload_blobber_files
14:32:56     INFO - Blob upload gear active.
14:32:56  WARNING - Blob upload directory does not exist!
program finished with exit code -1
elapsedTime=797.315000
========= master_lag: -0.49 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' failed (results: 2, elapsed: 13 mins, 16 secs) (at 2015-12-28 14:32:56.525259) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2015-12-28 14:32:56.526032) =========
'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f'
 in dir C:\slave\test\properties (timeout 1200 secs)
 watching logfiles {}
 argv: ['cmd', '/C', 'for', '%f', 'in', '(*)', 'do', '@type', '%f']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test\properties
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
program finished with exit code 0
elapsedTime=0.101000

========= master_lag: 0.02 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2015-12-28 14:32:56.643014) =========

========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 14:32:56.643345) =========
'rm' '-f' 'oauth.txt'
 in dir C:\slave\test\. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-f', 'oauth.txt']
 environment:
  ALLUSERSPROFILE=C:\ProgramData
  APPDATA=C:\Users\cltbld\AppData\Roaming
  COMMONPROGRAMFILES=C:\Program Files\Common Files
  COMPUTERNAME=T-W732-IX-102
  COMSPEC=C:\windows\system32\cmd.exe
  DCLOCATION=SCL3
  DNSSUFFIX=wintest.releng.scl3.mozilla.com
  FP_NO_HOST_CHECK=NO
  HOMEDRIVE=C:
  HOMEPATH=\Users\cltbld
  KTS_HOME=C:\Program Files\KTS
  KTS_VERSION=1.19c
  LOCALAPPDATA=C:\Users\cltbld\AppData\Local
  LOGONSERVER=\\T-W732-IX-102
  MONDIR=C:\Monitor_config\
  MOZBUILDDIR=C:\mozilla-build\
  NUMBER_OF_PROCESSORS=8
  OS=Windows_NT
  OURDRIVE=C:
  PATH=C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;c:\Program Files\Microsoft Windows Performance Toolkit\;c:\mozilla-build\hg\;C:\mozilla-build\hg
  PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
  PROCESSOR_ARCHITECTURE=x86
  PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
  PROCESSOR_LEVEL=6
  PROCESSOR_REVISION=1e05
  PROGRAMDATA=C:\ProgramData
  PROGRAMFILES=C:\Program Files
  PROMPT=$P$G
  PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
  PUBLIC=C:\Users\Public
  PWD=C:\slave\test
  RUNLOGFILE=C:\slave\\runslave.log
  SLAVEDIR=C:\slave\
  SYSTEMDRIVE=C:
  SYSTEMROOT=C:\windows
  TEMP=C:\Users\cltbld\AppData\Local\Temp
  TEST1=testie
  TMP=C:\Users\cltbld\AppData\Local\Temp
  USERDOMAIN=T-W732-IX-102
  USERNAME=cltbld
  USERPROFILE=C:\Users\cltbld
  WINDIR=C:\windows
  WINDOWS_TRACING_FLAGS=3
  WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
 using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.01 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 14:32:56.758267) =========

========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-12-28 14:32:56.758701) =========

========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-12-28 14:32:57.749732) =========

========= Total master_lag: 4.59 =========