builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1469923796.75 results: success (0) buildid: 20160730143002 builduid: 3daf938b93484ebc9966c59cca05c81d revision: 31f91a3da534dc849f0d6bfc00a395a97cf218a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.750977) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.751460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.751798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.806088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.806434) ========= 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=836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 17:09:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-30 17:09:56 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.910207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.910534) ========= 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=836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022566 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:56.974885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 17:09:56.975188) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 31f91a3da534dc849f0d6bfc00a395a97cf218a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 31f91a3da534dc849f0d6bfc00a395a97cf218a1 --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=836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 17:09:57,112 truncating revision to first 12 chars 2016-07-30 17:09:57,112 Setting DEBUG logging. 2016-07-30 17:09:57,112 attempt 1/10 2016-07-30 17:09:57,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/31f91a3da534?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 17:09:58,621 unpacking tar archive at: fx-team-31f91a3da534/testing/mozharness/ program finished with exit code 0 elapsedTime=1.831645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 17:09:58.823528) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:58.823855) ========= script_repo_revision: 31f91a3da534dc849f0d6bfc00a395a97cf218a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:58.824323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:58.824660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 17:09:58.838696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-30 17:09:58.839012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:59 INFO - MultiFileLogger online at 20160730 17:09:59 in /builds/slave/test 17:09:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:09:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:59 INFO - {'append_to_log': False, 17:09:59 INFO - 'base_work_dir': '/builds/slave/test', 17:09:59 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:59 INFO - 'branch': 'Fx-Team', 17:09:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:59 INFO - 'config_files': ('talos/linux_config.py',), 17:09:59 INFO - 'default_actions': ('clobber', 17:09:59 INFO - 'read-buildbot-config', 17:09:59 INFO - 'download-and-extract', 17:09:59 INFO - 'populate-webroot', 17:09:59 INFO - 'create-virtualenv', 17:09:59 INFO - 'install', 17:09:59 INFO - 'run-tests'), 17:09:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:59 INFO - 'download_minidump_stackwalk': True, 17:09:59 INFO - 'download_symbols': 'ondemand', 17:09:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:59 INFO - 'installer_path': 'installer.exe', 17:09:59 INFO - 'log_level': 'info', 17:09:59 INFO - 'log_name': 'talos', 17:09:59 INFO - 'log_to_console': True, 17:09:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:59 INFO - 'opt_config_files': (), 17:09:59 INFO - 'pip_index': False, 17:09:59 INFO - 'sps_profile': False, 17:09:59 INFO - 'sps_profile_interval': 0, 17:09:59 INFO - 'suite': 'dromaeojs', 17:09:59 INFO - 'system_bits': '32', 17:09:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:59 INFO - 'title': 'talos-linux64-ix-028', 17:09:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:59 INFO - 'use_talos_json': True, 17:09:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:59 INFO - 'work_dir': 'build'} 17:09:59 INFO - [mozharness: 2016-07-31 00:09:59.062324Z] Running clobber step. 17:09:59 INFO - Running pre-action listener: _resource_record_pre_action 17:09:59 INFO - Running main action method: clobber 17:09:59 INFO - rmtree: /builds/slave/test/build 17:09:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:59 INFO - Running post-action listener: _resource_record_post_action 17:09:59 INFO - [mozharness: 2016-07-31 00:09:59.511180Z] Finished clobber step (success) 17:09:59 INFO - [mozharness: 2016-07-31 00:09:59.511282Z] Running read-buildbot-config step. 17:09:59 INFO - Running pre-action listener: _resource_record_pre_action 17:09:59 INFO - Running main action method: read_buildbot_config 17:09:59 INFO - Using buildbot properties: 17:09:59 INFO - { 17:09:59 INFO - "project": "", 17:09:59 INFO - "product": "firefox", 17:09:59 INFO - "script_repo_revision": "production", 17:09:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:09:59 INFO - "repository": "", 17:09:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:09:59 INFO - "buildid": "20160730143002", 17:09:59 INFO - "pgo_build": "True", 17:09:59 INFO - "basedir": "/builds/slave/test", 17:09:59 INFO - "buildnumber": 1400, 17:09:59 INFO - "slavename": "talos-linux64-ix-028", 17:09:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:09:59 INFO - "platform": "ubuntu64_hw", 17:09:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:09:59 INFO - "branch": "fx-team", 17:09:59 INFO - "repo_path": "integration/fx-team", 17:09:59 INFO - "revision": "31f91a3da534dc849f0d6bfc00a395a97cf218a1", 17:09:59 INFO - "stage_platform": "linux64-pgo", 17:09:59 INFO - "builduid": "3daf938b93484ebc9966c59cca05c81d", 17:09:59 INFO - "slavebuilddir": "test" 17:09:59 INFO - } 17:09:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:09:59 INFO - Running post-action listener: _resource_record_post_action 17:09:59 INFO - [mozharness: 2016-07-31 00:09:59.513760Z] Finished read-buildbot-config step (success) 17:09:59 INFO - [mozharness: 2016-07-31 00:09:59.513850Z] Running download-and-extract step. 17:09:59 INFO - Running pre-action listener: _resource_record_pre_action 17:09:59 INFO - Running main action method: download_and_extract 17:09:59 INFO - mkdir: /builds/slave/test/build/tests 17:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:59 INFO - https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:10:08 INFO - Downloaded 1361 bytes. 17:10:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:10:08 INFO - Using the following test package requirements: 17:10:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:10:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:10:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'jsshell-linux-x86_64.zip'], 17:10:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:10:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:10:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:10:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:10:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:10:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:08 INFO - https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:10 INFO - Downloaded 21804081 bytes. 17:10:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:10:11 INFO - Return code: 0 17:10:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:10: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')]} 17:10:11 INFO - https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:14 INFO - Downloaded 21804081 bytes. 17:10:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:10:15 INFO - Return code: 0 17:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:15 INFO - https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:10:16 INFO - Downloaded 14413723 bytes. 17:10:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:10:16 INFO - Return code: 0 17:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:16 INFO - https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:10:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:10:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:10:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:10:18 INFO - Downloaded 59374780 bytes. 17:10:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:10:18 INFO - mkdir: /builds/slave/test/properties 17:10:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:18 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:18 INFO - Contents: 17:10:18 INFO - build_url:https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:10:18 INFO - Running post-action listener: _resource_record_post_action 17:10:18 INFO - Running post-action listener: set_extra_try_arguments 17:10:18 INFO - [mozharness: 2016-07-31 00:10:18.930789Z] Finished download-and-extract step (success) 17:10:18 INFO - [mozharness: 2016-07-31 00:10:18.931120Z] Running populate-webroot step. 17:10:18 INFO - Running pre-action listener: _resource_record_pre_action 17:10:18 INFO - Running main action method: populate_webroot 17:10:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:18 INFO - '--tppagecycles', 17:10:18 INFO - '7'], 17:10:18 INFO - 'tests': ['tsvgm']}}, 17:10:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:10:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:10:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['damp', 'tps']}, 17:10:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'tests': ['damp', 'tps']}, 17:10:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['dromaeo_dom']}, 17:10:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['basic_compositor_video']}, 17:10:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:10:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['a11yr', 17:10:18 INFO - 'ts_paint', 17:10:18 INFO - 'tpaint', 17:10:18 INFO - 'sessionrestore', 17:10:18 INFO - 'sessionrestore_no_auto_restore', 17:10:18 INFO - 'tabpaint']}, 17:10:18 INFO - 'other-e10s': {'tests': ['a11yr', 17:10:18 INFO - 'ts_paint', 17:10:18 INFO - 'tpaint', 17:10:18 INFO - 'sessionrestore', 17:10:18 INFO - 'sessionrestore_no_auto_restore', 17:10:18 INFO - 'tabpaint']}, 17:10:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:10:18 INFO - 'ts_paint', 17:10:18 INFO - 'tpaint', 17:10:18 INFO - 'sessionrestore', 17:10:18 INFO - 'sessionrestore_no_auto_restore', 17:10:18 INFO - 'tabpaint']}, 17:10:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:10:18 INFO - 'ts_paint', 17:10:18 INFO - 'tpaint', 17:10:18 INFO - 'sessionrestore', 17:10:18 INFO - 'sessionrestore_no_auto_restore', 17:10:18 INFO - 'tabpaint']}, 17:10:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['a11yr', 17:10:18 INFO - 'ts_paint', 17:10:18 INFO - 'tpaint', 17:10:18 INFO - 'sessionrestore', 17:10:18 INFO - 'sessionrestore_no_auto_restore', 17:10:18 INFO - 'tabpaint']}, 17:10:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['a11yr', 17:10:18 INFO - 'ts_paint', 17:10:18 INFO - 'tpaint', 17:10:18 INFO - 'sessionrestore', 17:10:18 INFO - 'sessionrestore_no_auto_restore', 17:10:18 INFO - 'tabpaint']}, 17:10:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['tsvgx', 17:10:18 INFO - 'tsvgr_opacity', 17:10:18 INFO - 'tart', 17:10:18 INFO - 'tscrollx', 17:10:18 INFO - 'cart']}, 17:10:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:10:18 INFO - 'tsvgr_opacity', 17:10:18 INFO - 'tart', 17:10:18 INFO - 'tscrollx', 17:10:18 INFO - 'cart']}, 17:10:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'talos_options': ['--disable-e10s'], 17:10:18 INFO - 'tests': ['tp5o']}, 17:10:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'tests': ['tp5o']}, 17:10:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'talos_options': ['--disable-e10s', 17:10:18 INFO - '--xperf_path', 17:10:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:18 INFO - 'tests': ['tp5n']}, 17:10:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:18 INFO - 'talos_options': ['--xperf_path', 17:10:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:18 INFO - 'tests': ['tp5n']}}, 17:10:18 INFO - 'talos.zip': {'path': '', 17:10:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:18 INFO - Running post-action listener: _resource_record_post_action 17:10:18 INFO - [mozharness: 2016-07-31 00:10:18.951982Z] Finished populate-webroot step (success) 17:10:18 INFO - [mozharness: 2016-07-31 00:10:18.952072Z] Running create-virtualenv step. 17:10:18 INFO - Running pre-action listener: _resource_record_pre_action 17:10:18 INFO - Running main action method: create_virtualenv 17:10:18 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:18 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 17:10:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:19 INFO - Using real prefix '/usr' 17:10:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:19 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:21 INFO - Installing pip.................done. 17:10:21 INFO - Return code: 0 17:10:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:10:21 INFO - Using env: {'DISPLAY': ':0', 17:10:21 INFO - 'HOME': '/home/cltbld', 17:10:21 INFO - 'LANG': 'en_US.UTF-8', 17:10:21 INFO - 'LANGUAGE': 'en_US:en', 17:10:21 INFO - 'LOGNAME': 'cltbld', 17:10:21 INFO - 'MAIL': '/var/mail/cltbld', 17:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:21 INFO - 'MOZ_NO_REMOTE': '1', 17:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:21 INFO - 'NO_EM_RESTART': '1', 17:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:21 INFO - 'PWD': '/builds/slave/test', 17:10:21 INFO - 'SHELL': '/bin/bash', 17:10:21 INFO - 'SHLVL': '1', 17:10:21 INFO - 'TERM': 'linux', 17:10:21 INFO - 'TMOUT': '86400', 17:10:21 INFO - 'USER': 'cltbld', 17:10:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:21 INFO - '_': '/tools/buildbot/bin/python'} 17:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:21 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 17:10:21 INFO - Cleaning up... 17:10:21 INFO - Return code: 0 17:10:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:10:21 INFO - Using env: {'DISPLAY': ':0', 17:10:21 INFO - 'HOME': '/home/cltbld', 17:10:21 INFO - 'LANG': 'en_US.UTF-8', 17:10:21 INFO - 'LANGUAGE': 'en_US:en', 17:10:21 INFO - 'LOGNAME': 'cltbld', 17:10:21 INFO - 'MAIL': '/var/mail/cltbld', 17:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:21 INFO - 'MOZ_NO_REMOTE': '1', 17:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:21 INFO - 'NO_EM_RESTART': '1', 17:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:21 INFO - 'PWD': '/builds/slave/test', 17:10:21 INFO - 'SHELL': '/bin/bash', 17:10:21 INFO - 'SHLVL': '1', 17:10:21 INFO - 'TERM': 'linux', 17:10:21 INFO - 'TMOUT': '86400', 17:10:21 INFO - 'USER': 'cltbld', 17:10:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:21 INFO - '_': '/tools/buildbot/bin/python'} 17:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:21 INFO - Downloading/unpacking psutil>=3.1.1 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:23 INFO - Installing collected packages: psutil 17:10:23 INFO - Running setup.py install for psutil 17:10:24 INFO - building 'psutil._psutil_linux' extension 17:10:24 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 17:10:24 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 17:10:24 INFO - building 'psutil._psutil_posix' extension 17:10:24 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 17:10:24 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 17:10:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:24 INFO - Successfully installed psutil 17:10:24 INFO - Cleaning up... 17:10:24 INFO - Return code: 0 17:10:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:24 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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:24 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 17:10:24 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 17:10:24 INFO - Using env: {'DISPLAY': ':0', 17:10:24 INFO - 'HOME': '/home/cltbld', 17:10:24 INFO - 'LANG': 'en_US.UTF-8', 17:10:24 INFO - 'LANGUAGE': 'en_US:en', 17:10:24 INFO - 'LOGNAME': 'cltbld', 17:10:24 INFO - 'MAIL': '/var/mail/cltbld', 17:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:24 INFO - 'MOZ_NO_REMOTE': '1', 17:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:24 INFO - 'NO_EM_RESTART': '1', 17:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:24 INFO - 'PWD': '/builds/slave/test', 17:10:24 INFO - 'SHELL': '/bin/bash', 17:10:24 INFO - 'SHLVL': '1', 17:10:24 INFO - 'TERM': 'linux', 17:10:24 INFO - 'TMOUT': '86400', 17:10:24 INFO - 'USER': 'cltbld', 17:10:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:24 INFO - '_': '/tools/buildbot/bin/python'} 17:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:10:26 INFO - Installing collected packages: mozsystemmonitor 17:10:26 INFO - Running setup.py install for mozsystemmonitor 17:10:26 INFO - Successfully installed mozsystemmonitor 17:10:26 INFO - Cleaning up... 17:10:26 INFO - Return code: 0 17:10:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:10:26 INFO - Using env: {'DISPLAY': ':0', 17:10:26 INFO - 'HOME': '/home/cltbld', 17:10:26 INFO - 'LANG': 'en_US.UTF-8', 17:10:26 INFO - 'LANGUAGE': 'en_US:en', 17:10:26 INFO - 'LOGNAME': 'cltbld', 17:10:26 INFO - 'MAIL': '/var/mail/cltbld', 17:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:26 INFO - 'MOZ_NO_REMOTE': '1', 17:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:26 INFO - 'NO_EM_RESTART': '1', 17:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:26 INFO - 'PWD': '/builds/slave/test', 17:10:26 INFO - 'SHELL': '/bin/bash', 17:10:26 INFO - 'SHLVL': '1', 17:10:26 INFO - 'TERM': 'linux', 17:10:26 INFO - 'TMOUT': '86400', 17:10:26 INFO - 'USER': 'cltbld', 17:10:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:26 INFO - '_': '/tools/buildbot/bin/python'} 17:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:27 INFO - Downloading/unpacking jsonschema==2.5.1 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:29 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:29 INFO - warning: no files found matching '*.txt' 17:10:29 INFO - no previously-included directories found matching 'build' 17:10:29 INFO - no previously-included directories found matching 'dist' 17:10:29 INFO - no previously-included directories found matching '.git*' 17:10:29 INFO - Installing collected packages: jsonschema, functools32 17:10:29 INFO - Running setup.py install for functools32 17:10:29 INFO - warning: no files found matching '*.txt' 17:10:29 INFO - no previously-included directories found matching 'build' 17:10:29 INFO - no previously-included directories found matching 'dist' 17:10:29 INFO - no previously-included directories found matching '.git*' 17:10:29 INFO - Successfully installed jsonschema functools32 17:10:29 INFO - Cleaning up... 17:10:29 INFO - Return code: 0 17:10:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:10:29 INFO - Using env: {'DISPLAY': ':0', 17:10:29 INFO - 'HOME': '/home/cltbld', 17:10:29 INFO - 'LANG': 'en_US.UTF-8', 17:10:29 INFO - 'LANGUAGE': 'en_US:en', 17:10:29 INFO - 'LOGNAME': 'cltbld', 17:10:29 INFO - 'MAIL': '/var/mail/cltbld', 17:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:29 INFO - 'MOZ_NO_REMOTE': '1', 17:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:29 INFO - 'NO_EM_RESTART': '1', 17:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:29 INFO - 'PWD': '/builds/slave/test', 17:10:29 INFO - 'SHELL': '/bin/bash', 17:10:29 INFO - 'SHLVL': '1', 17:10:29 INFO - 'TERM': 'linux', 17:10:29 INFO - 'TMOUT': '86400', 17:10:29 INFO - 'USER': 'cltbld', 17:10:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:29 INFO - '_': '/tools/buildbot/bin/python'} 17:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:10:29 INFO - Cleaning up... 17:10:29 INFO - Return code: 0 17:10:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:10:29 INFO - Using env: {'DISPLAY': ':0', 17:10:29 INFO - 'HOME': '/home/cltbld', 17:10:29 INFO - 'LANG': 'en_US.UTF-8', 17:10:29 INFO - 'LANGUAGE': 'en_US:en', 17:10:29 INFO - 'LOGNAME': 'cltbld', 17:10:29 INFO - 'MAIL': '/var/mail/cltbld', 17:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:29 INFO - 'MOZ_NO_REMOTE': '1', 17:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:29 INFO - 'NO_EM_RESTART': '1', 17:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:29 INFO - 'PWD': '/builds/slave/test', 17:10:29 INFO - 'SHELL': '/bin/bash', 17:10:29 INFO - 'SHLVL': '1', 17:10:29 INFO - 'TERM': 'linux', 17:10:29 INFO - 'TMOUT': '86400', 17:10:29 INFO - 'USER': 'cltbld', 17:10:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:29 INFO - '_': '/tools/buildbot/bin/python'} 17:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:29 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:31 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 INFO - Downloading docopt-0.6.1.tar.gz 17:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:32 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:32 INFO - Running setup.py install for blobuploader 17:10:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:32 INFO - Running setup.py install for requests 17:10:32 INFO - Running setup.py install for docopt 17:10:32 INFO - Successfully installed blobuploader requests docopt 17:10:32 INFO - Cleaning up... 17:10:33 INFO - Return code: 0 17:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:33 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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:33 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 17:10:33 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 17:10:33 INFO - Using env: {'DISPLAY': ':0', 17:10:33 INFO - 'HOME': '/home/cltbld', 17:10:33 INFO - 'LANG': 'en_US.UTF-8', 17:10:33 INFO - 'LANGUAGE': 'en_US:en', 17:10:33 INFO - 'LOGNAME': 'cltbld', 17:10:33 INFO - 'MAIL': '/var/mail/cltbld', 17:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:33 INFO - 'MOZ_NO_REMOTE': '1', 17:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:33 INFO - 'NO_EM_RESTART': '1', 17:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:33 INFO - 'PWD': '/builds/slave/test', 17:10:33 INFO - 'SHELL': '/bin/bash', 17:10:33 INFO - 'SHLVL': '1', 17:10:33 INFO - 'TERM': 'linux', 17:10:33 INFO - 'TMOUT': '86400', 17:10:33 INFO - 'USER': 'cltbld', 17:10:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:33 INFO - '_': '/tools/buildbot/bin/python'} 17:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:33 INFO - Running setup.py (path:/tmp/pip-YqjxeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:33 INFO - Running setup.py (path:/tmp/pip-kUQ3ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:33 INFO - Running setup.py (path:/tmp/pip-xJBr_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:33 INFO - Running setup.py (path:/tmp/pip-lPhHLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:33 INFO - Running setup.py (path:/tmp/pip-AG1zOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:33 INFO - Running setup.py (path:/tmp/pip-7oYhAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:33 INFO - Running setup.py (path:/tmp/pip-PqkgxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:33 INFO - Running setup.py (path:/tmp/pip-pYMRo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:33 INFO - Running setup.py (path:/tmp/pip-4za0DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:33 INFO - Running setup.py (path:/tmp/pip-P1gKDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:33 INFO - Running setup.py (path:/tmp/pip-YWMiLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:34 INFO - Running setup.py (path:/tmp/pip-e0fQtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:34 INFO - Running setup.py (path:/tmp/pip-6Ro_QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:34 INFO - Running setup.py (path:/tmp/pip-V5zDJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:34 INFO - Running setup.py (path:/tmp/pip-mDc2MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:34 INFO - Running setup.py (path:/tmp/pip-c5oYZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:34 INFO - Running setup.py (path:/tmp/pip-yC4VpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:34 INFO - Running setup.py install for manifestparser 17:10:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:34 INFO - Running setup.py install for mozcrash 17:10:34 INFO - Running setup.py install for mozdebug 17:10:34 INFO - Running setup.py install for mozdevice 17:10:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:34 INFO - Running setup.py install for mozfile 17:10:34 INFO - Running setup.py install for mozhttpd 17:10:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Running setup.py install for mozinfo 17:10:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Running setup.py install for mozInstall 17:10:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Running setup.py install for mozleak 17:10:35 INFO - Running setup.py install for mozlog 17:10:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Running setup.py install for moznetwork 17:10:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Running setup.py install for mozprocess 17:10:35 INFO - Running setup.py install for mozprofile 17:10:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Running setup.py install for mozrunner 17:10:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:35 INFO - Running setup.py install for mozscreenshot 17:10:36 INFO - Running setup.py install for moztest 17:10:36 INFO - Running setup.py install for mozversion 17:10:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:36 INFO - Cleaning up... 17:10:36 INFO - Return code: 0 17:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:36 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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:36 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 17:10:36 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 17:10:36 INFO - Using env: {'DISPLAY': ':0', 17:10:36 INFO - 'HOME': '/home/cltbld', 17:10:36 INFO - 'LANG': 'en_US.UTF-8', 17:10:36 INFO - 'LANGUAGE': 'en_US:en', 17:10:36 INFO - 'LOGNAME': 'cltbld', 17:10:36 INFO - 'MAIL': '/var/mail/cltbld', 17:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:36 INFO - 'MOZ_NO_REMOTE': '1', 17:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:36 INFO - 'NO_EM_RESTART': '1', 17:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:36 INFO - 'PWD': '/builds/slave/test', 17:10:36 INFO - 'SHELL': '/bin/bash', 17:10:36 INFO - 'SHLVL': '1', 17:10:36 INFO - 'TERM': 'linux', 17:10:36 INFO - 'TMOUT': '86400', 17:10:36 INFO - 'USER': 'cltbld', 17:10:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:36 INFO - '_': '/tools/buildbot/bin/python'} 17:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:36 INFO - Running setup.py (path:/tmp/pip-yIMlki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:36 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)) 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:36 INFO - Running setup.py (path:/tmp/pip-9WUJPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:36 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)) 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:36 INFO - Running setup.py (path:/tmp/pip-6mlIim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:36 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)) 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:36 INFO - Running setup.py (path:/tmp/pip-cGsdAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:36 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)) 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:36 INFO - Running setup.py (path:/tmp/pip-v4qP00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:36 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)) 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:36 INFO - Running setup.py (path:/tmp/pip-Xjf18Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:36 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)) 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:36 INFO - Running setup.py (path:/tmp/pip-_8tHA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:36 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)) 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:36 INFO - Running setup.py (path:/tmp/pip-LVUMpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:37 INFO - Running setup.py (path:/tmp/pip-f_qv_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:37 INFO - Running setup.py (path:/tmp/pip-10HCtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:37 INFO - Running setup.py (path:/tmp/pip-5ebAzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:37 INFO - Running setup.py (path:/tmp/pip-LSamyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:37 INFO - Running setup.py (path:/tmp/pip-0nEt4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:37 INFO - Running setup.py (path:/tmp/pip-sGOBs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:37 INFO - Running setup.py (path:/tmp/pip-eT_oC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:37 INFO - Running setup.py (path:/tmp/pip-UAiOJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:37 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)) 17:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:37 INFO - Running setup.py (path:/tmp/pip-nrZPuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:37 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)) 17:10:37 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)) 17:10:37 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)) 17:10:37 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)) 17:10:37 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)) 17:10:37 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)) 17:10:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:37 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 17:10:37 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 17:10:37 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 17:10:37 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 17:10:37 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 17:10:37 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 17:10:39 INFO - Downloading blessings-1.6.tar.gz 17:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:39 INFO - Installing collected packages: blessings 17:10:39 INFO - Running setup.py install for blessings 17:10:39 INFO - Successfully installed blessings 17:10:39 INFO - Cleaning up... 17:10:39 INFO - Return code: 0 17:10:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:40 INFO - Reading from file tmpfile_stdout 17:10:40 INFO - Current package versions: 17:10:40 INFO - argparse == 1.2.1 17:10:40 INFO - blessings == 1.6 17:10:40 INFO - blobuploader == 1.2.4 17:10:40 INFO - docopt == 0.6.1 17:10:40 INFO - functools32 == 3.2.3-2 17:10:40 INFO - jsonschema == 2.5.1 17:10:40 INFO - manifestparser == 1.1 17:10:40 INFO - mozInstall == 1.12 17:10:40 INFO - mozcrash == 0.17 17:10:40 INFO - mozdebug == 0.1 17:10:40 INFO - mozdevice == 0.48 17:10:40 INFO - mozfile == 1.2 17:10:40 INFO - mozhttpd == 0.7 17:10:40 INFO - mozinfo == 0.9 17:10:40 INFO - mozleak == 0.1 17:10:40 INFO - mozlog == 3.3 17:10:40 INFO - moznetwork == 0.27 17:10:40 INFO - mozprocess == 0.23 17:10:40 INFO - mozprofile == 0.28 17:10:40 INFO - mozrunner == 6.12 17:10:40 INFO - mozscreenshot == 0.1 17:10:40 INFO - mozsystemmonitor == 0.3 17:10:40 INFO - moztest == 0.7 17:10:40 INFO - mozversion == 1.4 17:10:40 INFO - psutil == 3.1.1 17:10:40 INFO - requests == 1.2.3 17:10:40 INFO - wsgiref == 0.1.2 17:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:40 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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:40 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 17:10:40 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 17:10:40 INFO - Using env: {'DISPLAY': ':0', 17:10:40 INFO - 'HOME': '/home/cltbld', 17:10:40 INFO - 'LANG': 'en_US.UTF-8', 17:10:40 INFO - 'LANGUAGE': 'en_US:en', 17:10:40 INFO - 'LOGNAME': 'cltbld', 17:10:40 INFO - 'MAIL': '/var/mail/cltbld', 17:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:40 INFO - 'MOZ_NO_REMOTE': '1', 17:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:40 INFO - 'NO_EM_RESTART': '1', 17:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:40 INFO - 'PWD': '/builds/slave/test', 17:10:40 INFO - 'SHELL': '/bin/bash', 17:10:40 INFO - 'SHLVL': '1', 17:10:40 INFO - 'TERM': 'linux', 17:10:40 INFO - 'TMOUT': '86400', 17:10:40 INFO - 'USER': 'cltbld', 17:10:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:40 INFO - '_': '/tools/buildbot/bin/python'} 17:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 INFO - Cleaning up... 17:10:40 INFO - Return code: 0 17:10:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:40 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 0x10d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1395180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, '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': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', '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 17:10:40 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 17:10:40 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 17:10:40 INFO - Using env: {'DISPLAY': ':0', 17:10:40 INFO - 'HOME': '/home/cltbld', 17:10:40 INFO - 'LANG': 'en_US.UTF-8', 17:10:40 INFO - 'LANGUAGE': 'en_US:en', 17:10:40 INFO - 'LOGNAME': 'cltbld', 17:10:40 INFO - 'MAIL': '/var/mail/cltbld', 17:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:40 INFO - 'MOZ_NO_REMOTE': '1', 17:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:40 INFO - 'NO_EM_RESTART': '1', 17:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:40 INFO - 'PWD': '/builds/slave/test', 17:10:40 INFO - 'SHELL': '/bin/bash', 17:10:40 INFO - 'SHLVL': '1', 17:10:40 INFO - 'TERM': 'linux', 17:10:40 INFO - 'TMOUT': '86400', 17:10:40 INFO - 'USER': 'cltbld', 17:10:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:40 INFO - '_': '/tools/buildbot/bin/python'} 17:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:10:40 INFO - Cleaning up... 17:10:40 INFO - Return code: 0 17:10:40 INFO - Running post-action listener: _resource_record_post_action 17:10:40 INFO - Running post-action listener: _start_resource_monitoring 17:10:40 INFO - Starting resource monitoring. 17:10:40 INFO - [mozharness: 2016-07-31 00:10:40.500460Z] Finished create-virtualenv step (success) 17:10:40 INFO - [mozharness: 2016-07-31 00:10:40.500890Z] Running install step. 17:10:40 INFO - Running pre-action listener: _resource_record_pre_action 17:10:40 INFO - Running main action method: install 17:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:40 INFO - Reading from file tmpfile_stdout 17:10:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:40 INFO - Reading from file tmpfile_stdout 17:10:40 INFO - Output received: 17:10:40 INFO - Usage: mozinstall [options] installer 17:10:40 INFO - Options: 17:10:40 INFO - -h, --help show this help message and exit 17:10:40 INFO - -d DEST, --destination=DEST 17:10:40 INFO - Directory to install application into. [default: 17:10:40 INFO - "/builds/slave/test"] 17:10:40 INFO - --app=APP Application being installed. [default: firefox] 17:10:40 INFO - mkdir: /builds/slave/test/build/application 17:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:10:57 INFO - Reading from file tmpfile_stdout 17:10:57 INFO - Output received: 17:10:57 INFO - /builds/slave/test/build/application/firefox/firefox 17:10:57 INFO - Running post-action listener: _resource_record_post_action 17:10:57 INFO - [mozharness: 2016-07-31 00:10:57.633150Z] Finished install step (success) 17:10:57 INFO - [mozharness: 2016-07-31 00:10:57.633491Z] Running run-tests step. 17:10:57 INFO - Running pre-action listener: _resource_record_pre_action 17:10:57 INFO - Running main action method: run_tests 17:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:57 INFO - Python 2.7.3 17:10:57 INFO - Return code: 0 17:10:57 INFO - grabbing minidump binary from tooltool 17:10:57 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')]} 17:10:57 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 0x13933b0>, '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 0x13942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1394740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:57 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 17:10:57 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 17:10:57 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 17:10:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:57 INFO - Return code: 0 17:10:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:10:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:10:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 17:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 17:10:57 INFO - Using env: {'DISPLAY': ':0', 17:10:57 INFO - 'HOME': '/home/cltbld', 17:10:57 INFO - 'LANG': 'en_US.UTF-8', 17:10:57 INFO - 'LANGUAGE': 'en_US:en', 17:10:57 INFO - 'LOGNAME': 'cltbld', 17:10:57 INFO - 'MAIL': '/var/mail/cltbld', 17:10:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:57 INFO - 'MOZ_NO_REMOTE': '1', 17:10:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:57 INFO - 'NO_EM_RESTART': '1', 17:10:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:57 INFO - 'PWD': '/builds/slave/test', 17:10:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:57 INFO - 'SHELL': '/bin/bash', 17:10:57 INFO - 'SHLVL': '1', 17:10:57 INFO - 'TERM': 'linux', 17:10:57 INFO - 'TMOUT': '86400', 17:10:57 INFO - 'USER': 'cltbld', 17:10:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462', 17:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:57 INFO - '_': '/tools/buildbot/bin/python'} 17:10:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 17:10:57 INFO - mozversion application_buildid: 20160730143002 17:10:57 INFO - mozversion application_changeset: 31f91a3da534dc849f0d6bfc00a395a97cf218a1 17:10:57 INFO - mozversion application_display_name: Nightly 17:10:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:57 INFO - mozversion application_name: Firefox 17:10:57 INFO - mozversion application_remotingname: firefox 17:10:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:57 INFO - mozversion application_vendor: Mozilla 17:10:57 INFO - mozversion application_version: 50.0a1 17:10:57 INFO - mozversion platform_buildid: 20160730143002 17:10:57 INFO - mozversion platform_changeset: 31f91a3da534dc849f0d6bfc00a395a97cf218a1 17:10:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:57 INFO - mozversion platform_version: 50.0a1 17:10:57 INFO - using testdate: 1469923857 17:10:57 INFO - actual date: 1469923857 17:10:57 INFO - starting webserver on 'localhost:51606' 17:10:57 INFO - SUITE-START | Running 2 tests 17:10:57 INFO - TEST-START | dromaeo_css 17:10:57 INFO - operating with platform_type : linux_ 17:10:57 INFO - Initialising browser for dromaeo_css test... 17:10:57 INFO - TEST-INFO | started process 4796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpolqhdV/profile http://localhost:51606/getInfo.html) 17:11:01 INFO - PROCESS | 4796 | __metrics Screen width/height:1600/1200 17:11:01 INFO - PROCESS | 4796 | colorDepth:24 17:11:01 INFO - PROCESS | 4796 | Browser inner width/height: 1024/697 17:11:01 INFO - PROCESS | 4796 | __metrics 17:11:02 INFO - PROCESS | 4796 | 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" 17:11:02 INFO - PROCESS | 4796 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:03 INFO - PROCESS | 4796 | console.error: PushService: 17:11:03 INFO - PROCESS | 4796 | stateChangeProcessEnqueue: Error transitioning state 17:11:03 INFO - PROCESS | 4796 | UnknownError 17:11:03 INFO - TEST-INFO | 4796: exit 0 17:11:03 INFO - Browser initialized. 17:11:03 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:03 INFO - TEST-INFO | started process 4874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpolqhdV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:15 INFO - PROCESS | 4874 | RSS: Main: 156037120 17:11:15 INFO - PROCESS | 4874 | 17:12:06 INFO - PROCESS | 4874 | 1469923926347 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] 17:14:15 INFO - PROCESS | 4874 | Cycle 1(1): loaded http://localhost:51606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51606/tests/dromaeo/cssquery-ext.html) 17:14:16 INFO - PROCESS | 4874 | RSS: Main: 262234112 17:14:16 INFO - PROCESS | 4874 | 17:17:18 INFO - PROCESS | 4874 | Cycle 1(1): loaded http://localhost:51606/tests/dromaeo/cssquery-ext.html (next: http://localhost:51606/tests/dromaeo/cssquery-jquery.html) 17:17:19 INFO - PROCESS | 4874 | RSS: Main: 238206976 17:17:19 INFO - PROCESS | 4874 | 17:20:21 INFO - PROCESS | 4874 | Cycle 1(1): loaded http://localhost:51606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51606/tests/dromaeo/cssquery-mootools.html) 17:20:22 INFO - PROCESS | 4874 | RSS: Main: 184143872 17:20:22 INFO - PROCESS | 4874 | 17:23:24 INFO - PROCESS | 4874 | Cycle 1(1): loaded http://localhost:51606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51606/tests/dromaeo/cssquery-prototype.html) 17:23:24 INFO - PROCESS | 4874 | RSS: Main: 209178624 17:23:24 INFO - PROCESS | 4874 | 17:26:27 INFO - PROCESS | 4874 | Cycle 1(1): loaded http://localhost:51606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51606/tests/dromaeo/cssquery-yui.html) 17:26:28 INFO - PROCESS | 4874 | RSS: Main: 184512512 17:26:28 INFO - PROCESS | 4874 | 17:29:30 INFO - PROCESS | 4874 | Cycle 1(1): loaded http://localhost:51606/tests/dromaeo/cssquery-yui.html (next: http://localhost:51606/tests/dromaeo/cssquery-dojo.html) 17:29:31 INFO - PROCESS | 4874 | RSS: Main: 278192128 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | __start_tp_report 17:29:31 INFO - PROCESS | 4874 | _x_x_mozilla_page_load 17:29:31 INFO - PROCESS | 4874 | _x_x_mozilla_page_load_details 17:29:31 INFO - PROCESS | 4874 | |i|pagename|runs| 17:29:31 INFO - PROCESS | 4874 | |0;dojo.html;3052.8168309901403;3087.7684173686953;3101.674324195959;3111.066679996002;3120.313531023174;5293.8941221175555;5321.813736519222;5393.4067252602235;5500.587455940806;5533.529649979747;5386.461353864612;5403.945960540404;5415.214793854899;5453.836384908459;5467.097928841737;4887.780049897745;4958.479359667237;4976.3530741003615;4986.177280748672;5134.7432628368615;5026.82406115786;5058.544730974211;5081.390233172025;5090.33825602673;5102.056119617882;4815.494373090845;4832.9275060874115;4883.511648835123;4938.012397520511;4967.329410529586;4942.950570494285;4942.975285123587;4953.356063711731;4991.401031876162;5016.347874776256;4957.355543779322;4984.925226121611;4985.800567977277;5005.774740136702;5020.322256495363;5253.789848406059;5364.624476286662;5477.945220547784;5487.862803429906;5495.752691128869;5829.47534721877;5869.1196320551835;5871.32479764824;5872.882542349172;5876.794312199096;5850.3272123705465;5907.556933230025;5916.083007133858;5920.674362910038;5923.851903702399;5227.555657769094;5305.973470132663;5343.973280133574;5350.625456218105;5486.039943009957;5955.40445955401;5957.940420595825;5963.701814909237;5967.283925928829;5970.13433052205;5709.571782116358;5713.600047996683;5720.1991721159075;5721.485066344049;5723.54211663066;5504.697241651667;5657.179708942181;5661.603687741818;5681.17622944679;5806.187133801272;5702;5722.685252311163;5745.626534275342;5753.453421924911;5753.539716822645;5684.147377893349;5730.08318669011;5735.0250457422335;5739.7704091836695;5741;4320.222359975234;4396.868093957187;4412.183746006999;4448.266036104072;4493.0339976905125;3921.9019524512114;3961.7226794124135;3995.6403923647013;3999.4000899864673;4016.216837716676;5498.560115190775;5501.642393244426;5505.284313039279;5506.284183056177;5512.310961129859;5613.663180209201;5776.537876969833;5830.883382332415;5836.066229403275;5871.735771890275;5424.267723857308;5516.972415137899;5536.723163841792;5546.805861794818;5566.749496272678;5064.366954130734;5077.23841423782;5080.23796430531;5084.161113416319;5127.897442051138;5867.207926929896;5959.344472108151;6102.420270074336;6114.296855861544;6116.602420842631;5787.247657804459;5836.854078648068;5844.415558444121;5893;5896.174535564938;6039.969800150971;6051.183090282755;6051.364606716407;6055.878882422238;6057.7879774207695;5510.1459273812625;5611.57913156523;5659.490645841894;5722.628029178257;5727.198192253171;5733.684647344436;5767.9269362685245;5796.01467750475;5835.328937172279;5845.707714614337;5628.690422026828;5630.915536266877;5633.6619802811965;5639.971800140973;5642;5494.862628434321;5572.136318870582;5608.158776183605;5612.663240205601;5614.9719251403485;5538.529225015919;5545.611807173459;5567.860803479945;5596.272484576979;5597.076482380362;5626.774929002794;5641.041023026013;5689.601727879009;5690.544756419394;5701.287339082614;5425.565954723534;5514.283143191359;5530.391656917816;5533.418991005887;5536.667799932017 17:29:31 INFO - PROCESS | 4874 | |1;ext.html;600.1537831657362;610.1214251477871;616.7717944360586;637.2448648351707;643.0514990389175;42371.36442953354;43847;43910.78044609773;43952.3407148893;47204.29193562099;45132.3230151548;45535.54464455354;45578;45580.316295255514;45583;8979.19187273147;9112.498812565307;9118.77203069922;9120.042395548438;9120.8631870522;8952.507612081334;9045.185933266004;9047.230985366252;9048.502332371718;9052.140046695553;9102.362834601581;9131.406458580204;9136.908630913673;9137.40606860552;9137.5888085036;9054.230390416757;9071.319651026199;9102.226310763526;9103.408278461946;9106.134917182857;8966.596503157374;9010.23413009895;9034.728958131267;9035.548222588845;9035.734997100411;42860;42933.78533107346;43018.78490607527;43070.784646076885;43242.351364729555;3291.358185153896;3341.331733653279;3345.130266130799;3359.8320083995704;3480.8259587020802;32002;32440.675593244003;32720.181995450068;33898.1525461863;34049.48925766115;4442.800073996678;4459.35339375792;4462.286034234539;4467.843625473125;4474.8433804817005;250655;250718;250866;250954;251612;34071.31857362889;56581.71709141428;57170.714146429;57186.14220786691;57268;34605.82697086498;36249.737523623;36326.27347453036;36337;36341.454878176846;14600.926995364955;14639.634009149644;14681.632959176106;14685.853141468662;14692.118472891447;12296.139270251175;12301.32342721159;12352.320622365676;12363.69090772738;12382.442790074469;8055.275025247756;8151.266386025286;8227.177282271725;8248.340132789363;8285.8342833143;3179.8410079495934;3191.2979144588153;3200.48792193248;3220.533022711694;3242.6595207503347;1009.2228983682523;1017.5217647705566;1069.0485467933545;1127.720037757135;1183.7454947186225;32785.84589780654;32795.50806737901;33003.339933201205;33193;33477.66522334794;1066.5253961986996;1107.06453047175;1126.6000569797604;1137.147139645266;1161.3960740415105;16768.496945091665;17283.777979763705;17391.913040434716;17452.389166379115;17548.824511754974;600980;904645;931462;932232;932574;59020.704896476105;59639.33426324492;59735;59762.40237597568;59911;1215.477344741752;1349.0893646788575;1358.952436664712;1369.5617402431326;1385.0166381868985;29263.268418289714;32990.67009329972;33253;33282.83358583192;33580.496292555144;48867.51132488772;49472.25791613057;49505.50494495153;49561.75219123881;49607;438139;439857;440580;442425;442793;23224.76775232226;24429.633555497036;27778.44443111086;28123.57814632741;28515.714842851306;46268.53731462777;46579.30131047969;46930.76534617305;46985.29522057103;47305.29042064441;39776.80111599423;40126.799366004154;40612.68015252394;40935.59064409318;42012.159756805304;39813;40070.19859602733;40349.39475907805;41084;41681.37477937773;30322.545161823033;39959.80020099881;40637.390439142844;40698.1860362797;40902;32478.35043299168;36012;36317.27365452729;36810.26379472342;37214.62785372112;27525.31186720268;28302;28411.43177136487;28479.28801779972;28517.857410712815 17:29:31 INFO - PROCESS | 4874 | |2;jquery.html;379.23583978283756;381.3041199810346;383.10927094505263;388.3289329144906;418.7278269125068;14452.783208251858;17182.312707491685;17860.553486162837;19612;19630.31293904712;19070;19429.902850485727;19909.800901990977;20180.59638807223;20204.898975505137;5688.146777983305;5868.530517558585;5869.2369991901205;5893.970530147343;5897.380775018604;4275.87172384829;5756.453136951983;5791.739371728261;6050.42520960508;6321.652309123019;6361.936380636181;6383.776567820128;6390.105385246069;6390.329015453357;6395.712192951305;6214.378562143772;6460.612363258196;6482.222133343982;6490.05894145351;6498.220213574401;5507.284053073115;5635.295588051494;5742.310922689262;5752.856178595569;5765.336986246593;22868.54262914749;22974.08103675851;23104.76895231043;23104.884475577514;23318.766812332;2287.0737351372554;2308.792208701208;2383.84505007174;2448.9755102449103;2895.869685864141;14174.291285435687;14570.4900328488;14902.91674367723;14934.759464210574;15257.847421525754;1896.2509808625653;1996.0418998880618;2019.6768517037203;2041.3875837248765;2057.804508571683;52433;79713.60143199305;82200.17799821985;82265.58867205685;82632.58683706603;9814.65648702292;10017.499125043718;10130.746731331628;10196.949015254877;10575.153987680967;13697.794533082011;13729.794053089212;13746.587602371945;13748.450061997408;13775.724485510234;7641.472274497777;7929.603519823986;7970.322522585529;8041.3164880984605;8058.234467725557;7531.887021694679;7625.084989801148;7814.3748500119855;7820.061592608923;7846.8430631387055;6420.646864422408;6556.934430655632;6613.537052406382;6618.801435956929;6655.800325990228;1843.7142242952364;1942.155162504315;1945.9416217513497;1986.1261045140093;2009.5880344529337;903.3992395057345;973.5813600151861;996.0985308296003;1059.2479339668766;1060.2154405739852;20113.698294525595;20600.175992960412;20665.690014649794;20759.169633214504;20980.160793568393;1004.1715584642553;1052.347544522401;1057.8254587992894;1070.4433694478828;1071.7427817323787;10980.835287470694;11789.882101178879;11849.466773995191;11871.46578403974;11917.106217033757;502514;505485;508563;514441;529282;81034;82833.58583207167;83106;96998.51500742593;104609;973.7662960889336;1016.913562347194;1034.715453250362;1056.2922841696081;1057.5505410200633;18168;18615.627687446446;19232.326868559532;19233.230670773573;19396.2241510338;39498;40971.1805763889;41405.23839758466;44874;46527.302090467994;54547.72726136344;56251.71874140767;57137;60649.09026364696;64017.67991160014;8157.75526734199;8219.794505137419;8472.40693151498;8518.0204276509;8717.738467845975;12466.812997804858;13337.866621333662;13524.39140238672;13672.52146174879;13730.93134534361;11427.542898284308;11496.712582185512;11520.769584608093;11798.764024719629;11818.468168932246;10783.352998820095;10994.84023715913;11081.778364432828;11082;11273.661790146309;11366.943165284121;11758.294502329887;12006.399680016139;12058;12090.153689241668;8154.1030486647605;8162.387820913336;8423.4945903246;8500.149985001697;8915.331350148635;8480.279176270085;10729.276492470459;10820.134389248999;11700.88299116998;11929.701757456132 17:29:31 INFO - PROCESS | 4874 | |3;mootools.html;1277.597556769618;1449.2391494465405;1492.0376357249575;1625.3498600559774;1773.5743421578818;8192.139825318345;8515.659373625056;8544.700935467252;8825.470471771681;8835.602397892095;8672.349573781976;8763.386562940597;8763.737087887357;8765.079666635007;8767;2227.676986836908;2250.246167533878;2250.2686626846257;2251.966220506694;2252.628316327804;2275.5562665280277;2283.9657405138937;2366.396568874943;2366.4675448024227;2371.632396978471;2279.430142464384;2282.8402011859093;2310.757370476101;2314.826388020905;2318.2697450303185;2231.6764069210035;2250.628646273363;2258.0516183203094;2266.354089084611;2271.886405679726;2203.603351396748;2207.9227227047136;2208.6134926387977;2212.23677831148;2216.9224077157382;8608.52653104079;8608.52653104079;8685.392022558424;8730.51982140982;8757.605907734167;4964.553190212898;5111.565516931066;5120.6927584344685;5139.331886854685;5146.639735218536;3089.8556183924343;3238.2151349839355;3241.692039256267;3312.287858110518;3317.6516465770987;1076.8169411200035;1085.478970094359;1093.8468614393992;1097.5390336058874;1111.283222321598;12013.279203247746;12079.698007549794;12142.0893432992;12149.271043737404;12153.574624888086;4072.615310794344;4241.618254357061;4305.504866940342;4316.093620339701;4319.503257125471;9057.637694492278;9059.320550958704;9082.40964337316;9082.86375704365;9086.091390860993;4938.777755001033;4945.703257804544;4953.479884612136;4956.405231372186;4956.504349565014;4005.919881602352;4210.852620158341;4264.701470897007;4607.746573938399;4612.192866248461;3671.2473942841652;3735.7945313007504;3801.125741079567;3804.695624350101;3809.790461524643;1023.82083135451;1076.1767248055244;1080.6325849211305;1095.70963694621;1096.309325125166;855.7774978505633;974.5322245322285;986.9457179855177;996.4917891875195;1008.7528555503802;5621.213030175779;5667.1782591524;5755.251817263729;5851.970740146272;5920.407959204045;418.99581004189565;424.87890951078793;426.60325896915543;431.52101167703825;437.56462319991175;3830.4254361845387;3846.538415390171;3919.2553414851086;4115.050193857244;4169.583041695806;10432.217583681102;10761.461926903623;10864.239503234698;10875.83686244707;10877.564897404174;10788.730281743019;10789.62236321725;10791.190660700478;10801.675949721364;10812.567497300177;7744.186860379692;8083.555404452812;8089.595520223966;8090.352771778244;8162.18378162179;5692.089265717465;5756.222909907109;5773.826785196451;5816.738246778989;6008.128821320972;9548.997355277595;9727.854082188915;9915.20678345745;9937.403755774387;9997.250206234416;9093.863592045993;9670;9873.50632468388;10133.797324053625;10143.391396516232;7131.179914309921;7310.268973102648;7360.116785985716;7547.811304717426;7559.470837041575;8334.874976875473;8350.624221909908;8382.119877413028;8444.577771111542;8456;7338.743143990148;7355.7057717690695;7413.66638501258;7464.552126872405;7600.695972161052;7157.534760240567;7272.236415176542;7423.851522969619;7441.851162976602;7477.9530865679935;6611.140551728245;6690.19717633887;6711.597304161766;6722.563033402813;6724.529282950147;4942.4316203637045;5132.46109158533;5173.14643083902;5205.609579281645;5452.2094296327605;5171.896562068813;5182.870428239325;5220.269162317202;5220.608454366014;5506.201600767947 17:29:31 INFO - PROCESS | 4874 | |4;prototype.html;310.579165231112;318.00781561528026;324.7742818740974;325.86802345050256;330.6263921768401;5163.586913046956;5182.559482443988;5280.630355875085;5316.73416329183;5327.147656374981;5186.455422180673;5208.635395522315;5208.7395630218525;5238.114278859617;5240.266362709214;4161.709869940313;4162.4796900387455;4163.146554956242;4166.812493437795;4167.708260421772;3896.318144324746;4012.6990475714438;4167.729097608646;4174.937375939348;4184.288670925935;3934.1934903344745;3955.307821131305;3968.503937007874;3969;3975.9602403975878;3951.6245956634075;3956.8615098471414;3965.7223994320266;3967.543732470774;3989.962609721464;3315.1712071982006;3435.47492592944;3444.121748954026;3450.1374656335915;3469.7744646598144;5032.094223039888;5054.671446355975;5056.710538812616;5067.290579318898;5086.18621020635;4511.623954693817;4519.728816271035;4520.434945631796;4525.705829121097;4526.352084030846;5300.595342234311;5377.946220537784;5405.621606487547;5433.782648694048;5439.755211015474;3730.8321125549414;3736.831842567091;3742.3450896093077;3744.2885851688366;3750.474933509311;5573.247611572467;5597.600599850038;5613.859653508654;5628.690422026787;5667.914981275326;3907.3943538751537;3959.3862951242604;3970.146418520032;3982.721209515364;3993.9201215975518;3955.3473676843573;3980.8208630611693;3992;4009.3384591542067;4037.8586749464216;4560.475545312265;4563.8134085137435;4576.473705523841;4584.358189853423;4589.380433641416;5311.256424100629;5425.856786569283;5434.3207099112615;5441.183822426668;5447.1829225616475;1340.477213886585;1343.4491858338035;1344.9798253026213;1354.8077691631302;1356.7354365898555;867.9956600217084;876;889.4174315823017;889.9009722992099;905.6060613633091;4729.905401891943;4734.715917044989;4750.292333369946;4771.212749896228;4796.832110876103;4899.240617704261;4965.677230980047;4987.401511818605;4990.451050384455;5029.371328583927;4486.932696009562;4741.95258047422;4770.689905156154;4783.832565860178;4787.54518320759;2649.284693132843;2683.6242925990377;2683.745044220796;2688.4085501189707;2690.690570584408;5184.507471790174;5190.532852043334;5194.649391158326;5199.206273835521;5207.609429292818;4735.7086824656535;5023.572996295356;5069.366329208849;5083.313752643419;5151.7681704323395;5074.49255074497;5114.951434955825;5115.795368185305;5128.9230661540105;5148;4971.850844474671;4981.476944920876;4981.950180498148;5000.949990500194;5003.749812509287;4807.254875494304;4919.385076865392;4961.883576195327;4977.531628169626;5011.920053177891;5187.481251874782;5206.219067139959;5221.9216711748595;5223.5559977402345;5236.591168062734;3635.6727894489622;3658.798766067892;3828.7511311764647;3856.5564960028833;3935.9409608856463;5564.276644036249;5566.415526369673;5569.248151499496;5577.609567330248;5585.1901474286815;5428.158635411518;5454.263674403905;5465.781368745205;5472.562195024469;5474.2609747683555;5302.231176479312;5464.104024866827;5473.343198816167;5486.698231597141;5488.600406896216;5382.246485491956;5425.972870135782;5468.26178465902;5470.398256191736;5507.669539827623;5314.920276195783;5581.609287349846;5596.972015139898;5599.236240584203;5637.196097248841;5384.865378365415;5385.3268341457315;5397.649152805055;5411.756470958738;5437.5378092860965 17:29:31 INFO - PROCESS | 4874 | |5;yui.html;736.0210919477092;741.8775901976178;792.2504585012847;807.1363640904232;807.8707406814904;15147.848521514808;15432.228388580568;15822;15966.121863297529;15987.760183597255;15130.09219446834;15187;15192.620184495394;15273.083614983108;15299.46451874182;785.6229010075153;804.3203493048364;808.8261023879865;809.9757007289761;810.5947026486757;657.3590749019716;778.3656320099101;805.3637626275265;808.7088648086684;814.5560669435172;828.3911325175991;832.6794184239081;834.6953362022848;834.8413801377719;834.9499030058186;822.8518866604009;826.4875777018257;826.8057006603443;826.8098337382376;827.5159031966307;499.37827404881153;599.469469519474;611.0833749375936;612.063542779548;614.3457218062749;15055.698886022328;15064.849351506564;15073.924630376778;15090.622734431618;15104.39582416702;11647.534098636044;13779.586612401645;14106.294685265695;14139.505117320947;14370.728901143646;13264.270465124415;13394.464221431132;13415.46338146473;13425.932870335684;13662.248576328298;4299.226139294926;4331.198728235255;4443.622292105175;4450.154470650566;4553.612942899857;70692.2930770696;71136.28863711348;71360.28639713589;71636.64181679058;75543.62228188824;10714.089302409227;10717.14262858985;10876.347419154876;10896.78206435867;10930.398828064534;19588;19645.214191432184;19660;19660.410187694393;19673.21307147698;8303.875441868377;8330;8563.143685631512;8588.570571471402;8735.078282777778;4227.2794883236165;4368.388425620416;4369.43197384338;4374.671899607479;4675.883102922454;3310.2386451116377;3386.3904497190742;3417.1798768295926;3418.6068602110577;3420.7605467617027;556.9749361278753;562.4768964862717;569.1576466829033;570.1020892094967;572.0561074227475;574.9683767392834;701.2671758012889;703.5673061067407;710.3606753921408;710.6517806274888;9888.604455821687;10255.230857685703;10293.74265643365;10316.43259620713;10591.417472039111;668.108075718911;682.8429461223847;712.7505373119367;775.2131586439768;788.9960550197327;4710.246360582359;5131.56381707559;5200.297959775382;5205.817796377109;5206.323177986837;127861.72138278498;128729.35635321763;131548;133649.3317533406;138573;115220;116457;117457;120440.39779801045;120960;59671.999999999134;60086.09870851941;61621.69189154026;62740.37259627345;97111.51444242733;9195.965331440475;9273.3045021625;9308.162265396148;9517.474846248224;9648.855267170858;54010.45989540054;54426.18360724513;55680;55834.720826395605;56163.15755263756;76356.61821690857;80755.59622201852;83155.5842220785;84449;85742;12747.980161586866;12917.806232906327;12923.612291631267;12998.870011299767;13171.209727416386;14607.634809129857;14732.337044833223;14801.407943682563;15003.2498375083;15005.849941500444;13782.93108534491;13801.654958625713;13979.510717124851;14222.359993800097;14270;13424.597262081763;13685.31573421345;13841.653958651113;13928.58214253574;14232.217228052557;13000.739985200433;13100.344982750634;13207.471701132232;13322.933385333012;14282.857171428153;10906.454677265947;11016.889831101907;11160.665180044612;11225.66323010311;11345.432728363714;10999.890001099886;11207.831882521932;11303.7739245213;11304.321740695585;11736.823947640622 17:29:31 INFO - PROCESS | 4874 | __end_tp_report 17:29:31 INFO - PROCESS | 4874 | __start_cc_report 17:29:31 INFO - PROCESS | 4874 | _x_x_mozilla_cycle_collect,961 17:29:31 INFO - PROCESS | 4874 | __end_cc_report 17:29:31 INFO - PROCESS | 4874 | __startTimestamp1469924971155__endTimestamp 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | ------- Summary: start ------- 17:29:31 INFO - PROCESS | 4874 | Number of tests: 6 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | [#0] dojo.html Cycles:165 Average:5387.75 Median:5545.61 stddev:609.37 (11.0%) stddev-sans-first:583.06 17:29:31 INFO - PROCESS | 4874 | Values: 3052.8 3087.8 3101.7 3111.1 3120.3 5293.9 5321.8 5393.4 5500.6 5533.5 5386.5 5403.9 5415.2 5453.8 5467.1 4887.8 4958.5 4976.4 4986.2 5134.7 5026.8 5058.5 5081.4 5090.3 5102.1 4815.5 4832.9 4883.5 4938.0 4967.3 4943.0 4943.0 4953.4 4991.4 5016.3 4957.4 4984.9 4985.8 5005.8 5020.3 5253.8 5364.6 5477.9 5487.9 5495.8 5829.5 5869.1 5871.3 5872.9 5876.8 5850.3 5907.6 5916.1 5920.7 5923.9 5227.6 5306.0 5344.0 5350.6 5486.0 5955.4 5957.9 5963.7 5967.3 5970.1 5709.6 5713.6 5720.2 5721.5 5723.5 5504.7 5657.2 5661.6 5681.2 5806.2 5702.0 5722.7 5745.6 5753.5 5753.5 5684.1 5730.1 5735.0 5739.8 5741.0 4320.2 4396.9 4412.2 4448.3 4493.0 3921.9 3961.7 3995.6 3999.4 4016.2 5498.6 5501.6 5505.3 5506.3 5512.3 5613.7 5776.5 5830.9 5836.1 5871.7 5424.3 5517.0 5536.7 5546.8 5566.7 5064.4 5077.2 5080.2 5084.2 5127.9 5867.2 5959.3 6102.4 6114.3 6116.6 5787.2 5836.9 5844.4 5893.0 5896.2 6040.0 6051.2 6051.4 6055.9 6057.8 5510.1 5611.6 5659.5 5722.6 5727.2 5733.7 5767.9 5796.0 5835.3 5845.7 5628.7 5630.9 5633.7 5640.0 5642.0 5494.9 5572.1 5608.2 5612.7 5615.0 5538.5 5545.6 5567.9 5596.3 5597.1 5626.8 5641.0 5689.6 5690.5 5701.3 5425.6 5514.3 5530.4 5533.4 5536.7 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | [#1] ext.html Cycles:180 Average:65303.25 Median:40800.09 stddev:157771.96 (386.7%) stddev-sans-first:158139.76 17:29:31 INFO - PROCESS | 4874 | Values: 600.2 610.1 616.8 637.2 643.1 42371.4 43847.0 43910.8 43952.3 47204.3 45132.3 45535.5 45578.0 45580.3 45583.0 8979.2 9112.5 9118.8 9120.0 9120.9 8952.5 9045.2 9047.2 9048.5 9052.1 9102.4 9131.4 9136.9 9137.4 9137.6 9054.2 9071.3 9102.2 9103.4 9106.1 8966.6 9010.2 9034.7 9035.5 9035.7 42860.0 42933.8 43018.8 43070.8 43242.4 3291.4 3341.3 3345.1 3359.8 3480.8 32002.0 32440.7 32720.2 33898.2 34049.5 4442.8 4459.4 4462.3 4467.8 4474.8 250655.0 250718.0 250866.0 250954.0 251612.0 34071.3 56581.7 57170.7 57186.1 57268.0 34605.8 36249.7 36326.3 36337.0 36341.5 14600.9 14639.6 14681.6 14685.9 14692.1 12296.1 12301.3 12352.3 12363.7 12382.4 8055.3 8151.3 8227.2 8248.3 8285.8 3179.8 3191.3 3200.5 3220.5 3242.7 1009.2 1017.5 1069.0 1127.7 1183.7 32785.8 32795.5 33003.3 33193.0 33477.7 1066.5 1107.1 1126.6 1137.1 1161.4 16768.5 17283.8 17391.9 17452.4 17548.8 600980.0 904645.0 931462.0 932232.0 932574.0 59020.7 59639.3 59735.0 59762.4 59911.0 1215.5 1349.1 1359.0 1369.6 1385.0 29263.3 32990.7 33253.0 33282.8 33580.5 48867.5 49472.3 49505.5 49561.8 49607.0 438139.0 439857.0 440580.0 442425.0 442793.0 23224.8 24429.6 27778.4 28123.6 28515.7 46268.5 46579.3 46930.8 46985.3 47305.3 39776.8 40126.8 40612.7 40935.6 42012.2 39813.0 40070.2 40349.4 41084.0 41681.4 30322.5 39959.8 40637.4 40698.2 40902.0 32478.4 36012.0 36317.3 36810.3 37214.6 27525.3 28302.0 28411.4 28479.3 28517.9 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | [#2] jquery.html Cycles:180 Average:29633.13 Median:23211.83 stddev:84205.36 (362.8%) stddev-sans-first:84412.93 17:29:31 INFO - PROCESS | 4874 | Values: 379.2 381.3 383.1 388.3 418.7 14452.8 17182.3 17860.6 19612.0 19630.3 19070.0 19429.9 19909.8 20180.6 20204.9 5688.1 5868.5 5869.2 5894.0 5897.4 4275.9 5756.5 5791.7 6050.4 6321.7 6361.9 6383.8 6390.1 6390.3 6395.7 6214.4 6460.6 6482.2 6490.1 6498.2 5507.3 5635.3 5742.3 5752.9 5765.3 22868.5 22974.1 23104.8 23104.9 23318.8 2287.1 2308.8 2383.8 2449.0 2895.9 14174.3 14570.5 14902.9 14934.8 15257.8 1896.3 1996.0 2019.7 2041.4 2057.8 52433.0 79713.6 82200.2 82265.6 82632.6 9814.7 10017.5 10130.7 10196.9 10575.2 13697.8 13729.8 13746.6 13748.5 13775.7 7641.5 7929.6 7970.3 8041.3 8058.2 7531.9 7625.1 7814.4 7820.1 7846.8 6420.6 6556.9 6613.5 6618.8 6655.8 1843.7 1942.2 1945.9 1986.1 2009.6 903.4 973.6 996.1 1059.2 1060.2 20113.7 20600.2 20665.7 20759.2 20980.2 1004.2 1052.3 1057.8 1070.4 1071.7 10980.8 11789.9 11849.5 11871.5 11917.1 502514.0 505485.0 508563.0 514441.0 529282.0 81034.0 82833.6 83106.0 96998.5 104609.0 973.8 1016.9 1034.7 1056.3 1057.6 18168.0 18615.6 19232.3 19233.2 19396.2 39498.0 40971.2 41405.2 44874.0 46527.3 54547.7 56251.7 57137.0 60649.1 64017.7 8157.8 8219.8 8472.4 8518.0 8717.7 12466.8 13337.9 13524.4 13672.5 13730.9 11427.5 11496.7 11520.8 11798.8 11818.5 10783.4 10994.8 11081.8 11082.0 11273.7 11366.9 11758.3 12006.4 12058.0 12090.2 8154.1 8162.4 8423.5 8500.1 8915.3 8480.3 10729.3 10820.1 11700.9 11929.7 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | [#3] mootools.html Cycles:180 Average:5603.03 Median:4949.59 stddev:3231.84 (65.3%) stddev-sans-first:3224.56 17:29:31 INFO - PROCESS | 4874 | Values: 1277.6 1449.2 1492.0 1625.3 1773.6 8192.1 8515.7 8544.7 8825.5 8835.6 8672.3 8763.4 8763.7 8765.1 8767.0 2227.7 2250.2 2250.3 2252.0 2252.6 2275.6 2284.0 2366.4 2366.5 2371.6 2279.4 2282.8 2310.8 2314.8 2318.3 2231.7 2250.6 2258.1 2266.4 2271.9 2203.6 2207.9 2208.6 2212.2 2216.9 8608.5 8608.5 8685.4 8730.5 8757.6 4964.6 5111.6 5120.7 5139.3 5146.6 3089.9 3238.2 3241.7 3312.3 3317.7 1076.8 1085.5 1093.8 1097.5 1111.3 12013.3 12079.7 12142.1 12149.3 12153.6 4072.6 4241.6 4305.5 4316.1 4319.5 9057.6 9059.3 9082.4 9082.9 9086.1 4938.8 4945.7 4953.5 4956.4 4956.5 4005.9 4210.9 4264.7 4607.7 4612.2 3671.2 3735.8 3801.1 3804.7 3809.8 1023.8 1076.2 1080.6 1095.7 1096.3 855.8 974.5 986.9 996.5 1008.8 5621.2 5667.2 5755.3 5852.0 5920.4 419.0 424.9 426.6 431.5 437.6 3830.4 3846.5 3919.3 4115.1 4169.6 10432.2 10761.5 10864.2 10875.8 10877.6 10788.7 10789.6 10791.2 10801.7 10812.6 7744.2 8083.6 8089.6 8090.4 8162.2 5692.1 5756.2 5773.8 5816.7 6008.1 9549.0 9727.9 9915.2 9937.4 9997.3 9093.9 9670.0 9873.5 10133.8 10143.4 7131.2 7310.3 7360.1 7547.8 7559.5 8334.9 8350.6 8382.1 8444.6 8456.0 7338.7 7355.7 7413.7 7464.6 7600.7 7157.5 7272.2 7423.9 7441.9 7478.0 6611.1 6690.2 6711.6 6722.6 6724.5 4942.4 5132.5 5173.1 5205.6 5452.2 5171.9 5182.9 5220.3 5220.6 5506.2 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | [#4] prototype.html Cycles:180 Average:4420.75 Median:4988.93 stddev:1291.92 (25.9%) stddev-sans-first:1258.18 17:29:31 INFO - PROCESS | 4874 | Values: 310.6 318.0 324.8 325.9 330.6 5163.6 5182.6 5280.6 5316.7 5327.1 5186.5 5208.6 5208.7 5238.1 5240.3 4161.7 4162.5 4163.1 4166.8 4167.7 3896.3 4012.7 4167.7 4174.9 4184.3 3934.2 3955.3 3968.5 3969.0 3976.0 3951.6 3956.9 3965.7 3967.5 3990.0 3315.2 3435.5 3444.1 3450.1 3469.8 5032.1 5054.7 5056.7 5067.3 5086.2 4511.6 4519.7 4520.4 4525.7 4526.4 5300.6 5377.9 5405.6 5433.8 5439.8 3730.8 3736.8 3742.3 3744.3 3750.5 5573.2 5597.6 5613.9 5628.7 5667.9 3907.4 3959.4 3970.1 3982.7 3993.9 3955.3 3980.8 3992.0 4009.3 4037.9 4560.5 4563.8 4576.5 4584.4 4589.4 5311.3 5425.9 5434.3 5441.2 5447.2 1340.5 1343.4 1345.0 1354.8 1356.7 868.0 876.0 889.4 889.9 905.6 4729.9 4734.7 4750.3 4771.2 4796.8 4899.2 4965.7 4987.4 4990.5 5029.4 4486.9 4742.0 4770.7 4783.8 4787.5 2649.3 2683.6 2683.7 2688.4 2690.7 5184.5 5190.5 5194.6 5199.2 5207.6 4735.7 5023.6 5069.4 5083.3 5151.8 5074.5 5115.0 5115.8 5128.9 5148.0 4971.9 4981.5 4982.0 5000.9 5003.7 4807.3 4919.4 4961.9 4977.5 5011.9 5187.5 5206.2 5221.9 5223.6 5236.6 3635.7 3658.8 3828.8 3856.6 3935.9 5564.3 5566.4 5569.2 5577.6 5585.2 5428.2 5454.3 5465.8 5472.6 5474.3 5302.2 5464.1 5473.3 5486.7 5488.6 5382.2 5426.0 5468.3 5470.4 5507.7 5314.9 5581.6 5597.0 5599.2 5637.2 5384.9 5385.3 5397.6 5411.8 5437.5 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - PROCESS | 4874 | [#5] yui.html Cycles:180 Average:21521.32 Median:4315.21 stddev:32464.55 (752.3%) stddev-sans-first:32518.11 17:29:31 INFO - PROCESS | 4874 | Values: 736.0 741.9 792.3 807.1 807.9 15147.8 15432.2 15822.0 15966.1 15987.8 15130.1 15187.0 15192.6 15273.1 15299.5 785.6 804.3 808.8 810.0 810.6 657.4 778.4 805.4 808.7 814.6 828.4 832.7 834.7 834.8 834.9 822.9 826.5 826.8 826.8 827.5 499.4 599.5 611.1 612.1 614.3 15055.7 15064.8 15073.9 15090.6 15104.4 11647.5 13779.6 14106.3 14139.5 14370.7 13264.3 13394.5 13415.5 13425.9 13662.2 4299.2 4331.2 4443.6 4450.2 4553.6 70692.3 71136.3 71360.3 71636.6 75543.6 10714.1 10717.1 10876.3 10896.8 10930.4 19588.0 19645.2 19660.0 19660.4 19673.2 8303.9 8330.0 8563.1 8588.6 8735.1 4227.3 4368.4 4369.4 4374.7 4675.9 3310.2 3386.4 3417.2 3418.6 3420.8 557.0 562.5 569.2 570.1 572.1 575.0 701.3 703.6 710.4 710.7 9888.6 10255.2 10293.7 10316.4 10591.4 668.1 682.8 712.8 775.2 789.0 4710.2 5131.6 5200.3 5205.8 5206.3 127861.7 128729.4 131548.0 133649.3 138573.0 115220.0 116457.0 117457.0 120440.4 120960.0 59672.0 60086.1 61621.7 62740.4 97111.5 9196.0 9273.3 9308.2 9517.5 9648.9 54010.5 54426.2 55680.0 55834.7 56163.2 76356.6 80755.6 83155.6 84449.0 85742.0 12748.0 12917.8 12923.6 12998.9 13171.2 14607.6 14732.3 14801.4 15003.2 15005.8 13782.9 13801.7 13979.5 14222.4 14270.0 13424.6 13685.3 13841.7 13928.6 14232.2 13000.7 13100.3 13207.5 13322.9 14282.9 10906.5 11016.9 11160.7 11225.7 11345.4 10999.9 11207.8 11303.8 11304.3 11736.8 17:29:31 INFO - PROCESS | 4874 | -------- Summary: end -------- 17:29:31 INFO - PROCESS | 4874 | 17:29:31 INFO - TEST-INFO | 4874: exit 0 17:29:31 INFO - TEST-OK | dromaeo_css | took 1114080ms 17:29:31 INFO - TEST-START | kraken 17:29:31 INFO - operating with platform_type : linux_ 17:29:31 INFO - Initialising browser for kraken test... 17:29:31 INFO - TEST-INFO | started process 5068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa9Mc0g/profile http://localhost:51606/getInfo.html) 17:29:36 INFO - PROCESS | 5068 | __metrics Screen width/height:1600/1200 17:29:36 INFO - PROCESS | 5068 | colorDepth:24 17:29:36 INFO - PROCESS | 5068 | Browser inner width/height: 1024/697 17:29:36 INFO - PROCESS | 5068 | __metrics 17:29:37 INFO - PROCESS | 5068 | 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" 17:29:37 INFO - PROCESS | 5068 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:29:37 INFO - TEST-INFO | 5068: exit 0 17:29:37 INFO - Browser initialized. 17:29:37 INFO - Running cycle 1/1 for kraken test... 17:29:37 INFO - TEST-INFO | started process 5147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa9Mc0g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:49 INFO - PROCESS | 5147 | RSS: Main: 155750400 17:29:49 INFO - PROCESS | 5147 | 17:29:52 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51606/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:53 INFO - PROCESS | 5147 | RSS: Main: 212353024 17:29:53 INFO - PROCESS | 5147 | 17:29:55 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51606/tests/kraken/driver.html?testName=audio-dft) 17:29:56 INFO - PROCESS | 5147 | RSS: Main: 191107072 17:29:56 INFO - PROCESS | 5147 | 17:29:59 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51606/tests/kraken/driver.html?testName=audio-fft) 17:29:59 INFO - PROCESS | 5147 | RSS: Main: 268500992 17:29:59 INFO - PROCESS | 5147 | 17:30:01 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51606/tests/kraken/driver.html?testName=audio-oscillator) 17:30:02 INFO - PROCESS | 5147 | RSS: Main: 179204096 17:30:02 INFO - PROCESS | 5147 | 17:30:04 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:05 INFO - PROCESS | 5147 | RSS: Main: 184139776 17:30:05 INFO - PROCESS | 5147 | 17:30:08 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51606/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:08 INFO - PROCESS | 5147 | RSS: Main: 220024832 17:30:08 INFO - PROCESS | 5147 | 17:30:12 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51606/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:12 INFO - PROCESS | 5147 | RSS: Main: 219541504 17:30:12 INFO - PROCESS | 5147 | 17:30:15 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51606/tests/kraken/driver.html?testName=json-parse-financial) 17:30:16 INFO - PROCESS | 5147 | RSS: Main: 219729920 17:30:16 INFO - PROCESS | 5147 | 17:30:17 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:18 INFO - PROCESS | 5147 | RSS: Main: 183328768 17:30:18 INFO - PROCESS | 5147 | 17:30:20 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:20 INFO - PROCESS | 5147 | RSS: Main: 189386752 17:30:20 INFO - PROCESS | 5147 | 17:30:22 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:23 INFO - PROCESS | 5147 | RSS: Main: 194347008 17:30:23 INFO - PROCESS | 5147 | 17:30:25 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:26 INFO - PROCESS | 5147 | RSS: Main: 187289600 17:30:26 INFO - PROCESS | 5147 | 17:30:29 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:29 INFO - PROCESS | 5147 | RSS: Main: 192462848 17:30:29 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:51606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51606/tests/kraken/driver.html?testName=ai-astar) 17:30:31 INFO - PROCESS | 5147 | RSS: Main: 242638848 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | __start_tp_report 17:30:31 INFO - PROCESS | 5147 | _x_x_mozilla_page_load 17:30:31 INFO - PROCESS | 5147 | _x_x_mozilla_page_load_details 17:30:31 INFO - PROCESS | 5147 | |i|pagename|runs| 17:30:31 INFO - PROCESS | 5147 | |0;ai-astar;103;113;110;109;110;111;110;111;113;111 17:30:31 INFO - PROCESS | 5147 | |1;audio-beat-detection;140;116;128;171;118;120;145;117;174;127 17:30:31 INFO - PROCESS | 5147 | |2;audio-dft;162;162;161;161;163;160;162;160;161;162 17:30:31 INFO - PROCESS | 5147 | |3;audio-fft;74;75;75;125;74;75;74;75;97;74 17:30:31 INFO - PROCESS | 5147 | |4;audio-oscillator;84;83;112;84;85;83;110;84;84;120 17:30:31 INFO - PROCESS | 5147 | |5;imaging-gaussian-blur;116;116;116;116;117;117;119;117;116;117 17:30:31 INFO - PROCESS | 5147 | |6;imaging-darkroom;145;145;145;145;145;145;145;146;145;145 17:30:31 INFO - PROCESS | 5147 | |7;imaging-desaturate;95;94;95;94;95;94;95;95;94;95 17:30:31 INFO - PROCESS | 5147 | |8;json-parse-financial;51;53;53;52;52;53;53;53;52;53 17:30:31 INFO - PROCESS | 5147 | |9;json-stringify-tinderbox;62;62;63;63;63;63;64;63;63;63 17:30:31 INFO - PROCESS | 5147 | |10;stanford-crypto-aes;77;76;75;77;77;76;75;76;77;81 17:30:31 INFO - PROCESS | 5147 | |11;stanford-crypto-ccm;122;121;122;142;120;120;122;127;181;120 17:30:31 INFO - PROCESS | 5147 | |12;stanford-crypto-pbkdf2;160;160;158;164;163;163;160;163;163;159 17:30:31 INFO - PROCESS | 5147 | |13;stanford-crypto-sha256-iterative;64;62;63;63;62;64;62;65;63;67 17:30:31 INFO - PROCESS | 5147 | __end_tp_report 17:30:31 INFO - PROCESS | 5147 | __start_cc_report 17:30:31 INFO - PROCESS | 5147 | _x_x_mozilla_cycle_collect,1654 17:30:31 INFO - PROCESS | 5147 | __end_cc_report 17:30:31 INFO - PROCESS | 5147 | __startTimestamp1469925031726__endTimestamp 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | ------- Summary: start ------- 17:30:31 INFO - PROCESS | 5147 | Number of tests: 14 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.81 (2.5%) stddev-sans-first:1.36 17:30:31 INFO - PROCESS | 5147 | Values: 103.0 113.0 110.0 109.0 110.0 111.0 110.0 111.0 113.0 111.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:134.00 stddev:21.73 (16.2%) stddev-sans-first:22.99 17:30:31 INFO - PROCESS | 5147 | Values: 140.0 116.0 128.0 171.0 118.0 120.0 145.0 117.0 174.0 127.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 17:30:31 INFO - PROCESS | 5147 | Values: 162.0 162.0 161.0 161.0 163.0 160.0 162.0 160.0 161.0 162.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:16.75 (22.3%) stddev-sans-first:17.53 17:30:31 INFO - PROCESS | 5147 | Values: 74.0 75.0 75.0 125.0 74.0 75.0 74.0 75.0 97.0 74.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:84.00 stddev:14.78 (17.6%) stddev-sans-first:15.33 17:30:31 INFO - PROCESS | 5147 | Values: 84.0 83.0 112.0 84.0 85.0 83.0 110.0 84.0 84.0 120.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 17:30:31 INFO - PROCESS | 5147 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 119.0 117.0 116.0 117.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 17:30:31 INFO - PROCESS | 5147 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:30:31 INFO - PROCESS | 5147 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.71 (1.3%) stddev-sans-first:0.50 17:30:31 INFO - PROCESS | 5147 | Values: 51.0 53.0 53.0 52.0 52.0 53.0 53.0 53.0 52.0 53.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 17:30:31 INFO - PROCESS | 5147 | Values: 62.0 62.0 63.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:77.00 stddev:1.70 (2.2%) stddev-sans-first:1.80 17:30:31 INFO - PROCESS | 5147 | Values: 77.0 76.0 75.0 77.0 77.0 76.0 75.0 76.0 77.0 81.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:122.00 stddev:19.22 (15.8%) stddev-sans-first:20.19 17:30:31 INFO - PROCESS | 5147 | Values: 122.0 121.0 122.0 142.0 120.0 120.0 122.0 127.0 181.0 120.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:163.00 stddev:2.11 (1.3%) stddev-sans-first:2.19 17:30:31 INFO - PROCESS | 5147 | Values: 160.0 160.0 158.0 164.0 163.0 163.0 160.0 163.0 163.0 159.0 17:30:31 INFO - PROCESS | 5147 | 17:30:31 INFO - PROCESS | 5147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.58 (2.5%) stddev-sans-first:1.67 17:30:31 INFO - PROCESS | 5147 | Values: 64.0 62.0 63.0 63.0 62.0 64.0 62.0 65.0 63.0 67.0 17:30:31 INFO - PROCESS | 5147 | -------- Summary: end -------- 17:30:31 INFO - PROCESS | 5147 | 17:30:32 INFO - TEST-INFO | 5147: exit 0 17:30:32 INFO - TEST-OK | kraken | took 60784ms 17:30:32 INFO - SUITE-END | took 1174s 17:30:32 INFO - Completed test suite (00:19:34) 17:30:32 INFO - javascript benchmark 17:30:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.8168309901403, 3087.7684173686953, 3101.674324195959, 3111.066679996002, 3120.313531023174, 5293.8941221175555, 5321.813736519222, 5393.4067252602235, 5500.587455940806, 5533.529649979747, 5386.461353864612, 5403.945960540404, 5415.214793854899, 5453.836384908459, 5467.097928841737, 4887.780049897745, 4958.479359667237, 4976.3530741003615, 4986.177280748672, 5134.7432628368615, 5026.82406115786, 5058.544730974211, 5081.390233172025, 5090.33825602673, 5102.056119617882, 4815.494373090845, 4832.9275060874115, 4883.511648835123, 4938.012397520511, 4967.329410529586, 4942.950570494285, 4942.975285123587, 4953.356063711731, 4991.401031876162, 5016.347874776256, 4957.355543779322, 4984.925226121611, 4985.800567977277, 5005.774740136702, 5020.322256495363, 5253.789848406059, 5364.624476286662, 5477.945220547784, 5487.862803429906, 5495.752691128869, 5829.47534721877, 5869.1196320551835, 5871.32479764824, 5872.882542349172, 5876.794312199096, 5850.3272123705465, 5907.556933230025, 5916.083007133858, 5920.674362910038, 5923.851903702399, 5227.555657769094, 5305.973470132663, 5343.973280133574, 5350.625456218105, 5486.039943009957, 5955.40445955401, 5957.940420595825, 5963.701814909237, 5967.283925928829, 5970.13433052205, 5709.571782116358, 5713.600047996683, 5720.1991721159075, 5721.485066344049, 5723.54211663066, 5504.697241651667, 5657.179708942181, 5661.603687741818, 5681.17622944679, 5806.187133801272, 5702.0, 5722.685252311163, 5745.626534275342, 5753.453421924911, 5753.539716822645, 5684.147377893349, 5730.08318669011, 5735.0250457422335, 5739.7704091836695, 5741.0, 4320.222359975234, 4396.868093957187, 4412.183746006999, 4448.266036104072, 4493.0339976905125, 3921.9019524512114, 3961.7226794124135, 3995.6403923647013, 3999.4000899864673, 4016.216837716676, 5498.560115190775, 5501.642393244426, 5505.284313039279, 5506.284183056177, 5512.310961129859, 5613.663180209201, 5776.537876969833, 5830.883382332415, 5836.066229403275, 5871.735771890275, 5424.267723857308, 5516.972415137899, 5536.723163841792, 5546.805861794818, 5566.749496272678, 5064.366954130734, 5077.23841423782, 5080.23796430531, 5084.161113416319, 5127.897442051138, 5867.207926929896, 5959.344472108151, 6102.420270074336, 6114.296855861544, 6116.602420842631, 5787.247657804459, 5836.854078648068, 5844.415558444121, 5893.0, 5896.174535564938, 6039.969800150971, 6051.183090282755, 6051.364606716407, 6055.878882422238, 6057.7879774207695, 5510.1459273812625, 5611.57913156523, 5659.490645841894, 5722.628029178257, 5727.198192253171, 5733.684647344436, 5767.9269362685245, 5796.01467750475, 5835.328937172279, 5845.707714614337, 5628.690422026828, 5630.915536266877, 5633.6619802811965, 5639.971800140973, 5642.0, 5494.862628434321, 5572.136318870582, 5608.158776183605, 5612.663240205601, 5614.9719251403485, 5538.529225015919, 5545.611807173459, 5567.860803479945, 5596.272484576979, 5597.076482380362, 5626.774929002794, 5641.041023026013, 5689.601727879009, 5690.544756419394, 5701.287339082614, 5425.565954723534, 5514.283143191359, 5530.391656917816, 5533.418991005887, 5536.667799932017], "value": 5346.40916377158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1537831657362, 610.1214251477871, 616.7717944360586, 637.2448648351707, 643.0514990389175, 42371.36442953354, 43847.0, 43910.78044609773, 43952.3407148893, 47204.29193562099, 45132.3230151548, 45535.54464455354, 45578.0, 45580.316295255514, 45583.0, 8979.19187273147, 9112.498812565307, 9118.77203069922, 9120.042395548438, 9120.8631870522, 8952.507612081334, 9045.185933266004, 9047.230985366252, 9048.502332371718, 9052.140046695553, 9102.362834601581, 9131.406458580204, 9136.908630913673, 9137.40606860552, 9137.5888085036, 9054.230390416757, 9071.319651026199, 9102.226310763526, 9103.408278461946, 9106.134917182857, 8966.596503157374, 9010.23413009895, 9034.728958131267, 9035.548222588845, 9035.734997100411, 42860.0, 42933.78533107346, 43018.78490607527, 43070.784646076885, 43242.351364729555, 3291.358185153896, 3341.331733653279, 3345.130266130799, 3359.8320083995704, 3480.8259587020802, 32002.0, 32440.675593244003, 32720.181995450068, 33898.1525461863, 34049.48925766115, 4442.800073996678, 4459.35339375792, 4462.286034234539, 4467.843625473125, 4474.8433804817005, 250655.0, 250718.0, 250866.0, 250954.0, 251612.0, 34071.31857362889, 56581.71709141428, 57170.714146429, 57186.14220786691, 57268.0, 34605.82697086498, 36249.737523623, 36326.27347453036, 36337.0, 36341.454878176846, 14600.926995364955, 14639.634009149644, 14681.632959176106, 14685.853141468662, 14692.118472891447, 12296.139270251175, 12301.32342721159, 12352.320622365676, 12363.69090772738, 12382.442790074469, 8055.275025247756, 8151.266386025286, 8227.177282271725, 8248.340132789363, 8285.8342833143, 3179.8410079495934, 3191.2979144588153, 3200.48792193248, 3220.533022711694, 3242.6595207503347, 1009.2228983682523, 1017.5217647705566, 1069.0485467933545, 1127.720037757135, 1183.7454947186225, 32785.84589780654, 32795.50806737901, 33003.339933201205, 33193.0, 33477.66522334794, 1066.5253961986996, 1107.06453047175, 1126.6000569797604, 1137.147139645266, 1161.3960740415105, 16768.496945091665, 17283.777979763705, 17391.913040434716, 17452.389166379115, 17548.824511754974, 600980.0, 904645.0, 931462.0, 932232.0, 932574.0, 59020.704896476105, 59639.33426324492, 59735.0, 59762.40237597568, 59911.0, 1215.477344741752, 1349.0893646788575, 1358.952436664712, 1369.5617402431326, 1385.0166381868985, 29263.268418289714, 32990.67009329972, 33253.0, 33282.83358583192, 33580.496292555144, 48867.51132488772, 49472.25791613057, 49505.50494495153, 49561.75219123881, 49607.0, 438139.0, 439857.0, 440580.0, 442425.0, 442793.0, 23224.76775232226, 24429.633555497036, 27778.44443111086, 28123.57814632741, 28515.714842851306, 46268.53731462777, 46579.30131047969, 46930.76534617305, 46985.29522057103, 47305.29042064441, 39776.80111599423, 40126.799366004154, 40612.68015252394, 40935.59064409318, 42012.159756805304, 39813.0, 40070.19859602733, 40349.39475907805, 41084.0, 41681.37477937773, 30322.545161823033, 39959.80020099881, 40637.390439142844, 40698.1860362797, 40902.0, 32478.35043299168, 36012.0, 36317.27365452729, 36810.26379472342, 37214.62785372112, 27525.31186720268, 28302.0, 28411.43177136487, 28479.28801779972, 28517.857410712815], "value": 18950.05361105561, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.23583978283756, 381.3041199810346, 383.10927094505263, 388.3289329144906, 418.7278269125068, 14452.783208251858, 17182.312707491685, 17860.553486162837, 19612.0, 19630.31293904712, 19070.0, 19429.902850485727, 19909.800901990977, 20180.59638807223, 20204.898975505137, 5688.146777983305, 5868.530517558585, 5869.2369991901205, 5893.970530147343, 5897.380775018604, 4275.87172384829, 5756.453136951983, 5791.739371728261, 6050.42520960508, 6321.652309123019, 6361.936380636181, 6383.776567820128, 6390.105385246069, 6390.329015453357, 6395.712192951305, 6214.378562143772, 6460.612363258196, 6482.222133343982, 6490.05894145351, 6498.220213574401, 5507.284053073115, 5635.295588051494, 5742.310922689262, 5752.856178595569, 5765.336986246593, 22868.54262914749, 22974.08103675851, 23104.76895231043, 23104.884475577514, 23318.766812332, 2287.0737351372554, 2308.792208701208, 2383.84505007174, 2448.9755102449103, 2895.869685864141, 14174.291285435687, 14570.4900328488, 14902.91674367723, 14934.759464210574, 15257.847421525754, 1896.2509808625653, 1996.0418998880618, 2019.6768517037203, 2041.3875837248765, 2057.804508571683, 52433.0, 79713.60143199305, 82200.17799821985, 82265.58867205685, 82632.58683706603, 9814.65648702292, 10017.499125043718, 10130.746731331628, 10196.949015254877, 10575.153987680967, 13697.794533082011, 13729.794053089212, 13746.587602371945, 13748.450061997408, 13775.724485510234, 7641.472274497777, 7929.603519823986, 7970.322522585529, 8041.3164880984605, 8058.234467725557, 7531.887021694679, 7625.084989801148, 7814.3748500119855, 7820.061592608923, 7846.8430631387055, 6420.646864422408, 6556.934430655632, 6613.537052406382, 6618.801435956929, 6655.800325990228, 1843.7142242952364, 1942.155162504315, 1945.9416217513497, 1986.1261045140093, 2009.5880344529337, 903.3992395057345, 973.5813600151861, 996.0985308296003, 1059.2479339668766, 1060.2154405739852, 20113.698294525595, 20600.175992960412, 20665.690014649794, 20759.169633214504, 20980.160793568393, 1004.1715584642553, 1052.347544522401, 1057.8254587992894, 1070.4433694478828, 1071.7427817323787, 10980.835287470694, 11789.882101178879, 11849.466773995191, 11871.46578403974, 11917.106217033757, 502514.0, 505485.0, 508563.0, 514441.0, 529282.0, 81034.0, 82833.58583207167, 83106.0, 96998.51500742593, 104609.0, 973.7662960889336, 1016.913562347194, 1034.715453250362, 1056.2922841696081, 1057.5505410200633, 18168.0, 18615.627687446446, 19232.326868559532, 19233.230670773573, 19396.2241510338, 39498.0, 40971.1805763889, 41405.23839758466, 44874.0, 46527.302090467994, 54547.72726136344, 56251.71874140767, 57137.0, 60649.09026364696, 64017.67991160014, 8157.75526734199, 8219.794505137419, 8472.40693151498, 8518.0204276509, 8717.738467845975, 12466.812997804858, 13337.866621333662, 13524.39140238672, 13672.52146174879, 13730.93134534361, 11427.542898284308, 11496.712582185512, 11520.769584608093, 11798.764024719629, 11818.468168932246, 10783.352998820095, 10994.84023715913, 11081.778364432828, 11082.0, 11273.661790146309, 11366.943165284121, 11758.294502329887, 12006.399680016139, 12058.0, 12090.153689241668, 8154.1030486647605, 8162.387820913336, 8423.4945903246, 8500.149985001697, 8915.331350148635, 8480.279176270085, 10729.276492470459, 10820.134389248999, 11700.88299116998, 11929.701757456132], "value": 9445.879096284674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.597556769618, 1449.2391494465405, 1492.0376357249575, 1625.3498600559774, 1773.5743421578818, 8192.139825318345, 8515.659373625056, 8544.700935467252, 8825.470471771681, 8835.602397892095, 8672.349573781976, 8763.386562940597, 8763.737087887357, 8765.079666635007, 8767.0, 2227.676986836908, 2250.246167533878, 2250.2686626846257, 2251.966220506694, 2252.628316327804, 2275.5562665280277, 2283.9657405138937, 2366.396568874943, 2366.4675448024227, 2371.632396978471, 2279.430142464384, 2282.8402011859093, 2310.757370476101, 2314.826388020905, 2318.2697450303185, 2231.6764069210035, 2250.628646273363, 2258.0516183203094, 2266.354089084611, 2271.886405679726, 2203.603351396748, 2207.9227227047136, 2208.6134926387977, 2212.23677831148, 2216.9224077157382, 8608.52653104079, 8608.52653104079, 8685.392022558424, 8730.51982140982, 8757.605907734167, 4964.553190212898, 5111.565516931066, 5120.6927584344685, 5139.331886854685, 5146.639735218536, 3089.8556183924343, 3238.2151349839355, 3241.692039256267, 3312.287858110518, 3317.6516465770987, 1076.8169411200035, 1085.478970094359, 1093.8468614393992, 1097.5390336058874, 1111.283222321598, 12013.279203247746, 12079.698007549794, 12142.0893432992, 12149.271043737404, 12153.574624888086, 4072.615310794344, 4241.618254357061, 4305.504866940342, 4316.093620339701, 4319.503257125471, 9057.637694492278, 9059.320550958704, 9082.40964337316, 9082.86375704365, 9086.091390860993, 4938.777755001033, 4945.703257804544, 4953.479884612136, 4956.405231372186, 4956.504349565014, 4005.919881602352, 4210.852620158341, 4264.701470897007, 4607.746573938399, 4612.192866248461, 3671.2473942841652, 3735.7945313007504, 3801.125741079567, 3804.695624350101, 3809.790461524643, 1023.82083135451, 1076.1767248055244, 1080.6325849211305, 1095.70963694621, 1096.309325125166, 855.7774978505633, 974.5322245322285, 986.9457179855177, 996.4917891875195, 1008.7528555503802, 5621.213030175779, 5667.1782591524, 5755.251817263729, 5851.970740146272, 5920.407959204045, 418.99581004189565, 424.87890951078793, 426.60325896915543, 431.52101167703825, 437.56462319991175, 3830.4254361845387, 3846.538415390171, 3919.2553414851086, 4115.050193857244, 4169.583041695806, 10432.217583681102, 10761.461926903623, 10864.239503234698, 10875.83686244707, 10877.564897404174, 10788.730281743019, 10789.62236321725, 10791.190660700478, 10801.675949721364, 10812.567497300177, 7744.186860379692, 8083.555404452812, 8089.595520223966, 8090.352771778244, 8162.18378162179, 5692.089265717465, 5756.222909907109, 5773.826785196451, 5816.738246778989, 6008.128821320972, 9548.997355277595, 9727.854082188915, 9915.20678345745, 9937.403755774387, 9997.250206234416, 9093.863592045993, 9670.0, 9873.50632468388, 10133.797324053625, 10143.391396516232, 7131.179914309921, 7310.268973102648, 7360.116785985716, 7547.811304717426, 7559.470837041575, 8334.874976875473, 8350.624221909908, 8382.119877413028, 8444.577771111542, 8456.0, 7338.743143990148, 7355.7057717690695, 7413.66638501258, 7464.552126872405, 7600.695972161052, 7157.534760240567, 7272.236415176542, 7423.851522969619, 7441.851162976602, 7477.9530865679935, 6611.140551728245, 6690.19717633887, 6711.597304161766, 6722.563033402813, 6724.529282950147, 4942.4316203637045, 5132.46109158533, 5173.14643083902, 5205.609579281645, 5452.2094296327605, 5171.896562068813, 5182.870428239325, 5220.269162317202, 5220.608454366014, 5506.201600767947], "value": 4389.2692854542875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.579165231112, 318.00781561528026, 324.7742818740974, 325.86802345050256, 330.6263921768401, 5163.586913046956, 5182.559482443988, 5280.630355875085, 5316.73416329183, 5327.147656374981, 5186.455422180673, 5208.635395522315, 5208.7395630218525, 5238.114278859617, 5240.266362709214, 4161.709869940313, 4162.4796900387455, 4163.146554956242, 4166.812493437795, 4167.708260421772, 3896.318144324746, 4012.6990475714438, 4167.729097608646, 4174.937375939348, 4184.288670925935, 3934.1934903344745, 3955.307821131305, 3968.503937007874, 3969.0, 3975.9602403975878, 3951.6245956634075, 3956.8615098471414, 3965.7223994320266, 3967.543732470774, 3989.962609721464, 3315.1712071982006, 3435.47492592944, 3444.121748954026, 3450.1374656335915, 3469.7744646598144, 5032.094223039888, 5054.671446355975, 5056.710538812616, 5067.290579318898, 5086.18621020635, 4511.623954693817, 4519.728816271035, 4520.434945631796, 4525.705829121097, 4526.352084030846, 5300.595342234311, 5377.946220537784, 5405.621606487547, 5433.782648694048, 5439.755211015474, 3730.8321125549414, 3736.831842567091, 3742.3450896093077, 3744.2885851688366, 3750.474933509311, 5573.247611572467, 5597.600599850038, 5613.859653508654, 5628.690422026787, 5667.914981275326, 3907.3943538751537, 3959.3862951242604, 3970.146418520032, 3982.721209515364, 3993.9201215975518, 3955.3473676843573, 3980.8208630611693, 3992.0, 4009.3384591542067, 4037.8586749464216, 4560.475545312265, 4563.8134085137435, 4576.473705523841, 4584.358189853423, 4589.380433641416, 5311.256424100629, 5425.856786569283, 5434.3207099112615, 5441.183822426668, 5447.1829225616475, 1340.477213886585, 1343.4491858338035, 1344.9798253026213, 1354.8077691631302, 1356.7354365898555, 867.9956600217084, 876.0, 889.4174315823017, 889.9009722992099, 905.6060613633091, 4729.905401891943, 4734.715917044989, 4750.292333369946, 4771.212749896228, 4796.832110876103, 4899.240617704261, 4965.677230980047, 4987.401511818605, 4990.451050384455, 5029.371328583927, 4486.932696009562, 4741.95258047422, 4770.689905156154, 4783.832565860178, 4787.54518320759, 2649.284693132843, 2683.6242925990377, 2683.745044220796, 2688.4085501189707, 2690.690570584408, 5184.507471790174, 5190.532852043334, 5194.649391158326, 5199.206273835521, 5207.609429292818, 4735.7086824656535, 5023.572996295356, 5069.366329208849, 5083.313752643419, 5151.7681704323395, 5074.49255074497, 5114.951434955825, 5115.795368185305, 5128.9230661540105, 5148.0, 4971.850844474671, 4981.476944920876, 4981.950180498148, 5000.949990500194, 5003.749812509287, 4807.254875494304, 4919.385076865392, 4961.883576195327, 4977.531628169626, 5011.920053177891, 5187.481251874782, 5206.219067139959, 5221.9216711748595, 5223.5559977402345, 5236.591168062734, 3635.6727894489622, 3658.798766067892, 3828.7511311764647, 3856.5564960028833, 3935.9409608856463, 5564.276644036249, 5566.415526369673, 5569.248151499496, 5577.609567330248, 5585.1901474286815, 5428.158635411518, 5454.263674403905, 5465.781368745205, 5472.562195024469, 5474.2609747683555, 5302.231176479312, 5464.104024866827, 5473.343198816167, 5486.698231597141, 5488.600406896216, 5382.246485491956, 5425.972870135782, 5468.26178465902, 5470.398256191736, 5507.669539827623, 5314.920276195783, 5581.609287349846, 5596.972015139898, 5599.236240584203, 5637.196097248841, 5384.865378365415, 5385.3268341457315, 5397.649152805055, 5411.756470958738, 5437.5378092860965], "value": 4009.42180464078, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.0210919477092, 741.8775901976178, 792.2504585012847, 807.1363640904232, 807.8707406814904, 15147.848521514808, 15432.228388580568, 15822.0, 15966.121863297529, 15987.760183597255, 15130.09219446834, 15187.0, 15192.620184495394, 15273.083614983108, 15299.46451874182, 785.6229010075153, 804.3203493048364, 808.8261023879865, 809.9757007289761, 810.5947026486757, 657.3590749019716, 778.3656320099101, 805.3637626275265, 808.7088648086684, 814.5560669435172, 828.3911325175991, 832.6794184239081, 834.6953362022848, 834.8413801377719, 834.9499030058186, 822.8518866604009, 826.4875777018257, 826.8057006603443, 826.8098337382376, 827.5159031966307, 499.37827404881153, 599.469469519474, 611.0833749375936, 612.063542779548, 614.3457218062749, 15055.698886022328, 15064.849351506564, 15073.924630376778, 15090.622734431618, 15104.39582416702, 11647.534098636044, 13779.586612401645, 14106.294685265695, 14139.505117320947, 14370.728901143646, 13264.270465124415, 13394.464221431132, 13415.46338146473, 13425.932870335684, 13662.248576328298, 4299.226139294926, 4331.198728235255, 4443.622292105175, 4450.154470650566, 4553.612942899857, 70692.2930770696, 71136.28863711348, 71360.28639713589, 71636.64181679058, 75543.62228188824, 10714.089302409227, 10717.14262858985, 10876.347419154876, 10896.78206435867, 10930.398828064534, 19588.0, 19645.214191432184, 19660.0, 19660.410187694393, 19673.21307147698, 8303.875441868377, 8330.0, 8563.143685631512, 8588.570571471402, 8735.078282777778, 4227.2794883236165, 4368.388425620416, 4369.43197384338, 4374.671899607479, 4675.883102922454, 3310.2386451116377, 3386.3904497190742, 3417.1798768295926, 3418.6068602110577, 3420.7605467617027, 556.9749361278753, 562.4768964862717, 569.1576466829033, 570.1020892094967, 572.0561074227475, 574.9683767392834, 701.2671758012889, 703.5673061067407, 710.3606753921408, 710.6517806274888, 9888.604455821687, 10255.230857685703, 10293.74265643365, 10316.43259620713, 10591.417472039111, 668.108075718911, 682.8429461223847, 712.7505373119367, 775.2131586439768, 788.9960550197327, 4710.246360582359, 5131.56381707559, 5200.297959775382, 5205.817796377109, 5206.323177986837, 127861.72138278498, 128729.35635321763, 131548.0, 133649.3317533406, 138573.0, 115220.0, 116457.0, 117457.0, 120440.39779801045, 120960.0, 59671.999999999134, 60086.09870851941, 61621.69189154026, 62740.37259627345, 97111.51444242733, 9195.965331440475, 9273.3045021625, 9308.162265396148, 9517.474846248224, 9648.855267170858, 54010.45989540054, 54426.18360724513, 55680.0, 55834.720826395605, 56163.15755263756, 76356.61821690857, 80755.59622201852, 83155.5842220785, 84449.0, 85742.0, 12747.980161586866, 12917.806232906327, 12923.612291631267, 12998.870011299767, 13171.209727416386, 14607.634809129857, 14732.337044833223, 14801.407943682563, 15003.2498375083, 15005.849941500444, 13782.93108534491, 13801.654958625713, 13979.510717124851, 14222.359993800097, 14270.0, 13424.597262081763, 13685.31573421345, 13841.653958651113, 13928.58214253574, 14232.217228052557, 13000.739985200433, 13100.344982750634, 13207.471701132232, 13322.933385333012, 14282.857171428153, 10906.454677265947, 11016.889831101907, 11160.665180044612, 11225.66323010311, 11345.432728363714, 10999.890001099886, 11207.831882521932, 11303.7739245213, 11304.321740695585, 11736.823947640622], "value": 7578.260447609052, "unit": "score"}], "name": "dromaeo_css", "value": 7095.793951601031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 109.0, 110.0, 111.0, 110.0, 111.0, 113.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 128.0, 171.0, 118.0, 120.0, 145.0, 117.0, 174.0, 127.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 163.0, 160.0, 162.0, 160.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 125.0, 74.0, 75.0, 74.0, 75.0, 97.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 84.0, 85.0, 83.0, 110.0, 84.0, 84.0, 120.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 119.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 77.0, 77.0, 76.0, 75.0, 76.0, 77.0, 81.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 122.0, 142.0, 120.0, 120.0, 122.0, 127.0, 181.0, 120.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 158.0, 164.0, 163.0, 163.0, 160.0, 163.0, 163.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 62.0, 64.0, 62.0, 65.0, 63.0, 67.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1484.8000000000002, "alertThreshold": 2.0}]} 17:30:32 INFO - Return code: 0 17:30:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:30:33 INFO - # TBPL SUCCESS # 17:30:33 INFO - Running post-action listener: _resource_record_post_action 17:30:33 INFO - [mozharness: 2016-07-31 00:30:33.018036Z] Finished run-tests step (success) 17:30:33 INFO - Running post-run listener: _resource_record_post_run 17:30:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 208896; Write bytes: 287047680; Read time: 332; Write time: 289556 17:30:33 INFO - TinderboxPrint: CPU usage
13.1% 17:30:33 INFO - TinderboxPrint: I/O read bytes / time
208,896 / 332 17:30:33 INFO - TinderboxPrint: I/O write bytes / time
287,047,680 / 289,556 17:30:33 INFO - TinderboxPrint: CPU idle
8,269.8 (86.9%) 17:30:33 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 17:30:33 INFO - TinderboxPrint: Swap in / out
0 / 0 17:30:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 626688; Read time: 0; Write time: 36 17:30:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 204800; Write bytes: 285384704; Read time: 320; Write time: 289376 17:30:33 INFO - Running post-run listener: _upload_blobber_files 17:30:33 INFO - Blob upload gear active. 17:30:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:33 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 17:30:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:30:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:35 INFO - (blobuploader) - INFO - Done attempting. 17:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:38 INFO - (blobuploader) - INFO - Done attempting. 17:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:39 INFO - (blobuploader) - INFO - Done attempting. 17:30:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:39 INFO - Return code: 0 17:30:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f365e22522017d00d8e99dc0607afa48bf979e9fb1b92f5d990d5f089cd3f56c3e66631494cb9e7897f2947b76d8d102eef404bf862b16c0132711ecf94f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af15194f5e430a7f53ba3016931d6410f9f3c6d3e4449de940ed7eeab110ceaaf9c9b4f6d2d0063099159de8ce1e6f152d4a636a5878ca0d5b20d486d0b2c09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90464caaeae7b56adb64002920736d7b53fb1cc0e79c1faa15dc322a9fd203f226fad60533bb2f06dba427f9c0b46423760068d281a22a078364f2dc820090da"} 17:30:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:39 INFO - Contents: 17:30:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f365e22522017d00d8e99dc0607afa48bf979e9fb1b92f5d990d5f089cd3f56c3e66631494cb9e7897f2947b76d8d102eef404bf862b16c0132711ecf94f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af15194f5e430a7f53ba3016931d6410f9f3c6d3e4449de940ed7eeab110ceaaf9c9b4f6d2d0063099159de8ce1e6f152d4a636a5878ca0d5b20d486d0b2c09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90464caaeae7b56adb64002920736d7b53fb1cc0e79c1faa15dc322a9fd203f226fad60533bb2f06dba427f9c0b46423760068d281a22a078364f2dc820090da"} 17:30:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:39 INFO - Copying logs to upload dir... 17:30:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.786028 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-30 17:30:39.660810) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 17:30:39.668854) ========= 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=836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f365e22522017d00d8e99dc0607afa48bf979e9fb1b92f5d990d5f089cd3f56c3e66631494cb9e7897f2947b76d8d102eef404bf862b16c0132711ecf94f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af15194f5e430a7f53ba3016931d6410f9f3c6d3e4449de940ed7eeab110ceaaf9c9b4f6d2d0063099159de8ce1e6f152d4a636a5878ca0d5b20d486d0b2c09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90464caaeae7b56adb64002920736d7b53fb1cc0e79c1faa15dc322a9fd203f226fad60533bb2f06dba427f9c0b46423760068d281a22a078364f2dc820090da"} build_url:https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/crj9dvvNTpiWt6mCnK5Ryg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f365e22522017d00d8e99dc0607afa48bf979e9fb1b92f5d990d5f089cd3f56c3e66631494cb9e7897f2947b76d8d102eef404bf862b16c0132711ecf94f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6af15194f5e430a7f53ba3016931d6410f9f3c6d3e4449de940ed7eeab110ceaaf9c9b4f6d2d0063099159de8ce1e6f152d4a636a5878ca0d5b20d486d0b2c09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90464caaeae7b56adb64002920736d7b53fb1cc0e79c1faa15dc322a9fd203f226fad60533bb2f06dba427f9c0b46423760068d281a22a078364f2dc820090da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 17:30:39.698320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 17:30:39.698785) ========= 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=836cfdc75598d54cb747368e000001a9-1469918186.904103-658189462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005146 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 17:30:39.778192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 17:30:39.780568) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 17:30:39.780966) ========= ========= Total master_lag: 0.21 =========