builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1467755226.36 results: success (0) buildid: 20160705121624 builduid: 788e236bd1be410084c74acb60713d71 revision: ce7a035cd2d10e06d8a720736e44bf81dea725f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.363378) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.363886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.364169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.380116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.380516) ========= 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=d2a8c569965ab8367867b893000001a1-1467754699.736231-279401276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 14:47:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-07-05 14:47:06 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091013 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.488389) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.488995) ========= 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=d2a8c569965ab8367867b893000001a1-1467754699.736231-279401276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017855 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.540184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:06.540582) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce7a035cd2d10e06d8a720736e44bf81dea725f2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce7a035cd2d10e06d8a720736e44bf81dea725f2 --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=d2a8c569965ab8367867b893000001a1-1467754699.736231-279401276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 14:47:06,847 truncating revision to first 12 chars 2016-07-05 14:47:06,847 Setting DEBUG logging. 2016-07-05 14:47:06,847 attempt 1/10 2016-07-05 14:47:06,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce7a035cd2d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 14:47:07,163 unpacking tar archive at: mozilla-aurora-ce7a035cd2d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657974 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:07.215259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:07.215633) ========= script_repo_revision: ce7a035cd2d10e06d8a720736e44bf81dea725f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:07.216089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:07.216373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 14:47:07.232074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-05 14:47:07.232475) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=d2a8c569965ab8367867b893000001a1-1467754699.736231-279401276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:47:07 INFO - MultiFileLogger online at 20160705 14:47:07 in /builds/slave/test 14:47:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:47:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:07 INFO - {'append_to_log': False, 14:47:07 INFO - 'base_work_dir': '/builds/slave/test', 14:47:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:47:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:07 INFO - 'branch': 'Mozilla-Aurora', 14:47:07 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:07 INFO - 'config_files': ('talos/linux_config.py',), 14:47:07 INFO - 'default_actions': ('clobber', 14:47:07 INFO - 'read-buildbot-config', 14:47:07 INFO - 'download-and-extract', 14:47:07 INFO - 'populate-webroot', 14:47:07 INFO - 'create-virtualenv', 14:47:07 INFO - 'install', 14:47:07 INFO - 'run-tests'), 14:47:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:07 INFO - 'download_minidump_stackwalk': True, 14:47:07 INFO - 'download_symbols': 'ondemand', 14:47:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:07 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:07 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:07 INFO - 'installer_path': 'installer.exe', 14:47:07 INFO - 'log_level': 'info', 14:47:07 INFO - 'log_name': 'talos', 14:47:07 INFO - 'log_to_console': True, 14:47:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:47:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:47:07 INFO - 'opt_config_files': (), 14:47:07 INFO - 'pip_index': False, 14:47:07 INFO - 'sps_profile': False, 14:47:07 INFO - 'sps_profile_interval': 0, 14:47:07 INFO - 'suite': 'dromaeojs', 14:47:07 INFO - 'system_bits': '32', 14:47:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:07 INFO - 'title': 'talos-linux64-ix-043', 14:47:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:07 INFO - 'use_talos_json': True, 14:47:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:07 INFO - 'work_dir': 'build'} 14:47:07 INFO - ##### 14:47:07 INFO - ##### Running clobber step. 14:47:07 INFO - ##### 14:47:07 INFO - Running pre-action listener: _resource_record_pre_action 14:47:07 INFO - Running main action method: clobber 14:47:07 INFO - rmtree: /builds/slave/test/build 14:47:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:08 INFO - Running post-action listener: _resource_record_post_action 14:47:08 INFO - ##### 14:47:08 INFO - ##### Finished clobber step (success) 14:47:08 INFO - ##### 14:47:08 INFO - ##### 14:47:08 INFO - ##### Running read-buildbot-config step. 14:47:08 INFO - ##### 14:47:08 INFO - Running pre-action listener: _resource_record_pre_action 14:47:08 INFO - Running main action method: read_buildbot_config 14:47:08 INFO - Using buildbot properties: 14:47:08 INFO - { 14:47:08 INFO - "project": "", 14:47:08 INFO - "product": "firefox", 14:47:08 INFO - "script_repo_revision": "production", 14:47:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:47:08 INFO - "repository": "", 14:47:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:47:08 INFO - "buildid": "20160705121624", 14:47:08 INFO - "pgo_build": "True", 14:47:08 INFO - "basedir": "/builds/slave/test", 14:47:08 INFO - "buildnumber": 348, 14:47:08 INFO - "slavename": "talos-linux64-ix-043", 14:47:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:47:08 INFO - "platform": "ubuntu64_hw", 14:47:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:47:08 INFO - "branch": "mozilla-aurora", 14:47:08 INFO - "repo_path": "releases/mozilla-aurora", 14:47:08 INFO - "revision": "ce7a035cd2d10e06d8a720736e44bf81dea725f2", 14:47:08 INFO - "stage_platform": "linux64-pgo", 14:47:08 INFO - "builduid": "788e236bd1be410084c74acb60713d71", 14:47:08 INFO - "slavebuilddir": "test" 14:47:08 INFO - } 14:47:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:47:08 INFO - Running post-action listener: _resource_record_post_action 14:47:08 INFO - ##### 14:47:08 INFO - ##### Finished read-buildbot-config step (success) 14:47:08 INFO - ##### 14:47:08 INFO - ##### 14:47:08 INFO - ##### Running download-and-extract step. 14:47:08 INFO - ##### 14:47:08 INFO - Running pre-action listener: _resource_record_pre_action 14:47:08 INFO - Running main action method: download_and_extract 14:47:08 INFO - mkdir: /builds/slave/test/build/tests 14:47: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')]} 14:47:08 INFO - https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:47:10 INFO - Downloaded 1361 bytes. 14:47:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:47:10 INFO - Using the following test package requirements: 14:47:10 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:47:10 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:47:10 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:47:10 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'jsshell-linux-x86_64.zip'], 14:47:10 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:47:10 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:47:10 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:47:10 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:47:10 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:47:10 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:47:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:47:10 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:10 INFO - https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:47:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:47:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:47:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:47:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:47:13 INFO - Downloaded 24526684 bytes. 14:47:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:47:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:47:15 INFO - Return code: 0 14:47:15 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:15 INFO - https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:47:18 INFO - Downloaded 24526684 bytes. 14:47:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:47:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:47:20 INFO - Return code: 0 14:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:20 INFO - https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:47:21 INFO - Downloaded 10833369 bytes. 14:47:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:47:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:47:21 INFO - Return code: 0 14:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:21 INFO - https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:47:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:47:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:47:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:47:22 INFO - Downloaded 63639158 bytes. 14:47:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:47:22 INFO - mkdir: /builds/slave/test/properties 14:47:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:47:22 INFO - Writing to file /builds/slave/test/properties/build_url 14:47:22 INFO - Contents: 14:47:22 INFO - build_url:https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:47:23 INFO - Running post-action listener: _resource_record_post_action 14:47:23 INFO - Running post-action listener: set_extra_try_arguments 14:47:23 INFO - ##### 14:47:23 INFO - ##### Finished download-and-extract step (success) 14:47:23 INFO - ##### 14:47:23 INFO - ##### 14:47:23 INFO - ##### Running populate-webroot step. 14:47:23 INFO - ##### 14:47:23 INFO - Running pre-action listener: _resource_record_pre_action 14:47:23 INFO - Running main action method: populate_webroot 14:47:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:47:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:47:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:47:23 INFO - '--tppagecycles', 14:47:23 INFO - '7'], 14:47:23 INFO - 'tests': ['tsvgm']}}, 14:47:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:47:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:47:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:47:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:47:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['damp', 'tps']}, 14:47:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'tests': ['damp', 'tps']}, 14:47:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['dromaeo_dom']}, 14:47:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:47:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['a11yr', 14:47:23 INFO - 'ts_paint', 14:47:23 INFO - 'tpaint', 14:47:23 INFO - 'sessionrestore', 14:47:23 INFO - 'sessionrestore_no_auto_restore', 14:47:23 INFO - 'tabpaint']}, 14:47:23 INFO - 'other-e10s': {'tests': ['a11yr', 14:47:23 INFO - 'ts_paint', 14:47:23 INFO - 'tpaint', 14:47:23 INFO - 'sessionrestore', 14:47:23 INFO - 'sessionrestore_no_auto_restore', 14:47:23 INFO - 'tabpaint']}, 14:47:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:47:23 INFO - 'ts_paint', 14:47:23 INFO - 'tpaint', 14:47:23 INFO - 'sessionrestore', 14:47:23 INFO - 'sessionrestore_no_auto_restore', 14:47:23 INFO - 'tabpaint']}, 14:47:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:47:23 INFO - 'ts_paint', 14:47:23 INFO - 'tpaint', 14:47:23 INFO - 'sessionrestore', 14:47:23 INFO - 'sessionrestore_no_auto_restore', 14:47:23 INFO - 'tabpaint']}, 14:47:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['a11yr', 14:47:23 INFO - 'ts_paint', 14:47:23 INFO - 'tpaint', 14:47:23 INFO - 'sessionrestore', 14:47:23 INFO - 'sessionrestore_no_auto_restore', 14:47:23 INFO - 'tabpaint']}, 14:47:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['a11yr', 14:47:23 INFO - 'ts_paint', 14:47:23 INFO - 'tpaint', 14:47:23 INFO - 'sessionrestore', 14:47:23 INFO - 'sessionrestore_no_auto_restore', 14:47:23 INFO - 'tabpaint']}, 14:47:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['tsvgx', 14:47:23 INFO - 'tsvgr_opacity', 14:47:23 INFO - 'tart', 14:47:23 INFO - 'tscrollx', 14:47:23 INFO - 'cart']}, 14:47:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:47:23 INFO - 'tsvgr_opacity', 14:47:23 INFO - 'tart', 14:47:23 INFO - 'tscrollx', 14:47:23 INFO - 'cart']}, 14:47:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'talos_options': ['--disable-e10s'], 14:47:23 INFO - 'tests': ['tp5o']}, 14:47:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'tests': ['tp5o']}, 14:47:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'talos_options': ['--disable-e10s', 14:47:23 INFO - '--xperf_path', 14:47:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:23 INFO - 'tests': ['tp5n']}, 14:47:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:23 INFO - 'talos_options': ['--xperf_path', 14:47:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:23 INFO - 'tests': ['tp5n']}}, 14:47:23 INFO - 'talos.zip': {'path': '', 14:47:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:47:23 INFO - Running post-action listener: _resource_record_post_action 14:47:23 INFO - ##### 14:47:23 INFO - ##### Finished populate-webroot step (success) 14:47:23 INFO - ##### 14:47:23 INFO - ##### 14:47:23 INFO - ##### Running create-virtualenv step. 14:47:23 INFO - ##### 14:47:23 INFO - Running pre-action listener: _resource_record_pre_action 14:47:23 INFO - Running main action method: create_virtualenv 14:47:23 INFO - Creating virtualenv /builds/slave/test/build/venv 14:47:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:47:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:47:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:47:23 INFO - Using real prefix '/usr' 14:47:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:47:24 INFO - Installing distribute.............................................................................................................................................................................................done. 14:47:26 INFO - Installing pip.................done. 14:47:26 INFO - Return code: 0 14:47:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:26 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:47:26 INFO - Using env: {'DISPLAY': ':0', 14:47:26 INFO - 'HOME': '/home/cltbld', 14:47:26 INFO - 'LANG': 'en_US.UTF-8', 14:47:26 INFO - 'LANGUAGE': 'en_US:en', 14:47:26 INFO - 'LOGNAME': 'cltbld', 14:47:26 INFO - 'MAIL': '/var/mail/cltbld', 14:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:26 INFO - 'MOZ_NO_REMOTE': '1', 14:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:26 INFO - 'NO_EM_RESTART': '1', 14:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:26 INFO - 'PWD': '/builds/slave/test', 14:47:26 INFO - 'SHELL': '/bin/bash', 14:47:26 INFO - 'SHLVL': '1', 14:47:26 INFO - 'TERM': 'linux', 14:47:26 INFO - 'TMOUT': '86400', 14:47:26 INFO - 'USER': 'cltbld', 14:47:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:26 INFO - '_': '/tools/buildbot/bin/python'} 14:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:47:26 INFO - Cleaning up... 14:47:26 INFO - Return code: 0 14:47:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:26 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:47:26 INFO - Using env: {'DISPLAY': ':0', 14:47:26 INFO - 'HOME': '/home/cltbld', 14:47:26 INFO - 'LANG': 'en_US.UTF-8', 14:47:26 INFO - 'LANGUAGE': 'en_US:en', 14:47:26 INFO - 'LOGNAME': 'cltbld', 14:47:26 INFO - 'MAIL': '/var/mail/cltbld', 14:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:26 INFO - 'MOZ_NO_REMOTE': '1', 14:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:26 INFO - 'NO_EM_RESTART': '1', 14:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:26 INFO - 'PWD': '/builds/slave/test', 14:47:26 INFO - 'SHELL': '/bin/bash', 14:47:26 INFO - 'SHLVL': '1', 14:47:26 INFO - 'TERM': 'linux', 14:47:26 INFO - 'TMOUT': '86400', 14:47:26 INFO - 'USER': 'cltbld', 14:47:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:26 INFO - '_': '/tools/buildbot/bin/python'} 14:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:26 INFO - Downloading/unpacking psutil>=3.1.1 14:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:47:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:28 INFO - Installing collected packages: psutil 14:47:28 INFO - Running setup.py install for psutil 14:47:28 INFO - building 'psutil._psutil_linux' extension 14:47:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:47:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:47:28 INFO - building 'psutil._psutil_posix' extension 14:47:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:47:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:47:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:29 INFO - Successfully installed psutil 14:47:29 INFO - Cleaning up... 14:47:29 INFO - Return code: 0 14:47:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:47:29 INFO - Using env: {'DISPLAY': ':0', 14:47:29 INFO - 'HOME': '/home/cltbld', 14:47:29 INFO - 'LANG': 'en_US.UTF-8', 14:47:29 INFO - 'LANGUAGE': 'en_US:en', 14:47:29 INFO - 'LOGNAME': 'cltbld', 14:47:29 INFO - 'MAIL': '/var/mail/cltbld', 14:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:29 INFO - 'MOZ_NO_REMOTE': '1', 14:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:29 INFO - 'NO_EM_RESTART': '1', 14:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:29 INFO - 'PWD': '/builds/slave/test', 14:47:29 INFO - 'SHELL': '/bin/bash', 14:47:29 INFO - 'SHLVL': '1', 14:47:29 INFO - 'TERM': 'linux', 14:47:29 INFO - 'TMOUT': '86400', 14:47:29 INFO - 'USER': 'cltbld', 14:47:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:29 INFO - '_': '/tools/buildbot/bin/python'} 14:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:47:31 INFO - Installing collected packages: mozsystemmonitor 14:47:31 INFO - Running setup.py install for mozsystemmonitor 14:47:31 INFO - Successfully installed mozsystemmonitor 14:47:31 INFO - Cleaning up... 14:47:31 INFO - Return code: 0 14:47:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:31 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:47:31 INFO - Using env: {'DISPLAY': ':0', 14:47:31 INFO - 'HOME': '/home/cltbld', 14:47:31 INFO - 'LANG': 'en_US.UTF-8', 14:47:31 INFO - 'LANGUAGE': 'en_US:en', 14:47:31 INFO - 'LOGNAME': 'cltbld', 14:47:31 INFO - 'MAIL': '/var/mail/cltbld', 14:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:31 INFO - 'MOZ_NO_REMOTE': '1', 14:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:31 INFO - 'NO_EM_RESTART': '1', 14:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:31 INFO - 'PWD': '/builds/slave/test', 14:47:31 INFO - 'SHELL': '/bin/bash', 14:47:31 INFO - 'SHLVL': '1', 14:47:31 INFO - 'TERM': 'linux', 14:47:31 INFO - 'TMOUT': '86400', 14:47:31 INFO - 'USER': 'cltbld', 14:47:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:31 INFO - '_': '/tools/buildbot/bin/python'} 14:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:31 INFO - Downloading/unpacking jsonschema==2.5.1 14:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:47:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:33 INFO - Downloading functools32-3.2.3-2.tar.gz 14:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:47:33 INFO - warning: no files found matching '*.txt' 14:47:33 INFO - no previously-included directories found matching 'build' 14:47:33 INFO - no previously-included directories found matching 'dist' 14:47:33 INFO - no previously-included directories found matching '.git*' 14:47:34 INFO - Installing collected packages: jsonschema, functools32 14:47:34 INFO - Running setup.py install for functools32 14:47:34 INFO - warning: no files found matching '*.txt' 14:47:34 INFO - no previously-included directories found matching 'build' 14:47:34 INFO - no previously-included directories found matching 'dist' 14:47:34 INFO - no previously-included directories found matching '.git*' 14:47:34 INFO - Successfully installed jsonschema functools32 14:47:34 INFO - Cleaning up... 14:47:34 INFO - Return code: 0 14:47:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:34 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:47:34 INFO - Using env: {'DISPLAY': ':0', 14:47:34 INFO - 'HOME': '/home/cltbld', 14:47:34 INFO - 'LANG': 'en_US.UTF-8', 14:47:34 INFO - 'LANGUAGE': 'en_US:en', 14:47:34 INFO - 'LOGNAME': 'cltbld', 14:47:34 INFO - 'MAIL': '/var/mail/cltbld', 14:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:34 INFO - 'MOZ_NO_REMOTE': '1', 14:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:34 INFO - 'NO_EM_RESTART': '1', 14:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:34 INFO - 'PWD': '/builds/slave/test', 14:47:34 INFO - 'SHELL': '/bin/bash', 14:47:34 INFO - 'SHLVL': '1', 14:47:34 INFO - 'TERM': 'linux', 14:47:34 INFO - 'TMOUT': '86400', 14:47:34 INFO - 'USER': 'cltbld', 14:47:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:34 INFO - '_': '/tools/buildbot/bin/python'} 14:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:34 INFO - Downloading/unpacking blobuploader==1.2.4 14:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:36 INFO - Downloading blobuploader-1.2.4.tar.gz 14:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:47:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:47:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:37 INFO - Downloading docopt-0.6.1.tar.gz 14:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:47:37 INFO - Installing collected packages: blobuploader, requests, docopt 14:47:37 INFO - Running setup.py install for blobuploader 14:47:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:47:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:47:37 INFO - Running setup.py install for requests 14:47:37 INFO - Running setup.py install for docopt 14:47:37 INFO - Successfully installed blobuploader requests docopt 14:47:37 INFO - Cleaning up... 14:47:37 INFO - Return code: 0 14:47:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:37 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:47:37 INFO - Using env: {'DISPLAY': ':0', 14:47:37 INFO - 'HOME': '/home/cltbld', 14:47:37 INFO - 'LANG': 'en_US.UTF-8', 14:47:37 INFO - 'LANGUAGE': 'en_US:en', 14:47:37 INFO - 'LOGNAME': 'cltbld', 14:47:37 INFO - 'MAIL': '/var/mail/cltbld', 14:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:37 INFO - 'MOZ_NO_REMOTE': '1', 14:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:37 INFO - 'NO_EM_RESTART': '1', 14:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:37 INFO - 'PWD': '/builds/slave/test', 14:47:37 INFO - 'SHELL': '/bin/bash', 14:47:37 INFO - 'SHLVL': '1', 14:47:37 INFO - 'TERM': 'linux', 14:47:37 INFO - 'TMOUT': '86400', 14:47:37 INFO - 'USER': 'cltbld', 14:47:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:37 INFO - '_': '/tools/buildbot/bin/python'} 14:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:37 INFO - Running setup.py (path:/tmp/pip-2dr0Zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:38 INFO - Running setup.py (path:/tmp/pip-qJ8K2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:38 INFO - Running setup.py (path:/tmp/pip-H3RgRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:38 INFO - Running setup.py (path:/tmp/pip-fCGlTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:38 INFO - Running setup.py (path:/tmp/pip-BQ_wuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:38 INFO - Running setup.py (path:/tmp/pip-X_bcbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:38 INFO - Running setup.py (path:/tmp/pip-8XHXgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:38 INFO - Running setup.py (path:/tmp/pip-Fu9gJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:38 INFO - Running setup.py (path:/tmp/pip-G76UqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:38 INFO - Running setup.py (path:/tmp/pip-SFdLXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:38 INFO - Running setup.py (path:/tmp/pip-yXN2zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:38 INFO - Running setup.py (path:/tmp/pip-IVh9sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:38 INFO - Running setup.py (path:/tmp/pip-x5fRwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:38 INFO - Running setup.py (path:/tmp/pip-sXFjA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:38 INFO - Running setup.py (path:/tmp/pip-Flnmea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:39 INFO - Running setup.py (path:/tmp/pip-DPHNhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:39 INFO - Running setup.py (path:/tmp/pip-OkeZZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:47:39 INFO - Running setup.py install for manifestparser 14:47:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozcrash 14:47:39 INFO - Running setup.py install for mozdebug 14:47:39 INFO - Running setup.py install for mozdevice 14:47:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozfile 14:47:39 INFO - Running setup.py install for mozhttpd 14:47:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozinfo 14:47:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozInstall 14:47:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozleak 14:47:40 INFO - Running setup.py install for mozlog 14:47:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Running setup.py install for moznetwork 14:47:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Running setup.py install for mozprocess 14:47:40 INFO - Running setup.py install for mozprofile 14:47:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Running setup.py install for mozrunner 14:47:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Running setup.py install for mozscreenshot 14:47:40 INFO - Running setup.py install for moztest 14:47:40 INFO - Running setup.py install for mozversion 14:47:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:47:40 INFO - Cleaning up... 14:47:40 INFO - Return code: 0 14:47:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:40 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:47:40 INFO - Using env: {'DISPLAY': ':0', 14:47:40 INFO - 'HOME': '/home/cltbld', 14:47:40 INFO - 'LANG': 'en_US.UTF-8', 14:47:40 INFO - 'LANGUAGE': 'en_US:en', 14:47:40 INFO - 'LOGNAME': 'cltbld', 14:47:40 INFO - 'MAIL': '/var/mail/cltbld', 14:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:40 INFO - 'MOZ_NO_REMOTE': '1', 14:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:40 INFO - 'NO_EM_RESTART': '1', 14:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:40 INFO - 'PWD': '/builds/slave/test', 14:47:40 INFO - 'SHELL': '/bin/bash', 14:47:40 INFO - 'SHLVL': '1', 14:47:40 INFO - 'TERM': 'linux', 14:47:40 INFO - 'TMOUT': '86400', 14:47:40 INFO - 'USER': 'cltbld', 14:47:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:40 INFO - '_': '/tools/buildbot/bin/python'} 14:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:41 INFO - Running setup.py (path:/tmp/pip-ZDeAHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:41 INFO - Running setup.py (path:/tmp/pip-qgc3hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:41 INFO - Running setup.py (path:/tmp/pip-lNmlsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:41 INFO - Running setup.py (path:/tmp/pip-vVUbdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:41 INFO - Running setup.py (path:/tmp/pip-PMWJf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:41 INFO - Running setup.py (path:/tmp/pip-2znv6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:41 INFO - Running setup.py (path:/tmp/pip-HWoCwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:41 INFO - Running setup.py (path:/tmp/pip-EFXmUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:41 INFO - Running setup.py (path:/tmp/pip-7AA0d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:41 INFO - Running setup.py (path:/tmp/pip-06xaRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:41 INFO - Running setup.py (path:/tmp/pip-EEhDhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:41 INFO - Running setup.py (path:/tmp/pip-YhAbEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:42 INFO - Running setup.py (path:/tmp/pip-Gk4H7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:42 INFO - Running setup.py (path:/tmp/pip-irv3Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:42 INFO - Running setup.py (path:/tmp/pip-zFiM2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:42 INFO - Running setup.py (path:/tmp/pip-yVzdom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:42 INFO - Running setup.py (path:/tmp/pip-D8T_ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:44 INFO - Downloading blessings-1.6.tar.gz 14:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:47:44 INFO - Installing collected packages: blessings 14:47:44 INFO - Running setup.py install for blessings 14:47:44 INFO - Successfully installed blessings 14:47:44 INFO - Cleaning up... 14:47:44 INFO - Return code: 0 14:47:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:44 INFO - Reading from file tmpfile_stdout 14:47:44 INFO - Current package versions: 14:47:44 INFO - argparse == 1.2.1 14:47:44 INFO - blessings == 1.6 14:47:44 INFO - blobuploader == 1.2.4 14:47:44 INFO - docopt == 0.6.1 14:47:44 INFO - functools32 == 3.2.3-2 14:47:44 INFO - jsonschema == 2.5.1 14:47:44 INFO - manifestparser == 1.1 14:47:44 INFO - mozInstall == 1.12 14:47:44 INFO - mozcrash == 0.17 14:47:44 INFO - mozdebug == 0.1 14:47:44 INFO - mozdevice == 0.48 14:47:44 INFO - mozfile == 1.2 14:47:44 INFO - mozhttpd == 0.7 14:47:44 INFO - mozinfo == 0.9 14:47:44 INFO - mozleak == 0.1 14:47:44 INFO - mozlog == 3.2 14:47:44 INFO - moznetwork == 0.27 14:47:44 INFO - mozprocess == 0.22 14:47:44 INFO - mozprofile == 0.28 14:47:44 INFO - mozrunner == 6.11 14:47:44 INFO - mozscreenshot == 0.1 14:47:44 INFO - mozsystemmonitor == 0.3 14:47:44 INFO - moztest == 0.7 14:47:44 INFO - mozversion == 1.4 14:47:44 INFO - psutil == 3.1.1 14:47:44 INFO - requests == 1.2.3 14:47:44 INFO - wsgiref == 0.1.2 14:47:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:44 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:47:44 INFO - Using env: {'DISPLAY': ':0', 14:47:44 INFO - 'HOME': '/home/cltbld', 14:47:44 INFO - 'LANG': 'en_US.UTF-8', 14:47:44 INFO - 'LANGUAGE': 'en_US:en', 14:47:44 INFO - 'LOGNAME': 'cltbld', 14:47:44 INFO - 'MAIL': '/var/mail/cltbld', 14:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:44 INFO - 'MOZ_NO_REMOTE': '1', 14:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:44 INFO - 'NO_EM_RESTART': '1', 14:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:44 INFO - 'PWD': '/builds/slave/test', 14:47:44 INFO - 'SHELL': '/bin/bash', 14:47:44 INFO - 'SHLVL': '1', 14:47:44 INFO - 'TERM': 'linux', 14:47:44 INFO - 'TMOUT': '86400', 14:47:44 INFO - 'USER': 'cltbld', 14:47:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:44 INFO - '_': '/tools/buildbot/bin/python'} 14:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:47:44 INFO - Cleaning up... 14:47:44 INFO - Return code: 0 14:47:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:44 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:47:44 INFO - Using env: {'DISPLAY': ':0', 14:47:44 INFO - 'HOME': '/home/cltbld', 14:47:44 INFO - 'LANG': 'en_US.UTF-8', 14:47:44 INFO - 'LANGUAGE': 'en_US:en', 14:47:44 INFO - 'LOGNAME': 'cltbld', 14:47:44 INFO - 'MAIL': '/var/mail/cltbld', 14:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:44 INFO - 'MOZ_NO_REMOTE': '1', 14:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:44 INFO - 'NO_EM_RESTART': '1', 14:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:44 INFO - 'PWD': '/builds/slave/test', 14:47:44 INFO - 'SHELL': '/bin/bash', 14:47:44 INFO - 'SHLVL': '1', 14:47:44 INFO - 'TERM': 'linux', 14:47:44 INFO - 'TMOUT': '86400', 14:47:44 INFO - 'USER': 'cltbld', 14:47:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:44 INFO - '_': '/tools/buildbot/bin/python'} 14:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:47:45 INFO - Cleaning up... 14:47:45 INFO - Return code: 0 14:47:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:45 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 0x7f6db1a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, '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': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:47:45 INFO - Using env: {'DISPLAY': ':0', 14:47:45 INFO - 'HOME': '/home/cltbld', 14:47:45 INFO - 'LANG': 'en_US.UTF-8', 14:47:45 INFO - 'LANGUAGE': 'en_US:en', 14:47:45 INFO - 'LOGNAME': 'cltbld', 14:47:45 INFO - 'MAIL': '/var/mail/cltbld', 14:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:45 INFO - 'MOZ_NO_REMOTE': '1', 14:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:45 INFO - 'NO_EM_RESTART': '1', 14:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:45 INFO - 'PWD': '/builds/slave/test', 14:47:45 INFO - 'SHELL': '/bin/bash', 14:47:45 INFO - 'SHLVL': '1', 14:47:45 INFO - 'TERM': 'linux', 14:47:45 INFO - 'TMOUT': '86400', 14:47:45 INFO - 'USER': 'cltbld', 14:47:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:45 INFO - '_': '/tools/buildbot/bin/python'} 14:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:45 INFO - Downloading/unpacking flake8 14:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:47:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:47:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:47:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:47:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:47:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:47:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:47:48 INFO - no previously-included directories found matching 'docs/_build' 14:47:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:47:48 INFO - Running setup.py install for pep8 14:47:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:47:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:47:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:47:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:47:48 INFO - no previously-included directories found matching 'docs/_build' 14:47:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:47:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:47:48 INFO - Cleaning up... 14:47:48 INFO - Return code: 0 14:47:48 INFO - Running post-action listener: _resource_record_post_action 14:47:48 INFO - Running post-action listener: _start_resource_monitoring 14:47:48 INFO - Starting resource monitoring. 14:47:48 INFO - ##### 14:47:48 INFO - ##### Finished create-virtualenv step (success) 14:47:48 INFO - ##### 14:47:48 INFO - ##### 14:47:48 INFO - ##### Running install step. 14:47:48 INFO - ##### 14:47:48 INFO - Running pre-action listener: _resource_record_pre_action 14:47:48 INFO - Running main action method: install 14:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:48 INFO - Reading from file tmpfile_stdout 14:47:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:47:48 INFO - Reading from file tmpfile_stdout 14:47:48 INFO - Output received: 14:47:48 INFO - Usage: mozinstall [options] installer 14:47:48 INFO - Options: 14:47:48 INFO - -h, --help show this help message and exit 14:47:48 INFO - -d DEST, --destination=DEST 14:47:48 INFO - Directory to install application into. [default: 14:47:48 INFO - "/builds/slave/test"] 14:47:48 INFO - --app=APP Application being installed. [default: firefox] 14:47:48 INFO - mkdir: /builds/slave/test/build/application 14:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:48:04 INFO - Reading from file tmpfile_stdout 14:48:04 INFO - Output received: 14:48:04 INFO - /builds/slave/test/build/application/firefox/firefox 14:48:04 INFO - Running post-action listener: _resource_record_post_action 14:48:04 INFO - ##### 14:48:04 INFO - ##### Finished install step (success) 14:48:04 INFO - ##### 14:48:04 INFO - ##### 14:48:04 INFO - ##### Running run-tests step. 14:48:04 INFO - ##### 14:48:04 INFO - Running pre-action listener: _resource_record_pre_action 14:48:04 INFO - Running main action method: run_tests 14:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:04 INFO - Python 2.7.3 14:48:04 INFO - Return code: 0 14:48:04 INFO - grabbing minidump binary from tooltool 14:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:04 INFO - 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 0x23da1c0>, '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 0x23db0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23db550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:48:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:48:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:48:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:04 INFO - Return code: 0 14:48:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:48:05 INFO - Return code: 0 14:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 14:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 14:48:05 INFO - Using env: {'DISPLAY': ':0', 14:48:05 INFO - 'HOME': '/home/cltbld', 14:48:05 INFO - 'LANG': 'en_US.UTF-8', 14:48:05 INFO - 'LANGUAGE': 'en_US:en', 14:48:05 INFO - 'LOGNAME': 'cltbld', 14:48:05 INFO - 'MAIL': '/var/mail/cltbld', 14:48:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:05 INFO - 'MOZ_NO_REMOTE': '1', 14:48:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:05 INFO - 'NO_EM_RESTART': '1', 14:48:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:05 INFO - 'PWD': '/builds/slave/test', 14:48:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:05 INFO - 'SHELL': '/bin/bash', 14:48:05 INFO - 'SHLVL': '1', 14:48:05 INFO - 'TERM': 'linux', 14:48:05 INFO - 'TMOUT': '86400', 14:48:05 INFO - 'USER': 'cltbld', 14:48:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467754699.736231-279401276', 14:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:05 INFO - '_': '/tools/buildbot/bin/python'} 14:48:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 14:48:05 INFO - mozversion application_buildid: 20160705121624 14:48:05 INFO - mozversion application_changeset: ce7a035cd2d10e06d8a720736e44bf81dea725f2 14:48:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:48:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:05 INFO - mozversion application_name: Firefox 14:48:05 INFO - mozversion application_remotingname: firefox-dev 14:48:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:48:05 INFO - mozversion application_vendor: Mozilla 14:48:05 INFO - mozversion application_version: 49.0a2 14:48:05 INFO - mozversion platform_buildid: 20160705121624 14:48:05 INFO - mozversion platform_changeset: ce7a035cd2d10e06d8a720736e44bf81dea725f2 14:48:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:48:05 INFO - mozversion platform_version: 49.0a2 14:48:05 INFO - using testdate: 1467755285 14:48:05 INFO - actual date: 1467755285 14:48:05 INFO - starting webserver on 'localhost:41279' 14:48:05 INFO - SUITE-START | Running 2 tests 14:48:05 INFO - TEST-START | dromaeo_css 14:48:05 INFO - operating with platform_type : linux_ 14:48:05 INFO - Initialising browser for dromaeo_css test... 14:48:05 INFO - TEST-INFO | started process 2930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunwBLy/profile http://localhost:41279/getInfo.html) 14:48:10 INFO - PROCESS | 2930 | __metrics Screen width/height:1600/1200 14:48:10 INFO - PROCESS | 2930 | colorDepth:24 14:48:10 INFO - PROCESS | 2930 | Browser inner width/height: 1024/697 14:48:10 INFO - PROCESS | 2930 | __metrics 14:48:11 ERROR - PROCESS | 2930 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:48:12 INFO - TEST-INFO | 2930: exit 0 14:48:12 INFO - Browser initialized. 14:48:12 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:12 INFO - TEST-INFO | started process 3022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunwBLy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:23 INFO - PROCESS | 3022 | RSS: Main: 145338368 14:48:23 INFO - PROCESS | 3022 | 14:49:15 INFO - PROCESS | 3022 | 1467755355147 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:51:23 INFO - PROCESS | 3022 | Cycle 1(1): loaded http://localhost:41279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41279/tests/dromaeo/cssquery-ext.html) 14:51:24 INFO - PROCESS | 3022 | RSS: Main: 252694528 14:51:24 INFO - PROCESS | 3022 | 14:54:26 INFO - PROCESS | 3022 | Cycle 1(1): loaded http://localhost:41279/tests/dromaeo/cssquery-ext.html (next: http://localhost:41279/tests/dromaeo/cssquery-jquery.html) 14:54:27 INFO - PROCESS | 3022 | RSS: Main: 227471360 14:54:27 INFO - PROCESS | 3022 | 14:57:29 INFO - PROCESS | 3022 | Cycle 1(1): loaded http://localhost:41279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41279/tests/dromaeo/cssquery-mootools.html) 14:57:29 INFO - PROCESS | 3022 | RSS: Main: 228286464 14:57:29 INFO - PROCESS | 3022 | 15:00:31 INFO - PROCESS | 3022 | Cycle 1(1): loaded http://localhost:41279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41279/tests/dromaeo/cssquery-prototype.html) 15:00:32 INFO - PROCESS | 3022 | RSS: Main: 224546816 15:00:32 INFO - PROCESS | 3022 | 15:03:34 INFO - PROCESS | 3022 | Cycle 1(1): loaded http://localhost:41279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41279/tests/dromaeo/cssquery-yui.html) 15:03:35 INFO - PROCESS | 3022 | RSS: Main: 217935872 15:03:35 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | Cycle 1(1): loaded http://localhost:41279/tests/dromaeo/cssquery-yui.html (next: http://localhost:41279/tests/dromaeo/cssquery-dojo.html) 15:06:38 INFO - PROCESS | 3022 | RSS: Main: 258314240 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | __start_tp_report 15:06:38 INFO - PROCESS | 3022 | _x_x_mozilla_page_load 15:06:38 INFO - PROCESS | 3022 | _x_x_mozilla_page_load_details 15:06:38 INFO - PROCESS | 3022 | |i|pagename|runs| 15:06:38 INFO - PROCESS | 3022 | |0;dojo.html;3301.1582046578123;3340.5323254744326;3352.4133276676585;3372.7301815854735;3384.289299247158;5456.099743542316;5464.781408743645;5489.533389661879;5498.835034948958;5531.308586426701;5383.488568585988;5415.539679127279;5433.4566543345645;5461.836144915659;5489.58828087893;4886.682365646239;4954.182559877625;4971;5002.224655178435;5041.406580288986;4879.365682461275;4997.750112494379;5028.622853286;5029.849104526852;5031.421386540558;4928.926066109011;4947.03532811102;4948.57937075349;4965.65240433168;5037.093323201822;5027.522385373383;5029.270755740416;5034.270030845543;5052.671576347562;5081.618878584102;4857;4902.828401005948;4957.107720610289;4960.801567937278;4990.850274491771;5351.973240133774;5356.11624082026;5366.114591092465;5391.595630327741;5411;5897.380775018647;5937.910931336033;5938.257717785277;5946.405359464019;5946.405359464062;5863.912041319383;5887.087501437284;5896.262967129109;5967.5524335675;6000.129981152752;5580.91628625571;5613.971930140364;5616.045272303718;5624.100143976944;5626.915596265977;5797.275340582427;6093.69531523422;6100.115483254903;6102.755889764359;6113.33293539461;5682.573806964494;5725.713714314267;5739.167820666064;5819.592628515963;5820.097884827774;5838.357780644125;5856.4143585641095;5867.383924687846;5895.55783316253;5896.380880007623;5627.155926611041;5777.19119323295;5795.217645617788;5811.535077193815;5811.94188058114;5852.853678658068;5915.556333275022;5917.112433134978;5921.437463440966;5954.07711804671;4562.817487300471;4569.474510431276;4573.611243044378;4577;4599.448066232007;3907.5701672815967;3991.560928297885;4065.4714887064492;4082.1631565528996;4122.896927576775;5699.601027928005;5720.370759216483;5722.685252311163;5730.255066841367;5736.168255602997;5953.077273022688;5958.85102872423;5968.253968253968;5972.104184372379;6000;5522.889542209214;5543.584231182677;5560.026995275892;5654.434556544313;5706.914396284059;5028.17035189197;5031.195008798574;5038.748062596856;5043.9912017596625;5050.747462626854;6086.2087928569;6134.202553668084;6135.631862088289;6144.354842741537;6146.446819786241;5691.345495268097;5747.540196784331;5823.7379317929945;5837.854053648693;5885.058390657474;5926.585139040226;6081.878362432638;6124.173236613;6130.01919692847;6130.47890929276;5753.856153596026;5755.079187330007;5762.135679647919;5764.365919748908;5765.192872997867;5723.456271654186;5799.159121927212;5841.561882858888;5843.415658434123;5870.55970802183;5703.515201207778;5710.914336285042;5712.571557133148;5712.600117991867;5722.62802917809;5559.805406810742;5719.771209151588;5728.856778580569;5730.484256416942;5741.368449470471;5600.85997850057;5646.604737668488;5650.095984642602;5684.573656975661;5691.63004404729;5802.506786923159;5804.477597016289;5818.6217895836635;5850.327212370632;5852.648841069549;5502.5597952164535;5566;5703.885922281448;5707.4577915098;5733.31200255972 15:06:38 INFO - PROCESS | 3022 | |1;ext.html;611.5505103748744;628.0735914526073;653.4086651580316;665.3546060321489;666.1306994372344;32885.17787055322;45094.999999999956;45201.54798452015;45608.54391456085;45685;49072;49504.25743613848;49682.75158624202;49708.50291497084;49774.75112624441;8196;9005.054469280745;9157.587908544132;9158;10730.624428145016;10483.737906552358;10873.184511161655;10882.510287037063;10883.564657413694;10883.67348979532;10885.727856803564;10941;10944.726381840437;10956.12351011921;10960.342379457219;8255.79360515989;8451.197136272045;10708.732281692943;10850.18623603229;10947.616833410792;10432.68701938943;10842.62050828225;10879.456027198688;10881.510332035077;10918.890811091867;46208.5379146211;46814.53185468136;46819.29771053437;46845.297320540216;46847.29729054033;3538.628444013393;3636.3636363636524;4128.587141285848;4208.789560521962;4279.807408666617;35726.28547429063;36745.08137296562;37054.44418333727;37112;37330.626693733255;3901.843926242947;3955.920881582352;3977.4033894915706;4012.217617564576;4101.118259574176;375362;377814;378702;378886;380158;40165.39751903724;41065.589344106775;41167.58832411697;71625.92561111588;72476.63761681263;43260.56739432628;43398;43468;43479.130417391476;43528.12943741107;16446.917765411337;16641.33434662624;16650.50048498547;16657.83342166587;16658.33366665344;12074.335911524951;12929.612111636667;13015;13234.338283085806;13268.601941941757;9688.90311096894;9703.466309352913;9704;9769.462679552693;9774.706758797105;3680.411134218512;3694.612065733113;3702.740808143458;3706.3328600852105;3742.8689995850013;1009.3035805294323;1034.4092313337653;1055.9788804223872;1155.8381826544291;1276.026857422204;32231.838840805645;33284.500732488545;33578.66421335804;33723.32553348968;33883;1116.1405717597404;1126.3973774030853;1163.203205804027;1189.3339729751367;1266.4111188297486;17749.29002839872;18104;18152.546186345182;18167.909160454114;18225.270989160552;635440;637762;641910;642713;643510;66445.33554664488;66653.66673166603;66975.66512167506;67022.3297767016;67266;1273.974520509603;1376.2636989210723;1407.0713329202881;1438.8561143885738;1450.1081834671602;32908;34676;35098.29803403969;35516.644833551334;35623.64376356203;56249.718751405984;56564.7171764155;56653.716731416076;56671;56846.43153568577;456000;456565;458550;459321;459734;27585.172444826687;31012.844935775178;31831.522527161647;31894;32308.35383292274;51777;51924.74037629788;52363.21455178099;52641.47358526366;53270.467295328104;43153.56846431496;44386.334204986306;44473.33290000588;44546.10907781891;45468.31797522974;43135.35296970611;43824.34263486114;43936;44967.55032449633;45441.31838022366;44591.55408445874;45713;45964;46553;48698.26952595785;38826.80586597049;40102;40349.79825100856;40712.79643601881;41175;29828.254293642833;30204.84897575498;30373.544396834506;30375.240618984702;30653 15:06:38 INFO - PROCESS | 3022 | |2;jquery.html;423.91733611945665;428.55858465780256;432.1745466159635;434.6891972239846;447.15264573632965;18979.430617081493;19831.305904293353;20410.387688369356;21195.364139075813;21221.151153953862;19680.2927151126;20070.49823754407;20191.09140088696;20519.589608207825;20569.177232910664;5762.769489220436;6023.6988150592515;6042.093685947099;6050.213472248602;6053.485453736438;5786.189933409326;5834.5040671542965;5868.853278668046;5925.822225333247;5926.288845338566;5873.0603103503445;5875.706214689249;5879.118132280149;5886.558508111887;5891.440313170242;5741.913871291934;5819.0689489681445;5906.527477801766;5923.733431995549;5933.732982015819;5220.216967454874;5301.416844147179;5314.574834013309;5318.840434786924;5320.813771518017;24070.63894041591;24274.39314017146;24315.270541883772;24423.877880610482;24431.26706198817;2281.3156053184143;2383.451806084593;2613.8562379069144;2752.7935404844716;2822.6895041545617;10057.446840423774;10232.13026892715;10924.672259832218;11009.724756881142;14377.640558986004;1881.5296175956012;2000.0699674651357;2064.4013236161495;2066.2664754012408;2074.6369385357502;85771;86291;86892.56553717254;87642.5617871913;89078;11351.318920864775;11370.715732106764;11393.544258229578;11407.201495895208;11424.42877856104;15740.60648483797;15778.60553486149;15878.44425445127;15878.9206053969;15897.602559936095;8003;8252.10757936529;8383.11977242393;8691.652333906573;8928.553572321487;7889.9211007890335;7896.723614673574;7971.920280797234;8052.476589021695;8080.595970201584;4933.28467372229;5001.224810154432;5009.949900501021;5182.144946083929;5204.583633309402;2022.5651484930515;2025.5746293278282;2053.117159621377;2055.486128467883;2096.716943212677;1017.5980487707315;1019.5463018956493;1031.339942436841;1083.8970297821695;1112.571659910924;19643;19846.603067938562;20009.699854502192;20182.293619723237;20340.89829550843;1057.4448414582253;1066.4720963123305;1084.7993121272589;1111.5831563163813;1143.742657901982;10907.345559266469;11135.815551913201;11272.492737826817;11277.266977646426;11278.210525263317;543308;546390;547663;548484;550259;99733;100214.49892750636;101593.49203253936;101920;102075.4896225529;1041.0890470838017;1063.8723353197665;1065.1425602389995;1080.8756992945755;1081.1296905990596;17617.647647047244;17994.910025450314;18150.546236343667;18160.545986350447;18358.1738821756;41045.79477102715;42149.578504214565;42166.36750448684;42235.3664695036;43952.56047439485;56339.154912677164;56506.43493565012;57284.140737888134;62599.37400625936;63191.6840415795;8872.689455869013;8898.734428705053;9062.22971047442;9109;9113.77215569616;9375.765605859635;13227.140235884637;13240.337983100613;13565.389557470135;14110.647233818827;11417.1437142213;11784.351860647746;12076.09429292789;12185;12357;11603.071754259809;11614.941925290657;11797.233179843282;11808.527658893549;11836.289822610672;11640.01059909917;11711.88288117108;11718.414079295831;11794.174407791372;11821.881781182423;8705.34709896773;8783.29733621296;8898.377113601986;9013.324000700104;9149.451032938045;10933.180011499011;10994.780104398027;11606.767864642828;11757.588484403004;11955.64133076009 15:06:38 INFO - PROCESS | 3022 | |3;mootools.html;1449.7607894697376;1576.408846682494;1603.9358425662974;1831.5878927241365;1938.7479627648404;8699.826003479926;9112.635494580218;9124.771880702985;9349.906500934989;9376.8593471098;9092.8636070459;9273.675421360254;9295.116963888437;9298.628054877796;9302.302327325444;2122.840786940978;2326.5928462519078;2396.2811156652933;2445.119756887519;2472.950540989179;2391.3304274802995;2397.724261709908;2399.2202534176463;2401.8799060047013;2404.555157295897;2377.583922813509;2416.709994800626;2423.1397853761923;2428.781409673129;2430.3802530354733;2122.4481634774993;2371.490129622131;2450.6936632920883;2454.1778504201116;2465.272744540347;2360.8465449745713;2368.46709490365;2370.134900761227;2372.0867466025534;2394.2697477269426;9247.398919070307;9327.20718738908;9374.390664606779;9381.953090234505;9389.15497605212;5290.788368465257;5442.809501667422;5451.672899626035;5457.317835270591;5458.399576046631;3306.8842590509457;3396.4056290149374;3447.0524153852994;3506.36885360635;3509.94735078974;1058.751193469534;1066.8186408310605;1080.778440419712;1087.1031399095777;1104.265663333882;12971.02717296197;12977.545785897448;12993.285369304684;13016.934915325362;13047.282399467931;4680;4778.259369797687;4825.372701548847;4829;4832.492588278251;10858.294210876267;10903.618373356894;10906.727331816768;10925.781484370267;10993.340399576051;4845.466998630148;5434.864128396822;5502.5597952163735;5508.091164957737;5508.118701007819;4974.228994505857;5095.363079615048;5108.131617625013;5166.974165129151;5168.81909133186;4138.337865941435;4180.268453020709;4182.2890108681595;4200.05498762782;4225.852095176654;1297.9091463597647;1304.3608631770553;1306.7582497237852;1312.6783937935268;1327.3296985022696;1023.0741179232806;1031.7059638003134;1032.9225308101923;1038.133158812385;1059.8304271316551;6397.200349956255;6418.486521078303;6437.25971513282;6442.130312407859;6517.804465866032;1018.4551265073151;1021.4841505039907;1030.8247597908373;1039.3867618105203;1050.401271275381;4044.4539987101953;4348.152110338454;4394.824207031683;4399.252127138394;4406.140802543473;11218.439078046065;11466.140039497071;11759;11878;11889.583864564698;11533.88466115328;11680.0655947524;11708.414579271173;11736.471858766376;11750.118741094451;8659;8970.730878073668;8974.057723939022;9020;9057.18485336323;6151.507879369729;6245.437910588069;6275.529335299962;6308.337624549356;6378.808635740936;10691.30506517074;10938.124950003821;10964;11013.118950484102;11146.275492092987;10918.836217456586;11118.110551155727;11170.385628790495;11236.887631123584;11263.7747245053;6954.513184077066;7485.812854678677;7619.352355049883;7630.504017238862;7765.650545725343;9198.724038278862;9241.214496767581;9288.814223715623;9295.628174872929;9301.302402319989;8156.510609363457;8317.376196785386;8367.707130250412;8424.199701028392;8453.704120355758;7974.84050319002;8051.959740201261;8074.677012919417;8101.270885620087;8119.797005074684;7352.485326027127;7639.961800190964;7659.080910290801;7713.460057796125;7816.374690024671;5583.218349431164;5591.30108736408;5630.127330263816;5646.265985421869;5782.681952492485;5390.757415916371;5465.945340546544;5479.4520547944885;5624.521915637053;5630.239917611234 15:06:38 INFO - PROCESS | 3022 | |4;prototype.html;349.4914898822214;351.33246831021063;356.2038843185481;363.5510144970962;364.11338391017875;5242;5414.675119492833;5492.780288788449;5542.473465020817;5570.916436253459;5401.9736250112455;5434.8913021739545;5435.728213589315;5443.755031023604;5444.774925641728;4308.289132293168;4326.891827704317;4328.653707703376;4330.112326972979;4331.076523346744;4073.4704488416464;4190.916181676364;4313.935290970638;4340.587644173815;4355.803988820495;4237.639800616951;4296.613304802567;4300.8709738707885;4315.287977483711;4342.174986752507;4249.128928569636;4270;4277.615014648681;4296.978515107436;4300.591443812848;3675.724320675933;3772.5661548921953;3821.293060783764;3832.6358995895343;3842.7886466244345;5154.015703953967;5157.53582177602;5163.7159956202395;5167.6641018333685;5246.898151388213;4879.707217566922;4885.487023862479;4958.181899986498;4970.478099799505;4982.227754698028;5583.497485226349;5585.664860108406;5642.633228840154;5652.5195358394585;5721.914171287434;4214.2414365414215;4215.852445164435;4235.131797981407;4237.660987121023;4240.766757828318;5948.940510594925;5956.702164891738;5982.312034116088;5983.970080149615;5991.400859914017;4242.363645453207;4317.525072242051;4337.698690392869;4349.369341445536;4356.8910777230185;4323.805428755713;4370.388145659546;4383.298672212431;4383.60547550722;4386.122775444924;4897.926531102036;4907.411110666742;4930.98914722481;4949.158643030693;4961.131801934647;5673.532013574026;5683.374828768832;5727.799527016535;5762.234127618766;5769.1923130761725;1406.9658800781417;1444.227338373986;1445.985540144585;1482.3255418784427;1519.3239008641049;962.5379817687409;967.777411195429;991.8214721350226;1000.4397537378945;1001.6944831826218;4953.777080031407;4997.925031124536;5000.6999580024585;5031.698098114125;5064.240363945438;5234.659747116501;5271.314729085195;5271.920921186185;5289.100852855024;5302.28419163408;4845.297431872359;5035.320231768737;5049.8737531562;5060.620453466005;5074.3657042869645;2781.415902660464;2785.234060633342;2796.3641269856953;2805.2145399288233;2831.8725657345467;5367.677939323653;5388.676679399248;5415.891682166334;5460.525658072298;5464.808731694372;5125.769340379692;5272.077386457355;5294.444083371268;5305.336832895888;5318.787248510016;5325.840224793263;5351.902859913631;5357.276767636319;5385.764907563395;5406.270153529302;5172.163881821899;5199.376074871039;5215.322008139069;5231.895362092813;5235.188545775259;4832.202686556679;5089.567386772166;5098.694078355311;5103.77033033507;5152.9694061187165;5335.973320133375;5365.409804921534;5369.624126311121;5374.973125134349;5426.755795989269;3887.853083340478;3889.649931506178;3930.390789427643;3950.881473555798;3963.246983073207;5051.545360917535;5184.066867963803;5205.219217117463;5221.37343518765;5608.2148499209325;5564.4991950724625;5659.434056594308;5704.543636508986;5709.543236540983;5716.828495145152;5621.409751975983;5668.489835914787;5715.8571035724435;5736.4263573643975;5740.282464691913;5485.259489968803;5631.7184140793615;5657.943420565742;5659.518940890071;5672.064109421899;5694.829155125353;5717.571182161438;5744.597878148489;5750.539956803362;5753.90675771602;5417.918731219113;5635.746391412315;5642.181883626769;5655.264815573949;5660.943390566206 15:06:38 INFO - PROCESS | 3022 | |5;yui.html;741.1476801678069;744.7840126363355;776.79026662801;783.3576467296817;906.1572737354257;16100.194990250498;16699.415520456787;16785.41251056213;16858.662826743457;16918.323267069318;14853.257337133155;14928.477503287388;14946.476873309437;14954.177520236382;14956.850431495708;709.4147328454046;821.4537332673765;865.8181781825824;866.5883705240024;873;860.9483430994161;864.235151890575;866.7183165471247;866.8569686001803;867.154524338771;910.135371397172;917.6925729880498;919.2645883293372;919.6689191890914;922.294444749767;725.4414101142117;874.6588830356167;908.0964440381796;910.7495438754329;913.7715571107224;678.8540463800307;679.0968012543306;679.5277282288811;679.5548915460381;679.8334408070006;13833.377498012613;13994.30028498571;14182.92908535461;14194.432222711182;14219.289035548181;14231.573052808433;14472.204028778413;14493.42026318946;14508.782368264485;14509.129452232899;13119.606411807661;13129;13206.207627542379;13330.933345333307;13494.662633434145;4528.56978587037;4706.388169537938;4733.621310295202;4809.519048095198;4819.228923372244;76667;78304.21695782969;79978.20021799766;81407.59296203482;81576.59211703904;10909.454527273605;11044.282121662067;11087.33475991443;11138.554457821758;11224.943875280735;20456.897715511626;21679.89160054221;21701.13195472195;21839.672404913937;21881;8456.281216096577;8479.872801907977;8544.060153383123;8560.315174786003;8800.16398442147;4913.361263035782;4940.1601727706375;4975.228839529878;4976.377952755905;4988.6507944444265;3833.6166383361997;3992.640662340403;3994.72036957416;4005.499312585927;4009.8596549121226;638.2532437048665;655.8530732727647;659.2945548263408;697.8778713725078;706.4772068669148;684.5105749389211;707.8831992721143;736.9557826530425;751.1249394455507;773.1920143450108;9638.42169469834;9812.65655702047;10038.799224015625;10118.797624047478;10121.645742398981;650.8828410885991;689.4484412470003;735.0260904301822;757.5114051436792;771.240328276647;4498.527654596221;4508.752018639007;4512.075024619945;4580.519045500241;4645.3032045193495;122962.38518807349;123935.38032309781;125670.37164814117;130283;130367;108070;110154;111052.44473777579;111092.4445377768;114879.42560287144;95767.52116239374;96394.51802740942;96788;97051;98696;9025.864612030693;9048.819023619359;9064.320175986695;9071.455712657262;9127;39965.40051899282;50381.24428133654;57868;58471;58505.4149458517;50858.23712644387;51547.48452515427;69061;69417.79301192092;80392.19607804081;13157.210567365988;13171;13180.143290686075;13422.597322080353;13482.93258533701;14536.709265814836;14789.408423662933;14829.777553336924;15220.847791521943;15228.086314821147;10012.899871001197;13530.729385412433;13682.45270189221;13766.105203161762;13940.860591393955;13507.594772156852;13590.116642418212;13826.308684565933;13914.86085139176;14251.358688859234;9370.67202647904;11603.6518904433;12759.48962041545;13003.414846332127;13381.53164639233;11322.207445478738;11545.48045337945;11845.111616628616;11858.525658973544;12159.756804863677;11727.648170554898;11957.880421195676;11960.700982475508;12029;12106.51573937068 15:06:38 INFO - PROCESS | 3022 | __end_tp_report 15:06:38 INFO - PROCESS | 3022 | __start_cc_report 15:06:38 INFO - PROCESS | 3022 | _x_x_mozilla_cycle_collect,840 15:06:38 INFO - PROCESS | 3022 | __end_cc_report 15:06:38 INFO - PROCESS | 3022 | __startTimestamp1467756398272__endTimestamp 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | ------- Summary: start ------- 15:06:38 INFO - PROCESS | 3022 | Number of tests: 6 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | [#0] dojo.html Cycles:165 Average:5467.44 Median:5703.89 stddev:601.55 (10.5%) stddev-sans-first:578.89 15:06:38 INFO - PROCESS | 3022 | Values: 3301.2 3340.5 3352.4 3372.7 3384.3 5456.1 5464.8 5489.5 5498.8 5531.3 5383.5 5415.5 5433.5 5461.8 5489.6 4886.7 4954.2 4971.0 5002.2 5041.4 4879.4 4997.8 5028.6 5029.8 5031.4 4928.9 4947.0 4948.6 4965.7 5037.1 5027.5 5029.3 5034.3 5052.7 5081.6 4857.0 4902.8 4957.1 4960.8 4990.9 5352.0 5356.1 5366.1 5391.6 5411.0 5897.4 5937.9 5938.3 5946.4 5946.4 5863.9 5887.1 5896.3 5967.6 6000.1 5580.9 5614.0 5616.0 5624.1 5626.9 5797.3 6093.7 6100.1 6102.8 6113.3 5682.6 5725.7 5739.2 5819.6 5820.1 5838.4 5856.4 5867.4 5895.6 5896.4 5627.2 5777.2 5795.2 5811.5 5811.9 5852.9 5915.6 5917.1 5921.4 5954.1 4562.8 4569.5 4573.6 4577.0 4599.4 3907.6 3991.6 4065.5 4082.2 4122.9 5699.6 5720.4 5722.7 5730.3 5736.2 5953.1 5958.9 5968.3 5972.1 6000.0 5522.9 5543.6 5560.0 5654.4 5706.9 5028.2 5031.2 5038.7 5044.0 5050.7 6086.2 6134.2 6135.6 6144.4 6146.4 5691.3 5747.5 5823.7 5837.9 5885.1 5926.6 6081.9 6124.2 6130.0 6130.5 5753.9 5755.1 5762.1 5764.4 5765.2 5723.5 5799.2 5841.6 5843.4 5870.6 5703.5 5710.9 5712.6 5712.6 5722.6 5559.8 5719.8 5728.9 5730.5 5741.4 5600.9 5646.6 5650.1 5684.6 5691.6 5802.5 5804.5 5818.6 5850.3 5852.6 5502.6 5566.0 5703.9 5707.5 5733.3 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | [#1] ext.html Cycles:180 Average:65401.53 Median:22039.70 stddev:134265.61 (609.2%) stddev-sans-first:134554.14 15:06:38 INFO - PROCESS | 3022 | Values: 611.6 628.1 653.4 665.4 666.1 32885.2 45095.0 45201.5 45608.5 45685.0 49072.0 49504.3 49682.8 49708.5 49774.8 8196.0 9005.1 9157.6 9158.0 10730.6 10483.7 10873.2 10882.5 10883.6 10883.7 10885.7 10941.0 10944.7 10956.1 10960.3 8255.8 8451.2 10708.7 10850.2 10947.6 10432.7 10842.6 10879.5 10881.5 10918.9 46208.5 46814.5 46819.3 46845.3 46847.3 3538.6 3636.4 4128.6 4208.8 4279.8 35726.3 36745.1 37054.4 37112.0 37330.6 3901.8 3955.9 3977.4 4012.2 4101.1 375362.0 377814.0 378702.0 378886.0 380158.0 40165.4 41065.6 41167.6 71625.9 72476.6 43260.6 43398.0 43468.0 43479.1 43528.1 16446.9 16641.3 16650.5 16657.8 16658.3 12074.3 12929.6 13015.0 13234.3 13268.6 9688.9 9703.5 9704.0 9769.5 9774.7 3680.4 3694.6 3702.7 3706.3 3742.9 1009.3 1034.4 1056.0 1155.8 1276.0 32231.8 33284.5 33578.7 33723.3 33883.0 1116.1 1126.4 1163.2 1189.3 1266.4 17749.3 18104.0 18152.5 18167.9 18225.3 635440.0 637762.0 641910.0 642713.0 643510.0 66445.3 66653.7 66975.7 67022.3 67266.0 1274.0 1376.3 1407.1 1438.9 1450.1 32908.0 34676.0 35098.3 35516.6 35623.6 56249.7 56564.7 56653.7 56671.0 56846.4 456000.0 456565.0 458550.0 459321.0 459734.0 27585.2 31012.8 31831.5 31894.0 32308.4 51777.0 51924.7 52363.2 52641.5 53270.5 43153.6 44386.3 44473.3 44546.1 45468.3 43135.4 43824.3 43936.0 44967.6 45441.3 44591.6 45713.0 45964.0 46553.0 48698.3 38826.8 40102.0 40349.8 40712.8 41175.0 29828.3 30204.8 30373.5 30375.2 30653.0 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | [#2] jquery.html Cycles:180 Average:31326.62 Median:11646.04 stddev:90196.02 (774.5%) stddev-sans-first:90419.20 15:06:38 INFO - PROCESS | 3022 | Values: 423.9 428.6 432.2 434.7 447.2 18979.4 19831.3 20410.4 21195.4 21221.2 19680.3 20070.5 20191.1 20519.6 20569.2 5762.8 6023.7 6042.1 6050.2 6053.5 5786.2 5834.5 5868.9 5925.8 5926.3 5873.1 5875.7 5879.1 5886.6 5891.4 5741.9 5819.1 5906.5 5923.7 5933.7 5220.2 5301.4 5314.6 5318.8 5320.8 24070.6 24274.4 24315.3 24423.9 24431.3 2281.3 2383.5 2613.9 2752.8 2822.7 10057.4 10232.1 10924.7 11009.7 14377.6 1881.5 2000.1 2064.4 2066.3 2074.6 85771.0 86291.0 86892.6 87642.6 89078.0 11351.3 11370.7 11393.5 11407.2 11424.4 15740.6 15778.6 15878.4 15878.9 15897.6 8003.0 8252.1 8383.1 8691.7 8928.6 7889.9 7896.7 7971.9 8052.5 8080.6 4933.3 5001.2 5009.9 5182.1 5204.6 2022.6 2025.6 2053.1 2055.5 2096.7 1017.6 1019.5 1031.3 1083.9 1112.6 19643.0 19846.6 20009.7 20182.3 20340.9 1057.4 1066.5 1084.8 1111.6 1143.7 10907.3 11135.8 11272.5 11277.3 11278.2 543308.0 546390.0 547663.0 548484.0 550259.0 99733.0 100214.5 101593.5 101920.0 102075.5 1041.1 1063.9 1065.1 1080.9 1081.1 17617.6 17994.9 18150.5 18160.5 18358.2 41045.8 42149.6 42166.4 42235.4 43952.6 56339.2 56506.4 57284.1 62599.4 63191.7 8872.7 8898.7 9062.2 9109.0 9113.8 9375.8 13227.1 13240.3 13565.4 14110.6 11417.1 11784.4 12076.1 12185.0 12357.0 11603.1 11614.9 11797.2 11808.5 11836.3 11640.0 11711.9 11718.4 11794.2 11821.9 8705.3 8783.3 8898.4 9013.3 9149.5 10933.2 10994.8 11606.8 11757.6 11955.6 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | [#3] mootools.html Cycles:180 Average:6148.38 Median:4287.00 stddev:3543.27 (82.7%) stddev-sans-first:3535.61 15:06:38 INFO - PROCESS | 3022 | Values: 1449.8 1576.4 1603.9 1831.6 1938.7 8699.8 9112.6 9124.8 9349.9 9376.9 9092.9 9273.7 9295.1 9298.6 9302.3 2122.8 2326.6 2396.3 2445.1 2473.0 2391.3 2397.7 2399.2 2401.9 2404.6 2377.6 2416.7 2423.1 2428.8 2430.4 2122.4 2371.5 2450.7 2454.2 2465.3 2360.8 2368.5 2370.1 2372.1 2394.3 9247.4 9327.2 9374.4 9382.0 9389.2 5290.8 5442.8 5451.7 5457.3 5458.4 3306.9 3396.4 3447.1 3506.4 3509.9 1058.8 1066.8 1080.8 1087.1 1104.3 12971.0 12977.5 12993.3 13016.9 13047.3 4680.0 4778.3 4825.4 4829.0 4832.5 10858.3 10903.6 10906.7 10925.8 10993.3 4845.5 5434.9 5502.6 5508.1 5508.1 4974.2 5095.4 5108.1 5167.0 5168.8 4138.3 4180.3 4182.3 4200.1 4225.9 1297.9 1304.4 1306.8 1312.7 1327.3 1023.1 1031.7 1032.9 1038.1 1059.8 6397.2 6418.5 6437.3 6442.1 6517.8 1018.5 1021.5 1030.8 1039.4 1050.4 4044.5 4348.2 4394.8 4399.3 4406.1 11218.4 11466.1 11759.0 11878.0 11889.6 11533.9 11680.1 11708.4 11736.5 11750.1 8659.0 8970.7 8974.1 9020.0 9057.2 6151.5 6245.4 6275.5 6308.3 6378.8 10691.3 10938.1 10964.0 11013.1 11146.3 10918.8 11118.1 11170.4 11236.9 11263.8 6954.5 7485.8 7619.4 7630.5 7765.7 9198.7 9241.2 9288.8 9295.6 9301.3 8156.5 8317.4 8367.7 8424.2 8453.7 7974.8 8052.0 8074.7 8101.3 8119.8 7352.5 7640.0 7659.1 7713.5 7816.4 5583.2 5591.3 5630.1 5646.3 5782.7 5390.8 5465.9 5479.5 5624.5 5630.2 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | [#4] prototype.html Cycles:180 Average:4644.86 Median:5160.63 stddev:1315.74 (25.5%) stddev-sans-first:1279.33 15:06:38 INFO - PROCESS | 3022 | Values: 349.5 351.3 356.2 363.6 364.1 5242.0 5414.7 5492.8 5542.5 5570.9 5402.0 5434.9 5435.7 5443.8 5444.8 4308.3 4326.9 4328.7 4330.1 4331.1 4073.5 4190.9 4313.9 4340.6 4355.8 4237.6 4296.6 4300.9 4315.3 4342.2 4249.1 4270.0 4277.6 4297.0 4300.6 3675.7 3772.6 3821.3 3832.6 3842.8 5154.0 5157.5 5163.7 5167.7 5246.9 4879.7 4885.5 4958.2 4970.5 4982.2 5583.5 5585.7 5642.6 5652.5 5721.9 4214.2 4215.9 4235.1 4237.7 4240.8 5948.9 5956.7 5982.3 5984.0 5991.4 4242.4 4317.5 4337.7 4349.4 4356.9 4323.8 4370.4 4383.3 4383.6 4386.1 4897.9 4907.4 4931.0 4949.2 4961.1 5673.5 5683.4 5727.8 5762.2 5769.2 1407.0 1444.2 1446.0 1482.3 1519.3 962.5 967.8 991.8 1000.4 1001.7 4953.8 4997.9 5000.7 5031.7 5064.2 5234.7 5271.3 5271.9 5289.1 5302.3 4845.3 5035.3 5049.9 5060.6 5074.4 2781.4 2785.2 2796.4 2805.2 2831.9 5367.7 5388.7 5415.9 5460.5 5464.8 5125.8 5272.1 5294.4 5305.3 5318.8 5325.8 5351.9 5357.3 5385.8 5406.3 5172.2 5199.4 5215.3 5231.9 5235.2 4832.2 5089.6 5098.7 5103.8 5153.0 5336.0 5365.4 5369.6 5375.0 5426.8 3887.9 3889.6 3930.4 3950.9 3963.2 5051.5 5184.1 5205.2 5221.4 5608.2 5564.5 5659.4 5704.5 5709.5 5716.8 5621.4 5668.5 5715.9 5736.4 5740.3 5485.3 5631.7 5657.9 5659.5 5672.1 5694.8 5717.6 5744.6 5750.5 5753.9 5417.9 5635.7 5642.2 5655.3 5660.9 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - PROCESS | 3022 | [#5] yui.html Cycles:180 Average:21696.40 Median:4520.32 stddev:32365.16 (716.0%) stddev-sans-first:32417.70 15:06:38 INFO - PROCESS | 3022 | Values: 741.1 744.8 776.8 783.4 906.2 16100.2 16699.4 16785.4 16858.7 16918.3 14853.3 14928.5 14946.5 14954.2 14956.9 709.4 821.5 865.8 866.6 873.0 860.9 864.2 866.7 866.9 867.2 910.1 917.7 919.3 919.7 922.3 725.4 874.7 908.1 910.7 913.8 678.9 679.1 679.5 679.6 679.8 13833.4 13994.3 14182.9 14194.4 14219.3 14231.6 14472.2 14493.4 14508.8 14509.1 13119.6 13129.0 13206.2 13330.9 13494.7 4528.6 4706.4 4733.6 4809.5 4819.2 76667.0 78304.2 79978.2 81407.6 81576.6 10909.5 11044.3 11087.3 11138.6 11224.9 20456.9 21679.9 21701.1 21839.7 21881.0 8456.3 8479.9 8544.1 8560.3 8800.2 4913.4 4940.2 4975.2 4976.4 4988.7 3833.6 3992.6 3994.7 4005.5 4009.9 638.3 655.9 659.3 697.9 706.5 684.5 707.9 737.0 751.1 773.2 9638.4 9812.7 10038.8 10118.8 10121.6 650.9 689.4 735.0 757.5 771.2 4498.5 4508.8 4512.1 4580.5 4645.3 122962.4 123935.4 125670.4 130283.0 130367.0 108070.0 110154.0 111052.4 111092.4 114879.4 95767.5 96394.5 96788.0 97051.0 98696.0 9025.9 9048.8 9064.3 9071.5 9127.0 39965.4 50381.2 57868.0 58471.0 58505.4 50858.2 51547.5 69061.0 69417.8 80392.2 13157.2 13171.0 13180.1 13422.6 13482.9 14536.7 14789.4 14829.8 15220.8 15228.1 10012.9 13530.7 13682.5 13766.1 13940.9 13507.6 13590.1 13826.3 13914.9 14251.4 9370.7 11603.7 12759.5 13003.4 13381.5 11322.2 11545.5 11845.1 11858.5 12159.8 11727.6 11957.9 11960.7 12029.0 12106.5 15:06:38 INFO - PROCESS | 3022 | -------- Summary: end -------- 15:06:38 INFO - PROCESS | 3022 | 15:06:38 INFO - TEST-INFO | 3022: exit 0 15:06:38 INFO - TEST-OK | dromaeo_css | took 1113239ms 15:06:38 INFO - TEST-START | kraken 15:06:38 INFO - operating with platform_type : linux_ 15:06:38 INFO - Initialising browser for kraken test... 15:06:38 INFO - TEST-INFO | started process 3213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4YMn3z/profile http://localhost:41279/getInfo.html) 15:06:42 INFO - PROCESS | 3213 | __metrics Screen width/height:1600/1200 15:06:42 INFO - PROCESS | 3213 | colorDepth:24 15:06:42 INFO - PROCESS | 3213 | Browser inner width/height: 1024/697 15:06:42 INFO - PROCESS | 3213 | __metrics 15:06:44 ERROR - PROCESS | 3213 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:06:44 INFO - TEST-INFO | 3213: exit 0 15:06:44 INFO - Browser initialized. 15:06:44 INFO - Running cycle 1/1 for kraken test... 15:06:44 INFO - TEST-INFO | started process 3307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4YMn3z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:56 INFO - PROCESS | 3307 | RSS: Main: 145797120 15:06:56 INFO - PROCESS | 3307 | 15:06:59 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41279/tests/kraken/driver.html?testName=audio-beat-detection) 15:06:59 INFO - PROCESS | 3307 | RSS: Main: 194318336 15:06:59 INFO - PROCESS | 3307 | 15:07:02 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41279/tests/kraken/driver.html?testName=audio-dft) 15:07:03 INFO - PROCESS | 3307 | RSS: Main: 188702720 15:07:03 INFO - PROCESS | 3307 | 15:07:06 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41279/tests/kraken/driver.html?testName=audio-fft) 15:07:06 INFO - PROCESS | 3307 | RSS: Main: 278728704 15:07:06 INFO - PROCESS | 3307 | 15:07:08 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41279/tests/kraken/driver.html?testName=audio-oscillator) 15:07:09 INFO - PROCESS | 3307 | RSS: Main: 187285504 15:07:09 INFO - PROCESS | 3307 | 15:07:11 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:12 INFO - PROCESS | 3307 | RSS: Main: 187809792 15:07:12 INFO - PROCESS | 3307 | 15:07:15 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41279/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:15 INFO - PROCESS | 3307 | RSS: Main: 223117312 15:07:15 INFO - PROCESS | 3307 | 15:07:18 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41279/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:19 INFO - PROCESS | 3307 | RSS: Main: 222126080 15:07:19 INFO - PROCESS | 3307 | 15:07:22 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41279/tests/kraken/driver.html?testName=json-parse-financial) 15:07:22 INFO - PROCESS | 3307 | RSS: Main: 221601792 15:07:22 INFO - PROCESS | 3307 | 15:07:24 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:07:25 INFO - PROCESS | 3307 | RSS: Main: 199974912 15:07:25 INFO - PROCESS | 3307 | 15:07:26 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:07:27 INFO - PROCESS | 3307 | RSS: Main: 201760768 15:07:27 INFO - PROCESS | 3307 | 15:07:29 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:07:30 INFO - PROCESS | 3307 | RSS: Main: 211206144 15:07:30 INFO - PROCESS | 3307 | 15:07:32 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:07:33 INFO - PROCESS | 3307 | RSS: Main: 216207360 15:07:33 INFO - PROCESS | 3307 | 15:07:35 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:07:36 INFO - PROCESS | 3307 | RSS: Main: 213925888 15:07:36 INFO - PROCESS | 3307 | 15:07:37 INFO - PROCESS | 3307 | Cycle 1(1): loaded http://localhost:41279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41279/tests/kraken/driver.html?testName=ai-astar) 15:07:38 INFO - PROCESS | 3307 | RSS: Main: 256512000 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | __start_tp_report 15:07:38 INFO - PROCESS | 3307 | _x_x_mozilla_page_load 15:07:38 INFO - PROCESS | 3307 | _x_x_mozilla_page_load_details 15:07:38 INFO - PROCESS | 3307 | |i|pagename|runs| 15:07:38 INFO - PROCESS | 3307 | |0;ai-astar;112;107;111;111;113;113;110;112;109;110 15:07:38 INFO - PROCESS | 3307 | |1;audio-beat-detection;157;123;126;193;125;125;155;130;161;130 15:07:38 INFO - PROCESS | 3307 | |2;audio-dft;161;162;161;160;161;163;162;163;161;160 15:07:38 INFO - PROCESS | 3307 | |3;audio-fft;74;75;76;124;75;87;76;76;102;75 15:07:38 INFO - PROCESS | 3307 | |4;audio-oscillator;86;84;115;84;85;85;117;83;84;129 15:07:38 INFO - PROCESS | 3307 | |5;imaging-gaussian-blur;117;117;117;116;117;116;118;117;117;117 15:07:38 INFO - PROCESS | 3307 | |6;imaging-darkroom;146;146;145;147;148;146;146;146;145;147 15:07:38 INFO - PROCESS | 3307 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 15:07:38 INFO - PROCESS | 3307 | |8;json-parse-financial;50;49;50;52;52;52;51;52;53;51 15:07:38 INFO - PROCESS | 3307 | |9;json-stringify-tinderbox;60;61;60;60;60;60;60;61;61;62 15:07:38 INFO - PROCESS | 3307 | |10;stanford-crypto-aes;76;82;76;75;77;77;76;83;107;82 15:07:38 INFO - PROCESS | 3307 | |11;stanford-crypto-ccm;118;123;124;129;121;117;114;120;130;118 15:07:38 INFO - PROCESS | 3307 | |12;stanford-crypto-pbkdf2;156;153;160;156;154;153;154;160;152;149 15:07:38 INFO - PROCESS | 3307 | |13;stanford-crypto-sha256-iterative;61;61;60;61;61;60;61;59;59;60 15:07:38 INFO - PROCESS | 3307 | __end_tp_report 15:07:38 INFO - PROCESS | 3307 | __start_cc_report 15:07:38 INFO - PROCESS | 3307 | _x_x_mozilla_cycle_collect,1602 15:07:38 INFO - PROCESS | 3307 | __end_cc_report 15:07:38 INFO - PROCESS | 3307 | __startTimestamp1467756458220__endTimestamp 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | ------- Summary: start ------- 15:07:38 INFO - PROCESS | 3307 | Number of tests: 14 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:1.87 (1.7%) stddev-sans-first:1.94 15:07:38 INFO - PROCESS | 3307 | Values: 112.0 107.0 111.0 111.0 113.0 113.0 110.0 112.0 109.0 110.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:142.50 stddev:23.18 (16.3%) stddev-sans-first:23.99 15:07:38 INFO - PROCESS | 3307 | Values: 157.0 123.0 126.0 193.0 125.0 125.0 155.0 130.0 161.0 130.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 15:07:38 INFO - PROCESS | 3307 | Values: 161.0 162.0 161.0 160.0 161.0 163.0 162.0 163.0 161.0 160.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:16.56 (21.9%) stddev-sans-first:17.16 15:07:38 INFO - PROCESS | 3307 | Values: 74.0 75.0 76.0 124.0 75.0 87.0 76.0 76.0 102.0 75.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.00 stddev:17.73 (21.1%) stddev-sans-first:18.48 15:07:38 INFO - PROCESS | 3307 | Values: 86.0 84.0 115.0 84.0 85.0 85.0 117.0 83.0 84.0 129.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:07:38 INFO - PROCESS | 3307 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 118.0 117.0 117.0 117.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 15:07:38 INFO - PROCESS | 3307 | Values: 146.0 146.0 145.0 147.0 148.0 146.0 146.0 146.0 145.0 147.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 15:07:38 INFO - PROCESS | 3307 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:52.00 stddev:1.23 (2.4%) stddev-sans-first:1.22 15:07:38 INFO - PROCESS | 3307 | Values: 50.0 49.0 50.0 52.0 52.0 52.0 51.0 52.0 53.0 51.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 15:07:38 INFO - PROCESS | 3307 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 60.0 61.0 61.0 62.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:77.00 stddev:9.57 (12.4%) stddev-sans-first:9.97 15:07:38 INFO - PROCESS | 3307 | Values: 76.0 82.0 76.0 75.0 77.0 77.0 76.0 83.0 107.0 82.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.00 stddev:5.17 (4.2%) stddev-sans-first:5.33 15:07:38 INFO - PROCESS | 3307 | Values: 118.0 123.0 124.0 129.0 121.0 117.0 114.0 120.0 130.0 118.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.00 stddev:3.43 (2.2%) stddev-sans-first:3.61 15:07:38 INFO - PROCESS | 3307 | Values: 156.0 153.0 160.0 156.0 154.0 153.0 154.0 160.0 152.0 149.0 15:07:38 INFO - PROCESS | 3307 | 15:07:38 INFO - PROCESS | 3307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 15:07:38 INFO - PROCESS | 3307 | Values: 61.0 61.0 60.0 61.0 61.0 60.0 61.0 59.0 59.0 60.0 15:07:38 INFO - PROCESS | 3307 | -------- Summary: end -------- 15:07:38 INFO - PROCESS | 3307 | 15:07:39 INFO - TEST-INFO | 3307: exit 0 15:07:39 INFO - TEST-OK | kraken | took 60273ms 15:07:39 INFO - SUITE-END | took 1173s 15:07:39 INFO - Completed test suite (00:19:33) 15:07:39 INFO - javascript benchmark 15:07:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.1582046578123, 3340.5323254744326, 3352.4133276676585, 3372.7301815854735, 3384.289299247158, 5456.099743542316, 5464.781408743645, 5489.533389661879, 5498.835034948958, 5531.308586426701, 5383.488568585988, 5415.539679127279, 5433.4566543345645, 5461.836144915659, 5489.58828087893, 4886.682365646239, 4954.182559877625, 4971.0, 5002.224655178435, 5041.406580288986, 4879.365682461275, 4997.750112494379, 5028.622853286, 5029.849104526852, 5031.421386540558, 4928.926066109011, 4947.03532811102, 4948.57937075349, 4965.65240433168, 5037.093323201822, 5027.522385373383, 5029.270755740416, 5034.270030845543, 5052.671576347562, 5081.618878584102, 4857.0, 4902.828401005948, 4957.107720610289, 4960.801567937278, 4990.850274491771, 5351.973240133774, 5356.11624082026, 5366.114591092465, 5391.595630327741, 5411.0, 5897.380775018647, 5937.910931336033, 5938.257717785277, 5946.405359464019, 5946.405359464062, 5863.912041319383, 5887.087501437284, 5896.262967129109, 5967.5524335675, 6000.129981152752, 5580.91628625571, 5613.971930140364, 5616.045272303718, 5624.100143976944, 5626.915596265977, 5797.275340582427, 6093.69531523422, 6100.115483254903, 6102.755889764359, 6113.33293539461, 5682.573806964494, 5725.713714314267, 5739.167820666064, 5819.592628515963, 5820.097884827774, 5838.357780644125, 5856.4143585641095, 5867.383924687846, 5895.55783316253, 5896.380880007623, 5627.155926611041, 5777.19119323295, 5795.217645617788, 5811.535077193815, 5811.94188058114, 5852.853678658068, 5915.556333275022, 5917.112433134978, 5921.437463440966, 5954.07711804671, 4562.817487300471, 4569.474510431276, 4573.611243044378, 4577.0, 4599.448066232007, 3907.5701672815967, 3991.560928297885, 4065.4714887064492, 4082.1631565528996, 4122.896927576775, 5699.601027928005, 5720.370759216483, 5722.685252311163, 5730.255066841367, 5736.168255602997, 5953.077273022688, 5958.85102872423, 5968.253968253968, 5972.104184372379, 6000.0, 5522.889542209214, 5543.584231182677, 5560.026995275892, 5654.434556544313, 5706.914396284059, 5028.17035189197, 5031.195008798574, 5038.748062596856, 5043.9912017596625, 5050.747462626854, 6086.2087928569, 6134.202553668084, 6135.631862088289, 6144.354842741537, 6146.446819786241, 5691.345495268097, 5747.540196784331, 5823.7379317929945, 5837.854053648693, 5885.058390657474, 5926.585139040226, 6081.878362432638, 6124.173236613, 6130.01919692847, 6130.47890929276, 5753.856153596026, 5755.079187330007, 5762.135679647919, 5764.365919748908, 5765.192872997867, 5723.456271654186, 5799.159121927212, 5841.561882858888, 5843.415658434123, 5870.55970802183, 5703.515201207778, 5710.914336285042, 5712.571557133148, 5712.600117991867, 5722.62802917809, 5559.805406810742, 5719.771209151588, 5728.856778580569, 5730.484256416942, 5741.368449470471, 5600.85997850057, 5646.604737668488, 5650.095984642602, 5684.573656975661, 5691.63004404729, 5802.506786923159, 5804.477597016289, 5818.6217895836635, 5850.327212370632, 5852.648841069549, 5502.5597952164535, 5566.0, 5703.885922281448, 5707.4577915098, 5733.31200255972], "value": 5429.054756272787, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5505103748744, 628.0735914526073, 653.4086651580316, 665.3546060321489, 666.1306994372344, 32885.17787055322, 45094.999999999956, 45201.54798452015, 45608.54391456085, 45685.0, 49072.0, 49504.25743613848, 49682.75158624202, 49708.50291497084, 49774.75112624441, 8196.0, 9005.054469280745, 9157.587908544132, 9158.0, 10730.624428145016, 10483.737906552358, 10873.184511161655, 10882.510287037063, 10883.564657413694, 10883.67348979532, 10885.727856803564, 10941.0, 10944.726381840437, 10956.12351011921, 10960.342379457219, 8255.79360515989, 8451.197136272045, 10708.732281692943, 10850.18623603229, 10947.616833410792, 10432.68701938943, 10842.62050828225, 10879.456027198688, 10881.510332035077, 10918.890811091867, 46208.5379146211, 46814.53185468136, 46819.29771053437, 46845.297320540216, 46847.29729054033, 3538.628444013393, 3636.3636363636524, 4128.587141285848, 4208.789560521962, 4279.807408666617, 35726.28547429063, 36745.08137296562, 37054.44418333727, 37112.0, 37330.626693733255, 3901.843926242947, 3955.920881582352, 3977.4033894915706, 4012.217617564576, 4101.118259574176, 375362.0, 377814.0, 378702.0, 378886.0, 380158.0, 40165.39751903724, 41065.589344106775, 41167.58832411697, 71625.92561111588, 72476.63761681263, 43260.56739432628, 43398.0, 43468.0, 43479.130417391476, 43528.12943741107, 16446.917765411337, 16641.33434662624, 16650.50048498547, 16657.83342166587, 16658.33366665344, 12074.335911524951, 12929.612111636667, 13015.0, 13234.338283085806, 13268.601941941757, 9688.90311096894, 9703.466309352913, 9704.0, 9769.462679552693, 9774.706758797105, 3680.411134218512, 3694.612065733113, 3702.740808143458, 3706.3328600852105, 3742.8689995850013, 1009.3035805294323, 1034.4092313337653, 1055.9788804223872, 1155.8381826544291, 1276.026857422204, 32231.838840805645, 33284.500732488545, 33578.66421335804, 33723.32553348968, 33883.0, 1116.1405717597404, 1126.3973774030853, 1163.203205804027, 1189.3339729751367, 1266.4111188297486, 17749.29002839872, 18104.0, 18152.546186345182, 18167.909160454114, 18225.270989160552, 635440.0, 637762.0, 641910.0, 642713.0, 643510.0, 66445.33554664488, 66653.66673166603, 66975.66512167506, 67022.3297767016, 67266.0, 1273.974520509603, 1376.2636989210723, 1407.0713329202881, 1438.8561143885738, 1450.1081834671602, 32908.0, 34676.0, 35098.29803403969, 35516.644833551334, 35623.64376356203, 56249.718751405984, 56564.7171764155, 56653.716731416076, 56671.0, 56846.43153568577, 456000.0, 456565.0, 458550.0, 459321.0, 459734.0, 27585.172444826687, 31012.844935775178, 31831.522527161647, 31894.0, 32308.35383292274, 51777.0, 51924.74037629788, 52363.21455178099, 52641.47358526366, 53270.467295328104, 43153.56846431496, 44386.334204986306, 44473.33290000588, 44546.10907781891, 45468.31797522974, 43135.35296970611, 43824.34263486114, 43936.0, 44967.55032449633, 45441.31838022366, 44591.55408445874, 45713.0, 45964.0, 46553.0, 48698.26952595785, 38826.80586597049, 40102.0, 40349.79825100856, 40712.79643601881, 41175.0, 29828.254293642833, 30204.84897575498, 30373.544396834506, 30375.240618984702, 30653.0], "value": 20659.230387446307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.91733611945665, 428.55858465780256, 432.1745466159635, 434.6891972239846, 447.15264573632965, 18979.430617081493, 19831.305904293353, 20410.387688369356, 21195.364139075813, 21221.151153953862, 19680.2927151126, 20070.49823754407, 20191.09140088696, 20519.589608207825, 20569.177232910664, 5762.769489220436, 6023.6988150592515, 6042.093685947099, 6050.213472248602, 6053.485453736438, 5786.189933409326, 5834.5040671542965, 5868.853278668046, 5925.822225333247, 5926.288845338566, 5873.0603103503445, 5875.706214689249, 5879.118132280149, 5886.558508111887, 5891.440313170242, 5741.913871291934, 5819.0689489681445, 5906.527477801766, 5923.733431995549, 5933.732982015819, 5220.216967454874, 5301.416844147179, 5314.574834013309, 5318.840434786924, 5320.813771518017, 24070.63894041591, 24274.39314017146, 24315.270541883772, 24423.877880610482, 24431.26706198817, 2281.3156053184143, 2383.451806084593, 2613.8562379069144, 2752.7935404844716, 2822.6895041545617, 10057.446840423774, 10232.13026892715, 10924.672259832218, 11009.724756881142, 14377.640558986004, 1881.5296175956012, 2000.0699674651357, 2064.4013236161495, 2066.2664754012408, 2074.6369385357502, 85771.0, 86291.0, 86892.56553717254, 87642.5617871913, 89078.0, 11351.318920864775, 11370.715732106764, 11393.544258229578, 11407.201495895208, 11424.42877856104, 15740.60648483797, 15778.60553486149, 15878.44425445127, 15878.9206053969, 15897.602559936095, 8003.0, 8252.10757936529, 8383.11977242393, 8691.652333906573, 8928.553572321487, 7889.9211007890335, 7896.723614673574, 7971.920280797234, 8052.476589021695, 8080.595970201584, 4933.28467372229, 5001.224810154432, 5009.949900501021, 5182.144946083929, 5204.583633309402, 2022.5651484930515, 2025.5746293278282, 2053.117159621377, 2055.486128467883, 2096.716943212677, 1017.5980487707315, 1019.5463018956493, 1031.339942436841, 1083.8970297821695, 1112.571659910924, 19643.0, 19846.603067938562, 20009.699854502192, 20182.293619723237, 20340.89829550843, 1057.4448414582253, 1066.4720963123305, 1084.7993121272589, 1111.5831563163813, 1143.742657901982, 10907.345559266469, 11135.815551913201, 11272.492737826817, 11277.266977646426, 11278.210525263317, 543308.0, 546390.0, 547663.0, 548484.0, 550259.0, 99733.0, 100214.49892750636, 101593.49203253936, 101920.0, 102075.4896225529, 1041.0890470838017, 1063.8723353197665, 1065.1425602389995, 1080.8756992945755, 1081.1296905990596, 17617.647647047244, 17994.910025450314, 18150.546236343667, 18160.545986350447, 18358.1738821756, 41045.79477102715, 42149.578504214565, 42166.36750448684, 42235.3664695036, 43952.56047439485, 56339.154912677164, 56506.43493565012, 57284.140737888134, 62599.37400625936, 63191.6840415795, 8872.689455869013, 8898.734428705053, 9062.22971047442, 9109.0, 9113.77215569616, 9375.765605859635, 13227.140235884637, 13240.337983100613, 13565.389557470135, 14110.647233818827, 11417.1437142213, 11784.351860647746, 12076.09429292789, 12185.0, 12357.0, 11603.071754259809, 11614.941925290657, 11797.233179843282, 11808.527658893549, 11836.289822610672, 11640.01059909917, 11711.88288117108, 11718.414079295831, 11794.174407791372, 11821.881781182423, 8705.34709896773, 8783.29733621296, 8898.377113601986, 9013.324000700104, 9149.451032938045, 10933.180011499011, 10994.780104398027, 11606.767864642828, 11757.588484403004, 11955.64133076009], "value": 9609.211490536027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.7607894697376, 1576.408846682494, 1603.9358425662974, 1831.5878927241365, 1938.7479627648404, 8699.826003479926, 9112.635494580218, 9124.771880702985, 9349.906500934989, 9376.8593471098, 9092.8636070459, 9273.675421360254, 9295.116963888437, 9298.628054877796, 9302.302327325444, 2122.840786940978, 2326.5928462519078, 2396.2811156652933, 2445.119756887519, 2472.950540989179, 2391.3304274802995, 2397.724261709908, 2399.2202534176463, 2401.8799060047013, 2404.555157295897, 2377.583922813509, 2416.709994800626, 2423.1397853761923, 2428.781409673129, 2430.3802530354733, 2122.4481634774993, 2371.490129622131, 2450.6936632920883, 2454.1778504201116, 2465.272744540347, 2360.8465449745713, 2368.46709490365, 2370.134900761227, 2372.0867466025534, 2394.2697477269426, 9247.398919070307, 9327.20718738908, 9374.390664606779, 9381.953090234505, 9389.15497605212, 5290.788368465257, 5442.809501667422, 5451.672899626035, 5457.317835270591, 5458.399576046631, 3306.8842590509457, 3396.4056290149374, 3447.0524153852994, 3506.36885360635, 3509.94735078974, 1058.751193469534, 1066.8186408310605, 1080.778440419712, 1087.1031399095777, 1104.265663333882, 12971.02717296197, 12977.545785897448, 12993.285369304684, 13016.934915325362, 13047.282399467931, 4680.0, 4778.259369797687, 4825.372701548847, 4829.0, 4832.492588278251, 10858.294210876267, 10903.618373356894, 10906.727331816768, 10925.781484370267, 10993.340399576051, 4845.466998630148, 5434.864128396822, 5502.5597952163735, 5508.091164957737, 5508.118701007819, 4974.228994505857, 5095.363079615048, 5108.131617625013, 5166.974165129151, 5168.81909133186, 4138.337865941435, 4180.268453020709, 4182.2890108681595, 4200.05498762782, 4225.852095176654, 1297.9091463597647, 1304.3608631770553, 1306.7582497237852, 1312.6783937935268, 1327.3296985022696, 1023.0741179232806, 1031.7059638003134, 1032.9225308101923, 1038.133158812385, 1059.8304271316551, 6397.200349956255, 6418.486521078303, 6437.25971513282, 6442.130312407859, 6517.804465866032, 1018.4551265073151, 1021.4841505039907, 1030.8247597908373, 1039.3867618105203, 1050.401271275381, 4044.4539987101953, 4348.152110338454, 4394.824207031683, 4399.252127138394, 4406.140802543473, 11218.439078046065, 11466.140039497071, 11759.0, 11878.0, 11889.583864564698, 11533.88466115328, 11680.0655947524, 11708.414579271173, 11736.471858766376, 11750.118741094451, 8659.0, 8970.730878073668, 8974.057723939022, 9020.0, 9057.18485336323, 6151.507879369729, 6245.437910588069, 6275.529335299962, 6308.337624549356, 6378.808635740936, 10691.30506517074, 10938.124950003821, 10964.0, 11013.118950484102, 11146.275492092987, 10918.836217456586, 11118.110551155727, 11170.385628790495, 11236.887631123584, 11263.7747245053, 6954.513184077066, 7485.812854678677, 7619.352355049883, 7630.504017238862, 7765.650545725343, 9198.724038278862, 9241.214496767581, 9288.814223715623, 9295.628174872929, 9301.302402319989, 8156.510609363457, 8317.376196785386, 8367.707130250412, 8424.199701028392, 8453.704120355758, 7974.84050319002, 8051.959740201261, 8074.677012919417, 8101.270885620087, 8119.797005074684, 7352.485326027127, 7639.961800190964, 7659.080910290801, 7713.460057796125, 7816.374690024671, 5583.218349431164, 5591.30108736408, 5630.127330263816, 5646.265985421869, 5782.681952492485, 5390.757415916371, 5465.945340546544, 5479.4520547944885, 5624.521915637053, 5630.239917611234], "value": 4887.949933300136, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.4914898822214, 351.33246831021063, 356.2038843185481, 363.5510144970962, 364.11338391017875, 5242.0, 5414.675119492833, 5492.780288788449, 5542.473465020817, 5570.916436253459, 5401.9736250112455, 5434.8913021739545, 5435.728213589315, 5443.755031023604, 5444.774925641728, 4308.289132293168, 4326.891827704317, 4328.653707703376, 4330.112326972979, 4331.076523346744, 4073.4704488416464, 4190.916181676364, 4313.935290970638, 4340.587644173815, 4355.803988820495, 4237.639800616951, 4296.613304802567, 4300.8709738707885, 4315.287977483711, 4342.174986752507, 4249.128928569636, 4270.0, 4277.615014648681, 4296.978515107436, 4300.591443812848, 3675.724320675933, 3772.5661548921953, 3821.293060783764, 3832.6358995895343, 3842.7886466244345, 5154.015703953967, 5157.53582177602, 5163.7159956202395, 5167.6641018333685, 5246.898151388213, 4879.707217566922, 4885.487023862479, 4958.181899986498, 4970.478099799505, 4982.227754698028, 5583.497485226349, 5585.664860108406, 5642.633228840154, 5652.5195358394585, 5721.914171287434, 4214.2414365414215, 4215.852445164435, 4235.131797981407, 4237.660987121023, 4240.766757828318, 5948.940510594925, 5956.702164891738, 5982.312034116088, 5983.970080149615, 5991.400859914017, 4242.363645453207, 4317.525072242051, 4337.698690392869, 4349.369341445536, 4356.8910777230185, 4323.805428755713, 4370.388145659546, 4383.298672212431, 4383.60547550722, 4386.122775444924, 4897.926531102036, 4907.411110666742, 4930.98914722481, 4949.158643030693, 4961.131801934647, 5673.532013574026, 5683.374828768832, 5727.799527016535, 5762.234127618766, 5769.1923130761725, 1406.9658800781417, 1444.227338373986, 1445.985540144585, 1482.3255418784427, 1519.3239008641049, 962.5379817687409, 967.777411195429, 991.8214721350226, 1000.4397537378945, 1001.6944831826218, 4953.777080031407, 4997.925031124536, 5000.6999580024585, 5031.698098114125, 5064.240363945438, 5234.659747116501, 5271.314729085195, 5271.920921186185, 5289.100852855024, 5302.28419163408, 4845.297431872359, 5035.320231768737, 5049.8737531562, 5060.620453466005, 5074.3657042869645, 2781.415902660464, 2785.234060633342, 2796.3641269856953, 2805.2145399288233, 2831.8725657345467, 5367.677939323653, 5388.676679399248, 5415.891682166334, 5460.525658072298, 5464.808731694372, 5125.769340379692, 5272.077386457355, 5294.444083371268, 5305.336832895888, 5318.787248510016, 5325.840224793263, 5351.902859913631, 5357.276767636319, 5385.764907563395, 5406.270153529302, 5172.163881821899, 5199.376074871039, 5215.322008139069, 5231.895362092813, 5235.188545775259, 4832.202686556679, 5089.567386772166, 5098.694078355311, 5103.77033033507, 5152.9694061187165, 5335.973320133375, 5365.409804921534, 5369.624126311121, 5374.973125134349, 5426.755795989269, 3887.853083340478, 3889.649931506178, 3930.390789427643, 3950.881473555798, 3963.246983073207, 5051.545360917535, 5184.066867963803, 5205.219217117463, 5221.37343518765, 5608.2148499209325, 5564.4991950724625, 5659.434056594308, 5704.543636508986, 5709.543236540983, 5716.828495145152, 5621.409751975983, 5668.489835914787, 5715.8571035724435, 5736.4263573643975, 5740.282464691913, 5485.259489968803, 5631.7184140793615, 5657.943420565742, 5659.518940890071, 5672.064109421899, 5694.829155125353, 5717.571182161438, 5744.597878148489, 5750.539956803362, 5753.90675771602, 5417.918731219113, 5635.746391412315, 5642.181883626769, 5655.264815573949, 5660.943390566206], "value": 4234.132359220618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.1476801678069, 744.7840126363355, 776.79026662801, 783.3576467296817, 906.1572737354257, 16100.194990250498, 16699.415520456787, 16785.41251056213, 16858.662826743457, 16918.323267069318, 14853.257337133155, 14928.477503287388, 14946.476873309437, 14954.177520236382, 14956.850431495708, 709.4147328454046, 821.4537332673765, 865.8181781825824, 866.5883705240024, 873.0, 860.9483430994161, 864.235151890575, 866.7183165471247, 866.8569686001803, 867.154524338771, 910.135371397172, 917.6925729880498, 919.2645883293372, 919.6689191890914, 922.294444749767, 725.4414101142117, 874.6588830356167, 908.0964440381796, 910.7495438754329, 913.7715571107224, 678.8540463800307, 679.0968012543306, 679.5277282288811, 679.5548915460381, 679.8334408070006, 13833.377498012613, 13994.30028498571, 14182.92908535461, 14194.432222711182, 14219.289035548181, 14231.573052808433, 14472.204028778413, 14493.42026318946, 14508.782368264485, 14509.129452232899, 13119.606411807661, 13129.0, 13206.207627542379, 13330.933345333307, 13494.662633434145, 4528.56978587037, 4706.388169537938, 4733.621310295202, 4809.519048095198, 4819.228923372244, 76667.0, 78304.21695782969, 79978.20021799766, 81407.59296203482, 81576.59211703904, 10909.454527273605, 11044.282121662067, 11087.33475991443, 11138.554457821758, 11224.943875280735, 20456.897715511626, 21679.89160054221, 21701.13195472195, 21839.672404913937, 21881.0, 8456.281216096577, 8479.872801907977, 8544.060153383123, 8560.315174786003, 8800.16398442147, 4913.361263035782, 4940.1601727706375, 4975.228839529878, 4976.377952755905, 4988.6507944444265, 3833.6166383361997, 3992.640662340403, 3994.72036957416, 4005.499312585927, 4009.8596549121226, 638.2532437048665, 655.8530732727647, 659.2945548263408, 697.8778713725078, 706.4772068669148, 684.5105749389211, 707.8831992721143, 736.9557826530425, 751.1249394455507, 773.1920143450108, 9638.42169469834, 9812.65655702047, 10038.799224015625, 10118.797624047478, 10121.645742398981, 650.8828410885991, 689.4484412470003, 735.0260904301822, 757.5114051436792, 771.240328276647, 4498.527654596221, 4508.752018639007, 4512.075024619945, 4580.519045500241, 4645.3032045193495, 122962.38518807349, 123935.38032309781, 125670.37164814117, 130283.0, 130367.0, 108070.0, 110154.0, 111052.44473777579, 111092.4445377768, 114879.42560287144, 95767.52116239374, 96394.51802740942, 96788.0, 97051.0, 98696.0, 9025.864612030693, 9048.819023619359, 9064.320175986695, 9071.455712657262, 9127.0, 39965.40051899282, 50381.24428133654, 57868.0, 58471.0, 58505.4149458517, 50858.23712644387, 51547.48452515427, 69061.0, 69417.79301192092, 80392.19607804081, 13157.210567365988, 13171.0, 13180.143290686075, 13422.597322080353, 13482.93258533701, 14536.709265814836, 14789.408423662933, 14829.777553336924, 15220.847791521943, 15228.086314821147, 10012.899871001197, 13530.729385412433, 13682.45270189221, 13766.105203161762, 13940.860591393955, 13507.594772156852, 13590.116642418212, 13826.308684565933, 13914.86085139176, 14251.358688859234, 9370.67202647904, 11603.6518904433, 12759.48962041545, 13003.414846332127, 13381.53164639233, 11322.207445478738, 11545.48045337945, 11845.111616628616, 11858.525658973544, 12159.756804863677, 11727.648170554898, 11957.880421195676, 11960.700982475508, 12029.0, 12106.51573937068], "value": 7793.436324285173, "unit": "score"}], "name": "dromaeo_css", "value": 7470.766091459982, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 111.0, 113.0, 113.0, 110.0, 112.0, 109.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 126.0, 193.0, 125.0, 125.0, 155.0, 130.0, 161.0, 130.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 163.0, 162.0, 163.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 124.0, 75.0, 87.0, 76.0, 76.0, 102.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 115.0, 84.0, 85.0, 85.0, 117.0, 83.0, 84.0, 129.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 148.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 52.0, 52.0, 52.0, 51.0, 52.0, 53.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 62.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 76.0, 75.0, 77.0, 77.0, 76.0, 83.0, 107.0, 82.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 123.0, 124.0, 129.0, 121.0, 117.0, 114.0, 120.0, 130.0, 118.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 160.0, 156.0, 154.0, 153.0, 154.0, 160.0, 152.0, 149.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 59.0, 59.0, 60.0], "value": 60.3, "unit": "score"}], "name": "kraken", "value": 1481.0, "alertThreshold": 2.0}]} 15:07:39 INFO - Return code: 0 15:07:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:07:39 ERROR - # TBPL SUCCESS # 15:07:39 INFO - Running post-action listener: _resource_record_post_action 15:07:39 INFO - ##### 15:07:39 INFO - ##### Finished run-tests step (success) 15:07:39 INFO - ##### 15:07:39 INFO - Running post-run listener: _resource_record_post_run 15:07:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 505659392; Read time: 28; Write time: 410736 15:07:39 INFO - TinderboxPrint: CPU usage
13.2% 15:07:39 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 15:07:39 INFO - TinderboxPrint: I/O write bytes / time
505,659,392 / 410,736 15:07:39 INFO - TinderboxPrint: CPU idle
8,254.0 (86.8%) 15:07:39 INFO - TinderboxPrint: CPU user
1,205.0 (12.7%) 15:07:39 INFO - TinderboxPrint: Swap in / out
0 / 0 15:07:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252755968; Read time: 0; Write time: 299348 15:07:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252903424; Read time: 28; Write time: 111388 15:07:40 INFO - Running post-run listener: _upload_blobber_files 15:07:40 INFO - Blob upload gear active. 15:07:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:07:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:07:40 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:07:40 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:07:40 INFO - (blobuploader) - INFO - Open directory for files ... 15:07:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:07:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:44 INFO - (blobuploader) - INFO - Done attempting. 15:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:45 INFO - (blobuploader) - INFO - Done attempting. 15:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:07:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:46 INFO - (blobuploader) - INFO - Done attempting. 15:07:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:07:46 INFO - Return code: 0 15:07:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:07:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:07:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c1f9152ef2e07cfc31a2bc9850caa6474bf3bc404940cb5b22f71588c8fa9df017ded1f78920463ee78477175928bb67e7339e1a43dd083275e455487bc6f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fa0780a07cda8131bc4666669d21067c582c1ac7ab30ce9bddbcde3299088a8ebbc538e2e373d3e88d09fa8c8eee564e7685bd8fdaf1f318d14325ea24986c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56409386f91ad6f00cd9de50c7cc582b3ce3c0dca7b2b56cbffa17c3b72f437c60b67e599273f4aa60794f77655b7ebdc3a6c4272a769e870e0041be908ce460"} 15:07:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:07:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:07:46 INFO - Contents: 15:07:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c1f9152ef2e07cfc31a2bc9850caa6474bf3bc404940cb5b22f71588c8fa9df017ded1f78920463ee78477175928bb67e7339e1a43dd083275e455487bc6f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fa0780a07cda8131bc4666669d21067c582c1ac7ab30ce9bddbcde3299088a8ebbc538e2e373d3e88d09fa8c8eee564e7685bd8fdaf1f318d14325ea24986c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56409386f91ad6f00cd9de50c7cc582b3ce3c0dca7b2b56cbffa17c3b72f437c60b67e599273f4aa60794f77655b7ebdc3a6c4272a769e870e0041be908ce460"} 15:07:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:07:46 INFO - Copying logs to upload dir... 15:07:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:07:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.934209 ========= master_lag: 0.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-05 15:07:46.836412) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 15:07:46.841089) ========= 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=d2a8c569965ab8367867b893000001a1-1467754699.736231-279401276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c1f9152ef2e07cfc31a2bc9850caa6474bf3bc404940cb5b22f71588c8fa9df017ded1f78920463ee78477175928bb67e7339e1a43dd083275e455487bc6f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fa0780a07cda8131bc4666669d21067c582c1ac7ab30ce9bddbcde3299088a8ebbc538e2e373d3e88d09fa8c8eee564e7685bd8fdaf1f318d14325ea24986c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56409386f91ad6f00cd9de50c7cc582b3ce3c0dca7b2b56cbffa17c3b72f437c60b67e599273f4aa60794f77655b7ebdc3a6c4272a769e870e0041be908ce460"} build_url:https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/BzEsW9i3QlS2hDIlOwc69Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c1f9152ef2e07cfc31a2bc9850caa6474bf3bc404940cb5b22f71588c8fa9df017ded1f78920463ee78477175928bb67e7339e1a43dd083275e455487bc6f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fa0780a07cda8131bc4666669d21067c582c1ac7ab30ce9bddbcde3299088a8ebbc538e2e373d3e88d09fa8c8eee564e7685bd8fdaf1f318d14325ea24986c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56409386f91ad6f00cd9de50c7cc582b3ce3c0dca7b2b56cbffa17c3b72f437c60b67e599273f4aa60794f77655b7ebdc3a6c4272a769e870e0041be908ce460"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 15:07:46.874279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:07:46.874630) ========= 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=d2a8c569965ab8367867b893000001a1-1467754699.736231-279401276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.33 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:07:47.213773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 15:07:47.214104) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 15:07:47.214469) ========= ========= Total master_lag: 1.09 =========