builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1469659994.49 results: success (0) buildid: 20160727131625 builduid: 0dffb885355149a08691c447b656af38 revision: f430f9a12c98a00bfb0edce37947614e0a2b83cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.492157) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.492686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.493058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.508685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.509086) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 15:53:14-- 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% 37.8M=0s 2016-07-27 15:53:14 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.660991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.661325) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014778 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.712881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:14.713307) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f430f9a12c98a00bfb0edce37947614e0a2b83cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f430f9a12c98a00bfb0edce37947614e0a2b83cc --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=7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 15:53:14,971 truncating revision to first 12 chars 2016-07-27 15:53:14,971 Setting DEBUG logging. 2016-07-27 15:53:14,972 attempt 1/10 2016-07-27 15:53:14,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f430f9a12c98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 15:53:15,279 unpacking tar archive at: mozilla-aurora-f430f9a12c98/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645584 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:15.374156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:15.374502) ========= script_repo_revision: f430f9a12c98a00bfb0edce37947614e0a2b83cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:15.375119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:15.375490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 15:53:15.385568) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-27 15:53:15.386040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:15 INFO - MultiFileLogger online at 20160727 15:53:15 in /builds/slave/test 15:53:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:53:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:15 INFO - {'append_to_log': False, 15:53:15 INFO - 'base_work_dir': '/builds/slave/test', 15:53:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:53:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:15 INFO - 'branch': 'Mozilla-Aurora', 15:53:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:15 INFO - 'config_files': ('talos/linux_config.py',), 15:53:15 INFO - 'default_actions': ('clobber', 15:53:15 INFO - 'read-buildbot-config', 15:53:15 INFO - 'download-and-extract', 15:53:15 INFO - 'populate-webroot', 15:53:15 INFO - 'create-virtualenv', 15:53:15 INFO - 'install', 15:53:15 INFO - 'run-tests'), 15:53:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:15 INFO - 'download_minidump_stackwalk': True, 15:53:15 INFO - 'download_symbols': 'ondemand', 15:53:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:53:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:53:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:53:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:53:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:15 INFO - 'installer_path': 'installer.exe', 15:53:15 INFO - 'log_level': 'info', 15:53:15 INFO - 'log_name': 'talos', 15:53:15 INFO - 'log_to_console': True, 15:53:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:15 INFO - 'opt_config_files': (), 15:53:15 INFO - 'pip_index': False, 15:53:15 INFO - 'sps_profile': False, 15:53:15 INFO - 'sps_profile_interval': 0, 15:53:15 INFO - 'suite': 'dromaeojs-e10s', 15:53:15 INFO - 'system_bits': '32', 15:53:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:15 INFO - 'title': 'talos-linux64-ix-005', 15:53:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:15 INFO - 'use_talos_json': True, 15:53:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:15 INFO - 'work_dir': 'build'} 15:53:15 INFO - ##### 15:53:15 INFO - ##### Running clobber step. 15:53:15 INFO - ##### 15:53:15 INFO - Running pre-action listener: _resource_record_pre_action 15:53:15 INFO - Running main action method: clobber 15:53:15 INFO - rmtree: /builds/slave/test/build 15:53:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:16 INFO - Running post-action listener: _resource_record_post_action 15:53:16 INFO - ##### 15:53:16 INFO - ##### Finished clobber step (success) 15:53:16 INFO - ##### 15:53:16 INFO - ##### 15:53:16 INFO - ##### Running read-buildbot-config step. 15:53:16 INFO - ##### 15:53:16 INFO - Running pre-action listener: _resource_record_pre_action 15:53:16 INFO - Running main action method: read_buildbot_config 15:53:16 INFO - Using buildbot properties: 15:53:16 INFO - { 15:53:16 INFO - "project": "", 15:53:16 INFO - "product": "firefox", 15:53:16 INFO - "script_repo_revision": "production", 15:53:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:53:16 INFO - "repository": "", 15:53:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:53:16 INFO - "buildid": "20160727131625", 15:53:16 INFO - "pgo_build": "True", 15:53:16 INFO - "basedir": "/builds/slave/test", 15:53:16 INFO - "buildnumber": 412, 15:53:16 INFO - "slavename": "talos-linux64-ix-005", 15:53:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:53:16 INFO - "platform": "ubuntu64_hw", 15:53:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:53:16 INFO - "branch": "mozilla-aurora", 15:53:16 INFO - "repo_path": "releases/mozilla-aurora", 15:53:16 INFO - "revision": "f430f9a12c98a00bfb0edce37947614e0a2b83cc", 15:53:16 INFO - "stage_platform": "linux64-pgo", 15:53:16 INFO - "builduid": "0dffb885355149a08691c447b656af38", 15:53:16 INFO - "slavebuilddir": "test" 15:53:16 INFO - } 15:53:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:53:16 INFO - Running post-action listener: _resource_record_post_action 15:53:16 INFO - ##### 15:53:16 INFO - ##### Finished read-buildbot-config step (success) 15:53:16 INFO - ##### 15:53:16 INFO - ##### 15:53:16 INFO - ##### Running download-and-extract step. 15:53:16 INFO - ##### 15:53:16 INFO - Running pre-action listener: _resource_record_pre_action 15:53:16 INFO - Running main action method: download_and_extract 15:53:16 INFO - mkdir: /builds/slave/test/build/tests 15:53: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')]} 15:53:16 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:53:16 INFO - Downloaded 1361 bytes. 15:53:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:53:16 INFO - Using the following test package requirements: 15:53:16 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:53:16 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:53:16 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:53:16 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'jsshell-linux-x86_64.zip'], 15:53:16 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:53:16 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:53:16 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:53:16 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:53:16 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:53:16 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:53:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:53:16 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:53: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')]} 15:53:16 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:53:17 INFO - Downloaded 24494588 bytes. 15:53:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:53:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:53:19 INFO - Return code: 0 15:53:19 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:53:19 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')]} 15:53:19 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:53:20 INFO - Downloaded 24494588 bytes. 15:53:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:53:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:53:22 INFO - Return code: 0 15:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:22 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:53:23 INFO - Downloaded 10833369 bytes. 15:53:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:53:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:53:23 INFO - Return code: 0 15:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:23 INFO - https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:53:24 INFO - Downloaded 63646822 bytes. 15:53:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:24 INFO - mkdir: /builds/slave/test/properties 15:53:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:24 INFO - Contents: 15:53:24 INFO - build_url:https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:53:25 INFO - Running post-action listener: _resource_record_post_action 15:53:25 INFO - Running post-action listener: set_extra_try_arguments 15:53:25 INFO - ##### 15:53:25 INFO - ##### Finished download-and-extract step (success) 15:53:25 INFO - ##### 15:53:25 INFO - ##### 15:53:25 INFO - ##### Running populate-webroot step. 15:53:25 INFO - ##### 15:53:25 INFO - Running pre-action listener: _resource_record_pre_action 15:53:25 INFO - Running main action method: populate_webroot 15:53:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:25 INFO - '--tppagecycles', 15:53:25 INFO - '7'], 15:53:25 INFO - 'tests': ['tsvgm']}}, 15:53:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['damp', 'tps']}, 15:53:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'tests': ['damp', 'tps']}, 15:53:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['dromaeo_dom']}, 15:53:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['a11yr', 15:53:25 INFO - 'ts_paint', 15:53:25 INFO - 'tpaint', 15:53:25 INFO - 'sessionrestore', 15:53:25 INFO - 'sessionrestore_no_auto_restore', 15:53:25 INFO - 'tabpaint']}, 15:53:25 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:25 INFO - 'ts_paint', 15:53:25 INFO - 'tpaint', 15:53:25 INFO - 'sessionrestore', 15:53:25 INFO - 'sessionrestore_no_auto_restore', 15:53:25 INFO - 'tabpaint']}, 15:53:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:25 INFO - 'ts_paint', 15:53:25 INFO - 'tpaint', 15:53:25 INFO - 'sessionrestore', 15:53:25 INFO - 'sessionrestore_no_auto_restore', 15:53:25 INFO - 'tabpaint']}, 15:53:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:25 INFO - 'ts_paint', 15:53:25 INFO - 'tpaint', 15:53:25 INFO - 'sessionrestore', 15:53:25 INFO - 'sessionrestore_no_auto_restore', 15:53:25 INFO - 'tabpaint']}, 15:53:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['a11yr', 15:53:25 INFO - 'ts_paint', 15:53:25 INFO - 'tpaint', 15:53:25 INFO - 'sessionrestore', 15:53:25 INFO - 'sessionrestore_no_auto_restore', 15:53:25 INFO - 'tabpaint']}, 15:53:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['a11yr', 15:53:25 INFO - 'ts_paint', 15:53:25 INFO - 'tpaint', 15:53:25 INFO - 'sessionrestore', 15:53:25 INFO - 'sessionrestore_no_auto_restore', 15:53:25 INFO - 'tabpaint']}, 15:53:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['tsvgx', 15:53:25 INFO - 'tsvgr_opacity', 15:53:25 INFO - 'tart', 15:53:25 INFO - 'tscrollx', 15:53:25 INFO - 'cart']}, 15:53:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:25 INFO - 'tsvgr_opacity', 15:53:25 INFO - 'tart', 15:53:25 INFO - 'tscrollx', 15:53:25 INFO - 'cart']}, 15:53:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'talos_options': ['--disable-e10s'], 15:53:25 INFO - 'tests': ['tp5o']}, 15:53:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'tests': ['tp5o']}, 15:53:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'talos_options': ['--disable-e10s', 15:53:25 INFO - '--xperf_path', 15:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:25 INFO - 'tests': ['tp5n']}, 15:53:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:25 INFO - 'talos_options': ['--xperf_path', 15:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:25 INFO - 'tests': ['tp5n']}}, 15:53:25 INFO - 'talos.zip': {'path': '', 15:53:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:25 INFO - Running post-action listener: _resource_record_post_action 15:53:25 INFO - ##### 15:53:25 INFO - ##### Finished populate-webroot step (success) 15:53:25 INFO - ##### 15:53:25 INFO - ##### 15:53:25 INFO - ##### Running create-virtualenv step. 15:53:25 INFO - ##### 15:53:25 INFO - Running pre-action listener: _resource_record_pre_action 15:53:25 INFO - Running main action method: create_virtualenv 15:53:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:25 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 15:53:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:25 INFO - Using real prefix '/usr' 15:53:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:28 INFO - Installing pip.................done. 15:53:28 INFO - Return code: 0 15:53:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:53:28 INFO - Using env: {'DISPLAY': ':0', 15:53:28 INFO - 'HOME': '/home/cltbld', 15:53:28 INFO - 'LANG': 'en_US.UTF-8', 15:53:28 INFO - 'LANGUAGE': 'en_US:en', 15:53:28 INFO - 'LOGNAME': 'cltbld', 15:53:28 INFO - 'MAIL': '/var/mail/cltbld', 15:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:28 INFO - 'MOZ_NO_REMOTE': '1', 15:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:28 INFO - 'NO_EM_RESTART': '1', 15:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:28 INFO - 'PWD': '/builds/slave/test', 15:53:28 INFO - 'SHELL': '/bin/bash', 15:53:28 INFO - 'SHLVL': '1', 15:53:28 INFO - 'TERM': 'linux', 15:53:28 INFO - 'TMOUT': '86400', 15:53:28 INFO - 'USER': 'cltbld', 15:53:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:28 INFO - '_': '/tools/buildbot/bin/python'} 15:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:28 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 15:53:28 INFO - Cleaning up... 15:53:28 INFO - Return code: 0 15:53:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:53:28 INFO - Using env: {'DISPLAY': ':0', 15:53:28 INFO - 'HOME': '/home/cltbld', 15:53:28 INFO - 'LANG': 'en_US.UTF-8', 15:53:28 INFO - 'LANGUAGE': 'en_US:en', 15:53:28 INFO - 'LOGNAME': 'cltbld', 15:53:28 INFO - 'MAIL': '/var/mail/cltbld', 15:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:28 INFO - 'MOZ_NO_REMOTE': '1', 15:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:28 INFO - 'NO_EM_RESTART': '1', 15:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:28 INFO - 'PWD': '/builds/slave/test', 15:53:28 INFO - 'SHELL': '/bin/bash', 15:53:28 INFO - 'SHLVL': '1', 15:53:28 INFO - 'TERM': 'linux', 15:53:28 INFO - 'TMOUT': '86400', 15:53:28 INFO - 'USER': 'cltbld', 15:53:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:28 INFO - '_': '/tools/buildbot/bin/python'} 15:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:28 INFO - Downloading/unpacking psutil>=3.1.1 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:30 INFO - Installing collected packages: psutil 15:53:30 INFO - Running setup.py install for psutil 15:53:30 INFO - building 'psutil._psutil_linux' extension 15:53:30 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 15:53:30 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 15:53:30 INFO - building 'psutil._psutil_posix' extension 15:53:30 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 15:53:30 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 15:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:31 INFO - Successfully installed psutil 15:53:31 INFO - Cleaning up... 15:53:31 INFO - Return code: 0 15:53:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:53:31 INFO - Using env: {'DISPLAY': ':0', 15:53:31 INFO - 'HOME': '/home/cltbld', 15:53:31 INFO - 'LANG': 'en_US.UTF-8', 15:53:31 INFO - 'LANGUAGE': 'en_US:en', 15:53:31 INFO - 'LOGNAME': 'cltbld', 15:53:31 INFO - 'MAIL': '/var/mail/cltbld', 15:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:31 INFO - 'MOZ_NO_REMOTE': '1', 15:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:31 INFO - 'NO_EM_RESTART': '1', 15:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:31 INFO - 'PWD': '/builds/slave/test', 15:53:31 INFO - 'SHELL': '/bin/bash', 15:53:31 INFO - 'SHLVL': '1', 15:53:31 INFO - 'TERM': 'linux', 15:53:31 INFO - 'TMOUT': '86400', 15:53:31 INFO - 'USER': 'cltbld', 15:53:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:31 INFO - '_': '/tools/buildbot/bin/python'} 15:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:33 INFO - Installing collected packages: mozsystemmonitor 15:53:33 INFO - Running setup.py install for mozsystemmonitor 15:53:33 INFO - Successfully installed mozsystemmonitor 15:53:33 INFO - Cleaning up... 15:53:33 INFO - Return code: 0 15:53:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:33 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 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:33 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 15:53:33 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 15:53:33 INFO - Using env: {'DISPLAY': ':0', 15:53:33 INFO - 'HOME': '/home/cltbld', 15:53:33 INFO - 'LANG': 'en_US.UTF-8', 15:53:33 INFO - 'LANGUAGE': 'en_US:en', 15:53:33 INFO - 'LOGNAME': 'cltbld', 15:53:33 INFO - 'MAIL': '/var/mail/cltbld', 15:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:33 INFO - 'MOZ_NO_REMOTE': '1', 15:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:33 INFO - 'NO_EM_RESTART': '1', 15:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:33 INFO - 'PWD': '/builds/slave/test', 15:53:33 INFO - 'SHELL': '/bin/bash', 15:53:33 INFO - 'SHLVL': '1', 15:53:33 INFO - 'TERM': 'linux', 15:53:33 INFO - 'TMOUT': '86400', 15:53:33 INFO - 'USER': 'cltbld', 15:53:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:33 INFO - '_': '/tools/buildbot/bin/python'} 15:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:33 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 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 15:53:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:36 INFO - warning: no files found matching '*.txt' 15:53:36 INFO - no previously-included directories found matching 'build' 15:53:36 INFO - no previously-included directories found matching 'dist' 15:53:36 INFO - no previously-included directories found matching '.git*' 15:53:36 INFO - Installing collected packages: jsonschema, functools32 15:53:36 INFO - Running setup.py install for functools32 15:53:36 INFO - warning: no files found matching '*.txt' 15:53:36 INFO - no previously-included directories found matching 'build' 15:53:36 INFO - no previously-included directories found matching 'dist' 15:53:36 INFO - no previously-included directories found matching '.git*' 15:53:36 INFO - Successfully installed jsonschema functools32 15:53:36 INFO - Cleaning up... 15:53:36 INFO - Return code: 0 15:53:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:36 INFO - Using env: {'DISPLAY': ':0', 15:53:36 INFO - 'HOME': '/home/cltbld', 15:53:36 INFO - 'LANG': 'en_US.UTF-8', 15:53:36 INFO - 'LANGUAGE': 'en_US:en', 15:53:36 INFO - 'LOGNAME': 'cltbld', 15:53:36 INFO - 'MAIL': '/var/mail/cltbld', 15:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:36 INFO - 'MOZ_NO_REMOTE': '1', 15:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:36 INFO - 'NO_EM_RESTART': '1', 15:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:36 INFO - 'PWD': '/builds/slave/test', 15:53:36 INFO - 'SHELL': '/bin/bash', 15:53:36 INFO - 'SHLVL': '1', 15:53:36 INFO - 'TERM': 'linux', 15:53:36 INFO - 'TMOUT': '86400', 15:53:36 INFO - 'USER': 'cltbld', 15:53:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:36 INFO - '_': '/tools/buildbot/bin/python'} 15:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:38 INFO - Downloading docopt-0.6.1.tar.gz 15:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:39 INFO - Running setup.py install for blobuploader 15:53:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:39 INFO - Running setup.py install for requests 15:53:39 INFO - Running setup.py install for docopt 15:53:39 INFO - Successfully installed blobuploader requests docopt 15:53:39 INFO - Cleaning up... 15:53:39 INFO - Return code: 0 15:53:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:39 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')]} 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:39 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')]} 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:39 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 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:39 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 15:53:39 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 15:53:39 INFO - Using env: {'DISPLAY': ':0', 15:53:39 INFO - 'HOME': '/home/cltbld', 15:53:39 INFO - 'LANG': 'en_US.UTF-8', 15:53:39 INFO - 'LANGUAGE': 'en_US:en', 15:53:39 INFO - 'LOGNAME': 'cltbld', 15:53:39 INFO - 'MAIL': '/var/mail/cltbld', 15:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:39 INFO - 'MOZ_NO_REMOTE': '1', 15:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:39 INFO - 'NO_EM_RESTART': '1', 15:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:39 INFO - 'PWD': '/builds/slave/test', 15:53:39 INFO - 'SHELL': '/bin/bash', 15:53:39 INFO - 'SHLVL': '1', 15:53:39 INFO - 'TERM': 'linux', 15:53:39 INFO - 'TMOUT': '86400', 15:53:39 INFO - 'USER': 'cltbld', 15:53:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:39 INFO - '_': '/tools/buildbot/bin/python'} 15:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:39 INFO - Running setup.py (path:/tmp/pip-PS_y30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:39 INFO - Running setup.py (path:/tmp/pip-pEOEiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:40 INFO - Running setup.py (path:/tmp/pip-gbNcx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:40 INFO - Running setup.py (path:/tmp/pip-aTl2Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:40 INFO - Running setup.py (path:/tmp/pip-6dz8fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:40 INFO - Running setup.py (path:/tmp/pip-oavG01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:40 INFO - Running setup.py (path:/tmp/pip-oNPkmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:40 INFO - Running setup.py (path:/tmp/pip-7WdNW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:40 INFO - Running setup.py (path:/tmp/pip-wJLpAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:40 INFO - Running setup.py (path:/tmp/pip-C4b99V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:40 INFO - Running setup.py (path:/tmp/pip-tPEKR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:40 INFO - Running setup.py (path:/tmp/pip-OP2DjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:40 INFO - Running setup.py (path:/tmp/pip-40d3it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:40 INFO - Running setup.py (path:/tmp/pip-yb336R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:40 INFO - Running setup.py (path:/tmp/pip-nRnbSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:40 INFO - Running setup.py (path:/tmp/pip-ZJ_2vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:41 INFO - Running setup.py (path:/tmp/pip-5Tp_i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:41 INFO - Running setup.py install for manifestparser 15:53:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Running setup.py install for mozcrash 15:53:41 INFO - Running setup.py install for mozdebug 15:53:41 INFO - Running setup.py install for mozdevice 15:53:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Running setup.py install for mozfile 15:53:41 INFO - Running setup.py install for mozhttpd 15:53:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Running setup.py install for mozinfo 15:53:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Running setup.py install for mozInstall 15:53:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:41 INFO - Running setup.py install for mozleak 15:53:41 INFO - Running setup.py install for mozlog 15:53:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:42 INFO - Running setup.py install for moznetwork 15:53:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:42 INFO - Running setup.py install for mozprocess 15:53:42 INFO - Running setup.py install for mozprofile 15:53:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:42 INFO - Running setup.py install for mozrunner 15:53:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:42 INFO - Running setup.py install for mozscreenshot 15:53:42 INFO - Running setup.py install for moztest 15:53:42 INFO - Running setup.py install for mozversion 15:53:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:42 INFO - Cleaning up... 15:53:42 INFO - Return code: 0 15:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:42 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')]} 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:42 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')]} 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:42 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 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:42 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 15:53:42 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 15:53:42 INFO - Using env: {'DISPLAY': ':0', 15:53:42 INFO - 'HOME': '/home/cltbld', 15:53:42 INFO - 'LANG': 'en_US.UTF-8', 15:53:42 INFO - 'LANGUAGE': 'en_US:en', 15:53:42 INFO - 'LOGNAME': 'cltbld', 15:53:42 INFO - 'MAIL': '/var/mail/cltbld', 15:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:42 INFO - 'MOZ_NO_REMOTE': '1', 15:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:42 INFO - 'NO_EM_RESTART': '1', 15:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:42 INFO - 'PWD': '/builds/slave/test', 15:53:42 INFO - 'SHELL': '/bin/bash', 15:53:42 INFO - 'SHLVL': '1', 15:53:42 INFO - 'TERM': 'linux', 15:53:42 INFO - 'TMOUT': '86400', 15:53:42 INFO - 'USER': 'cltbld', 15:53:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:42 INFO - '_': '/tools/buildbot/bin/python'} 15:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:43 INFO - Running setup.py (path:/tmp/pip-ckGZ5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:43 INFO - Running setup.py (path:/tmp/pip-E3nl0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:43 INFO - Running setup.py (path:/tmp/pip-qgWbjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:43 INFO - Running setup.py (path:/tmp/pip-HrbjCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:43 INFO - Running setup.py (path:/tmp/pip-Uhx0U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:43 INFO - Running setup.py (path:/tmp/pip-hRixTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:43 INFO - Running setup.py (path:/tmp/pip-EdyBfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:43 INFO - Running setup.py (path:/tmp/pip-U8Cef8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:43 INFO - Running setup.py (path:/tmp/pip-08k2LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:43 INFO - Running setup.py (path:/tmp/pip-R2G440-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:43 INFO - Running setup.py (path:/tmp/pip-V_VdVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:43 INFO - Running setup.py (path:/tmp/pip-iO5j23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:43 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)) 15:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:43 INFO - Running setup.py (path:/tmp/pip-MrbxQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:44 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)) 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:44 INFO - Running setup.py (path:/tmp/pip-XMCIUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:44 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)) 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:44 INFO - Running setup.py (path:/tmp/pip-2DjY_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:44 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)) 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:44 INFO - Running setup.py (path:/tmp/pip-xTDKI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:44 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)) 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:44 INFO - Running setup.py (path:/tmp/pip-K4kg0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:44 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)) 15:53:44 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)) 15:53:44 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)) 15:53:44 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)) 15:53:44 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)) 15:53:44 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)) 15:53:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:44 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 15:53:44 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 15:53:44 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 15:53:44 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 15:53:44 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 15:53:44 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 15:53:46 INFO - Downloading blessings-1.6.tar.gz 15:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:46 INFO - Installing collected packages: blessings 15:53:46 INFO - Running setup.py install for blessings 15:53:46 INFO - Successfully installed blessings 15:53:46 INFO - Cleaning up... 15:53:46 INFO - Return code: 0 15:53:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:46 INFO - Reading from file tmpfile_stdout 15:53:46 INFO - Current package versions: 15:53:46 INFO - argparse == 1.2.1 15:53:46 INFO - blessings == 1.6 15:53:46 INFO - blobuploader == 1.2.4 15:53:46 INFO - docopt == 0.6.1 15:53:46 INFO - functools32 == 3.2.3-2 15:53:46 INFO - jsonschema == 2.5.1 15:53:46 INFO - manifestparser == 1.1 15:53:46 INFO - mozInstall == 1.12 15:53:46 INFO - mozcrash == 0.17 15:53:46 INFO - mozdebug == 0.1 15:53:46 INFO - mozdevice == 0.48 15:53:46 INFO - mozfile == 1.2 15:53:46 INFO - mozhttpd == 0.7 15:53:46 INFO - mozinfo == 0.9 15:53:46 INFO - mozleak == 0.1 15:53:46 INFO - mozlog == 3.2 15:53:46 INFO - moznetwork == 0.27 15:53:46 INFO - mozprocess == 0.23 15:53:46 INFO - mozprofile == 0.28 15:53:46 INFO - mozrunner == 6.12 15:53:46 INFO - mozscreenshot == 0.1 15:53:46 INFO - mozsystemmonitor == 0.3 15:53:46 INFO - moztest == 0.7 15:53:46 INFO - mozversion == 1.4 15:53:46 INFO - psutil == 3.1.1 15:53:46 INFO - requests == 1.2.3 15:53:46 INFO - wsgiref == 0.1.2 15:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:46 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 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:46 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 15:53:46 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 15:53:46 INFO - Using env: {'DISPLAY': ':0', 15:53:46 INFO - 'HOME': '/home/cltbld', 15:53:46 INFO - 'LANG': 'en_US.UTF-8', 15:53:46 INFO - 'LANGUAGE': 'en_US:en', 15:53:46 INFO - 'LOGNAME': 'cltbld', 15:53:46 INFO - 'MAIL': '/var/mail/cltbld', 15:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:46 INFO - 'MOZ_NO_REMOTE': '1', 15:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:46 INFO - 'NO_EM_RESTART': '1', 15:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:46 INFO - 'PWD': '/builds/slave/test', 15:53:46 INFO - 'SHELL': '/bin/bash', 15:53:46 INFO - 'SHLVL': '1', 15:53:46 INFO - 'TERM': 'linux', 15:53:46 INFO - 'TMOUT': '86400', 15:53:46 INFO - 'USER': 'cltbld', 15:53:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:46 INFO - '_': '/tools/buildbot/bin/python'} 15:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 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)) 15:53:46 INFO - Cleaning up... 15:53:46 INFO - Return code: 0 15:53:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:46 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 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:46 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 15:53:46 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 15:53:46 INFO - Using env: {'DISPLAY': ':0', 15:53:46 INFO - 'HOME': '/home/cltbld', 15:53:46 INFO - 'LANG': 'en_US.UTF-8', 15:53:46 INFO - 'LANGUAGE': 'en_US:en', 15:53:46 INFO - 'LOGNAME': 'cltbld', 15:53:46 INFO - 'MAIL': '/var/mail/cltbld', 15:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:46 INFO - 'MOZ_NO_REMOTE': '1', 15:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:46 INFO - 'NO_EM_RESTART': '1', 15:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:46 INFO - 'PWD': '/builds/slave/test', 15:53:46 INFO - 'SHELL': '/bin/bash', 15:53:46 INFO - 'SHLVL': '1', 15:53:46 INFO - 'TERM': 'linux', 15:53:46 INFO - 'TMOUT': '86400', 15:53:46 INFO - 'USER': 'cltbld', 15:53:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:46 INFO - '_': '/tools/buildbot/bin/python'} 15:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:47 INFO - Cleaning up... 15:53:47 INFO - Return code: 0 15:53:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:53:47 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')]} 15:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:47 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')]} 15:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c3ef7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2086350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', '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 15:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:53:47 INFO - Using env: {'DISPLAY': ':0', 15:53:47 INFO - 'HOME': '/home/cltbld', 15:53:47 INFO - 'LANG': 'en_US.UTF-8', 15:53:47 INFO - 'LANGUAGE': 'en_US:en', 15:53:47 INFO - 'LOGNAME': 'cltbld', 15:53:47 INFO - 'MAIL': '/var/mail/cltbld', 15:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:47 INFO - 'MOZ_NO_REMOTE': '1', 15:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:47 INFO - 'NO_EM_RESTART': '1', 15:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:47 INFO - 'PWD': '/builds/slave/test', 15:53:47 INFO - 'SHELL': '/bin/bash', 15:53:47 INFO - 'SHLVL': '1', 15:53:47 INFO - 'TERM': 'linux', 15:53:47 INFO - 'TMOUT': '86400', 15:53:47 INFO - 'USER': 'cltbld', 15:53:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:47 INFO - '_': '/tools/buildbot/bin/python'} 15:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:47 INFO - Downloading/unpacking flake8 15:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:53:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:53:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 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 15:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:49 INFO - no previously-included directories found matching 'docs/_build' 15:53:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:53:50 INFO - Running setup.py install for pep8 15:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:50 INFO - no previously-included directories found matching 'docs/_build' 15:53:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:53:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:53:50 INFO - Cleaning up... 15:53:50 INFO - Return code: 0 15:53:50 INFO - Running post-action listener: _resource_record_post_action 15:53:50 INFO - Running post-action listener: _start_resource_monitoring 15:53:50 INFO - Starting resource monitoring. 15:53:50 INFO - ##### 15:53:50 INFO - ##### Finished create-virtualenv step (success) 15:53:50 INFO - ##### 15:53:50 INFO - ##### 15:53:50 INFO - ##### Running install step. 15:53:50 INFO - ##### 15:53:50 INFO - Running pre-action listener: _resource_record_pre_action 15:53:50 INFO - Running main action method: install 15:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:50 INFO - Reading from file tmpfile_stdout 15:53:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:50 INFO - Reading from file tmpfile_stdout 15:53:50 INFO - Output received: 15:53:50 INFO - Usage: mozinstall [options] installer 15:53:50 INFO - Options: 15:53:50 INFO - -h, --help show this help message and exit 15:53:50 INFO - -d DEST, --destination=DEST 15:53:50 INFO - Directory to install application into. [default: 15:53:50 INFO - "/builds/slave/test"] 15:53:50 INFO - --app=APP Application being installed. [default: firefox] 15:53:50 INFO - mkdir: /builds/slave/test/build/application 15:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:54:06 INFO - Reading from file tmpfile_stdout 15:54:06 INFO - Output received: 15:54:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:54:06 INFO - Running post-action listener: _resource_record_post_action 15:54:06 INFO - ##### 15:54:06 INFO - ##### Finished install step (success) 15:54:06 INFO - ##### 15:54:06 INFO - ##### 15:54:06 INFO - ##### Running run-tests step. 15:54:06 INFO - ##### 15:54:06 INFO - Running pre-action listener: _resource_record_pre_action 15:54:06 INFO - Running main action method: run_tests 15:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:06 INFO - Python 2.7.3 15:54:06 INFO - Return code: 0 15:54:06 INFO - grabbing minidump binary from tooltool 15:54:06 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')]} 15:54:06 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 0x21151c0>, '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 0x21160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2116550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:06 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 15:54:06 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 15:54:06 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 15:54:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:06 INFO - Return code: 0 15:54:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:54:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:54:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:54:07 INFO - Return code: 0 15:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:54:07 INFO - Using env: {'DISPLAY': ':0', 15:54:07 INFO - 'HOME': '/home/cltbld', 15:54:07 INFO - 'LANG': 'en_US.UTF-8', 15:54:07 INFO - 'LANGUAGE': 'en_US:en', 15:54:07 INFO - 'LOGNAME': 'cltbld', 15:54:07 INFO - 'MAIL': '/var/mail/cltbld', 15:54:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:07 INFO - 'MOZ_NO_REMOTE': '1', 15:54:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:07 INFO - 'NO_EM_RESTART': '1', 15:54:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:07 INFO - 'PWD': '/builds/slave/test', 15:54:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:07 INFO - 'SHELL': '/bin/bash', 15:54:07 INFO - 'SHLVL': '1', 15:54:07 INFO - 'TERM': 'linux', 15:54:07 INFO - 'TMOUT': '86400', 15:54:07 INFO - 'USER': 'cltbld', 15:54:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499', 15:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:07 INFO - '_': '/tools/buildbot/bin/python'} 15:54:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:54:07 INFO - mozversion application_buildid: 20160727131625 15:54:07 INFO - mozversion application_changeset: f430f9a12c98a00bfb0edce37947614e0a2b83cc 15:54:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:54:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:07 INFO - mozversion application_name: Firefox 15:54:07 INFO - mozversion application_remotingname: firefox-dev 15:54:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:54:07 INFO - mozversion application_vendor: Mozilla 15:54:07 INFO - mozversion application_version: 49.0a2 15:54:07 INFO - mozversion platform_buildid: 20160727131625 15:54:07 INFO - mozversion platform_changeset: f430f9a12c98a00bfb0edce37947614e0a2b83cc 15:54:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:54:07 INFO - mozversion platform_version: 49.0a2 15:54:07 INFO - using testdate: 1469660047 15:54:07 INFO - actual date: 1469660047 15:54:07 INFO - starting webserver on 'localhost:44896' 15:54:07 INFO - SUITE-START | Running 2 tests 15:54:07 INFO - TEST-START | dromaeo_css 15:54:07 INFO - operating with platform_type : linux_ 15:54:07 INFO - Initialising browser for dromaeo_css test... 15:54:07 INFO - TEST-INFO | started process 30754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbr1CUG/profile http://localhost:44896/getInfo.html) 15:54:12 INFO - PROCESS | 30754 | __metrics Screen width/height:1600/1200 15:54:12 INFO - PROCESS | 30754 | colorDepth:24 15:54:12 INFO - PROCESS | 30754 | Browser inner width/height: 1024/697 15:54:12 INFO - PROCESS | 30754 | __metrics 15:54:13 ERROR - PROCESS | 30754 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:54:14 INFO - TEST-INFO | 30754: exit 0 15:54:14 INFO - Browser initialized. 15:54:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:14 INFO - TEST-INFO | started process 30882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbr1CUG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:25 INFO - PROCESS | 30882 | RSS: Main: 155926528 15:54:25 INFO - PROCESS | 30882 | 15:55:15 INFO - PROCESS | 30882 | 1469660115374 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] 15:57:23 INFO - PROCESS | 30882 | Cycle 1(1): loaded http://localhost:44896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44896/tests/dromaeo/cssquery-ext.html) 15:57:24 INFO - PROCESS | 30882 | RSS: Main: 160043008 15:57:24 INFO - PROCESS | 30882 | 16:00:26 INFO - PROCESS | 30882 | Cycle 1(1): loaded http://localhost:44896/tests/dromaeo/cssquery-ext.html (next: http://localhost:44896/tests/dromaeo/cssquery-jquery.html) 16:00:27 INFO - PROCESS | 30882 | RSS: Main: 157343744 16:00:27 INFO - PROCESS | 30882 | 16:03:28 INFO - PROCESS | 30882 | Cycle 1(1): loaded http://localhost:44896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44896/tests/dromaeo/cssquery-mootools.html) 16:03:29 INFO - PROCESS | 30882 | RSS: Main: 156782592 16:03:29 INFO - PROCESS | 30882 | 16:06:31 INFO - PROCESS | 30882 | Cycle 1(1): loaded http://localhost:44896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44896/tests/dromaeo/cssquery-prototype.html) 16:06:31 INFO - PROCESS | 30882 | RSS: Main: 156536832 16:06:31 INFO - PROCESS | 30882 | 16:09:34 INFO - PROCESS | 30882 | Cycle 1(1): loaded http://localhost:44896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44896/tests/dromaeo/cssquery-yui.html) 16:09:34 INFO - PROCESS | 30882 | RSS: Main: 158388224 16:09:34 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | Cycle 1(1): loaded http://localhost:44896/tests/dromaeo/cssquery-yui.html (next: http://localhost:44896/tests/dromaeo/cssquery-dojo.html) 16:12:37 INFO - PROCESS | 30882 | RSS: Main: 158732288 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | __start_tp_report 16:12:37 INFO - PROCESS | 30882 | _x_x_mozilla_page_load 16:12:37 INFO - PROCESS | 30882 | _x_x_mozilla_page_load_details 16:12:37 INFO - PROCESS | 30882 | |i|pagename|runs| 16:12:37 INFO - PROCESS | 30882 | |0;dojo.html;3399.7280217582597;3403.353362861055;3408.863645454182;3422.589289285286;3427.143214196451;5629.831105066849;5644.689542075189;5684.403137670542;5691.146328050794;5797.971010144944;5796.797112101077;5830.766769329232;5838.182654428373;5870.324912635048;5871.031279838832;5259.973700131494;5281.603879709018;5306.681599104047;5318.547923426513;5329.813456529022;5193.480651934795;5194;5263.473652634744;5333.893322133555;5349;5226.1899405592;5230.73846307685;5288.629795914288;5388.326459192601;5394.109971854639;5297.311349524537;5297.655652382583;5310.256564081051;5326;5326.041312563737;5093.541581257705;5151.948480515184;5207.4792520748;5215.6609820361555;5278.9208161877605;5567.415421380737;5605.57958153136;5622;5637.013522633563;5641.12562552805;6113.694315284218;6156.4766994805495;6165.876682466371;6183.628982261033;6188.504919606466;6103.115048318014;6144.754209831602;6207.441330280297;6210.596311239755;6227.501799856046;5721;5801.6809075500405;5805.7097145143;5806.680632565207;5844.26946631671;6366.26787919386;6381.553291269566;6383.616982981036;6384.52116091295;6391.616503009835;5826.941730582725;6070.726817293144;6080.513558915276;6088.330283668793;6118.571699980958;6300.873982520324;6317.399847014526;6318.526110541728;6319.304876463585;6324.2410910691015;6208.72060757258;6236.18929539157;6243.750249989949;6246.625202487865;6254.249490061222;6008.639481631116;6073.119397687311;6087.086936959403;6091.08633704939;6300.464460520815;4682.1103990241745;4684.063187362473;4691.155591993405;4704.600108990706;4723.220668589713;4167.812448439828;4168.353905144708;4171.4368560243975;4196.076863090177;4225.492940847056;5703.74333155009;5946.256717910262;5950.196723442366;5973.880522389615;6070.362611925772;6054.39456054391;6139.469804862222;6152.938470615326;6205.28639206488;6211.3167551569295;6025.517958563304;6031.095335699592;6038.577299589075;6040.154378387029;6087.421694938974;5262.947370526245;5281.630285880028;5317.175837745156;5332.226827110047;5348.652337598043;6589.967050164719;6614.10709554204;6621.106150669694;6639.601623902581;6668.933310666928;6354.904676429765;6357.459615932605;6359.936400636119;6362.204724409449;6374.29882712892;6346.873062538816;6498.805035848932;6554.410103090745;6576.76981305652;6653.933460665331;6172;6206.193194884636;6214.844628884314;6233.875322493615;6237.033259844731;6066.848328791815;6335.683215839282;6351.777687780906;6352.237731472253;6360.427561519486;6082.817515474543;6097.969510152421;6119.474990425872;6135.84660383494;6200.441960223601;6122.938770612237;6145.66198859067;6161.907571386522;6184.938150618616;6186;5793.797217097382;5920.230370051866;6019.458248757633;6020.819375418744;6065.302490213682;6144.723487443165;6170.660613666291;6188.319284878749;6206.379362063757;6206.596571222856;6059.000264956233;6064.02975523914;6088.786892458743;6091.162976261861;6141.877162456636 16:12:37 INFO - PROCESS | 30882 | |1;ext.html;604.5163868904875;656.7110471392589;661.6890061671013;677.3598948993202;677.5832862789383;45417;46756.532434675726;47094.2935855962;47304.526954730485;50693.493065069335;47782.283265751044;48241.27638085432;48323.758381208136;48362.27456588154;48386.75806620962;8973.416727912681;8993.775155621097;9093.272538196961;9105.180533751962;9125.817483650322;8949.284057275436;9026.458412495238;9030.142136497023;9039.096090390974;9059.275257979345;8987.865182022275;9003.819923601524;9044.683436079738;9091.454512729257;9106.18044376006;9037.322200834931;9064.501452420114;9080.137386948263;9096.226820720247;9101.180893719596;8903.866442003375;8980.820383592292;9007.594658240328;9014.909850901473;9021.548922553911;43949.78025109886;44278.77860610709;44339.55660443386;44355.33466997997;44627.10745785099;3644.69020133289;3832.9041773955596;3909.0618251619408;4018.3168861293357;4501.257292546726;32738.345233095442;33771.662283377096;34097;34225.82887085548;34252.82873585641;4530.841420550298;4611.518303680733;4623.491415944243;4687.749880057558;4880.780364883553;385373;388628.2842928921;388970.99999999715;389756;390125;69881.65059174671;70643;70665.64667176631;70924;70942.29057709356;38711.2257754849;39618.207635847124;39769.40345894814;41194.1761164775;73850.63074684593;19766.308179213658;19954.90022549878;20024.89987550082;20034.69947950782;20046.198152074045;15162.696746065018;15253.237338133049;15255.237238138048;15265.313060912285;15298.694026119416;20559.8972005139;20848;20854;20935.581288374146;20961.89519052395;7463.514871533333;7506.962465187748;7568.735094271674;7885.723999659985;7972.880406793903;1053.3363980692116;1091.8525998990035;1096.7751610919743;1132.8758577666874;1199.424276347358;32897.83551082229;32920.67079329176;33287.66712332846;33773.15567110842;33792.80433514641;1170.8829117088394;1190.892819646236;1209.981850272229;1219.2196993923897;1256.6669832494397;17866.731999020027;17888.642227155644;17925.910370448066;17953.551161221076;18036.90981545084;545634;587493;589840;590315;616684;54960;59464.40535594675;60145.69927150336;60278.397216027275;60298.698506507186;1454.7381471335261;1456.5266288456294;1461.5469204546625;1468.4713503138862;1476.7489526780473;32506.674933250364;32951.50572741363;33780.97314161158;34217.97346079622;34460;54697.72651136719;55084;55403.72298138483;55429.44570554243;55439.72280138574;516527;522902;523028;524266;525194;30107.04326706849;30576.847115764278;30655.080347589606;30901.8454907724;30998;50429.74785126198;50934;51147.74426127994;51479.940802367484;52224.738876305375;41449.97631572411;42758;42939.375625414184;43237.13525729405;43583.78208108939;42687.786561068235;43035;43299;43567.782161088995;43738.78130609327;42640.573594264904;42934;43360.783196083816;43611.56388436075;44028.67913962586;36088.736894208574;36620.63379366279;36621.598067777406;36897.26205475929;37098.44352334771;28939.276518087216;30054.51717266146;30070.097897063122;30137.547936780527;30567.847160764053 16:12:37 INFO - PROCESS | 30882 | |2;jquery.html;416.4773209621925;417.6846480906915;418.5688740597186;421.4584259226894;431.65467625899294;18637.72043419348;19561.967894976282;20273.797262027376;20389.490262743402;20572.177112915484;18502.352417665385;18519.62960740788;18601.255949761995;18605.441836744918;19419.611607767834;5522.585806064551;5912.9704351478185;5970.373110823344;5983.461488466037;5988.700564971756;5847.824565263028;5870.354261031283;5908.645481271137;5933.970330148343;5935.406459354052;5612.41069687683;5781.335146458148;5798.478136967672;5807.186993820868;5817.680027598481;5692.829215123553;5714.57140714446;5735.139729040636;5772.653640781546;5804.912926306109;5281.102212623863;5303.28405665238;5303.310569625924;5324.440933701983;5335.466453354672;22907.08371665148;23512.294631161094;23743.881280593658;24246.39384015396;24251.272461826175;2518.9496210075695;2536.112360673768;2637.3406648337914;2702.3649442381025;2896.174590241792;14961.102333860003;15191;15264.46574369903;15438.38246470151;15655.295511702001;1973.3882496426154;2061.505238742706;2079.8856062916534;2100.7584127825344;2101.3800928726064;79134.20865791326;81651;81766;82855.585722071;83701;9797.118259356692;10384.480775961172;11145.888541114486;11154.553817847196;11434.656960291204;15687;15843.445479408165;15882.920585397;15912.840871591368;15914.204289785464;8564.443311184754;8944.642214311354;8979.730608081769;9033.096690330914;9125.498097604695;8831.470111793313;8886.644534218689;8905.73282801517;8936.374453788172;9164.770880727901;6774.153230846145;6863.803582853439;6922.134733158356;7040.894386584206;7051.153861536546;2014.375543581465;2016.939491815248;2034.4710375302527;2062.494688801223;2070.6498124628656;1009.9343542669703;1086.2463654635462;1119.9776004479866;1121.6130434999911;1125.8648962124598;19609.313674021625;19981;20079.867653600315;20473.692894606593;20673.689894651594;1101.8071837428417;1121.8429419881222;1199.736058067224;1215.2985819852277;1222.896053835434;10629;11509.216071508761;11681.182317237712;11753.529858805723;11797.469113889896;463250;468529;512626;513629;515635;74980.62509687417;81267.59366203132;83345.58327208446;101786.4910675442;104519.4774026125;962.2734835199379;993.5280741647804;1002.6190047781942;1009.3338396658023;1010.4947526236881;16570.17149142514;16838.57903552421;16965.236564354385;17102.48692539226;17282.82717172812;42425.78787106045;42912.78543607262;44776.77611612051;45391;45828.77085614551;58800.70599647146;59651.40348596458;63732;64201.67899160474;65351;7819.491733037335;8721.345899057469;8841.292696584387;8849.247813935888;9035.45787252767;13464.596062118153;13718.382672779948;13787.034907556375;13988.230647314089;14037.438502459787;11752.412379381169;11764.294142351486;12013.219140755822;12317.876821231674;12428.689282768004;6194.690265486617;11083.944580277048;12166.75666486683;12330.19853709506;12464.813027804408;12331.876681233072;12553.497860085494;12581.622551323475;12629.494820207088;12858.614241572768;8352.916470835215;8398.118197589409;8406.369522285731;8453.957730211556;8498.91501085006;12586.748265034832;12627.116101873147;12639.494420223456;12642.87357126417;12733 16:12:37 INFO - PROCESS | 30882 | |3;mootools.html;1600.6878658661558;1605.2696023309393;1822.8177182281765;1891.8959457229846;1937.3413039566544;8669.523176225304;9160.725178244647;9453.71638850834;9727.270454715897;9740;9481.194098501635;9861.901380986188;9923.0573095556;9936.950315248432;9950.004999500046;2471.0362958446176;2503.8372505787156;2506.1980166346775;2507.3856905058287;2508.159766478232;2396.281115665302;2513.610390389483;2515.1825656661567;2521.7982561395042;2528.6080657498023;2408.12103582193;2451.8528888266674;2495.351208685746;2497.7002759668867;2511.899524019037;2428.429319110008;2449.473363226906;2459.86470744109;2470.888810003536;2484.6024636058232;2440.365504968721;2450.6691596634405;2470.8641024743633;2480.900763969439;2510.5104504621604;9683.854742178873;9770.218382529452;9793.461359625218;9797.167240784542;9866.358686685415;5701.0878259478695;5770.6249093808765;5775.509081728058;5871.295444546682;5872.530197584183;3465.480177973299;3524.6475352464804;3582.0328511302064;3604.315180115796;3626.8549258029648;1102.3385968418966;1147.4033502578695;1156.0693641618493;1162.4652659776514;1177.1230433327141;13970.93014534931;13985.72028559423;14013.859861401459;14016.36926338307;14044.438222471088;4907.9263811042865;4937.1606826839525;4968.826091086795;4987.625928055338;5029.84910452687;11811.114166437552;11839.112066594867;11938.462769175409;11957.461914213882;11959.58141465062;5726.942730572724;5749.482546570745;5752.165935939265;5754.6547207167705;5766.826995190151;4696.131215725101;5009.89980200394;5065;5269.920951185735;5274.287971123926;4050.250703619781;4058.467791298398;4070.531888832822;4076.612721791425;4079.7760671798937;1281.5834853672593;1304.419533307688;1305.2299143505377;1306.7778477658821;1307.901907356952;1094.7785201682752;1104.3705088099866;1115.7378016166356;1116.8771435142128;1135.1940122512942;6858.725650973905;6872.10662613857;6874.175098988054;6963.059986901805;7003;442.25259311763017;446.3394176618558;458.1044058864911;463.7727513518419;464.8837790552362;4671.48613652498;4677.4854765975715;4757.35775670287;4767.4994125617;4801.039792041605;12121.515139394502;12607;12640.620781376574;12682.112252142446;12731.427085781163;11759.941200294115;12260.203086799329;12499.812502812465;12642.2414655121;12642.367881605884;8854.29165666745;8871.778205544784;8987.730368088967;9004.459732416077;9023.774405639911;6679.332066793476;6821.249662537216;6861.862762744817;6874.896876546956;6927.480438967198;11215.831762523405;11417.771644566896;11543.249688770204;11839.940800295943;11840.171188016757;11654.941725291319;11752.059835212991;11806.881931180578;11840.052795776144;11973.16187866841;7115.075040244735;8093.797655058671;8164.510129392255;8248.13394593583;8288.792780180544;9652.2278217741;9664.661736839176;9723.46520941355;9765.707028789147;9809.068138526829;8031.518108913484;8247.917520824954;8260.463069900437;8310.168983101641;8352.164783521599;8232.135625759209;8463.28062114727;8465.57672116404;8499.32005439551;8555.957220213859;7399.112106547249;7733.419993500397;7752.612369381395;7848.646810893638;7891.960540197262;5759.107338362561;5893.528517718658;5978;5984.820455386345;5998.040313549811;5512.062949298709;5546.500814926676;5557.833265002057;5583.469570390806;5647.491725744539 16:12:37 INFO - PROCESS | 30882 | |4;prototype.html;349;352.24267824178014;356.1470278682555;356.718192627824;362.83853685110137;5739.512141467975;5793.364019371186;5806.506446952004;5827.796027139051;5851.2100866383025;5671.8089201267785;5677.517411020068;5686.31764188297;5695;5722.656640601567;4324.4378230830025;4407.272799987998;4419.359192917025;4424.867253982386;4433.290673492242;4390.407295015164;4415.432521454885;4427.247367947441;4439.578240067204;4466.798994045275;4368.650507959355;4393.275109606911;4401.867943961686;4418.321038005553;4447.977760111211;4384.232759267132;4432.601065904052;4440.400545926291;4444.577765112309;4450.998525331806;3876.2635099331037;3876.341022026234;3889.533256009269;3896.8051597420017;3897.142628621699;5450.972745136289;5520.199571062214;5553.084185955839;5553.7778488860395;5616.606837521375;4934;5038.244263360489;5054.797808087672;5061.822836200752;5127.871803204913;5916.645001299893;5937.792177273818;5943.791967281168;5987.401259874021;6016.909746353808;4293.141371725636;4338.481531463994;4342.696011279212;4355.346697995295;4366;6036.305824830157;6112.174856394375;6292.811215663492;6298.023806310075;6370.362963703639;4414.514403415622;4422.690411671152;4425.800838962255;4431.689781715249;4442.622377097919;4469.620082293041;4499.302608095751;4506.909861802811;4513.616342610849;4544.7045942013665;4884.291777692215;5048.570871475966;5109.182530795055;5134.204198349262;5150.845474635767;5890.410958904161;5961.880762384728;5965.880682386415;5976.910346344808;6004.519638428916;1502.1512845242403;1521.5815650695927;1527.6639139389317;1528.96177595561;1537.7385844406479;944.6821683751128;973.095021629891;976.5019839881569;1001.8547310639916;1015.7003683913264;5195.324607801037;5211.296474975829;5230.869228269247;5245.423003469616;5250.842474725764;5475.644083134664;5524.254225679482;5525.656977528618;5531.778728850882;5571.29792050855;4826.276058591239;5144.893847822661;5156.845294641167;5227.45111763267;5254.316938798008;2974.628171478565;2976.538636511344;2981.5092453773113;2983.9552406713915;2996.756346116337;5606.748086110047;5710.2862142232225;5714.085746280575;5763.510101641324;5780.132980053026;5175.741212939338;5511.448855114537;5534.723263836792;5582.609217354746;5586.720663966786;5601.6670081300745;5621.606487545832;5669.1291873681585;5711.8000869969355;5743.812184237705;5208.619715775247;5413.621046526705;5460.372057213472;5525.430674736267;5549.089056185225;5450.291462109901;5491.28613280271;5498.505134537911;5511.283533140666;5875.559333050124;6264.561480696308;6464.02654778807;6474.676266186766;6510.414062734377;6512.934870651233;4293.97853010733;4341.196878577473;4343.370211319278;4350.260455722471;4351.8694439166875;5933.732982015906;6239.594426362272;6254.343293954069;6321.810345689637;6326.557141000086;5976.581639285208;6079.483243924139;6084.574079814371;6176.980798168252;6198.81403557894;5959.970200148971;5966.85302719802;6068.150458935841;6122.632642041313;6157.753689852356;5886.234789477512;5899.439553242435;5930.822075337746;5934.584579079423;5951.256092988377;6076.331603523698;6098;6104.718009218114;6120.60216085953;6135.815925522242;5624.550035997028;5960.8807823844145;5987.9401205989125;5990.760369585168;5993.471664725467 16:12:37 INFO - PROCESS | 30882 | |5;yui.html;671.4796033074367;718.4611541343992;784.0238902566306;854.6282367170279;888.524639317965;15307.234638268084;16012.43956461524;16055.83944160558;16098.678026439478;16170.434034808784;14865.92567037166;14872.256387180625;14911.478098266563;15009.849901500982;15030.699386012273;725.1515726599864;855.7518319687283;878.8462019146656;879.9516026618534;884.332329091535;832.3923535818856;846.3694547562075;846.9237768600825;847.1570787066877;847.1993965702413;902.6118768929358;905.9094090590921;908.1871724806294;910.7677542226722;910.8679241509977;893.696143311274;896.9551522423852;897.7486303834937;898.9910100899006;901.179926267097;656.3141517114626;662.6752891083382;664.5746722097862;665.6272487407067;665.6472069803012;14205.85794142066;14233.715325693429;14237.501687440994;14293.57119286423;14339.354729037219;14718.484853030199;14745.336459859333;14910.850891491054;15455.149966751824;15482;12411.875881241162;12677;12689.111762176652;12746.490140394373;12879.162854414526;3651.123730304708;3691.6123807000145;3721.7208709346637;3754.1928485375774;3791;79546.20453795446;79732.99999999942;80580;83012;83234.58382708048;11287.097032237401;11350.545978160946;11386.94306528462;11507.19449638534;11536.826947595793;21240.362789116352;21382.465438363855;21423.143074277166;21504.13983440676;21526.56946861054;8729.127087291346;9001.009888912215;9056.501892395981;9346.065393460736;9351.298652601083;4977.701337919664;5024.32171656829;5032.3206367139965;5120.769565369567;5188.325517682677;3761.8307176177136;3874.5350557932666;3874.6900247980657;3900.8439662413184;3902.785346805896;648.4229036157823;673.2930423055772;689.1489011071322;690.2821066091309;700.1668015062162;634.9873002540015;753.5252790741907;772.9343005844454;791.3708601661577;813.938954578409;9734.513274336396;9848.21214302854;9863.950680246553;10033.09702126812;10053.64812231583;699.464909344352;705.3792662457005;722.7181399254295;784.7214238945093;817.3992115794886;4859.975700121477;4970.72661003641;4983.103041452501;5016.122178618727;5039;115679.42160289313;119267;121323;121816;122864;62744;64969;73342;97959.51020244854;100080;91947;93802.53098734462;93928;95558;95958;9564.76088097803;9857.654982075594;9868.901310987085;9991.550380232762;10296.433696146783;39872.60127398689;43002.35496467493;53843.46156538541;54900.450995491134;55394.72302638461;71271.64364178145;73315.63342183255;74871.62564187362;75196.24803751892;78283;12584.18202816814;12752.808707869575;14073.225972571197;14235.715285694436;14493.405725370412;13807.861921380658;13930.58208253754;14053.36759845789;14095.647608809451;14363.281835908372;13634;13729.45082196701;14176.432942682177;14256.358463869357;14314;13650.617967164602;13798.310084495533;14250.216238106588;14261;14605.269736513344;12970;13757;13766.793498097337;13787.51743688966;13916.58250252494;11116.722081948015;11160.776784464428;11213.472800447471;11440.48517816717;11586.942065289619;11492.712682182679;11590.246633968765;11807.940960295144;11850.881491184979;11916.702082448008 16:12:37 INFO - PROCESS | 30882 | __end_tp_report 16:12:37 INFO - PROCESS | 30882 | __start_cc_report 16:12:37 INFO - PROCESS | 30882 | _x_x_mozilla_cycle_collect,336 16:12:37 INFO - PROCESS | 30882 | __end_cc_report 16:12:37 INFO - PROCESS | 30882 | __startTimestamp1469661157290__endTimestamp 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | ------- Summary: start ------- 16:12:37 INFO - PROCESS | 30882 | Number of tests: 6 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | [#0] dojo.html Cycles:165 Average:5788.29 Median:6065.30 stddev:679.89 (11.2%) stddev-sans-first:655.65 16:12:37 INFO - PROCESS | 30882 | Values: 3399.7 3403.4 3408.9 3422.6 3427.1 5629.8 5644.7 5684.4 5691.1 5798.0 5796.8 5830.8 5838.2 5870.3 5871.0 5260.0 5281.6 5306.7 5318.5 5329.8 5193.5 5194.0 5263.5 5333.9 5349.0 5226.2 5230.7 5288.6 5388.3 5394.1 5297.3 5297.7 5310.3 5326.0 5326.0 5093.5 5151.9 5207.5 5215.7 5278.9 5567.4 5605.6 5622.0 5637.0 5641.1 6113.7 6156.5 6165.9 6183.6 6188.5 6103.1 6144.8 6207.4 6210.6 6227.5 5721.0 5801.7 5805.7 5806.7 5844.3 6366.3 6381.6 6383.6 6384.5 6391.6 5826.9 6070.7 6080.5 6088.3 6118.6 6300.9 6317.4 6318.5 6319.3 6324.2 6208.7 6236.2 6243.8 6246.6 6254.2 6008.6 6073.1 6087.1 6091.1 6300.5 4682.1 4684.1 4691.2 4704.6 4723.2 4167.8 4168.4 4171.4 4196.1 4225.5 5703.7 5946.3 5950.2 5973.9 6070.4 6054.4 6139.5 6152.9 6205.3 6211.3 6025.5 6031.1 6038.6 6040.2 6087.4 5262.9 5281.6 5317.2 5332.2 5348.7 6590.0 6614.1 6621.1 6639.6 6668.9 6354.9 6357.5 6359.9 6362.2 6374.3 6346.9 6498.8 6554.4 6576.8 6653.9 6172.0 6206.2 6214.8 6233.9 6237.0 6066.8 6335.7 6351.8 6352.2 6360.4 6082.8 6098.0 6119.5 6135.8 6200.4 6122.9 6145.7 6161.9 6184.9 6186.0 5793.8 5920.2 6019.5 6020.8 6065.3 6144.7 6170.7 6188.3 6206.4 6206.6 6059.0 6064.0 6088.8 6091.2 6141.9 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | [#1] ext.html Cycles:180 Average:66304.65 Median:43675.17 stddev:134395.13 (307.7%) stddev-sans-first:134681.62 16:12:37 INFO - PROCESS | 30882 | Values: 604.5 656.7 661.7 677.4 677.6 45417.0 46756.5 47094.3 47304.5 50693.5 47782.3 48241.3 48323.8 48362.3 48386.8 8973.4 8993.8 9093.3 9105.2 9125.8 8949.3 9026.5 9030.1 9039.1 9059.3 8987.9 9003.8 9044.7 9091.5 9106.2 9037.3 9064.5 9080.1 9096.2 9101.2 8903.9 8980.8 9007.6 9014.9 9021.5 43949.8 44278.8 44339.6 44355.3 44627.1 3644.7 3832.9 3909.1 4018.3 4501.3 32738.3 33771.7 34097.0 34225.8 34252.8 4530.8 4611.5 4623.5 4687.7 4880.8 385373.0 388628.3 388971.0 389756.0 390125.0 69881.7 70643.0 70665.6 70924.0 70942.3 38711.2 39618.2 39769.4 41194.2 73850.6 19766.3 19954.9 20024.9 20034.7 20046.2 15162.7 15253.2 15255.2 15265.3 15298.7 20559.9 20848.0 20854.0 20935.6 20961.9 7463.5 7507.0 7568.7 7885.7 7972.9 1053.3 1091.9 1096.8 1132.9 1199.4 32897.8 32920.7 33287.7 33773.2 33792.8 1170.9 1190.9 1210.0 1219.2 1256.7 17866.7 17888.6 17925.9 17953.6 18036.9 545634.0 587493.0 589840.0 590315.0 616684.0 54960.0 59464.4 60145.7 60278.4 60298.7 1454.7 1456.5 1461.5 1468.5 1476.7 32506.7 32951.5 33781.0 34218.0 34460.0 54697.7 55084.0 55403.7 55429.4 55439.7 516527.0 522902.0 523028.0 524266.0 525194.0 30107.0 30576.8 30655.1 30901.8 30998.0 50429.7 50934.0 51147.7 51479.9 52224.7 41450.0 42758.0 42939.4 43237.1 43583.8 42687.8 43035.0 43299.0 43567.8 43738.8 42640.6 42934.0 43360.8 43611.6 44028.7 36088.7 36620.6 36621.6 36897.3 37098.4 28939.3 30054.5 30070.1 30137.5 30567.8 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | [#2] jquery.html Cycles:180 Average:29668.78 Median:23995.14 stddev:81591.79 (340.0%) stddev-sans-first:81791.11 16:12:37 INFO - PROCESS | 30882 | Values: 416.5 417.7 418.6 421.5 431.7 18637.7 19562.0 20273.8 20389.5 20572.2 18502.4 18519.6 18601.3 18605.4 19419.6 5522.6 5913.0 5970.4 5983.5 5988.7 5847.8 5870.4 5908.6 5934.0 5935.4 5612.4 5781.3 5798.5 5807.2 5817.7 5692.8 5714.6 5735.1 5772.7 5804.9 5281.1 5303.3 5303.3 5324.4 5335.5 22907.1 23512.3 23743.9 24246.4 24251.3 2518.9 2536.1 2637.3 2702.4 2896.2 14961.1 15191.0 15264.5 15438.4 15655.3 1973.4 2061.5 2079.9 2100.8 2101.4 79134.2 81651.0 81766.0 82855.6 83701.0 9797.1 10384.5 11145.9 11154.6 11434.7 15687.0 15843.4 15882.9 15912.8 15914.2 8564.4 8944.6 8979.7 9033.1 9125.5 8831.5 8886.6 8905.7 8936.4 9164.8 6774.2 6863.8 6922.1 7040.9 7051.2 2014.4 2016.9 2034.5 2062.5 2070.6 1009.9 1086.2 1120.0 1121.6 1125.9 19609.3 19981.0 20079.9 20473.7 20673.7 1101.8 1121.8 1199.7 1215.3 1222.9 10629.0 11509.2 11681.2 11753.5 11797.5 463250.0 468529.0 512626.0 513629.0 515635.0 74980.6 81267.6 83345.6 101786.5 104519.5 962.3 993.5 1002.6 1009.3 1010.5 16570.2 16838.6 16965.2 17102.5 17282.8 42425.8 42912.8 44776.8 45391.0 45828.8 58800.7 59651.4 63732.0 64201.7 65351.0 7819.5 8721.3 8841.3 8849.2 9035.5 13464.6 13718.4 13787.0 13988.2 14037.4 11752.4 11764.3 12013.2 12317.9 12428.7 6194.7 11083.9 12166.8 12330.2 12464.8 12331.9 12553.5 12581.6 12629.5 12858.6 8352.9 8398.1 8406.4 8454.0 8498.9 12586.7 12627.1 12639.5 12642.9 12733.0 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | [#3] mootools.html Cycles:180 Average:6433.16 Median:4674.49 stddev:3799.99 (81.3%) stddev-sans-first:3793.30 16:12:37 INFO - PROCESS | 30882 | Values: 1600.7 1605.3 1822.8 1891.9 1937.3 8669.5 9160.7 9453.7 9727.3 9740.0 9481.2 9861.9 9923.1 9937.0 9950.0 2471.0 2503.8 2506.2 2507.4 2508.2 2396.3 2513.6 2515.2 2521.8 2528.6 2408.1 2451.9 2495.4 2497.7 2511.9 2428.4 2449.5 2459.9 2470.9 2484.6 2440.4 2450.7 2470.9 2480.9 2510.5 9683.9 9770.2 9793.5 9797.2 9866.4 5701.1 5770.6 5775.5 5871.3 5872.5 3465.5 3524.6 3582.0 3604.3 3626.9 1102.3 1147.4 1156.1 1162.5 1177.1 13970.9 13985.7 14013.9 14016.4 14044.4 4907.9 4937.2 4968.8 4987.6 5029.8 11811.1 11839.1 11938.5 11957.5 11959.6 5726.9 5749.5 5752.2 5754.7 5766.8 4696.1 5009.9 5065.0 5269.9 5274.3 4050.3 4058.5 4070.5 4076.6 4079.8 1281.6 1304.4 1305.2 1306.8 1307.9 1094.8 1104.4 1115.7 1116.9 1135.2 6858.7 6872.1 6874.2 6963.1 7003.0 442.3 446.3 458.1 463.8 464.9 4671.5 4677.5 4757.4 4767.5 4801.0 12121.5 12607.0 12640.6 12682.1 12731.4 11759.9 12260.2 12499.8 12642.2 12642.4 8854.3 8871.8 8987.7 9004.5 9023.8 6679.3 6821.2 6861.9 6874.9 6927.5 11215.8 11417.8 11543.2 11839.9 11840.2 11654.9 11752.1 11806.9 11840.1 11973.2 7115.1 8093.8 8164.5 8248.1 8288.8 9652.2 9664.7 9723.5 9765.7 9809.1 8031.5 8247.9 8260.5 8310.2 8352.2 8232.1 8463.3 8465.6 8499.3 8556.0 7399.1 7733.4 7752.6 7848.6 7892.0 5759.1 5893.5 5978.0 5984.8 5998.0 5512.1 5546.5 5557.8 5583.5 5647.5 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | [#4] prototype.html Cycles:180 Average:4910.65 Median:5504.89 stddev:1432.12 (26.0%) stddev-sans-first:1394.61 16:12:37 INFO - PROCESS | 30882 | Values: 349.0 352.2 356.1 356.7 362.8 5739.5 5793.4 5806.5 5827.8 5851.2 5671.8 5677.5 5686.3 5695.0 5722.7 4324.4 4407.3 4419.4 4424.9 4433.3 4390.4 4415.4 4427.2 4439.6 4466.8 4368.7 4393.3 4401.9 4418.3 4448.0 4384.2 4432.6 4440.4 4444.6 4451.0 3876.3 3876.3 3889.5 3896.8 3897.1 5451.0 5520.2 5553.1 5553.8 5616.6 4934.0 5038.2 5054.8 5061.8 5127.9 5916.6 5937.8 5943.8 5987.4 6016.9 4293.1 4338.5 4342.7 4355.3 4366.0 6036.3 6112.2 6292.8 6298.0 6370.4 4414.5 4422.7 4425.8 4431.7 4442.6 4469.6 4499.3 4506.9 4513.6 4544.7 4884.3 5048.6 5109.2 5134.2 5150.8 5890.4 5961.9 5965.9 5976.9 6004.5 1502.2 1521.6 1527.7 1529.0 1537.7 944.7 973.1 976.5 1001.9 1015.7 5195.3 5211.3 5230.9 5245.4 5250.8 5475.6 5524.3 5525.7 5531.8 5571.3 4826.3 5144.9 5156.8 5227.5 5254.3 2974.6 2976.5 2981.5 2984.0 2996.8 5606.7 5710.3 5714.1 5763.5 5780.1 5175.7 5511.4 5534.7 5582.6 5586.7 5601.7 5621.6 5669.1 5711.8 5743.8 5208.6 5413.6 5460.4 5525.4 5549.1 5450.3 5491.3 5498.5 5511.3 5875.6 6264.6 6464.0 6474.7 6510.4 6512.9 4294.0 4341.2 4343.4 4350.3 4351.9 5933.7 6239.6 6254.3 6321.8 6326.6 5976.6 6079.5 6084.6 6177.0 6198.8 5960.0 5966.9 6068.2 6122.6 6157.8 5886.2 5899.4 5930.8 5934.6 5951.3 6076.3 6098.0 6104.7 6120.6 6135.8 5624.6 5960.9 5987.9 5990.8 5993.5 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - PROCESS | 30882 | [#5] yui.html Cycles:180 Average:20869.86 Median:23931.17 stddev:29986.03 (125.3%) stddev-sans-first:30031.80 16:12:37 INFO - PROCESS | 30882 | Values: 671.5 718.5 784.0 854.6 888.5 15307.2 16012.4 16055.8 16098.7 16170.4 14865.9 14872.3 14911.5 15009.8 15030.7 725.2 855.8 878.8 880.0 884.3 832.4 846.4 846.9 847.2 847.2 902.6 905.9 908.2 910.8 910.9 893.7 897.0 897.7 899.0 901.2 656.3 662.7 664.6 665.6 665.6 14205.9 14233.7 14237.5 14293.6 14339.4 14718.5 14745.3 14910.9 15455.1 15482.0 12411.9 12677.0 12689.1 12746.5 12879.2 3651.1 3691.6 3721.7 3754.2 3791.0 79546.2 79733.0 80580.0 83012.0 83234.6 11287.1 11350.5 11386.9 11507.2 11536.8 21240.4 21382.5 21423.1 21504.1 21526.6 8729.1 9001.0 9056.5 9346.1 9351.3 4977.7 5024.3 5032.3 5120.8 5188.3 3761.8 3874.5 3874.7 3900.8 3902.8 648.4 673.3 689.1 690.3 700.2 635.0 753.5 772.9 791.4 813.9 9734.5 9848.2 9864.0 10033.1 10053.6 699.5 705.4 722.7 784.7 817.4 4860.0 4970.7 4983.1 5016.1 5039.0 115679.4 119267.0 121323.0 121816.0 122864.0 62744.0 64969.0 73342.0 97959.5 100080.0 91947.0 93802.5 93928.0 95558.0 95958.0 9564.8 9857.7 9868.9 9991.6 10296.4 39872.6 43002.4 53843.5 54900.5 55394.7 71271.6 73315.6 74871.6 75196.2 78283.0 12584.2 12752.8 14073.2 14235.7 14493.4 13807.9 13930.6 14053.4 14095.6 14363.3 13634.0 13729.5 14176.4 14256.4 14314.0 13650.6 13798.3 14250.2 14261.0 14605.3 12970.0 13757.0 13766.8 13787.5 13916.6 11116.7 11160.8 11213.5 11440.5 11586.9 11492.7 11590.2 11807.9 11850.9 11916.7 16:12:37 INFO - PROCESS | 30882 | -------- Summary: end -------- 16:12:37 INFO - PROCESS | 30882 | 16:12:37 INFO - TEST-INFO | 30882: exit 0 16:12:37 INFO - TEST-OK | dromaeo_css | took 1110346ms 16:12:37 INFO - TEST-START | kraken 16:12:37 INFO - operating with platform_type : linux_ 16:12:37 INFO - Initialising browser for kraken test... 16:12:37 INFO - TEST-INFO | started process 31127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuLK0KD/profile http://localhost:44896/getInfo.html) 16:12:42 INFO - PROCESS | 31127 | __metrics Screen width/height:1600/1200 16:12:42 INFO - PROCESS | 31127 | colorDepth:24 16:12:42 INFO - PROCESS | 31127 | Browser inner width/height: 1024/697 16:12:42 INFO - PROCESS | 31127 | __metrics 16:12:42 ERROR - PROCESS | 31127 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:12:43 INFO - TEST-INFO | 31127: exit 0 16:12:43 INFO - Browser initialized. 16:12:43 INFO - Running cycle 1/1 for kraken test... 16:12:43 INFO - TEST-INFO | started process 31258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuLK0KD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:55 INFO - PROCESS | 31258 | RSS: Main: 155848704 16:12:55 INFO - PROCESS | 31258 | 16:12:58 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44896/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:58 INFO - PROCESS | 31258 | RSS: Main: 161603584 16:12:58 INFO - PROCESS | 31258 | 16:13:01 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44896/tests/kraken/driver.html?testName=audio-dft) 16:13:02 INFO - PROCESS | 31258 | RSS: Main: 160686080 16:13:02 INFO - PROCESS | 31258 | 16:13:05 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44896/tests/kraken/driver.html?testName=audio-fft) 16:13:05 INFO - PROCESS | 31258 | RSS: Main: 161431552 16:13:05 INFO - PROCESS | 31258 | 16:13:07 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44896/tests/kraken/driver.html?testName=audio-oscillator) 16:13:08 INFO - PROCESS | 31258 | RSS: Main: 160743424 16:13:08 INFO - PROCESS | 31258 | 16:13:10 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:11 INFO - PROCESS | 31258 | RSS: Main: 161431552 16:13:11 INFO - PROCESS | 31258 | 16:13:14 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44896/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:14 INFO - PROCESS | 31258 | RSS: Main: 161144832 16:13:14 INFO - PROCESS | 31258 | 16:13:18 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44896/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:18 INFO - PROCESS | 31258 | RSS: Main: 161714176 16:13:18 INFO - PROCESS | 31258 | 16:13:21 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44896/tests/kraken/driver.html?testName=json-parse-financial) 16:13:22 INFO - PROCESS | 31258 | RSS: Main: 161681408 16:13:22 INFO - PROCESS | 31258 | 16:13:23 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:24 INFO - PROCESS | 31258 | RSS: Main: 161177600 16:13:24 INFO - PROCESS | 31258 | 16:13:26 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:26 INFO - PROCESS | 31258 | RSS: Main: 161267712 16:13:26 INFO - PROCESS | 31258 | 16:13:28 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:29 INFO - PROCESS | 31258 | RSS: Main: 161525760 16:13:29 INFO - PROCESS | 31258 | 16:13:32 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:32 INFO - PROCESS | 31258 | RSS: Main: 162086912 16:13:32 INFO - PROCESS | 31258 | 16:13:35 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:36 INFO - PROCESS | 31258 | RSS: Main: 162316288 16:13:36 INFO - PROCESS | 31258 | 16:13:37 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:44896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44896/tests/kraken/driver.html?testName=ai-astar) 16:13:38 INFO - PROCESS | 31258 | RSS: Main: 162836480 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | __start_tp_report 16:13:38 INFO - PROCESS | 31258 | _x_x_mozilla_page_load 16:13:38 INFO - PROCESS | 31258 | _x_x_mozilla_page_load_details 16:13:38 INFO - PROCESS | 31258 | |i|pagename|runs| 16:13:38 INFO - PROCESS | 31258 | |0;ai-astar;110;105;111;110;112;112;109;108;110;110 16:13:38 INFO - PROCESS | 31258 | |1;audio-beat-detection;154;126;151;179;130;153;158;126;179;130 16:13:38 INFO - PROCESS | 31258 | |2;audio-dft;164;161;163;162;161;163;161;164;163;161 16:13:38 INFO - PROCESS | 31258 | |3;audio-fft;76;75;76;177;76;77;75;74;161;74 16:13:38 INFO - PROCESS | 31258 | |4;audio-oscillator;85;83;157;84;85;84;149;83;84;141 16:13:38 INFO - PROCESS | 31258 | |5;imaging-gaussian-blur;117;117;122;117;117;117;117;117;120;117 16:13:38 INFO - PROCESS | 31258 | |6;imaging-darkroom;146;149;147;146;146;147;146;146;146;147 16:13:38 INFO - PROCESS | 31258 | |7;imaging-desaturate;95;96;97;96;96;97;96;96;95;95 16:13:38 INFO - PROCESS | 31258 | |8;json-parse-financial;51;60;51;57;52;52;51;52;53;52 16:13:38 INFO - PROCESS | 31258 | |9;json-stringify-tinderbox;61;62;62;62;62;60;60;62;61;61 16:13:38 INFO - PROCESS | 31258 | |10;stanford-crypto-aes;78;78;78;78;82;81;79;79;109;79 16:13:38 INFO - PROCESS | 31258 | |11;stanford-crypto-ccm;123;127;126;119;129;148;125;139;123;122 16:13:38 INFO - PROCESS | 31258 | |12;stanford-crypto-pbkdf2;157;164;160;155;155;154;155;159;160;152 16:13:38 INFO - PROCESS | 31258 | |13;stanford-crypto-sha256-iterative;69;65;61;61;62;66;62;61;60;68 16:13:38 INFO - PROCESS | 31258 | __end_tp_report 16:13:38 INFO - PROCESS | 31258 | __start_cc_report 16:13:38 INFO - PROCESS | 31258 | _x_x_mozilla_cycle_collect,900 16:13:38 INFO - PROCESS | 31258 | __end_cc_report 16:13:38 INFO - PROCESS | 31258 | __startTimestamp1469661218038__endTimestamp 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | ------- Summary: start ------- 16:13:38 INFO - PROCESS | 31258 | Number of tests: 14 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.06 (1.9%) stddev-sans-first:2.18 16:13:38 INFO - PROCESS | 31258 | Values: 110.0 105.0 111.0 110.0 112.0 112.0 109.0 108.0 110.0 110.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:153.50 stddev:20.29 (13.2%) stddev-sans-first:21.42 16:13:38 INFO - PROCESS | 31258 | Values: 154.0 126.0 151.0 179.0 130.0 153.0 158.0 126.0 179.0 130.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 16:13:38 INFO - PROCESS | 31258 | Values: 164.0 161.0 163.0 162.0 161.0 163.0 161.0 164.0 163.0 161.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.67 (52.5%) stddev-sans-first:41.53 16:13:38 INFO - PROCESS | 31258 | Values: 76.0 75.0 76.0 177.0 76.0 77.0 75.0 74.0 161.0 74.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:84.00 stddev:31.63 (37.7%) stddev-sans-first:32.83 16:13:38 INFO - PROCESS | 31258 | Values: 85.0 83.0 157.0 84.0 85.0 84.0 149.0 83.0 84.0 141.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:1.75 (1.5%) stddev-sans-first:1.83 16:13:38 INFO - PROCESS | 31258 | Values: 117.0 117.0 122.0 117.0 117.0 117.0 117.0 117.0 120.0 117.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 16:13:38 INFO - PROCESS | 31258 | Values: 146.0 149.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 16:13:38 INFO - PROCESS | 31258 | Values: 95.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 95.0 95.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:52.00 stddev:3.00 (5.8%) stddev-sans-first:3.08 16:13:38 INFO - PROCESS | 31258 | Values: 51.0 60.0 51.0 57.0 52.0 52.0 51.0 52.0 53.0 52.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 16:13:38 INFO - PROCESS | 31258 | Values: 61.0 62.0 62.0 62.0 62.0 60.0 60.0 62.0 61.0 61.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:79.00 stddev:9.55 (12.1%) stddev-sans-first:10.01 16:13:38 INFO - PROCESS | 31258 | Values: 78.0 78.0 78.0 78.0 82.0 81.0 79.0 79.0 109.0 79.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.50 stddev:8.84 (7.0%) stddev-sans-first:9.18 16:13:38 INFO - PROCESS | 31258 | Values: 123.0 127.0 126.0 119.0 129.0 148.0 125.0 139.0 123.0 122.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:158.00 stddev:3.60 (2.3%) stddev-sans-first:3.82 16:13:38 INFO - PROCESS | 31258 | Values: 157.0 164.0 160.0 155.0 155.0 154.0 155.0 159.0 160.0 152.0 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - PROCESS | 31258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:3.24 (5.1%) stddev-sans-first:2.76 16:13:38 INFO - PROCESS | 31258 | Values: 69.0 65.0 61.0 61.0 62.0 66.0 62.0 61.0 60.0 68.0 16:13:38 INFO - PROCESS | 31258 | -------- Summary: end -------- 16:13:38 INFO - PROCESS | 31258 | 16:13:38 INFO - TEST-INFO | 31258: exit 0 16:13:38 INFO - TEST-OK | kraken | took 61014ms 16:13:38 INFO - SUITE-END | took 1171s 16:13:39 INFO - Completed test suite (00:19:31) 16:13:39 INFO - javascript benchmark 16:13:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7691.60723072936, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.7280217582597, 3403.353362861055, 3408.863645454182, 3422.589289285286, 3427.143214196451, 5629.831105066849, 5644.689542075189, 5684.403137670542, 5691.146328050794, 5797.971010144944, 5796.797112101077, 5830.766769329232, 5838.182654428373, 5870.324912635048, 5871.031279838832, 5259.973700131494, 5281.603879709018, 5306.681599104047, 5318.547923426513, 5329.813456529022, 5193.480651934795, 5194.0, 5263.473652634744, 5333.893322133555, 5349.0, 5226.1899405592, 5230.73846307685, 5288.629795914288, 5388.326459192601, 5394.109971854639, 5297.311349524537, 5297.655652382583, 5310.256564081051, 5326.0, 5326.041312563737, 5093.541581257705, 5151.948480515184, 5207.4792520748, 5215.6609820361555, 5278.9208161877605, 5567.415421380737, 5605.57958153136, 5622.0, 5637.013522633563, 5641.12562552805, 6113.694315284218, 6156.4766994805495, 6165.876682466371, 6183.628982261033, 6188.504919606466, 6103.115048318014, 6144.754209831602, 6207.441330280297, 6210.596311239755, 6227.501799856046, 5721.0, 5801.6809075500405, 5805.7097145143, 5806.680632565207, 5844.26946631671, 6366.26787919386, 6381.553291269566, 6383.616982981036, 6384.52116091295, 6391.616503009835, 5826.941730582725, 6070.726817293144, 6080.513558915276, 6088.330283668793, 6118.571699980958, 6300.873982520324, 6317.399847014526, 6318.526110541728, 6319.304876463585, 6324.2410910691015, 6208.72060757258, 6236.18929539157, 6243.750249989949, 6246.625202487865, 6254.249490061222, 6008.639481631116, 6073.119397687311, 6087.086936959403, 6091.08633704939, 6300.464460520815, 4682.1103990241745, 4684.063187362473, 4691.155591993405, 4704.600108990706, 4723.220668589713, 4167.812448439828, 4168.353905144708, 4171.4368560243975, 4196.076863090177, 4225.492940847056, 5703.74333155009, 5946.256717910262, 5950.196723442366, 5973.880522389615, 6070.362611925772, 6054.39456054391, 6139.469804862222, 6152.938470615326, 6205.28639206488, 6211.3167551569295, 6025.517958563304, 6031.095335699592, 6038.577299589075, 6040.154378387029, 6087.421694938974, 5262.947370526245, 5281.630285880028, 5317.175837745156, 5332.226827110047, 5348.652337598043, 6589.967050164719, 6614.10709554204, 6621.106150669694, 6639.601623902581, 6668.933310666928, 6354.904676429765, 6357.459615932605, 6359.936400636119, 6362.204724409449, 6374.29882712892, 6346.873062538816, 6498.805035848932, 6554.410103090745, 6576.76981305652, 6653.933460665331, 6172.0, 6206.193194884636, 6214.844628884314, 6233.875322493615, 6237.033259844731, 6066.848328791815, 6335.683215839282, 6351.777687780906, 6352.237731472253, 6360.427561519486, 6082.817515474543, 6097.969510152421, 6119.474990425872, 6135.84660383494, 6200.441960223601, 6122.938770612237, 6145.66198859067, 6161.907571386522, 6184.938150618616, 6186.0, 5793.797217097382, 5920.230370051866, 6019.458248757633, 6020.819375418744, 6065.302490213682, 6144.723487443165, 6170.660613666291, 6188.319284878749, 6206.379362063757, 6206.596571222856, 6059.000264956233, 6064.02975523914, 6088.786892458743, 6091.162976261861, 6141.877162456636], "value": 5741.495532785948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.5163868904875, 656.7110471392589, 661.6890061671013, 677.3598948993202, 677.5832862789383, 45417.0, 46756.532434675726, 47094.2935855962, 47304.526954730485, 50693.493065069335, 47782.283265751044, 48241.27638085432, 48323.758381208136, 48362.27456588154, 48386.75806620962, 8973.416727912681, 8993.775155621097, 9093.272538196961, 9105.180533751962, 9125.817483650322, 8949.284057275436, 9026.458412495238, 9030.142136497023, 9039.096090390974, 9059.275257979345, 8987.865182022275, 9003.819923601524, 9044.683436079738, 9091.454512729257, 9106.18044376006, 9037.322200834931, 9064.501452420114, 9080.137386948263, 9096.226820720247, 9101.180893719596, 8903.866442003375, 8980.820383592292, 9007.594658240328, 9014.909850901473, 9021.548922553911, 43949.78025109886, 44278.77860610709, 44339.55660443386, 44355.33466997997, 44627.10745785099, 3644.69020133289, 3832.9041773955596, 3909.0618251619408, 4018.3168861293357, 4501.257292546726, 32738.345233095442, 33771.662283377096, 34097.0, 34225.82887085548, 34252.82873585641, 4530.841420550298, 4611.518303680733, 4623.491415944243, 4687.749880057558, 4880.780364883553, 385373.0, 388628.2842928921, 388970.99999999715, 389756.0, 390125.0, 69881.65059174671, 70643.0, 70665.64667176631, 70924.0, 70942.29057709356, 38711.2257754849, 39618.207635847124, 39769.40345894814, 41194.1761164775, 73850.63074684593, 19766.308179213658, 19954.90022549878, 20024.89987550082, 20034.69947950782, 20046.198152074045, 15162.696746065018, 15253.237338133049, 15255.237238138048, 15265.313060912285, 15298.694026119416, 20559.8972005139, 20848.0, 20854.0, 20935.581288374146, 20961.89519052395, 7463.514871533333, 7506.962465187748, 7568.735094271674, 7885.723999659985, 7972.880406793903, 1053.3363980692116, 1091.8525998990035, 1096.7751610919743, 1132.8758577666874, 1199.424276347358, 32897.83551082229, 32920.67079329176, 33287.66712332846, 33773.15567110842, 33792.80433514641, 1170.8829117088394, 1190.892819646236, 1209.981850272229, 1219.2196993923897, 1256.6669832494397, 17866.731999020027, 17888.642227155644, 17925.910370448066, 17953.551161221076, 18036.90981545084, 545634.0, 587493.0, 589840.0, 590315.0, 616684.0, 54960.0, 59464.40535594675, 60145.69927150336, 60278.397216027275, 60298.698506507186, 1454.7381471335261, 1456.5266288456294, 1461.5469204546625, 1468.4713503138862, 1476.7489526780473, 32506.674933250364, 32951.50572741363, 33780.97314161158, 34217.97346079622, 34460.0, 54697.72651136719, 55084.0, 55403.72298138483, 55429.44570554243, 55439.72280138574, 516527.0, 522902.0, 523028.0, 524266.0, 525194.0, 30107.04326706849, 30576.847115764278, 30655.080347589606, 30901.8454907724, 30998.0, 50429.74785126198, 50934.0, 51147.74426127994, 51479.940802367484, 52224.738876305375, 41449.97631572411, 42758.0, 42939.375625414184, 43237.13525729405, 43583.78208108939, 42687.786561068235, 43035.0, 43299.0, 43567.782161088995, 43738.78130609327, 42640.573594264904, 42934.0, 43360.783196083816, 43611.56388436075, 44028.67913962586, 36088.736894208574, 36620.63379366279, 36621.598067777406, 36897.26205475929, 37098.44352334771, 28939.276518087216, 30054.51717266146, 30070.097897063122, 30137.547936780527, 30567.847160764053], "value": 21455.16107154848, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.4773209621925, 417.6846480906915, 418.5688740597186, 421.4584259226894, 431.65467625899294, 18637.72043419348, 19561.967894976282, 20273.797262027376, 20389.490262743402, 20572.177112915484, 18502.352417665385, 18519.62960740788, 18601.255949761995, 18605.441836744918, 19419.611607767834, 5522.585806064551, 5912.9704351478185, 5970.373110823344, 5983.461488466037, 5988.700564971756, 5847.824565263028, 5870.354261031283, 5908.645481271137, 5933.970330148343, 5935.406459354052, 5612.41069687683, 5781.335146458148, 5798.478136967672, 5807.186993820868, 5817.680027598481, 5692.829215123553, 5714.57140714446, 5735.139729040636, 5772.653640781546, 5804.912926306109, 5281.102212623863, 5303.28405665238, 5303.310569625924, 5324.440933701983, 5335.466453354672, 22907.08371665148, 23512.294631161094, 23743.881280593658, 24246.39384015396, 24251.272461826175, 2518.9496210075695, 2536.112360673768, 2637.3406648337914, 2702.3649442381025, 2896.174590241792, 14961.102333860003, 15191.0, 15264.46574369903, 15438.38246470151, 15655.295511702001, 1973.3882496426154, 2061.505238742706, 2079.8856062916534, 2100.7584127825344, 2101.3800928726064, 79134.20865791326, 81651.0, 81766.0, 82855.585722071, 83701.0, 9797.118259356692, 10384.480775961172, 11145.888541114486, 11154.553817847196, 11434.656960291204, 15687.0, 15843.445479408165, 15882.920585397, 15912.840871591368, 15914.204289785464, 8564.443311184754, 8944.642214311354, 8979.730608081769, 9033.096690330914, 9125.498097604695, 8831.470111793313, 8886.644534218689, 8905.73282801517, 8936.374453788172, 9164.770880727901, 6774.153230846145, 6863.803582853439, 6922.134733158356, 7040.894386584206, 7051.153861536546, 2014.375543581465, 2016.939491815248, 2034.4710375302527, 2062.494688801223, 2070.6498124628656, 1009.9343542669703, 1086.2463654635462, 1119.9776004479866, 1121.6130434999911, 1125.8648962124598, 19609.313674021625, 19981.0, 20079.867653600315, 20473.692894606593, 20673.689894651594, 1101.8071837428417, 1121.8429419881222, 1199.736058067224, 1215.2985819852277, 1222.896053835434, 10629.0, 11509.216071508761, 11681.182317237712, 11753.529858805723, 11797.469113889896, 463250.0, 468529.0, 512626.0, 513629.0, 515635.0, 74980.62509687417, 81267.59366203132, 83345.58327208446, 101786.4910675442, 104519.4774026125, 962.2734835199379, 993.5280741647804, 1002.6190047781942, 1009.3338396658023, 1010.4947526236881, 16570.17149142514, 16838.57903552421, 16965.236564354385, 17102.48692539226, 17282.82717172812, 42425.78787106045, 42912.78543607262, 44776.77611612051, 45391.0, 45828.77085614551, 58800.70599647146, 59651.40348596458, 63732.0, 64201.67899160474, 65351.0, 7819.491733037335, 8721.345899057469, 8841.292696584387, 8849.247813935888, 9035.45787252767, 13464.596062118153, 13718.382672779948, 13787.034907556375, 13988.230647314089, 14037.438502459787, 11752.412379381169, 11764.294142351486, 12013.219140755822, 12317.876821231674, 12428.689282768004, 6194.690265486617, 11083.944580277048, 12166.75666486683, 12330.19853709506, 12464.813027804408, 12331.876681233072, 12553.497860085494, 12581.622551323475, 12629.494820207088, 12858.614241572768, 8352.916470835215, 8398.118197589409, 8406.369522285731, 8453.957730211556, 8498.91501085006, 12586.748265034832, 12627.116101873147, 12639.494420223456, 12642.87357126417, 12733.0], "value": 9738.653567052825, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1600.6878658661558, 1605.2696023309393, 1822.8177182281765, 1891.8959457229846, 1937.3413039566544, 8669.523176225304, 9160.725178244647, 9453.71638850834, 9727.270454715897, 9740.0, 9481.194098501635, 9861.901380986188, 9923.0573095556, 9936.950315248432, 9950.004999500046, 2471.0362958446176, 2503.8372505787156, 2506.1980166346775, 2507.3856905058287, 2508.159766478232, 2396.281115665302, 2513.610390389483, 2515.1825656661567, 2521.7982561395042, 2528.6080657498023, 2408.12103582193, 2451.8528888266674, 2495.351208685746, 2497.7002759668867, 2511.899524019037, 2428.429319110008, 2449.473363226906, 2459.86470744109, 2470.888810003536, 2484.6024636058232, 2440.365504968721, 2450.6691596634405, 2470.8641024743633, 2480.900763969439, 2510.5104504621604, 9683.854742178873, 9770.218382529452, 9793.461359625218, 9797.167240784542, 9866.358686685415, 5701.0878259478695, 5770.6249093808765, 5775.509081728058, 5871.295444546682, 5872.530197584183, 3465.480177973299, 3524.6475352464804, 3582.0328511302064, 3604.315180115796, 3626.8549258029648, 1102.3385968418966, 1147.4033502578695, 1156.0693641618493, 1162.4652659776514, 1177.1230433327141, 13970.93014534931, 13985.72028559423, 14013.859861401459, 14016.36926338307, 14044.438222471088, 4907.9263811042865, 4937.1606826839525, 4968.826091086795, 4987.625928055338, 5029.84910452687, 11811.114166437552, 11839.112066594867, 11938.462769175409, 11957.461914213882, 11959.58141465062, 5726.942730572724, 5749.482546570745, 5752.165935939265, 5754.6547207167705, 5766.826995190151, 4696.131215725101, 5009.89980200394, 5065.0, 5269.920951185735, 5274.287971123926, 4050.250703619781, 4058.467791298398, 4070.531888832822, 4076.612721791425, 4079.7760671798937, 1281.5834853672593, 1304.419533307688, 1305.2299143505377, 1306.7778477658821, 1307.901907356952, 1094.7785201682752, 1104.3705088099866, 1115.7378016166356, 1116.8771435142128, 1135.1940122512942, 6858.725650973905, 6872.10662613857, 6874.175098988054, 6963.059986901805, 7003.0, 442.25259311763017, 446.3394176618558, 458.1044058864911, 463.7727513518419, 464.8837790552362, 4671.48613652498, 4677.4854765975715, 4757.35775670287, 4767.4994125617, 4801.039792041605, 12121.515139394502, 12607.0, 12640.620781376574, 12682.112252142446, 12731.427085781163, 11759.941200294115, 12260.203086799329, 12499.812502812465, 12642.2414655121, 12642.367881605884, 8854.29165666745, 8871.778205544784, 8987.730368088967, 9004.459732416077, 9023.774405639911, 6679.332066793476, 6821.249662537216, 6861.862762744817, 6874.896876546956, 6927.480438967198, 11215.831762523405, 11417.771644566896, 11543.249688770204, 11839.940800295943, 11840.171188016757, 11654.941725291319, 11752.059835212991, 11806.881931180578, 11840.052795776144, 11973.16187866841, 7115.075040244735, 8093.797655058671, 8164.510129392255, 8248.13394593583, 8288.792780180544, 9652.2278217741, 9664.661736839176, 9723.46520941355, 9765.707028789147, 9809.068138526829, 8031.518108913484, 8247.917520824954, 8260.463069900437, 8310.168983101641, 8352.164783521599, 8232.135625759209, 8463.28062114727, 8465.57672116404, 8499.32005439551, 8555.957220213859, 7399.112106547249, 7733.419993500397, 7752.612369381395, 7848.646810893638, 7891.960540197262, 5759.107338362561, 5893.528517718658, 5978.0, 5984.820455386345, 5998.040313549811, 5512.062949298709, 5546.500814926676, 5557.833265002057, 5583.469570390806, 5647.491725744539], "value": 4988.665715297536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.0, 352.24267824178014, 356.1470278682555, 356.718192627824, 362.83853685110137, 5739.512141467975, 5793.364019371186, 5806.506446952004, 5827.796027139051, 5851.2100866383025, 5671.8089201267785, 5677.517411020068, 5686.31764188297, 5695.0, 5722.656640601567, 4324.4378230830025, 4407.272799987998, 4419.359192917025, 4424.867253982386, 4433.290673492242, 4390.407295015164, 4415.432521454885, 4427.247367947441, 4439.578240067204, 4466.798994045275, 4368.650507959355, 4393.275109606911, 4401.867943961686, 4418.321038005553, 4447.977760111211, 4384.232759267132, 4432.601065904052, 4440.400545926291, 4444.577765112309, 4450.998525331806, 3876.2635099331037, 3876.341022026234, 3889.533256009269, 3896.8051597420017, 3897.142628621699, 5450.972745136289, 5520.199571062214, 5553.084185955839, 5553.7778488860395, 5616.606837521375, 4934.0, 5038.244263360489, 5054.797808087672, 5061.822836200752, 5127.871803204913, 5916.645001299893, 5937.792177273818, 5943.791967281168, 5987.401259874021, 6016.909746353808, 4293.141371725636, 4338.481531463994, 4342.696011279212, 4355.346697995295, 4366.0, 6036.305824830157, 6112.174856394375, 6292.811215663492, 6298.023806310075, 6370.362963703639, 4414.514403415622, 4422.690411671152, 4425.800838962255, 4431.689781715249, 4442.622377097919, 4469.620082293041, 4499.302608095751, 4506.909861802811, 4513.616342610849, 4544.7045942013665, 4884.291777692215, 5048.570871475966, 5109.182530795055, 5134.204198349262, 5150.845474635767, 5890.410958904161, 5961.880762384728, 5965.880682386415, 5976.910346344808, 6004.519638428916, 1502.1512845242403, 1521.5815650695927, 1527.6639139389317, 1528.96177595561, 1537.7385844406479, 944.6821683751128, 973.095021629891, 976.5019839881569, 1001.8547310639916, 1015.7003683913264, 5195.324607801037, 5211.296474975829, 5230.869228269247, 5245.423003469616, 5250.842474725764, 5475.644083134664, 5524.254225679482, 5525.656977528618, 5531.778728850882, 5571.29792050855, 4826.276058591239, 5144.893847822661, 5156.845294641167, 5227.45111763267, 5254.316938798008, 2974.628171478565, 2976.538636511344, 2981.5092453773113, 2983.9552406713915, 2996.756346116337, 5606.748086110047, 5710.2862142232225, 5714.085746280575, 5763.510101641324, 5780.132980053026, 5175.741212939338, 5511.448855114537, 5534.723263836792, 5582.609217354746, 5586.720663966786, 5601.6670081300745, 5621.606487545832, 5669.1291873681585, 5711.8000869969355, 5743.812184237705, 5208.619715775247, 5413.621046526705, 5460.372057213472, 5525.430674736267, 5549.089056185225, 5450.291462109901, 5491.28613280271, 5498.505134537911, 5511.283533140666, 5875.559333050124, 6264.561480696308, 6464.02654778807, 6474.676266186766, 6510.414062734377, 6512.934870651233, 4293.97853010733, 4341.196878577473, 4343.370211319278, 4350.260455722471, 4351.8694439166875, 5933.732982015906, 6239.594426362272, 6254.343293954069, 6321.810345689637, 6326.557141000086, 5976.581639285208, 6079.483243924139, 6084.574079814371, 6176.980798168252, 6198.81403557894, 5959.970200148971, 5966.85302719802, 6068.150458935841, 6122.632642041313, 6157.753689852356, 5886.234789477512, 5899.439553242435, 5930.822075337746, 5934.584579079423, 5951.256092988377, 6076.331603523698, 6098.0, 6104.718009218114, 6120.60216085953, 6135.815925522242, 5624.550035997028, 5960.8807823844145, 5987.9401205989125, 5990.760369585168, 5993.471664725467], "value": 4455.48662493565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.4796033074367, 718.4611541343992, 784.0238902566306, 854.6282367170279, 888.524639317965, 15307.234638268084, 16012.43956461524, 16055.83944160558, 16098.678026439478, 16170.434034808784, 14865.92567037166, 14872.256387180625, 14911.478098266563, 15009.849901500982, 15030.699386012273, 725.1515726599864, 855.7518319687283, 878.8462019146656, 879.9516026618534, 884.332329091535, 832.3923535818856, 846.3694547562075, 846.9237768600825, 847.1570787066877, 847.1993965702413, 902.6118768929358, 905.9094090590921, 908.1871724806294, 910.7677542226722, 910.8679241509977, 893.696143311274, 896.9551522423852, 897.7486303834937, 898.9910100899006, 901.179926267097, 656.3141517114626, 662.6752891083382, 664.5746722097862, 665.6272487407067, 665.6472069803012, 14205.85794142066, 14233.715325693429, 14237.501687440994, 14293.57119286423, 14339.354729037219, 14718.484853030199, 14745.336459859333, 14910.850891491054, 15455.149966751824, 15482.0, 12411.875881241162, 12677.0, 12689.111762176652, 12746.490140394373, 12879.162854414526, 3651.123730304708, 3691.6123807000145, 3721.7208709346637, 3754.1928485375774, 3791.0, 79546.20453795446, 79732.99999999942, 80580.0, 83012.0, 83234.58382708048, 11287.097032237401, 11350.545978160946, 11386.94306528462, 11507.19449638534, 11536.826947595793, 21240.362789116352, 21382.465438363855, 21423.143074277166, 21504.13983440676, 21526.56946861054, 8729.127087291346, 9001.009888912215, 9056.501892395981, 9346.065393460736, 9351.298652601083, 4977.701337919664, 5024.32171656829, 5032.3206367139965, 5120.769565369567, 5188.325517682677, 3761.8307176177136, 3874.5350557932666, 3874.6900247980657, 3900.8439662413184, 3902.785346805896, 648.4229036157823, 673.2930423055772, 689.1489011071322, 690.2821066091309, 700.1668015062162, 634.9873002540015, 753.5252790741907, 772.9343005844454, 791.3708601661577, 813.938954578409, 9734.513274336396, 9848.21214302854, 9863.950680246553, 10033.09702126812, 10053.64812231583, 699.464909344352, 705.3792662457005, 722.7181399254295, 784.7214238945093, 817.3992115794886, 4859.975700121477, 4970.72661003641, 4983.103041452501, 5016.122178618727, 5039.0, 115679.42160289313, 119267.0, 121323.0, 121816.0, 122864.0, 62744.0, 64969.0, 73342.0, 97959.51020244854, 100080.0, 91947.0, 93802.53098734462, 93928.0, 95558.0, 95958.0, 9564.76088097803, 9857.654982075594, 9868.901310987085, 9991.550380232762, 10296.433696146783, 39872.60127398689, 43002.35496467493, 53843.46156538541, 54900.450995491134, 55394.72302638461, 71271.64364178145, 73315.63342183255, 74871.62564187362, 75196.24803751892, 78283.0, 12584.18202816814, 12752.808707869575, 14073.225972571197, 14235.715285694436, 14493.405725370412, 13807.861921380658, 13930.58208253754, 14053.36759845789, 14095.647608809451, 14363.281835908372, 13634.0, 13729.45082196701, 14176.432942682177, 14256.358463869357, 14314.0, 13650.617967164602, 13798.310084495533, 14250.216238106588, 14261.0, 14605.269736513344, 12970.0, 13757.0, 13766.793498097337, 13787.51743688966, 13916.58250252494, 11116.722081948015, 11160.776784464428, 11213.472800447471, 11440.48517816717, 11586.942065289619, 11492.712682182679, 11590.246633968765, 11807.940960295144, 11850.881491184979, 11916.702082448008], "value": 7764.708742766152, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 110.0, 112.0, 112.0, 109.0, 108.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 151.0, 179.0, 130.0, 153.0, 158.0, 126.0, 179.0, 130.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 163.0, 162.0, 161.0, 163.0, 161.0, 164.0, 163.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 177.0, 76.0, 77.0, 75.0, 74.0, 161.0, 74.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 157.0, 84.0, 85.0, 84.0, 149.0, 83.0, 84.0, 141.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 122.0, 117.0, 117.0, 117.0, 117.0, 117.0, 120.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 60.0, 51.0, 57.0, 52.0, 52.0, 51.0, 52.0, 53.0, 52.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 60.0, 60.0, 62.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 82.0, 81.0, 79.0, 79.0, 109.0, 79.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 126.0, 119.0, 129.0, 148.0, 125.0, 139.0, 123.0, 122.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 164.0, 160.0, 155.0, 155.0, 154.0, 155.0, 159.0, 160.0, 152.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 61.0, 61.0, 62.0, 66.0, 62.0, 61.0, 60.0, 68.0], "value": 63.5, "unit": "score"}]}]} 16:13:39 INFO - Return code: 0 16:13:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:39 ERROR - # TBPL SUCCESS # 16:13:39 INFO - Running post-action listener: _resource_record_post_action 16:13:39 INFO - ##### 16:13:39 INFO - ##### Finished run-tests step (success) 16:13:39 INFO - ##### 16:13:39 INFO - Running post-run listener: _resource_record_post_run 16:13:39 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 299008; Write bytes: 506241024; Read time: 332; Write time: 320832 16:13:39 INFO - TinderboxPrint: CPU usage
13.4% 16:13:39 INFO - TinderboxPrint: I/O read bytes / time
299,008 / 332 16:13:39 INFO - TinderboxPrint: I/O write bytes / time
506,241,024 / 320,832 16:13:39 INFO - TinderboxPrint: CPU idle
8,213.2 (86.6%) 16:13:39 INFO - TinderboxPrint: CPU user
1,215.7 (12.8%) 16:13:39 INFO - TinderboxPrint: Swap in / out
0 / 0 16:13:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252764160; Read time: 140; Write time: 196324 16:13:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 270336; Write bytes: 253476864; Read time: 184; Write time: 124508 16:13:39 INFO - Running post-run listener: _upload_blobber_files 16:13:39 INFO - Blob upload gear active. 16:13:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:39 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 16:13:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:40 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:13:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:41 INFO - (blobuploader) - INFO - Done attempting. 16:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:42 INFO - (blobuploader) - INFO - Done attempting. 16:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:46 INFO - (blobuploader) - INFO - Done attempting. 16:13:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:46 INFO - Return code: 0 16:13:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/621e7e6957db37b97f2a36b9b20125ddddf10506728191be018c64eef0437375cf18292ea47a5bc0d66cfd093b8e155f81dffbca9c751b80546c9943e3c07e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b405459fc7a5f71f4b17f29470c996ca1e4b89d3bd3ae81e5f80b3e14838ff783742fa83c3023533a199005523684f5a8bdd3617af8da2893cb36721e6a520", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a4673e0378b60e3a25c83c9b685c458d2bd1b445ebe9d98c75f9fbec432b544daad28d0b7fabd9a56fc9d24ffb1f94495bbdd01afa41ca63d7a64b968b89adb"} 16:13:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:46 INFO - Contents: 16:13:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/621e7e6957db37b97f2a36b9b20125ddddf10506728191be018c64eef0437375cf18292ea47a5bc0d66cfd093b8e155f81dffbca9c751b80546c9943e3c07e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b405459fc7a5f71f4b17f29470c996ca1e4b89d3bd3ae81e5f80b3e14838ff783742fa83c3023533a199005523684f5a8bdd3617af8da2893cb36721e6a520", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a4673e0378b60e3a25c83c9b685c458d2bd1b445ebe9d98c75f9fbec432b544daad28d0b7fabd9a56fc9d24ffb1f94495bbdd01afa41ca63d7a64b968b89adb"} 16:13:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:46 INFO - Copying logs to upload dir... 16:13:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.657802 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-27 16:13:46.057378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:46.061407) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/621e7e6957db37b97f2a36b9b20125ddddf10506728191be018c64eef0437375cf18292ea47a5bc0d66cfd093b8e155f81dffbca9c751b80546c9943e3c07e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b405459fc7a5f71f4b17f29470c996ca1e4b89d3bd3ae81e5f80b3e14838ff783742fa83c3023533a199005523684f5a8bdd3617af8da2893cb36721e6a520", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a4673e0378b60e3a25c83c9b685c458d2bd1b445ebe9d98c75f9fbec432b544daad28d0b7fabd9a56fc9d24ffb1f94495bbdd01afa41ca63d7a64b968b89adb"} build_url:https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/IWBWgMsERR6EcxHA4vXWyA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/621e7e6957db37b97f2a36b9b20125ddddf10506728191be018c64eef0437375cf18292ea47a5bc0d66cfd093b8e155f81dffbca9c751b80546c9943e3c07e80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b405459fc7a5f71f4b17f29470c996ca1e4b89d3bd3ae81e5f80b3e14838ff783742fa83c3023533a199005523684f5a8bdd3617af8da2893cb36721e6a520", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a4673e0378b60e3a25c83c9b685c458d2bd1b445ebe9d98c75f9fbec432b544daad28d0b7fabd9a56fc9d24ffb1f94495bbdd01afa41ca63d7a64b968b89adb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:46.087933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:46.088275) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1469659965.691249-934412499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 16:13:46.171931) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 16:13:46.172250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 16:13:46.172552) ========= ========= Total master_lag: 0.18 =========