builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1461190633.39 results: success (0) buildid: 20160420124052 builduid: 273b70f21fd344da850619ad6714fc0e revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.394542) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.396260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.396560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.414068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.414501) ========= 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=232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 15:17:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.8M=0s 2016-04-20 15:17:13 (50.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.559823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.560125) ========= 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=232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022162 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.614887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.615223) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --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 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --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=232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 15:17:14,079 truncating revision to first 12 chars 2016-04-20 15:17:14,079 Setting DEBUG logging. 2016-04-20 15:17:14,079 attempt 1/10 2016-04-20 15:17:14,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2387e00d2ce8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 15:17:14,377 unpacking tar archive at: mozilla-aurora-2387e00d2ce8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.198339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.198646) ========= script_repo_revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.199052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.199358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.207902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-20 15:17:14.208194) ========= /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=232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:17:14 INFO - MultiFileLogger online at 20160420 15:17:14 in /builds/slave/test 15:17:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:17:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:14 INFO - {'append_to_log': False, 15:17:14 INFO - 'base_work_dir': '/builds/slave/test', 15:17:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:17:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:14 INFO - 'branch': 'Mozilla-Aurora', 15:17:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:14 INFO - 'config_files': ('talos/linux_config.py',), 15:17:14 INFO - 'default_actions': ('clobber', 15:17:14 INFO - 'read-buildbot-config', 15:17:14 INFO - 'download-and-extract', 15:17:14 INFO - 'populate-webroot', 15:17:14 INFO - 'create-virtualenv', 15:17:14 INFO - 'install', 15:17:14 INFO - 'run-tests'), 15:17:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:14 INFO - 'download_minidump_stackwalk': True, 15:17:14 INFO - 'download_symbols': 'ondemand', 15:17:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:14 INFO - 'installer_path': 'installer.exe', 15:17:14 INFO - 'log_level': 'info', 15:17:14 INFO - 'log_name': 'talos', 15:17:14 INFO - 'log_to_console': True, 15:17:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:17:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:17:14 INFO - 'opt_config_files': (), 15:17:14 INFO - 'pip_index': False, 15:17:14 INFO - 'sps_profile': False, 15:17:14 INFO - 'sps_profile_interval': 0, 15:17:14 INFO - 'suite': 'dromaeojs', 15:17:14 INFO - 'system_bits': '32', 15:17:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:14 INFO - 'title': 'talos-linux64-ix-025', 15:17:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:14 INFO - 'use_talos_json': True, 15:17:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:14 INFO - 'work_dir': 'build'} 15:17:14 INFO - ##### 15:17:14 INFO - ##### Running clobber step. 15:17:14 INFO - ##### 15:17:14 INFO - Running pre-action listener: _resource_record_pre_action 15:17:14 INFO - Running main action method: clobber 15:17:14 INFO - rmtree: /builds/slave/test/build 15:17:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:15 INFO - Running post-action listener: _resource_record_post_action 15:17:15 INFO - ##### 15:17:15 INFO - ##### Running read-buildbot-config step. 15:17:15 INFO - ##### 15:17:15 INFO - Running pre-action listener: _resource_record_pre_action 15:17:15 INFO - Running main action method: read_buildbot_config 15:17:15 INFO - Using buildbot properties: 15:17:15 INFO - { 15:17:15 INFO - "project": "", 15:17:15 INFO - "product": "firefox", 15:17:15 INFO - "script_repo_revision": "production", 15:17:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:17:15 INFO - "repository": "", 15:17:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:17:15 INFO - "buildid": "20160420124052", 15:17:15 INFO - "pgo_build": "True", 15:17:15 INFO - "basedir": "/builds/slave/test", 15:17:15 INFO - "buildnumber": 180, 15:17:15 INFO - "slavename": "talos-linux64-ix-025", 15:17:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:17:15 INFO - "platform": "ubuntu64_hw", 15:17:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:17:15 INFO - "branch": "mozilla-aurora", 15:17:15 INFO - "repo_path": "releases/mozilla-aurora", 15:17:15 INFO - "revision": "2387e00d2ce89a2cd641df7ca92af4feeeebe556", 15:17:15 INFO - "stage_platform": "linux64-pgo", 15:17:15 INFO - "builduid": "273b70f21fd344da850619ad6714fc0e", 15:17:15 INFO - "slavebuilddir": "test" 15:17:15 INFO - } 15:17:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 15:17:15 INFO - Running post-action listener: _resource_record_post_action 15:17:15 INFO - ##### 15:17:15 INFO - ##### Running download-and-extract step. 15:17:15 INFO - ##### 15:17:15 INFO - Running pre-action listener: _resource_record_pre_action 15:17:15 INFO - Running main action method: download_and_extract 15:17:15 INFO - mkdir: /builds/slave/test/build/tests 15:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:15 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:17:17 INFO - Downloaded 1448 bytes. 15:17:17 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:17:17 INFO - Using the following test package requirements: 15:17:17 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:17 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:17:17 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:17:17 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'jsshell-linux-x86_64.zip'], 15:17:17 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:17:17 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:17 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:17:17 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:17:17 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:17:17 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:17 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:17:17 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:17: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')]} 15:17:17 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:17:19 INFO - Downloaded 23353627 bytes. 15:17:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:17:20 INFO - Return code: 0 15:17:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:20 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:17:36 INFO - Downloaded 23353627 bytes. 15:17:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:17:37 INFO - Return code: 0 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:17:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:17:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:17:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:17:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:17:38 INFO - Downloaded 10845198 bytes. 15:17:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:17:39 INFO - Return code: 0 15:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:39 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:17:41 INFO - Downloaded 60606797 bytes. 15:17:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:41 INFO - mkdir: /builds/slave/test/properties 15:17:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:41 INFO - Contents: 15:17:41 INFO - build_url:https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:42 INFO - Running post-action listener: _resource_record_post_action 15:17:42 INFO - Running post-action listener: set_extra_try_arguments 15:17:42 INFO - ##### 15:17:42 INFO - ##### Running populate-webroot step. 15:17:42 INFO - ##### 15:17:42 INFO - Running pre-action listener: _resource_record_pre_action 15:17:42 INFO - Running main action method: populate_webroot 15:17:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:42 INFO - '--tppagecycles', 15:17:42 INFO - '7'], 15:17:42 INFO - 'tests': ['tsvgm']}}, 15:17:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:17:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:17:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'tests': ['damp', 'tps']}, 15:17:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['damp', 'tps']}, 15:17:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:17:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:42 INFO - 'other': {'tests': ['a11yr', 15:17:42 INFO - 'ts_paint', 15:17:42 INFO - 'tpaint', 15:17:42 INFO - 'sessionrestore', 15:17:42 INFO - 'sessionrestore_no_auto_restore', 15:17:42 INFO - 'tabpaint']}, 15:17:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['a11yr', 15:17:42 INFO - 'ts_paint', 15:17:42 INFO - 'tpaint', 15:17:42 INFO - 'sessionrestore', 15:17:42 INFO - 'sessionrestore_no_auto_restore', 15:17:42 INFO - 'tabpaint']}, 15:17:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['a11yr', 15:17:42 INFO - 'ts_paint', 15:17:42 INFO - 'tpaint', 15:17:42 INFO - 'sessionrestore', 15:17:42 INFO - 'sessionrestore_no_auto_restore', 15:17:42 INFO - 'tabpaint']}, 15:17:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['a11yr', 15:17:42 INFO - 'ts_paint', 15:17:42 INFO - 'tpaint', 15:17:42 INFO - 'sessionrestore', 15:17:42 INFO - 'sessionrestore_no_auto_restore', 15:17:42 INFO - 'tabpaint']}, 15:17:42 INFO - 'other_l64': {'tests': ['a11yr', 15:17:42 INFO - 'ts_paint', 15:17:42 INFO - 'tpaint', 15:17:42 INFO - 'sessionrestore', 15:17:42 INFO - 'sessionrestore_no_auto_restore', 15:17:42 INFO - 'tabpaint']}, 15:17:42 INFO - 'other_nol64': {'tests': ['a11yr', 15:17:42 INFO - 'ts_paint', 15:17:42 INFO - 'tpaint', 15:17:42 INFO - 'sessionrestore', 15:17:42 INFO - 'sessionrestore_no_auto_restore', 15:17:42 INFO - 'tabpaint']}, 15:17:42 INFO - 'svgr': {'tests': ['tsvgx', 15:17:42 INFO - 'tsvgr_opacity', 15:17:42 INFO - 'tart', 15:17:42 INFO - 'tscrollx', 15:17:42 INFO - 'cart']}, 15:17:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['tsvgx', 15:17:42 INFO - 'tsvgr_opacity', 15:17:42 INFO - 'tart', 15:17:42 INFO - 'tscrollx', 15:17:42 INFO - 'cart']}, 15:17:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'tests': ['tp5o']}, 15:17:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'talos_options': ['--e10s'], 15:17:42 INFO - 'tests': ['tp5o']}, 15:17:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'talos_options': ['--xperf_path', 15:17:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:42 INFO - 'tests': ['tp5n']}, 15:17:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:42 INFO - 'talos_options': ['--e10s', 15:17:42 INFO - '--xperf_path', 15:17:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:42 INFO - 'tests': ['tp5n']}}, 15:17:42 INFO - 'talos.zip': {'path': '', 15:17:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:42 INFO - Running post-action listener: _resource_record_post_action 15:17:42 INFO - ##### 15:17:42 INFO - ##### Running create-virtualenv step. 15:17:42 INFO - ##### 15:17:42 INFO - Running pre-action listener: _resource_record_pre_action 15:17:42 INFO - Running main action method: create_virtualenv 15:17:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:17:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:42 INFO - Using real prefix '/usr' 15:17:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:45 INFO - Installing pip.................done. 15:17:45 INFO - Return code: 0 15:17:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:45 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:17:45 INFO - Using env: {'DISPLAY': ':0', 15:17:45 INFO - 'HOME': '/home/cltbld', 15:17:45 INFO - 'LANG': 'en_US.UTF-8', 15:17:45 INFO - 'LANGUAGE': 'en_US:en', 15:17:45 INFO - 'LOGNAME': 'cltbld', 15:17:45 INFO - 'MAIL': '/var/mail/cltbld', 15:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:45 INFO - 'MOZ_NO_REMOTE': '1', 15:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:45 INFO - 'NO_EM_RESTART': '1', 15:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:45 INFO - 'PWD': '/builds/slave/test', 15:17:45 INFO - 'SHELL': '/bin/bash', 15:17:45 INFO - 'SHLVL': '1', 15:17:45 INFO - 'TERM': 'linux', 15:17:45 INFO - 'TMOUT': '86400', 15:17:45 INFO - 'USER': 'cltbld', 15:17:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:45 INFO - '_': '/tools/buildbot/bin/python'} 15:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:17:45 INFO - Cleaning up... 15:17:45 INFO - Return code: 0 15:17:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:45 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:17:45 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 15:17:45 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 15:17:45 INFO - Using env: {'DISPLAY': ':0', 15:17:45 INFO - 'HOME': '/home/cltbld', 15:17:45 INFO - 'LANG': 'en_US.UTF-8', 15:17:45 INFO - 'LANGUAGE': 'en_US:en', 15:17:45 INFO - 'LOGNAME': 'cltbld', 15:17:45 INFO - 'MAIL': '/var/mail/cltbld', 15:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:45 INFO - 'MOZ_NO_REMOTE': '1', 15:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:45 INFO - 'NO_EM_RESTART': '1', 15:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:45 INFO - 'PWD': '/builds/slave/test', 15:17:45 INFO - 'SHELL': '/bin/bash', 15:17:45 INFO - 'SHLVL': '1', 15:17:45 INFO - 'TERM': 'linux', 15:17:45 INFO - 'TMOUT': '86400', 15:17:45 INFO - 'USER': 'cltbld', 15:17:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:45 INFO - '_': '/tools/buildbot/bin/python'} 15:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:45 INFO - Downloading/unpacking psutil>=0.7.1 15:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:47 INFO - Installing collected packages: psutil 15:17:47 INFO - Running setup.py install for psutil 15:17:47 INFO - building 'psutil._psutil_linux' extension 15:17:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:17:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:17:47 INFO - building 'psutil._psutil_posix' extension 15:17:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:17:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:48 INFO - Successfully installed psutil 15:17:48 INFO - Cleaning up... 15:17:48 INFO - Return code: 0 15:17:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:17:48 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 15:17:48 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 15:17:48 INFO - Using env: {'DISPLAY': ':0', 15:17:48 INFO - 'HOME': '/home/cltbld', 15:17:48 INFO - 'LANG': 'en_US.UTF-8', 15:17:48 INFO - 'LANGUAGE': 'en_US:en', 15:17:48 INFO - 'LOGNAME': 'cltbld', 15:17:48 INFO - 'MAIL': '/var/mail/cltbld', 15:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:48 INFO - 'MOZ_NO_REMOTE': '1', 15:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:48 INFO - 'NO_EM_RESTART': '1', 15:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:48 INFO - 'PWD': '/builds/slave/test', 15:17:48 INFO - 'SHELL': '/bin/bash', 15:17:48 INFO - 'SHLVL': '1', 15:17:48 INFO - 'TERM': 'linux', 15:17:48 INFO - 'TMOUT': '86400', 15:17:48 INFO - 'USER': 'cltbld', 15:17:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:48 INFO - '_': '/tools/buildbot/bin/python'} 15:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:17:50 INFO - Installing collected packages: mozsystemmonitor 15:17:50 INFO - Running setup.py install for mozsystemmonitor 15:17:50 INFO - Successfully installed mozsystemmonitor 15:17:50 INFO - Cleaning up... 15:17:50 INFO - Return code: 0 15:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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', '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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:17: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 blobuploader==1.2.4 15:17:50 INFO - Using env: {'DISPLAY': ':0', 15:17:50 INFO - 'HOME': '/home/cltbld', 15:17:50 INFO - 'LANG': 'en_US.UTF-8', 15:17:50 INFO - 'LANGUAGE': 'en_US:en', 15:17:50 INFO - 'LOGNAME': 'cltbld', 15:17:50 INFO - 'MAIL': '/var/mail/cltbld', 15:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:50 INFO - 'MOZ_NO_REMOTE': '1', 15:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:50 INFO - 'NO_EM_RESTART': '1', 15:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:50 INFO - 'PWD': '/builds/slave/test', 15:17:50 INFO - 'SHELL': '/bin/bash', 15:17:50 INFO - 'SHLVL': '1', 15:17:50 INFO - 'TERM': 'linux', 15:17:50 INFO - 'TMOUT': '86400', 15:17:50 INFO - 'USER': 'cltbld', 15:17:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:50 INFO - '_': '/tools/buildbot/bin/python'} 15:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:53 INFO - Downloading docopt-0.6.1.tar.gz 15:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:53 INFO - Running setup.py install for blobuploader 15:17:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:53 INFO - Running setup.py install for requests 15:17:53 INFO - Running setup.py install for docopt 15:17:53 INFO - Successfully installed blobuploader requests docopt 15:17:53 INFO - Cleaning up... 15:17:53 INFO - Return code: 0 15:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:17:53 INFO - Using env: {'DISPLAY': ':0', 15:17:53 INFO - 'HOME': '/home/cltbld', 15:17:53 INFO - 'LANG': 'en_US.UTF-8', 15:17:53 INFO - 'LANGUAGE': 'en_US:en', 15:17:53 INFO - 'LOGNAME': 'cltbld', 15:17:53 INFO - 'MAIL': '/var/mail/cltbld', 15:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:53 INFO - 'MOZ_NO_REMOTE': '1', 15:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:53 INFO - 'NO_EM_RESTART': '1', 15:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:53 INFO - 'PWD': '/builds/slave/test', 15:17:53 INFO - 'SHELL': '/bin/bash', 15:17:53 INFO - 'SHLVL': '1', 15:17:53 INFO - 'TERM': 'linux', 15:17:53 INFO - 'TMOUT': '86400', 15:17:53 INFO - 'USER': 'cltbld', 15:17:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:53 INFO - '_': '/tools/buildbot/bin/python'} 15:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:54 INFO - Running setup.py (path:/tmp/pip-JIo3Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:54 INFO - Running setup.py (path:/tmp/pip-uHq9Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:54 INFO - Running setup.py (path:/tmp/pip-oHELWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:54 INFO - Running setup.py (path:/tmp/pip-DA9Nwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:54 INFO - Running setup.py (path:/tmp/pip-yz4OiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 INFO - Running setup.py (path:/tmp/pip-N4EQO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 INFO - Running setup.py (path:/tmp/pip-r5zk4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 INFO - Running setup.py (path:/tmp/pip-HOIBhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:54 INFO - Running setup.py (path:/tmp/pip-_XyxoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:54 INFO - Running setup.py (path:/tmp/pip-0asq_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 INFO - Running setup.py (path:/tmp/pip-V7LEih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 INFO - Running setup.py (path:/tmp/pip-V8jY20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 INFO - Running setup.py (path:/tmp/pip-z5TuCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:54 INFO - Running setup.py (path:/tmp/pip-Ww5jpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:55 INFO - Running setup.py (path:/tmp/pip-5ZKcat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:55 INFO - Running setup.py (path:/tmp/pip-iANT02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:55 INFO - Running setup.py (path:/tmp/pip-zxb3nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:55 INFO - Running setup.py install for manifestparser 15:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozcrash 15:17:55 INFO - Running setup.py install for mozdebug 15:17:55 INFO - Running setup.py install for mozdevice 15:17:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozfile 15:17:55 INFO - Running setup.py install for mozhttpd 15:17:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozinfo 15:17:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozInstall 15:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozleak 15:17:56 INFO - Running setup.py install for mozlog 15:17:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for moznetwork 15:17:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozprocess 15:17:56 INFO - Running setup.py install for mozprofile 15:17:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozrunner 15:17:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozscreenshot 15:17:56 INFO - Running setup.py install for moztest 15:17:56 INFO - Running setup.py install for mozversion 15:17:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:57 INFO - Cleaning up... 15:17:57 INFO - Return code: 0 15:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:17:57 INFO - Using env: {'DISPLAY': ':0', 15:17:57 INFO - 'HOME': '/home/cltbld', 15:17:57 INFO - 'LANG': 'en_US.UTF-8', 15:17:57 INFO - 'LANGUAGE': 'en_US:en', 15:17:57 INFO - 'LOGNAME': 'cltbld', 15:17:57 INFO - 'MAIL': '/var/mail/cltbld', 15:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:57 INFO - 'MOZ_NO_REMOTE': '1', 15:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:57 INFO - 'NO_EM_RESTART': '1', 15:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:57 INFO - 'PWD': '/builds/slave/test', 15:17:57 INFO - 'SHELL': '/bin/bash', 15:17:57 INFO - 'SHLVL': '1', 15:17:57 INFO - 'TERM': 'linux', 15:17:57 INFO - 'TMOUT': '86400', 15:17:57 INFO - 'USER': 'cltbld', 15:17:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:57 INFO - '_': '/tools/buildbot/bin/python'} 15:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:57 INFO - Running setup.py (path:/tmp/pip-5qgAih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:57 INFO - Running setup.py (path:/tmp/pip-7UpmI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:57 INFO - Running setup.py (path:/tmp/pip-F1edbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:57 INFO - Running setup.py (path:/tmp/pip-C8R_Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:57 INFO - Running setup.py (path:/tmp/pip-3L3ygp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:57 INFO - Running setup.py (path:/tmp/pip-oyde8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:57 INFO - Running setup.py (path:/tmp/pip-IT8MKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:57 INFO - Running setup.py (path:/tmp/pip-ThmvQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:57 INFO - Running setup.py (path:/tmp/pip-3XNrg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:57 INFO - Running setup.py (path:/tmp/pip-9lqfv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:58 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)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:58 INFO - Running setup.py (path:/tmp/pip-z8Nqr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:58 INFO - Running setup.py (path:/tmp/pip-nHlI5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:58 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)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:58 INFO - Running setup.py (path:/tmp/pip-UfnCml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:58 INFO - Running setup.py (path:/tmp/pip-mz9MRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:58 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)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:58 INFO - Running setup.py (path:/tmp/pip-Bq4b7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:58 INFO - Running setup.py (path:/tmp/pip-7IJ4wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:58 INFO - Running setup.py (path:/tmp/pip-ckG4ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:00 INFO - Downloading blessings-1.6.tar.gz 15:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:00 INFO - Installing collected packages: blessings 15:18:00 INFO - Running setup.py install for blessings 15:18:00 INFO - Successfully installed blessings 15:18:00 INFO - Cleaning up... 15:18:00 INFO - Return code: 0 15:18:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:00 INFO - Reading from file tmpfile_stdout 15:18:00 INFO - Current package versions: 15:18:00 INFO - argparse == 1.2.1 15:18:00 INFO - blessings == 1.6 15:18:00 INFO - blobuploader == 1.2.4 15:18:00 INFO - docopt == 0.6.1 15:18:00 INFO - manifestparser == 1.1 15:18:00 INFO - mozInstall == 1.12 15:18:00 INFO - mozcrash == 0.17 15:18:00 INFO - mozdebug == 0.1 15:18:00 INFO - mozdevice == 0.48 15:18:00 INFO - mozfile == 1.2 15:18:00 INFO - mozhttpd == 0.7 15:18:00 INFO - mozinfo == 0.9 15:18:00 INFO - mozleak == 0.1 15:18:00 INFO - mozlog == 3.1 15:18:00 INFO - moznetwork == 0.27 15:18:00 INFO - mozprocess == 0.22 15:18:00 INFO - mozprofile == 0.28 15:18:00 INFO - mozrunner == 6.11 15:18:00 INFO - mozscreenshot == 0.1 15:18:00 INFO - mozsystemmonitor == 0.0 15:18:00 INFO - moztest == 0.7 15:18:00 INFO - mozversion == 1.4 15:18:00 INFO - psutil == 3.1.1 15:18:00 INFO - requests == 1.2.3 15:18:00 INFO - wsgiref == 0.1.2 15:18:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:00 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:18:00 INFO - Using env: {'DISPLAY': ':0', 15:18:00 INFO - 'HOME': '/home/cltbld', 15:18:00 INFO - 'LANG': 'en_US.UTF-8', 15:18:00 INFO - 'LANGUAGE': 'en_US:en', 15:18:00 INFO - 'LOGNAME': 'cltbld', 15:18:00 INFO - 'MAIL': '/var/mail/cltbld', 15:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:00 INFO - 'MOZ_NO_REMOTE': '1', 15:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:00 INFO - 'NO_EM_RESTART': '1', 15:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:00 INFO - 'PWD': '/builds/slave/test', 15:18:00 INFO - 'SHELL': '/bin/bash', 15:18:00 INFO - 'SHLVL': '1', 15:18:00 INFO - 'TERM': 'linux', 15:18:00 INFO - 'TMOUT': '86400', 15:18:00 INFO - 'USER': 'cltbld', 15:18:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:00 INFO - '_': '/tools/buildbot/bin/python'} 15:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:18:01 INFO - Cleaning up... 15:18:01 INFO - Return code: 0 15:18:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:01 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:18:01 INFO - Using env: {'DISPLAY': ':0', 15:18:01 INFO - 'HOME': '/home/cltbld', 15:18:01 INFO - 'LANG': 'en_US.UTF-8', 15:18:01 INFO - 'LANGUAGE': 'en_US:en', 15:18:01 INFO - 'LOGNAME': 'cltbld', 15:18:01 INFO - 'MAIL': '/var/mail/cltbld', 15:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:01 INFO - 'MOZ_NO_REMOTE': '1', 15:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:01 INFO - 'NO_EM_RESTART': '1', 15:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:01 INFO - 'PWD': '/builds/slave/test', 15:18:01 INFO - 'SHELL': '/bin/bash', 15:18:01 INFO - 'SHLVL': '1', 15:18:01 INFO - 'TERM': 'linux', 15:18:01 INFO - 'TMOUT': '86400', 15:18:01 INFO - 'USER': 'cltbld', 15:18:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:01 INFO - '_': '/tools/buildbot/bin/python'} 15:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:01 INFO - Downloading/unpacking jsonschema 15:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:03 INFO - Downloading/unpacking functools32 (from jsonschema) 15:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:03 INFO - warning: no files found matching '*.txt' 15:18:03 INFO - no previously-included directories found matching 'build' 15:18:03 INFO - no previously-included directories found matching 'dist' 15:18:03 INFO - no previously-included directories found matching '.git*' 15:18:03 INFO - Installing collected packages: jsonschema, functools32 15:18:03 INFO - Running setup.py install for functools32 15:18:03 INFO - warning: no files found matching '*.txt' 15:18:03 INFO - no previously-included directories found matching 'build' 15:18:03 INFO - no previously-included directories found matching 'dist' 15:18:03 INFO - no previously-included directories found matching '.git*' 15:18:03 INFO - Successfully installed jsonschema functools32 15:18:03 INFO - Cleaning up... 15:18:03 INFO - Return code: 0 15:18:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:03 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 0x7fedfb3acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, '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': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:18:03 INFO - Using env: {'DISPLAY': ':0', 15:18:03 INFO - 'HOME': '/home/cltbld', 15:18:03 INFO - 'LANG': 'en_US.UTF-8', 15:18:03 INFO - 'LANGUAGE': 'en_US:en', 15:18:03 INFO - 'LOGNAME': 'cltbld', 15:18:03 INFO - 'MAIL': '/var/mail/cltbld', 15:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:03 INFO - 'MOZ_NO_REMOTE': '1', 15:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:03 INFO - 'NO_EM_RESTART': '1', 15:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:03 INFO - 'PWD': '/builds/slave/test', 15:18:03 INFO - 'SHELL': '/bin/bash', 15:18:03 INFO - 'SHLVL': '1', 15:18:03 INFO - 'TERM': 'linux', 15:18:03 INFO - 'TMOUT': '86400', 15:18:03 INFO - 'USER': 'cltbld', 15:18:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:03 INFO - '_': '/tools/buildbot/bin/python'} 15:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:03 INFO - Downloading/unpacking flake8 15:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:18:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:18:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:06 INFO - no previously-included directories found matching 'docs/_build' 15:18:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:18:06 INFO - Running setup.py install for pep8 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:06 INFO - no previously-included directories found matching 'docs/_build' 15:18:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:18:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:18:06 INFO - Cleaning up... 15:18:06 INFO - Return code: 0 15:18:06 INFO - Running post-action listener: _resource_record_post_action 15:18:06 INFO - Running post-action listener: _start_resource_monitoring 15:18:06 INFO - Starting resource monitoring. 15:18:06 INFO - ##### 15:18:06 INFO - ##### Running install step. 15:18:06 INFO - ##### 15:18:06 INFO - Running pre-action listener: _resource_record_pre_action 15:18:06 INFO - Running main action method: install 15:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:06 INFO - Reading from file tmpfile_stdout 15:18:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:06 INFO - Reading from file tmpfile_stdout 15:18:06 INFO - Output received: 15:18:07 INFO - Usage: mozinstall [options] installer 15:18:07 INFO - Options: 15:18:07 INFO - -h, --help show this help message and exit 15:18:07 INFO - -d DEST, --destination=DEST 15:18:07 INFO - Directory to install application into. [default: 15:18:07 INFO - "/builds/slave/test"] 15:18:07 INFO - --app=APP Application being installed. [default: firefox] 15:18:07 INFO - mkdir: /builds/slave/test/build/application 15:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:18:22 INFO - Reading from file tmpfile_stdout 15:18:22 INFO - Output received: 15:18:22 INFO - /builds/slave/test/build/application/firefox/firefox 15:18:22 INFO - Running post-action listener: _resource_record_post_action 15:18:22 INFO - ##### 15:18:22 INFO - ##### Running run-tests step. 15:18:22 INFO - ##### 15:18:22 INFO - Running pre-action listener: _resource_record_pre_action 15:18:22 INFO - Running main action method: run_tests 15:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:22 INFO - Python 2.7.3 15:18:22 INFO - Return code: 0 15:18:22 INFO - grabbing minidump binary from tooltool 15:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:22 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 0x1973160>, '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 0x1974060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19744f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:18:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:18:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:22 INFO - Return code: 0 15:18:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:18:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:18:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:18:23 INFO - Return code: 0 15:18:23 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/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 15:18:23 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/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 15:18:23 INFO - Using env: {'DISPLAY': ':0', 15:18:23 INFO - 'HOME': '/home/cltbld', 15:18:23 INFO - 'LANG': 'en_US.UTF-8', 15:18:23 INFO - 'LANGUAGE': 'en_US:en', 15:18:23 INFO - 'LOGNAME': 'cltbld', 15:18:23 INFO - 'MAIL': '/var/mail/cltbld', 15:18:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:23 INFO - 'MOZ_NO_REMOTE': '1', 15:18:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:23 INFO - 'NO_EM_RESTART': '1', 15:18:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:23 INFO - 'PWD': '/builds/slave/test', 15:18:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:23 INFO - 'SHELL': '/bin/bash', 15:18:23 INFO - 'SHLVL': '1', 15:18:23 INFO - 'TERM': 'linux', 15:18:23 INFO - 'TMOUT': '86400', 15:18:23 INFO - 'USER': 'cltbld', 15:18:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796', 15:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:23 INFO - '_': '/tools/buildbot/bin/python'} 15:18:23 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/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 15:18:23 INFO - mozversion application_buildid: 20160420124052 15:18:23 INFO - mozversion application_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 15:18:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:18:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:23 INFO - mozversion application_name: Firefox 15:18:23 INFO - mozversion application_remotingname: firefox-dev 15:18:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:18:23 INFO - mozversion application_vendor: Mozilla 15:18:23 INFO - mozversion application_version: 47.0a2 15:18:23 INFO - mozversion platform_buildid: 20160420124052 15:18:23 INFO - mozversion platform_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 15:18:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:18:23 INFO - mozversion platform_version: 47.0a2 15:18:23 INFO - using testdate: 1461190703 15:18:23 INFO - actual date: 1461190703 15:18:23 INFO - starting webserver on 'localhost:53424' 15:18:23 INFO - SUITE-START | Running 2 tests 15:18:23 INFO - TEST-START | dromaeo_css 15:18:23 INFO - operating with platform_type : linux_ 15:18:23 INFO - Initialising browser for dromaeo_css test... 15:18:23 INFO - TEST-INFO | started process 11558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHxIst1/profile http://localhost:53424/getInfo.html) 15:18:27 INFO - PROCESS | 11558 | __metrics Screen width/height:1600/1200 15:18:27 INFO - PROCESS | 11558 | colorDepth:24 15:18:27 INFO - PROCESS | 11558 | Browser inner width/height: 1024/697 15:18:27 INFO - PROCESS | 11558 | __metrics 15:18:28 INFO - PROCESS | 11558 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:29 INFO - TEST-INFO | 11558: exit 0 15:18:29 INFO - Browser initialized. 15:18:29 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:29 INFO - TEST-INFO | started process 11649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHxIst1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:41 INFO - PROCESS | 11649 | RSS: Main: 142102528 15:18:41 INFO - PROCESS | 11649 | 15:19:32 INFO - PROCESS | 11649 | 1461190772575 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:21:40 INFO - PROCESS | 11649 | Cycle 1(1): loaded http://localhost:53424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53424/tests/dromaeo/cssquery-ext.html) 15:21:41 INFO - PROCESS | 11649 | RSS: Main: 253202432 15:21:41 INFO - PROCESS | 11649 | 15:24:43 INFO - PROCESS | 11649 | Cycle 1(1): loaded http://localhost:53424/tests/dromaeo/cssquery-ext.html (next: http://localhost:53424/tests/dromaeo/cssquery-jquery.html) 15:24:44 INFO - PROCESS | 11649 | RSS: Main: 229539840 15:24:44 INFO - PROCESS | 11649 | 15:27:46 INFO - PROCESS | 11649 | Cycle 1(1): loaded http://localhost:53424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53424/tests/dromaeo/cssquery-mootools.html) 15:27:46 INFO - PROCESS | 11649 | RSS: Main: 226426880 15:27:46 INFO - PROCESS | 11649 | 15:30:48 INFO - PROCESS | 11649 | Cycle 1(1): loaded http://localhost:53424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53424/tests/dromaeo/cssquery-prototype.html) 15:30:49 INFO - PROCESS | 11649 | RSS: Main: 214110208 15:30:49 INFO - PROCESS | 11649 | 15:33:51 INFO - PROCESS | 11649 | Cycle 1(1): loaded http://localhost:53424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53424/tests/dromaeo/cssquery-yui.html) 15:33:52 INFO - PROCESS | 11649 | RSS: Main: 215539712 15:33:52 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | Cycle 1(1): loaded http://localhost:53424/tests/dromaeo/cssquery-yui.html (next: http://localhost:53424/tests/dromaeo/cssquery-dojo.html) 15:36:54 INFO - PROCESS | 11649 | RSS: Main: 259710976 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | __start_tp_report 15:36:54 INFO - PROCESS | 11649 | _x_x_mozilla_page_load 15:36:54 INFO - PROCESS | 11649 | _x_x_mozilla_page_load_details 15:36:54 INFO - PROCESS | 11649 | |i|pagename|runs| 15:36:54 INFO - PROCESS | 11649 | |0;dojo.html;3277.2462333663257;3360.2271477560175;3365.5288259643653;3377.206356506222;3390.4066788312048;5500.642458240211;5504.394516603171;5543.861403464915;5547.140193270045;5549.38956714761;5504.559635229182;5541.889162216763;5550.333959924805;5559.971405290024;5564;4827.686200396981;4993.350864387634;5013.097642424362;5105.5149760772665;5118.9488105119035;4905.4358748744;4995.450500444948;5006.474320196382;5064.037832811754;5068.113080210948;5032.647714659957;5039.395272567297;5042.319286896259;5052.4189718182515;5088.033273678007;4876.463589005207;4982.377202849644;5002.424721157041;5024.346834911475;5060.949390506103;4931.80272789088;4952;4958.429780575244;4968.90062198754;4972.254161875748;5351.036813373591;5367.221752845854;5372.118703926647;5376;5421.539169170625;5750.7412166452195;5903;5911.172435858984;5926.7925622603;5983.072623743326;6019.036954087325;6037.7584896604085;6038.667873266969;6046.848828779272;6051.4553690168095;5622.269105016322;5624.0439125348785;5627.606067575312;5629.211910332557;5653.547716182737;5916.26046744157;6045.183900173421;6114.969425152845;6116.816495505142;6126.731429653714;5764.394738552392;5781.5952883298605;5781.913271300934;5783.942160578425;5797.36229014808;5834.591578589458;5872.794452194238;5892.175095486636;5896.941030589725;5900.704964751745;5748.223989761413;5869.911951320733;5922.763089476372;5941.613795103391;5950.226470558886;5774.2782152230975;5807.419258074159;5811.244538210006;5816.5055970243;5819.709014549256;4453.710508816916;4461.420015398043;4464.977675111603;4468;4485.708428952173;3949.4273330366937;4027.838886444568;4102.774347410921;4106.507219133723;4120.114175452292;5514.862128446821;5518.172274158828;5525.392206857243;5526.613137080366;5529.502344788988;5937.2578427696535;5938.376470470538;5940.910886336708;5943.138244954457;5944.197533333031;5311.920321195185;5551.8889622207325;5597.6641401516035;5610.27066481363;5634.943650563524;5033.84898453047;5035.043341765053;5039.874003149951;5044.344235249394;5068.265101560253;5995.250593675791;6002.369751176151;6002.579819412686;6018.337982821886;6025.457708806229;5892.381299963614;5954.136650185612;5964.701764911651;5978.461938425563;5983.670898100646;6005.669688167192;6079;6079.3008803988105;6082.695865206633;6092.75628974836;5632.690202038763;5864.149698293809;5869.325027621708;5884.0585506318785;5884.499817515559;5907.734151963258;5908.291005079418;5910.083936989773;5916.49709774674;5951.7619295227705;5728.713564321684;5729.054705973635;5729.828105156852;5733.254676891977;5749.482546570829;5635.746391412478;5746.9712651436475;5752.9137062943255;5836.970815146067;5898.557608179318;5596.972015139898;5621.690807005654;5627.0715331971405;5627.634203776742;5656.038473459604;5655.4344565543115;5727.599068065362;5743.684097374685;5745.425457454388;5753.741081651252;5555.2222688822785;5640.85897852557;5644.266245388073;5727.513161381163;5746.2529871116485 15:36:54 INFO - PROCESS | 11649 | |1;ext.html;554.8085910360925;568.5281216590233;575.5855783835636;587.0694948506617;591.3347484080409;33539.32921341572;45417;45704.54295457045;45968;46012.07975840481;49411;50180.749096254556;50186.24720629193;50222.74888625552;50275.748621256935;9165.129312715282;9313.813723725521;9383.390079644836;9390.107939745712;9391.389559678633;9098.272138228958;9262.76843078925;9266.212371948359;9267.073292670746;9268.073192680711;9248;9249.53752312385;9268.536573171348;9271.21194698448;9273.119053689888;9096.636134554643;9236.030216827237;9259.675911343138;9261.027592102799;9261.583228754655;9151.588178531916;9304.348695591312;9323.25413966881;9325.06749325062;9326.347155699104;45136.54863451389;45652.77173614144;45672;45737.542624573995;45744;3700.5374328208973;3759.661630453272;3791.336516109697;3804.239152169577;3844.5002149720635;34384;35362.29275414503;36177.27645447103;36336.818315908255;36553.268934621155;4046.271671099201;4195.139996300782;4221.78891055446;4279.930017495626;4377.7592232427205;245480;249073;249339;249406;249721;49212.26181607279;73705;74903.25096749072;75390.24609753833;75391.62304188554;49611.503884960686;50103;50105.74947125241;50150;50198.2470262939;17039.233234504478;17210.741838872425;17240;17240.482785516455;17259.654806904044;12550.623481295575;12559.874401256053;12560.246385216917;12563.309018003914;12575.119741618182;16785.66428671444;16798.24407901623;16920.492385228463;16995.81029327935;17087.914560427365;6339.41822870077;6447.451966582799;6511.739530418825;6618.768343107968;6672;923.3674932671141;962.3263715399248;982.1111893736038;1046.042870773234;1110.2228440091967;31244.687553124633;31546.842265788524;31561.684383155876;32162.83918580392;32304.676953230635;1102.9007389334838;1121.0135081128556;1142.457332766929;1187.8812118788053;1190.2917763930448;16178.514644560682;16483.093429861234;16534;16696.081715505763;16943.91528042352;368220;369716;370132;372961;373860;60366.69816650889;61555;61708.38291617027;61730;61777.69111154506;1331.3609467455483;1452.3028946105928;1471.8601732835364;1476.151213052499;1491.8135233095863;30478.65097929672;30669.693303067575;30930.226744331572;31448.685513144577;31820.5226921601;48652;48706.512934870196;49105;49204.26193607171;49262.75368623134;205001;206103;217456;219194;219277;32075.518867216542;36443.27113457769;36765.26469470649;37109.81445092865;37128.257434851694;46833.531664682916;46930.29604555866;47034.529654703016;47947.76026119847;48336.274955874986;39900.2019959605;40303.798481007405;40359.59640403558;40649.1870162601;41167.1766564661;39000.804995975974;39931.40102898401;40068.1986360277;40279.798601006805;40367.19265614612;38651;38881.2223755529;39053.41419878761;39840.2031959365;39861.2027759449;34945;36382;36421;36470.8176459116;36643.26713465663;27095.72904270932;27123;27342.86328568424;27409;27676.169714908585 15:36:54 INFO - PROCESS | 11649 | |2;jquery.html;376.25501507016105;384.5942530630184;389.56664372226527;395.9448070891074;408.61590105301013;17111.657766844655;17614.207360668785;17630.559236019108;17656.205470753815;17806.28774849008;16769.24538395772;16819.66360672786;17315;17438;17674.469765907044;5629.296337957755;5777.451142141511;5791.565632577553;5794.913076303858;5814.156947242647;5546.639468434559;5672.262605861232;5686.147077938301;5720.141978703186;5772.7113644317615;5660.094384898417;5667.603267771257;5676.772929082852;5691.658500489963;5697.202391665171;5546.91679624806;5600.691961942091;5639.661620302774;5653.830385088454;5725.083986562172;5095.286659867622;5112.948870511322;5117.795288188505;5131.948680513185;5133.460986596391;20509.17963281467;20728;20973;21105.366838994854;21145.894270528548;2357.4342157882156;2392.892319845611;2597.0520759922683;2747.697753247141;2840.3183236023206;13342.733145337135;13547.796783048263;13556;13946.651333716738;14108.576742697736;1868.4021113243768;1940.1172466527837;1948.2012374926212;1990.4625751047136;2012.9094190761305;63209.68395158041;64798.3520164797;65692.67153664201;66449.66775166141;69121.96317055299;10620.468976551141;10686.25196236256;10787.67636970892;10805.13558915285;10899.782004359868;15456;15506.844931550766;15537.145456999748;15551.688966220838;15573.377064917277;8247.95876020616;8268.421210515327;8435.957820210982;8508.65965361391;8546.572671366532;8224.506529608243;8256.25693687559;8274.751757447286;8317.126701696356;8319.168083191753;4864.197407427806;4879.878003049881;4879.926801097987;4887.877803054952;4954.925676114861;1831.705813329099;1934.94195174145;2006.3278801601334;2012.1247257443058;2032.6664270596234;918.8851393575803;931.0875342164717;989.7030890732751;1027.712240572626;1108.4014632098738;17407.390741323994;17952.730709039373;18067.909660451613;18239.452816415527;18409.355672551395;976.9364991275544;990.390909590611;994.8408254679216;1031.3554028732042;1054.8154073037188;10167.949160254151;10383.169346452265;10392.116670082976;10393.480325983823;10623.36259824413;382257;383483;387010;435908;438756;68732.3126768736;82216.58891705504;83082.58458707789;83505;83657;1046.1421634259834;1091.1925175370327;1092.7377429416883;1100.5047728522036;1113.3486910157487;15988.68022639564;16001.359945602046;16156.919215404318;16170.514884553482;16403.753943691092;31797.36405271928;35238;35261.471077934366;35398;35764.4635330465;47358.28962565495;50200.49799502104;50728.23907641315;51076.48923510866;51508.484915150366;8409.422389162897;8447.788805279917;8457.87313190315;8472.237498625153;8520.446170998865;9798.853017204605;10377;11139.220254582102;11182.608608698656;12329.951954084003;8063;8733.56332183401;10128.59485620567;10557.208209384173;10588.947055264674;9360.95319523398;10253.641122560675;10290.742731431475;10456.215783816093;10479.528421220912;10199.898001019896;10267.486625668538;10301.866794652733;10461.633842815465;10574.154067674413;7986.2013798622;8220.3834712398;8239.423240373117;8298.170182981654;8303.418760686694;9250.344565846946;10435.58257669715;10509.789804204025;10524.579016839241;10860.728481788019 15:36:54 INFO - PROCESS | 11649 | |3;mootools.html;1497.3935556099784;1577.2586884164443;1612.798400199975;1840.9263629454822;1979.4061781465557;7897.842043159133;8055.395845311603;8056.516609003464;8056.91943080569;8072.152423995484;7990.680372785097;8120.269175774194;8143.633536490857;8159.4288399811885;8179.263866252036;2063.8658487198286;2279.4415368234722;2336.123953517431;2369.1589485732575;2402.699662542182;2350.306659535441;2357.163207061494;2358.127492827656;2359.0327965534134;2361.5985282502015;2300.7584203658625;2355.6584295277175;2356.7878890899815;2365.420471984366;2368.1948137633203;2351.247600767755;2384.892679829412;2400.8559486430872;2403.062805505854;2406.6991626046743;2362.6219804831144;2380.8928598213124;2390.1634427950253;2422.563938491071;2425.466397392571;8279.710210142677;8333.95833020831;8340.874886876702;8352.916470835275;8360.623771930277;5017.071841709296;5137.306463627438;5143.5113664201845;5144.717040562768;5144.742762861842;3126.04655580048;3211.3577284542953;3212.0363890832655;3220.1949512621845;3276.2300859298048;1080.8702955645374;1084.360227465791;1090.650991682662;1104.9060829829475;1120.1151090638468;11709.590164344207;11712.180147389687;11735.119866009998;11755.94122029393;11769.411529423494;4522.954770452254;4532.70537415067;4546;4577.862664120082;4582.679212455163;9856.50717464124;9865.80268394628;9870.25973052024;9874.851877221847;9875.802483950281;4572.3827283317;5203.661761985459;5220.477952204749;5221.791128354899;5230.137027390514;4567.817287308537;4635.675502714845;4648.1168577970075;4665.113628410591;4669.929951050737;3696.6488183622514;3781.054736315921;3788.0719223790347;3790.450384694259;3865.2849222893856;1173.8767429419959;1183.0831105893;1186.258588382261;1190.7916114679897;1216.7870622641003;1466.142306750563;1470.3677418709844;1486.4277253257358;1488.8213414390343;1506.4727345429012;8018.118007019223;8045.959770201229;8060.798480038046;8082.595870206584;8087.1912808719835;547.4990383798779;551.6552154903186;552.1248820619284;565.2820917434834;565.8217661436635;6109.5112391008615;6113.57204995655;6122.479589234876;6129.84675383119;6179.84550386244;9904.653337133166;10189.74525636865;10200.693979180636;10286.948565257275;10325.070743633109;9594.184494317922;10151.64469243573;10178;10196.4391958443;10197.94901025505;7769.145394006655;7869.252421019994;7970.840583188304;8007.199280072063;8009.559474228857;7889.053313602404;7893.565853878092;7916.84166316659;7966.3626909848235;8003.4797738146835;8627.439216451161;8843.734687959372;9052.728418147466;9264.16622503951;9278.257739380968;8954.238889694449;9157.31320150978;9196.58615362297;9222.631094756134;9284.675036373965;6661.16735408074;7028.578285302899;7195.640217989185;7310.744123955636;7427.925720742724;7762.4954377967515;7772.84454310922;7802.570858602831;7820.608969551614;7838.412119091205;7011.8247043822275;7187;7193.460490463341;7290.708371665074;7324.377427918474;6911.274316196928;7029.789106326818;7042.894356584758;7060.8940865886025;7146.071010768775;7330.303621155982;7581.658825352762;7624.5425274483705;7626.122995855326;7634.4655874088285;6743.898841517479;6765.9661701691175;6771.255161932085;6772.288909664414;6777.661116944231;6877.277885821916;6916.515843890879;6923.515353925177;6976.476764242803;6987.301269872972 15:36:54 INFO - PROCESS | 11649 | |4;prototype.html;366.4338596867839;369.4993284100044;377.2850448400283;379.25665695237336;386.96517313441785;6033.7888173913925;6100.450959413652;6112.2970858351355;6119.204503414561;6138;6012.218411606496;6029.065494848305;6035.668038257894;6037.516998640098;6046.697665116749;4502.122086193193;4592.655550833684;4705.505921878204;4724.267738500538;4790.592799612037;4743.288506723985;4756.714597124166;4772.4273087229585;4775.785089670973;4783.593394561466;4716.740579268139;4717.646176536757;4726.952730472703;4727.692699974491;4733.976330118345;4490.371348011281;4565.406497155382;4677.766111694402;4690.81236750533;4709.105269998689;4158.6465150462245;4183.393407955829;4193.391958166079;4199.181159673864;4218.303979843322;5739.196512488255;5739.770409183628;5745.396733342981;5745.540356771448;5747.281589801275;5531.889362212773;5534.142207957773;5539.113741801292;5543.584231182677;5558.471945165203;6411.67941602918;6412.198475190601;6412.583182093149;6417.550771446001;6420.261669907974;4310.245707001262;4367.323064924942;4390.341448782676;4432.645388368955;4668.883277918046;6658.201015878077;6688.3646053624825;6724.092247546617;6729.663516824139;6730.831729206809;4685.81256749733;4688.062387522509;4690.9765451172525;4693.507181745936;4699.835505757351;4743.691660042086;4751.548602882721;4755.857324280277;4758.619310455155;4763.476017638057;5446.7276636168035;5452.482014208644;5457.045017121988;5460.890782184413;5470.398256191816;6347.936520634827;6470.029495575702;6472.449841763409;6496.512761542903;6503.7073331700185;1651.884368094246;1661.2773443551853;1668.57451349905;1669.1654172913543;1671.4484220207303;1033.8397548380012;1050.369778133114;1086.098538213281;1103.9944800276107;1110.4725255503733;6026.6986650667295;6165.229346331708;6175.814725558241;6215.316315205324;6265.248170219603;6722.630255336004;6735.225449073321;6747.392734653905;6758.797236082925;6769.255381907986;6236.18929539157;6251.12484252205;6257.468115210167;6265.028920517327;6269.529785266123;3575.7318201135017;3612.205314830733;3612.3317186320614;3613.205094879175;3628.9818550907075;6797.72809087631;6880.4839637026425;6963.1296087989;6966.164060312693;6978.895316570255;6886.449084073262;6903.378695917391;6908.6545672716165;6913.965430172817;6916.861662766716;6943.409810166091;6950.965245173843;6956.339147780953;6957.791266261919;6965.094537710166;6686.364795344434;6718.630475323904;6723.159605049369;6738.59568425896;6739.0902228198565;6416.454601358937;6571.080048793077;6595.736170553124;6596.373344532261;6603.80188594343;6844.8973265402055;6876.793696189123;6881.346272104142;6882.4149947253045;6892.069570607904;4701.882452938704;4706.035262771055;4706.788194531186;4707.317438971399;4708.128996135726;6760.459163266829;6801.931980680328;6825.52221344521;6826.726930922708;6831.453483721191;6436.184346491069;6463.935360646334;6549.214094308713;6573.211214654081;6573.638449885302;6493;6511.706973186123;6519.511036672174;6526;6529.085927969993;6417.133686952202;6426.260979987174;6427.517936154901;6431.453326467115;6432.581882177644;6571.868562628816;6577.901331479936;6580.8354791130605;6586.110875031809;6597.3072827352435;6144.508439324933;6188.566800324114;6234.719437625408;6393.1688880445245;6411.647359395091 15:36:54 INFO - PROCESS | 11649 | |5;yui.html;769.4882902869592;823.5388182617735;856.6616186606291;905.47934937411;922.8154369126174;14146.64633384166;14557.12657240565;14557.92721036396;14589.343479543419;14643.341049652765;13334.333283335818;13378.331083445837;13389.263590502518;13530.594082177526;13552.051356405056;764.598585742484;908.0465511213233;909.6406919266902;921.0835218957113;936.1527817325332;923.2014307623924;928.5264515097315;929.3169520402499;931.1061381074177;931.5156118818211;978.2223132609593;981.6466072213997;982.0572250639394;982.1160955140359;983.2576404814355;814.1166833985104;971.1842052675715;974.4543055888689;981.5975450065511;984.4733067808688;729.2488736601309;729.4419768876813;729.580491217552;730.1202051527896;730.747891977267;14047.367868445945;14132.081414708011;14157.07978981363;14158.221297828615;14158.292085395791;14041.578752637437;14253.501127460593;14540.200288984102;14600.561983140522;14789.11265324084;11614.767704645945;11618.419079046014;11840.88159118415;12233.93883030588;12234.143609947307;3964.048628329209;3975.0857302820223;4035.394690796404;4045.6763458923215;4121.567235440266;49414.2587861186;50194;50633;50720.49279507194;50943;10660;10660.520276587573;10725.892741072645;11047.779044419067;11103.611373601885;19329.323473678636;19466.416007519798;19518;19540.902295488715;19545.609087818164;8363.58182090893;8434.704785332484;8457.281131103926;8683.2185103341;8737.825243495094;4495.213337665896;4539.546045395434;4574.679772415965;4584.724916505021;4657;3364.8485818138242;3423.8801641942414;3433.261848702491;3440.82795860206;3451.5340429041757;584.403908013832;642.1363266406676;644.6551095164065;651.7621068310033;655.6426747422666;685.8353995041253;715.8639858426882;734.8860926556392;739.9371053460409;744.9776506704808;7549.811254718676;7688.474265438801;7912.327452166515;7969.521828690297;8026.638801253957;554.3790954131399;617.062065660194;681.7409384433884;689.5965859971973;697.1982220446527;3606.1672698428333;3636.9636303636626;3705.0552109212517;3709.350863598859;3813.980930095387;60792.08811867826;61324.69337653372;61754.69122654358;61766;61884.690576546825;54718.17922731162;55355.44644553583;55605.44394556084;55809.72095139579;55823.44176558264;48594;48933.75533122383;49995.75002125039;50762;50778;7938.5236885787035;8087;8121.512709237465;8495.8725619117;8550.57247137653;37215.813920930224;37431.43852842155;38736.418953715154;38851.222975539764;38876.41685374778;43967;45364;46253.537464624926;47006.294905577124;48976.755116224194;12347.938260308641;12386.256824590553;12547.36715976792;12554.309512976874;12717.745645087232;12609.117361784587;12616.17994830333;12977.740445190855;13034.413451394521;13172.47310107585;10598.417087060287;10686;11199.496022679163;11226.943865280948;11826.231294965799;10398.948005259925;10484.790304194026;10495.265331426726;10717.464126793473;10735.89264107349;10344.741381465523;10841.295315804447;11042.282251653616;11224.102071834397;11675;9945.850812237677;10483;10565.63020294286;10634.14926805869;10656.413897235416;9509.286803489627;9695.466749328572;9760.707178784647;9838.114569688762;9843.606255749975 15:36:54 INFO - PROCESS | 11649 | __end_tp_report 15:36:54 INFO - PROCESS | 11649 | __start_cc_report 15:36:54 INFO - PROCESS | 11649 | _x_x_mozilla_cycle_collect,895 15:36:54 INFO - PROCESS | 11649 | __end_cc_report 15:36:54 INFO - PROCESS | 11649 | __startTimestamp1461191814732__endTimestamp 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | ------- Summary: start ------- 15:36:54 INFO - PROCESS | 11649 | Number of tests: 6 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | [#0] dojo.html Cycles:165 Average:5475.18 Median:5644.27 stddev:605.09 (10.7%) stddev-sans-first:581.86 15:36:54 INFO - PROCESS | 11649 | Values: 3277.2 3360.2 3365.5 3377.2 3390.4 5500.6 5504.4 5543.9 5547.1 5549.4 5504.6 5541.9 5550.3 5560.0 5564.0 4827.7 4993.4 5013.1 5105.5 5118.9 4905.4 4995.5 5006.5 5064.0 5068.1 5032.6 5039.4 5042.3 5052.4 5088.0 4876.5 4982.4 5002.4 5024.3 5060.9 4931.8 4952.0 4958.4 4968.9 4972.3 5351.0 5367.2 5372.1 5376.0 5421.5 5750.7 5903.0 5911.2 5926.8 5983.1 6019.0 6037.8 6038.7 6046.8 6051.5 5622.3 5624.0 5627.6 5629.2 5653.5 5916.3 6045.2 6115.0 6116.8 6126.7 5764.4 5781.6 5781.9 5783.9 5797.4 5834.6 5872.8 5892.2 5896.9 5900.7 5748.2 5869.9 5922.8 5941.6 5950.2 5774.3 5807.4 5811.2 5816.5 5819.7 4453.7 4461.4 4465.0 4468.0 4485.7 3949.4 4027.8 4102.8 4106.5 4120.1 5514.9 5518.2 5525.4 5526.6 5529.5 5937.3 5938.4 5940.9 5943.1 5944.2 5311.9 5551.9 5597.7 5610.3 5634.9 5033.8 5035.0 5039.9 5044.3 5068.3 5995.3 6002.4 6002.6 6018.3 6025.5 5892.4 5954.1 5964.7 5978.5 5983.7 6005.7 6079.0 6079.3 6082.7 6092.8 5632.7 5864.1 5869.3 5884.1 5884.5 5907.7 5908.3 5910.1 5916.5 5951.8 5728.7 5729.1 5729.8 5733.3 5749.5 5635.7 5747.0 5752.9 5837.0 5898.6 5597.0 5621.7 5627.1 5627.6 5656.0 5655.4 5727.6 5743.7 5745.4 5753.7 5555.2 5640.9 5644.3 5727.5 5746.3 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | [#1] ext.html Cycles:180 Average:47096.74 Median:39999.80 stddev:74826.65 (187.1%) stddev-sans-first:74954.96 15:36:54 INFO - PROCESS | 11649 | Values: 554.8 568.5 575.6 587.1 591.3 33539.3 45417.0 45704.5 45968.0 46012.1 49411.0 50180.7 50186.2 50222.7 50275.7 9165.1 9313.8 9383.4 9390.1 9391.4 9098.3 9262.8 9266.2 9267.1 9268.1 9248.0 9249.5 9268.5 9271.2 9273.1 9096.6 9236.0 9259.7 9261.0 9261.6 9151.6 9304.3 9323.3 9325.1 9326.3 45136.5 45652.8 45672.0 45737.5 45744.0 3700.5 3759.7 3791.3 3804.2 3844.5 34384.0 35362.3 36177.3 36336.8 36553.3 4046.3 4195.1 4221.8 4279.9 4377.8 245480.0 249073.0 249339.0 249406.0 249721.0 49212.3 73705.0 74903.3 75390.2 75391.6 49611.5 50103.0 50105.7 50150.0 50198.2 17039.2 17210.7 17240.0 17240.5 17259.7 12550.6 12559.9 12560.2 12563.3 12575.1 16785.7 16798.2 16920.5 16995.8 17087.9 6339.4 6447.5 6511.7 6618.8 6672.0 923.4 962.3 982.1 1046.0 1110.2 31244.7 31546.8 31561.7 32162.8 32304.7 1102.9 1121.0 1142.5 1187.9 1190.3 16178.5 16483.1 16534.0 16696.1 16943.9 368220.0 369716.0 370132.0 372961.0 373860.0 60366.7 61555.0 61708.4 61730.0 61777.7 1331.4 1452.3 1471.9 1476.2 1491.8 30478.7 30669.7 30930.2 31448.7 31820.5 48652.0 48706.5 49105.0 49204.3 49262.8 205001.0 206103.0 217456.0 219194.0 219277.0 32075.5 36443.3 36765.3 37109.8 37128.3 46833.5 46930.3 47034.5 47947.8 48336.3 39900.2 40303.8 40359.6 40649.2 41167.2 39000.8 39931.4 40068.2 40279.8 40367.2 38651.0 38881.2 39053.4 39840.2 39861.2 34945.0 36382.0 36421.0 36470.8 36643.3 27095.7 27123.0 27342.9 27409.0 27676.2 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | [#2] jquery.html Cycles:180 Average:25115.74 Median:35249.74 stddev:66896.74 (189.8%) stddev-sans-first:67058.62 15:36:54 INFO - PROCESS | 11649 | Values: 376.3 384.6 389.6 395.9 408.6 17111.7 17614.2 17630.6 17656.2 17806.3 16769.2 16819.7 17315.0 17438.0 17674.5 5629.3 5777.5 5791.6 5794.9 5814.2 5546.6 5672.3 5686.1 5720.1 5772.7 5660.1 5667.6 5676.8 5691.7 5697.2 5546.9 5600.7 5639.7 5653.8 5725.1 5095.3 5112.9 5117.8 5131.9 5133.5 20509.2 20728.0 20973.0 21105.4 21145.9 2357.4 2392.9 2597.1 2747.7 2840.3 13342.7 13547.8 13556.0 13946.7 14108.6 1868.4 1940.1 1948.2 1990.5 2012.9 63209.7 64798.4 65692.7 66449.7 69122.0 10620.5 10686.3 10787.7 10805.1 10899.8 15456.0 15506.8 15537.1 15551.7 15573.4 8248.0 8268.4 8436.0 8508.7 8546.6 8224.5 8256.3 8274.8 8317.1 8319.2 4864.2 4879.9 4879.9 4887.9 4954.9 1831.7 1934.9 2006.3 2012.1 2032.7 918.9 931.1 989.7 1027.7 1108.4 17407.4 17952.7 18067.9 18239.5 18409.4 976.9 990.4 994.8 1031.4 1054.8 10167.9 10383.2 10392.1 10393.5 10623.4 382257.0 383483.0 387010.0 435908.0 438756.0 68732.3 82216.6 83082.6 83505.0 83657.0 1046.1 1091.2 1092.7 1100.5 1113.3 15988.7 16001.4 16156.9 16170.5 16403.8 31797.4 35238.0 35261.5 35398.0 35764.5 47358.3 50200.5 50728.2 51076.5 51508.5 8409.4 8447.8 8457.9 8472.2 8520.4 9798.9 10377.0 11139.2 11182.6 12330.0 8063.0 8733.6 10128.6 10557.2 10588.9 9361.0 10253.6 10290.7 10456.2 10479.5 10199.9 10267.5 10301.9 10461.6 10574.2 7986.2 8220.4 8239.4 8298.2 8303.4 9250.3 10435.6 10509.8 10524.6 10860.7 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | [#3] mootools.html Cycles:180 Average:5810.62 Median:558.70 stddev:3068.43 (549.2%) stddev-sans-first:3059.91 15:36:54 INFO - PROCESS | 11649 | Values: 1497.4 1577.3 1612.8 1840.9 1979.4 7897.8 8055.4 8056.5 8056.9 8072.2 7990.7 8120.3 8143.6 8159.4 8179.3 2063.9 2279.4 2336.1 2369.2 2402.7 2350.3 2357.2 2358.1 2359.0 2361.6 2300.8 2355.7 2356.8 2365.4 2368.2 2351.2 2384.9 2400.9 2403.1 2406.7 2362.6 2380.9 2390.2 2422.6 2425.5 8279.7 8334.0 8340.9 8352.9 8360.6 5017.1 5137.3 5143.5 5144.7 5144.7 3126.0 3211.4 3212.0 3220.2 3276.2 1080.9 1084.4 1090.7 1104.9 1120.1 11709.6 11712.2 11735.1 11755.9 11769.4 4523.0 4532.7 4546.0 4577.9 4582.7 9856.5 9865.8 9870.3 9874.9 9875.8 4572.4 5203.7 5220.5 5221.8 5230.1 4567.8 4635.7 4648.1 4665.1 4669.9 3696.6 3781.1 3788.1 3790.5 3865.3 1173.9 1183.1 1186.3 1190.8 1216.8 1466.1 1470.4 1486.4 1488.8 1506.5 8018.1 8046.0 8060.8 8082.6 8087.2 547.5 551.7 552.1 565.3 565.8 6109.5 6113.6 6122.5 6129.8 6179.8 9904.7 10189.7 10200.7 10286.9 10325.1 9594.2 10151.6 10178.0 10196.4 10197.9 7769.1 7869.3 7970.8 8007.2 8009.6 7889.1 7893.6 7916.8 7966.4 8003.5 8627.4 8843.7 9052.7 9264.2 9278.3 8954.2 9157.3 9196.6 9222.6 9284.7 6661.2 7028.6 7195.6 7310.7 7427.9 7762.5 7772.8 7802.6 7820.6 7838.4 7011.8 7187.0 7193.5 7290.7 7324.4 6911.3 7029.8 7042.9 7060.9 7146.1 7330.3 7581.7 7624.5 7626.1 7634.5 6743.9 6766.0 6771.3 6772.3 6777.7 6877.3 6916.5 6923.5 6976.5 6987.3 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | [#4] prototype.html Cycles:180 Average:5443.61 Median:6141.25 stddev:1627.89 (26.5%) stddev-sans-first:1587.22 15:36:54 INFO - PROCESS | 11649 | Values: 366.4 369.5 377.3 379.3 387.0 6033.8 6100.5 6112.3 6119.2 6138.0 6012.2 6029.1 6035.7 6037.5 6046.7 4502.1 4592.7 4705.5 4724.3 4790.6 4743.3 4756.7 4772.4 4775.8 4783.6 4716.7 4717.6 4727.0 4727.7 4734.0 4490.4 4565.4 4677.8 4690.8 4709.1 4158.6 4183.4 4193.4 4199.2 4218.3 5739.2 5739.8 5745.4 5745.5 5747.3 5531.9 5534.1 5539.1 5543.6 5558.5 6411.7 6412.2 6412.6 6417.6 6420.3 4310.2 4367.3 4390.3 4432.6 4668.9 6658.2 6688.4 6724.1 6729.7 6730.8 4685.8 4688.1 4691.0 4693.5 4699.8 4743.7 4751.5 4755.9 4758.6 4763.5 5446.7 5452.5 5457.0 5460.9 5470.4 6347.9 6470.0 6472.4 6496.5 6503.7 1651.9 1661.3 1668.6 1669.2 1671.4 1033.8 1050.4 1086.1 1104.0 1110.5 6026.7 6165.2 6175.8 6215.3 6265.2 6722.6 6735.2 6747.4 6758.8 6769.3 6236.2 6251.1 6257.5 6265.0 6269.5 3575.7 3612.2 3612.3 3613.2 3629.0 6797.7 6880.5 6963.1 6966.2 6978.9 6886.4 6903.4 6908.7 6914.0 6916.9 6943.4 6951.0 6956.3 6957.8 6965.1 6686.4 6718.6 6723.2 6738.6 6739.1 6416.5 6571.1 6595.7 6596.4 6603.8 6844.9 6876.8 6881.3 6882.4 6892.1 4701.9 4706.0 4706.8 4707.3 4708.1 6760.5 6801.9 6825.5 6826.7 6831.5 6436.2 6463.9 6549.2 6573.2 6573.6 6493.0 6511.7 6519.5 6526.0 6529.1 6417.1 6426.3 6427.5 6431.5 6432.6 6571.9 6577.9 6580.8 6586.1 6597.3 6144.5 6188.6 6234.7 6393.2 6411.6 15:36:54 INFO - PROCESS | 11649 | 15:36:54 INFO - PROCESS | 11649 | [#5] yui.html Cycles:180 Average:14621.39 Median:25455.27 stddev:17032.12 (66.9%) stddev-sans-first:17048.13 15:36:54 INFO - PROCESS | 11649 | Values: 769.5 823.5 856.7 905.5 922.8 14146.6 14557.1 14557.9 14589.3 14643.3 13334.3 13378.3 13389.3 13530.6 13552.1 764.6 908.0 909.6 921.1 936.2 923.2 928.5 929.3 931.1 931.5 978.2 981.6 982.1 982.1 983.3 814.1 971.2 974.5 981.6 984.5 729.2 729.4 729.6 730.1 730.7 14047.4 14132.1 14157.1 14158.2 14158.3 14041.6 14253.5 14540.2 14600.6 14789.1 11614.8 11618.4 11840.9 12233.9 12234.1 3964.0 3975.1 4035.4 4045.7 4121.6 49414.3 50194.0 50633.0 50720.5 50943.0 10660.0 10660.5 10725.9 11047.8 11103.6 19329.3 19466.4 19518.0 19540.9 19545.6 8363.6 8434.7 8457.3 8683.2 8737.8 4495.2 4539.5 4574.7 4584.7 4657.0 3364.8 3423.9 3433.3 3440.8 3451.5 584.4 642.1 644.7 651.8 655.6 685.8 715.9 734.9 739.9 745.0 7549.8 7688.5 7912.3 7969.5 8026.6 554.4 617.1 681.7 689.6 697.2 3606.2 3637.0 3705.1 3709.4 3814.0 60792.1 61324.7 61754.7 61766.0 61884.7 54718.2 55355.4 55605.4 55809.7 55823.4 48594.0 48933.8 49995.8 50762.0 50778.0 7938.5 8087.0 8121.5 8495.9 8550.6 37215.8 37431.4 38736.4 38851.2 38876.4 43967.0 45364.0 46253.5 47006.3 48976.8 12347.9 12386.3 12547.4 12554.3 12717.7 12609.1 12616.2 12977.7 13034.4 13172.5 10598.4 10686.0 11199.5 11226.9 11826.2 10398.9 10484.8 10495.3 10717.5 10735.9 10344.7 10841.3 11042.3 11224.1 11675.0 9945.9 10483.0 10565.6 10634.1 10656.4 9509.3 9695.5 9760.7 9838.1 9843.6 15:36:54 INFO - PROCESS | 11649 | -------- Summary: end -------- 15:36:54 INFO - PROCESS | 11649 | 15:36:55 INFO - TEST-INFO | 11649: exit 0 15:36:55 INFO - TEST-OK | dromaeo_css | took 1111953ms 15:36:55 INFO - TEST-START | kraken 15:36:55 INFO - operating with platform_type : linux_ 15:36:55 INFO - Initialising browser for kraken test... 15:36:55 INFO - TEST-INFO | started process 11841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmzkA8y/profile http://localhost:53424/getInfo.html) 15:36:59 INFO - PROCESS | 11841 | __metrics Screen width/height:1600/1200 15:36:59 INFO - PROCESS | 11841 | colorDepth:24 15:36:59 INFO - PROCESS | 11841 | Browser inner width/height: 1024/697 15:36:59 INFO - PROCESS | 11841 | __metrics 15:37:00 INFO - PROCESS | 11841 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:37:01 INFO - TEST-INFO | 11841: exit 0 15:37:01 INFO - Browser initialized. 15:37:01 INFO - Running cycle 1/1 for kraken test... 15:37:01 INFO - TEST-INFO | started process 11932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmzkA8y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:13 INFO - PROCESS | 11932 | RSS: Main: 141066240 15:37:13 INFO - PROCESS | 11932 | 15:37:15 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53424/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:16 INFO - PROCESS | 11932 | RSS: Main: 178450432 15:37:16 INFO - PROCESS | 11932 | 15:37:18 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53424/tests/kraken/driver.html?testName=audio-dft) 15:37:19 INFO - PROCESS | 11932 | RSS: Main: 176062464 15:37:19 INFO - PROCESS | 11932 | 15:37:22 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53424/tests/kraken/driver.html?testName=audio-fft) 15:37:22 INFO - PROCESS | 11932 | RSS: Main: 173113344 15:37:22 INFO - PROCESS | 11932 | 15:37:24 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53424/tests/kraken/driver.html?testName=audio-oscillator) 15:37:25 INFO - PROCESS | 11932 | RSS: Main: 174022656 15:37:25 INFO - PROCESS | 11932 | 15:37:27 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:28 INFO - PROCESS | 11932 | RSS: Main: 170913792 15:37:28 INFO - PROCESS | 11932 | 15:37:31 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53424/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:31 INFO - PROCESS | 11932 | RSS: Main: 170786816 15:37:31 INFO - PROCESS | 11932 | 15:37:35 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53424/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:35 INFO - PROCESS | 11932 | RSS: Main: 171364352 15:37:35 INFO - PROCESS | 11932 | 15:37:38 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53424/tests/kraken/driver.html?testName=json-parse-financial) 15:37:39 INFO - PROCESS | 11932 | RSS: Main: 170733568 15:37:39 INFO - PROCESS | 11932 | 15:37:40 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:41 INFO - PROCESS | 11932 | RSS: Main: 177270784 15:37:41 INFO - PROCESS | 11932 | 15:37:42 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:43 INFO - PROCESS | 11932 | RSS: Main: 175132672 15:37:43 INFO - PROCESS | 11932 | 15:37:45 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:46 INFO - PROCESS | 11932 | RSS: Main: 185200640 15:37:46 INFO - PROCESS | 11932 | 15:37:48 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:49 INFO - PROCESS | 11932 | RSS: Main: 190484480 15:37:49 INFO - PROCESS | 11932 | 15:37:51 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:52 INFO - PROCESS | 11932 | RSS: Main: 189087744 15:37:52 INFO - PROCESS | 11932 | 15:37:53 INFO - PROCESS | 11932 | Cycle 1(1): loaded http://localhost:53424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53424/tests/kraken/driver.html?testName=ai-astar) 15:37:54 INFO - PROCESS | 11932 | RSS: Main: 250843136 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | __start_tp_report 15:37:54 INFO - PROCESS | 11932 | _x_x_mozilla_page_load 15:37:54 INFO - PROCESS | 11932 | _x_x_mozilla_page_load_details 15:37:54 INFO - PROCESS | 11932 | |i|pagename|runs| 15:37:54 INFO - PROCESS | 11932 | |0;ai-astar;108;110;104;111;108;110;99;110;110;110 15:37:54 INFO - PROCESS | 11932 | |1;audio-beat-detection;156;127;150;169;128;159;154;128;169;131 15:37:54 INFO - PROCESS | 11932 | |2;audio-dft;160;162;162;160;159;162;160;165;162;160 15:37:54 INFO - PROCESS | 11932 | |3;audio-fft;73;77;76;163;77;75;74;76;161;76 15:37:54 INFO - PROCESS | 11932 | |4;audio-oscillator;92;92;146;92;92;93;153;91;92;147 15:37:54 INFO - PROCESS | 11932 | |5;imaging-gaussian-blur;117;116;116;117;116;116;116;117;118;117 15:37:54 INFO - PROCESS | 11932 | |6;imaging-darkroom;146;146;145;146;146;145;145;146;146;146 15:37:54 INFO - PROCESS | 11932 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 15:37:54 INFO - PROCESS | 11932 | |8;json-parse-financial;54;55;57;55;56;56;57;63;54;55 15:37:54 INFO - PROCESS | 11932 | |9;json-stringify-tinderbox;64;66;65;66;64;66;66;64;64;65 15:37:54 INFO - PROCESS | 11932 | |10;stanford-crypto-aes;78;77;88;86;79;78;79;94;77;77 15:37:54 INFO - PROCESS | 11932 | |11;stanford-crypto-ccm;116;114;112;109;109;114;126;117;111;118 15:37:54 INFO - PROCESS | 11932 | |12;stanford-crypto-pbkdf2;156;142;141;142;155;138;147;143;132;156 15:37:54 INFO - PROCESS | 11932 | |13;stanford-crypto-sha256-iterative;71;68;69;67;67;65;65;66;66;64 15:37:54 INFO - PROCESS | 11932 | __end_tp_report 15:37:54 INFO - PROCESS | 11932 | __start_cc_report 15:37:54 INFO - PROCESS | 11932 | _x_x_mozilla_cycle_collect,1037 15:37:54 INFO - PROCESS | 11932 | __end_cc_report 15:37:54 INFO - PROCESS | 11932 | __startTimestamp1461191874088__endTimestamp 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | ------- Summary: start ------- 15:37:54 INFO - PROCESS | 11932 | Number of tests: 14 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.97 15:37:54 INFO - PROCESS | 11932 | Values: 108.0 110.0 104.0 111.0 108.0 110.0 99.0 110.0 110.0 110.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:155.00 stddev:17.09 (11.0%) stddev-sans-first:17.82 15:37:54 INFO - PROCESS | 11932 | Values: 156.0 127.0 150.0 169.0 128.0 159.0 154.0 128.0 169.0 131.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.75 (1.1%) stddev-sans-first:1.80 15:37:54 INFO - PROCESS | 11932 | Values: 160.0 162.0 162.0 160.0 159.0 162.0 160.0 165.0 162.0 160.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:36.50 (48.0%) stddev-sans-first:38.00 15:37:54 INFO - PROCESS | 11932 | Values: 73.0 77.0 76.0 163.0 77.0 75.0 74.0 76.0 161.0 76.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:27.43 (29.8%) stddev-sans-first:28.40 15:37:54 INFO - PROCESS | 11932 | Values: 92.0 92.0 146.0 92.0 92.0 93.0 153.0 91.0 92.0 147.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 15:37:54 INFO - PROCESS | 11932 | Values: 117.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 118.0 117.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:37:54 INFO - PROCESS | 11932 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:37:54 INFO - PROCESS | 11932 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.62 (4.7%) stddev-sans-first:2.65 15:37:54 INFO - PROCESS | 11932 | Values: 54.0 55.0 57.0 55.0 56.0 56.0 57.0 63.0 54.0 55.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 15:37:54 INFO - PROCESS | 11932 | Values: 64.0 66.0 65.0 66.0 64.0 66.0 66.0 64.0 64.0 65.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:79.00 stddev:5.93 (7.5%) stddev-sans-first:6.16 15:37:54 INFO - PROCESS | 11932 | Values: 78.0 77.0 88.0 86.0 79.0 78.0 79.0 94.0 77.0 77.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:115.00 stddev:5.08 (4.4%) stddev-sans-first:5.36 15:37:54 INFO - PROCESS | 11932 | Values: 116.0 114.0 112.0 109.0 109.0 114.0 126.0 117.0 111.0 118.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:145.00 stddev:8.18 (5.6%) stddev-sans-first:7.68 15:37:54 INFO - PROCESS | 11932 | Values: 156.0 142.0 141.0 142.0 155.0 138.0 147.0 143.0 132.0 156.0 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - PROCESS | 11932 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:2.10 (3.1%) stddev-sans-first:1.58 15:37:54 INFO - PROCESS | 11932 | Values: 71.0 68.0 69.0 67.0 67.0 65.0 65.0 66.0 66.0 64.0 15:37:54 INFO - PROCESS | 11932 | -------- Summary: end -------- 15:37:54 INFO - PROCESS | 11932 | 15:37:54 INFO - TEST-INFO | 11932: exit 0 15:37:54 INFO - TEST-OK | kraken | took 59507ms 15:37:54 INFO - SUITE-END | took 1171s 15:37:55 INFO - Completed test suite (00:19:31) 15:37:55 INFO - javascript benchmark 15:37:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3277.2462333663257, 3360.2271477560175, 3365.5288259643653, 3377.206356506222, 3390.4066788312048, 5500.642458240211, 5504.394516603171, 5543.861403464915, 5547.140193270045, 5549.38956714761, 5504.559635229182, 5541.889162216763, 5550.333959924805, 5559.971405290024, 5564.0, 4827.686200396981, 4993.350864387634, 5013.097642424362, 5105.5149760772665, 5118.9488105119035, 4905.4358748744, 4995.450500444948, 5006.474320196382, 5064.037832811754, 5068.113080210948, 5032.647714659957, 5039.395272567297, 5042.319286896259, 5052.4189718182515, 5088.033273678007, 4876.463589005207, 4982.377202849644, 5002.424721157041, 5024.346834911475, 5060.949390506103, 4931.80272789088, 4952.0, 4958.429780575244, 4968.90062198754, 4972.254161875748, 5351.036813373591, 5367.221752845854, 5372.118703926647, 5376.0, 5421.539169170625, 5750.7412166452195, 5903.0, 5911.172435858984, 5926.7925622603, 5983.072623743326, 6019.036954087325, 6037.7584896604085, 6038.667873266969, 6046.848828779272, 6051.4553690168095, 5622.269105016322, 5624.0439125348785, 5627.606067575312, 5629.211910332557, 5653.547716182737, 5916.26046744157, 6045.183900173421, 6114.969425152845, 6116.816495505142, 6126.731429653714, 5764.394738552392, 5781.5952883298605, 5781.913271300934, 5783.942160578425, 5797.36229014808, 5834.591578589458, 5872.794452194238, 5892.175095486636, 5896.941030589725, 5900.704964751745, 5748.223989761413, 5869.911951320733, 5922.763089476372, 5941.613795103391, 5950.226470558886, 5774.2782152230975, 5807.419258074159, 5811.244538210006, 5816.5055970243, 5819.709014549256, 4453.710508816916, 4461.420015398043, 4464.977675111603, 4468.0, 4485.708428952173, 3949.4273330366937, 4027.838886444568, 4102.774347410921, 4106.507219133723, 4120.114175452292, 5514.862128446821, 5518.172274158828, 5525.392206857243, 5526.613137080366, 5529.502344788988, 5937.2578427696535, 5938.376470470538, 5940.910886336708, 5943.138244954457, 5944.197533333031, 5311.920321195185, 5551.8889622207325, 5597.6641401516035, 5610.27066481363, 5634.943650563524, 5033.84898453047, 5035.043341765053, 5039.874003149951, 5044.344235249394, 5068.265101560253, 5995.250593675791, 6002.369751176151, 6002.579819412686, 6018.337982821886, 6025.457708806229, 5892.381299963614, 5954.136650185612, 5964.701764911651, 5978.461938425563, 5983.670898100646, 6005.669688167192, 6079.0, 6079.3008803988105, 6082.695865206633, 6092.75628974836, 5632.690202038763, 5864.149698293809, 5869.325027621708, 5884.0585506318785, 5884.499817515559, 5907.734151963258, 5908.291005079418, 5910.083936989773, 5916.49709774674, 5951.7619295227705, 5728.713564321684, 5729.054705973635, 5729.828105156852, 5733.254676891977, 5749.482546570829, 5635.746391412478, 5746.9712651436475, 5752.9137062943255, 5836.970815146067, 5898.557608179318, 5596.972015139898, 5621.690807005654, 5627.0715331971405, 5627.634203776742, 5656.038473459604, 5655.4344565543115, 5727.599068065362, 5743.684097374685, 5745.425457454388, 5753.741081651252, 5555.2222688822785, 5640.85897852557, 5644.266245388073, 5727.513161381163, 5746.2529871116485], "unit": "score", "name": "dojo.html", "value": 5436.397004601693}, {"lowerIsBetter": false, "replicates": [554.8085910360925, 568.5281216590233, 575.5855783835636, 587.0694948506617, 591.3347484080409, 33539.32921341572, 45417.0, 45704.54295457045, 45968.0, 46012.07975840481, 49411.0, 50180.749096254556, 50186.24720629193, 50222.74888625552, 50275.748621256935, 9165.129312715282, 9313.813723725521, 9383.390079644836, 9390.107939745712, 9391.389559678633, 9098.272138228958, 9262.76843078925, 9266.212371948359, 9267.073292670746, 9268.073192680711, 9248.0, 9249.53752312385, 9268.536573171348, 9271.21194698448, 9273.119053689888, 9096.636134554643, 9236.030216827237, 9259.675911343138, 9261.027592102799, 9261.583228754655, 9151.588178531916, 9304.348695591312, 9323.25413966881, 9325.06749325062, 9326.347155699104, 45136.54863451389, 45652.77173614144, 45672.0, 45737.542624573995, 45744.0, 3700.5374328208973, 3759.661630453272, 3791.336516109697, 3804.239152169577, 3844.5002149720635, 34384.0, 35362.29275414503, 36177.27645447103, 36336.818315908255, 36553.268934621155, 4046.271671099201, 4195.139996300782, 4221.78891055446, 4279.930017495626, 4377.7592232427205, 245480.0, 249073.0, 249339.0, 249406.0, 249721.0, 49212.26181607279, 73705.0, 74903.25096749072, 75390.24609753833, 75391.62304188554, 49611.503884960686, 50103.0, 50105.74947125241, 50150.0, 50198.2470262939, 17039.233234504478, 17210.741838872425, 17240.0, 17240.482785516455, 17259.654806904044, 12550.623481295575, 12559.874401256053, 12560.246385216917, 12563.309018003914, 12575.119741618182, 16785.66428671444, 16798.24407901623, 16920.492385228463, 16995.81029327935, 17087.914560427365, 6339.41822870077, 6447.451966582799, 6511.739530418825, 6618.768343107968, 6672.0, 923.3674932671141, 962.3263715399248, 982.1111893736038, 1046.042870773234, 1110.2228440091967, 31244.687553124633, 31546.842265788524, 31561.684383155876, 32162.83918580392, 32304.676953230635, 1102.9007389334838, 1121.0135081128556, 1142.457332766929, 1187.8812118788053, 1190.2917763930448, 16178.514644560682, 16483.093429861234, 16534.0, 16696.081715505763, 16943.91528042352, 368220.0, 369716.0, 370132.0, 372961.0, 373860.0, 60366.69816650889, 61555.0, 61708.38291617027, 61730.0, 61777.69111154506, 1331.3609467455483, 1452.3028946105928, 1471.8601732835364, 1476.151213052499, 1491.8135233095863, 30478.65097929672, 30669.693303067575, 30930.226744331572, 31448.685513144577, 31820.5226921601, 48652.0, 48706.512934870196, 49105.0, 49204.26193607171, 49262.75368623134, 205001.0, 206103.0, 217456.0, 219194.0, 219277.0, 32075.518867216542, 36443.27113457769, 36765.26469470649, 37109.81445092865, 37128.257434851694, 46833.531664682916, 46930.29604555866, 47034.529654703016, 47947.76026119847, 48336.274955874986, 39900.2019959605, 40303.798481007405, 40359.59640403558, 40649.1870162601, 41167.1766564661, 39000.804995975974, 39931.40102898401, 40068.1986360277, 40279.798601006805, 40367.19265614612, 38651.0, 38881.2223755529, 39053.41419878761, 39840.2031959365, 39861.2027759449, 34945.0, 36382.0, 36421.0, 36470.8176459116, 36643.26713465663, 27095.72904270932, 27123.0, 27342.86328568424, 27409.0, 27676.169714908585], "unit": "score", "name": "ext.html", "value": 19579.01380929703}, {"lowerIsBetter": false, "replicates": [376.25501507016105, 384.5942530630184, 389.56664372226527, 395.9448070891074, 408.61590105301013, 17111.657766844655, 17614.207360668785, 17630.559236019108, 17656.205470753815, 17806.28774849008, 16769.24538395772, 16819.66360672786, 17315.0, 17438.0, 17674.469765907044, 5629.296337957755, 5777.451142141511, 5791.565632577553, 5794.913076303858, 5814.156947242647, 5546.639468434559, 5672.262605861232, 5686.147077938301, 5720.141978703186, 5772.7113644317615, 5660.094384898417, 5667.603267771257, 5676.772929082852, 5691.658500489963, 5697.202391665171, 5546.91679624806, 5600.691961942091, 5639.661620302774, 5653.830385088454, 5725.083986562172, 5095.286659867622, 5112.948870511322, 5117.795288188505, 5131.948680513185, 5133.460986596391, 20509.17963281467, 20728.0, 20973.0, 21105.366838994854, 21145.894270528548, 2357.4342157882156, 2392.892319845611, 2597.0520759922683, 2747.697753247141, 2840.3183236023206, 13342.733145337135, 13547.796783048263, 13556.0, 13946.651333716738, 14108.576742697736, 1868.4021113243768, 1940.1172466527837, 1948.2012374926212, 1990.4625751047136, 2012.9094190761305, 63209.68395158041, 64798.3520164797, 65692.67153664201, 66449.66775166141, 69121.96317055299, 10620.468976551141, 10686.25196236256, 10787.67636970892, 10805.13558915285, 10899.782004359868, 15456.0, 15506.844931550766, 15537.145456999748, 15551.688966220838, 15573.377064917277, 8247.95876020616, 8268.421210515327, 8435.957820210982, 8508.65965361391, 8546.572671366532, 8224.506529608243, 8256.25693687559, 8274.751757447286, 8317.126701696356, 8319.168083191753, 4864.197407427806, 4879.878003049881, 4879.926801097987, 4887.877803054952, 4954.925676114861, 1831.705813329099, 1934.94195174145, 2006.3278801601334, 2012.1247257443058, 2032.6664270596234, 918.8851393575803, 931.0875342164717, 989.7030890732751, 1027.712240572626, 1108.4014632098738, 17407.390741323994, 17952.730709039373, 18067.909660451613, 18239.452816415527, 18409.355672551395, 976.9364991275544, 990.390909590611, 994.8408254679216, 1031.3554028732042, 1054.8154073037188, 10167.949160254151, 10383.169346452265, 10392.116670082976, 10393.480325983823, 10623.36259824413, 382257.0, 383483.0, 387010.0, 435908.0, 438756.0, 68732.3126768736, 82216.58891705504, 83082.58458707789, 83505.0, 83657.0, 1046.1421634259834, 1091.1925175370327, 1092.7377429416883, 1100.5047728522036, 1113.3486910157487, 15988.68022639564, 16001.359945602046, 16156.919215404318, 16170.514884553482, 16403.753943691092, 31797.36405271928, 35238.0, 35261.471077934366, 35398.0, 35764.4635330465, 47358.28962565495, 50200.49799502104, 50728.23907641315, 51076.48923510866, 51508.484915150366, 8409.422389162897, 8447.788805279917, 8457.87313190315, 8472.237498625153, 8520.446170998865, 9798.853017204605, 10377.0, 11139.220254582102, 11182.608608698656, 12329.951954084003, 8063.0, 8733.56332183401, 10128.59485620567, 10557.208209384173, 10588.947055264674, 9360.95319523398, 10253.641122560675, 10290.742731431475, 10456.215783816093, 10479.528421220912, 10199.898001019896, 10267.486625668538, 10301.866794652733, 10461.633842815465, 10574.154067674413, 7986.2013798622, 8220.3834712398, 8239.423240373117, 8298.170182981654, 8303.418760686694, 9250.344565846946, 10435.58257669715, 10509.789804204025, 10524.579016839241, 10860.728481788019], "unit": "score", "name": "jquery.html", "value": 8801.191272398786}, {"lowerIsBetter": false, "replicates": [1497.3935556099784, 1577.2586884164443, 1612.798400199975, 1840.9263629454822, 1979.4061781465557, 7897.842043159133, 8055.395845311603, 8056.516609003464, 8056.91943080569, 8072.152423995484, 7990.680372785097, 8120.269175774194, 8143.633536490857, 8159.4288399811885, 8179.263866252036, 2063.8658487198286, 2279.4415368234722, 2336.123953517431, 2369.1589485732575, 2402.699662542182, 2350.306659535441, 2357.163207061494, 2358.127492827656, 2359.0327965534134, 2361.5985282502015, 2300.7584203658625, 2355.6584295277175, 2356.7878890899815, 2365.420471984366, 2368.1948137633203, 2351.247600767755, 2384.892679829412, 2400.8559486430872, 2403.062805505854, 2406.6991626046743, 2362.6219804831144, 2380.8928598213124, 2390.1634427950253, 2422.563938491071, 2425.466397392571, 8279.710210142677, 8333.95833020831, 8340.874886876702, 8352.916470835275, 8360.623771930277, 5017.071841709296, 5137.306463627438, 5143.5113664201845, 5144.717040562768, 5144.742762861842, 3126.04655580048, 3211.3577284542953, 3212.0363890832655, 3220.1949512621845, 3276.2300859298048, 1080.8702955645374, 1084.360227465791, 1090.650991682662, 1104.9060829829475, 1120.1151090638468, 11709.590164344207, 11712.180147389687, 11735.119866009998, 11755.94122029393, 11769.411529423494, 4522.954770452254, 4532.70537415067, 4546.0, 4577.862664120082, 4582.679212455163, 9856.50717464124, 9865.80268394628, 9870.25973052024, 9874.851877221847, 9875.802483950281, 4572.3827283317, 5203.661761985459, 5220.477952204749, 5221.791128354899, 5230.137027390514, 4567.817287308537, 4635.675502714845, 4648.1168577970075, 4665.113628410591, 4669.929951050737, 3696.6488183622514, 3781.054736315921, 3788.0719223790347, 3790.450384694259, 3865.2849222893856, 1173.8767429419959, 1183.0831105893, 1186.258588382261, 1190.7916114679897, 1216.7870622641003, 1466.142306750563, 1470.3677418709844, 1486.4277253257358, 1488.8213414390343, 1506.4727345429012, 8018.118007019223, 8045.959770201229, 8060.798480038046, 8082.595870206584, 8087.1912808719835, 547.4990383798779, 551.6552154903186, 552.1248820619284, 565.2820917434834, 565.8217661436635, 6109.5112391008615, 6113.57204995655, 6122.479589234876, 6129.84675383119, 6179.84550386244, 9904.653337133166, 10189.74525636865, 10200.693979180636, 10286.948565257275, 10325.070743633109, 9594.184494317922, 10151.64469243573, 10178.0, 10196.4391958443, 10197.94901025505, 7769.145394006655, 7869.252421019994, 7970.840583188304, 8007.199280072063, 8009.559474228857, 7889.053313602404, 7893.565853878092, 7916.84166316659, 7966.3626909848235, 8003.4797738146835, 8627.439216451161, 8843.734687959372, 9052.728418147466, 9264.16622503951, 9278.257739380968, 8954.238889694449, 9157.31320150978, 9196.58615362297, 9222.631094756134, 9284.675036373965, 6661.16735408074, 7028.578285302899, 7195.640217989185, 7310.744123955636, 7427.925720742724, 7762.4954377967515, 7772.84454310922, 7802.570858602831, 7820.608969551614, 7838.412119091205, 7011.8247043822275, 7187.0, 7193.460490463341, 7290.708371665074, 7324.377427918474, 6911.274316196928, 7029.789106326818, 7042.894356584758, 7060.8940865886025, 7146.071010768775, 7330.303621155982, 7581.658825352762, 7624.5425274483705, 7626.122995855326, 7634.4655874088285, 6743.898841517479, 6765.9661701691175, 6771.255161932085, 6772.288909664414, 6777.661116944231, 6877.277885821916, 6916.515843890879, 6923.515353925177, 6976.476764242803, 6987.301269872972], "unit": "score", "name": "mootools.html", "value": 4691.840833350389}, {"lowerIsBetter": false, "replicates": [366.4338596867839, 369.4993284100044, 377.2850448400283, 379.25665695237336, 386.96517313441785, 6033.7888173913925, 6100.450959413652, 6112.2970858351355, 6119.204503414561, 6138.0, 6012.218411606496, 6029.065494848305, 6035.668038257894, 6037.516998640098, 6046.697665116749, 4502.122086193193, 4592.655550833684, 4705.505921878204, 4724.267738500538, 4790.592799612037, 4743.288506723985, 4756.714597124166, 4772.4273087229585, 4775.785089670973, 4783.593394561466, 4716.740579268139, 4717.646176536757, 4726.952730472703, 4727.692699974491, 4733.976330118345, 4490.371348011281, 4565.406497155382, 4677.766111694402, 4690.81236750533, 4709.105269998689, 4158.6465150462245, 4183.393407955829, 4193.391958166079, 4199.181159673864, 4218.303979843322, 5739.196512488255, 5739.770409183628, 5745.396733342981, 5745.540356771448, 5747.281589801275, 5531.889362212773, 5534.142207957773, 5539.113741801292, 5543.584231182677, 5558.471945165203, 6411.67941602918, 6412.198475190601, 6412.583182093149, 6417.550771446001, 6420.261669907974, 4310.245707001262, 4367.323064924942, 4390.341448782676, 4432.645388368955, 4668.883277918046, 6658.201015878077, 6688.3646053624825, 6724.092247546617, 6729.663516824139, 6730.831729206809, 4685.81256749733, 4688.062387522509, 4690.9765451172525, 4693.507181745936, 4699.835505757351, 4743.691660042086, 4751.548602882721, 4755.857324280277, 4758.619310455155, 4763.476017638057, 5446.7276636168035, 5452.482014208644, 5457.045017121988, 5460.890782184413, 5470.398256191816, 6347.936520634827, 6470.029495575702, 6472.449841763409, 6496.512761542903, 6503.7073331700185, 1651.884368094246, 1661.2773443551853, 1668.57451349905, 1669.1654172913543, 1671.4484220207303, 1033.8397548380012, 1050.369778133114, 1086.098538213281, 1103.9944800276107, 1110.4725255503733, 6026.6986650667295, 6165.229346331708, 6175.814725558241, 6215.316315205324, 6265.248170219603, 6722.630255336004, 6735.225449073321, 6747.392734653905, 6758.797236082925, 6769.255381907986, 6236.18929539157, 6251.12484252205, 6257.468115210167, 6265.028920517327, 6269.529785266123, 3575.7318201135017, 3612.205314830733, 3612.3317186320614, 3613.205094879175, 3628.9818550907075, 6797.72809087631, 6880.4839637026425, 6963.1296087989, 6966.164060312693, 6978.895316570255, 6886.449084073262, 6903.378695917391, 6908.6545672716165, 6913.965430172817, 6916.861662766716, 6943.409810166091, 6950.965245173843, 6956.339147780953, 6957.791266261919, 6965.094537710166, 6686.364795344434, 6718.630475323904, 6723.159605049369, 6738.59568425896, 6739.0902228198565, 6416.454601358937, 6571.080048793077, 6595.736170553124, 6596.373344532261, 6603.80188594343, 6844.8973265402055, 6876.793696189123, 6881.346272104142, 6882.4149947253045, 6892.069570607904, 4701.882452938704, 4706.035262771055, 4706.788194531186, 4707.317438971399, 4708.128996135726, 6760.459163266829, 6801.931980680328, 6825.52221344521, 6826.726930922708, 6831.453483721191, 6436.184346491069, 6463.935360646334, 6549.214094308713, 6573.211214654081, 6573.638449885302, 6493.0, 6511.706973186123, 6519.511036672174, 6526.0, 6529.085927969993, 6417.133686952202, 6426.260979987174, 6427.517936154901, 6431.453326467115, 6432.581882177644, 6571.868562628816, 6577.901331479936, 6580.8354791130605, 6586.110875031809, 6597.3072827352435, 6144.508439324933, 6188.566800324114, 6234.719437625408, 6393.1688880445245, 6411.647359395091], "unit": "score", "name": "prototype.html", "value": 4921.927753242326}, {"lowerIsBetter": false, "replicates": [769.4882902869592, 823.5388182617735, 856.6616186606291, 905.47934937411, 922.8154369126174, 14146.64633384166, 14557.12657240565, 14557.92721036396, 14589.343479543419, 14643.341049652765, 13334.333283335818, 13378.331083445837, 13389.263590502518, 13530.594082177526, 13552.051356405056, 764.598585742484, 908.0465511213233, 909.6406919266902, 921.0835218957113, 936.1527817325332, 923.2014307623924, 928.5264515097315, 929.3169520402499, 931.1061381074177, 931.5156118818211, 978.2223132609593, 981.6466072213997, 982.0572250639394, 982.1160955140359, 983.2576404814355, 814.1166833985104, 971.1842052675715, 974.4543055888689, 981.5975450065511, 984.4733067808688, 729.2488736601309, 729.4419768876813, 729.580491217552, 730.1202051527896, 730.747891977267, 14047.367868445945, 14132.081414708011, 14157.07978981363, 14158.221297828615, 14158.292085395791, 14041.578752637437, 14253.501127460593, 14540.200288984102, 14600.561983140522, 14789.11265324084, 11614.767704645945, 11618.419079046014, 11840.88159118415, 12233.93883030588, 12234.143609947307, 3964.048628329209, 3975.0857302820223, 4035.394690796404, 4045.6763458923215, 4121.567235440266, 49414.2587861186, 50194.0, 50633.0, 50720.49279507194, 50943.0, 10660.0, 10660.520276587573, 10725.892741072645, 11047.779044419067, 11103.611373601885, 19329.323473678636, 19466.416007519798, 19518.0, 19540.902295488715, 19545.609087818164, 8363.58182090893, 8434.704785332484, 8457.281131103926, 8683.2185103341, 8737.825243495094, 4495.213337665896, 4539.546045395434, 4574.679772415965, 4584.724916505021, 4657.0, 3364.8485818138242, 3423.8801641942414, 3433.261848702491, 3440.82795860206, 3451.5340429041757, 584.403908013832, 642.1363266406676, 644.6551095164065, 651.7621068310033, 655.6426747422666, 685.8353995041253, 715.8639858426882, 734.8860926556392, 739.9371053460409, 744.9776506704808, 7549.811254718676, 7688.474265438801, 7912.327452166515, 7969.521828690297, 8026.638801253957, 554.3790954131399, 617.062065660194, 681.7409384433884, 689.5965859971973, 697.1982220446527, 3606.1672698428333, 3636.9636303636626, 3705.0552109212517, 3709.350863598859, 3813.980930095387, 60792.08811867826, 61324.69337653372, 61754.69122654358, 61766.0, 61884.690576546825, 54718.17922731162, 55355.44644553583, 55605.44394556084, 55809.72095139579, 55823.44176558264, 48594.0, 48933.75533122383, 49995.75002125039, 50762.0, 50778.0, 7938.5236885787035, 8087.0, 8121.512709237465, 8495.8725619117, 8550.57247137653, 37215.813920930224, 37431.43852842155, 38736.418953715154, 38851.222975539764, 38876.41685374778, 43967.0, 45364.0, 46253.537464624926, 47006.294905577124, 48976.755116224194, 12347.938260308641, 12386.256824590553, 12547.36715976792, 12554.309512976874, 12717.745645087232, 12609.117361784587, 12616.17994830333, 12977.740445190855, 13034.413451394521, 13172.47310107585, 10598.417087060287, 10686.0, 11199.496022679163, 11226.943865280948, 11826.231294965799, 10398.948005259925, 10484.790304194026, 10495.265331426726, 10717.464126793473, 10735.89264107349, 10344.741381465523, 10841.295315804447, 11042.282251653616, 11224.102071834397, 11675.0, 9945.850812237677, 10483.0, 10565.63020294286, 10634.14926805869, 10656.413897235416, 9509.286803489627, 9695.466749328572, 9760.707178784647, 9838.114569688762, 9843.606255749975], "unit": "score", "name": "yui.html", "value": 6714.5550603990305}], "name": "dromaeo_css", "value": 7250.413542895934}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 111.0, 108.0, 110.0, 99.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 150.0, 169.0, 128.0, 159.0, 154.0, 128.0, 169.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 162.0, 160.0, 159.0, 162.0, 160.0, 165.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 76.0, 163.0, 77.0, 75.0, 74.0, 76.0, 161.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 146.0, 92.0, 92.0, 93.0, 153.0, 91.0, 92.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 57.0, 55.0, 56.0, 56.0, 57.0, 63.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 65.0, 66.0, 64.0, 66.0, 66.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 88.0, 86.0, 79.0, 78.0, 79.0, 94.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [116.0, 114.0, 112.0, 109.0, 109.0, 114.0, 126.0, 117.0, 111.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.6}, {"lowerIsBetter": true, "replicates": [156.0, 142.0, 141.0, 142.0, 155.0, 138.0, 147.0, 143.0, 132.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 69.0, 67.0, 67.0, 65.0, 65.0, 66.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1505.3999999999996}]} 15:37:55 INFO - Return code: 0 15:37:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:37:55 INFO - # TBPL SUCCESS # 15:37:55 INFO - Running post-action listener: _resource_record_post_action 15:37:55 INFO - Running post-run listener: _resource_record_post_run 15:37:56 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 274432; Write bytes: 499982336; Read time: 32; Write time: 535652 15:37:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251514880; Read time: 0; Write time: 347112 15:37:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 274432; Write bytes: 248467456; Read time: 32; Write time: 188540 15:37:56 INFO - Running post-run listener: _upload_blobber_files 15:37:56 INFO - Blob upload gear active. 15:37:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:56 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 15:37:56 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'] 15:37:56 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 15:37:56 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:57 INFO - (blobuploader) - INFO - Done attempting. 15:37:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:37:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:37:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:58 INFO - (blobuploader) - INFO - Done attempting. 15:37:58 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:58 INFO - Return code: 0 15:37:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/924478569b997d861be44837c03f6128d856eca7934516989b9d49d58a5118cd42135f240ab58f6cf1e56802d6d398a4da278fe9851caa1ad92373b5ebce77f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7aa6e62ec9957fa60cc1e0961d35f5b45ad3fcd12dc1e255225325561fbaaad74d7bb2709511f5e85d8404df648011f436fd602a6046843dc74b844058c6ea70"} 15:37:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:58 INFO - Contents: 15:37:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/924478569b997d861be44837c03f6128d856eca7934516989b9d49d58a5118cd42135f240ab58f6cf1e56802d6d398a4da278fe9851caa1ad92373b5ebce77f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7aa6e62ec9957fa60cc1e0961d35f5b45ad3fcd12dc1e255225325561fbaaad74d7bb2709511f5e85d8404df648011f436fd602a6046843dc74b844058c6ea70"} 15:37:58 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:58 INFO - Copying logs to upload dir... 15:37:58 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.873811 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-20 15:37:58.096959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:58.100514) ========= 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=232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796 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/924478569b997d861be44837c03f6128d856eca7934516989b9d49d58a5118cd42135f240ab58f6cf1e56802d6d398a4da278fe9851caa1ad92373b5ebce77f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7aa6e62ec9957fa60cc1e0961d35f5b45ad3fcd12dc1e255225325561fbaaad74d7bb2709511f5e85d8404df648011f436fd602a6046843dc74b844058c6ea70"} build_url:https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/924478569b997d861be44837c03f6128d856eca7934516989b9d49d58a5118cd42135f240ab58f6cf1e56802d6d398a4da278fe9851caa1ad92373b5ebce77f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7aa6e62ec9957fa60cc1e0961d35f5b45ad3fcd12dc1e255225325561fbaaad74d7bb2709511f5e85d8404df648011f436fd602a6046843dc74b844058c6ea70"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:58.124847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:58.125189) ========= 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=232498196343f89f466a4a9a000001c8-1461190206.13331-1991806796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:58.210808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:37:58.211141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:37:58.211668) ========= ========= Total master_lag: 0.17 =========