builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1465581828.72 results: success (0) buildid: 20160610083009 builduid: 89febec36f2242de91f48e95e1327297 revision: ebef91ed1cf0b4d9525ea33fda5d51d96a5c6d4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.716581) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.717004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.717270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.731685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.731953) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 11:03:48-- 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% 64.8M=0s 2016-06-10 11:03:48 (64.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118179 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.861413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.861727) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019696 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:48.911147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 11:03:48.911498) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebef91ed1cf0b4d9525ea33fda5d51d96a5c6d4d --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 ebef91ed1cf0b4d9525ea33fda5d51d96a5c6d4d --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=20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 11:03:49,005 truncating revision to first 12 chars 2016-06-10 11:03:49,005 Setting DEBUG logging. 2016-06-10 11:03:49,005 attempt 1/10 2016-06-10 11:03:49,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebef91ed1cf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 11:03:50,003 unpacking tar archive at: fx-team-ebef91ed1cf0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.358302 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 11:03:50.283134) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:50.283478) ========= script_repo_revision: ebef91ed1cf0b4d9525ea33fda5d51d96a5c6d4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:50.283878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:50.284137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 11:03:50.294093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-10 11:03:50.294358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:50 INFO - MultiFileLogger online at 20160610 11:03:50 in /builds/slave/test 11:03:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:03:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:50 INFO - {'append_to_log': False, 11:03:50 INFO - 'base_work_dir': '/builds/slave/test', 11:03:50 INFO - 'blob_upload_branch': 'Fx-Team', 11:03:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:50 INFO - 'branch': 'Fx-Team', 11:03:50 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:50 INFO - 'config_files': ('talos/linux_config.py',), 11:03:50 INFO - 'default_actions': ('clobber', 11:03:50 INFO - 'read-buildbot-config', 11:03:50 INFO - 'download-and-extract', 11:03:50 INFO - 'populate-webroot', 11:03:50 INFO - 'create-virtualenv', 11:03:50 INFO - 'install', 11:03:50 INFO - 'run-tests'), 11:03:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:50 INFO - 'download_minidump_stackwalk': True, 11:03:50 INFO - 'download_symbols': 'ondemand', 11:03:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:03:50 INFO - 'tooltool.py': '/tools/tooltool.py', 11:03:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:03:50 INFO - '/tools/misc-python/virtualenv.py')}, 11:03:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:50 INFO - 'installer_path': 'installer.exe', 11:03:50 INFO - 'log_level': 'info', 11:03:50 INFO - 'log_name': 'talos', 11:03:50 INFO - 'log_to_console': True, 11:03:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:50 INFO - 'opt_config_files': (), 11:03:50 INFO - 'pip_index': False, 11:03:50 INFO - 'sps_profile': False, 11:03:50 INFO - 'sps_profile_interval': 0, 11:03:50 INFO - 'suite': 'dromaeojs', 11:03:50 INFO - 'system_bits': '32', 11:03:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:50 INFO - 'title': 'talos-linux64-ix-015', 11:03:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:50 INFO - 'use_talos_json': True, 11:03:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:50 INFO - 'work_dir': 'build'} 11:03:50 INFO - ##### 11:03:50 INFO - ##### Running clobber step. 11:03:50 INFO - ##### 11:03:50 INFO - Running pre-action listener: _resource_record_pre_action 11:03:50 INFO - Running main action method: clobber 11:03:50 INFO - rmtree: /builds/slave/test/build 11:03:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:50 INFO - Running post-action listener: _resource_record_post_action 11:03:50 INFO - ##### 11:03:50 INFO - ##### Finished clobber step (success) 11:03:50 INFO - ##### 11:03:50 INFO - ##### 11:03:50 INFO - ##### Running read-buildbot-config step. 11:03:50 INFO - ##### 11:03:50 INFO - Running pre-action listener: _resource_record_pre_action 11:03:50 INFO - Running main action method: read_buildbot_config 11:03:50 INFO - Using buildbot properties: 11:03:50 INFO - { 11:03:50 INFO - "project": "", 11:03:50 INFO - "product": "firefox", 11:03:50 INFO - "script_repo_revision": "production", 11:03:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:03:50 INFO - "repository": "", 11:03:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:03:50 INFO - "buildid": "20160610083009", 11:03:50 INFO - "pgo_build": "True", 11:03:50 INFO - "basedir": "/builds/slave/test", 11:03:50 INFO - "buildnumber": 1244, 11:03:50 INFO - "slavename": "talos-linux64-ix-015", 11:03:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:03:50 INFO - "platform": "ubuntu64_hw", 11:03:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:03:50 INFO - "branch": "fx-team", 11:03:50 INFO - "repo_path": "integration/fx-team", 11:03:50 INFO - "revision": "ebef91ed1cf0b4d9525ea33fda5d51d96a5c6d4d", 11:03:50 INFO - "stage_platform": "linux64-pgo", 11:03:50 INFO - "builduid": "89febec36f2242de91f48e95e1327297", 11:03:50 INFO - "slavebuilddir": "test" 11:03:50 INFO - } 11:03:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:03:50 INFO - Running post-action listener: _resource_record_post_action 11:03:50 INFO - ##### 11:03:50 INFO - ##### Finished read-buildbot-config step (success) 11:03:50 INFO - ##### 11:03:50 INFO - ##### 11:03:50 INFO - ##### Running download-and-extract step. 11:03:50 INFO - ##### 11:03:50 INFO - Running pre-action listener: _resource_record_pre_action 11:03:50 INFO - Running main action method: download_and_extract 11:03:50 INFO - mkdir: /builds/slave/test/build/tests 11:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:50 INFO - https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:03:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:03:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:03:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:51 INFO - Downloaded 1361 bytes. 11:03:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:03:51 INFO - Using the following test package requirements: 11:03:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:03:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:03:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:03:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'jsshell-linux-x86_64.zip'], 11:03:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:03:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:03:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:03:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:03:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:03:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:03:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:03:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:03:51 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')]} 11:03:51 INFO - https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:03:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:03:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:03:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:52 INFO - Downloaded 24464283 bytes. 11:03:52 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'] 11:03:52 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 11:03:53 INFO - Return code: 0 11:03:53 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 11:03:53 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')]} 11:03:53 INFO - https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:55 INFO - Downloaded 24464283 bytes. 11:03:55 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'] 11:03:55 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 11:03:56 INFO - Return code: 0 11:03:56 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')]} 11:03:56 INFO - https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:03:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:03:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:03:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:57 INFO - Downloaded 10833377 bytes. 11:03:57 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'] 11:03:57 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 11:03:58 INFO - Return code: 0 11:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:58 INFO - https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:03:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:03:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:03:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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 11:03:59 INFO - Downloaded 59338891 bytes. 11:03:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:03:59 INFO - mkdir: /builds/slave/test/properties 11:03:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:59 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:59 INFO - Contents: 11:03:59 INFO - build_url:https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:04:00 INFO - Running post-action listener: _resource_record_post_action 11:04:00 INFO - Running post-action listener: set_extra_try_arguments 11:04:00 INFO - ##### 11:04:00 INFO - ##### Finished download-and-extract step (success) 11:04:00 INFO - ##### 11:04:00 INFO - ##### 11:04:00 INFO - ##### Running populate-webroot step. 11:04:00 INFO - ##### 11:04:00 INFO - Running pre-action listener: _resource_record_pre_action 11:04:00 INFO - Running main action method: populate_webroot 11:04:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:04:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:04:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:04:00 INFO - '--tppagecycles', 11:04:00 INFO - '7'], 11:04:00 INFO - 'tests': ['tsvgm']}}, 11:04:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:04:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:04:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:04:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:04:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['damp', 'tps']}, 11:04:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'tests': ['damp', 'tps']}, 11:04:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['dromaeo_dom']}, 11:04:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['a11yr', 11:04:00 INFO - 'ts_paint', 11:04:00 INFO - 'tpaint', 11:04:00 INFO - 'sessionrestore', 11:04:00 INFO - 'sessionrestore_no_auto_restore', 11:04:00 INFO - 'tabpaint']}, 11:04:00 INFO - 'other-e10s': {'tests': ['a11yr', 11:04:00 INFO - 'ts_paint', 11:04:00 INFO - 'tpaint', 11:04:00 INFO - 'sessionrestore', 11:04:00 INFO - 'sessionrestore_no_auto_restore', 11:04:00 INFO - 'tabpaint']}, 11:04:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:04:00 INFO - 'ts_paint', 11:04:00 INFO - 'tpaint', 11:04:00 INFO - 'sessionrestore', 11:04:00 INFO - 'sessionrestore_no_auto_restore', 11:04:00 INFO - 'tabpaint']}, 11:04:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:04:00 INFO - 'ts_paint', 11:04:00 INFO - 'tpaint', 11:04:00 INFO - 'sessionrestore', 11:04:00 INFO - 'sessionrestore_no_auto_restore', 11:04:00 INFO - 'tabpaint']}, 11:04:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['a11yr', 11:04:00 INFO - 'ts_paint', 11:04:00 INFO - 'tpaint', 11:04:00 INFO - 'sessionrestore', 11:04:00 INFO - 'sessionrestore_no_auto_restore', 11:04:00 INFO - 'tabpaint']}, 11:04:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['a11yr', 11:04:00 INFO - 'ts_paint', 11:04:00 INFO - 'tpaint', 11:04:00 INFO - 'sessionrestore', 11:04:00 INFO - 'sessionrestore_no_auto_restore', 11:04:00 INFO - 'tabpaint']}, 11:04:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['tsvgx', 11:04:00 INFO - 'tsvgr_opacity', 11:04:00 INFO - 'tart', 11:04:00 INFO - 'tscrollx', 11:04:00 INFO - 'cart']}, 11:04:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:04:00 INFO - 'tsvgr_opacity', 11:04:00 INFO - 'tart', 11:04:00 INFO - 'tscrollx', 11:04:00 INFO - 'cart']}, 11:04:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'talos_options': ['--disable-e10s'], 11:04:00 INFO - 'tests': ['tp5o']}, 11:04:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'tests': ['tp5o']}, 11:04:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'talos_options': ['--disable-e10s', 11:04:00 INFO - '--xperf_path', 11:04:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:00 INFO - 'tests': ['tp5n']}, 11:04:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:00 INFO - 'talos_options': ['--xperf_path', 11:04:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:00 INFO - 'tests': ['tp5n']}}, 11:04:00 INFO - 'talos.zip': {'path': '', 11:04:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:04:00 INFO - Running post-action listener: _resource_record_post_action 11:04:00 INFO - ##### 11:04:00 INFO - ##### Finished populate-webroot step (success) 11:04:00 INFO - ##### 11:04:00 INFO - ##### 11:04:00 INFO - ##### Running create-virtualenv step. 11:04:00 INFO - ##### 11:04:00 INFO - Running pre-action listener: _resource_record_pre_action 11:04:00 INFO - Running main action method: create_virtualenv 11:04:00 INFO - Creating virtualenv /builds/slave/test/build/venv 11:04:00 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 11:04:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:04:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:00 INFO - Using real prefix '/usr' 11:04:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:04:00 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:02 INFO - Installing pip.................done. 11:04:02 INFO - Return code: 0 11:04:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:02 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:02 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 11:04:02 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 11:04:02 INFO - Using env: {'DISPLAY': ':0', 11:04:02 INFO - 'HOME': '/home/cltbld', 11:04:02 INFO - 'LANG': 'en_US.UTF-8', 11:04:02 INFO - 'LANGUAGE': 'en_US:en', 11:04:02 INFO - 'LOGNAME': 'cltbld', 11:04:02 INFO - 'MAIL': '/var/mail/cltbld', 11:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:02 INFO - 'MOZ_NO_REMOTE': '1', 11:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:02 INFO - 'NO_EM_RESTART': '1', 11:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:02 INFO - 'PWD': '/builds/slave/test', 11:04:02 INFO - 'SHELL': '/bin/bash', 11:04:02 INFO - 'SHLVL': '1', 11:04:02 INFO - 'TERM': 'linux', 11:04:02 INFO - 'TMOUT': '86400', 11:04:02 INFO - 'USER': 'cltbld', 11:04:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:02 INFO - '_': '/tools/buildbot/bin/python'} 11:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:03 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 11:04:03 INFO - Cleaning up... 11:04:03 INFO - Return code: 0 11:04:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:04:03 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')]} 11:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:03 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')]} 11:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:03 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:03 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 11:04:03 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 11:04:03 INFO - Using env: {'DISPLAY': ':0', 11:04:03 INFO - 'HOME': '/home/cltbld', 11:04:03 INFO - 'LANG': 'en_US.UTF-8', 11:04:03 INFO - 'LANGUAGE': 'en_US:en', 11:04:03 INFO - 'LOGNAME': 'cltbld', 11:04:03 INFO - 'MAIL': '/var/mail/cltbld', 11:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:03 INFO - 'MOZ_NO_REMOTE': '1', 11:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:03 INFO - 'NO_EM_RESTART': '1', 11:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:03 INFO - 'PWD': '/builds/slave/test', 11:04:03 INFO - 'SHELL': '/bin/bash', 11:04:03 INFO - 'SHLVL': '1', 11:04:03 INFO - 'TERM': 'linux', 11:04:03 INFO - 'TMOUT': '86400', 11:04:03 INFO - 'USER': 'cltbld', 11:04:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:03 INFO - '_': '/tools/buildbot/bin/python'} 11:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:03 INFO - Downloading/unpacking psutil>=3.1.1 11:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:05 INFO - Installing collected packages: psutil 11:04:05 INFO - Running setup.py install for psutil 11:04:05 INFO - building 'psutil._psutil_linux' extension 11:04:05 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 11:04:05 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 11:04:05 INFO - building 'psutil._psutil_posix' extension 11:04:05 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 11:04:05 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 11:04:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:05 INFO - Successfully installed psutil 11:04:05 INFO - Cleaning up... 11:04:05 INFO - Return code: 0 11:04:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:05 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:05 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 11:04:05 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 11:04:05 INFO - Using env: {'DISPLAY': ':0', 11:04:05 INFO - 'HOME': '/home/cltbld', 11:04:05 INFO - 'LANG': 'en_US.UTF-8', 11:04:05 INFO - 'LANGUAGE': 'en_US:en', 11:04:05 INFO - 'LOGNAME': 'cltbld', 11:04:05 INFO - 'MAIL': '/var/mail/cltbld', 11:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:05 INFO - 'MOZ_NO_REMOTE': '1', 11:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:05 INFO - 'NO_EM_RESTART': '1', 11:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:05 INFO - 'PWD': '/builds/slave/test', 11:04:05 INFO - 'SHELL': '/bin/bash', 11:04:05 INFO - 'SHLVL': '1', 11:04:05 INFO - 'TERM': 'linux', 11:04:05 INFO - 'TMOUT': '86400', 11:04:05 INFO - 'USER': 'cltbld', 11:04:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:05 INFO - '_': '/tools/buildbot/bin/python'} 11:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:04:06 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 11:04:06 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 11:04:06 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 11:04:06 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 11:04:06 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 11:04:06 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 11:04:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:04:07 INFO - Installing collected packages: mozsystemmonitor 11:04:07 INFO - Running setup.py install for mozsystemmonitor 11:04:08 INFO - Successfully installed mozsystemmonitor 11:04:08 INFO - Cleaning up... 11:04:08 INFO - Return code: 0 11:04:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:08 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:08 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 11:04:08 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 11:04:08 INFO - Using env: {'DISPLAY': ':0', 11:04:08 INFO - 'HOME': '/home/cltbld', 11:04:08 INFO - 'LANG': 'en_US.UTF-8', 11:04:08 INFO - 'LANGUAGE': 'en_US:en', 11:04:08 INFO - 'LOGNAME': 'cltbld', 11:04:08 INFO - 'MAIL': '/var/mail/cltbld', 11:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:08 INFO - 'MOZ_NO_REMOTE': '1', 11:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:08 INFO - 'NO_EM_RESTART': '1', 11:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:08 INFO - 'PWD': '/builds/slave/test', 11:04:08 INFO - 'SHELL': '/bin/bash', 11:04:08 INFO - 'SHLVL': '1', 11:04:08 INFO - 'TERM': 'linux', 11:04:08 INFO - 'TMOUT': '86400', 11:04:08 INFO - 'USER': 'cltbld', 11:04:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:08 INFO - '_': '/tools/buildbot/bin/python'} 11:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:08 INFO - Downloading/unpacking jsonschema==2.5.1 11:04:08 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 11:04:08 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 11:04:08 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 11:04:08 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 11:04:08 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 11:04:08 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 11:04:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:04:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:04:10 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 11:04:10 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 11:04:10 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 11:04:10 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 11:04:10 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 11:04:10 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 11:04:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:04:10 INFO - warning: no files found matching '*.txt' 11:04:10 INFO - no previously-included directories found matching 'build' 11:04:10 INFO - no previously-included directories found matching 'dist' 11:04:10 INFO - no previously-included directories found matching '.git*' 11:04:10 INFO - Installing collected packages: jsonschema, functools32 11:04:10 INFO - Running setup.py install for functools32 11:04:10 INFO - warning: no files found matching '*.txt' 11:04:10 INFO - no previously-included directories found matching 'build' 11:04:10 INFO - no previously-included directories found matching 'dist' 11:04:10 INFO - no previously-included directories found matching '.git*' 11:04:10 INFO - Successfully installed jsonschema functools32 11:04:10 INFO - Cleaning up... 11:04:10 INFO - Return code: 0 11:04:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:04:10 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')]} 11:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:10 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')]} 11:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:10 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:10 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 11:04:10 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 11:04:10 INFO - Using env: {'DISPLAY': ':0', 11:04:10 INFO - 'HOME': '/home/cltbld', 11:04:10 INFO - 'LANG': 'en_US.UTF-8', 11:04:10 INFO - 'LANGUAGE': 'en_US:en', 11:04:10 INFO - 'LOGNAME': 'cltbld', 11:04:10 INFO - 'MAIL': '/var/mail/cltbld', 11:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:10 INFO - 'MOZ_NO_REMOTE': '1', 11:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:10 INFO - 'NO_EM_RESTART': '1', 11:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:10 INFO - 'PWD': '/builds/slave/test', 11:04:10 INFO - 'SHELL': '/bin/bash', 11:04:10 INFO - 'SHLVL': '1', 11:04:10 INFO - 'TERM': 'linux', 11:04:10 INFO - 'TMOUT': '86400', 11:04:10 INFO - 'USER': 'cltbld', 11:04:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:10 INFO - '_': '/tools/buildbot/bin/python'} 11:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:04:10 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 11:04:10 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 11:04:10 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 11:04:10 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 11:04:10 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 11:04:10 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 11:04:12 INFO - Downloading blobuploader-1.2.4.tar.gz 11:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:04:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:04:12 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 11:04:12 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 11:04:12 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 11:04:12 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 11:04:12 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 11:04:12 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 11:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:04:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:04:13 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 11:04:13 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 11:04:13 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 11:04:13 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 11:04:13 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 11:04:13 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 11:04:13 INFO - Downloading docopt-0.6.1.tar.gz 11:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:04:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:04:13 INFO - Running setup.py install for blobuploader 11:04:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:04:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:04:13 INFO - Running setup.py install for requests 11:04:13 INFO - Running setup.py install for docopt 11:04:14 INFO - Successfully installed blobuploader requests docopt 11:04:14 INFO - Cleaning up... 11:04:14 INFO - Return code: 0 11:04:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:14 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:14 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 11:04:14 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 11:04:14 INFO - Using env: {'DISPLAY': ':0', 11:04:14 INFO - 'HOME': '/home/cltbld', 11:04:14 INFO - 'LANG': 'en_US.UTF-8', 11:04:14 INFO - 'LANGUAGE': 'en_US:en', 11:04:14 INFO - 'LOGNAME': 'cltbld', 11:04:14 INFO - 'MAIL': '/var/mail/cltbld', 11:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:14 INFO - 'MOZ_NO_REMOTE': '1', 11:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:14 INFO - 'NO_EM_RESTART': '1', 11:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:14 INFO - 'PWD': '/builds/slave/test', 11:04:14 INFO - 'SHELL': '/bin/bash', 11:04:14 INFO - 'SHLVL': '1', 11:04:14 INFO - 'TERM': 'linux', 11:04:14 INFO - 'TMOUT': '86400', 11:04:14 INFO - 'USER': 'cltbld', 11:04:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:14 INFO - '_': '/tools/buildbot/bin/python'} 11:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:04:14 INFO - Running setup.py (path:/tmp/pip-Lyb2Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:04:14 INFO - Running setup.py (path:/tmp/pip-rqWts6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:04:14 INFO - Running setup.py (path:/tmp/pip-SO1bLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:04:14 INFO - Running setup.py (path:/tmp/pip-OZOLvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:04:14 INFO - Running setup.py (path:/tmp/pip-SZwt9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:04:14 INFO - Running setup.py (path:/tmp/pip-35Rvpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:04:14 INFO - Running setup.py (path:/tmp/pip-ROX9wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:04:14 INFO - Running setup.py (path:/tmp/pip-tGPyjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:04:14 INFO - Running setup.py (path:/tmp/pip-kbgwUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:04:14 INFO - Running setup.py (path:/tmp/pip-G74drt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:04:15 INFO - Running setup.py (path:/tmp/pip-ePyAfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:04:15 INFO - Running setup.py (path:/tmp/pip-W2u3FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:04:15 INFO - Running setup.py (path:/tmp/pip-sMtUzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:04:15 INFO - Running setup.py (path:/tmp/pip-0I__pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:15 INFO - Running setup.py (path:/tmp/pip-VwPF00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:04:15 INFO - Running setup.py (path:/tmp/pip-RKk3ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:04:15 INFO - Running setup.py (path:/tmp/pip-OJK0P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:04:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:04:15 INFO - Running setup.py install for manifestparser 11:04:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:04:15 INFO - Running setup.py install for mozcrash 11:04:15 INFO - Running setup.py install for mozdebug 11:04:15 INFO - Running setup.py install for mozdevice 11:04:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:04:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Running setup.py install for mozfile 11:04:16 INFO - Running setup.py install for mozhttpd 11:04:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Running setup.py install for mozinfo 11:04:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Running setup.py install for mozInstall 11:04:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Running setup.py install for mozleak 11:04:16 INFO - Running setup.py install for mozlog 11:04:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Running setup.py install for moznetwork 11:04:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Running setup.py install for mozprocess 11:04:16 INFO - Running setup.py install for mozprofile 11:04:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:04:16 INFO - Running setup.py install for mozrunner 11:04:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:04:17 INFO - Running setup.py install for mozscreenshot 11:04:17 INFO - Running setup.py install for moztest 11:04:17 INFO - Running setup.py install for mozversion 11:04:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:04:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:04:17 INFO - Cleaning up... 11:04:17 INFO - Return code: 0 11:04:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:17 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:17 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 11:04:17 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 11:04:17 INFO - Using env: {'DISPLAY': ':0', 11:04:17 INFO - 'HOME': '/home/cltbld', 11:04:17 INFO - 'LANG': 'en_US.UTF-8', 11:04:17 INFO - 'LANGUAGE': 'en_US:en', 11:04:17 INFO - 'LOGNAME': 'cltbld', 11:04:17 INFO - 'MAIL': '/var/mail/cltbld', 11:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:17 INFO - 'MOZ_NO_REMOTE': '1', 11:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:17 INFO - 'NO_EM_RESTART': '1', 11:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:17 INFO - 'PWD': '/builds/slave/test', 11:04:17 INFO - 'SHELL': '/bin/bash', 11:04:17 INFO - 'SHLVL': '1', 11:04:17 INFO - 'TERM': 'linux', 11:04:17 INFO - 'TMOUT': '86400', 11:04:17 INFO - 'USER': 'cltbld', 11:04:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:17 INFO - '_': '/tools/buildbot/bin/python'} 11:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:04:17 INFO - Running setup.py (path:/tmp/pip-3nrR52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:04:17 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)) 11:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:04:17 INFO - Running setup.py (path:/tmp/pip-w4fkCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:04:17 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)) 11:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:04:17 INFO - Running setup.py (path:/tmp/pip-B1opxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:04:17 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)) 11:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:04:17 INFO - Running setup.py (path:/tmp/pip-cY77Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:04:17 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)) 11:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:04:17 INFO - Running setup.py (path:/tmp/pip-APgdCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:04:17 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)) 11:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:04:17 INFO - Running setup.py (path:/tmp/pip-OpNi4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:04:18 INFO - Running setup.py (path:/tmp/pip-WHKoza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:04:18 INFO - Running setup.py (path:/tmp/pip-mQnM4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:04:18 INFO - Running setup.py (path:/tmp/pip-FpFwIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:04:18 INFO - Running setup.py (path:/tmp/pip-v4WHQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:04:18 INFO - Running setup.py (path:/tmp/pip-cSCab4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:04:18 INFO - Running setup.py (path:/tmp/pip-ouQX8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:04:18 INFO - Running setup.py (path:/tmp/pip-OC2Wea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:04:18 INFO - Running setup.py (path:/tmp/pip-yRvqCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:18 INFO - Running setup.py (path:/tmp/pip-6JdrNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:04:18 INFO - Running setup.py (path:/tmp/pip-QFqaVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:04:18 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)) 11:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:04:18 INFO - Running setup.py (path:/tmp/pip-2i3eP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:04:18 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)) 11:04:18 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)) 11:04:18 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)) 11:04:18 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)) 11:04:18 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)) 11:04:18 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)) 11:04:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:04:18 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 11:04:18 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 11:04:18 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 11:04:18 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 11:04:18 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 11:04:18 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 11:04:20 INFO - Downloading blessings-1.6.tar.gz 11:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:04:20 INFO - Installing collected packages: blessings 11:04:20 INFO - Running setup.py install for blessings 11:04:20 INFO - Successfully installed blessings 11:04:20 INFO - Cleaning up... 11:04:20 INFO - Return code: 0 11:04:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:04:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:21 INFO - Reading from file tmpfile_stdout 11:04:21 INFO - Current package versions: 11:04:21 INFO - argparse == 1.2.1 11:04:21 INFO - blessings == 1.6 11:04:21 INFO - blobuploader == 1.2.4 11:04:21 INFO - docopt == 0.6.1 11:04:21 INFO - functools32 == 3.2.3-2 11:04:21 INFO - jsonschema == 2.5.1 11:04:21 INFO - manifestparser == 1.1 11:04:21 INFO - mozInstall == 1.12 11:04:21 INFO - mozcrash == 0.17 11:04:21 INFO - mozdebug == 0.1 11:04:21 INFO - mozdevice == 0.48 11:04:21 INFO - mozfile == 1.2 11:04:21 INFO - mozhttpd == 0.7 11:04:21 INFO - mozinfo == 0.9 11:04:21 INFO - mozleak == 0.1 11:04:21 INFO - mozlog == 3.2 11:04:21 INFO - moznetwork == 0.27 11:04:21 INFO - mozprocess == 0.22 11:04:21 INFO - mozprofile == 0.28 11:04:21 INFO - mozrunner == 6.11 11:04:21 INFO - mozscreenshot == 0.1 11:04:21 INFO - mozsystemmonitor == 0.3 11:04:21 INFO - moztest == 0.7 11:04:21 INFO - mozversion == 1.4 11:04:21 INFO - psutil == 3.1.1 11:04:21 INFO - requests == 1.2.3 11:04:21 INFO - wsgiref == 0.1.2 11:04:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:21 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:21 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 11:04:21 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 11:04:21 INFO - Using env: {'DISPLAY': ':0', 11:04:21 INFO - 'HOME': '/home/cltbld', 11:04:21 INFO - 'LANG': 'en_US.UTF-8', 11:04:21 INFO - 'LANGUAGE': 'en_US:en', 11:04:21 INFO - 'LOGNAME': 'cltbld', 11:04:21 INFO - 'MAIL': '/var/mail/cltbld', 11:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:21 INFO - 'MOZ_NO_REMOTE': '1', 11:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:21 INFO - 'NO_EM_RESTART': '1', 11:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:21 INFO - 'PWD': '/builds/slave/test', 11:04:21 INFO - 'SHELL': '/bin/bash', 11:04:21 INFO - 'SHLVL': '1', 11:04:21 INFO - 'TERM': 'linux', 11:04:21 INFO - 'TMOUT': '86400', 11:04:21 INFO - 'USER': 'cltbld', 11:04:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:21 INFO - '_': '/tools/buildbot/bin/python'} 11:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 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)) 11:04:21 INFO - Cleaning up... 11:04:21 INFO - Return code: 0 11:04:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:21 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:21 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 11:04:21 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 11:04:21 INFO - Using env: {'DISPLAY': ':0', 11:04:21 INFO - 'HOME': '/home/cltbld', 11:04:21 INFO - 'LANG': 'en_US.UTF-8', 11:04:21 INFO - 'LANGUAGE': 'en_US:en', 11:04:21 INFO - 'LOGNAME': 'cltbld', 11:04:21 INFO - 'MAIL': '/var/mail/cltbld', 11:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:21 INFO - 'MOZ_NO_REMOTE': '1', 11:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:21 INFO - 'NO_EM_RESTART': '1', 11:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:21 INFO - 'PWD': '/builds/slave/test', 11:04:21 INFO - 'SHELL': '/bin/bash', 11:04:21 INFO - 'SHLVL': '1', 11:04:21 INFO - 'TERM': 'linux', 11:04:21 INFO - 'TMOUT': '86400', 11:04:21 INFO - 'USER': 'cltbld', 11:04:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:21 INFO - '_': '/tools/buildbot/bin/python'} 11:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:04:21 INFO - Cleaning up... 11:04:21 INFO - Return code: 0 11:04:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:21 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 0x7ff17292bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14743b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, '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': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', '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 11:04:21 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 11:04:21 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 11:04:21 INFO - Using env: {'DISPLAY': ':0', 11:04:21 INFO - 'HOME': '/home/cltbld', 11:04:21 INFO - 'LANG': 'en_US.UTF-8', 11:04:21 INFO - 'LANGUAGE': 'en_US:en', 11:04:21 INFO - 'LOGNAME': 'cltbld', 11:04:21 INFO - 'MAIL': '/var/mail/cltbld', 11:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:21 INFO - 'MOZ_NO_REMOTE': '1', 11:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:21 INFO - 'NO_EM_RESTART': '1', 11:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:21 INFO - 'PWD': '/builds/slave/test', 11:04:21 INFO - 'SHELL': '/bin/bash', 11:04:21 INFO - 'SHLVL': '1', 11:04:21 INFO - 'TERM': 'linux', 11:04:21 INFO - 'TMOUT': '86400', 11:04:21 INFO - 'USER': 'cltbld', 11:04:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:21 INFO - '_': '/tools/buildbot/bin/python'} 11:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:21 INFO - Downloading/unpacking flake8 11:04: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 11:04: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 11:04: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 11:04: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 11:04: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 11:04: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 11:04:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:04:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:04:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:04: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 11:04: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 11:04: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 11:04: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 11:04: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 11:04: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 11:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:04:24 INFO - no previously-included directories found matching 'docs/_build' 11:04:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:04:24 INFO - Running setup.py install for pep8 11:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:04:24 INFO - no previously-included directories found matching 'docs/_build' 11:04:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:04:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:04:24 INFO - Cleaning up... 11:04:24 INFO - Return code: 0 11:04:24 INFO - Running post-action listener: _resource_record_post_action 11:04:24 INFO - Running post-action listener: _start_resource_monitoring 11:04:24 INFO - Starting resource monitoring. 11:04:24 INFO - ##### 11:04:24 INFO - ##### Finished create-virtualenv step (success) 11:04:24 INFO - ##### 11:04:24 INFO - ##### 11:04:24 INFO - ##### Running install step. 11:04:24 INFO - ##### 11:04:24 INFO - Running pre-action listener: _resource_record_pre_action 11:04:24 INFO - Running main action method: install 11:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:24 INFO - Reading from file tmpfile_stdout 11:04:24 INFO - Detecting whether we're running mozinstall >=1.0... 11:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:04:24 INFO - Reading from file tmpfile_stdout 11:04:24 INFO - Output received: 11:04:24 INFO - Usage: mozinstall [options] installer 11:04:24 INFO - Options: 11:04:24 INFO - -h, --help show this help message and exit 11:04:24 INFO - -d DEST, --destination=DEST 11:04:24 INFO - Directory to install application into. [default: 11:04:24 INFO - "/builds/slave/test"] 11:04:24 INFO - --app=APP Application being installed. [default: firefox] 11:04:24 INFO - mkdir: /builds/slave/test/build/application 11:04:24 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'] 11:04:24 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 11:04:41 INFO - Reading from file tmpfile_stdout 11:04:41 INFO - Output received: 11:04:41 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:41 INFO - Running post-action listener: _resource_record_post_action 11:04:41 INFO - ##### 11:04:41 INFO - ##### Finished install step (success) 11:04:41 INFO - ##### 11:04:41 INFO - ##### 11:04:41 INFO - ##### Running run-tests step. 11:04:41 INFO - ##### 11:04:41 INFO - Running pre-action listener: _resource_record_pre_action 11:04:41 INFO - Running main action method: run_tests 11:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:41 INFO - Python 2.7.3 11:04:41 INFO - Return code: 0 11:04:41 INFO - grabbing minidump binary from tooltool 11:04:41 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')]} 11:04:41 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 0x1506990>, '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 0x1472470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1472900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:41 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 11:04:41 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 11:04:41 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 11:04:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:41 INFO - Return code: 0 11:04:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:04:42 INFO - Return code: 0 11:04:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 11:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 11:04:42 INFO - Using env: {'DISPLAY': ':0', 11:04:42 INFO - 'HOME': '/home/cltbld', 11:04:42 INFO - 'LANG': 'en_US.UTF-8', 11:04:42 INFO - 'LANGUAGE': 'en_US:en', 11:04:42 INFO - 'LOGNAME': 'cltbld', 11:04:42 INFO - 'MAIL': '/var/mail/cltbld', 11:04:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:42 INFO - 'MOZ_NO_REMOTE': '1', 11:04:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:42 INFO - 'NO_EM_RESTART': '1', 11:04:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:42 INFO - 'PWD': '/builds/slave/test', 11:04:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:42 INFO - 'SHELL': '/bin/bash', 11:04:42 INFO - 'SHLVL': '1', 11:04:42 INFO - 'TERM': 'linux', 11:04:42 INFO - 'TMOUT': '86400', 11:04:42 INFO - 'USER': 'cltbld', 11:04:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277', 11:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:42 INFO - '_': '/tools/buildbot/bin/python'} 11:04:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 11:04:43 INFO - mozversion application_buildid: 20160610083009 11:04:43 INFO - mozversion application_changeset: ebef91ed1cf0b4d9525ea33fda5d51d96a5c6d4d 11:04:43 INFO - mozversion application_display_name: Nightly 11:04:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:43 INFO - mozversion application_name: Firefox 11:04:43 INFO - mozversion application_remotingname: firefox 11:04:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:04:43 INFO - mozversion application_vendor: Mozilla 11:04:43 INFO - mozversion application_version: 50.0a1 11:04:43 INFO - mozversion platform_buildid: 20160610083009 11:04:43 INFO - mozversion platform_changeset: ebef91ed1cf0b4d9525ea33fda5d51d96a5c6d4d 11:04:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:04:43 INFO - mozversion platform_version: 50.0a1 11:04:43 INFO - using testdate: 1465581883 11:04:43 INFO - actual date: 1465581883 11:04:43 INFO - starting webserver on 'localhost:59217' 11:04:43 INFO - SUITE-START | Running 2 tests 11:04:43 INFO - TEST-START | dromaeo_css 11:04:43 INFO - operating with platform_type : linux_ 11:04:43 INFO - Initialising browser for dromaeo_css test... 11:04:43 INFO - TEST-INFO | started process 23697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptGr5ou/profile http://localhost:59217/getInfo.html) 11:04:47 INFO - PROCESS | 23697 | __metrics Screen width/height:1600/1200 11:04:47 INFO - PROCESS | 23697 | colorDepth:24 11:04:47 INFO - PROCESS | 23697 | Browser inner width/height: 1024/697 11:04:47 INFO - PROCESS | 23697 | __metrics 11:04:48 INFO - PROCESS | 23697 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:04:48 INFO - PROCESS | 23697 | console.error: PushService: 11:04:48 INFO - PROCESS | 23697 | stateChangeProcessEnqueue: Error transitioning state 11:04:48 INFO - PROCESS | 23697 | UnknownError 11:04:48 INFO - TEST-INFO | 23697: exit 0 11:04:48 INFO - Browser initialized. 11:04:48 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:48 INFO - TEST-INFO | started process 23780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptGr5ou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:00 INFO - PROCESS | 23780 | RSS: Main: 174080000 11:05:00 INFO - PROCESS | 23780 | 11:05:51 INFO - PROCESS | 23780 | 1465581951624 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] 11:08:00 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:59217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59217/tests/dromaeo/cssquery-ext.html) 11:08:01 INFO - PROCESS | 23780 | RSS: Main: 272027648 11:08:01 INFO - PROCESS | 23780 | 11:11:04 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:59217/tests/dromaeo/cssquery-ext.html (next: http://localhost:59217/tests/dromaeo/cssquery-jquery.html) 11:11:04 INFO - PROCESS | 23780 | RSS: Main: 265502720 11:11:04 INFO - PROCESS | 23780 | 11:14:06 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:59217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59217/tests/dromaeo/cssquery-mootools.html) 11:14:07 INFO - PROCESS | 23780 | RSS: Main: 260050944 11:14:07 INFO - PROCESS | 23780 | 11:17:09 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:59217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59217/tests/dromaeo/cssquery-prototype.html) 11:17:10 INFO - PROCESS | 23780 | RSS: Main: 258801664 11:17:10 INFO - PROCESS | 23780 | 11:20:12 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:59217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59217/tests/dromaeo/cssquery-yui.html) 11:20:13 INFO - PROCESS | 23780 | RSS: Main: 224563200 11:20:13 INFO - PROCESS | 23780 | 11:23:15 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:59217/tests/dromaeo/cssquery-yui.html (next: http://localhost:59217/tests/dromaeo/cssquery-dojo.html) 11:23:16 INFO - PROCESS | 23780 | RSS: Main: 292134912 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | __start_tp_report 11:23:16 INFO - PROCESS | 23780 | _x_x_mozilla_page_load 11:23:16 INFO - PROCESS | 23780 | _x_x_mozilla_page_load_details 11:23:16 INFO - PROCESS | 23780 | |i|pagename|runs| 11:23:16 INFO - PROCESS | 23780 | |0;dojo.html;3134.9686503134967;3143.2141964508874;3152.5271209318594;3168.112928380054;3210.9197270068244;5336.519713225809;5398.730063496829;5407.945920540794;5508.3114610673665;5517.255170551979;5445.237666726662;5449.972750136244;5481.835544933649;5492.917606235909;5515.4760297771645;4901.044296362211;4972.801087956477;4998.57512111471;5015.398152221738;5166.044281807859;5060.620453465986;5073.858381864088;5104.285400043997;5124.692518448886;5130.538251557359;4826.831060912887;4833.178359678863;4845.200541910581;4891.290762839386;4935.235038569028;4775.164346239429;4805.783739731721;4908.509149085098;4909.8772530686665;4967.50324967504;4866.58634016109;4867;4867.9269810952865;4927.162382395001;4956.330895329156;5261;5317.229001794718;5374.435684253175;5380.435054319319;5478.753456094445;5813.651180929158;5822.82531524055;5842.532597392198;5843.561732870009;5848.298204215479;5781.942180578182;5876.529877609781;5877.324107727623;5890.823275301705;5897.144913987448;5410.945890541084;5451.536619387357;5459.426760190163;5541;5542.695151766611;6023.849403764941;6036.456718895321;6037.516998640098;6039.456448919618;6040.879182416415;5514.448555144534;5676.971615141898;5805.88388232233;5844.15259787337;5844.532437404998;5775.971120144372;5864.9413505864395;5865.149553314745;5865.413458654186;5921.437463440966;5776.1624564437925;5825.592208545361;5829.5044921181325;5829.795957141479;5835.503982161479;5679.5172410345585;5695.1741997410145;5728.255326807488;5847.8245652630485;5860.472557469763;4442.622377097919;4451.354553589711;4455.242608756519;4487.5288094749585;4496.033352829158;3943.645071943539;3961.069148750041;3965.5836137205756;3995.10110225197;3998.34027385484;5378.811741589026;5404.081306177959;5413.539849112791;5420.945790542044;5437.945620543823;5766.509846662997;5784.421557844182;5792.797252096157;5795.565332600072;5834.183214349994;5431.131019036935;5456.127019676833;5479.287692599936;5479.917801232985;5481.725913704299;4986.650934434628;4987.650864439454;5024.572911302507;5031.345925029723;5103.948960510347;6030.125631783367;6044.576879618472;6045.63726176422;6048.9697551512845;6055.515558755289;5801.94198058014;5813.273340832396;5815.680137592304;5822.446867547576;5824.330202026821;5868.4424979626865;5904.557158213237;5918.881622367615;5940.673262970578;5999.100134979788;5609.663420194802;5660.405657406078;5667.8866422672145;5677.716114194356;5682;5681.573881958952;5751.769929202952;5762.538996880324;5763.827085187451;5767.134929760569;5691.459311365414;5731.541476681772;5743.195952566561;5776.566757493289;5791.7683292667825;5708.257926469532;5755.740991655469;5757.769689212385;5761.5390768739235;5767.509761670305;5350.4382039886805;5550.611457197957;5665.688387138582;5665.886682266414;5669.064604340238;5557.499825015606;5641.182028605911;5662.490375866192;5671.6029877909805;5677.51741102011;5442.673439593637;5487.890242195213;5494.670319780826;5497.285352904097;5501.064818980863 11:23:16 INFO - PROCESS | 23780 | |1;ext.html;605.6245128020628;606.5541826757333;613.5705006495455;630.8643641617051;633.6261605652664;31860.840695796516;42095.158096838044;42751.78624106875;42818.35772463415;46243;44480.11039779202;44704.10591788162;45112.548874511325;45201.32198017032;45219.77390113045;8734.868976965336;8845.601947912328;8852.955735221314;8864.911350886474;8866.113388661115;8648.1784230498;8732.781680458007;8735.388522803407;8740.606672699743;8746.562671866413;8798.86801697975;8887.066857979917;8898.37711360205;8903.777405564848;8907.242884354837;8760.956195218983;8804.64781408746;8836.55817209137;8847.867281990775;8848.070952549986;8719.825603487894;8773.605187766501;8778.692745753931;8781.692640757607;8786.253168480687;42487;42999.35500967457;43046.354304685454;43084.138317233796;43096.56903430988;3418.5214070030215;3521.0740772142494;3610.837512311926;3621.203335266237;3974.880753577397;32436.351272974644;32901.6709832901;33217.6678233217;33226.667733322596;33631.49552756711;4376.868693939187;4405.140997505488;4431.578999994996;4573.474050484204;4633.235516139833;329235.24588524527;329511;329565;330052;331190;51881.2217816733;54086.45913540893;55278.170827436814;55486.44513554813;57544.42455575475;60666.696666516385;60952.695236523534;60986.39013609896;61162;61191.69404152951;17206.31174752996;17351.826481735272;17361;17372;17399.47801565955;11003.834942475869;11976.940115299367;12066.09504287182;12088.697782555506;12393.318367489876;16579.336826527044;16637.084960327054;16662;16683.0824304662;16704.498865034067;6213.627182369072;6259.71831267594;6312.305646378894;6316.147320111726;6357.364263573606;962.3985009369144;966.6665000574791;1019.8674172357546;1048.8531605575226;1130.6381957773433;32077.89161647066;32423.837880810446;32487.187820304207;32675.509867352008;32757.508637370458;1122.550979608147;1138.6299452677913;1160.3096157786104;1221.9144659873723;1226.9447874845653;16922.74615880763;17271.56821079458;17318.307267709402;17324.393646222576;17550.122493875257;468995;474576;478238;479179;479579;57516;58106;58239.12641310384;58285.41714582885;58459.415405846245;1272.5037235478171;1334.7197088611306;1380.565121986571;1387.7293927684207;1394.7280280345437;30879.845600771852;33277.66722332746;33297.667023330425;33419.66580334263;33859.83070084634;49621;50115.49884501108;50185;50267.24599130943;50370;384847;386454;386569;386876;386976.10703090555;32892;35425.645743542234;41588.37617435801;41893.58106418897;45325;47837;47854;48234.27648585344;48645.02709945852;49508.50491495039;39387.40918886162;40888.38667419932;41207.79396103;41392;41906.58093419149;40136.59863401329;40259.1948161041;40761.59238407697;41108.79445602753;41215.175696486505;39301;40161.598384015786;40780.79609601933;40900.79549602233;41025;34810.47784283187;36122;36353.454698180074;36623;36730.63269367379;27454.725452745217;27504;27841;27876.16371508858;27907.720922791323 11:23:16 INFO - PROCESS | 23780 | |2;jquery.html;378.39834662886017;381.3421847313385;382.93872980323135;396.76590811421255;399.03632726964366;15280.465183718572;16408.507744767645;17297.827021729794;20292;20353.796462035374;16877.66244675106;18622.90688546559;19409.32067377642;19441.70837437436;19449;5166.5608423283975;5266.4733526647415;5335.679859208441;5374.543163831079;5375.569954403658;5404.243405923174;5576.693281869496;5600.467955544217;5607;5609.971950140243;5368.489993450616;5562.805301814437;5565.888682226353;5566.304211973504;5566.610337276392;5568.248286481355;5599.664020158803;5602.047651899187;5606.486248712845;5613.101903695409;4823.9517604824205;4992.775325110379;5020.799168033274;5028.949710502921;5030.245463180516;22554.323370298916;22617.208397706167;22986.390952633323;23383.88308058449;23535.76464235353;2411.565918134735;2461.3600463879343;2470.258922323296;2654.4558365535017;2751.119641714652;8563.871541926876;14386.92806535971;14432.20622865742;14525.201113938729;14881.404743810235;1974.042589344167;1977.8516611254213;1996.2114964589052;2003.8396928245706;2102.1696429910253;79730.60134699289;80626.59686701588;80913.59543202305;81398;82136.9999999994;10576.99518545737;10599.152067834555;10724.30292031031;10774.138068954464;10994.835077473845;14610.853891460949;14742.336594853043;14747.188904610135;14761.483348082766;14820.481283155254;7801.2198780121535;7929.286364227132;8263.793405164919;8359.247667709935;8396.496210227406;7826.8434631307055;7967.960160199278;8218.589070546448;8274.751757447286;8381.371397145238;4422.7346359218545;4463.196624607537;4474.172278128557;4529.614982726439;4576.88557786058;1805.1786437171056;1841.269206945467;1848.2111671074244;1856.8421684156729;1914.7510823592843;956.4309236004566;975.6487664440796;988.3773222869546;1024.8411496218098;1063.3566692151292;18454.907725461286;19498.415047548595;19657.705134422995;19763.40709778709;19909.900450497655;951.4196340232453;984.17329443268;989.7030890732896;1003.5985605757755;1011.630754774502;10709.892901070889;10987.60598837409;11008;11103.234824281086;11148.108151347873;366090;374514;496289;501985;522252;72869;85560;90836.5458172705;93851.53074234586;97227;853.4623187391903;871.9869201961849;891.7859713668803;897.5063714956748;900.1043961258721;15938.68122637564;16214;16284.755728663842;16489.96232750075;16605;41211.38182927199;41773;42172.789136054125;43106.56893431151;43496.130077398906;55496.72251638716;58151;58227;58444.415555843894;58481.973812702556;7663.655135518804;7827.804304892423;7932.563708996061;8014.639341229776;8020.558869262247;10389.740256493647;11884.821727674265;11887.524499019943;12352.567660131852;12742.42659080325;10833.349999000086;10945.233833631888;10998.285111467729;11063.22557421005;11171.66485005451;10685.946570267099;10807.08139808125;10838.721264367918;11043.116550675766;11143.108551316038;10841.623665987716;10973.23187376876;11185.496652650487;11238.269512481662;11381.089512838787;7316.268373162641;7915.406344524299;8094.15011423792;8132.75601731949;8187.1403502631365;10275.794484110425;12208.511659533518;12265.448054837376;12273.938630306791;12398.25610463339 11:23:16 INFO - PROCESS | 23780 | |3;mootools.html;1351.2973253907974;1466.5600319904029;1512.1229686781667;1646.448439772676;1816.6457540779545;7984.6007699615;8287.04698959619;8297.336213102952;8310.418270721051;8527.91472085279;8066.878996815052;8292.958535207315;8451.366147538929;8453.408261421702;8471.661133554651;1969.5765410436754;2224.7775222477785;2252.3693365857544;2294.1167650454613;2306.9423264418356;2342.3441436397834;2354.693889794324;2355.199232261031;2355.2463211772238;2359.9646005309933;2298.586254474194;2313.53729254149;2351.5179388225374;2352.5059737455153;2354.30547988343;1921.4139687395339;2141;2198.6152423326016;2203.8457307988447;2227.175944900389;2226.855254408458;2243.5064285857084;2244.5735310291157;2247.314569056437;2249.80876625487;8297.502149870967;8349.749507514784;8354.540500272482;8355.707550235773;8357.038940521858;4941.530554597308;5069.619778516626;5075.162598171298;5076.162433198518;5083.847484575469;3106.3476669899346;3151.5902932618615;3266.5426840242385;3270.1170683915448;3279.0490757680245;1195.7967145585185;1210.2012671636678;2151.483643925447;2172.847900646955;2192.7039849620414;11953.40232988347;12135.150539462242;12152.635420937386;12167.817482737766;12176.81734773979;4274.252005898955;4544.500104988449;4553.33976573395;4631.536846315342;4632.073585282957;10225;10240.692779216635;10244.48777561119;10249.897501024894;10257.948710256402;5193.506616871391;5204.739763011834;5204.843854684365;5205;5205.843824685266;4260.68044896634;4635.930461043087;4722.268048452426;4743.83396581118;4807.086653535887;3995.5604883462797;3996.620321069494;4074.6536544394057;4125.834966601303;4136.958630413717;1272.8090786382118;1296.2287438973794;1305.6866352075433;1317;1334.8665133486575;872.8123453457537;949.6059135458845;996.6312464388078;997.0926456924309;1029.0327092532996;5850.531957443394;5978.342382338026;6019.367966363557;6036.366181550961;6154.046122850876;445.19197656253795;448.90797386535684;454.4955099839176;455.3897776978864;456.09010024999674;4084.36692312692;4162.9945041343135;4274.722143060691;4285.550017248206;4303.440552728125;10351.120154786777;10665.253432259822;10710.678679639623;10710.839337409945;10727.088197503299;10456.215783816093;10468.110210632181;10548.578056877792;10615.575376984989;10733.463326833627;8069.233422824822;8093.514389136789;8192.713255036046;8199.672013119409;8208.958955205306;5683.943160568341;5821.243238378984;5858.150568167506;5907.793227237198;5928.822135335947;9848;9920.603175873173;9983.301168918106;9998.900011000087;10015.499225038864;9775.75560610962;9966.551505182138;10062.39625622465;10132.848007279748;10183.287169898036;7110.822229444305;7304.488685791944;7307.963460182665;7511.737089201852;7604.619769011417;8042.718504852302;8202.384821138558;8384.706535271236;8401.915980840358;8624.439411438236;7535.095788505414;7765.961170194113;7786.104597971306;7850.293473587404;7884.2115788423;7382.187959324578;7482.401407887465;7493.775186744407;7593.240675932362;7723.9227607723205;6988;7011.228764835966;7052.541584796972;7059;7061.470389720689;5192.714400707846;5236.188390799432;5360.463953604608;5363.892722145457;5406.162044883049;5338.946610533845;5397.217403476396;5399.082156033563;5406.540444062141;5463.754131064032 11:23:16 INFO - PROCESS | 23780 | |4;prototype.html;297.5165356296019;303.28122350030424;304.2682348950774;309.5078824668777;312.7669885934979;5349.625526213166;5371.060064488718;5372.758225879835;5381.569474442045;5411.431799661038;5089.592832573395;5117.616178786588;5201.349831271091;5256.973715131428;5308.23030660554;4070.837166513336;4096.713230073896;4098.4057311689785;4099.385092236159;4099.918001639965;4055.168690418457;4072.5927407259333;4072.816723247446;4084.305668036426;4089.6114869087387;3826.751261168029;3910.393888947218;4017.116234428421;4032.919341613166;4110.355857656946;4080.204360149772;4083;4086.6730661547303;4092.4475195848477;4104.630583247507;3587.515685382466;3608.711303095746;3609.205974685591;3623.601403845575;3652.945205821915;5091.715843281063;5100.5919526438165;5104.157813960692;5111.948880511184;5187.974060129713;4609.953900460986;4630.467496237942;4662.9067418651775;4664.437413466459;4684.672072954894;5470.2888624478965;5491.148871924858;5492.697901615409;5535.308086489189;5543.1408131739645;3840.1935593525395;3934.429507721364;3942.5466071401584;3948.1511475033008;3956.3274243378405;5642;5647.576431767634;5654.830355089395;5660.235868157787;5677.687727175004;3989.606236258222;4012.719109662354;4033.233685599727;4061.3501839705505;4068.06434520062;4008.574812238612;4025.959740402617;4100.876973690794;4103.651189648854;4118.670506359544;4666.859994200179;4673.826670598188;4681.9297710534365;4705;4709.364235828188;5524.392316845144;5530.364008139035;5556.416576259516;5610.691411972299;5655.802046928337;1304.3608631770364;1374.8075269462083;1412.837523684769;1437.2885421716107;1437.9712405751827;854.9529775862263;858.3176374782063;861.3195575495289;880.106691707917;881.4975463985595;4718.245080787057;4719;4751.786169622375;4774.904501909942;4825.565699087099;5098.847034588968;5122.897542049138;5123;5138.53551737753;5150.175971844487;4691.483936766953;4815.7351345676325;4835.274708793709;4871.905080815212;4882;2679.713737406056;2696.892124315045;2699.4331190450225;2713.8778754956074;2714.2264454630335;5181.202150838581;5219.478052194826;5233.476652334736;5292.814751483679;5307.336582927134;4881.267809828554;5088.567471764942;5153.793848246103;5169.560587350042;5173.922391164136;5136.537711605899;5149.382074151126;5184.844454666441;5282.366116066097;5288.603354748409;4948.73807179167;4992.375953005874;5024.648274620888;5050.49495050492;5076;4754.31062495943;4919.0899683558655;4980.406269993568;4997.475265097112;5000.64995450315;5172.482751724798;5179.663321884065;5199.688018718889;5208.322918020633;5225.843224703265;3578.7494875359516;3603.4775657039654;3624.3838547447526;3645.671889529955;3745.1198968242984;5461.15352120422;5658.434156584309;5715.828525144252;5735.655860648374;5748.511376532874;5545.223668686468;5554.305711786027;5556.555475562026;5593.720313984366;5616.915746263891;5356.892862142813;5552.444755524415;5554.777808887599;5613.943860561342;5617.831465056055;5462.644928079662;5464.972675136599;5486.259354987025;5486.369067557282;5506.889862202814;5561.443855614406;5579.60942734021;5605.131204663284;5614.494695477427;5620.437956204347;5245.947540524546;5392.840539283916;5449.828286918331;5464;5469.644473109235 11:23:16 INFO - PROCESS | 23780 | |5;yui.html;778.8286576953072;780.3172224303734;808.1070417189006;832.3798769916414;835.1481488881345;14713.632159196026;15308.617284567892;15328.463503777342;15329.84670153298;15363.846361536394;13860.930695346535;13997.650058748537;14010.509632162877;14012.859871401282;14027.509037183701;664.3688495928862;772.6754762999526;793.8928244686965;799.360511590728;805.6414895371562;788.8895554622358;794.9244821741954;796.9163237860029;797.3979645367739;797.5693125712108;853.4196746212573;858.4548811504708;858.4720396955859;858.527809704663;858.6779957515931;706.2019917493226;822.9588520573948;849.6941101203562;851.8679604661287;853.8847255620536;618.6319140111626;622.0855342646303;622.8536293970914;623.3174673732256;623.9984824356887;12208.145429819917;12305.507779688802;12416.627501174979;12573.057020723483;12659.810102848465;13607.31963401826;13886;14053;14223.644408889757;14254.501092461818;12723.872761272361;12925.353732313346;12955.740885182338;13002.739945201043;13086.47654093835;4368.235558777201;4376.6498680105515;4381.189479946188;4408.493023302329;4451.354553589744;70553.64723176352;71038.64480677615;71195.64402178008;71247.99999999948;71489.28510714878;11125;11369.658910232707;11395.25930814511;11524.078073754079;11587.246828956091;18574.349897753786;18576.907115464335;18579.071046447894;18648.906755466134;18667.346642867433;7789.571573563395;8027.959860200662;8034.638441270157;8081.393895457864;8200.097989221182;4496.168208881302;4548.977255113703;4552.453705555355;4575.656825738017;4780.928286075712;3299.4555898276994;3394.7453940954033;3403.676650718178;3406.233597440556;3410.4543273076683;547.0535972767135;603.2820943077724;604.3684349854412;604.7701873288122;606.5390303369471;680.4998326230217;684.2780866186222;731.2906480713699;731.934125928669;782.2685788787502;9779.706608801747;10475.266731328886;10506.947465262778;10508.947455262827;10554.788904222027;621.5773274173515;698.1482591238681;721.3724060067669;728.6174758251855;781.538892053691;4830.903381932341;4914.410270767531;5028.270900719375;5055.393352797688;5166.173412254021;65654.34345656578;66706.96181209243;67876;68035.3196468029;108586.45706771573;95497.52251238699;97382;97462;98556;98818;84157.57921210355;85722;85950;85952;86081.5695921529;9115.453072815651;9138.63445462174;9169.8909250874;9199.172074513326;9381.296402769683;48938.75530622324;49007.26489102595;50247.748761255956;50954.74522627363;51541.48458515367;64955.35044649493;67867.3213267861;72252;73171;74805.6259718698;13454.058215925183;13536;13703;13724.451021959409;13760.449582016607;14804.851951480778;15255.389784408942;15711.292991815168;15807.68384632278;16073.276702548646;9948.45283509414;14085.929570352082;14323.14061156334;14429.855701442852;14733.778993314894;13604.795928060888;13696.794548081985;13848.09987350819;14670;15153;14085.718285634435;14864.256787160815;14918.477853275082;14920.552383428514;15438.69122617519;11363.772724545297;11424.942875285571;11612.535498579962;12071.39643017828;12862.356882156042;11951.462184201559;11984;12428.875711242772;12565;12659.556915507914 11:23:16 INFO - PROCESS | 23780 | __end_tp_report 11:23:16 INFO - PROCESS | 23780 | __start_cc_report 11:23:16 INFO - PROCESS | 23780 | _x_x_mozilla_cycle_collect,895 11:23:16 INFO - PROCESS | 23780 | __end_cc_report 11:23:16 INFO - PROCESS | 23780 | __startTimestamp1465582996073__endTimestamp 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | ------- Summary: start ------- 11:23:16 INFO - PROCESS | 23780 | Number of tests: 6 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | [#0] dojo.html Cycles:165 Average:5397.21 Median:5550.61 stddev:610.04 (11.0%) stddev-sans-first:585.53 11:23:16 INFO - PROCESS | 23780 | Values: 3135.0 3143.2 3152.5 3168.1 3210.9 5336.5 5398.7 5407.9 5508.3 5517.3 5445.2 5450.0 5481.8 5492.9 5515.5 4901.0 4972.8 4998.6 5015.4 5166.0 5060.6 5073.9 5104.3 5124.7 5130.5 4826.8 4833.2 4845.2 4891.3 4935.2 4775.2 4805.8 4908.5 4909.9 4967.5 4866.6 4867.0 4867.9 4927.2 4956.3 5261.0 5317.2 5374.4 5380.4 5478.8 5813.7 5822.8 5842.5 5843.6 5848.3 5781.9 5876.5 5877.3 5890.8 5897.1 5410.9 5451.5 5459.4 5541.0 5542.7 6023.8 6036.5 6037.5 6039.5 6040.9 5514.4 5677.0 5805.9 5844.2 5844.5 5776.0 5864.9 5865.1 5865.4 5921.4 5776.2 5825.6 5829.5 5829.8 5835.5 5679.5 5695.2 5728.3 5847.8 5860.5 4442.6 4451.4 4455.2 4487.5 4496.0 3943.6 3961.1 3965.6 3995.1 3998.3 5378.8 5404.1 5413.5 5420.9 5437.9 5766.5 5784.4 5792.8 5795.6 5834.2 5431.1 5456.1 5479.3 5479.9 5481.7 4986.7 4987.7 5024.6 5031.3 5103.9 6030.1 6044.6 6045.6 6049.0 6055.5 5801.9 5813.3 5815.7 5822.4 5824.3 5868.4 5904.6 5918.9 5940.7 5999.1 5609.7 5660.4 5667.9 5677.7 5682.0 5681.6 5751.8 5762.5 5763.8 5767.1 5691.5 5731.5 5743.2 5776.6 5791.8 5708.3 5755.7 5757.8 5761.5 5767.5 5350.4 5550.6 5665.7 5665.9 5669.1 5557.5 5641.2 5662.5 5671.6 5677.5 5442.7 5487.9 5494.7 5497.3 5501.1 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | [#1] ext.html Cycles:180 Average:56765.18 Median:41740.98 stddev:106057.94 (254.1%) stddev-sans-first:106271.65 11:23:16 INFO - PROCESS | 23780 | Values: 605.6 606.6 613.6 630.9 633.6 31860.8 42095.2 42751.8 42818.4 46243.0 44480.1 44704.1 45112.5 45201.3 45219.8 8734.9 8845.6 8853.0 8864.9 8866.1 8648.2 8732.8 8735.4 8740.6 8746.6 8798.9 8887.1 8898.4 8903.8 8907.2 8761.0 8804.6 8836.6 8847.9 8848.1 8719.8 8773.6 8778.7 8781.7 8786.3 42487.0 42999.4 43046.4 43084.1 43096.6 3418.5 3521.1 3610.8 3621.2 3974.9 32436.4 32901.7 33217.7 33226.7 33631.5 4376.9 4405.1 4431.6 4573.5 4633.2 329235.2 329511.0 329565.0 330052.0 331190.0 51881.2 54086.5 55278.2 55486.4 57544.4 60666.7 60952.7 60986.4 61162.0 61191.7 17206.3 17351.8 17361.0 17372.0 17399.5 11003.8 11976.9 12066.1 12088.7 12393.3 16579.3 16637.1 16662.0 16683.1 16704.5 6213.6 6259.7 6312.3 6316.1 6357.4 962.4 966.7 1019.9 1048.9 1130.6 32077.9 32423.8 32487.2 32675.5 32757.5 1122.6 1138.6 1160.3 1221.9 1226.9 16922.7 17271.6 17318.3 17324.4 17550.1 468995.0 474576.0 478238.0 479179.0 479579.0 57516.0 58106.0 58239.1 58285.4 58459.4 1272.5 1334.7 1380.6 1387.7 1394.7 30879.8 33277.7 33297.7 33419.7 33859.8 49621.0 50115.5 50185.0 50267.2 50370.0 384847.0 386454.0 386569.0 386876.0 386976.1 32892.0 35425.6 41588.4 41893.6 45325.0 47837.0 47854.0 48234.3 48645.0 49508.5 39387.4 40888.4 41207.8 41392.0 41906.6 40136.6 40259.2 40761.6 41108.8 41215.2 39301.0 40161.6 40780.8 40900.8 41025.0 34810.5 36122.0 36353.5 36623.0 36730.6 27454.7 27504.0 27841.0 27876.2 27907.7 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | [#2] jquery.html Cycles:180 Average:27684.95 Median:379.87 stddev:75591.87 (19899.4%) stddev-sans-first:75776.12 11:23:16 INFO - PROCESS | 23780 | Values: 378.4 381.3 382.9 396.8 399.0 15280.5 16408.5 17297.8 20292.0 20353.8 16877.7 18622.9 19409.3 19441.7 19449.0 5166.6 5266.5 5335.7 5374.5 5375.6 5404.2 5576.7 5600.5 5607.0 5610.0 5368.5 5562.8 5565.9 5566.3 5566.6 5568.2 5599.7 5602.0 5606.5 5613.1 4824.0 4992.8 5020.8 5028.9 5030.2 22554.3 22617.2 22986.4 23383.9 23535.8 2411.6 2461.4 2470.3 2654.5 2751.1 8563.9 14386.9 14432.2 14525.2 14881.4 1974.0 1977.9 1996.2 2003.8 2102.2 79730.6 80626.6 80913.6 81398.0 82137.0 10577.0 10599.2 10724.3 10774.1 10994.8 14610.9 14742.3 14747.2 14761.5 14820.5 7801.2 7929.3 8263.8 8359.2 8396.5 7826.8 7968.0 8218.6 8274.8 8381.4 4422.7 4463.2 4474.2 4529.6 4576.9 1805.2 1841.3 1848.2 1856.8 1914.8 956.4 975.6 988.4 1024.8 1063.4 18454.9 19498.4 19657.7 19763.4 19909.9 951.4 984.2 989.7 1003.6 1011.6 10709.9 10987.6 11008.0 11103.2 11148.1 366090.0 374514.0 496289.0 501985.0 522252.0 72869.0 85560.0 90836.5 93851.5 97227.0 853.5 872.0 891.8 897.5 900.1 15938.7 16214.0 16284.8 16490.0 16605.0 41211.4 41773.0 42172.8 43106.6 43496.1 55496.7 58151.0 58227.0 58444.4 58482.0 7663.7 7827.8 7932.6 8014.6 8020.6 10389.7 11884.8 11887.5 12352.6 12742.4 10833.3 10945.2 10998.3 11063.2 11171.7 10685.9 10807.1 10838.7 11043.1 11143.1 10841.6 10973.2 11185.5 11238.3 11381.1 7316.3 7915.4 8094.2 8132.8 8187.1 10275.8 12208.5 12265.4 12273.9 12398.3 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | [#3] mootools.html Cycles:180 Average:5708.82 Median:4634.00 stddev:3208.90 (69.2%) stddev-sans-first:3201.19 11:23:16 INFO - PROCESS | 23780 | Values: 1351.3 1466.6 1512.1 1646.4 1816.6 7984.6 8287.0 8297.3 8310.4 8527.9 8066.9 8293.0 8451.4 8453.4 8471.7 1969.6 2224.8 2252.4 2294.1 2306.9 2342.3 2354.7 2355.2 2355.2 2360.0 2298.6 2313.5 2351.5 2352.5 2354.3 1921.4 2141.0 2198.6 2203.8 2227.2 2226.9 2243.5 2244.6 2247.3 2249.8 8297.5 8349.7 8354.5 8355.7 8357.0 4941.5 5069.6 5075.2 5076.2 5083.8 3106.3 3151.6 3266.5 3270.1 3279.0 1195.8 1210.2 2151.5 2172.8 2192.7 11953.4 12135.2 12152.6 12167.8 12176.8 4274.3 4544.5 4553.3 4631.5 4632.1 10225.0 10240.7 10244.5 10249.9 10257.9 5193.5 5204.7 5204.8 5205.0 5205.8 4260.7 4635.9 4722.3 4743.8 4807.1 3995.6 3996.6 4074.7 4125.8 4137.0 1272.8 1296.2 1305.7 1317.0 1334.9 872.8 949.6 996.6 997.1 1029.0 5850.5 5978.3 6019.4 6036.4 6154.0 445.2 448.9 454.5 455.4 456.1 4084.4 4163.0 4274.7 4285.6 4303.4 10351.1 10665.3 10710.7 10710.8 10727.1 10456.2 10468.1 10548.6 10615.6 10733.5 8069.2 8093.5 8192.7 8199.7 8209.0 5683.9 5821.2 5858.2 5907.8 5928.8 9848.0 9920.6 9983.3 9998.9 10015.5 9775.8 9966.6 10062.4 10132.8 10183.3 7110.8 7304.5 7308.0 7511.7 7604.6 8042.7 8202.4 8384.7 8401.9 8624.4 7535.1 7766.0 7786.1 7850.3 7884.2 7382.2 7482.4 7493.8 7593.2 7723.9 6988.0 7011.2 7052.5 7059.0 7061.5 5192.7 5236.2 5360.5 5363.9 5406.2 5338.9 5397.2 5399.1 5406.5 5463.8 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | [#4] prototype.html Cycles:180 Average:4478.15 Median:5082.28 stddev:1310.51 (25.8%) stddev-sans-first:1276.07 11:23:16 INFO - PROCESS | 23780 | Values: 297.5 303.3 304.3 309.5 312.8 5349.6 5371.1 5372.8 5381.6 5411.4 5089.6 5117.6 5201.3 5257.0 5308.2 4070.8 4096.7 4098.4 4099.4 4099.9 4055.2 4072.6 4072.8 4084.3 4089.6 3826.8 3910.4 4017.1 4032.9 4110.4 4080.2 4083.0 4086.7 4092.4 4104.6 3587.5 3608.7 3609.2 3623.6 3652.9 5091.7 5100.6 5104.2 5111.9 5188.0 4610.0 4630.5 4662.9 4664.4 4684.7 5470.3 5491.1 5492.7 5535.3 5543.1 3840.2 3934.4 3942.5 3948.2 3956.3 5642.0 5647.6 5654.8 5660.2 5677.7 3989.6 4012.7 4033.2 4061.4 4068.1 4008.6 4026.0 4100.9 4103.7 4118.7 4666.9 4673.8 4681.9 4705.0 4709.4 5524.4 5530.4 5556.4 5610.7 5655.8 1304.4 1374.8 1412.8 1437.3 1438.0 855.0 858.3 861.3 880.1 881.5 4718.2 4719.0 4751.8 4774.9 4825.6 5098.8 5122.9 5123.0 5138.5 5150.2 4691.5 4815.7 4835.3 4871.9 4882.0 2679.7 2696.9 2699.4 2713.9 2714.2 5181.2 5219.5 5233.5 5292.8 5307.3 4881.3 5088.6 5153.8 5169.6 5173.9 5136.5 5149.4 5184.8 5282.4 5288.6 4948.7 4992.4 5024.6 5050.5 5076.0 4754.3 4919.1 4980.4 4997.5 5000.6 5172.5 5179.7 5199.7 5208.3 5225.8 3578.7 3603.5 3624.4 3645.7 3745.1 5461.2 5658.4 5715.8 5735.7 5748.5 5545.2 5554.3 5556.6 5593.7 5616.9 5356.9 5552.4 5554.8 5613.9 5617.8 5462.6 5465.0 5486.3 5486.4 5506.9 5561.4 5579.6 5605.1 5614.5 5620.4 5245.9 5392.8 5449.8 5464.0 5469.6 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - PROCESS | 23780 | [#5] yui.html Cycles:180 Average:19346.30 Median:48973.01 stddev:26415.70 (53.9%) stddev-sans-first:26453.01 11:23:16 INFO - PROCESS | 23780 | Values: 778.8 780.3 808.1 832.4 835.1 14713.6 15308.6 15328.5 15329.8 15363.8 13860.9 13997.7 14010.5 14012.9 14027.5 664.4 772.7 793.9 799.4 805.6 788.9 794.9 796.9 797.4 797.6 853.4 858.5 858.5 858.5 858.7 706.2 823.0 849.7 851.9 853.9 618.6 622.1 622.9 623.3 624.0 12208.1 12305.5 12416.6 12573.1 12659.8 13607.3 13886.0 14053.0 14223.6 14254.5 12723.9 12925.4 12955.7 13002.7 13086.5 4368.2 4376.6 4381.2 4408.5 4451.4 70553.6 71038.6 71195.6 71248.0 71489.3 11125.0 11369.7 11395.3 11524.1 11587.2 18574.3 18576.9 18579.1 18648.9 18667.3 7789.6 8028.0 8034.6 8081.4 8200.1 4496.2 4549.0 4552.5 4575.7 4780.9 3299.5 3394.7 3403.7 3406.2 3410.5 547.1 603.3 604.4 604.8 606.5 680.5 684.3 731.3 731.9 782.3 9779.7 10475.3 10506.9 10508.9 10554.8 621.6 698.1 721.4 728.6 781.5 4830.9 4914.4 5028.3 5055.4 5166.2 65654.3 66707.0 67876.0 68035.3 108586.5 95497.5 97382.0 97462.0 98556.0 98818.0 84157.6 85722.0 85950.0 85952.0 86081.6 9115.5 9138.6 9169.9 9199.2 9381.3 48938.8 49007.3 50247.7 50954.7 51541.5 64955.4 67867.3 72252.0 73171.0 74805.6 13454.1 13536.0 13703.0 13724.5 13760.4 14804.9 15255.4 15711.3 15807.7 16073.3 9948.5 14085.9 14323.1 14429.9 14733.8 13604.8 13696.8 13848.1 14670.0 15153.0 14085.7 14864.3 14918.5 14920.6 15438.7 11363.8 11424.9 11612.5 12071.4 12862.4 11951.5 11984.0 12428.9 12565.0 12659.6 11:23:16 INFO - PROCESS | 23780 | -------- Summary: end -------- 11:23:16 INFO - PROCESS | 23780 | 11:23:16 INFO - TEST-INFO | 23780: exit 0 11:23:16 INFO - TEST-OK | dromaeo_css | took 1113844ms 11:23:16 INFO - TEST-START | kraken 11:23:16 INFO - operating with platform_type : linux_ 11:23:16 INFO - Initialising browser for kraken test... 11:23:16 INFO - TEST-INFO | started process 23966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVrtkQ0/profile http://localhost:59217/getInfo.html) 11:23:20 INFO - PROCESS | 23966 | __metrics Screen width/height:1600/1200 11:23:20 INFO - PROCESS | 23966 | colorDepth:24 11:23:20 INFO - PROCESS | 23966 | Browser inner width/height: 1024/697 11:23:20 INFO - PROCESS | 23966 | __metrics 11:23:21 INFO - PROCESS | 23966 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:23:21 INFO - PROCESS | 23966 | console.error: PushService: 11:23:21 INFO - PROCESS | 23966 | stateChangeProcessEnqueue: Error transitioning state 11:23:21 INFO - PROCESS | 23966 | UnknownError 11:23:22 INFO - TEST-INFO | 23966: exit 0 11:23:22 INFO - Browser initialized. 11:23:22 INFO - Running cycle 1/1 for kraken test... 11:23:22 INFO - TEST-INFO | started process 24048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVrtkQ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:34 INFO - PROCESS | 24048 | RSS: Main: 174256128 11:23:34 INFO - PROCESS | 24048 | 11:23:37 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59217/tests/kraken/driver.html?testName=audio-beat-detection) 11:23:37 INFO - PROCESS | 24048 | RSS: Main: 232292352 11:23:37 INFO - PROCESS | 24048 | 11:23:40 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59217/tests/kraken/driver.html?testName=audio-dft) 11:23:41 INFO - PROCESS | 24048 | RSS: Main: 216543232 11:23:41 INFO - PROCESS | 24048 | 11:23:44 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59217/tests/kraken/driver.html?testName=audio-fft) 11:23:45 INFO - PROCESS | 24048 | RSS: Main: 286502912 11:23:45 INFO - PROCESS | 24048 | 11:23:47 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59217/tests/kraken/driver.html?testName=audio-oscillator) 11:23:47 INFO - PROCESS | 24048 | RSS: Main: 197431296 11:23:47 INFO - PROCESS | 24048 | 11:23:49 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:50 INFO - PROCESS | 24048 | RSS: Main: 200798208 11:23:50 INFO - PROCESS | 24048 | 11:23:53 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59217/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:54 INFO - PROCESS | 24048 | RSS: Main: 235868160 11:23:54 INFO - PROCESS | 24048 | 11:23:57 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59217/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:57 INFO - PROCESS | 24048 | RSS: Main: 238137344 11:23:57 INFO - PROCESS | 24048 | 11:24:00 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59217/tests/kraken/driver.html?testName=json-parse-financial) 11:24:01 INFO - PROCESS | 24048 | RSS: Main: 237879296 11:24:01 INFO - PROCESS | 24048 | 11:24:02 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:03 INFO - PROCESS | 24048 | RSS: Main: 221523968 11:24:03 INFO - PROCESS | 24048 | 11:24:05 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:05 INFO - PROCESS | 24048 | RSS: Main: 227008512 11:24:05 INFO - PROCESS | 24048 | 11:24:07 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:24:08 INFO - PROCESS | 24048 | RSS: Main: 234557440 11:24:08 INFO - PROCESS | 24048 | 11:24:11 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:24:11 INFO - PROCESS | 24048 | RSS: Main: 239235072 11:24:11 INFO - PROCESS | 24048 | 11:24:14 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:24:15 INFO - PROCESS | 24048 | RSS: Main: 241422336 11:24:15 INFO - PROCESS | 24048 | 11:24:16 INFO - PROCESS | 24048 | Cycle 1(1): loaded http://localhost:59217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59217/tests/kraken/driver.html?testName=ai-astar) 11:24:17 INFO - PROCESS | 24048 | RSS: Main: 284090368 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | __start_tp_report 11:24:17 INFO - PROCESS | 24048 | _x_x_mozilla_page_load 11:24:17 INFO - PROCESS | 24048 | _x_x_mozilla_page_load_details 11:24:17 INFO - PROCESS | 24048 | |i|pagename|runs| 11:24:17 INFO - PROCESS | 24048 | |0;ai-astar;112;105;112;111;111;111;111;112;110;110 11:24:17 INFO - PROCESS | 24048 | |1;audio-beat-detection;150;132;127;173;127;131;124;159;160;124 11:24:17 INFO - PROCESS | 24048 | |2;audio-dft;162;160;162;160;160;161;159;161;160;161 11:24:17 INFO - PROCESS | 24048 | |3;audio-fft;76;75;77;102;76;75;74;74;105;76 11:24:17 INFO - PROCESS | 24048 | |4;audio-oscillator;84;85;110;84;84;85;120;84;85;119 11:24:17 INFO - PROCESS | 24048 | |5;imaging-gaussian-blur;116;117;116;116;116;116;117;116;117;117 11:24:17 INFO - PROCESS | 24048 | |6;imaging-darkroom;146;146;146;146;146;145;147;147;146;148 11:24:17 INFO - PROCESS | 24048 | |7;imaging-desaturate;95;95;95;94;94;95;95;95;95;95 11:24:17 INFO - PROCESS | 24048 | |8;json-parse-financial;54;53;53;52;53;53;55;55;52;53 11:24:17 INFO - PROCESS | 24048 | |9;json-stringify-tinderbox;62;63;61;62;62;61;61;61;62;63 11:24:17 INFO - PROCESS | 24048 | |10;stanford-crypto-aes;78;80;79;78;86;83;86;81;134;79 11:24:17 INFO - PROCESS | 24048 | |11;stanford-crypto-ccm;121;140;121;134;131;120;118;122;164;126 11:24:17 INFO - PROCESS | 24048 | |12;stanford-crypto-pbkdf2;172;162;158;163;160;162;158;161;159;160 11:24:17 INFO - PROCESS | 24048 | |13;stanford-crypto-sha256-iterative;63;63;64;63;64;63;64;66;63;61 11:24:17 INFO - PROCESS | 24048 | __end_tp_report 11:24:17 INFO - PROCESS | 24048 | __start_cc_report 11:24:17 INFO - PROCESS | 24048 | _x_x_mozilla_cycle_collect,1628 11:24:17 INFO - PROCESS | 24048 | __end_cc_report 11:24:17 INFO - PROCESS | 24048 | __startTimestamp1465583057113__endTimestamp 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | ------- Summary: start ------- 11:24:17 INFO - PROCESS | 24048 | Number of tests: 14 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:2.12 11:24:17 INFO - PROCESS | 24048 | Values: 112.0 105.0 112.0 111.0 111.0 111.0 111.0 112.0 110.0 110.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:141.00 stddev:18.07 (12.8%) stddev-sans-first:18.85 11:24:17 INFO - PROCESS | 24048 | Values: 150.0 132.0 127.0 173.0 127.0 131.0 124.0 159.0 160.0 124.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 11:24:17 INFO - PROCESS | 24048 | Values: 162.0 160.0 162.0 160.0 160.0 161.0 159.0 161.0 160.0 161.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:11.92 (15.8%) stddev-sans-first:12.50 11:24:17 INFO - PROCESS | 24048 | Values: 76.0 75.0 77.0 102.0 76.0 75.0 74.0 74.0 105.0 76.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.00 stddev:15.63 (18.6%) stddev-sans-first:16.16 11:24:17 INFO - PROCESS | 24048 | Values: 84.0 85.0 110.0 84.0 84.0 85.0 120.0 84.0 85.0 119.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:24:17 INFO - PROCESS | 24048 | Values: 116.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 11:24:17 INFO - PROCESS | 24048 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 147.0 147.0 146.0 148.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:24:17 INFO - PROCESS | 24048 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:1.06 (2.0%) stddev-sans-first:1.09 11:24:17 INFO - PROCESS | 24048 | Values: 54.0 53.0 53.0 52.0 53.0 53.0 55.0 55.0 52.0 53.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 11:24:17 INFO - PROCESS | 24048 | Values: 62.0 63.0 61.0 62.0 62.0 61.0 61.0 61.0 62.0 63.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:80.50 stddev:16.99 (21.1%) stddev-sans-first:17.75 11:24:17 INFO - PROCESS | 24048 | Values: 78.0 80.0 79.0 78.0 86.0 83.0 86.0 81.0 134.0 79.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:128.50 stddev:13.98 (10.9%) stddev-sans-first:14.47 11:24:17 INFO - PROCESS | 24048 | Values: 121.0 140.0 121.0 134.0 131.0 120.0 118.0 122.0 164.0 126.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.50 stddev:4.06 (2.5%) stddev-sans-first:1.80 11:24:17 INFO - PROCESS | 24048 | Values: 172.0 162.0 158.0 163.0 160.0 162.0 158.0 161.0 159.0 160.0 11:24:17 INFO - PROCESS | 24048 | 11:24:17 INFO - PROCESS | 24048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.26 (2.0%) stddev-sans-first:1.33 11:24:17 INFO - PROCESS | 24048 | Values: 63.0 63.0 64.0 63.0 64.0 63.0 64.0 66.0 63.0 61.0 11:24:17 INFO - PROCESS | 24048 | -------- Summary: end -------- 11:24:17 INFO - PROCESS | 24048 | 11:24:18 INFO - TEST-INFO | 24048: exit 0 11:24:18 INFO - TEST-OK | kraken | took 61284ms 11:24:18 INFO - SUITE-END | took 1175s 11:24:18 INFO - Completed test suite (00:19:35) 11:24:18 INFO - javascript benchmark 11:24:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.9686503134967, 3143.2141964508874, 3152.5271209318594, 3168.112928380054, 3210.9197270068244, 5336.519713225809, 5398.730063496829, 5407.945920540794, 5508.3114610673665, 5517.255170551979, 5445.237666726662, 5449.972750136244, 5481.835544933649, 5492.917606235909, 5515.4760297771645, 4901.044296362211, 4972.801087956477, 4998.57512111471, 5015.398152221738, 5166.044281807859, 5060.620453465986, 5073.858381864088, 5104.285400043997, 5124.692518448886, 5130.538251557359, 4826.831060912887, 4833.178359678863, 4845.200541910581, 4891.290762839386, 4935.235038569028, 4775.164346239429, 4805.783739731721, 4908.509149085098, 4909.8772530686665, 4967.50324967504, 4866.58634016109, 4867.0, 4867.9269810952865, 4927.162382395001, 4956.330895329156, 5261.0, 5317.229001794718, 5374.435684253175, 5380.435054319319, 5478.753456094445, 5813.651180929158, 5822.82531524055, 5842.532597392198, 5843.561732870009, 5848.298204215479, 5781.942180578182, 5876.529877609781, 5877.324107727623, 5890.823275301705, 5897.144913987448, 5410.945890541084, 5451.536619387357, 5459.426760190163, 5541.0, 5542.695151766611, 6023.849403764941, 6036.456718895321, 6037.516998640098, 6039.456448919618, 6040.879182416415, 5514.448555144534, 5676.971615141898, 5805.88388232233, 5844.15259787337, 5844.532437404998, 5775.971120144372, 5864.9413505864395, 5865.149553314745, 5865.413458654186, 5921.437463440966, 5776.1624564437925, 5825.592208545361, 5829.5044921181325, 5829.795957141479, 5835.503982161479, 5679.5172410345585, 5695.1741997410145, 5728.255326807488, 5847.8245652630485, 5860.472557469763, 4442.622377097919, 4451.354553589711, 4455.242608756519, 4487.5288094749585, 4496.033352829158, 3943.645071943539, 3961.069148750041, 3965.5836137205756, 3995.10110225197, 3998.34027385484, 5378.811741589026, 5404.081306177959, 5413.539849112791, 5420.945790542044, 5437.945620543823, 5766.509846662997, 5784.421557844182, 5792.797252096157, 5795.565332600072, 5834.183214349994, 5431.131019036935, 5456.127019676833, 5479.287692599936, 5479.917801232985, 5481.725913704299, 4986.650934434628, 4987.650864439454, 5024.572911302507, 5031.345925029723, 5103.948960510347, 6030.125631783367, 6044.576879618472, 6045.63726176422, 6048.9697551512845, 6055.515558755289, 5801.94198058014, 5813.273340832396, 5815.680137592304, 5822.446867547576, 5824.330202026821, 5868.4424979626865, 5904.557158213237, 5918.881622367615, 5940.673262970578, 5999.100134979788, 5609.663420194802, 5660.405657406078, 5667.8866422672145, 5677.716114194356, 5682.0, 5681.573881958952, 5751.769929202952, 5762.538996880324, 5763.827085187451, 5767.134929760569, 5691.459311365414, 5731.541476681772, 5743.195952566561, 5776.566757493289, 5791.7683292667825, 5708.257926469532, 5755.740991655469, 5757.769689212385, 5761.5390768739235, 5767.509761670305, 5350.4382039886805, 5550.611457197957, 5665.688387138582, 5665.886682266414, 5669.064604340238, 5557.499825015606, 5641.182028605911, 5662.490375866192, 5671.6029877909805, 5677.51741102011, 5442.673439593637, 5487.890242195213, 5494.670319780826, 5497.285352904097, 5501.064818980863], "value": 5356.338950086623, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.6245128020628, 606.5541826757333, 613.5705006495455, 630.8643641617051, 633.6261605652664, 31860.840695796516, 42095.158096838044, 42751.78624106875, 42818.35772463415, 46243.0, 44480.11039779202, 44704.10591788162, 45112.548874511325, 45201.32198017032, 45219.77390113045, 8734.868976965336, 8845.601947912328, 8852.955735221314, 8864.911350886474, 8866.113388661115, 8648.1784230498, 8732.781680458007, 8735.388522803407, 8740.606672699743, 8746.562671866413, 8798.86801697975, 8887.066857979917, 8898.37711360205, 8903.777405564848, 8907.242884354837, 8760.956195218983, 8804.64781408746, 8836.55817209137, 8847.867281990775, 8848.070952549986, 8719.825603487894, 8773.605187766501, 8778.692745753931, 8781.692640757607, 8786.253168480687, 42487.0, 42999.35500967457, 43046.354304685454, 43084.138317233796, 43096.56903430988, 3418.5214070030215, 3521.0740772142494, 3610.837512311926, 3621.203335266237, 3974.880753577397, 32436.351272974644, 32901.6709832901, 33217.6678233217, 33226.667733322596, 33631.49552756711, 4376.868693939187, 4405.140997505488, 4431.578999994996, 4573.474050484204, 4633.235516139833, 329235.24588524527, 329511.0, 329565.0, 330052.0, 331190.0, 51881.2217816733, 54086.45913540893, 55278.170827436814, 55486.44513554813, 57544.42455575475, 60666.696666516385, 60952.695236523534, 60986.39013609896, 61162.0, 61191.69404152951, 17206.31174752996, 17351.826481735272, 17361.0, 17372.0, 17399.47801565955, 11003.834942475869, 11976.940115299367, 12066.09504287182, 12088.697782555506, 12393.318367489876, 16579.336826527044, 16637.084960327054, 16662.0, 16683.0824304662, 16704.498865034067, 6213.627182369072, 6259.71831267594, 6312.305646378894, 6316.147320111726, 6357.364263573606, 962.3985009369144, 966.6665000574791, 1019.8674172357546, 1048.8531605575226, 1130.6381957773433, 32077.89161647066, 32423.837880810446, 32487.187820304207, 32675.509867352008, 32757.508637370458, 1122.550979608147, 1138.6299452677913, 1160.3096157786104, 1221.9144659873723, 1226.9447874845653, 16922.74615880763, 17271.56821079458, 17318.307267709402, 17324.393646222576, 17550.122493875257, 468995.0, 474576.0, 478238.0, 479179.0, 479579.0, 57516.0, 58106.0, 58239.12641310384, 58285.41714582885, 58459.415405846245, 1272.5037235478171, 1334.7197088611306, 1380.565121986571, 1387.7293927684207, 1394.7280280345437, 30879.845600771852, 33277.66722332746, 33297.667023330425, 33419.66580334263, 33859.83070084634, 49621.0, 50115.49884501108, 50185.0, 50267.24599130943, 50370.0, 384847.0, 386454.0, 386569.0, 386876.0, 386976.10703090555, 32892.0, 35425.645743542234, 41588.37617435801, 41893.58106418897, 45325.0, 47837.0, 47854.0, 48234.27648585344, 48645.02709945852, 49508.50491495039, 39387.40918886162, 40888.38667419932, 41207.79396103, 41392.0, 41906.58093419149, 40136.59863401329, 40259.1948161041, 40761.59238407697, 41108.79445602753, 41215.175696486505, 39301.0, 40161.598384015786, 40780.79609601933, 40900.79549602233, 41025.0, 34810.47784283187, 36122.0, 36353.454698180074, 36623.0, 36730.63269367379, 27454.725452745217, 27504.0, 27841.0, 27876.16371508858, 27907.720922791323], "value": 20008.186675690024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.39834662886017, 381.3421847313385, 382.93872980323135, 396.76590811421255, 399.03632726964366, 15280.465183718572, 16408.507744767645, 17297.827021729794, 20292.0, 20353.796462035374, 16877.66244675106, 18622.90688546559, 19409.32067377642, 19441.70837437436, 19449.0, 5166.5608423283975, 5266.4733526647415, 5335.679859208441, 5374.543163831079, 5375.569954403658, 5404.243405923174, 5576.693281869496, 5600.467955544217, 5607.0, 5609.971950140243, 5368.489993450616, 5562.805301814437, 5565.888682226353, 5566.304211973504, 5566.610337276392, 5568.248286481355, 5599.664020158803, 5602.047651899187, 5606.486248712845, 5613.101903695409, 4823.9517604824205, 4992.775325110379, 5020.799168033274, 5028.949710502921, 5030.245463180516, 22554.323370298916, 22617.208397706167, 22986.390952633323, 23383.88308058449, 23535.76464235353, 2411.565918134735, 2461.3600463879343, 2470.258922323296, 2654.4558365535017, 2751.119641714652, 8563.871541926876, 14386.92806535971, 14432.20622865742, 14525.201113938729, 14881.404743810235, 1974.042589344167, 1977.8516611254213, 1996.2114964589052, 2003.8396928245706, 2102.1696429910253, 79730.60134699289, 80626.59686701588, 80913.59543202305, 81398.0, 82136.9999999994, 10576.99518545737, 10599.152067834555, 10724.30292031031, 10774.138068954464, 10994.835077473845, 14610.853891460949, 14742.336594853043, 14747.188904610135, 14761.483348082766, 14820.481283155254, 7801.2198780121535, 7929.286364227132, 8263.793405164919, 8359.247667709935, 8396.496210227406, 7826.8434631307055, 7967.960160199278, 8218.589070546448, 8274.751757447286, 8381.371397145238, 4422.7346359218545, 4463.196624607537, 4474.172278128557, 4529.614982726439, 4576.88557786058, 1805.1786437171056, 1841.269206945467, 1848.2111671074244, 1856.8421684156729, 1914.7510823592843, 956.4309236004566, 975.6487664440796, 988.3773222869546, 1024.8411496218098, 1063.3566692151292, 18454.907725461286, 19498.415047548595, 19657.705134422995, 19763.40709778709, 19909.900450497655, 951.4196340232453, 984.17329443268, 989.7030890732896, 1003.5985605757755, 1011.630754774502, 10709.892901070889, 10987.60598837409, 11008.0, 11103.234824281086, 11148.108151347873, 366090.0, 374514.0, 496289.0, 501985.0, 522252.0, 72869.0, 85560.0, 90836.5458172705, 93851.53074234586, 97227.0, 853.4623187391903, 871.9869201961849, 891.7859713668803, 897.5063714956748, 900.1043961258721, 15938.68122637564, 16214.0, 16284.755728663842, 16489.96232750075, 16605.0, 41211.38182927199, 41773.0, 42172.789136054125, 43106.56893431151, 43496.130077398906, 55496.72251638716, 58151.0, 58227.0, 58444.415555843894, 58481.973812702556, 7663.655135518804, 7827.804304892423, 7932.563708996061, 8014.639341229776, 8020.558869262247, 10389.740256493647, 11884.821727674265, 11887.524499019943, 12352.567660131852, 12742.42659080325, 10833.349999000086, 10945.233833631888, 10998.285111467729, 11063.22557421005, 11171.66485005451, 10685.946570267099, 10807.08139808125, 10838.721264367918, 11043.116550675766, 11143.108551316038, 10841.623665987716, 10973.23187376876, 11185.496652650487, 11238.269512481662, 11381.089512838787, 7316.268373162641, 7915.406344524299, 8094.15011423792, 8132.75601731949, 8187.1403502631365, 10275.794484110425, 12208.511659533518, 12265.448054837376, 12273.938630306791, 12398.25610463339], "value": 9007.16785807409, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.2973253907974, 1466.5600319904029, 1512.1229686781667, 1646.448439772676, 1816.6457540779545, 7984.6007699615, 8287.04698959619, 8297.336213102952, 8310.418270721051, 8527.91472085279, 8066.878996815052, 8292.958535207315, 8451.366147538929, 8453.408261421702, 8471.661133554651, 1969.5765410436754, 2224.7775222477785, 2252.3693365857544, 2294.1167650454613, 2306.9423264418356, 2342.3441436397834, 2354.693889794324, 2355.199232261031, 2355.2463211772238, 2359.9646005309933, 2298.586254474194, 2313.53729254149, 2351.5179388225374, 2352.5059737455153, 2354.30547988343, 1921.4139687395339, 2141.0, 2198.6152423326016, 2203.8457307988447, 2227.175944900389, 2226.855254408458, 2243.5064285857084, 2244.5735310291157, 2247.314569056437, 2249.80876625487, 8297.502149870967, 8349.749507514784, 8354.540500272482, 8355.707550235773, 8357.038940521858, 4941.530554597308, 5069.619778516626, 5075.162598171298, 5076.162433198518, 5083.847484575469, 3106.3476669899346, 3151.5902932618615, 3266.5426840242385, 3270.1170683915448, 3279.0490757680245, 1195.7967145585185, 1210.2012671636678, 2151.483643925447, 2172.847900646955, 2192.7039849620414, 11953.40232988347, 12135.150539462242, 12152.635420937386, 12167.817482737766, 12176.81734773979, 4274.252005898955, 4544.500104988449, 4553.33976573395, 4631.536846315342, 4632.073585282957, 10225.0, 10240.692779216635, 10244.48777561119, 10249.897501024894, 10257.948710256402, 5193.506616871391, 5204.739763011834, 5204.843854684365, 5205.0, 5205.843824685266, 4260.68044896634, 4635.930461043087, 4722.268048452426, 4743.83396581118, 4807.086653535887, 3995.5604883462797, 3996.620321069494, 4074.6536544394057, 4125.834966601303, 4136.958630413717, 1272.8090786382118, 1296.2287438973794, 1305.6866352075433, 1317.0, 1334.8665133486575, 872.8123453457537, 949.6059135458845, 996.6312464388078, 997.0926456924309, 1029.0327092532996, 5850.531957443394, 5978.342382338026, 6019.367966363557, 6036.366181550961, 6154.046122850876, 445.19197656253795, 448.90797386535684, 454.4955099839176, 455.3897776978864, 456.09010024999674, 4084.36692312692, 4162.9945041343135, 4274.722143060691, 4285.550017248206, 4303.440552728125, 10351.120154786777, 10665.253432259822, 10710.678679639623, 10710.839337409945, 10727.088197503299, 10456.215783816093, 10468.110210632181, 10548.578056877792, 10615.575376984989, 10733.463326833627, 8069.233422824822, 8093.514389136789, 8192.713255036046, 8199.672013119409, 8208.958955205306, 5683.943160568341, 5821.243238378984, 5858.150568167506, 5907.793227237198, 5928.822135335947, 9848.0, 9920.603175873173, 9983.301168918106, 9998.900011000087, 10015.499225038864, 9775.75560610962, 9966.551505182138, 10062.39625622465, 10132.848007279748, 10183.287169898036, 7110.822229444305, 7304.488685791944, 7307.963460182665, 7511.737089201852, 7604.619769011417, 8042.718504852302, 8202.384821138558, 8384.706535271236, 8401.915980840358, 8624.439411438236, 7535.095788505414, 7765.961170194113, 7786.104597971306, 7850.293473587404, 7884.2115788423, 7382.187959324578, 7482.401407887465, 7493.775186744407, 7593.240675932362, 7723.9227607723205, 6988.0, 7011.228764835966, 7052.541584796972, 7059.0, 7061.470389720689, 5192.714400707846, 5236.188390799432, 5360.463953604608, 5363.892722145457, 5406.162044883049, 5338.946610533845, 5397.217403476396, 5399.082156033563, 5406.540444062141, 5463.754131064032], "value": 4545.2366973972585, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5165356296019, 303.28122350030424, 304.2682348950774, 309.5078824668777, 312.7669885934979, 5349.625526213166, 5371.060064488718, 5372.758225879835, 5381.569474442045, 5411.431799661038, 5089.592832573395, 5117.616178786588, 5201.349831271091, 5256.973715131428, 5308.23030660554, 4070.837166513336, 4096.713230073896, 4098.4057311689785, 4099.385092236159, 4099.918001639965, 4055.168690418457, 4072.5927407259333, 4072.816723247446, 4084.305668036426, 4089.6114869087387, 3826.751261168029, 3910.393888947218, 4017.116234428421, 4032.919341613166, 4110.355857656946, 4080.204360149772, 4083.0, 4086.6730661547303, 4092.4475195848477, 4104.630583247507, 3587.515685382466, 3608.711303095746, 3609.205974685591, 3623.601403845575, 3652.945205821915, 5091.715843281063, 5100.5919526438165, 5104.157813960692, 5111.948880511184, 5187.974060129713, 4609.953900460986, 4630.467496237942, 4662.9067418651775, 4664.437413466459, 4684.672072954894, 5470.2888624478965, 5491.148871924858, 5492.697901615409, 5535.308086489189, 5543.1408131739645, 3840.1935593525395, 3934.429507721364, 3942.5466071401584, 3948.1511475033008, 3956.3274243378405, 5642.0, 5647.576431767634, 5654.830355089395, 5660.235868157787, 5677.687727175004, 3989.606236258222, 4012.719109662354, 4033.233685599727, 4061.3501839705505, 4068.06434520062, 4008.574812238612, 4025.959740402617, 4100.876973690794, 4103.651189648854, 4118.670506359544, 4666.859994200179, 4673.826670598188, 4681.9297710534365, 4705.0, 4709.364235828188, 5524.392316845144, 5530.364008139035, 5556.416576259516, 5610.691411972299, 5655.802046928337, 1304.3608631770364, 1374.8075269462083, 1412.837523684769, 1437.2885421716107, 1437.9712405751827, 854.9529775862263, 858.3176374782063, 861.3195575495289, 880.106691707917, 881.4975463985595, 4718.245080787057, 4719.0, 4751.786169622375, 4774.904501909942, 4825.565699087099, 5098.847034588968, 5122.897542049138, 5123.0, 5138.53551737753, 5150.175971844487, 4691.483936766953, 4815.7351345676325, 4835.274708793709, 4871.905080815212, 4882.0, 2679.713737406056, 2696.892124315045, 2699.4331190450225, 2713.8778754956074, 2714.2264454630335, 5181.202150838581, 5219.478052194826, 5233.476652334736, 5292.814751483679, 5307.336582927134, 4881.267809828554, 5088.567471764942, 5153.793848246103, 5169.560587350042, 5173.922391164136, 5136.537711605899, 5149.382074151126, 5184.844454666441, 5282.366116066097, 5288.603354748409, 4948.73807179167, 4992.375953005874, 5024.648274620888, 5050.49495050492, 5076.0, 4754.31062495943, 4919.0899683558655, 4980.406269993568, 4997.475265097112, 5000.64995450315, 5172.482751724798, 5179.663321884065, 5199.688018718889, 5208.322918020633, 5225.843224703265, 3578.7494875359516, 3603.4775657039654, 3624.3838547447526, 3645.671889529955, 3745.1198968242984, 5461.15352120422, 5658.434156584309, 5715.828525144252, 5735.655860648374, 5748.511376532874, 5545.223668686468, 5554.305711786027, 5556.555475562026, 5593.720313984366, 5616.915746263891, 5356.892862142813, 5552.444755524415, 5554.777808887599, 5613.943860561342, 5617.831465056055, 5462.644928079662, 5464.972675136599, 5486.259354987025, 5486.369067557282, 5506.889862202814, 5561.443855614406, 5579.60942734021, 5605.131204663284, 5614.494695477427, 5620.437956204347, 5245.947540524546, 5392.840539283916, 5449.828286918331, 5464.0, 5469.644473109235], "value": 4053.2739273712095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.8286576953072, 780.3172224303734, 808.1070417189006, 832.3798769916414, 835.1481488881345, 14713.632159196026, 15308.617284567892, 15328.463503777342, 15329.84670153298, 15363.846361536394, 13860.930695346535, 13997.650058748537, 14010.509632162877, 14012.859871401282, 14027.509037183701, 664.3688495928862, 772.6754762999526, 793.8928244686965, 799.360511590728, 805.6414895371562, 788.8895554622358, 794.9244821741954, 796.9163237860029, 797.3979645367739, 797.5693125712108, 853.4196746212573, 858.4548811504708, 858.4720396955859, 858.527809704663, 858.6779957515931, 706.2019917493226, 822.9588520573948, 849.6941101203562, 851.8679604661287, 853.8847255620536, 618.6319140111626, 622.0855342646303, 622.8536293970914, 623.3174673732256, 623.9984824356887, 12208.145429819917, 12305.507779688802, 12416.627501174979, 12573.057020723483, 12659.810102848465, 13607.31963401826, 13886.0, 14053.0, 14223.644408889757, 14254.501092461818, 12723.872761272361, 12925.353732313346, 12955.740885182338, 13002.739945201043, 13086.47654093835, 4368.235558777201, 4376.6498680105515, 4381.189479946188, 4408.493023302329, 4451.354553589744, 70553.64723176352, 71038.64480677615, 71195.64402178008, 71247.99999999948, 71489.28510714878, 11125.0, 11369.658910232707, 11395.25930814511, 11524.078073754079, 11587.246828956091, 18574.349897753786, 18576.907115464335, 18579.071046447894, 18648.906755466134, 18667.346642867433, 7789.571573563395, 8027.959860200662, 8034.638441270157, 8081.393895457864, 8200.097989221182, 4496.168208881302, 4548.977255113703, 4552.453705555355, 4575.656825738017, 4780.928286075712, 3299.4555898276994, 3394.7453940954033, 3403.676650718178, 3406.233597440556, 3410.4543273076683, 547.0535972767135, 603.2820943077724, 604.3684349854412, 604.7701873288122, 606.5390303369471, 680.4998326230217, 684.2780866186222, 731.2906480713699, 731.934125928669, 782.2685788787502, 9779.706608801747, 10475.266731328886, 10506.947465262778, 10508.947455262827, 10554.788904222027, 621.5773274173515, 698.1482591238681, 721.3724060067669, 728.6174758251855, 781.538892053691, 4830.903381932341, 4914.410270767531, 5028.270900719375, 5055.393352797688, 5166.173412254021, 65654.34345656578, 66706.96181209243, 67876.0, 68035.3196468029, 108586.45706771573, 95497.52251238699, 97382.0, 97462.0, 98556.0, 98818.0, 84157.57921210355, 85722.0, 85950.0, 85952.0, 86081.5695921529, 9115.453072815651, 9138.63445462174, 9169.8909250874, 9199.172074513326, 9381.296402769683, 48938.75530622324, 49007.26489102595, 50247.748761255956, 50954.74522627363, 51541.48458515367, 64955.35044649493, 67867.3213267861, 72252.0, 73171.0, 74805.6259718698, 13454.058215925183, 13536.0, 13703.0, 13724.451021959409, 13760.449582016607, 14804.851951480778, 15255.389784408942, 15711.292991815168, 15807.68384632278, 16073.276702548646, 9948.45283509414, 14085.929570352082, 14323.14061156334, 14429.855701442852, 14733.778993314894, 13604.795928060888, 13696.794548081985, 13848.09987350819, 14670.0, 15153.0, 14085.718285634435, 14864.256787160815, 14918.477853275082, 14920.552383428514, 15438.69122617519, 11363.772724545297, 11424.942875285571, 11612.535498579962, 12071.39643017828, 12862.356882156042, 11951.462184201559, 11984.0, 12428.875711242772, 12565.0, 12659.556915507914], "value": 7445.320428428964, "unit": "score"}], "name": "dromaeo_css", "value": 7139.363377416533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 111.0, 111.0, 111.0, 111.0, 112.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 127.0, 173.0, 127.0, 131.0, 124.0, 159.0, 160.0, 124.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 160.0, 160.0, 161.0, 159.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 102.0, 76.0, 75.0, 74.0, 74.0, 105.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 110.0, 84.0, 84.0, 85.0, 120.0, 84.0, 85.0, 119.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 148.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 52.0, 53.0, 53.0, 55.0, 55.0, 52.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 63.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 78.0, 86.0, 83.0, 86.0, 81.0, 134.0, 79.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 140.0, 121.0, 134.0, 131.0, 120.0, 118.0, 122.0, 164.0, 126.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 162.0, 158.0, 163.0, 160.0, 162.0, 158.0, 161.0, 159.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 66.0, 63.0, 61.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1500.4, "alertThreshold": 2.0}]} 11:24:18 INFO - Return code: 0 11:24:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:24:18 INFO - # TBPL SUCCESS # 11:24:18 INFO - Running post-action listener: _resource_record_post_action 11:24:18 INFO - ##### 11:24:18 INFO - ##### Finished run-tests step (success) 11:24:18 INFO - ##### 11:24:18 INFO - Running post-run listener: _resource_record_post_run 11:24:18 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549142528; Read time: 12; Write time: 611276 11:24:18 INFO - TinderboxPrint: CPU usage
13.2% 11:24:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:24:18 INFO - TinderboxPrint: I/O write bytes / time
549,142,528 / 611,276 11:24:18 INFO - TinderboxPrint: CPU idle
8,257.6 (86.7%) 11:24:18 INFO - TinderboxPrint: CPU user
1,213.2 (12.7%) 11:24:18 INFO - TinderboxPrint: Swap in / out
0 / 0 11:24:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255934464; Read time: 0; Write time: 312072 11:24:18 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293208064; Read time: 12; Write time: 299204 11:24:19 INFO - Running post-run listener: _upload_blobber_files 11:24:19 INFO - Blob upload gear active. 11:24:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:24:19 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 11:24:19 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:24:19 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:24:19 INFO - (blobuploader) - INFO - Open directory for files ... 11:24:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:24:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:23 INFO - (blobuploader) - INFO - Done attempting. 11:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:23 INFO - (blobuploader) - INFO - Done attempting. 11:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:24:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:24 INFO - (blobuploader) - INFO - Done attempting. 11:24:24 INFO - (blobuploader) - INFO - Iteration through files over. 11:24:24 INFO - Return code: 0 11:24:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:24:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:24:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/321d35d174f636e73ff6ed1fa1692d0e8bf538341a9c451fbf244bd1bdad1626c1c71657128eb3c8aaeaeb6b9d78c2c39dcac3abad9961eb8f41bce96bf04e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c3b6111b6ab431b45ba6c1e818968fad1d6c13c71e8a13e0cfcb15579171acf4deceb777729b78a258a14680c75b5251d3b76e14d7e068471673fcc08aba9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/505e66781842c69087a6b4f27457ca2e2d408da6de700129964290660ff553bd58fd8e8d7dc620c9fb75aca4f98b961c268b30d4a9e06a389948060e053be0dc"} 11:24:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:24:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:24:24 INFO - Contents: 11:24:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/321d35d174f636e73ff6ed1fa1692d0e8bf538341a9c451fbf244bd1bdad1626c1c71657128eb3c8aaeaeb6b9d78c2c39dcac3abad9961eb8f41bce96bf04e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c3b6111b6ab431b45ba6c1e818968fad1d6c13c71e8a13e0cfcb15579171acf4deceb777729b78a258a14680c75b5251d3b76e14d7e068471673fcc08aba9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/505e66781842c69087a6b4f27457ca2e2d408da6de700129964290660ff553bd58fd8e8d7dc620c9fb75aca4f98b961c268b30d4a9e06a389948060e053be0dc"} 11:24:24 INFO - Running post-run listener: copy_logs_to_upload_dir 11:24:24 INFO - Copying logs to upload dir... 11:24:24 INFO - mkdir: /builds/slave/test/build/upload/logs 11:24:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.370762 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-10 11:24:24.682811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 11:24:24.685861) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277 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/sha512/321d35d174f636e73ff6ed1fa1692d0e8bf538341a9c451fbf244bd1bdad1626c1c71657128eb3c8aaeaeb6b9d78c2c39dcac3abad9961eb8f41bce96bf04e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c3b6111b6ab431b45ba6c1e818968fad1d6c13c71e8a13e0cfcb15579171acf4deceb777729b78a258a14680c75b5251d3b76e14d7e068471673fcc08aba9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/505e66781842c69087a6b4f27457ca2e2d408da6de700129964290660ff553bd58fd8e8d7dc620c9fb75aca4f98b961c268b30d4a9e06a389948060e053be0dc"} build_url:https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/fMkVf5XFT6yFT7XWQNOZXw/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/sha512/321d35d174f636e73ff6ed1fa1692d0e8bf538341a9c451fbf244bd1bdad1626c1c71657128eb3c8aaeaeb6b9d78c2c39dcac3abad9961eb8f41bce96bf04e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c3b6111b6ab431b45ba6c1e818968fad1d6c13c71e8a13e0cfcb15579171acf4deceb777729b78a258a14680c75b5251d3b76e14d7e068471673fcc08aba9b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/505e66781842c69087a6b4f27457ca2e2d408da6de700129964290660ff553bd58fd8e8d7dc620c9fb75aca4f98b961c268b30d4a9e06a389948060e053be0dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 11:24:24.710950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:24:24.711255) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465581828.86762-906989277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:24:24.794062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 11:24:24.794390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 11:24:24.794685) ========= ========= Total master_lag: 0.16 =========