builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1464108495.08 results: success (0) buildid: 20160524065713 builduid: 303562a2b4ca43de9d8997b6f45bfbf6 revision: 58f539121d2b6fe7d5a36d09b9a67314a2966e23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.084706) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.085153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.085432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.101622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.101927) ========= 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=ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 09:48:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-05-24 09:48:15 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.291764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.292096) ========= 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=ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017202 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:15.341428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 09:48:15.341777) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 58f539121d2b6fe7d5a36d09b9a67314a2966e23 --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 58f539121d2b6fe7d5a36d09b9a67314a2966e23 --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=ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 09:48:15,494 truncating revision to first 12 chars 2016-05-24 09:48:15,494 Setting DEBUG logging. 2016-05-24 09:48:15,494 attempt 1/10 2016-05-24 09:48:15,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/58f539121d2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 09:48:16,611 unpacking tar archive at: mozilla-aurora-58f539121d2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.416567 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 09:48:16.771548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:16.771872) ========= script_repo_revision: 58f539121d2b6fe7d5a36d09b9a67314a2966e23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:16.772250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:16.772554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 09:48:16.782195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-24 09:48:16.782504) ========= /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=ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:17 INFO - MultiFileLogger online at 20160524 09:48:17 in /builds/slave/test 09:48:17 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 09:48:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:17 INFO - {'append_to_log': False, 09:48:17 INFO - 'base_work_dir': '/builds/slave/test', 09:48:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:48:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:17 INFO - 'branch': 'Mozilla-Aurora', 09:48:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:17 INFO - 'config_files': ('talos/linux_config.py',), 09:48:17 INFO - 'default_actions': ('clobber', 09:48:17 INFO - 'read-buildbot-config', 09:48:17 INFO - 'download-and-extract', 09:48:17 INFO - 'populate-webroot', 09:48:17 INFO - 'create-virtualenv', 09:48:17 INFO - 'install', 09:48:17 INFO - 'run-tests'), 09:48:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:17 INFO - 'download_minidump_stackwalk': True, 09:48:17 INFO - 'download_symbols': 'ondemand', 09:48:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:17 INFO - 'installer_path': 'installer.exe', 09:48:17 INFO - 'log_level': 'info', 09:48:17 INFO - 'log_name': 'talos', 09:48:17 INFO - 'log_to_console': True, 09:48:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:17 INFO - 'opt_config_files': (), 09:48:17 INFO - 'pip_index': False, 09:48:17 INFO - 'sps_profile': False, 09:48:17 INFO - 'sps_profile_interval': 0, 09:48:17 INFO - 'suite': 'dromaeojs', 09:48:17 INFO - 'system_bits': '32', 09:48:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:17 INFO - 'title': 'talos-linux64-ix-024', 09:48:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:17 INFO - 'use_talos_json': True, 09:48:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:17 INFO - 'work_dir': 'build'} 09:48:17 INFO - ##### 09:48:17 INFO - ##### Running clobber step. 09:48:17 INFO - ##### 09:48:17 INFO - Running pre-action listener: _resource_record_pre_action 09:48:17 INFO - Running main action method: clobber 09:48:17 INFO - rmtree: /builds/slave/test/build 09:48:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:17 INFO - Running post-action listener: _resource_record_post_action 09:48:17 INFO - ##### 09:48:17 INFO - ##### Running read-buildbot-config step. 09:48:17 INFO - ##### 09:48:17 INFO - Running pre-action listener: _resource_record_pre_action 09:48:17 INFO - Running main action method: read_buildbot_config 09:48:17 INFO - Using buildbot properties: 09:48:17 INFO - { 09:48:17 INFO - "project": "", 09:48:17 INFO - "product": "firefox", 09:48:17 INFO - "script_repo_revision": "production", 09:48:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:48:17 INFO - "repository": "", 09:48:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:48:17 INFO - "buildid": "20160524065713", 09:48:17 INFO - "pgo_build": "True", 09:48:17 INFO - "basedir": "/builds/slave/test", 09:48:17 INFO - "buildnumber": 253, 09:48:17 INFO - "slavename": "talos-linux64-ix-024", 09:48:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:48:17 INFO - "platform": "ubuntu64_hw", 09:48:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:48:17 INFO - "branch": "mozilla-aurora", 09:48:17 INFO - "repo_path": "releases/mozilla-aurora", 09:48:17 INFO - "revision": "58f539121d2b6fe7d5a36d09b9a67314a2966e23", 09:48:17 INFO - "stage_platform": "linux64-pgo", 09:48:17 INFO - "builduid": "303562a2b4ca43de9d8997b6f45bfbf6", 09:48:17 INFO - "slavebuilddir": "test" 09:48:17 INFO - } 09:48:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 09:48:17 INFO - Running post-action listener: _resource_record_post_action 09:48:17 INFO - ##### 09:48:17 INFO - ##### Running download-and-extract step. 09:48:17 INFO - ##### 09:48:17 INFO - Running pre-action listener: _resource_record_pre_action 09:48:17 INFO - Running main action method: download_and_extract 09:48:17 INFO - mkdir: /builds/slave/test/build/tests 09:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:17 INFO - https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:48:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:48:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:48:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:48:19 INFO - Downloaded 1361 bytes. 09:48:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:48:19 INFO - Using the following test package requirements: 09:48:19 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:48:19 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:48:19 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:48:19 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'jsshell-linux-x86_64.zip'], 09:48:19 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:48:19 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:48:19 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:48:19 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:48:19 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:48:19 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:48:19 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:48:19 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:19 INFO - https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:20 INFO - Downloaded 24134934 bytes. 09:48:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:21 INFO - Return code: 0 09:48:21 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:21 INFO - https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:23 INFO - Downloaded 24134934 bytes. 09:48:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:24 INFO - Return code: 0 09:48: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')]} 09:48:24 INFO - https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:48:25 INFO - Downloaded 10840145 bytes. 09:48:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:48:25 INFO - Return code: 0 09:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:25 INFO - https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:48:27 INFO - Downloaded 62722445 bytes. 09:48:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:48:27 INFO - mkdir: /builds/slave/test/properties 09:48:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:27 INFO - Contents: 09:48:27 INFO - build_url:https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:48:28 INFO - Running post-action listener: _resource_record_post_action 09:48:28 INFO - Running post-action listener: set_extra_try_arguments 09:48:28 INFO - ##### 09:48:28 INFO - ##### Running populate-webroot step. 09:48:28 INFO - ##### 09:48:28 INFO - Running pre-action listener: _resource_record_pre_action 09:48:28 INFO - Running main action method: populate_webroot 09:48:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:28 INFO - '--tppagecycles', 09:48:28 INFO - '7'], 09:48:28 INFO - 'tests': ['tsvgm']}}, 09:48:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['damp', 'tps']}, 09:48:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'tests': ['damp', 'tps']}, 09:48:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['dromaeo_dom']}, 09:48:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['a11yr', 09:48:28 INFO - 'ts_paint', 09:48:28 INFO - 'tpaint', 09:48:28 INFO - 'sessionrestore', 09:48:28 INFO - 'sessionrestore_no_auto_restore', 09:48:28 INFO - 'tabpaint']}, 09:48:28 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:28 INFO - 'ts_paint', 09:48:28 INFO - 'tpaint', 09:48:28 INFO - 'sessionrestore', 09:48:28 INFO - 'sessionrestore_no_auto_restore', 09:48:28 INFO - 'tabpaint']}, 09:48:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:28 INFO - 'ts_paint', 09:48:28 INFO - 'tpaint', 09:48:28 INFO - 'sessionrestore', 09:48:28 INFO - 'sessionrestore_no_auto_restore', 09:48:28 INFO - 'tabpaint']}, 09:48:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:28 INFO - 'ts_paint', 09:48:28 INFO - 'tpaint', 09:48:28 INFO - 'sessionrestore', 09:48:28 INFO - 'sessionrestore_no_auto_restore', 09:48:28 INFO - 'tabpaint']}, 09:48:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['a11yr', 09:48:28 INFO - 'ts_paint', 09:48:28 INFO - 'tpaint', 09:48:28 INFO - 'sessionrestore', 09:48:28 INFO - 'sessionrestore_no_auto_restore', 09:48:28 INFO - 'tabpaint']}, 09:48:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['a11yr', 09:48:28 INFO - 'ts_paint', 09:48:28 INFO - 'tpaint', 09:48:28 INFO - 'sessionrestore', 09:48:28 INFO - 'sessionrestore_no_auto_restore', 09:48:28 INFO - 'tabpaint']}, 09:48:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['tsvgx', 09:48:28 INFO - 'tsvgr_opacity', 09:48:28 INFO - 'tart', 09:48:28 INFO - 'tscrollx', 09:48:28 INFO - 'cart']}, 09:48:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:28 INFO - 'tsvgr_opacity', 09:48:28 INFO - 'tart', 09:48:28 INFO - 'tscrollx', 09:48:28 INFO - 'cart']}, 09:48:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'talos_options': ['--disable-e10s'], 09:48:28 INFO - 'tests': ['tp5o']}, 09:48:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'tests': ['tp5o']}, 09:48:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'talos_options': ['--disable-e10s', 09:48:28 INFO - '--xperf_path', 09:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:28 INFO - 'tests': ['tp5n']}, 09:48:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:28 INFO - 'talos_options': ['--xperf_path', 09:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:28 INFO - 'tests': ['tp5n']}}, 09:48:28 INFO - 'talos.zip': {'path': '', 09:48:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:28 INFO - Running post-action listener: _resource_record_post_action 09:48:28 INFO - ##### 09:48:28 INFO - ##### Running create-virtualenv step. 09:48:28 INFO - ##### 09:48:28 INFO - Running pre-action listener: _resource_record_pre_action 09:48:28 INFO - Running main action method: create_virtualenv 09:48:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:28 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 09:48:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:28 INFO - Using real prefix '/usr' 09:48:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:30 INFO - Installing pip.................done. 09:48:30 INFO - Return code: 0 09:48:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:30 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')]} 09:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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')]} 09:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48:30 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 09:48:30 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 09:48:30 INFO - Using env: {'DISPLAY': ':0', 09:48:30 INFO - 'HOME': '/home/cltbld', 09:48:30 INFO - 'LANG': 'en_US.UTF-8', 09:48:30 INFO - 'LANGUAGE': 'en_US:en', 09:48:30 INFO - 'LOGNAME': 'cltbld', 09:48:30 INFO - 'MAIL': '/var/mail/cltbld', 09:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:30 INFO - 'MOZ_NO_REMOTE': '1', 09:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:30 INFO - 'NO_EM_RESTART': '1', 09:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:30 INFO - 'PWD': '/builds/slave/test', 09:48:30 INFO - 'SHELL': '/bin/bash', 09:48:30 INFO - 'SHLVL': '1', 09:48:30 INFO - 'TERM': 'linux', 09:48:30 INFO - 'TMOUT': '86400', 09:48:30 INFO - 'USER': 'cltbld', 09:48:30 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:30 INFO - '_': '/tools/buildbot/bin/python'} 09:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:31 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 09:48:31 INFO - Cleaning up... 09:48:31 INFO - Return code: 0 09:48:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48: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', 'psutil>=0.7.1'] in /builds/slave/test/build 09:48: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 psutil>=0.7.1 09:48:31 INFO - Using env: {'DISPLAY': ':0', 09:48:31 INFO - 'HOME': '/home/cltbld', 09:48:31 INFO - 'LANG': 'en_US.UTF-8', 09:48:31 INFO - 'LANGUAGE': 'en_US:en', 09:48:31 INFO - 'LOGNAME': 'cltbld', 09:48:31 INFO - 'MAIL': '/var/mail/cltbld', 09:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:31 INFO - 'MOZ_NO_REMOTE': '1', 09:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:31 INFO - 'NO_EM_RESTART': '1', 09:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:31 INFO - 'PWD': '/builds/slave/test', 09:48:31 INFO - 'SHELL': '/bin/bash', 09:48:31 INFO - 'SHLVL': '1', 09:48:31 INFO - 'TERM': 'linux', 09:48:31 INFO - 'TMOUT': '86400', 09:48:31 INFO - 'USER': 'cltbld', 09:48:31 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:31 INFO - '_': '/tools/buildbot/bin/python'} 09:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:31 INFO - Downloading/unpacking psutil>=0.7.1 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:33 INFO - Installing collected packages: psutil 09:48:33 INFO - Running setup.py install for psutil 09:48:33 INFO - building 'psutil._psutil_linux' extension 09:48:33 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 09:48:33 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 09:48:33 INFO - building 'psutil._psutil_posix' extension 09:48:33 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 09:48:33 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 09:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:33 INFO - Successfully installed psutil 09:48:33 INFO - Cleaning up... 09:48:33 INFO - Return code: 0 09:48:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:48:33 INFO - Using env: {'DISPLAY': ':0', 09:48:33 INFO - 'HOME': '/home/cltbld', 09:48:33 INFO - 'LANG': 'en_US.UTF-8', 09:48:33 INFO - 'LANGUAGE': 'en_US:en', 09:48:33 INFO - 'LOGNAME': 'cltbld', 09:48:33 INFO - 'MAIL': '/var/mail/cltbld', 09:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:33 INFO - 'MOZ_NO_REMOTE': '1', 09:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:33 INFO - 'NO_EM_RESTART': '1', 09:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:33 INFO - 'PWD': '/builds/slave/test', 09:48:33 INFO - 'SHELL': '/bin/bash', 09:48:33 INFO - 'SHLVL': '1', 09:48:33 INFO - 'TERM': 'linux', 09:48:33 INFO - 'TMOUT': '86400', 09:48:33 INFO - 'USER': 'cltbld', 09:48:33 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:33 INFO - '_': '/tools/buildbot/bin/python'} 09:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:48:36 INFO - Installing collected packages: mozsystemmonitor 09:48:36 INFO - Running setup.py install for mozsystemmonitor 09:48:36 INFO - Successfully installed mozsystemmonitor 09:48:36 INFO - Cleaning up... 09:48:36 INFO - Return code: 0 09:48:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:48:36 INFO - Using env: {'DISPLAY': ':0', 09:48:36 INFO - 'HOME': '/home/cltbld', 09:48:36 INFO - 'LANG': 'en_US.UTF-8', 09:48:36 INFO - 'LANGUAGE': 'en_US:en', 09:48:36 INFO - 'LOGNAME': 'cltbld', 09:48:36 INFO - 'MAIL': '/var/mail/cltbld', 09:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:36 INFO - 'MOZ_NO_REMOTE': '1', 09:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:36 INFO - 'NO_EM_RESTART': '1', 09:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:36 INFO - 'PWD': '/builds/slave/test', 09:48:36 INFO - 'SHELL': '/bin/bash', 09:48:36 INFO - 'SHLVL': '1', 09:48:36 INFO - 'TERM': 'linux', 09:48:36 INFO - 'TMOUT': '86400', 09:48:36 INFO - 'USER': 'cltbld', 09:48:36 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:36 INFO - '_': '/tools/buildbot/bin/python'} 09:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:39 INFO - Downloading docopt-0.6.1.tar.gz 09:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:39 INFO - Running setup.py install for blobuploader 09:48:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:39 INFO - Running setup.py install for requests 09:48:40 INFO - Running setup.py install for docopt 09:48:40 INFO - Successfully installed blobuploader requests docopt 09:48:40 INFO - Cleaning up... 09:48:40 INFO - Return code: 0 09:48:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48:40 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 09:48:40 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 09:48:40 INFO - Using env: {'DISPLAY': ':0', 09:48:40 INFO - 'HOME': '/home/cltbld', 09:48:40 INFO - 'LANG': 'en_US.UTF-8', 09:48:40 INFO - 'LANGUAGE': 'en_US:en', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MAIL': '/var/mail/cltbld', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SHLVL': '1', 09:48:40 INFO - 'TERM': 'linux', 09:48:40 INFO - 'TMOUT': '86400', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - '_': '/tools/buildbot/bin/python'} 09:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Running setup.py (path:/tmp/pip-EugpU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Running setup.py (path:/tmp/pip-bBcmFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Running setup.py (path:/tmp/pip-teEbps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Running setup.py (path:/tmp/pip-MyB5YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:40 INFO - Running setup.py (path:/tmp/pip-SSRFIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:40 INFO - Running setup.py (path:/tmp/pip-yPowxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:40 INFO - Running setup.py (path:/tmp/pip-Mhe0qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Running setup.py (path:/tmp/pip-Dfq93g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Running setup.py (path:/tmp/pip-sSRL5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Running setup.py (path:/tmp/pip-mIw6_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Running setup.py (path:/tmp/pip-7raxg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Running setup.py (path:/tmp/pip-zZJ26R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Running setup.py (path:/tmp/pip-7uegOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Running setup.py (path:/tmp/pip-lhI9Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:41 INFO - Running setup.py (path:/tmp/pip-mQmGVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:41 INFO - Running setup.py (path:/tmp/pip-rGZEgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:41 INFO - Running setup.py (path:/tmp/pip-sHrL7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:41 INFO - Running setup.py install for manifestparser 09:48:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:41 INFO - Running setup.py install for mozcrash 09:48:41 INFO - Running setup.py install for mozdebug 09:48:42 INFO - Running setup.py install for mozdevice 09:48:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozfile 09:48:42 INFO - Running setup.py install for mozhttpd 09:48:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozinfo 09:48:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozInstall 09:48:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozleak 09:48:42 INFO - Running setup.py install for mozlog 09:48:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for moznetwork 09:48:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozprocess 09:48:42 INFO - Running setup.py install for mozprofile 09:48:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozrunner 09:48:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozscreenshot 09:48:43 INFO - Running setup.py install for moztest 09:48:43 INFO - Running setup.py install for mozversion 09:48:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:43 INFO - Cleaning up... 09:48:43 INFO - Return code: 0 09:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:43 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 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48:43 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 09:48:43 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 09:48:43 INFO - Using env: {'DISPLAY': ':0', 09:48:43 INFO - 'HOME': '/home/cltbld', 09:48:43 INFO - 'LANG': 'en_US.UTF-8', 09:48:43 INFO - 'LANGUAGE': 'en_US:en', 09:48:43 INFO - 'LOGNAME': 'cltbld', 09:48:43 INFO - 'MAIL': '/var/mail/cltbld', 09:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:43 INFO - 'MOZ_NO_REMOTE': '1', 09:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:43 INFO - 'NO_EM_RESTART': '1', 09:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:43 INFO - 'PWD': '/builds/slave/test', 09:48:43 INFO - 'SHELL': '/bin/bash', 09:48:43 INFO - 'SHLVL': '1', 09:48:43 INFO - 'TERM': 'linux', 09:48:43 INFO - 'TMOUT': '86400', 09:48:43 INFO - 'USER': 'cltbld', 09:48:43 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:43 INFO - '_': '/tools/buildbot/bin/python'} 09:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:43 INFO - Running setup.py (path:/tmp/pip-pvhS9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:43 INFO - Running setup.py (path:/tmp/pip-fgfm4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:43 INFO - Running setup.py (path:/tmp/pip-YgXZVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:43 INFO - Running setup.py (path:/tmp/pip-DasV0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:44 INFO - Running setup.py (path:/tmp/pip-NSt7sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:44 INFO - Running setup.py (path:/tmp/pip-U9F5mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:44 INFO - Running setup.py (path:/tmp/pip-G8YzMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:44 INFO - Running setup.py (path:/tmp/pip-1t6Puo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:44 INFO - Running setup.py (path:/tmp/pip-n4RpVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:44 INFO - Running setup.py (path:/tmp/pip-qp8fLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:44 INFO - Running setup.py (path:/tmp/pip-FNdH_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:44 INFO - Running setup.py (path:/tmp/pip-hCGGaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:44 INFO - Running setup.py (path:/tmp/pip-9PHzLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:44 INFO - Running setup.py (path:/tmp/pip-xz6Ng0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:44 INFO - Running setup.py (path:/tmp/pip-SbhMaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:44 INFO - Running setup.py (path:/tmp/pip-Ts8llg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:44 INFO - Running setup.py (path:/tmp/pip-nK_S31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:46 INFO - Downloading blessings-1.6.tar.gz 09:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:46 INFO - Installing collected packages: blessings 09:48:46 INFO - Running setup.py install for blessings 09:48:47 INFO - Successfully installed blessings 09:48:47 INFO - Cleaning up... 09:48:47 INFO - Return code: 0 09:48:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:47 INFO - Reading from file tmpfile_stdout 09:48:47 INFO - Current package versions: 09:48:47 INFO - argparse == 1.2.1 09:48:47 INFO - blessings == 1.6 09:48:47 INFO - blobuploader == 1.2.4 09:48:47 INFO - docopt == 0.6.1 09:48:47 INFO - manifestparser == 1.1 09:48:47 INFO - mozInstall == 1.12 09:48:47 INFO - mozcrash == 0.17 09:48:47 INFO - mozdebug == 0.1 09:48:47 INFO - mozdevice == 0.48 09:48:47 INFO - mozfile == 1.2 09:48:47 INFO - mozhttpd == 0.7 09:48:47 INFO - mozinfo == 0.9 09:48:47 INFO - mozleak == 0.1 09:48:47 INFO - mozlog == 3.1 09:48:47 INFO - moznetwork == 0.27 09:48:47 INFO - mozprocess == 0.22 09:48:47 INFO - mozprofile == 0.28 09:48:47 INFO - mozrunner == 6.11 09:48:47 INFO - mozscreenshot == 0.1 09:48:47 INFO - mozsystemmonitor == 0.0 09:48:47 INFO - moztest == 0.7 09:48:47 INFO - mozversion == 1.4 09:48:47 INFO - psutil == 3.1.1 09:48:47 INFO - requests == 1.2.3 09:48:47 INFO - wsgiref == 0.1.2 09:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 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 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48:47 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 09:48:47 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 09:48:47 INFO - Using env: {'DISPLAY': ':0', 09:48:47 INFO - 'HOME': '/home/cltbld', 09:48:47 INFO - 'LANG': 'en_US.UTF-8', 09:48:47 INFO - 'LANGUAGE': 'en_US:en', 09:48:47 INFO - 'LOGNAME': 'cltbld', 09:48:47 INFO - 'MAIL': '/var/mail/cltbld', 09:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:47 INFO - 'MOZ_NO_REMOTE': '1', 09:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:47 INFO - 'NO_EM_RESTART': '1', 09:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:47 INFO - 'PWD': '/builds/slave/test', 09:48:47 INFO - 'SHELL': '/bin/bash', 09:48:47 INFO - 'SHLVL': '1', 09:48:47 INFO - 'TERM': 'linux', 09:48:47 INFO - 'TMOUT': '86400', 09:48:47 INFO - 'USER': 'cltbld', 09:48:47 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:47 INFO - '_': '/tools/buildbot/bin/python'} 09:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 INFO - Cleaning up... 09:48:47 INFO - Return code: 0 09:48:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:48:47 INFO - Using env: {'DISPLAY': ':0', 09:48:47 INFO - 'HOME': '/home/cltbld', 09:48:47 INFO - 'LANG': 'en_US.UTF-8', 09:48:47 INFO - 'LANGUAGE': 'en_US:en', 09:48:47 INFO - 'LOGNAME': 'cltbld', 09:48:47 INFO - 'MAIL': '/var/mail/cltbld', 09:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:47 INFO - 'MOZ_NO_REMOTE': '1', 09:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:47 INFO - 'NO_EM_RESTART': '1', 09:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:47 INFO - 'PWD': '/builds/slave/test', 09:48:47 INFO - 'SHELL': '/bin/bash', 09:48:47 INFO - 'SHLVL': '1', 09:48:47 INFO - 'TERM': 'linux', 09:48:47 INFO - 'TMOUT': '86400', 09:48:47 INFO - 'USER': 'cltbld', 09:48:47 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:47 INFO - '_': '/tools/buildbot/bin/python'} 09:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:47 INFO - Downloading/unpacking jsonschema 09:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:49 INFO - Downloading/unpacking functools32 (from jsonschema) 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:49 INFO - warning: no files found matching '*.txt' 09:48:49 INFO - no previously-included directories found matching 'build' 09:48:49 INFO - no previously-included directories found matching 'dist' 09:48:49 INFO - no previously-included directories found matching '.git*' 09:48:49 INFO - Installing collected packages: jsonschema, functools32 09:48:49 INFO - Running setup.py install for functools32 09:48:50 INFO - warning: no files found matching '*.txt' 09:48:50 INFO - no previously-included directories found matching 'build' 09:48:50 INFO - no previously-included directories found matching 'dist' 09:48:50 INFO - no previously-included directories found matching '.git*' 09:48:50 INFO - Successfully installed jsonschema functools32 09:48:50 INFO - Cleaning up... 09:48:50 INFO - Return code: 0 09:48:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac3cbb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, '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': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', '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 09:48: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', 'flake8'] in /builds/slave/test/build 09:48: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 flake8 09:48:50 INFO - Using env: {'DISPLAY': ':0', 09:48:50 INFO - 'HOME': '/home/cltbld', 09:48:50 INFO - 'LANG': 'en_US.UTF-8', 09:48:50 INFO - 'LANGUAGE': 'en_US:en', 09:48:50 INFO - 'LOGNAME': 'cltbld', 09:48:50 INFO - 'MAIL': '/var/mail/cltbld', 09:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:50 INFO - 'MOZ_NO_REMOTE': '1', 09:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:50 INFO - 'NO_EM_RESTART': '1', 09:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:50 INFO - 'PWD': '/builds/slave/test', 09:48:50 INFO - 'SHELL': '/bin/bash', 09:48:50 INFO - 'SHLVL': '1', 09:48:50 INFO - 'TERM': 'linux', 09:48:50 INFO - 'TMOUT': '86400', 09:48:50 INFO - 'USER': 'cltbld', 09:48:50 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:50 INFO - '_': '/tools/buildbot/bin/python'} 09:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:50 INFO - Downloading/unpacking flake8 09:48:50 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 09:48:50 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 09:48:50 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 09:48:50 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 09:48:50 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 09:48:50 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 09:48:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:48:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:48:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 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 09:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:52 INFO - no previously-included directories found matching 'docs/_build' 09:48:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:48:52 INFO - Running setup.py install for pep8 09:48:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:53 INFO - no previously-included directories found matching 'docs/_build' 09:48:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:48:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:48:53 INFO - Cleaning up... 09:48:53 INFO - Return code: 0 09:48:53 INFO - Running post-action listener: _resource_record_post_action 09:48:53 INFO - Running post-action listener: _start_resource_monitoring 09:48:53 INFO - Starting resource monitoring. 09:48:53 INFO - ##### 09:48:53 INFO - ##### Running install step. 09:48:53 INFO - ##### 09:48:53 INFO - Running pre-action listener: _resource_record_pre_action 09:48:53 INFO - Running main action method: install 09:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:53 INFO - Reading from file tmpfile_stdout 09:48:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:53 INFO - Reading from file tmpfile_stdout 09:48:53 INFO - Output received: 09:48:53 INFO - Usage: mozinstall [options] installer 09:48:53 INFO - Options: 09:48:53 INFO - -h, --help show this help message and exit 09:48:53 INFO - -d DEST, --destination=DEST 09:48:53 INFO - Directory to install application into. [default: 09:48:53 INFO - "/builds/slave/test"] 09:48:53 INFO - --app=APP Application being installed. [default: firefox] 09:48:53 INFO - mkdir: /builds/slave/test/build/application 09:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:49:09 INFO - Reading from file tmpfile_stdout 09:49:09 INFO - Output received: 09:49:09 INFO - /builds/slave/test/build/application/firefox/firefox 09:49:09 INFO - Running post-action listener: _resource_record_post_action 09:49:09 INFO - ##### 09:49:09 INFO - ##### Running run-tests step. 09:49:09 INFO - ##### 09:49:09 INFO - Running pre-action listener: _resource_record_pre_action 09:49:09 INFO - Running main action method: run_tests 09:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:09 INFO - Python 2.7.3 09:49:09 INFO - Return code: 0 09:49:09 INFO - grabbing minidump binary from tooltool 09:49:09 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')]} 09:49:09 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4d640>, '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 0x1b4e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:09 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 09:49:09 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 09:49:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:09 INFO - Return code: 0 09:49:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:49:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:49:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:49:10 INFO - Return code: 0 09:49:10 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/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 09:49:10 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/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 09:49:10 INFO - Using env: {'DISPLAY': ':0', 09:49:10 INFO - 'HOME': '/home/cltbld', 09:49:10 INFO - 'LANG': 'en_US.UTF-8', 09:49:10 INFO - 'LANGUAGE': 'en_US:en', 09:49:10 INFO - 'LOGNAME': 'cltbld', 09:49:10 INFO - 'MAIL': '/var/mail/cltbld', 09:49:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:10 INFO - 'MOZ_NO_REMOTE': '1', 09:49:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:10 INFO - 'NO_EM_RESTART': '1', 09:49:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:10 INFO - 'PWD': '/builds/slave/test', 09:49:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:10 INFO - 'SHELL': '/bin/bash', 09:49:10 INFO - 'SHLVL': '1', 09:49:10 INFO - 'TERM': 'linux', 09:49:10 INFO - 'TMOUT': '86400', 09:49:10 INFO - 'USER': 'cltbld', 09:49:10 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130', 09:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:10 INFO - '_': '/tools/buildbot/bin/python'} 09:49:10 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/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 09:49:10 INFO - mozversion application_buildid: 20160524065713 09:49:10 INFO - mozversion application_changeset: 58f539121d2b6fe7d5a36d09b9a67314a2966e23 09:49:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:49:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:10 INFO - mozversion application_name: Firefox 09:49:10 INFO - mozversion application_remotingname: firefox-dev 09:49:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:10 INFO - mozversion application_vendor: Mozilla 09:49:10 INFO - mozversion application_version: 48.0a2 09:49:10 INFO - mozversion platform_buildid: 20160524065713 09:49:10 INFO - mozversion platform_changeset: 58f539121d2b6fe7d5a36d09b9a67314a2966e23 09:49:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:10 INFO - mozversion platform_version: 48.0a2 09:49:10 INFO - using testdate: 1464108550 09:49:10 INFO - actual date: 1464108550 09:49:10 INFO - starting webserver on 'localhost:34133' 09:49:10 INFO - SUITE-START | Running 2 tests 09:49:10 INFO - TEST-START | dromaeo_css 09:49:10 INFO - operating with platform_type : linux_ 09:49:10 INFO - Initialising browser for dromaeo_css test... 09:49:10 INFO - TEST-INFO | started process 3896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmXuY91/profile http://localhost:34133/getInfo.html) 09:49:14 INFO - PROCESS | 3896 | __metrics Screen width/height:1600/1200 09:49:14 INFO - PROCESS | 3896 | colorDepth:24 09:49:14 INFO - PROCESS | 3896 | Browser inner width/height: 1024/697 09:49:14 INFO - PROCESS | 3896 | __metrics 09:49:15 ERROR - PROCESS | 3896 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:49:15 INFO - TEST-INFO | 3896: exit 0 09:49:15 INFO - Browser initialized. 09:49:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:15 INFO - TEST-INFO | started process 3990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmXuY91/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:27 INFO - PROCESS | 3990 | RSS: Main: 142004224 09:49:27 INFO - PROCESS | 3990 | 09:50:18 INFO - PROCESS | 3990 | 1464108618715 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] 09:52:26 INFO - PROCESS | 3990 | Cycle 1(1): loaded http://localhost:34133/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34133/tests/dromaeo/cssquery-ext.html) 09:52:27 INFO - PROCESS | 3990 | RSS: Main: 249794560 09:52:27 INFO - PROCESS | 3990 | 09:55:29 INFO - PROCESS | 3990 | Cycle 1(1): loaded http://localhost:34133/tests/dromaeo/cssquery-ext.html (next: http://localhost:34133/tests/dromaeo/cssquery-jquery.html) 09:55:30 INFO - PROCESS | 3990 | RSS: Main: 221466624 09:55:30 INFO - PROCESS | 3990 | 09:58:32 INFO - PROCESS | 3990 | Cycle 1(1): loaded http://localhost:34133/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34133/tests/dromaeo/cssquery-mootools.html) 09:58:32 INFO - PROCESS | 3990 | RSS: Main: 221208576 09:58:32 INFO - PROCESS | 3990 | 10:01:34 INFO - PROCESS | 3990 | Cycle 1(1): loaded http://localhost:34133/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34133/tests/dromaeo/cssquery-prototype.html) 10:01:35 INFO - PROCESS | 3990 | RSS: Main: 216006656 10:01:35 INFO - PROCESS | 3990 | 10:04:37 INFO - PROCESS | 3990 | Cycle 1(1): loaded http://localhost:34133/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34133/tests/dromaeo/cssquery-yui.html) 10:04:38 INFO - PROCESS | 3990 | RSS: Main: 184860672 10:04:38 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | Cycle 1(1): loaded http://localhost:34133/tests/dromaeo/cssquery-yui.html (next: http://localhost:34133/tests/dromaeo/cssquery-dojo.html) 10:07:40 INFO - PROCESS | 3990 | RSS: Main: 260526080 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | __start_tp_report 10:07:40 INFO - PROCESS | 3990 | _x_x_mozilla_page_load 10:07:40 INFO - PROCESS | 3990 | _x_x_mozilla_page_load_details 10:07:40 INFO - PROCESS | 3990 | |i|pagename|runs| 10:07:40 INFO - PROCESS | 3990 | |0;dojo.html;3301.7358611311097;3383.103477578442;3389.593248810143;3399.84700688469;3425.62318145004;5503.09198982168;5521.365043020054;5528.7788488460465;5545.639533430324;5567.192757050226;5528.695921724304;5561.360443548983;5564.610477266583;5572.554195664347;5603.523700485463;4992.600591952644;4994.850154495352;5084.084864724348;5123.333966584339;5142.537171654551;5013.899722005558;5075.086484432801;5080.79676812927;5085.66943148696;5086.898262034757;5094.235864620318;5162.457941916101;5186.611004174683;5188.429272779991;5226.947730522703;5043.344365232533;5064.645474816764;5070.391553013662;5077.898442031157;5091.643584949055;4859.149648811479;4952.306677065214;5002.099622068026;5006.873453472939;5020.5732512736095;5261.105612045923;5397.54120899724;5414.5668346532575;5437.211604317352;5452.291202143736;5975.342712301644;6013.338532761437;6030.246219222598;6032.547558933054;6038.63768173911;6034.849128771772;6039.335673075958;6084.154662623186;6088.512918966517;6097.725602347905;5633.943660563383;5681.602287839853;5685.744141513683;5687.74405151765;5723.77104915807;5919.940800592025;6191.25704915404;6208.161898143783;6210.31686514483;6214.098955651496;5912.17229587858;5959.404059594092;5960.403959604092;5969.343372229051;5973.133895585116;5860.589758716849;5862.267216597926;5866.12008198765;5867.530597552186;5868.149118377812;5830.650160990354;5835.35811060783;5838.562107841929;5843.474087332075;6000.849978750479;6041.9395806041375;6043.2748070231855;6043.516518678495;6043.788467403708;6075.5747097703625;4573.588377046081;4587.08258348325;4592.908141837144;4601.976990115028;4620.630349572026;3992.860249891298;3995.440638310639;4014.1570270243574;4098.057446787256;4133.21468920904;5645.802396916089;5676.602637815396;5678.772849086073;5680.744366503434;5702.54379649627;5970.820875373745;5973.074173503114;5975.492083172892;5975.641461512323;5991.340952495222;5632.718364081779;5666.518345940559;5676.517496012885;5734.197212390269;5820.505257053113;5045.697258164522;5054.898902021939;5055.039542486916;5057.8735531612;5071.949280507221;6022.57841951068;6025.578209525379;6025.758969641253;6030.547708921761;6083.7870674526175;5825.155352473952;5911.349751527243;5913.852153696192;5947.375525569752;5982.222311099703;6202.34875338083;6221.813345599639;6236.937795224482;6265.906011409741;6268.843278918063;5919.970400147971;5940.8811823764145;5941.970290148522;5942.970285148546;5980.684249465111;5878.706064696663;5891.823245302648;5959.91060134107;5964.850878727893;5990.7903223386975;5834.883302333845;5894.528437725057;5899.734511947058;5923.5853490256995;5947.821565353046;5724.4561766632105;5824.796132135355;5839.240898683144;5886.323072846506;5886.499647530008;5812.3025236971835;5851.882962340815;5858.062709966385;5861.413858614104;5894.0274854648505;5827.621204621686;5841.269841269841;5852.502537284208;5861.120831875082;5862.530997520103;5560;5668.829935101953;5725.255716756795;5735.684537350319;5776.480116789509 10:07:40 INFO - PROCESS | 3990 | |1;ext.html;610.7099127914241;652.3574279334855;667.229350100634;667.9899801502982;673.161913417795;32899.177520562;33748.83125584375;33761.493577596324;38836.61163388365;39686.80156599213;43194.784026079826;43479.3478097828;43621;43828.78085609576;43891;8108.472949258309;8842.204201621837;9011.234045106174;9013.729588112334;9022.233110185642;8237.670493180296;8375.246227839492;10663.520141593646;10946.507407166697;10951.069159121444;10717.089047430978;10754.408507532082;10784.245102842804;10807.135429165648;10810.35137891725;8142.47073940192;10921.508532116035;10991.945040274748;11014.50434730443;11015.669529914116;10362.481875906175;10551.103156231653;10552.15582753378;10564.577416903314;10568.577256909715;37330.253394932224;37807.62192378069;37834.24331513382;37847.432288515694;37958.43062354039;3819.236152769457;3822.140018495844;3840.3087444260022;3951.9012024699614;4243.554426785205;31606.841965790252;32155.678443215736;32244.193895152574;32428.675713243036;32473.188170295696;4585.977070114662;4641.930371044437;4668.906621867578;4701.48283688794;4717.056588682277;234308;236770;236905;237176;237757;68630;68963.31036689569;68975.31024689689;69139.30860691429;69256.307436926;60790;61697;61833;62000.37999619946;62852.05721914175;18364.357247496275;18483.075846207907;18581.16384762689;18591.25634974613;18592.907035464737;12751.808722869164;12758;12787.232766034067;13298.601041968757;13752.518661846787;20891.8955405222;21430.357089287347;21704.457388565414;21759.45601359947;21914.89042554809;7935.206479352134;8121.837563248702;8205.220504052106;8270.462419942685;8321.542315172603;1060.6711919304885;1078.7033565769477;1102.9411764705972;1176.1825531255695;1222.4865556466304;32069.839650802063;32499.675003250137;32827.835860820545;33056.3388732224;33733;1227.6056703215615;1228.7112528555783;1235.4996226528272;1245.894099001577;1271.7329360834144;17119;17510.29958801659;17614.735778963324;17707.516201078208;17945.641087178185;474537;479372;479744;480302;480852;60770.088448673305;61411.078833817526;61428.38571614316;61479.6926015376;61644;1376.3393571085935;1506.4877941499724;1522.9466968656043;1529.8852586056091;1545.8763298936058;30497;31294.217644558157;32023.679763202068;32205.838970804994;32271.35457290794;45177.774111129234;45660.771696142634;45725.77137114293;45831.31253031274;45864.77067614641;245950;250732;252645;252787;253090;27975.440491190468;30786.230344241572;31517.212069698442;33227.335453291285;33249.501257480675;47360.28959565678;48772.75613621909;50873.74563127309;51702.22446663379;52089;40591.39112913368;41020;41087.794561027;41336.1732765337;42151.36772948347;35057.48833892903;35925.28149437049;35940.82029589835;36206.637933620324;36731.81634091812;41830.58169418267;42061.57938420577;42149.789251053546;42460.363094554225;42844;35736.28527429385;36633.26733465263;36940.63059369372;37355.252894942496;37494.812525937195;28852;29292.41415171642;29327.853360733912;29420.411591767617;29562.704372955995 10:07:40 INFO - PROCESS | 3990 | |2;jquery.html;396.14432825097776;400.84968136948646;403.513765912076;411.81262525550875;412.5173546950068;14988.475403360884;16991.320347186127;18626.53433664159;19199.808001919977;19228.519287017833;16161;17673.91163044186;18291.268349266014;20273.797262027376;21001.47496312593;5619.971900140504;5733.856653583673;5779.335376431701;5784.797532086378;5796.24648795656;4452.421185245914;5753.5397168226655;5807.477327040566;6314;6600;6513.478921686277;6520.18497687789;6535.150430444036;6556.803295901131;6571.178602674666;6315.905261421082;6493.1558897343275;6572.07990881277;6576.704048317837;6579.243387010507;5809.82570522885;5823.475887170175;5826.941730582682;5831.88336233273;5835.649861008311;23244.3026709199;23281.883590582107;24151.396215094763;24234;24303.513929721306;2574.407886186169;2709.8509581972985;2814.845183514906;2850.3016760893506;2918.124562631202;13934.765997612769;14796.632538793849;15314.770278445832;15375.231238438146;15415.229238538028;1974.9901250493656;1997.10130441302;2016.9294074707461;2079.08520251089;2099.4016705238932;77225.61387193028;80312;82508.58745706292;82959.9999999994;83666;10661.520231589597;10834.729131771768;11026.393548354918;11086.487721983282;11087.611933582286;15129.47046853355;15280;15384.615384615474;15386.076835389913;15430.845691543165;8411.495310281403;8575.099614540384;8795.164459376349;8949.373543851998;9025.864612030824;7404.555726656418;8094.421587790324;8262.669493220325;8340.457870238415;8387.203215694499;6354.142190804275;6537.34626537352;6675.7997260082275;6809.863802723918;6812.352826481477;1841.5948491331885;1869.9158537865828;1873.185164453467;1896.7913529511743;1902.2391043582402;1011.1001208924064;1042.4370839746603;1111.4220605285207;1136.2046567402851;1215.6170806196196;19170.71243931342;19363.709544356847;19518;19880.90059549722;20040.498987525138;1074.2211896375065;1080.378782200238;1094.518411898762;1153.6654370232538;1183.479269121601;10919.3994330311;11485.655430337103;11530.711732206762;11568.652940411801;11576.42117894102;495141;496205;501554;504812;511468;83833.58083209545;84008.57995709982;85116.57441712751;85807.57096214479;87637;1152.7348709796627;1186.483879512415;1187.26389638423;1188.95966029724;1211.987880121205;17281;17436.47690569285;17674.734878976567;17726.379576714753;17905.462836114937;38604.420933685455;38777.806110969264;38810.41784373293;39169.804150979064;39243.2151356977;52377.214341785664;53050.469495304555;53169;53328.73335633297;53348.4665153359;8711.128887111492;8775.166359195866;8927.732168034969;9000;9024.413413128126;13261.933690331487;13560.728785424433;13586.116902401312;13733.793993089912;13873.653158671113;6926.757563485254;10233.9488302558;11657.18399712012;12009;12203.08476864221;11723.531058757895;11740.706482337668;11879.10906681985;11997.460114294703;12218.450169742206;11983.580574679845;12157.635270941886;12426.937865310978;12479.688007799878;12482.750344992868;8749.956250218707;8825.33809964268;8871.379003469696;8892.510911899908;8959.686410975584;11501.597444089417;11751.764964700487;11762.294262344287;12134.453949572115;12136.089793265364 10:07:40 INFO - PROCESS | 3990 | |3;mootools.html;1335.0162387064913;1400.579826052184;1431.8496557861426;1652.4133932453979;1936.1190658250498;7540.924590754091;7674.194209607987;7675.347595454379;7685.231476852319;7691.730789422358;7780.844383112349;7908.802279943005;7909.367250619951;7938.722144724921;7951.562664053475;2047.1708957872086;2284.463151159476;2286.302677683306;2300.64340027296;2332.8600283982933;2302.102180149743;2306.9733968384076;2317.4438134847683;2320.2807129789735;2323.860568365895;2218.6450167973126;2239.9776002240014;2263.094762095159;2272.3523795718224;2273.011240110549;2006.9899650501727;2267.535155293161;2307.861528308307;2323.3726893738767;2324.0239099578134;2275.2150508074687;2307.60770668985;2323.4423738302685;2323.779240972105;2328.138588722167;7689.038870141232;7697.884531732028;7706.7687969361;7711.730089446898;7712.6914923403;4808.182608956451;4887.70673759572;4889.266610008492;4894.021195760862;4911.165101932645;3202.6316973547873;3219.6780321967617;3266.1344743642953;3280.852361643732;3302.620198677135;1194.5221911235487;1197.479096592976;1226.3622916083675;1234.271779650002;1265.1966001588964;11096.500657470353;11178.608748693838;11186.105111591054;11190.832137517944;11200.047995920357;4332.350147477903;4388.341748737715;4396.9554157317;4418.381426600278;4442.977785111054;9499.38254013487;9558.856617150748;9568.47373394456;9579.952100239594;9588.520573971273;4493.078918821634;4991.126552853309;5006.774695138654;5011.123053465702;5015.122353588107;4547.15877562652;4643.257078867365;4686.179918514246;4719.59883409914;4742.549457801503;3887.8250478728523;3942.3495123304333;3966.3257246268204;4012.1775036117524;4083.7549747015273;1326.191023475679;1356.8439629442544;1358.7146699193281;1370.184740079651;1370.616227456314;819.8688209886509;886.1847100667402;899.3839220134229;903.5662881816764;905.5834316214483;5376.381716102698;5380.919286210632;5416.241726158341;5552.555795536347;5556.277683901067;1003.7490627343165;1048.0829274384914;1089.3899416326883;1160.9651710448532;1164.4527072276016;3767.4913886625504;3821.216650586623;3894.6300101490315;3903.4535165076913;3929.7052721046034;9487.241020718326;9641.710748677551;9668.661596844217;9816.705498835046;9882.703518894445;9658.613655453844;9667.371620844622;9703.708888733348;9738.415695058318;9748.805023899482;7799.3760499159935;7871.763847084597;8075.111737708848;8164.67341306353;8174.7956301092945;5508.256385387921;5539.584531160099;5628.155776633538;5704.80033198836;5754.424557544212;9190.724278271662;9293.30300227472;9304.255659547356;9404.623815047322;9428.198603118812;8747.081556436482;9122.452652840851;9136.817263654822;9297.395669281475;9485.620575177192;6554.606723596599;6695.765648202289;6731.057651928832;6953.513254072166;7000.334968178015;7681.769546913378;7834.529928204326;7839.294463498312;7846;7849.764507064797;7178.102737157856;7394.667239974322;7478.850422991619;7488.513246638951;7489.925100749141;7049.682764275517;7147.106611673541;7253.673584688807;7348.008018917378;7380.409567234716;6380.521460890359;6433.935660643334;6434.4852411806005;6450.193725784277;6450.193725784277;4669.369635099354;4686.203345431217;4741.83403580873;4815.783289751899;4936.827211047596;4643.303504474356;4653.022865198346;4709.529047095263;4710.4347478302825;4762.6189904808225 10:07:40 INFO - PROCESS | 3990 | |4;prototype.html;334.27128859087196;334.40642858925406;342.31366110947545;349.7044996977553;364.48607463476503;6296.401841825025;6310.716017779205;6317.652529110897;6326.588771729846;6336.398042185997;6023.36754640763;6132.509399248061;6305.8108256752375;6322.178116844803;6377;4811.037792441508;4841.56425921667;4849.175640141176;4850.514948505139;4853.538913803183;4826.469088400273;4847.175980083394;4856.465788763251;4857.29569212464;4866.6106711463;4571.862844114666;4641.93037104442;4732.077244937239;4736.313234581001;4738.170820106485;4766.451858036301;4777.259524773665;4780.187368147406;4800.135975524404;4804.495527969565;4197.307444271692;4206.2008218438705;4206.8737937861915;4206.894827629303;4211.115665710174;6062.484688801457;6079.726412311456;6081.665508397036;6083.209182806251;6085.847853803691;5604.607677462579;5606.523445507096;5611.803586874481;5614.747336369833;5615.708387070956;6486.837829054264;6656.833579160511;6662.633555154464;6666;6668.066470694107;4667.043256132485;4681.695689780154;4686.929696054562;4688.648351373627;4691.601213896823;6949.617771022592;6949.965250173767;6955.65221738911;6962.860742785167;6964.582125072512;4783.808647654055;4792.832250871203;4796.736179510161;4801.423829140525;4806.206975849016;4851.587615052689;4853.830115945995;4854.053459575349;4859.319695242669;4864.318995340655;5298.81454149103;5455.399906010336;5460.262864513319;5579.330480342385;5580.888382232414;6671.466282697373;6767.830804229934;6789.864202716017;6822.624755638488;6827.044213810071;1584.6592982508816;1604.2620394618607;1627.8372162783864;1643.3755173034172;1643.802743670767;1078.1698092468912;1091.841682955967;1094.0372472224392;1095.9780804384027;1096.2107282756403;6368.84077898047;6443.387878151568;6446.903296450557;6449.580777249464;6492.285848556655;6862.382385585322;6865.0732151159955;6866;6876.277990810993;6876.381125698711;6416.647084410402;6420.775272865428;6468.579542329733;6493.642849643315;6506.707198176094;3673.045008297808;3691.6492933171307;3704;3707.3697471429923;3713.4429835524347;7087.2558381370245;7125.144982602017;7275.308845659654;7277.563346199245;7301.634918254066;7170.8207294817;7182.8204294892;7195.064641596664;7199.604021778852;7199.928000719926;7248.238934911864;7261;7261.709531618676;7267.709291628487;7273.0908636420445;7011.754588589375;7017.789466316019;7018.438524918097;7025.402840758388;7029.718811247493;6781.796546103625;6935.237123916466;6935.618540980295;6939.965300173467;6955.026296318621;7219.8556028880175;7234.963825181051;7239.601821899846;7245.637718114179;7256.7097316106765;4542.523035081269;4560.156371071363;4562.087582483583;4564.224081906017;4565.06416184688;6742.157230346207;6982.301769822977;6982.79051628452;6993.965030174817;6996.125484314461;6657.434118100015;6811.8978215325815;6813.318668133147;6827.283135270725;6829.258539072504;6718.798436046926;6730.663466826737;6739.764108256188;6770.424513916372;6778.491613129134;6661.700223490052;6665.333466653296;6695.665216739046;6753.662316884234;6757.459403247827;6665.766698165541;6805.3875151236625;6844;6846.110005699227;6890.483213759088;6679.165104361955;6688.297728738413;6696.096027036482;6704;6704.932950670626 10:07:40 INFO - PROCESS | 3990 | |5;yui.html;827.3009307135468;832.3590835057006;848.4569875279822;875.0899064972429;875.4659657608858;13490.59528214154;13638.659033524142;13744.106633068843;13779.724405511895;13819.93090034551;14180.858191418109;15827.287772050257;16077;16111.677766444664;16133.193340332995;911.2209061252616;920.1902325953151;926.4024704065873;926.5645146781002;926.8517037274038;754.4454825703132;914.3325372478095;930.9394889332206;933.0343094896783;936.0732874454309;956.0678338619825;957.6121670723368;959.9472029038435;960.0591420408005;960.7646126698934;780.9882851757171;953.1374106433689;957.6265256549916;958.3531116496372;958.6117622362954;687.295522089862;697.745322957117;697.7801992372387;697.8325201951545;697.8988046733245;14333.354999025069;14453.78319325211;14511.274436278143;14535.854641453556;14565;13242.139260948008;13626.59120226385;13725.039247252696;13890.861091389057;14133.929330353283;11758.941205294004;11850.3482308473;12000.09999250051;12041.337726425043;12099.87900121005;3985.2826491231567;4036.374361973899;4050.8784736457956;4056.8377264909664;4099.385092236159;61386;61515.69242153806;61602.69198653978;61793.38206617921;61817.69091154561;10221.33561318512;10260.897391025994;10282.794344113225;10641.255112142077;10669.03978641926;17803.19885605151;17819.554511137325;17838.37565685195;17899.552511187063;18000.9099954502;8364.623591938378;8375.623096960651;8531.872021919677;8533.767904963865;8816.250618697355;4750.121227572841;4772.427308722976;4794.304825800239;5053;5068.594512438996;3521.137321356233;3567;3568.750187486851;3571.714262859017;3574.428091505347;646.8447572582546;654.2900952466532;657.7599176300616;659.1365311442026;674.3391476353202;755.75815738963;766.4749646492171;796.7012370361115;808.1635507249968;827.148037521354;9058.32062595308;9098.31762617793;9176.81646367069;9199.494027828534;9307.3019523536;705.9011738356634;740.4853626729479;751.8909758085047;758.8823732321499;762.4777027735907;4104.979475102606;4291.74249545022;4304.978475107667;4364.890877728082;4527.388802511618;58781;60008.09987850186;60019.69990150109;62927.6853615729;63335.36664633387;51526.74236628793;52696.20955685591;53281.733591331795;53741.73129134329;54062;50637.240441393405;51351.229731554056;51608.22587661188;52099.99999999924;53062.204066939026;9312.906870931203;9434;9441.763955900882;9442.669506567237;9494.240460762985;37722.43416348702;38131.23737525178;38663;39636;39843;46854.53145468501;50171.24743128929;50303.245451318995;54044.45955540394;54489.72755136199;12916.160449570747;13210.207387556777;13659.79510307366;13722.45110195581;14291.285435727965;14032.22822744759;14301.35643896048;14376.928115359357;14480.710385792436;15115.244237788287;11098.5560577576;13633.182009079486;13687.931560342135;13991.510297139552;14226.288685565472;11694.88305116938;11738.70653233676;11754.764904701688;11930.76138477243;12089.455974481345;13177.407016684463;13234.139780914209;13235.735285294048;13340.933295333462;13573.253471059186;9964.320467077465;10239.180865530889;10365.274430789772;10548.208884333859;10942.398168100832;10754.623588174376;10893.56425742993;11108.166887483632;11497.367644779282;11505.827412588986 10:07:40 INFO - PROCESS | 3990 | __end_tp_report 10:07:40 INFO - PROCESS | 3990 | __start_cc_report 10:07:40 INFO - PROCESS | 3990 | _x_x_mozilla_cycle_collect,835 10:07:40 INFO - PROCESS | 3990 | __end_cc_report 10:07:40 INFO - PROCESS | 3990 | __startTimestamp1464109660793__endTimestamp 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | ------- Summary: start ------- 10:07:40 INFO - PROCESS | 3990 | Number of tests: 6 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | [#0] dojo.html Cycles:165 Average:5549.69 Median:5824.80 stddev:621.04 (10.7%) stddev-sans-first:597.38 10:07:40 INFO - PROCESS | 3990 | Values: 3301.7 3383.1 3389.6 3399.8 3425.6 5503.1 5521.4 5528.8 5545.6 5567.2 5528.7 5561.4 5564.6 5572.6 5603.5 4992.6 4994.9 5084.1 5123.3 5142.5 5013.9 5075.1 5080.8 5085.7 5086.9 5094.2 5162.5 5186.6 5188.4 5226.9 5043.3 5064.6 5070.4 5077.9 5091.6 4859.1 4952.3 5002.1 5006.9 5020.6 5261.1 5397.5 5414.6 5437.2 5452.3 5975.3 6013.3 6030.2 6032.5 6038.6 6034.8 6039.3 6084.2 6088.5 6097.7 5633.9 5681.6 5685.7 5687.7 5723.8 5919.9 6191.3 6208.2 6210.3 6214.1 5912.2 5959.4 5960.4 5969.3 5973.1 5860.6 5862.3 5866.1 5867.5 5868.1 5830.7 5835.4 5838.6 5843.5 6000.8 6041.9 6043.3 6043.5 6043.8 6075.6 4573.6 4587.1 4592.9 4602.0 4620.6 3992.9 3995.4 4014.2 4098.1 4133.2 5645.8 5676.6 5678.8 5680.7 5702.5 5970.8 5973.1 5975.5 5975.6 5991.3 5632.7 5666.5 5676.5 5734.2 5820.5 5045.7 5054.9 5055.0 5057.9 5071.9 6022.6 6025.6 6025.8 6030.5 6083.8 5825.2 5911.3 5913.9 5947.4 5982.2 6202.3 6221.8 6236.9 6265.9 6268.8 5920.0 5940.9 5942.0 5943.0 5980.7 5878.7 5891.8 5959.9 5964.9 5990.8 5834.9 5894.5 5899.7 5923.6 5947.8 5724.5 5824.8 5839.2 5886.3 5886.5 5812.3 5851.9 5858.1 5861.4 5894.0 5827.6 5841.3 5852.5 5861.1 5862.5 5560.0 5668.8 5725.3 5735.7 5776.5 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | [#1] ext.html Cycles:180 Average:50769.30 Median:35396.89 stddev:90033.61 (254.4%) stddev-sans-first:90207.41 10:07:40 INFO - PROCESS | 3990 | Values: 610.7 652.4 667.2 668.0 673.2 32899.2 33748.8 33761.5 38836.6 39686.8 43194.8 43479.3 43621.0 43828.8 43891.0 8108.5 8842.2 9011.2 9013.7 9022.2 8237.7 8375.2 10663.5 10946.5 10951.1 10717.1 10754.4 10784.2 10807.1 10810.4 8142.5 10921.5 10991.9 11014.5 11015.7 10362.5 10551.1 10552.2 10564.6 10568.6 37330.3 37807.6 37834.2 37847.4 37958.4 3819.2 3822.1 3840.3 3951.9 4243.6 31606.8 32155.7 32244.2 32428.7 32473.2 4586.0 4641.9 4668.9 4701.5 4717.1 234308.0 236770.0 236905.0 237176.0 237757.0 68630.0 68963.3 68975.3 69139.3 69256.3 60790.0 61697.0 61833.0 62000.4 62852.1 18364.4 18483.1 18581.2 18591.3 18592.9 12751.8 12758.0 12787.2 13298.6 13752.5 20891.9 21430.4 21704.5 21759.5 21914.9 7935.2 8121.8 8205.2 8270.5 8321.5 1060.7 1078.7 1102.9 1176.2 1222.5 32069.8 32499.7 32827.8 33056.3 33733.0 1227.6 1228.7 1235.5 1245.9 1271.7 17119.0 17510.3 17614.7 17707.5 17945.6 474537.0 479372.0 479744.0 480302.0 480852.0 60770.1 61411.1 61428.4 61479.7 61644.0 1376.3 1506.5 1522.9 1529.9 1545.9 30497.0 31294.2 32023.7 32205.8 32271.4 45177.8 45660.8 45725.8 45831.3 45864.8 245950.0 250732.0 252645.0 252787.0 253090.0 27975.4 30786.2 31517.2 33227.3 33249.5 47360.3 48772.8 50873.7 51702.2 52089.0 40591.4 41020.0 41087.8 41336.2 42151.4 35057.5 35925.3 35940.8 36206.6 36731.8 41830.6 42061.6 42149.8 42460.4 42844.0 35736.3 36633.3 36940.6 37355.3 37494.8 28852.0 29292.4 29327.9 29420.4 29562.7 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | [#2] jquery.html Cycles:180 Average:29250.46 Median:23716.64 stddev:82426.16 (347.5%) stddev-sans-first:82628.91 10:07:40 INFO - PROCESS | 3990 | Values: 396.1 400.8 403.5 411.8 412.5 14988.5 16991.3 18626.5 19199.8 19228.5 16161.0 17673.9 18291.3 20273.8 21001.5 5620.0 5733.9 5779.3 5784.8 5796.2 4452.4 5753.5 5807.5 6314.0 6600.0 6513.5 6520.2 6535.2 6556.8 6571.2 6315.9 6493.2 6572.1 6576.7 6579.2 5809.8 5823.5 5826.9 5831.9 5835.6 23244.3 23281.9 24151.4 24234.0 24303.5 2574.4 2709.9 2814.8 2850.3 2918.1 13934.8 14796.6 15314.8 15375.2 15415.2 1975.0 1997.1 2016.9 2079.1 2099.4 77225.6 80312.0 82508.6 82960.0 83666.0 10661.5 10834.7 11026.4 11086.5 11087.6 15129.5 15280.0 15384.6 15386.1 15430.8 8411.5 8575.1 8795.2 8949.4 9025.9 7404.6 8094.4 8262.7 8340.5 8387.2 6354.1 6537.3 6675.8 6809.9 6812.4 1841.6 1869.9 1873.2 1896.8 1902.2 1011.1 1042.4 1111.4 1136.2 1215.6 19170.7 19363.7 19518.0 19880.9 20040.5 1074.2 1080.4 1094.5 1153.7 1183.5 10919.4 11485.7 11530.7 11568.7 11576.4 495141.0 496205.0 501554.0 504812.0 511468.0 83833.6 84008.6 85116.6 85807.6 87637.0 1152.7 1186.5 1187.3 1189.0 1212.0 17281.0 17436.5 17674.7 17726.4 17905.5 38604.4 38777.8 38810.4 39169.8 39243.2 52377.2 53050.5 53169.0 53328.7 53348.5 8711.1 8775.2 8927.7 9000.0 9024.4 13261.9 13560.7 13586.1 13733.8 13873.7 6926.8 10233.9 11657.2 12009.0 12203.1 11723.5 11740.7 11879.1 11997.5 12218.5 11983.6 12157.6 12426.9 12479.7 12482.8 8750.0 8825.3 8871.4 8892.5 8959.7 11501.6 11751.8 11762.3 12134.5 12136.1 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | [#3] mootools.html Cycles:180 Average:5375.80 Median:4963.98 stddev:2921.19 (58.8%) stddev-sans-first:2913.60 10:07:40 INFO - PROCESS | 3990 | Values: 1335.0 1400.6 1431.8 1652.4 1936.1 7540.9 7674.2 7675.3 7685.2 7691.7 7780.8 7908.8 7909.4 7938.7 7951.6 2047.2 2284.5 2286.3 2300.6 2332.9 2302.1 2307.0 2317.4 2320.3 2323.9 2218.6 2240.0 2263.1 2272.4 2273.0 2007.0 2267.5 2307.9 2323.4 2324.0 2275.2 2307.6 2323.4 2323.8 2328.1 7689.0 7697.9 7706.8 7711.7 7712.7 4808.2 4887.7 4889.3 4894.0 4911.2 3202.6 3219.7 3266.1 3280.9 3302.6 1194.5 1197.5 1226.4 1234.3 1265.2 11096.5 11178.6 11186.1 11190.8 11200.0 4332.4 4388.3 4397.0 4418.4 4443.0 9499.4 9558.9 9568.5 9580.0 9588.5 4493.1 4991.1 5006.8 5011.1 5015.1 4547.2 4643.3 4686.2 4719.6 4742.5 3887.8 3942.3 3966.3 4012.2 4083.8 1326.2 1356.8 1358.7 1370.2 1370.6 819.9 886.2 899.4 903.6 905.6 5376.4 5380.9 5416.2 5552.6 5556.3 1003.7 1048.1 1089.4 1161.0 1164.5 3767.5 3821.2 3894.6 3903.5 3929.7 9487.2 9641.7 9668.7 9816.7 9882.7 9658.6 9667.4 9703.7 9738.4 9748.8 7799.4 7871.8 8075.1 8164.7 8174.8 5508.3 5539.6 5628.2 5704.8 5754.4 9190.7 9293.3 9304.3 9404.6 9428.2 8747.1 9122.5 9136.8 9297.4 9485.6 6554.6 6695.8 6731.1 6953.5 7000.3 7681.8 7834.5 7839.3 7846.0 7849.8 7178.1 7394.7 7478.9 7488.5 7489.9 7049.7 7147.1 7253.7 7348.0 7380.4 6380.5 6433.9 6434.5 6450.2 6450.2 4669.4 4686.2 4741.8 4815.8 4936.8 4643.3 4653.0 4709.5 4710.4 4762.6 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | [#4] prototype.html Cycles:180 Average:5621.77 Median:6396.82 stddev:1723.87 (26.9%) stddev-sans-first:1682.40 10:07:40 INFO - PROCESS | 3990 | Values: 334.3 334.4 342.3 349.7 364.5 6296.4 6310.7 6317.7 6326.6 6336.4 6023.4 6132.5 6305.8 6322.2 6377.0 4811.0 4841.6 4849.2 4850.5 4853.5 4826.5 4847.2 4856.5 4857.3 4866.6 4571.9 4641.9 4732.1 4736.3 4738.2 4766.5 4777.3 4780.2 4800.1 4804.5 4197.3 4206.2 4206.9 4206.9 4211.1 6062.5 6079.7 6081.7 6083.2 6085.8 5604.6 5606.5 5611.8 5614.7 5615.7 6486.8 6656.8 6662.6 6666.0 6668.1 4667.0 4681.7 4686.9 4688.6 4691.6 6949.6 6950.0 6955.7 6962.9 6964.6 4783.8 4792.8 4796.7 4801.4 4806.2 4851.6 4853.8 4854.1 4859.3 4864.3 5298.8 5455.4 5460.3 5579.3 5580.9 6671.5 6767.8 6789.9 6822.6 6827.0 1584.7 1604.3 1627.8 1643.4 1643.8 1078.2 1091.8 1094.0 1096.0 1096.2 6368.8 6443.4 6446.9 6449.6 6492.3 6862.4 6865.1 6866.0 6876.3 6876.4 6416.6 6420.8 6468.6 6493.6 6506.7 3673.0 3691.6 3704.0 3707.4 3713.4 7087.3 7125.1 7275.3 7277.6 7301.6 7170.8 7182.8 7195.1 7199.6 7199.9 7248.2 7261.0 7261.7 7267.7 7273.1 7011.8 7017.8 7018.4 7025.4 7029.7 6781.8 6935.2 6935.6 6940.0 6955.0 7219.9 7235.0 7239.6 7245.6 7256.7 4542.5 4560.2 4562.1 4564.2 4565.1 6742.2 6982.3 6982.8 6994.0 6996.1 6657.4 6811.9 6813.3 6827.3 6829.3 6718.8 6730.7 6739.8 6770.4 6778.5 6661.7 6665.3 6695.7 6753.7 6757.5 6665.8 6805.4 6844.0 6846.1 6890.5 6679.2 6688.3 6696.1 6704.0 6704.9 10:07:40 INFO - PROCESS | 3990 | 10:07:40 INFO - PROCESS | 3990 | [#5] yui.html Cycles:180 Average:15407.19 Median:4761.27 stddev:17887.08 (375.7%) stddev-sans-first:17903.75 10:07:40 INFO - PROCESS | 3990 | Values: 827.3 832.4 848.5 875.1 875.5 13490.6 13638.7 13744.1 13779.7 13819.9 14180.9 15827.3 16077.0 16111.7 16133.2 911.2 920.2 926.4 926.6 926.9 754.4 914.3 930.9 933.0 936.1 956.1 957.6 959.9 960.1 960.8 781.0 953.1 957.6 958.4 958.6 687.3 697.7 697.8 697.8 697.9 14333.4 14453.8 14511.3 14535.9 14565.0 13242.1 13626.6 13725.0 13890.9 14133.9 11758.9 11850.3 12000.1 12041.3 12099.9 3985.3 4036.4 4050.9 4056.8 4099.4 61386.0 61515.7 61602.7 61793.4 61817.7 10221.3 10260.9 10282.8 10641.3 10669.0 17803.2 17819.6 17838.4 17899.6 18000.9 8364.6 8375.6 8531.9 8533.8 8816.3 4750.1 4772.4 4794.3 5053.0 5068.6 3521.1 3567.0 3568.8 3571.7 3574.4 646.8 654.3 657.8 659.1 674.3 755.8 766.5 796.7 808.2 827.1 9058.3 9098.3 9176.8 9199.5 9307.3 705.9 740.5 751.9 758.9 762.5 4105.0 4291.7 4305.0 4364.9 4527.4 58781.0 60008.1 60019.7 62927.7 63335.4 51526.7 52696.2 53281.7 53741.7 54062.0 50637.2 51351.2 51608.2 52100.0 53062.2 9312.9 9434.0 9441.8 9442.7 9494.2 37722.4 38131.2 38663.0 39636.0 39843.0 46854.5 50171.2 50303.2 54044.5 54489.7 12916.2 13210.2 13659.8 13722.5 14291.3 14032.2 14301.4 14376.9 14480.7 15115.2 11098.6 13633.2 13687.9 13991.5 14226.3 11694.9 11738.7 11754.8 11930.8 12089.5 13177.4 13234.1 13235.7 13340.9 13573.3 9964.3 10239.2 10365.3 10548.2 10942.4 10754.6 10893.6 11108.2 11497.4 11505.8 10:07:40 INFO - PROCESS | 3990 | -------- Summary: end -------- 10:07:40 INFO - PROCESS | 3990 | 10:07:41 INFO - TEST-INFO | 3990: exit 0 10:07:41 INFO - TEST-OK | dromaeo_css | took 1111225ms 10:07:41 INFO - TEST-START | kraken 10:07:41 INFO - operating with platform_type : linux_ 10:07:41 INFO - Initialising browser for kraken test... 10:07:41 INFO - TEST-INFO | started process 4179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7TWBOq/profile http://localhost:34133/getInfo.html) 10:07:45 INFO - PROCESS | 4179 | __metrics Screen width/height:1600/1200 10:07:45 INFO - PROCESS | 4179 | colorDepth:24 10:07:45 INFO - PROCESS | 4179 | Browser inner width/height: 1024/697 10:07:45 INFO - PROCESS | 4179 | __metrics 10:07:46 ERROR - PROCESS | 4179 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:07:46 INFO - TEST-INFO | 4179: exit 0 10:07:46 INFO - Browser initialized. 10:07:46 INFO - Running cycle 1/1 for kraken test... 10:07:46 INFO - TEST-INFO | started process 4269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7TWBOq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:58 INFO - PROCESS | 4269 | RSS: Main: 141754368 10:07:58 INFO - PROCESS | 4269 | 10:08:01 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34133/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:02 INFO - PROCESS | 4269 | RSS: Main: 196530176 10:08:02 INFO - PROCESS | 4269 | 10:08:04 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34133/tests/kraken/driver.html?testName=audio-dft) 10:08:05 INFO - PROCESS | 4269 | RSS: Main: 181673984 10:08:05 INFO - PROCESS | 4269 | 10:08:08 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34133/tests/kraken/driver.html?testName=audio-fft) 10:08:08 INFO - PROCESS | 4269 | RSS: Main: 273059840 10:08:08 INFO - PROCESS | 4269 | 10:08:10 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34133/tests/kraken/driver.html?testName=audio-oscillator) 10:08:11 INFO - PROCESS | 4269 | RSS: Main: 179585024 10:08:11 INFO - PROCESS | 4269 | 10:08:13 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34133/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:14 INFO - PROCESS | 4269 | RSS: Main: 177647616 10:08:14 INFO - PROCESS | 4269 | 10:08:17 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34133/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:17 INFO - PROCESS | 4269 | RSS: Main: 212680704 10:08:17 INFO - PROCESS | 4269 | 10:08:21 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34133/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:21 INFO - PROCESS | 4269 | RSS: Main: 210890752 10:08:21 INFO - PROCESS | 4269 | 10:08:24 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34133/tests/kraken/driver.html?testName=json-parse-financial) 10:08:24 INFO - PROCESS | 4269 | RSS: Main: 211775488 10:08:24 INFO - PROCESS | 4269 | 10:08:26 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34133/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:27 INFO - PROCESS | 4269 | RSS: Main: 191229952 10:08:27 INFO - PROCESS | 4269 | 10:08:28 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:29 INFO - PROCESS | 4269 | RSS: Main: 193888256 10:08:29 INFO - PROCESS | 4269 | 10:08:31 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:31 INFO - PROCESS | 4269 | RSS: Main: 210145280 10:08:31 INFO - PROCESS | 4269 | 10:08:34 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:34 INFO - PROCESS | 4269 | RSS: Main: 215408640 10:08:34 INFO - PROCESS | 4269 | 10:08:37 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:38 INFO - PROCESS | 4269 | RSS: Main: 212213760 10:08:38 INFO - PROCESS | 4269 | 10:08:39 INFO - PROCESS | 4269 | Cycle 1(1): loaded http://localhost:34133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34133/tests/kraken/driver.html?testName=ai-astar) 10:08:40 INFO - PROCESS | 4269 | RSS: Main: 276398080 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | __start_tp_report 10:08:40 INFO - PROCESS | 4269 | _x_x_mozilla_page_load 10:08:40 INFO - PROCESS | 4269 | _x_x_mozilla_page_load_details 10:08:40 INFO - PROCESS | 4269 | |i|pagename|runs| 10:08:40 INFO - PROCESS | 4269 | |0;ai-astar;112;113;112;109;112;111;107;110;110;112 10:08:40 INFO - PROCESS | 4269 | |1;audio-beat-detection;157;125;157;179;129;153;160;127;188;130 10:08:40 INFO - PROCESS | 4269 | |2;audio-dft;162;162;162;159;160;162;159;163;157;158 10:08:40 INFO - PROCESS | 4269 | |3;audio-fft;75;77;77;164;75;76;74;75;169;74 10:08:40 INFO - PROCESS | 4269 | |4;audio-oscillator;92;93;155;91;92;93;144;91;92;139 10:08:40 INFO - PROCESS | 4269 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;116 10:08:40 INFO - PROCESS | 4269 | |6;imaging-darkroom;145;145;147;145;146;146;145;145;146;145 10:08:40 INFO - PROCESS | 4269 | |7;imaging-desaturate;95;94;95;94;95;95;95;95;95;95 10:08:40 INFO - PROCESS | 4269 | |8;json-parse-financial;55;56;54;56;54;55;57;75;54;52 10:08:40 INFO - PROCESS | 4269 | |9;json-stringify-tinderbox;60;58;58;58;59;61;57;58;60;58 10:08:40 INFO - PROCESS | 4269 | |10;stanford-crypto-aes;85;73;73;74;73;74;74;75;76;75 10:08:40 INFO - PROCESS | 4269 | |11;stanford-crypto-ccm;118;116;113;111;111;109;110;114;135;132 10:08:40 INFO - PROCESS | 4269 | |12;stanford-crypto-pbkdf2;156;159;161;160;164;159;157;169;160;159 10:08:40 INFO - PROCESS | 4269 | |13;stanford-crypto-sha256-iterative;69;66;67;66;67;64;66;66;67;63 10:08:40 INFO - PROCESS | 4269 | __end_tp_report 10:08:40 INFO - PROCESS | 4269 | __start_cc_report 10:08:40 INFO - PROCESS | 4269 | _x_x_mozilla_cycle_collect,1585 10:08:40 INFO - PROCESS | 4269 | __end_cc_report 10:08:40 INFO - PROCESS | 4269 | __startTimestamp1464109720215__endTimestamp 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | ------- Summary: start ------- 10:08:40 INFO - PROCESS | 4269 | Number of tests: 14 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:1.81 (1.6%) stddev-sans-first:1.87 10:08:40 INFO - PROCESS | 4269 | Values: 112.0 113.0 112.0 109.0 112.0 111.0 107.0 110.0 110.0 112.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:157.00 stddev:22.32 (14.2%) stddev-sans-first:23.55 10:08:40 INFO - PROCESS | 4269 | Values: 157.0 125.0 157.0 179.0 129.0 153.0 160.0 127.0 188.0 130.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#2] audio-dft Cycles:10 Average:160.40 Median:162.00 stddev:2.07 (1.3%) stddev-sans-first:2.11 10:08:40 INFO - PROCESS | 4269 | Values: 162.0 162.0 162.0 159.0 160.0 162.0 159.0 163.0 157.0 158.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:38.45 (51.3%) stddev-sans-first:40.19 10:08:40 INFO - PROCESS | 4269 | Values: 75.0 77.0 77.0 164.0 75.0 76.0 74.0 75.0 169.0 74.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.00 stddev:26.38 (28.7%) stddev-sans-first:27.32 10:08:40 INFO - PROCESS | 4269 | Values: 92.0 93.0 155.0 91.0 92.0 93.0 144.0 91.0 92.0 139.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:08:40 INFO - PROCESS | 4269 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 10:08:40 INFO - PROCESS | 4269 | Values: 145.0 145.0 147.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:08:40 INFO - PROCESS | 4269 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:55.50 stddev:6.55 (11.8%) stddev-sans-first:6.91 10:08:40 INFO - PROCESS | 4269 | Values: 55.0 56.0 54.0 56.0 54.0 55.0 57.0 75.0 54.0 52.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.50 stddev:1.25 (2.1%) stddev-sans-first:1.24 10:08:40 INFO - PROCESS | 4269 | Values: 60.0 58.0 58.0 58.0 59.0 61.0 57.0 58.0 60.0 58.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:74.50 stddev:3.58 (4.8%) stddev-sans-first:1.05 10:08:40 INFO - PROCESS | 4269 | Values: 85.0 73.0 73.0 74.0 73.0 74.0 74.0 75.0 76.0 75.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:115.00 stddev:9.19 (8.0%) stddev-sans-first:9.74 10:08:40 INFO - PROCESS | 4269 | Values: 118.0 116.0 113.0 111.0 111.0 109.0 110.0 114.0 135.0 132.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:3.72 (2.3%) stddev-sans-first:3.59 10:08:40 INFO - PROCESS | 4269 | Values: 156.0 159.0 161.0 160.0 164.0 159.0 157.0 169.0 160.0 159.0 10:08:40 INFO - PROCESS | 4269 | 10:08:40 INFO - PROCESS | 4269 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.66 (2.5%) stddev-sans-first:1.39 10:08:40 INFO - PROCESS | 4269 | Values: 69.0 66.0 67.0 66.0 67.0 64.0 66.0 66.0 67.0 63.0 10:08:40 INFO - PROCESS | 4269 | -------- Summary: end -------- 10:08:40 INFO - PROCESS | 4269 | 10:08:41 INFO - TEST-INFO | 4269: exit 0 10:08:41 INFO - TEST-OK | kraken | took 59816ms 10:08:41 INFO - SUITE-END | took 1171s 10:08:41 INFO - Completed test suite (00:19:31) 10:08:41 INFO - javascript benchmark 10:08:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.7358611311097, 3383.103477578442, 3389.593248810143, 3399.84700688469, 3425.62318145004, 5503.09198982168, 5521.365043020054, 5528.7788488460465, 5545.639533430324, 5567.192757050226, 5528.695921724304, 5561.360443548983, 5564.610477266583, 5572.554195664347, 5603.523700485463, 4992.600591952644, 4994.850154495352, 5084.084864724348, 5123.333966584339, 5142.537171654551, 5013.899722005558, 5075.086484432801, 5080.79676812927, 5085.66943148696, 5086.898262034757, 5094.235864620318, 5162.457941916101, 5186.611004174683, 5188.429272779991, 5226.947730522703, 5043.344365232533, 5064.645474816764, 5070.391553013662, 5077.898442031157, 5091.643584949055, 4859.149648811479, 4952.306677065214, 5002.099622068026, 5006.873453472939, 5020.5732512736095, 5261.105612045923, 5397.54120899724, 5414.5668346532575, 5437.211604317352, 5452.291202143736, 5975.342712301644, 6013.338532761437, 6030.246219222598, 6032.547558933054, 6038.63768173911, 6034.849128771772, 6039.335673075958, 6084.154662623186, 6088.512918966517, 6097.725602347905, 5633.943660563383, 5681.602287839853, 5685.744141513683, 5687.74405151765, 5723.77104915807, 5919.940800592025, 6191.25704915404, 6208.161898143783, 6210.31686514483, 6214.098955651496, 5912.17229587858, 5959.404059594092, 5960.403959604092, 5969.343372229051, 5973.133895585116, 5860.589758716849, 5862.267216597926, 5866.12008198765, 5867.530597552186, 5868.149118377812, 5830.650160990354, 5835.35811060783, 5838.562107841929, 5843.474087332075, 6000.849978750479, 6041.9395806041375, 6043.2748070231855, 6043.516518678495, 6043.788467403708, 6075.5747097703625, 4573.588377046081, 4587.08258348325, 4592.908141837144, 4601.976990115028, 4620.630349572026, 3992.860249891298, 3995.440638310639, 4014.1570270243574, 4098.057446787256, 4133.21468920904, 5645.802396916089, 5676.602637815396, 5678.772849086073, 5680.744366503434, 5702.54379649627, 5970.820875373745, 5973.074173503114, 5975.492083172892, 5975.641461512323, 5991.340952495222, 5632.718364081779, 5666.518345940559, 5676.517496012885, 5734.197212390269, 5820.505257053113, 5045.697258164522, 5054.898902021939, 5055.039542486916, 5057.8735531612, 5071.949280507221, 6022.57841951068, 6025.578209525379, 6025.758969641253, 6030.547708921761, 6083.7870674526175, 5825.155352473952, 5911.349751527243, 5913.852153696192, 5947.375525569752, 5982.222311099703, 6202.34875338083, 6221.813345599639, 6236.937795224482, 6265.906011409741, 6268.843278918063, 5919.970400147971, 5940.8811823764145, 5941.970290148522, 5942.970285148546, 5980.684249465111, 5878.706064696663, 5891.823245302648, 5959.91060134107, 5964.850878727893, 5990.7903223386975, 5834.883302333845, 5894.528437725057, 5899.734511947058, 5923.5853490256995, 5947.821565353046, 5724.4561766632105, 5824.796132135355, 5839.240898683144, 5886.323072846506, 5886.499647530008, 5812.3025236971835, 5851.882962340815, 5858.062709966385, 5861.413858614104, 5894.0274854648505, 5827.621204621686, 5841.269841269841, 5852.502537284208, 5861.120831875082, 5862.530997520103, 5560.0, 5668.829935101953, 5725.255716756795, 5735.684537350319, 5776.480116789509], "value": 5509.182117722027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.7099127914241, 652.3574279334855, 667.229350100634, 667.9899801502982, 673.161913417795, 32899.177520562, 33748.83125584375, 33761.493577596324, 38836.61163388365, 39686.80156599213, 43194.784026079826, 43479.3478097828, 43621.0, 43828.78085609576, 43891.0, 8108.472949258309, 8842.204201621837, 9011.234045106174, 9013.729588112334, 9022.233110185642, 8237.670493180296, 8375.246227839492, 10663.520141593646, 10946.507407166697, 10951.069159121444, 10717.089047430978, 10754.408507532082, 10784.245102842804, 10807.135429165648, 10810.35137891725, 8142.47073940192, 10921.508532116035, 10991.945040274748, 11014.50434730443, 11015.669529914116, 10362.481875906175, 10551.103156231653, 10552.15582753378, 10564.577416903314, 10568.577256909715, 37330.253394932224, 37807.62192378069, 37834.24331513382, 37847.432288515694, 37958.43062354039, 3819.236152769457, 3822.140018495844, 3840.3087444260022, 3951.9012024699614, 4243.554426785205, 31606.841965790252, 32155.678443215736, 32244.193895152574, 32428.675713243036, 32473.188170295696, 4585.977070114662, 4641.930371044437, 4668.906621867578, 4701.48283688794, 4717.056588682277, 234308.0, 236770.0, 236905.0, 237176.0, 237757.0, 68630.0, 68963.31036689569, 68975.31024689689, 69139.30860691429, 69256.307436926, 60790.0, 61697.0, 61833.0, 62000.37999619946, 62852.05721914175, 18364.357247496275, 18483.075846207907, 18581.16384762689, 18591.25634974613, 18592.907035464737, 12751.808722869164, 12758.0, 12787.232766034067, 13298.601041968757, 13752.518661846787, 20891.8955405222, 21430.357089287347, 21704.457388565414, 21759.45601359947, 21914.89042554809, 7935.206479352134, 8121.837563248702, 8205.220504052106, 8270.462419942685, 8321.542315172603, 1060.6711919304885, 1078.7033565769477, 1102.9411764705972, 1176.1825531255695, 1222.4865556466304, 32069.839650802063, 32499.675003250137, 32827.835860820545, 33056.3388732224, 33733.0, 1227.6056703215615, 1228.7112528555783, 1235.4996226528272, 1245.894099001577, 1271.7329360834144, 17119.0, 17510.29958801659, 17614.735778963324, 17707.516201078208, 17945.641087178185, 474537.0, 479372.0, 479744.0, 480302.0, 480852.0, 60770.088448673305, 61411.078833817526, 61428.38571614316, 61479.6926015376, 61644.0, 1376.3393571085935, 1506.4877941499724, 1522.9466968656043, 1529.8852586056091, 1545.8763298936058, 30497.0, 31294.217644558157, 32023.679763202068, 32205.838970804994, 32271.35457290794, 45177.774111129234, 45660.771696142634, 45725.77137114293, 45831.31253031274, 45864.77067614641, 245950.0, 250732.0, 252645.0, 252787.0, 253090.0, 27975.440491190468, 30786.230344241572, 31517.212069698442, 33227.335453291285, 33249.501257480675, 47360.28959565678, 48772.75613621909, 50873.74563127309, 51702.22446663379, 52089.0, 40591.39112913368, 41020.0, 41087.794561027, 41336.1732765337, 42151.36772948347, 35057.48833892903, 35925.28149437049, 35940.82029589835, 36206.637933620324, 36731.81634091812, 41830.58169418267, 42061.57938420577, 42149.789251053546, 42460.363094554225, 42844.0, 35736.28527429385, 36633.26733465263, 36940.63059369372, 37355.252894942496, 37494.812525937195, 28852.0, 29292.41415171642, 29327.853360733912, 29420.411591767617, 29562.704372955995], "value": 20390.41306146233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.14432825097776, 400.84968136948646, 403.513765912076, 411.81262525550875, 412.5173546950068, 14988.475403360884, 16991.320347186127, 18626.53433664159, 19199.808001919977, 19228.519287017833, 16161.0, 17673.91163044186, 18291.268349266014, 20273.797262027376, 21001.47496312593, 5619.971900140504, 5733.856653583673, 5779.335376431701, 5784.797532086378, 5796.24648795656, 4452.421185245914, 5753.5397168226655, 5807.477327040566, 6314.0, 6600.0, 6513.478921686277, 6520.18497687789, 6535.150430444036, 6556.803295901131, 6571.178602674666, 6315.905261421082, 6493.1558897343275, 6572.07990881277, 6576.704048317837, 6579.243387010507, 5809.82570522885, 5823.475887170175, 5826.941730582682, 5831.88336233273, 5835.649861008311, 23244.3026709199, 23281.883590582107, 24151.396215094763, 24234.0, 24303.513929721306, 2574.407886186169, 2709.8509581972985, 2814.845183514906, 2850.3016760893506, 2918.124562631202, 13934.765997612769, 14796.632538793849, 15314.770278445832, 15375.231238438146, 15415.229238538028, 1974.9901250493656, 1997.10130441302, 2016.9294074707461, 2079.08520251089, 2099.4016705238932, 77225.61387193028, 80312.0, 82508.58745706292, 82959.9999999994, 83666.0, 10661.520231589597, 10834.729131771768, 11026.393548354918, 11086.487721983282, 11087.611933582286, 15129.47046853355, 15280.0, 15384.615384615474, 15386.076835389913, 15430.845691543165, 8411.495310281403, 8575.099614540384, 8795.164459376349, 8949.373543851998, 9025.864612030824, 7404.555726656418, 8094.421587790324, 8262.669493220325, 8340.457870238415, 8387.203215694499, 6354.142190804275, 6537.34626537352, 6675.7997260082275, 6809.863802723918, 6812.352826481477, 1841.5948491331885, 1869.9158537865828, 1873.185164453467, 1896.7913529511743, 1902.2391043582402, 1011.1001208924064, 1042.4370839746603, 1111.4220605285207, 1136.2046567402851, 1215.6170806196196, 19170.71243931342, 19363.709544356847, 19518.0, 19880.90059549722, 20040.498987525138, 1074.2211896375065, 1080.378782200238, 1094.518411898762, 1153.6654370232538, 1183.479269121601, 10919.3994330311, 11485.655430337103, 11530.711732206762, 11568.652940411801, 11576.42117894102, 495141.0, 496205.0, 501554.0, 504812.0, 511468.0, 83833.58083209545, 84008.57995709982, 85116.57441712751, 85807.57096214479, 87637.0, 1152.7348709796627, 1186.483879512415, 1187.26389638423, 1188.95966029724, 1211.987880121205, 17281.0, 17436.47690569285, 17674.734878976567, 17726.379576714753, 17905.462836114937, 38604.420933685455, 38777.806110969264, 38810.41784373293, 39169.804150979064, 39243.2151356977, 52377.214341785664, 53050.469495304555, 53169.0, 53328.73335633297, 53348.4665153359, 8711.128887111492, 8775.166359195866, 8927.732168034969, 9000.0, 9024.413413128126, 13261.933690331487, 13560.728785424433, 13586.116902401312, 13733.793993089912, 13873.653158671113, 6926.757563485254, 10233.9488302558, 11657.18399712012, 12009.0, 12203.08476864221, 11723.531058757895, 11740.706482337668, 11879.10906681985, 11997.460114294703, 12218.450169742206, 11983.580574679845, 12157.635270941886, 12426.937865310978, 12479.688007799878, 12482.750344992868, 8749.956250218707, 8825.33809964268, 8871.379003469696, 8892.510911899908, 8959.686410975584, 11501.597444089417, 11751.764964700487, 11762.294262344287, 12134.453949572115, 12136.089793265364], "value": 9644.174623588624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.0162387064913, 1400.579826052184, 1431.8496557861426, 1652.4133932453979, 1936.1190658250498, 7540.924590754091, 7674.194209607987, 7675.347595454379, 7685.231476852319, 7691.730789422358, 7780.844383112349, 7908.802279943005, 7909.367250619951, 7938.722144724921, 7951.562664053475, 2047.1708957872086, 2284.463151159476, 2286.302677683306, 2300.64340027296, 2332.8600283982933, 2302.102180149743, 2306.9733968384076, 2317.4438134847683, 2320.2807129789735, 2323.860568365895, 2218.6450167973126, 2239.9776002240014, 2263.094762095159, 2272.3523795718224, 2273.011240110549, 2006.9899650501727, 2267.535155293161, 2307.861528308307, 2323.3726893738767, 2324.0239099578134, 2275.2150508074687, 2307.60770668985, 2323.4423738302685, 2323.779240972105, 2328.138588722167, 7689.038870141232, 7697.884531732028, 7706.7687969361, 7711.730089446898, 7712.6914923403, 4808.182608956451, 4887.70673759572, 4889.266610008492, 4894.021195760862, 4911.165101932645, 3202.6316973547873, 3219.6780321967617, 3266.1344743642953, 3280.852361643732, 3302.620198677135, 1194.5221911235487, 1197.479096592976, 1226.3622916083675, 1234.271779650002, 1265.1966001588964, 11096.500657470353, 11178.608748693838, 11186.105111591054, 11190.832137517944, 11200.047995920357, 4332.350147477903, 4388.341748737715, 4396.9554157317, 4418.381426600278, 4442.977785111054, 9499.38254013487, 9558.856617150748, 9568.47373394456, 9579.952100239594, 9588.520573971273, 4493.078918821634, 4991.126552853309, 5006.774695138654, 5011.123053465702, 5015.122353588107, 4547.15877562652, 4643.257078867365, 4686.179918514246, 4719.59883409914, 4742.549457801503, 3887.8250478728523, 3942.3495123304333, 3966.3257246268204, 4012.1775036117524, 4083.7549747015273, 1326.191023475679, 1356.8439629442544, 1358.7146699193281, 1370.184740079651, 1370.616227456314, 819.8688209886509, 886.1847100667402, 899.3839220134229, 903.5662881816764, 905.5834316214483, 5376.381716102698, 5380.919286210632, 5416.241726158341, 5552.555795536347, 5556.277683901067, 1003.7490627343165, 1048.0829274384914, 1089.3899416326883, 1160.9651710448532, 1164.4527072276016, 3767.4913886625504, 3821.216650586623, 3894.6300101490315, 3903.4535165076913, 3929.7052721046034, 9487.241020718326, 9641.710748677551, 9668.661596844217, 9816.705498835046, 9882.703518894445, 9658.613655453844, 9667.371620844622, 9703.708888733348, 9738.415695058318, 9748.805023899482, 7799.3760499159935, 7871.763847084597, 8075.111737708848, 8164.67341306353, 8174.7956301092945, 5508.256385387921, 5539.584531160099, 5628.155776633538, 5704.80033198836, 5754.424557544212, 9190.724278271662, 9293.30300227472, 9304.255659547356, 9404.623815047322, 9428.198603118812, 8747.081556436482, 9122.452652840851, 9136.817263654822, 9297.395669281475, 9485.620575177192, 6554.606723596599, 6695.765648202289, 6731.057651928832, 6953.513254072166, 7000.334968178015, 7681.769546913378, 7834.529928204326, 7839.294463498312, 7846.0, 7849.764507064797, 7178.102737157856, 7394.667239974322, 7478.850422991619, 7488.513246638951, 7489.925100749141, 7049.682764275517, 7147.106611673541, 7253.673584688807, 7348.008018917378, 7380.409567234716, 6380.521460890359, 6433.935660643334, 6434.4852411806005, 6450.193725784277, 6450.193725784277, 4669.369635099354, 4686.203345431217, 4741.83403580873, 4815.783289751899, 4936.827211047596, 4643.303504474356, 4653.022865198346, 4709.529047095263, 4710.4347478302825, 4762.6189904808225], "value": 4403.296262575534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.27128859087196, 334.40642858925406, 342.31366110947545, 349.7044996977553, 364.48607463476503, 6296.401841825025, 6310.716017779205, 6317.652529110897, 6326.588771729846, 6336.398042185997, 6023.36754640763, 6132.509399248061, 6305.8108256752375, 6322.178116844803, 6377.0, 4811.037792441508, 4841.56425921667, 4849.175640141176, 4850.514948505139, 4853.538913803183, 4826.469088400273, 4847.175980083394, 4856.465788763251, 4857.29569212464, 4866.6106711463, 4571.862844114666, 4641.93037104442, 4732.077244937239, 4736.313234581001, 4738.170820106485, 4766.451858036301, 4777.259524773665, 4780.187368147406, 4800.135975524404, 4804.495527969565, 4197.307444271692, 4206.2008218438705, 4206.8737937861915, 4206.894827629303, 4211.115665710174, 6062.484688801457, 6079.726412311456, 6081.665508397036, 6083.209182806251, 6085.847853803691, 5604.607677462579, 5606.523445507096, 5611.803586874481, 5614.747336369833, 5615.708387070956, 6486.837829054264, 6656.833579160511, 6662.633555154464, 6666.0, 6668.066470694107, 4667.043256132485, 4681.695689780154, 4686.929696054562, 4688.648351373627, 4691.601213896823, 6949.617771022592, 6949.965250173767, 6955.65221738911, 6962.860742785167, 6964.582125072512, 4783.808647654055, 4792.832250871203, 4796.736179510161, 4801.423829140525, 4806.206975849016, 4851.587615052689, 4853.830115945995, 4854.053459575349, 4859.319695242669, 4864.318995340655, 5298.81454149103, 5455.399906010336, 5460.262864513319, 5579.330480342385, 5580.888382232414, 6671.466282697373, 6767.830804229934, 6789.864202716017, 6822.624755638488, 6827.044213810071, 1584.6592982508816, 1604.2620394618607, 1627.8372162783864, 1643.3755173034172, 1643.802743670767, 1078.1698092468912, 1091.841682955967, 1094.0372472224392, 1095.9780804384027, 1096.2107282756403, 6368.84077898047, 6443.387878151568, 6446.903296450557, 6449.580777249464, 6492.285848556655, 6862.382385585322, 6865.0732151159955, 6866.0, 6876.277990810993, 6876.381125698711, 6416.647084410402, 6420.775272865428, 6468.579542329733, 6493.642849643315, 6506.707198176094, 3673.045008297808, 3691.6492933171307, 3704.0, 3707.3697471429923, 3713.4429835524347, 7087.2558381370245, 7125.144982602017, 7275.308845659654, 7277.563346199245, 7301.634918254066, 7170.8207294817, 7182.8204294892, 7195.064641596664, 7199.604021778852, 7199.928000719926, 7248.238934911864, 7261.0, 7261.709531618676, 7267.709291628487, 7273.0908636420445, 7011.754588589375, 7017.789466316019, 7018.438524918097, 7025.402840758388, 7029.718811247493, 6781.796546103625, 6935.237123916466, 6935.618540980295, 6939.965300173467, 6955.026296318621, 7219.8556028880175, 7234.963825181051, 7239.601821899846, 7245.637718114179, 7256.7097316106765, 4542.523035081269, 4560.156371071363, 4562.087582483583, 4564.224081906017, 4565.06416184688, 6742.157230346207, 6982.301769822977, 6982.79051628452, 6993.965030174817, 6996.125484314461, 6657.434118100015, 6811.8978215325815, 6813.318668133147, 6827.283135270725, 6829.258539072504, 6718.798436046926, 6730.663466826737, 6739.764108256188, 6770.424513916372, 6778.491613129134, 6661.700223490052, 6665.333466653296, 6695.665216739046, 6753.662316884234, 6757.459403247827, 6665.766698165541, 6805.3875151236625, 6844.0, 6846.110005699227, 6890.483213759088, 6679.165104361955, 6688.297728738413, 6696.096027036482, 6704.0, 6704.932950670626], "value": 5051.409933090994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.3009307135468, 832.3590835057006, 848.4569875279822, 875.0899064972429, 875.4659657608858, 13490.59528214154, 13638.659033524142, 13744.106633068843, 13779.724405511895, 13819.93090034551, 14180.858191418109, 15827.287772050257, 16077.0, 16111.677766444664, 16133.193340332995, 911.2209061252616, 920.1902325953151, 926.4024704065873, 926.5645146781002, 926.8517037274038, 754.4454825703132, 914.3325372478095, 930.9394889332206, 933.0343094896783, 936.0732874454309, 956.0678338619825, 957.6121670723368, 959.9472029038435, 960.0591420408005, 960.7646126698934, 780.9882851757171, 953.1374106433689, 957.6265256549916, 958.3531116496372, 958.6117622362954, 687.295522089862, 697.745322957117, 697.7801992372387, 697.8325201951545, 697.8988046733245, 14333.354999025069, 14453.78319325211, 14511.274436278143, 14535.854641453556, 14565.0, 13242.139260948008, 13626.59120226385, 13725.039247252696, 13890.861091389057, 14133.929330353283, 11758.941205294004, 11850.3482308473, 12000.09999250051, 12041.337726425043, 12099.87900121005, 3985.2826491231567, 4036.374361973899, 4050.8784736457956, 4056.8377264909664, 4099.385092236159, 61386.0, 61515.69242153806, 61602.69198653978, 61793.38206617921, 61817.69091154561, 10221.33561318512, 10260.897391025994, 10282.794344113225, 10641.255112142077, 10669.03978641926, 17803.19885605151, 17819.554511137325, 17838.37565685195, 17899.552511187063, 18000.9099954502, 8364.623591938378, 8375.623096960651, 8531.872021919677, 8533.767904963865, 8816.250618697355, 4750.121227572841, 4772.427308722976, 4794.304825800239, 5053.0, 5068.594512438996, 3521.137321356233, 3567.0, 3568.750187486851, 3571.714262859017, 3574.428091505347, 646.8447572582546, 654.2900952466532, 657.7599176300616, 659.1365311442026, 674.3391476353202, 755.75815738963, 766.4749646492171, 796.7012370361115, 808.1635507249968, 827.148037521354, 9058.32062595308, 9098.31762617793, 9176.81646367069, 9199.494027828534, 9307.3019523536, 705.9011738356634, 740.4853626729479, 751.8909758085047, 758.8823732321499, 762.4777027735907, 4104.979475102606, 4291.74249545022, 4304.978475107667, 4364.890877728082, 4527.388802511618, 58781.0, 60008.09987850186, 60019.69990150109, 62927.6853615729, 63335.36664633387, 51526.74236628793, 52696.20955685591, 53281.733591331795, 53741.73129134329, 54062.0, 50637.240441393405, 51351.229731554056, 51608.22587661188, 52099.99999999924, 53062.204066939026, 9312.906870931203, 9434.0, 9441.763955900882, 9442.669506567237, 9494.240460762985, 37722.43416348702, 38131.23737525178, 38663.0, 39636.0, 39843.0, 46854.53145468501, 50171.24743128929, 50303.245451318995, 54044.45955540394, 54489.72755136199, 12916.160449570747, 13210.207387556777, 13659.79510307366, 13722.45110195581, 14291.285435727965, 14032.22822744759, 14301.35643896048, 14376.928115359357, 14480.710385792436, 15115.244237788287, 11098.5560577576, 13633.182009079486, 13687.931560342135, 13991.510297139552, 14226.288685565472, 11694.88305116938, 11738.70653233676, 11754.764904701688, 11930.76138477243, 12089.455974481345, 13177.407016684463, 13234.139780914209, 13235.735285294048, 13340.933295333462, 13573.253471059186, 9964.320467077465, 10239.180865530889, 10365.274430789772, 10548.208884333859, 10942.398168100832, 10754.623588174376, 10893.56425742993, 11108.166887483632, 11497.367644779282, 11505.827412588986], "value": 7054.910385860428, "unit": "score"}], "name": "dromaeo_css", "value": 7443.038122432462, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 109.0, 112.0, 111.0, 107.0, 110.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 157.0, 179.0, 129.0, 153.0, 160.0, 127.0, 188.0, 130.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 159.0, 160.0, 162.0, 159.0, 163.0, 157.0, 158.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 164.0, 75.0, 76.0, 74.0, 75.0, 169.0, 74.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 155.0, 91.0, 92.0, 93.0, 144.0, 91.0, 92.0, 139.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 56.0, 54.0, 55.0, 57.0, 75.0, 54.0, 52.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 58.0, 59.0, 61.0, 57.0, 58.0, 60.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 73.0, 74.0, 73.0, 74.0, 74.0, 75.0, 76.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 113.0, 111.0, 111.0, 109.0, 110.0, 114.0, 135.0, 132.0], "value": 116.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 161.0, 160.0, 164.0, 159.0, 157.0, 169.0, 160.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 66.0, 67.0, 64.0, 66.0, 66.0, 67.0, 63.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1514.6000000000004, "alertThreshold": 2.0}]} 10:08:41 INFO - Return code: 0 10:08:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:08:41 ERROR - # TBPL SUCCESS # 10:08:41 INFO - Running post-action listener: _resource_record_post_action 10:08:41 INFO - Running post-run listener: _resource_record_post_run 10:08:42 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 692224; Write bytes: 250724352; Read time: 68; Write time: 180096 10:08:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 2772992; Read time: 0; Write time: 108 10:08:42 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 692224; Write bytes: 247951360; Read time: 68; Write time: 179988 10:08:42 INFO - Running post-run listener: _upload_blobber_files 10:08:42 INFO - Blob upload gear active. 10:08:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:42 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 10:08:42 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'] 10:08:42 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 10:08:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:43 INFO - (blobuploader) - INFO - Done attempting. 10:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:44 INFO - (blobuploader) - INFO - Done attempting. 10:08:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:44 INFO - Return code: 0 10:08:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b288c7ee2f31dc108bcc91fdf9323ee7e7f0dad65121d9e755af610cc238cff12bec1bb6fbb37103efbdd475aad9b9b6635952c3bf3a3a1feb14dfe1d7690c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7d8669a9f564dcca192b12f070bf6dc9ee44948672acc794805c7f618df5d0d02a8da49c19b66d19a38fa8d7264e30266f8bf82aad4d56902cc956200d134b2"} 10:08:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:44 INFO - Contents: 10:08:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b288c7ee2f31dc108bcc91fdf9323ee7e7f0dad65121d9e755af610cc238cff12bec1bb6fbb37103efbdd475aad9b9b6635952c3bf3a3a1feb14dfe1d7690c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7d8669a9f564dcca192b12f070bf6dc9ee44948672acc794805c7f618df5d0d02a8da49c19b66d19a38fa8d7264e30266f8bf82aad4d56902cc956200d134b2"} 10:08:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:44 INFO - Copying logs to upload dir... 10:08:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.805716 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-24 10:08:44.763241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:08:44.767010) ========= 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=ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130 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/b288c7ee2f31dc108bcc91fdf9323ee7e7f0dad65121d9e755af610cc238cff12bec1bb6fbb37103efbdd475aad9b9b6635952c3bf3a3a1feb14dfe1d7690c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7d8669a9f564dcca192b12f070bf6dc9ee44948672acc794805c7f618df5d0d02a8da49c19b66d19a38fa8d7264e30266f8bf82aad4d56902cc956200d134b2"} build_url:https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/XMwjbyaRSoWWZTexmw7gbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b288c7ee2f31dc108bcc91fdf9323ee7e7f0dad65121d9e755af610cc238cff12bec1bb6fbb37103efbdd475aad9b9b6635952c3bf3a3a1feb14dfe1d7690c21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7d8669a9f564dcca192b12f070bf6dc9ee44948672acc794805c7f618df5d0d02a8da49c19b66d19a38fa8d7264e30266f8bf82aad4d56902cc956200d134b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:08:44.795397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:08:44.795768) ========= 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=ea34ab03e80221fdf844251c000001a3-1464108494.181788-85914130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:08:44.879501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:08:44.880027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:08:44.880396) ========= ========= Total master_lag: 0.33 =========