builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1458039679.07 results: success (0) buildid: 20160315024234 builduid: 12d15daa324242efb822906186ce9f6e revision: 4adc4cef81179df18fe4e7e8463e4240aca3ae95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.072955) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.073385) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.073707) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006394 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.103090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.103531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.132332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.132597) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.189963) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.190261) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.190576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.190856) ========= 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 /builds/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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 04:01:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.1M=0s 2016-03-15 04:01:19 (70.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155411 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.359398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.359690) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018411 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.409568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.409882) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4adc4cef81179df18fe4e7e8463e4240aca3ae95 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4adc4cef81179df18fe4e7e8463e4240aca3ae95 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 04:01:20,008 truncating revision to first 12 chars 2016-03-15 04:01:20,008 Setting DEBUG logging. 2016-03-15 04:01:20,008 attempt 1/10 2016-03-15 04:01:20,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4adc4cef8117?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 04:01:20,268 unpacking tar archive at: mozilla-central-4adc4cef8117/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529863 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.952305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:19.952610) ========= echo 4adc4cef81179df18fe4e7e8463e4240aca3ae95 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4adc4cef81179df18fe4e7e8463e4240aca3ae95'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4adc4cef81179df18fe4e7e8463e4240aca3ae95 program finished with exit code 0 elapsedTime=0.004740 script_repo_revision: '4adc4cef81179df18fe4e7e8463e4240aca3ae95' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:20.003311) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:20.003606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 04:01:20.013775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-03-15 04:01:20.014059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:20 INFO - MultiFileLogger online at 20160315 04:01:20 in /builds/slave/test 04:01:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:01:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:20 INFO - {'append_to_log': False, 04:01:20 INFO - 'base_work_dir': '/builds/slave/test', 04:01:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:01:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:20 INFO - 'branch': 'Firefox-Non-PGO', 04:01:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:20 INFO - 'config_files': ('talos/linux_config.py',), 04:01:20 INFO - 'default_actions': ('clobber', 04:01:20 INFO - 'read-buildbot-config', 04:01:20 INFO - 'download-and-extract', 04:01:20 INFO - 'populate-webroot', 04:01:20 INFO - 'create-virtualenv', 04:01:20 INFO - 'install', 04:01:20 INFO - 'run-tests'), 04:01:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:20 INFO - 'download_minidump_stackwalk': True, 04:01:20 INFO - 'download_symbols': 'ondemand', 04:01:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:20 INFO - 'installer_path': 'installer.exe', 04:01:20 INFO - 'log_level': 'info', 04:01:20 INFO - 'log_name': 'talos', 04:01:20 INFO - 'log_to_console': True, 04:01:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:20 INFO - 'opt_config_files': (), 04:01:20 INFO - 'pip_index': False, 04:01:20 INFO - 'sps_profile': False, 04:01:20 INFO - 'sps_profile_interval': 0, 04:01:20 INFO - 'suite': 'dromaeojs', 04:01:20 INFO - 'system_bits': '32', 04:01:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:20 INFO - 'title': 'talos-linux64-ix-051', 04:01:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:20 INFO - 'use_talos_json': True, 04:01:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:20 INFO - 'work_dir': 'build'} 04:01:20 INFO - ##### 04:01:20 INFO - ##### Running clobber step. 04:01:20 INFO - ##### 04:01:20 INFO - Running pre-action listener: _resource_record_pre_action 04:01:20 INFO - Running main action method: clobber 04:01:20 INFO - rmtree: /builds/slave/test/build 04:01:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:21 INFO - Running post-action listener: _resource_record_post_action 04:01:21 INFO - ##### 04:01:21 INFO - ##### Running read-buildbot-config step. 04:01:21 INFO - ##### 04:01:21 INFO - Running pre-action listener: _resource_record_pre_action 04:01:21 INFO - Running main action method: read_buildbot_config 04:01:21 INFO - Using buildbot properties: 04:01:21 INFO - { 04:01:21 INFO - "project": "", 04:01:21 INFO - "product": "firefox", 04:01:21 INFO - "script_repo_revision": "production", 04:01:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:01:21 INFO - "repository": "", 04:01:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:01:21 INFO - "buildid": "20160315024234", 04:01:21 INFO - "pgo_build": "False", 04:01:21 INFO - "basedir": "/builds/slave/test", 04:01:21 INFO - "buildnumber": 511, 04:01:21 INFO - "slavename": "talos-linux64-ix-051", 04:01:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:01:21 INFO - "platform": "ubuntu64_hw", 04:01:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:01:21 INFO - "branch": "mozilla-central", 04:01:21 INFO - "repo_path": "mozilla-central", 04:01:21 INFO - "revision": "4adc4cef81179df18fe4e7e8463e4240aca3ae95", 04:01:21 INFO - "stage_platform": "linux64", 04:01:21 INFO - "builduid": "12d15daa324242efb822906186ce9f6e", 04:01:21 INFO - "slavebuilddir": "test" 04:01:21 INFO - } 04:01:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:01:21 INFO - Running post-action listener: _resource_record_post_action 04:01:21 INFO - ##### 04:01:21 INFO - ##### Running download-and-extract step. 04:01:21 INFO - ##### 04:01:21 INFO - Running pre-action listener: _resource_record_pre_action 04:01:21 INFO - Running main action method: download_and_extract 04:01:21 INFO - mkdir: /builds/slave/test/build/tests 04:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:21 INFO - https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:01:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:01:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:01:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:01:23 INFO - Downloaded 1361 bytes. 04:01:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:01:23 INFO - Using the following test package requirements: 04:01:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:01:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:01:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'jsshell-linux-x86_64.zip'], 04:01:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:01:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:01:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:01:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:23 INFO - https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:25 INFO - Downloaded 21990771 bytes. 04:01:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:01:26 INFO - Return code: 0 04:01:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:26 INFO - https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:35 INFO - Downloaded 21990771 bytes. 04:01:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:01:36 INFO - Return code: 0 04:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:36 INFO - https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:01:37 INFO - Downloaded 10845263 bytes. 04:01:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:01:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:01:37 INFO - Return code: 0 04:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:37 INFO - https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:01:38 INFO - Downloaded 54154555 bytes. 04:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:38 INFO - mkdir: /builds/slave/test/properties 04:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:38 INFO - Contents: 04:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:01:39 INFO - Running post-action listener: _resource_record_post_action 04:01:39 INFO - Running post-action listener: set_extra_try_arguments 04:01:39 INFO - ##### 04:01:39 INFO - ##### Running populate-webroot step. 04:01:39 INFO - ##### 04:01:39 INFO - Running pre-action listener: _resource_record_pre_action 04:01:39 INFO - Running main action method: populate_webroot 04:01:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:39 INFO - '--tppagecycles', 04:01:39 INFO - '7'], 04:01:39 INFO - 'tests': ['tsvgm']}}, 04:01:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:01:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:01:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'tests': ['damp', 'tps']}, 04:01:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['damp', 'tps']}, 04:01:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:01:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:39 INFO - 'other': {'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other_l64': {'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'other_nol64': {'tests': ['a11yr', 04:01:39 INFO - 'ts_paint', 04:01:39 INFO - 'tpaint', 04:01:39 INFO - 'sessionrestore', 04:01:39 INFO - 'sessionrestore_no_auto_restore', 04:01:39 INFO - 'tabpaint']}, 04:01:39 INFO - 'svgr': {'tests': ['tsvgx', 04:01:39 INFO - 'tsvgr_opacity', 04:01:39 INFO - 'tart', 04:01:39 INFO - 'tscrollx', 04:01:39 INFO - 'cart']}, 04:01:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['tsvgx', 04:01:39 INFO - 'tsvgr_opacity', 04:01:39 INFO - 'tart', 04:01:39 INFO - 'tscrollx', 04:01:39 INFO - 'cart']}, 04:01:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'tests': ['tp5o']}, 04:01:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--e10s'], 04:01:39 INFO - 'tests': ['tp5o']}, 04:01:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--xperf_path', 04:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:39 INFO - 'tests': ['tp5n']}, 04:01:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:39 INFO - 'talos_options': ['--e10s', 04:01:39 INFO - '--xperf_path', 04:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:39 INFO - 'tests': ['tp5n']}}, 04:01:39 INFO - 'talos.zip': {'path': '', 04:01:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:39 INFO - Running post-action listener: _resource_record_post_action 04:01:39 INFO - ##### 04:01:39 INFO - ##### Running create-virtualenv step. 04:01:39 INFO - ##### 04:01:39 INFO - Running pre-action listener: _resource_record_pre_action 04:01:39 INFO - Running main action method: create_virtualenv 04:01:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:01:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:39 INFO - Using real prefix '/usr' 04:01:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:42 INFO - Installing pip.................done. 04:01:42 INFO - Return code: 0 04:01:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:01:42 INFO - Using env: {'DISPLAY': ':0', 04:01:42 INFO - 'HOME': '/home/cltbld', 04:01:42 INFO - 'LANG': 'en_US.UTF-8', 04:01:42 INFO - 'LANGUAGE': 'en_US:en', 04:01:42 INFO - 'LOGNAME': 'cltbld', 04:01:42 INFO - 'MAIL': '/var/mail/cltbld', 04:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:42 INFO - 'MOZ_NO_REMOTE': '1', 04:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:42 INFO - 'NO_EM_RESTART': '1', 04:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:42 INFO - 'PWD': '/builds/slave/test', 04:01:42 INFO - 'SHELL': '/bin/bash', 04:01:42 INFO - 'SHLVL': '1', 04:01:42 INFO - 'TERM': 'linux', 04:01:42 INFO - 'TMOUT': '86400', 04:01:42 INFO - 'USER': 'cltbld', 04:01:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:42 INFO - '_': '/tools/buildbot/bin/python'} 04:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:01:42 INFO - Cleaning up... 04:01:42 INFO - Return code: 0 04:01:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:01:42 INFO - Using env: {'DISPLAY': ':0', 04:01:42 INFO - 'HOME': '/home/cltbld', 04:01:42 INFO - 'LANG': 'en_US.UTF-8', 04:01:42 INFO - 'LANGUAGE': 'en_US:en', 04:01:42 INFO - 'LOGNAME': 'cltbld', 04:01:42 INFO - 'MAIL': '/var/mail/cltbld', 04:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:42 INFO - 'MOZ_NO_REMOTE': '1', 04:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:42 INFO - 'NO_EM_RESTART': '1', 04:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:42 INFO - 'PWD': '/builds/slave/test', 04:01:42 INFO - 'SHELL': '/bin/bash', 04:01:42 INFO - 'SHLVL': '1', 04:01:42 INFO - 'TERM': 'linux', 04:01:42 INFO - 'TMOUT': '86400', 04:01:42 INFO - 'USER': 'cltbld', 04:01:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:42 INFO - '_': '/tools/buildbot/bin/python'} 04:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:42 INFO - Downloading/unpacking psutil>=0.7.1 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:44 INFO - Installing collected packages: psutil 04:01:44 INFO - Running setup.py install for psutil 04:01:44 INFO - building 'psutil._psutil_linux' extension 04:01:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:01:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:01:44 INFO - building 'psutil._psutil_posix' extension 04:01:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:01:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:01:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:45 INFO - Successfully installed psutil 04:01:45 INFO - Cleaning up... 04:01:45 INFO - Return code: 0 04:01:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:01:45 INFO - Using env: {'DISPLAY': ':0', 04:01:45 INFO - 'HOME': '/home/cltbld', 04:01:45 INFO - 'LANG': 'en_US.UTF-8', 04:01:45 INFO - 'LANGUAGE': 'en_US:en', 04:01:45 INFO - 'LOGNAME': 'cltbld', 04:01:45 INFO - 'MAIL': '/var/mail/cltbld', 04:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:45 INFO - 'MOZ_NO_REMOTE': '1', 04:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:45 INFO - 'NO_EM_RESTART': '1', 04:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:45 INFO - 'PWD': '/builds/slave/test', 04:01:45 INFO - 'SHELL': '/bin/bash', 04:01:45 INFO - 'SHLVL': '1', 04:01:45 INFO - 'TERM': 'linux', 04:01:45 INFO - 'TMOUT': '86400', 04:01:45 INFO - 'USER': 'cltbld', 04:01:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:45 INFO - '_': '/tools/buildbot/bin/python'} 04:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:01:47 INFO - Installing collected packages: mozsystemmonitor 04:01:47 INFO - Running setup.py install for mozsystemmonitor 04:01:47 INFO - Successfully installed mozsystemmonitor 04:01:47 INFO - Cleaning up... 04:01:47 INFO - Return code: 0 04:01:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:01:47 INFO - Using env: {'DISPLAY': ':0', 04:01:47 INFO - 'HOME': '/home/cltbld', 04:01:47 INFO - 'LANG': 'en_US.UTF-8', 04:01:47 INFO - 'LANGUAGE': 'en_US:en', 04:01:47 INFO - 'LOGNAME': 'cltbld', 04:01:47 INFO - 'MAIL': '/var/mail/cltbld', 04:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:47 INFO - 'MOZ_NO_REMOTE': '1', 04:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:47 INFO - 'NO_EM_RESTART': '1', 04:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:47 INFO - 'PWD': '/builds/slave/test', 04:01:47 INFO - 'SHELL': '/bin/bash', 04:01:47 INFO - 'SHLVL': '1', 04:01:47 INFO - 'TERM': 'linux', 04:01:47 INFO - 'TMOUT': '86400', 04:01:47 INFO - 'USER': 'cltbld', 04:01:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:47 INFO - '_': '/tools/buildbot/bin/python'} 04:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:50 INFO - Downloading docopt-0.6.1.tar.gz 04:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:50 INFO - Running setup.py install for blobuploader 04:01:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:50 INFO - Running setup.py install for requests 04:01:50 INFO - Running setup.py install for docopt 04:01:50 INFO - Successfully installed blobuploader requests docopt 04:01:50 INFO - Cleaning up... 04:01:50 INFO - Return code: 0 04:01:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:50 INFO - Using env: {'DISPLAY': ':0', 04:01:50 INFO - 'HOME': '/home/cltbld', 04:01:50 INFO - 'LANG': 'en_US.UTF-8', 04:01:50 INFO - 'LANGUAGE': 'en_US:en', 04:01:50 INFO - 'LOGNAME': 'cltbld', 04:01:50 INFO - 'MAIL': '/var/mail/cltbld', 04:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:50 INFO - 'MOZ_NO_REMOTE': '1', 04:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:50 INFO - 'NO_EM_RESTART': '1', 04:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:50 INFO - 'PWD': '/builds/slave/test', 04:01:50 INFO - 'SHELL': '/bin/bash', 04:01:50 INFO - 'SHLVL': '1', 04:01:50 INFO - 'TERM': 'linux', 04:01:50 INFO - 'TMOUT': '86400', 04:01:50 INFO - 'USER': 'cltbld', 04:01:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:50 INFO - '_': '/tools/buildbot/bin/python'} 04:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:51 INFO - Running setup.py (path:/tmp/pip-nh0KyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:51 INFO - Running setup.py (path:/tmp/pip-Xcmdb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:51 INFO - Running setup.py (path:/tmp/pip-DrgrTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:51 INFO - Running setup.py (path:/tmp/pip-vn3Fbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:51 INFO - Running setup.py (path:/tmp/pip-K7NtPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:51 INFO - Running setup.py (path:/tmp/pip-TYiLvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:51 INFO - Running setup.py (path:/tmp/pip-QrJoIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:51 INFO - Running setup.py (path:/tmp/pip-EWJOwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:51 INFO - Running setup.py (path:/tmp/pip-86spJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:51 INFO - Running setup.py (path:/tmp/pip-VIAeXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:51 INFO - Running setup.py (path:/tmp/pip-vQUHBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:51 INFO - Running setup.py (path:/tmp/pip-1IHsAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:51 INFO - Running setup.py (path:/tmp/pip-iQMWlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:51 INFO - Running setup.py (path:/tmp/pip-cKW_Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:52 INFO - Running setup.py (path:/tmp/pip-7VVYr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:52 INFO - Running setup.py (path:/tmp/pip-LE99oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:52 INFO - Running setup.py (path:/tmp/pip-R61BJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:52 INFO - Running setup.py install for manifestparser 04:01:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Running setup.py install for mozcrash 04:01:52 INFO - Running setup.py install for mozdebug 04:01:52 INFO - Running setup.py install for mozdevice 04:01:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Running setup.py install for mozfile 04:01:52 INFO - Running setup.py install for mozhttpd 04:01:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Running setup.py install for mozinfo 04:01:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:52 INFO - Running setup.py install for mozInstall 04:01:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozleak 04:01:53 INFO - Running setup.py install for mozlog 04:01:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for moznetwork 04:01:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozprocess 04:01:53 INFO - Running setup.py install for mozprofile 04:01:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozrunner 04:01:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:53 INFO - Running setup.py install for mozscreenshot 04:01:53 INFO - Running setup.py install for moztest 04:01:53 INFO - Running setup.py install for mozversion 04:01:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:54 INFO - Cleaning up... 04:01:54 INFO - Return code: 0 04:01:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:54 INFO - Using env: {'DISPLAY': ':0', 04:01:54 INFO - 'HOME': '/home/cltbld', 04:01:54 INFO - 'LANG': 'en_US.UTF-8', 04:01:54 INFO - 'LANGUAGE': 'en_US:en', 04:01:54 INFO - 'LOGNAME': 'cltbld', 04:01:54 INFO - 'MAIL': '/var/mail/cltbld', 04:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:54 INFO - 'MOZ_NO_REMOTE': '1', 04:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:54 INFO - 'NO_EM_RESTART': '1', 04:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:54 INFO - 'PWD': '/builds/slave/test', 04:01:54 INFO - 'SHELL': '/bin/bash', 04:01:54 INFO - 'SHLVL': '1', 04:01:54 INFO - 'TERM': 'linux', 04:01:54 INFO - 'TMOUT': '86400', 04:01:54 INFO - 'USER': 'cltbld', 04:01:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:54 INFO - '_': '/tools/buildbot/bin/python'} 04:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:54 INFO - Running setup.py (path:/tmp/pip-dcvLjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:54 INFO - Running setup.py (path:/tmp/pip-UVaS0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:54 INFO - Running setup.py (path:/tmp/pip-9D68em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:54 INFO - Running setup.py (path:/tmp/pip-jmCEZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:54 INFO - Running setup.py (path:/tmp/pip-9bKI9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:54 INFO - Running setup.py (path:/tmp/pip-SRQQTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:54 INFO - Running setup.py (path:/tmp/pip-m9GpRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:54 INFO - Running setup.py (path:/tmp/pip-HaxWzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:54 INFO - Running setup.py (path:/tmp/pip-yMxnLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:54 INFO - Running setup.py (path:/tmp/pip-3nJLZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:55 INFO - Running setup.py (path:/tmp/pip-LJNbRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:55 INFO - Running setup.py (path:/tmp/pip-32SlId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:55 INFO - Running setup.py (path:/tmp/pip-LMSFtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:55 INFO - Running setup.py (path:/tmp/pip-eD1DNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:55 INFO - Running setup.py (path:/tmp/pip-7qNnWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:55 INFO - Running setup.py (path:/tmp/pip-rGALOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:55 INFO - Running setup.py (path:/tmp/pip-8_4QC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:01:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:57 INFO - Downloading blessings-1.6.tar.gz 04:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:57 INFO - Installing collected packages: blessings 04:01:57 INFO - Running setup.py install for blessings 04:01:57 INFO - Successfully installed blessings 04:01:57 INFO - Cleaning up... 04:01:57 INFO - Return code: 0 04:01:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:57 INFO - Reading from file tmpfile_stdout 04:01:57 INFO - Current package versions: 04:01:57 INFO - argparse == 1.2.1 04:01:57 INFO - blessings == 1.6 04:01:57 INFO - blobuploader == 1.2.4 04:01:57 INFO - docopt == 0.6.1 04:01:57 INFO - manifestparser == 1.1 04:01:57 INFO - mozInstall == 1.12 04:01:57 INFO - mozcrash == 0.17 04:01:57 INFO - mozdebug == 0.1 04:01:57 INFO - mozdevice == 0.48 04:01:57 INFO - mozfile == 1.2 04:01:57 INFO - mozhttpd == 0.7 04:01:57 INFO - mozinfo == 0.9 04:01:57 INFO - mozleak == 0.1 04:01:57 INFO - mozlog == 3.1 04:01:57 INFO - moznetwork == 0.27 04:01:57 INFO - mozprocess == 0.22 04:01:57 INFO - mozprofile == 0.28 04:01:57 INFO - mozrunner == 6.11 04:01:57 INFO - mozscreenshot == 0.1 04:01:57 INFO - mozsystemmonitor == 0.0 04:01:57 INFO - moztest == 0.7 04:01:57 INFO - mozversion == 1.4 04:01:57 INFO - psutil == 3.1.1 04:01:57 INFO - requests == 1.2.3 04:01:57 INFO - wsgiref == 0.1.2 04:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:57 INFO - Using env: {'DISPLAY': ':0', 04:01:57 INFO - 'HOME': '/home/cltbld', 04:01:57 INFO - 'LANG': 'en_US.UTF-8', 04:01:57 INFO - 'LANGUAGE': 'en_US:en', 04:01:57 INFO - 'LOGNAME': 'cltbld', 04:01:57 INFO - 'MAIL': '/var/mail/cltbld', 04:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:57 INFO - 'MOZ_NO_REMOTE': '1', 04:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:57 INFO - 'NO_EM_RESTART': '1', 04:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:57 INFO - 'PWD': '/builds/slave/test', 04:01:57 INFO - 'SHELL': '/bin/bash', 04:01:57 INFO - 'SHLVL': '1', 04:01:57 INFO - 'TERM': 'linux', 04:01:57 INFO - 'TMOUT': '86400', 04:01:57 INFO - 'USER': 'cltbld', 04:01:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:57 INFO - '_': '/tools/buildbot/bin/python'} 04:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:01:58 INFO - Cleaning up... 04:01:58 INFO - Return code: 0 04:01:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:01:58 INFO - Using env: {'DISPLAY': ':0', 04:01:58 INFO - 'HOME': '/home/cltbld', 04:01:58 INFO - 'LANG': 'en_US.UTF-8', 04:01:58 INFO - 'LANGUAGE': 'en_US:en', 04:01:58 INFO - 'LOGNAME': 'cltbld', 04:01:58 INFO - 'MAIL': '/var/mail/cltbld', 04:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:58 INFO - 'MOZ_NO_REMOTE': '1', 04:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:58 INFO - 'NO_EM_RESTART': '1', 04:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:58 INFO - 'PWD': '/builds/slave/test', 04:01:58 INFO - 'SHELL': '/bin/bash', 04:01:58 INFO - 'SHLVL': '1', 04:01:58 INFO - 'TERM': 'linux', 04:01:58 INFO - 'TMOUT': '86400', 04:01:58 INFO - 'USER': 'cltbld', 04:01:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:58 INFO - '_': '/tools/buildbot/bin/python'} 04:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:58 INFO - Downloading/unpacking jsonschema 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:00 INFO - Downloading/unpacking functools32 (from jsonschema) 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:00 INFO - warning: no files found matching '*.txt' 04:02:00 INFO - no previously-included directories found matching 'build' 04:02:00 INFO - no previously-included directories found matching 'dist' 04:02:00 INFO - no previously-included directories found matching '.git*' 04:02:00 INFO - Installing collected packages: jsonschema, functools32 04:02:00 INFO - Running setup.py install for functools32 04:02:00 INFO - warning: no files found matching '*.txt' 04:02:00 INFO - no previously-included directories found matching 'build' 04:02:00 INFO - no previously-included directories found matching 'dist' 04:02:00 INFO - no previously-included directories found matching '.git*' 04:02:00 INFO - Successfully installed jsonschema functools32 04:02:00 INFO - Cleaning up... 04:02:00 INFO - Return code: 0 04:02:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312b0cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2103410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:02:00 INFO - Using env: {'DISPLAY': ':0', 04:02:00 INFO - 'HOME': '/home/cltbld', 04:02:00 INFO - 'LANG': 'en_US.UTF-8', 04:02:00 INFO - 'LANGUAGE': 'en_US:en', 04:02:00 INFO - 'LOGNAME': 'cltbld', 04:02:00 INFO - 'MAIL': '/var/mail/cltbld', 04:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:00 INFO - 'MOZ_NO_REMOTE': '1', 04:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:00 INFO - 'NO_EM_RESTART': '1', 04:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:00 INFO - 'PWD': '/builds/slave/test', 04:02:00 INFO - 'SHELL': '/bin/bash', 04:02:00 INFO - 'SHLVL': '1', 04:02:00 INFO - 'TERM': 'linux', 04:02:00 INFO - 'TMOUT': '86400', 04:02:00 INFO - 'USER': 'cltbld', 04:02:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:00 INFO - '_': '/tools/buildbot/bin/python'} 04:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:00 INFO - Downloading/unpacking flake8 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:03 INFO - no previously-included directories found matching 'docs/_build' 04:02:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:03 INFO - Running setup.py install for pep8 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:03 INFO - no previously-included directories found matching 'docs/_build' 04:02:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:03 INFO - Cleaning up... 04:02:03 INFO - Return code: 0 04:02:03 INFO - Running post-action listener: _resource_record_post_action 04:02:03 INFO - Running post-action listener: _start_resource_monitoring 04:02:03 INFO - Starting resource monitoring. 04:02:03 INFO - ##### 04:02:03 INFO - ##### Running install step. 04:02:03 INFO - ##### 04:02:03 INFO - Running pre-action listener: _resource_record_pre_action 04:02:03 INFO - Running main action method: install 04:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:03 INFO - Reading from file tmpfile_stdout 04:02:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:03 INFO - Reading from file tmpfile_stdout 04:02:03 INFO - Output received: 04:02:03 INFO - Usage: mozinstall [options] installer 04:02:03 INFO - Options: 04:02:03 INFO - -h, --help show this help message and exit 04:02:03 INFO - -d DEST, --destination=DEST 04:02:03 INFO - Directory to install application into. [default: 04:02:03 INFO - "/builds/slave/test"] 04:02:03 INFO - --app=APP Application being installed. [default: firefox] 04:02:03 INFO - mkdir: /builds/slave/test/build/application 04:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:02:19 INFO - Reading from file tmpfile_stdout 04:02:19 INFO - Output received: 04:02:19 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:19 INFO - Running post-action listener: _resource_record_post_action 04:02:19 INFO - ##### 04:02:19 INFO - ##### Running run-tests step. 04:02:19 INFO - ##### 04:02:19 INFO - Running pre-action listener: _resource_record_pre_action 04:02:19 INFO - Running main action method: run_tests 04:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:19 INFO - Python 2.7.3 04:02:19 INFO - Return code: 0 04:02:19 INFO - grabbing minidump binary from tooltool 04:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2192160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21934f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:02:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:02:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:19 INFO - Return code: 0 04:02:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:20 INFO - Return code: 0 04:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:02:20 INFO - Using env: {'DISPLAY': ':0', 04:02:20 INFO - 'HOME': '/home/cltbld', 04:02:20 INFO - 'LANG': 'en_US.UTF-8', 04:02:20 INFO - 'LANGUAGE': 'en_US:en', 04:02:20 INFO - 'LOGNAME': 'cltbld', 04:02:20 INFO - 'MAIL': '/var/mail/cltbld', 04:02:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:20 INFO - 'MOZ_NO_REMOTE': '1', 04:02:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:20 INFO - 'NO_EM_RESTART': '1', 04:02:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:20 INFO - 'PWD': '/builds/slave/test', 04:02:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:20 INFO - 'SHELL': '/bin/bash', 04:02:20 INFO - 'SHLVL': '1', 04:02:20 INFO - 'TERM': 'linux', 04:02:20 INFO - 'TMOUT': '86400', 04:02:20 INFO - 'USER': 'cltbld', 04:02:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306', 04:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:20 INFO - '_': '/tools/buildbot/bin/python'} 04:02:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:02:20 INFO - mozversion application_buildid: 20160315024234 04:02:20 INFO - mozversion application_changeset: 4adc4cef81179df18fe4e7e8463e4240aca3ae95 04:02:20 INFO - mozversion application_display_name: Nightly 04:02:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:20 INFO - mozversion application_name: Firefox 04:02:20 INFO - mozversion application_remotingname: firefox 04:02:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:02:20 INFO - mozversion application_vendor: Mozilla 04:02:20 INFO - mozversion application_version: 48.0a1 04:02:20 INFO - mozversion platform_buildid: 20160315024234 04:02:20 INFO - mozversion platform_changeset: 4adc4cef81179df18fe4e7e8463e4240aca3ae95 04:02:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:02:20 INFO - mozversion platform_version: 48.0a1 04:02:20 INFO - using testdate: 1458039740 04:02:20 INFO - actual date: 1458039740 04:02:20 INFO - starting webserver on 'localhost:36791' 04:02:20 INFO - SUITE-START | Running 2 tests 04:02:20 INFO - TEST-START | dromaeo_css 04:02:20 INFO - operating with platform_type : linux_ 04:02:20 INFO - Initialising browser for dromaeo_css test... 04:02:20 INFO - TEST-INFO | started process 770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9sedx7/profile http://localhost:36791/getInfo.html) 04:02:25 INFO - PROCESS | 770 | __metrics Screen width/height:1600/1200 04:02:25 INFO - PROCESS | 770 | colorDepth:24 04:02:25 INFO - PROCESS | 770 | Browser inner width/height: 1024/697 04:02:25 INFO - PROCESS | 770 | __metrics 04:02:25 ERROR - PROCESS | 770 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:26 INFO - PROCESS | 770 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:02:26 INFO - TEST-INFO | 770: exit 0 04:02:26 INFO - Browser initialized. 04:02:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:26 INFO - TEST-INFO | started process 869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9sedx7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:38 INFO - PROCESS | 869 | RSS: Main: 154750976 04:02:38 INFO - PROCESS | 869 | 04:03:29 INFO - PROCESS | 869 | 1458039809745 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:05:41 INFO - PROCESS | 869 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36791/tests/dromaeo/cssquery-ext.html) 04:05:42 INFO - PROCESS | 869 | RSS: Main: 242225152 04:05:42 INFO - PROCESS | 869 | 04:08:44 INFO - PROCESS | 869 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-ext.html (next: http://localhost:36791/tests/dromaeo/cssquery-jquery.html) 04:08:44 INFO - PROCESS | 869 | RSS: Main: 240254976 04:08:44 INFO - PROCESS | 869 | 04:11:46 INFO - PROCESS | 869 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36791/tests/dromaeo/cssquery-mootools.html) 04:11:47 INFO - PROCESS | 869 | RSS: Main: 237891584 04:11:47 INFO - PROCESS | 869 | 04:14:49 INFO - PROCESS | 869 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36791/tests/dromaeo/cssquery-prototype.html) 04:14:50 INFO - PROCESS | 869 | RSS: Main: 207560704 04:14:50 INFO - PROCESS | 869 | 04:17:52 INFO - PROCESS | 869 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36791/tests/dromaeo/cssquery-yui.html) 04:17:53 INFO - PROCESS | 869 | RSS: Main: 201469952 04:17:53 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-yui.html (next: http://localhost:36791/tests/dromaeo/cssquery-dojo.html) 04:20:56 INFO - PROCESS | 869 | RSS: Main: 291434496 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | __start_tp_report 04:20:56 INFO - PROCESS | 869 | _x_x_mozilla_page_load 04:20:56 INFO - PROCESS | 869 | _x_x_mozilla_page_load_details 04:20:56 INFO - PROCESS | 869 | |i|pagename|runs| 04:20:56 INFO - PROCESS | 869 | |0;dojo.html;2622.331305517093;2678.8526631035297;2679.772219361354;2693.946121077577;2716.7147449517806;4601.470830854452;4633.443986721594;4634.397528321313;4647.047355292166;4720.622350211984;4678.883027924304;4739.431268247807;4745.477997420281;4747.169245382053;4753.857384278468;4272.401863739064;4354.346847972805;4407.625351845081;4449.199144154051;4454;4196.853110141145;4354.542773008836;4413.911721765563;4427.003924117064;4433.490148632916;4272.50866150392;4331.740095594243;4344.847930322424;4345.73925564464;4370.606645401929;4304.160688665712;4304.827806887721;4324.82700691972;4350.8042138103865;4360.520342762294;4232.978835105836;4297.462817147856;4303.849365272232;4324.481062272547;4362.738235705868;4612.238980568202;4643.605293550052;4646.233371493699;4651.279051746951;4689.132510485571;5019.548240658358;5022.321986531808;5024.8492545223335;5024.949750502485;5025.14572522672;4903.411590609114;4993.226049962225;5034.345535080416;5065.088284108896;5082.491750824888;4691.507391723888;4703.412073490814;4703.529647035269;4705.552972467644;4714.740689262089;5128.589712822965;5167.483251674803;5169.638125331266;5173.146430838945;5215.478452154754;4829.517048295143;4906.656534042583;4927.236278376858;4988.376452943382;4989.800407983713;4999.850004499871;5002.199648056294;5015.598752099823;5023.1711767557945;5063.367079115111;4971.875703107379;4976.05454963563;4978;4982.800687972441;5022.372203474566;4851.636127290467;4874.658773885794;4967.5032496750755;4972.701637901738;4980.551750342486;4224.091820258659;4226.112516371596;4229.281022226168;4231.661467082626;4265.040365917644;3701.851925922987;3704.2221133562252;3715.6655900969045;3749.9062523436587;3750.718696097804;4279.679024073207;4308.052228509786;4335.501417337046;4337.175936572041;4375.606195442426;5004.049230646166;5027.547520723152;5031.018951304461;5035.093683136997;5070.7464626768515;4348.934765978513;4350.1734670412525;4351.238533256667;4389.31965545341;4395.252807022814;4474.239379305461;4505.954940450553;4506.369108324837;4562.475315338778;4566.429196350457;4725.834595789269;4730.361401210861;4744.928826067543;4749.097671442484;4799.472058073539;5016.874578135576;5036.345275114211;5048.141815891234;5056.57019153376;5098.439171691037;4666.1834179019215;4743.051389722001;4749.2876068589985;4805.13507568641;4822.397200349957;4942.530459606475;4955.603551715926;4971.676841005323;4975.477574854588;5019.698818070928;4927.9507204927495;5018.749062546931;5038.496150384932;5041.924371134509;5089.465606111453;4886.53577910098;4887.780049897692;4923.261510773413;4927.18701414277;4972.2790195422185;4850.345203397496;4870.926936095891;4874.317595536699;4880.46314905353;4927.408710954708;4729.834455794031;4781.52184781533;4815.109204797123;4831.95168048315;4881.536254055859;4854.247591623304;4873.805047798191;4903.901921961612;4909.0672772173175;4953.777080031336;4766.713997160182;4771.594414474808;4772.164871147465;4786.377770889762;4807.711537307773 04:20:56 INFO - PROCESS | 869 | |1;ext.html;499.22370713540454;534.6471328922911;538.5072658517457;541.8864233999133;554.2434576802665;27051.32371690709;35711.642883571156;36617.267654646894;36620.633793662026;36640.816795915984;38722;39536.023198840085;39564.60435395645;39640.20719585606;39670.20659586807;7444.8138796529975;7742.225777422269;8044.115147333789;8066.556339401331;9731.318807683465;9771.657991970282;9940.40357578544;9947;9949.104580587746;9952.303338766289;9984.251181161406;10061.245406594498;10081.747956301078;10086.596536138546;10089.041541053588;9883.999999999964;9974.850377244347;9976.351537150062;9980.652611897374;9984.301098923079;9739.220862331067;10208.846867296996;10210.897891021143;10214.693559193236;10221.33561318512;39521.20957580832;39950.40074398887;40058.399124013165;40061.59938400608;40062.39906401406;3193.6486986431705;3217.7104060634656;3220.91947701307;3262.1192278084786;3327.284633803744;30012.8499357504;30118.24704382386;30979.380412391853;31063.844680776678;31662.841685791424;3038.8784448622027;3044.5128779395413;3134.984325078383;3146.2291738523977;3228.322052369005;260779;261009;261294;261726;262427;60584.697076514334;60661.69669151626;60892.695536522035;61176.694116529135;61380;64967;65745.05529668235;66021.66989165024;66124.33875661278;67001;14568.49010284635;15044.247787610575;15163.924180379028;15186.696266074838;15191;10178.287519873538;10367.740806479747;10374.118199952938;12188.695282618006;12648.620541383772;20205.595888082156;20243.291484797963;20432.182712691327;20450.181992720423;20551.588968220552;7463.253674632602;7797.103333116765;7797.727079552188;7800.141984381714;7873;872.829798189347;881.4711173295971;905.3888625177979;966.9661561845302;1003.9046290602381;27300.726992730215;28211.43577128487;28892.566611500843;29036;29158.41683166325;982.6148916981075;1018.8166130096506;1030.5414090729703;1051.2536099369381;1075.0593230922943;14227.573172804832;14690.485832995793;14930.925345373204;15191.62020949463;15312.693746125238;295224;298733;298825;298831;299513;50262.49737502651;51041;51083.23375149376;51108.48891511037;51269;1069.909057730086;1180.1090176916546;1245.8504979402348;1245.993770031144;1273.9426725797362;26577;27375.726242737317;27945.860270698515;27998.86000569984;28224;39688.206235875696;40075.1984960305;40201.39697904592;40238.597614023485;40240.1951960965;213572;213648;214876;215211;215869;28741;32901.83549082239;32926.83536582302;33163.17092072718;33183.170420739676;37121.443178352885;37712.43431348477;37906.241875162894;38354.42468362921;38715.41926871043;31848.6815131855;32693.836530817192;32706;32899;33025.174370640925;31912.840435797672;32160.678393216705;32405;32462.837685812363;35342.82328588341;34067.318653627284;34682.82658586691;34860.65139348574;34984.47523287102;35065.29869402546;29911.850440747658;31214.687853121177;31243.640136475045;31500.369992600477;31579.684203157674;24206.51586968286;24330.87834560816;24349.513009739352;24727.134550290655;24728.629070563595 04:20:56 INFO - PROCESS | 869 | |2;jquery.html;358.1994242867193;363.6908627666483;364.6663303077684;366.4119088862376;370.1468115992636;15693.686126277482;15803.920980395096;17674.911625441888;17702.291908323685;17711.46865594031;16202.594935126628;16753.91623041886;16754.58113547162;16759.078250696206;16970.83029169708;4713.5993440557595;4914.655974081807;5129.102407078746;5140.897182056376;5144.56271216947;5079.111155547765;5093.516115968977;5100.897982040357;5106.69359838409;5125;4916.901661966758;4992.875178120558;5034.270030845543;5057.0897238497055;5085.466026067265;4997.250412438145;5013.423456302536;5026.2711906773675;5038.521340472667;5042.218456139304;4496.64026877849;4522.570355816192;4525.366448697185;4529.456465224194;4529.728216307032;19357.225710971543;19374.70937935932;19974.900125499425;19978.10098545569;20672.17311307546;2039.3881835449306;2092.1422216891156;2103.8001389867936;2112.0495776900457;2113.6301147299314;8756.4308319959;12628.368581570885;13218.933905330508;13550;13626.454941802316;1752.570620198047;1763.2506184871506;1796.2006906926422;1866.132248504452;1883.896385698786;51457;51954.22068668973;52736.47140518808;53274.73362633162;53829.73085134549;9894.752631184278;9994.150497207673;10059.39643621385;10245.180385569136;10471;12417;12453.501859925682;12506.374681266083;12533.749325013448;12547.623571292876;7054.329838665319;7145.1425828900865;7245.9275407246305;7322.414206863438;7344.779656610311;7168.068151140423;7191.352778249878;7264.309890560388;7341.192468828424;7352.77941661751;4116.485439320085;4150.27370210218;4181.372794080912;4207.095474473003;4495.955040449554;1750.8249175082644;1762.2598508626409;1768.6904791661407;1833.2858777043507;1835.220031486613;878.4334104502688;922.349743430893;951.6764300137986;968.8982656821073;974.9220062394992;16074.75887861683;16235.350585976665;16305.755413668567;16313.265903034391;17057;911.6763548940163;912.2792993535033;937.7749340158449;942.3121121581147;979.7410327728834;9321.254299656011;9568.712938611852;9638.42169469834;9669.274804389699;9798.902010979942;252542;255889;397772;403279;405329;46301;66982.33017669761;71799;72542.63728681323;73294.63352683309;892.5448021509077;984.2175470500969;993.2153598657125;1013.8428543575758;1014.0467960117466;12168.87831121713;14868.85131148718;15088;15096;15399.846001540289;31099.533506997865;31109;31504.369912602077;32220.19449513781;32939.341213176085;40785;41006.1798764029;41088.58911410967;41173;41557.58442415537;6998.895016574654;7066.328698773608;7109.537880037781;7238.167610724834;7312.561246325237;6025.969870150621;8469.61886715087;8470.407071504935;10678.718553773597;11259.324440533594;9509.714708558755;9688.12806847387;10267.806324208532;10601.522931468257;10929;8270.917290827014;8358.791030224293;9091.227245684191;9546.809063818824;9899.1585715215;8020.558869262247;9934.403935763878;10568;10717.35695858251;11021;7139.286071392819;7656.732014379692;7657.042869641295;7705.152433232228;7787.92212077872;9740.123388895034;10059.39643621385;10657.467126643482;10677.679669609925;10891.67324980252 04:20:56 INFO - PROCESS | 869 | |3;mootools.html;1269.2004037456402;1390.3673828408073;1401.5515035188741;1528.892977491576;1767.0634563681253;7318.34134927857;7449.292317229868;7469.514481558695;7474.252574742523;7475.51409158405;7280.708771649128;7397.889031664529;7415.962920185391;7440.330370266675;7458.067741532309;1924.5573518090848;1967.0951362373326;1967.2131147540954;2114.6722258050027;2154.719886414764;2188.835837312208;2248.730152381708;2252.155441709359;2252.9211477598287;2253.5830871288863;2192.210804110519;2197.747259065204;2206.095500844646;2208.039502816272;2277.3851060213733;2226.543558570489;2235.4523141830273;2236.0720301075035;2236.496788222645;2237.5413040326694;2175.8803265820375;2216.9224077157223;2228.5097278598682;2240.451089483087;2241.350008497534;7638.732644357421;7649.732259370895;7689.577073260968;7714.267144621252;7718.536887786695;4471.709338892994;4580.244259697146;4582.312653102028;4583.4041574595085;4584.633229341644;2952.5866378706996;2984.358362951954;3049.2072061264007;3062.9846850765825;3067.6932306769368;867.7136544940217;904.0552622509493;915.2677857713802;927.4667066436825;936.4568550240843;10275.48622568876;10285.331453455501;10298.3820970742;10298.7425314367;10310.742231444274;4169.833206671759;4347.978260108743;4352.455943007124;4354.782260886943;4359.694821362537;8835.823283534293;8845.69040083594;8876.334274929277;8883;8889.422187557788;4625.653076019312;4639.86080417588;4642.628589712815;4659.836905708284;4664.86005419838;3694.612065733113;4092.7339722917914;4181.038361176947;4188.895277618084;4200.7479551227025;3737.2151848111657;3791.75353602015;3793.241351729665;3825.158465137665;3856.5950575189763;1207.5954555223923;1221.0841868598552;1223.9632811015683;1224.2470880408484;1243.7947738623207;1150.1833698074295;1159.646307876106;1187.4715751490676;1192.5349113845607;1219.969500762488;7167.462440316997;7242.420606351479;7285.890711639329;7300.6349682515665;7345.522541034816;468.80778880658767;471.0907947661047;473.5524928942186;477.81365267545686;483.3957553058677;5627.690477023803;5688.886222275614;5691.943080569225;5693.82918512437;5726.627769194989;8822.558872056372;9031.232345250595;9151.95424022889;9189.218916392048;9228.676996305232;9010.684626038188;9023.413478124032;9073.274138068939;9088.681896133603;9136.862947055799;7214.891776623354;7262.96368518154;7349.963250183821;7413.110426748717;7437.665305061285;7361.9631901842295;7414.332710055905;7419.666115024945;7422.146453157956;7426.071741032371;8368.12134725845;8419.8737018946;8585.699500517452;8709;8736.475811451333;8562;8689.913100869164;8722.25860801839;8842.336824738042;8911.688090916787;6000.21997140369;6570.507211959027;6703.296153903965;6820.590764554143;6937.098177237129;7245.637718114179;7268.0914885639295;7268.127824661075;7301.780946571611;7308.744193953186;6417.197850268716;6484.092227088117;6537.1501704778075;6644.60132392058;6652.40128388428;6402.839929001812;6405.295417503978;6463.967680161569;6573.967130164318;6603.900941485786;7020.017197592239;7024.367806897404;7059.25877782846;7065.57606543609;7069.187043490065;6168.19813424252;6199.318075011655;6213.068039794067;6213.099100630293;6256.155419018556;6412.326705695835;6412.647304398303;6429.678516074271;6447.967760161169;6460.838479038061 04:20:56 INFO - PROCESS | 869 | |4;prototype.html;318.9473736833423;319.72982829509056;322.612864562525;325.38664617196577;329.2805220593006;5326.440723724011;5407.891842163154;5412.404635490103;5427.62006659534;5432.592555558334;5308.601854860891;5364.946350536494;5386.272853164822;5394.838154855351;5395.919061214085;3978.4231286463446;4111.48606424197;4202.054537729017;4219.11398606293;4230.132822771325;4204.684648651348;4209;4250.61744443;4258.53156152823;4259.16946195492;4198.895027624303;4206.663466922654;4223.535411104776;4226.1547690461875;4237.957620423803;3956.3274243378837;4100.815463304159;4182.874513764592;4225.640820530259;4241.2365774160635;3741.7754934703735;3744.775313481173;3745.138618117848;3745.176061266517;3750.4186851038135;5208.453112423179;5220.973895130538;5221.582273418117;5226.425093239779;5227.2159176123505;4864.756762161913;4874.4150701916;4883.218685010382;4883.706977581356;4886.584640305578;5662.292213473316;5668.093105103164;5672.34768001681;5675.574331925122;5680.091185410314;4087.0395457067566;4094.6487659072436;4095.28332541804;4097.09863829957;4103.9179216415805;5713.628614140068;5985.940140598582;6067.877442673075;6072.180255665517;6078.240219972504;4017.7589344639414;4063.553009168989;4068.2880495913096;4070.1656160487028;4078.857239996586;4123.175364927027;4124.91750164995;4133.2973394522405;4136.8138433770555;4137.358709400048;4750.881227969259;4751.358566593465;4757.858114052602;4765.618750499952;4769.332293478916;5693.060644993612;5700.486956173964;5704.486596206361;5706.28671416073;5706.857328566819;1435.2680133132178;1460.0290806613484;1461.7076584682893;1464.912105273687;1467.9633009174856;901.2159421303377;966.5070813884969;971.640493017588;974.7173319737196;990.094063931509;4907.141250281186;5006.07387633289;5012.398512178489;5019;5019.698818070928;5845.327787304429;5874.441928016917;5879.7060146993335;5881.088431293157;5882.911756323659;4991;5003.549680528697;5006.874828129253;5009.148444764399;5012.624053196025;3124.8125112492867;3160.620725512953;3167.619885613741;3190.218396492874;3191.473406887884;5570.5543556516195;5575.60970732053;5583.4137415571595;5589.720513974285;5591.9720401397735;5903.822885313448;6099.878002440015;6103.176071230416;6108.633481991006;6109.175261339751;5528.308961379827;5551.666899986014;5553.416891226525;5553.888922221614;5554.888902221933;5922.851928701644;5942.316633587193;5942.910856337245;5944.64332140073;5965.70171491415;5820.76716931318;5820.82537523875;5825.94174058271;5832.504237139721;5833.79581714638;5555;5558.305211848519;5563.499285064364;5613.270274864241;5623.409541998195;3941.172353805618;4060.675145988255;4063.756174629532;4064.674826013971;4067.9796601016806;5775.94224057754;5925.99258126111;5955.285365756137;5958.046712525975;5963.403659634176;5655.236543066798;5667.291588551431;5679.9148012779015;5680.488756011979;5683.8863222736145;5665.3201615806365;5669.574781891292;5677.51741102011;5680.204771331934;5680.318361796611;5481;5572.721363931706;5593;5595.8880822384135;5598.69207193592;5751.079827227791;5778.335491418541;5782.1615865698395;5784.248047753765;5791.420857914175;5634.971825141012;5636.239107720406;5636.802711905064;5637.746301416364;5645.322561292671 04:20:56 INFO - PROCESS | 869 | |5;yui.html;705.6260182103483;716.212166616722;737.0933751485672;745.247300226771;770.1912991359072;12107.818382724256;12868.871311286895;13024.088313818036;13106.606801795937;13164.275964821943;11654.883451165486;12351.629451116458;12403.255804651728;12491.812622810665;12494.687632809184;804.0632662947673;808.2039191396469;809.0089640190778;813.4427916876929;815.6411179081185;817.8037271054964;819.2053707903324;819.7622689420061;819.9057108432518;819.9508029518219;848.1433751910553;853.6414705823569;854.7734850264685;855.2174760094506;855.3114742632179;850.3834719828137;851.1233429567556;851.5997481183833;852;852.0584753847003;622.1041699952054;622.7664625765339;622.9688515574248;623.4544773323342;623.6133597169738;11873.109516786275;11883.465244063951;11980.34108124053;11986.64040078799;11992.100592455601;10334.483275836179;10427.791444171075;10593.788124237471;10750.892491075067;11010.174236932262;8691.608877600524;8781.165789250012;8951.910480895172;9076.22852057576;9167.77080572991;3024.5765592817024;3096.1598672080418;3098.5662007318992;3111.1444352802932;3171.762117841171;40893.38659920103;40912.181756365004;44446.11107777827;44715.329270060975;44928.77535612366;9491.525423728925;9555.187809036172;9876.753081172885;9973.800523989625;10232.59069637206;15646.061236325857;17082.572935676708;17183.914080429768;17715.29138834458;17817.376391826223;6952.930470695228;6974.37230649244;7027.227005029443;7054.118235220598;7055.2239253682055;3691.2802003609577;3704.499892514476;3790.6588407042946;3810.3903375459795;3825.8522443266907;2891.551809469536;2907.927301817429;2917.0957003328613;2921.956170657442;2922.722341377566;497.8083437876444;517.1880148167417;526.4603781124301;529.9947000530022;530.7319803499208;537.9838604841862;560.9971950140305;561.9438056194348;567.3447168520365;574.4714862326585;7986;8015.679372825021;8130.878036829452;8304.377171712145;8309.6676132954;570.2273419516579;595.7527626035147;597.4294548705975;598.1506261109236;602.197125154647;3701.7038636908983;3781.5840257571645;3824.4042429164588;3832.3868181090893;3844.4041173618134;54370;54986;55158.44841551613;55242.72378638161;55268.72365638146;48949.265761013616;49136.50863491391;49880.50119498831;50465;50527.49472505228;40620.593794062275;41090;41215.38176927349;41856;42345.364819527735;8754.430961987451;8811.779705507413;8813.515256660945;8923.598438070432;9000.86498702533;30121.397572048874;30173.245668858453;30879.536806948363;32124.83937580297;33705;38379.61620383872;38677.22645547017;39218.215635687695;41213.79393103015;41898.162036759706;10385.065344119066;10824.232853106058;10925.617603383844;11114.333140011626;11280.32318060919;11788.823167652663;11835.881641183478;11921.642350729491;11971.341576213044;12695.87304126947;10922.453877306261;10978.670639880816;11296.661100167008;11345.716357091138;11788.174827761974;11103.777924441305;11338.376389298668;11393.14551408631;11434.085273178292;11464.94267528657;11184.161187910777;11231.71920701989;11734.061275098142;11826.763464730486;11946.104042197045;9387.859182112137;9507.369009249805;9728.17310528613;9937.552810123707;10134.645287414905;9028.18746312835;9353.719388418358;9387.249020078514;9400;9496.097870702271 04:20:56 INFO - PROCESS | 869 | __end_tp_report 04:20:56 INFO - PROCESS | 869 | __start_cc_report 04:20:56 INFO - PROCESS | 869 | _x_x_mozilla_cycle_collect,828 04:20:56 INFO - PROCESS | 869 | __end_cc_report 04:20:56 INFO - PROCESS | 869 | __startTimestamp1458040856408__endTimestamp 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | ------- Summary: start ------- 04:20:56 INFO - PROCESS | 869 | Number of tests: 6 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | [#0] dojo.html Cycles:165 Average:4644.19 Median:4753.86 stddev:475.03 (10.0%) stddev-sans-first:449.23 04:20:56 INFO - PROCESS | 869 | Values: 2622.3 2678.9 2679.8 2693.9 2716.7 4601.5 4633.4 4634.4 4647.0 4720.6 4678.9 4739.4 4745.5 4747.2 4753.9 4272.4 4354.3 4407.6 4449.2 4454.0 4196.9 4354.5 4413.9 4427.0 4433.5 4272.5 4331.7 4344.8 4345.7 4370.6 4304.2 4304.8 4324.8 4350.8 4360.5 4233.0 4297.5 4303.8 4324.5 4362.7 4612.2 4643.6 4646.2 4651.3 4689.1 5019.5 5022.3 5024.8 5024.9 5025.1 4903.4 4993.2 5034.3 5065.1 5082.5 4691.5 4703.4 4703.5 4705.6 4714.7 5128.6 5167.5 5169.6 5173.1 5215.5 4829.5 4906.7 4927.2 4988.4 4989.8 4999.9 5002.2 5015.6 5023.2 5063.4 4971.9 4976.1 4978.0 4982.8 5022.4 4851.6 4874.7 4967.5 4972.7 4980.6 4224.1 4226.1 4229.3 4231.7 4265.0 3701.9 3704.2 3715.7 3749.9 3750.7 4279.7 4308.1 4335.5 4337.2 4375.6 5004.0 5027.5 5031.0 5035.1 5070.7 4348.9 4350.2 4351.2 4389.3 4395.3 4474.2 4506.0 4506.4 4562.5 4566.4 4725.8 4730.4 4744.9 4749.1 4799.5 5016.9 5036.3 5048.1 5056.6 5098.4 4666.2 4743.1 4749.3 4805.1 4822.4 4942.5 4955.6 4971.7 4975.5 5019.7 4928.0 5018.7 5038.5 5041.9 5089.5 4886.5 4887.8 4923.3 4927.2 4972.3 4850.3 4870.9 4874.3 4880.5 4927.4 4729.8 4781.5 4815.1 4832.0 4881.5 4854.2 4873.8 4903.9 4909.1 4953.8 4766.7 4771.6 4772.2 4786.4 4807.7 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | [#1] ext.html Cycles:180 Average:42957.65 Median:17816.66 stddev:67893.44 (381.1%) stddev-sans-first:68009.05 04:20:56 INFO - PROCESS | 869 | Values: 499.2 534.6 538.5 541.9 554.2 27051.3 35711.6 36617.3 36620.6 36640.8 38722.0 39536.0 39564.6 39640.2 39670.2 7444.8 7742.2 8044.1 8066.6 9731.3 9771.7 9940.4 9947.0 9949.1 9952.3 9984.3 10061.2 10081.7 10086.6 10089.0 9884.0 9974.9 9976.4 9980.7 9984.3 9739.2 10208.8 10210.9 10214.7 10221.3 39521.2 39950.4 40058.4 40061.6 40062.4 3193.6 3217.7 3220.9 3262.1 3327.3 30012.8 30118.2 30979.4 31063.8 31662.8 3038.9 3044.5 3135.0 3146.2 3228.3 260779.0 261009.0 261294.0 261726.0 262427.0 60584.7 60661.7 60892.7 61176.7 61380.0 64967.0 65745.1 66021.7 66124.3 67001.0 14568.5 15044.2 15163.9 15186.7 15191.0 10178.3 10367.7 10374.1 12188.7 12648.6 20205.6 20243.3 20432.2 20450.2 20551.6 7463.3 7797.1 7797.7 7800.1 7873.0 872.8 881.5 905.4 967.0 1003.9 27300.7 28211.4 28892.6 29036.0 29158.4 982.6 1018.8 1030.5 1051.3 1075.1 14227.6 14690.5 14930.9 15191.6 15312.7 295224.0 298733.0 298825.0 298831.0 299513.0 50262.5 51041.0 51083.2 51108.5 51269.0 1069.9 1180.1 1245.9 1246.0 1273.9 26577.0 27375.7 27945.9 27998.9 28224.0 39688.2 40075.2 40201.4 40238.6 40240.2 213572.0 213648.0 214876.0 215211.0 215869.0 28741.0 32901.8 32926.8 33163.2 33183.2 37121.4 37712.4 37906.2 38354.4 38715.4 31848.7 32693.8 32706.0 32899.0 33025.2 31912.8 32160.7 32405.0 32462.8 35342.8 34067.3 34682.8 34860.7 34984.5 35065.3 29911.9 31214.7 31243.6 31500.4 31579.7 24206.5 24330.9 24349.5 24727.1 24728.6 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | [#2] jquery.html Cycles:180 Average:21649.42 Median:4496.30 stddev:57596.98 (1281.0%) stddev-sans-first:57736.37 04:20:56 INFO - PROCESS | 869 | Values: 358.2 363.7 364.7 366.4 370.1 15693.7 15803.9 17674.9 17702.3 17711.5 16202.6 16753.9 16754.6 16759.1 16970.8 4713.6 4914.7 5129.1 5140.9 5144.6 5079.1 5093.5 5100.9 5106.7 5125.0 4916.9 4992.9 5034.3 5057.1 5085.5 4997.3 5013.4 5026.3 5038.5 5042.2 4496.6 4522.6 4525.4 4529.5 4529.7 19357.2 19374.7 19974.9 19978.1 20672.2 2039.4 2092.1 2103.8 2112.0 2113.6 8756.4 12628.4 13218.9 13550.0 13626.5 1752.6 1763.3 1796.2 1866.1 1883.9 51457.0 51954.2 52736.5 53274.7 53829.7 9894.8 9994.2 10059.4 10245.2 10471.0 12417.0 12453.5 12506.4 12533.7 12547.6 7054.3 7145.1 7245.9 7322.4 7344.8 7168.1 7191.4 7264.3 7341.2 7352.8 4116.5 4150.3 4181.4 4207.1 4496.0 1750.8 1762.3 1768.7 1833.3 1835.2 878.4 922.3 951.7 968.9 974.9 16074.8 16235.4 16305.8 16313.3 17057.0 911.7 912.3 937.8 942.3 979.7 9321.3 9568.7 9638.4 9669.3 9798.9 252542.0 255889.0 397772.0 403279.0 405329.0 46301.0 66982.3 71799.0 72542.6 73294.6 892.5 984.2 993.2 1013.8 1014.0 12168.9 14868.9 15088.0 15096.0 15399.8 31099.5 31109.0 31504.4 32220.2 32939.3 40785.0 41006.2 41088.6 41173.0 41557.6 6998.9 7066.3 7109.5 7238.2 7312.6 6026.0 8469.6 8470.4 10678.7 11259.3 9509.7 9688.1 10267.8 10601.5 10929.0 8270.9 8358.8 9091.2 9546.8 9899.2 8020.6 9934.4 10568.0 10717.4 11021.0 7139.3 7656.7 7657.0 7705.2 7787.9 9740.1 10059.4 10657.5 10677.7 10891.7 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | [#3] mootools.html Cycles:180 Average:5335.23 Median:6329.50 stddev:2797.15 (44.2%) stddev-sans-first:2788.30 04:20:56 INFO - PROCESS | 869 | Values: 1269.2 1390.4 1401.6 1528.9 1767.1 7318.3 7449.3 7469.5 7474.3 7475.5 7280.7 7397.9 7416.0 7440.3 7458.1 1924.6 1967.1 1967.2 2114.7 2154.7 2188.8 2248.7 2252.2 2252.9 2253.6 2192.2 2197.7 2206.1 2208.0 2277.4 2226.5 2235.5 2236.1 2236.5 2237.5 2175.9 2216.9 2228.5 2240.5 2241.4 7638.7 7649.7 7689.6 7714.3 7718.5 4471.7 4580.2 4582.3 4583.4 4584.6 2952.6 2984.4 3049.2 3063.0 3067.7 867.7 904.1 915.3 927.5 936.5 10275.5 10285.3 10298.4 10298.7 10310.7 4169.8 4348.0 4352.5 4354.8 4359.7 8835.8 8845.7 8876.3 8883.0 8889.4 4625.7 4639.9 4642.6 4659.8 4664.9 3694.6 4092.7 4181.0 4188.9 4200.7 3737.2 3791.8 3793.2 3825.2 3856.6 1207.6 1221.1 1224.0 1224.2 1243.8 1150.2 1159.6 1187.5 1192.5 1220.0 7167.5 7242.4 7285.9 7300.6 7345.5 468.8 471.1 473.6 477.8 483.4 5627.7 5688.9 5691.9 5693.8 5726.6 8822.6 9031.2 9152.0 9189.2 9228.7 9010.7 9023.4 9073.3 9088.7 9136.9 7214.9 7263.0 7350.0 7413.1 7437.7 7362.0 7414.3 7419.7 7422.1 7426.1 8368.1 8419.9 8585.7 8709.0 8736.5 8562.0 8689.9 8722.3 8842.3 8911.7 6000.2 6570.5 6703.3 6820.6 6937.1 7245.6 7268.1 7268.1 7301.8 7308.7 6417.2 6484.1 6537.2 6644.6 6652.4 6402.8 6405.3 6464.0 6574.0 6603.9 7020.0 7024.4 7059.3 7065.6 7069.2 6168.2 6199.3 6213.1 6213.1 6256.2 6412.3 6412.6 6429.7 6448.0 6460.8 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | [#4] prototype.html Cycles:180 Average:4732.76 Median:5401.91 stddev:1388.89 (25.7%) stddev-sans-first:1352.70 04:20:56 INFO - PROCESS | 869 | Values: 318.9 319.7 322.6 325.4 329.3 5326.4 5407.9 5412.4 5427.6 5432.6 5308.6 5364.9 5386.3 5394.8 5395.9 3978.4 4111.5 4202.1 4219.1 4230.1 4204.7 4209.0 4250.6 4258.5 4259.2 4198.9 4206.7 4223.5 4226.2 4238.0 3956.3 4100.8 4182.9 4225.6 4241.2 3741.8 3744.8 3745.1 3745.2 3750.4 5208.5 5221.0 5221.6 5226.4 5227.2 4864.8 4874.4 4883.2 4883.7 4886.6 5662.3 5668.1 5672.3 5675.6 5680.1 4087.0 4094.6 4095.3 4097.1 4103.9 5713.6 5985.9 6067.9 6072.2 6078.2 4017.8 4063.6 4068.3 4070.2 4078.9 4123.2 4124.9 4133.3 4136.8 4137.4 4750.9 4751.4 4757.9 4765.6 4769.3 5693.1 5700.5 5704.5 5706.3 5706.9 1435.3 1460.0 1461.7 1464.9 1468.0 901.2 966.5 971.6 974.7 990.1 4907.1 5006.1 5012.4 5019.0 5019.7 5845.3 5874.4 5879.7 5881.1 5882.9 4991.0 5003.5 5006.9 5009.1 5012.6 3124.8 3160.6 3167.6 3190.2 3191.5 5570.6 5575.6 5583.4 5589.7 5592.0 5903.8 6099.9 6103.2 6108.6 6109.2 5528.3 5551.7 5553.4 5553.9 5554.9 5922.9 5942.3 5942.9 5944.6 5965.7 5820.8 5820.8 5825.9 5832.5 5833.8 5555.0 5558.3 5563.5 5613.3 5623.4 3941.2 4060.7 4063.8 4064.7 4068.0 5775.9 5926.0 5955.3 5958.0 5963.4 5655.2 5667.3 5679.9 5680.5 5683.9 5665.3 5669.6 5677.5 5680.2 5680.3 5481.0 5572.7 5593.0 5595.9 5598.7 5751.1 5778.3 5782.2 5784.2 5791.4 5635.0 5636.2 5636.8 5637.7 5645.3 04:20:56 INFO - PROCESS | 869 | 04:20:56 INFO - PROCESS | 869 | [#5] yui.html Cycles:180 Average:12900.28 Median:44822.05 stddev:14762.03 (32.9%) stddev-sans-first:14775.03 04:20:56 INFO - PROCESS | 869 | Values: 705.6 716.2 737.1 745.2 770.2 12107.8 12868.9 13024.1 13106.6 13164.3 11654.9 12351.6 12403.3 12491.8 12494.7 804.1 808.2 809.0 813.4 815.6 817.8 819.2 819.8 819.9 820.0 848.1 853.6 854.8 855.2 855.3 850.4 851.1 851.6 852.0 852.1 622.1 622.8 623.0 623.5 623.6 11873.1 11883.5 11980.3 11986.6 11992.1 10334.5 10427.8 10593.8 10750.9 11010.2 8691.6 8781.2 8951.9 9076.2 9167.8 3024.6 3096.2 3098.6 3111.1 3171.8 40893.4 40912.2 44446.1 44715.3 44928.8 9491.5 9555.2 9876.8 9973.8 10232.6 15646.1 17082.6 17183.9 17715.3 17817.4 6952.9 6974.4 7027.2 7054.1 7055.2 3691.3 3704.5 3790.7 3810.4 3825.9 2891.6 2907.9 2917.1 2922.0 2922.7 497.8 517.2 526.5 530.0 530.7 538.0 561.0 561.9 567.3 574.5 7986.0 8015.7 8130.9 8304.4 8309.7 570.2 595.8 597.4 598.2 602.2 3701.7 3781.6 3824.4 3832.4 3844.4 54370.0 54986.0 55158.4 55242.7 55268.7 48949.3 49136.5 49880.5 50465.0 50527.5 40620.6 41090.0 41215.4 41856.0 42345.4 8754.4 8811.8 8813.5 8923.6 9000.9 30121.4 30173.2 30879.5 32124.8 33705.0 38379.6 38677.2 39218.2 41213.8 41898.2 10385.1 10824.2 10925.6 11114.3 11280.3 11788.8 11835.9 11921.6 11971.3 12695.9 10922.5 10978.7 11296.7 11345.7 11788.2 11103.8 11338.4 11393.1 11434.1 11464.9 11184.2 11231.7 11734.1 11826.8 11946.1 9387.9 9507.4 9728.2 9937.6 10134.6 9028.2 9353.7 9387.2 9400.0 9496.1 04:20:56 INFO - PROCESS | 869 | -------- Summary: end -------- 04:20:56 INFO - PROCESS | 869 | 04:20:57 INFO - TEST-INFO | 869: exit 0 04:20:57 INFO - TEST-OK | dromaeo_css | took 1116401ms 04:20:57 INFO - TEST-START | kraken 04:20:57 INFO - operating with platform_type : linux_ 04:20:57 INFO - Initialising browser for kraken test... 04:20:57 INFO - TEST-INFO | started process 1054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2kwAId/profile http://localhost:36791/getInfo.html) 04:21:01 INFO - PROCESS | 1054 | __metrics Screen width/height:1600/1200 04:21:01 INFO - PROCESS | 1054 | colorDepth:24 04:21:01 INFO - PROCESS | 1054 | Browser inner width/height: 1024/697 04:21:01 INFO - PROCESS | 1054 | __metrics 04:21:02 ERROR - PROCESS | 1054 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:21:03 INFO - TEST-INFO | 1054: exit 0 04:21:03 INFO - Browser initialized. 04:21:03 INFO - Running cycle 1/1 for kraken test... 04:21:03 INFO - TEST-INFO | started process 1147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2kwAId/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:15 INFO - PROCESS | 1147 | RSS: Main: 154779648 04:21:15 INFO - PROCESS | 1147 | 04:21:17 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:18 INFO - PROCESS | 1147 | RSS: Main: 194801664 04:21:18 INFO - PROCESS | 1147 | 04:21:20 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-dft) 04:21:21 INFO - PROCESS | 1147 | RSS: Main: 185016320 04:21:21 INFO - PROCESS | 1147 | 04:21:27 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-fft) 04:21:27 INFO - PROCESS | 1147 | RSS: Main: 172187648 04:21:27 INFO - PROCESS | 1147 | 04:21:29 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-oscillator) 04:21:30 INFO - PROCESS | 1147 | RSS: Main: 176697344 04:21:30 INFO - PROCESS | 1147 | 04:21:32 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:33 INFO - PROCESS | 1147 | RSS: Main: 175603712 04:21:33 INFO - PROCESS | 1147 | 04:21:36 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36791/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:36 INFO - PROCESS | 1147 | RSS: Main: 176574464 04:21:36 INFO - PROCESS | 1147 | 04:21:40 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36791/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:41 INFO - PROCESS | 1147 | RSS: Main: 174112768 04:21:41 INFO - PROCESS | 1147 | 04:21:44 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36791/tests/kraken/driver.html?testName=json-parse-financial) 04:21:44 INFO - PROCESS | 1147 | RSS: Main: 174891008 04:21:44 INFO - PROCESS | 1147 | 04:21:46 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:47 INFO - PROCESS | 1147 | RSS: Main: 188276736 04:21:47 INFO - PROCESS | 1147 | 04:21:48 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:49 INFO - PROCESS | 1147 | RSS: Main: 187215872 04:21:49 INFO - PROCESS | 1147 | 04:21:51 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:52 INFO - PROCESS | 1147 | RSS: Main: 195072000 04:21:52 INFO - PROCESS | 1147 | 04:21:54 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:55 INFO - PROCESS | 1147 | RSS: Main: 200744960 04:21:55 INFO - PROCESS | 1147 | 04:21:57 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:58 INFO - PROCESS | 1147 | RSS: Main: 199630848 04:21:58 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36791/tests/kraken/driver.html?testName=ai-astar) 04:22:00 INFO - PROCESS | 1147 | RSS: Main: 259383296 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | __start_tp_report 04:22:00 INFO - PROCESS | 1147 | _x_x_mozilla_page_load 04:22:00 INFO - PROCESS | 1147 | _x_x_mozilla_page_load_details 04:22:00 INFO - PROCESS | 1147 | |i|pagename|runs| 04:22:00 INFO - PROCESS | 1147 | |0;ai-astar;111;112;107;113;113;113;101;111;111;113 04:22:00 INFO - PROCESS | 1147 | |1;audio-beat-detection;157;134;158;182;134;158;152;141;181;130 04:22:00 INFO - PROCESS | 1147 | |2;audio-dft;385;384;385;384;386;385;385;384;383;383 04:22:00 INFO - PROCESS | 1147 | |3;audio-fft;75;75;75;157;75;76;77;76;151;76 04:22:00 INFO - PROCESS | 1147 | |4;audio-oscillator;94;93;146;94;94;94;152;94;94;139 04:22:00 INFO - PROCESS | 1147 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 04:22:00 INFO - PROCESS | 1147 | |6;imaging-darkroom;193;193;193;193;194;193;193;193;193;193 04:22:00 INFO - PROCESS | 1147 | |7;imaging-desaturate;95;96;95;95;95;95;96;96;95;96 04:22:00 INFO - PROCESS | 1147 | |8;json-parse-financial;64;65;65;65;65;64;64;64;64;65 04:22:00 INFO - PROCESS | 1147 | |9;json-stringify-tinderbox;63;63;63;63;65;64;64;65;65;64 04:22:00 INFO - PROCESS | 1147 | |10;stanford-crypto-aes;81;81;82;82;81;82;82;81;94;87 04:22:00 INFO - PROCESS | 1147 | |11;stanford-crypto-ccm;125;115;114;115;116;116;117;115;117;116 04:22:00 INFO - PROCESS | 1147 | |12;stanford-crypto-pbkdf2;138;139;137;137;136;138;141;137;140;142 04:22:00 INFO - PROCESS | 1147 | |13;stanford-crypto-sha256-iterative;66;68;69;68;68;66;66;67;67;64 04:22:00 INFO - PROCESS | 1147 | __end_tp_report 04:22:00 INFO - PROCESS | 1147 | __start_cc_report 04:22:00 INFO - PROCESS | 1147 | _x_x_mozilla_cycle_collect,1092 04:22:00 INFO - PROCESS | 1147 | __end_cc_report 04:22:00 INFO - PROCESS | 1147 | __startTimestamp1458040920385__endTimestamp 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | ------- Summary: start ------- 04:22:00 INFO - PROCESS | 1147 | Number of tests: 14 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.50 stddev:3.81 (3.4%) stddev-sans-first:4.03 04:22:00 INFO - PROCESS | 1147 | Values: 111.0 112.0 107.0 113.0 113.0 113.0 101.0 111.0 111.0 113.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:157.50 stddev:18.52 (11.8%) stddev-sans-first:19.58 04:22:00 INFO - PROCESS | 1147 | Values: 157.0 134.0 158.0 182.0 134.0 158.0 152.0 141.0 181.0 130.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#2] audio-dft Cycles:10 Average:384.40 Median:385.00 stddev:0.97 (0.3%) stddev-sans-first:1.00 04:22:00 INFO - PROCESS | 1147 | Values: 385.0 384.0 385.0 384.0 386.0 385.0 385.0 384.0 383.0 383.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#3] audio-fft Cycles:10 Average:91.30 Median:75.50 stddev:33.08 (43.8%) stddev-sans-first:34.56 04:22:00 INFO - PROCESS | 1147 | Values: 75.0 75.0 75.0 157.0 75.0 76.0 77.0 76.0 151.0 76.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.00 stddev:25.22 (26.8%) stddev-sans-first:26.12 04:22:00 INFO - PROCESS | 1147 | Values: 94.0 93.0 146.0 94.0 94.0 94.0 152.0 94.0 94.0 139.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:22:00 INFO - PROCESS | 1147 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#6] imaging-darkroom Cycles:10 Average:193.10 Median:193.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:22:00 INFO - PROCESS | 1147 | Values: 193.0 193.0 193.0 193.0 194.0 193.0 193.0 193.0 193.0 193.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:22:00 INFO - PROCESS | 1147 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:22:00 INFO - PROCESS | 1147 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 64.0 64.0 64.0 65.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 04:22:00 INFO - PROCESS | 1147 | Values: 63.0 63.0 63.0 63.0 65.0 64.0 64.0 65.0 65.0 64.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:4.16 (5.1%) stddev-sans-first:4.33 04:22:00 INFO - PROCESS | 1147 | Values: 81.0 81.0 82.0 82.0 81.0 82.0 82.0 81.0 94.0 87.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:116.00 stddev:3.10 (2.7%) stddev-sans-first:1.00 04:22:00 INFO - PROCESS | 1147 | Values: 125.0 115.0 114.0 115.0 116.0 116.0 117.0 115.0 117.0 116.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:138.50 stddev:1.96 (1.4%) stddev-sans-first:2.07 04:22:00 INFO - PROCESS | 1147 | Values: 138.0 139.0 137.0 137.0 136.0 138.0 141.0 137.0 140.0 142.0 04:22:00 INFO - PROCESS | 1147 | 04:22:00 INFO - PROCESS | 1147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.45 (2.1%) stddev-sans-first:1.50 04:22:00 INFO - PROCESS | 1147 | Values: 66.0 68.0 69.0 68.0 68.0 66.0 66.0 67.0 67.0 64.0 04:22:00 INFO - PROCESS | 1147 | -------- Summary: end -------- 04:22:00 INFO - PROCESS | 1147 | 04:22:01 INFO - TEST-INFO | 1147: exit 0 04:22:01 INFO - TEST-OK | kraken | took 64232ms 04:22:01 INFO - SUITE-END | took 1180s 04:22:01 INFO - Completed test suite (00:19:40) 04:22:01 INFO - javascript benchmark 04:22:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.331305517093, 2678.8526631035297, 2679.772219361354, 2693.946121077577, 2716.7147449517806, 4601.470830854452, 4633.443986721594, 4634.397528321313, 4647.047355292166, 4720.622350211984, 4678.883027924304, 4739.431268247807, 4745.477997420281, 4747.169245382053, 4753.857384278468, 4272.401863739064, 4354.346847972805, 4407.625351845081, 4449.199144154051, 4454.0, 4196.853110141145, 4354.542773008836, 4413.911721765563, 4427.003924117064, 4433.490148632916, 4272.50866150392, 4331.740095594243, 4344.847930322424, 4345.73925564464, 4370.606645401929, 4304.160688665712, 4304.827806887721, 4324.82700691972, 4350.8042138103865, 4360.520342762294, 4232.978835105836, 4297.462817147856, 4303.849365272232, 4324.481062272547, 4362.738235705868, 4612.238980568202, 4643.605293550052, 4646.233371493699, 4651.279051746951, 4689.132510485571, 5019.548240658358, 5022.321986531808, 5024.8492545223335, 5024.949750502485, 5025.14572522672, 4903.411590609114, 4993.226049962225, 5034.345535080416, 5065.088284108896, 5082.491750824888, 4691.507391723888, 4703.412073490814, 4703.529647035269, 4705.552972467644, 4714.740689262089, 5128.589712822965, 5167.483251674803, 5169.638125331266, 5173.146430838945, 5215.478452154754, 4829.517048295143, 4906.656534042583, 4927.236278376858, 4988.376452943382, 4989.800407983713, 4999.850004499871, 5002.199648056294, 5015.598752099823, 5023.1711767557945, 5063.367079115111, 4971.875703107379, 4976.05454963563, 4978.0, 4982.800687972441, 5022.372203474566, 4851.636127290467, 4874.658773885794, 4967.5032496750755, 4972.701637901738, 4980.551750342486, 4224.091820258659, 4226.112516371596, 4229.281022226168, 4231.661467082626, 4265.040365917644, 3701.851925922987, 3704.2221133562252, 3715.6655900969045, 3749.9062523436587, 3750.718696097804, 4279.679024073207, 4308.052228509786, 4335.501417337046, 4337.175936572041, 4375.606195442426, 5004.049230646166, 5027.547520723152, 5031.018951304461, 5035.093683136997, 5070.7464626768515, 4348.934765978513, 4350.1734670412525, 4351.238533256667, 4389.31965545341, 4395.252807022814, 4474.239379305461, 4505.954940450553, 4506.369108324837, 4562.475315338778, 4566.429196350457, 4725.834595789269, 4730.361401210861, 4744.928826067543, 4749.097671442484, 4799.472058073539, 5016.874578135576, 5036.345275114211, 5048.141815891234, 5056.57019153376, 5098.439171691037, 4666.1834179019215, 4743.051389722001, 4749.2876068589985, 4805.13507568641, 4822.397200349957, 4942.530459606475, 4955.603551715926, 4971.676841005323, 4975.477574854588, 5019.698818070928, 4927.9507204927495, 5018.749062546931, 5038.496150384932, 5041.924371134509, 5089.465606111453, 4886.53577910098, 4887.780049897692, 4923.261510773413, 4927.18701414277, 4972.2790195422185, 4850.345203397496, 4870.926936095891, 4874.317595536699, 4880.46314905353, 4927.408710954708, 4729.834455794031, 4781.52184781533, 4815.109204797123, 4831.95168048315, 4881.536254055859, 4854.247591623304, 4873.805047798191, 4903.901921961612, 4909.0672772173175, 4953.777080031336, 4766.713997160182, 4771.594414474808, 4772.164871147465, 4786.377770889762, 4807.711537307773], "unit": "score", "name": "dojo.html", "value": 4614.755020471479}, {"lowerIsBetter": false, "replicates": [499.22370713540454, 534.6471328922911, 538.5072658517457, 541.8864233999133, 554.2434576802665, 27051.32371690709, 35711.642883571156, 36617.267654646894, 36620.633793662026, 36640.816795915984, 38722.0, 39536.023198840085, 39564.60435395645, 39640.20719585606, 39670.20659586807, 7444.8138796529975, 7742.225777422269, 8044.115147333789, 8066.556339401331, 9731.318807683465, 9771.657991970282, 9940.40357578544, 9947.0, 9949.104580587746, 9952.303338766289, 9984.251181161406, 10061.245406594498, 10081.747956301078, 10086.596536138546, 10089.041541053588, 9883.999999999964, 9974.850377244347, 9976.351537150062, 9980.652611897374, 9984.301098923079, 9739.220862331067, 10208.846867296996, 10210.897891021143, 10214.693559193236, 10221.33561318512, 39521.20957580832, 39950.40074398887, 40058.399124013165, 40061.59938400608, 40062.39906401406, 3193.6486986431705, 3217.7104060634656, 3220.91947701307, 3262.1192278084786, 3327.284633803744, 30012.8499357504, 30118.24704382386, 30979.380412391853, 31063.844680776678, 31662.841685791424, 3038.8784448622027, 3044.5128779395413, 3134.984325078383, 3146.2291738523977, 3228.322052369005, 260779.0, 261009.0, 261294.0, 261726.0, 262427.0, 60584.697076514334, 60661.69669151626, 60892.695536522035, 61176.694116529135, 61380.0, 64967.0, 65745.05529668235, 66021.66989165024, 66124.33875661278, 67001.0, 14568.49010284635, 15044.247787610575, 15163.924180379028, 15186.696266074838, 15191.0, 10178.287519873538, 10367.740806479747, 10374.118199952938, 12188.695282618006, 12648.620541383772, 20205.595888082156, 20243.291484797963, 20432.182712691327, 20450.181992720423, 20551.588968220552, 7463.253674632602, 7797.103333116765, 7797.727079552188, 7800.141984381714, 7873.0, 872.829798189347, 881.4711173295971, 905.3888625177979, 966.9661561845302, 1003.9046290602381, 27300.726992730215, 28211.43577128487, 28892.566611500843, 29036.0, 29158.41683166325, 982.6148916981075, 1018.8166130096506, 1030.5414090729703, 1051.2536099369381, 1075.0593230922943, 14227.573172804832, 14690.485832995793, 14930.925345373204, 15191.62020949463, 15312.693746125238, 295224.0, 298733.0, 298825.0, 298831.0, 299513.0, 50262.49737502651, 51041.0, 51083.23375149376, 51108.48891511037, 51269.0, 1069.909057730086, 1180.1090176916546, 1245.8504979402348, 1245.993770031144, 1273.9426725797362, 26577.0, 27375.726242737317, 27945.860270698515, 27998.86000569984, 28224.0, 39688.206235875696, 40075.1984960305, 40201.39697904592, 40238.597614023485, 40240.1951960965, 213572.0, 213648.0, 214876.0, 215211.0, 215869.0, 28741.0, 32901.83549082239, 32926.83536582302, 33163.17092072718, 33183.170420739676, 37121.443178352885, 37712.43431348477, 37906.241875162894, 38354.42468362921, 38715.41926871043, 31848.6815131855, 32693.836530817192, 32706.0, 32899.0, 33025.174370640925, 31912.840435797672, 32160.678393216705, 32405.0, 32462.837685812363, 35342.82328588341, 34067.318653627284, 34682.82658586691, 34860.65139348574, 34984.47523287102, 35065.29869402546, 29911.850440747658, 31214.687853121177, 31243.640136475045, 31500.369992600477, 31579.684203157674, 24206.51586968286, 24330.87834560816, 24349.513009739352, 24727.134550290655, 24728.629070563595], "unit": "score", "name": "ext.html", "value": 17900.651574521456}, {"lowerIsBetter": false, "replicates": [358.1994242867193, 363.6908627666483, 364.6663303077684, 366.4119088862376, 370.1468115992636, 15693.686126277482, 15803.920980395096, 17674.911625441888, 17702.291908323685, 17711.46865594031, 16202.594935126628, 16753.91623041886, 16754.58113547162, 16759.078250696206, 16970.83029169708, 4713.5993440557595, 4914.655974081807, 5129.102407078746, 5140.897182056376, 5144.56271216947, 5079.111155547765, 5093.516115968977, 5100.897982040357, 5106.69359838409, 5125.0, 4916.901661966758, 4992.875178120558, 5034.270030845543, 5057.0897238497055, 5085.466026067265, 4997.250412438145, 5013.423456302536, 5026.2711906773675, 5038.521340472667, 5042.218456139304, 4496.64026877849, 4522.570355816192, 4525.366448697185, 4529.456465224194, 4529.728216307032, 19357.225710971543, 19374.70937935932, 19974.900125499425, 19978.10098545569, 20672.17311307546, 2039.3881835449306, 2092.1422216891156, 2103.8001389867936, 2112.0495776900457, 2113.6301147299314, 8756.4308319959, 12628.368581570885, 13218.933905330508, 13550.0, 13626.454941802316, 1752.570620198047, 1763.2506184871506, 1796.2006906926422, 1866.132248504452, 1883.896385698786, 51457.0, 51954.22068668973, 52736.47140518808, 53274.73362633162, 53829.73085134549, 9894.752631184278, 9994.150497207673, 10059.39643621385, 10245.180385569136, 10471.0, 12417.0, 12453.501859925682, 12506.374681266083, 12533.749325013448, 12547.623571292876, 7054.329838665319, 7145.1425828900865, 7245.9275407246305, 7322.414206863438, 7344.779656610311, 7168.068151140423, 7191.352778249878, 7264.309890560388, 7341.192468828424, 7352.77941661751, 4116.485439320085, 4150.27370210218, 4181.372794080912, 4207.095474473003, 4495.955040449554, 1750.8249175082644, 1762.2598508626409, 1768.6904791661407, 1833.2858777043507, 1835.220031486613, 878.4334104502688, 922.349743430893, 951.6764300137986, 968.8982656821073, 974.9220062394992, 16074.75887861683, 16235.350585976665, 16305.755413668567, 16313.265903034391, 17057.0, 911.6763548940163, 912.2792993535033, 937.7749340158449, 942.3121121581147, 979.7410327728834, 9321.254299656011, 9568.712938611852, 9638.42169469834, 9669.274804389699, 9798.902010979942, 252542.0, 255889.0, 397772.0, 403279.0, 405329.0, 46301.0, 66982.33017669761, 71799.0, 72542.63728681323, 73294.63352683309, 892.5448021509077, 984.2175470500969, 993.2153598657125, 1013.8428543575758, 1014.0467960117466, 12168.87831121713, 14868.85131148718, 15088.0, 15096.0, 15399.846001540289, 31099.533506997865, 31109.0, 31504.369912602077, 32220.19449513781, 32939.341213176085, 40785.0, 41006.1798764029, 41088.58911410967, 41173.0, 41557.58442415537, 6998.895016574654, 7066.328698773608, 7109.537880037781, 7238.167610724834, 7312.561246325237, 6025.969870150621, 8469.61886715087, 8470.407071504935, 10678.718553773597, 11259.324440533594, 9509.714708558755, 9688.12806847387, 10267.806324208532, 10601.522931468257, 10929.0, 8270.917290827014, 8358.791030224293, 9091.227245684191, 9546.809063818824, 9899.1585715215, 8020.558869262247, 9934.403935763878, 10568.0, 10717.35695858251, 11021.0, 7139.286071392819, 7656.732014379692, 7657.042869641295, 7705.152433232228, 7787.92212077872, 9740.123388895034, 10059.39643621385, 10657.467126643482, 10677.679669609925, 10891.67324980252], "unit": "score", "name": "jquery.html", "value": 7897.2864730806605}, {"lowerIsBetter": false, "replicates": [1269.2004037456402, 1390.3673828408073, 1401.5515035188741, 1528.892977491576, 1767.0634563681253, 7318.34134927857, 7449.292317229868, 7469.514481558695, 7474.252574742523, 7475.51409158405, 7280.708771649128, 7397.889031664529, 7415.962920185391, 7440.330370266675, 7458.067741532309, 1924.5573518090848, 1967.0951362373326, 1967.2131147540954, 2114.6722258050027, 2154.719886414764, 2188.835837312208, 2248.730152381708, 2252.155441709359, 2252.9211477598287, 2253.5830871288863, 2192.210804110519, 2197.747259065204, 2206.095500844646, 2208.039502816272, 2277.3851060213733, 2226.543558570489, 2235.4523141830273, 2236.0720301075035, 2236.496788222645, 2237.5413040326694, 2175.8803265820375, 2216.9224077157223, 2228.5097278598682, 2240.451089483087, 2241.350008497534, 7638.732644357421, 7649.732259370895, 7689.577073260968, 7714.267144621252, 7718.536887786695, 4471.709338892994, 4580.244259697146, 4582.312653102028, 4583.4041574595085, 4584.633229341644, 2952.5866378706996, 2984.358362951954, 3049.2072061264007, 3062.9846850765825, 3067.6932306769368, 867.7136544940217, 904.0552622509493, 915.2677857713802, 927.4667066436825, 936.4568550240843, 10275.48622568876, 10285.331453455501, 10298.3820970742, 10298.7425314367, 10310.742231444274, 4169.833206671759, 4347.978260108743, 4352.455943007124, 4354.782260886943, 4359.694821362537, 8835.823283534293, 8845.69040083594, 8876.334274929277, 8883.0, 8889.422187557788, 4625.653076019312, 4639.86080417588, 4642.628589712815, 4659.836905708284, 4664.86005419838, 3694.612065733113, 4092.7339722917914, 4181.038361176947, 4188.895277618084, 4200.7479551227025, 3737.2151848111657, 3791.75353602015, 3793.241351729665, 3825.158465137665, 3856.5950575189763, 1207.5954555223923, 1221.0841868598552, 1223.9632811015683, 1224.2470880408484, 1243.7947738623207, 1150.1833698074295, 1159.646307876106, 1187.4715751490676, 1192.5349113845607, 1219.969500762488, 7167.462440316997, 7242.420606351479, 7285.890711639329, 7300.6349682515665, 7345.522541034816, 468.80778880658767, 471.0907947661047, 473.5524928942186, 477.81365267545686, 483.3957553058677, 5627.690477023803, 5688.886222275614, 5691.943080569225, 5693.82918512437, 5726.627769194989, 8822.558872056372, 9031.232345250595, 9151.95424022889, 9189.218916392048, 9228.676996305232, 9010.684626038188, 9023.413478124032, 9073.274138068939, 9088.681896133603, 9136.862947055799, 7214.891776623354, 7262.96368518154, 7349.963250183821, 7413.110426748717, 7437.665305061285, 7361.9631901842295, 7414.332710055905, 7419.666115024945, 7422.146453157956, 7426.071741032371, 8368.12134725845, 8419.8737018946, 8585.699500517452, 8709.0, 8736.475811451333, 8562.0, 8689.913100869164, 8722.25860801839, 8842.336824738042, 8911.688090916787, 6000.21997140369, 6570.507211959027, 6703.296153903965, 6820.590764554143, 6937.098177237129, 7245.637718114179, 7268.0914885639295, 7268.127824661075, 7301.780946571611, 7308.744193953186, 6417.197850268716, 6484.092227088117, 6537.1501704778075, 6644.60132392058, 6652.40128388428, 6402.839929001812, 6405.295417503978, 6463.967680161569, 6573.967130164318, 6603.900941485786, 7020.017197592239, 7024.367806897404, 7059.25877782846, 7065.57606543609, 7069.187043490065, 6168.19813424252, 6199.318075011655, 6213.068039794067, 6213.099100630293, 6256.155419018556, 6412.326705695835, 6412.647304398303, 6429.678516074271, 6447.967760161169, 6460.838479038061], "unit": "score", "name": "mootools.html", "value": 4293.9135212062565}, {"lowerIsBetter": false, "replicates": [318.9473736833423, 319.72982829509056, 322.612864562525, 325.38664617196577, 329.2805220593006, 5326.440723724011, 5407.891842163154, 5412.404635490103, 5427.62006659534, 5432.592555558334, 5308.601854860891, 5364.946350536494, 5386.272853164822, 5394.838154855351, 5395.919061214085, 3978.4231286463446, 4111.48606424197, 4202.054537729017, 4219.11398606293, 4230.132822771325, 4204.684648651348, 4209.0, 4250.61744443, 4258.53156152823, 4259.16946195492, 4198.895027624303, 4206.663466922654, 4223.535411104776, 4226.1547690461875, 4237.957620423803, 3956.3274243378837, 4100.815463304159, 4182.874513764592, 4225.640820530259, 4241.2365774160635, 3741.7754934703735, 3744.775313481173, 3745.138618117848, 3745.176061266517, 3750.4186851038135, 5208.453112423179, 5220.973895130538, 5221.582273418117, 5226.425093239779, 5227.2159176123505, 4864.756762161913, 4874.4150701916, 4883.218685010382, 4883.706977581356, 4886.584640305578, 5662.292213473316, 5668.093105103164, 5672.34768001681, 5675.574331925122, 5680.091185410314, 4087.0395457067566, 4094.6487659072436, 4095.28332541804, 4097.09863829957, 4103.9179216415805, 5713.628614140068, 5985.940140598582, 6067.877442673075, 6072.180255665517, 6078.240219972504, 4017.7589344639414, 4063.553009168989, 4068.2880495913096, 4070.1656160487028, 4078.857239996586, 4123.175364927027, 4124.91750164995, 4133.2973394522405, 4136.8138433770555, 4137.358709400048, 4750.881227969259, 4751.358566593465, 4757.858114052602, 4765.618750499952, 4769.332293478916, 5693.060644993612, 5700.486956173964, 5704.486596206361, 5706.28671416073, 5706.857328566819, 1435.2680133132178, 1460.0290806613484, 1461.7076584682893, 1464.912105273687, 1467.9633009174856, 901.2159421303377, 966.5070813884969, 971.640493017588, 974.7173319737196, 990.094063931509, 4907.141250281186, 5006.07387633289, 5012.398512178489, 5019.0, 5019.698818070928, 5845.327787304429, 5874.441928016917, 5879.7060146993335, 5881.088431293157, 5882.911756323659, 4991.0, 5003.549680528697, 5006.874828129253, 5009.148444764399, 5012.624053196025, 3124.8125112492867, 3160.620725512953, 3167.619885613741, 3190.218396492874, 3191.473406887884, 5570.5543556516195, 5575.60970732053, 5583.4137415571595, 5589.720513974285, 5591.9720401397735, 5903.822885313448, 6099.878002440015, 6103.176071230416, 6108.633481991006, 6109.175261339751, 5528.308961379827, 5551.666899986014, 5553.416891226525, 5553.888922221614, 5554.888902221933, 5922.851928701644, 5942.316633587193, 5942.910856337245, 5944.64332140073, 5965.70171491415, 5820.76716931318, 5820.82537523875, 5825.94174058271, 5832.504237139721, 5833.79581714638, 5555.0, 5558.305211848519, 5563.499285064364, 5613.270274864241, 5623.409541998195, 3941.172353805618, 4060.675145988255, 4063.756174629532, 4064.674826013971, 4067.9796601016806, 5775.94224057754, 5925.99258126111, 5955.285365756137, 5958.046712525975, 5963.403659634176, 5655.236543066798, 5667.291588551431, 5679.9148012779015, 5680.488756011979, 5683.8863222736145, 5665.3201615806365, 5669.574781891292, 5677.51741102011, 5680.204771331934, 5680.318361796611, 5481.0, 5572.721363931706, 5593.0, 5595.8880822384135, 5598.69207193592, 5751.079827227791, 5778.335491418541, 5782.1615865698395, 5784.248047753765, 5791.420857914175, 5634.971825141012, 5636.239107720406, 5636.802711905064, 5637.746301416364, 5645.322561292671], "unit": "score", "name": "prototype.html", "value": 4287.566096724901}, {"lowerIsBetter": false, "replicates": [705.6260182103483, 716.212166616722, 737.0933751485672, 745.247300226771, 770.1912991359072, 12107.818382724256, 12868.871311286895, 13024.088313818036, 13106.606801795937, 13164.275964821943, 11654.883451165486, 12351.629451116458, 12403.255804651728, 12491.812622810665, 12494.687632809184, 804.0632662947673, 808.2039191396469, 809.0089640190778, 813.4427916876929, 815.6411179081185, 817.8037271054964, 819.2053707903324, 819.7622689420061, 819.9057108432518, 819.9508029518219, 848.1433751910553, 853.6414705823569, 854.7734850264685, 855.2174760094506, 855.3114742632179, 850.3834719828137, 851.1233429567556, 851.5997481183833, 852.0, 852.0584753847003, 622.1041699952054, 622.7664625765339, 622.9688515574248, 623.4544773323342, 623.6133597169738, 11873.109516786275, 11883.465244063951, 11980.34108124053, 11986.64040078799, 11992.100592455601, 10334.483275836179, 10427.791444171075, 10593.788124237471, 10750.892491075067, 11010.174236932262, 8691.608877600524, 8781.165789250012, 8951.910480895172, 9076.22852057576, 9167.77080572991, 3024.5765592817024, 3096.1598672080418, 3098.5662007318992, 3111.1444352802932, 3171.762117841171, 40893.38659920103, 40912.181756365004, 44446.11107777827, 44715.329270060975, 44928.77535612366, 9491.525423728925, 9555.187809036172, 9876.753081172885, 9973.800523989625, 10232.59069637206, 15646.061236325857, 17082.572935676708, 17183.914080429768, 17715.29138834458, 17817.376391826223, 6952.930470695228, 6974.37230649244, 7027.227005029443, 7054.118235220598, 7055.2239253682055, 3691.2802003609577, 3704.499892514476, 3790.6588407042946, 3810.3903375459795, 3825.8522443266907, 2891.551809469536, 2907.927301817429, 2917.0957003328613, 2921.956170657442, 2922.722341377566, 497.8083437876444, 517.1880148167417, 526.4603781124301, 529.9947000530022, 530.7319803499208, 537.9838604841862, 560.9971950140305, 561.9438056194348, 567.3447168520365, 574.4714862326585, 7986.0, 8015.679372825021, 8130.878036829452, 8304.377171712145, 8309.6676132954, 570.2273419516579, 595.7527626035147, 597.4294548705975, 598.1506261109236, 602.197125154647, 3701.7038636908983, 3781.5840257571645, 3824.4042429164588, 3832.3868181090893, 3844.4041173618134, 54370.0, 54986.0, 55158.44841551613, 55242.72378638161, 55268.72365638146, 48949.265761013616, 49136.50863491391, 49880.50119498831, 50465.0, 50527.49472505228, 40620.593794062275, 41090.0, 41215.38176927349, 41856.0, 42345.364819527735, 8754.430961987451, 8811.779705507413, 8813.515256660945, 8923.598438070432, 9000.86498702533, 30121.397572048874, 30173.245668858453, 30879.536806948363, 32124.83937580297, 33705.0, 38379.61620383872, 38677.22645547017, 39218.215635687695, 41213.79393103015, 41898.162036759706, 10385.065344119066, 10824.232853106058, 10925.617603383844, 11114.333140011626, 11280.32318060919, 11788.823167652663, 11835.881641183478, 11921.642350729491, 11971.341576213044, 12695.87304126947, 10922.453877306261, 10978.670639880816, 11296.661100167008, 11345.716357091138, 11788.174827761974, 11103.777924441305, 11338.376389298668, 11393.14551408631, 11434.085273178292, 11464.94267528657, 11184.161187910777, 11231.71920701989, 11734.061275098142, 11826.763464730486, 11946.104042197045, 9387.859182112137, 9507.369009249805, 9728.17310528613, 9937.552810123707, 10134.645287414905, 9028.18746312835, 9353.719388418358, 9387.249020078514, 9400.0, 9496.097870702271], "unit": "score", "name": "yui.html", "value": 5962.133413750302}], "name": "dromaeo_css", "value": 6444.178727266479}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 113.0, 113.0, 113.0, 101.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [157.0, 134.0, 158.0, 182.0, 134.0, 158.0, 152.0, 141.0, 181.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [385.0, 384.0, 385.0, 384.0, 386.0, 385.0, 385.0, 384.0, 383.0, 383.0], "unit": "score", "name": "audio-dft", "value": 384.4}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 157.0, 75.0, 76.0, 77.0, 76.0, 151.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 146.0, 94.0, 94.0, 94.0, 152.0, 94.0, 94.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [193.0, 193.0, 193.0, 193.0, 194.0, 193.0, 193.0, 193.0, 193.0, 193.0], "unit": "score", "name": "imaging-darkroom", "value": 193.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 64.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 63.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 81.0, 82.0, 82.0, 81.0, 94.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [125.0, 115.0, 114.0, 115.0, 116.0, 116.0, 117.0, 115.0, 117.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [138.0, 139.0, 137.0, 137.0, 136.0, 138.0, 141.0, 137.0, 140.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 69.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1787.3}]} 04:22:01 INFO - Return code: 0 04:22:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:22:01 ERROR - # TBPL SUCCESS # 04:22:01 INFO - Running post-action listener: _resource_record_post_action 04:22:01 INFO - Running post-run listener: _resource_record_post_run 04:22:02 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525148160; Read time: 8; Write time: 511960 04:22:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232280064; Read time: 0; Write time: 273144 04:22:02 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292868096; Read time: 8; Write time: 238816 04:22:02 INFO - Running post-run listener: _upload_blobber_files 04:22:02 INFO - Blob upload gear active. 04:22:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:22:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:22:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:22:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:04 INFO - (blobuploader) - INFO - Done attempting. 04:22:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:22:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:22:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:04 INFO - (blobuploader) - INFO - Done attempting. 04:22:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:04 INFO - Return code: 0 04:22:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/576c2ef4f60ba5cb3ad5dedca1bdf543ac1217f9713eab84e0053965a812af83393eed23229bac00469cb02dc16e1c16c51069a2f202860a0e045e2abfb9f990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b63e51da65207ba8bd11617ef8e1bc79d4c135278870de513a4b54c1f62da2887dcb1cfc8c471d7ddb6f0aacbe05ca231c38e2732717ec03914d741eb444c29"} 04:22:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:04 INFO - Contents: 04:22:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/576c2ef4f60ba5cb3ad5dedca1bdf543ac1217f9713eab84e0053965a812af83393eed23229bac00469cb02dc16e1c16c51069a2f202860a0e045e2abfb9f990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b63e51da65207ba8bd11617ef8e1bc79d4c135278870de513a4b54c1f62da2887dcb1cfc8c471d7ddb6f0aacbe05ca231c38e2732717ec03914d741eb444c29"} 04:22:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:04 INFO - Copying logs to upload dir... 04:22:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.457293 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-03-15 04:22:04.478299) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 04:22:04.482052) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/576c2ef4f60ba5cb3ad5dedca1bdf543ac1217f9713eab84e0053965a812af83393eed23229bac00469cb02dc16e1c16c51069a2f202860a0e045e2abfb9f990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b63e51da65207ba8bd11617ef8e1bc79d4c135278870de513a4b54c1f62da2887dcb1cfc8c471d7ddb6f0aacbe05ca231c38e2732717ec03914d741eb444c29"} build_url:https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/UxguxQIyR-mOIPJd71Ly_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/576c2ef4f60ba5cb3ad5dedca1bdf543ac1217f9713eab84e0053965a812af83393eed23229bac00469cb02dc16e1c16c51069a2f202860a0e045e2abfb9f990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b63e51da65207ba8bd11617ef8e1bc79d4c135278870de513a4b54c1f62da2887dcb1cfc8c471d7ddb6f0aacbe05ca231c38e2732717ec03914d741eb444c29"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 04:22:04.506871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:22:04.507224) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1458039229.262978-1066719306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005175 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:22:04.592186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 04:22:04.592503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 04:22:04.592952) ========= ========= Total master_lag: 0.28 =========