builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1467051381.2 results: success (0) buildid: 20160627083118 builduid: 68f55c1ee9ae4b7a8f5a97ed4a19b275 revision: 3c55e34b5259d9e656f93b18f2aebe46af09a732 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.202139) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.202597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.202905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.218801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.219303) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 11:16:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-27 11:16:21 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187762 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.422464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.422825) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016484 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.473108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:21.473525) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c55e34b5259d9e656f93b18f2aebe46af09a732 --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 3c55e34b5259d9e656f93b18f2aebe46af09a732 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 11:16:21,626 truncating revision to first 12 chars 2016-06-27 11:16:21,626 Setting DEBUG logging. 2016-06-27 11:16:21,626 attempt 1/10 2016-06-27 11:16:21,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c55e34b5259?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 11:16:21,934 unpacking tar archive at: fx-team-3c55e34b5259/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639208 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:22.129281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:22.129670) ========= script_repo_revision: 3c55e34b5259d9e656f93b18f2aebe46af09a732 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:22.130178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:22.130511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:22.141799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-27 11:16:22.142353) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:22 INFO - MultiFileLogger online at 20160627 11:16:22 in /builds/slave/test 11:16:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:16:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:22 INFO - {'append_to_log': False, 11:16:22 INFO - 'base_work_dir': '/builds/slave/test', 11:16:22 INFO - 'blob_upload_branch': 'Fx-Team', 11:16:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:22 INFO - 'branch': 'Fx-Team', 11:16:22 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:22 INFO - 'config_files': ('talos/linux_config.py',), 11:16:22 INFO - 'default_actions': ('clobber', 11:16:22 INFO - 'read-buildbot-config', 11:16:22 INFO - 'download-and-extract', 11:16:22 INFO - 'populate-webroot', 11:16:22 INFO - 'create-virtualenv', 11:16:22 INFO - 'install', 11:16:22 INFO - 'run-tests'), 11:16:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:22 INFO - 'download_minidump_stackwalk': True, 11:16:22 INFO - 'download_symbols': 'ondemand', 11:16:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:22 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:22 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:22 INFO - 'installer_path': 'installer.exe', 11:16:22 INFO - 'log_level': 'info', 11:16:22 INFO - 'log_name': 'talos', 11:16:22 INFO - 'log_to_console': True, 11:16:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:22 INFO - 'opt_config_files': (), 11:16:22 INFO - 'pip_index': False, 11:16:22 INFO - 'sps_profile': False, 11:16:22 INFO - 'sps_profile_interval': 0, 11:16:22 INFO - 'suite': 'dromaeojs', 11:16:22 INFO - 'system_bits': '32', 11:16:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:22 INFO - 'title': 'talos-linux64-ix-012', 11:16:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:22 INFO - 'use_talos_json': True, 11:16:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:22 INFO - 'work_dir': 'build'} 11:16:22 INFO - ##### 11:16:22 INFO - ##### Running clobber step. 11:16:22 INFO - ##### 11:16:22 INFO - Running pre-action listener: _resource_record_pre_action 11:16:22 INFO - Running main action method: clobber 11:16:22 INFO - rmtree: /builds/slave/test/build 11:16:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:23 INFO - Running post-action listener: _resource_record_post_action 11:16:23 INFO - ##### 11:16:23 INFO - ##### Finished clobber step (success) 11:16:23 INFO - ##### 11:16:23 INFO - ##### 11:16:23 INFO - ##### Running read-buildbot-config step. 11:16:23 INFO - ##### 11:16:23 INFO - Running pre-action listener: _resource_record_pre_action 11:16:23 INFO - Running main action method: read_buildbot_config 11:16:23 INFO - Using buildbot properties: 11:16:23 INFO - { 11:16:23 INFO - "project": "", 11:16:23 INFO - "product": "firefox", 11:16:23 INFO - "script_repo_revision": "production", 11:16:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:16:23 INFO - "repository": "", 11:16:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:16:23 INFO - "buildid": "20160627083118", 11:16:23 INFO - "pgo_build": "True", 11:16:23 INFO - "basedir": "/builds/slave/test", 11:16:23 INFO - "buildnumber": 1283, 11:16:23 INFO - "slavename": "talos-linux64-ix-012", 11:16:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:16:23 INFO - "platform": "ubuntu64_hw", 11:16:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:16:23 INFO - "branch": "fx-team", 11:16:23 INFO - "repo_path": "integration/fx-team", 11:16:23 INFO - "revision": "3c55e34b5259d9e656f93b18f2aebe46af09a732", 11:16:23 INFO - "stage_platform": "linux64-pgo", 11:16:23 INFO - "builduid": "68f55c1ee9ae4b7a8f5a97ed4a19b275", 11:16:23 INFO - "slavebuilddir": "test" 11:16:23 INFO - } 11:16:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:16:23 INFO - Running post-action listener: _resource_record_post_action 11:16:23 INFO - ##### 11:16:23 INFO - ##### Finished read-buildbot-config step (success) 11:16:23 INFO - ##### 11:16:23 INFO - ##### 11:16:23 INFO - ##### Running download-and-extract step. 11:16:23 INFO - ##### 11:16:23 INFO - Running pre-action listener: _resource_record_pre_action 11:16:23 INFO - Running main action method: download_and_extract 11:16:23 INFO - mkdir: /builds/slave/test/build/tests 11:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:23 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:16:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:16:29 INFO - Downloaded 1361 bytes. 11:16:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:29 INFO - Using the following test package requirements: 11:16:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:16:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:16:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'jsshell-linux-x86_64.zip'], 11:16:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:16:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:16:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:16:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:16:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:16:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:16: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')]} 11:16:29 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:32 INFO - Downloaded 24280069 bytes. 11:16:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:16:33 INFO - Return code: 0 11:16:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:33 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:44 INFO - Downloaded 24280069 bytes. 11:16:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:16:46 INFO - Return code: 0 11:16: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')]} 11:16:46 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:16:47 INFO - Downloaded 14405245 bytes. 11:16:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:16:48 INFO - Return code: 0 11:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:48 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:16:52 INFO - Downloaded 60200994 bytes. 11:16:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:52 INFO - mkdir: /builds/slave/test/properties 11:16:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:52 INFO - Contents: 11:16:52 INFO - build_url:https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:53 INFO - Running post-action listener: _resource_record_post_action 11:16:53 INFO - Running post-action listener: set_extra_try_arguments 11:16:53 INFO - ##### 11:16:53 INFO - ##### Finished download-and-extract step (success) 11:16:53 INFO - ##### 11:16:53 INFO - ##### 11:16:53 INFO - ##### Running populate-webroot step. 11:16:53 INFO - ##### 11:16:53 INFO - Running pre-action listener: _resource_record_pre_action 11:16:53 INFO - Running main action method: populate_webroot 11:16:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:53 INFO - '--tppagecycles', 11:16:53 INFO - '7'], 11:16:53 INFO - 'tests': ['tsvgm']}}, 11:16:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['damp', 'tps']}, 11:16:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'tests': ['damp', 'tps']}, 11:16:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['dromaeo_dom']}, 11:16:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['basic_compositor_video']}, 11:16:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:16:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['a11yr', 11:16:53 INFO - 'ts_paint', 11:16:53 INFO - 'tpaint', 11:16:53 INFO - 'sessionrestore', 11:16:53 INFO - 'sessionrestore_no_auto_restore', 11:16:53 INFO - 'tabpaint']}, 11:16:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:53 INFO - 'ts_paint', 11:16:53 INFO - 'tpaint', 11:16:53 INFO - 'sessionrestore', 11:16:53 INFO - 'sessionrestore_no_auto_restore', 11:16:53 INFO - 'tabpaint']}, 11:16:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:53 INFO - 'ts_paint', 11:16:53 INFO - 'tpaint', 11:16:53 INFO - 'sessionrestore', 11:16:53 INFO - 'sessionrestore_no_auto_restore', 11:16:53 INFO - 'tabpaint']}, 11:16:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:53 INFO - 'ts_paint', 11:16:53 INFO - 'tpaint', 11:16:53 INFO - 'sessionrestore', 11:16:53 INFO - 'sessionrestore_no_auto_restore', 11:16:53 INFO - 'tabpaint']}, 11:16:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['a11yr', 11:16:53 INFO - 'ts_paint', 11:16:53 INFO - 'tpaint', 11:16:53 INFO - 'sessionrestore', 11:16:53 INFO - 'sessionrestore_no_auto_restore', 11:16:53 INFO - 'tabpaint']}, 11:16:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['a11yr', 11:16:53 INFO - 'ts_paint', 11:16:53 INFO - 'tpaint', 11:16:53 INFO - 'sessionrestore', 11:16:53 INFO - 'sessionrestore_no_auto_restore', 11:16:53 INFO - 'tabpaint']}, 11:16:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['tsvgx', 11:16:53 INFO - 'tsvgr_opacity', 11:16:53 INFO - 'tart', 11:16:53 INFO - 'tscrollx', 11:16:53 INFO - 'cart']}, 11:16:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:53 INFO - 'tsvgr_opacity', 11:16:53 INFO - 'tart', 11:16:53 INFO - 'tscrollx', 11:16:53 INFO - 'cart']}, 11:16:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'talos_options': ['--disable-e10s'], 11:16:53 INFO - 'tests': ['tp5o']}, 11:16:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'tests': ['tp5o']}, 11:16:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'talos_options': ['--disable-e10s', 11:16:53 INFO - '--xperf_path', 11:16:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:53 INFO - 'tests': ['tp5n']}, 11:16:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:53 INFO - 'talos_options': ['--xperf_path', 11:16:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:53 INFO - 'tests': ['tp5n']}}, 11:16:53 INFO - 'talos.zip': {'path': '', 11:16:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:53 INFO - Running post-action listener: _resource_record_post_action 11:16:53 INFO - ##### 11:16:53 INFO - ##### Finished populate-webroot step (success) 11:16:53 INFO - ##### 11:16:53 INFO - ##### 11:16:53 INFO - ##### Running create-virtualenv step. 11:16:53 INFO - ##### 11:16:53 INFO - Running pre-action listener: _resource_record_pre_action 11:16:53 INFO - Running main action method: create_virtualenv 11:16:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:16:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:53 INFO - Using real prefix '/usr' 11:16:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:56 INFO - Installing pip.................done. 11:16:56 INFO - Return code: 0 11:16:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:56 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:16:56 INFO - Using env: {'DISPLAY': ':0', 11:16:56 INFO - 'HOME': '/home/cltbld', 11:16:56 INFO - 'LANG': 'en_US.UTF-8', 11:16:56 INFO - 'LANGUAGE': 'en_US:en', 11:16:56 INFO - 'LOGNAME': 'cltbld', 11:16:56 INFO - 'MAIL': '/var/mail/cltbld', 11:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:56 INFO - 'MOZ_NO_REMOTE': '1', 11:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:56 INFO - 'NO_EM_RESTART': '1', 11:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:56 INFO - 'PWD': '/builds/slave/test', 11:16:56 INFO - 'SHELL': '/bin/bash', 11:16:56 INFO - 'SHLVL': '1', 11:16:56 INFO - 'TERM': 'linux', 11:16:56 INFO - 'TMOUT': '86400', 11:16:56 INFO - 'USER': 'cltbld', 11:16:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:56 INFO - '_': '/tools/buildbot/bin/python'} 11:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:16:56 INFO - Cleaning up... 11:16:56 INFO - Return code: 0 11:16:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:56 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:16:56 INFO - Using env: {'DISPLAY': ':0', 11:16:56 INFO - 'HOME': '/home/cltbld', 11:16:56 INFO - 'LANG': 'en_US.UTF-8', 11:16:56 INFO - 'LANGUAGE': 'en_US:en', 11:16:56 INFO - 'LOGNAME': 'cltbld', 11:16:56 INFO - 'MAIL': '/var/mail/cltbld', 11:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:56 INFO - 'MOZ_NO_REMOTE': '1', 11:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:56 INFO - 'NO_EM_RESTART': '1', 11:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:56 INFO - 'PWD': '/builds/slave/test', 11:16:56 INFO - 'SHELL': '/bin/bash', 11:16:56 INFO - 'SHLVL': '1', 11:16:56 INFO - 'TERM': 'linux', 11:16:56 INFO - 'TMOUT': '86400', 11:16:56 INFO - 'USER': 'cltbld', 11:16:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:56 INFO - '_': '/tools/buildbot/bin/python'} 11:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:56 INFO - Downloading/unpacking psutil>=3.1.1 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:58 INFO - Installing collected packages: psutil 11:16:58 INFO - Running setup.py install for psutil 11:16:58 INFO - building 'psutil._psutil_linux' extension 11:16:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:16:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:16:58 INFO - building 'psutil._psutil_posix' extension 11:16:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:16:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:16:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:58 INFO - Successfully installed psutil 11:16:58 INFO - Cleaning up... 11:16:59 INFO - Return code: 0 11:16:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:59 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:16:59 INFO - Using env: {'DISPLAY': ':0', 11:16:59 INFO - 'HOME': '/home/cltbld', 11:16:59 INFO - 'LANG': 'en_US.UTF-8', 11:16:59 INFO - 'LANGUAGE': 'en_US:en', 11:16:59 INFO - 'LOGNAME': 'cltbld', 11:16:59 INFO - 'MAIL': '/var/mail/cltbld', 11:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:59 INFO - 'MOZ_NO_REMOTE': '1', 11:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:59 INFO - 'NO_EM_RESTART': '1', 11:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:59 INFO - 'PWD': '/builds/slave/test', 11:16:59 INFO - 'SHELL': '/bin/bash', 11:16:59 INFO - 'SHLVL': '1', 11:16:59 INFO - 'TERM': 'linux', 11:16:59 INFO - 'TMOUT': '86400', 11:16:59 INFO - 'USER': 'cltbld', 11:16:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:59 INFO - '_': '/tools/buildbot/bin/python'} 11:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:01 INFO - Installing collected packages: mozsystemmonitor 11:17:01 INFO - Running setup.py install for mozsystemmonitor 11:17:01 INFO - Successfully installed mozsystemmonitor 11:17:01 INFO - Cleaning up... 11:17:01 INFO - Return code: 0 11:17:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:01 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:17:01 INFO - Using env: {'DISPLAY': ':0', 11:17:01 INFO - 'HOME': '/home/cltbld', 11:17:01 INFO - 'LANG': 'en_US.UTF-8', 11:17:01 INFO - 'LANGUAGE': 'en_US:en', 11:17:01 INFO - 'LOGNAME': 'cltbld', 11:17:01 INFO - 'MAIL': '/var/mail/cltbld', 11:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:01 INFO - 'MOZ_NO_REMOTE': '1', 11:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:01 INFO - 'NO_EM_RESTART': '1', 11:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:01 INFO - 'PWD': '/builds/slave/test', 11:17:01 INFO - 'SHELL': '/bin/bash', 11:17:01 INFO - 'SHLVL': '1', 11:17:01 INFO - 'TERM': 'linux', 11:17:01 INFO - 'TMOUT': '86400', 11:17:01 INFO - 'USER': 'cltbld', 11:17:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:01 INFO - '_': '/tools/buildbot/bin/python'} 11:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:03 INFO - warning: no files found matching '*.txt' 11:17:03 INFO - no previously-included directories found matching 'build' 11:17:03 INFO - no previously-included directories found matching 'dist' 11:17:03 INFO - no previously-included directories found matching '.git*' 11:17:03 INFO - Installing collected packages: jsonschema, functools32 11:17:03 INFO - Running setup.py install for functools32 11:17:03 INFO - warning: no files found matching '*.txt' 11:17:03 INFO - no previously-included directories found matching 'build' 11:17:03 INFO - no previously-included directories found matching 'dist' 11:17:03 INFO - no previously-included directories found matching '.git*' 11:17:03 INFO - Successfully installed jsonschema functools32 11:17:03 INFO - Cleaning up... 11:17:03 INFO - Return code: 0 11:17:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:17:03 INFO - Using env: {'DISPLAY': ':0', 11:17:03 INFO - 'HOME': '/home/cltbld', 11:17:03 INFO - 'LANG': 'en_US.UTF-8', 11:17:03 INFO - 'LANGUAGE': 'en_US:en', 11:17:03 INFO - 'LOGNAME': 'cltbld', 11:17:03 INFO - 'MAIL': '/var/mail/cltbld', 11:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:03 INFO - 'MOZ_NO_REMOTE': '1', 11:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:03 INFO - 'NO_EM_RESTART': '1', 11:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:04 INFO - 'PWD': '/builds/slave/test', 11:17:04 INFO - 'SHELL': '/bin/bash', 11:17:04 INFO - 'SHLVL': '1', 11:17:04 INFO - 'TERM': 'linux', 11:17:04 INFO - 'TMOUT': '86400', 11:17:04 INFO - 'USER': 'cltbld', 11:17:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:04 INFO - '_': '/tools/buildbot/bin/python'} 11:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Downloading docopt-0.6.1.tar.gz 11:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:07 INFO - Running setup.py install for blobuploader 11:17:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:07 INFO - Running setup.py install for requests 11:17:08 INFO - Running setup.py install for docopt 11:17:08 INFO - Successfully installed blobuploader requests docopt 11:17:08 INFO - Cleaning up... 11:17:08 INFO - Return code: 0 11:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:08 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:08 INFO - Using env: {'DISPLAY': ':0', 11:17:08 INFO - 'HOME': '/home/cltbld', 11:17:08 INFO - 'LANG': 'en_US.UTF-8', 11:17:08 INFO - 'LANGUAGE': 'en_US:en', 11:17:08 INFO - 'LOGNAME': 'cltbld', 11:17:08 INFO - 'MAIL': '/var/mail/cltbld', 11:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:08 INFO - 'MOZ_NO_REMOTE': '1', 11:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:08 INFO - 'NO_EM_RESTART': '1', 11:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:08 INFO - 'PWD': '/builds/slave/test', 11:17:08 INFO - 'SHELL': '/bin/bash', 11:17:08 INFO - 'SHLVL': '1', 11:17:08 INFO - 'TERM': 'linux', 11:17:08 INFO - 'TMOUT': '86400', 11:17:08 INFO - 'USER': 'cltbld', 11:17:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:08 INFO - '_': '/tools/buildbot/bin/python'} 11:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:08 INFO - Running setup.py (path:/tmp/pip-ssT0Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:08 INFO - Running setup.py (path:/tmp/pip-UAmyfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:08 INFO - Running setup.py (path:/tmp/pip-J7BnnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:08 INFO - Running setup.py (path:/tmp/pip-3crPww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:09 INFO - Running setup.py (path:/tmp/pip-83ozgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:09 INFO - Running setup.py (path:/tmp/pip-REPTKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:09 INFO - Running setup.py (path:/tmp/pip-ymQpMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:09 INFO - Running setup.py (path:/tmp/pip-DeAZ5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:09 INFO - Running setup.py (path:/tmp/pip-DstH8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:09 INFO - Running setup.py (path:/tmp/pip-Eug7bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:09 INFO - Running setup.py (path:/tmp/pip-vFAr48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:09 INFO - Running setup.py (path:/tmp/pip-Yyv6bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:09 INFO - Running setup.py (path:/tmp/pip-XeGkPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:09 INFO - Running setup.py (path:/tmp/pip-n_nTSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:09 INFO - Running setup.py (path:/tmp/pip-F_0WD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:09 INFO - Running setup.py (path:/tmp/pip-RUdgy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:09 INFO - Running setup.py (path:/tmp/pip-ISJ5cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:09 INFO - Running setup.py install for manifestparser 11:17:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Running setup.py install for mozcrash 11:17:10 INFO - Running setup.py install for mozdebug 11:17:10 INFO - Running setup.py install for mozdevice 11:17:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Running setup.py install for mozfile 11:17:10 INFO - Running setup.py install for mozhttpd 11:17:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Running setup.py install for mozinfo 11:17:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Running setup.py install for mozInstall 11:17:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Running setup.py install for mozleak 11:17:10 INFO - Running setup.py install for mozlog 11:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Running setup.py install for moznetwork 11:17:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozprocess 11:17:11 INFO - Running setup.py install for mozprofile 11:17:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozrunner 11:17:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozscreenshot 11:17:11 INFO - Running setup.py install for moztest 11:17:11 INFO - Running setup.py install for mozversion 11:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:11 INFO - Cleaning up... 11:17:11 INFO - Return code: 0 11:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:11 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:11 INFO - Using env: {'DISPLAY': ':0', 11:17:11 INFO - 'HOME': '/home/cltbld', 11:17:11 INFO - 'LANG': 'en_US.UTF-8', 11:17:11 INFO - 'LANGUAGE': 'en_US:en', 11:17:11 INFO - 'LOGNAME': 'cltbld', 11:17:11 INFO - 'MAIL': '/var/mail/cltbld', 11:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:11 INFO - 'MOZ_NO_REMOTE': '1', 11:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:11 INFO - 'NO_EM_RESTART': '1', 11:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:11 INFO - 'PWD': '/builds/slave/test', 11:17:11 INFO - 'SHELL': '/bin/bash', 11:17:11 INFO - 'SHLVL': '1', 11:17:11 INFO - 'TERM': 'linux', 11:17:11 INFO - 'TMOUT': '86400', 11:17:11 INFO - 'USER': 'cltbld', 11:17:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:11 INFO - '_': '/tools/buildbot/bin/python'} 11:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:11 INFO - Running setup.py (path:/tmp/pip-rEuBVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:12 INFO - Running setup.py (path:/tmp/pip-HELJMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:12 INFO - Running setup.py (path:/tmp/pip-hhZZfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:12 INFO - Running setup.py (path:/tmp/pip-ighLdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:12 INFO - Running setup.py (path:/tmp/pip-0Bv2tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:12 INFO - Running setup.py (path:/tmp/pip-8lCo8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:12 INFO - Running setup.py (path:/tmp/pip-T2yAgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:12 INFO - Running setup.py (path:/tmp/pip-br9Vzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:12 INFO - Running setup.py (path:/tmp/pip-hD3f5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:12 INFO - Running setup.py (path:/tmp/pip-NsBqDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:12 INFO - Running setup.py (path:/tmp/pip-3i7KlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:12 INFO - Running setup.py (path:/tmp/pip-ViuNbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:12 INFO - Running setup.py (path:/tmp/pip-VH87Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:12 INFO - Running setup.py (path:/tmp/pip-98Q3vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:12 INFO - Running setup.py (path:/tmp/pip-65PI8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:13 INFO - Running setup.py (path:/tmp/pip-ZWVcK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:13 INFO - Running setup.py (path:/tmp/pip-3RUWUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:15 INFO - Downloading blessings-1.6.tar.gz 11:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:15 INFO - Installing collected packages: blessings 11:17:15 INFO - Running setup.py install for blessings 11:17:15 INFO - Successfully installed blessings 11:17:15 INFO - Cleaning up... 11:17:15 INFO - Return code: 0 11:17:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:15 INFO - Reading from file tmpfile_stdout 11:17:15 INFO - Current package versions: 11:17:15 INFO - argparse == 1.2.1 11:17:15 INFO - blessings == 1.6 11:17:15 INFO - blobuploader == 1.2.4 11:17:15 INFO - docopt == 0.6.1 11:17:15 INFO - functools32 == 3.2.3-2 11:17:15 INFO - jsonschema == 2.5.1 11:17:15 INFO - manifestparser == 1.1 11:17:15 INFO - mozInstall == 1.12 11:17:15 INFO - mozcrash == 0.17 11:17:15 INFO - mozdebug == 0.1 11:17:15 INFO - mozdevice == 0.48 11:17:15 INFO - mozfile == 1.2 11:17:15 INFO - mozhttpd == 0.7 11:17:15 INFO - mozinfo == 0.9 11:17:15 INFO - mozleak == 0.1 11:17:15 INFO - mozlog == 3.2 11:17:15 INFO - moznetwork == 0.27 11:17:15 INFO - mozprocess == 0.22 11:17:15 INFO - mozprofile == 0.28 11:17:15 INFO - mozrunner == 6.11 11:17:15 INFO - mozscreenshot == 0.1 11:17:15 INFO - mozsystemmonitor == 0.3 11:17:15 INFO - moztest == 0.7 11:17:15 INFO - mozversion == 1.4 11:17:15 INFO - psutil == 3.1.1 11:17:15 INFO - requests == 1.2.3 11:17:15 INFO - wsgiref == 0.1.2 11:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:15 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:15 INFO - Using env: {'DISPLAY': ':0', 11:17:15 INFO - 'HOME': '/home/cltbld', 11:17:15 INFO - 'LANG': 'en_US.UTF-8', 11:17:15 INFO - 'LANGUAGE': 'en_US:en', 11:17:15 INFO - 'LOGNAME': 'cltbld', 11:17:15 INFO - 'MAIL': '/var/mail/cltbld', 11:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:15 INFO - 'MOZ_NO_REMOTE': '1', 11:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:15 INFO - 'NO_EM_RESTART': '1', 11:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:15 INFO - 'PWD': '/builds/slave/test', 11:17:15 INFO - 'SHELL': '/bin/bash', 11:17:15 INFO - 'SHLVL': '1', 11:17:15 INFO - 'TERM': 'linux', 11:17:15 INFO - 'TMOUT': '86400', 11:17:15 INFO - 'USER': 'cltbld', 11:17:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:15 INFO - '_': '/tools/buildbot/bin/python'} 11:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:17:15 INFO - Cleaning up... 11:17:15 INFO - Return code: 0 11:17:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17: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'] in /builds/slave/test/build 11:17: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 11:17:15 INFO - Using env: {'DISPLAY': ':0', 11:17:15 INFO - 'HOME': '/home/cltbld', 11:17:15 INFO - 'LANG': 'en_US.UTF-8', 11:17:15 INFO - 'LANGUAGE': 'en_US:en', 11:17:15 INFO - 'LOGNAME': 'cltbld', 11:17:15 INFO - 'MAIL': '/var/mail/cltbld', 11:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:15 INFO - 'MOZ_NO_REMOTE': '1', 11:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:15 INFO - 'NO_EM_RESTART': '1', 11:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:15 INFO - 'PWD': '/builds/slave/test', 11:17:15 INFO - 'SHELL': '/bin/bash', 11:17:15 INFO - 'SHLVL': '1', 11:17:15 INFO - 'TERM': 'linux', 11:17:15 INFO - 'TMOUT': '86400', 11:17:15 INFO - 'USER': 'cltbld', 11:17:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:15 INFO - '_': '/tools/buildbot/bin/python'} 11:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:16 INFO - Cleaning up... 11:17:16 INFO - Return code: 0 11:17:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:16 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 0x7fb38d780f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:17:16 INFO - Using env: {'DISPLAY': ':0', 11:17:16 INFO - 'HOME': '/home/cltbld', 11:17:16 INFO - 'LANG': 'en_US.UTF-8', 11:17:16 INFO - 'LANGUAGE': 'en_US:en', 11:17:16 INFO - 'LOGNAME': 'cltbld', 11:17:16 INFO - 'MAIL': '/var/mail/cltbld', 11:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:16 INFO - 'MOZ_NO_REMOTE': '1', 11:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:16 INFO - 'NO_EM_RESTART': '1', 11:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:16 INFO - 'PWD': '/builds/slave/test', 11:17:16 INFO - 'SHELL': '/bin/bash', 11:17:16 INFO - 'SHLVL': '1', 11:17:16 INFO - 'TERM': 'linux', 11:17:16 INFO - 'TMOUT': '86400', 11:17:16 INFO - 'USER': 'cltbld', 11:17:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:16 INFO - '_': '/tools/buildbot/bin/python'} 11:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:16 INFO - Downloading/unpacking flake8 11:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:17:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:17:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:19 INFO - no previously-included directories found matching 'docs/_build' 11:17:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:17:19 INFO - Running setup.py install for pep8 11:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:19 INFO - no previously-included directories found matching 'docs/_build' 11:17:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:17:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:17:19 INFO - Cleaning up... 11:17:19 INFO - Return code: 0 11:17:19 INFO - Running post-action listener: _resource_record_post_action 11:17:19 INFO - Running post-action listener: _start_resource_monitoring 11:17:19 INFO - Starting resource monitoring. 11:17:19 INFO - ##### 11:17:19 INFO - ##### Finished create-virtualenv step (success) 11:17:19 INFO - ##### 11:17:19 INFO - ##### 11:17:19 INFO - ##### Running install step. 11:17:19 INFO - ##### 11:17:19 INFO - Running pre-action listener: _resource_record_pre_action 11:17:19 INFO - Running main action method: install 11:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:19 INFO - Reading from file tmpfile_stdout 11:17:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:19 INFO - Reading from file tmpfile_stdout 11:17:19 INFO - Output received: 11:17:19 INFO - Usage: mozinstall [options] installer 11:17:19 INFO - Options: 11:17:19 INFO - -h, --help show this help message and exit 11:17:19 INFO - -d DEST, --destination=DEST 11:17:19 INFO - Directory to install application into. [default: 11:17:19 INFO - "/builds/slave/test"] 11:17:19 INFO - --app=APP Application being installed. [default: firefox] 11:17:19 INFO - mkdir: /builds/slave/test/build/application 11:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:17:36 INFO - Reading from file tmpfile_stdout 11:17:36 INFO - Output received: 11:17:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:36 INFO - Running post-action listener: _resource_record_post_action 11:17:36 INFO - ##### 11:17:36 INFO - ##### Finished install step (success) 11:17:36 INFO - ##### 11:17:36 INFO - ##### 11:17:36 INFO - ##### Running run-tests step. 11:17:36 INFO - ##### 11:17:36 INFO - Running pre-action listener: _resource_record_pre_action 11:17:36 INFO - Running main action method: run_tests 11:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:36 INFO - Python 2.7.3 11:17:36 INFO - Return code: 0 11:17:36 INFO - grabbing minidump binary from tooltool 11:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:36 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 0x116c6f0>, '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 0x116d5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116daa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:17:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:17:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:17:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:36 INFO - Return code: 0 11:17:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:17:37 INFO - Return code: 0 11:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:17:37 INFO - Using env: {'DISPLAY': ':0', 11:17:37 INFO - 'HOME': '/home/cltbld', 11:17:37 INFO - 'LANG': 'en_US.UTF-8', 11:17:37 INFO - 'LANGUAGE': 'en_US:en', 11:17:37 INFO - 'LOGNAME': 'cltbld', 11:17:37 INFO - 'MAIL': '/var/mail/cltbld', 11:17:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:37 INFO - 'MOZ_NO_REMOTE': '1', 11:17:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:37 INFO - 'NO_EM_RESTART': '1', 11:17:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:37 INFO - 'PWD': '/builds/slave/test', 11:17:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:37 INFO - 'SHELL': '/bin/bash', 11:17:37 INFO - 'SHLVL': '1', 11:17:37 INFO - 'TERM': 'linux', 11:17:37 INFO - 'TMOUT': '86400', 11:17:37 INFO - 'USER': 'cltbld', 11:17:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124', 11:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:37 INFO - '_': '/tools/buildbot/bin/python'} 11:17:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:17:38 INFO - mozversion application_buildid: 20160627083118 11:17:38 INFO - mozversion application_changeset: 3c55e34b5259d9e656f93b18f2aebe46af09a732 11:17:38 INFO - mozversion application_display_name: Nightly 11:17:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:38 INFO - mozversion application_name: Firefox 11:17:38 INFO - mozversion application_remotingname: firefox 11:17:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:17:38 INFO - mozversion application_vendor: Mozilla 11:17:38 INFO - mozversion application_version: 50.0a1 11:17:38 INFO - mozversion platform_buildid: 20160627083118 11:17:38 INFO - mozversion platform_changeset: 3c55e34b5259d9e656f93b18f2aebe46af09a732 11:17:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:38 INFO - mozversion platform_version: 50.0a1 11:17:38 INFO - using testdate: 1467051458 11:17:38 INFO - actual date: 1467051458 11:17:38 INFO - starting webserver on 'localhost:52073' 11:17:38 INFO - SUITE-START | Running 2 tests 11:17:38 INFO - TEST-START | dromaeo_css 11:17:38 INFO - operating with platform_type : linux_ 11:17:38 INFO - Initialising browser for dromaeo_css test... 11:17:38 INFO - TEST-INFO | started process 12416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLeTAt/profile http://localhost:52073/getInfo.html) 11:17:41 INFO - PROCESS | 12416 | __metrics Screen width/height:1600/1200 11:17:41 INFO - PROCESS | 12416 | colorDepth:24 11:17:41 INFO - PROCESS | 12416 | Browser inner width/height: 1024/697 11:17:41 INFO - PROCESS | 12416 | __metrics 11:17:42 INFO - PROCESS | 12416 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:17:43 INFO - TEST-INFO | 12416: exit 0 11:17:43 INFO - Browser initialized. 11:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:43 INFO - TEST-INFO | started process 12499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLeTAt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:55 INFO - PROCESS | 12499 | RSS: Main: 173457408 11:17:55 INFO - PROCESS | 12499 | 11:18:46 INFO - PROCESS | 12499 | 1467051526420 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:20:55 INFO - PROCESS | 12499 | Cycle 1(1): loaded http://localhost:52073/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52073/tests/dromaeo/cssquery-ext.html) 11:20:56 INFO - PROCESS | 12499 | RSS: Main: 259964928 11:20:56 INFO - PROCESS | 12499 | 11:23:58 INFO - PROCESS | 12499 | Cycle 1(1): loaded http://localhost:52073/tests/dromaeo/cssquery-ext.html (next: http://localhost:52073/tests/dromaeo/cssquery-jquery.html) 11:23:59 INFO - PROCESS | 12499 | RSS: Main: 260071424 11:23:59 INFO - PROCESS | 12499 | 11:27:01 INFO - PROCESS | 12499 | Cycle 1(1): loaded http://localhost:52073/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52073/tests/dromaeo/cssquery-mootools.html) 11:27:01 INFO - PROCESS | 12499 | RSS: Main: 265670656 11:27:01 INFO - PROCESS | 12499 | 11:30:03 INFO - PROCESS | 12499 | Cycle 1(1): loaded http://localhost:52073/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52073/tests/dromaeo/cssquery-prototype.html) 11:30:04 INFO - PROCESS | 12499 | RSS: Main: 258879488 11:30:04 INFO - PROCESS | 12499 | 11:33:07 INFO - PROCESS | 12499 | Cycle 1(1): loaded http://localhost:52073/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52073/tests/dromaeo/cssquery-yui.html) 11:33:07 INFO - PROCESS | 12499 | RSS: Main: 241852416 11:33:07 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | Cycle 1(1): loaded http://localhost:52073/tests/dromaeo/cssquery-yui.html (next: http://localhost:52073/tests/dromaeo/cssquery-dojo.html) 11:36:10 INFO - PROCESS | 12499 | RSS: Main: 303042560 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | __start_tp_report 11:36:10 INFO - PROCESS | 12499 | _x_x_mozilla_page_load 11:36:10 INFO - PROCESS | 12499 | _x_x_mozilla_page_load_details 11:36:10 INFO - PROCESS | 12499 | |i|pagename|runs| 11:36:10 INFO - PROCESS | 12499 | |0;dojo.html;3112.1752735525083;3119.578856854324;3140.1207661854687;3143;3183.6338821035574;5265.8946821063655;5342.465753424665;5349.358077030757;5416.187571864222;5432.402435732066;5285.973570132153;5303.178007408848;5355.571554275658;5358.517733403993;5368.516833484986;4797.999999999991;4823.903521929559;4865.586425153866;4874.561289483946;5025.949740502585;4932.482089380617;4940.6788558743565;4967.031428871372;4985.551300382965;4996.500349964993;4758.619310455173;4803.495632958524;4820.156472617313;4848.345473361122;4910.558049775537;4848.248521479177;4856.05306965142;4860.781264843055;4865.19724245499;4965.428975667808;4852.781624826891;4876.975615121937;4884.706917584921;4893.6329775266995;4955.4548999610015;5229.320188375525;5310.548603368679;5389.865253368658;5394.622376433651;5401.486858748452;5765.942340576625;5776.393478684761;5816.1566572846705;5825.300963884319;5832.6792026438525;5846.415358464162;5874.823755287348;5877.588568800185;5887.8528036799;5888.941110588925;5254.789808407659;5379.865503362408;5434.619576629598;5438.129899216146;5440.047991601454;5904.7342869570975;5964.7912323068485;5965.701714914324;5970.9701451492465;5976.970115149484;5483.670979741149;5737.741801618937;5746.741396637161;5748.626339287933;5748.9712551437815;5634.154876768517;5683.204351390808;5693.089105743061;5699.373068962411;5710.200571919934;5679.716014199274;5696.51579615729;5697.943020569741;5698.230738850285;5705.971470142623;5596.86007849807;5676.176954341598;5685.289338832646;5691;5692.971535142381;4360.106178233455;4365.301551751704;4385.057212699285;4423.734575925455;4436.3123715824095;3900.64894159527;3922.7254092213843;3936.527616686016;3938.8424463021156;3968.40473928913;5246;5304.787808487695;5355.384130825005;5426.75579598919;5470.9452905471235;5697.544196464273;5719.971400143056;5738.282714660668;5743.2246646703;5782.248307720053;5380.677159370451;5392.352917649907;5392.433794451605;5393.514583687408;5399.244105825188;4883.609311255091;4968.552830245295;4968.826091086795;4995.700257984533;5007.7245751484015;5994.3705910878725;6065.848353791191;6068;6068.120122582201;6127.448529632355;5830.53355731549;5842.824715258549;5849.502792262705;5854.268216472941;5854.502367298657;5835.94164058371;5930.436608522184;5932.139839723302;6052.455279024909;6065.484433822998;5634.183043458594;5686.118651609007;5686.77252909879;5724.79963201286;5758.481736643722;5811.215485909517;5819.94180058194;5820.679862607597;5821.825345239649;5823.970880145572;5427.240186373831;5573.7770489179975;5576.302962129734;5643.3792282848035;5645.830625081254;5670.376258611467;5683.658980461186;5685.005124103182;5688.971555142198;5692.544596432358;5598.440155984369;5606.6636001840025;5607.579431542569;5607.579431542569;5611.859703507445;5497.615166938436;5647.6893770843;5683.8010669626365;5701.030824759718;5759.107338362561;5545.667259964253;5564.332280126248;5571.359293681278;5578.748956296895;5587 11:36:10 INFO - PROCESS | 12499 | |1;ext.html;586.7799575159315;607.7599348257438;610.2372034956304;623.3672822085582;630.5806638585341;31003.68996310036;31457.21356966077;34057.829710851445;42949.57050429495;44539.554604453944;45737.77131114348;46334;46349;46366;46368.304475432895;8988.955055224715;9154.862677059817;9157.771055723593;9158.40470369424;9165.72502824913;8866.689665861697;8909.73270801877;8920.643174273022;8941.150590693873;9027.277817774595;9059.95470022649;9102.954485227565;9108.544572771369;9114.043025482328;9118.088191180896;8973.955130224373;9010.684626038123;9018.098190180963;9028.052054534312;9030.096990300983;8854.645814167425;8927.910720892773;8931.50876701781;8974.86537701935;8986.640534378617;42743.35884961697;42973.78513107446;43186;43195;43240.78379608113;3588.282343531278;3694.612065733086;3703.5000274962804;3721.3673675475234;4231.42875711778;33332.3333533328;33721.83139084314;34089.14777130567;34450.483242751376;34550.48174277388;4273.188832254401;4362.734806906025;4370.650347972155;4401.64786817057;4456.353828694853;337323;337984;338012;338340.99999999756;339007;53336.46663533393;59743.402565974655;60305.39694603086;63595.68202158959;65489;64490.677546611965;64659.67670161619;64759;64761;64821;16661.666766664843;16963.321467141424;16999.49001529956;17011.149442528073;17014;10623.575056997788;13149.21104733719;13287.13633613812;13466.93266533661;13494.730105397837;18157.63684726298;18202.635947281244;18360.357387491375;18378.724319135225;18442;6245.406686364788;6327.829351569974;6451.483881289486;6462.806115816533;6471.9676401618635;956.7512446763892;976.3799987008301;1046.2676126711333;1062.2617280989793;1093.4095588382343;30452;32298.192545186557;32861.50707739338;32898;33072;1092.6885837536263;1185.3776767197119;1191.737817680109;1200.1778781534676;1261.8801213884667;16918.731095167666;17182.914085429493;17226.483205503606;17282.395116170872;17332.431276178715;516714;520349;520908;524266;525098;59826.40173598295;60080;60122.69938650279;60171.39828601746;60257.39742602606;1275.3049587974576;1344;1383.5641772841523;1398.1261711430357;1408.9984444178378;32918;33957.49063764095;34234.48648270328;34346.82826585851;34391.31217375588;51559;52113;52155.21767173419;52259;52327;318149;324678;324845;325563;326285;25444.618330724683;27574;28099.157025289274;28349.291267718472;30366.696333036387;49307.26039109344;49325.26012109893;49760;50694.493055068975;51403;42322.78838605787;42445;43185;43727;44681.4361497346;41796;42214.1557168861;42271.365929510466;42770.57229427666;43101.56898431101;41498.585014149474;42119.789401054026;42822.35766463568;42950.78524607482;43213;37177;37230.8138459306;38667.2266554673;39052.21895562016;39325;28133;28681;29051.85474072616;29111;29118.27204319824 11:36:10 INFO - PROCESS | 12499 | |2;jquery.html;378.3549048871674;382.7339998700902;386.84139502803856;388.30299612196103;406.7152992904967;18294.54263643408;20086.59826803463;20264.98675066246;20512.87179205145;20537.589248215063;16720.49838504844;18537.16582753776;18669.906650466728;18914;19096.33162839301;5554.750036248379;5572.749226284827;5757.481826635602;5809.419058094178;5844.035734103868;5704.828855134353;5736.856578585527;5745.827625171251;5751.4536119068625;5818.476337129658;5445.646033007842;5688.943110568883;5692.971535142318;5719.542436605082;5732.885342293152;5633.971830140844;5645.774169033234;5678.318601767773;5694.829155125353;5701.144828275771;4907.803687852482;5094.210397388374;5123.1546794778815;5135.512126348029;5139.948600513984;23115.190968316027;23289;23364.766352336428;23659.171928982403;23664.88167559151;2399.9160029399063;2404.5311164322966;2493.9002439902565;2537.2007817537415;2869.139258222525;13765.931170344184;14692.926535367254;14795.482158124521;15150.54548363551;15332.770008449883;1953.540917884296;1955.325412732605;1982.7620685517686;2002.119067610247;2102.2326850699383;78618.60690696567;78888;79229.60385198095;79307.60346198232;79442;10091.69724908254;10314.690559283234;10430.478476076318;10497.317674351143;10716.732081697864;14365.13809171453;14405.135691858522;14471.131732096108;14604.196769177584;14614.34235459407;8122.675092996214;8335.458195217292;8425.65189569666;8497.150284971576;8593.097724738938;8198.262156405952;8229.79425514367;8241.629126689193;8393.538355390512;8412.284955778705;6415.262244841903;6593.102494032985;6621.867562648817;6633.2040155181685;6751.864962700817;1833.1027386655014;1910.3504808365224;1910.3695780392436;1925.4704956137175;1944.270898413095;931.1573026410973;958.3100167879115;970.8301047316692;995.3629677006721;1006.582268358623;19736.40790776279;19953.60092798165;19991.300304489272;20085.899570502344;20094;1019.6176433837311;1023.8566600675912;1031.3244824639723;1034.1571619130384;1051.363924825485;10739.516721747541;11339.319640821577;11415.315081095161;11485.827712584318;11504.654860354203;486911;499284;500052;504069;513642;77386.61306693543;79182.20817791864;81120;81180;81226.59386703146;1000.7097941596855;1030.7732298894232;1057.038095333243;1070.6038765656601;1074.398336931321;17205.65588688194;17281.567960800578;17807.19867605935;17813.376531821323;17953.910230448764;43586.346204806316;44577.55422445864;44869.32696009497;45586.772066139456;45760.7711961438;59142;59200;61377.69311153416;62395;63320;7678.6544605494;8680.392372534114;8747.956260218658;8757.211850933447;9080.500572468314;13698.931505342409;14121.505747298796;14218;14237.715245695235;14250.28748562547;11610.187286889837;11806.409679515818;12451.25292482454;12475;12709.93645031769;11964.222325548812;12380.195287306296;12534.811977820158;12548.372581370711;12909.354532273537;12563.623091307276;12611.93694031524;12616.87383126157;12658.556950506689;12798.104132710621;8075.636596353061;8120.187981202069;8261.504309741435;8441.493510389397;8449.070602233873;11072.501737421997;12280.447379867748;12353.197042192229;12382.442790074288;12501 11:36:10 INFO - PROCESS | 12499 | |3;mootools.html;1308.7447947650212;1418.9787153192697;1447.4716728394137;1524.603603063204;1747.8426941575265;7955.522668639878;8181.550014749194;8287.66849326027;8488.957555212231;8504.702335418262;8427.789305267372;8630.266427353683;8631.180037896389;8642.438241514297;8650.524221167832;1989.801019898006;2194.1662168376074;2281.4182383492184;2292.4154340643113;2318.4435735423544;2307.077169132344;2311.9537609247805;2313.652952057188;2316.0388438797877;2319.5940710375703;2245.921392751254;2247.381969958258;2288.8626682399026;2289.553537060274;2292.071710957065;1926.9903650481729;2149.9032543535423;2200.504886400563;2223.8888055597317;2232.0960011195493;2203.1848216160124;2220;2224.7663995280586;2233.1514024670682;2233.4974630708125;8605.268552173073;8657.047724750273;8674.175953284428;8807.515586642732;8884.466931984101;4939.950600493985;5023.497650234984;5038.614381045205;5038.84883453497;5042.495750424928;2986.4027194561177;3180.204948762809;3232.951505727416;3240.4329242382487;3252.544643749853;1063.8246289463043;1080.713610893114;1084.0893649334596;1084.4631907205983;1101.6805126513302;11160.497777600027;11183.608573699881;11217.383043932581;11251.381174035425;11256.606018789304;4260.850870219528;4277.57224277576;4363.672724545671;4364.018095928454;4430.13612345596;9684.273679474067;9711.46586937711;9712.562934667956;9713.854292185622;9715.757106072404;4908.9754551227015;4910.410750709866;4919.631027672939;4919.926201106986;4920.335754673145;4117.135401565645;4480.059187570647;4573.49691533931;4580.221362368406;4649.139909116824;3857.884263472044;3880.9611903881164;3951.545572259227;3975.582563830814;4010.7794071325775;1180.911431642613;1228.7358217983176;1234.1916044990546;1248.5630029489605;1272.2684456437585;889.3063410539789;1004.5278719002057;1010.4745532323298;1017.165923942375;1040.9687709368732;6029.8191054268445;6100.633961962297;6208.689565521796;6254.74981000764;6392.936070639327;437.73298288044265;446.6181414890287;451.2554285429068;452.48416804842503;454.3684278852398;4194.077302993336;4280.5291417944;4292.098659281586;4311.374850646639;4330.610245077958;10515.369077855354;10948.124150067975;10952.507137178845;11009.229353945148;11060.668179954615;10723.249372543847;10792.190585706103;10819.513121909376;10825.13398928084;10832.24174307791;7567.621618919032;7918.604069796603;7939.364850811921;8156.592170391576;8189.95905020483;5947.375525569752;6229.190205273286;6311.684415779285;6357.523185760994;6385.68071596409;9788.853167202355;9968.50157492108;10021.348612340174;10058.748531286776;10301.845472317771;9930.801383972424;9977.650782222587;10041.949790251001;10064.295499314978;10064.949675251577;7852.882206767017;7966.28303452692;8090.959545202471;8098.75703728889;8142.389320800845;8574.65701371963;8580.399372043898;8612;8653.61058752345;8656.653733850575;7578.1285152206;7703.884441733267;7746.419018573517;7892.289693927574;7984.760457186294;7197.100362454693;7421.183669796426;7432.2567743225245;7616.9238307616215;7790.766277011699;6615.140031795836;7168.139823221247;7247.094113235846;7263.709451621876;7266.1280646322775;5229.241759944863;5233.110371236823;5312.043832110257;5328.6802791832615;5448.346198456211;5478.096114141122;5555.777768889199;5581.860453488533;5596.076647353304;5647.29408823897 11:36:10 INFO - PROCESS | 12499 | |4;prototype.html;325.63366213010363;332.95286324509414;338.7938937382916;339.9371116343475;341.87179807572176;5335.59983001275;5374.38768369489;5380.5426538744205;5391.406945236021;5397.973010134944;5252.290940723001;5293.173855020022;5322.760475778589;5337.306150200468;5359.839204823852;3886.397608370707;4030.3752918297564;4132.29750942339;4142.813573389205;4144.626983571478;4126.319157339036;4132.214879172948;4133.6693064554765;4133.7106402551835;4145.502539695226;3890.435886796413;4116.300228961069;4124.608162224584;4128.935532233883;4170.645495132902;4009.3785463253244;4131.772752498627;4149;4150.688698347636;4169.91660166798;3698.6671199591897;3709.7032237421213;3721.8697345593046;3723.441483777428;3724.4599533067826;5126.307948426952;5170.5346518813485;5170.586353091744;5212.791488340462;5236.73816309183;4486.775661216959;4733.857984260478;4765.8570242892765;4773.665843390964;4798.95201047992;5619.241402410704;5619.325680918316;5626.156076588503;5651.632643878134;5697.515711164556;4001.519817621904;4033.253848038093;4063.1467391847746;4066.4510291110914;4076.3070278052505;5506.284183056217;5710.514606258473;5713.65729053672;5720.914186287209;5755.366909639936;4060;4063.2889244382113;4093.7339072960162;4106.77412742302;4109.445224894601;4165.75005499671;4167.291560434734;4185.455890734246;4186.162767446462;4188.539260681323;4497.887552811206;4721.15019296523;4737.573618374294;4745.810167593327;4772.952270477251;5570.554355651539;5615.354234263031;5629.4652008059165;5646.661200327993;5666.320041595035;1416.4334266293358;1431.177073182903;1437.583100900748;1449.8187726534184;1457.7084583083426;889.6174644902625;898.1333013641867;901.1349104859408;965.6041023180462;977.6333874796951;5259.289995850511;5274.129768588216;5282.445343238905;5289;5338.412774594792;5613.635113717677;5647.6329038613185;5665.971670141623;5679.943200568024;5690.2887139107615;5022.874428139253;5322.574194064466;5328.786848526093;5380.892382152413;5404.783923617233;3023.760258294089;3080.183751305906;3088.768342374331;3107.331923636429;3114.470540008204;5736.311642602915;6001;6033.336333003366;6044.697765111727;6046.969765151146;5813.418658134153;5822.475977161991;5830.854228644318;5840.8247752567495;5862.296524417097;5886.323072846678;5918.437748413894;5932.940670593325;5955.37468565803;5960.493358064439;5616.269884914935;5624.943750562606;5739.483446489836;5762.423757624204;5763.971180144073;5592.944070559242;5630.211770352072;5633.549316054624;5692.203091567267;5724.79963201286;5641.548676105819;5861.853453663693;5890.204822348928;5936.3470018297085;5945.227120474484;4072.266991941479;4100.897477563085;4128.236276288896;4134.4831896013;4135.193637240709;5729.598928075162;5752.741126649227;5754.935336962675;5785.681787501728;5793.594448388572;5393.460653934575;5440.836774896759;5537.944620553743;5541.972290138524;5580.916286255629;5490.313710786152;5524.094187505304;5538.418466061005;5565.55475561946;5608.663480191201;5275.947240527699;5474.315710536183;5486.286782718221;5498.5876059296515;5517.730921888068;5611.494965453129;5617.5505959522325;5645.1532270159805;5656.066748986371;5669.3842254957135;5534.667919924817;5538.944610554004;5546.057170280981;5553.6390134641115;5562.3022833926325 11:36:10 INFO - PROCESS | 12499 | |5;yui.html;723.7647764476545;761.2653789093524;776.3478677910554;787.4212453846418;815.111528434007;14907.254637268134;15313.23433828307;15494.070355778662;15559.61100972475;15595.220238988062;13125.201637920338;14852.851471485283;14875.181864997421;14899.92550037251;14920.403183872659;792.3898598079489;793.7023616143946;797.7487091566138;799.2686691677109;799.6481548118838;668.9765858194964;774.7365895595497;809.4293523066224;814.1532805881876;814.6537721468382;838.9580520973957;839.3830534557096;841.20506121715;842.7766641839918;842.8187939592987;681.4990981628499;839.131498898643;839.3243439031608;840;840.7309660908512;593.4243783529969;620.3517324396017;620.5780069552702;621.1056079245917;621.7948077134535;15313.23433828304;15324.080555166725;15375.615609609737;15381.230938453033;15412.691746165014;13667.521636742666;13869.653258668513;14001.509947151902;14007.859921400757;14165.362558684781;12652.17760845542;12757.489700411972;12781.61655150347;12912.935435322763;12943;4326.134773045404;4395.12097580482;4425.601695847389;4426.955730442686;4456.866294011184;73421;73421;73504;73958.63020684863;74347.25652743457;10293.639722609672;10628.25602207838;10813.459327033617;10854.945725271324;11002.229843911009;17056.317747290217;18492.445226643224;18590.628187436447;18725.438236852642;18751.90624046871;8496.150384961578;8662.090480499583;8667.869981950276;8675;8704.608292626846;4046.4941882264716;4209.873703788891;4225.661947044229;4233.407322974786;4714.4106986626675;3107.1765982014786;3212.951805722916;3216.1477208539754;3218.726408255278;3222.581064461605;543.1743749500737;551.8399664097367;561.7163332517052;564.7797359029981;565.4769338361999;551.8316913341389;559.759303499491;622.3030206169119;712.9394001509929;718.6202491216876;8716.738497845075;8799;8856.261899883531;9110.635574576943;9462.053794620482;608.2883026858498;624.1418050181001;635.9523035772336;655.0959675647671;664.1465716554301;4342.32693932441;4384;4412.624926881187;4514.142312960527;4553.362529245908;89027.55486222656;119076;123247;123674;123886;106098.46950765197;106330.46834765776;108376.45811771048;109245.99999999841;109479.45260273806;89422;91805.54097229337;92823;93034.53482732679;94601.5269923646;10186.745331366776;10206.948965255126;10227.335223210468;10253.74365640865;10285.53715082808;40180.3972940412;53368;55221.44778552324;55261.44738552563;57226;65536;67872.3212767866;72857.6357118211;74848;76884;13694.589162325146;13710.314484275546;13825.51610693621;13917.373718182504;14248.35882385316;15360.615984600474;15401.922990384975;15635.452759153375;15694.607634808764;16547.420840270534;13404.463821447032;13791.793123103362;13968.511102111377;14411;14662.706745864809;13783.241921694002;13993.860061399255;14243.501477448654;14410.682545767691;14943.701125977637;13433;13457.798133027816;14193.219372934587;14227.715445691236;14268.928655356656;10933.890661093288;10960.397178155277;10997.12023038139;11381.829272561085;11476.655700328669;10998.890011100106;11163;11213.495392707511;11276.154288428237;11281.266717663326 11:36:10 INFO - PROCESS | 12499 | __end_tp_report 11:36:10 INFO - PROCESS | 12499 | __start_cc_report 11:36:10 INFO - PROCESS | 12499 | _x_x_mozilla_cycle_collect,1038 11:36:10 INFO - PROCESS | 12499 | __end_cc_report 11:36:10 INFO - PROCESS | 12499 | __startTimestamp1467052570773__endTimestamp 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | ------- Summary: start ------- 11:36:10 INFO - PROCESS | 12499 | Number of tests: 6 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | [#0] dojo.html Cycles:165 Average:5353.11 Median:5576.30 stddev:614.96 (11.0%) stddev-sans-first:591.19 11:36:10 INFO - PROCESS | 12499 | Values: 3112.2 3119.6 3140.1 3143.0 3183.6 5265.9 5342.5 5349.4 5416.2 5432.4 5286.0 5303.2 5355.6 5358.5 5368.5 4798.0 4823.9 4865.6 4874.6 5025.9 4932.5 4940.7 4967.0 4985.6 4996.5 4758.6 4803.5 4820.2 4848.3 4910.6 4848.2 4856.1 4860.8 4865.2 4965.4 4852.8 4877.0 4884.7 4893.6 4955.5 5229.3 5310.5 5389.9 5394.6 5401.5 5765.9 5776.4 5816.2 5825.3 5832.7 5846.4 5874.8 5877.6 5887.9 5888.9 5254.8 5379.9 5434.6 5438.1 5440.0 5904.7 5964.8 5965.7 5971.0 5977.0 5483.7 5737.7 5746.7 5748.6 5749.0 5634.2 5683.2 5693.1 5699.4 5710.2 5679.7 5696.5 5697.9 5698.2 5706.0 5596.9 5676.2 5685.3 5691.0 5693.0 4360.1 4365.3 4385.1 4423.7 4436.3 3900.6 3922.7 3936.5 3938.8 3968.4 5246.0 5304.8 5355.4 5426.8 5470.9 5697.5 5720.0 5738.3 5743.2 5782.2 5380.7 5392.4 5392.4 5393.5 5399.2 4883.6 4968.6 4968.8 4995.7 5007.7 5994.4 6065.8 6068.0 6068.1 6127.4 5830.5 5842.8 5849.5 5854.3 5854.5 5835.9 5930.4 5932.1 6052.5 6065.5 5634.2 5686.1 5686.8 5724.8 5758.5 5811.2 5819.9 5820.7 5821.8 5824.0 5427.2 5573.8 5576.3 5643.4 5645.8 5670.4 5683.7 5685.0 5689.0 5692.5 5598.4 5606.7 5607.6 5607.6 5611.9 5497.6 5647.7 5683.8 5701.0 5759.1 5545.7 5564.3 5571.4 5578.7 5587.0 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | [#1] ext.html Cycles:180 Average:56937.81 Median:42796.46 stddev:107023.27 (250.1%) stddev-sans-first:107239.87 11:36:10 INFO - PROCESS | 12499 | Values: 586.8 607.8 610.2 623.4 630.6 31003.7 31457.2 34057.8 42949.6 44539.6 45737.8 46334.0 46349.0 46366.0 46368.3 8989.0 9154.9 9157.8 9158.4 9165.7 8866.7 8909.7 8920.6 8941.2 9027.3 9060.0 9103.0 9108.5 9114.0 9118.1 8974.0 9010.7 9018.1 9028.1 9030.1 8854.6 8927.9 8931.5 8974.9 8986.6 42743.4 42973.8 43186.0 43195.0 43240.8 3588.3 3694.6 3703.5 3721.4 4231.4 33332.3 33721.8 34089.1 34450.5 34550.5 4273.2 4362.7 4370.7 4401.6 4456.4 337323.0 337984.0 338012.0 338341.0 339007.0 53336.5 59743.4 60305.4 63595.7 65489.0 64490.7 64659.7 64759.0 64761.0 64821.0 16661.7 16963.3 16999.5 17011.1 17014.0 10623.6 13149.2 13287.1 13466.9 13494.7 18157.6 18202.6 18360.4 18378.7 18442.0 6245.4 6327.8 6451.5 6462.8 6472.0 956.8 976.4 1046.3 1062.3 1093.4 30452.0 32298.2 32861.5 32898.0 33072.0 1092.7 1185.4 1191.7 1200.2 1261.9 16918.7 17182.9 17226.5 17282.4 17332.4 516714.0 520349.0 520908.0 524266.0 525098.0 59826.4 60080.0 60122.7 60171.4 60257.4 1275.3 1344.0 1383.6 1398.1 1409.0 32918.0 33957.5 34234.5 34346.8 34391.3 51559.0 52113.0 52155.2 52259.0 52327.0 318149.0 324678.0 324845.0 325563.0 326285.0 25444.6 27574.0 28099.2 28349.3 30366.7 49307.3 49325.3 49760.0 50694.5 51403.0 42322.8 42445.0 43185.0 43727.0 44681.4 41796.0 42214.2 42271.4 42770.6 43101.6 41498.6 42119.8 42822.4 42950.8 43213.0 37177.0 37230.8 38667.2 39052.2 39325.0 28133.0 28681.0 29051.9 29111.0 29118.3 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | [#2] jquery.html Cycles:180 Average:29377.80 Median:13032.40 stddev:82247.63 (631.1%) stddev-sans-first:82449.53 11:36:10 INFO - PROCESS | 12499 | Values: 378.4 382.7 386.8 388.3 406.7 18294.5 20086.6 20265.0 20512.9 20537.6 16720.5 18537.2 18669.9 18914.0 19096.3 5554.8 5572.7 5757.5 5809.4 5844.0 5704.8 5736.9 5745.8 5751.5 5818.5 5445.6 5688.9 5693.0 5719.5 5732.9 5634.0 5645.8 5678.3 5694.8 5701.1 4907.8 5094.2 5123.2 5135.5 5139.9 23115.2 23289.0 23364.8 23659.2 23664.9 2399.9 2404.5 2493.9 2537.2 2869.1 13765.9 14692.9 14795.5 15150.5 15332.8 1953.5 1955.3 1982.8 2002.1 2102.2 78618.6 78888.0 79229.6 79307.6 79442.0 10091.7 10314.7 10430.5 10497.3 10716.7 14365.1 14405.1 14471.1 14604.2 14614.3 8122.7 8335.5 8425.7 8497.2 8593.1 8198.3 8229.8 8241.6 8393.5 8412.3 6415.3 6593.1 6621.9 6633.2 6751.9 1833.1 1910.4 1910.4 1925.5 1944.3 931.2 958.3 970.8 995.4 1006.6 19736.4 19953.6 19991.3 20085.9 20094.0 1019.6 1023.9 1031.3 1034.2 1051.4 10739.5 11339.3 11415.3 11485.8 11504.7 486911.0 499284.0 500052.0 504069.0 513642.0 77386.6 79182.2 81120.0 81180.0 81226.6 1000.7 1030.8 1057.0 1070.6 1074.4 17205.7 17281.6 17807.2 17813.4 17953.9 43586.3 44577.6 44869.3 45586.8 45760.8 59142.0 59200.0 61377.7 62395.0 63320.0 7678.7 8680.4 8748.0 8757.2 9080.5 13698.9 14121.5 14218.0 14237.7 14250.3 11610.2 11806.4 12451.3 12475.0 12709.9 11964.2 12380.2 12534.8 12548.4 12909.4 12563.6 12611.9 12616.9 12658.6 12798.1 8075.6 8120.2 8261.5 8441.5 8449.1 11072.5 12280.4 12353.2 12382.4 12501.0 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | [#3] mootools.html Cycles:180 Average:5698.40 Median:453.43 stddev:3238.65 (714.3%) stddev-sans-first:3230.93 11:36:10 INFO - PROCESS | 12499 | Values: 1308.7 1419.0 1447.5 1524.6 1747.8 7955.5 8181.6 8287.7 8489.0 8504.7 8427.8 8630.3 8631.2 8642.4 8650.5 1989.8 2194.2 2281.4 2292.4 2318.4 2307.1 2312.0 2313.7 2316.0 2319.6 2245.9 2247.4 2288.9 2289.6 2292.1 1927.0 2149.9 2200.5 2223.9 2232.1 2203.2 2220.0 2224.8 2233.2 2233.5 8605.3 8657.0 8674.2 8807.5 8884.5 4940.0 5023.5 5038.6 5038.8 5042.5 2986.4 3180.2 3233.0 3240.4 3252.5 1063.8 1080.7 1084.1 1084.5 1101.7 11160.5 11183.6 11217.4 11251.4 11256.6 4260.9 4277.6 4363.7 4364.0 4430.1 9684.3 9711.5 9712.6 9713.9 9715.8 4909.0 4910.4 4919.6 4919.9 4920.3 4117.1 4480.1 4573.5 4580.2 4649.1 3857.9 3881.0 3951.5 3975.6 4010.8 1180.9 1228.7 1234.2 1248.6 1272.3 889.3 1004.5 1010.5 1017.2 1041.0 6029.8 6100.6 6208.7 6254.7 6392.9 437.7 446.6 451.3 452.5 454.4 4194.1 4280.5 4292.1 4311.4 4330.6 10515.4 10948.1 10952.5 11009.2 11060.7 10723.2 10792.2 10819.5 10825.1 10832.2 7567.6 7918.6 7939.4 8156.6 8190.0 5947.4 6229.2 6311.7 6357.5 6385.7 9788.9 9968.5 10021.3 10058.7 10301.8 9930.8 9977.7 10041.9 10064.3 10064.9 7852.9 7966.3 8091.0 8098.8 8142.4 8574.7 8580.4 8612.0 8653.6 8656.7 7578.1 7703.9 7746.4 7892.3 7984.8 7197.1 7421.2 7432.3 7616.9 7790.8 6615.1 7168.1 7247.1 7263.7 7266.1 5229.2 5233.1 5312.0 5328.7 5448.3 5478.1 5555.8 5581.9 5596.1 5647.3 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | [#4] prototype.html Cycles:180 Average:4700.00 Median:5377.47 stddev:1380.21 (25.7%) stddev-sans-first:1344.46 11:36:10 INFO - PROCESS | 12499 | Values: 325.6 333.0 338.8 339.9 341.9 5335.6 5374.4 5380.5 5391.4 5398.0 5252.3 5293.2 5322.8 5337.3 5359.8 3886.4 4030.4 4132.3 4142.8 4144.6 4126.3 4132.2 4133.7 4133.7 4145.5 3890.4 4116.3 4124.6 4128.9 4170.6 4009.4 4131.8 4149.0 4150.7 4169.9 3698.7 3709.7 3721.9 3723.4 3724.5 5126.3 5170.5 5170.6 5212.8 5236.7 4486.8 4733.9 4765.9 4773.7 4799.0 5619.2 5619.3 5626.2 5651.6 5697.5 4001.5 4033.3 4063.1 4066.5 4076.3 5506.3 5710.5 5713.7 5720.9 5755.4 4060.0 4063.3 4093.7 4106.8 4109.4 4165.8 4167.3 4185.5 4186.2 4188.5 4497.9 4721.2 4737.6 4745.8 4773.0 5570.6 5615.4 5629.5 5646.7 5666.3 1416.4 1431.2 1437.6 1449.8 1457.7 889.6 898.1 901.1 965.6 977.6 5259.3 5274.1 5282.4 5289.0 5338.4 5613.6 5647.6 5666.0 5679.9 5690.3 5022.9 5322.6 5328.8 5380.9 5404.8 3023.8 3080.2 3088.8 3107.3 3114.5 5736.3 6001.0 6033.3 6044.7 6047.0 5813.4 5822.5 5830.9 5840.8 5862.3 5886.3 5918.4 5932.9 5955.4 5960.5 5616.3 5624.9 5739.5 5762.4 5764.0 5592.9 5630.2 5633.5 5692.2 5724.8 5641.5 5861.9 5890.2 5936.3 5945.2 4072.3 4100.9 4128.2 4134.5 4135.2 5729.6 5752.7 5754.9 5785.7 5793.6 5393.5 5440.8 5537.9 5542.0 5580.9 5490.3 5524.1 5538.4 5565.6 5608.7 5275.9 5474.3 5486.3 5498.6 5517.7 5611.5 5617.6 5645.2 5656.1 5669.4 5534.7 5538.9 5546.1 5553.6 5562.3 11:36:10 INFO - PROCESS | 12499 | 11:36:10 INFO - PROCESS | 12499 | [#5] yui.html Cycles:180 Average:21096.74 Median:4128.18 stddev:30908.25 (748.7%) stddev-sans-first:30957.10 11:36:10 INFO - PROCESS | 12499 | Values: 723.8 761.3 776.3 787.4 815.1 14907.3 15313.2 15494.1 15559.6 15595.2 13125.2 14852.9 14875.2 14899.9 14920.4 792.4 793.7 797.7 799.3 799.6 669.0 774.7 809.4 814.2 814.7 839.0 839.4 841.2 842.8 842.8 681.5 839.1 839.3 840.0 840.7 593.4 620.4 620.6 621.1 621.8 15313.2 15324.1 15375.6 15381.2 15412.7 13667.5 13869.7 14001.5 14007.9 14165.4 12652.2 12757.5 12781.6 12912.9 12943.0 4326.1 4395.1 4425.6 4427.0 4456.9 73421.0 73421.0 73504.0 73958.6 74347.3 10293.6 10628.3 10813.5 10854.9 11002.2 17056.3 18492.4 18590.6 18725.4 18751.9 8496.2 8662.1 8667.9 8675.0 8704.6 4046.5 4209.9 4225.7 4233.4 4714.4 3107.2 3213.0 3216.1 3218.7 3222.6 543.2 551.8 561.7 564.8 565.5 551.8 559.8 622.3 712.9 718.6 8716.7 8799.0 8856.3 9110.6 9462.1 608.3 624.1 636.0 655.1 664.1 4342.3 4384.0 4412.6 4514.1 4553.4 89027.6 119076.0 123247.0 123674.0 123886.0 106098.5 106330.5 108376.5 109246.0 109479.5 89422.0 91805.5 92823.0 93034.5 94601.5 10186.7 10206.9 10227.3 10253.7 10285.5 40180.4 53368.0 55221.4 55261.4 57226.0 65536.0 67872.3 72857.6 74848.0 76884.0 13694.6 13710.3 13825.5 13917.4 14248.4 15360.6 15401.9 15635.5 15694.6 16547.4 13404.5 13791.8 13968.5 14411.0 14662.7 13783.2 13993.9 14243.5 14410.7 14943.7 13433.0 13457.8 14193.2 14227.7 14268.9 10933.9 10960.4 10997.1 11381.8 11476.7 10998.9 11163.0 11213.5 11276.2 11281.3 11:36:10 INFO - PROCESS | 12499 | -------- Summary: end -------- 11:36:10 INFO - PROCESS | 12499 | 11:36:11 INFO - TEST-INFO | 12499: exit 0 11:36:11 INFO - TEST-OK | dromaeo_css | took 1113439ms 11:36:11 INFO - TEST-START | kraken 11:36:11 INFO - operating with platform_type : linux_ 11:36:11 INFO - Initialising browser for kraken test... 11:36:11 INFO - TEST-INFO | started process 12682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_5Mwk/profile http://localhost:52073/getInfo.html) 11:36:15 INFO - PROCESS | 12682 | __metrics Screen width/height:1600/1200 11:36:15 INFO - PROCESS | 12682 | colorDepth:24 11:36:15 INFO - PROCESS | 12682 | Browser inner width/height: 1024/697 11:36:15 INFO - PROCESS | 12682 | __metrics 11:36:16 INFO - PROCESS | 12682 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:16 INFO - TEST-INFO | 12682: exit 0 11:36:16 INFO - Browser initialized. 11:36:16 INFO - Running cycle 1/1 for kraken test... 11:36:16 INFO - TEST-INFO | started process 12768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_5Mwk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:28 INFO - PROCESS | 12768 | RSS: Main: 174100480 11:36:28 INFO - PROCESS | 12768 | 11:36:31 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52073/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:32 INFO - PROCESS | 12768 | RSS: Main: 231870464 11:36:32 INFO - PROCESS | 12768 | 11:36:34 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52073/tests/kraken/driver.html?testName=audio-dft) 11:36:35 INFO - PROCESS | 12768 | RSS: Main: 219410432 11:36:35 INFO - PROCESS | 12768 | 11:36:38 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52073/tests/kraken/driver.html?testName=audio-fft) 11:36:39 INFO - PROCESS | 12768 | RSS: Main: 285818880 11:36:39 INFO - PROCESS | 12768 | 11:36:41 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52073/tests/kraken/driver.html?testName=audio-oscillator) 11:36:42 INFO - PROCESS | 12768 | RSS: Main: 196341760 11:36:42 INFO - PROCESS | 12768 | 11:36:44 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52073/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:44 INFO - PROCESS | 12768 | RSS: Main: 200179712 11:36:44 INFO - PROCESS | 12768 | 11:36:47 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52073/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:48 INFO - PROCESS | 12768 | RSS: Main: 236781568 11:36:48 INFO - PROCESS | 12768 | 11:36:51 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52073/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:52 INFO - PROCESS | 12768 | RSS: Main: 238030848 11:36:52 INFO - PROCESS | 12768 | 11:36:55 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52073/tests/kraken/driver.html?testName=json-parse-financial) 11:36:55 INFO - PROCESS | 12768 | RSS: Main: 237555712 11:36:55 INFO - PROCESS | 12768 | 11:36:57 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52073/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:57 INFO - PROCESS | 12768 | RSS: Main: 225288192 11:36:57 INFO - PROCESS | 12768 | 11:36:59 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:00 INFO - PROCESS | 12768 | RSS: Main: 229060608 11:37:00 INFO - PROCESS | 12768 | 11:37:02 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:03 INFO - PROCESS | 12768 | RSS: Main: 235634688 11:37:03 INFO - PROCESS | 12768 | 11:37:05 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:06 INFO - PROCESS | 12768 | RSS: Main: 238833664 11:37:06 INFO - PROCESS | 12768 | 11:37:08 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:09 INFO - PROCESS | 12768 | RSS: Main: 238874624 11:37:09 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | Cycle 1(1): loaded http://localhost:52073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52073/tests/kraken/driver.html?testName=ai-astar) 11:37:11 INFO - PROCESS | 12768 | RSS: Main: 281804800 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | __start_tp_report 11:37:11 INFO - PROCESS | 12768 | _x_x_mozilla_page_load 11:37:11 INFO - PROCESS | 12768 | _x_x_mozilla_page_load_details 11:37:11 INFO - PROCESS | 12768 | |i|pagename|runs| 11:37:11 INFO - PROCESS | 12768 | |0;ai-astar;102;111;110;110;110;110;109;109;111;109 11:37:11 INFO - PROCESS | 12768 | |1;audio-beat-detection;154;133;124;174;135;127;151;132;177;127 11:37:11 INFO - PROCESS | 12768 | |2;audio-dft;161;161;161;163;162;162;161;161;161;161 11:37:11 INFO - PROCESS | 12768 | |3;audio-fft;75;74;76;133;76;76;76;74;96;74 11:37:11 INFO - PROCESS | 12768 | |4;audio-oscillator;84;86;117;86;86;86;127;86;85;130 11:37:11 INFO - PROCESS | 12768 | |5;imaging-gaussian-blur;117;116;117;117;117;117;118;117;118;117 11:37:11 INFO - PROCESS | 12768 | |6;imaging-darkroom;144;146;146;146;146;146;146;147;145;145 11:37:11 INFO - PROCESS | 12768 | |7;imaging-desaturate;96;96;95;96;95;95;96;96;96;96 11:37:11 INFO - PROCESS | 12768 | |8;json-parse-financial;52;54;52;52;52;54;54;53;55;52 11:37:11 INFO - PROCESS | 12768 | |9;json-stringify-tinderbox;61;61;60;61;62;62;61;62;61;61 11:37:11 INFO - PROCESS | 12768 | |10;stanford-crypto-aes;79;78;85;79;78;79;79;81;95;79 11:37:11 INFO - PROCESS | 12768 | |11;stanford-crypto-ccm;123;121;124;133;127;119;126;120;121;128 11:37:11 INFO - PROCESS | 12768 | |12;stanford-crypto-pbkdf2;161;164;162;163;160;160;158;160;159;157 11:37:11 INFO - PROCESS | 12768 | |13;stanford-crypto-sha256-iterative;67;63;66;64;63;64;65;66;62;62 11:37:11 INFO - PROCESS | 12768 | __end_tp_report 11:37:11 INFO - PROCESS | 12768 | __start_cc_report 11:37:11 INFO - PROCESS | 12768 | _x_x_mozilla_cycle_collect,1651 11:37:11 INFO - PROCESS | 12768 | __end_cc_report 11:37:11 INFO - PROCESS | 12768 | __startTimestamp1467052631417__endTimestamp 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | ------- Summary: start ------- 11:37:11 INFO - PROCESS | 12768 | Number of tests: 14 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.60 (2.4%) stddev-sans-first:0.78 11:37:11 INFO - PROCESS | 12768 | Values: 102.0 111.0 110.0 110.0 110.0 110.0 109.0 109.0 111.0 109.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:143.00 stddev:19.60 (13.7%) stddev-sans-first:20.41 11:37:11 INFO - PROCESS | 12768 | Values: 154.0 133.0 124.0 174.0 135.0 127.0 151.0 132.0 177.0 127.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 11:37:11 INFO - PROCESS | 12768 | Values: 161.0 161.0 161.0 163.0 162.0 162.0 161.0 161.0 161.0 161.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:18.77 (24.7%) stddev-sans-first:19.69 11:37:11 INFO - PROCESS | 12768 | Values: 75.0 74.0 76.0 133.0 76.0 76.0 76.0 74.0 96.0 74.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:86.00 stddev:19.17 (22.3%) stddev-sans-first:19.72 11:37:11 INFO - PROCESS | 12768 | Values: 84.0 86.0 117.0 86.0 86.0 86.0 127.0 86.0 85.0 130.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:37:11 INFO - PROCESS | 12768 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 11:37:11 INFO - PROCESS | 12768 | Values: 144.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 145.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:37:11 INFO - PROCESS | 12768 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.50 stddev:1.15 (2.2%) stddev-sans-first:1.17 11:37:11 INFO - PROCESS | 12768 | Values: 52.0 54.0 52.0 52.0 52.0 54.0 54.0 53.0 55.0 52.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 11:37:11 INFO - PROCESS | 12768 | Values: 61.0 61.0 60.0 61.0 62.0 62.0 61.0 62.0 61.0 61.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:79.00 stddev:5.27 (6.7%) stddev-sans-first:5.53 11:37:11 INFO - PROCESS | 12768 | Values: 79.0 78.0 85.0 79.0 78.0 79.0 79.0 81.0 95.0 79.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.00 stddev:4.34 (3.5%) stddev-sans-first:4.58 11:37:11 INFO - PROCESS | 12768 | Values: 123.0 121.0 124.0 133.0 127.0 119.0 126.0 120.0 121.0 128.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:2.17 (1.4%) stddev-sans-first:2.29 11:37:11 INFO - PROCESS | 12768 | Values: 161.0 164.0 162.0 163.0 160.0 160.0 158.0 160.0 159.0 157.0 11:37:11 INFO - PROCESS | 12768 | 11:37:11 INFO - PROCESS | 12768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.75 (2.7%) stddev-sans-first:1.54 11:37:11 INFO - PROCESS | 12768 | Values: 67.0 63.0 66.0 64.0 63.0 64.0 65.0 66.0 62.0 62.0 11:37:11 INFO - PROCESS | 12768 | -------- Summary: end -------- 11:37:11 INFO - PROCESS | 12768 | 11:37:12 INFO - TEST-INFO | 12768: exit 0 11:37:12 INFO - TEST-OK | kraken | took 60913ms 11:37:12 INFO - SUITE-END | took 1174s 11:37:12 INFO - Completed test suite (00:19:34) 11:37:12 INFO - javascript benchmark 11:37:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.1752735525083, 3119.578856854324, 3140.1207661854687, 3143.0, 3183.6338821035574, 5265.8946821063655, 5342.465753424665, 5349.358077030757, 5416.187571864222, 5432.402435732066, 5285.973570132153, 5303.178007408848, 5355.571554275658, 5358.517733403993, 5368.516833484986, 4797.999999999991, 4823.903521929559, 4865.586425153866, 4874.561289483946, 5025.949740502585, 4932.482089380617, 4940.6788558743565, 4967.031428871372, 4985.551300382965, 4996.500349964993, 4758.619310455173, 4803.495632958524, 4820.156472617313, 4848.345473361122, 4910.558049775537, 4848.248521479177, 4856.05306965142, 4860.781264843055, 4865.19724245499, 4965.428975667808, 4852.781624826891, 4876.975615121937, 4884.706917584921, 4893.6329775266995, 4955.4548999610015, 5229.320188375525, 5310.548603368679, 5389.865253368658, 5394.622376433651, 5401.486858748452, 5765.942340576625, 5776.393478684761, 5816.1566572846705, 5825.300963884319, 5832.6792026438525, 5846.415358464162, 5874.823755287348, 5877.588568800185, 5887.8528036799, 5888.941110588925, 5254.789808407659, 5379.865503362408, 5434.619576629598, 5438.129899216146, 5440.047991601454, 5904.7342869570975, 5964.7912323068485, 5965.701714914324, 5970.9701451492465, 5976.970115149484, 5483.670979741149, 5737.741801618937, 5746.741396637161, 5748.626339287933, 5748.9712551437815, 5634.154876768517, 5683.204351390808, 5693.089105743061, 5699.373068962411, 5710.200571919934, 5679.716014199274, 5696.51579615729, 5697.943020569741, 5698.230738850285, 5705.971470142623, 5596.86007849807, 5676.176954341598, 5685.289338832646, 5691.0, 5692.971535142381, 4360.106178233455, 4365.301551751704, 4385.057212699285, 4423.734575925455, 4436.3123715824095, 3900.64894159527, 3922.7254092213843, 3936.527616686016, 3938.8424463021156, 3968.40473928913, 5246.0, 5304.787808487695, 5355.384130825005, 5426.75579598919, 5470.9452905471235, 5697.544196464273, 5719.971400143056, 5738.282714660668, 5743.2246646703, 5782.248307720053, 5380.677159370451, 5392.352917649907, 5392.433794451605, 5393.514583687408, 5399.244105825188, 4883.609311255091, 4968.552830245295, 4968.826091086795, 4995.700257984533, 5007.7245751484015, 5994.3705910878725, 6065.848353791191, 6068.0, 6068.120122582201, 6127.448529632355, 5830.53355731549, 5842.824715258549, 5849.502792262705, 5854.268216472941, 5854.502367298657, 5835.94164058371, 5930.436608522184, 5932.139839723302, 6052.455279024909, 6065.484433822998, 5634.183043458594, 5686.118651609007, 5686.77252909879, 5724.79963201286, 5758.481736643722, 5811.215485909517, 5819.94180058194, 5820.679862607597, 5821.825345239649, 5823.970880145572, 5427.240186373831, 5573.7770489179975, 5576.302962129734, 5643.3792282848035, 5645.830625081254, 5670.376258611467, 5683.658980461186, 5685.005124103182, 5688.971555142198, 5692.544596432358, 5598.440155984369, 5606.6636001840025, 5607.579431542569, 5607.579431542569, 5611.859703507445, 5497.615166938436, 5647.6893770843, 5683.8010669626365, 5701.030824759718, 5759.107338362561, 5545.667259964253, 5564.332280126248, 5571.359293681278, 5578.748956296895, 5587.0], "value": 5311.471116085416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7799575159315, 607.7599348257438, 610.2372034956304, 623.3672822085582, 630.5806638585341, 31003.68996310036, 31457.21356966077, 34057.829710851445, 42949.57050429495, 44539.554604453944, 45737.77131114348, 46334.0, 46349.0, 46366.0, 46368.304475432895, 8988.955055224715, 9154.862677059817, 9157.771055723593, 9158.40470369424, 9165.72502824913, 8866.689665861697, 8909.73270801877, 8920.643174273022, 8941.150590693873, 9027.277817774595, 9059.95470022649, 9102.954485227565, 9108.544572771369, 9114.043025482328, 9118.088191180896, 8973.955130224373, 9010.684626038123, 9018.098190180963, 9028.052054534312, 9030.096990300983, 8854.645814167425, 8927.910720892773, 8931.50876701781, 8974.86537701935, 8986.640534378617, 42743.35884961697, 42973.78513107446, 43186.0, 43195.0, 43240.78379608113, 3588.282343531278, 3694.612065733086, 3703.5000274962804, 3721.3673675475234, 4231.42875711778, 33332.3333533328, 33721.83139084314, 34089.14777130567, 34450.483242751376, 34550.48174277388, 4273.188832254401, 4362.734806906025, 4370.650347972155, 4401.64786817057, 4456.353828694853, 337323.0, 337984.0, 338012.0, 338340.99999999756, 339007.0, 53336.46663533393, 59743.402565974655, 60305.39694603086, 63595.68202158959, 65489.0, 64490.677546611965, 64659.67670161619, 64759.0, 64761.0, 64821.0, 16661.666766664843, 16963.321467141424, 16999.49001529956, 17011.149442528073, 17014.0, 10623.575056997788, 13149.21104733719, 13287.13633613812, 13466.93266533661, 13494.730105397837, 18157.63684726298, 18202.635947281244, 18360.357387491375, 18378.724319135225, 18442.0, 6245.406686364788, 6327.829351569974, 6451.483881289486, 6462.806115816533, 6471.9676401618635, 956.7512446763892, 976.3799987008301, 1046.2676126711333, 1062.2617280989793, 1093.4095588382343, 30452.0, 32298.192545186557, 32861.50707739338, 32898.0, 33072.0, 1092.6885837536263, 1185.3776767197119, 1191.737817680109, 1200.1778781534676, 1261.8801213884667, 16918.731095167666, 17182.914085429493, 17226.483205503606, 17282.395116170872, 17332.431276178715, 516714.0, 520349.0, 520908.0, 524266.0, 525098.0, 59826.40173598295, 60080.0, 60122.69938650279, 60171.39828601746, 60257.39742602606, 1275.3049587974576, 1344.0, 1383.5641772841523, 1398.1261711430357, 1408.9984444178378, 32918.0, 33957.49063764095, 34234.48648270328, 34346.82826585851, 34391.31217375588, 51559.0, 52113.0, 52155.21767173419, 52259.0, 52327.0, 318149.0, 324678.0, 324845.0, 325563.0, 326285.0, 25444.618330724683, 27574.0, 28099.157025289274, 28349.291267718472, 30366.696333036387, 49307.26039109344, 49325.26012109893, 49760.0, 50694.493055068975, 51403.0, 42322.78838605787, 42445.0, 43185.0, 43727.0, 44681.4361497346, 41796.0, 42214.1557168861, 42271.365929510466, 42770.57229427666, 43101.56898431101, 41498.585014149474, 42119.789401054026, 42822.35766463568, 42950.78524607482, 43213.0, 37177.0, 37230.8138459306, 38667.2266554673, 39052.21895562016, 39325.0, 28133.0, 28681.0, 29051.85474072616, 29111.0, 29118.27204319824], "value": 20218.83696869069, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.3549048871674, 382.7339998700902, 386.84139502803856, 388.30299612196103, 406.7152992904967, 18294.54263643408, 20086.59826803463, 20264.98675066246, 20512.87179205145, 20537.589248215063, 16720.49838504844, 18537.16582753776, 18669.906650466728, 18914.0, 19096.33162839301, 5554.750036248379, 5572.749226284827, 5757.481826635602, 5809.419058094178, 5844.035734103868, 5704.828855134353, 5736.856578585527, 5745.827625171251, 5751.4536119068625, 5818.476337129658, 5445.646033007842, 5688.943110568883, 5692.971535142318, 5719.542436605082, 5732.885342293152, 5633.971830140844, 5645.774169033234, 5678.318601767773, 5694.829155125353, 5701.144828275771, 4907.803687852482, 5094.210397388374, 5123.1546794778815, 5135.512126348029, 5139.948600513984, 23115.190968316027, 23289.0, 23364.766352336428, 23659.171928982403, 23664.88167559151, 2399.9160029399063, 2404.5311164322966, 2493.9002439902565, 2537.2007817537415, 2869.139258222525, 13765.931170344184, 14692.926535367254, 14795.482158124521, 15150.54548363551, 15332.770008449883, 1953.540917884296, 1955.325412732605, 1982.7620685517686, 2002.119067610247, 2102.2326850699383, 78618.60690696567, 78888.0, 79229.60385198095, 79307.60346198232, 79442.0, 10091.69724908254, 10314.690559283234, 10430.478476076318, 10497.317674351143, 10716.732081697864, 14365.13809171453, 14405.135691858522, 14471.131732096108, 14604.196769177584, 14614.34235459407, 8122.675092996214, 8335.458195217292, 8425.65189569666, 8497.150284971576, 8593.097724738938, 8198.262156405952, 8229.79425514367, 8241.629126689193, 8393.538355390512, 8412.284955778705, 6415.262244841903, 6593.102494032985, 6621.867562648817, 6633.2040155181685, 6751.864962700817, 1833.1027386655014, 1910.3504808365224, 1910.3695780392436, 1925.4704956137175, 1944.270898413095, 931.1573026410973, 958.3100167879115, 970.8301047316692, 995.3629677006721, 1006.582268358623, 19736.40790776279, 19953.60092798165, 19991.300304489272, 20085.899570502344, 20094.0, 1019.6176433837311, 1023.8566600675912, 1031.3244824639723, 1034.1571619130384, 1051.363924825485, 10739.516721747541, 11339.319640821577, 11415.315081095161, 11485.827712584318, 11504.654860354203, 486911.0, 499284.0, 500052.0, 504069.0, 513642.0, 77386.61306693543, 79182.20817791864, 81120.0, 81180.0, 81226.59386703146, 1000.7097941596855, 1030.7732298894232, 1057.038095333243, 1070.6038765656601, 1074.398336931321, 17205.65588688194, 17281.567960800578, 17807.19867605935, 17813.376531821323, 17953.910230448764, 43586.346204806316, 44577.55422445864, 44869.32696009497, 45586.772066139456, 45760.7711961438, 59142.0, 59200.0, 61377.69311153416, 62395.0, 63320.0, 7678.6544605494, 8680.392372534114, 8747.956260218658, 8757.211850933447, 9080.500572468314, 13698.931505342409, 14121.505747298796, 14218.0, 14237.715245695235, 14250.28748562547, 11610.187286889837, 11806.409679515818, 12451.25292482454, 12475.0, 12709.93645031769, 11964.222325548812, 12380.195287306296, 12534.811977820158, 12548.372581370711, 12909.354532273537, 12563.623091307276, 12611.93694031524, 12616.87383126157, 12658.556950506689, 12798.104132710621, 8075.636596353061, 8120.187981202069, 8261.504309741435, 8441.493510389397, 8449.070602233873, 11072.501737421997, 12280.447379867748, 12353.197042192229, 12382.442790074288, 12501.0], "value": 9487.827045295739, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.7447947650212, 1418.9787153192697, 1447.4716728394137, 1524.603603063204, 1747.8426941575265, 7955.522668639878, 8181.550014749194, 8287.66849326027, 8488.957555212231, 8504.702335418262, 8427.789305267372, 8630.266427353683, 8631.180037896389, 8642.438241514297, 8650.524221167832, 1989.801019898006, 2194.1662168376074, 2281.4182383492184, 2292.4154340643113, 2318.4435735423544, 2307.077169132344, 2311.9537609247805, 2313.652952057188, 2316.0388438797877, 2319.5940710375703, 2245.921392751254, 2247.381969958258, 2288.8626682399026, 2289.553537060274, 2292.071710957065, 1926.9903650481729, 2149.9032543535423, 2200.504886400563, 2223.8888055597317, 2232.0960011195493, 2203.1848216160124, 2220.0, 2224.7663995280586, 2233.1514024670682, 2233.4974630708125, 8605.268552173073, 8657.047724750273, 8674.175953284428, 8807.515586642732, 8884.466931984101, 4939.950600493985, 5023.497650234984, 5038.614381045205, 5038.84883453497, 5042.495750424928, 2986.4027194561177, 3180.204948762809, 3232.951505727416, 3240.4329242382487, 3252.544643749853, 1063.8246289463043, 1080.713610893114, 1084.0893649334596, 1084.4631907205983, 1101.6805126513302, 11160.497777600027, 11183.608573699881, 11217.383043932581, 11251.381174035425, 11256.606018789304, 4260.850870219528, 4277.57224277576, 4363.672724545671, 4364.018095928454, 4430.13612345596, 9684.273679474067, 9711.46586937711, 9712.562934667956, 9713.854292185622, 9715.757106072404, 4908.9754551227015, 4910.410750709866, 4919.631027672939, 4919.926201106986, 4920.335754673145, 4117.135401565645, 4480.059187570647, 4573.49691533931, 4580.221362368406, 4649.139909116824, 3857.884263472044, 3880.9611903881164, 3951.545572259227, 3975.582563830814, 4010.7794071325775, 1180.911431642613, 1228.7358217983176, 1234.1916044990546, 1248.5630029489605, 1272.2684456437585, 889.3063410539789, 1004.5278719002057, 1010.4745532323298, 1017.165923942375, 1040.9687709368732, 6029.8191054268445, 6100.633961962297, 6208.689565521796, 6254.74981000764, 6392.936070639327, 437.73298288044265, 446.6181414890287, 451.2554285429068, 452.48416804842503, 454.3684278852398, 4194.077302993336, 4280.5291417944, 4292.098659281586, 4311.374850646639, 4330.610245077958, 10515.369077855354, 10948.124150067975, 10952.507137178845, 11009.229353945148, 11060.668179954615, 10723.249372543847, 10792.190585706103, 10819.513121909376, 10825.13398928084, 10832.24174307791, 7567.621618919032, 7918.604069796603, 7939.364850811921, 8156.592170391576, 8189.95905020483, 5947.375525569752, 6229.190205273286, 6311.684415779285, 6357.523185760994, 6385.68071596409, 9788.853167202355, 9968.50157492108, 10021.348612340174, 10058.748531286776, 10301.845472317771, 9930.801383972424, 9977.650782222587, 10041.949790251001, 10064.295499314978, 10064.949675251577, 7852.882206767017, 7966.28303452692, 8090.959545202471, 8098.75703728889, 8142.389320800845, 8574.65701371963, 8580.399372043898, 8612.0, 8653.61058752345, 8656.653733850575, 7578.1285152206, 7703.884441733267, 7746.419018573517, 7892.289693927574, 7984.760457186294, 7197.100362454693, 7421.183669796426, 7432.2567743225245, 7616.9238307616215, 7790.766277011699, 6615.140031795836, 7168.139823221247, 7247.094113235846, 7263.709451621876, 7266.1280646322775, 5229.241759944863, 5233.110371236823, 5312.043832110257, 5328.6802791832615, 5448.346198456211, 5478.096114141122, 5555.777768889199, 5581.860453488533, 5596.076647353304, 5647.29408823897], "value": 4473.475814700045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.63366213010363, 332.95286324509414, 338.7938937382916, 339.9371116343475, 341.87179807572176, 5335.59983001275, 5374.38768369489, 5380.5426538744205, 5391.406945236021, 5397.973010134944, 5252.290940723001, 5293.173855020022, 5322.760475778589, 5337.306150200468, 5359.839204823852, 3886.397608370707, 4030.3752918297564, 4132.29750942339, 4142.813573389205, 4144.626983571478, 4126.319157339036, 4132.214879172948, 4133.6693064554765, 4133.7106402551835, 4145.502539695226, 3890.435886796413, 4116.300228961069, 4124.608162224584, 4128.935532233883, 4170.645495132902, 4009.3785463253244, 4131.772752498627, 4149.0, 4150.688698347636, 4169.91660166798, 3698.6671199591897, 3709.7032237421213, 3721.8697345593046, 3723.441483777428, 3724.4599533067826, 5126.307948426952, 5170.5346518813485, 5170.586353091744, 5212.791488340462, 5236.73816309183, 4486.775661216959, 4733.857984260478, 4765.8570242892765, 4773.665843390964, 4798.95201047992, 5619.241402410704, 5619.325680918316, 5626.156076588503, 5651.632643878134, 5697.515711164556, 4001.519817621904, 4033.253848038093, 4063.1467391847746, 4066.4510291110914, 4076.3070278052505, 5506.284183056217, 5710.514606258473, 5713.65729053672, 5720.914186287209, 5755.366909639936, 4060.0, 4063.2889244382113, 4093.7339072960162, 4106.77412742302, 4109.445224894601, 4165.75005499671, 4167.291560434734, 4185.455890734246, 4186.162767446462, 4188.539260681323, 4497.887552811206, 4721.15019296523, 4737.573618374294, 4745.810167593327, 4772.952270477251, 5570.554355651539, 5615.354234263031, 5629.4652008059165, 5646.661200327993, 5666.320041595035, 1416.4334266293358, 1431.177073182903, 1437.583100900748, 1449.8187726534184, 1457.7084583083426, 889.6174644902625, 898.1333013641867, 901.1349104859408, 965.6041023180462, 977.6333874796951, 5259.289995850511, 5274.129768588216, 5282.445343238905, 5289.0, 5338.412774594792, 5613.635113717677, 5647.6329038613185, 5665.971670141623, 5679.943200568024, 5690.2887139107615, 5022.874428139253, 5322.574194064466, 5328.786848526093, 5380.892382152413, 5404.783923617233, 3023.760258294089, 3080.183751305906, 3088.768342374331, 3107.331923636429, 3114.470540008204, 5736.311642602915, 6001.0, 6033.336333003366, 6044.697765111727, 6046.969765151146, 5813.418658134153, 5822.475977161991, 5830.854228644318, 5840.8247752567495, 5862.296524417097, 5886.323072846678, 5918.437748413894, 5932.940670593325, 5955.37468565803, 5960.493358064439, 5616.269884914935, 5624.943750562606, 5739.483446489836, 5762.423757624204, 5763.971180144073, 5592.944070559242, 5630.211770352072, 5633.549316054624, 5692.203091567267, 5724.79963201286, 5641.548676105819, 5861.853453663693, 5890.204822348928, 5936.3470018297085, 5945.227120474484, 4072.266991941479, 4100.897477563085, 4128.236276288896, 4134.4831896013, 4135.193637240709, 5729.598928075162, 5752.741126649227, 5754.935336962675, 5785.681787501728, 5793.594448388572, 5393.460653934575, 5440.836774896759, 5537.944620553743, 5541.972290138524, 5580.916286255629, 5490.313710786152, 5524.094187505304, 5538.418466061005, 5565.55475561946, 5608.663480191201, 5275.947240527699, 5474.315710536183, 5486.286782718221, 5498.5876059296515, 5517.730921888068, 5611.494965453129, 5617.5505959522325, 5645.1532270159805, 5656.066748986371, 5669.3842254957135, 5534.667919924817, 5538.944610554004, 5546.057170280981, 5553.6390134641115, 5562.3022833926325], "value": 4259.305076666759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.7647764476545, 761.2653789093524, 776.3478677910554, 787.4212453846418, 815.111528434007, 14907.254637268134, 15313.23433828307, 15494.070355778662, 15559.61100972475, 15595.220238988062, 13125.201637920338, 14852.851471485283, 14875.181864997421, 14899.92550037251, 14920.403183872659, 792.3898598079489, 793.7023616143946, 797.7487091566138, 799.2686691677109, 799.6481548118838, 668.9765858194964, 774.7365895595497, 809.4293523066224, 814.1532805881876, 814.6537721468382, 838.9580520973957, 839.3830534557096, 841.20506121715, 842.7766641839918, 842.8187939592987, 681.4990981628499, 839.131498898643, 839.3243439031608, 840.0, 840.7309660908512, 593.4243783529969, 620.3517324396017, 620.5780069552702, 621.1056079245917, 621.7948077134535, 15313.23433828304, 15324.080555166725, 15375.615609609737, 15381.230938453033, 15412.691746165014, 13667.521636742666, 13869.653258668513, 14001.509947151902, 14007.859921400757, 14165.362558684781, 12652.17760845542, 12757.489700411972, 12781.61655150347, 12912.935435322763, 12943.0, 4326.134773045404, 4395.12097580482, 4425.601695847389, 4426.955730442686, 4456.866294011184, 73421.0, 73421.0, 73504.0, 73958.63020684863, 74347.25652743457, 10293.639722609672, 10628.25602207838, 10813.459327033617, 10854.945725271324, 11002.229843911009, 17056.317747290217, 18492.445226643224, 18590.628187436447, 18725.438236852642, 18751.90624046871, 8496.150384961578, 8662.090480499583, 8667.869981950276, 8675.0, 8704.608292626846, 4046.4941882264716, 4209.873703788891, 4225.661947044229, 4233.407322974786, 4714.4106986626675, 3107.1765982014786, 3212.951805722916, 3216.1477208539754, 3218.726408255278, 3222.581064461605, 543.1743749500737, 551.8399664097367, 561.7163332517052, 564.7797359029981, 565.4769338361999, 551.8316913341389, 559.759303499491, 622.3030206169119, 712.9394001509929, 718.6202491216876, 8716.738497845075, 8799.0, 8856.261899883531, 9110.635574576943, 9462.053794620482, 608.2883026858498, 624.1418050181001, 635.9523035772336, 655.0959675647671, 664.1465716554301, 4342.32693932441, 4384.0, 4412.624926881187, 4514.142312960527, 4553.362529245908, 89027.55486222656, 119076.0, 123247.0, 123674.0, 123886.0, 106098.46950765197, 106330.46834765776, 108376.45811771048, 109245.99999999841, 109479.45260273806, 89422.0, 91805.54097229337, 92823.0, 93034.53482732679, 94601.5269923646, 10186.745331366776, 10206.948965255126, 10227.335223210468, 10253.74365640865, 10285.53715082808, 40180.3972940412, 53368.0, 55221.44778552324, 55261.44738552563, 57226.0, 65536.0, 67872.3212767866, 72857.6357118211, 74848.0, 76884.0, 13694.589162325146, 13710.314484275546, 13825.51610693621, 13917.373718182504, 14248.35882385316, 15360.615984600474, 15401.922990384975, 15635.452759153375, 15694.607634808764, 16547.420840270534, 13404.463821447032, 13791.793123103362, 13968.511102111377, 14411.0, 14662.706745864809, 13783.241921694002, 13993.860061399255, 14243.501477448654, 14410.682545767691, 14943.701125977637, 13433.0, 13457.798133027816, 14193.219372934587, 14227.715445691236, 14268.928655356656, 10933.890661093288, 10960.397178155277, 10997.12023038139, 11381.829272561085, 11476.655700328669, 10998.890011100106, 11163.0, 11213.495392707511, 11276.154288428237, 11281.266717663326], "value": 7474.976142091977, "unit": "score"}], "name": "dromaeo_css", "value": 7249.304650770239, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 124.0, 174.0, 135.0, 127.0, 151.0, 132.0, 177.0, 127.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 133.0, 76.0, 76.0, 76.0, 74.0, 96.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 117.0, 86.0, 86.0, 86.0, 127.0, 86.0, 85.0, 130.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 52.0, 52.0, 54.0, 54.0, 53.0, 55.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 85.0, 79.0, 78.0, 79.0, 79.0, 81.0, 95.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 124.0, 133.0, 127.0, 119.0, 126.0, 120.0, 121.0, 128.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 163.0, 160.0, 160.0, 158.0, 160.0, 159.0, 157.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 66.0, 64.0, 63.0, 64.0, 65.0, 66.0, 62.0, 62.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1496.9000000000003, "alertThreshold": 2.0}]} 11:37:12 INFO - Return code: 0 11:37:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:12 INFO - # TBPL SUCCESS # 11:37:12 INFO - Running post-action listener: _resource_record_post_action 11:37:12 INFO - ##### 11:37:12 INFO - ##### Finished run-tests step (success) 11:37:12 INFO - ##### 11:37:12 INFO - Running post-run listener: _resource_record_post_run 11:37:12 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416202752; Read time: 12; Write time: 294060 11:37:12 INFO - TinderboxPrint: CPU usage
13.2% 11:37:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:37:12 INFO - TinderboxPrint: I/O write bytes / time
416,202,752 / 294,060 11:37:12 INFO - TinderboxPrint: CPU idle
8,265.9 (86.8%) 11:37:12 INFO - TinderboxPrint: CPU user
1,209.8 (12.7%) 11:37:12 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118931456; Read time: 0; Write time: 83496 11:37:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290709504; Read time: 12; Write time: 204444 11:37:13 INFO - Running post-run listener: _upload_blobber_files 11:37:13 INFO - Blob upload gear active. 11:37:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:37:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:14 INFO - (blobuploader) - INFO - Done attempting. 11:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:18 INFO - (blobuploader) - INFO - Done attempting. 11:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:37:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:19 INFO - (blobuploader) - INFO - Done attempting. 11:37:19 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:19 INFO - Return code: 0 11:37:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85cce04ebec56f833deeef35d227c5b912fd070fb29b76e78bbefdf6ecb77a61cfd7a945d088c3dd4fb645492f0cbdcbdc4b44700682197126f51d9d7f8bd562", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6088324908cbc51819258ed6f25633428024818a51a9cc1f1789ee5341999d88980ad688f5101f2d568c36e72f418474542456b15e0e5ad24e5f0ec728871031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f90a65640d0b2f55bfd9378fbc7dbf329a5f843ed20416caa6c905ea44b8e8bad97cfe634491c262aadd460b2956d0d2149f3dbff52e282e545254d850d6a592"} 11:37:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:19 INFO - Contents: 11:37:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85cce04ebec56f833deeef35d227c5b912fd070fb29b76e78bbefdf6ecb77a61cfd7a945d088c3dd4fb645492f0cbdcbdc4b44700682197126f51d9d7f8bd562", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6088324908cbc51819258ed6f25633428024818a51a9cc1f1789ee5341999d88980ad688f5101f2d568c36e72f418474542456b15e0e5ad24e5f0ec728871031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f90a65640d0b2f55bfd9378fbc7dbf329a5f843ed20416caa6c905ea44b8e8bad97cfe634491c262aadd460b2956d0d2149f3dbff52e282e545254d850d6a592"} 11:37:19 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:19 INFO - Copying logs to upload dir... 11:37:19 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.336998 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-27 11:37:19.499798) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:19.503581) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85cce04ebec56f833deeef35d227c5b912fd070fb29b76e78bbefdf6ecb77a61cfd7a945d088c3dd4fb645492f0cbdcbdc4b44700682197126f51d9d7f8bd562", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6088324908cbc51819258ed6f25633428024818a51a9cc1f1789ee5341999d88980ad688f5101f2d568c36e72f418474542456b15e0e5ad24e5f0ec728871031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f90a65640d0b2f55bfd9378fbc7dbf329a5f843ed20416caa6c905ea44b8e8bad97cfe634491c262aadd460b2956d0d2149f3dbff52e282e545254d850d6a592"} build_url:https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85cce04ebec56f833deeef35d227c5b912fd070fb29b76e78bbefdf6ecb77a61cfd7a945d088c3dd4fb645492f0cbdcbdc4b44700682197126f51d9d7f8bd562", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6088324908cbc51819258ed6f25633428024818a51a9cc1f1789ee5341999d88980ad688f5101f2d568c36e72f418474542456b15e0e5ad24e5f0ec728871031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f90a65640d0b2f55bfd9378fbc7dbf329a5f843ed20416caa6c905ea44b8e8bad97cfe634491c262aadd460b2956d0d2149f3dbff52e282e545254d850d6a592"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:19.530217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:19.530654) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1467050749.673631-1090179124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:19.614776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 11:37:19.615180) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 11:37:19.615525) ========= ========= Total master_lag: 0.18 =========