builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1467032613.52 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.520729) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.521183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.521472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.536251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.536522) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 06:03:33-- 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% 221M=0s 2016-06-27 06:03:33 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084850 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.635054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.635382) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020636 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:33.685217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 06:03:33.685580) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --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-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --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=31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 06:03:33,769 truncating revision to first 12 chars 2016-06-27 06:03:33,769 Setting DEBUG logging. 2016-06-27 06:03:33,770 attempt 1/10 2016-06-27 06:03:33,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/229741b7de04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 06:03:34,874 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436520 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 06:03:35.135563) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:35.135888) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:35.136285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:35.136551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:03:35.145496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-27 06:03:35.145796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:03:35 INFO - MultiFileLogger online at 20160627 06:03:35 in /builds/slave/test 06:03:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:03:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:03:35 INFO - {'append_to_log': False, 06:03:35 INFO - 'base_work_dir': '/builds/slave/test', 06:03:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:03:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:03:35 INFO - 'branch': 'Mozilla-Beta', 06:03:35 INFO - 'buildbot_json_path': 'buildprops.json', 06:03:35 INFO - 'config_files': ('talos/linux_config.py',), 06:03:35 INFO - 'default_actions': ('clobber', 06:03:35 INFO - 'read-buildbot-config', 06:03:35 INFO - 'download-and-extract', 06:03:35 INFO - 'populate-webroot', 06:03:35 INFO - 'create-virtualenv', 06:03:35 INFO - 'install', 06:03:35 INFO - 'run-tests'), 06:03:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:03:35 INFO - 'download_minidump_stackwalk': True, 06:03:35 INFO - 'download_symbols': 'ondemand', 06:03:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:03:35 INFO - 'tooltool.py': '/tools/tooltool.py', 06:03:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:03:35 INFO - '/tools/misc-python/virtualenv.py')}, 06:03:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:03:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:03:35 INFO - 'installer_path': 'installer.exe', 06:03:35 INFO - 'log_level': 'info', 06:03:35 INFO - 'log_name': 'talos', 06:03:35 INFO - 'log_to_console': True, 06:03:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:03:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:03:35 INFO - 'opt_config_files': (), 06:03:35 INFO - 'pip_index': False, 06:03:35 INFO - 'sps_profile': False, 06:03:35 INFO - 'sps_profile_interval': 0, 06:03:35 INFO - 'suite': 'dromaeojs', 06:03:35 INFO - 'system_bits': '32', 06:03:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:03:35 INFO - 'title': 'talos-linux64-ix-014', 06:03:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:03:35 INFO - 'use_talos_json': True, 06:03:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:03:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:03:35 INFO - 'work_dir': 'build'} 06:03:35 INFO - ##### 06:03:35 INFO - ##### Running clobber step. 06:03:35 INFO - ##### 06:03:35 INFO - Running pre-action listener: _resource_record_pre_action 06:03:35 INFO - Running main action method: clobber 06:03:35 INFO - rmtree: /builds/slave/test/build 06:03:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:03:35 INFO - Running post-action listener: _resource_record_post_action 06:03:35 INFO - ##### 06:03:35 INFO - ##### Running read-buildbot-config step. 06:03:35 INFO - ##### 06:03:35 INFO - Running pre-action listener: _resource_record_pre_action 06:03:35 INFO - Running main action method: read_buildbot_config 06:03:35 INFO - Using buildbot properties: 06:03:35 INFO - { 06:03:35 INFO - "project": "", 06:03:35 INFO - "product": "firefox", 06:03:35 INFO - "script_repo_revision": "production", 06:03:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:03:35 INFO - "repository": "", 06:03:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:03:35 INFO - "buildid": "20160624143557", 06:03:35 INFO - "pgo_build": "True", 06:03:35 INFO - "basedir": "/builds/slave/test", 06:03:35 INFO - "buildnumber": 132, 06:03:35 INFO - "slavename": "talos-linux64-ix-014", 06:03:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:03:35 INFO - "platform": "ubuntu64_hw", 06:03:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:03:35 INFO - "branch": "mozilla-beta", 06:03:35 INFO - "repo_path": "releases/mozilla-beta", 06:03:35 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 06:03:35 INFO - "stage_platform": "linux64-pgo", 06:03:35 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 06:03:35 INFO - "slavebuilddir": "test" 06:03:35 INFO - } 06:03:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:03:35 INFO - Running post-action listener: _resource_record_post_action 06:03:35 INFO - ##### 06:03:35 INFO - ##### Running download-and-extract step. 06:03:35 INFO - ##### 06:03:35 INFO - Running pre-action listener: _resource_record_pre_action 06:03:35 INFO - Running main action method: download_and_extract 06:03:35 INFO - mkdir: /builds/slave/test/build/tests 06:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:35 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:03:36 INFO - Downloaded 1327 bytes. 06:03:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:03:36 INFO - Using the following test package requirements: 06:03:36 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:03:36 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:03:36 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:03:36 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'jsshell-linux-x86_64.zip'], 06:03:36 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:03:36 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:03:36 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:03:36 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:03:36 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:03:36 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:03:36 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:03:36 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:36 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:03:37 INFO - Downloaded 24228390 bytes. 06:03:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:03:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:03:38 INFO - Return code: 0 06:03:38 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:03:38 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')]} 06:03:38 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:03:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:03:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:03:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:03:39 INFO - Downloaded 24228390 bytes. 06:03:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:03:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:03:41 INFO - Return code: 0 06:03:41 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')]} 06:03:41 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:03:42 INFO - Downloaded 10840145 bytes. 06:03:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:03:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:03:42 INFO - Return code: 0 06:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:42 INFO - https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:03:43 INFO - Downloaded 56007799 bytes. 06:03:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:03:43 INFO - mkdir: /builds/slave/test/properties 06:03:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:03:43 INFO - Writing to file /builds/slave/test/properties/build_url 06:03:43 INFO - Contents: 06:03:43 INFO - build_url:https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:03:44 INFO - Running post-action listener: _resource_record_post_action 06:03:44 INFO - Running post-action listener: set_extra_try_arguments 06:03:44 INFO - ##### 06:03:44 INFO - ##### Running populate-webroot step. 06:03:44 INFO - ##### 06:03:44 INFO - Running pre-action listener: _resource_record_pre_action 06:03:44 INFO - Running main action method: populate_webroot 06:03:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:03:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:03:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:03:44 INFO - '--tppagecycles', 06:03:44 INFO - '7'], 06:03:44 INFO - 'tests': ['tsvgm']}}, 06:03:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:03:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:03:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:03:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:03:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:03:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:03:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['damp', 'tps']}, 06:03:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'tests': ['damp', 'tps']}, 06:03:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['dromaeo_dom']}, 06:03:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:03:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['a11yr', 06:03:44 INFO - 'ts_paint', 06:03:44 INFO - 'tpaint', 06:03:44 INFO - 'sessionrestore', 06:03:44 INFO - 'sessionrestore_no_auto_restore', 06:03:44 INFO - 'tabpaint']}, 06:03:44 INFO - 'other-e10s': {'tests': ['a11yr', 06:03:44 INFO - 'ts_paint', 06:03:44 INFO - 'tpaint', 06:03:44 INFO - 'sessionrestore', 06:03:44 INFO - 'sessionrestore_no_auto_restore', 06:03:44 INFO - 'tabpaint']}, 06:03:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:03:44 INFO - 'ts_paint', 06:03:44 INFO - 'tpaint', 06:03:44 INFO - 'sessionrestore', 06:03:44 INFO - 'sessionrestore_no_auto_restore', 06:03:44 INFO - 'tabpaint']}, 06:03:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:03:44 INFO - 'ts_paint', 06:03:44 INFO - 'tpaint', 06:03:44 INFO - 'sessionrestore', 06:03:44 INFO - 'sessionrestore_no_auto_restore', 06:03:44 INFO - 'tabpaint']}, 06:03:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['a11yr', 06:03:44 INFO - 'ts_paint', 06:03:44 INFO - 'tpaint', 06:03:44 INFO - 'sessionrestore', 06:03:44 INFO - 'sessionrestore_no_auto_restore', 06:03:44 INFO - 'tabpaint']}, 06:03:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['a11yr', 06:03:44 INFO - 'ts_paint', 06:03:44 INFO - 'tpaint', 06:03:44 INFO - 'sessionrestore', 06:03:44 INFO - 'sessionrestore_no_auto_restore', 06:03:44 INFO - 'tabpaint']}, 06:03:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['tsvgx', 06:03:44 INFO - 'tsvgr_opacity', 06:03:44 INFO - 'tart', 06:03:44 INFO - 'tscrollx', 06:03:44 INFO - 'cart']}, 06:03:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:03:44 INFO - 'tsvgr_opacity', 06:03:44 INFO - 'tart', 06:03:44 INFO - 'tscrollx', 06:03:44 INFO - 'cart']}, 06:03:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'talos_options': ['--disable-e10s'], 06:03:44 INFO - 'tests': ['tp5o']}, 06:03:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'tests': ['tp5o']}, 06:03:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'talos_options': ['--disable-e10s', 06:03:44 INFO - '--xperf_path', 06:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:03:44 INFO - 'tests': ['tp5n']}, 06:03:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:03:44 INFO - 'talos_options': ['--xperf_path', 06:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:03:44 INFO - 'tests': ['tp5n']}}, 06:03:44 INFO - 'talos.zip': {'path': '', 06:03:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:03:44 INFO - Running post-action listener: _resource_record_post_action 06:03:44 INFO - ##### 06:03:44 INFO - ##### Running create-virtualenv step. 06:03:44 INFO - ##### 06:03:44 INFO - Running pre-action listener: _resource_record_pre_action 06:03:44 INFO - Running main action method: create_virtualenv 06:03:44 INFO - Creating virtualenv /builds/slave/test/build/venv 06:03:44 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 06:03:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:03:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:03:44 INFO - Using real prefix '/usr' 06:03:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:03:45 INFO - Installing distribute.............................................................................................................................................................................................done. 06:03:47 INFO - Installing pip.................done. 06:03:47 INFO - Return code: 0 06:03:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:03:47 INFO - Using env: {'DISPLAY': ':0', 06:03:47 INFO - 'HOME': '/home/cltbld', 06:03:47 INFO - 'LANG': 'en_US.UTF-8', 06:03:47 INFO - 'LANGUAGE': 'en_US:en', 06:03:47 INFO - 'LOGNAME': 'cltbld', 06:03:47 INFO - 'MAIL': '/var/mail/cltbld', 06:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:47 INFO - 'MOZ_NO_REMOTE': '1', 06:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:47 INFO - 'NO_EM_RESTART': '1', 06:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:47 INFO - 'PWD': '/builds/slave/test', 06:03:47 INFO - 'SHELL': '/bin/bash', 06:03:47 INFO - 'SHLVL': '1', 06:03:47 INFO - 'TERM': 'linux', 06:03:47 INFO - 'TMOUT': '86400', 06:03:47 INFO - 'USER': 'cltbld', 06:03:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:47 INFO - '_': '/tools/buildbot/bin/python'} 06:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:47 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 06:03:47 INFO - Cleaning up... 06:03:47 INFO - Return code: 0 06:03:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:03:47 INFO - Using env: {'DISPLAY': ':0', 06:03:47 INFO - 'HOME': '/home/cltbld', 06:03:47 INFO - 'LANG': 'en_US.UTF-8', 06:03:47 INFO - 'LANGUAGE': 'en_US:en', 06:03:47 INFO - 'LOGNAME': 'cltbld', 06:03:47 INFO - 'MAIL': '/var/mail/cltbld', 06:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:47 INFO - 'MOZ_NO_REMOTE': '1', 06:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:47 INFO - 'NO_EM_RESTART': '1', 06:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:47 INFO - 'PWD': '/builds/slave/test', 06:03:47 INFO - 'SHELL': '/bin/bash', 06:03:47 INFO - 'SHLVL': '1', 06:03:47 INFO - 'TERM': 'linux', 06:03:47 INFO - 'TMOUT': '86400', 06:03:47 INFO - 'USER': 'cltbld', 06:03:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:47 INFO - '_': '/tools/buildbot/bin/python'} 06:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:47 INFO - Downloading/unpacking psutil>=0.7.1 06:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:03:49 INFO - Installing collected packages: psutil 06:03:49 INFO - Running setup.py install for psutil 06:03:49 INFO - building 'psutil._psutil_linux' extension 06:03:49 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 06:03:49 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 06:03:49 INFO - building 'psutil._psutil_posix' extension 06:03:50 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 06:03:50 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 06:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:03:50 INFO - Successfully installed psutil 06:03:50 INFO - Cleaning up... 06:03:50 INFO - Return code: 0 06:03:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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', '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 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:03: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:03: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 mozsystemmonitor==0.0.0 06:03:50 INFO - Using env: {'DISPLAY': ':0', 06:03:50 INFO - 'HOME': '/home/cltbld', 06:03:50 INFO - 'LANG': 'en_US.UTF-8', 06:03:50 INFO - 'LANGUAGE': 'en_US:en', 06:03:50 INFO - 'LOGNAME': 'cltbld', 06:03:50 INFO - 'MAIL': '/var/mail/cltbld', 06:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:50 INFO - 'MOZ_NO_REMOTE': '1', 06:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:50 INFO - 'NO_EM_RESTART': '1', 06:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:50 INFO - 'PWD': '/builds/slave/test', 06:03:50 INFO - 'SHELL': '/bin/bash', 06:03:50 INFO - 'SHLVL': '1', 06:03:50 INFO - 'TERM': 'linux', 06:03:50 INFO - 'TMOUT': '86400', 06:03:50 INFO - 'USER': 'cltbld', 06:03:50 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:50 INFO - '_': '/tools/buildbot/bin/python'} 06:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:03:52 INFO - Installing collected packages: mozsystemmonitor 06:03:52 INFO - Running setup.py install for mozsystemmonitor 06:03:52 INFO - Successfully installed mozsystemmonitor 06:03:52 INFO - Cleaning up... 06:03:52 INFO - Return code: 0 06:03:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:03:52 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')]} 06:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:52 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')]} 06:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:52 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 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:03:52 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 06:03:52 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 06:03:52 INFO - Using env: {'DISPLAY': ':0', 06:03:52 INFO - 'HOME': '/home/cltbld', 06:03:52 INFO - 'LANG': 'en_US.UTF-8', 06:03:52 INFO - 'LANGUAGE': 'en_US:en', 06:03:52 INFO - 'LOGNAME': 'cltbld', 06:03:52 INFO - 'MAIL': '/var/mail/cltbld', 06:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:52 INFO - 'MOZ_NO_REMOTE': '1', 06:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:52 INFO - 'NO_EM_RESTART': '1', 06:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:52 INFO - 'PWD': '/builds/slave/test', 06:03:52 INFO - 'SHELL': '/bin/bash', 06:03:52 INFO - 'SHLVL': '1', 06:03:52 INFO - 'TERM': 'linux', 06:03:52 INFO - 'TMOUT': '86400', 06:03:52 INFO - 'USER': 'cltbld', 06:03:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:52 INFO - '_': '/tools/buildbot/bin/python'} 06:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:52 INFO - Downloading/unpacking blobuploader==1.2.4 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:54 INFO - Downloading blobuploader-1.2.4.tar.gz 06:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:03:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:03:54 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 06:03:54 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 06:03:54 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 06:03:54 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 06:03:54 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 06:03:54 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 06:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:03:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:03:55 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 06:03:55 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 06:03:55 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 06:03:55 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 06:03:55 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 06:03:55 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 06:03:55 INFO - Downloading docopt-0.6.1.tar.gz 06:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:03:55 INFO - Installing collected packages: blobuploader, requests, docopt 06:03:55 INFO - Running setup.py install for blobuploader 06:03:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:03:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:03:55 INFO - Running setup.py install for requests 06:03:55 INFO - Running setup.py install for docopt 06:03:55 INFO - Successfully installed blobuploader requests docopt 06:03:55 INFO - Cleaning up... 06:03:56 INFO - Return code: 0 06:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:56 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')]} 06:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:56 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')]} 06:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:56 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 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:03:56 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 06:03:56 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 06:03:56 INFO - Using env: {'DISPLAY': ':0', 06:03:56 INFO - 'HOME': '/home/cltbld', 06:03:56 INFO - 'LANG': 'en_US.UTF-8', 06:03:56 INFO - 'LANGUAGE': 'en_US:en', 06:03:56 INFO - 'LOGNAME': 'cltbld', 06:03:56 INFO - 'MAIL': '/var/mail/cltbld', 06:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:56 INFO - 'MOZ_NO_REMOTE': '1', 06:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:56 INFO - 'NO_EM_RESTART': '1', 06:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:56 INFO - 'PWD': '/builds/slave/test', 06:03:56 INFO - 'SHELL': '/bin/bash', 06:03:56 INFO - 'SHLVL': '1', 06:03:56 INFO - 'TERM': 'linux', 06:03:56 INFO - 'TMOUT': '86400', 06:03:56 INFO - 'USER': 'cltbld', 06:03:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:56 INFO - '_': '/tools/buildbot/bin/python'} 06:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:56 INFO - Running setup.py (path:/tmp/pip-qeHei1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:56 INFO - Running setup.py (path:/tmp/pip-w3dIev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:56 INFO - Running setup.py (path:/tmp/pip-xE4dBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:56 INFO - Running setup.py (path:/tmp/pip-7g9RX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:56 INFO - Running setup.py (path:/tmp/pip-gDkH1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:56 INFO - Running setup.py (path:/tmp/pip-I7j_uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:56 INFO - Running setup.py (path:/tmp/pip-5B4ltM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:56 INFO - Running setup.py (path:/tmp/pip-PsLViJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:56 INFO - Running setup.py (path:/tmp/pip-UOJXCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:56 INFO - Running setup.py (path:/tmp/pip-GZ50I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:56 INFO - Running setup.py (path:/tmp/pip-DqxwIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:57 INFO - Running setup.py (path:/tmp/pip-57C2xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:57 INFO - Running setup.py (path:/tmp/pip-iP6nVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:57 INFO - Running setup.py (path:/tmp/pip-F3NFB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:57 INFO - Running setup.py (path:/tmp/pip-Z6kLx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:57 INFO - Running setup.py (path:/tmp/pip-L8dLt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:57 INFO - Running setup.py (path:/tmp/pip-jNiAg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:03:57 INFO - Running setup.py install for manifestparser 06:03:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:03:57 INFO - Running setup.py install for mozcrash 06:03:57 INFO - Running setup.py install for mozdebug 06:03:57 INFO - Running setup.py install for mozdevice 06:03:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:03:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:03:57 INFO - Running setup.py install for mozfile 06:03:57 INFO - Running setup.py install for mozhttpd 06:03:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Running setup.py install for mozinfo 06:03:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Running setup.py install for mozInstall 06:03:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Running setup.py install for mozleak 06:03:58 INFO - Running setup.py install for mozlog 06:03:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Running setup.py install for moznetwork 06:03:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Running setup.py install for mozprocess 06:03:58 INFO - Running setup.py install for mozprofile 06:03:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Running setup.py install for mozrunner 06:03:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:03:58 INFO - Running setup.py install for mozscreenshot 06:03:59 INFO - Running setup.py install for moztest 06:03:59 INFO - Running setup.py install for mozversion 06:03:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:03:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:03:59 INFO - Cleaning up... 06:03:59 INFO - Return code: 0 06:03:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:59 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 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:03:59 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 06:03:59 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 06:03:59 INFO - Using env: {'DISPLAY': ':0', 06:03:59 INFO - 'HOME': '/home/cltbld', 06:03:59 INFO - 'LANG': 'en_US.UTF-8', 06:03:59 INFO - 'LANGUAGE': 'en_US:en', 06:03:59 INFO - 'LOGNAME': 'cltbld', 06:03:59 INFO - 'MAIL': '/var/mail/cltbld', 06:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:59 INFO - 'MOZ_NO_REMOTE': '1', 06:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:03:59 INFO - 'NO_EM_RESTART': '1', 06:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:59 INFO - 'PWD': '/builds/slave/test', 06:03:59 INFO - 'SHELL': '/bin/bash', 06:03:59 INFO - 'SHLVL': '1', 06:03:59 INFO - 'TERM': 'linux', 06:03:59 INFO - 'TMOUT': '86400', 06:03:59 INFO - 'USER': 'cltbld', 06:03:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:59 INFO - '_': '/tools/buildbot/bin/python'} 06:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:59 INFO - Running setup.py (path:/tmp/pip-g49RY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:59 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)) 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:59 INFO - Running setup.py (path:/tmp/pip-aRvXpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:59 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)) 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:59 INFO - Running setup.py (path:/tmp/pip-wRc3j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:59 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)) 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:59 INFO - Running setup.py (path:/tmp/pip-LINfot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:59 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)) 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:59 INFO - Running setup.py (path:/tmp/pip-aMJbo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:59 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)) 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:59 INFO - Running setup.py (path:/tmp/pip-V3xRve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:59 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)) 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:59 INFO - Running setup.py (path:/tmp/pip-bX8Ru4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:59 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)) 06:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:59 INFO - Running setup.py (path:/tmp/pip-HC6x_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:04:00 INFO - Running setup.py (path:/tmp/pip-nofiuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:04:00 INFO - Running setup.py (path:/tmp/pip-oufuqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:04:00 INFO - Running setup.py (path:/tmp/pip-oPPCRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:04:00 INFO - Running setup.py (path:/tmp/pip-_JNYCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:04:00 INFO - Running setup.py (path:/tmp/pip-BCy98E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:04:00 INFO - Running setup.py (path:/tmp/pip-MvAhHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:00 INFO - Running setup.py (path:/tmp/pip-7IJM9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:04:00 INFO - Running setup.py (path:/tmp/pip-FKrg07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:04:00 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)) 06:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:04:00 INFO - Running setup.py (path:/tmp/pip-mUu5rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:04:00 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)) 06:04:00 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)) 06:04:00 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)) 06:04:00 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)) 06:04:00 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)) 06:04:00 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)) 06:04:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:04:00 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 06:04:00 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 06:04:00 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 06:04:00 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 06:04:00 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 06:04:00 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 06:04:02 INFO - Downloading blessings-1.6.tar.gz 06:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:04:02 INFO - Installing collected packages: blessings 06:04:02 INFO - Running setup.py install for blessings 06:04:02 INFO - Successfully installed blessings 06:04:02 INFO - Cleaning up... 06:04:02 INFO - Return code: 0 06:04:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:04:03 INFO - Reading from file tmpfile_stdout 06:04:03 INFO - Current package versions: 06:04:03 INFO - argparse == 1.2.1 06:04:03 INFO - blessings == 1.6 06:04:03 INFO - blobuploader == 1.2.4 06:04:03 INFO - docopt == 0.6.1 06:04:03 INFO - manifestparser == 1.1 06:04:03 INFO - mozInstall == 1.12 06:04:03 INFO - mozcrash == 0.17 06:04:03 INFO - mozdebug == 0.1 06:04:03 INFO - mozdevice == 0.48 06:04:03 INFO - mozfile == 1.2 06:04:03 INFO - mozhttpd == 0.7 06:04:03 INFO - mozinfo == 0.9 06:04:03 INFO - mozleak == 0.1 06:04:03 INFO - mozlog == 3.1 06:04:03 INFO - moznetwork == 0.27 06:04:03 INFO - mozprocess == 0.22 06:04:03 INFO - mozprofile == 0.28 06:04:03 INFO - mozrunner == 6.11 06:04:03 INFO - mozscreenshot == 0.1 06:04:03 INFO - mozsystemmonitor == 0.0 06:04:03 INFO - moztest == 0.7 06:04:03 INFO - mozversion == 1.4 06:04:03 INFO - psutil == 3.1.1 06:04:03 INFO - requests == 1.2.3 06:04:03 INFO - wsgiref == 0.1.2 06:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:03 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 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:04:03 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 06:04:03 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 06:04:03 INFO - Using env: {'DISPLAY': ':0', 06:04:03 INFO - 'HOME': '/home/cltbld', 06:04:03 INFO - 'LANG': 'en_US.UTF-8', 06:04:03 INFO - 'LANGUAGE': 'en_US:en', 06:04:03 INFO - 'LOGNAME': 'cltbld', 06:04:03 INFO - 'MAIL': '/var/mail/cltbld', 06:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:03 INFO - 'MOZ_NO_REMOTE': '1', 06:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:03 INFO - 'NO_EM_RESTART': '1', 06:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:03 INFO - 'PWD': '/builds/slave/test', 06:04:03 INFO - 'SHELL': '/bin/bash', 06:04:03 INFO - 'SHLVL': '1', 06:04:03 INFO - 'TERM': 'linux', 06:04:03 INFO - 'TMOUT': '86400', 06:04:03 INFO - 'USER': 'cltbld', 06:04:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:03 INFO - '_': '/tools/buildbot/bin/python'} 06:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 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)) 06:04:03 INFO - Cleaning up... 06:04:03 INFO - Return code: 0 06:04:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:04: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', 'jsonschema'] in /builds/slave/test/build 06:04: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 jsonschema 06:04:03 INFO - Using env: {'DISPLAY': ':0', 06:04:03 INFO - 'HOME': '/home/cltbld', 06:04:03 INFO - 'LANG': 'en_US.UTF-8', 06:04:03 INFO - 'LANGUAGE': 'en_US:en', 06:04:03 INFO - 'LOGNAME': 'cltbld', 06:04:03 INFO - 'MAIL': '/var/mail/cltbld', 06:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:03 INFO - 'MOZ_NO_REMOTE': '1', 06:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:03 INFO - 'NO_EM_RESTART': '1', 06:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:03 INFO - 'PWD': '/builds/slave/test', 06:04:03 INFO - 'SHELL': '/bin/bash', 06:04:03 INFO - 'SHLVL': '1', 06:04:03 INFO - 'TERM': 'linux', 06:04:03 INFO - 'TMOUT': '86400', 06:04:03 INFO - 'USER': 'cltbld', 06:04:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:03 INFO - '_': '/tools/buildbot/bin/python'} 06:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:03 INFO - Downloading/unpacking jsonschema 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:04:05 INFO - Downloading/unpacking functools32 (from jsonschema) 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:04:05 INFO - warning: no files found matching '*.txt' 06:04:05 INFO - no previously-included directories found matching 'build' 06:04:05 INFO - no previously-included directories found matching 'dist' 06:04:05 INFO - no previously-included directories found matching '.git*' 06:04:05 INFO - Installing collected packages: jsonschema, functools32 06:04:05 INFO - Running setup.py install for functools32 06:04:05 INFO - warning: no files found matching '*.txt' 06:04:05 INFO - no previously-included directories found matching 'build' 06:04:05 INFO - no previously-included directories found matching 'dist' 06:04:05 INFO - no previously-included directories found matching '.git*' 06:04:05 INFO - Successfully installed jsonschema functools32 06:04:05 INFO - Cleaning up... 06:04:05 INFO - Return code: 0 06:04:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:04:05 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')]} 06:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:05 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')]} 06:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:05 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 0x7fb2a536bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', '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 06:04:05 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 06:04:05 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 06:04:05 INFO - Using env: {'DISPLAY': ':0', 06:04:05 INFO - 'HOME': '/home/cltbld', 06:04:05 INFO - 'LANG': 'en_US.UTF-8', 06:04:05 INFO - 'LANGUAGE': 'en_US:en', 06:04:05 INFO - 'LOGNAME': 'cltbld', 06:04:05 INFO - 'MAIL': '/var/mail/cltbld', 06:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:05 INFO - 'MOZ_NO_REMOTE': '1', 06:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:05 INFO - 'NO_EM_RESTART': '1', 06:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:05 INFO - 'PWD': '/builds/slave/test', 06:04:05 INFO - 'SHELL': '/bin/bash', 06:04:05 INFO - 'SHLVL': '1', 06:04:05 INFO - 'TERM': 'linux', 06:04:05 INFO - 'TMOUT': '86400', 06:04:05 INFO - 'USER': 'cltbld', 06:04:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:05 INFO - '_': '/tools/buildbot/bin/python'} 06:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:06 INFO - Downloading/unpacking flake8 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:04:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:04:07 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 06:04:07 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 06:04:07 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 06:04:07 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 06:04:07 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 06:04:07 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 06:04:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:04:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:04:08 INFO - no previously-included directories found matching 'docs/_build' 06:04:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:04:08 INFO - Running setup.py install for pep8 06:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:04:08 INFO - no previously-included directories found matching 'docs/_build' 06:04:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:04:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:04:08 INFO - Cleaning up... 06:04:08 INFO - Return code: 0 06:04:08 INFO - Running post-action listener: _resource_record_post_action 06:04:08 INFO - Running post-action listener: _start_resource_monitoring 06:04:08 INFO - Starting resource monitoring. 06:04:08 INFO - ##### 06:04:08 INFO - ##### Running install step. 06:04:08 INFO - ##### 06:04:08 INFO - Running pre-action listener: _resource_record_pre_action 06:04:08 INFO - Running main action method: install 06:04:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:04:09 INFO - Reading from file tmpfile_stdout 06:04:09 INFO - Detecting whether we're running mozinstall >=1.0... 06:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:04:09 INFO - Reading from file tmpfile_stdout 06:04:09 INFO - Output received: 06:04:09 INFO - Usage: mozinstall [options] installer 06:04:09 INFO - Options: 06:04:09 INFO - -h, --help show this help message and exit 06:04:09 INFO - -d DEST, --destination=DEST 06:04:09 INFO - Directory to install application into. [default: 06:04:09 INFO - "/builds/slave/test"] 06:04:09 INFO - --app=APP Application being installed. [default: firefox] 06:04:09 INFO - mkdir: /builds/slave/test/build/application 06:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:04:22 INFO - Reading from file tmpfile_stdout 06:04:22 INFO - Output received: 06:04:22 INFO - /builds/slave/test/build/application/firefox/firefox 06:04:22 INFO - Running post-action listener: _resource_record_post_action 06:04:22 INFO - ##### 06:04:22 INFO - ##### Running run-tests step. 06:04:22 INFO - ##### 06:04:22 INFO - Running pre-action listener: _resource_record_pre_action 06:04:22 INFO - Running main action method: run_tests 06:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:04:22 INFO - Python 2.7.3 06:04:22 INFO - Return code: 0 06:04:22 INFO - grabbing minidump binary from tooltool 06:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04: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 0x1ba6410>, '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 0x1ba7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:04: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 06:04: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 06:04:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:04:22 INFO - Return code: 0 06:04:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:04:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:04:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:04:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:04:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:04:23 INFO - Return code: 0 06:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 06:04:23 INFO - Using env: {'DISPLAY': ':0', 06:04:23 INFO - 'HOME': '/home/cltbld', 06:04:23 INFO - 'LANG': 'en_US.UTF-8', 06:04:23 INFO - 'LANGUAGE': 'en_US:en', 06:04:23 INFO - 'LOGNAME': 'cltbld', 06:04:23 INFO - 'MAIL': '/var/mail/cltbld', 06:04:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:04:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:23 INFO - 'MOZ_NO_REMOTE': '1', 06:04:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:23 INFO - 'NO_EM_RESTART': '1', 06:04:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:23 INFO - 'PWD': '/builds/slave/test', 06:04:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:04:23 INFO - 'SHELL': '/bin/bash', 06:04:23 INFO - 'SHLVL': '1', 06:04:23 INFO - 'TERM': 'linux', 06:04:23 INFO - 'TMOUT': '86400', 06:04:23 INFO - 'USER': 'cltbld', 06:04:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930', 06:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:23 INFO - '_': '/tools/buildbot/bin/python'} 06:04:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 06:04:23 INFO - mozversion application_buildid: 20160624143557 06:04:23 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:04:23 INFO - mozversion application_display_name: Firefox 06:04:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:04:23 INFO - mozversion application_name: Firefox 06:04:23 INFO - mozversion application_remotingname: firefox 06:04:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:04:23 INFO - mozversion application_vendor: Mozilla 06:04:23 INFO - mozversion application_version: 48.0 06:04:23 INFO - mozversion platform_buildid: 20160624143557 06:04:23 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:04:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:04:23 INFO - mozversion platform_version: 48.0 06:04:23 INFO - using testdate: 1467032663 06:04:23 INFO - actual date: 1467032663 06:04:23 INFO - starting webserver on 'localhost:40173' 06:04:23 INFO - SUITE-START | Running 2 tests 06:04:23 INFO - TEST-START | dromaeo_css 06:04:23 INFO - operating with platform_type : linux_ 06:04:23 INFO - Initialising browser for dromaeo_css test... 06:04:23 INFO - TEST-INFO | started process 5989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLniXl7/profile http://localhost:40173/getInfo.html) 06:04:27 INFO - PROCESS | 5989 | __metrics Screen width/height:1600/1200 06:04:27 INFO - PROCESS | 5989 | colorDepth:24 06:04:27 INFO - PROCESS | 5989 | Browser inner width/height: 1024/697 06:04:27 INFO - PROCESS | 5989 | __metrics 06:04:28 ERROR - PROCESS | 5989 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:04:29 INFO - TEST-INFO | 5989: exit 0 06:04:29 INFO - Browser initialized. 06:04:29 INFO - Running cycle 1/1 for dromaeo_css test... 06:04:29 INFO - TEST-INFO | started process 6080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLniXl7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:40 INFO - PROCESS | 6080 | RSS: Main: 139472896 06:04:40 INFO - PROCESS | 6080 | 06:05:32 INFO - PROCESS | 6080 | 1467032732298 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] 06:07:39 INFO - PROCESS | 6080 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40173/tests/dromaeo/cssquery-ext.html) 06:07:40 INFO - PROCESS | 6080 | RSS: Main: 246452224 06:07:40 INFO - PROCESS | 6080 | 06:10:42 INFO - PROCESS | 6080 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-ext.html (next: http://localhost:40173/tests/dromaeo/cssquery-jquery.html) 06:10:42 INFO - PROCESS | 6080 | RSS: Main: 216502272 06:10:42 INFO - PROCESS | 6080 | 06:13:44 INFO - PROCESS | 6080 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40173/tests/dromaeo/cssquery-mootools.html) 06:13:45 INFO - PROCESS | 6080 | RSS: Main: 210165760 06:13:45 INFO - PROCESS | 6080 | 06:16:47 INFO - PROCESS | 6080 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40173/tests/dromaeo/cssquery-prototype.html) 06:16:47 INFO - PROCESS | 6080 | RSS: Main: 215994368 06:16:47 INFO - PROCESS | 6080 | 06:19:50 INFO - PROCESS | 6080 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40173/tests/dromaeo/cssquery-yui.html) 06:19:50 INFO - PROCESS | 6080 | RSS: Main: 179273728 06:19:50 INFO - PROCESS | 6080 | 06:22:52 INFO - PROCESS | 6080 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-yui.html (next: http://localhost:40173/tests/dromaeo/cssquery-dojo.html) 06:22:53 INFO - PROCESS | 6080 | RSS: Main: 251084800 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | __start_tp_report 06:22:53 INFO - PROCESS | 6080 | _x_x_mozilla_page_load 06:22:53 INFO - PROCESS | 6080 | _x_x_mozilla_page_load_details 06:22:53 INFO - PROCESS | 6080 | |i|pagename|runs| 06:22:53 INFO - PROCESS | 6080 | |0;dojo.html;3229.1281354034413;3301.059198128533;3310.4041272570944;3340.5156252343395;3353.161709572607;5437.728113594319;5445.373782015069;5449.972750136249;5453.563714902808;5474.917876231854;5438.428964958682;5439.4832490913395;5446.7276636168235;5448.046591846421;5500.862478438041;4939.135651261033;4971.577415919651;4977.676451030689;5041.621878359119;5083.212102124176;4928.408590969071;4997.0505603935135;5036.269740887569;5045.621578381618;5057.49425057495;4926.655134140611;4939.20972644377;4947.529984651453;4950.653454258203;4954.677945933521;4951.455339912624;4956.207006878918;4984.675996060245;4994.97502512487;5009.574186194178;4914.21372580389;4921.163402221631;4922.680025798311;4961.801527938878;4976.0794253063295;5407.621466497347;5425.511703946624;5447.673139611636;5448.591355648342;5457.836264912059;5949.791757288474;5985.790497332616;5990.041593345088;5992.310884248323;5995.130706047598;5652.152177173416;5830.387809280007;5833.737481813286;5897.587168898179;5933.525317974551;5466.945330546683;5467.589930755209;5480;5480.232767412565;5481.040817856899;5724.055530837365;5927.1405646181065;5944.197533333031;5946.494547963385;5949.494292985145;5781.739821708034;5792.9710351447975;5819.82540523785;5849.034909240013;5857.179994800731;5754.625949313281;5758.280214973129;5758.856028599319;5760.3951585083805;5761.942380576224;5616.241807356037;5738.942610573841;5745.396733343023;5746.770129194869;5763.567732420085;5730.856728581735;5736.741846616912;5740.311162660508;5766.567507436959;5778.306603207642;4427.40230068943;4428.047969686533;4430.468343798765;4445.599896009375;4455.977720111378;3915.588863169326;3941.7437866538585;3969.7419667722083;3998.100427403811;4003.199360127928;5504.339479262514;5506.063969125258;5512.4211957743855;5529.612927095065;5538.667679939216;5787.565932555075;5797.101449275369;5798.10129429939;5799.652020878761;5800.187973683687;5491.258680078218;5511;5549.667019978733;5571.637843540157;5593.608447408642;4938.654294199443;4969.850904472872;4970.179920313108;4973.154563724175;4995.500449955048;5982.970085149546;6067.696615169224;6074.362191969868;6079.817605471843;6081.908771368433;5592.440755924375;5767.942320576741;5832.416758324133;5836.095405212199;5836.591438599427;6033.366496517978;6036.0644100164545;6046.334903160737;6052.546059045677;6053.061775424816;5658.801941932013;5670.262865827416;5676.063449530781;5677.063284558167;5682.659040457585;5675.8864822704145;5763.164341170591;5810.448007439287;5905.527557795452;5922.703864806656;5669.092945128759;5681.0910254359105;5682.886342273048;5688.345840228261;5691.14632805066;5536.75084621201;5627.409122042127;5673.858153546194;5686.402927692533;5694.373618902;5510.201020852034;5546.140348246028;5587.720613969366;5594.804181853616;5606.719664016864;5738.598298119092;5779.7977070804;5799.2750906136735;5802.245708057925;5805.303363596396;5478.342598888159;5585.134304182858;5656.773729050792;5675.943240567707;5677.886442271214 06:22:53 INFO - PROCESS | 6080 | |1;ext.html;616.5807251069274;650.8177710241133;674.2414783368712;686.9622170780608;704.0706267726597;33358.49962250568;34042.14894627636;34090.65909340906;34093.48859767102;40349.59650403495;42943.57056429435;43128.78435607826;43155.78422107893;43168.56831431685;43174;8733.08302628223;8890.288776897833;8908.331875109361;8918.375713700043;8918.866217006751;8182.427230093896;8658.826823463558;10645.361278323287;10870.510827012764;10874.782504349909;10539.947300263488;10558;10606.098481629071;10617.362958222493;10619.362838229692;10423.895761042368;10490.842637360445;10493.265471416966;10494.895051049469;10504.579816807318;10340.172786177087;10424.79150416995;10467.319624224478;10480.318779279323;10506.579736810518;44875.77562112201;45108.548914510764;45271.32093018608;45285.54714452879;45290;3975.3241948868763;3984.043829480933;4059.7970101495102;4063.959360406417;4091.509018917719;32970.835145824116;33228;33744.66255337464;33800.32399352024;33962.15094622654;4402.823887044515;4478.462584489882;4513.435820522434;4521.593056624886;4543.704659197175;332812;335527.3223633891;336293;339169;340099;40656.59343406587;63454.36545634577;63995;64068.679656601416;64075.35924640694;39127.80436097858;39293.803530982164;39314.41028384576;39336.6066339333;39380.409293860044;17287.56781080458;17514.562135946704;17517;17530;17530.123493825256;13460.192388456724;13719.382627781773;13735.931320343334;13764.724705505834;13778.793318100237;9404.482753448627;9450.487921932458;9463.05369463062;9547.188488978376;9602.951985240168;3468.358353704573;3590.7127429805555;3656.670899619047;3688.9262214755554;3716.9442458363146;1114.8717897441736;1145.6734830573246;1148.093006524836;1170.39724541861;1231.6920769807548;32821.17947051295;33358.8332058343;33712.325753484794;33778.15554611154;33992.66007339895;1219.3720234079456;1233.481937586216;1239.1759479945736;1362.50949658123;1388.8680575345327;17691.380801672138;17837.821621783874;17921.103944802708;17973.19120639548;18001.549961251072;483579;590136;596960;600488;602617;64448.677756610916;65136;65240.67379663071;65287;65344;1411.4354258296557;1420.1904914199015;1474.7640377539542;1544.1121355220794;1565.9451919182775;30717.389021933384;32881.69708146732;33150.502742459365;34296;34299.14252143716;51868.22197666963;52405.47594524006;52527.474725253785;52590;52632;374327;377851;378149;378791;378848;27765.861170694017;28499.28751781222;31520.842395787873;32422.35155296928;32464;44243.77878110589;45077.54922450733;45106.323405149604;45283.54716452793;46050.53949460597;40156.3976540358;41432.58567414408;41491.1701765957;41661.58338416698;41856.3721544171;40190.50636671476;40236;40906.38640420337;41124.38313425361;41514.792426037675;42700.145997079264;43038.78480607577;43091;43409.78295108504;43901.121977560906;34578.65421345754;36753.816230918674;36986.260274793814;37006;37582;28083.578746319232;28400.573991389734;28515;28657.856710716314;28735.137945861657 06:22:53 INFO - PROCESS | 6080 | |2;jquery.html;406.8657343076785;409.65384250308495;428.789892952453;430.7566225082828;435.1253979501204;13904.860951390483;18951.905240473796;19609.31367402141;19643.214271429144;20430.387088387335;15537;19877.40367788965;20317.49206269844;20540.897295513503;20620.793792062075;5606.411326810688;5729.054705973509;5755.884882302352;5776.133579963018;5784.074548072309;5621.325440947092;5658.519025882784;5662.122371032476;5677.602567820233;5683.545316374701;5440.619156659035;5647.322321321447;5648.943510564904;5665.178549110397;5749.942500574983;5678.4605462480995;5689.0328644130595;5691.630044047124;5726.885462290773;5731.512821410164;4837.7339246341435;5104.285400043997;5104.515071068243;5128.769205385766;5278.419373868871;23877.7612223879;23890.163844265368;24329.391765205834;24479.510409791703;24648;2595.9870200649066;2632.3813903732607;2685.3018215264174;2782.9304267393277;3072.8924487642826;14318;15279.388824447009;15296.847031529765;15612.76580851288;15748.606284842856;2059.1145807302855;2066.4317312738967;2089.6656534954486;2112.102356498482;2125.4686328417897;71044.2895571048;71490.64254678745;72230.27769722287;72445.63777181134;74296.62851685761;11349.716257093638;11385.886141138648;11431.942840285912;11714;11729.765404691858;14618.56144315651;14656.853431465763;14681.119132852064;14683.853161468462;14697.706045879022;8691.174338437839;8728.345374096842;8836.116388361112;8918.55407229636;8934.09641866396;9010.14403631654;9015.909840901639;9048.864267035868;9053.818923621491;9107;4407.493138289138;4444.288913773846;4501.279795232747;4744.4069491313585;4806;1932.343003378858;2013.3054096336741;2022.393282015419;2042.3158241988804;2051.5178932950744;982.4547376206274;1067.0739315535534;1071.3734010374937;1121.9214654974237;1163.5927425401042;18561.81438185601;18918.43244702661;18933.715994260096;19394.612107757766;19697.606047878962;1051.7633532455136;1065.1798115451213;1075.7579544602402;1107.7507560798917;1118.1725523112839;10701.143908487458;11039.227254092137;11047;11098.389588572705;11159.776804464027;463892;464904;496579;514537;516610;56996;85201;93599.0640093604;95879.52060239794;96241.5187924056;1069.6897899609182;1081.9134469242442;1103.4813637590319;1108.0304733358312;1113.6603335982604;16825;17074.317027318768;17258.482245532654;17360.652786943938;17619.471415857544;38780.41829372618;38938.22123557569;39100.608993910835;41505.16989660129;42642.57357426386;57600;57652.42347576638;57697.4230257692;57910.7104464475;58331;8520.19058189471;8524.27543658796;8638.17937295956;8694.913050869663;8750.781230469289;12792.394406604544;13593.184408935496;14021.088629239066;14310.28448577546;14348.856511434751;9994.550790135245;12093.213941093802;12223.633291001284;12287.201331913397;12592.244465332109;12111.515539378326;12175.208611440228;12181.451834667285;12386.690332741753;12482.375881205722;12183.634490965285;12197.939010304892;12421.813672794735;12484.43820028119;12491.687707807378;8339.332853371594;8351.415400921876;8434.536100514286;8688;8769.956150219208;9729.659461918798;10432.530536126045;10661.733456663645;10746.570137194425;10798.946005269923 06:22:53 INFO - PROCESS | 6080 | |3;mootools.html;1349.4737052549501;1504.9247537623119;1555.8444155584439;1748.8600911927047;1863.9496553790832;7976.361891048717;8143.389245806566;8172.836543269131;8174.877376839338;8185.549794761286;8373.246407823295;8534.829303413928;8542.65829366826;8545.700900468484;8546.444481108723;2440.2557220047834;2470.2218801077693;2473.492933948545;2474.3690358958443;2474.9628755568683;2400.6159014557675;2449.7550244975537;2450.5221481811054;2458.0782206672498;2460.7047154341503;2348.3307257431634;2361.456864921069;2362.397588614901;2410.4696966667307;2423.2245681381964;2419.346776370388;2457.8771061446855;2461.10169788027;2476.455179860437;2479.3553676044266;2390.4262976885598;2431.0397393029652;2445.9510809783883;2445.9877700611382;2446.7920226780743;7088.113985751781;8181.550014749187;8664.913350866475;8734.86897696535;8735.388522803407;5118.07874582575;5191.247269145991;5214.765335559909;5223.033738758304;5231.555317797992;3451.3442445935193;3470.496777967206;3518.6305437928904;3552.0942159749357;3602.963970360315;1142.657202839145;1145.0896537252904;1156.6587856582244;1159.1827761428174;1189.9167058305923;11695;11945.04439644835;12070.879291207064;12181.086418518647;12196.634100976986;4784.158653125994;4792.113459010095;4812.25410061441;4836.588889944394;4879.4388645305535;10349;10372.429516376671;10400.063994240554;10405.9479702601;10420.843687344695;5507.476789704971;5515.200295957144;5520.972395138079;5521.475459831309;5522.502974732293;4973.030259099441;5046.596272298208;5053;5056.140456122468;5058.367704036996;4024.3158663027357;4095.1604920991126;4127.071408933026;4139.482564679415;4148.937765933513;1256.1772039314264;1275.196626125535;1311.04948912038;1322.6891680455085;1327.575175943708;1008.435276245305;1096.3421946831998;1102.7629059752192;1122.7249323915694;1137.8122609769296;5957.16599676037;6178.474829639441;6211.378862113753;6263.96868015657;6316.684165791784;1044.498640652491;1059.4649701900491;1062.4103622489438;1064.7763969566322;1078.0513148429332;4135.669146468275;4208.894777630584;4222.683298752606;4249.851255206053;4256.106217694319;10455.68632941013;10670.35977841332;10746.355218686904;10897;10904.182186336056;10718.41048742311;10730.087942524817;10744;10850.782984340269;10923.945380273048;7694.384449244047;7895;7979;8014.79963000918;8142.063662678749;5742.827715168552;5760.308762948473;5788.0739081746715;5830.53355731532;5985.25184351956;9003.414778039407;9189.081091891025;9240.983491815761;9281.39670921388;9353.625854965725;9274.118958698913;9326.906730932604;9388.295877809329;9577.569009394734;9600.951995239979;7453.776386708408;7470.626468676436;7509.6245187739305;7515.887261690969;7531.020967274219;7846.568438735696;7863.52818830872;7870.527768333918;7876.291133797757;7882.211778822072;7274.781756547312;7524.473286869867;7528.736494222676;7593.658285377061;7645.732399365996;7454.291842274975;7538.585377804274;7545;7632.045994250719;7647.426443016907;6842.315768423317;6865.794026179223;6901.447884169154;6906.965465172642;6916.515843890879;4381.430414046281;5171.379434467888;5419.729013549386;5617.32592088952;5645.181448689999;5116.386033675983;5159.845204643867;5305.973470132624;5320.0955837506945;5363.03465376236 06:22:53 INFO - PROCESS | 6080 | |4;prototype.html;337.0885321504295;337.94761811919153;341.5491551152479;346.2520954737767;348.4738045551217;6137.048757442598;6158.384161583839;6253.937460625392;6281.780137695182;6292.433680968712;5878.1476685880625;5980.970095149529;6089.391060893909;6177.66022868742;6197.1324014637985;4734.124187025394;4773.594244489205;4775.235962246042;4789.904201915968;4790.832320868771;4773.236282194849;4777.04459108178;4780.545848144438;4792.305115758213;4798.4241890973135;4556.111558246143;4611.262198048313;4710.317004034413;4729.55069268419;4741.407324084489;4698.295255711637;4704.4945617402445;4721.2918062290755;4723.881902952419;4729.905401891943;4117.8970525736795;4122.752634841889;4129.545749967501;4130.793460327001;4140.399642051916;5969.343372229051;5986.580939334249;5991.580589358747;6002.309734380558;6009.399060094;5480.671159730429;5482.259894914216;5484.780608775644;5486.3690675572025;5486.753096110685;6428.4214420702365;6546.476281897437;6556.967215163893;6571.737130514822;6642.070110184578;4565.748883811389;4589.2886602576655;4592.586667199968;4599.333096700993;4601.493835678073;6838.794836154923;6847.1783385993;6847.623380714059;6848.931510684929;6860.588364698134;4683.086798074342;4687.601553867891;4693.976530117396;4694.131585656664;4706.364640773451;4711.081339138835;4752.976235118802;4757.048590281957;4757.881052973703;4762.976185119052;5313.760880760375;5480.123180291134;5492.5331346835965;5500.119980803052;5500.7524661390335;6561.475081993429;6573.441257493167;6607;6633.933660663428;6657.567258128206;1604.5427053289757;1648.4477699970644;1654.2142482321042;1659.5602165426171;1666.308481979989;1118.608487029533;1122.71370800447;1151.6717735445359;1158.102470585303;1158.2702897174727;6290.21372328459;6298.1812364392335;6329.398707122816;6337.873242535124;6368.64972426521;6671.933280667228;6701.899471507833;6704.061431399608;6716.395524402729;6729.293424190488;6353.428191462698;6356.2054743157105;6361.4592759615025;6364.522660800459;6369.363063693593;3576.588692300367;3615.801130937771;3617.2584620152807;3618.9276214475562;3625.166211771307;6914.239433662293;7053.858922821515;7056.400205982549;7062.15254169503;7091.184513780878;6851.691673874688;6868.656567171622;6879.140107486564;6879.89680154798;6896.103506544117;7031.753888613874;7047.999999999897;7050;7053.435725142079;7058.047163632947;6684.097646817811;6696.564723293165;6716.361945615159;6720.260771315054;6732.966335168293;6415.743370265137;6625.204975402982;6626.204855417381;6630.436412904957;6632.104665870239;7016.017757514054;7038.3665470107935;7043.7534686285735;7044.753433629799;7045.894311585228;4697.694649847749;4702.365180700698;4714;4716.268978308368;4721.834735784231;6716.798496045127;6724.49566282521;6727.697253623501;6728.596284222962;6736.393724564813;6346.619202847844;6442.484601231984;6613.768518101843;6648.202215734143;6657.900131497934;6615.669216539058;6615.702293396713;6632.933670663425;6633.170853643294;6643.036759669917;6509.1863517060365;6511;6515.12045873801;6525.282218956006;6530.510211734044;6541.08424820516;6678.866422671616;6691.1636045494315;6697.765578204934;6703.095082164041;6446.323136070832;6495.707693153914;6514.218293804774;6516.478681705547;6536.673166341759 06:22:53 INFO - PROCESS | 6080 | |5;yui.html;831.7587899509139;852.9232369086781;881.2377293641002;909.6179604566081;942.9009953954833;15831.129287889162;16066.357345706172;16103.919480402581;16115.83884161158;16117.597060073504;14479.276036198175;14944.103353798753;14973.550793476186;14982.625434364147;14985.775213371808;773.3233420756837;908.7001289574424;909.3043821476575;911.3210658059754;916.9724908252763;925.9259259259277;928.1831987850682;928.3455164109287;928.8606708993638;929.525941769699;969.0890562870914;969.4571040217501;972.9708108756748;973.0804389851593;974.5955428497165;802.1016461563057;953.699584630839;968.7917097823967;968.8934217236134;975.2246963663904;714.8606021825746;715.9033530473372;716.2622498826217;716.7670507085218;717.0857157124656;15253.466128685553;15298.388064477407;15384;15421.614459638487;15426.46007389736;14745;15244.923775381163;15427.691446171126;15812.13033283169;15814.68370632581;12227.14409991301;12267.263964162179;12320.137590368679;12324.32216228107;12528.436220370015;4028.274910516135;4070.7761073140964;4079.6940229482907;4093.713440059197;4178.498580170369;54384.45615543873;54922.72538637321;56990.71504642492;57053.42946570522;57153.714231428574;11869.940650296694;12129.818052729217;12142.150049496451;12164.939175304067;12259;21312.573748525254;21476.463088422603;21482.462938426354;21517.78482215189;21544.892275538834;8701.956490217635;8791.780205494786;9101.908980910106;9110.27117830572;9126.315526335551;4997.675151115166;5021.221710634857;5075.847724568269;5093.592512598983;5157.716325602053;3658.743887927873;3716.163863130828;3717.70258379329;3718.888433347004;3720.088578298334;509.2895410901771;673.5689158938284;684.9006894000343;685.4953377336798;686.3548264631231;676.3878689785654;766.5515673331053;770.2451597434546;772.7179579453459;800.2117913854848;9045.276377889753;9943.850842237372;10009.099181073738;10057.649932103384;10159.187265018782;674.0125715826338;804.8309854930413;818.8894499242646;825.9876101858476;838.7861095420628;4281.828726850953;4506.7070640408265;4680.836170734008;4681.9297710534365;4790.4969978152485;60349.094763577705;61848.690756545926;61923.69038154781;61996.07005894915;68521.65739171272;48714;50461.49538504568;53943.46056539463;54946.450535494136;55029.72485137629;47854.521454785005;48624.5137548627;48822.51177488251;49547.752261239184;49774.75112624486;9387.483688397204;9451.905480945377;9567;9661.806763864824;9676.70969870905;38440.61559384482;39259;39610.405843912944;40011;40098.79950600228;44526.3321050191;45309.32036019397;50954.23568646547;51548.22677659763;52420.21369679381;12382.5666101686;12634.494620215088;12761.553345632858;12792.74414511723;12960.546380876624;14087.15477071338;14250.714985700435;14543.709125817213;14699.632509187355;15486.84513154854;10813.891861081289;12441.875581244072;13494.662633434242;13699.589012329647;13945.442182312594;13363.1313964592;13538.932305338803;13554.93222533881;13558;13685;11928.940355298515;12087.456064477296;12108.334041627795;12203.633890983285;12624.431900564681;11325.263857849543;11511.827322590336;11532.365719885487;11533.295525773852;11798.528058877891;11320.886791132312;11745.887339854775;11787.41062946832;11816.881831181578;12027.15809893299 06:22:53 INFO - PROCESS | 6080 | __end_tp_report 06:22:53 INFO - PROCESS | 6080 | __start_cc_report 06:22:53 INFO - PROCESS | 6080 | _x_x_mozilla_cycle_collect,806 06:22:53 INFO - PROCESS | 6080 | __end_cc_report 06:22:53 INFO - PROCESS | 6080 | __startTimestamp1467033773173__endTimestamp 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | ------- Summary: start ------- 06:22:53 INFO - PROCESS | 6080 | Number of tests: 6 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | [#0] dojo.html Cycles:165 Average:5413.81 Median:5594.80 stddev:595.14 (10.6%) stddev-sans-first:571.75 06:22:53 INFO - PROCESS | 6080 | Values: 3229.1 3301.1 3310.4 3340.5 3353.2 5437.7 5445.4 5450.0 5453.6 5474.9 5438.4 5439.5 5446.7 5448.0 5500.9 4939.1 4971.6 4977.7 5041.6 5083.2 4928.4 4997.1 5036.3 5045.6 5057.5 4926.7 4939.2 4947.5 4950.7 4954.7 4951.5 4956.2 4984.7 4995.0 5009.6 4914.2 4921.2 4922.7 4961.8 4976.1 5407.6 5425.5 5447.7 5448.6 5457.8 5949.8 5985.8 5990.0 5992.3 5995.1 5652.2 5830.4 5833.7 5897.6 5933.5 5466.9 5467.6 5480.0 5480.2 5481.0 5724.1 5927.1 5944.2 5946.5 5949.5 5781.7 5793.0 5819.8 5849.0 5857.2 5754.6 5758.3 5758.9 5760.4 5761.9 5616.2 5738.9 5745.4 5746.8 5763.6 5730.9 5736.7 5740.3 5766.6 5778.3 4427.4 4428.0 4430.5 4445.6 4456.0 3915.6 3941.7 3969.7 3998.1 4003.2 5504.3 5506.1 5512.4 5529.6 5538.7 5787.6 5797.1 5798.1 5799.7 5800.2 5491.3 5511.0 5549.7 5571.6 5593.6 4938.7 4969.9 4970.2 4973.2 4995.5 5983.0 6067.7 6074.4 6079.8 6081.9 5592.4 5767.9 5832.4 5836.1 5836.6 6033.4 6036.1 6046.3 6052.5 6053.1 5658.8 5670.3 5676.1 5677.1 5682.7 5675.9 5763.2 5810.4 5905.5 5922.7 5669.1 5681.1 5682.9 5688.3 5691.1 5536.8 5627.4 5673.9 5686.4 5694.4 5510.2 5546.1 5587.7 5594.8 5606.7 5738.6 5779.8 5799.3 5802.2 5805.3 5478.3 5585.1 5656.8 5675.9 5677.9 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | [#1] ext.html Cycles:180 Average:58899.90 Median:189021.97 stddev:117706.50 (62.3%) stddev-sans-first:117955.35 06:22:53 INFO - PROCESS | 6080 | Values: 616.6 650.8 674.2 687.0 704.1 33358.5 34042.1 34090.7 34093.5 40349.6 42943.6 43128.8 43155.8 43168.6 43174.0 8733.1 8890.3 8908.3 8918.4 8918.9 8182.4 8658.8 10645.4 10870.5 10874.8 10539.9 10558.0 10606.1 10617.4 10619.4 10423.9 10490.8 10493.3 10494.9 10504.6 10340.2 10424.8 10467.3 10480.3 10506.6 44875.8 45108.5 45271.3 45285.5 45290.0 3975.3 3984.0 4059.8 4064.0 4091.5 32970.8 33228.0 33744.7 33800.3 33962.2 4402.8 4478.5 4513.4 4521.6 4543.7 332812.0 335527.3 336293.0 339169.0 340099.0 40656.6 63454.4 63995.0 64068.7 64075.4 39127.8 39293.8 39314.4 39336.6 39380.4 17287.6 17514.6 17517.0 17530.0 17530.1 13460.2 13719.4 13735.9 13764.7 13778.8 9404.5 9450.5 9463.1 9547.2 9603.0 3468.4 3590.7 3656.7 3688.9 3716.9 1114.9 1145.7 1148.1 1170.4 1231.7 32821.2 33358.8 33712.3 33778.2 33992.7 1219.4 1233.5 1239.2 1362.5 1388.9 17691.4 17837.8 17921.1 17973.2 18001.5 483579.0 590136.0 596960.0 600488.0 602617.0 64448.7 65136.0 65240.7 65287.0 65344.0 1411.4 1420.2 1474.8 1544.1 1565.9 30717.4 32881.7 33150.5 34296.0 34299.1 51868.2 52405.5 52527.5 52590.0 52632.0 374327.0 377851.0 378149.0 378791.0 378848.0 27765.9 28499.3 31520.8 32422.4 32464.0 44243.8 45077.5 45106.3 45283.5 46050.5 40156.4 41432.6 41491.2 41661.6 41856.4 40190.5 40236.0 40906.4 41124.4 41514.8 42700.1 43038.8 43091.0 43409.8 43901.1 34578.7 36753.8 36986.3 37006.0 37582.0 28083.6 28400.6 28515.0 28657.9 28735.1 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | [#2] jquery.html Cycles:180 Average:28800.75 Median:24563.76 stddev:80797.98 (328.9%) stddev-sans-first:80996.51 06:22:53 INFO - PROCESS | 6080 | Values: 406.9 409.7 428.8 430.8 435.1 13904.9 18951.9 19609.3 19643.2 20430.4 15537.0 19877.4 20317.5 20540.9 20620.8 5606.4 5729.1 5755.9 5776.1 5784.1 5621.3 5658.5 5662.1 5677.6 5683.5 5440.6 5647.3 5648.9 5665.2 5749.9 5678.5 5689.0 5691.6 5726.9 5731.5 4837.7 5104.3 5104.5 5128.8 5278.4 23877.8 23890.2 24329.4 24479.5 24648.0 2596.0 2632.4 2685.3 2782.9 3072.9 14318.0 15279.4 15296.8 15612.8 15748.6 2059.1 2066.4 2089.7 2112.1 2125.5 71044.3 71490.6 72230.3 72445.6 74296.6 11349.7 11385.9 11431.9 11714.0 11729.8 14618.6 14656.9 14681.1 14683.9 14697.7 8691.2 8728.3 8836.1 8918.6 8934.1 9010.1 9015.9 9048.9 9053.8 9107.0 4407.5 4444.3 4501.3 4744.4 4806.0 1932.3 2013.3 2022.4 2042.3 2051.5 982.5 1067.1 1071.4 1121.9 1163.6 18561.8 18918.4 18933.7 19394.6 19697.6 1051.8 1065.2 1075.8 1107.8 1118.2 10701.1 11039.2 11047.0 11098.4 11159.8 463892.0 464904.0 496579.0 514537.0 516610.0 56996.0 85201.0 93599.1 95879.5 96241.5 1069.7 1081.9 1103.5 1108.0 1113.7 16825.0 17074.3 17258.5 17360.7 17619.5 38780.4 38938.2 39100.6 41505.2 42642.6 57600.0 57652.4 57697.4 57910.7 58331.0 8520.2 8524.3 8638.2 8694.9 8750.8 12792.4 13593.2 14021.1 14310.3 14348.9 9994.6 12093.2 12223.6 12287.2 12592.2 12111.5 12175.2 12181.5 12386.7 12482.4 12183.6 12197.9 12421.8 12484.4 12491.7 8339.3 8351.4 8434.5 8688.0 8770.0 9729.7 10432.5 10661.7 10746.6 10798.9 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | [#3] mootools.html Cycles:180 Average:5724.86 Median:4926.23 stddev:3110.25 (63.1%) stddev-sans-first:3101.59 06:22:53 INFO - PROCESS | 6080 | Values: 1349.5 1504.9 1555.8 1748.9 1863.9 7976.4 8143.4 8172.8 8174.9 8185.5 8373.2 8534.8 8542.7 8545.7 8546.4 2440.3 2470.2 2473.5 2474.4 2475.0 2400.6 2449.8 2450.5 2458.1 2460.7 2348.3 2361.5 2362.4 2410.5 2423.2 2419.3 2457.9 2461.1 2476.5 2479.4 2390.4 2431.0 2446.0 2446.0 2446.8 7088.1 8181.6 8664.9 8734.9 8735.4 5118.1 5191.2 5214.8 5223.0 5231.6 3451.3 3470.5 3518.6 3552.1 3603.0 1142.7 1145.1 1156.7 1159.2 1189.9 11695.0 11945.0 12070.9 12181.1 12196.6 4784.2 4792.1 4812.3 4836.6 4879.4 10349.0 10372.4 10400.1 10405.9 10420.8 5507.5 5515.2 5521.0 5521.5 5522.5 4973.0 5046.6 5053.0 5056.1 5058.4 4024.3 4095.2 4127.1 4139.5 4148.9 1256.2 1275.2 1311.0 1322.7 1327.6 1008.4 1096.3 1102.8 1122.7 1137.8 5957.2 6178.5 6211.4 6264.0 6316.7 1044.5 1059.5 1062.4 1064.8 1078.1 4135.7 4208.9 4222.7 4249.9 4256.1 10455.7 10670.4 10746.4 10897.0 10904.2 10718.4 10730.1 10744.0 10850.8 10923.9 7694.4 7895.0 7979.0 8014.8 8142.1 5742.8 5760.3 5788.1 5830.5 5985.3 9003.4 9189.1 9241.0 9281.4 9353.6 9274.1 9326.9 9388.3 9577.6 9601.0 7453.8 7470.6 7509.6 7515.9 7531.0 7846.6 7863.5 7870.5 7876.3 7882.2 7274.8 7524.5 7528.7 7593.7 7645.7 7454.3 7538.6 7545.0 7632.0 7647.4 6842.3 6865.8 6901.4 6907.0 6916.5 4381.4 5171.4 5419.7 5617.3 5645.2 5116.4 5159.8 5306.0 5320.1 5363.0 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | [#4] prototype.html Cycles:180 Average:5501.21 Median:6295.31 stddev:1654.47 (26.3%) stddev-sans-first:1613.07 06:22:53 INFO - PROCESS | 6080 | Values: 337.1 337.9 341.5 346.3 348.5 6137.0 6158.4 6253.9 6281.8 6292.4 5878.1 5981.0 6089.4 6177.7 6197.1 4734.1 4773.6 4775.2 4789.9 4790.8 4773.2 4777.0 4780.5 4792.3 4798.4 4556.1 4611.3 4710.3 4729.6 4741.4 4698.3 4704.5 4721.3 4723.9 4729.9 4117.9 4122.8 4129.5 4130.8 4140.4 5969.3 5986.6 5991.6 6002.3 6009.4 5480.7 5482.3 5484.8 5486.4 5486.8 6428.4 6546.5 6557.0 6571.7 6642.1 4565.7 4589.3 4592.6 4599.3 4601.5 6838.8 6847.2 6847.6 6848.9 6860.6 4683.1 4687.6 4694.0 4694.1 4706.4 4711.1 4753.0 4757.0 4757.9 4763.0 5313.8 5480.1 5492.5 5500.1 5500.8 6561.5 6573.4 6607.0 6633.9 6657.6 1604.5 1648.4 1654.2 1659.6 1666.3 1118.6 1122.7 1151.7 1158.1 1158.3 6290.2 6298.2 6329.4 6337.9 6368.6 6671.9 6701.9 6704.1 6716.4 6729.3 6353.4 6356.2 6361.5 6364.5 6369.4 3576.6 3615.8 3617.3 3618.9 3625.2 6914.2 7053.9 7056.4 7062.2 7091.2 6851.7 6868.7 6879.1 6879.9 6896.1 7031.8 7048.0 7050.0 7053.4 7058.0 6684.1 6696.6 6716.4 6720.3 6733.0 6415.7 6625.2 6626.2 6630.4 6632.1 7016.0 7038.4 7043.8 7044.8 7045.9 4697.7 4702.4 4714.0 4716.3 4721.8 6716.8 6724.5 6727.7 6728.6 6736.4 6346.6 6442.5 6613.8 6648.2 6657.9 6615.7 6615.7 6632.9 6633.2 6643.0 6509.2 6511.0 6515.1 6525.3 6530.5 6541.1 6678.9 6691.2 6697.8 6703.1 6446.3 6495.7 6514.2 6516.5 6536.7 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - PROCESS | 6080 | [#5] yui.html Cycles:180 Average:15531.80 Median:24908.01 stddev:17351.37 (69.7%) stddev-sans-first:17364.92 06:22:53 INFO - PROCESS | 6080 | Values: 831.8 852.9 881.2 909.6 942.9 15831.1 16066.4 16103.9 16115.8 16117.6 14479.3 14944.1 14973.6 14982.6 14985.8 773.3 908.7 909.3 911.3 917.0 925.9 928.2 928.3 928.9 929.5 969.1 969.5 973.0 973.1 974.6 802.1 953.7 968.8 968.9 975.2 714.9 715.9 716.3 716.8 717.1 15253.5 15298.4 15384.0 15421.6 15426.5 14745.0 15244.9 15427.7 15812.1 15814.7 12227.1 12267.3 12320.1 12324.3 12528.4 4028.3 4070.8 4079.7 4093.7 4178.5 54384.5 54922.7 56990.7 57053.4 57153.7 11869.9 12129.8 12142.2 12164.9 12259.0 21312.6 21476.5 21482.5 21517.8 21544.9 8702.0 8791.8 9101.9 9110.3 9126.3 4997.7 5021.2 5075.8 5093.6 5157.7 3658.7 3716.2 3717.7 3718.9 3720.1 509.3 673.6 684.9 685.5 686.4 676.4 766.6 770.2 772.7 800.2 9045.3 9943.9 10009.1 10057.6 10159.2 674.0 804.8 818.9 826.0 838.8 4281.8 4506.7 4680.8 4681.9 4790.5 60349.1 61848.7 61923.7 61996.1 68521.7 48714.0 50461.5 53943.5 54946.5 55029.7 47854.5 48624.5 48822.5 49547.8 49774.8 9387.5 9451.9 9567.0 9661.8 9676.7 38440.6 39259.0 39610.4 40011.0 40098.8 44526.3 45309.3 50954.2 51548.2 52420.2 12382.6 12634.5 12761.6 12792.7 12960.5 14087.2 14250.7 14543.7 14699.6 15486.8 10813.9 12441.9 13494.7 13699.6 13945.4 13363.1 13538.9 13554.9 13558.0 13685.0 11928.9 12087.5 12108.3 12203.6 12624.4 11325.3 11511.8 11532.4 11533.3 11798.5 11320.9 11745.9 11787.4 11816.9 12027.2 06:22:53 INFO - PROCESS | 6080 | -------- Summary: end -------- 06:22:53 INFO - PROCESS | 6080 | 06:22:53 INFO - TEST-INFO | 6080: exit 0 06:22:53 INFO - TEST-OK | dromaeo_css | took 1110258ms 06:22:53 INFO - TEST-START | kraken 06:22:53 INFO - operating with platform_type : linux_ 06:22:53 INFO - Initialising browser for kraken test... 06:22:53 INFO - TEST-INFO | started process 6271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wUF4j/profile http://localhost:40173/getInfo.html) 06:22:57 INFO - PROCESS | 6271 | __metrics Screen width/height:1600/1200 06:22:57 INFO - PROCESS | 6271 | colorDepth:24 06:22:57 INFO - PROCESS | 6271 | Browser inner width/height: 1024/697 06:22:57 INFO - PROCESS | 6271 | __metrics 06:22:58 ERROR - PROCESS | 6271 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:22:59 INFO - TEST-INFO | 6271: exit 0 06:22:59 INFO - Browser initialized. 06:22:59 INFO - Running cycle 1/1 for kraken test... 06:22:59 INFO - TEST-INFO | started process 6361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wUF4j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:23:11 INFO - PROCESS | 6361 | RSS: Main: 139517952 06:23:11 INFO - PROCESS | 6361 | 06:23:13 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-beat-detection) 06:23:14 INFO - PROCESS | 6361 | RSS: Main: 197410816 06:23:14 INFO - PROCESS | 6361 | 06:23:17 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-dft) 06:23:17 INFO - PROCESS | 6361 | RSS: Main: 185237504 06:23:17 INFO - PROCESS | 6361 | 06:23:20 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-fft) 06:23:21 INFO - PROCESS | 6361 | RSS: Main: 274882560 06:23:21 INFO - PROCESS | 6361 | 06:23:23 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-oscillator) 06:23:23 INFO - PROCESS | 6361 | RSS: Main: 181297152 06:23:23 INFO - PROCESS | 6361 | 06:23:25 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:23:26 INFO - PROCESS | 6361 | RSS: Main: 179060736 06:23:26 INFO - PROCESS | 6361 | 06:23:29 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40173/tests/kraken/driver.html?testName=imaging-darkroom) 06:23:30 INFO - PROCESS | 6361 | RSS: Main: 213491712 06:23:30 INFO - PROCESS | 6361 | 06:23:33 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40173/tests/kraken/driver.html?testName=imaging-desaturate) 06:23:34 INFO - PROCESS | 6361 | RSS: Main: 214106112 06:23:34 INFO - PROCESS | 6361 | 06:23:36 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40173/tests/kraken/driver.html?testName=json-parse-financial) 06:23:37 INFO - PROCESS | 6361 | RSS: Main: 213184512 06:23:37 INFO - PROCESS | 6361 | 06:23:38 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:23:39 INFO - PROCESS | 6361 | RSS: Main: 196231168 06:23:39 INFO - PROCESS | 6361 | 06:23:41 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:23:41 INFO - PROCESS | 6361 | RSS: Main: 200474624 06:23:41 INFO - PROCESS | 6361 | 06:23:43 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:23:44 INFO - PROCESS | 6361 | RSS: Main: 210313216 06:23:44 INFO - PROCESS | 6361 | 06:23:46 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:23:47 INFO - PROCESS | 6361 | RSS: Main: 217157632 06:23:47 INFO - PROCESS | 6361 | 06:23:50 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:23:50 INFO - PROCESS | 6361 | RSS: Main: 211902464 06:23:50 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40173/tests/kraken/driver.html?testName=ai-astar) 06:23:52 INFO - PROCESS | 6361 | RSS: Main: 272564224 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | __start_tp_report 06:23:52 INFO - PROCESS | 6361 | _x_x_mozilla_page_load 06:23:52 INFO - PROCESS | 6361 | _x_x_mozilla_page_load_details 06:23:52 INFO - PROCESS | 6361 | |i|pagename|runs| 06:23:52 INFO - PROCESS | 6361 | |0;ai-astar;110;110;109;110;111;111;105;110;109;110 06:23:52 INFO - PROCESS | 6361 | |1;audio-beat-detection;156;128;153;176;128;155;162;129;180;124 06:23:52 INFO - PROCESS | 6361 | |2;audio-dft;162;160;161;160;160;161;159;168;160;161 06:23:52 INFO - PROCESS | 6361 | |3;audio-fft;76;74;72;176;77;76;75;77;169;76 06:23:52 INFO - PROCESS | 6361 | |4;audio-oscillator;92;92;156;92;91;92;150;92;91;146 06:23:52 INFO - PROCESS | 6361 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;118;116;117 06:23:52 INFO - PROCESS | 6361 | |6;imaging-darkroom;145;145;144;145;146;145;145;147;146;146 06:23:52 INFO - PROCESS | 6361 | |7;imaging-desaturate;95;94;94;94;94;95;94;94;94;94 06:23:52 INFO - PROCESS | 6361 | |8;json-parse-financial;54;56;54;54;54;55;60;75;53;53 06:23:52 INFO - PROCESS | 6361 | |9;json-stringify-tinderbox;59;59;58;58;59;58;59;59;60;58 06:23:52 INFO - PROCESS | 6361 | |10;stanford-crypto-aes;74;74;74;73;76;74;74;74;74;74 06:23:52 INFO - PROCESS | 6361 | |11;stanford-crypto-ccm;116;119;118;117;114;116;111;114;135;116 06:23:52 INFO - PROCESS | 6361 | |12;stanford-crypto-pbkdf2;163;158;166;159;159;164;161;158;157;161 06:23:52 INFO - PROCESS | 6361 | |13;stanford-crypto-sha256-iterative;66;66;68;66;65;65;65;67;64;67 06:23:52 INFO - PROCESS | 6361 | __end_tp_report 06:23:52 INFO - PROCESS | 6361 | __start_cc_report 06:23:52 INFO - PROCESS | 6361 | _x_x_mozilla_cycle_collect,1587 06:23:52 INFO - PROCESS | 6361 | __end_cc_report 06:23:52 INFO - PROCESS | 6361 | __startTimestamp1467033832629__endTimestamp 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | ------- Summary: start ------- 06:23:52 INFO - PROCESS | 6361 | Number of tests: 14 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.72 (1.6%) stddev-sans-first:1.81 06:23:52 INFO - PROCESS | 6361 | Values: 110.0 110.0 109.0 110.0 111.0 111.0 105.0 110.0 109.0 110.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.50 stddev:20.73 (13.3%) stddev-sans-first:21.83 06:23:52 INFO - PROCESS | 6361 | Values: 156.0 128.0 153.0 176.0 128.0 155.0 162.0 129.0 180.0 124.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:2.53 (1.6%) stddev-sans-first:2.67 06:23:52 INFO - PROCESS | 6361 | Values: 162.0 160.0 161.0 160.0 160.0 161.0 159.0 168.0 160.0 161.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:41.01 (54.0%) stddev-sans-first:42.93 06:23:52 INFO - PROCESS | 6361 | Values: 76.0 74.0 72.0 176.0 77.0 76.0 75.0 77.0 169.0 76.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:28.58 (31.1%) stddev-sans-first:29.61 06:23:52 INFO - PROCESS | 6361 | Values: 92.0 92.0 156.0 92.0 91.0 92.0 150.0 92.0 91.0 146.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 06:23:52 INFO - PROCESS | 6361 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 116.0 117.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 06:23:52 INFO - PROCESS | 6361 | Values: 145.0 145.0 144.0 145.0 146.0 145.0 145.0 147.0 146.0 146.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:23:52 INFO - PROCESS | 6361 | Values: 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:54.50 stddev:6.71 (12.3%) stddev-sans-first:7.04 06:23:52 INFO - PROCESS | 6361 | Values: 54.0 56.0 54.0 54.0 54.0 55.0 60.0 75.0 53.0 53.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 06:23:52 INFO - PROCESS | 6361 | Values: 59.0 59.0 58.0 58.0 59.0 58.0 59.0 59.0 60.0 58.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 06:23:52 INFO - PROCESS | 6361 | Values: 74.0 74.0 74.0 73.0 76.0 74.0 74.0 74.0 74.0 74.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:116.50 stddev:6.52 (5.6%) stddev-sans-first:6.89 06:23:52 INFO - PROCESS | 6361 | Values: 116.0 119.0 118.0 117.0 114.0 116.0 111.0 114.0 135.0 116.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.95 (1.8%) stddev-sans-first:3.00 06:23:52 INFO - PROCESS | 6361 | Values: 163.0 158.0 166.0 159.0 159.0 164.0 161.0 158.0 157.0 161.0 06:23:52 INFO - PROCESS | 6361 | 06:23:52 INFO - PROCESS | 6361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 06:23:52 INFO - PROCESS | 6361 | Values: 66.0 66.0 68.0 66.0 65.0 65.0 65.0 67.0 64.0 67.0 06:23:52 INFO - PROCESS | 6361 | -------- Summary: end -------- 06:23:52 INFO - PROCESS | 6361 | 06:23:53 INFO - TEST-INFO | 6361: exit 0 06:23:53 INFO - TEST-OK | kraken | took 59758ms 06:23:53 INFO - SUITE-END | took 1170s 06:23:53 INFO - Completed test suite (00:19:30) 06:23:53 INFO - javascript benchmark 06:23:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3229.1281354034413, 3301.059198128533, 3310.4041272570944, 3340.5156252343395, 3353.161709572607, 5437.728113594319, 5445.373782015069, 5449.972750136249, 5453.563714902808, 5474.917876231854, 5438.428964958682, 5439.4832490913395, 5446.7276636168235, 5448.046591846421, 5500.862478438041, 4939.135651261033, 4971.577415919651, 4977.676451030689, 5041.621878359119, 5083.212102124176, 4928.408590969071, 4997.0505603935135, 5036.269740887569, 5045.621578381618, 5057.49425057495, 4926.655134140611, 4939.20972644377, 4947.529984651453, 4950.653454258203, 4954.677945933521, 4951.455339912624, 4956.207006878918, 4984.675996060245, 4994.97502512487, 5009.574186194178, 4914.21372580389, 4921.163402221631, 4922.680025798311, 4961.801527938878, 4976.0794253063295, 5407.621466497347, 5425.511703946624, 5447.673139611636, 5448.591355648342, 5457.836264912059, 5949.791757288474, 5985.790497332616, 5990.041593345088, 5992.310884248323, 5995.130706047598, 5652.152177173416, 5830.387809280007, 5833.737481813286, 5897.587168898179, 5933.525317974551, 5466.945330546683, 5467.589930755209, 5480.0, 5480.232767412565, 5481.040817856899, 5724.055530837365, 5927.1405646181065, 5944.197533333031, 5946.494547963385, 5949.494292985145, 5781.739821708034, 5792.9710351447975, 5819.82540523785, 5849.034909240013, 5857.179994800731, 5754.625949313281, 5758.280214973129, 5758.856028599319, 5760.3951585083805, 5761.942380576224, 5616.241807356037, 5738.942610573841, 5745.396733343023, 5746.770129194869, 5763.567732420085, 5730.856728581735, 5736.741846616912, 5740.311162660508, 5766.567507436959, 5778.306603207642, 4427.40230068943, 4428.047969686533, 4430.468343798765, 4445.599896009375, 4455.977720111378, 3915.588863169326, 3941.7437866538585, 3969.7419667722083, 3998.100427403811, 4003.199360127928, 5504.339479262514, 5506.063969125258, 5512.4211957743855, 5529.612927095065, 5538.667679939216, 5787.565932555075, 5797.101449275369, 5798.10129429939, 5799.652020878761, 5800.187973683687, 5491.258680078218, 5511.0, 5549.667019978733, 5571.637843540157, 5593.608447408642, 4938.654294199443, 4969.850904472872, 4970.179920313108, 4973.154563724175, 4995.500449955048, 5982.970085149546, 6067.696615169224, 6074.362191969868, 6079.817605471843, 6081.908771368433, 5592.440755924375, 5767.942320576741, 5832.416758324133, 5836.095405212199, 5836.591438599427, 6033.366496517978, 6036.0644100164545, 6046.334903160737, 6052.546059045677, 6053.061775424816, 5658.801941932013, 5670.262865827416, 5676.063449530781, 5677.063284558167, 5682.659040457585, 5675.8864822704145, 5763.164341170591, 5810.448007439287, 5905.527557795452, 5922.703864806656, 5669.092945128759, 5681.0910254359105, 5682.886342273048, 5688.345840228261, 5691.14632805066, 5536.75084621201, 5627.409122042127, 5673.858153546194, 5686.402927692533, 5694.373618902, 5510.201020852034, 5546.140348246028, 5587.720613969366, 5594.804181853616, 5606.719664016864, 5738.598298119092, 5779.7977070804, 5799.2750906136735, 5802.245708057925, 5805.303363596396, 5478.342598888159, 5585.134304182858, 5656.773729050792, 5675.943240567707, 5677.886442271214], "value": 5375.579129267454, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.5807251069274, 650.8177710241133, 674.2414783368712, 686.9622170780608, 704.0706267726597, 33358.49962250568, 34042.14894627636, 34090.65909340906, 34093.48859767102, 40349.59650403495, 42943.57056429435, 43128.78435607826, 43155.78422107893, 43168.56831431685, 43174.0, 8733.08302628223, 8890.288776897833, 8908.331875109361, 8918.375713700043, 8918.866217006751, 8182.427230093896, 8658.826823463558, 10645.361278323287, 10870.510827012764, 10874.782504349909, 10539.947300263488, 10558.0, 10606.098481629071, 10617.362958222493, 10619.362838229692, 10423.895761042368, 10490.842637360445, 10493.265471416966, 10494.895051049469, 10504.579816807318, 10340.172786177087, 10424.79150416995, 10467.319624224478, 10480.318779279323, 10506.579736810518, 44875.77562112201, 45108.548914510764, 45271.32093018608, 45285.54714452879, 45290.0, 3975.3241948868763, 3984.043829480933, 4059.7970101495102, 4063.959360406417, 4091.509018917719, 32970.835145824116, 33228.0, 33744.66255337464, 33800.32399352024, 33962.15094622654, 4402.823887044515, 4478.462584489882, 4513.435820522434, 4521.593056624886, 4543.704659197175, 332812.0, 335527.3223633891, 336293.0, 339169.0, 340099.0, 40656.59343406587, 63454.36545634577, 63995.0, 64068.679656601416, 64075.35924640694, 39127.80436097858, 39293.803530982164, 39314.41028384576, 39336.6066339333, 39380.409293860044, 17287.56781080458, 17514.562135946704, 17517.0, 17530.0, 17530.123493825256, 13460.192388456724, 13719.382627781773, 13735.931320343334, 13764.724705505834, 13778.793318100237, 9404.482753448627, 9450.487921932458, 9463.05369463062, 9547.188488978376, 9602.951985240168, 3468.358353704573, 3590.7127429805555, 3656.670899619047, 3688.9262214755554, 3716.9442458363146, 1114.8717897441736, 1145.6734830573246, 1148.093006524836, 1170.39724541861, 1231.6920769807548, 32821.17947051295, 33358.8332058343, 33712.325753484794, 33778.15554611154, 33992.66007339895, 1219.3720234079456, 1233.481937586216, 1239.1759479945736, 1362.50949658123, 1388.8680575345327, 17691.380801672138, 17837.821621783874, 17921.103944802708, 17973.19120639548, 18001.549961251072, 483579.0, 590136.0, 596960.0, 600488.0, 602617.0, 64448.677756610916, 65136.0, 65240.67379663071, 65287.0, 65344.0, 1411.4354258296557, 1420.1904914199015, 1474.7640377539542, 1544.1121355220794, 1565.9451919182775, 30717.389021933384, 32881.69708146732, 33150.502742459365, 34296.0, 34299.14252143716, 51868.22197666963, 52405.47594524006, 52527.474725253785, 52590.0, 52632.0, 374327.0, 377851.0, 378149.0, 378791.0, 378848.0, 27765.861170694017, 28499.28751781222, 31520.842395787873, 32422.35155296928, 32464.0, 44243.77878110589, 45077.54922450733, 45106.323405149604, 45283.54716452793, 46050.53949460597, 40156.3976540358, 41432.58567414408, 41491.1701765957, 41661.58338416698, 41856.3721544171, 40190.50636671476, 40236.0, 40906.38640420337, 41124.38313425361, 41514.792426037675, 42700.145997079264, 43038.78480607577, 43091.0, 43409.78295108504, 43901.121977560906, 34578.65421345754, 36753.816230918674, 36986.260274793814, 37006.0, 37582.0, 28083.578746319232, 28400.573991389734, 28515.0, 28657.856710716314, 28735.137945861657], "value": 19944.67402084894, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.8657343076785, 409.65384250308495, 428.789892952453, 430.7566225082828, 435.1253979501204, 13904.860951390483, 18951.905240473796, 19609.31367402141, 19643.214271429144, 20430.387088387335, 15537.0, 19877.40367788965, 20317.49206269844, 20540.897295513503, 20620.793792062075, 5606.411326810688, 5729.054705973509, 5755.884882302352, 5776.133579963018, 5784.074548072309, 5621.325440947092, 5658.519025882784, 5662.122371032476, 5677.602567820233, 5683.545316374701, 5440.619156659035, 5647.322321321447, 5648.943510564904, 5665.178549110397, 5749.942500574983, 5678.4605462480995, 5689.0328644130595, 5691.630044047124, 5726.885462290773, 5731.512821410164, 4837.7339246341435, 5104.285400043997, 5104.515071068243, 5128.769205385766, 5278.419373868871, 23877.7612223879, 23890.163844265368, 24329.391765205834, 24479.510409791703, 24648.0, 2595.9870200649066, 2632.3813903732607, 2685.3018215264174, 2782.9304267393277, 3072.8924487642826, 14318.0, 15279.388824447009, 15296.847031529765, 15612.76580851288, 15748.606284842856, 2059.1145807302855, 2066.4317312738967, 2089.6656534954486, 2112.102356498482, 2125.4686328417897, 71044.2895571048, 71490.64254678745, 72230.27769722287, 72445.63777181134, 74296.62851685761, 11349.716257093638, 11385.886141138648, 11431.942840285912, 11714.0, 11729.765404691858, 14618.56144315651, 14656.853431465763, 14681.119132852064, 14683.853161468462, 14697.706045879022, 8691.174338437839, 8728.345374096842, 8836.116388361112, 8918.55407229636, 8934.09641866396, 9010.14403631654, 9015.909840901639, 9048.864267035868, 9053.818923621491, 9107.0, 4407.493138289138, 4444.288913773846, 4501.279795232747, 4744.4069491313585, 4806.0, 1932.343003378858, 2013.3054096336741, 2022.393282015419, 2042.3158241988804, 2051.5178932950744, 982.4547376206274, 1067.0739315535534, 1071.3734010374937, 1121.9214654974237, 1163.5927425401042, 18561.81438185601, 18918.43244702661, 18933.715994260096, 19394.612107757766, 19697.606047878962, 1051.7633532455136, 1065.1798115451213, 1075.7579544602402, 1107.7507560798917, 1118.1725523112839, 10701.143908487458, 11039.227254092137, 11047.0, 11098.389588572705, 11159.776804464027, 463892.0, 464904.0, 496579.0, 514537.0, 516610.0, 56996.0, 85201.0, 93599.0640093604, 95879.52060239794, 96241.5187924056, 1069.6897899609182, 1081.9134469242442, 1103.4813637590319, 1108.0304733358312, 1113.6603335982604, 16825.0, 17074.317027318768, 17258.482245532654, 17360.652786943938, 17619.471415857544, 38780.41829372618, 38938.22123557569, 39100.608993910835, 41505.16989660129, 42642.57357426386, 57600.0, 57652.42347576638, 57697.4230257692, 57910.7104464475, 58331.0, 8520.19058189471, 8524.27543658796, 8638.17937295956, 8694.913050869663, 8750.781230469289, 12792.394406604544, 13593.184408935496, 14021.088629239066, 14310.28448577546, 14348.856511434751, 9994.550790135245, 12093.213941093802, 12223.633291001284, 12287.201331913397, 12592.244465332109, 12111.515539378326, 12175.208611440228, 12181.451834667285, 12386.690332741753, 12482.375881205722, 12183.634490965285, 12197.939010304892, 12421.813672794735, 12484.43820028119, 12491.687707807378, 8339.332853371594, 8351.415400921876, 8434.536100514286, 8688.0, 8769.956150219208, 9729.659461918798, 10432.530536126045, 10661.733456663645, 10746.570137194425, 10798.946005269923], "value": 9456.840695259767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.4737052549501, 1504.9247537623119, 1555.8444155584439, 1748.8600911927047, 1863.9496553790832, 7976.361891048717, 8143.389245806566, 8172.836543269131, 8174.877376839338, 8185.549794761286, 8373.246407823295, 8534.829303413928, 8542.65829366826, 8545.700900468484, 8546.444481108723, 2440.2557220047834, 2470.2218801077693, 2473.492933948545, 2474.3690358958443, 2474.9628755568683, 2400.6159014557675, 2449.7550244975537, 2450.5221481811054, 2458.0782206672498, 2460.7047154341503, 2348.3307257431634, 2361.456864921069, 2362.397588614901, 2410.4696966667307, 2423.2245681381964, 2419.346776370388, 2457.8771061446855, 2461.10169788027, 2476.455179860437, 2479.3553676044266, 2390.4262976885598, 2431.0397393029652, 2445.9510809783883, 2445.9877700611382, 2446.7920226780743, 7088.113985751781, 8181.550014749187, 8664.913350866475, 8734.86897696535, 8735.388522803407, 5118.07874582575, 5191.247269145991, 5214.765335559909, 5223.033738758304, 5231.555317797992, 3451.3442445935193, 3470.496777967206, 3518.6305437928904, 3552.0942159749357, 3602.963970360315, 1142.657202839145, 1145.0896537252904, 1156.6587856582244, 1159.1827761428174, 1189.9167058305923, 11695.0, 11945.04439644835, 12070.879291207064, 12181.086418518647, 12196.634100976986, 4784.158653125994, 4792.113459010095, 4812.25410061441, 4836.588889944394, 4879.4388645305535, 10349.0, 10372.429516376671, 10400.063994240554, 10405.9479702601, 10420.843687344695, 5507.476789704971, 5515.200295957144, 5520.972395138079, 5521.475459831309, 5522.502974732293, 4973.030259099441, 5046.596272298208, 5053.0, 5056.140456122468, 5058.367704036996, 4024.3158663027357, 4095.1604920991126, 4127.071408933026, 4139.482564679415, 4148.937765933513, 1256.1772039314264, 1275.196626125535, 1311.04948912038, 1322.6891680455085, 1327.575175943708, 1008.435276245305, 1096.3421946831998, 1102.7629059752192, 1122.7249323915694, 1137.8122609769296, 5957.16599676037, 6178.474829639441, 6211.378862113753, 6263.96868015657, 6316.684165791784, 1044.498640652491, 1059.4649701900491, 1062.4103622489438, 1064.7763969566322, 1078.0513148429332, 4135.669146468275, 4208.894777630584, 4222.683298752606, 4249.851255206053, 4256.106217694319, 10455.68632941013, 10670.35977841332, 10746.355218686904, 10897.0, 10904.182186336056, 10718.41048742311, 10730.087942524817, 10744.0, 10850.782984340269, 10923.945380273048, 7694.384449244047, 7895.0, 7979.0, 8014.79963000918, 8142.063662678749, 5742.827715168552, 5760.308762948473, 5788.0739081746715, 5830.53355731532, 5985.25184351956, 9003.414778039407, 9189.081091891025, 9240.983491815761, 9281.39670921388, 9353.625854965725, 9274.118958698913, 9326.906730932604, 9388.295877809329, 9577.569009394734, 9600.951995239979, 7453.776386708408, 7470.626468676436, 7509.6245187739305, 7515.887261690969, 7531.020967274219, 7846.568438735696, 7863.52818830872, 7870.527768333918, 7876.291133797757, 7882.211778822072, 7274.781756547312, 7524.473286869867, 7528.736494222676, 7593.658285377061, 7645.732399365996, 7454.291842274975, 7538.585377804274, 7545.0, 7632.045994250719, 7647.426443016907, 6842.315768423317, 6865.794026179223, 6901.447884169154, 6906.965465172642, 6916.515843890879, 4381.430414046281, 5171.379434467888, 5419.729013549386, 5617.32592088952, 5645.181448689999, 5116.386033675983, 5159.845204643867, 5305.973470132624, 5320.0955837506945, 5363.03465376236], "value": 4679.613627420695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.0885321504295, 337.94761811919153, 341.5491551152479, 346.2520954737767, 348.4738045551217, 6137.048757442598, 6158.384161583839, 6253.937460625392, 6281.780137695182, 6292.433680968712, 5878.1476685880625, 5980.970095149529, 6089.391060893909, 6177.66022868742, 6197.1324014637985, 4734.124187025394, 4773.594244489205, 4775.235962246042, 4789.904201915968, 4790.832320868771, 4773.236282194849, 4777.04459108178, 4780.545848144438, 4792.305115758213, 4798.4241890973135, 4556.111558246143, 4611.262198048313, 4710.317004034413, 4729.55069268419, 4741.407324084489, 4698.295255711637, 4704.4945617402445, 4721.2918062290755, 4723.881902952419, 4729.905401891943, 4117.8970525736795, 4122.752634841889, 4129.545749967501, 4130.793460327001, 4140.399642051916, 5969.343372229051, 5986.580939334249, 5991.580589358747, 6002.309734380558, 6009.399060094, 5480.671159730429, 5482.259894914216, 5484.780608775644, 5486.3690675572025, 5486.753096110685, 6428.4214420702365, 6546.476281897437, 6556.967215163893, 6571.737130514822, 6642.070110184578, 4565.748883811389, 4589.2886602576655, 4592.586667199968, 4599.333096700993, 4601.493835678073, 6838.794836154923, 6847.1783385993, 6847.623380714059, 6848.931510684929, 6860.588364698134, 4683.086798074342, 4687.601553867891, 4693.976530117396, 4694.131585656664, 4706.364640773451, 4711.081339138835, 4752.976235118802, 4757.048590281957, 4757.881052973703, 4762.976185119052, 5313.760880760375, 5480.123180291134, 5492.5331346835965, 5500.119980803052, 5500.7524661390335, 6561.475081993429, 6573.441257493167, 6607.0, 6633.933660663428, 6657.567258128206, 1604.5427053289757, 1648.4477699970644, 1654.2142482321042, 1659.5602165426171, 1666.308481979989, 1118.608487029533, 1122.71370800447, 1151.6717735445359, 1158.102470585303, 1158.2702897174727, 6290.21372328459, 6298.1812364392335, 6329.398707122816, 6337.873242535124, 6368.64972426521, 6671.933280667228, 6701.899471507833, 6704.061431399608, 6716.395524402729, 6729.293424190488, 6353.428191462698, 6356.2054743157105, 6361.4592759615025, 6364.522660800459, 6369.363063693593, 3576.588692300367, 3615.801130937771, 3617.2584620152807, 3618.9276214475562, 3625.166211771307, 6914.239433662293, 7053.858922821515, 7056.400205982549, 7062.15254169503, 7091.184513780878, 6851.691673874688, 6868.656567171622, 6879.140107486564, 6879.89680154798, 6896.103506544117, 7031.753888613874, 7047.999999999897, 7050.0, 7053.435725142079, 7058.047163632947, 6684.097646817811, 6696.564723293165, 6716.361945615159, 6720.260771315054, 6732.966335168293, 6415.743370265137, 6625.204975402982, 6626.204855417381, 6630.436412904957, 6632.104665870239, 7016.017757514054, 7038.3665470107935, 7043.7534686285735, 7044.753433629799, 7045.894311585228, 4697.694649847749, 4702.365180700698, 4714.0, 4716.268978308368, 4721.834735784231, 6716.798496045127, 6724.49566282521, 6727.697253623501, 6728.596284222962, 6736.393724564813, 6346.619202847844, 6442.484601231984, 6613.768518101843, 6648.202215734143, 6657.900131497934, 6615.669216539058, 6615.702293396713, 6632.933670663425, 6633.170853643294, 6643.036759669917, 6509.1863517060365, 6511.0, 6515.12045873801, 6525.282218956006, 6530.510211734044, 6541.08424820516, 6678.866422671616, 6691.1636045494315, 6697.765578204934, 6703.095082164041, 6446.323136070832, 6495.707693153914, 6514.218293804774, 6516.478681705547, 6536.673166341759], "value": 4961.447986953948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.7587899509139, 852.9232369086781, 881.2377293641002, 909.6179604566081, 942.9009953954833, 15831.129287889162, 16066.357345706172, 16103.919480402581, 16115.83884161158, 16117.597060073504, 14479.276036198175, 14944.103353798753, 14973.550793476186, 14982.625434364147, 14985.775213371808, 773.3233420756837, 908.7001289574424, 909.3043821476575, 911.3210658059754, 916.9724908252763, 925.9259259259277, 928.1831987850682, 928.3455164109287, 928.8606708993638, 929.525941769699, 969.0890562870914, 969.4571040217501, 972.9708108756748, 973.0804389851593, 974.5955428497165, 802.1016461563057, 953.699584630839, 968.7917097823967, 968.8934217236134, 975.2246963663904, 714.8606021825746, 715.9033530473372, 716.2622498826217, 716.7670507085218, 717.0857157124656, 15253.466128685553, 15298.388064477407, 15384.0, 15421.614459638487, 15426.46007389736, 14745.0, 15244.923775381163, 15427.691446171126, 15812.13033283169, 15814.68370632581, 12227.14409991301, 12267.263964162179, 12320.137590368679, 12324.32216228107, 12528.436220370015, 4028.274910516135, 4070.7761073140964, 4079.6940229482907, 4093.713440059197, 4178.498580170369, 54384.45615543873, 54922.72538637321, 56990.71504642492, 57053.42946570522, 57153.714231428574, 11869.940650296694, 12129.818052729217, 12142.150049496451, 12164.939175304067, 12259.0, 21312.573748525254, 21476.463088422603, 21482.462938426354, 21517.78482215189, 21544.892275538834, 8701.956490217635, 8791.780205494786, 9101.908980910106, 9110.27117830572, 9126.315526335551, 4997.675151115166, 5021.221710634857, 5075.847724568269, 5093.592512598983, 5157.716325602053, 3658.743887927873, 3716.163863130828, 3717.70258379329, 3718.888433347004, 3720.088578298334, 509.2895410901771, 673.5689158938284, 684.9006894000343, 685.4953377336798, 686.3548264631231, 676.3878689785654, 766.5515673331053, 770.2451597434546, 772.7179579453459, 800.2117913854848, 9045.276377889753, 9943.850842237372, 10009.099181073738, 10057.649932103384, 10159.187265018782, 674.0125715826338, 804.8309854930413, 818.8894499242646, 825.9876101858476, 838.7861095420628, 4281.828726850953, 4506.7070640408265, 4680.836170734008, 4681.9297710534365, 4790.4969978152485, 60349.094763577705, 61848.690756545926, 61923.69038154781, 61996.07005894915, 68521.65739171272, 48714.0, 50461.49538504568, 53943.46056539463, 54946.450535494136, 55029.72485137629, 47854.521454785005, 48624.5137548627, 48822.51177488251, 49547.752261239184, 49774.75112624486, 9387.483688397204, 9451.905480945377, 9567.0, 9661.806763864824, 9676.70969870905, 38440.61559384482, 39259.0, 39610.405843912944, 40011.0, 40098.79950600228, 44526.3321050191, 45309.32036019397, 50954.23568646547, 51548.22677659763, 52420.21369679381, 12382.5666101686, 12634.494620215088, 12761.553345632858, 12792.74414511723, 12960.546380876624, 14087.15477071338, 14250.714985700435, 14543.709125817213, 14699.632509187355, 15486.84513154854, 10813.891861081289, 12441.875581244072, 13494.662633434242, 13699.589012329647, 13945.442182312594, 13363.1313964592, 13538.932305338803, 13554.93222533881, 13558.0, 13685.0, 11928.940355298515, 12087.456064477296, 12108.334041627795, 12203.633890983285, 12624.431900564681, 11325.263857849543, 11511.827322590336, 11532.365719885487, 11533.295525773852, 11798.528058877891, 11320.886791132312, 11745.887339854775, 11787.41062946832, 11816.881831181578, 12027.15809893299], "value": 7249.172089736122, "unit": "score"}], "name": "dromaeo_css", "value": 7447.731243430869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 110.0, 111.0, 111.0, 105.0, 110.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 153.0, 176.0, 128.0, 155.0, 162.0, 129.0, 180.0, 124.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 160.0, 161.0, 159.0, 168.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 72.0, 176.0, 77.0, 76.0, 75.0, 77.0, 169.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 156.0, 92.0, 91.0, 92.0, 150.0, 92.0, 91.0, 146.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 144.0, 145.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 54.0, 54.0, 55.0, 60.0, 75.0, 53.0, 53.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 59.0, 58.0, 59.0, 59.0, 60.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 73.0, 76.0, 74.0, 74.0, 74.0, 74.0, 74.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 118.0, 117.0, 114.0, 116.0, 111.0, 114.0, 135.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 166.0, 159.0, 159.0, 164.0, 161.0, 158.0, 157.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 66.0, 65.0, 65.0, 65.0, 67.0, 64.0, 67.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1514.1, "alertThreshold": 2.0}]} 06:23:53 INFO - Return code: 0 06:23:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:23:53 ERROR - # TBPL SUCCESS # 06:23:53 INFO - Running post-action listener: _resource_record_post_action 06:23:53 INFO - Running post-run listener: _resource_record_post_run 06:23:54 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 465412096; Read time: 4; Write time: 402756 06:23:54 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 250134528; Read time: 0; Write time: 239856 06:23:55 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 215277568; Read time: 4; Write time: 162900 06:23:55 INFO - Running post-run listener: _upload_blobber_files 06:23:55 INFO - Blob upload gear active. 06:23:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:23:55 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 06:23:55 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:23:55 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:23:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:56 INFO - (blobuploader) - INFO - Done attempting. 06:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:56 INFO - (blobuploader) - INFO - Done attempting. 06:23:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:23:56 INFO - Return code: 0 06:23:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:23:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:23:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/39f91313305aba3c999bdf901780ce25e3cbb5bc832a119b56512a4770e353caad502259d5b85b37a26858746b0c517478b75f2508223850481a85e9f8151f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f78f0c0094368d61862d8528befbc4770af1b782050a4387969a03c3274187004a0f99dd5e28bfb70b9e6b3184bd72a514d926381b7187baa9444f6a9550c344"} 06:23:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:23:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:23:56 INFO - Contents: 06:23:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/39f91313305aba3c999bdf901780ce25e3cbb5bc832a119b56512a4770e353caad502259d5b85b37a26858746b0c517478b75f2508223850481a85e9f8151f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f78f0c0094368d61862d8528befbc4770af1b782050a4387969a03c3274187004a0f99dd5e28bfb70b9e6b3184bd72a514d926381b7187baa9444f6a9550c344"} 06:23:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:23:56 INFO - Copying logs to upload dir... 06:23:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:23:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.692163 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-06-27 06:23:56.873899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:23:56.878715) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930 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-Beta/sha512/39f91313305aba3c999bdf901780ce25e3cbb5bc832a119b56512a4770e353caad502259d5b85b37a26858746b0c517478b75f2508223850481a85e9f8151f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f78f0c0094368d61862d8528befbc4770af1b782050a4387969a03c3274187004a0f99dd5e28bfb70b9e6b3184bd72a514d926381b7187baa9444f6a9550c344"} build_url:https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/39f91313305aba3c999bdf901780ce25e3cbb5bc832a119b56512a4770e353caad502259d5b85b37a26858746b0c517478b75f2508223850481a85e9f8151f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f78f0c0094368d61862d8528befbc4770af1b782050a4387969a03c3274187004a0f99dd5e28bfb70b9e6b3184bd72a514d926381b7187baa9444f6a9550c344"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:23:56.906586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:23:56.906900) ========= 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=31acecf42b6a79ec49471d4a000001bb-1467032612.883410-643681930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:23:56.989132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:23:56.992485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:23:56.992782) ========= ========= Total master_lag: 0.19 =========