builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1465517051.94 results: success (0) buildid: 20160609142532 builduid: 363139945ab7421585493c1f579e99e3 revision: 4253296f212b3cca52992ec5f6cd824b13153abd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:11.939503) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:11.939972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:11.940296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:11.954746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:11.955014) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 17:04:12-- 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% 109M=0s 2016-06-09 17:04:12 (109 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:12.058904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:12.059212) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014915 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:12.109026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 17:04:12.109382) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4253296f212b3cca52992ec5f6cd824b13153abd --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 4253296f212b3cca52992ec5f6cd824b13153abd --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=edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 17:04:12,300 truncating revision to first 12 chars 2016-06-09 17:04:12,300 Setting DEBUG logging. 2016-06-09 17:04:12,300 attempt 1/10 2016-06-09 17:04:12,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4253296f212b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 17:04:13,670 unpacking tar archive at: mozilla-aurora-4253296f212b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.751060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 17:04:13.875450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:13.875893) ========= script_repo_revision: 4253296f212b3cca52992ec5f6cd824b13153abd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:13.876330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:13.876596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 17:04:13.886080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-09 17:04:13.886362) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:04:14 INFO - MultiFileLogger online at 20160609 17:04:14 in /builds/slave/test 17:04:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:04:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:04:14 INFO - {'append_to_log': False, 17:04:14 INFO - 'base_work_dir': '/builds/slave/test', 17:04:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:04:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:04:14 INFO - 'branch': 'Mozilla-Aurora', 17:04:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:14 INFO - 'config_files': ('talos/linux_config.py',), 17:04:14 INFO - 'default_actions': ('clobber', 17:04:14 INFO - 'read-buildbot-config', 17:04:14 INFO - 'download-and-extract', 17:04:14 INFO - 'populate-webroot', 17:04:14 INFO - 'create-virtualenv', 17:04:14 INFO - 'install', 17:04:14 INFO - 'run-tests'), 17:04:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:14 INFO - 'download_minidump_stackwalk': True, 17:04:14 INFO - 'download_symbols': 'ondemand', 17:04:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:14 INFO - 'installer_path': 'installer.exe', 17:04:14 INFO - 'log_level': 'info', 17:04:14 INFO - 'log_name': 'talos', 17:04:14 INFO - 'log_to_console': True, 17:04:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:04:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:04:14 INFO - 'opt_config_files': (), 17:04:14 INFO - 'pip_index': False, 17:04:14 INFO - 'sps_profile': False, 17:04:14 INFO - 'sps_profile_interval': 0, 17:04:14 INFO - 'suite': 'dromaeojs', 17:04:14 INFO - 'system_bits': '32', 17:04:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:14 INFO - 'title': 'talos-linux64-ix-033', 17:04:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:14 INFO - 'use_talos_json': True, 17:04:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:04:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:14 INFO - 'work_dir': 'build'} 17:04:14 INFO - ##### 17:04:14 INFO - ##### Running clobber step. 17:04:14 INFO - ##### 17:04:14 INFO - Running pre-action listener: _resource_record_pre_action 17:04:14 INFO - Running main action method: clobber 17:04:14 INFO - rmtree: /builds/slave/test/build 17:04:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:04:15 INFO - Running post-action listener: _resource_record_post_action 17:04:15 INFO - ##### 17:04:15 INFO - ##### Finished clobber step (success) 17:04:15 INFO - ##### 17:04:15 INFO - ##### 17:04:15 INFO - ##### Running read-buildbot-config step. 17:04:15 INFO - ##### 17:04:15 INFO - Running pre-action listener: _resource_record_pre_action 17:04:15 INFO - Running main action method: read_buildbot_config 17:04:15 INFO - Using buildbot properties: 17:04:15 INFO - { 17:04:15 INFO - "project": "", 17:04:15 INFO - "product": "firefox", 17:04:15 INFO - "script_repo_revision": "production", 17:04:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:04:15 INFO - "repository": "", 17:04:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:04:15 INFO - "buildid": "20160609142532", 17:04:15 INFO - "pgo_build": "True", 17:04:15 INFO - "basedir": "/builds/slave/test", 17:04:15 INFO - "buildnumber": 382, 17:04:15 INFO - "slavename": "talos-linux64-ix-033", 17:04:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:04:15 INFO - "platform": "ubuntu64_hw", 17:04:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:04:15 INFO - "branch": "mozilla-aurora", 17:04:15 INFO - "repo_path": "releases/mozilla-aurora", 17:04:15 INFO - "revision": "4253296f212b3cca52992ec5f6cd824b13153abd", 17:04:15 INFO - "stage_platform": "linux64-pgo", 17:04:15 INFO - "builduid": "363139945ab7421585493c1f579e99e3", 17:04:15 INFO - "slavebuilddir": "test" 17:04:15 INFO - } 17:04:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 17:04:15 INFO - Running post-action listener: _resource_record_post_action 17:04:15 INFO - ##### 17:04:15 INFO - ##### Finished read-buildbot-config step (success) 17:04:15 INFO - ##### 17:04:15 INFO - ##### 17:04:15 INFO - ##### Running download-and-extract step. 17:04:15 INFO - ##### 17:04:15 INFO - Running pre-action listener: _resource_record_pre_action 17:04:15 INFO - Running main action method: download_and_extract 17:04:15 INFO - mkdir: /builds/slave/test/build/tests 17:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:15 INFO - https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:15 INFO - Downloaded 1361 bytes. 17:04:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:04:15 INFO - Using the following test package requirements: 17:04:15 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:04:15 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:04:15 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:04:15 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'jsshell-linux-x86_64.zip'], 17:04:15 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:04:15 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:04:15 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:04:15 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:04:15 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:04:15 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:04:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:04:15 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:15 INFO - https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:18 INFO - Downloaded 24473590 bytes. 17:04:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:04:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:04:20 INFO - Return code: 0 17:04:20 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 17:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:20 INFO - https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:21 INFO - Downloaded 24473590 bytes. 17:04:21 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'] 17:04:21 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 17:04:22 INFO - Return code: 0 17:04: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')]} 17:04:22 INFO - https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:04:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:04:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:04:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:24 INFO - Downloaded 10833369 bytes. 17:04:24 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'] 17:04:24 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 17:04:24 INFO - Return code: 0 17:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:24 INFO - https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JHgjjcaASHGrnes67W7JJg/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 17:04:28 INFO - Downloaded 63560763 bytes. 17:04:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:04:28 INFO - mkdir: /builds/slave/test/properties 17:04:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:04:28 INFO - Writing to file /builds/slave/test/properties/build_url 17:04:28 INFO - Contents: 17:04:28 INFO - build_url:https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:04:29 INFO - Running post-action listener: _resource_record_post_action 17:04:29 INFO - Running post-action listener: set_extra_try_arguments 17:04:29 INFO - ##### 17:04:29 INFO - ##### Finished download-and-extract step (success) 17:04:29 INFO - ##### 17:04:29 INFO - ##### 17:04:29 INFO - ##### Running populate-webroot step. 17:04:29 INFO - ##### 17:04:29 INFO - Running pre-action listener: _resource_record_pre_action 17:04:29 INFO - Running main action method: populate_webroot 17:04:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:29 INFO - '--tppagecycles', 17:04:29 INFO - '7'], 17:04:29 INFO - 'tests': ['tsvgm']}}, 17:04:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:04:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:04:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:04:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['damp', 'tps']}, 17:04:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'tests': ['damp', 'tps']}, 17:04:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['dromaeo_dom']}, 17:04:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['a11yr', 17:04:29 INFO - 'ts_paint', 17:04:29 INFO - 'tpaint', 17:04:29 INFO - 'sessionrestore', 17:04:29 INFO - 'sessionrestore_no_auto_restore', 17:04:29 INFO - 'tabpaint']}, 17:04:29 INFO - 'other-e10s': {'tests': ['a11yr', 17:04:29 INFO - 'ts_paint', 17:04:29 INFO - 'tpaint', 17:04:29 INFO - 'sessionrestore', 17:04:29 INFO - 'sessionrestore_no_auto_restore', 17:04:29 INFO - 'tabpaint']}, 17:04:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:04:29 INFO - 'ts_paint', 17:04:29 INFO - 'tpaint', 17:04:29 INFO - 'sessionrestore', 17:04:29 INFO - 'sessionrestore_no_auto_restore', 17:04:29 INFO - 'tabpaint']}, 17:04:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:04:29 INFO - 'ts_paint', 17:04:29 INFO - 'tpaint', 17:04:29 INFO - 'sessionrestore', 17:04:29 INFO - 'sessionrestore_no_auto_restore', 17:04:29 INFO - 'tabpaint']}, 17:04:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['a11yr', 17:04:29 INFO - 'ts_paint', 17:04:29 INFO - 'tpaint', 17:04:29 INFO - 'sessionrestore', 17:04:29 INFO - 'sessionrestore_no_auto_restore', 17:04:29 INFO - 'tabpaint']}, 17:04:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['a11yr', 17:04:29 INFO - 'ts_paint', 17:04:29 INFO - 'tpaint', 17:04:29 INFO - 'sessionrestore', 17:04:29 INFO - 'sessionrestore_no_auto_restore', 17:04:29 INFO - 'tabpaint']}, 17:04:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['tsvgx', 17:04:29 INFO - 'tsvgr_opacity', 17:04:29 INFO - 'tart', 17:04:29 INFO - 'tscrollx', 17:04:29 INFO - 'cart']}, 17:04:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:04:29 INFO - 'tsvgr_opacity', 17:04:29 INFO - 'tart', 17:04:29 INFO - 'tscrollx', 17:04:29 INFO - 'cart']}, 17:04:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'talos_options': ['--disable-e10s'], 17:04:29 INFO - 'tests': ['tp5o']}, 17:04:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'tests': ['tp5o']}, 17:04:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'talos_options': ['--disable-e10s', 17:04:29 INFO - '--xperf_path', 17:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:29 INFO - 'tests': ['tp5n']}, 17:04:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:29 INFO - 'talos_options': ['--xperf_path', 17:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:29 INFO - 'tests': ['tp5n']}}, 17:04:29 INFO - 'talos.zip': {'path': '', 17:04:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:29 INFO - Running post-action listener: _resource_record_post_action 17:04:29 INFO - ##### 17:04:29 INFO - ##### Finished populate-webroot step (success) 17:04:29 INFO - ##### 17:04:29 INFO - ##### 17:04:29 INFO - ##### Running create-virtualenv step. 17:04:29 INFO - ##### 17:04:29 INFO - Running pre-action listener: _resource_record_pre_action 17:04:29 INFO - Running main action method: create_virtualenv 17:04:29 INFO - Creating virtualenv /builds/slave/test/build/venv 17:04:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:04:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:04:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:29 INFO - Using real prefix '/usr' 17:04:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:04:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:31 INFO - Installing pip.................done. 17:04:31 INFO - Return code: 0 17:04:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04: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', 'pip>=1.5'] in /builds/slave/test/build 17:04: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 pip>=1.5 17:04:31 INFO - Using env: {'DISPLAY': ':0', 17:04:31 INFO - 'HOME': '/home/cltbld', 17:04:31 INFO - 'LANG': 'en_US.UTF-8', 17:04:31 INFO - 'LANGUAGE': 'en_US:en', 17:04:31 INFO - 'LOGNAME': 'cltbld', 17:04:31 INFO - 'MAIL': '/var/mail/cltbld', 17:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:31 INFO - 'MOZ_NO_REMOTE': '1', 17:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:31 INFO - 'NO_EM_RESTART': '1', 17:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:31 INFO - 'PWD': '/builds/slave/test', 17:04:31 INFO - 'SHELL': '/bin/bash', 17:04:31 INFO - 'SHLVL': '1', 17:04:31 INFO - 'TERM': 'linux', 17:04:31 INFO - 'TMOUT': '86400', 17:04:31 INFO - 'USER': 'cltbld', 17:04:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:31 INFO - '_': '/tools/buildbot/bin/python'} 17:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:04:32 INFO - Cleaning up... 17:04:32 INFO - Return code: 0 17:04:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:32 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:04:32 INFO - Using env: {'DISPLAY': ':0', 17:04:32 INFO - 'HOME': '/home/cltbld', 17:04:32 INFO - 'LANG': 'en_US.UTF-8', 17:04:32 INFO - 'LANGUAGE': 'en_US:en', 17:04:32 INFO - 'LOGNAME': 'cltbld', 17:04:32 INFO - 'MAIL': '/var/mail/cltbld', 17:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:32 INFO - 'MOZ_NO_REMOTE': '1', 17:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:32 INFO - 'NO_EM_RESTART': '1', 17:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:32 INFO - 'PWD': '/builds/slave/test', 17:04:32 INFO - 'SHELL': '/bin/bash', 17:04:32 INFO - 'SHLVL': '1', 17:04:32 INFO - 'TERM': 'linux', 17:04:32 INFO - 'TMOUT': '86400', 17:04:32 INFO - 'USER': 'cltbld', 17:04:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:32 INFO - '_': '/tools/buildbot/bin/python'} 17:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:32 INFO - Downloading/unpacking psutil>=3.1.1 17:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:34 INFO - Installing collected packages: psutil 17:04:34 INFO - Running setup.py install for psutil 17:04:34 INFO - building 'psutil._psutil_linux' extension 17:04:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:04:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:04:34 INFO - building 'psutil._psutil_posix' extension 17:04:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:04:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:35 INFO - Successfully installed psutil 17:04:35 INFO - Cleaning up... 17:04:35 INFO - Return code: 0 17:04:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:35 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:04:35 INFO - Using env: {'DISPLAY': ':0', 17:04:35 INFO - 'HOME': '/home/cltbld', 17:04:35 INFO - 'LANG': 'en_US.UTF-8', 17:04:35 INFO - 'LANGUAGE': 'en_US:en', 17:04:35 INFO - 'LOGNAME': 'cltbld', 17:04:35 INFO - 'MAIL': '/var/mail/cltbld', 17:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:35 INFO - 'MOZ_NO_REMOTE': '1', 17:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:35 INFO - 'NO_EM_RESTART': '1', 17:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:35 INFO - 'PWD': '/builds/slave/test', 17:04:35 INFO - 'SHELL': '/bin/bash', 17:04:35 INFO - 'SHLVL': '1', 17:04:35 INFO - 'TERM': 'linux', 17:04:35 INFO - 'TMOUT': '86400', 17:04:35 INFO - 'USER': 'cltbld', 17:04:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:35 INFO - '_': '/tools/buildbot/bin/python'} 17:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:04:37 INFO - Installing collected packages: mozsystemmonitor 17:04:37 INFO - Running setup.py install for mozsystemmonitor 17:04:37 INFO - Successfully installed mozsystemmonitor 17:04:37 INFO - Cleaning up... 17:04:37 INFO - Return code: 0 17:04:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:37 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:04:37 INFO - Using env: {'DISPLAY': ':0', 17:04:37 INFO - 'HOME': '/home/cltbld', 17:04:37 INFO - 'LANG': 'en_US.UTF-8', 17:04:37 INFO - 'LANGUAGE': 'en_US:en', 17:04:37 INFO - 'LOGNAME': 'cltbld', 17:04:37 INFO - 'MAIL': '/var/mail/cltbld', 17:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:37 INFO - 'MOZ_NO_REMOTE': '1', 17:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:37 INFO - 'NO_EM_RESTART': '1', 17:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:37 INFO - 'PWD': '/builds/slave/test', 17:04:37 INFO - 'SHELL': '/bin/bash', 17:04:37 INFO - 'SHLVL': '1', 17:04:37 INFO - 'TERM': 'linux', 17:04:37 INFO - 'TMOUT': '86400', 17:04:37 INFO - 'USER': 'cltbld', 17:04:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:37 INFO - '_': '/tools/buildbot/bin/python'} 17:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:37 INFO - Downloading/unpacking jsonschema==2.5.1 17:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:39 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:39 INFO - warning: no files found matching '*.txt' 17:04:39 INFO - no previously-included directories found matching 'build' 17:04:39 INFO - no previously-included directories found matching 'dist' 17:04:39 INFO - no previously-included directories found matching '.git*' 17:04:39 INFO - Installing collected packages: jsonschema, functools32 17:04:39 INFO - Running setup.py install for functools32 17:04:39 INFO - warning: no files found matching '*.txt' 17:04:39 INFO - no previously-included directories found matching 'build' 17:04:39 INFO - no previously-included directories found matching 'dist' 17:04:39 INFO - no previously-included directories found matching '.git*' 17:04:39 INFO - Successfully installed jsonschema functools32 17:04:39 INFO - Cleaning up... 17:04:39 INFO - Return code: 0 17:04:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:39 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:04:39 INFO - Using env: {'DISPLAY': ':0', 17:04:39 INFO - 'HOME': '/home/cltbld', 17:04:39 INFO - 'LANG': 'en_US.UTF-8', 17:04:39 INFO - 'LANGUAGE': 'en_US:en', 17:04:39 INFO - 'LOGNAME': 'cltbld', 17:04:39 INFO - 'MAIL': '/var/mail/cltbld', 17:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:39 INFO - 'MOZ_NO_REMOTE': '1', 17:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:39 INFO - 'NO_EM_RESTART': '1', 17:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:39 INFO - 'PWD': '/builds/slave/test', 17:04:39 INFO - 'SHELL': '/bin/bash', 17:04:39 INFO - 'SHLVL': '1', 17:04:39 INFO - 'TERM': 'linux', 17:04:39 INFO - 'TMOUT': '86400', 17:04:39 INFO - 'USER': 'cltbld', 17:04:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:39 INFO - '_': '/tools/buildbot/bin/python'} 17:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:40 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:42 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:04:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:42 INFO - Downloading docopt-0.6.1.tar.gz 17:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:43 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:43 INFO - Running setup.py install for blobuploader 17:04:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:04:43 INFO - Running setup.py install for requests 17:04:43 INFO - Running setup.py install for docopt 17:04:43 INFO - Successfully installed blobuploader requests docopt 17:04:43 INFO - Cleaning up... 17:04:43 INFO - Return code: 0 17:04:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:43 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:43 INFO - Using env: {'DISPLAY': ':0', 17:04:43 INFO - 'HOME': '/home/cltbld', 17:04:43 INFO - 'LANG': 'en_US.UTF-8', 17:04:43 INFO - 'LANGUAGE': 'en_US:en', 17:04:43 INFO - 'LOGNAME': 'cltbld', 17:04:43 INFO - 'MAIL': '/var/mail/cltbld', 17:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:43 INFO - 'MOZ_NO_REMOTE': '1', 17:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:43 INFO - 'NO_EM_RESTART': '1', 17:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:43 INFO - 'PWD': '/builds/slave/test', 17:04:43 INFO - 'SHELL': '/bin/bash', 17:04:43 INFO - 'SHLVL': '1', 17:04:43 INFO - 'TERM': 'linux', 17:04:43 INFO - 'TMOUT': '86400', 17:04:43 INFO - 'USER': 'cltbld', 17:04:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:43 INFO - '_': '/tools/buildbot/bin/python'} 17:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:43 INFO - Running setup.py (path:/tmp/pip-rC0JgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:43 INFO - Running setup.py (path:/tmp/pip-MY_Rkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:44 INFO - Running setup.py (path:/tmp/pip-RM9i5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:44 INFO - Running setup.py (path:/tmp/pip-ZY_Xa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:44 INFO - Running setup.py (path:/tmp/pip-8gMx6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:44 INFO - Running setup.py (path:/tmp/pip-4P3aNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:44 INFO - Running setup.py (path:/tmp/pip-j7tHqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:44 INFO - Running setup.py (path:/tmp/pip-6Ijdor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:44 INFO - Running setup.py (path:/tmp/pip-Vkxxbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:44 INFO - Running setup.py (path:/tmp/pip-yfcKiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:44 INFO - Running setup.py (path:/tmp/pip-bLeFeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:44 INFO - Running setup.py (path:/tmp/pip-do96HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:44 INFO - Running setup.py (path:/tmp/pip-F0cjOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:44 INFO - Running setup.py (path:/tmp/pip-hH_YP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:44 INFO - Running setup.py (path:/tmp/pip-oJbdXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:44 INFO - Running setup.py (path:/tmp/pip-Zl1Wgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:45 INFO - Running setup.py (path:/tmp/pip-_okajn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:45 INFO - Running setup.py install for manifestparser 17:04:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Running setup.py install for mozcrash 17:04:45 INFO - Running setup.py install for mozdebug 17:04:45 INFO - Running setup.py install for mozdevice 17:04:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Running setup.py install for mozfile 17:04:45 INFO - Running setup.py install for mozhttpd 17:04:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Running setup.py install for mozinfo 17:04:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Running setup.py install for mozInstall 17:04:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:04:45 INFO - Running setup.py install for mozleak 17:04:46 INFO - Running setup.py install for mozlog 17:04:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:04:46 INFO - Running setup.py install for moznetwork 17:04:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:04:46 INFO - Running setup.py install for mozprocess 17:04:46 INFO - Running setup.py install for mozprofile 17:04:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:04:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:04:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:04:46 INFO - Running setup.py install for mozrunner 17:04:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:04:46 INFO - Running setup.py install for mozscreenshot 17:04:46 INFO - Running setup.py install for moztest 17:04:46 INFO - Running setup.py install for mozversion 17:04:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:04:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:46 INFO - Cleaning up... 17:04:46 INFO - Return code: 0 17:04:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:46 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:46 INFO - Using env: {'DISPLAY': ':0', 17:04:46 INFO - 'HOME': '/home/cltbld', 17:04:46 INFO - 'LANG': 'en_US.UTF-8', 17:04:46 INFO - 'LANGUAGE': 'en_US:en', 17:04:46 INFO - 'LOGNAME': 'cltbld', 17:04:46 INFO - 'MAIL': '/var/mail/cltbld', 17:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:46 INFO - 'MOZ_NO_REMOTE': '1', 17:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:46 INFO - 'NO_EM_RESTART': '1', 17:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:46 INFO - 'PWD': '/builds/slave/test', 17:04:46 INFO - 'SHELL': '/bin/bash', 17:04:46 INFO - 'SHLVL': '1', 17:04:46 INFO - 'TERM': 'linux', 17:04:46 INFO - 'TMOUT': '86400', 17:04:46 INFO - 'USER': 'cltbld', 17:04:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:46 INFO - '_': '/tools/buildbot/bin/python'} 17:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:47 INFO - Running setup.py (path:/tmp/pip-pL5UnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:47 INFO - Running setup.py (path:/tmp/pip-rYtiqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:47 INFO - Running setup.py (path:/tmp/pip-YJunlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:47 INFO - Running setup.py (path:/tmp/pip-i3uBFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:47 INFO - Running setup.py (path:/tmp/pip-vF4ql8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:47 INFO - Running setup.py (path:/tmp/pip-thK9Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:47 INFO - Running setup.py (path:/tmp/pip-avfTa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:47 INFO - Running setup.py (path:/tmp/pip-Tq3k1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:47 INFO - Running setup.py (path:/tmp/pip-bai6oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:47 INFO - Running setup.py (path:/tmp/pip-SJHroc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:47 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)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:47 INFO - Running setup.py (path:/tmp/pip-pqPXyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:47 INFO - Running setup.py (path:/tmp/pip-xnVixI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:48 INFO - Running setup.py (path:/tmp/pip-rDkHXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:48 INFO - Running setup.py (path:/tmp/pip-I0Geim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:48 INFO - Running setup.py (path:/tmp/pip-GjTLtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:48 INFO - Running setup.py (path:/tmp/pip-TfdnKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:48 INFO - Running setup.py (path:/tmp/pip-WuNkmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:50 INFO - Downloading blessings-1.6.tar.gz 17:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:50 INFO - Installing collected packages: blessings 17:04:50 INFO - Running setup.py install for blessings 17:04:50 INFO - Successfully installed blessings 17:04:50 INFO - Cleaning up... 17:04:50 INFO - Return code: 0 17:04:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:50 INFO - Reading from file tmpfile_stdout 17:04:50 INFO - Current package versions: 17:04:50 INFO - argparse == 1.2.1 17:04:50 INFO - blessings == 1.6 17:04:50 INFO - blobuploader == 1.2.4 17:04:50 INFO - docopt == 0.6.1 17:04:50 INFO - functools32 == 3.2.3-2 17:04:50 INFO - jsonschema == 2.5.1 17:04:50 INFO - manifestparser == 1.1 17:04:50 INFO - mozInstall == 1.12 17:04:50 INFO - mozcrash == 0.17 17:04:50 INFO - mozdebug == 0.1 17:04:50 INFO - mozdevice == 0.48 17:04:50 INFO - mozfile == 1.2 17:04:50 INFO - mozhttpd == 0.7 17:04:50 INFO - mozinfo == 0.9 17:04:50 INFO - mozleak == 0.1 17:04:50 INFO - mozlog == 3.2 17:04:50 INFO - moznetwork == 0.27 17:04:50 INFO - mozprocess == 0.22 17:04:50 INFO - mozprofile == 0.28 17:04:50 INFO - mozrunner == 6.11 17:04:50 INFO - mozscreenshot == 0.1 17:04:50 INFO - mozsystemmonitor == 0.3 17:04:50 INFO - moztest == 0.7 17:04:50 INFO - mozversion == 1.4 17:04:50 INFO - psutil == 3.1.1 17:04:50 INFO - requests == 1.2.3 17:04:50 INFO - wsgiref == 0.1.2 17:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:50 INFO - Using env: {'DISPLAY': ':0', 17:04:50 INFO - 'HOME': '/home/cltbld', 17:04:50 INFO - 'LANG': 'en_US.UTF-8', 17:04:50 INFO - 'LANGUAGE': 'en_US:en', 17:04:50 INFO - 'LOGNAME': 'cltbld', 17:04:50 INFO - 'MAIL': '/var/mail/cltbld', 17:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:50 INFO - 'MOZ_NO_REMOTE': '1', 17:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:50 INFO - 'NO_EM_RESTART': '1', 17:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:50 INFO - 'PWD': '/builds/slave/test', 17:04:50 INFO - 'SHELL': '/bin/bash', 17:04:50 INFO - 'SHLVL': '1', 17:04:50 INFO - 'TERM': 'linux', 17:04:50 INFO - 'TMOUT': '86400', 17:04:50 INFO - 'USER': 'cltbld', 17:04:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:50 INFO - '_': '/tools/buildbot/bin/python'} 17:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:04:50 INFO - Cleaning up... 17:04:50 INFO - Return code: 0 17:04:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:04:50 INFO - Using env: {'DISPLAY': ':0', 17:04:50 INFO - 'HOME': '/home/cltbld', 17:04:50 INFO - 'LANG': 'en_US.UTF-8', 17:04:50 INFO - 'LANGUAGE': 'en_US:en', 17:04:50 INFO - 'LOGNAME': 'cltbld', 17:04:50 INFO - 'MAIL': '/var/mail/cltbld', 17:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:50 INFO - 'MOZ_NO_REMOTE': '1', 17:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:50 INFO - 'NO_EM_RESTART': '1', 17:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:50 INFO - 'PWD': '/builds/slave/test', 17:04:50 INFO - 'SHELL': '/bin/bash', 17:04:50 INFO - 'SHLVL': '1', 17:04:50 INFO - 'TERM': 'linux', 17:04:50 INFO - 'TMOUT': '86400', 17:04:50 INFO - 'USER': 'cltbld', 17:04:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:50 INFO - '_': '/tools/buildbot/bin/python'} 17:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:04:51 INFO - Cleaning up... 17:04:51 INFO - Return code: 0 17:04:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:51 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 0x7f6dd9741f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:51 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 17:04:51 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 17:04:51 INFO - Using env: {'DISPLAY': ':0', 17:04:51 INFO - 'HOME': '/home/cltbld', 17:04:51 INFO - 'LANG': 'en_US.UTF-8', 17:04:51 INFO - 'LANGUAGE': 'en_US:en', 17:04:51 INFO - 'LOGNAME': 'cltbld', 17:04:51 INFO - 'MAIL': '/var/mail/cltbld', 17:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:51 INFO - 'MOZ_NO_REMOTE': '1', 17:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:51 INFO - 'NO_EM_RESTART': '1', 17:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:51 INFO - 'PWD': '/builds/slave/test', 17:04:51 INFO - 'SHELL': '/bin/bash', 17:04:51 INFO - 'SHLVL': '1', 17:04:51 INFO - 'TERM': 'linux', 17:04:51 INFO - 'TMOUT': '86400', 17:04:51 INFO - 'USER': 'cltbld', 17:04:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:51 INFO - '_': '/tools/buildbot/bin/python'} 17:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:51 INFO - Downloading/unpacking flake8 17:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:53 INFO - no previously-included directories found matching 'docs/_build' 17:04:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:54 INFO - Running setup.py install for pep8 17:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:54 INFO - no previously-included directories found matching 'docs/_build' 17:04:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:04:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:54 INFO - Cleaning up... 17:04:54 INFO - Return code: 0 17:04:54 INFO - Running post-action listener: _resource_record_post_action 17:04:54 INFO - Running post-action listener: _start_resource_monitoring 17:04:54 INFO - Starting resource monitoring. 17:04:54 INFO - ##### 17:04:54 INFO - ##### Finished create-virtualenv step (success) 17:04:54 INFO - ##### 17:04:54 INFO - ##### 17:04:54 INFO - ##### Running install step. 17:04:54 INFO - ##### 17:04:54 INFO - Running pre-action listener: _resource_record_pre_action 17:04:54 INFO - Running main action method: install 17:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:54 INFO - Reading from file tmpfile_stdout 17:04:54 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:54 INFO - Reading from file tmpfile_stdout 17:04:54 INFO - Output received: 17:04:54 INFO - Usage: mozinstall [options] installer 17:04:54 INFO - Options: 17:04:54 INFO - -h, --help show this help message and exit 17:04:54 INFO - -d DEST, --destination=DEST 17:04:54 INFO - Directory to install application into. [default: 17:04:54 INFO - "/builds/slave/test"] 17:04:54 INFO - --app=APP Application being installed. [default: firefox] 17:04:54 INFO - mkdir: /builds/slave/test/build/application 17:04:54 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'] 17:04:54 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 17:05:10 INFO - Reading from file tmpfile_stdout 17:05:10 INFO - Output received: 17:05:10 INFO - /builds/slave/test/build/application/firefox/firefox 17:05:10 INFO - Running post-action listener: _resource_record_post_action 17:05:10 INFO - ##### 17:05:10 INFO - ##### Finished install step (success) 17:05:10 INFO - ##### 17:05:10 INFO - ##### 17:05:10 INFO - ##### Running run-tests step. 17:05:10 INFO - ##### 17:05:10 INFO - Running pre-action listener: _resource_record_pre_action 17:05:10 INFO - Running main action method: run_tests 17:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:05:10 INFO - Python 2.7.3 17:05:10 INFO - Return code: 0 17:05:10 INFO - grabbing minidump binary from tooltool 17:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:10 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 0x25861c0>, '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 0x25870c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2587550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:05:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:05:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:05:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:05:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:10 INFO - Return code: 0 17:05:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:05:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:05:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:05:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:05:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:05:11 INFO - Return code: 0 17:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:05:11 INFO - Using env: {'DISPLAY': ':0', 17:05:11 INFO - 'HOME': '/home/cltbld', 17:05:11 INFO - 'LANG': 'en_US.UTF-8', 17:05:11 INFO - 'LANGUAGE': 'en_US:en', 17:05:11 INFO - 'LOGNAME': 'cltbld', 17:05:11 INFO - 'MAIL': '/var/mail/cltbld', 17:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:11 INFO - 'MOZ_NO_REMOTE': '1', 17:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:11 INFO - 'NO_EM_RESTART': '1', 17:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:11 INFO - 'PWD': '/builds/slave/test', 17:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:05:11 INFO - 'SHELL': '/bin/bash', 17:05:11 INFO - 'SHLVL': '1', 17:05:11 INFO - 'TERM': 'linux', 17:05:11 INFO - 'TMOUT': '86400', 17:05:11 INFO - 'USER': 'cltbld', 17:05:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070', 17:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:11 INFO - '_': '/tools/buildbot/bin/python'} 17:05:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:05:11 INFO - mozversion application_buildid: 20160609142532 17:05:11 INFO - mozversion application_changeset: 4253296f212b3cca52992ec5f6cd824b13153abd 17:05:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:05:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:11 INFO - mozversion application_name: Firefox 17:05:11 INFO - mozversion application_remotingname: firefox-dev 17:05:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:05:11 INFO - mozversion application_vendor: Mozilla 17:05:11 INFO - mozversion application_version: 49.0a2 17:05:11 INFO - mozversion platform_buildid: 20160609142532 17:05:11 INFO - mozversion platform_changeset: 4253296f212b3cca52992ec5f6cd824b13153abd 17:05:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:05:11 INFO - mozversion platform_version: 49.0a2 17:05:11 INFO - using testdate: 1465517111 17:05:11 INFO - actual date: 1465517111 17:05:11 INFO - starting webserver on 'localhost:42147' 17:05:11 INFO - SUITE-START | Running 2 tests 17:05:11 INFO - TEST-START | dromaeo_css 17:05:11 INFO - operating with platform_type : linux_ 17:05:11 INFO - Initialising browser for dromaeo_css test... 17:05:11 INFO - TEST-INFO | started process 17291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZkJ7h/profile http://localhost:42147/getInfo.html) 17:05:16 INFO - PROCESS | 17291 | __metrics Screen width/height:1600/1200 17:05:16 INFO - PROCESS | 17291 | colorDepth:24 17:05:16 INFO - PROCESS | 17291 | Browser inner width/height: 1024/697 17:05:16 INFO - PROCESS | 17291 | __metrics 17:05:18 ERROR - PROCESS | 17291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:05:18 INFO - PROCESS | 17291 | console.error: PushService: 17:05:18 INFO - PROCESS | 17291 | stateChangeProcessEnqueue: Error transitioning state 17:05:18 INFO - PROCESS | 17291 | UnknownError 17:05:19 INFO - TEST-INFO | 17291: exit 0 17:05:19 INFO - Browser initialized. 17:05:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:05:19 INFO - TEST-INFO | started process 17381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZkJ7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:31 INFO - PROCESS | 17381 | RSS: Main: 145199104 17:05:31 INFO - PROCESS | 17381 | 17:06:23 INFO - PROCESS | 17381 | 1465517183145 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:08:30 INFO - PROCESS | 17381 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42147/tests/dromaeo/cssquery-ext.html) 17:08:31 INFO - PROCESS | 17381 | RSS: Main: 259149824 17:08:31 INFO - PROCESS | 17381 | 17:11:34 INFO - PROCESS | 17381 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-ext.html (next: http://localhost:42147/tests/dromaeo/cssquery-jquery.html) 17:11:35 INFO - PROCESS | 17381 | RSS: Main: 224169984 17:11:35 INFO - PROCESS | 17381 | 17:14:36 INFO - PROCESS | 17381 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42147/tests/dromaeo/cssquery-mootools.html) 17:14:37 INFO - PROCESS | 17381 | RSS: Main: 226197504 17:14:37 INFO - PROCESS | 17381 | 17:17:39 INFO - PROCESS | 17381 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42147/tests/dromaeo/cssquery-prototype.html) 17:17:40 INFO - PROCESS | 17381 | RSS: Main: 221745152 17:17:40 INFO - PROCESS | 17381 | 17:20:42 INFO - PROCESS | 17381 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42147/tests/dromaeo/cssquery-yui.html) 17:20:43 INFO - PROCESS | 17381 | RSS: Main: 216604672 17:20:43 INFO - PROCESS | 17381 | 17:23:45 INFO - PROCESS | 17381 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-yui.html (next: http://localhost:42147/tests/dromaeo/cssquery-dojo.html) 17:23:46 INFO - PROCESS | 17381 | RSS: Main: 256811008 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | __start_tp_report 17:23:46 INFO - PROCESS | 17381 | _x_x_mozilla_page_load 17:23:46 INFO - PROCESS | 17381 | _x_x_mozilla_page_load_details 17:23:46 INFO - PROCESS | 17381 | |i|pagename|runs| 17:23:46 INFO - PROCESS | 17381 | |0;dojo.html;3189.154873958401;3248.0742988248353;3284.4252255855217;3307.4046671599103;3334.6498617645148;5355.437679043698;5435.9728201358985;5453.972730136354;5470.890582188354;5490.917636235455;5392.40683524812;5403.51368376846;5422.240886275925;5434.076207044802;5468.6171967962155;4789.6168306535565;4892;4911.45973942866;4927.802887884481;4959.851204463854;4900.436449808282;4916.827911023097;5037.5214354636255;5051.898962020758;5060;4911.926321105187;5015.673981191211;5020;5020.297158397827;5036.370453693288;4937.654364194508;4973.452920178777;4979.377577802775;4989.90020199594;5002.399712034561;4726.338312636233;4866.367372241586;4876.731779752112;4882.316475693406;4947.134251505972;5340.225667278223;5366.114591092504;5379.731013449312;5386.380566234894;5420.457954204548;5601.719914004324;5797.942020579782;5826.883462330729;5836.095405212199;5836.2996440427;5883.14694369314;5886.205362276123;5892.793752218695;5905.4094590541035;5907.763689452417;5508.779648814043;5512.118061110203;5513.889722205534;5515.09001014832;5517.779288828442;5691.800786972436;5853.5317174625925;5913.769567253495;5959.821205363846;5967.31375891778;5715.599908006483;5760.74076666551;5785.595008349459;5795.913061304083;5803.129530570363;5843.065109582446;5886.58793884424;5895.322037965689;5900.822975310662;5902.321233058167;5617.8033768817895;5741;5772.249607550992;5837.6497410155525;5861;5825.2135961644635;5846.181534585162;5849.268841394825;5860.706964651836;5878;4435.645148388121;4490.7754612269255;4494.842680506232;4515.81936722534;4516.796744146522;3915.5105611798526;3935.0752573145287;3964.623360780721;3969.2656858481273;4033.757974521538;5518.475744804237;5541.5289700375915;5557.77768889248;5565.471280228372;5576.609637325349;5629.774809007594;5813.447722466359;5845.415458454206;5847.093700476433;5856.677882716492;5440.809571664972;5492.038893193755;5495.120780675073;5501.697406642673;5538.224648549206;5017.071841709296;5026.195808670595;5033.094043072282;5037.219231019198;5061.038402703474;5794.362620111784;6011.248593925759;6016.789412370546;6030.155778191057;6030.9747342951805;5841.912371314349;5901.144334071621;5906.586538942232;5910.586258961831;5919.408059194218;6098.847528811815;6112.2970858351855;6113.908291375544;6122.663253521099;6129;5572.804951826666;5600.887982240414;5619.269494965628;5799.072148456226;5817.040188368872;5745.166950792028;5780.884382312414;5781.103928891029;5801.158831969426;5812.273465816773;5627.240322556566;5636.774529018793;5640.097584386478;5649.237352957298;5652.745626446737;5425.321834770653;5603.271574695264;5627.324721033502;5647.971760141173;5656.915146272891;5556.888862222814;5602.607817452739;5606.775728970795;5607.691576963143;5613.607047506635;5712;5727.11229759388;5764.308283006066;5765.740541675551;5775.989201889569;5356.812511562077;5416.214648875812;5453;5491.0939694951485;5555.7499912504845 17:23:46 INFO - PROCESS | 17381 | |1;ext.html;590.5098768022542;632.2602555010637;635.7679447001843;652.644308851676;654.0679531667373;32995.175120622;46559.76720116399;47659;47754.28368574465;47821.282680759774;49790.75104624472;50464.243036354485;50488;50578.494215057835;50610.49389506113;8547.273481754028;8967.237784788285;9178.082191780835;11125.610603628875;11487.942560287187;10841.403722795283;10974.725631859188;10989.395583242918;11000;11004.119670426388;10978.835317470244;10993.61522346718;11051.226414151013;11066.28069175505;11066.446677666125;8359.373047021467;10750.623728169516;11022.944885275603;11046.171537134667;11393.088552915748;10823.13414926804;10865.565377384895;10907.672769816918;10913.508892099795;10920.890791092066;44170.77914610438;44516;44549.55450445519;44572.3314150288;44628.3305750414;3414.897553073412;3983.3626619740703;4383.07955329378;4419.889502762425;4529.841455549073;34453.31093378143;34878.30243395143;34880.82559587186;36461.63538364609;36678.81660591707;4416.315471101984;4438.467383913951;4470.709403888737;4564;4668.486466488684;375568;377911;378297;380943;381233;37165.62834371622;38454.61545384566;38472.230555388735;63320;63332;40355;40502.392464113065;40634;40674;40698.59301407007;15011.924940375227;15613.141277229633;15685.843141568439;15704.92147539255;15716.21418929049;13736.519221827188;14073.437062517385;14081.85918140826;14475.059121157092;14493.130412175304;9066.637334506546;9069.77325566866;9077.818443631091;9141.040190780006;9142.131497507726;3439.5012723155;3445.4659527773233;3504.491848681978;3509.5437593112733;3523.9119022024142;905.2260317428635;976.8876579193484;1014.761531040205;1066.8879767624444;1078.7033565769477;31542.684573154434;32081.197970050936;32750.344993100003;32909.50635740466;33110.17224569357;1109.3066833229232;1126.5493802479075;1155.1394211312459;1223.9877601223873;1250.9179559680992;16954.23705933236;17684.823151768316;17689.38087166943;17753.822461775475;17851.37520186787;443893;637133;648578;650163;1017796;66037;66548.33451665421;66802.3319766796;66804;66909.66545167242;1311.5016293808292;1359.5377571625497;1370.5614203454998;1402.144691738039;1407.9929600352139;30719.539206912363;34707.82646086753;34775.304493909476;34855.302893942484;35287;55852;56110.71944640251;56524;56529;56669.71665141648;429268;443673;444100;444108;444312;26867;29458.558121628623;29806.70193298039;30321;30756.231094222825;52752.736236318575;52801.471985279655;52815;53097.4690253108;53960;44301.11397772091;44671.77664111659;45288.094238115715;45348.546514534435;45979.3103103447;43531.564684354016;44147.577619921474;44835.55164448444;45923.311150332105;46477.53522464867;44365.55634443614;44570.77714611406;44611.33083003823;45218.09563808771;45619.77190114028;38159.809200953816;39299.60700393074;39880.40179397253;40584.79707601443;40710;28908.7109128906;29388.11835644934;29569.408611828072;29739.405211896075;31653.20866978344 17:23:46 INFO - PROCESS | 17381 | |2;jquery.html;429.70135755649824;435.27309393313163;439.0932723925092;447.58598296575667;456.2403598009317;18861.962592057447;20301.39095827126;20340.288089916838;20736;20818;18424.170912308946;18439;18675.43973680792;18712.251509939586;19136.904315478438;5794.652320860751;5981.043033114703;6001.429864162919;6003.0395136778125;6022.54830887683;4241.554636763141;5926.051831706928;5979.730912108944;6306.590071645352;6633.867322653544;6661.100751398571;6675.966620166917;6676.232233293161;6696.497762667795;6707.1616047994;6517.413432791024;6611.636360000198;6675.265720770712;6683.565568238073;6686.5653732507235;3993.6605388542007;5575.637583557056;5889.1755154278435;5898.41015898411;5909.113632955048;22607.88696056509;23439.062437502478;23481.88259058711;23777;23845.761542384527;2302.6776251324827;2351.4239011442305;2366.6450032495263;2448.153667495672;2485.3041148478455;14339.21134337611;14731.631709207248;14911.478098266618;15118.773218401622;15542.300596473073;2052.404802607242;2079.729635147436;2169.631162702344;2175.7497887742798;2200.3179014505395;79325;79953.60023199847;80058.59970700167;80188;80517;10841.67474975752;11005.954434328725;11174.776504469864;11197.776044479066;11232.831507527393;15689.137097459748;15886.602834928988;15905.681886362208;15949.760753588705;15956.441524546584;8609.268212202032;8685.696000640073;8726.956365218133;8781.604827782765;8842.071582483875;8373.455725377953;8374.371922105745;8568.828623427622;8570.271526920156;8612.837266969005;7021.29787021304;7090.078289822393;7111.217766045731;7142.035825163641;7167;1814.0522537702502;1884.453508482552;2059.907304171316;2060.2789023841538;2070.6790447480666;836.8744688296804;1029.7425643589104;1029.8712660917386;1146.0487795130023;1158.5365853658436;19103.426897193105;20042.699359509617;20049.59900801976;20195.394138175583;20236.898815506123;1037.5382954585136;1038.631285893512;1044.1125043712934;1097.7639807441437;1098.2038022433671;11147.275427097213;11535;11595.840415958506;11608.071354291636;11725.296482210924;460561;468894;473859;488433;492876;77005.22994770092;78373.60813195897;79289;79712;79729.20270797334;1051.600391851107;1058.7829494953517;1060.226034994443;1070.0957690751302;1079.7462596289865;17970.191341389407;17990.37033703814;18006.5498362542;18315.35896243625;18516;31104.844475777478;36983.075423114635;36998.8150059248;39439.408408874464;39835.402468962406;51964.740176298874;52789.47210527846;53215.46784532105;54226.72886635541;54549;9032.857192784613;9228.44629322216;9302.767430814283;9509.762255943657;9653.565589548347;9086.772830679285;11247.606333778278;11875.931166195083;13570.185788852701;14003.719925601226;12048.096392770753;12133.332666703063;12244.755104897675;12513.43689533955;12622.179558328678;11577.663255906724;11715.648530544097;11821.645350639494;12053.276803391824;12352.691182720504;11467.369294688539;11786.58746943853;12254.938725306316;12308.692282692646;12423.813642795185;9012.594433250388;9018.774530636787;9102.954485227532;9220.308476864127;9377.718668439958;11540.769184616092;12068.758624827278;12097.697557561132;12193.268403895794;12479.625611231677 17:23:46 INFO - PROCESS | 17381 | |3;mootools.html;1378.8965827562922;1592.3948899418224;1601.1193843386134;1849.537615596101;1964.8821070735748;9205.171534561889;9549.761255968604;9602.231821454285;9873.506324683773;9898;9635.277354198446;9794.755131121725;9806.607735690583;9814.214862810975;9839.114479696826;2235.832312576555;2283.1552325639536;2295.517941232343;2478.50429914017;2520.8109391795597;2468.2471846086937;2529.582618867885;2530.7342729013467;2532.5314816758864;2545.109211775873;2479.38015496126;2486.589712697403;2509.8494090354548;2516.018752686454;2520.3447103752974;2206.1396055538353;2276.2943487518924;2523.079076137206;2557.705863825656;2570.627259047437;2224.27710993926;2363.409147713072;2433.6714543536573;2448.326710154704;2454.0797201049604;9480.525973701357;9577.808443831085;9602.855957160647;9609.855852162224;9621.51892405377;5571.4428557144365;5684.943150568482;5698.772049118031;5698.914516282259;5699.74351154199;3458.2046129390383;3582.301451217014;3616.4032934565766;3635.8909232723063;3663.0476076220107;1214.1318956945827;1226.0865655086927;1237.2514628649628;1258.4399942025802;1270.1870802686287;14283.928580357031;14326.212058336787;14331.211783351911;14331.641708957255;14356.282185890768;4932.087563800636;5136.229565565195;5168.095583272912;5168.198929165986;5186.351706036746;11940.522379104912;11977.161598688182;11979.880201198052;11987.940060299643;11990.220635658654;5701.144828275792;5705.771769129271;5705.857353566194;5708.514776243983;5719.914201286984;4727.763611819464;5207.6875387476875;5295.126304159848;5315.574754019669;5472.097103977879;4508.684392092522;4534.319852022157;4537.705049171794;4580.954190458119;4583.106294272651;1396.5072345862586;1417.1638733147493;1423.352374669523;1431.4131206205407;1438.3311760031427;935.5415846235431;964.1467301438278;1006.5118417567473;1024.1294899335653;1037.5590374090982;6148.661823599745;6162.7843025494785;6221.751129954841;6301.52738544611;6321.1782468278825;454.1190091223083;460.5187578979974;464.47746285428894;466.97665116744025;472.53219312880003;4141.585841415895;4166.687498437629;4168.687348448879;4184.937225941613;4196.181744559782;11934.582289619822;12429.192102513307;12496.562620308245;12515.311657858905;12530.624081277576;12142.514299428101;12395.690107747378;12398.81401778974;12411.565595204125;12422.689432764253;8714.956425217833;9061.365704400629;9078.182963533181;9088.772780680536;9331.860022099674;6345.7144428499905;6501.9674901625185;6563.573367731082;6572.244191917991;6595.934040659724;11572.94213528927;11620.767584648429;11643.5924742637;11774.05807535378;11816.054715622902;11019.283746556448;11458.770824583295;11527.308361498337;11577.6526704199;11965.521379144737;8032.196780321921;8557.272631826365;8783.91216087831;8883.33374996865;9051.094890510896;9687.806243875224;9706.6117355305;9736.707898763048;9777.9022209777;9785.657501987396;8555.486670799772;8613.526256055977;8748.168923952215;8750.343724220837;8843.823123537622;8408.579571021302;8427.325813934993;8574.699885503978;8590.871136933076;8729.432586881832;7525.774226772986;7619.390448763975;7628.389728821792;7631.580263085361;7637.350825179922;5498.972505137449;5583.134614134816;5647.209390685225;5729.28383952006;5752.942470575241;5318.893622127458;5401.4868587484125;5482.725863706878;5625.915611265752;5659.717014149359 17:23:46 INFO - PROCESS | 17381 | |4;prototype.html;361.45600870689606;363.70539862711206;366.8752624107803;368.3130960758187;372.0791042170628;5388.595855310848;5460.372057213422;5477.315335583052;5488.121900495921;5496.670199788005;5271.992292641261;5303.071962406582;5396.731768034509;5414.648047876885;5446;4253.171136411342;4291.141771645668;4296.140771845643;4315.093830295634;4323.675724320673;4280.828766849322;4293.914121717564;4294.828206871722;4299.4195783569285;4346.478422589294;4283.957160428387;4307.633851122659;4314.913701725964;4324.437823083011;4327.6754243431715;4061.451704019964;4236.343366778155;4257.936130958038;4266.466691663542;4267.991066298252;3776.584575696671;3789.488419063419;3791.241751649681;3798.6771124454453;3817.7518461300206;5212.478752124795;5216.191490319006;5232.2674825524455;5250.317458730341;5304.602154838402;4610.953890461086;4866.732329721864;4897.657163998521;4901.191303434929;4901.558859702608;5737.282839645044;5739.253896993406;5745.2818397700285;5755.280589926259;5760.884782304331;4163.188178305231;4179.91640167198;4188.62302392783;4205.936910946339;4206.49522057352;5627.761892383669;5778.248827652378;5818.389069147764;5916.408359164092;5927.585069045169;4288.335308027261;4299.161663475655;4301.634361079281;4303.569643035734;4309.870703878826;4352;4356.324769660708;4360.389545463638;4365.672574556857;4370.541093185233;4680.391549098664;4698.8355407560575;4795.034036045205;4839.346688197048;4849.806007759721;5690.800821971211;5720.141978703228;5734.799282025109;5739.167820666064;5774.566907481955;1429.121090529317;1443.826740791112;1445.5518789175178;1455.628814652257;1465.6848777512887;952.518977916148;956.206348730552;971.048372594861;980.5979548385128;982.6462473509531;4891.388576427947;4991.625628077909;5051.772670229849;5070.974645126751;5095.261187127846;5211.931554031415;5212.765425555859;5258.553022993088;5276.630635855453;5282.418933917266;4995.402390756786;5008.348914641073;5040.36995375578;5043.814703544737;5074.67014644047;2685.23470810818;2783.6937936826935;2798.622186004904;2810.578413238031;2826.4488424756973;5230.875361797232;5389.895071510331;5396;5407.270018547446;5421.72589441481;4957.487966170281;5262.44757796451;5268.367795864521;5289.20661900718;5304.973475132677;5310.6813591184655;5326.174442961425;5335.839924802262;5378.2739330189925;5400.648957817729;5121.539061484485;5141.665791723526;5192.143296356059;5286.524212820711;5298.781280305474;5150.48495150482;5152.690838549699;5202.791888324576;5560.582956278215;5850.414958504116;6082.327359976042;6085.3306136325855;6094.39056094387;6109.20580324555;6113;4211.462816072173;4215.156968606352;4225.28170211071;4228.260054490391;4235.407043013919;5656.2929633795775;5837.6497410155525;5852.678102704393;5875.882482350244;5878.970605146947;5684.857878553069;5715.799417224482;5721.485066344049;5742.598018138858;5749.367569567428;5429.429909859408;5641.576881733804;5713.457221563945;5772.39389864075;5775.884482310415;5626.015447296789;5636.309107267885;5688.317401911797;5691.975444420044;5696.518905084625;5736.361273814092;5757.625754325955;5784.82645520635;5790;5820.30156381237;5483.259759932358;5648.802291919763;5710.428957104256;5716.256541754805;5727.427257274239 17:23:46 INFO - PROCESS | 17381 | |5;yui.html;744.6276861569215;758.9165191828898;760.232165512832;821;844.1474111147746;15346.539603811876;16010.19949002551;16135.87048906577;16285.267162977665;16292.348306067743;15593.376264949417;15782.131982740944;15792.526224213263;15811.604709882258;15826.76259856103;729.7956572159791;851.0978362935277;881.6825942660637;887.6848718704864;891.1934699097327;883.7569668341193;884.8982367027778;889.2485849457198;889.7464222696533;891.2558014058237;766.0654002117436;937.7749340158347;940.1961323068746;940.4404379394249;941.7174847545743;903.746950853762;928.9349745517817;929.7815013471795;932.6362718539775;934.9252059835197;687.8246047257917;688.3323176518769;688.3907741648627;688.50771698236;688.5145972089665;15509.146996915166;15561.144137072457;15565.45520906774;15569.221538923008;15617.453389131439;14815.407383704638;15052.32264548098;15142.318595663111;15202.163880986542;15255.38978440861;13240.53658121961;13241.404136813866;13432.664183395493;13518.797218041736;13677.86322136776;4633.30500424939;4661.277501987197;4720.976395118037;4727.95272047282;4841.540053694894;64057.359426406074;65601.99999999952;75138;75206;75771;11719.296842189497;11752.529898804123;11767.176297659082;11959.701007474709;12092.697682558006;22195.001224944917;22224.444388890082;22259;22276.772322767916;22336.106555737915;8992.685256016008;9104.499252541042;9164.495952722531;9541;9666.984966578548;4759.595434388047;4779.641526885497;4916.115099282163;4925.039617274597;4990.975045124751;4064.9593504064583;4172.311568591209;4178.35235538492;4179.561146079618;4186.35111557709;728.4391018915511;734.5225603357753;745.1691364129066;752.3604935804523;758.4008633179836;595.7140572525212;651.8924377477758;659.001612556967;740.5075624709616;755.2145768400911;9755.658551950648;10216.387016779017;10228.744281392876;10270.435126067989;10282.28024038325;615.8552740106071;651.4755621724463;747.8541684371495;810.1088802317521;837.7026155714756;4891.877703057452;4912.803487860446;5020.3724534433195;5145.434002259748;5146.76839542214;68157.3184268151;97153.51423242979;98558;99718;105353.47323263335;59253.703731481066;80075.19924800677;89750.55124724335;96623;97821.5108924465;86727.56636216653;90664.54667726619;92118.53940730254;92214;92224;10348.741281468023;10472.895271047191;10582.947085264525;10877.184211184034;10877.564897404016;49658;51642.741786290826;52575.47424525706;52776.20835687391;53417.465825342806;67547.66226168838;73851.26148738444;74407.62796185985;75243;76268.23731762833;13472.461101555828;13791.793123102962;13989.580312590639;14006.859931400555;14389.496367627084;12042.337671428155;13552.79670804919;16137;16156.353745850034;16756.916215418845;13278.136921100098;14942.252887355806;14995.77506337384;15020.624484387978;15021;14431.927840360731;14566.927165364104;14744.705105897607;14977.577130172616;15093.54719358421;13628.523001694894;13959.302034898012;14118.929405352908;14294.428222870969;14379.352929118424;12001.219920705125;12120.939395302967;12203.75592488163;12227.510899564273;12672.809907851206;11824.81751824845;12096.395180241128;12141.08941829384;12312.630621081382;12325.630231092722 17:23:46 INFO - PROCESS | 17381 | __end_tp_report 17:23:46 INFO - PROCESS | 17381 | __start_cc_report 17:23:46 INFO - PROCESS | 17381 | _x_x_mozilla_cycle_collect,955 17:23:46 INFO - PROCESS | 17381 | __end_cc_report 17:23:46 INFO - PROCESS | 17381 | __startTimestamp1465518226136__endTimestamp 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | ------- Summary: start ------- 17:23:46 INFO - PROCESS | 17381 | Number of tests: 6 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | [#0] dojo.html Cycles:165 Average:5406.26 Median:5576.61 stddev:599.88 (10.8%) stddev-sans-first:575.96 17:23:46 INFO - PROCESS | 17381 | Values: 3189.2 3248.1 3284.4 3307.4 3334.6 5355.4 5436.0 5454.0 5470.9 5490.9 5392.4 5403.5 5422.2 5434.1 5468.6 4789.6 4892.0 4911.5 4927.8 4959.9 4900.4 4916.8 5037.5 5051.9 5060.0 4911.9 5015.7 5020.0 5020.3 5036.4 4937.7 4973.5 4979.4 4989.9 5002.4 4726.3 4866.4 4876.7 4882.3 4947.1 5340.2 5366.1 5379.7 5386.4 5420.5 5601.7 5797.9 5826.9 5836.1 5836.3 5883.1 5886.2 5892.8 5905.4 5907.8 5508.8 5512.1 5513.9 5515.1 5517.8 5691.8 5853.5 5913.8 5959.8 5967.3 5715.6 5760.7 5785.6 5795.9 5803.1 5843.1 5886.6 5895.3 5900.8 5902.3 5617.8 5741.0 5772.2 5837.6 5861.0 5825.2 5846.2 5849.3 5860.7 5878.0 4435.6 4490.8 4494.8 4515.8 4516.8 3915.5 3935.1 3964.6 3969.3 4033.8 5518.5 5541.5 5557.8 5565.5 5576.6 5629.8 5813.4 5845.4 5847.1 5856.7 5440.8 5492.0 5495.1 5501.7 5538.2 5017.1 5026.2 5033.1 5037.2 5061.0 5794.4 6011.2 6016.8 6030.2 6031.0 5841.9 5901.1 5906.6 5910.6 5919.4 6098.8 6112.3 6113.9 6122.7 6129.0 5572.8 5600.9 5619.3 5799.1 5817.0 5745.2 5780.9 5781.1 5801.2 5812.3 5627.2 5636.8 5640.1 5649.2 5652.7 5425.3 5603.3 5627.3 5648.0 5656.9 5556.9 5602.6 5606.8 5607.7 5613.6 5712.0 5727.1 5764.3 5765.7 5776.0 5356.8 5416.2 5453.0 5491.1 5555.7 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | [#1] ext.html Cycles:180 Average:65710.98 Median:38885.92 stddev:141275.86 (363.3%) stddev-sans-first:141587.57 17:23:46 INFO - PROCESS | 17381 | Values: 590.5 632.3 635.8 652.6 654.1 32995.2 46559.8 47659.0 47754.3 47821.3 49790.8 50464.2 50488.0 50578.5 50610.5 8547.3 8967.2 9178.1 11125.6 11487.9 10841.4 10974.7 10989.4 11000.0 11004.1 10978.8 10993.6 11051.2 11066.3 11066.4 8359.4 10750.6 11022.9 11046.2 11393.1 10823.1 10865.6 10907.7 10913.5 10920.9 44170.8 44516.0 44549.6 44572.3 44628.3 3414.9 3983.4 4383.1 4419.9 4529.8 34453.3 34878.3 34880.8 36461.6 36678.8 4416.3 4438.5 4470.7 4564.0 4668.5 375568.0 377911.0 378297.0 380943.0 381233.0 37165.6 38454.6 38472.2 63320.0 63332.0 40355.0 40502.4 40634.0 40674.0 40698.6 15011.9 15613.1 15685.8 15704.9 15716.2 13736.5 14073.4 14081.9 14475.1 14493.1 9066.6 9069.8 9077.8 9141.0 9142.1 3439.5 3445.5 3504.5 3509.5 3523.9 905.2 976.9 1014.8 1066.9 1078.7 31542.7 32081.2 32750.3 32909.5 33110.2 1109.3 1126.5 1155.1 1224.0 1250.9 16954.2 17684.8 17689.4 17753.8 17851.4 443893.0 637133.0 648578.0 650163.0 1017796.0 66037.0 66548.3 66802.3 66804.0 66909.7 1311.5 1359.5 1370.6 1402.1 1408.0 30719.5 34707.8 34775.3 34855.3 35287.0 55852.0 56110.7 56524.0 56529.0 56669.7 429268.0 443673.0 444100.0 444108.0 444312.0 26867.0 29458.6 29806.7 30321.0 30756.2 52752.7 52801.5 52815.0 53097.5 53960.0 44301.1 44671.8 45288.1 45348.5 45979.3 43531.6 44147.6 44835.6 45923.3 46477.5 44365.6 44570.8 44611.3 45218.1 45619.8 38159.8 39299.6 39880.4 40584.8 40710.0 28908.7 29388.1 29569.4 29739.4 31653.2 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | [#2] jquery.html Cycles:180 Average:28433.00 Median:23460.47 stddev:78285.31 (333.7%) stddev-sans-first:78476.68 17:23:46 INFO - PROCESS | 17381 | Values: 429.7 435.3 439.1 447.6 456.2 18862.0 20301.4 20340.3 20736.0 20818.0 18424.2 18439.0 18675.4 18712.3 19136.9 5794.7 5981.0 6001.4 6003.0 6022.5 4241.6 5926.1 5979.7 6306.6 6633.9 6661.1 6676.0 6676.2 6696.5 6707.2 6517.4 6611.6 6675.3 6683.6 6686.6 3993.7 5575.6 5889.2 5898.4 5909.1 22607.9 23439.1 23481.9 23777.0 23845.8 2302.7 2351.4 2366.6 2448.2 2485.3 14339.2 14731.6 14911.5 15118.8 15542.3 2052.4 2079.7 2169.6 2175.7 2200.3 79325.0 79953.6 80058.6 80188.0 80517.0 10841.7 11006.0 11174.8 11197.8 11232.8 15689.1 15886.6 15905.7 15949.8 15956.4 8609.3 8685.7 8727.0 8781.6 8842.1 8373.5 8374.4 8568.8 8570.3 8612.8 7021.3 7090.1 7111.2 7142.0 7167.0 1814.1 1884.5 2059.9 2060.3 2070.7 836.9 1029.7 1029.9 1146.0 1158.5 19103.4 20042.7 20049.6 20195.4 20236.9 1037.5 1038.6 1044.1 1097.8 1098.2 11147.3 11535.0 11595.8 11608.1 11725.3 460561.0 468894.0 473859.0 488433.0 492876.0 77005.2 78373.6 79289.0 79712.0 79729.2 1051.6 1058.8 1060.2 1070.1 1079.7 17970.2 17990.4 18006.5 18315.4 18516.0 31104.8 36983.1 36998.8 39439.4 39835.4 51964.7 52789.5 53215.5 54226.7 54549.0 9032.9 9228.4 9302.8 9509.8 9653.6 9086.8 11247.6 11875.9 13570.2 14003.7 12048.1 12133.3 12244.8 12513.4 12622.2 11577.7 11715.6 11821.6 12053.3 12352.7 11467.4 11786.6 12254.9 12308.7 12423.8 9012.6 9018.8 9103.0 9220.3 9377.7 11540.8 12068.8 12097.7 12193.3 12479.6 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | [#3] mootools.html Cycles:180 Average:6428.37 Median:465.73 stddev:3828.71 (822.1%) stddev-sans-first:3820.65 17:23:46 INFO - PROCESS | 17381 | Values: 1378.9 1592.4 1601.1 1849.5 1964.9 9205.2 9549.8 9602.2 9873.5 9898.0 9635.3 9794.8 9806.6 9814.2 9839.1 2235.8 2283.2 2295.5 2478.5 2520.8 2468.2 2529.6 2530.7 2532.5 2545.1 2479.4 2486.6 2509.8 2516.0 2520.3 2206.1 2276.3 2523.1 2557.7 2570.6 2224.3 2363.4 2433.7 2448.3 2454.1 9480.5 9577.8 9602.9 9609.9 9621.5 5571.4 5684.9 5698.8 5698.9 5699.7 3458.2 3582.3 3616.4 3635.9 3663.0 1214.1 1226.1 1237.3 1258.4 1270.2 14283.9 14326.2 14331.2 14331.6 14356.3 4932.1 5136.2 5168.1 5168.2 5186.4 11940.5 11977.2 11979.9 11987.9 11990.2 5701.1 5705.8 5705.9 5708.5 5719.9 4727.8 5207.7 5295.1 5315.6 5472.1 4508.7 4534.3 4537.7 4581.0 4583.1 1396.5 1417.2 1423.4 1431.4 1438.3 935.5 964.1 1006.5 1024.1 1037.6 6148.7 6162.8 6221.8 6301.5 6321.2 454.1 460.5 464.5 467.0 472.5 4141.6 4166.7 4168.7 4184.9 4196.2 11934.6 12429.2 12496.6 12515.3 12530.6 12142.5 12395.7 12398.8 12411.6 12422.7 8715.0 9061.4 9078.2 9088.8 9331.9 6345.7 6502.0 6563.6 6572.2 6595.9 11572.9 11620.8 11643.6 11774.1 11816.1 11019.3 11458.8 11527.3 11577.7 11965.5 8032.2 8557.3 8783.9 8883.3 9051.1 9687.8 9706.6 9736.7 9777.9 9785.7 8555.5 8613.5 8748.2 8750.3 8843.8 8408.6 8427.3 8574.7 8590.9 8729.4 7525.8 7619.4 7628.4 7631.6 7637.4 5499.0 5583.1 5647.2 5729.3 5752.9 5318.9 5401.5 5482.7 5625.9 5659.7 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | [#4] prototype.html Cycles:180 Average:4688.12 Median:5223.53 stddev:1345.00 (25.7%) stddev-sans-first:1308.98 17:23:46 INFO - PROCESS | 17381 | Values: 361.5 363.7 366.9 368.3 372.1 5388.6 5460.4 5477.3 5488.1 5496.7 5272.0 5303.1 5396.7 5414.6 5446.0 4253.2 4291.1 4296.1 4315.1 4323.7 4280.8 4293.9 4294.8 4299.4 4346.5 4284.0 4307.6 4314.9 4324.4 4327.7 4061.5 4236.3 4257.9 4266.5 4268.0 3776.6 3789.5 3791.2 3798.7 3817.8 5212.5 5216.2 5232.3 5250.3 5304.6 4611.0 4866.7 4897.7 4901.2 4901.6 5737.3 5739.3 5745.3 5755.3 5760.9 4163.2 4179.9 4188.6 4205.9 4206.5 5627.8 5778.2 5818.4 5916.4 5927.6 4288.3 4299.2 4301.6 4303.6 4309.9 4352.0 4356.3 4360.4 4365.7 4370.5 4680.4 4698.8 4795.0 4839.3 4849.8 5690.8 5720.1 5734.8 5739.2 5774.6 1429.1 1443.8 1445.6 1455.6 1465.7 952.5 956.2 971.0 980.6 982.6 4891.4 4991.6 5051.8 5071.0 5095.3 5211.9 5212.8 5258.6 5276.6 5282.4 4995.4 5008.3 5040.4 5043.8 5074.7 2685.2 2783.7 2798.6 2810.6 2826.4 5230.9 5389.9 5396.0 5407.3 5421.7 4957.5 5262.4 5268.4 5289.2 5305.0 5310.7 5326.2 5335.8 5378.3 5400.6 5121.5 5141.7 5192.1 5286.5 5298.8 5150.5 5152.7 5202.8 5560.6 5850.4 6082.3 6085.3 6094.4 6109.2 6113.0 4211.5 4215.2 4225.3 4228.3 4235.4 5656.3 5837.6 5852.7 5875.9 5879.0 5684.9 5715.8 5721.5 5742.6 5749.4 5429.4 5641.6 5713.5 5772.4 5775.9 5626.0 5636.3 5688.3 5692.0 5696.5 5736.4 5757.6 5784.8 5790.0 5820.3 5483.3 5648.8 5710.4 5716.3 5727.4 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - PROCESS | 17381 | [#5] yui.html Cycles:180 Average:20240.78 Median:4810.59 stddev:27250.22 (566.5%) stddev-sans-first:27287.34 17:23:46 INFO - PROCESS | 17381 | Values: 744.6 758.9 760.2 821.0 844.1 15346.5 16010.2 16135.9 16285.3 16292.3 15593.4 15782.1 15792.5 15811.6 15826.8 729.8 851.1 881.7 887.7 891.2 883.8 884.9 889.2 889.7 891.3 766.1 937.8 940.2 940.4 941.7 903.7 928.9 929.8 932.6 934.9 687.8 688.3 688.4 688.5 688.5 15509.1 15561.1 15565.5 15569.2 15617.5 14815.4 15052.3 15142.3 15202.2 15255.4 13240.5 13241.4 13432.7 13518.8 13677.9 4633.3 4661.3 4721.0 4728.0 4841.5 64057.4 65602.0 75138.0 75206.0 75771.0 11719.3 11752.5 11767.2 11959.7 12092.7 22195.0 22224.4 22259.0 22276.8 22336.1 8992.7 9104.5 9164.5 9541.0 9667.0 4759.6 4779.6 4916.1 4925.0 4991.0 4065.0 4172.3 4178.4 4179.6 4186.4 728.4 734.5 745.2 752.4 758.4 595.7 651.9 659.0 740.5 755.2 9755.7 10216.4 10228.7 10270.4 10282.3 615.9 651.5 747.9 810.1 837.7 4891.9 4912.8 5020.4 5145.4 5146.8 68157.3 97153.5 98558.0 99718.0 105353.5 59253.7 80075.2 89750.6 96623.0 97821.5 86727.6 90664.5 92118.5 92214.0 92224.0 10348.7 10472.9 10582.9 10877.2 10877.6 49658.0 51642.7 52575.5 52776.2 53417.5 67547.7 73851.3 74407.6 75243.0 76268.2 13472.5 13791.8 13989.6 14006.9 14389.5 12042.3 13552.8 16137.0 16156.4 16756.9 13278.1 14942.3 14995.8 15020.6 15021.0 14431.9 14566.9 14744.7 14977.6 15093.5 13628.5 13959.3 14118.9 14294.4 14379.4 12001.2 12120.9 12203.8 12227.5 12672.8 11824.8 12096.4 12141.1 12312.6 12325.6 17:23:46 INFO - PROCESS | 17381 | -------- Summary: end -------- 17:23:46 INFO - PROCESS | 17381 | 17:23:46 INFO - TEST-INFO | 17381: exit 0 17:23:46 INFO - TEST-OK | dromaeo_css | took 1115139ms 17:23:46 INFO - TEST-START | kraken 17:23:46 INFO - operating with platform_type : linux_ 17:23:46 INFO - Initialising browser for kraken test... 17:23:46 INFO - TEST-INFO | started process 17570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKyvjY/profile http://localhost:42147/getInfo.html) 17:23:51 INFO - PROCESS | 17570 | __metrics Screen width/height:1600/1200 17:23:51 INFO - PROCESS | 17570 | colorDepth:24 17:23:51 INFO - PROCESS | 17570 | Browser inner width/height: 1024/697 17:23:51 INFO - PROCESS | 17570 | __metrics 17:23:52 ERROR - PROCESS | 17570 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:23:53 INFO - PROCESS | 17570 | console.error: PushService: 17:23:53 INFO - PROCESS | 17570 | stateChangeProcessEnqueue: Error transitioning state 17:23:53 INFO - PROCESS | 17570 | UnknownError 17:23:53 INFO - TEST-INFO | 17570: exit 0 17:23:53 INFO - Browser initialized. 17:23:53 INFO - Running cycle 1/1 for kraken test... 17:23:53 INFO - TEST-INFO | started process 17663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplKyvjY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:05 INFO - PROCESS | 17663 | RSS: Main: 148692992 17:24:05 INFO - PROCESS | 17663 | 17:24:08 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:08 INFO - PROCESS | 17663 | RSS: Main: 197611520 17:24:08 INFO - PROCESS | 17663 | 17:24:11 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-dft) 17:24:12 INFO - PROCESS | 17663 | RSS: Main: 196362240 17:24:12 INFO - PROCESS | 17663 | 17:24:14 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-fft) 17:24:15 INFO - PROCESS | 17663 | RSS: Main: 282550272 17:24:15 INFO - PROCESS | 17663 | 17:24:17 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-oscillator) 17:24:18 INFO - PROCESS | 17663 | RSS: Main: 191647744 17:24:18 INFO - PROCESS | 17663 | 17:24:20 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:24:20 INFO - PROCESS | 17663 | RSS: Main: 192024576 17:24:20 INFO - PROCESS | 17663 | 17:24:23 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42147/tests/kraken/driver.html?testName=imaging-darkroom) 17:24:24 INFO - PROCESS | 17663 | RSS: Main: 226721792 17:24:24 INFO - PROCESS | 17663 | 17:24:27 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42147/tests/kraken/driver.html?testName=imaging-desaturate) 17:24:28 INFO - PROCESS | 17663 | RSS: Main: 225640448 17:24:28 INFO - PROCESS | 17663 | 17:24:31 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42147/tests/kraken/driver.html?testName=json-parse-financial) 17:24:31 INFO - PROCESS | 17663 | RSS: Main: 225476608 17:24:31 INFO - PROCESS | 17663 | 17:24:33 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:33 INFO - PROCESS | 17663 | RSS: Main: 204185600 17:24:33 INFO - PROCESS | 17663 | 17:24:35 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:36 INFO - PROCESS | 17663 | RSS: Main: 207773696 17:24:36 INFO - PROCESS | 17663 | 17:24:38 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:38 INFO - PROCESS | 17663 | RSS: Main: 211574784 17:24:38 INFO - PROCESS | 17663 | 17:24:41 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:42 INFO - PROCESS | 17663 | RSS: Main: 214376448 17:24:42 INFO - PROCESS | 17663 | 17:24:44 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:45 INFO - PROCESS | 17663 | RSS: Main: 213422080 17:24:45 INFO - PROCESS | 17663 | 17:24:46 INFO - PROCESS | 17663 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42147/tests/kraken/driver.html?testName=ai-astar) 17:24:47 INFO - PROCESS | 17663 | RSS: Main: 256638976 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | __start_tp_report 17:24:47 INFO - PROCESS | 17663 | _x_x_mozilla_page_load 17:24:47 INFO - PROCESS | 17663 | _x_x_mozilla_page_load_details 17:24:47 INFO - PROCESS | 17663 | |i|pagename|runs| 17:24:47 INFO - PROCESS | 17663 | |0;ai-astar;113;104;109;112;111;112;111;111;112;112 17:24:47 INFO - PROCESS | 17663 | |1;audio-beat-detection;153;125;132;176;127;130;152;125;151;125 17:24:47 INFO - PROCESS | 17663 | |2;audio-dft;160;161;160;163;161;161;160;161;160;161 17:24:47 INFO - PROCESS | 17663 | |3;audio-fft;75;84;77;122;75;76;75;75;100;74 17:24:47 INFO - PROCESS | 17663 | |4;audio-oscillator;85;85;128;85;84;86;116;85;85;124 17:24:47 INFO - PROCESS | 17663 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;116;118 17:24:47 INFO - PROCESS | 17663 | |6;imaging-darkroom;146;146;146;145;146;146;145;145;145;145 17:24:47 INFO - PROCESS | 17663 | |7;imaging-desaturate;95;95;95;95;96;95;94;95;95;95 17:24:47 INFO - PROCESS | 17663 | |8;json-parse-financial;50;50;50;51;53;51;53;51;52;51 17:24:47 INFO - PROCESS | 17663 | |9;json-stringify-tinderbox;62;61;60;60;61;61;60;61;61;62 17:24:47 INFO - PROCESS | 17663 | |10;stanford-crypto-aes;77;76;75;76;77;79;82;77;108;77 17:24:47 INFO - PROCESS | 17663 | |11;stanford-crypto-ccm;121;120;131;118;130;122;126;125;146;122 17:24:47 INFO - PROCESS | 17663 | |12;stanford-crypto-pbkdf2;153;153;149;154;154;154;148;148;153;152 17:24:47 INFO - PROCESS | 17663 | |13;stanford-crypto-sha256-iterative;65;62;62;61;62;60;60;61;62;64 17:24:47 INFO - PROCESS | 17663 | __end_tp_report 17:24:47 INFO - PROCESS | 17663 | __start_cc_report 17:24:47 INFO - PROCESS | 17663 | _x_x_mozilla_cycle_collect,1559 17:24:47 INFO - PROCESS | 17663 | __end_cc_report 17:24:47 INFO - PROCESS | 17663 | __startTimestamp1465518287159__endTimestamp 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | ------- Summary: start ------- 17:24:47 INFO - PROCESS | 17663 | Number of tests: 14 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.58 (2.3%) stddev-sans-first:2.60 17:24:47 INFO - PROCESS | 17663 | Values: 113.0 104.0 109.0 112.0 111.0 112.0 111.0 111.0 112.0 112.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:141.50 stddev:17.44 (12.3%) stddev-sans-first:17.81 17:24:47 INFO - PROCESS | 17663 | Values: 153.0 125.0 132.0 176.0 127.0 130.0 152.0 125.0 151.0 125.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 17:24:47 INFO - PROCESS | 17663 | Values: 160.0 161.0 160.0 163.0 161.0 161.0 160.0 161.0 160.0 161.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:15.75 (21.0%) stddev-sans-first:16.41 17:24:47 INFO - PROCESS | 17663 | Values: 75.0 84.0 77.0 122.0 75.0 76.0 75.0 75.0 100.0 74.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:18.43 (21.7%) stddev-sans-first:19.09 17:24:47 INFO - PROCESS | 17663 | Values: 85.0 85.0 128.0 85.0 84.0 86.0 116.0 85.0 85.0 124.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:24:47 INFO - PROCESS | 17663 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 118.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:24:47 INFO - PROCESS | 17663 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:24:47 INFO - PROCESS | 17663 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.14 (2.2%) stddev-sans-first:1.12 17:24:47 INFO - PROCESS | 17663 | Values: 50.0 50.0 50.0 51.0 53.0 51.0 53.0 51.0 52.0 51.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 17:24:47 INFO - PROCESS | 17663 | Values: 62.0 61.0 60.0 60.0 61.0 61.0 60.0 61.0 61.0 62.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:77.00 stddev:9.89 (12.8%) stddev-sans-first:10.41 17:24:47 INFO - PROCESS | 17663 | Values: 77.0 76.0 75.0 76.0 77.0 79.0 82.0 77.0 108.0 77.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:125.50 stddev:8.16 (6.5%) stddev-sans-first:8.44 17:24:47 INFO - PROCESS | 17663 | Values: 121.0 120.0 131.0 118.0 130.0 122.0 126.0 125.0 146.0 122.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:153.00 stddev:2.49 (1.6%) stddev-sans-first:2.60 17:24:47 INFO - PROCESS | 17663 | Values: 153.0 153.0 149.0 154.0 154.0 154.0 148.0 148.0 153.0 152.0 17:24:47 INFO - PROCESS | 17663 | 17:24:47 INFO - PROCESS | 17663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.60 (2.6%) stddev-sans-first:1.24 17:24:47 INFO - PROCESS | 17663 | Values: 65.0 62.0 62.0 61.0 62.0 60.0 60.0 61.0 62.0 64.0 17:24:47 INFO - PROCESS | 17663 | -------- Summary: end -------- 17:24:47 INFO - PROCESS | 17663 | 17:24:48 INFO - TEST-INFO | 17663: exit 0 17:24:48 INFO - TEST-OK | kraken | took 61406ms 17:24:48 INFO - SUITE-END | took 1176s 17:24:48 INFO - Completed test suite (00:19:36) 17:24:48 INFO - javascript benchmark 17:24:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3189.154873958401, 3248.0742988248353, 3284.4252255855217, 3307.4046671599103, 3334.6498617645148, 5355.437679043698, 5435.9728201358985, 5453.972730136354, 5470.890582188354, 5490.917636235455, 5392.40683524812, 5403.51368376846, 5422.240886275925, 5434.076207044802, 5468.6171967962155, 4789.6168306535565, 4892.0, 4911.45973942866, 4927.802887884481, 4959.851204463854, 4900.436449808282, 4916.827911023097, 5037.5214354636255, 5051.898962020758, 5060.0, 4911.926321105187, 5015.673981191211, 5020.0, 5020.297158397827, 5036.370453693288, 4937.654364194508, 4973.452920178777, 4979.377577802775, 4989.90020199594, 5002.399712034561, 4726.338312636233, 4866.367372241586, 4876.731779752112, 4882.316475693406, 4947.134251505972, 5340.225667278223, 5366.114591092504, 5379.731013449312, 5386.380566234894, 5420.457954204548, 5601.719914004324, 5797.942020579782, 5826.883462330729, 5836.095405212199, 5836.2996440427, 5883.14694369314, 5886.205362276123, 5892.793752218695, 5905.4094590541035, 5907.763689452417, 5508.779648814043, 5512.118061110203, 5513.889722205534, 5515.09001014832, 5517.779288828442, 5691.800786972436, 5853.5317174625925, 5913.769567253495, 5959.821205363846, 5967.31375891778, 5715.599908006483, 5760.74076666551, 5785.595008349459, 5795.913061304083, 5803.129530570363, 5843.065109582446, 5886.58793884424, 5895.322037965689, 5900.822975310662, 5902.321233058167, 5617.8033768817895, 5741.0, 5772.249607550992, 5837.6497410155525, 5861.0, 5825.2135961644635, 5846.181534585162, 5849.268841394825, 5860.706964651836, 5878.0, 4435.645148388121, 4490.7754612269255, 4494.842680506232, 4515.81936722534, 4516.796744146522, 3915.5105611798526, 3935.0752573145287, 3964.623360780721, 3969.2656858481273, 4033.757974521538, 5518.475744804237, 5541.5289700375915, 5557.77768889248, 5565.471280228372, 5576.609637325349, 5629.774809007594, 5813.447722466359, 5845.415458454206, 5847.093700476433, 5856.677882716492, 5440.809571664972, 5492.038893193755, 5495.120780675073, 5501.697406642673, 5538.224648549206, 5017.071841709296, 5026.195808670595, 5033.094043072282, 5037.219231019198, 5061.038402703474, 5794.362620111784, 6011.248593925759, 6016.789412370546, 6030.155778191057, 6030.9747342951805, 5841.912371314349, 5901.144334071621, 5906.586538942232, 5910.586258961831, 5919.408059194218, 6098.847528811815, 6112.2970858351855, 6113.908291375544, 6122.663253521099, 6129.0, 5572.804951826666, 5600.887982240414, 5619.269494965628, 5799.072148456226, 5817.040188368872, 5745.166950792028, 5780.884382312414, 5781.103928891029, 5801.158831969426, 5812.273465816773, 5627.240322556566, 5636.774529018793, 5640.097584386478, 5649.237352957298, 5652.745626446737, 5425.321834770653, 5603.271574695264, 5627.324721033502, 5647.971760141173, 5656.915146272891, 5556.888862222814, 5602.607817452739, 5606.775728970795, 5607.691576963143, 5613.607047506635, 5712.0, 5727.11229759388, 5764.308283006066, 5765.740541675551, 5775.989201889569, 5356.812511562077, 5416.214648875812, 5453.0, 5491.0939694951485, 5555.7499912504845], "value": 5367.424498493297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.5098768022542, 632.2602555010637, 635.7679447001843, 652.644308851676, 654.0679531667373, 32995.175120622, 46559.76720116399, 47659.0, 47754.28368574465, 47821.282680759774, 49790.75104624472, 50464.243036354485, 50488.0, 50578.494215057835, 50610.49389506113, 8547.273481754028, 8967.237784788285, 9178.082191780835, 11125.610603628875, 11487.942560287187, 10841.403722795283, 10974.725631859188, 10989.395583242918, 11000.0, 11004.119670426388, 10978.835317470244, 10993.61522346718, 11051.226414151013, 11066.28069175505, 11066.446677666125, 8359.373047021467, 10750.623728169516, 11022.944885275603, 11046.171537134667, 11393.088552915748, 10823.13414926804, 10865.565377384895, 10907.672769816918, 10913.508892099795, 10920.890791092066, 44170.77914610438, 44516.0, 44549.55450445519, 44572.3314150288, 44628.3305750414, 3414.897553073412, 3983.3626619740703, 4383.07955329378, 4419.889502762425, 4529.841455549073, 34453.31093378143, 34878.30243395143, 34880.82559587186, 36461.63538364609, 36678.81660591707, 4416.315471101984, 4438.467383913951, 4470.709403888737, 4564.0, 4668.486466488684, 375568.0, 377911.0, 378297.0, 380943.0, 381233.0, 37165.62834371622, 38454.61545384566, 38472.230555388735, 63320.0, 63332.0, 40355.0, 40502.392464113065, 40634.0, 40674.0, 40698.59301407007, 15011.924940375227, 15613.141277229633, 15685.843141568439, 15704.92147539255, 15716.21418929049, 13736.519221827188, 14073.437062517385, 14081.85918140826, 14475.059121157092, 14493.130412175304, 9066.637334506546, 9069.77325566866, 9077.818443631091, 9141.040190780006, 9142.131497507726, 3439.5012723155, 3445.4659527773233, 3504.491848681978, 3509.5437593112733, 3523.9119022024142, 905.2260317428635, 976.8876579193484, 1014.761531040205, 1066.8879767624444, 1078.7033565769477, 31542.684573154434, 32081.197970050936, 32750.344993100003, 32909.50635740466, 33110.17224569357, 1109.3066833229232, 1126.5493802479075, 1155.1394211312459, 1223.9877601223873, 1250.9179559680992, 16954.23705933236, 17684.823151768316, 17689.38087166943, 17753.822461775475, 17851.37520186787, 443893.0, 637133.0, 648578.0, 650163.0, 1017796.0, 66037.0, 66548.33451665421, 66802.3319766796, 66804.0, 66909.66545167242, 1311.5016293808292, 1359.5377571625497, 1370.5614203454998, 1402.144691738039, 1407.9929600352139, 30719.539206912363, 34707.82646086753, 34775.304493909476, 34855.302893942484, 35287.0, 55852.0, 56110.71944640251, 56524.0, 56529.0, 56669.71665141648, 429268.0, 443673.0, 444100.0, 444108.0, 444312.0, 26867.0, 29458.558121628623, 29806.70193298039, 30321.0, 30756.231094222825, 52752.736236318575, 52801.471985279655, 52815.0, 53097.4690253108, 53960.0, 44301.11397772091, 44671.77664111659, 45288.094238115715, 45348.546514534435, 45979.3103103447, 43531.564684354016, 44147.577619921474, 44835.55164448444, 45923.311150332105, 46477.53522464867, 44365.55634443614, 44570.77714611406, 44611.33083003823, 45218.09563808771, 45619.77190114028, 38159.809200953816, 39299.60700393074, 39880.40179397253, 40584.79707601443, 40710.0, 28908.7109128906, 29388.11835644934, 29569.408611828072, 29739.405211896075, 31653.20866978344], "value": 20536.244862126976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.70135755649824, 435.27309393313163, 439.0932723925092, 447.58598296575667, 456.2403598009317, 18861.962592057447, 20301.39095827126, 20340.288089916838, 20736.0, 20818.0, 18424.170912308946, 18439.0, 18675.43973680792, 18712.251509939586, 19136.904315478438, 5794.652320860751, 5981.043033114703, 6001.429864162919, 6003.0395136778125, 6022.54830887683, 4241.554636763141, 5926.051831706928, 5979.730912108944, 6306.590071645352, 6633.867322653544, 6661.100751398571, 6675.966620166917, 6676.232233293161, 6696.497762667795, 6707.1616047994, 6517.413432791024, 6611.636360000198, 6675.265720770712, 6683.565568238073, 6686.5653732507235, 3993.6605388542007, 5575.637583557056, 5889.1755154278435, 5898.41015898411, 5909.113632955048, 22607.88696056509, 23439.062437502478, 23481.88259058711, 23777.0, 23845.761542384527, 2302.6776251324827, 2351.4239011442305, 2366.6450032495263, 2448.153667495672, 2485.3041148478455, 14339.21134337611, 14731.631709207248, 14911.478098266618, 15118.773218401622, 15542.300596473073, 2052.404802607242, 2079.729635147436, 2169.631162702344, 2175.7497887742798, 2200.3179014505395, 79325.0, 79953.60023199847, 80058.59970700167, 80188.0, 80517.0, 10841.67474975752, 11005.954434328725, 11174.776504469864, 11197.776044479066, 11232.831507527393, 15689.137097459748, 15886.602834928988, 15905.681886362208, 15949.760753588705, 15956.441524546584, 8609.268212202032, 8685.696000640073, 8726.956365218133, 8781.604827782765, 8842.071582483875, 8373.455725377953, 8374.371922105745, 8568.828623427622, 8570.271526920156, 8612.837266969005, 7021.29787021304, 7090.078289822393, 7111.217766045731, 7142.035825163641, 7167.0, 1814.0522537702502, 1884.453508482552, 2059.907304171316, 2060.2789023841538, 2070.6790447480666, 836.8744688296804, 1029.7425643589104, 1029.8712660917386, 1146.0487795130023, 1158.5365853658436, 19103.426897193105, 20042.699359509617, 20049.59900801976, 20195.394138175583, 20236.898815506123, 1037.5382954585136, 1038.631285893512, 1044.1125043712934, 1097.7639807441437, 1098.2038022433671, 11147.275427097213, 11535.0, 11595.840415958506, 11608.071354291636, 11725.296482210924, 460561.0, 468894.0, 473859.0, 488433.0, 492876.0, 77005.22994770092, 78373.60813195897, 79289.0, 79712.0, 79729.20270797334, 1051.600391851107, 1058.7829494953517, 1060.226034994443, 1070.0957690751302, 1079.7462596289865, 17970.191341389407, 17990.37033703814, 18006.5498362542, 18315.35896243625, 18516.0, 31104.844475777478, 36983.075423114635, 36998.8150059248, 39439.408408874464, 39835.402468962406, 51964.740176298874, 52789.47210527846, 53215.46784532105, 54226.72886635541, 54549.0, 9032.857192784613, 9228.44629322216, 9302.767430814283, 9509.762255943657, 9653.565589548347, 9086.772830679285, 11247.606333778278, 11875.931166195083, 13570.185788852701, 14003.719925601226, 12048.096392770753, 12133.332666703063, 12244.755104897675, 12513.43689533955, 12622.179558328678, 11577.663255906724, 11715.648530544097, 11821.645350639494, 12053.276803391824, 12352.691182720504, 11467.369294688539, 11786.58746943853, 12254.938725306316, 12308.692282692646, 12423.813642795185, 9012.594433250388, 9018.774530636787, 9102.954485227532, 9220.308476864127, 9377.718668439958, 11540.769184616092, 12068.758624827278, 12097.697557561132, 12193.268403895794, 12479.625611231677], "value": 9663.447265506324, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.8965827562922, 1592.3948899418224, 1601.1193843386134, 1849.537615596101, 1964.8821070735748, 9205.171534561889, 9549.761255968604, 9602.231821454285, 9873.506324683773, 9898.0, 9635.277354198446, 9794.755131121725, 9806.607735690583, 9814.214862810975, 9839.114479696826, 2235.832312576555, 2283.1552325639536, 2295.517941232343, 2478.50429914017, 2520.8109391795597, 2468.2471846086937, 2529.582618867885, 2530.7342729013467, 2532.5314816758864, 2545.109211775873, 2479.38015496126, 2486.589712697403, 2509.8494090354548, 2516.018752686454, 2520.3447103752974, 2206.1396055538353, 2276.2943487518924, 2523.079076137206, 2557.705863825656, 2570.627259047437, 2224.27710993926, 2363.409147713072, 2433.6714543536573, 2448.326710154704, 2454.0797201049604, 9480.525973701357, 9577.808443831085, 9602.855957160647, 9609.855852162224, 9621.51892405377, 5571.4428557144365, 5684.943150568482, 5698.772049118031, 5698.914516282259, 5699.74351154199, 3458.2046129390383, 3582.301451217014, 3616.4032934565766, 3635.8909232723063, 3663.0476076220107, 1214.1318956945827, 1226.0865655086927, 1237.2514628649628, 1258.4399942025802, 1270.1870802686287, 14283.928580357031, 14326.212058336787, 14331.211783351911, 14331.641708957255, 14356.282185890768, 4932.087563800636, 5136.229565565195, 5168.095583272912, 5168.198929165986, 5186.351706036746, 11940.522379104912, 11977.161598688182, 11979.880201198052, 11987.940060299643, 11990.220635658654, 5701.144828275792, 5705.771769129271, 5705.857353566194, 5708.514776243983, 5719.914201286984, 4727.763611819464, 5207.6875387476875, 5295.126304159848, 5315.574754019669, 5472.097103977879, 4508.684392092522, 4534.319852022157, 4537.705049171794, 4580.954190458119, 4583.106294272651, 1396.5072345862586, 1417.1638733147493, 1423.352374669523, 1431.4131206205407, 1438.3311760031427, 935.5415846235431, 964.1467301438278, 1006.5118417567473, 1024.1294899335653, 1037.5590374090982, 6148.661823599745, 6162.7843025494785, 6221.751129954841, 6301.52738544611, 6321.1782468278825, 454.1190091223083, 460.5187578979974, 464.47746285428894, 466.97665116744025, 472.53219312880003, 4141.585841415895, 4166.687498437629, 4168.687348448879, 4184.937225941613, 4196.181744559782, 11934.582289619822, 12429.192102513307, 12496.562620308245, 12515.311657858905, 12530.624081277576, 12142.514299428101, 12395.690107747378, 12398.81401778974, 12411.565595204125, 12422.689432764253, 8714.956425217833, 9061.365704400629, 9078.182963533181, 9088.772780680536, 9331.860022099674, 6345.7144428499905, 6501.9674901625185, 6563.573367731082, 6572.244191917991, 6595.934040659724, 11572.94213528927, 11620.767584648429, 11643.5924742637, 11774.05807535378, 11816.054715622902, 11019.283746556448, 11458.770824583295, 11527.308361498337, 11577.6526704199, 11965.521379144737, 8032.196780321921, 8557.272631826365, 8783.91216087831, 8883.33374996865, 9051.094890510896, 9687.806243875224, 9706.6117355305, 9736.707898763048, 9777.9022209777, 9785.657501987396, 8555.486670799772, 8613.526256055977, 8748.168923952215, 8750.343724220837, 8843.823123537622, 8408.579571021302, 8427.325813934993, 8574.699885503978, 8590.871136933076, 8729.432586881832, 7525.774226772986, 7619.390448763975, 7628.389728821792, 7631.580263085361, 7637.350825179922, 5498.972505137449, 5583.134614134816, 5647.209390685225, 5729.28383952006, 5752.942470575241, 5318.893622127458, 5401.4868587484125, 5482.725863706878, 5625.915611265752, 5659.717014149359], "value": 4973.458796057949, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.45600870689606, 363.70539862711206, 366.8752624107803, 368.3130960758187, 372.0791042170628, 5388.595855310848, 5460.372057213422, 5477.315335583052, 5488.121900495921, 5496.670199788005, 5271.992292641261, 5303.071962406582, 5396.731768034509, 5414.648047876885, 5446.0, 4253.171136411342, 4291.141771645668, 4296.140771845643, 4315.093830295634, 4323.675724320673, 4280.828766849322, 4293.914121717564, 4294.828206871722, 4299.4195783569285, 4346.478422589294, 4283.957160428387, 4307.633851122659, 4314.913701725964, 4324.437823083011, 4327.6754243431715, 4061.451704019964, 4236.343366778155, 4257.936130958038, 4266.466691663542, 4267.991066298252, 3776.584575696671, 3789.488419063419, 3791.241751649681, 3798.6771124454453, 3817.7518461300206, 5212.478752124795, 5216.191490319006, 5232.2674825524455, 5250.317458730341, 5304.602154838402, 4610.953890461086, 4866.732329721864, 4897.657163998521, 4901.191303434929, 4901.558859702608, 5737.282839645044, 5739.253896993406, 5745.2818397700285, 5755.280589926259, 5760.884782304331, 4163.188178305231, 4179.91640167198, 4188.62302392783, 4205.936910946339, 4206.49522057352, 5627.761892383669, 5778.248827652378, 5818.389069147764, 5916.408359164092, 5927.585069045169, 4288.335308027261, 4299.161663475655, 4301.634361079281, 4303.569643035734, 4309.870703878826, 4352.0, 4356.324769660708, 4360.389545463638, 4365.672574556857, 4370.541093185233, 4680.391549098664, 4698.8355407560575, 4795.034036045205, 4839.346688197048, 4849.806007759721, 5690.800821971211, 5720.141978703228, 5734.799282025109, 5739.167820666064, 5774.566907481955, 1429.121090529317, 1443.826740791112, 1445.5518789175178, 1455.628814652257, 1465.6848777512887, 952.518977916148, 956.206348730552, 971.048372594861, 980.5979548385128, 982.6462473509531, 4891.388576427947, 4991.625628077909, 5051.772670229849, 5070.974645126751, 5095.261187127846, 5211.931554031415, 5212.765425555859, 5258.553022993088, 5276.630635855453, 5282.418933917266, 4995.402390756786, 5008.348914641073, 5040.36995375578, 5043.814703544737, 5074.67014644047, 2685.23470810818, 2783.6937936826935, 2798.622186004904, 2810.578413238031, 2826.4488424756973, 5230.875361797232, 5389.895071510331, 5396.0, 5407.270018547446, 5421.72589441481, 4957.487966170281, 5262.44757796451, 5268.367795864521, 5289.20661900718, 5304.973475132677, 5310.6813591184655, 5326.174442961425, 5335.839924802262, 5378.2739330189925, 5400.648957817729, 5121.539061484485, 5141.665791723526, 5192.143296356059, 5286.524212820711, 5298.781280305474, 5150.48495150482, 5152.690838549699, 5202.791888324576, 5560.582956278215, 5850.414958504116, 6082.327359976042, 6085.3306136325855, 6094.39056094387, 6109.20580324555, 6113.0, 4211.462816072173, 4215.156968606352, 4225.28170211071, 4228.260054490391, 4235.407043013919, 5656.2929633795775, 5837.6497410155525, 5852.678102704393, 5875.882482350244, 5878.970605146947, 5684.857878553069, 5715.799417224482, 5721.485066344049, 5742.598018138858, 5749.367569567428, 5429.429909859408, 5641.576881733804, 5713.457221563945, 5772.39389864075, 5775.884482310415, 5626.015447296789, 5636.309107267885, 5688.317401911797, 5691.975444420044, 5696.518905084625, 5736.361273814092, 5757.625754325955, 5784.82645520635, 5790.0, 5820.30156381237, 5483.259759932358, 5648.802291919763, 5710.428957104256, 5716.256541754805, 5727.427257274239], "value": 4268.457975645576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.6276861569215, 758.9165191828898, 760.232165512832, 821.0, 844.1474111147746, 15346.539603811876, 16010.19949002551, 16135.87048906577, 16285.267162977665, 16292.348306067743, 15593.376264949417, 15782.131982740944, 15792.526224213263, 15811.604709882258, 15826.76259856103, 729.7956572159791, 851.0978362935277, 881.6825942660637, 887.6848718704864, 891.1934699097327, 883.7569668341193, 884.8982367027778, 889.2485849457198, 889.7464222696533, 891.2558014058237, 766.0654002117436, 937.7749340158347, 940.1961323068746, 940.4404379394249, 941.7174847545743, 903.746950853762, 928.9349745517817, 929.7815013471795, 932.6362718539775, 934.9252059835197, 687.8246047257917, 688.3323176518769, 688.3907741648627, 688.50771698236, 688.5145972089665, 15509.146996915166, 15561.144137072457, 15565.45520906774, 15569.221538923008, 15617.453389131439, 14815.407383704638, 15052.32264548098, 15142.318595663111, 15202.163880986542, 15255.38978440861, 13240.53658121961, 13241.404136813866, 13432.664183395493, 13518.797218041736, 13677.86322136776, 4633.30500424939, 4661.277501987197, 4720.976395118037, 4727.95272047282, 4841.540053694894, 64057.359426406074, 65601.99999999952, 75138.0, 75206.0, 75771.0, 11719.296842189497, 11752.529898804123, 11767.176297659082, 11959.701007474709, 12092.697682558006, 22195.001224944917, 22224.444388890082, 22259.0, 22276.772322767916, 22336.106555737915, 8992.685256016008, 9104.499252541042, 9164.495952722531, 9541.0, 9666.984966578548, 4759.595434388047, 4779.641526885497, 4916.115099282163, 4925.039617274597, 4990.975045124751, 4064.9593504064583, 4172.311568591209, 4178.35235538492, 4179.561146079618, 4186.35111557709, 728.4391018915511, 734.5225603357753, 745.1691364129066, 752.3604935804523, 758.4008633179836, 595.7140572525212, 651.8924377477758, 659.001612556967, 740.5075624709616, 755.2145768400911, 9755.658551950648, 10216.387016779017, 10228.744281392876, 10270.435126067989, 10282.28024038325, 615.8552740106071, 651.4755621724463, 747.8541684371495, 810.1088802317521, 837.7026155714756, 4891.877703057452, 4912.803487860446, 5020.3724534433195, 5145.434002259748, 5146.76839542214, 68157.3184268151, 97153.51423242979, 98558.0, 99718.0, 105353.47323263335, 59253.703731481066, 80075.19924800677, 89750.55124724335, 96623.0, 97821.5108924465, 86727.56636216653, 90664.54667726619, 92118.53940730254, 92214.0, 92224.0, 10348.741281468023, 10472.895271047191, 10582.947085264525, 10877.184211184034, 10877.564897404016, 49658.0, 51642.741786290826, 52575.47424525706, 52776.20835687391, 53417.465825342806, 67547.66226168838, 73851.26148738444, 74407.62796185985, 75243.0, 76268.23731762833, 13472.461101555828, 13791.793123102962, 13989.580312590639, 14006.859931400555, 14389.496367627084, 12042.337671428155, 13552.79670804919, 16137.0, 16156.353745850034, 16756.916215418845, 13278.136921100098, 14942.252887355806, 14995.77506337384, 15020.624484387978, 15021.0, 14431.927840360731, 14566.927165364104, 14744.705105897607, 14977.577130172616, 15093.54719358421, 13628.523001694894, 13959.302034898012, 14118.929405352908, 14294.428222870969, 14379.352929118424, 12001.219920705125, 12120.939395302967, 12203.75592488163, 12227.510899564273, 12672.809907851206, 11824.81751824845, 12096.395180241128, 12141.08941829384, 12312.630621081382, 12325.630231092722], "value": 7931.868672767917, "unit": "score"}], "name": "dromaeo_css", "value": 7509.793403744572, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 109.0, 112.0, 111.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 132.0, 176.0, 127.0, 130.0, 152.0, 125.0, 151.0, 125.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 163.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 77.0, 122.0, 75.0, 76.0, 75.0, 75.0, 100.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 128.0, 85.0, 84.0, 86.0, 116.0, 85.0, 85.0, 124.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 51.0, 53.0, 51.0, 53.0, 51.0, 52.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 76.0, 77.0, 79.0, 82.0, 77.0, 108.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 131.0, 118.0, 130.0, 122.0, 126.0, 125.0, 146.0, 122.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 149.0, 154.0, 154.0, 154.0, 148.0, 148.0, 153.0, 152.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 61.0, 62.0, 60.0, 60.0, 61.0, 62.0, 64.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1480.6000000000001, "alertThreshold": 2.0}]} 17:24:48 INFO - Return code: 0 17:24:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:24:48 ERROR - # TBPL SUCCESS # 17:24:48 INFO - Running post-action listener: _resource_record_post_action 17:24:48 INFO - ##### 17:24:48 INFO - ##### Finished run-tests step (success) 17:24:48 INFO - ##### 17:24:48 INFO - Running post-run listener: _resource_record_post_run 17:24:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 502652928; Read time: 20; Write time: 1052088 17:24:48 INFO - TinderboxPrint: CPU usage
13.2% 17:24:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 17:24:48 INFO - TinderboxPrint: I/O write bytes / time
502,652,928 / 1,052,088 17:24:48 INFO - TinderboxPrint: CPU idle
8,271.3 (86.8%) 17:24:48 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 17:24:48 INFO - TinderboxPrint: Swap in / out
0 / 0 17:24:48 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 252497920; Read time: 0; Write time: 588964 17:24:48 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250155008; Read time: 20; Write time: 463124 17:24:49 INFO - Running post-run listener: _upload_blobber_files 17:24:49 INFO - Blob upload gear active. 17:24:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:24:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:24:49 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'] 17:24:49 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 17:24:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:24:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:53 INFO - (blobuploader) - INFO - Done attempting. 17:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:54 INFO - (blobuploader) - INFO - Done attempting. 17:24:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:24:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:54 INFO - (blobuploader) - INFO - Done attempting. 17:24:54 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:54 INFO - Return code: 0 17:24:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:24:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/672029cef87bdb8153d59051f7c53dd520b80a8f80d638af7f0b4b772ed7847a7b9e579debd04e3f5043b24c988fdd8b08625a28b0c18aea20481e2a07f058a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb52857b1009cf18eb06c9ea09da85549e40617ee9c740820395bbf460c2556878bc7bf6306191347f2981aa39cf06d711150bb267faf0a7c9813e9ff07f8f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68256c314c5b64ae677d47354ffbe8e73b684de804c6368e2f8f92c99c80cee97ca5cc89f8e7d84549ddbc56bb4e6d7d908b90ad15e8082484e1ef00587eed08"} 17:24:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:24:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:24:54 INFO - Contents: 17:24:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/672029cef87bdb8153d59051f7c53dd520b80a8f80d638af7f0b4b772ed7847a7b9e579debd04e3f5043b24c988fdd8b08625a28b0c18aea20481e2a07f058a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb52857b1009cf18eb06c9ea09da85549e40617ee9c740820395bbf460c2556878bc7bf6306191347f2981aa39cf06d711150bb267faf0a7c9813e9ff07f8f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68256c314c5b64ae677d47354ffbe8e73b684de804c6368e2f8f92c99c80cee97ca5cc89f8e7d84549ddbc56bb4e6d7d908b90ad15e8082484e1ef00587eed08"} 17:24:54 INFO - Running post-run listener: copy_logs_to_upload_dir 17:24:54 INFO - Copying logs to upload dir... 17:24:54 INFO - mkdir: /builds/slave/test/build/upload/logs 17:24:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.832787 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-09 17:24:54.742385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:24:54.745768) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/672029cef87bdb8153d59051f7c53dd520b80a8f80d638af7f0b4b772ed7847a7b9e579debd04e3f5043b24c988fdd8b08625a28b0c18aea20481e2a07f058a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb52857b1009cf18eb06c9ea09da85549e40617ee9c740820395bbf460c2556878bc7bf6306191347f2981aa39cf06d711150bb267faf0a7c9813e9ff07f8f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68256c314c5b64ae677d47354ffbe8e73b684de804c6368e2f8f92c99c80cee97ca5cc89f8e7d84549ddbc56bb4e6d7d908b90ad15e8082484e1ef00587eed08"} build_url:https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/JHgjjcaASHGrnes67W7JJg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/672029cef87bdb8153d59051f7c53dd520b80a8f80d638af7f0b4b772ed7847a7b9e579debd04e3f5043b24c988fdd8b08625a28b0c18aea20481e2a07f058a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb52857b1009cf18eb06c9ea09da85549e40617ee9c740820395bbf460c2556878bc7bf6306191347f2981aa39cf06d711150bb267faf0a7c9813e9ff07f8f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68256c314c5b64ae677d47354ffbe8e73b684de804c6368e2f8f92c99c80cee97ca5cc89f8e7d84549ddbc56bb4e6d7d908b90ad15e8082484e1ef00587eed08"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 17:24:54.770939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:24:54.771276) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465517051.230779-1927653070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 17:24:54.855324) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:24:54.855640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 17:24:54.855920) ========= ========= Total master_lag: 0.18 =========