builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1469135692.01 results: success (0) buildid: 20160721114020 builduid: ea99a900982d4a2082f4e30dc8340e46 revision: 419d32e09203b0062d9652e35094734be81b9e80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.015201) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.015602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.015925) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.062281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.062572) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 14:14:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.3M=0s 2016-07-21 14:14:52 (45.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.252464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.253202) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020391 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.306035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.306708) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 419d32e09203b0062d9652e35094734be81b9e80 --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 419d32e09203b0062d9652e35094734be81b9e80 --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=4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 14:14:52,401 truncating revision to first 12 chars 2016-07-21 14:14:52,401 Setting DEBUG logging. 2016-07-21 14:14:52,401 attempt 1/10 2016-07-21 14:14:52,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/419d32e09203?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 14:14:52,703 unpacking tar archive at: mozilla-aurora-419d32e09203/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617331 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.940709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.941275) ========= script_repo_revision: 419d32e09203b0062d9652e35094734be81b9e80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.942174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.942834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 14:14:52.954531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-21 14:14:52.954845) ========= /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=4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:14:53 INFO - MultiFileLogger online at 20160721 14:14:53 in /builds/slave/test 14:14:53 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:14:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:14:53 INFO - {'append_to_log': False, 14:14:53 INFO - 'base_work_dir': '/builds/slave/test', 14:14:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:14:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:14:53 INFO - 'branch': 'Mozilla-Aurora', 14:14:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:14:53 INFO - 'config_files': ('talos/linux_config.py',), 14:14:53 INFO - 'default_actions': ('clobber', 14:14:53 INFO - 'read-buildbot-config', 14:14:53 INFO - 'download-and-extract', 14:14:53 INFO - 'populate-webroot', 14:14:53 INFO - 'create-virtualenv', 14:14:53 INFO - 'install', 14:14:53 INFO - 'run-tests'), 14:14:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:14:53 INFO - 'download_minidump_stackwalk': True, 14:14:53 INFO - 'download_symbols': 'ondemand', 14:14:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:14:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:14:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:14:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:14:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:14:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:14:53 INFO - 'installer_path': 'installer.exe', 14:14:53 INFO - 'log_level': 'info', 14:14:53 INFO - 'log_name': 'talos', 14:14:53 INFO - 'log_to_console': True, 14:14:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:14:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:14:53 INFO - 'opt_config_files': (), 14:14:53 INFO - 'pip_index': False, 14:14:53 INFO - 'sps_profile': False, 14:14:53 INFO - 'sps_profile_interval': 0, 14:14:53 INFO - 'suite': 'dromaeojs', 14:14:53 INFO - 'system_bits': '32', 14:14:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:14:53 INFO - 'title': 'talos-linux64-ix-030', 14:14:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:14:53 INFO - 'use_talos_json': True, 14:14:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:14:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:14:53 INFO - 'work_dir': 'build'} 14:14:53 INFO - ##### 14:14:53 INFO - ##### Running clobber step. 14:14:53 INFO - ##### 14:14:53 INFO - Running pre-action listener: _resource_record_pre_action 14:14:53 INFO - Running main action method: clobber 14:14:53 INFO - rmtree: /builds/slave/test/build 14:14:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:14:54 INFO - Running post-action listener: _resource_record_post_action 14:14:54 INFO - ##### 14:14:54 INFO - ##### Finished clobber step (success) 14:14:54 INFO - ##### 14:14:54 INFO - ##### 14:14:54 INFO - ##### Running read-buildbot-config step. 14:14:54 INFO - ##### 14:14:54 INFO - Running pre-action listener: _resource_record_pre_action 14:14:54 INFO - Running main action method: read_buildbot_config 14:14:54 INFO - Using buildbot properties: 14:14:54 INFO - { 14:14:54 INFO - "project": "", 14:14:54 INFO - "product": "firefox", 14:14:54 INFO - "script_repo_revision": "production", 14:14:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:14:54 INFO - "repository": "", 14:14:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:14:54 INFO - "buildid": "20160721114020", 14:14:54 INFO - "pgo_build": "True", 14:14:54 INFO - "basedir": "/builds/slave/test", 14:14:54 INFO - "buildnumber": 422, 14:14:54 INFO - "slavename": "talos-linux64-ix-030", 14:14:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:14:54 INFO - "platform": "ubuntu64_hw", 14:14:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:14:54 INFO - "branch": "mozilla-aurora", 14:14:54 INFO - "repo_path": "releases/mozilla-aurora", 14:14:54 INFO - "revision": "419d32e09203b0062d9652e35094734be81b9e80", 14:14:54 INFO - "stage_platform": "linux64-pgo", 14:14:54 INFO - "builduid": "ea99a900982d4a2082f4e30dc8340e46", 14:14:54 INFO - "slavebuilddir": "test" 14:14:54 INFO - } 14:14:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:14:54 INFO - Running post-action listener: _resource_record_post_action 14:14:54 INFO - ##### 14:14:54 INFO - ##### Finished read-buildbot-config step (success) 14:14:54 INFO - ##### 14:14:54 INFO - ##### 14:14:54 INFO - ##### Running download-and-extract step. 14:14:54 INFO - ##### 14:14:54 INFO - Running pre-action listener: _resource_record_pre_action 14:14:54 INFO - Running main action method: download_and_extract 14:14:54 INFO - mkdir: /builds/slave/test/build/tests 14:14:54 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:14:54 INFO - https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:14:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:14:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:14:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:01 INFO - Downloaded 1361 bytes. 14:15:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:15:01 INFO - Using the following test package requirements: 14:15:01 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:15:01 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:15:01 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:15:01 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'jsshell-linux-x86_64.zip'], 14:15:01 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:15:01 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:15:01 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:15:01 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:15:01 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:15:01 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:15:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:15:01 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:01 INFO - https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:15:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:15:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:05 INFO - Downloaded 24490975 bytes. 14:15:05 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:15:05 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:15:07 INFO - Return code: 0 14:15:07 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:15:07 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:15:07 INFO - https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:09 INFO - Downloaded 24490975 bytes. 14:15:09 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:15:09 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:15:11 INFO - Return code: 0 14:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:11 INFO - https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:12 INFO - Downloaded 10833369 bytes. 14:15:12 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:15:12 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:15:12 INFO - Return code: 0 14:15:12 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:15:12 INFO - https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:15:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:15:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:15:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaZrnChhRnSiIMgdg0ho2g/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:15:14 INFO - Downloaded 63649452 bytes. 14:15:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:15:14 INFO - mkdir: /builds/slave/test/properties 14:15:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:14 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:14 INFO - Contents: 14:15:14 INFO - build_url:https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:15:14 INFO - Running post-action listener: _resource_record_post_action 14:15:14 INFO - Running post-action listener: set_extra_try_arguments 14:15:14 INFO - ##### 14:15:14 INFO - ##### Finished download-and-extract step (success) 14:15:14 INFO - ##### 14:15:14 INFO - ##### 14:15:14 INFO - ##### Running populate-webroot step. 14:15:14 INFO - ##### 14:15:14 INFO - Running pre-action listener: _resource_record_pre_action 14:15:14 INFO - Running main action method: populate_webroot 14:15:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:14 INFO - '--tppagecycles', 14:15:14 INFO - '7'], 14:15:14 INFO - 'tests': ['tsvgm']}}, 14:15:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:15:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:15:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:15:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['damp', 'tps']}, 14:15:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'tests': ['damp', 'tps']}, 14:15:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['dromaeo_dom']}, 14:15:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['a11yr', 14:15:14 INFO - 'ts_paint', 14:15:14 INFO - 'tpaint', 14:15:14 INFO - 'sessionrestore', 14:15:14 INFO - 'sessionrestore_no_auto_restore', 14:15:14 INFO - 'tabpaint']}, 14:15:14 INFO - 'other-e10s': {'tests': ['a11yr', 14:15:14 INFO - 'ts_paint', 14:15:14 INFO - 'tpaint', 14:15:14 INFO - 'sessionrestore', 14:15:14 INFO - 'sessionrestore_no_auto_restore', 14:15:14 INFO - 'tabpaint']}, 14:15:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:15:14 INFO - 'ts_paint', 14:15:14 INFO - 'tpaint', 14:15:14 INFO - 'sessionrestore', 14:15:14 INFO - 'sessionrestore_no_auto_restore', 14:15:14 INFO - 'tabpaint']}, 14:15:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:15:14 INFO - 'ts_paint', 14:15:14 INFO - 'tpaint', 14:15:14 INFO - 'sessionrestore', 14:15:14 INFO - 'sessionrestore_no_auto_restore', 14:15:14 INFO - 'tabpaint']}, 14:15:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['a11yr', 14:15:14 INFO - 'ts_paint', 14:15:14 INFO - 'tpaint', 14:15:14 INFO - 'sessionrestore', 14:15:14 INFO - 'sessionrestore_no_auto_restore', 14:15:14 INFO - 'tabpaint']}, 14:15:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['a11yr', 14:15:14 INFO - 'ts_paint', 14:15:14 INFO - 'tpaint', 14:15:14 INFO - 'sessionrestore', 14:15:14 INFO - 'sessionrestore_no_auto_restore', 14:15:14 INFO - 'tabpaint']}, 14:15:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['tsvgx', 14:15:14 INFO - 'tsvgr_opacity', 14:15:14 INFO - 'tart', 14:15:14 INFO - 'tscrollx', 14:15:14 INFO - 'cart']}, 14:15:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:15:14 INFO - 'tsvgr_opacity', 14:15:14 INFO - 'tart', 14:15:14 INFO - 'tscrollx', 14:15:14 INFO - 'cart']}, 14:15:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'talos_options': ['--disable-e10s'], 14:15:14 INFO - 'tests': ['tp5o']}, 14:15:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'tests': ['tp5o']}, 14:15:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'talos_options': ['--disable-e10s', 14:15:14 INFO - '--xperf_path', 14:15:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:14 INFO - 'tests': ['tp5n']}, 14:15:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:14 INFO - 'talos_options': ['--xperf_path', 14:15:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:14 INFO - 'tests': ['tp5n']}}, 14:15:14 INFO - 'talos.zip': {'path': '', 14:15:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:14 INFO - Running post-action listener: _resource_record_post_action 14:15:14 INFO - ##### 14:15:14 INFO - ##### Finished populate-webroot step (success) 14:15:14 INFO - ##### 14:15:14 INFO - ##### 14:15:14 INFO - ##### Running create-virtualenv step. 14:15:14 INFO - ##### 14:15:14 INFO - Running pre-action listener: _resource_record_pre_action 14:15:14 INFO - Running main action method: create_virtualenv 14:15:14 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:14 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:15:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:14 INFO - Using real prefix '/usr' 14:15:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:15 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:17 INFO - Installing pip.................done. 14:15:17 INFO - Return code: 0 14:15:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:15:17 INFO - Using env: {'DISPLAY': ':0', 14:15:17 INFO - 'HOME': '/home/cltbld', 14:15:17 INFO - 'LANG': 'en_US.UTF-8', 14:15:17 INFO - 'LANGUAGE': 'en_US:en', 14:15:17 INFO - 'LOGNAME': 'cltbld', 14:15:17 INFO - 'MAIL': '/var/mail/cltbld', 14:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:17 INFO - 'MOZ_NO_REMOTE': '1', 14:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:17 INFO - 'NO_EM_RESTART': '1', 14:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:17 INFO - 'PWD': '/builds/slave/test', 14:15:17 INFO - 'SHELL': '/bin/bash', 14:15:17 INFO - 'SHLVL': '1', 14:15:17 INFO - 'TERM': 'linux', 14:15:17 INFO - 'TMOUT': '86400', 14:15:17 INFO - 'USER': 'cltbld', 14:15:17 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:17 INFO - '_': '/tools/buildbot/bin/python'} 14:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:17 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:15:17 INFO - Cleaning up... 14:15:17 INFO - Return code: 0 14:15:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:15:17 INFO - Using env: {'DISPLAY': ':0', 14:15:17 INFO - 'HOME': '/home/cltbld', 14:15:17 INFO - 'LANG': 'en_US.UTF-8', 14:15:17 INFO - 'LANGUAGE': 'en_US:en', 14:15:17 INFO - 'LOGNAME': 'cltbld', 14:15:17 INFO - 'MAIL': '/var/mail/cltbld', 14:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:17 INFO - 'MOZ_NO_REMOTE': '1', 14:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:17 INFO - 'NO_EM_RESTART': '1', 14:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:17 INFO - 'PWD': '/builds/slave/test', 14:15:17 INFO - 'SHELL': '/bin/bash', 14:15:17 INFO - 'SHLVL': '1', 14:15:17 INFO - 'TERM': 'linux', 14:15:17 INFO - 'TMOUT': '86400', 14:15:17 INFO - 'USER': 'cltbld', 14:15:17 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:17 INFO - '_': '/tools/buildbot/bin/python'} 14:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:17 INFO - Downloading/unpacking psutil>=3.1.1 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:19 INFO - Installing collected packages: psutil 14:15:19 INFO - Running setup.py install for psutil 14:15:19 INFO - building 'psutil._psutil_linux' extension 14:15:19 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:15:20 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:15:20 INFO - building 'psutil._psutil_posix' extension 14:15:20 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:15:20 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:15:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:20 INFO - Successfully installed psutil 14:15:20 INFO - Cleaning up... 14:15:20 INFO - Return code: 0 14:15:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:15: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:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:20 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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:20 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:15:20 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:15:20 INFO - Using env: {'DISPLAY': ':0', 14:15:20 INFO - 'HOME': '/home/cltbld', 14:15:20 INFO - 'LANG': 'en_US.UTF-8', 14:15:20 INFO - 'LANGUAGE': 'en_US:en', 14:15:20 INFO - 'LOGNAME': 'cltbld', 14:15:20 INFO - 'MAIL': '/var/mail/cltbld', 14:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:20 INFO - 'MOZ_NO_REMOTE': '1', 14:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:20 INFO - 'NO_EM_RESTART': '1', 14:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:20 INFO - 'PWD': '/builds/slave/test', 14:15:20 INFO - 'SHELL': '/bin/bash', 14:15:20 INFO - 'SHLVL': '1', 14:15:20 INFO - 'TERM': 'linux', 14:15:20 INFO - 'TMOUT': '86400', 14:15:20 INFO - 'USER': 'cltbld', 14:15:20 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:20 INFO - '_': '/tools/buildbot/bin/python'} 14:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:15:22 INFO - Installing collected packages: mozsystemmonitor 14:15:22 INFO - Running setup.py install for mozsystemmonitor 14:15:22 INFO - Successfully installed mozsystemmonitor 14:15:22 INFO - Cleaning up... 14:15:22 INFO - Return code: 0 14:15:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:15:22 INFO - Using env: {'DISPLAY': ':0', 14:15:22 INFO - 'HOME': '/home/cltbld', 14:15:22 INFO - 'LANG': 'en_US.UTF-8', 14:15:22 INFO - 'LANGUAGE': 'en_US:en', 14:15:22 INFO - 'LOGNAME': 'cltbld', 14:15:22 INFO - 'MAIL': '/var/mail/cltbld', 14:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:22 INFO - 'MOZ_NO_REMOTE': '1', 14:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:22 INFO - 'NO_EM_RESTART': '1', 14:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:22 INFO - 'PWD': '/builds/slave/test', 14:15:22 INFO - 'SHELL': '/bin/bash', 14:15:22 INFO - 'SHLVL': '1', 14:15:22 INFO - 'TERM': 'linux', 14:15:22 INFO - 'TMOUT': '86400', 14:15:22 INFO - 'USER': 'cltbld', 14:15:22 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:22 INFO - '_': '/tools/buildbot/bin/python'} 14:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:22 INFO - Downloading/unpacking jsonschema==2.5.1 14:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:15:25 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:15:25 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:15:25 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:15:25 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:15:25 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:15:25 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:15:25 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:25 INFO - warning: no files found matching '*.txt' 14:15:25 INFO - no previously-included directories found matching 'build' 14:15:25 INFO - no previously-included directories found matching 'dist' 14:15:25 INFO - no previously-included directories found matching '.git*' 14:15:25 INFO - Installing collected packages: jsonschema, functools32 14:15:25 INFO - Running setup.py install for functools32 14:15:25 INFO - warning: no files found matching '*.txt' 14:15:25 INFO - no previously-included directories found matching 'build' 14:15:25 INFO - no previously-included directories found matching 'dist' 14:15:25 INFO - no previously-included directories found matching '.git*' 14:15:25 INFO - Successfully installed jsonschema functools32 14:15:25 INFO - Cleaning up... 14:15:25 INFO - Return code: 0 14:15:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:25 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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:25 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:15:25 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:15:25 INFO - Using env: {'DISPLAY': ':0', 14:15:25 INFO - 'HOME': '/home/cltbld', 14:15:25 INFO - 'LANG': 'en_US.UTF-8', 14:15:25 INFO - 'LANGUAGE': 'en_US:en', 14:15:25 INFO - 'LOGNAME': 'cltbld', 14:15:25 INFO - 'MAIL': '/var/mail/cltbld', 14:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:25 INFO - 'MOZ_NO_REMOTE': '1', 14:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:25 INFO - 'NO_EM_RESTART': '1', 14:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:25 INFO - 'PWD': '/builds/slave/test', 14:15:25 INFO - 'SHELL': '/bin/bash', 14:15:25 INFO - 'SHLVL': '1', 14:15:25 INFO - 'TERM': 'linux', 14:15:25 INFO - 'TMOUT': '86400', 14:15:25 INFO - 'USER': 'cltbld', 14:15:25 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:25 INFO - '_': '/tools/buildbot/bin/python'} 14:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:25 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:25 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:15:25 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:15:25 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:15:25 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:15:25 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:15:25 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:15:27 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 INFO - Downloading docopt-0.6.1.tar.gz 14:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:28 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:28 INFO - Running setup.py install for blobuploader 14:15:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:28 INFO - Running setup.py install for requests 14:15:28 INFO - Running setup.py install for docopt 14:15:28 INFO - Successfully installed blobuploader requests docopt 14:15:28 INFO - Cleaning up... 14:15:28 INFO - Return code: 0 14:15:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:28 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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:28 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:15:28 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:15:28 INFO - Using env: {'DISPLAY': ':0', 14:15:28 INFO - 'HOME': '/home/cltbld', 14:15:28 INFO - 'LANG': 'en_US.UTF-8', 14:15:28 INFO - 'LANGUAGE': 'en_US:en', 14:15:28 INFO - 'LOGNAME': 'cltbld', 14:15:28 INFO - 'MAIL': '/var/mail/cltbld', 14:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:28 INFO - 'MOZ_NO_REMOTE': '1', 14:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:28 INFO - 'NO_EM_RESTART': '1', 14:15:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:28 INFO - 'PWD': '/builds/slave/test', 14:15:28 INFO - 'SHELL': '/bin/bash', 14:15:28 INFO - 'SHLVL': '1', 14:15:28 INFO - 'TERM': 'linux', 14:15:28 INFO - 'TMOUT': '86400', 14:15:28 INFO - 'USER': 'cltbld', 14:15:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:28 INFO - '_': '/tools/buildbot/bin/python'} 14:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:29 INFO - Running setup.py (path:/tmp/pip-wgf9ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:29 INFO - Running setup.py (path:/tmp/pip-O_emYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:29 INFO - Running setup.py (path:/tmp/pip-Cn2Cvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:29 INFO - Running setup.py (path:/tmp/pip-d08UPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:29 INFO - Running setup.py (path:/tmp/pip-ALwijf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:29 INFO - Running setup.py (path:/tmp/pip-pwSdGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:29 INFO - Running setup.py (path:/tmp/pip-TBU4i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:29 INFO - Running setup.py (path:/tmp/pip-yDeR00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:29 INFO - Running setup.py (path:/tmp/pip-1SbBjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:29 INFO - Running setup.py (path:/tmp/pip-mtak5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:29 INFO - Running setup.py (path:/tmp/pip-w__MJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:29 INFO - Running setup.py (path:/tmp/pip-VqC0OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:30 INFO - Running setup.py (path:/tmp/pip-hlJ1Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:30 INFO - Running setup.py (path:/tmp/pip-CpRBwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:30 INFO - Running setup.py (path:/tmp/pip-cbrGDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:30 INFO - Running setup.py (path:/tmp/pip-eYCHxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:30 INFO - Running setup.py (path:/tmp/pip-RwoOjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:30 INFO - Running setup.py install for manifestparser 14:15:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:30 INFO - Running setup.py install for mozcrash 14:15:30 INFO - Running setup.py install for mozdebug 14:15:30 INFO - Running setup.py install for mozdevice 14:15:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:30 INFO - Running setup.py install for mozfile 14:15:30 INFO - Running setup.py install for mozhttpd 14:15:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Running setup.py install for mozinfo 14:15:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Running setup.py install for mozInstall 14:15:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Running setup.py install for mozleak 14:15:31 INFO - Running setup.py install for mozlog 14:15:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Running setup.py install for moznetwork 14:15:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Running setup.py install for mozprocess 14:15:31 INFO - Running setup.py install for mozprofile 14:15:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Running setup.py install for mozrunner 14:15:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:31 INFO - Running setup.py install for mozscreenshot 14:15:31 INFO - Running setup.py install for moztest 14:15:32 INFO - Running setup.py install for mozversion 14:15:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:32 INFO - Cleaning up... 14:15:32 INFO - Return code: 0 14:15:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:32 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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:32 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:15:32 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:15:32 INFO - Using env: {'DISPLAY': ':0', 14:15:32 INFO - 'HOME': '/home/cltbld', 14:15:32 INFO - 'LANG': 'en_US.UTF-8', 14:15:32 INFO - 'LANGUAGE': 'en_US:en', 14:15:32 INFO - 'LOGNAME': 'cltbld', 14:15:32 INFO - 'MAIL': '/var/mail/cltbld', 14:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:32 INFO - 'MOZ_NO_REMOTE': '1', 14:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:32 INFO - 'NO_EM_RESTART': '1', 14:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:32 INFO - 'PWD': '/builds/slave/test', 14:15:32 INFO - 'SHELL': '/bin/bash', 14:15:32 INFO - 'SHLVL': '1', 14:15:32 INFO - 'TERM': 'linux', 14:15:32 INFO - 'TMOUT': '86400', 14:15:32 INFO - 'USER': 'cltbld', 14:15:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:32 INFO - '_': '/tools/buildbot/bin/python'} 14:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:32 INFO - Running setup.py (path:/tmp/pip-qr3mwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:32 INFO - Running setup.py (path:/tmp/pip-tM11kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:32 INFO - Running setup.py (path:/tmp/pip-ZmYu_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:32 INFO - Running setup.py (path:/tmp/pip-BmLwCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:32 INFO - Running setup.py (path:/tmp/pip-EtL6yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:32 INFO - Running setup.py (path:/tmp/pip-2GDgI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:32 INFO - Running setup.py (path:/tmp/pip-Iwn4Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:32 INFO - Running setup.py (path:/tmp/pip-27r0wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:32 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:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:32 INFO - Running setup.py (path:/tmp/pip-Rvm2Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:33 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:33 INFO - Running setup.py (path:/tmp/pip-MZJR88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:33 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:33 INFO - Running setup.py (path:/tmp/pip-yWt_ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:33 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:33 INFO - Running setup.py (path:/tmp/pip-FxV5dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:33 INFO - Running setup.py (path:/tmp/pip-tH_tUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:33 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:33 INFO - Running setup.py (path:/tmp/pip-R0VmIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:33 INFO - Running setup.py (path:/tmp/pip-tA4sDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:33 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:33 INFO - Running setup.py (path:/tmp/pip-8CyZY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:33 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:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:33 INFO - Running setup.py (path:/tmp/pip-rcOwxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:33 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:15:33 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:15:33 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:15:33 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:15:33 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:15:33 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:15:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15: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:15: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:15: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:15: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:15: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:15: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:15:35 INFO - Downloading blessings-1.6.tar.gz 14:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:35 INFO - Installing collected packages: blessings 14:15:35 INFO - Running setup.py install for blessings 14:15:35 INFO - Successfully installed blessings 14:15:35 INFO - Cleaning up... 14:15:35 INFO - Return code: 0 14:15:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:35 INFO - Reading from file tmpfile_stdout 14:15:35 INFO - Current package versions: 14:15:35 INFO - argparse == 1.2.1 14:15:35 INFO - blessings == 1.6 14:15:35 INFO - blobuploader == 1.2.4 14:15:35 INFO - docopt == 0.6.1 14:15:35 INFO - functools32 == 3.2.3-2 14:15:35 INFO - jsonschema == 2.5.1 14:15:35 INFO - manifestparser == 1.1 14:15:35 INFO - mozInstall == 1.12 14:15:35 INFO - mozcrash == 0.17 14:15:35 INFO - mozdebug == 0.1 14:15:35 INFO - mozdevice == 0.48 14:15:35 INFO - mozfile == 1.2 14:15:35 INFO - mozhttpd == 0.7 14:15:35 INFO - mozinfo == 0.9 14:15:35 INFO - mozleak == 0.1 14:15:35 INFO - mozlog == 3.2 14:15:35 INFO - moznetwork == 0.27 14:15:35 INFO - mozprocess == 0.23 14:15:35 INFO - mozprofile == 0.28 14:15:35 INFO - mozrunner == 6.12 14:15:35 INFO - mozscreenshot == 0.1 14:15:35 INFO - mozsystemmonitor == 0.3 14:15:35 INFO - moztest == 0.7 14:15:35 INFO - mozversion == 1.4 14:15:35 INFO - psutil == 3.1.1 14:15:35 INFO - requests == 1.2.3 14:15:35 INFO - wsgiref == 0.1.2 14:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:35 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:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:35 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:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:35 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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:35 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:15:35 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:15:35 INFO - Using env: {'DISPLAY': ':0', 14:15:35 INFO - 'HOME': '/home/cltbld', 14:15:35 INFO - 'LANG': 'en_US.UTF-8', 14:15:35 INFO - 'LANGUAGE': 'en_US:en', 14:15:35 INFO - 'LOGNAME': 'cltbld', 14:15:35 INFO - 'MAIL': '/var/mail/cltbld', 14:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:35 INFO - 'MOZ_NO_REMOTE': '1', 14:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:35 INFO - 'NO_EM_RESTART': '1', 14:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:35 INFO - 'PWD': '/builds/slave/test', 14:15:35 INFO - 'SHELL': '/bin/bash', 14:15:35 INFO - 'SHLVL': '1', 14:15:35 INFO - 'TERM': 'linux', 14:15:35 INFO - 'TMOUT': '86400', 14:15:35 INFO - 'USER': 'cltbld', 14:15:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:35 INFO - '_': '/tools/buildbot/bin/python'} 14:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 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:15:36 INFO - Cleaning up... 14:15:36 INFO - Return code: 0 14:15:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:36 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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:36 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:15:36 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:15:36 INFO - Using env: {'DISPLAY': ':0', 14:15:36 INFO - 'HOME': '/home/cltbld', 14:15:36 INFO - 'LANG': 'en_US.UTF-8', 14:15:36 INFO - 'LANGUAGE': 'en_US:en', 14:15:36 INFO - 'LOGNAME': 'cltbld', 14:15:36 INFO - 'MAIL': '/var/mail/cltbld', 14:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:36 INFO - 'MOZ_NO_REMOTE': '1', 14:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:36 INFO - 'NO_EM_RESTART': '1', 14:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:36 INFO - 'PWD': '/builds/slave/test', 14:15:36 INFO - 'SHELL': '/bin/bash', 14:15:36 INFO - 'SHLVL': '1', 14:15:36 INFO - 'TERM': 'linux', 14:15:36 INFO - 'TMOUT': '86400', 14:15:36 INFO - 'USER': 'cltbld', 14:15:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:36 INFO - '_': '/tools/buildbot/bin/python'} 14:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:15:36 INFO - Cleaning up... 14:15:36 INFO - Return code: 0 14:15:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:36 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 0x7f64880ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, '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': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', '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:15:36 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:15:36 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:15:36 INFO - Using env: {'DISPLAY': ':0', 14:15:36 INFO - 'HOME': '/home/cltbld', 14:15:36 INFO - 'LANG': 'en_US.UTF-8', 14:15:36 INFO - 'LANGUAGE': 'en_US:en', 14:15:36 INFO - 'LOGNAME': 'cltbld', 14:15:36 INFO - 'MAIL': '/var/mail/cltbld', 14:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:36 INFO - 'MOZ_NO_REMOTE': '1', 14:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:36 INFO - 'NO_EM_RESTART': '1', 14:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:36 INFO - 'PWD': '/builds/slave/test', 14:15:36 INFO - 'SHELL': '/bin/bash', 14:15:36 INFO - 'SHLVL': '1', 14:15:36 INFO - 'TERM': 'linux', 14:15:36 INFO - 'TMOUT': '86400', 14:15:36 INFO - 'USER': 'cltbld', 14:15:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:36 INFO - '_': '/tools/buildbot/bin/python'} 14:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:36 INFO - Downloading/unpacking flake8 14:15: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:15: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:15: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:15: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:15: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:15: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:15:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:15:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:15:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:38 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:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:15:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:39 INFO - no previously-included directories found matching 'docs/_build' 14:15:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:15:39 INFO - Running setup.py install for pep8 14:15:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:39 INFO - no previously-included directories found matching 'docs/_build' 14:15:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:15:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:15:39 INFO - Cleaning up... 14:15:39 INFO - Return code: 0 14:15:39 INFO - Running post-action listener: _resource_record_post_action 14:15:39 INFO - Running post-action listener: _start_resource_monitoring 14:15:39 INFO - Starting resource monitoring. 14:15:39 INFO - ##### 14:15:39 INFO - ##### Finished create-virtualenv step (success) 14:15:39 INFO - ##### 14:15:39 INFO - ##### 14:15:39 INFO - ##### Running install step. 14:15:39 INFO - ##### 14:15:39 INFO - Running pre-action listener: _resource_record_pre_action 14:15:39 INFO - Running main action method: install 14:15:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:39 INFO - Reading from file tmpfile_stdout 14:15:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:39 INFO - Reading from file tmpfile_stdout 14:15:39 INFO - Output received: 14:15:39 INFO - Usage: mozinstall [options] installer 14:15:39 INFO - Options: 14:15:39 INFO - -h, --help show this help message and exit 14:15:39 INFO - -d DEST, --destination=DEST 14:15:39 INFO - Directory to install application into. [default: 14:15:39 INFO - "/builds/slave/test"] 14:15:39 INFO - --app=APP Application being installed. [default: firefox] 14:15:39 INFO - mkdir: /builds/slave/test/build/application 14:15:39 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:15:39 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:15:55 INFO - Reading from file tmpfile_stdout 14:15:55 INFO - Output received: 14:15:55 INFO - /builds/slave/test/build/application/firefox/firefox 14:15:55 INFO - Running post-action listener: _resource_record_post_action 14:15:55 INFO - ##### 14:15:55 INFO - ##### Finished install step (success) 14:15:55 INFO - ##### 14:15:55 INFO - ##### 14:15:55 INFO - ##### Running run-tests step. 14:15:55 INFO - ##### 14:15:55 INFO - Running pre-action listener: _resource_record_pre_action 14:15:55 INFO - Running main action method: run_tests 14:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:55 INFO - Python 2.7.3 14:15:55 INFO - Return code: 0 14:15:55 INFO - grabbing minidump binary from tooltool 14:15:55 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:15:55 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 0x1b4e2e0>, '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 0x1aba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aba5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:55 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:15:55 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:15:55 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:15:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:55 INFO - Return code: 0 14:15:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:15:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:15:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:15:56 INFO - Return code: 0 14:15:56 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/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:15:56 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/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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:15:56 INFO - Using env: {'DISPLAY': ':0', 14:15:56 INFO - 'HOME': '/home/cltbld', 14:15:56 INFO - 'LANG': 'en_US.UTF-8', 14:15:56 INFO - 'LANGUAGE': 'en_US:en', 14:15:56 INFO - 'LOGNAME': 'cltbld', 14:15:56 INFO - 'MAIL': '/var/mail/cltbld', 14:15:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:56 INFO - 'MOZ_NO_REMOTE': '1', 14:15:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:56 INFO - 'NO_EM_RESTART': '1', 14:15:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:56 INFO - 'PWD': '/builds/slave/test', 14:15:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:56 INFO - 'SHELL': '/bin/bash', 14:15:56 INFO - 'SHLVL': '1', 14:15:56 INFO - 'TERM': 'linux', 14:15:56 INFO - 'TMOUT': '86400', 14:15:56 INFO - 'USER': 'cltbld', 14:15:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918', 14:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:56 INFO - '_': '/tools/buildbot/bin/python'} 14:15:56 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/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:15:56 INFO - mozversion application_buildid: 20160721114020 14:15:56 INFO - mozversion application_changeset: 419d32e09203b0062d9652e35094734be81b9e80 14:15:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:15:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:56 INFO - mozversion application_name: Firefox 14:15:56 INFO - mozversion application_remotingname: firefox-dev 14:15:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:15:56 INFO - mozversion application_vendor: Mozilla 14:15:56 INFO - mozversion application_version: 49.0a2 14:15:56 INFO - mozversion platform_buildid: 20160721114020 14:15:56 INFO - mozversion platform_changeset: 419d32e09203b0062d9652e35094734be81b9e80 14:15:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:15:56 INFO - mozversion platform_version: 49.0a2 14:15:56 INFO - using testdate: 1469135756 14:15:56 INFO - actual date: 1469135756 14:15:56 INFO - starting webserver on 'localhost:36815' 14:15:56 INFO - SUITE-START | Running 2 tests 14:15:56 INFO - TEST-START | dromaeo_css 14:15:56 INFO - operating with platform_type : linux_ 14:15:56 INFO - Initialising browser for dromaeo_css test... 14:15:56 INFO - TEST-INFO | started process 3391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXOu4AC/profile http://localhost:36815/getInfo.html) 14:16:00 INFO - PROCESS | 3391 | __metrics Screen width/height:1600/1200 14:16:00 INFO - PROCESS | 3391 | colorDepth:24 14:16:00 INFO - PROCESS | 3391 | Browser inner width/height: 1024/697 14:16:00 INFO - PROCESS | 3391 | __metrics 14:16:01 INFO - PROCESS | 3391 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:16:01 ERROR - PROCESS | 3391 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:16:02 INFO - TEST-INFO | 3391: exit 0 14:16:02 INFO - Browser initialized. 14:16:02 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:02 INFO - TEST-INFO | started process 3479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXOu4AC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:14 INFO - PROCESS | 3479 | RSS: Main: 145833984 14:16:14 INFO - PROCESS | 3479 | 14:17:06 INFO - PROCESS | 3479 | 1469135826457 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:19:13 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36815/tests/dromaeo/cssquery-ext.html) 14:19:14 INFO - PROCESS | 3479 | RSS: Main: 255180800 14:19:14 INFO - PROCESS | 3479 | 14:22:17 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-ext.html (next: http://localhost:36815/tests/dromaeo/cssquery-jquery.html) 14:22:17 INFO - PROCESS | 3479 | RSS: Main: 223928320 14:22:17 INFO - PROCESS | 3479 | 14:25:19 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36815/tests/dromaeo/cssquery-mootools.html) 14:25:20 INFO - PROCESS | 3479 | RSS: Main: 223952896 14:25:20 INFO - PROCESS | 3479 | 14:28:22 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36815/tests/dromaeo/cssquery-prototype.html) 14:28:22 INFO - PROCESS | 3479 | RSS: Main: 224317440 14:28:22 INFO - PROCESS | 3479 | 14:31:25 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36815/tests/dromaeo/cssquery-yui.html) 14:31:26 INFO - PROCESS | 3479 | RSS: Main: 218415104 14:31:26 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-yui.html (next: http://localhost:36815/tests/dromaeo/cssquery-dojo.html) 14:34:28 INFO - PROCESS | 3479 | RSS: Main: 260694016 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | __start_tp_report 14:34:28 INFO - PROCESS | 3479 | _x_x_mozilla_page_load 14:34:28 INFO - PROCESS | 3479 | _x_x_mozilla_page_load_details 14:34:28 INFO - PROCESS | 3479 | |i|pagename|runs| 14:34:28 INFO - PROCESS | 3479 | |0;dojo.html;3291.6379198288187;3331.0673011556755;3337.315850250699;3351.413502637041;3376.5104059911314;5384.8923021539595;5492.313460817398;5506.284183056202;5508.504234618884;5523.033469142899;5375.919361209575;5414.512693857552;5417.404085550586;5441.7279136043235;5455.099908515091;4801.783919723621;4857.2714092886;4889.804407823683;4913.164761990471;4942.283368911506;4802.663813533054;4863.14894893394;4895.069936712031;4895.290182923474;4899.951000489985;4935.901281974358;5015.924761128586;5016;5023.974880125613;5039.344885164924;4804.95195048052;4977.975110124463;4986.800527978913;5014.473480284572;5025.246213068032;4846.75766211688;4873.902521949542;4894.461609223018;4918.311436398907;4946.72792996385;5332.9733351333;5381.7578208980685;5381.838544843661;5402.972985135049;5419.241306217133;5533.142362933751;5566.192902029183;5620.747066382022;5816.360200377955;5840.474357307863;5710.800121995751;5761.107028410603;5803.854903627401;5819.388964158745;5819.79630712923;5395.865103372447;5421.213923981;5425.131978883399;5425.321834770653;5429.53848922842;5739.827805165852;5752.654840709571;5773.39379365169;5896.204012458264;5901.645901245939;5594;5612.607117501817;5628.71856407178;5629.971850140805;5633.183188437653;5676.545876329967;5681.517071049007;5695.857603559862;5700.458456446631;5736.799212027559;5560.332760068737;5673.205751194836;5677.80127695537;5692.544596432275;5722.62802917809;5776.075827867521;5784.045632470596;5784.305883294031;5802.65184088956;5822.912656310159;4449.976505403711;4480.753558554311;4499.302608095751;4505.954940450619;4527.388802511685;3903.0632648164237;3910.335243008695;3978.204359128186;3989.5810939851476;3991.501062367204;5480;5518.19986102013;5518.227448157261;5526.613137080446;5539.446055394428;5776.537876969833;5792.681402522901;5792.884142317214;5793.536517078624;5827.650340979555;5352.652077614943;5501.092319767274;5539.723013849372;5544.029794785977;5557.666540007613;4965.925511117336;4989.12690279207;4989.426215985136;4992.450830408652;5020.447750747415;5819;6101.694915254308;6108.236470441195;6122.081687746873;6123.877522449526;5697;5782.653040817564;5795.39148389413;5842.123681447817;5870.471657550841;5949.52403807703;5957.4042595740075;5959.4934430573885;5961.850953726018;5962.284525856925;5543;5545.750441230235;5596.916046259228;5658.490735833795;5658.943410566007;5631.549476041825;5736.225609542826;5743.74153163117;5744.109663002241;5775.220345253505;5579.2746942897165;5583.804566840141;5596.944030559643;5599.524040456444;5607.5513958884;5371.140617501181;5547.278853748987;5555.166724991283;5558.360788509373;5606.523445507014;5592.328920529562;5601.327840659147;5604.495595396271;5607.467290607386;5619.80330688424;5660.094384898561;5725.427457254241;5754.856128596819;5765.048766953573;5767.192593037062;5347.491988261109;5487.478689524489;5514.338279406497;5540.778368865362;5609.046462101371 14:34:28 INFO - PROCESS | 3479 | |1;ext.html;621.7512994802079;659.1793217444281;671.3253180553543;674.308833445718;677.7187467201112;32259.51610725838;44916.550834491645;45402.54597454025;45689.31466028012;45859.31211031833;47171.52828471714;47660.523394766045;47667.52332476674;47693.284600731015;47708;8282.461639993411;8937.240334571568;9116.042815504376;9119;10524.631637892675;10370.792584148312;10756.247062705614;10763.569457221702;10764.031237188652;10780.946095269514;10768.300060496082;10823.080038196762;10832.187585931048;10834;10838.891611083907;8370.707025254118;10814.243002989793;10924.672259832218;11203.21577489576;11214.551417943272;10704.839427408595;10762.246642735012;10764.407957562331;10769.299995500267;10772.40751758653;43341.78329108366;43725.78137109326;43731.78134109309;43733.34399984003;43776.781116094535;3526.188976535386;3583.2475180211927;3585.659362360572;3635.182084031072;3684.318401095779;33633.32733345319;34032.6596734032;34093.65906340929;34387;35578.822105889565;4740.905181896377;4766.952330476685;4768.213244814601;4847.85456436304;4847.927281090787;377147;377152;377344.99999999726;378343;378396;36960;58366;59401.405985939586;59468.10797838036;59529.70235148796;37039.81480092582;38957.415638765444;39000.41499377511;39030.609693903265;39060.21879562393;15128.773068403983;15312.846871531365;15337.539873803804;15338.463153789564;15342.616434589225;11919.404029798476;12582.87417125817;12777.297248651228;12792.488300468063;13104.410301536454;8886.066962968924;8894.332925030649;8907.688230911886;8971.416857904216;8980.101989800967;3409.3010932758725;3425.828708564562;3426.794392336468;3429.1941393772445;3458.4466485362223;1072.5120070367964;1122.629532254354;1153.0890596428728;1170.631251155883;1239.4360565942475;32520.83739581334;32827.3434531308;33082;33099;33702.83148584241;1178.7701398227434;1192.8687844337117;1196.353968856825;1196.5632544121333;1205.1864991130951;15163.317650705745;16608.335666573203;17085.31658733637;17546.91226543859;17760.911195444198;666076;674469;674612;675086;677353;62118.378816212164;63216;63273.683631581545;63289.36710632927;63302;1364.1883079567442;1364.4133022800092;1383.889288856889;1418.4751641892565;1480.9259537023106;27211.183664490098;34944.475832863034;34986.82506587451;35373.46939795957;35759.82120089383;58528.12207816971;58707.11939320999;58976.41023589709;59108.40891591029;59168;418408;419434;420293;421250;425866;26214.213573592824;28505.28736781597;29464.852675736485;29743;30206;50308.74845625748;50395.244071338224;50706.49293507018;51603.22595161151;52127.73936130295;40869.38695919504;41081.58918410897;41697.16605667809;41720.37419438772;42576;41005.58994410137;41180.58819411768;41675.7916210417;41715.58284417117;42301;41511.58488415077;42034.78982605068;42513;42684.5731542693;43097.569024309356;36787.63212367842;36810.63189368072;37642.43536346902;38368.04079898025;38374.42438363371;28315.575266371434;28316.15051548457;28406.857965710038;28522.42955140927;28525.28686782847 14:34:28 INFO - PROCESS | 3479 | |2;jquery.html;426.5499897608024;432.2309654946996;433.715916074971;433.7701018460217;439.07136406500246;18529.16618752156;19520.414387568377;20121.19515219391;20589.897050514763;20661.4834629134;17195.226214820334;18037.639247215047;18856.528586785338;18868.339608113718;19603.313884014064;5241.737913104339;5423.755930983115;5448.536874365684;5460.836174914759;5462.9726851365685;4000.5999400059904;5302.204669299597;5369;5706.800261990831;6008.489278411318;6060.272767267934;6089.847753806146;6094.299155597118;6098.969505152468;6099.634021958675;5724;5888.146218798251;5924.496417804492;5938.584299099065;5975;3820.9808950955344;4029.0531725044593;4035.717499775017;5684.2326285951285;5706.115552089433;13140.60578182656;13688.178709277376;13704.794428083587;14142.08076475036;24713.6292955604;2662.5207462656713;2896.232498387929;2995.8052726572705;3139.9686003139905;3504.6670566296416;15310;15792.210389480595;16122.113283769388;16253.51239462818;17219.1390430478;2121.8620789648776;2179.2917301876796;2217.157480157546;2252.583272094668;2256.616375216217;76087;78454;81039.59480202562;100836.49581752044;100907.49546252222;16886.40897568579;18611.720824187647;18899.24403023891;18926.52683682919;19844.107015184352;34817.47773783395;34848.9545313641;35175.296494070484;35195;35310.11724706903;10051.296409251428;10461.476926153662;10631.627893023708;10701.715794104757;10744.892551074388;8771.736847894574;8812.60343284541;8854.822903541894;8896.688615898413;8954.149355811187;9016.819663606822;9221.53892305382;9259.72220833376;9333.133373325361;9365;2724.6049322848075;3487.8604855805993;3532.5937517185853;3533.9293214135573;3749.062734316421;936.2509992006368;997.670768646345;1067.066316972649;1090.432974853088;1123.9494222759995;19262.133204005855;19448.22207111728;19653.213871444983;19690.212391504465;19875;1025.8717660292464;1056.4717641179411;1063.8510608514814;1067.8024565455416;1076.4133547216786;10869.728256793644;11114.944425277983;11136.888631113585;11198.664040078811;11228.719282018015;497120;502659;506460;515379;517832;66441.33558664448;100308;100545;101883.4905825481;101989;1006.3257617396362;1034.4724190662816;1047.9423631700329;1055.298226679265;1059.586761163147;17444.21501032431;17504.73742893883;17769.289228430716;17898.463046108638;17958.91020544941;40714.79642601768;41732.58267417287;42067.368989465795;42539.57460425356;42994.57005429906;55966;57547;57922;58060.419395805504;58343.416565833795;8029;8589.14108589136;8895.4662720237;8998.740176375444;9070.591823367833;8835.734927952171;13112.475500979854;13446.126001809851;13577.11748736329;13853.515126970507;11348.148888833206;12243.816342754688;12421;12470.438830252842;12481.126321157431;11927.582534611247;12014.75970480603;12272.815907761213;12311.75376492483;12437.253764774143;12382.133250672727;12394.256344619353;12478.937605312278;12547.623571292876;12623.81064284018;8793.252573531321;8818.603162857558;9095.590698418455;9116.772080698036;9174.311926605398;12154.696132596402;12322.815157772462;12454.25274483534;12474.937625311815;12528.749425011267 14:34:28 INFO - PROCESS | 3479 | |3;mootools.html;1345.8788709016187;1546.3428043081692;1582.778411022457;1776.6624341375139;1913.6651086059935;8853.203211710945;9137.269018478522;9193.908060919397;9436.480993545352;9471;9200.907990920088;9398.107179817905;9421.43471391717;9423.10480504351;9437.905620943788;2170.381441289233;2390.6892104026538;2464.556379851626;2512.761287677672;2553.872306384683;2550.821442499026;2555.9744402556016;2562.9231123066243;2576.407426291954;2580.3420127867366;2437.6221685638666;2464.2853572464055;2469.1851688942606;2469.2839076667747;2469.753024697525;2148.4628842789302;2490.340059884132;2566.781823545001;2566.8716564171905;2584.3409930467797;2418.879056047208;2433.245693834917;2439.146298795425;2492.4516606346756;2492.95014099717;9710.61157553697;9728.659496917573;9751.512424378752;9753.073458021476;9764.072413120743;5491.807786727485;5598;5609.887802243973;5610.214569960209;5615.803446879339;3540.7875527468436;3604.7476676632646;3695.260947810422;3704.573973992998;3732.253549290153;1314.8224989626374;1332.8867046301077;1334.2661536155174;1349.9527516536873;1354.539456584756;13914.095583787122;13916;13936.303184840819;13949.093308934887;13952.2326272055;5123.948760512421;5132.307138536325;5189.792408303701;5239.685618862881;5259.39516955555;11376.886231137583;11394.487248073856;11407.429628518541;11407.94296028531;11409.201355905174;4788.138135135709;5605.971970140205;5615.859603509945;5616.438356164433;5623.915641265385;4932.7533623319405;5097.46476619957;5111.182210846247;5145.691258524501;5147.897042059138;4410.07388448423;4417.757023363682;4433.445819272591;4492.258777301774;4497.752623605733;1377.572952384764;1383.889288856889;1393.5192358636255;1399.5871217990716;1419.8864090872705;924.8705181274627;1021.0912288063629;1037.4760745823312;1038.8026275007876;1044.6343779677204;6388.616682999035;6484.286728459866;6521.739130434729;6531.216254049449;6540.4767618590395;495.7669895149274;498.91019616468657;503.34313720594974;515.1680036740637;523.5209783048545;4318.201132790444;4434.911301773946;4474.507804141542;4567.680262381601;4577.153226653079;12046.698832529082;12375.876241237653;12463.314517701432;12469.75060498803;12561.434735436744;11692.532298708127;12167.695807604703;12207.755844883053;12434;12438.440270187863;8861.689840855539;8957.776055598531;8986.955065224633;9000.414973026733;9021.32340074497;6353.650549219838;6495.837604059936;6560.27836937946;6588.703508342041;6591.406773390226;11307.151963602599;11600.88399115998;11665.533378664759;11695.473703683185;11728;11545.595904143314;11645.592404266148;11678.474468649101;11786.646400607995;11844.52621895149;7551.244875512405;8308.875366869623;8408.705695300636;8454.1123182065;8740.082291359317;9698.36960597559;9756.46339451337;9770.120689138012;9811.166050885755;9849.064338887794;8440.704575339834;8586.613602388032;8608.182222688834;8640.395172337876;8648.264897483532;8365.456245344034;8442.282405995313;8603.612837422206;8634.007089184825;8744.825103498022;7844.529328240324;7946;7950.4832185907735;7951.165127661512;7952.085510166174;5531;5566.443355664401;5633.492985631313;5647.774089036392;5652.802151924663;5494.917576236279;5534.501894829485;5654.802081927113;5758.366579676316;5795.565332599987 14:34:28 INFO - PROCESS | 3479 | |4;prototype.html;355.236242079529;361.4217252396166;367.2984599415116;369.436609171014;370.6386273383451;5351.180598596477;5429.158480435529;5452.91820622691;5477.698726570037;5536.114221724525;5452.146270268108;5467.480589344016;5478;5479.835604931848;5505.807296744615;4086.0602061525865;4182.184474027566;4280.4221430107;4294.9570504295025;4296.48442186938;4279.251131052069;4295.484541854982;4303.462067241595;4305.892352691192;4314.180305741899;4235.724677895927;4266.637335826458;4320.935185972213;4321.351797230409;4339.804708788096;4122.855700050483;4312.3531470279395;4319.200947824631;4364.934525982113;4372.234858899696;3707.295613833363;3756.5867754547253;3795.2788970095594;3808.7524310919703;3817.1793064491267;5296.523312901819;5322.350071477816;5334.67991920486;5361.946380536184;5401.810936617238;4718.575328220477;4876.292937524075;4934.703917764946;4939.382577177853;4956.479569645171;5662.943370566324;5665.555283402748;5692.48767610917;5709.685967271798;5741.397153298927;4092.4884389451317;4130.958690413087;4149.33610622299;4177.49870015597;4193.853215137486;5644.74598643062;5879.706014699291;5916.704164791786;5962.403759624046;6013.909791353133;4154.667626589926;4210.6841986851105;4212.7472351659;4224.978875105667;4226.344916537942;4325.675574331937;4327.394164816865;4338.284183109751;4347.934780978288;4354.738715677069;4660.580547750718;4732.503087175865;4869.610431165498;4878.487758785347;4903;5584.659681676369;5680.176374425685;5690.089585666274;5737.3688894221605;5741.167530708108;1454.3964254834336;1481.488886334213;1482.1255459279078;1485.1460410264142;1485.1954874827136;921.1755478846395;949.3070058857073;955.9522023898777;963.3545524498603;971.3783178765595;4955.628327875424;4997.225430058346;5014.824481143142;5016.398032236155;5047.41954675217;5183.637145399785;5216.817411390583;5244.639912039597;5257.027449921777;5312.007997001125;4951.455339912607;4992.4039499460805;5022.6233032522705;5215.826439051259;5672.688002159921;3111.5686784079576;3123.406552754969;3140.4190224808485;3141.575887255237;3152.6128503458863;6083.844069626757;6124.234470691164;6128.417800308964;6159.5072394208355;6171.660558669317;5748.396418376094;6010.2186715726675;6049.727762250709;6074.605150665281;6074.908876366858;6225.844353891189;6251.531135164881;6255.280642726054;6272.937270627235;6281.968590157111;5642.7460764266525;5906.173135760911;5920.970395147997;6005.789797357072;6006.828668409618;5798.115612425894;5836.766529338779;5857.8535536610225;5875.823725288248;5900.409959004065;5916.3492015877355;6185.824693308257;6192.566520343533;6260.906086408799;6265.467435268053;4229.429027081304;4242.257604919188;4242.851500197478;4260.44614200152;4281.25078111323;5759.560109972507;5787.884242315046;6039.728212230548;6050.394960503914;6055.424734650202;5730.140478928194;5771.884562308815;5791.598385227342;5792.304923409218;5829.677084062044;5758.942410576008;5761.251037365283;5770.3364113125845;5787.131930210502;5789.478946894799;5540.224368588481;5649.604527683023;5676.325483982153;5677.01304543423;5721.026245945142;5736.225609542658;5743.798967036134;5747.4252574742195;5777.826665200051;5810.854728631818;5468.863278418072;5594.720263986866;5657.43425657431;5659.094544872801;5698.430156984268 14:34:28 INFO - PROCESS | 3479 | |5;yui.html;784.725346128855;810.4529442626226;815.7430409421032;876.1413814461828;901.0898992018068;15311.770323445156;15444.922775386121;16460.588485287873;16683.66632667349;16882.831171688278;15265.236738163103;15364;15398.692026159499;15473.922630386833;15484.69030619387;700.9789706308819;820;839.7228914458215;843.8396704626132;853.5390888919976;830.7258604660448;837.1962915601031;837.7612380471567;838.0990435282096;839.82363703622;886.7694399456124;887.4675194883051;887.6582515731425;888.0453512474083;888.3381880499037;734.9191588925214;857.4255248983166;880.4013270975765;880.7886107334258;884.6063501741728;649.1528555235416;650.5413683353224;651.3258777165611;651.8337823854887;651.9054737063146;16071.598210044842;16081.597960050975;16083.035017898846;16109.919450402673;16125.354985800554;15076.170810605412;15146.091234525964;15304.617384565363;15317.080975141527;15527.534173974798;13248.801267980987;13261.73476530464;13267;13370.39833207508;13437.32813359328;4614.289057870335;4640.164770341337;4650.534946505356;4666.090112428078;4774.40319960005;75417.24582754157;75677.62161189159;75807.24192758113;76550;76761.61619191924;11186.049185819296;11187.216894817284;11534.307941523535;11656.41717914101;11950.940245298718;22780.544389112125;22875.885620572124;22922;23035.424114397276;23053.654195187086;8667.4366166199;8755.299576033902;8783.736487905246;8790.560471976376;8870.423422477648;4720.433547974265;4890.368499598212;4914.213725803854;4967.3294105296045;5033.949660503421;3560.6795388415167;3730.925381492355;3737.4767532545466;3739.9813000934823;3743.157789497341;566.5071387892477;609.4454046817375;635.6726285962733;638.9808305750835;641.1568787045114;596.6628854697083;696.5576858694664;735.6615956659996;749.1946157880301;768.5734417398397;10425.320190703533;10606.469676516142;10637.9468102659;10984.395858227714;11141.442927853575;740.5334639177283;771.124773382204;773.6441237030916;780.7930898311952;784.1922819495928;5033.496650334937;5095.566876815438;5177.58579313654;5191.844244672666;5202.661826981234;80540.19459805444;112764;121497;126065;127803;80945.19054809495;83481;107077;110906;111365.44317278362;94170;94839;95672;95727.04272957321;97669.51165244129;9691.951540242535;9732.70801875945;9783.315167938175;9800.166985806287;9864.21086313079;56035.43964560465;56609.150862737915;56774.7161264191;58716;59268;69886.65056674684;79323.60338198271;82211.5889420549;83854.58072709598;84435;12519.749605008032;13015.349232538525;13289.800652990407;13300.667483312995;13485.056046076681;13882.583522494342;14048.929755351157;14348;14411.207383593584;14866.702665946405;13629.386677599334;13652.931735341259;13746.59978538063;13831.654208644462;14160.645983850487;13504.260763707813;13609.455621775018;13855.099418537762;13915.58253252404;14125.505607303696;12861.899824533313;12956.676083097998;13029.609111726664;13100.541481048118;13179.077464577387;10581.682549523526;10681;10749.89250107489;10910.454477275945;11356.205065645325;11200.663980080612;11294.548218071184;11401.942990284995;11630.592929247436;11701.590444334408 14:34:28 INFO - PROCESS | 3479 | __end_tp_report 14:34:28 INFO - PROCESS | 3479 | __start_cc_report 14:34:28 INFO - PROCESS | 3479 | _x_x_mozilla_cycle_collect,909 14:34:28 INFO - PROCESS | 3479 | __end_cc_report 14:34:28 INFO - PROCESS | 3479 | __startTimestamp1469136868668__endTimestamp 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | ------- Summary: start ------- 14:34:28 INFO - PROCESS | 3479 | Number of tests: 6 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | [#0] dojo.html Cycles:165 Average:5365.40 Median:5547.28 stddev:572.30 (10.3%) stddev-sans-first:550.45 14:34:28 INFO - PROCESS | 3479 | Values: 3291.6 3331.1 3337.3 3351.4 3376.5 5384.9 5492.3 5506.3 5508.5 5523.0 5375.9 5414.5 5417.4 5441.7 5455.1 4801.8 4857.3 4889.8 4913.2 4942.3 4802.7 4863.1 4895.1 4895.3 4900.0 4935.9 5015.9 5016.0 5024.0 5039.3 4805.0 4978.0 4986.8 5014.5 5025.2 4846.8 4873.9 4894.5 4918.3 4946.7 5333.0 5381.8 5381.8 5403.0 5419.2 5533.1 5566.2 5620.7 5816.4 5840.5 5710.8 5761.1 5803.9 5819.4 5819.8 5395.9 5421.2 5425.1 5425.3 5429.5 5739.8 5752.7 5773.4 5896.2 5901.6 5594.0 5612.6 5628.7 5630.0 5633.2 5676.5 5681.5 5695.9 5700.5 5736.8 5560.3 5673.2 5677.8 5692.5 5722.6 5776.1 5784.0 5784.3 5802.7 5822.9 4450.0 4480.8 4499.3 4506.0 4527.4 3903.1 3910.3 3978.2 3989.6 3991.5 5480.0 5518.2 5518.2 5526.6 5539.4 5776.5 5792.7 5792.9 5793.5 5827.7 5352.7 5501.1 5539.7 5544.0 5557.7 4965.9 4989.1 4989.4 4992.5 5020.4 5819.0 6101.7 6108.2 6122.1 6123.9 5697.0 5782.7 5795.4 5842.1 5870.5 5949.5 5957.4 5959.5 5961.9 5962.3 5543.0 5545.8 5596.9 5658.5 5658.9 5631.5 5736.2 5743.7 5744.1 5775.2 5579.3 5583.8 5596.9 5599.5 5607.6 5371.1 5547.3 5555.2 5558.4 5606.5 5592.3 5601.3 5604.5 5607.5 5619.8 5660.1 5725.4 5754.9 5765.0 5767.2 5347.5 5487.5 5514.3 5540.8 5609.0 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | [#1] ext.html Cycles:180 Average:64331.91 Median:207394.72 stddev:135604.36 (65.4%) stddev-sans-first:135900.40 14:34:28 INFO - PROCESS | 3479 | Values: 621.8 659.2 671.3 674.3 677.7 32259.5 44916.6 45402.5 45689.3 45859.3 47171.5 47660.5 47667.5 47693.3 47708.0 8282.5 8937.2 9116.0 9119.0 10524.6 10370.8 10756.2 10763.6 10764.0 10780.9 10768.3 10823.1 10832.2 10834.0 10838.9 8370.7 10814.2 10924.7 11203.2 11214.6 10704.8 10762.2 10764.4 10769.3 10772.4 43341.8 43725.8 43731.8 43733.3 43776.8 3526.2 3583.2 3585.7 3635.2 3684.3 33633.3 34032.7 34093.7 34387.0 35578.8 4740.9 4767.0 4768.2 4847.9 4847.9 377147.0 377152.0 377345.0 378343.0 378396.0 36960.0 58366.0 59401.4 59468.1 59529.7 37039.8 38957.4 39000.4 39030.6 39060.2 15128.8 15312.8 15337.5 15338.5 15342.6 11919.4 12582.9 12777.3 12792.5 13104.4 8886.1 8894.3 8907.7 8971.4 8980.1 3409.3 3425.8 3426.8 3429.2 3458.4 1072.5 1122.6 1153.1 1170.6 1239.4 32520.8 32827.3 33082.0 33099.0 33702.8 1178.8 1192.9 1196.4 1196.6 1205.2 15163.3 16608.3 17085.3 17546.9 17760.9 666076.0 674469.0 674612.0 675086.0 677353.0 62118.4 63216.0 63273.7 63289.4 63302.0 1364.2 1364.4 1383.9 1418.5 1480.9 27211.2 34944.5 34986.8 35373.5 35759.8 58528.1 58707.1 58976.4 59108.4 59168.0 418408.0 419434.0 420293.0 421250.0 425866.0 26214.2 28505.3 29464.9 29743.0 30206.0 50308.7 50395.2 50706.5 51603.2 52127.7 40869.4 41081.6 41697.2 41720.4 42576.0 41005.6 41180.6 41675.8 41715.6 42301.0 41511.6 42034.8 42513.0 42684.6 43097.6 36787.6 36810.6 37642.4 38368.0 38374.4 28315.6 28316.2 28406.9 28522.4 28525.3 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | [#2] jquery.html Cycles:180 Average:30816.47 Median:2254.60 stddev:83699.87 (3712.4%) stddev-sans-first:83903.57 14:34:28 INFO - PROCESS | 3479 | Values: 426.5 432.2 433.7 433.8 439.1 18529.2 19520.4 20121.2 20589.9 20661.5 17195.2 18037.6 18856.5 18868.3 19603.3 5241.7 5423.8 5448.5 5460.8 5463.0 4000.6 5302.2 5369.0 5706.8 6008.5 6060.3 6089.8 6094.3 6099.0 6099.6 5724.0 5888.1 5924.5 5938.6 5975.0 3821.0 4029.1 4035.7 5684.2 5706.1 13140.6 13688.2 13704.8 14142.1 24713.6 2662.5 2896.2 2995.8 3140.0 3504.7 15310.0 15792.2 16122.1 16253.5 17219.1 2121.9 2179.3 2217.2 2252.6 2256.6 76087.0 78454.0 81039.6 100836.5 100907.5 16886.4 18611.7 18899.2 18926.5 19844.1 34817.5 34849.0 35175.3 35195.0 35310.1 10051.3 10461.5 10631.6 10701.7 10744.9 8771.7 8812.6 8854.8 8896.7 8954.1 9016.8 9221.5 9259.7 9333.1 9365.0 2724.6 3487.9 3532.6 3533.9 3749.1 936.3 997.7 1067.1 1090.4 1123.9 19262.1 19448.2 19653.2 19690.2 19875.0 1025.9 1056.5 1063.9 1067.8 1076.4 10869.7 11114.9 11136.9 11198.7 11228.7 497120.0 502659.0 506460.0 515379.0 517832.0 66441.3 100308.0 100545.0 101883.5 101989.0 1006.3 1034.5 1047.9 1055.3 1059.6 17444.2 17504.7 17769.3 17898.5 17958.9 40714.8 41732.6 42067.4 42539.6 42994.6 55966.0 57547.0 57922.0 58060.4 58343.4 8029.0 8589.1 8895.5 8998.7 9070.6 8835.7 13112.5 13446.1 13577.1 13853.5 11348.1 12243.8 12421.0 12470.4 12481.1 11927.6 12014.8 12272.8 12311.8 12437.3 12382.1 12394.3 12478.9 12547.6 12623.8 8793.3 8818.6 9095.6 9116.8 9174.3 12154.7 12322.8 12454.3 12474.9 12528.7 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | [#3] mootools.html Cycles:180 Average:6390.62 Median:2714.26 stddev:3749.63 (138.1%) stddev-sans-first:3740.98 14:34:28 INFO - PROCESS | 3479 | Values: 1345.9 1546.3 1582.8 1776.7 1913.7 8853.2 9137.3 9193.9 9436.5 9471.0 9200.9 9398.1 9421.4 9423.1 9437.9 2170.4 2390.7 2464.6 2512.8 2553.9 2550.8 2556.0 2562.9 2576.4 2580.3 2437.6 2464.3 2469.2 2469.3 2469.8 2148.5 2490.3 2566.8 2566.9 2584.3 2418.9 2433.2 2439.1 2492.5 2493.0 9710.6 9728.7 9751.5 9753.1 9764.1 5491.8 5598.0 5609.9 5610.2 5615.8 3540.8 3604.7 3695.3 3704.6 3732.3 1314.8 1332.9 1334.3 1350.0 1354.5 13914.1 13916.0 13936.3 13949.1 13952.2 5123.9 5132.3 5189.8 5239.7 5259.4 11376.9 11394.5 11407.4 11407.9 11409.2 4788.1 5606.0 5615.9 5616.4 5623.9 4932.8 5097.5 5111.2 5145.7 5147.9 4410.1 4417.8 4433.4 4492.3 4497.8 1377.6 1383.9 1393.5 1399.6 1419.9 924.9 1021.1 1037.5 1038.8 1044.6 6388.6 6484.3 6521.7 6531.2 6540.5 495.8 498.9 503.3 515.2 523.5 4318.2 4434.9 4474.5 4567.7 4577.2 12046.7 12375.9 12463.3 12469.8 12561.4 11692.5 12167.7 12207.8 12434.0 12438.4 8861.7 8957.8 8987.0 9000.4 9021.3 6353.7 6495.8 6560.3 6588.7 6591.4 11307.2 11600.9 11665.5 11695.5 11728.0 11545.6 11645.6 11678.5 11786.6 11844.5 7551.2 8308.9 8408.7 8454.1 8740.1 9698.4 9756.5 9770.1 9811.2 9849.1 8440.7 8586.6 8608.2 8640.4 8648.3 8365.5 8442.3 8603.6 8634.0 8744.8 7844.5 7946.0 7950.5 7951.2 7952.1 5531.0 5566.4 5633.5 5647.8 5652.8 5494.9 5534.5 5654.8 5758.4 5795.6 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | [#4] prototype.html Cycles:180 Average:4812.38 Median:5440.65 stddev:1410.96 (25.9%) stddev-sans-first:1374.68 14:34:28 INFO - PROCESS | 3479 | Values: 355.2 361.4 367.3 369.4 370.6 5351.2 5429.2 5452.9 5477.7 5536.1 5452.1 5467.5 5478.0 5479.8 5505.8 4086.1 4182.2 4280.4 4295.0 4296.5 4279.3 4295.5 4303.5 4305.9 4314.2 4235.7 4266.6 4320.9 4321.4 4339.8 4122.9 4312.4 4319.2 4364.9 4372.2 3707.3 3756.6 3795.3 3808.8 3817.2 5296.5 5322.4 5334.7 5361.9 5401.8 4718.6 4876.3 4934.7 4939.4 4956.5 5662.9 5665.6 5692.5 5709.7 5741.4 4092.5 4131.0 4149.3 4177.5 4193.9 5644.7 5879.7 5916.7 5962.4 6013.9 4154.7 4210.7 4212.7 4225.0 4226.3 4325.7 4327.4 4338.3 4347.9 4354.7 4660.6 4732.5 4869.6 4878.5 4903.0 5584.7 5680.2 5690.1 5737.4 5741.2 1454.4 1481.5 1482.1 1485.1 1485.2 921.2 949.3 956.0 963.4 971.4 4955.6 4997.2 5014.8 5016.4 5047.4 5183.6 5216.8 5244.6 5257.0 5312.0 4951.5 4992.4 5022.6 5215.8 5672.7 3111.6 3123.4 3140.4 3141.6 3152.6 6083.8 6124.2 6128.4 6159.5 6171.7 5748.4 6010.2 6049.7 6074.6 6074.9 6225.8 6251.5 6255.3 6272.9 6282.0 5642.7 5906.2 5921.0 6005.8 6006.8 5798.1 5836.8 5857.9 5875.8 5900.4 5916.3 6185.8 6192.6 6260.9 6265.5 4229.4 4242.3 4242.9 4260.4 4281.3 5759.6 5787.9 6039.7 6050.4 6055.4 5730.1 5771.9 5791.6 5792.3 5829.7 5758.9 5761.3 5770.3 5787.1 5789.5 5540.2 5649.6 5676.3 5677.0 5721.0 5736.2 5743.8 5747.4 5777.8 5810.9 5468.9 5594.7 5657.4 5659.1 5698.4 14:34:28 INFO - PROCESS | 3479 | 14:34:28 INFO - PROCESS | 3479 | [#5] yui.html Cycles:180 Average:21591.87 Median:4693.26 stddev:31010.49 (660.7%) stddev-sans-first:31058.13 14:34:28 INFO - PROCESS | 3479 | Values: 784.7 810.5 815.7 876.1 901.1 15311.8 15444.9 16460.6 16683.7 16882.8 15265.2 15364.0 15398.7 15473.9 15484.7 701.0 820.0 839.7 843.8 853.5 830.7 837.2 837.8 838.1 839.8 886.8 887.5 887.7 888.0 888.3 734.9 857.4 880.4 880.8 884.6 649.2 650.5 651.3 651.8 651.9 16071.6 16081.6 16083.0 16109.9 16125.4 15076.2 15146.1 15304.6 15317.1 15527.5 13248.8 13261.7 13267.0 13370.4 13437.3 4614.3 4640.2 4650.5 4666.1 4774.4 75417.2 75677.6 75807.2 76550.0 76761.6 11186.0 11187.2 11534.3 11656.4 11950.9 22780.5 22875.9 22922.0 23035.4 23053.7 8667.4 8755.3 8783.7 8790.6 8870.4 4720.4 4890.4 4914.2 4967.3 5033.9 3560.7 3730.9 3737.5 3740.0 3743.2 566.5 609.4 635.7 639.0 641.2 596.7 696.6 735.7 749.2 768.6 10425.3 10606.5 10637.9 10984.4 11141.4 740.5 771.1 773.6 780.8 784.2 5033.5 5095.6 5177.6 5191.8 5202.7 80540.2 112764.0 121497.0 126065.0 127803.0 80945.2 83481.0 107077.0 110906.0 111365.4 94170.0 94839.0 95672.0 95727.0 97669.5 9692.0 9732.7 9783.3 9800.2 9864.2 56035.4 56609.2 56774.7 58716.0 59268.0 69886.7 79323.6 82211.6 83854.6 84435.0 12519.7 13015.3 13289.8 13300.7 13485.1 13882.6 14048.9 14348.0 14411.2 14866.7 13629.4 13652.9 13746.6 13831.7 14160.6 13504.3 13609.5 13855.1 13915.6 14125.5 12861.9 12956.7 13029.6 13100.5 13179.1 10581.7 10681.0 10749.9 10910.5 11356.2 11200.7 11294.5 11401.9 11630.6 11701.6 14:34:28 INFO - PROCESS | 3479 | -------- Summary: end -------- 14:34:28 INFO - PROCESS | 3479 | 14:34:29 INFO - TEST-INFO | 3479: exit 0 14:34:29 INFO - TEST-OK | dromaeo_css | took 1112493ms 14:34:29 INFO - TEST-START | kraken 14:34:29 INFO - operating with platform_type : linux_ 14:34:29 INFO - Initialising browser for kraken test... 14:34:29 INFO - TEST-INFO | started process 3671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8jyEl/profile http://localhost:36815/getInfo.html) 14:34:33 INFO - PROCESS | 3671 | __metrics Screen width/height:1600/1200 14:34:33 INFO - PROCESS | 3671 | colorDepth:24 14:34:33 INFO - PROCESS | 3671 | Browser inner width/height: 1024/697 14:34:33 INFO - PROCESS | 3671 | __metrics 14:34:34 INFO - PROCESS | 3671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:34:34 ERROR - PROCESS | 3671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:34:35 INFO - TEST-INFO | 3671: exit 0 14:34:35 INFO - Browser initialized. 14:34:35 INFO - Running cycle 1/1 for kraken test... 14:34:35 INFO - TEST-INFO | started process 3759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8jyEl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:47 INFO - PROCESS | 3759 | RSS: Main: 145879040 14:34:47 INFO - PROCESS | 3759 | 14:34:49 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:50 INFO - PROCESS | 3759 | RSS: Main: 194801664 14:34:50 INFO - PROCESS | 3759 | 14:34:52 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-dft) 14:34:53 INFO - PROCESS | 3759 | RSS: Main: 193519616 14:34:53 INFO - PROCESS | 3759 | 14:34:56 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-fft) 14:34:57 INFO - PROCESS | 3759 | RSS: Main: 278814720 14:34:57 INFO - PROCESS | 3759 | 14:34:59 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-oscillator) 14:34:59 INFO - PROCESS | 3759 | RSS: Main: 187854848 14:34:59 INFO - PROCESS | 3759 | 14:35:01 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36815/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:02 INFO - PROCESS | 3759 | RSS: Main: 188370944 14:35:02 INFO - PROCESS | 3759 | 14:35:05 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36815/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:06 INFO - PROCESS | 3759 | RSS: Main: 223191040 14:35:06 INFO - PROCESS | 3759 | 14:35:09 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36815/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:10 INFO - PROCESS | 3759 | RSS: Main: 223322112 14:35:10 INFO - PROCESS | 3759 | 14:35:12 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36815/tests/kraken/driver.html?testName=json-parse-financial) 14:35:13 INFO - PROCESS | 3759 | RSS: Main: 222912512 14:35:13 INFO - PROCESS | 3759 | 14:35:14 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36815/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:15 INFO - PROCESS | 3759 | RSS: Main: 201297920 14:35:15 INFO - PROCESS | 3759 | 14:35:17 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:17 INFO - PROCESS | 3759 | RSS: Main: 203010048 14:35:17 INFO - PROCESS | 3759 | 14:35:19 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:20 INFO - PROCESS | 3759 | RSS: Main: 208969728 14:35:20 INFO - PROCESS | 3759 | 14:35:22 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:23 INFO - PROCESS | 3759 | RSS: Main: 214585344 14:35:23 INFO - PROCESS | 3759 | 14:35:26 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:26 INFO - PROCESS | 3759 | RSS: Main: 213389312 14:35:26 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36815/tests/kraken/driver.html?testName=ai-astar) 14:35:28 INFO - PROCESS | 3759 | RSS: Main: 256483328 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | __start_tp_report 14:35:28 INFO - PROCESS | 3759 | _x_x_mozilla_page_load 14:35:28 INFO - PROCESS | 3759 | _x_x_mozilla_page_load_details 14:35:28 INFO - PROCESS | 3759 | |i|pagename|runs| 14:35:28 INFO - PROCESS | 3759 | |0;ai-astar;110;103;109;110;110;110;111;111;109;110 14:35:28 INFO - PROCESS | 3759 | |1;audio-beat-detection;155;125;128;177;128;126;153;124;166;124 14:35:28 INFO - PROCESS | 3759 | |2;audio-dft;161;159;162;159;160;161;161;161;162;160 14:35:28 INFO - PROCESS | 3759 | |3;audio-fft;74;75;75;133;76;75;75;73;95;74 14:35:28 INFO - PROCESS | 3759 | |4;audio-oscillator;83;85;126;83;84;84;124;83;84;136 14:35:28 INFO - PROCESS | 3759 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;117;117 14:35:28 INFO - PROCESS | 3759 | |6;imaging-darkroom;146;146;145;145;147;145;146;146;147;145 14:35:28 INFO - PROCESS | 3759 | |7;imaging-desaturate;94;95;95;94;95;94;95;94;95;94 14:35:28 INFO - PROCESS | 3759 | |8;json-parse-financial;49;53;49;50;51;52;51;51;51;52 14:35:28 INFO - PROCESS | 3759 | |9;json-stringify-tinderbox;62;60;60;60;61;60;59;59;60;60 14:35:28 INFO - PROCESS | 3759 | |10;stanford-crypto-aes;77;77;81;78;76;79;77;77;124;83 14:35:28 INFO - PROCESS | 3759 | |11;stanford-crypto-ccm;127;118;118;130;126;117;119;131;121;127 14:35:28 INFO - PROCESS | 3759 | |12;stanford-crypto-pbkdf2;152;150;148;151;150;150;151;149;156;150 14:35:28 INFO - PROCESS | 3759 | |13;stanford-crypto-sha256-iterative;62;61;61;65;60;61;60;59;63;59 14:35:28 INFO - PROCESS | 3759 | __end_tp_report 14:35:28 INFO - PROCESS | 3759 | __start_cc_report 14:35:28 INFO - PROCESS | 3759 | _x_x_mozilla_cycle_collect,1563 14:35:28 INFO - PROCESS | 3759 | __end_cc_report 14:35:28 INFO - PROCESS | 3759 | __startTimestamp1469136928593__endTimestamp 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | ------- Summary: start ------- 14:35:28 INFO - PROCESS | 3759 | Number of tests: 14 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.31 (2.1%) stddev-sans-first:2.44 14:35:28 INFO - PROCESS | 3759 | Values: 110.0 103.0 109.0 110.0 110.0 110.0 111.0 111.0 109.0 110.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:140.50 stddev:20.16 (14.3%) stddev-sans-first:20.69 14:35:28 INFO - PROCESS | 3759 | Values: 155.0 125.0 128.0 177.0 128.0 126.0 153.0 124.0 166.0 124.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 14:35:28 INFO - PROCESS | 3759 | Values: 161.0 159.0 162.0 159.0 160.0 161.0 161.0 161.0 162.0 160.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:18.88 (25.2%) stddev-sans-first:19.77 14:35:28 INFO - PROCESS | 3759 | Values: 74.0 75.0 75.0 133.0 76.0 75.0 75.0 73.0 95.0 74.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:83.50 stddev:21.93 (26.3%) stddev-sans-first:22.65 14:35:28 INFO - PROCESS | 3759 | Values: 83.0 85.0 126.0 83.0 84.0 84.0 124.0 83.0 84.0 136.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:35:28 INFO - PROCESS | 3759 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:35:28 INFO - PROCESS | 3759 | Values: 146.0 146.0 145.0 145.0 147.0 145.0 146.0 146.0 147.0 145.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:35:28 INFO - PROCESS | 3759 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.29 (2.5%) stddev-sans-first:1.17 14:35:28 INFO - PROCESS | 3759 | Values: 49.0 53.0 49.0 50.0 51.0 52.0 51.0 51.0 51.0 52.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.88 (1.5%) stddev-sans-first:0.60 14:35:28 INFO - PROCESS | 3759 | Values: 62.0 60.0 60.0 60.0 61.0 60.0 59.0 59.0 60.0 60.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:77.50 stddev:14.60 (18.8%) stddev-sans-first:15.33 14:35:28 INFO - PROCESS | 3759 | Values: 77.0 77.0 81.0 78.0 76.0 79.0 77.0 77.0 124.0 83.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:126.50 stddev:5.36 (4.2%) stddev-sans-first:5.52 14:35:28 INFO - PROCESS | 3759 | Values: 127.0 118.0 118.0 130.0 126.0 117.0 119.0 131.0 121.0 127.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:150.50 stddev:2.16 (1.4%) stddev-sans-first:2.24 14:35:28 INFO - PROCESS | 3759 | Values: 152.0 150.0 148.0 151.0 150.0 150.0 151.0 149.0 156.0 150.0 14:35:28 INFO - PROCESS | 3759 | 14:35:28 INFO - PROCESS | 3759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:1.85 (3.0%) stddev-sans-first:1.94 14:35:28 INFO - PROCESS | 3759 | Values: 62.0 61.0 61.0 65.0 60.0 61.0 60.0 59.0 63.0 59.0 14:35:28 INFO - PROCESS | 3759 | -------- Summary: end -------- 14:35:28 INFO - PROCESS | 3759 | 14:35:29 INFO - TEST-INFO | 3759: exit 0 14:35:29 INFO - TEST-OK | kraken | took 60170ms 14:35:29 INFO - SUITE-END | took 1172s 14:35:29 INFO - Completed test suite (00:19:32) 14:35:29 INFO - javascript benchmark 14:35:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.6379198288187, 3331.0673011556755, 3337.315850250699, 3351.413502637041, 3376.5104059911314, 5384.8923021539595, 5492.313460817398, 5506.284183056202, 5508.504234618884, 5523.033469142899, 5375.919361209575, 5414.512693857552, 5417.404085550586, 5441.7279136043235, 5455.099908515091, 4801.783919723621, 4857.2714092886, 4889.804407823683, 4913.164761990471, 4942.283368911506, 4802.663813533054, 4863.14894893394, 4895.069936712031, 4895.290182923474, 4899.951000489985, 4935.901281974358, 5015.924761128586, 5016.0, 5023.974880125613, 5039.344885164924, 4804.95195048052, 4977.975110124463, 4986.800527978913, 5014.473480284572, 5025.246213068032, 4846.75766211688, 4873.902521949542, 4894.461609223018, 4918.311436398907, 4946.72792996385, 5332.9733351333, 5381.7578208980685, 5381.838544843661, 5402.972985135049, 5419.241306217133, 5533.142362933751, 5566.192902029183, 5620.747066382022, 5816.360200377955, 5840.474357307863, 5710.800121995751, 5761.107028410603, 5803.854903627401, 5819.388964158745, 5819.79630712923, 5395.865103372447, 5421.213923981, 5425.131978883399, 5425.321834770653, 5429.53848922842, 5739.827805165852, 5752.654840709571, 5773.39379365169, 5896.204012458264, 5901.645901245939, 5594.0, 5612.607117501817, 5628.71856407178, 5629.971850140805, 5633.183188437653, 5676.545876329967, 5681.517071049007, 5695.857603559862, 5700.458456446631, 5736.799212027559, 5560.332760068737, 5673.205751194836, 5677.80127695537, 5692.544596432275, 5722.62802917809, 5776.075827867521, 5784.045632470596, 5784.305883294031, 5802.65184088956, 5822.912656310159, 4449.976505403711, 4480.753558554311, 4499.302608095751, 4505.954940450619, 4527.388802511685, 3903.0632648164237, 3910.335243008695, 3978.204359128186, 3989.5810939851476, 3991.501062367204, 5480.0, 5518.19986102013, 5518.227448157261, 5526.613137080446, 5539.446055394428, 5776.537876969833, 5792.681402522901, 5792.884142317214, 5793.536517078624, 5827.650340979555, 5352.652077614943, 5501.092319767274, 5539.723013849372, 5544.029794785977, 5557.666540007613, 4965.925511117336, 4989.12690279207, 4989.426215985136, 4992.450830408652, 5020.447750747415, 5819.0, 6101.694915254308, 6108.236470441195, 6122.081687746873, 6123.877522449526, 5697.0, 5782.653040817564, 5795.39148389413, 5842.123681447817, 5870.471657550841, 5949.52403807703, 5957.4042595740075, 5959.4934430573885, 5961.850953726018, 5962.284525856925, 5543.0, 5545.750441230235, 5596.916046259228, 5658.490735833795, 5658.943410566007, 5631.549476041825, 5736.225609542826, 5743.74153163117, 5744.109663002241, 5775.220345253505, 5579.2746942897165, 5583.804566840141, 5596.944030559643, 5599.524040456444, 5607.5513958884, 5371.140617501181, 5547.278853748987, 5555.166724991283, 5558.360788509373, 5606.523445507014, 5592.328920529562, 5601.327840659147, 5604.495595396271, 5607.467290607386, 5619.80330688424, 5660.094384898561, 5725.427457254241, 5754.856128596819, 5765.048766953573, 5767.192593037062, 5347.491988261109, 5487.478689524489, 5514.338279406497, 5540.778368865362, 5609.046462101371], "value": 5330.029187476389, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.7512994802079, 659.1793217444281, 671.3253180553543, 674.308833445718, 677.7187467201112, 32259.51610725838, 44916.550834491645, 45402.54597454025, 45689.31466028012, 45859.31211031833, 47171.52828471714, 47660.523394766045, 47667.52332476674, 47693.284600731015, 47708.0, 8282.461639993411, 8937.240334571568, 9116.042815504376, 9119.0, 10524.631637892675, 10370.792584148312, 10756.247062705614, 10763.569457221702, 10764.031237188652, 10780.946095269514, 10768.300060496082, 10823.080038196762, 10832.187585931048, 10834.0, 10838.891611083907, 8370.707025254118, 10814.243002989793, 10924.672259832218, 11203.21577489576, 11214.551417943272, 10704.839427408595, 10762.246642735012, 10764.407957562331, 10769.299995500267, 10772.40751758653, 43341.78329108366, 43725.78137109326, 43731.78134109309, 43733.34399984003, 43776.781116094535, 3526.188976535386, 3583.2475180211927, 3585.659362360572, 3635.182084031072, 3684.318401095779, 33633.32733345319, 34032.6596734032, 34093.65906340929, 34387.0, 35578.822105889565, 4740.905181896377, 4766.952330476685, 4768.213244814601, 4847.85456436304, 4847.927281090787, 377147.0, 377152.0, 377344.99999999726, 378343.0, 378396.0, 36960.0, 58366.0, 59401.405985939586, 59468.10797838036, 59529.70235148796, 37039.81480092582, 38957.415638765444, 39000.41499377511, 39030.609693903265, 39060.21879562393, 15128.773068403983, 15312.846871531365, 15337.539873803804, 15338.463153789564, 15342.616434589225, 11919.404029798476, 12582.87417125817, 12777.297248651228, 12792.488300468063, 13104.410301536454, 8886.066962968924, 8894.332925030649, 8907.688230911886, 8971.416857904216, 8980.101989800967, 3409.3010932758725, 3425.828708564562, 3426.794392336468, 3429.1941393772445, 3458.4466485362223, 1072.5120070367964, 1122.629532254354, 1153.0890596428728, 1170.631251155883, 1239.4360565942475, 32520.83739581334, 32827.3434531308, 33082.0, 33099.0, 33702.83148584241, 1178.7701398227434, 1192.8687844337117, 1196.353968856825, 1196.5632544121333, 1205.1864991130951, 15163.317650705745, 16608.335666573203, 17085.31658733637, 17546.91226543859, 17760.911195444198, 666076.0, 674469.0, 674612.0, 675086.0, 677353.0, 62118.378816212164, 63216.0, 63273.683631581545, 63289.36710632927, 63302.0, 1364.1883079567442, 1364.4133022800092, 1383.889288856889, 1418.4751641892565, 1480.9259537023106, 27211.183664490098, 34944.475832863034, 34986.82506587451, 35373.46939795957, 35759.82120089383, 58528.12207816971, 58707.11939320999, 58976.41023589709, 59108.40891591029, 59168.0, 418408.0, 419434.0, 420293.0, 421250.0, 425866.0, 26214.213573592824, 28505.28736781597, 29464.852675736485, 29743.0, 30206.0, 50308.74845625748, 50395.244071338224, 50706.49293507018, 51603.22595161151, 52127.73936130295, 40869.38695919504, 41081.58918410897, 41697.16605667809, 41720.37419438772, 42576.0, 41005.58994410137, 41180.58819411768, 41675.7916210417, 41715.58284417117, 42301.0, 41511.58488415077, 42034.78982605068, 42513.0, 42684.5731542693, 43097.569024309356, 36787.63212367842, 36810.63189368072, 37642.43536346902, 38368.04079898025, 38374.42438363371, 28315.575266371434, 28316.15051548457, 28406.857965710038, 28522.42955140927, 28525.28686782847], "value": 20131.437168795335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.5499897608024, 432.2309654946996, 433.715916074971, 433.7701018460217, 439.07136406500246, 18529.16618752156, 19520.414387568377, 20121.19515219391, 20589.897050514763, 20661.4834629134, 17195.226214820334, 18037.639247215047, 18856.528586785338, 18868.339608113718, 19603.313884014064, 5241.737913104339, 5423.755930983115, 5448.536874365684, 5460.836174914759, 5462.9726851365685, 4000.5999400059904, 5302.204669299597, 5369.0, 5706.800261990831, 6008.489278411318, 6060.272767267934, 6089.847753806146, 6094.299155597118, 6098.969505152468, 6099.634021958675, 5724.0, 5888.146218798251, 5924.496417804492, 5938.584299099065, 5975.0, 3820.9808950955344, 4029.0531725044593, 4035.717499775017, 5684.2326285951285, 5706.115552089433, 13140.60578182656, 13688.178709277376, 13704.794428083587, 14142.08076475036, 24713.6292955604, 2662.5207462656713, 2896.232498387929, 2995.8052726572705, 3139.9686003139905, 3504.6670566296416, 15310.0, 15792.210389480595, 16122.113283769388, 16253.51239462818, 17219.1390430478, 2121.8620789648776, 2179.2917301876796, 2217.157480157546, 2252.583272094668, 2256.616375216217, 76087.0, 78454.0, 81039.59480202562, 100836.49581752044, 100907.49546252222, 16886.40897568579, 18611.720824187647, 18899.24403023891, 18926.52683682919, 19844.107015184352, 34817.47773783395, 34848.9545313641, 35175.296494070484, 35195.0, 35310.11724706903, 10051.296409251428, 10461.476926153662, 10631.627893023708, 10701.715794104757, 10744.892551074388, 8771.736847894574, 8812.60343284541, 8854.822903541894, 8896.688615898413, 8954.149355811187, 9016.819663606822, 9221.53892305382, 9259.72220833376, 9333.133373325361, 9365.0, 2724.6049322848075, 3487.8604855805993, 3532.5937517185853, 3533.9293214135573, 3749.062734316421, 936.2509992006368, 997.670768646345, 1067.066316972649, 1090.432974853088, 1123.9494222759995, 19262.133204005855, 19448.22207111728, 19653.213871444983, 19690.212391504465, 19875.0, 1025.8717660292464, 1056.4717641179411, 1063.8510608514814, 1067.8024565455416, 1076.4133547216786, 10869.728256793644, 11114.944425277983, 11136.888631113585, 11198.664040078811, 11228.719282018015, 497120.0, 502659.0, 506460.0, 515379.0, 517832.0, 66441.33558664448, 100308.0, 100545.0, 101883.4905825481, 101989.0, 1006.3257617396362, 1034.4724190662816, 1047.9423631700329, 1055.298226679265, 1059.586761163147, 17444.21501032431, 17504.73742893883, 17769.289228430716, 17898.463046108638, 17958.91020544941, 40714.79642601768, 41732.58267417287, 42067.368989465795, 42539.57460425356, 42994.57005429906, 55966.0, 57547.0, 57922.0, 58060.419395805504, 58343.416565833795, 8029.0, 8589.14108589136, 8895.4662720237, 8998.740176375444, 9070.591823367833, 8835.734927952171, 13112.475500979854, 13446.126001809851, 13577.11748736329, 13853.515126970507, 11348.148888833206, 12243.816342754688, 12421.0, 12470.438830252842, 12481.126321157431, 11927.582534611247, 12014.75970480603, 12272.815907761213, 12311.75376492483, 12437.253764774143, 12382.133250672727, 12394.256344619353, 12478.937605312278, 12547.623571292876, 12623.81064284018, 8793.252573531321, 8818.603162857558, 9095.590698418455, 9116.772080698036, 9174.311926605398, 12154.696132596402, 12322.815157772462, 12454.25274483534, 12474.937625311815, 12528.749425011267], "value": 10263.715846824147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.8788709016187, 1546.3428043081692, 1582.778411022457, 1776.6624341375139, 1913.6651086059935, 8853.203211710945, 9137.269018478522, 9193.908060919397, 9436.480993545352, 9471.0, 9200.907990920088, 9398.107179817905, 9421.43471391717, 9423.10480504351, 9437.905620943788, 2170.381441289233, 2390.6892104026538, 2464.556379851626, 2512.761287677672, 2553.872306384683, 2550.821442499026, 2555.9744402556016, 2562.9231123066243, 2576.407426291954, 2580.3420127867366, 2437.6221685638666, 2464.2853572464055, 2469.1851688942606, 2469.2839076667747, 2469.753024697525, 2148.4628842789302, 2490.340059884132, 2566.781823545001, 2566.8716564171905, 2584.3409930467797, 2418.879056047208, 2433.245693834917, 2439.146298795425, 2492.4516606346756, 2492.95014099717, 9710.61157553697, 9728.659496917573, 9751.512424378752, 9753.073458021476, 9764.072413120743, 5491.807786727485, 5598.0, 5609.887802243973, 5610.214569960209, 5615.803446879339, 3540.7875527468436, 3604.7476676632646, 3695.260947810422, 3704.573973992998, 3732.253549290153, 1314.8224989626374, 1332.8867046301077, 1334.2661536155174, 1349.9527516536873, 1354.539456584756, 13914.095583787122, 13916.0, 13936.303184840819, 13949.093308934887, 13952.2326272055, 5123.948760512421, 5132.307138536325, 5189.792408303701, 5239.685618862881, 5259.39516955555, 11376.886231137583, 11394.487248073856, 11407.429628518541, 11407.94296028531, 11409.201355905174, 4788.138135135709, 5605.971970140205, 5615.859603509945, 5616.438356164433, 5623.915641265385, 4932.7533623319405, 5097.46476619957, 5111.182210846247, 5145.691258524501, 5147.897042059138, 4410.07388448423, 4417.757023363682, 4433.445819272591, 4492.258777301774, 4497.752623605733, 1377.572952384764, 1383.889288856889, 1393.5192358636255, 1399.5871217990716, 1419.8864090872705, 924.8705181274627, 1021.0912288063629, 1037.4760745823312, 1038.8026275007876, 1044.6343779677204, 6388.616682999035, 6484.286728459866, 6521.739130434729, 6531.216254049449, 6540.4767618590395, 495.7669895149274, 498.91019616468657, 503.34313720594974, 515.1680036740637, 523.5209783048545, 4318.201132790444, 4434.911301773946, 4474.507804141542, 4567.680262381601, 4577.153226653079, 12046.698832529082, 12375.876241237653, 12463.314517701432, 12469.75060498803, 12561.434735436744, 11692.532298708127, 12167.695807604703, 12207.755844883053, 12434.0, 12438.440270187863, 8861.689840855539, 8957.776055598531, 8986.955065224633, 9000.414973026733, 9021.32340074497, 6353.650549219838, 6495.837604059936, 6560.27836937946, 6588.703508342041, 6591.406773390226, 11307.151963602599, 11600.88399115998, 11665.533378664759, 11695.473703683185, 11728.0, 11545.595904143314, 11645.592404266148, 11678.474468649101, 11786.646400607995, 11844.52621895149, 7551.244875512405, 8308.875366869623, 8408.705695300636, 8454.1123182065, 8740.082291359317, 9698.36960597559, 9756.46339451337, 9770.120689138012, 9811.166050885755, 9849.064338887794, 8440.704575339834, 8586.613602388032, 8608.182222688834, 8640.395172337876, 8648.264897483532, 8365.456245344034, 8442.282405995313, 8603.612837422206, 8634.007089184825, 8744.825103498022, 7844.529328240324, 7946.0, 7950.4832185907735, 7951.165127661512, 7952.085510166174, 5531.0, 5566.443355664401, 5633.492985631313, 5647.774089036392, 5652.802151924663, 5494.917576236279, 5534.501894829485, 5654.802081927113, 5758.366579676316, 5795.565332599987], "value": 4986.929260526992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.236242079529, 361.4217252396166, 367.2984599415116, 369.436609171014, 370.6386273383451, 5351.180598596477, 5429.158480435529, 5452.91820622691, 5477.698726570037, 5536.114221724525, 5452.146270268108, 5467.480589344016, 5478.0, 5479.835604931848, 5505.807296744615, 4086.0602061525865, 4182.184474027566, 4280.4221430107, 4294.9570504295025, 4296.48442186938, 4279.251131052069, 4295.484541854982, 4303.462067241595, 4305.892352691192, 4314.180305741899, 4235.724677895927, 4266.637335826458, 4320.935185972213, 4321.351797230409, 4339.804708788096, 4122.855700050483, 4312.3531470279395, 4319.200947824631, 4364.934525982113, 4372.234858899696, 3707.295613833363, 3756.5867754547253, 3795.2788970095594, 3808.7524310919703, 3817.1793064491267, 5296.523312901819, 5322.350071477816, 5334.67991920486, 5361.946380536184, 5401.810936617238, 4718.575328220477, 4876.292937524075, 4934.703917764946, 4939.382577177853, 4956.479569645171, 5662.943370566324, 5665.555283402748, 5692.48767610917, 5709.685967271798, 5741.397153298927, 4092.4884389451317, 4130.958690413087, 4149.33610622299, 4177.49870015597, 4193.853215137486, 5644.74598643062, 5879.706014699291, 5916.704164791786, 5962.403759624046, 6013.909791353133, 4154.667626589926, 4210.6841986851105, 4212.7472351659, 4224.978875105667, 4226.344916537942, 4325.675574331937, 4327.394164816865, 4338.284183109751, 4347.934780978288, 4354.738715677069, 4660.580547750718, 4732.503087175865, 4869.610431165498, 4878.487758785347, 4903.0, 5584.659681676369, 5680.176374425685, 5690.089585666274, 5737.3688894221605, 5741.167530708108, 1454.3964254834336, 1481.488886334213, 1482.1255459279078, 1485.1460410264142, 1485.1954874827136, 921.1755478846395, 949.3070058857073, 955.9522023898777, 963.3545524498603, 971.3783178765595, 4955.628327875424, 4997.225430058346, 5014.824481143142, 5016.398032236155, 5047.41954675217, 5183.637145399785, 5216.817411390583, 5244.639912039597, 5257.027449921777, 5312.007997001125, 4951.455339912607, 4992.4039499460805, 5022.6233032522705, 5215.826439051259, 5672.688002159921, 3111.5686784079576, 3123.406552754969, 3140.4190224808485, 3141.575887255237, 3152.6128503458863, 6083.844069626757, 6124.234470691164, 6128.417800308964, 6159.5072394208355, 6171.660558669317, 5748.396418376094, 6010.2186715726675, 6049.727762250709, 6074.605150665281, 6074.908876366858, 6225.844353891189, 6251.531135164881, 6255.280642726054, 6272.937270627235, 6281.968590157111, 5642.7460764266525, 5906.173135760911, 5920.970395147997, 6005.789797357072, 6006.828668409618, 5798.115612425894, 5836.766529338779, 5857.8535536610225, 5875.823725288248, 5900.409959004065, 5916.3492015877355, 6185.824693308257, 6192.566520343533, 6260.906086408799, 6265.467435268053, 4229.429027081304, 4242.257604919188, 4242.851500197478, 4260.44614200152, 4281.25078111323, 5759.560109972507, 5787.884242315046, 6039.728212230548, 6050.394960503914, 6055.424734650202, 5730.140478928194, 5771.884562308815, 5791.598385227342, 5792.304923409218, 5829.677084062044, 5758.942410576008, 5761.251037365283, 5770.3364113125845, 5787.131930210502, 5789.478946894799, 5540.224368588481, 5649.604527683023, 5676.325483982153, 5677.01304543423, 5721.026245945142, 5736.225609542658, 5743.798967036134, 5747.4252574742195, 5777.826665200051, 5810.854728631818, 5468.863278418072, 5594.720263986866, 5657.43425657431, 5659.094544872801, 5698.430156984268], "value": 4369.042813706293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.725346128855, 810.4529442626226, 815.7430409421032, 876.1413814461828, 901.0898992018068, 15311.770323445156, 15444.922775386121, 16460.588485287873, 16683.66632667349, 16882.831171688278, 15265.236738163103, 15364.0, 15398.692026159499, 15473.922630386833, 15484.69030619387, 700.9789706308819, 820.0, 839.7228914458215, 843.8396704626132, 853.5390888919976, 830.7258604660448, 837.1962915601031, 837.7612380471567, 838.0990435282096, 839.82363703622, 886.7694399456124, 887.4675194883051, 887.6582515731425, 888.0453512474083, 888.3381880499037, 734.9191588925214, 857.4255248983166, 880.4013270975765, 880.7886107334258, 884.6063501741728, 649.1528555235416, 650.5413683353224, 651.3258777165611, 651.8337823854887, 651.9054737063146, 16071.598210044842, 16081.597960050975, 16083.035017898846, 16109.919450402673, 16125.354985800554, 15076.170810605412, 15146.091234525964, 15304.617384565363, 15317.080975141527, 15527.534173974798, 13248.801267980987, 13261.73476530464, 13267.0, 13370.39833207508, 13437.32813359328, 4614.289057870335, 4640.164770341337, 4650.534946505356, 4666.090112428078, 4774.40319960005, 75417.24582754157, 75677.62161189159, 75807.24192758113, 76550.0, 76761.61619191924, 11186.049185819296, 11187.216894817284, 11534.307941523535, 11656.41717914101, 11950.940245298718, 22780.544389112125, 22875.885620572124, 22922.0, 23035.424114397276, 23053.654195187086, 8667.4366166199, 8755.299576033902, 8783.736487905246, 8790.560471976376, 8870.423422477648, 4720.433547974265, 4890.368499598212, 4914.213725803854, 4967.3294105296045, 5033.949660503421, 3560.6795388415167, 3730.925381492355, 3737.4767532545466, 3739.9813000934823, 3743.157789497341, 566.5071387892477, 609.4454046817375, 635.6726285962733, 638.9808305750835, 641.1568787045114, 596.6628854697083, 696.5576858694664, 735.6615956659996, 749.1946157880301, 768.5734417398397, 10425.320190703533, 10606.469676516142, 10637.9468102659, 10984.395858227714, 11141.442927853575, 740.5334639177283, 771.124773382204, 773.6441237030916, 780.7930898311952, 784.1922819495928, 5033.496650334937, 5095.566876815438, 5177.58579313654, 5191.844244672666, 5202.661826981234, 80540.19459805444, 112764.0, 121497.0, 126065.0, 127803.0, 80945.19054809495, 83481.0, 107077.0, 110906.0, 111365.44317278362, 94170.0, 94839.0, 95672.0, 95727.04272957321, 97669.51165244129, 9691.951540242535, 9732.70801875945, 9783.315167938175, 9800.166985806287, 9864.21086313079, 56035.43964560465, 56609.150862737915, 56774.7161264191, 58716.0, 59268.0, 69886.65056674684, 79323.60338198271, 82211.5889420549, 83854.58072709598, 84435.0, 12519.749605008032, 13015.349232538525, 13289.800652990407, 13300.667483312995, 13485.056046076681, 13882.583522494342, 14048.929755351157, 14348.0, 14411.207383593584, 14866.702665946405, 13629.386677599334, 13652.931735341259, 13746.59978538063, 13831.654208644462, 14160.645983850487, 13504.260763707813, 13609.455621775018, 13855.099418537762, 13915.58253252404, 14125.505607303696, 12861.899824533313, 12956.676083097998, 13029.609111726664, 13100.541481048118, 13179.077464577387, 10581.682549523526, 10681.0, 10749.89250107489, 10910.454477275945, 11356.205065645325, 11200.663980080612, 11294.548218071184, 11401.942990284995, 11630.592929247436, 11701.590444334408], "value": 7868.102807837625, "unit": "score"}], "name": "dromaeo_css", "value": 7574.260815593888, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 110.0, 110.0, 110.0, 111.0, 111.0, 109.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 128.0, 177.0, 128.0, 126.0, 153.0, 124.0, 166.0, 124.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 162.0, 159.0, 160.0, 161.0, 161.0, 161.0, 162.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 133.0, 76.0, 75.0, 75.0, 73.0, 95.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 126.0, 83.0, 84.0, 84.0, 124.0, 83.0, 84.0, 136.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 53.0, 49.0, 50.0, 51.0, 52.0, 51.0, 51.0, 51.0, 52.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 59.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 81.0, 78.0, 76.0, 79.0, 77.0, 77.0, 124.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 118.0, 118.0, 130.0, 126.0, 117.0, 119.0, 131.0, 121.0, 127.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 148.0, 151.0, 150.0, 150.0, 151.0, 149.0, 156.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 65.0, 60.0, 61.0, 60.0, 59.0, 63.0, 59.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1476.3000000000002, "alertThreshold": 2.0}]} 14:35:29 INFO - Return code: 0 14:35:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:35:29 ERROR - # TBPL SUCCESS # 14:35:29 INFO - Running post-action listener: _resource_record_post_action 14:35:29 INFO - ##### 14:35:29 INFO - ##### Finished run-tests step (success) 14:35:29 INFO - ##### 14:35:29 INFO - Running post-run listener: _resource_record_post_run 14:35:29 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506597376; Read time: 12; Write time: 508576 14:35:29 INFO - TinderboxPrint: CPU usage
13.1% 14:35:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:35:29 INFO - TinderboxPrint: I/O write bytes / time
506,597,376 / 508,576 14:35:29 INFO - TinderboxPrint: CPU idle
8,255.2 (86.9%) 14:35:29 INFO - TinderboxPrint: CPU user
1,195.7 (12.6%) 14:35:29 INFO - TinderboxPrint: Swap in / out
0 / 0 14:35:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252411904; Read time: 0; Write time: 291396 14:35:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254185472; Read time: 12; Write time: 217180 14:35:30 INFO - Running post-run listener: _upload_blobber_files 14:35:30 INFO - Blob upload gear active. 14:35:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:35:30 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'] 14:35:30 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 14:35:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:31 INFO - (blobuploader) - INFO - Done attempting. 14:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:32 INFO - (blobuploader) - INFO - Done attempting. 14:35:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:35:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:57 INFO - (blobuploader) - INFO - Done attempting. 14:35:57 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:57 INFO - Return code: 0 14:35:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3912305dcd4a990cd15520cc6f90484576deed40961ada3d593e0b5aa430fae3f7462737b8068f91b66a53a8b43149563caf7551b28d0accab65a65777f3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f50365a3a6c64162a930baa242c61a0fc4efc551bba0052118cfb3e9b63806b71bb235eeb4a2b2bf7cf999ef521bbbe0d53f982197b0085b9add30cf243c743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55e5745f21f33a4bedb844c310ac83de6df467135550004ad6966c4e8ab9119b2092fe49b7d9860faa92fec61ff38d4ae6a9eba0211348deb373360409227b3"} 14:35:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:57 INFO - Contents: 14:35:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3912305dcd4a990cd15520cc6f90484576deed40961ada3d593e0b5aa430fae3f7462737b8068f91b66a53a8b43149563caf7551b28d0accab65a65777f3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f50365a3a6c64162a930baa242c61a0fc4efc551bba0052118cfb3e9b63806b71bb235eeb4a2b2bf7cf999ef521bbbe0d53f982197b0085b9add30cf243c743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55e5745f21f33a4bedb844c310ac83de6df467135550004ad6966c4e8ab9119b2092fe49b7d9860faa92fec61ff38d4ae6a9eba0211348deb373360409227b3"} 14:35:57 INFO - Running post-run listener: copy_logs_to_upload_dir 14:35:57 INFO - Copying logs to upload dir... 14:35:57 INFO - mkdir: /builds/slave/test/build/upload/logs 14:35:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.682570 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-21 14:35:57.668170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 14:35:57.671333) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918 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/7f3912305dcd4a990cd15520cc6f90484576deed40961ada3d593e0b5aa430fae3f7462737b8068f91b66a53a8b43149563caf7551b28d0accab65a65777f3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f50365a3a6c64162a930baa242c61a0fc4efc551bba0052118cfb3e9b63806b71bb235eeb4a2b2bf7cf999ef521bbbe0d53f982197b0085b9add30cf243c743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55e5745f21f33a4bedb844c310ac83de6df467135550004ad6966c4e8ab9119b2092fe49b7d9860faa92fec61ff38d4ae6a9eba0211348deb373360409227b3"} build_url:https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/VaZrnChhRnSiIMgdg0ho2g/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/7f3912305dcd4a990cd15520cc6f90484576deed40961ada3d593e0b5aa430fae3f7462737b8068f91b66a53a8b43149563caf7551b28d0accab65a65777f3e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f50365a3a6c64162a930baa242c61a0fc4efc551bba0052118cfb3e9b63806b71bb235eeb4a2b2bf7cf999ef521bbbe0d53f982197b0085b9add30cf243c743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55e5745f21f33a4bedb844c310ac83de6df467135550004ad6966c4e8ab9119b2092fe49b7d9860faa92fec61ff38d4ae6a9eba0211348deb373360409227b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 14:35:57.698303) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:35:57.699010) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469133595.876252-410890918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 14:35:57.784506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 14:35:57.785254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 14:35:57.785814) ========= ========= Total master_lag: 0.19 =========