builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1466675999.5 results: success (0) buildid: 20160623021224 builduid: 688d99bcfe6c48b295ff0afc494499bc revision: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.496717) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.497661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.498272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.515282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.515933) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 02:59:59-- 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% 220M=0s 2016-06-23 02:59:59 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.613954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.614316) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.664566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:59:59.665092) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 --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 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 --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=2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 03:00:00,016 truncating revision to first 12 chars 2016-06-23 03:00:00,016 Setting DEBUG logging. 2016-06-23 03:00:00,016 attempt 1/10 2016-06-23 03:00:00,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f29b11f5ae8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 03:00:00,287 unpacking tar archive at: fx-team-5f29b11f5ae8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:00:00.293268) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 03:00:00.293648) ========= script_repo_revision: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 03:00:00.294173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 03:00:00.294510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 03:00:00.308366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-23 03:00:00.308698) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', 'dromaeojs', '--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=2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:00:00 INFO - MultiFileLogger online at 20160623 03:00:00 in /builds/slave/test 03:00:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:00:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:00 INFO - {'append_to_log': False, 03:00:00 INFO - 'base_work_dir': '/builds/slave/test', 03:00:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:00:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:00 INFO - 'branch': 'Fx-Team-Non-PGO', 03:00:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:00 INFO - 'config_files': ('talos/linux_config.py',), 03:00:00 INFO - 'default_actions': ('clobber', 03:00:00 INFO - 'read-buildbot-config', 03:00:00 INFO - 'download-and-extract', 03:00:00 INFO - 'populate-webroot', 03:00:00 INFO - 'create-virtualenv', 03:00:00 INFO - 'install', 03:00:00 INFO - 'run-tests'), 03:00:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:00 INFO - 'download_minidump_stackwalk': True, 03:00:00 INFO - 'download_symbols': 'ondemand', 03:00:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:00 INFO - 'installer_path': 'installer.exe', 03:00:00 INFO - 'log_level': 'info', 03:00:00 INFO - 'log_name': 'talos', 03:00:00 INFO - 'log_to_console': True, 03:00:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:00:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:00:00 INFO - 'opt_config_files': (), 03:00:00 INFO - 'pip_index': False, 03:00:00 INFO - 'sps_profile': False, 03:00:00 INFO - 'sps_profile_interval': 0, 03:00:00 INFO - 'suite': 'dromaeojs', 03:00:00 INFO - 'system_bits': '32', 03:00:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:00 INFO - 'title': 'talos-linux64-ix-012', 03:00:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:00 INFO - 'use_talos_json': True, 03:00:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:00 INFO - 'work_dir': 'build'} 03:00:00 INFO - ##### 03:00:00 INFO - ##### Running clobber step. 03:00:00 INFO - ##### 03:00:00 INFO - Running pre-action listener: _resource_record_pre_action 03:00:00 INFO - Running main action method: clobber 03:00:00 INFO - rmtree: /builds/slave/test/build 03:00:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:01 INFO - Running post-action listener: _resource_record_post_action 03:00:01 INFO - ##### 03:00:01 INFO - ##### Finished clobber step (success) 03:00:01 INFO - ##### 03:00:01 INFO - ##### 03:00:01 INFO - ##### Running read-buildbot-config step. 03:00:01 INFO - ##### 03:00:01 INFO - Running pre-action listener: _resource_record_pre_action 03:00:01 INFO - Running main action method: read_buildbot_config 03:00:01 INFO - Using buildbot properties: 03:00:01 INFO - { 03:00:01 INFO - "project": "", 03:00:01 INFO - "product": "firefox", 03:00:01 INFO - "script_repo_revision": "production", 03:00:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:00:01 INFO - "repository": "", 03:00:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:00:01 INFO - "buildid": "20160623021224", 03:00:01 INFO - "pgo_build": "False", 03:00:01 INFO - "basedir": "/builds/slave/test", 03:00:01 INFO - "buildnumber": 3106, 03:00:01 INFO - "slavename": "talos-linux64-ix-012", 03:00:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:00:01 INFO - "platform": "ubuntu64_hw", 03:00:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:00:01 INFO - "branch": "fx-team", 03:00:01 INFO - "repo_path": "integration/fx-team", 03:00:01 INFO - "revision": "5f29b11f5ae8ce218baf26ad8e19340f6ee35b70", 03:00:01 INFO - "stage_platform": "linux64", 03:00:01 INFO - "builduid": "688d99bcfe6c48b295ff0afc494499bc", 03:00:01 INFO - "slavebuilddir": "test" 03:00:01 INFO - } 03:00:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:00:01 INFO - Running post-action listener: _resource_record_post_action 03:00:01 INFO - ##### 03:00:01 INFO - ##### Finished read-buildbot-config step (success) 03:00:01 INFO - ##### 03:00:01 INFO - ##### 03:00:01 INFO - ##### Running download-and-extract step. 03:00:01 INFO - ##### 03:00:01 INFO - Running pre-action listener: _resource_record_pre_action 03:00:01 INFO - Running main action method: download_and_extract 03:00:01 INFO - mkdir: /builds/slave/test/build/tests 03:00:01 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')]} 03:00:01 INFO - https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:00:02 INFO - Downloaded 1361 bytes. 03:00:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:00:02 INFO - Using the following test package requirements: 03:00:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:00:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:00:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:00:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'jsshell-linux-x86_64.zip'], 03:00:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:00:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:00:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:00:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:00:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:00:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:00:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:00:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:00:02 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')]} 03:00:02 INFO - https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:00:04 INFO - Downloaded 22709579 bytes. 03:00:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:00:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:00:05 INFO - Return code: 0 03:00:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:00:05 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')]} 03:00:05 INFO - https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:00:06 INFO - Downloaded 22709579 bytes. 03:00:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:00:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:00:08 INFO - Return code: 0 03:00:08 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')]} 03:00:08 INFO - https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:00:09 INFO - Downloaded 14405384 bytes. 03:00:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:00:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:00:09 INFO - Return code: 0 03:00: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')]} 03:00:09 INFO - https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:00:10 INFO - Downloaded 56246428 bytes. 03:00:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:10 INFO - mkdir: /builds/slave/test/properties 03:00:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:10 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:10 INFO - Contents: 03:00:10 INFO - build_url:https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:00:11 INFO - Running post-action listener: _resource_record_post_action 03:00:11 INFO - Running post-action listener: set_extra_try_arguments 03:00:11 INFO - ##### 03:00:11 INFO - ##### Finished download-and-extract step (success) 03:00:11 INFO - ##### 03:00:11 INFO - ##### 03:00:11 INFO - ##### Running populate-webroot step. 03:00:11 INFO - ##### 03:00:11 INFO - Running pre-action listener: _resource_record_pre_action 03:00:11 INFO - Running main action method: populate_webroot 03:00:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:11 INFO - '--tppagecycles', 03:00:11 INFO - '7'], 03:00:11 INFO - 'tests': ['tsvgm']}}, 03:00:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['damp', 'tps']}, 03:00:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'tests': ['damp', 'tps']}, 03:00:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['dromaeo_dom']}, 03:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['basic_compositor_video']}, 03:00:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:00:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['a11yr', 03:00:11 INFO - 'ts_paint', 03:00:11 INFO - 'tpaint', 03:00:11 INFO - 'sessionrestore', 03:00:11 INFO - 'sessionrestore_no_auto_restore', 03:00:11 INFO - 'tabpaint']}, 03:00:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:11 INFO - 'ts_paint', 03:00:11 INFO - 'tpaint', 03:00:11 INFO - 'sessionrestore', 03:00:11 INFO - 'sessionrestore_no_auto_restore', 03:00:11 INFO - 'tabpaint']}, 03:00:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:11 INFO - 'ts_paint', 03:00:11 INFO - 'tpaint', 03:00:11 INFO - 'sessionrestore', 03:00:11 INFO - 'sessionrestore_no_auto_restore', 03:00:11 INFO - 'tabpaint']}, 03:00:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:11 INFO - 'ts_paint', 03:00:11 INFO - 'tpaint', 03:00:11 INFO - 'sessionrestore', 03:00:11 INFO - 'sessionrestore_no_auto_restore', 03:00:11 INFO - 'tabpaint']}, 03:00:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['a11yr', 03:00:11 INFO - 'ts_paint', 03:00:11 INFO - 'tpaint', 03:00:11 INFO - 'sessionrestore', 03:00:11 INFO - 'sessionrestore_no_auto_restore', 03:00:11 INFO - 'tabpaint']}, 03:00:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['a11yr', 03:00:11 INFO - 'ts_paint', 03:00:11 INFO - 'tpaint', 03:00:11 INFO - 'sessionrestore', 03:00:11 INFO - 'sessionrestore_no_auto_restore', 03:00:11 INFO - 'tabpaint']}, 03:00:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['tsvgx', 03:00:11 INFO - 'tsvgr_opacity', 03:00:11 INFO - 'tart', 03:00:11 INFO - 'tscrollx', 03:00:11 INFO - 'cart']}, 03:00:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:11 INFO - 'tsvgr_opacity', 03:00:11 INFO - 'tart', 03:00:11 INFO - 'tscrollx', 03:00:11 INFO - 'cart']}, 03:00:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'talos_options': ['--disable-e10s'], 03:00:11 INFO - 'tests': ['tp5o']}, 03:00:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'tests': ['tp5o']}, 03:00:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'talos_options': ['--disable-e10s', 03:00:11 INFO - '--xperf_path', 03:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:11 INFO - 'tests': ['tp5n']}, 03:00:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:11 INFO - 'talos_options': ['--xperf_path', 03:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:11 INFO - 'tests': ['tp5n']}}, 03:00:11 INFO - 'talos.zip': {'path': '', 03:00:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:11 INFO - Running post-action listener: _resource_record_post_action 03:00:11 INFO - ##### 03:00:11 INFO - ##### Finished populate-webroot step (success) 03:00:11 INFO - ##### 03:00:11 INFO - ##### 03:00:11 INFO - ##### Running create-virtualenv step. 03:00:11 INFO - ##### 03:00:11 INFO - Running pre-action listener: _resource_record_pre_action 03:00:11 INFO - Running main action method: create_virtualenv 03:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:11 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 03:00:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:11 INFO - Using real prefix '/usr' 03:00:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:14 INFO - Installing pip.................done. 03:00:14 INFO - Return code: 0 03:00:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:14 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')]} 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 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')]} 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 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 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00:14 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 03:00:14 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 03:00:14 INFO - Using env: {'DISPLAY': ':0', 03:00:14 INFO - 'HOME': '/home/cltbld', 03:00:14 INFO - 'LANG': 'en_US.UTF-8', 03:00:14 INFO - 'LANGUAGE': 'en_US:en', 03:00:14 INFO - 'LOGNAME': 'cltbld', 03:00:14 INFO - 'MAIL': '/var/mail/cltbld', 03:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:14 INFO - 'MOZ_NO_REMOTE': '1', 03:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:14 INFO - 'NO_EM_RESTART': '1', 03:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:14 INFO - 'PWD': '/builds/slave/test', 03:00:14 INFO - 'SHELL': '/bin/bash', 03:00:14 INFO - 'SHLVL': '1', 03:00:14 INFO - 'TERM': 'linux', 03:00:14 INFO - 'TMOUT': '86400', 03:00:14 INFO - 'USER': 'cltbld', 03:00:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:14 INFO - '_': '/tools/buildbot/bin/python'} 03:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:14 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 03:00:14 INFO - Cleaning up... 03:00:14 INFO - Return code: 0 03:00:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:14 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')]} 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 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')]} 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00:14 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>=3.1.1'] in /builds/slave/test/build 03:00:14 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>=3.1.1 03:00:14 INFO - Using env: {'DISPLAY': ':0', 03:00:14 INFO - 'HOME': '/home/cltbld', 03:00:14 INFO - 'LANG': 'en_US.UTF-8', 03:00:14 INFO - 'LANGUAGE': 'en_US:en', 03:00:14 INFO - 'LOGNAME': 'cltbld', 03:00:14 INFO - 'MAIL': '/var/mail/cltbld', 03:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:14 INFO - 'MOZ_NO_REMOTE': '1', 03:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:14 INFO - 'NO_EM_RESTART': '1', 03:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:14 INFO - 'PWD': '/builds/slave/test', 03:00:14 INFO - 'SHELL': '/bin/bash', 03:00:14 INFO - 'SHLVL': '1', 03:00:14 INFO - 'TERM': 'linux', 03:00:14 INFO - 'TMOUT': '86400', 03:00:14 INFO - 'USER': 'cltbld', 03:00:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:14 INFO - '_': '/tools/buildbot/bin/python'} 03:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:14 INFO - Downloading/unpacking psutil>=3.1.1 03:00:14 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 03:00:14 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 03:00:14 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 03:00:14 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 03:00:14 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 03:00:14 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 03:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:16 INFO - Installing collected packages: psutil 03:00:16 INFO - Running setup.py install for psutil 03:00:16 INFO - building 'psutil._psutil_linux' extension 03:00:16 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 03:00:17 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 03:00:17 INFO - building 'psutil._psutil_posix' extension 03:00:17 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 03:00:17 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 03:00:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:17 INFO - Successfully installed psutil 03:00:17 INFO - Cleaning up... 03:00:17 INFO - Return code: 0 03:00:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:00: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 mozsystemmonitor==0.3 03:00:17 INFO - Using env: {'DISPLAY': ':0', 03:00:17 INFO - 'HOME': '/home/cltbld', 03:00:17 INFO - 'LANG': 'en_US.UTF-8', 03:00:17 INFO - 'LANGUAGE': 'en_US:en', 03:00:17 INFO - 'LOGNAME': 'cltbld', 03:00:17 INFO - 'MAIL': '/var/mail/cltbld', 03:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:17 INFO - 'MOZ_NO_REMOTE': '1', 03:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:17 INFO - 'NO_EM_RESTART': '1', 03:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:17 INFO - 'PWD': '/builds/slave/test', 03:00:17 INFO - 'SHELL': '/bin/bash', 03:00:17 INFO - 'SHLVL': '1', 03:00:17 INFO - 'TERM': 'linux', 03:00:17 INFO - 'TMOUT': '86400', 03:00:17 INFO - 'USER': 'cltbld', 03:00:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:17 INFO - '_': '/tools/buildbot/bin/python'} 03:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:19 INFO - Installing collected packages: mozsystemmonitor 03:00:19 INFO - Running setup.py install for mozsystemmonitor 03:00:19 INFO - Successfully installed mozsystemmonitor 03:00:19 INFO - Cleaning up... 03:00:19 INFO - Return code: 0 03:00:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:19 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00:19 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==2.5.1'] in /builds/slave/test/build 03:00:19 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==2.5.1 03:00:19 INFO - Using env: {'DISPLAY': ':0', 03:00:19 INFO - 'HOME': '/home/cltbld', 03:00:19 INFO - 'LANG': 'en_US.UTF-8', 03:00:19 INFO - 'LANGUAGE': 'en_US:en', 03:00:19 INFO - 'LOGNAME': 'cltbld', 03:00:19 INFO - 'MAIL': '/var/mail/cltbld', 03:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:19 INFO - 'MOZ_NO_REMOTE': '1', 03:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:19 INFO - 'NO_EM_RESTART': '1', 03:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:19 INFO - 'PWD': '/builds/slave/test', 03:00:19 INFO - 'SHELL': '/bin/bash', 03:00:19 INFO - 'SHLVL': '1', 03:00:19 INFO - 'TERM': 'linux', 03:00:19 INFO - 'TMOUT': '86400', 03:00:19 INFO - 'USER': 'cltbld', 03:00:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:19 INFO - '_': '/tools/buildbot/bin/python'} 03:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:19 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:21 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 03:00:21 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 03:00:21 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 03:00:21 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 03:00:21 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 03:00:21 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 03:00:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:22 INFO - warning: no files found matching '*.txt' 03:00:22 INFO - no previously-included directories found matching 'build' 03:00:22 INFO - no previously-included directories found matching 'dist' 03:00:22 INFO - no previously-included directories found matching '.git*' 03:00:22 INFO - Installing collected packages: jsonschema, functools32 03:00:22 INFO - Running setup.py install for functools32 03:00:22 INFO - warning: no files found matching '*.txt' 03:00:22 INFO - no previously-included directories found matching 'build' 03:00:22 INFO - no previously-included directories found matching 'dist' 03:00:22 INFO - no previously-included directories found matching '.git*' 03:00:22 INFO - Successfully installed jsonschema functools32 03:00:22 INFO - Cleaning up... 03:00:22 INFO - Return code: 0 03:00:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:22 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')]} 03:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:22 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')]} 03:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:22 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 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00:22 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 03:00:22 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 03:00:22 INFO - Using env: {'DISPLAY': ':0', 03:00:22 INFO - 'HOME': '/home/cltbld', 03:00:22 INFO - 'LANG': 'en_US.UTF-8', 03:00:22 INFO - 'LANGUAGE': 'en_US:en', 03:00:22 INFO - 'LOGNAME': 'cltbld', 03:00:22 INFO - 'MAIL': '/var/mail/cltbld', 03:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:22 INFO - 'MOZ_NO_REMOTE': '1', 03:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:22 INFO - 'NO_EM_RESTART': '1', 03:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:22 INFO - 'PWD': '/builds/slave/test', 03:00:22 INFO - 'SHELL': '/bin/bash', 03:00:22 INFO - 'SHLVL': '1', 03:00:22 INFO - 'TERM': 'linux', 03:00:22 INFO - 'TMOUT': '86400', 03:00:22 INFO - 'USER': 'cltbld', 03:00:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:22 INFO - '_': '/tools/buildbot/bin/python'} 03:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:22 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:22 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 03:00:22 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 03:00:22 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 03:00:22 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 03:00:22 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 03:00:22 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 03:00:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:24 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 03:00:24 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 03:00:24 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 03:00:24 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 03:00:24 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 03:00:24 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 03:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:24 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 03:00:24 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 03:00:24 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 03:00:24 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 03:00:24 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 03:00:24 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 03:00:25 INFO - Downloading docopt-0.6.1.tar.gz 03:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:25 INFO - Running setup.py install for blobuploader 03:00:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:25 INFO - Running setup.py install for requests 03:00:25 INFO - Running setup.py install for docopt 03:00:25 INFO - Successfully installed blobuploader requests docopt 03:00:25 INFO - Cleaning up... 03:00:25 INFO - Return code: 0 03:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:25 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')]} 03:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:25 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')]} 03:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:25 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 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00:25 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 03:00:25 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 03:00:25 INFO - Using env: {'DISPLAY': ':0', 03:00:25 INFO - 'HOME': '/home/cltbld', 03:00:25 INFO - 'LANG': 'en_US.UTF-8', 03:00:25 INFO - 'LANGUAGE': 'en_US:en', 03:00:25 INFO - 'LOGNAME': 'cltbld', 03:00:25 INFO - 'MAIL': '/var/mail/cltbld', 03:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:25 INFO - 'MOZ_NO_REMOTE': '1', 03:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:25 INFO - 'NO_EM_RESTART': '1', 03:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:25 INFO - 'PWD': '/builds/slave/test', 03:00:25 INFO - 'SHELL': '/bin/bash', 03:00:25 INFO - 'SHLVL': '1', 03:00:25 INFO - 'TERM': 'linux', 03:00:25 INFO - 'TMOUT': '86400', 03:00:25 INFO - 'USER': 'cltbld', 03:00:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:25 INFO - '_': '/tools/buildbot/bin/python'} 03:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:25 INFO - Running setup.py (path:/tmp/pip-BZdXbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:26 INFO - Running setup.py (path:/tmp/pip-4N9tvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:26 INFO - Running setup.py (path:/tmp/pip-W5KnzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:26 INFO - Running setup.py (path:/tmp/pip-TCndQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:26 INFO - Running setup.py (path:/tmp/pip-earvdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:26 INFO - Running setup.py (path:/tmp/pip-SR_7FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:26 INFO - Running setup.py (path:/tmp/pip-TTjsod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:26 INFO - Running setup.py (path:/tmp/pip-zWJfUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:26 INFO - Running setup.py (path:/tmp/pip-wn91BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:26 INFO - Running setup.py (path:/tmp/pip-8y16wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:26 INFO - Running setup.py (path:/tmp/pip-lHphzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:26 INFO - Running setup.py (path:/tmp/pip-Ni69zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:26 INFO - Running setup.py (path:/tmp/pip-vGX5Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:26 INFO - Running setup.py (path:/tmp/pip-PF37Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:27 INFO - Running setup.py (path:/tmp/pip-yH0qTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:27 INFO - Running setup.py (path:/tmp/pip-vjxizj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:27 INFO - Running setup.py (path:/tmp/pip-Zx0Y77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:27 INFO - Running setup.py install for manifestparser 03:00:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:27 INFO - Running setup.py install for mozcrash 03:00:27 INFO - Running setup.py install for mozdebug 03:00:27 INFO - Running setup.py install for mozdevice 03:00:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:27 INFO - Running setup.py install for mozfile 03:00:27 INFO - Running setup.py install for mozhttpd 03:00:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:27 INFO - Running setup.py install for mozinfo 03:00:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:27 INFO - Running setup.py install for mozInstall 03:00:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Running setup.py install for mozleak 03:00:28 INFO - Running setup.py install for mozlog 03:00:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Running setup.py install for moznetwork 03:00:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Running setup.py install for mozprocess 03:00:28 INFO - Running setup.py install for mozprofile 03:00:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Running setup.py install for mozrunner 03:00:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Running setup.py install for mozscreenshot 03:00:28 INFO - Running setup.py install for moztest 03:00:28 INFO - Running setup.py install for mozversion 03:00:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:28 INFO - Cleaning up... 03:00:29 INFO - Return code: 0 03:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00: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 03:00: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 03:00:29 INFO - Using env: {'DISPLAY': ':0', 03:00:29 INFO - 'HOME': '/home/cltbld', 03:00:29 INFO - 'LANG': 'en_US.UTF-8', 03:00:29 INFO - 'LANGUAGE': 'en_US:en', 03:00:29 INFO - 'LOGNAME': 'cltbld', 03:00:29 INFO - 'MAIL': '/var/mail/cltbld', 03:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:29 INFO - 'MOZ_NO_REMOTE': '1', 03:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:29 INFO - 'NO_EM_RESTART': '1', 03:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:29 INFO - 'PWD': '/builds/slave/test', 03:00:29 INFO - 'SHELL': '/bin/bash', 03:00:29 INFO - 'SHLVL': '1', 03:00:29 INFO - 'TERM': 'linux', 03:00:29 INFO - 'TMOUT': '86400', 03:00:29 INFO - 'USER': 'cltbld', 03:00:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:29 INFO - '_': '/tools/buildbot/bin/python'} 03:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:29 INFO - Running setup.py (path:/tmp/pip-5uk1Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:29 INFO - Running setup.py (path:/tmp/pip-v0jTB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:29 INFO - Running setup.py (path:/tmp/pip-8ylgYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:29 INFO - Running setup.py (path:/tmp/pip-mhP3Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:29 INFO - Running setup.py (path:/tmp/pip-EBU8n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:29 INFO - Running setup.py (path:/tmp/pip-48jKf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:29 INFO - Running setup.py (path:/tmp/pip-NWCf0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:29 INFO - Running setup.py (path:/tmp/pip-YyBzvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:29 INFO - Running setup.py (path:/tmp/pip-wK2POE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:29 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:29 INFO - Running setup.py (path:/tmp/pip-DjZuxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 03:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:29 INFO - Running setup.py (path:/tmp/pip-U5R5VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00: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)) 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:30 INFO - Running setup.py (path:/tmp/pip-PO1bQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:30 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)) 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:30 INFO - Running setup.py (path:/tmp/pip-_SY5Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:30 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)) 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:30 INFO - Running setup.py (path:/tmp/pip-VCcyKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:30 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)) 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:30 INFO - Running setup.py (path:/tmp/pip-ebZYoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:30 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)) 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:30 INFO - Running setup.py (path:/tmp/pip-es9zdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:30 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)) 03:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:30 INFO - Running setup.py (path:/tmp/pip-YDRHPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:30 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)) 03:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:30 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)) 03:00:30 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)) 03:00:30 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)) 03:00:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:30 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 03:00:30 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 03:00:30 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 03:00:30 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 03:00:30 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 03:00:30 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 03:00:32 INFO - Downloading blessings-1.6.tar.gz 03:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:32 INFO - Installing collected packages: blessings 03:00:32 INFO - Running setup.py install for blessings 03:00:32 INFO - Successfully installed blessings 03:00:32 INFO - Cleaning up... 03:00:32 INFO - Return code: 0 03:00:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:32 INFO - Reading from file tmpfile_stdout 03:00:32 INFO - Current package versions: 03:00:32 INFO - argparse == 1.2.1 03:00:32 INFO - blessings == 1.6 03:00:32 INFO - blobuploader == 1.2.4 03:00:32 INFO - docopt == 0.6.1 03:00:32 INFO - functools32 == 3.2.3-2 03:00:32 INFO - jsonschema == 2.5.1 03:00:32 INFO - manifestparser == 1.1 03:00:32 INFO - mozInstall == 1.12 03:00:32 INFO - mozcrash == 0.17 03:00:32 INFO - mozdebug == 0.1 03:00:32 INFO - mozdevice == 0.48 03:00:32 INFO - mozfile == 1.2 03:00:32 INFO - mozhttpd == 0.7 03:00:32 INFO - mozinfo == 0.9 03:00:32 INFO - mozleak == 0.1 03:00:32 INFO - mozlog == 3.2 03:00:32 INFO - moznetwork == 0.27 03:00:32 INFO - mozprocess == 0.22 03:00:32 INFO - mozprofile == 0.28 03:00:32 INFO - mozrunner == 6.11 03:00:32 INFO - mozscreenshot == 0.1 03:00:32 INFO - mozsystemmonitor == 0.3 03:00:32 INFO - moztest == 0.7 03:00:32 INFO - mozversion == 1.4 03:00:32 INFO - psutil == 3.1.1 03:00:32 INFO - requests == 1.2.3 03:00:32 INFO - wsgiref == 0.1.2 03:00:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:32 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')]} 03:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:32 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')]} 03:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:32 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 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00:32 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 03:00:32 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 03:00:32 INFO - Using env: {'DISPLAY': ':0', 03:00:32 INFO - 'HOME': '/home/cltbld', 03:00:32 INFO - 'LANG': 'en_US.UTF-8', 03:00:32 INFO - 'LANGUAGE': 'en_US:en', 03:00:32 INFO - 'LOGNAME': 'cltbld', 03:00:32 INFO - 'MAIL': '/var/mail/cltbld', 03:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:32 INFO - 'MOZ_NO_REMOTE': '1', 03:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:32 INFO - 'NO_EM_RESTART': '1', 03:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:32 INFO - 'PWD': '/builds/slave/test', 03:00:32 INFO - 'SHELL': '/bin/bash', 03:00:32 INFO - 'SHLVL': '1', 03:00:32 INFO - 'TERM': 'linux', 03:00:32 INFO - 'TMOUT': '86400', 03:00:32 INFO - 'USER': 'cltbld', 03:00:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:32 INFO - '_': '/tools/buildbot/bin/python'} 03:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00: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)) 03:00:33 INFO - Cleaning up... 03:00:33 INFO - Return code: 0 03:00:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00: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 03:00: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 03:00:33 INFO - Using env: {'DISPLAY': ':0', 03:00:33 INFO - 'HOME': '/home/cltbld', 03:00:33 INFO - 'LANG': 'en_US.UTF-8', 03:00:33 INFO - 'LANGUAGE': 'en_US:en', 03:00:33 INFO - 'LOGNAME': 'cltbld', 03:00:33 INFO - 'MAIL': '/var/mail/cltbld', 03:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:33 INFO - 'MOZ_NO_REMOTE': '1', 03:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:33 INFO - 'NO_EM_RESTART': '1', 03:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:33 INFO - 'PWD': '/builds/slave/test', 03:00:33 INFO - 'SHELL': '/bin/bash', 03:00:33 INFO - 'SHLVL': '1', 03:00:33 INFO - 'TERM': 'linux', 03:00:33 INFO - 'TMOUT': '86400', 03:00:33 INFO - 'USER': 'cltbld', 03:00:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:33 INFO - '_': '/tools/buildbot/bin/python'} 03:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:33 INFO - Cleaning up... 03:00:33 INFO - Return code: 0 03:00:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c8337df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1564350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', '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 03:00: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', 'flake8'] in /builds/slave/test/build 03:00: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 flake8 03:00:33 INFO - Using env: {'DISPLAY': ':0', 03:00:33 INFO - 'HOME': '/home/cltbld', 03:00:33 INFO - 'LANG': 'en_US.UTF-8', 03:00:33 INFO - 'LANGUAGE': 'en_US:en', 03:00:33 INFO - 'LOGNAME': 'cltbld', 03:00:33 INFO - 'MAIL': '/var/mail/cltbld', 03:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:33 INFO - 'MOZ_NO_REMOTE': '1', 03:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:33 INFO - 'NO_EM_RESTART': '1', 03:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:33 INFO - 'PWD': '/builds/slave/test', 03:00:33 INFO - 'SHELL': '/bin/bash', 03:00:33 INFO - 'SHLVL': '1', 03:00:33 INFO - 'TERM': 'linux', 03:00:33 INFO - 'TMOUT': '86400', 03:00:33 INFO - 'USER': 'cltbld', 03:00:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:33 INFO - '_': '/tools/buildbot/bin/python'} 03:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:33 INFO - Downloading/unpacking flake8 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:00:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:00:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:00:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:36 INFO - no previously-included directories found matching 'docs/_build' 03:00:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:00:36 INFO - Running setup.py install for pep8 03:00:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:36 INFO - no previously-included directories found matching 'docs/_build' 03:00:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:00:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:00:36 INFO - Cleaning up... 03:00:36 INFO - Return code: 0 03:00:36 INFO - Running post-action listener: _resource_record_post_action 03:00:36 INFO - Running post-action listener: _start_resource_monitoring 03:00:36 INFO - Starting resource monitoring. 03:00:36 INFO - ##### 03:00:36 INFO - ##### Finished create-virtualenv step (success) 03:00:36 INFO - ##### 03:00:36 INFO - ##### 03:00:36 INFO - ##### Running install step. 03:00:36 INFO - ##### 03:00:36 INFO - Running pre-action listener: _resource_record_pre_action 03:00:36 INFO - Running main action method: install 03:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:36 INFO - Reading from file tmpfile_stdout 03:00:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:36 INFO - Reading from file tmpfile_stdout 03:00:36 INFO - Output received: 03:00:36 INFO - Usage: mozinstall [options] installer 03:00:36 INFO - Options: 03:00:36 INFO - -h, --help show this help message and exit 03:00:36 INFO - -d DEST, --destination=DEST 03:00:36 INFO - Directory to install application into. [default: 03:00:36 INFO - "/builds/slave/test"] 03:00:36 INFO - --app=APP Application being installed. [default: firefox] 03:00:36 INFO - mkdir: /builds/slave/test/build/application 03:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:00:52 INFO - Reading from file tmpfile_stdout 03:00:52 INFO - Output received: 03:00:52 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:52 INFO - Running post-action listener: _resource_record_post_action 03:00:52 INFO - ##### 03:00:52 INFO - ##### Finished install step (success) 03:00:52 INFO - ##### 03:00:52 INFO - ##### 03:00:52 INFO - ##### Running run-tests step. 03:00:52 INFO - ##### 03:00:52 INFO - Running pre-action listener: _resource_record_pre_action 03:00:52 INFO - Running main action method: run_tests 03:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:52 INFO - Python 2.7.3 03:00:52 INFO - Return code: 0 03:00:52 INFO - grabbing minidump binary from tooltool 03:00:52 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')]} 03:00:52 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f31c0>, '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 0x15f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:52 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 03:00:52 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 03:00:52 INFO - Calling ['/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'] with output_timeout 600 03:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:52 INFO - Return code: 0 03:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:00:53 INFO - Return code: 0 03:00:53 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', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:00:53 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 dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:00:53 INFO - Using env: {'DISPLAY': ':0', 03:00:53 INFO - 'HOME': '/home/cltbld', 03:00:53 INFO - 'LANG': 'en_US.UTF-8', 03:00:53 INFO - 'LANGUAGE': 'en_US:en', 03:00:53 INFO - 'LOGNAME': 'cltbld', 03:00:53 INFO - 'MAIL': '/var/mail/cltbld', 03:00:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:53 INFO - 'MOZ_NO_REMOTE': '1', 03:00:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:53 INFO - 'NO_EM_RESTART': '1', 03:00:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:53 INFO - 'PWD': '/builds/slave/test', 03:00:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:53 INFO - 'SHELL': '/bin/bash', 03:00:53 INFO - 'SHLVL': '1', 03:00:53 INFO - 'TERM': 'linux', 03:00:53 INFO - 'TMOUT': '86400', 03:00:53 INFO - 'USER': 'cltbld', 03:00:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071', 03:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:53 INFO - '_': '/tools/buildbot/bin/python'} 03:00:53 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', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:00:54 INFO - mozversion application_buildid: 20160623021224 03:00:54 INFO - mozversion application_changeset: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 03:00:54 INFO - mozversion application_display_name: Nightly 03:00:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:54 INFO - mozversion application_name: Firefox 03:00:54 INFO - mozversion application_remotingname: firefox 03:00:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:00:54 INFO - mozversion application_vendor: Mozilla 03:00:54 INFO - mozversion application_version: 50.0a1 03:00:54 INFO - mozversion platform_buildid: 20160623021224 03:00:54 INFO - mozversion platform_changeset: 5f29b11f5ae8ce218baf26ad8e19340f6ee35b70 03:00:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:00:54 INFO - mozversion platform_version: 50.0a1 03:00:54 INFO - using testdate: 1466676054 03:00:54 INFO - actual date: 1466676054 03:00:54 INFO - starting webserver on 'localhost:41828' 03:00:54 INFO - SUITE-START | Running 2 tests 03:00:54 INFO - TEST-START | dromaeo_css 03:00:54 INFO - operating with platform_type : linux_ 03:00:54 INFO - Initialising browser for dromaeo_css test... 03:00:54 INFO - TEST-INFO | started process 4237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSuDE8/profile http://localhost:41828/getInfo.html) 03:00:58 INFO - PROCESS | 4237 | __metrics Screen width/height:1600/1200 03:00:58 INFO - PROCESS | 4237 | colorDepth:24 03:00:58 INFO - PROCESS | 4237 | Browser inner width/height: 1024/697 03:00:58 INFO - PROCESS | 4237 | __metrics 03:00:58 INFO - PROCESS | 4237 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:59 INFO - TEST-INFO | 4237: exit 0 03:00:59 INFO - Browser initialized. 03:00:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:59 INFO - TEST-INFO | started process 4315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSuDE8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:11 INFO - PROCESS | 4315 | RSS: Main: 175403008 03:01:11 INFO - PROCESS | 4315 | 03:02:03 INFO - PROCESS | 4315 | 1466676123165 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:04:15 INFO - PROCESS | 4315 | Cycle 1(1): loaded http://localhost:41828/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41828/tests/dromaeo/cssquery-ext.html) 03:04:16 INFO - PROCESS | 4315 | RSS: Main: 271679488 03:04:16 INFO - PROCESS | 4315 | 03:07:19 INFO - PROCESS | 4315 | Cycle 1(1): loaded http://localhost:41828/tests/dromaeo/cssquery-ext.html (next: http://localhost:41828/tests/dromaeo/cssquery-jquery.html) 03:07:20 INFO - PROCESS | 4315 | RSS: Main: 258637824 03:07:20 INFO - PROCESS | 4315 | 03:10:22 INFO - PROCESS | 4315 | Cycle 1(1): loaded http://localhost:41828/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41828/tests/dromaeo/cssquery-mootools.html) 03:10:22 INFO - PROCESS | 4315 | RSS: Main: 264806400 03:10:22 INFO - PROCESS | 4315 | 03:13:25 INFO - PROCESS | 4315 | Cycle 1(1): loaded http://localhost:41828/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41828/tests/dromaeo/cssquery-prototype.html) 03:13:25 INFO - PROCESS | 4315 | RSS: Main: 260927488 03:13:25 INFO - PROCESS | 4315 | 03:16:28 INFO - PROCESS | 4315 | Cycle 1(1): loaded http://localhost:41828/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41828/tests/dromaeo/cssquery-yui.html) 03:16:29 INFO - PROCESS | 4315 | RSS: Main: 238637056 03:16:29 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | Cycle 1(1): loaded http://localhost:41828/tests/dromaeo/cssquery-yui.html (next: http://localhost:41828/tests/dromaeo/cssquery-dojo.html) 03:19:32 INFO - PROCESS | 4315 | RSS: Main: 279973888 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | __start_tp_report 03:19:32 INFO - PROCESS | 4315 | _x_x_mozilla_page_load 03:19:32 INFO - PROCESS | 4315 | _x_x_mozilla_page_load_details 03:19:32 INFO - PROCESS | 4315 | |i|pagename|runs| 03:19:32 INFO - PROCESS | 4315 | |0;dojo.html;2607.7261887501813;2622.5934980078096;2651.867406629668;2654.1241390341183;2656.4421471490987;4738.2892566115015;4801.303810947415;4832.081904438154;4860.149473842077;4907.435644900837;4861.270809378586;4862.14912390332;4877.951220487794;4890.290907818364;4978.950210497894;4452.933206001896;4466.419365482483;4490.461144662645;4500.5724456176695;4507.72953622782;4609.193391156551;4646.465656449501;4654.418197725285;4682.41469816273;4702.05958808238;4576.519465456146;4593.862184134481;4629.0279041401345;4634.281686338623;4665.953340466603;4397.890052748675;4460.063386688799;4463.152001119777;4463.799129039168;4492.84275050375;4391.363252328394;4394.62645675118;4444.622207112399;4470.9105817883465;4557.58981691646;4881.926771098437;4899.118158731427;4922.926156107661;4942.456329803718;4943.456219815817;5067.8986420271385;5120.334356533664;5308.681479111227;5312.946870531323;5322.520973112439;5229;5234.502722241381;5274.815381461669;5385.811496597639;5409.756560954727;4920.950790492049;4995.300657907896;5019.447860735316;5035.949640503548;5039.924401133986;5231.895362092737;5374.570034397317;5473.397926228112;5476.780928762805;5477.589180811455;5167.819126330561;5281.841544753664;5286.418493965661;5290.523852853262;5291.074062039128;5271.683698978073;5281.894362112736;5285.180796976475;5287.4976877196605;5288.048151332797;5150.253213284052;5160.0969830279555;5216.739163041832;5244.213367994831;5308.761105750251;5215.374155101412;5239.423663397023;5240.895182096337;5246.527812496894;5272.103742363731;4490.368542545599;4497.2804351304285;4497.595216430537;4539.818407263672;4543;3872.2642697887313;3888.416737489399;3894.279558281727;3910.100676844285;3929.1159489115294;4470.329450582439;4518.525554816762;4520.819167233274;4531.093781243699;4554.339620755039;5332.520073193431;5346.1713434417725;5355.491228333302;5356.0894647909945;5407.83776486706;4374.4531933508315;4520.728756274634;4540.977295113569;4556.794944227518;4603.95396046042;4657.46439159501;4699.95300047002;4714.104320179155;4719.292106184032;4719.3628860103445;4865.854024379274;4891;4894.388201474816;4898.142825005539;4945.208766597327;5139.408967968731;5225.973870130625;5228.215767634885;5233.712145831863;5285.550728188147;4938.530839570235;4955.975220123876;4981.850544483671;4990.101781679187;5031;5235.790568377222;5238.109521381298;5248.60635452335;5251.947480525146;5305.257263983122;5158.690478571298;5250.081235783799;5302.549283310962;5314.415414304346;5332.200169974535;5174.767135478837;5181.948180518147;5184.922226166535;5189.481051894781;5219.712915789516;5132.717700526507;5154.433012368561;5178.249153872592;5180.896382072413;5229.581633469237;4911.287863259879;4984.127777638972;5054;5059.038782631288;5090.49095090488;5141.742912854417;5165.7675404607635;5167.044096841946;5167.844964651066;5208.24480450325;5014;5016.849494515171;5028.673136246132;5062.746862656926;5070.340855688737 03:19:32 INFO - PROCESS | 4315 | |1;ext.html;538.1389202750064;582.7872826418358;587.3451102021247;592.5644651181384;600.4715850051955;26242.606360904578;28531.714682853166;38996.805015974955;39940.80029599855;40053;39245.803770981176;39649.20701585967;39696;39730.60269397305;39756.40365394514;7884.4086693498075;8046.959765201166;8050.4364694471415;8052.074011488666;8054.43618946674;7863.56750378729;7932.365410767125;7956.960215198916;7961.402894782915;7990.720324788634;7962.243586859239;8003.559804210766;8007.279344858962;8011.799705007393;8013.799655008643;7960.323372513314;8003.95998020012;8004.799880002988;8007.799805004864;8011.679532818738;7935.365170786324;8008.7597372078935;8013.358931285483;8014;8021.117677055519;38143.23713525714;38577.61422385796;38603.80698096519;38727.419088713694;38732.612673873184;3134.7492200623897;3243.9026829195163;3291.1113999220074;3354.1446931032674;3755.511783468159;28881.56677649837;29409.411811763646;29647.851760741272;29721.25696857574;29743.851280743456;3121.3133110715607;3167.667394923546;3238.0771480128287;3239.6922292382187;3241.578594782663;261841;264522;264956;265125;265461;53336.199957000674;53592.464075358745;53891.730541347824;53972.46027539753;53977.73011134998;33018.66981330156;33799.15502112467;33868.49197262043;35756.28487430237;56363.71818140883;14299.499517516837;14331.06848054873;14410.855891440951;14449.78325325121;14468.565943021726;10923.726906827393;11054.557817687364;11054.557817687364;11058.281211721212;11071.225014248925;18468.907655461637;18575.16411761474;18609.81390186108;18691.252349906124;18789.43631691024;6805.353491418307;6860.5197636165985;6872.793816185523;6981.965090174618;7111.2533184015965;794.3367288314322;872.6858331000834;920.3511524375299;992.8400003983287;993.3046867192994;26748.465030699666;27261.182164535097;27673.584896226574;27847.30381740473;27902.3024424391;790.8615992201342;948.6774496671027;960.846264597675;1005.0853723111933;1023.559869256227;13955.79066314006;14258.643533911736;14410;14576.125432474086;14755.114693118232;373253;375542;375945.1202743969;376276;377259;47617.285740713916;48088.75955620199;48176.27735583969;48227.276590851165;48292.999999999294;1073.1414868105485;1136.2954967919943;1184.5084290019545;1201.4893670190133;1206.1255589697398;26982.32544186411;27570.310742231606;28027;28777.712222877504;29406.55890161692;46334.53665463302;47123.52876471191;47178;47205.80736119093;47243.29135062908;339082;340519;342261;343752;344419;32569.348613027134;36774.26451471009;38018.61981380151;38204;40429.39355909605;41141.382879256234;41318.806423264934;41464.79267603643;41516.377254341816;41636;35008.29983400369;35035.47446788351;35309.29381412306;35653.64346356607;35745.28509429745;35441.46837797383;35453.113672158404;35490;35839.28321433609;35908.76821086115;34440.48339274963;35327;35456;35941.640583594875;36142.63857361393;31558.36883262276;32216.516752248266;32250;32571.511427328136;32785.836070819496;23572.52854942857;24206.878965605763;24258.272251832474;24637.38406539851;24649.60209050959 03:19:32 INFO - PROCESS | 4315 | |2;jquery.html;371.1796928787381;371.63950967561465;377.3716761591948;383.1933779394375;385.57201506327954;16036.118013509253;17443.3022679093;17647.823521764778;18118.637627247448;18168.36410725625;16759.162041897886;17050.39204914349;17282.740758888627;17343.566410839736;17379.304827806904;5091.312672789172;5303.178007408838;5333.093374126408;5340.946590534103;5341.172118321666;3752.924941501182;3840.8463661453507;4726.4328280606205;5189.6886186828915;6348.428641422271;6178.660173690468;6210.130581718563;6288.119663247149;6290.874182516347;6298.748050077991;5978.701064946757;6090.908636370458;6108.694565271719;6153.569250152491;6210.937890621081;3404.3531728971666;5133.358330208724;5438.700871452069;5460.645058071253;5472.124460086367;19916.80083199164;20587.970601469868;20640.380788576367;20925.686114708293;20964;1988.542635193899;1998.860079794415;2052.5792212596384;2091.759447663523;2136.4231657452556;12790.616281511477;13129.34353282332;13236.669083272898;13487.258200798951;13698.65753356174;1709.6409753951561;1756.0692832798509;1796.7568538787484;1798.379559052125;1807.9186436610385;63072;64106.67946660237;65221.347786522005;66595.3340466594;66721;9514.429134251966;9659.758506037406;9690.660826871026;9816.950915245377;10157.003683913263;13653.38559764813;13721.245331506663;13747.793783093262;13759.10565813239;13760;7327.2672732726305;7327.340539351484;7591.089069311718;7607.16321204667;7628.580428076398;7243.674034668453;7259.745908893164;7301.744438944612;7320.816979575553;7415.592142432218;6181.103739957681;6244.750209991549;6246.187995560548;6306.558540902093;6421.389967953037;1746.4324094669282;1748.9038102904462;1772.2556526259002;1784.97322540162;1837.154908741967;866.7096522664978;877.688420610674;918.701422037827;963.6145541783343;983.2379905573094;17070;17567.38514152024;17735.201915913814;17854;18231.088445577934;872.2542226396466;888.5335199020566;913.2283220678516;916.7662246127195;952.3857112162755;9732.056365034487;10273.537690803782;10290;10321.225908056926;10335.328203666737;374003;375434;380515;382808;388863;42674.359884601756;71479.2852071483;71948;74266.6286668574;84856;898.5282726568473;917.2111983694151;938.6245501799199;941.7363138321281;950.4107453379088;15986.360545578513;16134.193290335672;16184.271707772943;16250.26873790706;16293.67412651764;36485.45271820978;37609;38172.04569885775;38361.808190958865;40103.79948100241;52504.73747631237;54928.176077358075;55413.44586554083;55473.44526554683;55626.72186639203;6709.329067093447;7061.152661680631;7300.926990730025;7872.685092596461;8224.958875205586;11787.998020168381;11902.226355286879;12241.265524068584;12277.324747138637;12283.938580307398;9801.264905132;9804.509774511103;9828.606855725691;9831.606735730491;10003.449810260505;4965.155923493087;7445.664945077377;10060.440631702098;10234.283600147919;10504.842427363748;9808.16630586408;9931.404115753077;10031.398116112765;10068.89931100709;10651.201159913193;7241.710331586678;7319.74380896666;7336.4130869529245;7367.926320736939;7515.248475152441;9754.707358779247;9914.157296629868;9923.156531694887;10028.247881408777;10206.23453240995 03:19:32 INFO - PROCESS | 4315 | |3;mootools.html;1213.842200513933;1360.7142500074983;1388.2989090509295;1464.202009904602;1723.1987125986414;6579.440747536459;7612.200718924516;7761.999999999993;7825;8056.758297251092;7657.961710191441;7818.179091195428;7820.882686759704;7825.1783562725805;7825.5304681719135;1844.5757475780579;2073.1396470464815;2144.2816656420077;2160.6975023496725;2177.7822217778253;2232.162938897913;2244.079927229836;2250.8424410291204;2258.5144193998285;2260.152442833937;2141.4218161096496;2151.558930419268;2183.8098236461087;2189.627763280238;2191.616467118256;1778.8221177882174;1835.9357422490148;1840.604270081939;2056.4550394145563;2123.62836503612;2139.6148693235214;2178.6078505868936;2185.4317877352005;2189.0477642225524;2189.8576592521435;7998.720044798462;7999.120096789348;8064;8068.112507624157;8068.596570171468;4609.078184363141;4729.408823897013;4745.288206768978;4746.02706445178;4758.048390321949;2867.426514697048;2895.60909277247;2947.2042548511995;2998.895038673636;3002.084364268897;943.1700103908585;944.6740874398322;954.7374472020181;970.815545046446;985.0199051943291;10966.396848173346;10978.231523793338;10979.945100274528;11004.669859904216;11034.17243706717;4280.571942805756;4321.65426765858;4346.413234213404;4383.517813040563;4468.017036252019;9175.669527918548;9212.53937303132;9229.030951750105;9262.073792620818;9291.163795258459;4681.461631912305;4701.388819453449;4702.412198475191;4714.504976977437;4715.575598196178;3628.3468975584647;4188.015816283171;4330.458692663417;4340.500842403101;4374.081442896963;3645.0705070206927;3727.310447567209;3767.2842159990064;3776.905577360588;3860.7104467165077;1100.763335882773;1196.0969468051564;1203.7773011992633;1208.9939550302192;1219.969500762488;732.4726197138052;779.8518281526492;836.7406104107746;846.3736834742247;860.4364141487335;5140.254663073908;5196.610254230948;5279.313689220377;5339.652922560099;5362.463753624606;872.1365847810748;913.3323767916677;921.6635927886407;941.0989800602744;961.3078583419926;3437.4671925851535;3612.403953347668;3622.5652921649043;3652.7625704329134;3666.7066634669163;9654.131128198356;9827.066428689262;9951.55218015191;9956.751081223027;9971.501424928725;9826.06652368024;9884.406935583887;9894.505274736235;9900.55447504864;9925.602975880884;6978.825529361705;7387.81530461732;7532.435067369969;7533.962330188314;7538.09542854861;5101.795928162832;5157.93702357277;5379.973100134631;5528.419515950767;5552.056150454513;8974.057723938893;9154.496502692416;9267.119623635745;9269.258459323373;9275.953620231856;9089.181973622406;9225.261979041527;9331.626734930798;9382.29632777558;9477.004914484156;6459.838504037249;6730.427913627396;6810.62541560219;6823.897641535282;6974.616396098263;7588.962055189689;7632.771016869503;7670.654820533201;7682.001339825787;7708.807279818049;6693.09643198162;6911.516193866582;7027.051348067946;7118.786436406709;7121.537100088685;6925.27284635106;6988.965055174692;7051.43588512928;7052.576845389293;7142.285771422816;6262.68686565679;6271.498280137487;6275.466585340298;6281.623102613858;6283.3716628338625;4400.097979914174;4401.383806267061;4448.844290449819;4462.754548499864;4484.9103017940115;4553.043860789271;4570.81716731327;4586.357909892685;4630.629549636088;4634.930476042795 03:19:32 INFO - PROCESS | 4315 | |4;prototype.html;295.8860838577147;297.77071654825784;306.462158911111;312.39083786616106;314.99999999999983;4780.545848144429;4924.901501969958;4932.210846264598;4937.530934561211;4978.676386034906;4661.533846615337;4841.273808928662;4861.465238823726;4885.242787367954;4910.6071514278865;3866.1881004988845;3867.690584753227;3876.205377897524;3879.9718074710154;3897.2205558888195;3639.1811842335396;3694.261147770457;3856.2865869814036;3868.3423817950875;3872.8644497442597;3824.7187192290617;3825.8087095645105;3832.8466861325514;3844.2695887781374;3846.74996125251;3794.620537946211;3811.6760075393627;3818.6563209311157;3828.7511311764647;3830.9042273943096;3379.273456206927;3388.6441923597913;3421.36704709627;3428.7257019438384;3456.5679290088738;4645.721256724607;4715.561753665131;4722.220833562493;4725.834595789131;4764.522997870637;4372.606465418127;4384.6273066789045;4391.3193455014525;4426.490953540319;4434.9356154523;5103.668261562986;5111.795528178905;5111.952049829813;5114.462981386975;5128.512791284822;3656.981715091434;3765.3222419964395;3771.9434208486896;3776.244751049801;3784.5836957934607;5291.703532634529;5358.223057656657;5369.785208591691;5413.702246376448;5421.918671219935;3804.904877378088;3809.3904975203836;3814.389697648363;3826.6938644908896;3827.6937844972335;3662.52387189669;3881.359575669983;3883.8446462141765;3894.766314021168;3906.140649057203;4382.474103107647;4384.320430333303;4384.47386313638;4390.143921935192;4411.7867586413995;5152.458991805881;5162.199859021857;5174.24973378858;5182;5184.144616138295;1272.0904553244475;1296.4619682831708;1339.3169483563258;1345.6232254968625;1348.9325533723274;865.6191275838611;880.1858281090094;889.6975028490344;891.8751374807532;894.9821003579892;3990.86031988879;4003.3394489908837;4011.498562679665;4016.59834016596;4026.154507553388;4606.907861842745;4621.745803980746;4624.768761561976;4655.39207114489;4659;3952.288588054178;3979.6270286751023;3993.800309984489;4004.577230775339;4015.297322968469;2360.4806942472974;2451.9141830035865;2460.3972026853176;2463.7289898111194;2505.5843448451565;4330.870073897788;4345.543717909637;4384.96953215994;4396.714213576107;4401.053773438662;4708.929366059512;4722.811087556459;4743.810247590127;4790.616750659939;4798.616110711135;4172.415861779354;4365.956340436555;4373.606375426163;4384.802683879233;4403.691741578059;4560.429946256718;4600.769961501978;4608.907821843612;4610.608098311681;4618.769061546842;4553.840615578439;4593.035462552902;4600.884977875446;4618.976905115453;4643.814247430065;4121.855735049259;4197.782643033608;4383.736975781463;4417.8232870684815;4431.556844315672;3494.423420135751;3496.5629296337956;3500.457429098494;3500.492428597788;3521.3837578423163;4743.644226683082;4761.642931764431;4762.380890484214;4765.783910481643;5131.846044618667;5005.49835049491;5109.284700142058;5110.61670374716;5133.845984620468;5174.301469301596;5098.668586541863;5120.283160357628;5129.256257842667;5142.1772516397195;5144.9742751286;4824.986752781955;5034.546890779848;5054.393472783289;5068.341115654941;5071.163258062378;5177.637565370538;5189.169732842727;5201.531862132426;5226.189940559219;5246.449122842047;5067.5185857343495;5080.593552515864;5108.3103780989095;5134.204198349262;5139.306193663808 03:19:32 INFO - PROCESS | 4315 | |5;yui.html;711.7295427737462;727.8762610356239;733.3802936518641;750.8385697075128;765.4565258666347;13441.932790336046;13981.091229070129;14001.019928605014;14006.369713362898;14013.719725605482;14176.716465670706;14178.220197889112;14197.219152946584;14224.928875355608;14320.71358572828;612.3692596625483;755.5617741709823;796.5579103597515;801.0427539090789;802.1096582793095;785.5993443343907;798.1659166171336;798.7883210949103;798.8282519258358;799.4084377560592;822.2969361196181;827.0571548434789;829.0631586307464;831.2311112221201;834.2325060943946;629.0564153769346;779.7037125892182;820.8973878265188;823.4976664234812;825.051191130202;603.7464265008663;606.6754286456725;606.8634557224633;606.902895536712;607.4259824465881;12913;12930.09489335747;12935.741285174337;12963.092583519157;12965.546205882843;11662.241954272946;11902.940485297604;12473.189242699196;12477.50089996399;12548.8117678234;11532.94233528827;11975.820362694567;12023.278603283743;12220.2667839929;12320.876791232062;4118.19695159444;4128.793560321972;4171.499420069581;4186.91626167478;4200.306949353353;60168.39831601672;60480.39519604792;60612.39387606111;60703.39296607021;61121.69439152776;10072.899271007196;10259.17926565873;10292.104175690685;10562.630307939186;10810.783784324269;17762.46712598624;17764.045954944944;17787.911060444614;17789.288428462718;17800.732989005177;6879.380855723009;6964.79105626832;6965.721371145098;7036.9296307036275;7124.679389427488;3655.1593133578895;3672.4491326301268;3697.963020369762;3707.4994875691978;3734;2753.3529620539157;2852.4437734641547;2853.172579951791;2855.814372065809;2855.9000434984678;492.2886429109902;504.848545436375;505.7370167512873;505.94181669107786;506.37968488601905;481.7759741720117;539.3500831498036;571.1176232720456;594.1147689941955;606.2936678769273;7515.887261691079;7840.882386764203;7975.441719079725;8072.757817265491;8126.878096828552;503.768266597362;504.19580768673904;509.34294759759496;541.4287926237857;587.8354060862965;3551.6270791566512;3672.6878215351994;3801.4107813288983;3809.657130858236;3827.2536855312946;68452.65773671199;81429.59285203654;86640;87688;93428.53285733527;70970.73433478906;72976.63511682514;80733.3853322942;80842.59578702069;81435;41847.58152418498;50506.74746626243;66646;72595.99999999894;73348.89976650354;8693.956530217309;9000.909990900269;9015.639374424949;9019.458832470073;9022.684206052756;41887.162256755306;41972;42318;42658.36012459754;42698.78650606727;54188.45811541834;59876.70061649664;61879.6906015467;61967;62069.37930620636;12392.442340094538;12421.44103515362;12506.499740010298;12538.811917821058;12765.106442548933;12938.870611293767;13084.738305234032;13324.733505330032;13409.982753880298;13419.396127174105;12260.509579616715;12315.815262770886;12445.813312800496;12652.051096168008;12815.679608009874;12454.564090256797;12630.610632830565;12669;12843.935780321039;13456.798148027983;12277.815832762337;12815.102942793916;12906.493467800832;12937.935310323388;13023.739525209254;9539.445862376188;10085.899141008496;10122.342047766871;10202.744931376776;10278.588856445958;10216.438095904796;10989.175811813986;11021;11061.668149955514;11166.665000050012 03:19:32 INFO - PROCESS | 4315 | __end_tp_report 03:19:32 INFO - PROCESS | 4315 | __start_cc_report 03:19:32 INFO - PROCESS | 4315 | _x_x_mozilla_cycle_collect,978 03:19:32 INFO - PROCESS | 4315 | __end_cc_report 03:19:32 INFO - PROCESS | 4315 | __startTimestamp1466677172519__endTimestamp 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | ------- Summary: start ------- 03:19:32 INFO - PROCESS | 4315 | Number of tests: 6 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | [#0] dojo.html Cycles:165 Average:4867.60 Median:4995.30 stddev:530.61 (10.6%) stddev-sans-first:501.74 03:19:32 INFO - PROCESS | 4315 | Values: 2607.7 2622.6 2651.9 2654.1 2656.4 4738.3 4801.3 4832.1 4860.1 4907.4 4861.3 4862.1 4878.0 4890.3 4979.0 4452.9 4466.4 4490.5 4500.6 4507.7 4609.2 4646.5 4654.4 4682.4 4702.1 4576.5 4593.9 4629.0 4634.3 4666.0 4397.9 4460.1 4463.2 4463.8 4492.8 4391.4 4394.6 4444.6 4470.9 4557.6 4881.9 4899.1 4922.9 4942.5 4943.5 5067.9 5120.3 5308.7 5312.9 5322.5 5229.0 5234.5 5274.8 5385.8 5409.8 4921.0 4995.3 5019.4 5035.9 5039.9 5231.9 5374.6 5473.4 5476.8 5477.6 5167.8 5281.8 5286.4 5290.5 5291.1 5271.7 5281.9 5285.2 5287.5 5288.0 5150.3 5160.1 5216.7 5244.2 5308.8 5215.4 5239.4 5240.9 5246.5 5272.1 4490.4 4497.3 4497.6 4539.8 4543.0 3872.3 3888.4 3894.3 3910.1 3929.1 4470.3 4518.5 4520.8 4531.1 4554.3 5332.5 5346.2 5355.5 5356.1 5407.8 4374.5 4520.7 4541.0 4556.8 4604.0 4657.5 4700.0 4714.1 4719.3 4719.4 4865.9 4891.0 4894.4 4898.1 4945.2 5139.4 5226.0 5228.2 5233.7 5285.6 4938.5 4956.0 4981.9 4990.1 5031.0 5235.8 5238.1 5248.6 5251.9 5305.3 5158.7 5250.1 5302.5 5314.4 5332.2 5174.8 5181.9 5184.9 5189.5 5219.7 5132.7 5154.4 5178.2 5180.9 5229.6 4911.3 4984.1 5054.0 5059.0 5090.5 5141.7 5165.8 5167.0 5167.8 5208.2 5014.0 5016.8 5028.7 5062.7 5070.3 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | [#1] ext.html Cycles:180 Average:47904.94 Median:35925.20 stddev:86982.47 (242.1%) stddev-sans-first:87153.78 03:19:32 INFO - PROCESS | 4315 | Values: 538.1 582.8 587.3 592.6 600.5 26242.6 28531.7 38996.8 39940.8 40053.0 39245.8 39649.2 39696.0 39730.6 39756.4 7884.4 8047.0 8050.4 8052.1 8054.4 7863.6 7932.4 7957.0 7961.4 7990.7 7962.2 8003.6 8007.3 8011.8 8013.8 7960.3 8004.0 8004.8 8007.8 8011.7 7935.4 8008.8 8013.4 8014.0 8021.1 38143.2 38577.6 38603.8 38727.4 38732.6 3134.7 3243.9 3291.1 3354.1 3755.5 28881.6 29409.4 29647.9 29721.3 29743.9 3121.3 3167.7 3238.1 3239.7 3241.6 261841.0 264522.0 264956.0 265125.0 265461.0 53336.2 53592.5 53891.7 53972.5 53977.7 33018.7 33799.2 33868.5 35756.3 56363.7 14299.5 14331.1 14410.9 14449.8 14468.6 10923.7 11054.6 11054.6 11058.3 11071.2 18468.9 18575.2 18609.8 18691.3 18789.4 6805.4 6860.5 6872.8 6982.0 7111.3 794.3 872.7 920.4 992.8 993.3 26748.5 27261.2 27673.6 27847.3 27902.3 790.9 948.7 960.8 1005.1 1023.6 13955.8 14258.6 14410.0 14576.1 14755.1 373253.0 375542.0 375945.1 376276.0 377259.0 47617.3 48088.8 48176.3 48227.3 48293.0 1073.1 1136.3 1184.5 1201.5 1206.1 26982.3 27570.3 28027.0 28777.7 29406.6 46334.5 47123.5 47178.0 47205.8 47243.3 339082.0 340519.0 342261.0 343752.0 344419.0 32569.3 36774.3 38018.6 38204.0 40429.4 41141.4 41318.8 41464.8 41516.4 41636.0 35008.3 35035.5 35309.3 35653.6 35745.3 35441.5 35453.1 35490.0 35839.3 35908.8 34440.5 35327.0 35456.0 35941.6 36142.6 31558.4 32216.5 32250.0 32571.5 32785.8 23572.5 24206.9 24258.3 24637.4 24649.6 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | [#2] jquery.html Cycles:180 Average:24060.85 Median:5112.34 stddev:62672.78 (1225.9%) stddev-sans-first:62823.35 03:19:32 INFO - PROCESS | 4315 | Values: 371.2 371.6 377.4 383.2 385.6 16036.1 17443.3 17647.8 18118.6 18168.4 16759.2 17050.4 17282.7 17343.6 17379.3 5091.3 5303.2 5333.1 5340.9 5341.2 3752.9 3840.8 4726.4 5189.7 6348.4 6178.7 6210.1 6288.1 6290.9 6298.7 5978.7 6090.9 6108.7 6153.6 6210.9 3404.4 5133.4 5438.7 5460.6 5472.1 19916.8 20588.0 20640.4 20925.7 20964.0 1988.5 1998.9 2052.6 2091.8 2136.4 12790.6 13129.3 13236.7 13487.3 13698.7 1709.6 1756.1 1796.8 1798.4 1807.9 63072.0 64106.7 65221.3 66595.3 66721.0 9514.4 9659.8 9690.7 9817.0 10157.0 13653.4 13721.2 13747.8 13759.1 13760.0 7327.3 7327.3 7591.1 7607.2 7628.6 7243.7 7259.7 7301.7 7320.8 7415.6 6181.1 6244.8 6246.2 6306.6 6421.4 1746.4 1748.9 1772.3 1785.0 1837.2 866.7 877.7 918.7 963.6 983.2 17070.0 17567.4 17735.2 17854.0 18231.1 872.3 888.5 913.2 916.8 952.4 9732.1 10273.5 10290.0 10321.2 10335.3 374003.0 375434.0 380515.0 382808.0 388863.0 42674.4 71479.3 71948.0 74266.6 84856.0 898.5 917.2 938.6 941.7 950.4 15986.4 16134.2 16184.3 16250.3 16293.7 36485.5 37609.0 38172.0 38361.8 40103.8 52504.7 54928.2 55413.4 55473.4 55626.7 6709.3 7061.2 7300.9 7872.7 8225.0 11788.0 11902.2 12241.3 12277.3 12283.9 9801.3 9804.5 9828.6 9831.6 10003.4 4965.2 7445.7 10060.4 10234.3 10504.8 9808.2 9931.4 10031.4 10068.9 10651.2 7241.7 7319.7 7336.4 7367.9 7515.2 9754.7 9914.2 9923.2 10028.2 10206.2 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | [#3] mootools.html Cycles:180 Average:5215.77 Median:5351.06 stddev:2964.33 (55.4%) stddev-sans-first:2957.39 03:19:32 INFO - PROCESS | 4315 | Values: 1213.8 1360.7 1388.3 1464.2 1723.2 6579.4 7612.2 7762.0 7825.0 8056.8 7658.0 7818.2 7820.9 7825.2 7825.5 1844.6 2073.1 2144.3 2160.7 2177.8 2232.2 2244.1 2250.8 2258.5 2260.2 2141.4 2151.6 2183.8 2189.6 2191.6 1778.8 1835.9 1840.6 2056.5 2123.6 2139.6 2178.6 2185.4 2189.0 2189.9 7998.7 7999.1 8064.0 8068.1 8068.6 4609.1 4729.4 4745.3 4746.0 4758.0 2867.4 2895.6 2947.2 2998.9 3002.1 943.2 944.7 954.7 970.8 985.0 10966.4 10978.2 10979.9 11004.7 11034.2 4280.6 4321.7 4346.4 4383.5 4468.0 9175.7 9212.5 9229.0 9262.1 9291.2 4681.5 4701.4 4702.4 4714.5 4715.6 3628.3 4188.0 4330.5 4340.5 4374.1 3645.1 3727.3 3767.3 3776.9 3860.7 1100.8 1196.1 1203.8 1209.0 1220.0 732.5 779.9 836.7 846.4 860.4 5140.3 5196.6 5279.3 5339.7 5362.5 872.1 913.3 921.7 941.1 961.3 3437.5 3612.4 3622.6 3652.8 3666.7 9654.1 9827.1 9951.6 9956.8 9971.5 9826.1 9884.4 9894.5 9900.6 9925.6 6978.8 7387.8 7532.4 7534.0 7538.1 5101.8 5157.9 5380.0 5528.4 5552.1 8974.1 9154.5 9267.1 9269.3 9276.0 9089.2 9225.3 9331.6 9382.3 9477.0 6459.8 6730.4 6810.6 6823.9 6974.6 7589.0 7632.8 7670.7 7682.0 7708.8 6693.1 6911.5 7027.1 7118.8 7121.5 6925.3 6989.0 7051.4 7052.6 7142.3 6262.7 6271.5 6275.5 6281.6 6283.4 4400.1 4401.4 4448.8 4462.8 4484.9 4553.0 4570.8 4586.4 4630.6 4634.9 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | [#4] prototype.html Cycles:180 Average:4097.59 Median:4414.81 stddev:1173.62 (26.6%) stddev-sans-first:1141.70 03:19:32 INFO - PROCESS | 4315 | Values: 295.9 297.8 306.5 312.4 315.0 4780.5 4924.9 4932.2 4937.5 4978.7 4661.5 4841.3 4861.5 4885.2 4910.6 3866.2 3867.7 3876.2 3880.0 3897.2 3639.2 3694.3 3856.3 3868.3 3872.9 3824.7 3825.8 3832.8 3844.3 3846.7 3794.6 3811.7 3818.7 3828.8 3830.9 3379.3 3388.6 3421.4 3428.7 3456.6 4645.7 4715.6 4722.2 4725.8 4764.5 4372.6 4384.6 4391.3 4426.5 4434.9 5103.7 5111.8 5112.0 5114.5 5128.5 3657.0 3765.3 3771.9 3776.2 3784.6 5291.7 5358.2 5369.8 5413.7 5421.9 3804.9 3809.4 3814.4 3826.7 3827.7 3662.5 3881.4 3883.8 3894.8 3906.1 4382.5 4384.3 4384.5 4390.1 4411.8 5152.5 5162.2 5174.2 5182.0 5184.1 1272.1 1296.5 1339.3 1345.6 1348.9 865.6 880.2 889.7 891.9 895.0 3990.9 4003.3 4011.5 4016.6 4026.2 4606.9 4621.7 4624.8 4655.4 4659.0 3952.3 3979.6 3993.8 4004.6 4015.3 2360.5 2451.9 2460.4 2463.7 2505.6 4330.9 4345.5 4385.0 4396.7 4401.1 4708.9 4722.8 4743.8 4790.6 4798.6 4172.4 4366.0 4373.6 4384.8 4403.7 4560.4 4600.8 4608.9 4610.6 4618.8 4553.8 4593.0 4600.9 4619.0 4643.8 4121.9 4197.8 4383.7 4417.8 4431.6 3494.4 3496.6 3500.5 3500.5 3521.4 4743.6 4761.6 4762.4 4765.8 5131.8 5005.5 5109.3 5110.6 5133.8 5174.3 5098.7 5120.3 5129.3 5142.2 5145.0 4825.0 5034.5 5054.4 5068.3 5071.2 5177.6 5189.2 5201.5 5226.2 5246.4 5067.5 5080.6 5108.3 5134.2 5139.3 03:19:32 INFO - PROCESS | 4315 | 03:19:32 INFO - PROCESS | 4315 | [#5] yui.html Cycles:180 Average:16873.52 Median:23086.15 stddev:22624.89 (98.0%) stddev-sans-first:22655.81 03:19:32 INFO - PROCESS | 4315 | Values: 711.7 727.9 733.4 750.8 765.5 13441.9 13981.1 14001.0 14006.4 14013.7 14176.7 14178.2 14197.2 14224.9 14320.7 612.4 755.6 796.6 801.0 802.1 785.6 798.2 798.8 798.8 799.4 822.3 827.1 829.1 831.2 834.2 629.1 779.7 820.9 823.5 825.1 603.7 606.7 606.9 606.9 607.4 12913.0 12930.1 12935.7 12963.1 12965.5 11662.2 11902.9 12473.2 12477.5 12548.8 11532.9 11975.8 12023.3 12220.3 12320.9 4118.2 4128.8 4171.5 4186.9 4200.3 60168.4 60480.4 60612.4 60703.4 61121.7 10072.9 10259.2 10292.1 10562.6 10810.8 17762.5 17764.0 17787.9 17789.3 17800.7 6879.4 6964.8 6965.7 7036.9 7124.7 3655.2 3672.4 3698.0 3707.5 3734.0 2753.4 2852.4 2853.2 2855.8 2855.9 492.3 504.8 505.7 505.9 506.4 481.8 539.4 571.1 594.1 606.3 7515.9 7840.9 7975.4 8072.8 8126.9 503.8 504.2 509.3 541.4 587.8 3551.6 3672.7 3801.4 3809.7 3827.3 68452.7 81429.6 86640.0 87688.0 93428.5 70970.7 72976.6 80733.4 80842.6 81435.0 41847.6 50506.7 66646.0 72596.0 73348.9 8694.0 9000.9 9015.6 9019.5 9022.7 41887.2 41972.0 42318.0 42658.4 42698.8 54188.5 59876.7 61879.7 61967.0 62069.4 12392.4 12421.4 12506.5 12538.8 12765.1 12938.9 13084.7 13324.7 13410.0 13419.4 12260.5 12315.8 12445.8 12652.1 12815.7 12454.6 12630.6 12669.0 12843.9 13456.8 12277.8 12815.1 12906.5 12937.9 13023.7 9539.4 10085.9 10122.3 10202.7 10278.6 10216.4 10989.2 11021.0 11061.7 11166.7 03:19:32 INFO - PROCESS | 4315 | -------- Summary: end -------- 03:19:32 INFO - PROCESS | 4315 | 03:19:33 INFO - TEST-INFO | 4315: exit 0 03:19:33 INFO - TEST-OK | dromaeo_css | took 1119212ms 03:19:33 INFO - TEST-START | kraken 03:19:33 INFO - operating with platform_type : linux_ 03:19:33 INFO - Initialising browser for kraken test... 03:19:33 INFO - TEST-INFO | started process 4498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3R8KgT/profile http://localhost:41828/getInfo.html) 03:19:37 INFO - PROCESS | 4498 | __metrics Screen width/height:1600/1200 03:19:37 INFO - PROCESS | 4498 | colorDepth:24 03:19:37 INFO - PROCESS | 4498 | Browser inner width/height: 1024/697 03:19:37 INFO - PROCESS | 4498 | __metrics 03:19:37 INFO - PROCESS | 4498 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:38 INFO - TEST-INFO | 4498: exit 0 03:19:38 INFO - Browser initialized. 03:19:38 INFO - Running cycle 1/1 for kraken test... 03:19:38 INFO - TEST-INFO | started process 4577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3R8KgT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:50 INFO - PROCESS | 4577 | RSS: Main: 175620096 03:19:50 INFO - PROCESS | 4577 | 03:19:53 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41828/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:54 INFO - PROCESS | 4577 | RSS: Main: 232960000 03:19:54 INFO - PROCESS | 4577 | 03:19:57 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41828/tests/kraken/driver.html?testName=audio-dft) 03:19:57 INFO - PROCESS | 4577 | RSS: Main: 222830592 03:19:57 INFO - PROCESS | 4577 | 03:20:01 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41828/tests/kraken/driver.html?testName=audio-fft) 03:20:01 INFO - PROCESS | 4577 | RSS: Main: 288882688 03:20:01 INFO - PROCESS | 4577 | 03:20:04 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41828/tests/kraken/driver.html?testName=audio-oscillator) 03:20:04 INFO - PROCESS | 4577 | RSS: Main: 198889472 03:20:04 INFO - PROCESS | 4577 | 03:20:06 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41828/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:07 INFO - PROCESS | 4577 | RSS: Main: 202371072 03:20:07 INFO - PROCESS | 4577 | 03:20:10 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41828/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:11 INFO - PROCESS | 4577 | RSS: Main: 239362048 03:20:11 INFO - PROCESS | 4577 | 03:20:14 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41828/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:15 INFO - PROCESS | 4577 | RSS: Main: 234319872 03:20:15 INFO - PROCESS | 4577 | 03:20:18 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41828/tests/kraken/driver.html?testName=json-parse-financial) 03:20:18 INFO - PROCESS | 4577 | RSS: Main: 237469696 03:20:18 INFO - PROCESS | 4577 | 03:20:20 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41828/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:21 INFO - PROCESS | 4577 | RSS: Main: 226476032 03:20:21 INFO - PROCESS | 4577 | 03:20:23 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:23 INFO - PROCESS | 4577 | RSS: Main: 229593088 03:20:23 INFO - PROCESS | 4577 | 03:20:26 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:26 INFO - PROCESS | 4577 | RSS: Main: 237961216 03:20:26 INFO - PROCESS | 4577 | 03:20:29 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:30 INFO - PROCESS | 4577 | RSS: Main: 239857664 03:20:30 INFO - PROCESS | 4577 | 03:20:33 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:33 INFO - PROCESS | 4577 | RSS: Main: 241958912 03:20:33 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | Cycle 1(1): loaded http://localhost:41828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41828/tests/kraken/driver.html?testName=ai-astar) 03:20:35 INFO - PROCESS | 4577 | RSS: Main: 284557312 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | __start_tp_report 03:20:35 INFO - PROCESS | 4577 | _x_x_mozilla_page_load 03:20:35 INFO - PROCESS | 4577 | _x_x_mozilla_page_load_details 03:20:35 INFO - PROCESS | 4577 | |i|pagename|runs| 03:20:35 INFO - PROCESS | 4577 | |0;ai-astar;103;114;114;114;116;113;112;114;114;112 03:20:35 INFO - PROCESS | 4577 | |1;audio-beat-detection;165;132;136;190;131;132;155;131;195;130 03:20:35 INFO - PROCESS | 4577 | |2;audio-dft;161;161;161;162;161;162;161;161;161;161 03:20:35 INFO - PROCESS | 4577 | |3;audio-fft;76;77;78;110;76;77;76;75;98;76 03:20:35 INFO - PROCESS | 4577 | |4;audio-oscillator;87;86;127;85;86;85;126;87;87;127 03:20:35 INFO - PROCESS | 4577 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 03:20:35 INFO - PROCESS | 4577 | |6;imaging-darkroom;146;147;146;146;145;146;146;147;147;147 03:20:35 INFO - PROCESS | 4577 | |7;imaging-desaturate;96;96;95;95;96;95;95;96;95;95 03:20:35 INFO - PROCESS | 4577 | |8;json-parse-financial;63;64;62;63;65;64;63;62;63;63 03:20:35 INFO - PROCESS | 4577 | |9;json-stringify-tinderbox;64;64;64;64;75;65;65;64;65;65 03:20:35 INFO - PROCESS | 4577 | |10;stanford-crypto-aes;87;82;83;82;88;86;83;84;114;89 03:20:35 INFO - PROCESS | 4577 | |11;stanford-crypto-ccm;135;132;130;126;132;127;127;127;137;144 03:20:35 INFO - PROCESS | 4577 | |12;stanford-crypto-pbkdf2;167;169;165;167;165;165;166;171;169;165 03:20:35 INFO - PROCESS | 4577 | |13;stanford-crypto-sha256-iterative;69;75;67;65;69;67;73;67;72;65 03:20:35 INFO - PROCESS | 4577 | __end_tp_report 03:20:35 INFO - PROCESS | 4577 | __start_cc_report 03:20:35 INFO - PROCESS | 4577 | _x_x_mozilla_cycle_collect,1912 03:20:35 INFO - PROCESS | 4577 | __end_cc_report 03:20:35 INFO - PROCESS | 4577 | __startTimestamp1466677235652__endTimestamp 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | ------- Summary: start ------- 03:20:35 INFO - PROCESS | 4577 | Number of tests: 14 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.57 (3.1%) stddev-sans-first:1.22 03:20:35 INFO - PROCESS | 4577 | Values: 103.0 114.0 114.0 114.0 116.0 113.0 112.0 114.0 114.0 112.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:145.50 stddev:25.47 (17.5%) stddev-sans-first:26.41 03:20:35 INFO - PROCESS | 4577 | Values: 165.0 132.0 136.0 190.0 131.0 132.0 155.0 131.0 195.0 130.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:20:35 INFO - PROCESS | 4577 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 161.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.50 stddev:12.01 (15.7%) stddev-sans-first:12.55 03:20:35 INFO - PROCESS | 4577 | Values: 76.0 77.0 78.0 110.0 76.0 77.0 76.0 75.0 98.0 76.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:86.00 stddev:19.59 (22.8%) stddev-sans-first:20.35 03:20:35 INFO - PROCESS | 4577 | Values: 87.0 86.0 127.0 85.0 86.0 85.0 126.0 87.0 87.0 127.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:20:35 INFO - PROCESS | 4577 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:20:35 INFO - PROCESS | 4577 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 146.0 147.0 147.0 147.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:20:35 INFO - PROCESS | 4577 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 03:20:35 INFO - PROCESS | 4577 | Values: 63.0 64.0 62.0 63.0 65.0 64.0 63.0 62.0 63.0 63.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:3.37 (5.2%) stddev-sans-first:3.54 03:20:35 INFO - PROCESS | 4577 | Values: 64.0 64.0 64.0 64.0 75.0 65.0 65.0 64.0 65.0 65.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:9.54 (11.2%) stddev-sans-first:10.12 03:20:35 INFO - PROCESS | 4577 | Values: 87.0 82.0 83.0 82.0 88.0 86.0 83.0 84.0 114.0 89.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:132.00 stddev:5.70 (4.3%) stddev-sans-first:5.92 03:20:35 INFO - PROCESS | 4577 | Values: 135.0 132.0 130.0 126.0 132.0 127.0 127.0 127.0 137.0 144.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:167.00 stddev:2.13 (1.3%) stddev-sans-first:2.26 03:20:35 INFO - PROCESS | 4577 | Values: 167.0 169.0 165.0 167.0 165.0 165.0 166.0 171.0 169.0 165.0 03:20:35 INFO - PROCESS | 4577 | 03:20:35 INFO - PROCESS | 4577 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:3.41 (4.9%) stddev-sans-first:3.62 03:20:35 INFO - PROCESS | 4577 | Values: 69.0 75.0 67.0 65.0 69.0 67.0 73.0 67.0 72.0 65.0 03:20:35 INFO - PROCESS | 4577 | -------- Summary: end -------- 03:20:35 INFO - PROCESS | 4577 | 03:20:36 INFO - TEST-INFO | 4577: exit 0 03:20:36 INFO - TEST-OK | kraken | took 63455ms 03:20:36 INFO - SUITE-END | took 1182s 03:20:36 INFO - Completed test suite (00:19:42) 03:20:36 INFO - javascript benchmark 03:20:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.7261887501813, 2622.5934980078096, 2651.867406629668, 2654.1241390341183, 2656.4421471490987, 4738.2892566115015, 4801.303810947415, 4832.081904438154, 4860.149473842077, 4907.435644900837, 4861.270809378586, 4862.14912390332, 4877.951220487794, 4890.290907818364, 4978.950210497894, 4452.933206001896, 4466.419365482483, 4490.461144662645, 4500.5724456176695, 4507.72953622782, 4609.193391156551, 4646.465656449501, 4654.418197725285, 4682.41469816273, 4702.05958808238, 4576.519465456146, 4593.862184134481, 4629.0279041401345, 4634.281686338623, 4665.953340466603, 4397.890052748675, 4460.063386688799, 4463.152001119777, 4463.799129039168, 4492.84275050375, 4391.363252328394, 4394.62645675118, 4444.622207112399, 4470.9105817883465, 4557.58981691646, 4881.926771098437, 4899.118158731427, 4922.926156107661, 4942.456329803718, 4943.456219815817, 5067.8986420271385, 5120.334356533664, 5308.681479111227, 5312.946870531323, 5322.520973112439, 5229.0, 5234.502722241381, 5274.815381461669, 5385.811496597639, 5409.756560954727, 4920.950790492049, 4995.300657907896, 5019.447860735316, 5035.949640503548, 5039.924401133986, 5231.895362092737, 5374.570034397317, 5473.397926228112, 5476.780928762805, 5477.589180811455, 5167.819126330561, 5281.841544753664, 5286.418493965661, 5290.523852853262, 5291.074062039128, 5271.683698978073, 5281.894362112736, 5285.180796976475, 5287.4976877196605, 5288.048151332797, 5150.253213284052, 5160.0969830279555, 5216.739163041832, 5244.213367994831, 5308.761105750251, 5215.374155101412, 5239.423663397023, 5240.895182096337, 5246.527812496894, 5272.103742363731, 4490.368542545599, 4497.2804351304285, 4497.595216430537, 4539.818407263672, 4543.0, 3872.2642697887313, 3888.416737489399, 3894.279558281727, 3910.100676844285, 3929.1159489115294, 4470.329450582439, 4518.525554816762, 4520.819167233274, 4531.093781243699, 4554.339620755039, 5332.520073193431, 5346.1713434417725, 5355.491228333302, 5356.0894647909945, 5407.83776486706, 4374.4531933508315, 4520.728756274634, 4540.977295113569, 4556.794944227518, 4603.95396046042, 4657.46439159501, 4699.95300047002, 4714.104320179155, 4719.292106184032, 4719.3628860103445, 4865.854024379274, 4891.0, 4894.388201474816, 4898.142825005539, 4945.208766597327, 5139.408967968731, 5225.973870130625, 5228.215767634885, 5233.712145831863, 5285.550728188147, 4938.530839570235, 4955.975220123876, 4981.850544483671, 4990.101781679187, 5031.0, 5235.790568377222, 5238.109521381298, 5248.60635452335, 5251.947480525146, 5305.257263983122, 5158.690478571298, 5250.081235783799, 5302.549283310962, 5314.415414304346, 5332.200169974535, 5174.767135478837, 5181.948180518147, 5184.922226166535, 5189.481051894781, 5219.712915789516, 5132.717700526507, 5154.433012368561, 5178.249153872592, 5180.896382072413, 5229.581633469237, 4911.287863259879, 4984.127777638972, 5054.0, 5059.038782631288, 5090.49095090488, 5141.742912854417, 5165.7675404607635, 5167.044096841946, 5167.844964651066, 5208.24480450325, 5014.0, 5016.849494515171, 5028.673136246132, 5062.746862656926, 5070.340855688737], "value": 4831.655639665984, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.1389202750064, 582.7872826418358, 587.3451102021247, 592.5644651181384, 600.4715850051955, 26242.606360904578, 28531.714682853166, 38996.805015974955, 39940.80029599855, 40053.0, 39245.803770981176, 39649.20701585967, 39696.0, 39730.60269397305, 39756.40365394514, 7884.4086693498075, 8046.959765201166, 8050.4364694471415, 8052.074011488666, 8054.43618946674, 7863.56750378729, 7932.365410767125, 7956.960215198916, 7961.402894782915, 7990.720324788634, 7962.243586859239, 8003.559804210766, 8007.279344858962, 8011.799705007393, 8013.799655008643, 7960.323372513314, 8003.95998020012, 8004.799880002988, 8007.799805004864, 8011.679532818738, 7935.365170786324, 8008.7597372078935, 8013.358931285483, 8014.0, 8021.117677055519, 38143.23713525714, 38577.61422385796, 38603.80698096519, 38727.419088713694, 38732.612673873184, 3134.7492200623897, 3243.9026829195163, 3291.1113999220074, 3354.1446931032674, 3755.511783468159, 28881.56677649837, 29409.411811763646, 29647.851760741272, 29721.25696857574, 29743.851280743456, 3121.3133110715607, 3167.667394923546, 3238.0771480128287, 3239.6922292382187, 3241.578594782663, 261841.0, 264522.0, 264956.0, 265125.0, 265461.0, 53336.199957000674, 53592.464075358745, 53891.730541347824, 53972.46027539753, 53977.73011134998, 33018.66981330156, 33799.15502112467, 33868.49197262043, 35756.28487430237, 56363.71818140883, 14299.499517516837, 14331.06848054873, 14410.855891440951, 14449.78325325121, 14468.565943021726, 10923.726906827393, 11054.557817687364, 11054.557817687364, 11058.281211721212, 11071.225014248925, 18468.907655461637, 18575.16411761474, 18609.81390186108, 18691.252349906124, 18789.43631691024, 6805.353491418307, 6860.5197636165985, 6872.793816185523, 6981.965090174618, 7111.2533184015965, 794.3367288314322, 872.6858331000834, 920.3511524375299, 992.8400003983287, 993.3046867192994, 26748.465030699666, 27261.182164535097, 27673.584896226574, 27847.30381740473, 27902.3024424391, 790.8615992201342, 948.6774496671027, 960.846264597675, 1005.0853723111933, 1023.559869256227, 13955.79066314006, 14258.643533911736, 14410.0, 14576.125432474086, 14755.114693118232, 373253.0, 375542.0, 375945.1202743969, 376276.0, 377259.0, 47617.285740713916, 48088.75955620199, 48176.27735583969, 48227.276590851165, 48292.999999999294, 1073.1414868105485, 1136.2954967919943, 1184.5084290019545, 1201.4893670190133, 1206.1255589697398, 26982.32544186411, 27570.310742231606, 28027.0, 28777.712222877504, 29406.55890161692, 46334.53665463302, 47123.52876471191, 47178.0, 47205.80736119093, 47243.29135062908, 339082.0, 340519.0, 342261.0, 343752.0, 344419.0, 32569.348613027134, 36774.26451471009, 38018.61981380151, 38204.0, 40429.39355909605, 41141.382879256234, 41318.806423264934, 41464.79267603643, 41516.377254341816, 41636.0, 35008.29983400369, 35035.47446788351, 35309.29381412306, 35653.64346356607, 35745.28509429745, 35441.46837797383, 35453.113672158404, 35490.0, 35839.28321433609, 35908.76821086115, 34440.48339274963, 35327.0, 35456.0, 35941.640583594875, 36142.63857361393, 31558.36883262276, 32216.516752248266, 32250.0, 32571.511427328136, 32785.836070819496, 23572.52854942857, 24206.878965605763, 24258.272251832474, 24637.38406539851, 24649.60209050959], "value": 17554.002501382372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.1796928787381, 371.63950967561465, 377.3716761591948, 383.1933779394375, 385.57201506327954, 16036.118013509253, 17443.3022679093, 17647.823521764778, 18118.637627247448, 18168.36410725625, 16759.162041897886, 17050.39204914349, 17282.740758888627, 17343.566410839736, 17379.304827806904, 5091.312672789172, 5303.178007408838, 5333.093374126408, 5340.946590534103, 5341.172118321666, 3752.924941501182, 3840.8463661453507, 4726.4328280606205, 5189.6886186828915, 6348.428641422271, 6178.660173690468, 6210.130581718563, 6288.119663247149, 6290.874182516347, 6298.748050077991, 5978.701064946757, 6090.908636370458, 6108.694565271719, 6153.569250152491, 6210.937890621081, 3404.3531728971666, 5133.358330208724, 5438.700871452069, 5460.645058071253, 5472.124460086367, 19916.80083199164, 20587.970601469868, 20640.380788576367, 20925.686114708293, 20964.0, 1988.542635193899, 1998.860079794415, 2052.5792212596384, 2091.759447663523, 2136.4231657452556, 12790.616281511477, 13129.34353282332, 13236.669083272898, 13487.258200798951, 13698.65753356174, 1709.6409753951561, 1756.0692832798509, 1796.7568538787484, 1798.379559052125, 1807.9186436610385, 63072.0, 64106.67946660237, 65221.347786522005, 66595.3340466594, 66721.0, 9514.429134251966, 9659.758506037406, 9690.660826871026, 9816.950915245377, 10157.003683913263, 13653.38559764813, 13721.245331506663, 13747.793783093262, 13759.10565813239, 13760.0, 7327.2672732726305, 7327.340539351484, 7591.089069311718, 7607.16321204667, 7628.580428076398, 7243.674034668453, 7259.745908893164, 7301.744438944612, 7320.816979575553, 7415.592142432218, 6181.103739957681, 6244.750209991549, 6246.187995560548, 6306.558540902093, 6421.389967953037, 1746.4324094669282, 1748.9038102904462, 1772.2556526259002, 1784.97322540162, 1837.154908741967, 866.7096522664978, 877.688420610674, 918.701422037827, 963.6145541783343, 983.2379905573094, 17070.0, 17567.38514152024, 17735.201915913814, 17854.0, 18231.088445577934, 872.2542226396466, 888.5335199020566, 913.2283220678516, 916.7662246127195, 952.3857112162755, 9732.056365034487, 10273.537690803782, 10290.0, 10321.225908056926, 10335.328203666737, 374003.0, 375434.0, 380515.0, 382808.0, 388863.0, 42674.359884601756, 71479.2852071483, 71948.0, 74266.6286668574, 84856.0, 898.5282726568473, 917.2111983694151, 938.6245501799199, 941.7363138321281, 950.4107453379088, 15986.360545578513, 16134.193290335672, 16184.271707772943, 16250.26873790706, 16293.67412651764, 36485.45271820978, 37609.0, 38172.04569885775, 38361.808190958865, 40103.79948100241, 52504.73747631237, 54928.176077358075, 55413.44586554083, 55473.44526554683, 55626.72186639203, 6709.329067093447, 7061.152661680631, 7300.926990730025, 7872.685092596461, 8224.958875205586, 11787.998020168381, 11902.226355286879, 12241.265524068584, 12277.324747138637, 12283.938580307398, 9801.264905132, 9804.509774511103, 9828.606855725691, 9831.606735730491, 10003.449810260505, 4965.155923493087, 7445.664945077377, 10060.440631702098, 10234.283600147919, 10504.842427363748, 9808.16630586408, 9931.404115753077, 10031.398116112765, 10068.89931100709, 10651.201159913193, 7241.710331586678, 7319.74380896666, 7336.4130869529245, 7367.926320736939, 7515.248475152441, 9754.707358779247, 9914.157296629868, 9923.156531694887, 10028.247881408777, 10206.23453240995], "value": 8420.950265715072, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.842200513933, 1360.7142500074983, 1388.2989090509295, 1464.202009904602, 1723.1987125986414, 6579.440747536459, 7612.200718924516, 7761.999999999993, 7825.0, 8056.758297251092, 7657.961710191441, 7818.179091195428, 7820.882686759704, 7825.1783562725805, 7825.5304681719135, 1844.5757475780579, 2073.1396470464815, 2144.2816656420077, 2160.6975023496725, 2177.7822217778253, 2232.162938897913, 2244.079927229836, 2250.8424410291204, 2258.5144193998285, 2260.152442833937, 2141.4218161096496, 2151.558930419268, 2183.8098236461087, 2189.627763280238, 2191.616467118256, 1778.8221177882174, 1835.9357422490148, 1840.604270081939, 2056.4550394145563, 2123.62836503612, 2139.6148693235214, 2178.6078505868936, 2185.4317877352005, 2189.0477642225524, 2189.8576592521435, 7998.720044798462, 7999.120096789348, 8064.0, 8068.112507624157, 8068.596570171468, 4609.078184363141, 4729.408823897013, 4745.288206768978, 4746.02706445178, 4758.048390321949, 2867.426514697048, 2895.60909277247, 2947.2042548511995, 2998.895038673636, 3002.084364268897, 943.1700103908585, 944.6740874398322, 954.7374472020181, 970.815545046446, 985.0199051943291, 10966.396848173346, 10978.231523793338, 10979.945100274528, 11004.669859904216, 11034.17243706717, 4280.571942805756, 4321.65426765858, 4346.413234213404, 4383.517813040563, 4468.017036252019, 9175.669527918548, 9212.53937303132, 9229.030951750105, 9262.073792620818, 9291.163795258459, 4681.461631912305, 4701.388819453449, 4702.412198475191, 4714.504976977437, 4715.575598196178, 3628.3468975584647, 4188.015816283171, 4330.458692663417, 4340.500842403101, 4374.081442896963, 3645.0705070206927, 3727.310447567209, 3767.2842159990064, 3776.905577360588, 3860.7104467165077, 1100.763335882773, 1196.0969468051564, 1203.7773011992633, 1208.9939550302192, 1219.969500762488, 732.4726197138052, 779.8518281526492, 836.7406104107746, 846.3736834742247, 860.4364141487335, 5140.254663073908, 5196.610254230948, 5279.313689220377, 5339.652922560099, 5362.463753624606, 872.1365847810748, 913.3323767916677, 921.6635927886407, 941.0989800602744, 961.3078583419926, 3437.4671925851535, 3612.403953347668, 3622.5652921649043, 3652.7625704329134, 3666.7066634669163, 9654.131128198356, 9827.066428689262, 9951.55218015191, 9956.751081223027, 9971.501424928725, 9826.06652368024, 9884.406935583887, 9894.505274736235, 9900.55447504864, 9925.602975880884, 6978.825529361705, 7387.81530461732, 7532.435067369969, 7533.962330188314, 7538.09542854861, 5101.795928162832, 5157.93702357277, 5379.973100134631, 5528.419515950767, 5552.056150454513, 8974.057723938893, 9154.496502692416, 9267.119623635745, 9269.258459323373, 9275.953620231856, 9089.181973622406, 9225.261979041527, 9331.626734930798, 9382.29632777558, 9477.004914484156, 6459.838504037249, 6730.427913627396, 6810.62541560219, 6823.897641535282, 6974.616396098263, 7588.962055189689, 7632.771016869503, 7670.654820533201, 7682.001339825787, 7708.807279818049, 6693.09643198162, 6911.516193866582, 7027.051348067946, 7118.786436406709, 7121.537100088685, 6925.27284635106, 6988.965055174692, 7051.43588512928, 7052.576845389293, 7142.285771422816, 6262.68686565679, 6271.498280137487, 6275.466585340298, 6281.623102613858, 6283.3716628338625, 4400.097979914174, 4401.383806267061, 4448.844290449819, 4462.754548499864, 4484.9103017940115, 4553.043860789271, 4570.81716731327, 4586.357909892685, 4630.629549636088, 4634.930476042795], "value": 4178.01021689091, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8860838577147, 297.77071654825784, 306.462158911111, 312.39083786616106, 314.99999999999983, 4780.545848144429, 4924.901501969958, 4932.210846264598, 4937.530934561211, 4978.676386034906, 4661.533846615337, 4841.273808928662, 4861.465238823726, 4885.242787367954, 4910.6071514278865, 3866.1881004988845, 3867.690584753227, 3876.205377897524, 3879.9718074710154, 3897.2205558888195, 3639.1811842335396, 3694.261147770457, 3856.2865869814036, 3868.3423817950875, 3872.8644497442597, 3824.7187192290617, 3825.8087095645105, 3832.8466861325514, 3844.2695887781374, 3846.74996125251, 3794.620537946211, 3811.6760075393627, 3818.6563209311157, 3828.7511311764647, 3830.9042273943096, 3379.273456206927, 3388.6441923597913, 3421.36704709627, 3428.7257019438384, 3456.5679290088738, 4645.721256724607, 4715.561753665131, 4722.220833562493, 4725.834595789131, 4764.522997870637, 4372.606465418127, 4384.6273066789045, 4391.3193455014525, 4426.490953540319, 4434.9356154523, 5103.668261562986, 5111.795528178905, 5111.952049829813, 5114.462981386975, 5128.512791284822, 3656.981715091434, 3765.3222419964395, 3771.9434208486896, 3776.244751049801, 3784.5836957934607, 5291.703532634529, 5358.223057656657, 5369.785208591691, 5413.702246376448, 5421.918671219935, 3804.904877378088, 3809.3904975203836, 3814.389697648363, 3826.6938644908896, 3827.6937844972335, 3662.52387189669, 3881.359575669983, 3883.8446462141765, 3894.766314021168, 3906.140649057203, 4382.474103107647, 4384.320430333303, 4384.47386313638, 4390.143921935192, 4411.7867586413995, 5152.458991805881, 5162.199859021857, 5174.24973378858, 5182.0, 5184.144616138295, 1272.0904553244475, 1296.4619682831708, 1339.3169483563258, 1345.6232254968625, 1348.9325533723274, 865.6191275838611, 880.1858281090094, 889.6975028490344, 891.8751374807532, 894.9821003579892, 3990.86031988879, 4003.3394489908837, 4011.498562679665, 4016.59834016596, 4026.154507553388, 4606.907861842745, 4621.745803980746, 4624.768761561976, 4655.39207114489, 4659.0, 3952.288588054178, 3979.6270286751023, 3993.800309984489, 4004.577230775339, 4015.297322968469, 2360.4806942472974, 2451.9141830035865, 2460.3972026853176, 2463.7289898111194, 2505.5843448451565, 4330.870073897788, 4345.543717909637, 4384.96953215994, 4396.714213576107, 4401.053773438662, 4708.929366059512, 4722.811087556459, 4743.810247590127, 4790.616750659939, 4798.616110711135, 4172.415861779354, 4365.956340436555, 4373.606375426163, 4384.802683879233, 4403.691741578059, 4560.429946256718, 4600.769961501978, 4608.907821843612, 4610.608098311681, 4618.769061546842, 4553.840615578439, 4593.035462552902, 4600.884977875446, 4618.976905115453, 4643.814247430065, 4121.855735049259, 4197.782643033608, 4383.736975781463, 4417.8232870684815, 4431.556844315672, 3494.423420135751, 3496.5629296337956, 3500.457429098494, 3500.492428597788, 3521.3837578423163, 4743.644226683082, 4761.642931764431, 4762.380890484214, 4765.783910481643, 5131.846044618667, 5005.49835049491, 5109.284700142058, 5110.61670374716, 5133.845984620468, 5174.301469301596, 5098.668586541863, 5120.283160357628, 5129.256257842667, 5142.1772516397195, 5144.9742751286, 4824.986752781955, 5034.546890779848, 5054.393472783289, 5068.341115654941, 5071.163258062378, 5177.637565370538, 5189.169732842727, 5201.531862132426, 5226.189940559219, 5246.449122842047, 5067.5185857343495, 5080.593552515864, 5108.3103780989095, 5134.204198349262, 5139.306193663808], "value": 3732.7400357032398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.7295427737462, 727.8762610356239, 733.3802936518641, 750.8385697075128, 765.4565258666347, 13441.932790336046, 13981.091229070129, 14001.019928605014, 14006.369713362898, 14013.719725605482, 14176.716465670706, 14178.220197889112, 14197.219152946584, 14224.928875355608, 14320.71358572828, 612.3692596625483, 755.5617741709823, 796.5579103597515, 801.0427539090789, 802.1096582793095, 785.5993443343907, 798.1659166171336, 798.7883210949103, 798.8282519258358, 799.4084377560592, 822.2969361196181, 827.0571548434789, 829.0631586307464, 831.2311112221201, 834.2325060943946, 629.0564153769346, 779.7037125892182, 820.8973878265188, 823.4976664234812, 825.051191130202, 603.7464265008663, 606.6754286456725, 606.8634557224633, 606.902895536712, 607.4259824465881, 12913.0, 12930.09489335747, 12935.741285174337, 12963.092583519157, 12965.546205882843, 11662.241954272946, 11902.940485297604, 12473.189242699196, 12477.50089996399, 12548.8117678234, 11532.94233528827, 11975.820362694567, 12023.278603283743, 12220.2667839929, 12320.876791232062, 4118.19695159444, 4128.793560321972, 4171.499420069581, 4186.91626167478, 4200.306949353353, 60168.39831601672, 60480.39519604792, 60612.39387606111, 60703.39296607021, 61121.69439152776, 10072.899271007196, 10259.17926565873, 10292.104175690685, 10562.630307939186, 10810.783784324269, 17762.46712598624, 17764.045954944944, 17787.911060444614, 17789.288428462718, 17800.732989005177, 6879.380855723009, 6964.79105626832, 6965.721371145098, 7036.9296307036275, 7124.679389427488, 3655.1593133578895, 3672.4491326301268, 3697.963020369762, 3707.4994875691978, 3734.0, 2753.3529620539157, 2852.4437734641547, 2853.172579951791, 2855.814372065809, 2855.9000434984678, 492.2886429109902, 504.848545436375, 505.7370167512873, 505.94181669107786, 506.37968488601905, 481.7759741720117, 539.3500831498036, 571.1176232720456, 594.1147689941955, 606.2936678769273, 7515.887261691079, 7840.882386764203, 7975.441719079725, 8072.757817265491, 8126.878096828552, 503.768266597362, 504.19580768673904, 509.34294759759496, 541.4287926237857, 587.8354060862965, 3551.6270791566512, 3672.6878215351994, 3801.4107813288983, 3809.657130858236, 3827.2536855312946, 68452.65773671199, 81429.59285203654, 86640.0, 87688.0, 93428.53285733527, 70970.73433478906, 72976.63511682514, 80733.3853322942, 80842.59578702069, 81435.0, 41847.58152418498, 50506.74746626243, 66646.0, 72595.99999999894, 73348.89976650354, 8693.956530217309, 9000.909990900269, 9015.639374424949, 9019.458832470073, 9022.684206052756, 41887.162256755306, 41972.0, 42318.0, 42658.36012459754, 42698.78650606727, 54188.45811541834, 59876.70061649664, 61879.6906015467, 61967.0, 62069.37930620636, 12392.442340094538, 12421.44103515362, 12506.499740010298, 12538.811917821058, 12765.106442548933, 12938.870611293767, 13084.738305234032, 13324.733505330032, 13409.982753880298, 13419.396127174105, 12260.509579616715, 12315.815262770886, 12445.813312800496, 12652.051096168008, 12815.679608009874, 12454.564090256797, 12630.610632830565, 12669.0, 12843.935780321039, 13456.798148027983, 12277.815832762337, 12815.102942793916, 12906.493467800832, 12937.935310323388, 13023.739525209254, 9539.445862376188, 10085.899141008496, 10122.342047766871, 10202.744931376776, 10278.588856445958, 10216.438095904796, 10989.175811813986, 11021.0, 11061.668149955514, 11166.665000050012], "value": 6604.201718501368, "unit": "score"}], "name": "dromaeo_css", "value": 6473.166070873836, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 114.0, 116.0, 113.0, 112.0, 114.0, 114.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 136.0, 190.0, 131.0, 132.0, 155.0, 131.0, 195.0, 130.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 110.0, 76.0, 77.0, 76.0, 75.0, 98.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 127.0, 85.0, 86.0, 85.0, 126.0, 87.0, 87.0, 127.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 65.0, 64.0, 63.0, 62.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 75.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 83.0, 82.0, 88.0, 86.0, 83.0, 84.0, 114.0, 89.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 130.0, 126.0, 132.0, 127.0, 127.0, 127.0, 137.0, 144.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 165.0, 167.0, 165.0, 165.0, 166.0, 171.0, 169.0, 165.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 67.0, 65.0, 69.0, 67.0, 73.0, 67.0, 72.0, 65.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1546.2, "alertThreshold": 2.0}]} 03:20:36 INFO - Return code: 0 03:20:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:36 INFO - # TBPL SUCCESS # 03:20:36 INFO - Running post-action listener: _resource_record_post_action 03:20:36 INFO - ##### 03:20:36 INFO - ##### Finished run-tests step (success) 03:20:36 INFO - ##### 03:20:36 INFO - Running post-run listener: _resource_record_post_run 03:20:37 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 535109632; Read time: 164; Write time: 406924 03:20:37 INFO - TinderboxPrint: CPU usage
13.2% 03:20:37 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 164 03:20:37 INFO - TinderboxPrint: I/O write bytes / time
535,109,632 / 406,924 03:20:37 INFO - TinderboxPrint: CPU idle
8,305.8 (86.7%) 03:20:37 INFO - TinderboxPrint: CPU user
1,223.6 (12.8%) 03:20:37 INFO - TinderboxPrint: Swap in / out
0 / 0 03:20:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252280832; Read time: 0; Write time: 239092 03:20:37 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 282828800; Read time: 164; Write time: 167832 03:20:37 INFO - Running post-run listener: _upload_blobber_files 03:20:37 INFO - Blob upload gear active. 03:20:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:37 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 03:20:37 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'] 03:20:37 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 03:20:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:38 INFO - (blobuploader) - INFO - Done attempting. 03:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:42 INFO - (blobuploader) - INFO - Done attempting. 03:20:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:43 INFO - (blobuploader) - INFO - Done attempting. 03:20:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:43 INFO - Return code: 0 03:20:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a494b964b6647479847190d6bf08be9fe66b10274d037550a9aec26355880c48088b66285fac169001c15cdee38223ebd1c7a9c778e6845233f87805ead2455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fa16c6c986b434fc8401c6831bdc53692f84aec1e9462b0731dca899515870badcba71ddf1fa1c743ee47a6dcd500e9ef697049fca957d92ddbced7438d80a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f908750790b71bba537ec789049a9b3547c845caa371176ef53ac9ad3b69b75ced7ae78582c7a15acd5430af814a959fda601ea345f1fae9d0643c38e79c3d8"} 03:20:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:43 INFO - Contents: 03:20:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a494b964b6647479847190d6bf08be9fe66b10274d037550a9aec26355880c48088b66285fac169001c15cdee38223ebd1c7a9c778e6845233f87805ead2455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fa16c6c986b434fc8401c6831bdc53692f84aec1e9462b0731dca899515870badcba71ddf1fa1c743ee47a6dcd500e9ef697049fca957d92ddbced7438d80a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f908750790b71bba537ec789049a9b3547c845caa371176ef53ac9ad3b69b75ced7ae78582c7a15acd5430af814a959fda601ea345f1fae9d0643c38e79c3d8"} 03:20:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:43 INFO - Copying logs to upload dir... 03:20:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.546629 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-23 03:20:42.884774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 03:20:42.888534) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a494b964b6647479847190d6bf08be9fe66b10274d037550a9aec26355880c48088b66285fac169001c15cdee38223ebd1c7a9c778e6845233f87805ead2455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fa16c6c986b434fc8401c6831bdc53692f84aec1e9462b0731dca899515870badcba71ddf1fa1c743ee47a6dcd500e9ef697049fca957d92ddbced7438d80a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f908750790b71bba537ec789049a9b3547c845caa371176ef53ac9ad3b69b75ced7ae78582c7a15acd5430af814a959fda601ea345f1fae9d0643c38e79c3d8"} build_url:https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/UWowGdC9SOqZSVujy_nKAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a494b964b6647479847190d6bf08be9fe66b10274d037550a9aec26355880c48088b66285fac169001c15cdee38223ebd1c7a9c778e6845233f87805ead2455", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fa16c6c986b434fc8401c6831bdc53692f84aec1e9462b0731dca899515870badcba71ddf1fa1c743ee47a6dcd500e9ef697049fca957d92ddbced7438d80a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f908750790b71bba537ec789049a9b3547c845caa371176ef53ac9ad3b69b75ced7ae78582c7a15acd5430af814a959fda601ea345f1fae9d0643c38e79c3d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 03:20:42.919589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:20:42.920284) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466675999.41032-1350175071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 03:20:43.005131) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 03:20:43.005848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 03:20:43.006537) ========= ========= Total master_lag: 0.19 =========