builder: fx-team_ubuntu64_hw_test-g2 slave: talos-linux64-ix-003 starttime: 1453934872.98 results: success (0) buildid: 20160127140558 builduid: 29fcc0ac36ee4233a3cfb784cae5083e revision: 6c9406cbc5019478f91784616b357ed9fb68de35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:52.984381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:52.984813) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:52.985095) ========= 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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006408 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.024281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.024603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.097582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.097940) ========= 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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.163777) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.164073) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.164438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.164710) ========= 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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 14:47:53-- 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% 69.9M=0s 2016-01-27 14:47:53 (69.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100687 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.297113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.297389) ========= 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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015008 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.372312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.372644) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6c9406cbc5019478f91784616b357ed9fb68de35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6c9406cbc5019478f91784616b357ed9fb68de35 --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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 14:47:53,722 truncating revision to first 12 chars 2016-01-27 14:47:53,723 Setting DEBUG logging. 2016-01-27 14:47:53,723 attempt 1/10 2016-01-27 14:47:53,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6c9406cbc501?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 14:47:53,987 unpacking tar archive at: fx-team-6c9406cbc501/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.919754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.920105) ========= echo 6c9406cbc5019478f91784616b357ed9fb68de35 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6c9406cbc5019478f91784616b357ed9fb68de35'] 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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6c9406cbc5019478f91784616b357ed9fb68de35 program finished with exit code 0 elapsedTime=0.004621 script_repo_revision: '6c9406cbc5019478f91784616b357ed9fb68de35' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.970394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.970745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 14:47:53.980457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 31 mins, 25 secs) (at 2016-01-27 14:47:53.980775) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite g2 --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'g2', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:47:54 INFO - MultiFileLogger online at 20160127 14:47:54 in /builds/slave/test 14:47:54 INFO - Run as scripts/scripts/talos_script.py --suite g2 --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:47:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:54 INFO - {'append_to_log': False, 14:47:54 INFO - 'base_work_dir': '/builds/slave/test', 14:47:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:47:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:54 INFO - 'branch': 'Fx-Team-Non-PGO', 14:47:54 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:54 INFO - 'config_files': ('talos/linux_config.py',), 14:47:54 INFO - 'default_actions': ('clobber', 14:47:54 INFO - 'read-buildbot-config', 14:47:54 INFO - 'download-and-extract', 14:47:54 INFO - 'populate-webroot', 14:47:54 INFO - 'create-virtualenv', 14:47:54 INFO - 'install', 14:47:54 INFO - 'run-tests'), 14:47:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:54 INFO - 'download_minidump_stackwalk': True, 14:47:54 INFO - 'download_symbols': 'ondemand', 14:47:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:54 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:54 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:54 INFO - 'installer_path': 'installer.exe', 14:47:54 INFO - 'log_level': 'info', 14:47:54 INFO - 'log_name': 'talos', 14:47:54 INFO - 'log_to_console': True, 14:47:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:47:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:47:54 INFO - 'opt_config_files': (), 14:47:54 INFO - 'pip_index': False, 14:47:54 INFO - 'sps_profile': False, 14:47:54 INFO - 'sps_profile_interval': 0, 14:47:54 INFO - 'suite': 'g2', 14:47:54 INFO - 'system_bits': '32', 14:47:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:54 INFO - 'title': 'talos-linux64-ix-003', 14:47:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:54 INFO - 'use_talos_json': True, 14:47:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:54 INFO - 'work_dir': 'build'} 14:47:54 INFO - ##### 14:47:54 INFO - ##### Running clobber step. 14:47:54 INFO - ##### 14:47:54 INFO - Running pre-action listener: _resource_record_pre_action 14:47:54 INFO - Running main action method: clobber 14:47:54 INFO - rmtree: /builds/slave/test/build 14:47:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:55 INFO - Running post-action listener: _resource_record_post_action 14:47:55 INFO - ##### 14:47:55 INFO - ##### Running read-buildbot-config step. 14:47:55 INFO - ##### 14:47:55 INFO - Running pre-action listener: _resource_record_pre_action 14:47:55 INFO - Running main action method: read_buildbot_config 14:47:55 INFO - Using buildbot properties: 14:47:55 INFO - { 14:47:55 INFO - "project": "", 14:47:55 INFO - "product": "firefox", 14:47:55 INFO - "script_repo_revision": "production", 14:47:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-g2", 14:47:55 INFO - "repository": "", 14:47:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos g2", 14:47:55 INFO - "buildid": "20160127140558", 14:47:55 INFO - "pgo_build": "False", 14:47:55 INFO - "basedir": "/builds/slave/test", 14:47:55 INFO - "buildnumber": 1755, 14:47:55 INFO - "slavename": "talos-linux64-ix-003", 14:47:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:47:55 INFO - "platform": "ubuntu64_hw", 14:47:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:47:55 INFO - "branch": "fx-team", 14:47:55 INFO - "repo_path": "integration/fx-team", 14:47:55 INFO - "revision": "6c9406cbc5019478f91784616b357ed9fb68de35", 14:47:55 INFO - "stage_platform": "linux64", 14:47:55 INFO - "builduid": "29fcc0ac36ee4233a3cfb784cae5083e", 14:47:55 INFO - "slavebuilddir": "test" 14:47:55 INFO - } 14:47:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:47:55 INFO - Running post-action listener: _resource_record_post_action 14:47:55 INFO - ##### 14:47:55 INFO - ##### Running download-and-extract step. 14:47:55 INFO - ##### 14:47:55 INFO - Running pre-action listener: _resource_record_pre_action 14:47:55 INFO - Running main action method: download_and_extract 14:47:55 INFO - mkdir: /builds/slave/test/build/tests 14:47:55 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')]} 14:47:55 INFO - https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/test_packages.json 14:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/test_packages.json 14:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:48:04 INFO - Downloaded 1448 bytes. 14:48:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:48:04 INFO - Using the following test package requirements: 14:48:04 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:48:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:48:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:48:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'jsshell-linux-x86_64.zip'], 14:48:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:48:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:48:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:48:04 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:48:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:48:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:48:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:48:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:48:04 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')]} 14:48:04 INFO - https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:48:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:48:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:48:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:48:06 INFO - Downloaded 21235255 bytes. 14:48:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:48:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:48:07 INFO - Return code: 0 14:48:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:48:07 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')]} 14:48:07 INFO - https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:48:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:48:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:48:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:48:08 INFO - Downloaded 21235255 bytes. 14:48:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:48:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:48:09 INFO - Return code: 0 14:48:09 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')]} 14:48:09 INFO - https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:48:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:48:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:48:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:48:10 INFO - Downloaded 10706572 bytes. 14:48:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:48:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:48:11 INFO - Return code: 0 14:48:11 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')]} 14:48:11 INFO - https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:48:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:48:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:48:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:48:12 INFO - Downloaded 54207910 bytes. 14:48:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:48:12 INFO - mkdir: /builds/slave/test/properties 14:48:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:12 INFO - Contents: 14:48:12 INFO - build_url:https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:48:12 INFO - Running post-action listener: _resource_record_post_action 14:48:12 INFO - Running post-action listener: set_extra_try_arguments 14:48:12 INFO - ##### 14:48:12 INFO - ##### Running populate-webroot step. 14:48:12 INFO - ##### 14:48:12 INFO - Running pre-action listener: _resource_record_pre_action 14:48:12 INFO - Running main action method: populate_webroot 14:48:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:48:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:48:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:48:12 INFO - '--tppagecycles', 14:48:12 INFO - '7'], 14:48:12 INFO - 'tests': ['tsvgm']}}, 14:48:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:48:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:48:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:48:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:48:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'tests': ['damp', 'tps']}, 14:48:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['damp', 'tps']}, 14:48:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:48:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:12 INFO - 'other': {'tests': ['a11yr', 14:48:12 INFO - 'ts_paint', 14:48:12 INFO - 'tpaint', 14:48:12 INFO - 'sessionrestore', 14:48:12 INFO - 'sessionrestore_no_auto_restore']}, 14:48:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['a11yr', 14:48:12 INFO - 'ts_paint', 14:48:12 INFO - 'tpaint', 14:48:12 INFO - 'sessionrestore', 14:48:12 INFO - 'sessionrestore_no_auto_restore']}, 14:48:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['a11yr', 14:48:12 INFO - 'ts_paint', 14:48:12 INFO - 'tpaint', 14:48:12 INFO - 'sessionrestore', 14:48:12 INFO - 'sessionrestore_no_auto_restore']}, 14:48:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['a11yr', 14:48:12 INFO - 'ts_paint', 14:48:12 INFO - 'tpaint', 14:48:12 INFO - 'sessionrestore', 14:48:12 INFO - 'sessionrestore_no_auto_restore']}, 14:48:12 INFO - 'other_l64': {'tests': ['a11yr', 14:48:12 INFO - 'ts_paint', 14:48:12 INFO - 'tpaint', 14:48:12 INFO - 'sessionrestore', 14:48:12 INFO - 'sessionrestore_no_auto_restore']}, 14:48:12 INFO - 'other_nol64': {'tests': ['a11yr', 14:48:12 INFO - 'ts_paint', 14:48:12 INFO - 'tpaint', 14:48:12 INFO - 'sessionrestore', 14:48:12 INFO - 'sessionrestore_no_auto_restore']}, 14:48:12 INFO - 'svgr': {'tests': ['tsvgx', 14:48:12 INFO - 'tsvgr_opacity', 14:48:12 INFO - 'tart', 14:48:12 INFO - 'tscrollx', 14:48:12 INFO - 'cart']}, 14:48:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['tsvgx', 14:48:12 INFO - 'tsvgr_opacity', 14:48:12 INFO - 'tart', 14:48:12 INFO - 'tscrollx', 14:48:12 INFO - 'cart']}, 14:48:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'tests': ['tp5o']}, 14:48:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'talos_options': ['--e10s'], 14:48:12 INFO - 'tests': ['tp5o']}, 14:48:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'talos_options': ['--xperf_path', 14:48:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:12 INFO - 'tests': ['tp5n']}, 14:48:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:12 INFO - 'talos_options': ['--e10s', 14:48:12 INFO - '--xperf_path', 14:48:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:12 INFO - 'tests': ['tp5n']}}, 14:48:12 INFO - 'talos.zip': {'path': '', 14:48:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:48:12 INFO - Downloading pageset... 14:48:12 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')]} 14:48:12 INFO - trying http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip 14:48:12 INFO - Downloading http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip to /builds/slave/test/build/tp5n.zip 14:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 'file_name': '/builds/slave/test/build/tp5n.zip'}, attempt #1 14:48:13 INFO - Downloaded 81753769 bytes. 14:48:13 INFO - Running command: ['unzip', '-q', '-o', '/builds/slave/test/build/tp5n.zip', '-d', '/builds/slave/test/build/tests/talos/talos/tests'] 14:48:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/tp5n.zip -d /builds/slave/test/build/tests/talos/talos/tests 14:48:14 INFO - Return code: 0 14:48:14 INFO - Running post-action listener: _resource_record_post_action 14:48:14 INFO - ##### 14:48:14 INFO - ##### Running create-virtualenv step. 14:48:14 INFO - ##### 14:48:14 INFO - Running pre-action listener: _resource_record_pre_action 14:48:14 INFO - Running main action method: create_virtualenv 14:48:14 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:14 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 14:48:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:48:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:15 INFO - Using real prefix '/usr' 14:48:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:15 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:17 INFO - Installing pip.................done. 14:48:17 INFO - Return code: 0 14:48:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48:17 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')]} 14:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:17 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')]} 14:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:17 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:17 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 14:48:17 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 14:48:17 INFO - Using env: {'DISPLAY': ':0', 14:48:17 INFO - 'HOME': '/home/cltbld', 14:48:17 INFO - 'LANG': 'en_US.UTF-8', 14:48:17 INFO - 'LANGUAGE': 'en_US:en', 14:48:17 INFO - 'LOGNAME': 'cltbld', 14:48:17 INFO - 'MAIL': '/var/mail/cltbld', 14:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:17 INFO - 'MOZ_NO_REMOTE': '1', 14:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:17 INFO - 'NO_EM_RESTART': '1', 14:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:17 INFO - 'PWD': '/builds/slave/test', 14:48:17 INFO - 'SHELL': '/bin/bash', 14:48:17 INFO - 'SHLVL': '1', 14:48:17 INFO - 'TERM': 'linux', 14:48:17 INFO - 'TMOUT': '86400', 14:48:17 INFO - 'USER': 'cltbld', 14:48:17 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:17 INFO - '_': '/tools/buildbot/bin/python'} 14:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:17 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 14:48:17 INFO - Cleaning up... 14:48:17 INFO - Return code: 0 14:48:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:48:17 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')]} 14:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:17 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')]} 14:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:17 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:17 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 14:48:17 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 14:48:17 INFO - Using env: {'DISPLAY': ':0', 14:48:17 INFO - 'HOME': '/home/cltbld', 14:48:17 INFO - 'LANG': 'en_US.UTF-8', 14:48:17 INFO - 'LANGUAGE': 'en_US:en', 14:48:17 INFO - 'LOGNAME': 'cltbld', 14:48:17 INFO - 'MAIL': '/var/mail/cltbld', 14:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:17 INFO - 'MOZ_NO_REMOTE': '1', 14:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:17 INFO - 'NO_EM_RESTART': '1', 14:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:17 INFO - 'PWD': '/builds/slave/test', 14:48:17 INFO - 'SHELL': '/bin/bash', 14:48:17 INFO - 'SHLVL': '1', 14:48:17 INFO - 'TERM': 'linux', 14:48:17 INFO - 'TMOUT': '86400', 14:48:17 INFO - 'USER': 'cltbld', 14:48:17 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:17 INFO - '_': '/tools/buildbot/bin/python'} 14:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:17 INFO - Downloading/unpacking psutil>=0.7.1 14:48:17 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 14:48:17 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 14:48:17 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 14:48:17 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 14:48:17 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 14:48:17 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 14:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:20 INFO - Installing collected packages: psutil 14:48:20 INFO - Running setup.py install for psutil 14:48:20 INFO - building 'psutil._psutil_linux' extension 14:48:20 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 14:48:20 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 14:48:20 INFO - building 'psutil._psutil_posix' extension 14:48:20 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 14:48:20 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 14:48:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:20 INFO - Successfully installed psutil 14:48:20 INFO - Cleaning up... 14:48:20 INFO - Return code: 0 14:48:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:48:20 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')]} 14:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:20 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')]} 14:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:20 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:20 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 14:48:20 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 14:48:20 INFO - Using env: {'DISPLAY': ':0', 14:48:20 INFO - 'HOME': '/home/cltbld', 14:48:20 INFO - 'LANG': 'en_US.UTF-8', 14:48:20 INFO - 'LANGUAGE': 'en_US:en', 14:48:20 INFO - 'LOGNAME': 'cltbld', 14:48:20 INFO - 'MAIL': '/var/mail/cltbld', 14:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:20 INFO - 'MOZ_NO_REMOTE': '1', 14:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:20 INFO - 'NO_EM_RESTART': '1', 14:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:20 INFO - 'PWD': '/builds/slave/test', 14:48:20 INFO - 'SHELL': '/bin/bash', 14:48:20 INFO - 'SHLVL': '1', 14:48:20 INFO - 'TERM': 'linux', 14:48:20 INFO - 'TMOUT': '86400', 14:48:20 INFO - 'USER': 'cltbld', 14:48:20 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:20 INFO - '_': '/tools/buildbot/bin/python'} 14:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:48:20 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 14:48:20 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 14:48:20 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 14:48:20 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 14:48:20 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 14:48:20 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 14:48:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:48:22 INFO - Installing collected packages: mozsystemmonitor 14:48:22 INFO - Running setup.py install for mozsystemmonitor 14:48:22 INFO - Successfully installed mozsystemmonitor 14:48:22 INFO - Cleaning up... 14:48:23 INFO - Return code: 0 14:48:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48: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')]} 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:23 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 14:48:23 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 14:48:23 INFO - Using env: {'DISPLAY': ':0', 14:48:23 INFO - 'HOME': '/home/cltbld', 14:48:23 INFO - 'LANG': 'en_US.UTF-8', 14:48:23 INFO - 'LANGUAGE': 'en_US:en', 14:48:23 INFO - 'LOGNAME': 'cltbld', 14:48:23 INFO - 'MAIL': '/var/mail/cltbld', 14:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:23 INFO - 'MOZ_NO_REMOTE': '1', 14:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:23 INFO - 'NO_EM_RESTART': '1', 14:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:23 INFO - 'PWD': '/builds/slave/test', 14:48:23 INFO - 'SHELL': '/bin/bash', 14:48:23 INFO - 'SHLVL': '1', 14:48:23 INFO - 'TERM': 'linux', 14:48:23 INFO - 'TMOUT': '86400', 14:48:23 INFO - 'USER': 'cltbld', 14:48:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:23 INFO - '_': '/tools/buildbot/bin/python'} 14:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:23 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 14:48:23 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 14:48:23 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 14:48:23 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 14:48:23 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 14:48:23 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 14:48:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:25 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 14:48:25 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 14:48:25 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 14:48:25 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 14:48:25 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 14:48:25 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 14:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:25 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 14:48:25 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 14:48:25 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 14:48:25 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 14:48:25 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 14:48:25 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 14:48:26 INFO - Downloading docopt-0.6.1.tar.gz 14:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:26 INFO - Running setup.py install for blobuploader 14:48:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:26 INFO - Running setup.py install for requests 14:48:26 INFO - Running setup.py install for docopt 14:48:26 INFO - Successfully installed blobuploader requests docopt 14:48:26 INFO - Cleaning up... 14:48:26 INFO - Return code: 0 14:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48: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')]} 14:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:26 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:26 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 14:48:26 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 14:48:26 INFO - Using env: {'DISPLAY': ':0', 14:48:26 INFO - 'HOME': '/home/cltbld', 14:48:26 INFO - 'LANG': 'en_US.UTF-8', 14:48:26 INFO - 'LANGUAGE': 'en_US:en', 14:48:26 INFO - 'LOGNAME': 'cltbld', 14:48:26 INFO - 'MAIL': '/var/mail/cltbld', 14:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:26 INFO - 'MOZ_NO_REMOTE': '1', 14:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:26 INFO - 'NO_EM_RESTART': '1', 14:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:26 INFO - 'PWD': '/builds/slave/test', 14:48:26 INFO - 'SHELL': '/bin/bash', 14:48:26 INFO - 'SHLVL': '1', 14:48:26 INFO - 'TERM': 'linux', 14:48:26 INFO - 'TMOUT': '86400', 14:48:26 INFO - 'USER': 'cltbld', 14:48:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:26 INFO - '_': '/tools/buildbot/bin/python'} 14:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:26 INFO - Running setup.py (path:/tmp/pip-QJbDzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:26 INFO - Running setup.py (path:/tmp/pip-106xRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:27 INFO - Running setup.py (path:/tmp/pip-RVZT7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:27 INFO - Running setup.py (path:/tmp/pip-jLvBYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:27 INFO - Running setup.py (path:/tmp/pip-C2PqS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:27 INFO - Running setup.py (path:/tmp/pip-hFTRXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:27 INFO - Running setup.py (path:/tmp/pip-Ghd6M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:27 INFO - Running setup.py (path:/tmp/pip-OcRupw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:27 INFO - Running setup.py (path:/tmp/pip-2hOxS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:27 INFO - Running setup.py (path:/tmp/pip-yCXWRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:27 INFO - Running setup.py (path:/tmp/pip-yCykeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:27 INFO - Running setup.py (path:/tmp/pip-ruuRkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:27 INFO - Running setup.py (path:/tmp/pip-YMPa9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:27 INFO - Running setup.py (path:/tmp/pip-4bn63b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:27 INFO - Running setup.py (path:/tmp/pip-braaMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:28 INFO - Running setup.py (path:/tmp/pip-p9viBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:28 INFO - Running setup.py (path:/tmp/pip-OZdBLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:28 INFO - Running setup.py install for manifestparser 14:48:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Running setup.py install for mozcrash 14:48:28 INFO - Running setup.py install for mozdebug 14:48:28 INFO - Running setup.py install for mozdevice 14:48:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Running setup.py install for mozfile 14:48:28 INFO - Running setup.py install for mozhttpd 14:48:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Running setup.py install for mozinfo 14:48:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Running setup.py install for mozInstall 14:48:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:48:28 INFO - Running setup.py install for mozleak 14:48:29 INFO - Running setup.py install for mozlog 14:48:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:48:29 INFO - Running setup.py install for moznetwork 14:48:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:48:29 INFO - Running setup.py install for mozprocess 14:48:29 INFO - Running setup.py install for mozprofile 14:48:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:48:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:48:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:48:29 INFO - Running setup.py install for mozrunner 14:48:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:48:29 INFO - Running setup.py install for mozscreenshot 14:48:29 INFO - Running setup.py install for moztest 14:48:29 INFO - Running setup.py install for mozversion 14:48:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:48:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:48:29 INFO - Cleaning up... 14:48:29 INFO - Return code: 0 14:48:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:29 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')]} 14:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:29 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')]} 14:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:29 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:29 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 14:48:29 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 14:48:29 INFO - Using env: {'DISPLAY': ':0', 14:48:29 INFO - 'HOME': '/home/cltbld', 14:48:29 INFO - 'LANG': 'en_US.UTF-8', 14:48:29 INFO - 'LANGUAGE': 'en_US:en', 14:48:29 INFO - 'LOGNAME': 'cltbld', 14:48:29 INFO - 'MAIL': '/var/mail/cltbld', 14:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:29 INFO - 'MOZ_NO_REMOTE': '1', 14:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:29 INFO - 'NO_EM_RESTART': '1', 14:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:29 INFO - 'PWD': '/builds/slave/test', 14:48:29 INFO - 'SHELL': '/bin/bash', 14:48:29 INFO - 'SHLVL': '1', 14:48:29 INFO - 'TERM': 'linux', 14:48:29 INFO - 'TMOUT': '86400', 14:48:29 INFO - 'USER': 'cltbld', 14:48:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:29 INFO - '_': '/tools/buildbot/bin/python'} 14:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:30 INFO - Running setup.py (path:/tmp/pip-njaSU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:30 INFO - Running setup.py (path:/tmp/pip-HRTOXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:30 INFO - Running setup.py (path:/tmp/pip-LHulMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:30 INFO - Running setup.py (path:/tmp/pip-H9RcI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:30 INFO - Running setup.py (path:/tmp/pip-mnjUyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:30 INFO - Running setup.py (path:/tmp/pip-CyI1Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:30 INFO - Running setup.py (path:/tmp/pip-X3x6z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:30 INFO - Running setup.py (path:/tmp/pip-Qtui_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:30 INFO - Running setup.py (path:/tmp/pip-kwkFB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:30 INFO - Running setup.py (path:/tmp/pip-fTd2MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:30 INFO - Running setup.py (path:/tmp/pip-EuhTlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:30 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)) 14:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:30 INFO - Running setup.py (path:/tmp/pip-91rBLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:31 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)) 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:31 INFO - Running setup.py (path:/tmp/pip-X0FV34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:31 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)) 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:31 INFO - Running setup.py (path:/tmp/pip-Ae0VYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:31 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)) 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:31 INFO - Running setup.py (path:/tmp/pip-jvYU9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:31 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)) 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:31 INFO - Running setup.py (path:/tmp/pip-iUoFFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:31 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)) 14:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:31 INFO - Running setup.py (path:/tmp/pip-CjLl44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:31 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)) 14:48:31 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:48:31 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:48:31 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)) 14:48:31 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)) 14:48:31 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)) 14:48:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:48:31 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 14:48:31 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 14:48:31 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 14:48:31 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 14:48:31 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 14:48:31 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 14:48:33 INFO - Downloading blessings-1.6.tar.gz 14:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:48:33 INFO - Installing collected packages: blessings 14:48:33 INFO - Running setup.py install for blessings 14:48:33 INFO - Successfully installed blessings 14:48:33 INFO - Cleaning up... 14:48:33 INFO - Return code: 0 14:48:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:33 INFO - Reading from file tmpfile_stdout 14:48:33 INFO - Current package versions: 14:48:33 INFO - argparse == 1.2.1 14:48:33 INFO - blessings == 1.6 14:48:33 INFO - blobuploader == 1.2.4 14:48:33 INFO - docopt == 0.6.1 14:48:33 INFO - manifestparser == 1.1 14:48:33 INFO - mozInstall == 1.12 14:48:33 INFO - mozcrash == 0.16 14:48:33 INFO - mozdebug == 0.1 14:48:33 INFO - mozdevice == 0.48 14:48:33 INFO - mozfile == 1.2 14:48:33 INFO - mozhttpd == 0.7 14:48:33 INFO - mozinfo == 0.9 14:48:33 INFO - mozleak == 0.1 14:48:33 INFO - mozlog == 3.1 14:48:33 INFO - moznetwork == 0.27 14:48:33 INFO - mozprocess == 0.22 14:48:33 INFO - mozprofile == 0.28 14:48:33 INFO - mozrunner == 6.11 14:48:33 INFO - mozscreenshot == 0.1 14:48:33 INFO - mozsystemmonitor == 0.0 14:48:33 INFO - moztest == 0.7 14:48:33 INFO - mozversion == 1.4 14:48:33 INFO - psutil == 3.1.1 14:48:33 INFO - requests == 1.2.3 14:48:33 INFO - wsgiref == 0.1.2 14:48:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:33 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')]} 14:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:33 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')]} 14:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:33 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:33 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 14:48:33 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 14:48:33 INFO - Using env: {'DISPLAY': ':0', 14:48:33 INFO - 'HOME': '/home/cltbld', 14:48:33 INFO - 'LANG': 'en_US.UTF-8', 14:48:33 INFO - 'LANGUAGE': 'en_US:en', 14:48:33 INFO - 'LOGNAME': 'cltbld', 14:48:33 INFO - 'MAIL': '/var/mail/cltbld', 14:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:33 INFO - 'MOZ_NO_REMOTE': '1', 14:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:33 INFO - 'NO_EM_RESTART': '1', 14:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:33 INFO - 'PWD': '/builds/slave/test', 14:48:33 INFO - 'SHELL': '/bin/bash', 14:48:33 INFO - 'SHLVL': '1', 14:48:33 INFO - 'TERM': 'linux', 14:48:33 INFO - 'TMOUT': '86400', 14:48:33 INFO - 'USER': 'cltbld', 14:48:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:33 INFO - '_': '/tools/buildbot/bin/python'} 14:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 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)) 14:48:33 INFO - Cleaning up... 14:48:33 INFO - Return code: 0 14:48:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:48:33 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')]} 14:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:33 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')]} 14:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:33 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:33 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 14:48:33 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 14:48:33 INFO - Using env: {'DISPLAY': ':0', 14:48:33 INFO - 'HOME': '/home/cltbld', 14:48:33 INFO - 'LANG': 'en_US.UTF-8', 14:48:33 INFO - 'LANGUAGE': 'en_US:en', 14:48:33 INFO - 'LOGNAME': 'cltbld', 14:48:33 INFO - 'MAIL': '/var/mail/cltbld', 14:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:33 INFO - 'MOZ_NO_REMOTE': '1', 14:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:33 INFO - 'NO_EM_RESTART': '1', 14:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:33 INFO - 'PWD': '/builds/slave/test', 14:48:33 INFO - 'SHELL': '/bin/bash', 14:48:33 INFO - 'SHLVL': '1', 14:48:33 INFO - 'TERM': 'linux', 14:48:33 INFO - 'TMOUT': '86400', 14:48:33 INFO - 'USER': 'cltbld', 14:48:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:33 INFO - '_': '/tools/buildbot/bin/python'} 14:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:33 INFO - Downloading/unpacking jsonschema 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:35 INFO - Downloading/unpacking functools32 (from jsonschema) 14:48:35 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 14:48:35 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 14:48:35 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 14:48:35 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 14:48:35 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 14:48:35 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 14:48:35 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:36 INFO - warning: no files found matching '*.txt' 14:48:36 INFO - no previously-included directories found matching 'build' 14:48:36 INFO - no previously-included directories found matching 'dist' 14:48:36 INFO - no previously-included directories found matching '.git*' 14:48:36 INFO - Installing collected packages: jsonschema, functools32 14:48:36 INFO - Running setup.py install for functools32 14:48:36 INFO - warning: no files found matching '*.txt' 14:48:36 INFO - no previously-included directories found matching 'build' 14:48:36 INFO - no previously-included directories found matching 'dist' 14:48:36 INFO - no previously-included directories found matching '.git*' 14:48:36 INFO - Successfully installed jsonschema functools32 14:48:36 INFO - Cleaning up... 14:48:36 INFO - Return code: 0 14:48:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48: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')]} 14:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:36 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 0x7f2dd354cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, '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': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', '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 14:48:36 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 14:48:36 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 14:48:36 INFO - Using env: {'DISPLAY': ':0', 14:48:36 INFO - 'HOME': '/home/cltbld', 14:48:36 INFO - 'LANG': 'en_US.UTF-8', 14:48:36 INFO - 'LANGUAGE': 'en_US:en', 14:48:36 INFO - 'LOGNAME': 'cltbld', 14:48:36 INFO - 'MAIL': '/var/mail/cltbld', 14:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:36 INFO - 'MOZ_NO_REMOTE': '1', 14:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:36 INFO - 'NO_EM_RESTART': '1', 14:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:36 INFO - 'PWD': '/builds/slave/test', 14:48:36 INFO - 'SHELL': '/bin/bash', 14:48:36 INFO - 'SHLVL': '1', 14:48:36 INFO - 'TERM': 'linux', 14:48:36 INFO - 'TMOUT': '86400', 14:48:36 INFO - 'USER': 'cltbld', 14:48:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:36 INFO - '_': '/tools/buildbot/bin/python'} 14:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:36 INFO - Downloading/unpacking flake8 14:48:36 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 14:48:36 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 14:48:36 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 14:48:36 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 14:48:36 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 14:48:36 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 14:48:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:48:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:48:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 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 14:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:48:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:38 INFO - no previously-included directories found matching 'docs/_build' 14:48:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:48:38 INFO - Running setup.py install for pep8 14:48:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:39 INFO - no previously-included directories found matching 'docs/_build' 14:48:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:48:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:48:39 INFO - Cleaning up... 14:48:39 INFO - Return code: 0 14:48:39 INFO - Running post-action listener: _resource_record_post_action 14:48:39 INFO - Running post-action listener: _start_resource_monitoring 14:48:39 INFO - Starting resource monitoring. 14:48:39 INFO - ##### 14:48:39 INFO - ##### Running install step. 14:48:39 INFO - ##### 14:48:39 INFO - Running pre-action listener: _resource_record_pre_action 14:48:39 INFO - Running main action method: install 14:48:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:39 INFO - Reading from file tmpfile_stdout 14:48:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:48:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:48:39 INFO - Reading from file tmpfile_stdout 14:48:39 INFO - Output received: 14:48:39 INFO - Usage: mozinstall [options] installer 14:48:39 INFO - Options: 14:48:39 INFO - -h, --help show this help message and exit 14:48:39 INFO - -d DEST, --destination=DEST 14:48:39 INFO - Directory to install application into. [default: 14:48:39 INFO - "/builds/slave/test"] 14:48:39 INFO - --app=APP Application being installed. [default: firefox] 14:48:39 INFO - mkdir: /builds/slave/test/build/application 14:48:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:48:55 INFO - Reading from file tmpfile_stdout 14:48:55 INFO - Output received: 14:48:55 INFO - /builds/slave/test/build/application/firefox/firefox 14:48:55 INFO - Running post-action listener: _resource_record_post_action 14:48:55 INFO - ##### 14:48:55 INFO - ##### Running run-tests step. 14:48:55 INFO - ##### 14:48:55 INFO - Running pre-action listener: _resource_record_pre_action 14:48:55 INFO - Running main action method: run_tests 14:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:55 INFO - Python 2.7.3 14:48:55 INFO - Return code: 0 14:48:55 INFO - grabbing minidump binary from tooltool 14:48:55 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')]} 14:48:55 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 0x14e33d0>, '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 0x144eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144f360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:55 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 14:48:55 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 14:48:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:55 INFO - Return code: 0 14:48:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:48:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:48:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:48:56 INFO - Return code: 0 14:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'g2', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/g2_raw.log'] in /builds/slave/test/build 14:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite g2 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/g2_raw.log 14:48:56 INFO - Using env: {'DISPLAY': ':0', 14:48:56 INFO - 'HOME': '/home/cltbld', 14:48:56 INFO - 'LANG': 'en_US.UTF-8', 14:48:56 INFO - 'LANGUAGE': 'en_US:en', 14:48:56 INFO - 'LOGNAME': 'cltbld', 14:48:56 INFO - 'MAIL': '/var/mail/cltbld', 14:48:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:56 INFO - 'MOZ_NO_REMOTE': '1', 14:48:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:56 INFO - 'NO_EM_RESTART': '1', 14:48:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:56 INFO - 'PWD': '/builds/slave/test', 14:48:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:56 INFO - 'SHELL': '/bin/bash', 14:48:56 INFO - 'SHLVL': '1', 14:48:56 INFO - 'TERM': 'linux', 14:48:56 INFO - 'TMOUT': '86400', 14:48:56 INFO - 'USER': 'cltbld', 14:48:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1453925193.673615-37183540', 14:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:56 INFO - '_': '/tools/buildbot/bin/python'} 14:48:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'g2', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/g2_raw.log'] with output_timeout 3600 14:48:57 INFO - mozversion application_buildid: 20160127140558 14:48:57 INFO - mozversion application_changeset: 6c9406cbc5019478f91784616b357ed9fb68de35 14:48:57 INFO - mozversion application_display_name: Nightly 14:48:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:57 INFO - mozversion application_name: Firefox 14:48:57 INFO - mozversion application_remotingname: firefox 14:48:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:48:57 INFO - mozversion application_vendor: Mozilla 14:48:57 INFO - mozversion application_version: 47.0a1 14:48:57 INFO - mozversion platform_buildid: 20160127140558 14:48:57 INFO - mozversion platform_changeset: 6c9406cbc5019478f91784616b357ed9fb68de35 14:48:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:48:57 INFO - mozversion platform_version: 47.0a1 14:48:57 INFO - using testdate: 1453934937 14:48:57 INFO - actual date: 1453934937 14:48:57 INFO - starting webserver on 'localhost:36800' 14:48:57 INFO - SUITE-START | Running 2 tests 14:48:57 INFO - TEST-START | damp 14:48:57 INFO - operating with platform_type : linux_ 14:48:57 INFO - Initialising browser for damp test... 14:48:57 INFO - TEST-INFO | started process 14991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlpU1q/profile http://localhost:36800/getInfo.html) 14:49:02 INFO - PROCESS | 14991 | __metrics Screen width/height:1600/1200 14:49:02 INFO - PROCESS | 14991 | colorDepth:24 14:49:02 INFO - PROCESS | 14991 | Browser inner width/height: 1024/697 14:49:02 INFO - PROCESS | 14991 | __metrics 14:49:02 INFO - PROCESS | 14991 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:49:02 INFO - PROCESS | 14991 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:49:03 INFO - TEST-INFO | 14991: exit 0 14:49:03 INFO - Browser initialized. 14:49:03 INFO - Running cycle 1/1 for damp test... 14:49:03 INFO - TEST-INFO | started process 15087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlpU1q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/devtools/damp.manifest.develop -tpchrome -tpnoisy -tploadnocache -tpcycles 1 -tppagecycles 25) 14:49:15 INFO - PROCESS | 15087 | RSS: Main: 148758528 14:49:15 INFO - PROCESS | 15087 | 14:49:16 INFO - PROCESS | 15087 | console.error: 14:49:16 INFO - PROCESS | 15087 | Failed to load module devtools/shared/gcli/commands/mdn: Module `devtools/shared/gcli/commands/mdn` is not found at resource://devtools/shared/gcli/commands/mdn.js 14:49:16 INFO - PROCESS | 15087 | console.error: 14:49:16 INFO - PROCESS | 15087 | exports.createSystem/system.addItemsByModule/damp: 276.84 15:19:14 INFO - RETURN: tps: 58.04 15:19:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [1285.3549999999996, 346.3550000000032, 364.5899999999965, 342.0, 355.25499999997555, 358.8550000000396, 366.79999999998836, 348.45000000001164, 355.8099999999977, 364.3050000000512, 354.21999999997206, 363.4449999999488, 382.97500000009313, 349.84499999997206, 349.58500000007916, 347.6500000000233, 360.06500000006054, 348.77499999990687, 348.30000000004657, 336.80000000004657, 364.35999999998603, 358.0649999999441, 331.6199999998789, 348.875, 337.1850000000559], "unit": "ms", "name": "simple.webconsole.open.DAMP", "value": 352.03249999997206}, {"lowerIsBetter": true, "replicates": [43.975000000000364, 33.98999999999796, 40.23999999999069, 45.220000000001164, 47.66000000000349, 38.36499999999069, 49.49499999999534, 47.34499999997206, 35.43499999999767, 50.52000000001863, 39.17999999993481, 34.84999999997672, 34.43500000005588, 44.50499999988824, 41.40500000002794, 40.95000000006985, 35.455000000074506, 41.93999999994412, 44.77000000001863, 46.03000000002794, 46.08500000007916, 35.28500000014901, 44.359999999869615, 45.11499999999069, 39.2750000001397], "unit": "ms", "name": "simple.webconsole.reload.DAMP", "value": 41.67249999998603}, {"lowerIsBetter": true, "replicates": [35.225000000000364, 40.03499999999622, 53.89999999999418, 42.40999999997439, 42.29999999998836, 38.57999999995809, 42.23499999998603, 40.59999999997672, 43.23499999998603, 38.46500000002561, 39.06999999994878, 43.919999999925494, 40.71999999997206, 40.035000000032596, 48.09499999997206, 46.27500000002328, 45.68999999994412, 41.11999999999534, 41.29000000003725, 44.50500000000466, 43.10000000009313, 45.00500000012107, 39.4749999998603, 42.81500000017695, 40.62999999988824], "unit": "ms", "name": "simple.webconsole.close.DAMP", "value": 42.267499999987194}, {"lowerIsBetter": true, "replicates": [698.1900000000005, 455.15499999999156, 456.375, 462.9349999999977, 467.9100000000035, 445.0249999999651, 443.7700000000186, 467.66500000003725, 506.13000000000466, 459.61000000004424, 468.625, 468.01499999989755, 470.7700000000186, 462.21000000007916, 481.36999999999534, 472.3299999999581, 490.625, 459.07500000006985, 480.80999999993946, 465.8100000000559, 487.3200000000652, 470.6450000000186, 486.75499999988824, 482.09499999997206, 465.86000000010245], "unit": "ms", "name": "simple.inspector.open.DAMP", "value": 467.9624999999505}, {"lowerIsBetter": true, "replicates": [143.51500000000124, 120.42999999999302, 119.24000000000524, 117.92999999999302, 121.92500000001746, 120.98499999998603, 118.76000000000931, 119.20499999995809, 122.66500000003725, 116.15499999996973, 119.30499999993481, 115.86499999999069, 116.33499999996275, 118.0350000000326, 118.14000000001397, 120.15999999991618, 120.84500000008848, 117.95000000006985, 115.24499999999534, 115.15000000002328, 123.29000000003725, 119.35999999986961, 119.52000000001863, 120.68999999994412, 116.0449999999255], "unit": "ms", "name": "simple.inspector.reload.DAMP", "value": 119.22249999998166}, {"lowerIsBetter": true, "replicates": [88.4950000000008, 60.24499999999534, 66.11000000000058, 65.8299999999872, 63.03500000000349, 61.50500000000466, 63.53499999997439, 70.28499999997439, 62.82500000001164, 62.56999999994878, 61.050000000046566, 61.30499999993481, 65.53000000002794, 63.214999999967404, 66.81499999994412, 60.47999999998137, 65.89000000001397, 66.19999999995343, 65.41500000003725, 60.92999999993481, 63.10999999998603, 60.110000000102445, 65.28500000014901, 63.77499999990687, 65.49499999987893], "unit": "ms", "name": "simple.inspector.close.DAMP", "value": 63.374999999970896}, {"lowerIsBetter": true, "replicates": [633.1049999999996, 495.4400000000023, 499.42499999998836, 483.88000000000466, 499.1449999999895, 483.79999999998836, 483.6500000000233, 479.63000000000466, 513.5349999999744, 503.00500000000466, 752.5799999999581, 502.4799999999814, 479.72500000009313, 485.34499999997206, 482.1350000000093, 483.625, 499.8499999999767, 498.0200000000186, 818.6900000000605, 479.14999999990687, 513.5, 502.2299999999814, 580.6699999999255, 490.1049999999814, 596.0249999999069], "unit": "ms", "name": "simple.jsdebugger.open.DAMP", "value": 498.5825000000041}, {"lowerIsBetter": true, "replicates": [49.98999999999978, 47.11000000000058, 47.5850000000064, 43.50500000000466, 48.054999999993015, 46.51000000000931, 47.34499999997206, 46.79000000003725, 46.949999999953434, 50.5449999999837, 47.324999999953434, 47.14500000001863, 56.49499999999534, 46.68500000005588, 47.00500000000466, 47.40500000002794, 54.589999999967404, 50.47499999997672, 53.99499999999534, 45.35999999998603, 55.34999999997672, 46.30999999982305, 353.9450000000652, 47.00499999988824, 348.8850000000093], "unit": "ms", "name": "simple.jsdebugger.reload.DAMP", "value": 47.33499999996275}, {"lowerIsBetter": true, "replicates": [33.469999999999345, 41.41500000000815, 45.13499999999476, 41.595000000001164, 41.3300000000163, 42.86999999999534, 43.070000000006985, 43.80999999999767, 43.67499999998836, 44.31999999994878, 52.11499999999069, 41.31999999994878, 43.59999999997672, 39.169999999925494, 44.39500000001863, 41.22500000009313, 47.76000000000931, 44.14999999990687, 45.20499999995809, 78.94999999995343, 46.90000000002328, 40.610000000102445, 52.08999999985099, 44.88500000000931, 53.329999999841675], "unit": "ms", "name": "simple.jsdebugger.close.DAMP", "value": 43.97999999995227}, {"lowerIsBetter": true, "replicates": [654.8099999999995, 612.2949999999983, 644.2200000000012, 647.8500000000058, 622.7099999999919, 656.6849999999977, 665.9550000000163, 871.7399999999907, 670.25, 621.2150000000256, 715.3949999999022, 686.3349999999627, 633.6600000000326, 661.0400000000373, 644.8149999999441, 729.6899999999441, 736.0400000000373, 627.8499999999767, 659.2249999999767, 842.625, 755.6500000000233, 599.8299999998417, 712.1549999997951, 640.5400000000373, 714.3250000001863], "unit": "ms", "name": "simple.styleeditor.open.DAMP", "value": 660.132500000007}, {"lowerIsBetter": true, "replicates": [55.8700000000008, 36.654999999998836, 45.96499999999651, 38.10000000000582, 37.5, 37.04000000003725, 55.070000000006985, 58.649999999965075, 101.61999999999534, 37.21999999997206, 57.95999999996275, 77.13500000000931, 57.809999999939464, 63.88000000000466, 80.90999999991618, 85.98999999999069, 37.73499999998603, 55.684999999939464, 46.38000000000466, 48.449999999953434, 61.06999999994878, 56.14500000001863, 57.13000000012107, 51.19499999983236, 60.234999999869615], "unit": "ms", "name": "simple.styleeditor.reload.DAMP", "value": 55.914999999979045}, {"lowerIsBetter": true, "replicates": [40.474999999998545, 50.46500000001106, 51.71499999999651, 48.8300000000163, 47.375, 48.820000000006985, 46.97999999998137, 51.48999999999069, 68.78000000002794, 45.410000000032596, 59.48999999999069, 60.50500000000466, 44.8650000001071, 43.110000000102445, 65.54500000004191, 64.29500000004191, 45.69499999994878, 47.535000000032596, 47.84499999997206, 59.51500000001397, 49.04999999993015, 50.56000000005588, 50.985000000102445, 51.02000000001863, 45.56999999983236], "unit": "ms", "name": "simple.styleeditor.close.DAMP", "value": 49.757499999970605}, {"lowerIsBetter": true, "replicates": [483.5650000000005, 471.9349999999977, 465.38000000000466, 433.35999999998603, 401.0350000000035, 357.4649999999674, 377.1449999999604, 363.85999999998603, 535.1449999999604, 343.1049999999814, 358.25500000000466, 493.07499999995343, 336.56500000006054, 360.5, 541.859999999986, 444.1600000000326, 545.9700000000885, 412.8050000000512, 365.8200000000652, 357.6149999999907, 540.5050000000047, 360.2399999999907, 359.1350000000093, 333.6049999999814, 369.74500000011176], "unit": "ms", "name": "simple.performance.open.DAMP", "value": 373.4450000000361}, {"lowerIsBetter": true, "replicates": [37.284999999999854, 81.75500000000466, 69.13000000000466, 70.125, 92.16500000000815, 31.005000000004657, 32.2949999999837, 36.50500000000466, 31.320000000006985, 31.074999999953434, 33.84000000008382, 37.79000000003725, 34.035000000032596, 31.445000000065193, 41.03999999992084, 35.08499999996275, 152.99499999999534, 83.98499999998603, 31.084999999962747, 36.044999999925494, 76.33500000007916, 31.449999999953434, 32.79000000003725, 33.125, 31.78000000002794], "unit": "ms", "name": "simple.performance.reload.DAMP", "value": 34.55999999999767}, {"lowerIsBetter": true, "replicates": [33.89500000000044, 56.14999999999418, 51.645000000004075, 57.845000000001164, 56.57499999998254, 41.59500000003027, 38.32500000001164, 42.32500000001164, 43.59499999997206, 122.84500000003027, 37.20999999996275, 39.824999999953434, 38.48999999999069, 36.65500000002794, 40.574999999953434, 41.794999999925494, 43.68999999994412, 55.30500000005122, 36.77000000001863, 39.81000000005588, 49.964999999967404, 111.39999999990687, 37.51000000000931, 36.515000000130385, 38.80499999993481], "unit": "ms", "name": "simple.performance.close.DAMP", "value": 41.69499999997788}, {"lowerIsBetter": true, "replicates": [420.9299999999985, 435.70999999999185, 455.1750000000029, 516.5299999999988, 616.9400000000023, 617.445000000007, 610.7199999999721, 358.90500000002794, 363.8949999999604, 619.1700000000419, 357.875, 366.1049999999814, 602.2999999999302, 610.4349999999395, 359.96999999997206, 355.9549999999581, 389.1149999999907, 513.5300000000279, 367.90500000002794, 333.9200000000419, 403.73499999998603, 622.5349999999162, 351.99500000011176, 596.1500000001397, 328.9799999999814], "unit": "ms", "name": "simple.netmonitor.open.DAMP", "value": 419.72249999998894}, {"lowerIsBetter": true, "replicates": [90.46500000000015, 41.34499999998661, 40.36000000000058, 39.43499999999767, 52.10999999998603, 47.19000000000233, 70.42499999998836, 36.93499999999767, 41.61499999999069, 65.75500000000466, 51.43500000005588, 41.7400000001071, 92.2850000000326, 86.50500000000466, 44.64500000001863, 46.464999999967404, 45.72499999997672, 37.580000000074506, 42.57999999995809, 39.315000000060536, 39.47999999998137, 44.92999999993481, 52.544999999925494, 41.670000000158325, 35.34000000008382], "unit": "ms", "name": "simple.netmonitor.reload.DAMP", "value": 43.61249999998836}, {"lowerIsBetter": true, "replicates": [61.875, 55.71499999999651, 63.645000000004075, 63.86999999999534, 55.58999999999651, 55.240000000048894, 58.899999999965075, 55.304999999993015, 55.91500000003725, 60.240000000048894, 69.45499999995809, 57.11499999999069, 59.68000000005122, 57.60000000009313, 58.91500000003725, 61.71999999997206, 72.72999999998137, 56.02000000001863, 69.9199999999255, 57.65500000002794, 71.14499999990221, 58.80500000016764, 67.54000000003725, 58.125, 56.205000000074506], "unit": "ms", "name": "simple.netmonitor.close.DAMP", "value": 58.85250000006636}, {"lowerIsBetter": true, "replicates": [479.3199999999997, 394.7350000000006, 387.570000000007, 413.4550000000163, 434.1849999999977, 437.3549999999814, 406.0800000000163, 452.2699999999604, 399.125, 446.3500000000349, 411.50500000000466, 397.9100000000326, 452.7399999999907, 436.2399999999907, 390.9549999999581, 401.32499999995343, 403.3149999999441, 415.79000000003725, 415.4899999999907, 391.21000000007916, 386.31500000006054, 446.6850000000559, 448.5700000000652, 414.3800000001211, 381.0200000000186], "unit": "ms", "name": "simple.memory.open.DAMP", "value": 412.4800000000105}, {"lowerIsBetter": true, "replicates": [57.91500000000087, 56.879999999990105, 41.18000000000757, 41.37999999997555, 69.36499999999069, 49.39499999996042, 49.64499999996042, 42.51000000000931, 39.81500000000233, 63.1699999999837, 41.669999999925494, 48.34999999997672, 41.64500000001863, 46.70999999996275, 54.199999999953434, 43.04000000003725, 46.71999999997206, 40.64000000001397, 39.94499999994878, 53.48999999999069, 45.61499999999069, 60.330000000074506, 48.7750000001397, 52.06499999994412, 38.31499999994412], "unit": "ms", "name": "simple.memory.reload.DAMP", "value": 46.714999999967404}, {"lowerIsBetter": true, "replicates": [82.56999999999971, 72.69000000000233, 75.30000000000291, 82.20999999999185, 79.48500000001513, 78.10999999998603, 75.53000000002794, 94.42499999998836, 73.42000000004191, 76.44499999994878, 76.53000000002794, 78.75500000000466, 75.65500000002794, 77.61499999999069, 82.01499999989755, 83.40999999991618, 79.8399999999674, 79.89000000001397, 78.375, 85.87000000011176, 76.47499999997672, 76.0449999999255, 90.9749999998603, 72.10499999998137, 72.49499999987893], "unit": "ms", "name": "simple.saveHeapSnapshot", "value": 77.86249999998836}, {"lowerIsBetter": true, "replicates": [9.940000000002328, 14.369999999995343, 9.330000000001746, 16.06500000000233, 13.480000000010477, 9.205000000016298, 13.005000000004657, 9.834999999962747, 14.315000000002328, 18.389999999955762, 17.849999999976717, 20.760000000009313, 10.130000000004657, 11.690000000060536, 13.135000000009313, 9.385000000009313, 14.630000000004657, 10.440000000060536, 15.70000000006985, 21.70499999995809, 16.114999999990687, 9.180000000167638, 10.885000000009313, 16.850000000093132, 10.334999999962747], "unit": "ms", "name": "simple.readHeapSnapshot", "value": 13.307500000009895}, {"lowerIsBetter": true, "replicates": [4.68999999999869, 4.875, 4.815000000002328, 4.820000000006985, 4.744999999995343, 5.070000000006985, 5.64000000001397, 4.864999999990687, 5.864999999990687, 4.730000000039581, 4.744999999995343, 4.549999999930151, 4.680000000051223, 4.7700000000186265, 4.825000000069849, 4.6049999999813735, 4.6700000000419095, 4.665000000037253, 4.724999999976717, 4.850000000093132, 4.85999999998603, 4.724999999860302, 4.630000000121072, 5.060000000055879, 4.679999999934807], "unit": "ms", "name": "simple.takeCensus", "value": 4.757500000006985}, {"lowerIsBetter": true, "replicates": [37.17499999999927, 49.99000000000524, 43.830000000001746, 26.744999999995343, 52.01999999998952, 41.61499999999069, 40.660000000032596, 48.85499999998137, 42.12000000005355, 45.35499999998137, 36.34499999997206, 37.669999999925494, 26.550000000046566, 41.65999999991618, 38.99499999999534, 43.31499999994412, 37.82500000006985, 43.31499999994412, 44.70000000006985, 59.08499999996275, 42.91500000003725, 38.43000000016764, 44.90999999991618, 40.34000000008382, 41.65499999979511], "unit": "ms", "name": "simple.memory.close.DAMP", "value": 41.889999999984866}, {"lowerIsBetter": true, "replicates": [564.5300000000025, 626.6449999999895, 674.804999999993, 670.125, 696.9249999999884, 622.9650000000256, 627.6949999999488, 603.3150000000023, 656.109999999986, 623.5950000000303, 599.1300000000047, 645.8549999999814, 629.0800000000745, 610.9250000000466, 650.1149999999907, 662.1849999999395, 706.4449999999488, 672.5050000000047, 597.5599999999395, 606.5250000000233, 647.8850000000093, 624.1000000000931, 612.1500000001397, 620.3649999999907, 636.2600000000093], "unit": "ms", "name": "complicated.webconsole.open.DAMP", "value": 628.3875000000116}, {"lowerIsBetter": true, "replicates": [3109.625, 2665.3850000000093, 2657.7850000000035, 2657.1300000000047, 2652.4800000000105, 2642.9749999999767, 2673.320000000007, 2588.7700000000186, 2576.890000000014, 2687.3549999999814, 2580.8099999999395, 2557.890000000014, 2675.795000000042, 2698.9949999999953, 2559.9850000001024, 2555.6500000000233, 2706.04999999993, 2688.4649999999674, 2583.9100000000326, 2595.3249999999534, 2710.069999999949, 2721.2399999999907, 2635.7999999998137, 2704.934999999823, 2693.5], "unit": "ms", "name": "complicated.webconsole.reload.DAMP", "value": 2657.457500000004}, {"lowerIsBetter": true, "replicates": [811.989999999998, 825.1899999999878, 797.7599999999948, 816.7099999999919, 778.0350000000035, 798.179999999993, 800.8549999999814, 1102.125, 868.6600000000326, 810.109999999986, 1120.3649999999907, 1199.8499999999767, 817.4499999999534, 832.125, 1206.4899999999907, 1212.1350000000093, 787.6450000000186, 804.8649999999907, 1144.2900000000373, 1125.8199999999488, 821.1700000000419, 818.714999999851, 1083.75, 805.5149999998976, 832.4350000000559], "unit": "ms", "name": "complicated.webconsole.close.DAMP", "value": 823.1800000000148}, {"lowerIsBetter": true, "replicates": [828.2599999999984, 908.3499999999913, 846.0200000000041, 855.1000000000058, 851.6850000000268, 894.8549999999814, 869.8699999999953, 848.0599999999977, 873.804999999993, 863.4550000000163, 820.1499999999069, 844.2299999999814, 880.9699999999721, 947.7600000000093, 867.0050000000047, 828.4200000000419, 848.6650000000373, 977.140000000014, 840.234999999986, 838.0599999999395, 1107.2099999999627, 887.2800000000279, 837.3600000001024, 883.5, 749.5949999999721], "unit": "ms", "name": "complicated.inspector.open.DAMP", "value": 859.2775000000111}, {"lowerIsBetter": true, "replicates": [2537.654999999999, 2995.8399999999965, 2515.770000000004, 3277.859999999986, 2539.334999999992, 2977.9550000000163, 2967.445000000007, 2537.8850000000093, 2541.1650000000373, 2883.9099999999744, 2499.280000000028, 2554.7399999999907, 2836.3499999999767, 2941.2149999999674, 2544.4749999999767, 2513.795000000042, 2562.1149999999907, 2739.344999999972, 2539.3349999999627, 2511.2099999999627, 2559.7750000001397, 3012.094999999972, 2493.7549999998882, 3011.119999999879, 2930.75], "unit": "ms", "name": "complicated.inspector.reload.DAMP", "value": 2560.945000000065}, {"lowerIsBetter": true, "replicates": [984.3549999999996, 872.8150000000023, 857.4700000000157, 919.5799999999872, 849.4649999999965, 873.9899999999907, 856.8400000000256, 864.5199999999604, 925.7700000000186, 880.9699999999721, 835.1450000000186, 864.0450000000419, 870.5550000000512, 875.8649999999907, 850.2550000000047, 848.0799999999581, 936.4050000000279, 866.734999999986, 853.8000000000466, 874.9150000000373, 893.3449999999721, 860.9500000001863, 860.6649999998044, 868.8900000001304, 863.2350000001024], "unit": "ms", "name": "complicated.inspector.close.DAMP", "value": 865.6274999999732}, {"lowerIsBetter": true, "replicates": [739.6949999999997, 904.0050000000047, 788.9950000000244, 755.9749999999767, 766.5500000000175, 919.359999999986, 907.25, 769.1300000000047, 861.484999999986, 894.6849999999977, 826.0400000000373, 770.859999999986, 913.1650000000373, 902.4599999999627, 771.2150000000838, 764.8249999999534, 793.0050000000047, 902.2900000000373, 829.3399999999674, 758.4500000000698, 816.8100000000559, 920.160000000149, 765.7449999998789, 900.410000000149, 915.8799999998882], "unit": "ms", "name": "complicated.jsdebugger.open.DAMP", "value": 827.6900000000023}, {"lowerIsBetter": true, "replicates": [2935.3700000000026, 2771.1349999999948, 2545.4199999999837, 2588.7399999999907, 2564.310000000027, 2767.429999999993, 2800.844999999972, 2802.1900000000023, 2611.9400000000023, 2707.1699999999837, 2915.07500000007, 2572.640000000014, 2738.414999999921, 2810.314999999944, 2586.945000000065, 2607.305000000051, 2561.1999999999534, 2763.185000000056, 2881.6199999999953, 2819.355000000098, 2571.1649999998044, 2767.25, 2825.3950000000186, 2772.7549999998882, 2744.9950000001118], "unit": "ms", "name": "complicated.jsdebugger.reload.DAMP", "value": 2754.090000000084}, {"lowerIsBetter": true, "replicates": [880.5850000000064, 712.6349999999948, 677.4100000000035, 692.0449999999837, 664.8399999999965, 741.3249999999534, 740.5300000000279, 736.445000000007, 1020.7449999999953, 735.7150000000256, 717.1700000000419, 747.7899999999208, 742.1650000000373, 716.7249999999767, 759.4600000000792, 780.7750000000233, 1047.8549999999814, 733.4350000000559, 700.1650000000373, 755.375, 1109.4149999998044, 715.8350000001956, 735.1850000000559, 722.9299999999348, 735.5700000000652], "unit": "ms", "name": "complicated.jsdebugger.close.DAMP", "value": 735.6425000000454}, {"lowerIsBetter": true, "replicates": [2664.9300000000003, 2978.7899999999936, 2956.5100000000093, 2841.7600000000093, 2866.2050000000163, 2939.0900000000256, 2952.9550000000163, 2945.280000000028, 2242.0050000000047, 2420.1199999999953, 2921.9150000000373, 2601.5049999998882, 2436.284999999916, 2995.609999999986, 3107.960000000079, 2623.0, 2259.6049999999814, 2487.6149999999907, 2846.109999999986, 3123.6600000000326, 2309.7350000001024, 2943.8950000000186, 3009.6650000000373, 2917.7649999998976, 2834.1650000000373], "unit": "ms", "name": "complicated.styleeditor.open.DAMP", "value": 2891.984999999957}, {"lowerIsBetter": true, "replicates": [2673.510000000002, 2778.5999999999913, 2580.9649999999965, 2628.0250000000233, 2940.220000000001, 2753.1599999999744, 2571.640000000014, 2536.2299999999814, 2579.835000000021, 2655.295000000042, 2608.9550000000745, 2512.0100000000093, 2838.25, 2762.359999999986, 2572.6750000000466, 2593.069999999949, 2551.5650000000605, 2823.6450000000186, 2604.4949999999953, 2518.2700000000186, 2573.8549999999814, 2734.255000000121, 2644.5749999999534, 2722.9499999999534, 2582.840000000084], "unit": "ms", "name": "complicated.styleeditor.reload.DAMP", "value": 2606.725000000035}, {"lowerIsBetter": true, "replicates": [1058.0049999999974, 821.2700000000041, 708.0750000000116, 726.7300000000105, 730.1350000000093, 794.3899999999558, 819.789999999979, 746.734999999986, 684.2550000000047, 762.7099999999627, 755.9749999999767, 692.0249999999069, 771.3200000000652, 810.234999999986, 727.4899999999907, 697.6700000000419, 690.5350000000326, 775.4899999999907, 794.1649999999208, 765.9000000000233, 696.6550000000279, 831.0050000001211, 808.2350000001024, 855.7199999999721, 718.9650000000838], "unit": "ms", "name": "complicated.styleeditor.close.DAMP", "value": 759.3424999999697}, {"lowerIsBetter": true, "replicates": [681.1900000000023, 664.6949999999924, 677.8099999999977, 678.0650000000023, 693.75, 703.3499999999767, 736.7399999999907, 907.289999999979, 688.8800000000047, 799.2300000000396, 866.375, 604.8649999999907, 1203.454999999958, 916.8499999999767, 856.4599999999627, 749.0349999999162, 683.3100000000559, 1173.1999999999534, 766.1700000000419, 851.1600000000326, 691.2300000002142, 792.3349999999627, 785.2349999998696, 793.089999999851, 846.4699999999721], "unit": "ms", "name": "complicated.performance.open.DAMP", "value": 775.7024999999558}, {"lowerIsBetter": true, "replicates": [2301.375, 2700.850000000006, 2440.9500000000116, 2481.4800000000105, 2310.1999999999825, 2665.4500000000116, 2471.9799999999814, 2466.920000000042, 2490.4400000000023, 2610.4700000000303, 2479.25, 2335.149999999907, 2332.4150000000373, 2418.109999999986, 2368.444999999949, 2524.1699999999255, 2518.3399999999674, 2302.320000000065, 2502.0650000000605, 2370.445000000065, 2542.6450000000186, 2676.369999999879, 2518.344999999972, 2717.559999999823, 2494.719999999972], "unit": "ms", "name": "complicated.performance.reload.DAMP", "value": 2485.9600000000064}, {"lowerIsBetter": true, "replicates": [659.2700000000041, 702.3350000000064, 1145.570000000007, 1144.1499999999942, 672.679999999993, 700.1549999999697, 981.460000000021, 1040.274999999965, 735.7399999999907, 723.210000000021, 1064.420000000042, 647.1550000000279, 689.1300000000047, 696.7149999999674, 1073.890000000014, 729.7950000000419, 687.9550000000745, 681.9050000000279, 1023.0199999999022, 1033.890000000014, 709.3999999999069, 688.0400000000373, 1022.1650000000373, 707.4699999999721, 1082.5249999999069], "unit": "ms", "name": "complicated.performance.close.DAMP", "value": 726.5025000000314}, {"lowerIsBetter": true, "replicates": [592.1849999999977, 651.5800000000017, 678.5299999999988, 670.179999999993, 603.3500000000058, 673.9899999999907, 665.1399999999558, 666.4749999999767, 758.359999999986, 673.3450000000303, 653.5849999999627, 675.015000000014, 781.4350000000559, 730.0899999999674, 649.6650000000373, 1083.0950000000885, 947.1199999999953, 728.515000000014, 661.3049999999348, 659.0399999999208, 808.4749999998603, 696.589999999851, 655.1650000000373, 745.1550000000279, 674.5949999999721], "unit": "ms", "name": "complicated.netmonitor.open.DAMP", "value": 674.2924999999814}, {"lowerIsBetter": true, "replicates": [2809.3499999999985, 2741.645000000004, 2868.1449999999895, 2842.9199999999837, 2983.88499999998, 2953.5750000000116, 2800.5499999999884, 2786.75, 3434.7600000000093, 2949.1500000000233, 2763.7099999999627, 2899.54999999993, 2858.5999999999767, 2917.234999999986, 2806.384999999893, 2846.780000000028, 2951.554999999935, 2887.4899999999907, 2783.5500000000466, 2778.9000000000233, 3344.850000000093, 2887.8000000000466, 3021.8199999998324, 2846.3899999998976, 2815.3349999999627], "unit": "ms", "name": "complicated.netmonitor.reload.DAMP", "value": 2863.372499999983}, {"lowerIsBetter": true, "replicates": [915.6349999999948, 906.9700000000012, 945.4399999999732, 927.820000000007, 1036.804999999993, 992.2000000000116, 931.9100000000326, 888.390000000014, 927.0999999999767, 952.4699999999721, 930.2150000000838, 1073.875, 1275.7149999999674, 954.6049999999814, 931.2850000000326, 934.5049999998882, 914.4549999999581, 926.609999999986, 934.4399999999441, 922.765000000014, 913.2950000001583, 919.589999999851, 1020.9850000001024, 945.4350000000559, 927.8600000001024], "unit": "ms", "name": "complicated.netmonitor.close.DAMP", "value": 931.5975000000326}, {"lowerIsBetter": true, "replicates": [705.1050000000032, 691.8050000000076, 687.359999999986, 721.4200000000128, 751.7950000000128, 713.0400000000373, 662.414999999979, 657.195000000007, 777.8449999999721, 710.9749999999767, 646.4100000000326, 790.4750000000931, 703.7299999999814, 725.3449999999721, 641.2850000000326, 649.7700000000186, 765.4550000000745, 724.3399999999674, 652.1199999999953, 657.3000000000466, 761.7399999999907, 712.7399999999907, 855.8700000001118, 739.1750000000466, 658.4899999999907], "unit": "ms", "name": "complicated.memory.open.DAMP", "value": 711.8574999999837}, {"lowerIsBetter": true, "replicates": [2757.5499999999956, 2811.6600000000035, 2627.4100000000035, 2630.6999999999825, 2779.415000000008, 2372.984999999986, 2543.984999999986, 2447.6699999999837, 2618.8399999999674, 2382.875, 2432.554999999935, 2455.375, 2379.680000000051, 2374.9899999999907, 2425.7700000000186, 2362.795000000042, 2623.7399999999907, 2361.564999999944, 2585.2299999999814, 2384.530000000028, 2617.024999999907, 2346.524999999907, 2622.090000000084, 2397.214999999851, 2390.1149999999907], "unit": "ms", "name": "complicated.memory.reload.DAMP", "value": 2440.1124999999593}, {"lowerIsBetter": true, "replicates": [2077.0599999999977, 1929.9300000000076, 1721.8199999999779, 1713.3999999999942, 1510.1700000000128, 1565.765000000014, 1527.670000000042, 1640.1750000000466, 1620.3549999999814, 1527.3850000000093, 1683.5050000000047, 1655.7900000000373, 1530.1300000000047, 1734.6900000000605, 1628.155000000028, 1529.6900000000605, 2045.1999999999534, 1502.5250000000233, 1561.1350000000093, 1461.545000000042, 2141.225000000093, 1502.035000000149, 1462.625, 1599.3000000000466, 1644.0449999999255], "unit": "ms", "name": "complicated.saveHeapSnapshot", "value": 1609.827500000014}, {"lowerIsBetter": true, "replicates": [348.5350000000035, 312.3550000000105, 329.7849999999744, 332.7950000000128, 299.79999999998836, 310.8299999999581, 258.46999999997206, 257.16499999997905, 329.875, 286.3150000000023, 251.7399999999907, 262.33500000007916, 303.39000000001397, 310.08499999996275, 239.60499999998137, 247.5350000000326, 329.1700000000419, 278.625, 272.4550000000745, 247.83500000007916, 311.37000000011176, 304.214999999851, 282.90500000002794, 308.09499999997206, 240.5250000001397], "unit": "ms", "name": "complicated.readHeapSnapshot", "value": 293.05749999999534}, {"lowerIsBetter": true, "replicates": [147.3350000000064, 142.94500000000698, 143.19999999998254, 144.52500000002328, 136.01999999996042, 140.9899999999907, 143.5899999999674, 146.82000000000698, 147.52999999996973, 140.875, 150.27500000002328, 105.76000000000931, 142.70000000006985, 153.36999999999534, 144.875, 141.65499999991152, 146.3399999999674, 140.4100000000326, 153.85999999998603, 144.14500000001863, 152.62999999988824, 140.18500000005588, 135.03499999991618, 138.44499999983236, 142.39999999990687], "unit": "ms", "name": "complicated.takeCensus", "value": 143.07249999999476}, {"lowerIsBetter": true, "replicates": [281.5599999999977, 330.2100000000064, 775.8000000000175, 772.8149999999732, 296.9100000000326, 288.99499999999534, 346.0449999999837, 367.1699999999837, 820.4200000000419, 289.2749999999651, 371.0, 307.89999999990687, 305.0350000000326, 367.6049999999814, 416.5449999999255, 297.9299999999348, 355.54000000003725, 296.6149999999907, 328.86999999999534, 378.95999999996275, 360.42500000004657, 318.6899999999441, 296.089999999851, 291.2399999999907, 373.7949999999255], "unit": "ms", "name": "complicated.memory.close.DAMP", "value": 338.12749999999505}, {"lowerIsBetter": true, "replicates": [122.23500000000058, 118.93499999999767, 117.84500000000116, 116.89999999999418, 110.75, 105.43499999999767, 104.84999999997672, 105.90000000002328, 120.97499999997672, 108.0, 116.6600000000326, 114.38500000000931, 108.52500000002328, 105.97999999998137, 117.67500000004657, 128.6350000000093, 109.63000000000466, 105.31999999994878, 111.86499999999069, 108.19500000006519, 114.89500000001863, 106.07000000006519, 110.71999999997206, 113.52000000001863, 108.49500000011176], "unit": "ms", "name": "console.bulklog", "value": 110.73499999998603}, {"lowerIsBetter": true, "replicates": [29.0, 27.0, 28.0, 29.0, 32.0, 29.0, 33.0, 34.0, 28.0, 29.0, 34.0, 32.0, 30.0, 32.0, 34.0, 32.0, 28.0, 29.0, 34.0, 33.0, 27.0, 29.0, 29.0, 30.0, 34.0], "unit": "ms", "name": "console.streamlog", "value": 30.0}], "name": "damp", "value": 276.8410146797941}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [70.05999999999767, 75.63499999999476, 69.30000000000291, 74.83999999999651, 77.77000000000407], "unit": "ms", "name": "amazon.com", "value": 75.23749999999563}, {"lowerIsBetter": true, "replicates": [65.58999999999651, 74.88499999999476, 67.88500000000931, 68.53499999998894, 67.61500000000524], "unit": "ms", "name": "cgi.ebay.com", "value": 68.20999999999913}, {"lowerIsBetter": true, "replicates": [71.13999999999942, 64.76499999999942, 86.82499999999709, 65.69499999999243, 69.19999999999709], "unit": "ms", "name": "163.com", "value": 67.44749999999476}, {"lowerIsBetter": true, "replicates": [60.445000000006985, 55.595000000001164, 57.29000000000815, 57.30999999999767, 57.970000000001164], "unit": "ms", "name": "mail.ru", "value": 57.30000000000291}, {"lowerIsBetter": true, "replicates": [46.46500000001106, 45.29000000000815, 50.245000000009895, 55.11499999999069, 46.15000000000873], "unit": "ms", "name": "bbc.co.uk", "value": 48.19750000000931}, {"lowerIsBetter": true, "replicates": [79.68499999999767, 86.80999999999767, 89.33499999999185, 81.59000000001106, 87.09000000001106], "unit": "ms", "name": "store.apple.com", "value": 86.95000000000437}, {"lowerIsBetter": true, "replicates": [77.06500000000233, 54.24000000000524, 56.080000000001746, 51.98500000000058, 52.11500000000524], "unit": "ms", "name": "imdb.com", "value": 53.17750000000524}, {"lowerIsBetter": true, "replicates": [55.375, 85.625, 57.104999999995925, 55.40999999998894, 67.36500000000524], "unit": "ms", "name": "cnn.com", "value": 62.23500000000058}, {"lowerIsBetter": true, "replicates": [65.67499999998836, 66.81000000001222, 70.08999999999651, 61.745000000009895, 76.69999999999709], "unit": "ms", "name": "sohu.com", "value": 68.45000000000437}, {"lowerIsBetter": true, "replicates": [52.875, 52.794999999998254, 56.94999999999709, 54.145000000004075, 60.36499999999069], "unit": "ms", "name": "youku.com", "value": 55.54750000000058}, {"lowerIsBetter": true, "replicates": [83.69500000000698, 87.17499999998836, 91.69000000000233, 99.30000000000291, 94.91999999999825], "unit": "ms", "name": "ifeng.com", "value": 93.30500000000029}, {"lowerIsBetter": true, "replicates": [49.645000000004075, 71.30999999999767, 58.94999999999709, 64.55000000000291, 53.5399999999936], "unit": "ms", "name": "tudou.com", "value": 61.75}, {"lowerIsBetter": true, "replicates": [49.970000000001164, 57.654999999998836, 45.44499999999243, 44.00999999999476, 58.08499999999185], "unit": "ms", "name": "chemistry.about.com", "value": 51.549999999995634}, {"lowerIsBetter": true, "replicates": [41.794999999998254, 72.36999999999534, 45.720000000001164, 39.029999999998836, 41.34000000001106], "unit": "ms", "name": "beatonna.livejournal.com", "value": 43.53000000000611}, {"lowerIsBetter": true, "replicates": [71.32499999999709, 76.1649999999936, 73.0, 68.24000000000524, 66.91999999999825], "unit": "ms", "name": "rakuten.co.jp", "value": 70.62000000000262}, {"lowerIsBetter": true, "replicates": [56.875, 49.88999999999942, 52.57499999999709, 51.93499999999767, 64.98500000000058], "unit": "ms", "name": "uol.com.br", "value": 52.25499999999738}, {"lowerIsBetter": true, "replicates": [47.39000000001397, 49.13999999999942, 47.01000000000931, 49.28500000000349, 50.10000000000582], "unit": "ms", "name": "thepiratebay.org", "value": 49.212500000001455}, {"lowerIsBetter": true, "replicates": [51.320000000006985, 53.01499999999942, 52.970000000001164, 52.220000000001164, 46.794999999998254], "unit": "ms", "name": "page.renren.com", "value": 52.595000000001164}, {"lowerIsBetter": true, "replicates": [62.45000000001164, 64.99499999999534, 61.40999999998894, 66.66999999999825, 75.23000000001048], "unit": "ms", "name": "chinaz.com", "value": 65.8324999999968}, {"lowerIsBetter": true, "replicates": [56.544999999998254, 71.20500000000175, 60.57499999999709, 60.26499999999942, 59.44499999999243], "unit": "ms", "name": "globo.com", "value": 60.419999999998254}, {"lowerIsBetter": true, "replicates": [48.245000000009895, 44.73500000000058, 42.88499999999476, 42.52499999999418, 44.029999999998836], "unit": "ms", "name": "spiegel.de", "value": 43.4574999999968}, {"lowerIsBetter": true, "replicates": [47.45999999999185, 51.44000000000233, 52.11000000000058, 53.19999999999709, 56.33999999999651], "unit": "ms", "name": "dailymotion.com", "value": 52.654999999998836}, {"lowerIsBetter": true, "replicates": [66.69499999999243, 75.09500000000116, 59.16000000000349, 65.64999999999418, 69.22500000000582], "unit": "ms", "name": "goo.ne.jp", "value": 67.4375}, {"lowerIsBetter": true, "replicates": [57.229999999995925, 58.5, 54.71499999999651, 50.429999999993015, 49.05999999999767], "unit": "ms", "name": "stackoverflow.com", "value": 52.57249999999476}, {"lowerIsBetter": true, "replicates": [46.669999999998254, 53.14999999999418, 47.070000000006985, 44.48500000000058, 44.11500000000524], "unit": "ms", "name": "ezinearticles.com", "value": 45.77750000000378}, {"lowerIsBetter": true, "replicates": [47.33999999999651, 61.68000000000757, 60.09000000001106, 46.10500000001048, 45.97499999999127], "unit": "ms", "name": "huffingtonpost.com", "value": 53.09750000001077}, {"lowerIsBetter": true, "replicates": [45.98500000000058, 46.29000000000815, 55.0, 47.929999999993015, 50.354999999995925], "unit": "ms", "name": "media.photobucket.com", "value": 49.14249999999447}, {"lowerIsBetter": true, "replicates": [43.08999999999651, 48.18000000000757, 61.154999999998836, 39.67500000000291, 41.179999999993015], "unit": "ms", "name": "imgur.com", "value": 44.68000000000029}, {"lowerIsBetter": true, "replicates": [50.15999999998894, 51.74000000000524, 57.16000000000349, 58.96499999999651, 49.929999999993015], "unit": "ms", "name": "reddit.com", "value": 54.450000000004366}, {"lowerIsBetter": true, "replicates": [50.96499999999651, 59.75999999999476, 55.11999999999534, 54.01499999999942, 60.11000000000058], "unit": "ms", "name": "noimpactman.typepad.com", "value": 57.43999999999505}, {"lowerIsBetter": true, "replicates": [53.27499999999418, 71.63999999999942, 53.75, 78.9149999999936, 52.875], "unit": "ms", "name": "myspace.com", "value": 62.69499999999971}, {"lowerIsBetter": true, "replicates": [48.73500000000058, 59.554999999993015, 48.17500000000291, 50.61999999999534, 46.220000000001164], "unit": "ms", "name": "mashable.com", "value": 49.39749999999913}, {"lowerIsBetter": true, "replicates": [57.50500000000466, 53.544999999998254, 55.22500000000582, 73.27999999999884, 60.625], "unit": "ms", "name": "dailymail.co.uk", "value": 57.92500000000291}, {"lowerIsBetter": true, "replicates": [45.5399999999936, 66.66000000000349, 46.304999999993015, 47.83499999999185, 40.54000000000815], "unit": "ms", "name": "whois.domaintools.com", "value": 47.06999999999243}, {"lowerIsBetter": true, "replicates": [70.67999999999302, 62.29999999998836, 53.15999999998894, 49.1649999999936, 59.445000000006985], "unit": "ms", "name": "indiatimes.com", "value": 56.30249999999796}, {"lowerIsBetter": true, "replicates": [44.22500000000582, 51.82499999999709, 52.73500000000058, 51.91500000000815, 44.69000000000233], "unit": "ms", "name": "reuters.com", "value": 51.87000000000262}, {"lowerIsBetter": true, "replicates": [82.38000000000466, 90.13999999999942, 81.72000000000116, 90.55999999999767, 90.01499999999942], "unit": "ms", "name": "xinhuanet.com", "value": 90.07749999999942}, {"lowerIsBetter": true, "replicates": [66.81500000000233, 64.99000000000524, 64.23999999999069, 65.02499999999418, 62.27499999999418], "unit": "ms", "name": "56.com", "value": 64.61499999999796}, {"lowerIsBetter": true, "replicates": [40.52499999999418, 40.080000000001746, 41.2899999999936, 47.929999999993015, 38.995000000009895], "unit": "ms", "name": "bild.de", "value": 40.68499999999767}, {"lowerIsBetter": true, "replicates": [57.84999999999127, 60.020000000004075, 54.49000000000524, 50.91000000000349, 49.080000000001746], "unit": "ms", "name": "guardian.co.uk", "value": 52.700000000004366}, {"lowerIsBetter": true, "replicates": [75.11000000000058, 74.22000000000116, 72.72500000000582, 71.04000000000815, 76.61500000000524], "unit": "ms", "name": "naver.com", "value": 73.47250000000349}, {"lowerIsBetter": true, "replicates": [58.82499999999709, 61.095000000001164, 61.49000000000524, 59.43499999999767, 57.84999999999127], "unit": "ms", "name": "yelp.com", "value": 60.26499999999942}, {"lowerIsBetter": true, "replicates": [61.05000000000291, 59.4149999999936, 51.029999999998836, 54.50500000000466, 56.51499999999942], "unit": "ms", "name": "wsj.com", "value": 55.51000000000204}, {"lowerIsBetter": true, "replicates": [54.320000000006985, 43.544999999998254, 43.61000000000058, 60.080000000001746, 55.9600000000064], "unit": "ms", "name": "google.com", "value": 49.78500000000349}, {"lowerIsBetter": true, "replicates": [86.07000000000698, 67.23500000000058, 76.14500000000407, 65.98500000000058, 63.96500000001106], "unit": "ms", "name": "xunlei.com", "value": 66.61000000000058}, {"lowerIsBetter": true, "replicates": [52.63999999999942, 48.17500000000291, 45.75, 49.05999999999767, 49.69000000000233], "unit": "ms", "name": "aljazeera.net", "value": 48.61750000000029}, {"lowerIsBetter": true, "replicates": [57.58999999999651, 55.229999999995925, 58.23500000000058, 51.7899999999936, 51.5399999999936], "unit": "ms", "name": "w3.org", "value": 53.50999999999476}, {"lowerIsBetter": true, "replicates": [76.45500000000175, 73.86999999999534, 73.77000000000407, 73.56999999999243, 65.95999999999185], "unit": "ms", "name": "homeway.com.cn", "value": 73.66999999999825}, {"lowerIsBetter": true, "replicates": [51.404999999998836, 65.29499999999825, 46.38499999999476, 47.70999999999185, 47.070000000006985], "unit": "ms", "name": "youtube.com", "value": 47.38999999999942}, {"lowerIsBetter": true, "replicates": [83.40499999999884, 97.43499999999767, 109.59500000000116, 93.19999999999709, 82.21499999999651], "unit": "ms", "name": "people.com.cn", "value": 95.31749999999738}], "name": "tps", "value": 58.039663179129114}]} 15:19:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"damp": {"url": "http://graphs.mozilla.org/graph.html#tests=[[327,132,35]]", "result": "276.84"}, "tps": {"url": "http://graphs.mozilla.org/graph.html#tests=[[329,132,35]]", "result": "58.04"}}} 15:19:14 INFO - Return code: 0 15:19:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:19:14 INFO - # TBPL SUCCESS # 15:19:14 INFO - Running post-action listener: _resource_record_post_action 15:19:14 INFO - Running post-run listener: _resource_record_post_run 15:19:15 INFO - Total resource usage - Wall time: 1835s; CPU: 14.0%; Read bytes: 4096; Write bytes: 953835520; Read time: 12; Write time: 997352 15:19:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79319040; Read time: 0; Write time: 84256 15:19:15 INFO - run-tests - Wall time: 1819s; CPU: 14.0%; Read bytes: 4096; Write bytes: 873918464; Read time: 12; Write time: 913060 15:19:15 INFO - Running post-run listener: _upload_blobber_files 15:19:15 INFO - Blob upload gear active. 15:19:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:15 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 15:19:15 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:19:15 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:19:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/g2_raw.log ... 15:19:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: g2_raw.log: uploaded 15:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:18 INFO - (blobuploader) - INFO - Done attempting. 15:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log ... 15:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: g2_errorsummary.log: uploaded 15:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:18 INFO - (blobuploader) - INFO - Done attempting. 15:19:18 INFO - (blobuploader) - INFO - Iteration through files over. 15:19:18 INFO - Return code: 0 15:19:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:19:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:19:18 INFO - Setting buildbot property blobber_files to {"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86082da4bfecfd9f46773a3c5512d75e97c8ba2dd35a6f21c3fe094663232892097ee6e7ceb39a34f7f2e73a1c6c6f959401ae8c2975bca8393a492d7b57d0d", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e7a95c078976211c8d9f0f8b7a6acc4edf20fcd4412d2aa0fb33a5d53d162c15974e9dd88a5d6633de44829d02824158687891a9a2960edc09d55c01e8dc69b"} 15:19:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:19:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:19:18 INFO - Contents: 15:19:18 INFO - blobber_files:{"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86082da4bfecfd9f46773a3c5512d75e97c8ba2dd35a6f21c3fe094663232892097ee6e7ceb39a34f7f2e73a1c6c6f959401ae8c2975bca8393a492d7b57d0d", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e7a95c078976211c8d9f0f8b7a6acc4edf20fcd4412d2aa0fb33a5d53d162c15974e9dd88a5d6633de44829d02824158687891a9a2960edc09d55c01e8dc69b"} 15:19:18 INFO - Running post-run listener: copy_logs_to_upload_dir 15:19:18 INFO - Copying logs to upload dir... 15:19:18 INFO - mkdir: /builds/slave/test/build/upload/logs 15:19:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1884.589105 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 31 mins, 25 secs) (at 2016-01-27 15:19:19.004021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 15:19:19.007988) ========= 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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86082da4bfecfd9f46773a3c5512d75e97c8ba2dd35a6f21c3fe094663232892097ee6e7ceb39a34f7f2e73a1c6c6f959401ae8c2975bca8393a492d7b57d0d", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e7a95c078976211c8d9f0f8b7a6acc4edf20fcd4412d2aa0fb33a5d53d162c15974e9dd88a5d6633de44829d02824158687891a9a2960edc09d55c01e8dc69b"} build_url:https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011470 build_url: 'https://queue.taskcluster.net/v1/task/dzkxuUpnSJeD_DXel1n24g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86082da4bfecfd9f46773a3c5512d75e97c8ba2dd35a6f21c3fe094663232892097ee6e7ceb39a34f7f2e73a1c6c6f959401ae8c2975bca8393a492d7b57d0d", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e7a95c078976211c8d9f0f8b7a6acc4edf20fcd4412d2aa0fb33a5d53d162c15974e9dd88a5d6633de44829d02824158687891a9a2960edc09d55c01e8dc69b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 15:19:19.035102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 15:19:19.035406) ========= 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=7de08804244eb36560b44971000001c3-1453925193.673615-37183540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 15:19:19.116093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 15:19:19.116393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 15:19:19.119718) ========= ========= Total master_lag: 0.78 =========