builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1467061599.24 results: success (0) buildid: 20160627113032 builduid: 63f12c61ae234384a4254170f9959b10 revision: d095e848a601937d9e7daedfd7e4e6f0199706e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.243575) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.244168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.244507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.307405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.307698) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 14:06:39-- 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% 81.7M=0s 2016-06-27 14:06:39 (81.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.431212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.431537) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.482220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:39.482595) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d095e848a601937d9e7daedfd7e4e6f0199706e2 --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 d095e848a601937d9e7daedfd7e4e6f0199706e2 --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=652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 14:06:39,728 truncating revision to first 12 chars 2016-06-27 14:06:39,728 Setting DEBUG logging. 2016-06-27 14:06:39,728 attempt 1/10 2016-06-27 14:06:39,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d095e848a601?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 14:06:40,167 unpacking tar archive at: fx-team-d095e848a601/testing/mozharness/ program finished with exit code 0 elapsedTime=0.828766 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:40.325293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:40.325655) ========= script_repo_revision: d095e848a601937d9e7daedfd7e4e6f0199706e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:40.326106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:40.326480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:40.339095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-27 14:06:40.339424) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:06:40 INFO - MultiFileLogger online at 20160627 14:06:40 in /builds/slave/test 14:06:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:06:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:06:40 INFO - {'append_to_log': False, 14:06:40 INFO - 'base_work_dir': '/builds/slave/test', 14:06:40 INFO - 'blob_upload_branch': 'Fx-Team', 14:06:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:06:40 INFO - 'branch': 'Fx-Team', 14:06:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:06:40 INFO - 'config_files': ('talos/linux_config.py',), 14:06:40 INFO - 'default_actions': ('clobber', 14:06:40 INFO - 'read-buildbot-config', 14:06:40 INFO - 'download-and-extract', 14:06:40 INFO - 'populate-webroot', 14:06:40 INFO - 'create-virtualenv', 14:06:40 INFO - 'install', 14:06:40 INFO - 'run-tests'), 14:06:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:06:40 INFO - 'download_minidump_stackwalk': True, 14:06:40 INFO - 'download_symbols': 'ondemand', 14:06:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:06:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:06:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:06:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:06:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:06:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:06:40 INFO - 'installer_path': 'installer.exe', 14:06:40 INFO - 'log_level': 'info', 14:06:40 INFO - 'log_name': 'talos', 14:06:40 INFO - 'log_to_console': True, 14:06:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:06:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:06:40 INFO - 'opt_config_files': (), 14:06:40 INFO - 'pip_index': False, 14:06:40 INFO - 'sps_profile': False, 14:06:40 INFO - 'sps_profile_interval': 0, 14:06:40 INFO - 'suite': 'dromaeojs-e10s', 14:06:40 INFO - 'system_bits': '32', 14:06:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:06:40 INFO - 'title': 'talos-linux64-ix-046', 14:06:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:06:40 INFO - 'use_talos_json': True, 14:06:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:06:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:06:40 INFO - 'work_dir': 'build'} 14:06:40 INFO - ##### 14:06:40 INFO - ##### Running clobber step. 14:06:40 INFO - ##### 14:06:40 INFO - Running pre-action listener: _resource_record_pre_action 14:06:40 INFO - Running main action method: clobber 14:06:40 INFO - rmtree: /builds/slave/test/build 14:06:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:06:41 INFO - Running post-action listener: _resource_record_post_action 14:06:41 INFO - ##### 14:06:41 INFO - ##### Finished clobber step (success) 14:06:41 INFO - ##### 14:06:41 INFO - ##### 14:06:41 INFO - ##### Running read-buildbot-config step. 14:06:41 INFO - ##### 14:06:41 INFO - Running pre-action listener: _resource_record_pre_action 14:06:41 INFO - Running main action method: read_buildbot_config 14:06:41 INFO - Using buildbot properties: 14:06:41 INFO - { 14:06:41 INFO - "project": "", 14:06:41 INFO - "product": "firefox", 14:06:41 INFO - "script_repo_revision": "production", 14:06:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:06:41 INFO - "repository": "", 14:06:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:06:41 INFO - "buildid": "20160627113032", 14:06:41 INFO - "pgo_build": "True", 14:06:41 INFO - "basedir": "/builds/slave/test", 14:06:41 INFO - "buildnumber": 869, 14:06:41 INFO - "slavename": "talos-linux64-ix-046", 14:06:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:06:41 INFO - "platform": "ubuntu64_hw", 14:06:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:06:41 INFO - "branch": "fx-team", 14:06:41 INFO - "repo_path": "integration/fx-team", 14:06:41 INFO - "revision": "d095e848a601937d9e7daedfd7e4e6f0199706e2", 14:06:41 INFO - "stage_platform": "linux64-pgo", 14:06:41 INFO - "builduid": "63f12c61ae234384a4254170f9959b10", 14:06:41 INFO - "slavebuilddir": "test" 14:06:41 INFO - } 14:06:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:06:41 INFO - Running post-action listener: _resource_record_post_action 14:06:41 INFO - ##### 14:06:41 INFO - ##### Finished read-buildbot-config step (success) 14:06:41 INFO - ##### 14:06:41 INFO - ##### 14:06:41 INFO - ##### Running download-and-extract step. 14:06:41 INFO - ##### 14:06:41 INFO - Running pre-action listener: _resource_record_pre_action 14:06:41 INFO - Running main action method: download_and_extract 14:06:41 INFO - mkdir: /builds/slave/test/build/tests 14:06: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')]} 14:06:41 INFO - https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:46 INFO - Downloaded 1361 bytes. 14:06:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:06:46 INFO - Using the following test package requirements: 14:06:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:06:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:06:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'jsshell-linux-x86_64.zip'], 14:06:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:06:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:06:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:06:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:06:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:06:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:46 INFO - https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:49 INFO - Downloaded 24279589 bytes. 14:06:49 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'] 14:06:49 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 14:06:50 INFO - Return code: 0 14:06:50 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 14:06: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')]} 14:06:50 INFO - https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:57 INFO - Downloaded 24279589 bytes. 14:06:57 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'] 14:06:57 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 14:06:58 INFO - Return code: 0 14:06: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')]} 14:06:58 INFO - https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:59 INFO - Downloaded 14405245 bytes. 14:06:59 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'] 14:06:59 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 14:06:59 INFO - Return code: 0 14:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:59 INFO - https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyiHBvSZT3eg0TxIyuN4ow/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 14:07:06 INFO - Downloaded 60190165 bytes. 14:07:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:06 INFO - mkdir: /builds/slave/test/properties 14:07:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:06 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:06 INFO - Contents: 14:07:06 INFO - build_url:https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:07 INFO - Running post-action listener: _resource_record_post_action 14:07:07 INFO - Running post-action listener: set_extra_try_arguments 14:07:07 INFO - ##### 14:07:07 INFO - ##### Finished download-and-extract step (success) 14:07:07 INFO - ##### 14:07:07 INFO - ##### 14:07:07 INFO - ##### Running populate-webroot step. 14:07:07 INFO - ##### 14:07:07 INFO - Running pre-action listener: _resource_record_pre_action 14:07:07 INFO - Running main action method: populate_webroot 14:07:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:07 INFO - '--tppagecycles', 14:07:07 INFO - '7'], 14:07:07 INFO - 'tests': ['tsvgm']}}, 14:07:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['damp', 'tps']}, 14:07:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'tests': ['damp', 'tps']}, 14:07:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['dromaeo_dom']}, 14:07:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['basic_compositor_video']}, 14:07:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:07:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['tsvgx', 14:07:07 INFO - 'tsvgr_opacity', 14:07:07 INFO - 'tart', 14:07:07 INFO - 'tscrollx', 14:07:07 INFO - 'cart']}, 14:07:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:07 INFO - 'tsvgr_opacity', 14:07:07 INFO - 'tart', 14:07:07 INFO - 'tscrollx', 14:07:07 INFO - 'cart']}, 14:07:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--disable-e10s'], 14:07:07 INFO - 'tests': ['tp5o']}, 14:07:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'tests': ['tp5o']}, 14:07:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--disable-e10s', 14:07:07 INFO - '--xperf_path', 14:07:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:07 INFO - 'tests': ['tp5n']}, 14:07:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--xperf_path', 14:07:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:07 INFO - 'tests': ['tp5n']}}, 14:07:07 INFO - 'talos.zip': {'path': '', 14:07:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:07 INFO - Running post-action listener: _resource_record_post_action 14:07:07 INFO - ##### 14:07:07 INFO - ##### Finished populate-webroot step (success) 14:07:07 INFO - ##### 14:07:07 INFO - ##### 14:07:07 INFO - ##### Running create-virtualenv step. 14:07:07 INFO - ##### 14:07:07 INFO - Running pre-action listener: _resource_record_pre_action 14:07:07 INFO - Running main action method: create_virtualenv 14:07:07 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:07:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:07 INFO - Using real prefix '/usr' 14:07:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:08 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:10 INFO - Installing pip.................done. 14:07:10 INFO - Return code: 0 14:07:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07: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', 'pip>=1.5'] in /builds/slave/test/build 14:07: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 pip>=1.5 14:07:10 INFO - Using env: {'DISPLAY': ':0', 14:07:10 INFO - 'HOME': '/home/cltbld', 14:07:10 INFO - 'LANG': 'en_US.UTF-8', 14:07:10 INFO - 'LANGUAGE': 'en_US:en', 14:07:10 INFO - 'LOGNAME': 'cltbld', 14:07:10 INFO - 'MAIL': '/var/mail/cltbld', 14:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:10 INFO - 'MOZ_NO_REMOTE': '1', 14:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:10 INFO - 'NO_EM_RESTART': '1', 14:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:10 INFO - 'PWD': '/builds/slave/test', 14:07:10 INFO - 'SHELL': '/bin/bash', 14:07:10 INFO - 'SHLVL': '1', 14:07:10 INFO - 'TERM': 'linux', 14:07:10 INFO - 'TMOUT': '86400', 14:07:10 INFO - 'USER': 'cltbld', 14:07:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:10 INFO - '_': '/tools/buildbot/bin/python'} 14:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:07:10 INFO - Cleaning up... 14:07:10 INFO - Return code: 0 14:07:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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', '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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:07: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 psutil>=3.1.1 14:07:10 INFO - Using env: {'DISPLAY': ':0', 14:07:10 INFO - 'HOME': '/home/cltbld', 14:07:10 INFO - 'LANG': 'en_US.UTF-8', 14:07:10 INFO - 'LANGUAGE': 'en_US:en', 14:07:10 INFO - 'LOGNAME': 'cltbld', 14:07:10 INFO - 'MAIL': '/var/mail/cltbld', 14:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:10 INFO - 'MOZ_NO_REMOTE': '1', 14:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:10 INFO - 'NO_EM_RESTART': '1', 14:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:10 INFO - 'PWD': '/builds/slave/test', 14:07:10 INFO - 'SHELL': '/bin/bash', 14:07:10 INFO - 'SHLVL': '1', 14:07:10 INFO - 'TERM': 'linux', 14:07:10 INFO - 'TMOUT': '86400', 14:07:10 INFO - 'USER': 'cltbld', 14:07:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:10 INFO - '_': '/tools/buildbot/bin/python'} 14:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:10 INFO - Downloading/unpacking psutil>=3.1.1 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:12 INFO - Installing collected packages: psutil 14:07:12 INFO - Running setup.py install for psutil 14:07:12 INFO - building 'psutil._psutil_linux' extension 14:07:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:07:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:07:12 INFO - building 'psutil._psutil_posix' extension 14:07:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:07:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:13 INFO - Successfully installed psutil 14:07:13 INFO - Cleaning up... 14:07:13 INFO - Return code: 0 14:07:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:13 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:13 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 14:07:13 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 14:07:13 INFO - Using env: {'DISPLAY': ':0', 14:07:13 INFO - 'HOME': '/home/cltbld', 14:07:13 INFO - 'LANG': 'en_US.UTF-8', 14:07:13 INFO - 'LANGUAGE': 'en_US:en', 14:07:13 INFO - 'LOGNAME': 'cltbld', 14:07:13 INFO - 'MAIL': '/var/mail/cltbld', 14:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:13 INFO - 'MOZ_NO_REMOTE': '1', 14:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:13 INFO - 'NO_EM_RESTART': '1', 14:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:13 INFO - 'PWD': '/builds/slave/test', 14:07:13 INFO - 'SHELL': '/bin/bash', 14:07:13 INFO - 'SHLVL': '1', 14:07:13 INFO - 'TERM': 'linux', 14:07:13 INFO - 'TMOUT': '86400', 14:07:13 INFO - 'USER': 'cltbld', 14:07:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:13 INFO - '_': '/tools/buildbot/bin/python'} 14:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:07:15 INFO - Installing collected packages: mozsystemmonitor 14:07:15 INFO - Running setup.py install for mozsystemmonitor 14:07:15 INFO - Successfully installed mozsystemmonitor 14:07:15 INFO - Cleaning up... 14:07:15 INFO - Return code: 0 14:07:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:15 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:15 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 14:07:15 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 14:07:15 INFO - Using env: {'DISPLAY': ':0', 14:07:15 INFO - 'HOME': '/home/cltbld', 14:07:15 INFO - 'LANG': 'en_US.UTF-8', 14:07:15 INFO - 'LANGUAGE': 'en_US:en', 14:07:15 INFO - 'LOGNAME': 'cltbld', 14:07:15 INFO - 'MAIL': '/var/mail/cltbld', 14:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:15 INFO - 'MOZ_NO_REMOTE': '1', 14:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:15 INFO - 'NO_EM_RESTART': '1', 14:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:15 INFO - 'PWD': '/builds/slave/test', 14:07:15 INFO - 'SHELL': '/bin/bash', 14:07:15 INFO - 'SHLVL': '1', 14:07:15 INFO - 'TERM': 'linux', 14:07:15 INFO - 'TMOUT': '86400', 14:07:15 INFO - 'USER': 'cltbld', 14:07:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:15 INFO - '_': '/tools/buildbot/bin/python'} 14:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:15 INFO - Downloading/unpacking jsonschema==2.5.1 14:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:17 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:17 INFO - warning: no files found matching '*.txt' 14:07:17 INFO - no previously-included directories found matching 'build' 14:07:17 INFO - no previously-included directories found matching 'dist' 14:07:17 INFO - no previously-included directories found matching '.git*' 14:07:17 INFO - Installing collected packages: jsonschema, functools32 14:07:17 INFO - Running setup.py install for functools32 14:07:18 INFO - warning: no files found matching '*.txt' 14:07:18 INFO - no previously-included directories found matching 'build' 14:07:18 INFO - no previously-included directories found matching 'dist' 14:07:18 INFO - no previously-included directories found matching '.git*' 14:07:18 INFO - Successfully installed jsonschema functools32 14:07:18 INFO - Cleaning up... 14:07:18 INFO - Return code: 0 14:07:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:18 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:07:18 INFO - Using env: {'DISPLAY': ':0', 14:07:18 INFO - 'HOME': '/home/cltbld', 14:07:18 INFO - 'LANG': 'en_US.UTF-8', 14:07:18 INFO - 'LANGUAGE': 'en_US:en', 14:07:18 INFO - 'LOGNAME': 'cltbld', 14:07:18 INFO - 'MAIL': '/var/mail/cltbld', 14:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:18 INFO - 'MOZ_NO_REMOTE': '1', 14:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:18 INFO - 'NO_EM_RESTART': '1', 14:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:18 INFO - 'PWD': '/builds/slave/test', 14:07:18 INFO - 'SHELL': '/bin/bash', 14:07:18 INFO - 'SHLVL': '1', 14:07:18 INFO - 'TERM': 'linux', 14:07:18 INFO - 'TMOUT': '86400', 14:07:18 INFO - 'USER': 'cltbld', 14:07:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:18 INFO - '_': '/tools/buildbot/bin/python'} 14:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:18 INFO - Downloading/unpacking blobuploader==1.2.4 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:20 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:20 INFO - Downloading docopt-0.6.1.tar.gz 14:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:21 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:21 INFO - Running setup.py install for blobuploader 14:07:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:21 INFO - Running setup.py install for requests 14:07:21 INFO - Running setup.py install for docopt 14:07:21 INFO - Successfully installed blobuploader requests docopt 14:07:21 INFO - Cleaning up... 14:07:21 INFO - Return code: 0 14:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:21 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:21 INFO - Using env: {'DISPLAY': ':0', 14:07:21 INFO - 'HOME': '/home/cltbld', 14:07:21 INFO - 'LANG': 'en_US.UTF-8', 14:07:21 INFO - 'LANGUAGE': 'en_US:en', 14:07:21 INFO - 'LOGNAME': 'cltbld', 14:07:21 INFO - 'MAIL': '/var/mail/cltbld', 14:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:21 INFO - 'MOZ_NO_REMOTE': '1', 14:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:21 INFO - 'NO_EM_RESTART': '1', 14:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:21 INFO - 'PWD': '/builds/slave/test', 14:07:21 INFO - 'SHELL': '/bin/bash', 14:07:21 INFO - 'SHLVL': '1', 14:07:21 INFO - 'TERM': 'linux', 14:07:21 INFO - 'TMOUT': '86400', 14:07:21 INFO - 'USER': 'cltbld', 14:07:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:21 INFO - '_': '/tools/buildbot/bin/python'} 14:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:21 INFO - Running setup.py (path:/tmp/pip-xPY93R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:21 INFO - Running setup.py (path:/tmp/pip-OvXqck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:21 INFO - Running setup.py (path:/tmp/pip-4qAABg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:22 INFO - Running setup.py (path:/tmp/pip-12mIuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:22 INFO - Running setup.py (path:/tmp/pip-LQISdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:22 INFO - Running setup.py (path:/tmp/pip-iSx6zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:22 INFO - Running setup.py (path:/tmp/pip-pLThb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:22 INFO - Running setup.py (path:/tmp/pip-KmsA_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:22 INFO - Running setup.py (path:/tmp/pip-UoUFcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:22 INFO - Running setup.py (path:/tmp/pip-KSwRat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:22 INFO - Running setup.py (path:/tmp/pip-H86WiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:22 INFO - Running setup.py (path:/tmp/pip-usA9Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:22 INFO - Running setup.py (path:/tmp/pip-EwPEH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:22 INFO - Running setup.py (path:/tmp/pip-l3QAdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:22 INFO - Running setup.py (path:/tmp/pip-XUj1ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:22 INFO - Running setup.py (path:/tmp/pip-zdQTlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:22 INFO - Running setup.py (path:/tmp/pip-9mKLvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:23 INFO - Running setup.py install for manifestparser 14:07:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Running setup.py install for mozcrash 14:07:23 INFO - Running setup.py install for mozdebug 14:07:23 INFO - Running setup.py install for mozdevice 14:07:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Running setup.py install for mozfile 14:07:23 INFO - Running setup.py install for mozhttpd 14:07:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Running setup.py install for mozinfo 14:07:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Running setup.py install for mozInstall 14:07:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:07:23 INFO - Running setup.py install for mozleak 14:07:23 INFO - Running setup.py install for mozlog 14:07:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:07:24 INFO - Running setup.py install for moznetwork 14:07:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:07:24 INFO - Running setup.py install for mozprocess 14:07:24 INFO - Running setup.py install for mozprofile 14:07:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:07:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:07:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:07:24 INFO - Running setup.py install for mozrunner 14:07:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:07:24 INFO - Running setup.py install for mozscreenshot 14:07:24 INFO - Running setup.py install for moztest 14:07:24 INFO - Running setup.py install for mozversion 14:07:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:07:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:24 INFO - Cleaning up... 14:07:24 INFO - Return code: 0 14:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:24 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:24 INFO - Using env: {'DISPLAY': ':0', 14:07:24 INFO - 'HOME': '/home/cltbld', 14:07:24 INFO - 'LANG': 'en_US.UTF-8', 14:07:24 INFO - 'LANGUAGE': 'en_US:en', 14:07:24 INFO - 'LOGNAME': 'cltbld', 14:07:24 INFO - 'MAIL': '/var/mail/cltbld', 14:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:24 INFO - 'MOZ_NO_REMOTE': '1', 14:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:24 INFO - 'NO_EM_RESTART': '1', 14:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:24 INFO - 'PWD': '/builds/slave/test', 14:07:24 INFO - 'SHELL': '/bin/bash', 14:07:24 INFO - 'SHLVL': '1', 14:07:24 INFO - 'TERM': 'linux', 14:07:24 INFO - 'TMOUT': '86400', 14:07:24 INFO - 'USER': 'cltbld', 14:07:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:24 INFO - '_': '/tools/buildbot/bin/python'} 14:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:25 INFO - Running setup.py (path:/tmp/pip-7YPa3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:25 INFO - Running setup.py (path:/tmp/pip-MT9hyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:25 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)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:25 INFO - Running setup.py (path:/tmp/pip-SWsGxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:25 INFO - Running setup.py (path:/tmp/pip-9ywMgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:25 INFO - Running setup.py (path:/tmp/pip-1S4KRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:25 INFO - Running setup.py (path:/tmp/pip-YxCCSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:25 INFO - Running setup.py (path:/tmp/pip-_4cxpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:25 INFO - Running setup.py (path:/tmp/pip-aiODH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:25 INFO - Running setup.py (path:/tmp/pip-A9VM2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:25 INFO - Running setup.py (path:/tmp/pip-E20lL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:25 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)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:25 INFO - Running setup.py (path:/tmp/pip-h3g3eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:25 INFO - Running setup.py (path:/tmp/pip-i1HPpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:25 INFO - Running setup.py (path:/tmp/pip-KXSyO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:25 INFO - Running setup.py (path:/tmp/pip-QzL1_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:26 INFO - Running setup.py (path:/tmp/pip-HGa8xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:26 INFO - Running setup.py (path:/tmp/pip-0cJkME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:26 INFO - Running setup.py (path:/tmp/pip-ifyu10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:07:26 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)) 14:07:26 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)) 14:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:28 INFO - Downloading blessings-1.6.tar.gz 14:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:28 INFO - Installing collected packages: blessings 14:07:28 INFO - Running setup.py install for blessings 14:07:28 INFO - Successfully installed blessings 14:07:28 INFO - Cleaning up... 14:07:28 INFO - Return code: 0 14:07:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:28 INFO - Reading from file tmpfile_stdout 14:07:28 INFO - Current package versions: 14:07:28 INFO - argparse == 1.2.1 14:07:28 INFO - blessings == 1.6 14:07:28 INFO - blobuploader == 1.2.4 14:07:28 INFO - docopt == 0.6.1 14:07:28 INFO - functools32 == 3.2.3-2 14:07:28 INFO - jsonschema == 2.5.1 14:07:28 INFO - manifestparser == 1.1 14:07:28 INFO - mozInstall == 1.12 14:07:28 INFO - mozcrash == 0.17 14:07:28 INFO - mozdebug == 0.1 14:07:28 INFO - mozdevice == 0.48 14:07:28 INFO - mozfile == 1.2 14:07:28 INFO - mozhttpd == 0.7 14:07:28 INFO - mozinfo == 0.9 14:07:28 INFO - mozleak == 0.1 14:07:28 INFO - mozlog == 3.2 14:07:28 INFO - moznetwork == 0.27 14:07:28 INFO - mozprocess == 0.22 14:07:28 INFO - mozprofile == 0.28 14:07:28 INFO - mozrunner == 6.11 14:07:28 INFO - mozscreenshot == 0.1 14:07:28 INFO - mozsystemmonitor == 0.3 14:07:28 INFO - moztest == 0.7 14:07:28 INFO - mozversion == 1.4 14:07:28 INFO - psutil == 3.1.1 14:07:28 INFO - requests == 1.2.3 14:07:28 INFO - wsgiref == 0.1.2 14:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:28 INFO - Using env: {'DISPLAY': ':0', 14:07:28 INFO - 'HOME': '/home/cltbld', 14:07:28 INFO - 'LANG': 'en_US.UTF-8', 14:07:28 INFO - 'LANGUAGE': 'en_US:en', 14:07:28 INFO - 'LOGNAME': 'cltbld', 14:07:28 INFO - 'MAIL': '/var/mail/cltbld', 14:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:28 INFO - 'MOZ_NO_REMOTE': '1', 14:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:28 INFO - 'NO_EM_RESTART': '1', 14:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:28 INFO - 'PWD': '/builds/slave/test', 14:07:28 INFO - 'SHELL': '/bin/bash', 14:07:28 INFO - 'SHLVL': '1', 14:07:28 INFO - 'TERM': 'linux', 14:07:28 INFO - 'TMOUT': '86400', 14:07:28 INFO - 'USER': 'cltbld', 14:07:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:28 INFO - '_': '/tools/buildbot/bin/python'} 14:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:28 INFO - Cleaning up... 14:07:28 INFO - Return code: 0 14:07:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:07:28 INFO - Using env: {'DISPLAY': ':0', 14:07:28 INFO - 'HOME': '/home/cltbld', 14:07:28 INFO - 'LANG': 'en_US.UTF-8', 14:07:28 INFO - 'LANGUAGE': 'en_US:en', 14:07:28 INFO - 'LOGNAME': 'cltbld', 14:07:28 INFO - 'MAIL': '/var/mail/cltbld', 14:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:28 INFO - 'MOZ_NO_REMOTE': '1', 14:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:28 INFO - 'NO_EM_RESTART': '1', 14:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:28 INFO - 'PWD': '/builds/slave/test', 14:07:28 INFO - 'SHELL': '/bin/bash', 14:07:28 INFO - 'SHLVL': '1', 14:07:28 INFO - 'TERM': 'linux', 14:07:28 INFO - 'TMOUT': '86400', 14:07:28 INFO - 'USER': 'cltbld', 14:07:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:28 INFO - '_': '/tools/buildbot/bin/python'} 14:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:07:29 INFO - Cleaning up... 14:07:29 INFO - Return code: 0 14:07:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:29 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 0x7f4edef1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f2c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, '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': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:07:29 INFO - Using env: {'DISPLAY': ':0', 14:07:29 INFO - 'HOME': '/home/cltbld', 14:07:29 INFO - 'LANG': 'en_US.UTF-8', 14:07:29 INFO - 'LANGUAGE': 'en_US:en', 14:07:29 INFO - 'LOGNAME': 'cltbld', 14:07:29 INFO - 'MAIL': '/var/mail/cltbld', 14:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:29 INFO - 'MOZ_NO_REMOTE': '1', 14:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:29 INFO - 'NO_EM_RESTART': '1', 14:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:29 INFO - 'PWD': '/builds/slave/test', 14:07:29 INFO - 'SHELL': '/bin/bash', 14:07:29 INFO - 'SHLVL': '1', 14:07:29 INFO - 'TERM': 'linux', 14:07:29 INFO - 'TMOUT': '86400', 14:07:29 INFO - 'USER': 'cltbld', 14:07:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:29 INFO - '_': '/tools/buildbot/bin/python'} 14:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:29 INFO - Downloading/unpacking flake8 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:07:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:07:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:31 INFO - no previously-included directories found matching 'docs/_build' 14:07:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:07:31 INFO - Running setup.py install for pep8 14:07:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:32 INFO - no previously-included directories found matching 'docs/_build' 14:07:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:07:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:07:32 INFO - Cleaning up... 14:07:32 INFO - Return code: 0 14:07:32 INFO - Running post-action listener: _resource_record_post_action 14:07:32 INFO - Running post-action listener: _start_resource_monitoring 14:07:32 INFO - Starting resource monitoring. 14:07:32 INFO - ##### 14:07:32 INFO - ##### Finished create-virtualenv step (success) 14:07:32 INFO - ##### 14:07:32 INFO - ##### 14:07:32 INFO - ##### Running install step. 14:07:32 INFO - ##### 14:07:32 INFO - Running pre-action listener: _resource_record_pre_action 14:07:32 INFO - Running main action method: install 14:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:32 INFO - Reading from file tmpfile_stdout 14:07:32 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:32 INFO - Reading from file tmpfile_stdout 14:07:32 INFO - Output received: 14:07:32 INFO - Usage: mozinstall [options] installer 14:07:32 INFO - Options: 14:07:32 INFO - -h, --help show this help message and exit 14:07:32 INFO - -d DEST, --destination=DEST 14:07:32 INFO - Directory to install application into. [default: 14:07:32 INFO - "/builds/slave/test"] 14:07:32 INFO - --app=APP Application being installed. [default: firefox] 14:07:32 INFO - mkdir: /builds/slave/test/build/application 14:07:32 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'] 14:07:32 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 14:07:49 INFO - Reading from file tmpfile_stdout 14:07:49 INFO - Output received: 14:07:49 INFO - /builds/slave/test/build/application/firefox/firefox 14:07:49 INFO - Running post-action listener: _resource_record_post_action 14:07:49 INFO - ##### 14:07:49 INFO - ##### Finished install step (success) 14:07:49 INFO - ##### 14:07:49 INFO - ##### 14:07:49 INFO - ##### Running run-tests step. 14:07:49 INFO - ##### 14:07:49 INFO - Running pre-action listener: _resource_record_pre_action 14:07:49 INFO - Running main action method: run_tests 14:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:49 INFO - Python 2.7.3 14:07:49 INFO - Return code: 0 14:07:49 INFO - grabbing minidump binary from tooltool 14:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:49 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 0x1482710>, '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 0x1483610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:07:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:07:49 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 14:07:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:49 INFO - Return code: 0 14:07:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:07:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:07:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:07:50 INFO - Return code: 0 14:07:50 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:07:50 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:07:50 INFO - Using env: {'DISPLAY': ':0', 14:07:50 INFO - 'HOME': '/home/cltbld', 14:07:50 INFO - 'LANG': 'en_US.UTF-8', 14:07:50 INFO - 'LANGUAGE': 'en_US:en', 14:07:50 INFO - 'LOGNAME': 'cltbld', 14:07:50 INFO - 'MAIL': '/var/mail/cltbld', 14:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:50 INFO - 'MOZ_NO_REMOTE': '1', 14:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:50 INFO - 'NO_EM_RESTART': '1', 14:07:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:50 INFO - 'PWD': '/builds/slave/test', 14:07:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:50 INFO - 'SHELL': '/bin/bash', 14:07:50 INFO - 'SHLVL': '1', 14:07:50 INFO - 'TERM': 'linux', 14:07:50 INFO - 'TMOUT': '86400', 14:07:50 INFO - 'USER': 'cltbld', 14:07:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923', 14:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:50 INFO - '_': '/tools/buildbot/bin/python'} 14:07:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:07:50 INFO - mozversion application_buildid: 20160627113032 14:07:50 INFO - mozversion application_changeset: d095e848a601937d9e7daedfd7e4e6f0199706e2 14:07:50 INFO - mozversion application_display_name: Nightly 14:07:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:50 INFO - mozversion application_name: Firefox 14:07:50 INFO - mozversion application_remotingname: firefox 14:07:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:07:50 INFO - mozversion application_vendor: Mozilla 14:07:50 INFO - mozversion application_version: 50.0a1 14:07:50 INFO - mozversion platform_buildid: 20160627113032 14:07:50 INFO - mozversion platform_changeset: d095e848a601937d9e7daedfd7e4e6f0199706e2 14:07:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:07:50 INFO - mozversion platform_version: 50.0a1 14:07:50 INFO - using testdate: 1467061670 14:07:50 INFO - actual date: 1467061670 14:07:50 INFO - starting webserver on 'localhost:60686' 14:07:50 INFO - SUITE-START | Running 2 tests 14:07:50 INFO - TEST-START | dromaeo_css 14:07:50 INFO - operating with platform_type : linux_ 14:07:50 INFO - Initialising browser for dromaeo_css test... 14:07:50 INFO - TEST-INFO | started process 4321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08uDWw/profile http://localhost:60686/getInfo.html) 14:07:55 INFO - PROCESS | 4321 | __metrics Screen width/height:1600/1200 14:07:55 INFO - PROCESS | 4321 | colorDepth:24 14:07:55 INFO - PROCESS | 4321 | Browser inner width/height: 1024/697 14:07:55 INFO - PROCESS | 4321 | __metrics 14:07:56 ERROR - PROCESS | 4321 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:07:57 INFO - TEST-INFO | 4321: exit 0 14:07:57 INFO - Browser initialized. 14:07:57 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:57 INFO - TEST-INFO | started process 4440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08uDWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:09 INFO - PROCESS | 4440 | RSS: Main: 184913920 14:08:09 INFO - PROCESS | 4440 | 14:08:58 INFO - PROCESS | 4440 | 1467061738724 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] 14:11:06 INFO - PROCESS | 4440 | Cycle 1(1): loaded http://localhost:60686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60686/tests/dromaeo/cssquery-ext.html) 14:11:07 INFO - PROCESS | 4440 | RSS: Main: 187613184 14:11:07 INFO - PROCESS | 4440 | 14:14:09 INFO - PROCESS | 4440 | Cycle 1(1): loaded http://localhost:60686/tests/dromaeo/cssquery-ext.html (next: http://localhost:60686/tests/dromaeo/cssquery-jquery.html) 14:14:10 INFO - PROCESS | 4440 | RSS: Main: 187211776 14:14:10 INFO - PROCESS | 4440 | 14:17:12 INFO - PROCESS | 4440 | Cycle 1(1): loaded http://localhost:60686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60686/tests/dromaeo/cssquery-mootools.html) 14:17:12 INFO - PROCESS | 4440 | RSS: Main: 189042688 14:17:12 INFO - PROCESS | 4440 | 14:20:14 INFO - PROCESS | 4440 | Cycle 1(1): loaded http://localhost:60686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60686/tests/dromaeo/cssquery-prototype.html) 14:20:15 INFO - PROCESS | 4440 | RSS: Main: 186003456 14:20:15 INFO - PROCESS | 4440 | 14:23:17 INFO - PROCESS | 4440 | Cycle 1(1): loaded http://localhost:60686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60686/tests/dromaeo/cssquery-yui.html) 14:23:18 INFO - PROCESS | 4440 | RSS: Main: 188530688 14:23:18 INFO - PROCESS | 4440 | 14:26:20 INFO - PROCESS | 4440 | Cycle 1(1): loaded http://localhost:60686/tests/dromaeo/cssquery-yui.html (next: http://localhost:60686/tests/dromaeo/cssquery-dojo.html) 14:26:21 INFO - PROCESS | 4440 | RSS: Main: 189693952 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | __start_tp_report 14:26:21 INFO - PROCESS | 4440 | _x_x_mozilla_page_load 14:26:21 INFO - PROCESS | 4440 | _x_x_mozilla_page_load_details 14:26:21 INFO - PROCESS | 4440 | |i|pagename|runs| 14:26:21 INFO - PROCESS | 4440 | |0;dojo.html;3079.5380692896065;3109.518024706171;3117.1427857339227;3151.7636177286695;3155.573997510337;5375;5392.4877136672;5458.918116228259;5483.698396588186;5502.532284755791;5465.480779325968;5483.040467918118;5486.753096110675;5498.505134537891;5560.944390556093;4878.902421951559;4936.333594964688;5015.348004759376;5056.696598204101;5142.460041695625;683.8236114364756;4852.830150944717;4923.113839508887;4961.627877909171;5045.84862454127;4935.35840340757;4942.481039490855;4948.529889660476;4952.232403977389;4965.155923492996;4986.551210391082;4992.201247800334;5011.498850114996;5011.599072074262;5027.49725027498;4957.5042495750495;4971.154903666349;4990.525900039491;5008.499150084999;5010.974945125251;5458.972705136489;5500.58745594078;5512.889742205173;5547.8890422191735;5583.609147359686;5743.138529220609;5884.588078834483;5947.851303717398;5955.047192449188;5958.672273024982;5931.495822855062;5962.1951036609935;5977.22296101504;5989.460948514655;6062.848428789272;5563.415841336642;5571.052921003398;5580.553555715533;5581.49766521015;5590.91613625796;5908.911366329508;5980.581359304894;5992.280926288873;6103.206583144163;6107.114468402056;5733.111367738007;5741.19623252745;5771.105478650816;5793.275840519935;5813.273340832396;5903.2325797646035;5904.350521442638;5906.5570082244;5907.261592300963;5926.407359264039;5816.767329306865;5831.650100993954;5833.183354330397;5872.941270587325;5885.735141918538;5830.679312637761;5889.116632505158;5892.6759028253;5899.321578018583;5907.2911250650195;4390.780460976938;4398.868033958986;4460.598546130864;4461.442319710036;4503.392042074343;3895.2988462077096;3968.8412463501713;3971.7418367806;4019.196160767858;4027.4764280643913;5534.059209934321;5596.860078497989;5634.464725851038;5638.746256418471;5678.858028549319;5817;5991.730372133265;5992.730327135289;6004.309504407049;6007.189029481052;5571.860703482445;5626.634268772598;5663.575231857545;5669.829905102853;5680.233168522197;4939.185034469344;4987.775550100254;4992.276119962585;5001.599872010231;5007.774650140753;6011.398860114041;6097.146399504073;6170;6196.194494715658;6203.038529028008;5914.290285165722;6002.579819412774;6003.519718422428;6007.309159446545;6027.306859711014;6181.96909015452;6188.752449901954;6206.689665516616;6211.503079753699;6224.657643829632;5726.370099288992;5742.913856292243;5770.682612456355;5878.2358293421585;5884.882302354014;5888.852778680567;5911.261092363455;5919.792807251725;5921.2006379138265;5926.881462370815;5626.352969408406;5700;5740.6268592541355;5745.712714364348;5760.654360738369;5573.693446860461;5741.827745167651;5771.105478650816;5793.102069179284;5810.273715785527;5639.295088113986;5670.546356291569;5683.77264909399;5726.4273572642405;5756.94243057564;5826.73779679907;5865.5600829937075;5868.061110222344;5877.089051197071;5884.499817515559;5609.775608975595;5617.859553511195;5622.24099746529;5632.971835140962;5711.828645140652 14:26:21 INFO - PROCESS | 4440 | |1;ext.html;562.9690367029814;608.4098424528208;613.5521069619178;635.5836926812938;639.5906619763349;40894.79552602237;41645.167096658086;44261.7786911065;44690.553094469;45057;45501.54498455014;46175.76912115435;46417;46487;46582.301265481045;9023.774405639862;9174.678886238982;9181.540922953858;9184.8622270666;9191.632334706605;8997.145271199259;9053.547322633875;9057.411268267575;9058.048904864992;9058.23005044572;9118.316126290521;9175.54122293886;9190.770230744218;9202.217811486033;9215.907840921605;9078.092190780902;9106.271498280188;9129.95435022824;9177.082291770803;9178.586963586587;8934.64261429542;8969.910300896972;9043.728688139367;9048.140426659456;9050.592723327467;43224.351634725506;43587;43638;43689.56310436887;43750.562494374964;2977.702229777027;3253.6746325367512;3376.679215474526;3562.4834399012257;3930.587288334741;32362;32710.83644581762;33114.834425827954;33168.50247246293;33732.14473203973;4155.31437312843;4164.6251837334485;4201.34879093741;4207.936880946788;4233.195692818385;325261;326136;326249;327089;327202;34593.30813383769;35530.46704299437;35593.288134237686;35720;35776.46335304972;37116.81441592775;37148.257034859154;37349.253014939546;37369.62630373716;37444.43833342502;12980.935095324463;13081.869181308066;13128.34358282082;13129.67175820593;13148.539801107107;10406.635767748092;10441.373517588969;10445.059944605022;10458.895411045944;10472.424016679004;8453.408261421764;8468.32253419725;8491.320694344438;8537.445066070686;8591.269742071994;3280.671932806748;3291.4569096098876;3311.288073064303;3333.1833700743473;3334.3664703706218;953.4041224234853;972.2416515118077;1076.5855145768935;1089.782043591285;1143.8112711402691;31514.212144696565;32047.359052818814;32279;32784;32933.17667058295;1012.8531362952331;1103.939283339408;1127.8928501792316;1155.156735583029;1159.6173262823247;16579.50261492157;16738.832611673726;17082.316707331815;17083.231254593575;17174.39889603858;649830;651547;651762;653090;658677;59011;59461;59588.80822383528;59871;59971.40028599746;1297.941592628334;1300.7138429545485;1343.516334119716;1350.3450826349213;1357.0229434806922;30834.53748193734;31332.530012050294;31365.529517056806;31514.212144695648;31994.6800532001;52396.738016309675;52593;52848;52952.73523632357;53089.469105309996;450805;457237;461581;461987;463424;29223.85388073046;29270.7072929268;29508;29585.2603684901;29686.55470167906;49145.262821057;49922.500774991786;50931.745341273054;51038.74480627573;51781.22328165156;42024.789876050425;42161.36757948572;43026.78486607547;43062.78468607637;44499;42183;42296.788516057226;42477.36283955805;42657.5734242666;44013.33979990239;40974.59025409827;42096.57903421049;42183.36724949067;42291.3656295162;42414;37016.25967480689;37736;37939;38891.22217555576;39609.2078158441;28489.28776780597;28540.857295713387;29279.121626351243;29619.555706664847;29697.257568560093 14:26:21 INFO - PROCESS | 4440 | |2;jquery.html;379.13557089835166;380.2243423416231;385.837948061814;388.37665546797405;401.55226921981983;18850.34023809167;19582;19799.802001979977;20283;20283.08726107325;16988.320467181296;17137.314507419687;17317.82682173178;17348.47954561362;17691.911540442314;5335.893282134355;5394.352677678665;5577.247071645337;5597.132444471114;5628.043232650439;5532.3637781655225;5589.608727389084;5600.887982240352;5617.21359009739;5643.8024669136585;5383.919241211385;5561.63849349791;5590.776368945238;5595.776168953257;5599.468050535193;5568.610197286192;5589.664620122806;5622.662640241599;5628.409017053192;5630.915536266939;4905.5094490550655;4945.901081978341;4968.30443737877;4998.275250088753;5034.09386310464;22738;23013.654795178085;23068.307950761504;23123.884380578158;23162.76837231623;2545.7963362931105;2719.333763228002;2761;3073.6618971913294;3087.768417368684;14298.142111473346;14426.134431934117;14637.926810365987;14810.851891481163;14899.255037248202;1865.4496923407628;1950.7268982342484;1997.9001049947444;1998.9600207995904;2011.2730613562348;65732.67133664349;73403.63298183474;73570.63214683946;78261.60869195675;81773;8961.59672814725;9444.763880902896;9660.420374777395;9775.804483910282;10157.39055656663;12857.485700571873;12981.870181298065;12996.220226786234;13029;13050.934745326402;7093;7099.183593886769;7263;7284.235155308722;7298.927010729824;7083.82290442743;7091.716331346688;7174.677139528734;7188.4968052235845;7210.603416812126;3999.440078389028;4044.7168698190844;4085.55058943516;4105.137921036616;4137.172565486914;1916.3867562380183;1941.3108346537058;1970.389179354376;1974.871633343828;2010.0753653319637;768.5119948832531;890.2566357091771;922.8246633139682;981.3326937682302;1001.5042553935702;18398.908005459885;19805.702914456295;19832;19871.701924471145;19885.204591816455;872.5986046418592;873.930085593151;903.2864037410372;917.605429665237;941.9387739796891;10310.948445257876;11032.834507482394;11142.108631309638;11202.831957520644;11286.604968826052;458872;468084;470601;481360;488935;92738.53630731939;98277.50861245791;98829;98949.50525247327;99589.50205249072;934.1872570863393;936.489613160829;962.6197651927589;967.298708436378;989.7674046599044;17274.136293185038;17304.65390692204;17426.82573174252;17592.120393980505;17678.381256655954;42076.78961605173;42656.14687706166;43413.565864340955;44064.339034915145;44252;58688.413115870004;61545;61944.69027654833;62290.377096228454;62718;8594.613242404232;8773.078826723102;8850.822983540422;8894.822103558023;8946.37375383717;10326.586936522455;13783.862161378658;14112.858871411565;14201.147931124166;14279.286035698382;11802.58690945847;11974.700632484257;12076.396180191132;12104.636860894187;12117.515299387926;12013.975318268478;12053.51785928553;12076.335801531;12184.51261949512;12253.509859605516;12188.756224875275;12415.44130514147;12496.187747796364;12681.23912565249;12748.61754147377;8718.60766265507;8740.868886966573;8931.553422328987;9044.50255235942;9269.119433653792;11960.58137965167;12499.687507812378;12548.874511254771;12571.559995400117;12652.30412327294 14:26:21 INFO - PROCESS | 4440 | |3;mootools.html;1442.7619442791936;1488.523672424824;1577.8974366666166;1747.2050217151198;1757.4727581725488;8106.959465202665;8694.956525217365;8914.598843052063;9538.713838584845;9557.900841403241;8628.525431101303;8842.469451832894;8936.776580585472;9073.682421115262;9080.72757817265;2331.5919714050015;2385.725641551218;2391.2109004028716;2396.8082553395775;2399.7360290368047;2332.265336419023;2374.2402431222017;2380.3929997850523;2392.473655795722;2408.3256688127353;2344.6834677318516;2358.79950204232;2369.07606033647;2398.2085911649115;2405.530921470314;2281.897314620846;2296.0930432479076;2316.6061769499224;2316.791488766011;2328.883555822202;2298.908043678251;2306.6194077977116;2312.063614236237;2313.664518644804;2314.826388020905;9112.453252804853;9125.494293441574;9198.218151457135;9200.217981471584;9203.769905752342;5015.32293140425;5196;5203.115470370046;5214.765335559909;5236.764345604457;3356.2616224430585;3373.751711866625;3525.665061819123;3529.7882127072203;3550.520679708258;1231.3043130631165;1242.105683907585;1245.8068999305121;1261.6215135459418;1269.2701696524443;12882.549110781172;13112.344382780822;13149;13214.933925330408;13232.338383080903;4682.742449165328;4770.833020844254;4780.11567859947;4804.639652026112;4817.879553011203;11000.064994475399;11068.335899846035;11069.169812264112;11092.889071109346;11149.05233055183;5190.351206099238;5208;5221.425643179247;5251.422343542207;5264.078786212397;4216.915661686749;4758.16732071893;4785.712857228577;4840.273958906192;4933.605311575066;4057.776822274803;4150.398192262165;4159.625633692982;4184.644305234028;4197.412362269285;1281.423359488234;1298.3313593499356;1316.6115995781267;1320.2672516753294;1328.6877583767807;968.1818863060703;990.8166989106894;994.0953732103751;1002.6209386640766;1002.7593377589326;6142.692865356715;6164.229471316085;6199.752009919553;6350.4284614384005;6387.936120638827;461.21823509152335;476.3902205177379;478.5358202543527;487.0575436530325;491.15766460520376;4281.400603915455;4314.094040251583;4320.4599425071865;4356.912861742748;4367.803448844809;11041.889581104248;11401.201915865975;11466.713332166762;11484.94257528707;11507.136964727679;10698.251122421356;11136.109111271078;11139.10887129044;11396.430178491042;11428;8181.100078991306;8402.957985210034;8448.366372522085;8450.028246751579;8480.491170529665;6099.817005489843;6322.49420046386;6372.808815735535;6387.073874288295;6473.061406096184;10411.323263987817;10587.947060264649;10612.310199836986;10763.246572740147;10775.08411785007;10749.731256718645;10754.677359679223;10806.675799726021;10843.67468975932;10860.076893464144;7375.668094935848;7872.212778722082;7984.6406911687955;8107.756767296991;8138;8995.280377569648;9082.954585227031;9085.22775564058;9103.362764606414;9151.542422878696;7973.362131029619;8197.549134797406;8205.425620206766;8231.259186672989;8267.710630127916;7989.400794940287;8030.357571394391;8067.94686816703;8097.676092956452;8123.0658474276215;7254.5647261164495;7325.597092159983;7382.224866388952;7530.887036694345;7566.508176968479;5183.533481986639;5251.868703282448;5262.236975638434;5273.235380869675;5354.759035843318;5302.628815982998;5321.627486075938;5398.64908780928;5497.257870187474;5618.494335509824 14:26:21 INFO - PROCESS | 4440 | |4;prototype.html;327.4171973886482;328.6155198417851;331.2943430493049;332.41494968854806;333.9499075138729;5559.749811258488;5566.495077215249;5613;5616.382197958222;5625.718714064295;5566.274454918978;5571.609987300881;5576.442355764421;5590.496855283024;5608.551315894729;4153.608541138722;4170.64549513291;4281.293586558214;4309.396684464177;4327.826886924519;4266.189424009443;4308.590683885026;4314.71954322968;4322.891927701801;4326.805293761772;4288.656907447396;4291.163223171483;4294.4202532658;4295.849645262417;4300.161468513641;3986.5614782373914;4206.116715489751;4232.492100947875;4242.024334403104;4309.719868208556;3677.3748462761396;3704.1480459494196;3706.388445906422;3723.2739615774935;3735.962640373589;5409.675419474844;5427.158790387496;5433.77215341712;5482.945170548283;5529.751161197756;4633.837815676469;4870.951290487085;4900.901981960341;4905.4358748744;4920.901581968341;5773.538116950634;5836.795712150054;5842.532597392198;5845.152452894349;5848.181254624356;4129.339305711102;4132.380142978547;4132.896677583054;4140.254754144253;4141.5918587680035;5875.471207591295;5890.263717035371;5948.31594366649;6008.738164985359;6009.978303688384;4106.609872062149;4124.340105583093;4133.46264985556;4174.248635245624;4179.373094035858;4217.7891105445215;4227.450431443893;4230.090530535949;4234.9576504234565;4239.130978149472;4709.929351059737;4865.635077369211;4872.80508779652;4902.166631672624;4920.3111564381015;5811.472009675805;5813.476787089182;5837.357890632027;5856.882862342729;5904.852378690482;1462.817147856518;1471.9558413247619;1472.0578829549097;1472.5655931500232;1484.665950161205;940.2431043010442;946.2855544064325;946.9668561600449;951.1962391778935;989.4211886046743;5468.890622187534;5494.697791621419;5504.559635229172;5523.309586301712;5531.751071201806;5870.55970802183;5886.3230728465915;5886.352501224862;5902.527797776168;5912.438318359749;5279.41926388097;5440.673559586358;5513.912209162801;5550.250716153268;5551.9722401387735;3119.313750974782;3130.593022907053;3153.952690709641;3156.8004158420113;3163.6678148794504;5835.44563266489;6056.848578785565;6057.3336932937345;6076.240469941257;6099.573029887865;5999.910001349983;6024.186734790835;6030.005049166926;6037.366076561985;6040.728167232485;6040.607360521552;6050.668852852454;6076.605020673731;6122.724477398528;6123.326434092246;5669.943300567106;5913.51102849321;5934.851628709317;5941.752232031322;5951.7619295227705;5831.4168583141345;5868.5305175585;5940.1487286103775;5961.850953726018;5962.2249107615735;5840.532757379485;6052.727627256696;6055.394460553909;6078.240219972504;6103.84740381494;4172.812223450012;4198.3702444633545;4205.411242426124;4216.24107660624;4231.23837709203;5974.193483879794;5976.671283079472;5982.803439312068;5993.220881285405;6019.0369540875;5583.637063590853;5788.334341550775;5797.971010144923;5816.73824677882;5860.765569377178;5770.13447982806;5778.653280803165;5801.564882633904;5804.506616937608;5806;5441.319835020622;5480.862978425571;5660.254776433509;5716.771329146954;5726;5775.018246898121;5833.649981001154;5885.823425297248;5918.260217472816;5925.1704761332585;5513.724313784375;5667.574931880043;5680.38702196994;5713.971430142823;5737.393529811659 14:26:21 INFO - PROCESS | 4440 | |5;yui.html;756.1115689065347;778.8286576953068;811.9797005074876;814.4543156085422;842.9968337678163;12841.293728844921;12948.805767913476;12967;12984.74030519389;13089.607311780663;12929.159604625693;13005.609831705064;13013.024023198273;13016.349182540858;13049.67375815605;780.4536824223038;787.3071696906715;787.8424315136967;789.9447038707293;790.0558832195528;757.3335464791004;758.6017340896046;758.9582572958485;760.0840986611121;760.889670997705;790.2808444315674;798.2456578533288;798.4091772088642;802.0415603353995;802.7712102050916;798.0622768247287;799.760071978407;800.7197480881674;801.2548330053048;801.7274126796888;589.8407429993921;590.1236663554618;590.2739630254767;590.7695998560565;590.7843637072438;14284.92857535716;14320.57038288853;14329.57011289663;14353.712925741427;14411.567652970427;13969.720605587932;14082.788758168635;14163.716725665532;14387.424503019867;14537.927310363486;11982.940085299604;11992.940035299855;12007.366848190348;12057;12219.450124744319;3803.9429408558617;3824;3829.0618798394294;3848.3650197717343;3883.49514563105;77598.61200694017;79506.60246698787;79769.20230797734;79817;80122.59938700385;10271.897281027244;10580.25938184335;10804.621838235782;10961.945190273998;11296.435178241056;17718.645627087386;18735.718964215546;19091.80908190928;19182.808171918383;19198.232070717015;8202.179782021869;8284.46151000183;8292.58537073156;8490.957545212234;8605.913940860512;4752.833650822205;4760.761961901961;4784.30627559002;4814.711117332971;4965.627577931597;3402.965970340265;3485.738569607239;3496.9650303496637;3502.9824850875584;3503.2292895562937;624.5128799536369;627.6347999662338;643.4209211709406;644.5133923887435;651.6839332923528;604.6493034040246;690.4028015766427;739.988900166498;768.876979683248;772.5982489105746;9065;9119.680811171576;9319.16127548524;9361.62553497866;9362.25101991839;679.5684740190015;709.6203531110831;710.5061981922514;725.680700491782;727.5307426709743;4414.448193975753;4718.8584342469785;4814.133455977888;4823.541763532529;4827.179379505493;67635;94011.52994235122;96798;118222;118689.40655296668;90100;96441;97943;97989.51005244929;99231;86051;86324;87555.56222218848;89271.55364223267;89696;9449.338546301693;10314.793704125725;10334.121599664113;10475.52860121281;10505.9474702626;49422.752886235336;51046.48953510417;51098.744506278716;51174.23238651349;51937;43924.780376097915;43939.78030109829;72340.63829680817;76280.61859690666;77734.50194741137;12993.220406775623;13007.934960325138;13036.739265214832;13047.505228562817;13228.537001204912;14567.34446949911;14693.632659183606;14918.85081149218;14989.0257133286;15353.232338382813;13381.264030478416;13571.728565428833;13625.931870340584;14173.00788944764;14198.432062717375;13581.25303108299;13743.518976835763;13924.25286323391;13959.511417100759;14637.780433293296;11575.421228938689;12723.745525089631;12830.807537886752;13117.622649621653;14407.06354087023;11118.444077796239;11174.27367221128;11381;11771.352575608082;11902.166848320534;11428.942855286003;11639.76720465603;11658.825117623073;11664.475098620753;11688.18182727201 14:26:21 INFO - PROCESS | 4440 | __end_tp_report 14:26:21 INFO - PROCESS | 4440 | __start_cc_report 14:26:21 INFO - PROCESS | 4440 | _x_x_mozilla_cycle_collect,351 14:26:21 INFO - PROCESS | 4440 | __end_cc_report 14:26:21 INFO - PROCESS | 4440 | __startTimestamp1467062781069__endTimestamp 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | ------- Summary: start ------- 14:26:21 INFO - PROCESS | 4440 | Number of tests: 6 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | [#0] dojo.html Cycles:165 Average:5449.66 Median:5683.77 stddev:749.13 (13.2%) stddev-sans-first:727.99 14:26:21 INFO - PROCESS | 4440 | Values: 3079.5 3109.5 3117.1 3151.8 3155.6 5375.0 5392.5 5458.9 5483.7 5502.5 5465.5 5483.0 5486.8 5498.5 5560.9 4878.9 4936.3 5015.3 5056.7 5142.5 683.8 4852.8 4923.1 4961.6 5045.8 4935.4 4942.5 4948.5 4952.2 4965.2 4986.6 4992.2 5011.5 5011.6 5027.5 4957.5 4971.2 4990.5 5008.5 5011.0 5459.0 5500.6 5512.9 5547.9 5583.6 5743.1 5884.6 5947.9 5955.0 5958.7 5931.5 5962.2 5977.2 5989.5 6062.8 5563.4 5571.1 5580.6 5581.5 5590.9 5908.9 5980.6 5992.3 6103.2 6107.1 5733.1 5741.2 5771.1 5793.3 5813.3 5903.2 5904.4 5906.6 5907.3 5926.4 5816.8 5831.7 5833.2 5872.9 5885.7 5830.7 5889.1 5892.7 5899.3 5907.3 4390.8 4398.9 4460.6 4461.4 4503.4 3895.3 3968.8 3971.7 4019.2 4027.5 5534.1 5596.9 5634.5 5638.7 5678.9 5817.0 5991.7 5992.7 6004.3 6007.2 5571.9 5626.6 5663.6 5669.8 5680.2 4939.2 4987.8 4992.3 5001.6 5007.8 6011.4 6097.1 6170.0 6196.2 6203.0 5914.3 6002.6 6003.5 6007.3 6027.3 6182.0 6188.8 6206.7 6211.5 6224.7 5726.4 5742.9 5770.7 5878.2 5884.9 5888.9 5911.3 5919.8 5921.2 5926.9 5626.4 5700.0 5740.6 5745.7 5760.7 5573.7 5741.8 5771.1 5793.1 5810.3 5639.3 5670.5 5683.8 5726.4 5756.9 5826.7 5865.6 5868.1 5877.1 5884.5 5609.8 5617.9 5622.2 5633.0 5711.8 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | [#1] ext.html Cycles:180 Average:62163.78 Median:23152.26 stddev:133161.47 (575.2%) stddev-sans-first:133454.70 14:26:21 INFO - PROCESS | 4440 | Values: 563.0 608.4 613.6 635.6 639.6 40894.8 41645.2 44261.8 44690.6 45057.0 45501.5 46175.8 46417.0 46487.0 46582.3 9023.8 9174.7 9181.5 9184.9 9191.6 8997.1 9053.5 9057.4 9058.0 9058.2 9118.3 9175.5 9190.8 9202.2 9215.9 9078.1 9106.3 9130.0 9177.1 9178.6 8934.6 8969.9 9043.7 9048.1 9050.6 43224.4 43587.0 43638.0 43689.6 43750.6 2977.7 3253.7 3376.7 3562.5 3930.6 32362.0 32710.8 33114.8 33168.5 33732.1 4155.3 4164.6 4201.3 4207.9 4233.2 325261.0 326136.0 326249.0 327089.0 327202.0 34593.3 35530.5 35593.3 35720.0 35776.5 37116.8 37148.3 37349.3 37369.6 37444.4 12980.9 13081.9 13128.3 13129.7 13148.5 10406.6 10441.4 10445.1 10458.9 10472.4 8453.4 8468.3 8491.3 8537.4 8591.3 3280.7 3291.5 3311.3 3333.2 3334.4 953.4 972.2 1076.6 1089.8 1143.8 31514.2 32047.4 32279.0 32784.0 32933.2 1012.9 1103.9 1127.9 1155.2 1159.6 16579.5 16738.8 17082.3 17083.2 17174.4 649830.0 651547.0 651762.0 653090.0 658677.0 59011.0 59461.0 59588.8 59871.0 59971.4 1297.9 1300.7 1343.5 1350.3 1357.0 30834.5 31332.5 31365.5 31514.2 31994.7 52396.7 52593.0 52848.0 52952.7 53089.5 450805.0 457237.0 461581.0 461987.0 463424.0 29223.9 29270.7 29508.0 29585.3 29686.6 49145.3 49922.5 50931.7 51038.7 51781.2 42024.8 42161.4 43026.8 43062.8 44499.0 42183.0 42296.8 42477.4 42657.6 44013.3 40974.6 42096.6 42183.4 42291.4 42414.0 37016.3 37736.0 37939.0 38891.2 39609.2 28489.3 28540.9 29279.1 29619.6 29697.3 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | [#2] jquery.html Cycles:180 Average:28654.79 Median:4121.16 stddev:78273.16 (1899.3%) stddev-sans-first:78463.94 14:26:21 INFO - PROCESS | 4440 | Values: 379.1 380.2 385.8 388.4 401.6 18850.3 19582.0 19799.8 20283.0 20283.1 16988.3 17137.3 17317.8 17348.5 17691.9 5335.9 5394.4 5577.2 5597.1 5628.0 5532.4 5589.6 5600.9 5617.2 5643.8 5383.9 5561.6 5590.8 5595.8 5599.5 5568.6 5589.7 5622.7 5628.4 5630.9 4905.5 4945.9 4968.3 4998.3 5034.1 22738.0 23013.7 23068.3 23123.9 23162.8 2545.8 2719.3 2761.0 3073.7 3087.8 14298.1 14426.1 14637.9 14810.9 14899.3 1865.4 1950.7 1997.9 1999.0 2011.3 65732.7 73403.6 73570.6 78261.6 81773.0 8961.6 9444.8 9660.4 9775.8 10157.4 12857.5 12981.9 12996.2 13029.0 13050.9 7093.0 7099.2 7263.0 7284.2 7298.9 7083.8 7091.7 7174.7 7188.5 7210.6 3999.4 4044.7 4085.6 4105.1 4137.2 1916.4 1941.3 1970.4 1974.9 2010.1 768.5 890.3 922.8 981.3 1001.5 18398.9 19805.7 19832.0 19871.7 19885.2 872.6 873.9 903.3 917.6 941.9 10310.9 11032.8 11142.1 11202.8 11286.6 458872.0 468084.0 470601.0 481360.0 488935.0 92738.5 98277.5 98829.0 98949.5 99589.5 934.2 936.5 962.6 967.3 989.8 17274.1 17304.7 17426.8 17592.1 17678.4 42076.8 42656.1 43413.6 44064.3 44252.0 58688.4 61545.0 61944.7 62290.4 62718.0 8594.6 8773.1 8850.8 8894.8 8946.4 10326.6 13783.9 14112.9 14201.1 14279.3 11802.6 11974.7 12076.4 12104.6 12117.5 12014.0 12053.5 12076.3 12184.5 12253.5 12188.8 12415.4 12496.2 12681.2 12748.6 8718.6 8740.9 8931.6 9044.5 9269.1 11960.6 12499.7 12548.9 12571.6 12652.3 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | [#3] mootools.html Cycles:180 Average:6019.75 Median:2617.28 stddev:3499.94 (133.7%) stddev-sans-first:3492.86 14:26:21 INFO - PROCESS | 4440 | Values: 1442.8 1488.5 1577.9 1747.2 1757.5 8107.0 8695.0 8914.6 9538.7 9557.9 8628.5 8842.5 8936.8 9073.7 9080.7 2331.6 2385.7 2391.2 2396.8 2399.7 2332.3 2374.2 2380.4 2392.5 2408.3 2344.7 2358.8 2369.1 2398.2 2405.5 2281.9 2296.1 2316.6 2316.8 2328.9 2298.9 2306.6 2312.1 2313.7 2314.8 9112.5 9125.5 9198.2 9200.2 9203.8 5015.3 5196.0 5203.1 5214.8 5236.8 3356.3 3373.8 3525.7 3529.8 3550.5 1231.3 1242.1 1245.8 1261.6 1269.3 12882.5 13112.3 13149.0 13214.9 13232.3 4682.7 4770.8 4780.1 4804.6 4817.9 11000.1 11068.3 11069.2 11092.9 11149.1 5190.4 5208.0 5221.4 5251.4 5264.1 4216.9 4758.2 4785.7 4840.3 4933.6 4057.8 4150.4 4159.6 4184.6 4197.4 1281.4 1298.3 1316.6 1320.3 1328.7 968.2 990.8 994.1 1002.6 1002.8 6142.7 6164.2 6199.8 6350.4 6387.9 461.2 476.4 478.5 487.1 491.2 4281.4 4314.1 4320.5 4356.9 4367.8 11041.9 11401.2 11466.7 11484.9 11507.1 10698.3 11136.1 11139.1 11396.4 11428.0 8181.1 8403.0 8448.4 8450.0 8480.5 6099.8 6322.5 6372.8 6387.1 6473.1 10411.3 10587.9 10612.3 10763.2 10775.1 10749.7 10754.7 10806.7 10843.7 10860.1 7375.7 7872.2 7984.6 8107.8 8138.0 8995.3 9083.0 9085.2 9103.4 9151.5 7973.4 8197.5 8205.4 8231.3 8267.7 7989.4 8030.4 8067.9 8097.7 8123.1 7254.6 7325.6 7382.2 7530.9 7566.5 5183.5 5251.9 5262.2 5273.2 5354.8 5302.6 5321.6 5398.6 5497.3 5618.5 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | [#4] prototype.html Cycles:180 Average:4856.50 Median:5569.05 stddev:1439.70 (25.9%) stddev-sans-first:1403.03 14:26:21 INFO - PROCESS | 4440 | Values: 327.4 328.6 331.3 332.4 333.9 5559.7 5566.5 5613.0 5616.4 5625.7 5566.3 5571.6 5576.4 5590.5 5608.6 4153.6 4170.6 4281.3 4309.4 4327.8 4266.2 4308.6 4314.7 4322.9 4326.8 4288.7 4291.2 4294.4 4295.8 4300.2 3986.6 4206.1 4232.5 4242.0 4309.7 3677.4 3704.1 3706.4 3723.3 3736.0 5409.7 5427.2 5433.8 5482.9 5529.8 4633.8 4871.0 4900.9 4905.4 4920.9 5773.5 5836.8 5842.5 5845.2 5848.2 4129.3 4132.4 4132.9 4140.3 4141.6 5875.5 5890.3 5948.3 6008.7 6010.0 4106.6 4124.3 4133.5 4174.2 4179.4 4217.8 4227.5 4230.1 4235.0 4239.1 4709.9 4865.6 4872.8 4902.2 4920.3 5811.5 5813.5 5837.4 5856.9 5904.9 1462.8 1472.0 1472.1 1472.6 1484.7 940.2 946.3 947.0 951.2 989.4 5468.9 5494.7 5504.6 5523.3 5531.8 5870.6 5886.3 5886.4 5902.5 5912.4 5279.4 5440.7 5513.9 5550.3 5552.0 3119.3 3130.6 3154.0 3156.8 3163.7 5835.4 6056.8 6057.3 6076.2 6099.6 5999.9 6024.2 6030.0 6037.4 6040.7 6040.6 6050.7 6076.6 6122.7 6123.3 5669.9 5913.5 5934.9 5941.8 5951.8 5831.4 5868.5 5940.1 5961.9 5962.2 5840.5 6052.7 6055.4 6078.2 6103.8 4172.8 4198.4 4205.4 4216.2 4231.2 5974.2 5976.7 5982.8 5993.2 6019.0 5583.6 5788.3 5798.0 5816.7 5860.8 5770.1 5778.7 5801.6 5804.5 5806.0 5441.3 5480.9 5660.3 5716.8 5726.0 5775.0 5833.6 5885.8 5918.3 5925.2 5513.7 5667.6 5680.4 5714.0 5737.4 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - PROCESS | 4440 | [#5] yui.html Cycles:180 Average:19875.66 Median:4756.80 stddev:28433.61 (597.7%) stddev-sans-first:28477.13 14:26:21 INFO - PROCESS | 4440 | Values: 756.1 778.8 812.0 814.5 843.0 12841.3 12948.8 12967.0 12984.7 13089.6 12929.2 13005.6 13013.0 13016.3 13049.7 780.5 787.3 787.8 789.9 790.1 757.3 758.6 759.0 760.1 760.9 790.3 798.2 798.4 802.0 802.8 798.1 799.8 800.7 801.3 801.7 589.8 590.1 590.3 590.8 590.8 14284.9 14320.6 14329.6 14353.7 14411.6 13969.7 14082.8 14163.7 14387.4 14537.9 11982.9 11992.9 12007.4 12057.0 12219.5 3803.9 3824.0 3829.1 3848.4 3883.5 77598.6 79506.6 79769.2 79817.0 80122.6 10271.9 10580.3 10804.6 10961.9 11296.4 17718.6 18735.7 19091.8 19182.8 19198.2 8202.2 8284.5 8292.6 8491.0 8605.9 4752.8 4760.8 4784.3 4814.7 4965.6 3403.0 3485.7 3497.0 3503.0 3503.2 624.5 627.6 643.4 644.5 651.7 604.6 690.4 740.0 768.9 772.6 9065.0 9119.7 9319.2 9361.6 9362.3 679.6 709.6 710.5 725.7 727.5 4414.4 4718.9 4814.1 4823.5 4827.2 67635.0 94011.5 96798.0 118222.0 118689.4 90100.0 96441.0 97943.0 97989.5 99231.0 86051.0 86324.0 87555.6 89271.6 89696.0 9449.3 10314.8 10334.1 10475.5 10505.9 49422.8 51046.5 51098.7 51174.2 51937.0 43924.8 43939.8 72340.6 76280.6 77734.5 12993.2 13007.9 13036.7 13047.5 13228.5 14567.3 14693.6 14918.9 14989.0 15353.2 13381.3 13571.7 13625.9 14173.0 14198.4 13581.3 13743.5 13924.3 13959.5 14637.8 11575.4 12723.7 12830.8 13117.6 14407.1 11118.4 11174.3 11381.0 11771.4 11902.2 11428.9 11639.8 11658.8 11664.5 11688.2 14:26:21 INFO - PROCESS | 4440 | -------- Summary: end -------- 14:26:21 INFO - PROCESS | 4440 | 14:26:21 INFO - TEST-INFO | 4440: exit 0 14:26:21 INFO - TEST-OK | dromaeo_css | took 1111178ms 14:26:21 INFO - TEST-START | kraken 14:26:21 INFO - operating with platform_type : linux_ 14:26:21 INFO - Initialising browser for kraken test... 14:26:21 INFO - TEST-INFO | started process 4680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHyiTF/profile http://localhost:60686/getInfo.html) 14:26:26 INFO - PROCESS | 4680 | __metrics Screen width/height:1600/1200 14:26:26 INFO - PROCESS | 4680 | colorDepth:24 14:26:26 INFO - PROCESS | 4680 | Browser inner width/height: 1024/697 14:26:26 INFO - PROCESS | 4680 | __metrics 14:26:27 ERROR - PROCESS | 4680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:26:28 INFO - TEST-INFO | 4680: exit 0 14:26:28 INFO - Browser initialized. 14:26:28 INFO - Running cycle 1/1 for kraken test... 14:26:28 INFO - TEST-INFO | started process 4799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHyiTF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:40 INFO - PROCESS | 4799 | RSS: Main: 184717312 14:26:40 INFO - PROCESS | 4799 | 14:26:42 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60686/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:43 INFO - PROCESS | 4799 | RSS: Main: 190234624 14:26:43 INFO - PROCESS | 4799 | 14:26:46 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60686/tests/kraken/driver.html?testName=audio-dft) 14:26:46 INFO - PROCESS | 4799 | RSS: Main: 189669376 14:26:46 INFO - PROCESS | 4799 | 14:26:49 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60686/tests/kraken/driver.html?testName=audio-fft) 14:26:50 INFO - PROCESS | 4799 | RSS: Main: 184078336 14:26:50 INFO - PROCESS | 4799 | 14:26:52 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60686/tests/kraken/driver.html?testName=audio-oscillator) 14:26:53 INFO - PROCESS | 4799 | RSS: Main: 185155584 14:26:53 INFO - PROCESS | 4799 | 14:26:55 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:55 INFO - PROCESS | 4799 | RSS: Main: 185634816 14:26:55 INFO - PROCESS | 4799 | 14:26:58 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60686/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:59 INFO - PROCESS | 4799 | RSS: Main: 185769984 14:26:59 INFO - PROCESS | 4799 | 14:27:03 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60686/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:03 INFO - PROCESS | 4799 | RSS: Main: 183492608 14:27:03 INFO - PROCESS | 4799 | 14:27:06 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60686/tests/kraken/driver.html?testName=json-parse-financial) 14:27:07 INFO - PROCESS | 4799 | RSS: Main: 184725504 14:27:07 INFO - PROCESS | 4799 | 14:27:08 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:09 INFO - PROCESS | 4799 | RSS: Main: 185495552 14:27:09 INFO - PROCESS | 4799 | 14:27:11 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:11 INFO - PROCESS | 4799 | RSS: Main: 185769984 14:27:11 INFO - PROCESS | 4799 | 14:27:13 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:14 INFO - PROCESS | 4799 | RSS: Main: 186363904 14:27:14 INFO - PROCESS | 4799 | 14:27:17 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:17 INFO - PROCESS | 4799 | RSS: Main: 186261504 14:27:17 INFO - PROCESS | 4799 | 14:27:20 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:21 INFO - PROCESS | 4799 | RSS: Main: 185970688 14:27:21 INFO - PROCESS | 4799 | 14:27:22 INFO - PROCESS | 4799 | Cycle 1(1): loaded http://localhost:60686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60686/tests/kraken/driver.html?testName=ai-astar) 14:27:23 INFO - PROCESS | 4799 | RSS: Main: 186757120 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | __start_tp_report 14:27:23 INFO - PROCESS | 4799 | _x_x_mozilla_page_load 14:27:23 INFO - PROCESS | 4799 | _x_x_mozilla_page_load_details 14:27:23 INFO - PROCESS | 4799 | |i|pagename|runs| 14:27:23 INFO - PROCESS | 4799 | |0;ai-astar;101;111;106;112;111;114;114;111;111;111 14:27:23 INFO - PROCESS | 4799 | |1;audio-beat-detection;161;128;155;178;131;157;160;130;181;128 14:27:23 INFO - PROCESS | 4799 | |2;audio-dft;162;161;161;163;163;177;164;164;162;163 14:27:23 INFO - PROCESS | 4799 | |3;audio-fft;76;76;75;160;76;75;74;75;179;74 14:27:23 INFO - PROCESS | 4799 | |4;audio-oscillator;85;85;145;85;84;87;135;86;87;138 14:27:23 INFO - PROCESS | 4799 | |5;imaging-gaussian-blur;119;119;118;117;118;118;118;118;118;117 14:27:23 INFO - PROCESS | 4799 | |6;imaging-darkroom;148;148;147;148;149;151;151;148;147;147 14:27:23 INFO - PROCESS | 4799 | |7;imaging-desaturate;95;97;95;95;95;95;95;97;96;96 14:27:23 INFO - PROCESS | 4799 | |8;json-parse-financial;55;55;55;55;55;54;56;54;56;57 14:27:23 INFO - PROCESS | 4799 | |9;json-stringify-tinderbox;64;62;63;63;64;63;63;66;63;64 14:27:23 INFO - PROCESS | 4799 | |10;stanford-crypto-aes;83;80;79;80;81;80;81;82;89;86 14:27:23 INFO - PROCESS | 4799 | |11;stanford-crypto-ccm;125;122;125;122;128;143;125;125;133;138 14:27:23 INFO - PROCESS | 4799 | |12;stanford-crypto-pbkdf2;164;164;161;159;168;165;164;167;163;157 14:27:23 INFO - PROCESS | 4799 | |13;stanford-crypto-sha256-iterative;69;65;63;65;61;63;62;62;62;61 14:27:23 INFO - PROCESS | 4799 | __end_tp_report 14:27:23 INFO - PROCESS | 4799 | __start_cc_report 14:27:23 INFO - PROCESS | 4799 | _x_x_mozilla_cycle_collect,880 14:27:23 INFO - PROCESS | 4799 | __end_cc_report 14:27:23 INFO - PROCESS | 4799 | __startTimestamp1467062843046__endTimestamp 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | ------- Summary: start ------- 14:27:23 INFO - PROCESS | 4799 | Number of tests: 14 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.91 (3.5%) stddev-sans-first:2.33 14:27:23 INFO - PROCESS | 4799 | Values: 101.0 111.0 106.0 112.0 111.0 114.0 114.0 111.0 111.0 111.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:158.50 stddev:20.44 (12.9%) stddev-sans-first:21.35 14:27:23 INFO - PROCESS | 4799 | Values: 161.0 128.0 155.0 178.0 131.0 157.0 160.0 130.0 181.0 128.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.69 (2.9%) stddev-sans-first:4.92 14:27:23 INFO - PROCESS | 4799 | Values: 162.0 161.0 161.0 163.0 163.0 177.0 164.0 164.0 162.0 163.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:40.05 (53.4%) stddev-sans-first:41.95 14:27:23 INFO - PROCESS | 4799 | Values: 76.0 76.0 75.0 160.0 76.0 75.0 74.0 75.0 179.0 74.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:85.00 stddev:26.10 (30.7%) stddev-sans-first:26.97 14:27:23 INFO - PROCESS | 4799 | Values: 85.0 85.0 145.0 85.0 84.0 87.0 135.0 86.0 87.0 138.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 14:27:23 INFO - PROCESS | 4799 | Values: 119.0 119.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.51 (1.0%) stddev-sans-first:1.59 14:27:23 INFO - PROCESS | 4799 | Values: 148.0 148.0 147.0 148.0 149.0 151.0 151.0 148.0 147.0 147.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 14:27:23 INFO - PROCESS | 4799 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 97.0 96.0 96.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 14:27:23 INFO - PROCESS | 4799 | Values: 55.0 55.0 55.0 55.0 55.0 54.0 56.0 54.0 56.0 57.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:1.08 (1.7%) stddev-sans-first:1.13 14:27:23 INFO - PROCESS | 4799 | Values: 64.0 62.0 63.0 63.0 64.0 63.0 63.0 66.0 63.0 64.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.50 stddev:3.14 (3.9%) stddev-sans-first:3.32 14:27:23 INFO - PROCESS | 4799 | Values: 83.0 80.0 79.0 80.0 81.0 80.0 81.0 82.0 89.0 86.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:126.50 stddev:7.11 (5.6%) stddev-sans-first:7.42 14:27:23 INFO - PROCESS | 4799 | Values: 125.0 122.0 125.0 122.0 128.0 143.0 125.0 125.0 133.0 138.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.00 stddev:3.39 (2.1%) stddev-sans-first:3.59 14:27:23 INFO - PROCESS | 4799 | Values: 164.0 164.0 161.0 159.0 168.0 165.0 164.0 167.0 163.0 157.0 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - PROCESS | 4799 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:2.45 (3.9%) stddev-sans-first:1.50 14:27:23 INFO - PROCESS | 4799 | Values: 69.0 65.0 63.0 65.0 61.0 63.0 62.0 62.0 62.0 61.0 14:27:23 INFO - PROCESS | 4799 | -------- Summary: end -------- 14:27:23 INFO - PROCESS | 4799 | 14:27:23 INFO - TEST-INFO | 4799: exit 0 14:27:23 INFO - TEST-OK | kraken | took 62099ms 14:27:23 INFO - SUITE-END | took 1173s 14:27:24 INFO - Completed test suite (00:19:33) 14:27:24 INFO - javascript benchmark 14:27:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7222.561007852282, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.5380692896065, 3109.518024706171, 3117.1427857339227, 3151.7636177286695, 3155.573997510337, 5375.0, 5392.4877136672, 5458.918116228259, 5483.698396588186, 5502.532284755791, 5465.480779325968, 5483.040467918118, 5486.753096110675, 5498.505134537891, 5560.944390556093, 4878.902421951559, 4936.333594964688, 5015.348004759376, 5056.696598204101, 5142.460041695625, 683.8236114364756, 4852.830150944717, 4923.113839508887, 4961.627877909171, 5045.84862454127, 4935.35840340757, 4942.481039490855, 4948.529889660476, 4952.232403977389, 4965.155923492996, 4986.551210391082, 4992.201247800334, 5011.498850114996, 5011.599072074262, 5027.49725027498, 4957.5042495750495, 4971.154903666349, 4990.525900039491, 5008.499150084999, 5010.974945125251, 5458.972705136489, 5500.58745594078, 5512.889742205173, 5547.8890422191735, 5583.609147359686, 5743.138529220609, 5884.588078834483, 5947.851303717398, 5955.047192449188, 5958.672273024982, 5931.495822855062, 5962.1951036609935, 5977.22296101504, 5989.460948514655, 6062.848428789272, 5563.415841336642, 5571.052921003398, 5580.553555715533, 5581.49766521015, 5590.91613625796, 5908.911366329508, 5980.581359304894, 5992.280926288873, 6103.206583144163, 6107.114468402056, 5733.111367738007, 5741.19623252745, 5771.105478650816, 5793.275840519935, 5813.273340832396, 5903.2325797646035, 5904.350521442638, 5906.5570082244, 5907.261592300963, 5926.407359264039, 5816.767329306865, 5831.650100993954, 5833.183354330397, 5872.941270587325, 5885.735141918538, 5830.679312637761, 5889.116632505158, 5892.6759028253, 5899.321578018583, 5907.2911250650195, 4390.780460976938, 4398.868033958986, 4460.598546130864, 4461.442319710036, 4503.392042074343, 3895.2988462077096, 3968.8412463501713, 3971.7418367806, 4019.196160767858, 4027.4764280643913, 5534.059209934321, 5596.860078497989, 5634.464725851038, 5638.746256418471, 5678.858028549319, 5817.0, 5991.730372133265, 5992.730327135289, 6004.309504407049, 6007.189029481052, 5571.860703482445, 5626.634268772598, 5663.575231857545, 5669.829905102853, 5680.233168522197, 4939.185034469344, 4987.775550100254, 4992.276119962585, 5001.599872010231, 5007.774650140753, 6011.398860114041, 6097.146399504073, 6170.0, 6196.194494715658, 6203.038529028008, 5914.290285165722, 6002.579819412774, 6003.519718422428, 6007.309159446545, 6027.306859711014, 6181.96909015452, 6188.752449901954, 6206.689665516616, 6211.503079753699, 6224.657643829632, 5726.370099288992, 5742.913856292243, 5770.682612456355, 5878.2358293421585, 5884.882302354014, 5888.852778680567, 5911.261092363455, 5919.792807251725, 5921.2006379138265, 5926.881462370815, 5626.352969408406, 5700.0, 5740.6268592541355, 5745.712714364348, 5760.654360738369, 5573.693446860461, 5741.827745167651, 5771.105478650816, 5793.102069179284, 5810.273715785527, 5639.295088113986, 5670.546356291569, 5683.77264909399, 5726.4273572642405, 5756.94243057564, 5826.73779679907, 5865.5600829937075, 5868.061110222344, 5877.089051197071, 5884.499817515559, 5609.775608975595, 5617.859553511195, 5622.24099746529, 5632.971835140962, 5711.828645140652], "value": 5398.277413970457, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9690367029814, 608.4098424528208, 613.5521069619178, 635.5836926812938, 639.5906619763349, 40894.79552602237, 41645.167096658086, 44261.7786911065, 44690.553094469, 45057.0, 45501.54498455014, 46175.76912115435, 46417.0, 46487.0, 46582.301265481045, 9023.774405639862, 9174.678886238982, 9181.540922953858, 9184.8622270666, 9191.632334706605, 8997.145271199259, 9053.547322633875, 9057.411268267575, 9058.048904864992, 9058.23005044572, 9118.316126290521, 9175.54122293886, 9190.770230744218, 9202.217811486033, 9215.907840921605, 9078.092190780902, 9106.271498280188, 9129.95435022824, 9177.082291770803, 9178.586963586587, 8934.64261429542, 8969.910300896972, 9043.728688139367, 9048.140426659456, 9050.592723327467, 43224.351634725506, 43587.0, 43638.0, 43689.56310436887, 43750.562494374964, 2977.702229777027, 3253.6746325367512, 3376.679215474526, 3562.4834399012257, 3930.587288334741, 32362.0, 32710.83644581762, 33114.834425827954, 33168.50247246293, 33732.14473203973, 4155.31437312843, 4164.6251837334485, 4201.34879093741, 4207.936880946788, 4233.195692818385, 325261.0, 326136.0, 326249.0, 327089.0, 327202.0, 34593.30813383769, 35530.46704299437, 35593.288134237686, 35720.0, 35776.46335304972, 37116.81441592775, 37148.257034859154, 37349.253014939546, 37369.62630373716, 37444.43833342502, 12980.935095324463, 13081.869181308066, 13128.34358282082, 13129.67175820593, 13148.539801107107, 10406.635767748092, 10441.373517588969, 10445.059944605022, 10458.895411045944, 10472.424016679004, 8453.408261421764, 8468.32253419725, 8491.320694344438, 8537.445066070686, 8591.269742071994, 3280.671932806748, 3291.4569096098876, 3311.288073064303, 3333.1833700743473, 3334.3664703706218, 953.4041224234853, 972.2416515118077, 1076.5855145768935, 1089.782043591285, 1143.8112711402691, 31514.212144696565, 32047.359052818814, 32279.0, 32784.0, 32933.17667058295, 1012.8531362952331, 1103.939283339408, 1127.8928501792316, 1155.156735583029, 1159.6173262823247, 16579.50261492157, 16738.832611673726, 17082.316707331815, 17083.231254593575, 17174.39889603858, 649830.0, 651547.0, 651762.0, 653090.0, 658677.0, 59011.0, 59461.0, 59588.80822383528, 59871.0, 59971.40028599746, 1297.941592628334, 1300.7138429545485, 1343.516334119716, 1350.3450826349213, 1357.0229434806922, 30834.53748193734, 31332.530012050294, 31365.529517056806, 31514.212144695648, 31994.6800532001, 52396.738016309675, 52593.0, 52848.0, 52952.73523632357, 53089.469105309996, 450805.0, 457237.0, 461581.0, 461987.0, 463424.0, 29223.85388073046, 29270.7072929268, 29508.0, 29585.2603684901, 29686.55470167906, 49145.262821057, 49922.500774991786, 50931.745341273054, 51038.74480627573, 51781.22328165156, 42024.789876050425, 42161.36757948572, 43026.78486607547, 43062.78468607637, 44499.0, 42183.0, 42296.788516057226, 42477.36283955805, 42657.5734242666, 44013.33979990239, 40974.59025409827, 42096.57903421049, 42183.36724949067, 42291.3656295162, 42414.0, 37016.25967480689, 37736.0, 37939.0, 38891.22217555576, 39609.2078158441, 28489.28776780597, 28540.857295713387, 29279.121626351243, 29619.555706664847, 29697.257568560093], "value": 18869.382495171234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.13557089835166, 380.2243423416231, 385.837948061814, 388.37665546797405, 401.55226921981983, 18850.34023809167, 19582.0, 19799.802001979977, 20283.0, 20283.08726107325, 16988.320467181296, 17137.314507419687, 17317.82682173178, 17348.47954561362, 17691.911540442314, 5335.893282134355, 5394.352677678665, 5577.247071645337, 5597.132444471114, 5628.043232650439, 5532.3637781655225, 5589.608727389084, 5600.887982240352, 5617.21359009739, 5643.8024669136585, 5383.919241211385, 5561.63849349791, 5590.776368945238, 5595.776168953257, 5599.468050535193, 5568.610197286192, 5589.664620122806, 5622.662640241599, 5628.409017053192, 5630.915536266939, 4905.5094490550655, 4945.901081978341, 4968.30443737877, 4998.275250088753, 5034.09386310464, 22738.0, 23013.654795178085, 23068.307950761504, 23123.884380578158, 23162.76837231623, 2545.7963362931105, 2719.333763228002, 2761.0, 3073.6618971913294, 3087.768417368684, 14298.142111473346, 14426.134431934117, 14637.926810365987, 14810.851891481163, 14899.255037248202, 1865.4496923407628, 1950.7268982342484, 1997.9001049947444, 1998.9600207995904, 2011.2730613562348, 65732.67133664349, 73403.63298183474, 73570.63214683946, 78261.60869195675, 81773.0, 8961.59672814725, 9444.763880902896, 9660.420374777395, 9775.804483910282, 10157.39055656663, 12857.485700571873, 12981.870181298065, 12996.220226786234, 13029.0, 13050.934745326402, 7093.0, 7099.183593886769, 7263.0, 7284.235155308722, 7298.927010729824, 7083.82290442743, 7091.716331346688, 7174.677139528734, 7188.4968052235845, 7210.603416812126, 3999.440078389028, 4044.7168698190844, 4085.55058943516, 4105.137921036616, 4137.172565486914, 1916.3867562380183, 1941.3108346537058, 1970.389179354376, 1974.871633343828, 2010.0753653319637, 768.5119948832531, 890.2566357091771, 922.8246633139682, 981.3326937682302, 1001.5042553935702, 18398.908005459885, 19805.702914456295, 19832.0, 19871.701924471145, 19885.204591816455, 872.5986046418592, 873.930085593151, 903.2864037410372, 917.605429665237, 941.9387739796891, 10310.948445257876, 11032.834507482394, 11142.108631309638, 11202.831957520644, 11286.604968826052, 458872.0, 468084.0, 470601.0, 481360.0, 488935.0, 92738.53630731939, 98277.50861245791, 98829.0, 98949.50525247327, 99589.50205249072, 934.1872570863393, 936.489613160829, 962.6197651927589, 967.298708436378, 989.7674046599044, 17274.136293185038, 17304.65390692204, 17426.82573174252, 17592.120393980505, 17678.381256655954, 42076.78961605173, 42656.14687706166, 43413.565864340955, 44064.339034915145, 44252.0, 58688.413115870004, 61545.0, 61944.69027654833, 62290.377096228454, 62718.0, 8594.613242404232, 8773.078826723102, 8850.822983540422, 8894.822103558023, 8946.37375383717, 10326.586936522455, 13783.862161378658, 14112.858871411565, 14201.147931124166, 14279.286035698382, 11802.58690945847, 11974.700632484257, 12076.396180191132, 12104.636860894187, 12117.515299387926, 12013.975318268478, 12053.51785928553, 12076.335801531, 12184.51261949512, 12253.509859605516, 12188.756224875275, 12415.44130514147, 12496.187747796364, 12681.23912565249, 12748.61754147377, 8718.60766265507, 8740.868886966573, 8931.553422328987, 9044.50255235942, 9269.119433653792, 11960.58137965167, 12499.687507812378, 12548.874511254771, 12571.559995400117, 12652.30412327294], "value": 9141.55665552774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.7619442791936, 1488.523672424824, 1577.8974366666166, 1747.2050217151198, 1757.4727581725488, 8106.959465202665, 8694.956525217365, 8914.598843052063, 9538.713838584845, 9557.900841403241, 8628.525431101303, 8842.469451832894, 8936.776580585472, 9073.682421115262, 9080.72757817265, 2331.5919714050015, 2385.725641551218, 2391.2109004028716, 2396.8082553395775, 2399.7360290368047, 2332.265336419023, 2374.2402431222017, 2380.3929997850523, 2392.473655795722, 2408.3256688127353, 2344.6834677318516, 2358.79950204232, 2369.07606033647, 2398.2085911649115, 2405.530921470314, 2281.897314620846, 2296.0930432479076, 2316.6061769499224, 2316.791488766011, 2328.883555822202, 2298.908043678251, 2306.6194077977116, 2312.063614236237, 2313.664518644804, 2314.826388020905, 9112.453252804853, 9125.494293441574, 9198.218151457135, 9200.217981471584, 9203.769905752342, 5015.32293140425, 5196.0, 5203.115470370046, 5214.765335559909, 5236.764345604457, 3356.2616224430585, 3373.751711866625, 3525.665061819123, 3529.7882127072203, 3550.520679708258, 1231.3043130631165, 1242.105683907585, 1245.8068999305121, 1261.6215135459418, 1269.2701696524443, 12882.549110781172, 13112.344382780822, 13149.0, 13214.933925330408, 13232.338383080903, 4682.742449165328, 4770.833020844254, 4780.11567859947, 4804.639652026112, 4817.879553011203, 11000.064994475399, 11068.335899846035, 11069.169812264112, 11092.889071109346, 11149.05233055183, 5190.351206099238, 5208.0, 5221.425643179247, 5251.422343542207, 5264.078786212397, 4216.915661686749, 4758.16732071893, 4785.712857228577, 4840.273958906192, 4933.605311575066, 4057.776822274803, 4150.398192262165, 4159.625633692982, 4184.644305234028, 4197.412362269285, 1281.423359488234, 1298.3313593499356, 1316.6115995781267, 1320.2672516753294, 1328.6877583767807, 968.1818863060703, 990.8166989106894, 994.0953732103751, 1002.6209386640766, 1002.7593377589326, 6142.692865356715, 6164.229471316085, 6199.752009919553, 6350.4284614384005, 6387.936120638827, 461.21823509152335, 476.3902205177379, 478.5358202543527, 487.0575436530325, 491.15766460520376, 4281.400603915455, 4314.094040251583, 4320.4599425071865, 4356.912861742748, 4367.803448844809, 11041.889581104248, 11401.201915865975, 11466.713332166762, 11484.94257528707, 11507.136964727679, 10698.251122421356, 11136.109111271078, 11139.10887129044, 11396.430178491042, 11428.0, 8181.100078991306, 8402.957985210034, 8448.366372522085, 8450.028246751579, 8480.491170529665, 6099.817005489843, 6322.49420046386, 6372.808815735535, 6387.073874288295, 6473.061406096184, 10411.323263987817, 10587.947060264649, 10612.310199836986, 10763.246572740147, 10775.08411785007, 10749.731256718645, 10754.677359679223, 10806.675799726021, 10843.67468975932, 10860.076893464144, 7375.668094935848, 7872.212778722082, 7984.6406911687955, 8107.756767296991, 8138.0, 8995.280377569648, 9082.954585227031, 9085.22775564058, 9103.362764606414, 9151.542422878696, 7973.362131029619, 8197.549134797406, 8205.425620206766, 8231.259186672989, 8267.710630127916, 7989.400794940287, 8030.357571394391, 8067.94686816703, 8097.676092956452, 8123.0658474276215, 7254.5647261164495, 7325.597092159983, 7382.224866388952, 7530.887036694345, 7566.508176968479, 5183.533481986639, 5251.868703282448, 5262.236975638434, 5273.235380869675, 5354.759035843318, 5302.628815982998, 5321.627486075938, 5398.64908780928, 5497.257870187474, 5618.494335509824], "value": 4714.142860205259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.4171973886482, 328.6155198417851, 331.2943430493049, 332.41494968854806, 333.9499075138729, 5559.749811258488, 5566.495077215249, 5613.0, 5616.382197958222, 5625.718714064295, 5566.274454918978, 5571.609987300881, 5576.442355764421, 5590.496855283024, 5608.551315894729, 4153.608541138722, 4170.64549513291, 4281.293586558214, 4309.396684464177, 4327.826886924519, 4266.189424009443, 4308.590683885026, 4314.71954322968, 4322.891927701801, 4326.805293761772, 4288.656907447396, 4291.163223171483, 4294.4202532658, 4295.849645262417, 4300.161468513641, 3986.5614782373914, 4206.116715489751, 4232.492100947875, 4242.024334403104, 4309.719868208556, 3677.3748462761396, 3704.1480459494196, 3706.388445906422, 3723.2739615774935, 3735.962640373589, 5409.675419474844, 5427.158790387496, 5433.77215341712, 5482.945170548283, 5529.751161197756, 4633.837815676469, 4870.951290487085, 4900.901981960341, 4905.4358748744, 4920.901581968341, 5773.538116950634, 5836.795712150054, 5842.532597392198, 5845.152452894349, 5848.181254624356, 4129.339305711102, 4132.380142978547, 4132.896677583054, 4140.254754144253, 4141.5918587680035, 5875.471207591295, 5890.263717035371, 5948.31594366649, 6008.738164985359, 6009.978303688384, 4106.609872062149, 4124.340105583093, 4133.46264985556, 4174.248635245624, 4179.373094035858, 4217.7891105445215, 4227.450431443893, 4230.090530535949, 4234.9576504234565, 4239.130978149472, 4709.929351059737, 4865.635077369211, 4872.80508779652, 4902.166631672624, 4920.3111564381015, 5811.472009675805, 5813.476787089182, 5837.357890632027, 5856.882862342729, 5904.852378690482, 1462.817147856518, 1471.9558413247619, 1472.0578829549097, 1472.5655931500232, 1484.665950161205, 940.2431043010442, 946.2855544064325, 946.9668561600449, 951.1962391778935, 989.4211886046743, 5468.890622187534, 5494.697791621419, 5504.559635229172, 5523.309586301712, 5531.751071201806, 5870.55970802183, 5886.3230728465915, 5886.352501224862, 5902.527797776168, 5912.438318359749, 5279.41926388097, 5440.673559586358, 5513.912209162801, 5550.250716153268, 5551.9722401387735, 3119.313750974782, 3130.593022907053, 3153.952690709641, 3156.8004158420113, 3163.6678148794504, 5835.44563266489, 6056.848578785565, 6057.3336932937345, 6076.240469941257, 6099.573029887865, 5999.910001349983, 6024.186734790835, 6030.005049166926, 6037.366076561985, 6040.728167232485, 6040.607360521552, 6050.668852852454, 6076.605020673731, 6122.724477398528, 6123.326434092246, 5669.943300567106, 5913.51102849321, 5934.851628709317, 5941.752232031322, 5951.7619295227705, 5831.4168583141345, 5868.5305175585, 5940.1487286103775, 5961.850953726018, 5962.2249107615735, 5840.532757379485, 6052.727627256696, 6055.394460553909, 6078.240219972504, 6103.84740381494, 4172.812223450012, 4198.3702444633545, 4205.411242426124, 4216.24107660624, 4231.23837709203, 5974.193483879794, 5976.671283079472, 5982.803439312068, 5993.220881285405, 6019.0369540875, 5583.637063590853, 5788.334341550775, 5797.971010144923, 5816.73824677882, 5860.765569377178, 5770.13447982806, 5778.653280803165, 5801.564882633904, 5804.506616937608, 5806.0, 5441.319835020622, 5480.862978425571, 5660.254776433509, 5716.771329146954, 5726.0, 5775.018246898121, 5833.649981001154, 5885.823425297248, 5918.260217472816, 5925.1704761332585, 5513.724313784375, 5667.574931880043, 5680.38702196994, 5713.971430142823, 5737.393529811659], "value": 4391.312328387564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.1115689065347, 778.8286576953068, 811.9797005074876, 814.4543156085422, 842.9968337678163, 12841.293728844921, 12948.805767913476, 12967.0, 12984.74030519389, 13089.607311780663, 12929.159604625693, 13005.609831705064, 13013.024023198273, 13016.349182540858, 13049.67375815605, 780.4536824223038, 787.3071696906715, 787.8424315136967, 789.9447038707293, 790.0558832195528, 757.3335464791004, 758.6017340896046, 758.9582572958485, 760.0840986611121, 760.889670997705, 790.2808444315674, 798.2456578533288, 798.4091772088642, 802.0415603353995, 802.7712102050916, 798.0622768247287, 799.760071978407, 800.7197480881674, 801.2548330053048, 801.7274126796888, 589.8407429993921, 590.1236663554618, 590.2739630254767, 590.7695998560565, 590.7843637072438, 14284.92857535716, 14320.57038288853, 14329.57011289663, 14353.712925741427, 14411.567652970427, 13969.720605587932, 14082.788758168635, 14163.716725665532, 14387.424503019867, 14537.927310363486, 11982.940085299604, 11992.940035299855, 12007.366848190348, 12057.0, 12219.450124744319, 3803.9429408558617, 3824.0, 3829.0618798394294, 3848.3650197717343, 3883.49514563105, 77598.61200694017, 79506.60246698787, 79769.20230797734, 79817.0, 80122.59938700385, 10271.897281027244, 10580.25938184335, 10804.621838235782, 10961.945190273998, 11296.435178241056, 17718.645627087386, 18735.718964215546, 19091.80908190928, 19182.808171918383, 19198.232070717015, 8202.179782021869, 8284.46151000183, 8292.58537073156, 8490.957545212234, 8605.913940860512, 4752.833650822205, 4760.761961901961, 4784.30627559002, 4814.711117332971, 4965.627577931597, 3402.965970340265, 3485.738569607239, 3496.9650303496637, 3502.9824850875584, 3503.2292895562937, 624.5128799536369, 627.6347999662338, 643.4209211709406, 644.5133923887435, 651.6839332923528, 604.6493034040246, 690.4028015766427, 739.988900166498, 768.876979683248, 772.5982489105746, 9065.0, 9119.680811171576, 9319.16127548524, 9361.62553497866, 9362.25101991839, 679.5684740190015, 709.6203531110831, 710.5061981922514, 725.680700491782, 727.5307426709743, 4414.448193975753, 4718.8584342469785, 4814.133455977888, 4823.541763532529, 4827.179379505493, 67635.0, 94011.52994235122, 96798.0, 118222.0, 118689.40655296668, 90100.0, 96441.0, 97943.0, 97989.51005244929, 99231.0, 86051.0, 86324.0, 87555.56222218848, 89271.55364223267, 89696.0, 9449.338546301693, 10314.793704125725, 10334.121599664113, 10475.52860121281, 10505.9474702626, 49422.752886235336, 51046.48953510417, 51098.744506278716, 51174.23238651349, 51937.0, 43924.780376097915, 43939.78030109829, 72340.63829680817, 76280.61859690666, 77734.50194741137, 12993.220406775623, 13007.934960325138, 13036.739265214832, 13047.505228562817, 13228.537001204912, 14567.34446949911, 14693.632659183606, 14918.85081149218, 14989.0257133286, 15353.232338382813, 13381.264030478416, 13571.728565428833, 13625.931870340584, 14173.00788944764, 14198.432062717375, 13581.25303108299, 13743.518976835763, 13924.25286323391, 13959.511417100759, 14637.780433293296, 11575.421228938689, 12723.745525089631, 12830.807537886752, 13117.622649621653, 14407.06354087023, 11118.444077796239, 11174.27367221128, 11381.0, 11771.352575608082, 11902.166848320534, 11428.942855286003, 11639.76720465603, 11658.825117623073, 11664.475098620753, 11688.18182727201], "value": 7363.376691959924, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 106.0, 112.0, 111.0, 114.0, 114.0, 111.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 155.0, 178.0, 131.0, 157.0, 160.0, 130.0, 181.0, 128.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 163.0, 177.0, 164.0, 164.0, 162.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 160.0, 76.0, 75.0, 74.0, 75.0, 179.0, 74.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 145.0, 85.0, 84.0, 87.0, 135.0, 86.0, 87.0, 138.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 149.0, 151.0, 151.0, 148.0, 147.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 56.0, 54.0, 56.0, 57.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 64.0, 63.0, 63.0, 66.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 79.0, 80.0, 81.0, 80.0, 81.0, 82.0, 89.0, 86.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 125.0, 122.0, 128.0, 143.0, 125.0, 125.0, 133.0, 138.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 159.0, 168.0, 165.0, 164.0, 167.0, 163.0, 157.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 63.0, 65.0, 61.0, 63.0, 62.0, 62.0, 62.0, 61.0], "value": 63.3, "unit": "score"}]}]} 14:27:24 INFO - Return code: 0 14:27:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:27:24 ERROR - # TBPL SUCCESS # 14:27:24 INFO - Running post-action listener: _resource_record_post_action 14:27:24 INFO - ##### 14:27:24 INFO - ##### Finished run-tests step (success) 14:27:24 INFO - ##### 14:27:24 INFO - Running post-run listener: _resource_record_post_run 14:27:24 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 374300672; Read time: 12; Write time: 308232 14:27:24 INFO - TinderboxPrint: CPU usage
13.4% 14:27:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:27:24 INFO - TinderboxPrint: I/O write bytes / time
374,300,672 / 308,232 14:27:24 INFO - TinderboxPrint: CPU idle
8,234.1 (86.6%) 14:27:24 INFO - TinderboxPrint: CPU user
1,217.6 (12.8%) 14:27:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:27:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79261696; Read time: 0; Write time: 44248 14:27:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295038976; Read time: 12; Write time: 263984 14:27:25 INFO - Running post-run listener: _upload_blobber_files 14:27:25 INFO - Blob upload gear active. 14:27:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:27:25 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 14:27:25 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'] 14:27:25 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 14:27:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:26 INFO - (blobuploader) - INFO - Done attempting. 14:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:26 INFO - (blobuploader) - INFO - Done attempting. 14:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:30 INFO - (blobuploader) - INFO - Done attempting. 14:27:30 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:30 INFO - Return code: 0 14:27:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:27:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c5f9fb3d85baaa1f5afd768e2c0fc587ec0912a686f7def12a55519fe25905218c2ab33320fea4bafc40778a5a08cb3855023e99f29b244a2d29dc1ed2f774", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad7250da4f2cbfe1051feb1f48dd53649f49ad6ff71ea21e850435ffe5e03302fc64d7fd5d8b8d6292a7d9d923d5dac3c4503dc0afba7dc20c9a55f2f0448e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309c170d3a8c01732908945fcbab0425738eddfa9c47e35bd3c4160fefd9ffcf5816db1c401f9ba14aa90ad9604c9e960ef5447f64a434542ceb796c09908afd"} 14:27:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:27:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:27:30 INFO - Contents: 14:27:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c5f9fb3d85baaa1f5afd768e2c0fc587ec0912a686f7def12a55519fe25905218c2ab33320fea4bafc40778a5a08cb3855023e99f29b244a2d29dc1ed2f774", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad7250da4f2cbfe1051feb1f48dd53649f49ad6ff71ea21e850435ffe5e03302fc64d7fd5d8b8d6292a7d9d923d5dac3c4503dc0afba7dc20c9a55f2f0448e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309c170d3a8c01732908945fcbab0425738eddfa9c47e35bd3c4160fefd9ffcf5816db1c401f9ba14aa90ad9604c9e960ef5447f64a434542ceb796c09908afd"} 14:27:30 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:30 INFO - Copying logs to upload dir... 14:27:30 INFO - mkdir: /builds/slave/test/build/upload/logs 14:27:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.461790 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-27 14:27:30.831664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 14:27:30.835528) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c5f9fb3d85baaa1f5afd768e2c0fc587ec0912a686f7def12a55519fe25905218c2ab33320fea4bafc40778a5a08cb3855023e99f29b244a2d29dc1ed2f774", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad7250da4f2cbfe1051feb1f48dd53649f49ad6ff71ea21e850435ffe5e03302fc64d7fd5d8b8d6292a7d9d923d5dac3c4503dc0afba7dc20c9a55f2f0448e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309c170d3a8c01732908945fcbab0425738eddfa9c47e35bd3c4160fefd9ffcf5816db1c401f9ba14aa90ad9604c9e960ef5447f64a434542ceb796c09908afd"} build_url:https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/EyiHBvSZT3eg0TxIyuN4ow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c5f9fb3d85baaa1f5afd768e2c0fc587ec0912a686f7def12a55519fe25905218c2ab33320fea4bafc40778a5a08cb3855023e99f29b244a2d29dc1ed2f774", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad7250da4f2cbfe1051feb1f48dd53649f49ad6ff71ea21e850435ffe5e03302fc64d7fd5d8b8d6292a7d9d923d5dac3c4503dc0afba7dc20c9a55f2f0448e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309c170d3a8c01732908945fcbab0425738eddfa9c47e35bd3c4160fefd9ffcf5816db1c401f9ba14aa90ad9604c9e960ef5447f64a434542ceb796c09908afd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 14:27:30.862258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:27:30.862703) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467060418.911823-48714923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:27:30.947481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 14:27:30.947843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 14:27:30.948185) ========= ========= Total master_lag: 0.19 =========