builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1467032687.55 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.546991) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.547459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.547736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.562232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.562567) ========= 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=db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 06:04:48-- 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% 46.1M=0s 2016-06-27 06:04:48 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127610 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.731323) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.731637) ========= 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=db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014734 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.799281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.799652) ========= 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=db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 06:04:49,078 truncating revision to first 12 chars 2016-06-27 06:04:49,078 Setting DEBUG logging. 2016-06-27 06:04:49,078 attempt 1/10 2016-06-27 06:04:49,078 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:04:49,427 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.479920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.480224) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.480626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.480891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.490107) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-27 06:04:48.490462) ========= /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=db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:04:49 INFO - MultiFileLogger online at 20160627 06:04:49 in /builds/slave/test 06:04:49 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:04:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:04:49 INFO - {'append_to_log': False, 06:04:49 INFO - 'base_work_dir': '/builds/slave/test', 06:04:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:04:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:04:49 INFO - 'branch': 'Mozilla-Beta', 06:04:49 INFO - 'buildbot_json_path': 'buildprops.json', 06:04:49 INFO - 'config_files': ('talos/linux_config.py',), 06:04:49 INFO - 'default_actions': ('clobber', 06:04:49 INFO - 'read-buildbot-config', 06:04:49 INFO - 'download-and-extract', 06:04:49 INFO - 'populate-webroot', 06:04:49 INFO - 'create-virtualenv', 06:04:49 INFO - 'install', 06:04:49 INFO - 'run-tests'), 06:04:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:04:49 INFO - 'download_minidump_stackwalk': True, 06:04:49 INFO - 'download_symbols': 'ondemand', 06:04:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:04:49 INFO - 'tooltool.py': '/tools/tooltool.py', 06:04:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:04:49 INFO - '/tools/misc-python/virtualenv.py')}, 06:04:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:04:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:04:49 INFO - 'installer_path': 'installer.exe', 06:04:49 INFO - 'log_level': 'info', 06:04:49 INFO - 'log_name': 'talos', 06:04:49 INFO - 'log_to_console': True, 06:04:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:04:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:04:49 INFO - 'opt_config_files': (), 06:04:49 INFO - 'pip_index': False, 06:04:49 INFO - 'sps_profile': False, 06:04:49 INFO - 'sps_profile_interval': 0, 06:04:49 INFO - 'suite': 'dromaeojs', 06:04:49 INFO - 'system_bits': '32', 06:04:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:49 INFO - 'title': 'talos-linux64-ix-031', 06:04:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:04:49 INFO - 'use_talos_json': True, 06:04:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:04:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:04:49 INFO - 'work_dir': 'build'} 06:04:49 INFO - ##### 06:04:49 INFO - ##### Running clobber step. 06:04:49 INFO - ##### 06:04:49 INFO - Running pre-action listener: _resource_record_pre_action 06:04:49 INFO - Running main action method: clobber 06:04:49 INFO - rmtree: /builds/slave/test/build 06:04:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:04:50 INFO - Running post-action listener: _resource_record_post_action 06:04:50 INFO - ##### 06:04:50 INFO - ##### Running read-buildbot-config step. 06:04:50 INFO - ##### 06:04:50 INFO - Running pre-action listener: _resource_record_pre_action 06:04:50 INFO - Running main action method: read_buildbot_config 06:04:50 INFO - Using buildbot properties: 06:04:50 INFO - { 06:04:50 INFO - "project": "", 06:04:50 INFO - "product": "firefox", 06:04:50 INFO - "script_repo_revision": "production", 06:04:50 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:04:50 INFO - "repository": "", 06:04:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:04:50 INFO - "buildid": "20160624143557", 06:04:50 INFO - "pgo_build": "True", 06:04:50 INFO - "basedir": "/builds/slave/test", 06:04:50 INFO - "buildnumber": 133, 06:04:50 INFO - "slavename": "talos-linux64-ix-031", 06:04:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:04:50 INFO - "platform": "ubuntu64_hw", 06:04:50 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:04:50 INFO - "branch": "mozilla-beta", 06:04:50 INFO - "repo_path": "releases/mozilla-beta", 06:04:50 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 06:04:50 INFO - "stage_platform": "linux64-pgo", 06:04:50 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 06:04:50 INFO - "slavebuilddir": "test" 06:04:50 INFO - } 06:04:50 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:04:50 INFO - Running post-action listener: _resource_record_post_action 06:04:50 INFO - ##### 06:04:50 INFO - ##### Running download-and-extract step. 06:04:50 INFO - ##### 06:04:50 INFO - Running pre-action listener: _resource_record_pre_action 06:04:50 INFO - Running main action method: download_and_extract 06:04:50 INFO - mkdir: /builds/slave/test/build/tests 06:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:50 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:04:50 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:04:50 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:04:50 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:04:50 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:04:51 INFO - Downloaded 1327 bytes. 06:04:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:04:51 INFO - Using the following test package requirements: 06:04:51 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:04:51 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:51 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:04:51 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'jsshell-linux-x86_64.zip'], 06:04:51 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:51 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:04:51 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:04:51 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:04:51 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:51 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:04:51 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:51 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:52 INFO - Downloaded 24228390 bytes. 06:04:52 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:04:52 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:04:53 INFO - Return code: 0 06:04:53 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:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:53 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:04:53 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:04:53 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:04:53 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:04:53 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:04:54 INFO - Downloaded 24228390 bytes. 06:04:54 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:04:54 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:04:56 INFO - Return code: 0 06:04: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:04:56 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:04:56 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:04:56 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:04:56 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:04:56 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:04:57 INFO - Downloaded 10840145 bytes. 06:04:57 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:04:57 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:04:57 INFO - Return code: 0 06:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:57 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:04:57 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:04:57 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:04:57 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:04:57 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:04:58 INFO - Downloaded 56007799 bytes. 06:04:58 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:04:58 INFO - mkdir: /builds/slave/test/properties 06:04:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:04:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:04:58 INFO - Contents: 06:04:58 INFO - build_url:https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:04:59 INFO - Running post-action listener: _resource_record_post_action 06:04:59 INFO - Running post-action listener: set_extra_try_arguments 06:04:59 INFO - ##### 06:04:59 INFO - ##### Running populate-webroot step. 06:04:59 INFO - ##### 06:04:59 INFO - Running pre-action listener: _resource_record_pre_action 06:04:59 INFO - Running main action method: populate_webroot 06:04:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:04:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:04:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:04:59 INFO - '--tppagecycles', 06:04:59 INFO - '7'], 06:04:59 INFO - 'tests': ['tsvgm']}}, 06:04:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:04:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:04:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:04:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:04:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['damp', 'tps']}, 06:04:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'tests': ['damp', 'tps']}, 06:04:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['dromaeo_dom']}, 06:04:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:04:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['a11yr', 06:04:59 INFO - 'ts_paint', 06:04:59 INFO - 'tpaint', 06:04:59 INFO - 'sessionrestore', 06:04:59 INFO - 'sessionrestore_no_auto_restore', 06:04:59 INFO - 'tabpaint']}, 06:04:59 INFO - 'other-e10s': {'tests': ['a11yr', 06:04:59 INFO - 'ts_paint', 06:04:59 INFO - 'tpaint', 06:04:59 INFO - 'sessionrestore', 06:04:59 INFO - 'sessionrestore_no_auto_restore', 06:04:59 INFO - 'tabpaint']}, 06:04:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:04:59 INFO - 'ts_paint', 06:04:59 INFO - 'tpaint', 06:04:59 INFO - 'sessionrestore', 06:04:59 INFO - 'sessionrestore_no_auto_restore', 06:04:59 INFO - 'tabpaint']}, 06:04:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:04:59 INFO - 'ts_paint', 06:04:59 INFO - 'tpaint', 06:04:59 INFO - 'sessionrestore', 06:04:59 INFO - 'sessionrestore_no_auto_restore', 06:04:59 INFO - 'tabpaint']}, 06:04:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['a11yr', 06:04:59 INFO - 'ts_paint', 06:04:59 INFO - 'tpaint', 06:04:59 INFO - 'sessionrestore', 06:04:59 INFO - 'sessionrestore_no_auto_restore', 06:04:59 INFO - 'tabpaint']}, 06:04:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['a11yr', 06:04:59 INFO - 'ts_paint', 06:04:59 INFO - 'tpaint', 06:04:59 INFO - 'sessionrestore', 06:04:59 INFO - 'sessionrestore_no_auto_restore', 06:04:59 INFO - 'tabpaint']}, 06:04:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['tsvgx', 06:04:59 INFO - 'tsvgr_opacity', 06:04:59 INFO - 'tart', 06:04:59 INFO - 'tscrollx', 06:04:59 INFO - 'cart']}, 06:04:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:04:59 INFO - 'tsvgr_opacity', 06:04:59 INFO - 'tart', 06:04:59 INFO - 'tscrollx', 06:04:59 INFO - 'cart']}, 06:04:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'talos_options': ['--disable-e10s'], 06:04:59 INFO - 'tests': ['tp5o']}, 06:04:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'tests': ['tp5o']}, 06:04:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'talos_options': ['--disable-e10s', 06:04:59 INFO - '--xperf_path', 06:04:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:59 INFO - 'tests': ['tp5n']}, 06:04:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:59 INFO - 'talos_options': ['--xperf_path', 06:04:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:59 INFO - 'tests': ['tp5n']}}, 06:04:59 INFO - 'talos.zip': {'path': '', 06:04:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:04:59 INFO - Running post-action listener: _resource_record_post_action 06:04:59 INFO - ##### 06:04:59 INFO - ##### Running create-virtualenv step. 06:04:59 INFO - ##### 06:04:59 INFO - Running pre-action listener: _resource_record_pre_action 06:04:59 INFO - Running main action method: create_virtualenv 06:04:59 INFO - Creating virtualenv /builds/slave/test/build/venv 06:04:59 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:04:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:04:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:04:59 INFO - Using real prefix '/usr' 06:04:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:04:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:01 INFO - Installing pip.................done. 06:05:01 INFO - Return code: 0 06:05:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:05:01 INFO - Using env: {'DISPLAY': ':0', 06:05:01 INFO - 'HOME': '/home/cltbld', 06:05:01 INFO - 'LANG': 'en_US.UTF-8', 06:05:01 INFO - 'LANGUAGE': 'en_US:en', 06:05:01 INFO - 'LOGNAME': 'cltbld', 06:05:01 INFO - 'MAIL': '/var/mail/cltbld', 06:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:01 INFO - 'MOZ_NO_REMOTE': '1', 06:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:01 INFO - 'NO_EM_RESTART': '1', 06:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:01 INFO - 'PWD': '/builds/slave/test', 06:05:01 INFO - 'SHELL': '/bin/bash', 06:05:01 INFO - 'SHLVL': '1', 06:05:01 INFO - 'TERM': 'linux', 06:05:01 INFO - 'TMOUT': '86400', 06:05:01 INFO - 'USER': 'cltbld', 06:05:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:01 INFO - '_': '/tools/buildbot/bin/python'} 06:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:02 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:05:02 INFO - Cleaning up... 06:05:02 INFO - Return code: 0 06:05:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:05:02 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:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:02 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:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:02 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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:02 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:05:02 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:05:02 INFO - Using env: {'DISPLAY': ':0', 06:05:02 INFO - 'HOME': '/home/cltbld', 06:05:02 INFO - 'LANG': 'en_US.UTF-8', 06:05:02 INFO - 'LANGUAGE': 'en_US:en', 06:05:02 INFO - 'LOGNAME': 'cltbld', 06:05:02 INFO - 'MAIL': '/var/mail/cltbld', 06:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:02 INFO - 'MOZ_NO_REMOTE': '1', 06:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:02 INFO - 'NO_EM_RESTART': '1', 06:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:02 INFO - 'PWD': '/builds/slave/test', 06:05:02 INFO - 'SHELL': '/bin/bash', 06:05:02 INFO - 'SHLVL': '1', 06:05:02 INFO - 'TERM': 'linux', 06:05:02 INFO - 'TMOUT': '86400', 06:05:02 INFO - 'USER': 'cltbld', 06:05:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:02 INFO - '_': '/tools/buildbot/bin/python'} 06:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:02 INFO - Downloading/unpacking psutil>=0.7.1 06:05:02 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:05:02 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:05:02 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:05:02 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:05:02 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:05:02 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:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:04 INFO - Installing collected packages: psutil 06:05:04 INFO - Running setup.py install for psutil 06:05:04 INFO - building 'psutil._psutil_linux' extension 06:05:04 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:05:04 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:05:04 INFO - building 'psutil._psutil_posix' extension 06:05:04 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:05:04 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:05:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:04 INFO - Successfully installed psutil 06:05:04 INFO - Cleaning up... 06:05:05 INFO - Return code: 0 06:05:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:05: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:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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', '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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:05: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 mozsystemmonitor==0.0.0 06:05:05 INFO - Using env: {'DISPLAY': ':0', 06:05:05 INFO - 'HOME': '/home/cltbld', 06:05:05 INFO - 'LANG': 'en_US.UTF-8', 06:05:05 INFO - 'LANGUAGE': 'en_US:en', 06:05:05 INFO - 'LOGNAME': 'cltbld', 06:05:05 INFO - 'MAIL': '/var/mail/cltbld', 06:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:05 INFO - 'MOZ_NO_REMOTE': '1', 06:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:05 INFO - 'NO_EM_RESTART': '1', 06:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:05 INFO - 'PWD': '/builds/slave/test', 06:05:05 INFO - 'SHELL': '/bin/bash', 06:05:05 INFO - 'SHLVL': '1', 06:05:05 INFO - 'TERM': 'linux', 06:05:05 INFO - 'TMOUT': '86400', 06:05:05 INFO - 'USER': 'cltbld', 06:05:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:05 INFO - '_': '/tools/buildbot/bin/python'} 06:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:05: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:05: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:05: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:05: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:05: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:05: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:05:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:07 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:05:07 INFO - Installing collected packages: mozsystemmonitor 06:05:07 INFO - Running setup.py install for mozsystemmonitor 06:05:07 INFO - Successfully installed mozsystemmonitor 06:05:07 INFO - Cleaning up... 06:05:07 INFO - Return code: 0 06:05:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05:07 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:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:07 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:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:07 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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:07 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:05:07 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:05:07 INFO - Using env: {'DISPLAY': ':0', 06:05:07 INFO - 'HOME': '/home/cltbld', 06:05:07 INFO - 'LANG': 'en_US.UTF-8', 06:05:07 INFO - 'LANGUAGE': 'en_US:en', 06:05:07 INFO - 'LOGNAME': 'cltbld', 06:05:07 INFO - 'MAIL': '/var/mail/cltbld', 06:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:07 INFO - 'MOZ_NO_REMOTE': '1', 06:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:07 INFO - 'NO_EM_RESTART': '1', 06:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:07 INFO - 'PWD': '/builds/slave/test', 06:05:07 INFO - 'SHELL': '/bin/bash', 06:05:07 INFO - 'SHLVL': '1', 06:05:07 INFO - 'TERM': 'linux', 06:05:07 INFO - 'TMOUT': '86400', 06:05:07 INFO - 'USER': 'cltbld', 06:05:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:07 INFO - '_': '/tools/buildbot/bin/python'} 06:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:07 INFO - Downloading/unpacking blobuploader==1.2.4 06:05: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:05: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:05: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:05: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:05: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:05: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:05:09 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05:09 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:05:09 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:05:09 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:05:09 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:05:09 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:05:09 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:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05:09 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:05:09 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:05:09 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:05:09 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:05:09 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:05:09 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:05:10 INFO - Downloading docopt-0.6.1.tar.gz 06:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:10 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:10 INFO - Running setup.py install for blobuploader 06:05:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:10 INFO - Running setup.py install for requests 06:05:10 INFO - Running setup.py install for docopt 06:05:10 INFO - Successfully installed blobuploader requests docopt 06:05:10 INFO - Cleaning up... 06:05:10 INFO - Return code: 0 06:05:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:10 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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:10 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:05:10 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:05:10 INFO - Using env: {'DISPLAY': ':0', 06:05:10 INFO - 'HOME': '/home/cltbld', 06:05:10 INFO - 'LANG': 'en_US.UTF-8', 06:05:10 INFO - 'LANGUAGE': 'en_US:en', 06:05:10 INFO - 'LOGNAME': 'cltbld', 06:05:10 INFO - 'MAIL': '/var/mail/cltbld', 06:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:10 INFO - 'MOZ_NO_REMOTE': '1', 06:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:10 INFO - 'NO_EM_RESTART': '1', 06:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:10 INFO - 'PWD': '/builds/slave/test', 06:05:10 INFO - 'SHELL': '/bin/bash', 06:05:10 INFO - 'SHLVL': '1', 06:05:10 INFO - 'TERM': 'linux', 06:05:10 INFO - 'TMOUT': '86400', 06:05:10 INFO - 'USER': 'cltbld', 06:05:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:10 INFO - '_': '/tools/buildbot/bin/python'} 06:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:10 INFO - Running setup.py (path:/tmp/pip-wOOFdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:11 INFO - Running setup.py (path:/tmp/pip-UrdiYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:11 INFO - Running setup.py (path:/tmp/pip-7m6bTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:11 INFO - Running setup.py (path:/tmp/pip-Iq8BNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:11 INFO - Running setup.py (path:/tmp/pip-seFbKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:11 INFO - Running setup.py (path:/tmp/pip-qTge2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:11 INFO - Running setup.py (path:/tmp/pip-NY5LUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:11 INFO - Running setup.py (path:/tmp/pip-JcBHlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:11 INFO - Running setup.py (path:/tmp/pip-cGv8h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:11 INFO - Running setup.py (path:/tmp/pip-0VBtlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:11 INFO - Running setup.py (path:/tmp/pip-IcvjVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:11 INFO - Running setup.py (path:/tmp/pip-a_IDdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:11 INFO - Running setup.py (path:/tmp/pip-D9J3ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:11 INFO - Running setup.py (path:/tmp/pip-6kFGuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:11 INFO - Running setup.py (path:/tmp/pip-QVLKCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:12 INFO - Running setup.py (path:/tmp/pip-J7HY4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:12 INFO - Running setup.py (path:/tmp/pip-Ge9noV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:12 INFO - Running setup.py install for manifestparser 06:05:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Running setup.py install for mozcrash 06:05:12 INFO - Running setup.py install for mozdebug 06:05:12 INFO - Running setup.py install for mozdevice 06:05:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Running setup.py install for mozfile 06:05:12 INFO - Running setup.py install for mozhttpd 06:05:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Running setup.py install for mozinfo 06:05:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Running setup.py install for mozInstall 06:05:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:12 INFO - Running setup.py install for mozleak 06:05:13 INFO - Running setup.py install for mozlog 06:05:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Running setup.py install for moznetwork 06:05:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Running setup.py install for mozprocess 06:05:13 INFO - Running setup.py install for mozprofile 06:05:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Running setup.py install for mozrunner 06:05:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Running setup.py install for mozscreenshot 06:05:13 INFO - Running setup.py install for moztest 06:05:13 INFO - Running setup.py install for mozversion 06:05:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:13 INFO - Cleaning up... 06:05:13 INFO - Return code: 0 06:05:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:13 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:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:13 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:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:13 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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:13 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:05:13 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:05:13 INFO - Using env: {'DISPLAY': ':0', 06:05:13 INFO - 'HOME': '/home/cltbld', 06:05:13 INFO - 'LANG': 'en_US.UTF-8', 06:05:13 INFO - 'LANGUAGE': 'en_US:en', 06:05:13 INFO - 'LOGNAME': 'cltbld', 06:05:13 INFO - 'MAIL': '/var/mail/cltbld', 06:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:13 INFO - 'MOZ_NO_REMOTE': '1', 06:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:13 INFO - 'NO_EM_RESTART': '1', 06:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:13 INFO - 'PWD': '/builds/slave/test', 06:05:13 INFO - 'SHELL': '/bin/bash', 06:05:13 INFO - 'SHLVL': '1', 06:05:13 INFO - 'TERM': 'linux', 06:05:13 INFO - 'TMOUT': '86400', 06:05:13 INFO - 'USER': 'cltbld', 06:05:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:13 INFO - '_': '/tools/buildbot/bin/python'} 06:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:14 INFO - Running setup.py (path:/tmp/pip-kb0WSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:14 INFO - Running setup.py (path:/tmp/pip-2OacVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:14 INFO - Running setup.py (path:/tmp/pip-rDVc8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:14 INFO - Running setup.py (path:/tmp/pip-7cX7LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:14 INFO - Running setup.py (path:/tmp/pip-KAqotV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:14 INFO - Running setup.py (path:/tmp/pip-oOKOjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:14 INFO - Running setup.py (path:/tmp/pip-xd0Gtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:14 INFO - Running setup.py (path:/tmp/pip-zdkK3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:14 INFO - Running setup.py (path:/tmp/pip-UBfwIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:14 INFO - Running setup.py (path:/tmp/pip-9J00Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:14 INFO - Running setup.py (path:/tmp/pip-XsVBh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:14 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:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:14 INFO - Running setup.py (path:/tmp/pip-DkZ8a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:15 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:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:15 INFO - Running setup.py (path:/tmp/pip-6EfEl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:15 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:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:15 INFO - Running setup.py (path:/tmp/pip-1MEjZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:15 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:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:15 INFO - Running setup.py (path:/tmp/pip-pnh7tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:15 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:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:15 INFO - Running setup.py (path:/tmp/pip-5mRebZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:15 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:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:15 INFO - Running setup.py (path:/tmp/pip-dTHFHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:15 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:05:15 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:05:15 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:05:15 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:05:15 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:05:15 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:05:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:15 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:05:15 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:05:15 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:05:15 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:05:15 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:05:15 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:05:17 INFO - Downloading blessings-1.6.tar.gz 06:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:05:17 INFO - Installing collected packages: blessings 06:05:17 INFO - Running setup.py install for blessings 06:05:17 INFO - Successfully installed blessings 06:05:17 INFO - Cleaning up... 06:05:17 INFO - Return code: 0 06:05:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:17 INFO - Reading from file tmpfile_stdout 06:05:17 INFO - Current package versions: 06:05:17 INFO - argparse == 1.2.1 06:05:17 INFO - blessings == 1.6 06:05:17 INFO - blobuploader == 1.2.4 06:05:17 INFO - docopt == 0.6.1 06:05:17 INFO - manifestparser == 1.1 06:05:17 INFO - mozInstall == 1.12 06:05:17 INFO - mozcrash == 0.17 06:05:17 INFO - mozdebug == 0.1 06:05:17 INFO - mozdevice == 0.48 06:05:17 INFO - mozfile == 1.2 06:05:17 INFO - mozhttpd == 0.7 06:05:17 INFO - mozinfo == 0.9 06:05:17 INFO - mozleak == 0.1 06:05:17 INFO - mozlog == 3.1 06:05:17 INFO - moznetwork == 0.27 06:05:17 INFO - mozprocess == 0.22 06:05:17 INFO - mozprofile == 0.28 06:05:17 INFO - mozrunner == 6.11 06:05:17 INFO - mozscreenshot == 0.1 06:05:17 INFO - mozsystemmonitor == 0.0 06:05:17 INFO - moztest == 0.7 06:05:17 INFO - mozversion == 1.4 06:05:17 INFO - psutil == 3.1.1 06:05:17 INFO - requests == 1.2.3 06:05:17 INFO - wsgiref == 0.1.2 06:05:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:17 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:05:17 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:05:17 INFO - Using env: {'DISPLAY': ':0', 06:05:17 INFO - 'HOME': '/home/cltbld', 06:05:17 INFO - 'LANG': 'en_US.UTF-8', 06:05:17 INFO - 'LANGUAGE': 'en_US:en', 06:05:17 INFO - 'LOGNAME': 'cltbld', 06:05:17 INFO - 'MAIL': '/var/mail/cltbld', 06:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:17 INFO - 'MOZ_NO_REMOTE': '1', 06:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:17 INFO - 'NO_EM_RESTART': '1', 06:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:17 INFO - 'PWD': '/builds/slave/test', 06:05:17 INFO - 'SHELL': '/bin/bash', 06:05:17 INFO - 'SHLVL': '1', 06:05:17 INFO - 'TERM': 'linux', 06:05:17 INFO - 'TMOUT': '86400', 06:05:17 INFO - 'USER': 'cltbld', 06:05:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:17 INFO - '_': '/tools/buildbot/bin/python'} 06:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 INFO - Cleaning up... 06:05:17 INFO - Return code: 0 06:05:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:17 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:05:17 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:05:17 INFO - Using env: {'DISPLAY': ':0', 06:05:17 INFO - 'HOME': '/home/cltbld', 06:05:17 INFO - 'LANG': 'en_US.UTF-8', 06:05:17 INFO - 'LANGUAGE': 'en_US:en', 06:05:17 INFO - 'LOGNAME': 'cltbld', 06:05:17 INFO - 'MAIL': '/var/mail/cltbld', 06:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:17 INFO - 'MOZ_NO_REMOTE': '1', 06:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:17 INFO - 'NO_EM_RESTART': '1', 06:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:17 INFO - 'PWD': '/builds/slave/test', 06:05:17 INFO - 'SHELL': '/bin/bash', 06:05:17 INFO - 'SHLVL': '1', 06:05:17 INFO - 'TERM': 'linux', 06:05:17 INFO - 'TMOUT': '86400', 06:05:17 INFO - 'USER': 'cltbld', 06:05:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:17 INFO - '_': '/tools/buildbot/bin/python'} 06:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:18 INFO - Downloading/unpacking jsonschema 06:05:18 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:05:18 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:05:18 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:05:18 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:05:18 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:05:18 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:05:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:20 INFO - Downloading/unpacking functools32 (from jsonschema) 06:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:20 INFO - warning: no files found matching '*.txt' 06:05:20 INFO - no previously-included directories found matching 'build' 06:05:20 INFO - no previously-included directories found matching 'dist' 06:05:20 INFO - no previously-included directories found matching '.git*' 06:05:20 INFO - Installing collected packages: jsonschema, functools32 06:05:20 INFO - Running setup.py install for functools32 06:05:20 INFO - warning: no files found matching '*.txt' 06:05:20 INFO - no previously-included directories found matching 'build' 06:05:20 INFO - no previously-included directories found matching 'dist' 06:05:20 INFO - no previously-included directories found matching '.git*' 06:05:20 INFO - Successfully installed jsonschema functools32 06:05:20 INFO - Cleaning up... 06:05:20 INFO - Return code: 0 06:05:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:20 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 0x7fb776b6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', '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:05:20 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:05:20 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:05:20 INFO - Using env: {'DISPLAY': ':0', 06:05:20 INFO - 'HOME': '/home/cltbld', 06:05:20 INFO - 'LANG': 'en_US.UTF-8', 06:05:20 INFO - 'LANGUAGE': 'en_US:en', 06:05:20 INFO - 'LOGNAME': 'cltbld', 06:05:20 INFO - 'MAIL': '/var/mail/cltbld', 06:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:20 INFO - 'MOZ_NO_REMOTE': '1', 06:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:20 INFO - 'NO_EM_RESTART': '1', 06:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:20 INFO - 'PWD': '/builds/slave/test', 06:05:20 INFO - 'SHELL': '/bin/bash', 06:05:20 INFO - 'SHLVL': '1', 06:05:20 INFO - 'TERM': 'linux', 06:05:20 INFO - 'TMOUT': '86400', 06:05:20 INFO - 'USER': 'cltbld', 06:05:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:20 INFO - '_': '/tools/buildbot/bin/python'} 06:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:20 INFO - Downloading/unpacking flake8 06:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:05:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:05:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:23 INFO - no previously-included directories found matching 'docs/_build' 06:05:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:05:23 INFO - Running setup.py install for pep8 06:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:23 INFO - no previously-included directories found matching 'docs/_build' 06:05:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:05:23 INFO - Cleaning up... 06:05:23 INFO - Return code: 0 06:05:23 INFO - Running post-action listener: _resource_record_post_action 06:05:23 INFO - Running post-action listener: _start_resource_monitoring 06:05:23 INFO - Starting resource monitoring. 06:05:23 INFO - ##### 06:05:23 INFO - ##### Running install step. 06:05:23 INFO - ##### 06:05:23 INFO - Running pre-action listener: _resource_record_pre_action 06:05:23 INFO - Running main action method: install 06:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:23 INFO - Reading from file tmpfile_stdout 06:05:23 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:23 INFO - Reading from file tmpfile_stdout 06:05:23 INFO - Output received: 06:05:23 INFO - Usage: mozinstall [options] installer 06:05:23 INFO - Options: 06:05:23 INFO - -h, --help show this help message and exit 06:05:23 INFO - -d DEST, --destination=DEST 06:05:23 INFO - Directory to install application into. [default: 06:05:23 INFO - "/builds/slave/test"] 06:05:23 INFO - --app=APP Application being installed. [default: firefox] 06:05:23 INFO - mkdir: /builds/slave/test/build/application 06:05:23 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:05:23 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:05:37 INFO - Reading from file tmpfile_stdout 06:05:37 INFO - Output received: 06:05:37 INFO - /builds/slave/test/build/application/firefox/firefox 06:05:37 INFO - Running post-action listener: _resource_record_post_action 06:05:37 INFO - ##### 06:05:37 INFO - ##### Running run-tests step. 06:05:37 INFO - ##### 06:05:37 INFO - Running pre-action listener: _resource_record_pre_action 06:05:37 INFO - Running main action method: run_tests 06:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:37 INFO - Python 2.7.3 06:05:37 INFO - Return code: 0 06:05:37 INFO - grabbing minidump binary from tooltool 06:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:37 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 0x135c640>, '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 0x135d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135d9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:37 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:05:37 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:05:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:37 INFO - Return code: 0 06:05:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:05:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:05:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:05:38 INFO - Return code: 0 06:05:38 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-031', '--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:05:38 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-031 --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:05:38 INFO - Using env: {'DISPLAY': ':0', 06:05:38 INFO - 'HOME': '/home/cltbld', 06:05:38 INFO - 'LANG': 'en_US.UTF-8', 06:05:38 INFO - 'LANGUAGE': 'en_US:en', 06:05:38 INFO - 'LOGNAME': 'cltbld', 06:05:38 INFO - 'MAIL': '/var/mail/cltbld', 06:05:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:38 INFO - 'MOZ_NO_REMOTE': '1', 06:05:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:38 INFO - 'NO_EM_RESTART': '1', 06:05:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:38 INFO - 'PWD': '/builds/slave/test', 06:05:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:38 INFO - 'SHELL': '/bin/bash', 06:05:38 INFO - 'SHLVL': '1', 06:05:38 INFO - 'TERM': 'linux', 06:05:38 INFO - 'TMOUT': '86400', 06:05:38 INFO - 'USER': 'cltbld', 06:05:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071', 06:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:38 INFO - '_': '/tools/buildbot/bin/python'} 06:05:38 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-031', '--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:05:38 INFO - mozversion application_buildid: 20160624143557 06:05:38 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:05:38 INFO - mozversion application_display_name: Firefox 06:05:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:38 INFO - mozversion application_name: Firefox 06:05:38 INFO - mozversion application_remotingname: firefox 06:05:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:05:38 INFO - mozversion application_vendor: Mozilla 06:05:38 INFO - mozversion application_version: 48.0 06:05:38 INFO - mozversion platform_buildid: 20160624143557 06:05:38 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:05:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:05:38 INFO - mozversion platform_version: 48.0 06:05:38 INFO - using testdate: 1467032738 06:05:38 INFO - actual date: 1467032738 06:05:38 INFO - starting webserver on 'localhost:56118' 06:05:38 INFO - SUITE-START | Running 2 tests 06:05:38 INFO - TEST-START | dromaeo_css 06:05:38 INFO - operating with platform_type : linux_ 06:05:38 INFO - Initialising browser for dromaeo_css test... 06:05:38 INFO - TEST-INFO | started process 28131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuLy4_g/profile http://localhost:56118/getInfo.html) 06:05:42 INFO - PROCESS | 28131 | __metrics Screen width/height:1600/1200 06:05:42 INFO - PROCESS | 28131 | colorDepth:24 06:05:42 INFO - PROCESS | 28131 | Browser inner width/height: 1024/697 06:05:42 INFO - PROCESS | 28131 | __metrics 06:05:43 ERROR - PROCESS | 28131 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:05:43 INFO - TEST-INFO | 28131: exit 0 06:05:43 INFO - Browser initialized. 06:05:43 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:43 INFO - TEST-INFO | started process 28222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuLy4_g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:55 INFO - PROCESS | 28222 | RSS: Main: 138948608 06:05:55 INFO - PROCESS | 28222 | 06:06:46 INFO - PROCESS | 28222 | 1467032806562 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:08:53 INFO - PROCESS | 28222 | Cycle 1(1): loaded http://localhost:56118/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56118/tests/dromaeo/cssquery-ext.html) 06:08:54 INFO - PROCESS | 28222 | RSS: Main: 246472704 06:08:54 INFO - PROCESS | 28222 | 06:11:57 INFO - PROCESS | 28222 | Cycle 1(1): loaded http://localhost:56118/tests/dromaeo/cssquery-ext.html (next: http://localhost:56118/tests/dromaeo/cssquery-jquery.html) 06:11:57 INFO - PROCESS | 28222 | RSS: Main: 226476032 06:11:57 INFO - PROCESS | 28222 | 06:14:59 INFO - PROCESS | 28222 | Cycle 1(1): loaded http://localhost:56118/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56118/tests/dromaeo/cssquery-mootools.html) 06:15:00 INFO - PROCESS | 28222 | RSS: Main: 216629248 06:15:00 INFO - PROCESS | 28222 | 06:18:01 INFO - PROCESS | 28222 | Cycle 1(1): loaded http://localhost:56118/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56118/tests/dromaeo/cssquery-prototype.html) 06:18:02 INFO - PROCESS | 28222 | RSS: Main: 218431488 06:18:02 INFO - PROCESS | 28222 | 06:21:04 INFO - PROCESS | 28222 | Cycle 1(1): loaded http://localhost:56118/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56118/tests/dromaeo/cssquery-yui.html) 06:21:05 INFO - PROCESS | 28222 | RSS: Main: 212779008 06:21:05 INFO - PROCESS | 28222 | 06:24:07 INFO - PROCESS | 28222 | Cycle 1(1): loaded http://localhost:56118/tests/dromaeo/cssquery-yui.html (next: http://localhost:56118/tests/dromaeo/cssquery-dojo.html) 06:24:08 INFO - PROCESS | 28222 | RSS: Main: 255172608 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | __start_tp_report 06:24:08 INFO - PROCESS | 28222 | _x_x_mozilla_page_load 06:24:08 INFO - PROCESS | 28222 | _x_x_mozilla_page_load_details 06:24:08 INFO - PROCESS | 28222 | |i|pagename|runs| 06:24:08 INFO - PROCESS | 28222 | |0;dojo.html;3220.6779322067787;3328.9167770805725;3333.2333563280445;3372.460406334987;3385.4583266677323;5459.481349271818;5513.50378465938;5513.751881165347;5525.668459892404;5526.640768350055;5452.345718513784;5505.779768809253;5508.807191748289;5532.2531458253125;5552.472515111068;4889.633277504184;4982.526659967298;5085.745712714368;5132.794688212467;5164.974175129138;4830.637702172334;4894.583960363356;4927.063857866994;4929.728864912428;4937.407511098673;4942.752862356868;4983.426905905831;5022.899542009158;5054.039732450822;5071.264666623338;5033.471485494026;5036.496350364971;5050.898982020339;5060.620453465968;5082.923756143661;4837.806487740486;4939.234418665113;4954.87612809679;4965.428975667808;5017.49825017499;5232.502912223333;5263.44733802949;5263.947360526384;5273.314469119028;5296.496832800878;5707.62900411476;5755.539556835443;5760.711964401805;5764.654120752768;5774.740136693859;5764.538836893039;5794.217780599607;5822.9417705822825;5846.649201047951;5856.7071646417935;5331.920021199685;5361.5978801589645;5365.812196573102;5369.301990741218;5373.731313434313;5731.885362292731;5837.445442682938;5841.153032810219;5856.180134781049;5861.443162899518;5610.5231055360755;5684.261046063985;5691.345495268097;5721.456461636138;5737.3975732548315;5793.710314484259;5809.970950145223;5812.622179558315;5819.6508209507565;5822.446867547576;5638.126090455986;5733.111367738007;5763.711814409263;5779.2775903012125;5784;5768.192453056576;5781.508571771446;5786.189933409326;5796.101604251347;5819.88360232793;4452.888677783081;4456.197884380777;4458.308962110878;4458.866234012985;4481.5070342262325;3960.7821569813937;3975.34406822871;3985.362342025262;4011.13760541485;4039.091204478969;5569.192467092249;5594.832155035356;5604;5609.326880774252;5629.521490673257;5836.9124463133085;5853.443922827325;5853.473187413153;5854.473097421167;5862.091375836752;5431.755570999315;5517.393086760453;5562.694051827189;5565.526930210896;5590.189422533791;4853.563179313879;4854.902901942012;4859.2954021667365;4885;4887.3890763654545;5871.6770577618645;5887.322957859901;5922.585419020714;5925.34821169671;5942.7920022799;5635.8591035224445;5708.058170401837;5821.534277257894;5894.469497745224;5896.027155519463;5978.760849565969;5981.3719559445635;5981.371955944737;5983.371745966785;5990.730417131327;5617.887642247214;5626.43735626434;5627.971860140673;5631.380548139619;5638.323401191719;5605.635633683797;5751.654900705971;5815.0405183146;5820.563457740602;5824.271966004249;5617.719114044363;5618.803341883178;5618.915716264341;5624.268845050117;5639;5496.367917689517;5608.46719561641;5610.438956104357;5613.438656134354;5628.690422026828;5526.917096243479;5593.440655934374;5616.522595579421;5627.943720562742;5630;5652.349979752381;5675.687837168995;5701.116326969326;5705.172749951317;5718.113692377522;5519.834404967857;5534.446555344433;5568.610197286151;5580;5582.27430434041 06:24:08 INFO - PROCESS | 28222 | |1;ext.html;671.9260881303059;672.6838385958599;682.259748173232;694.7360003198784;742.8031571633518;32739.836300818493;33221.66778332216;38782.80608596957;39429.8028509857;39485.80257098718;42887;43233;43360.783196084056;43455.78272108635;43622;8188.508689478621;8723.869141962876;8991.3256505762;8995.640174393016;9019.954900225523;8173.386995975296;10726.731831704192;10991.450427478634;10997.835032474519;11001.064909482704;10708.143348532138;10789.784204315909;10793.460326983619;10797.5680972761;10798.67603971878;10609.045185933264;10732.302400343953;10744.516496757664;10753.139748820115;10759.946200269027;10429.895701042968;10517.579296828118;10543.36739795607;10546.36721796687;10900.672979810619;43284.134317313474;43737;43790.12419751587;43824;43824;3968.1666849961543;4086.7139300248996;4127.463429754142;4227.852025179104;4695.248760198352;29765.065270757546;29774.851125744233;30011.549826752616;31020.689793102232;31103.688963110304;4312.417823593806;4330.696851220416;4341.674374421931;4384.539623339535;4468.955310446887;298010;298579;299402.50298748584;299600;299640;62853.68573157105;62916;63222;63222.36777632165;63233.36766632367;67652;69354.3064569358;70047.64976175189;70669.64665176744;70860;17785.110744462727;17929;17952.730709039115;17965.550861228312;17966.371177008743;13707.109037912503;13753.449862005607;14087.506937257147;14426.278686065654;14956.551303460914;19843.40469785909;20364.592708145756;20541.178352866016;20567.38297851067;20612.69080963787;7507.662155203029;7591.278828511283;7714.5756983366455;7718.3053525183;7747.225277472207;1084.7450849050467;1217.3304682424632;1226.687194765347;1248.4132457744845;1251.9170917156594;32409;32924.835375822964;32993.3401331972;33517.16207094793;34012.82993585016;1257.867923867999;1271.713864380507;1308.5485507499898;1347.1243691600341;1361.0608680010762;17705.557361066076;17908.641827163385;17996.190171442315;17999.73000404995;18038.90980545089;467060;471172;473216;474636;475631;61973.690131549054;62993.370066298754;63045.68477157585;63104.36895630985;63278;1359.8368195816565;1536.7464368379092;1572.4182052640597;1574.087029522874;1625.7236269834157;30375;31687.366252674357;31819;32007;32197.839010805732;44840;45189.32216016828;45261.54738452574;45278.773606131756;45283.773581131885;296018;296395;300498;300515;301016;27917.58123628188;30469;30774.538381924736;30827.383452330378;31197.688023119477;49168.75415622899;49291.753541232065;50148.24777628265;50300;50853.49146508487;37677;40264;40756;40771.38842917418;41202.58797411987;39378.80310598428;39763.204735905696;40595.59404405918;40947.590524094376;41554;43227.567724322354;43869.78065109654;43905.56094439015;43914.12171756483;44291.55708442874;34191.82904085464;36657.816710916275;36939.63060369469;37222.25555488929;37336.25327493489;28261.17193554133;28305.50068833387;28560.285992849513;28665.42669146647;28768 06:24:08 INFO - PROCESS | 28222 | |2;jquery.html;410.0568692008381;412.57092623671383;428.38098947021547;431.69781153192736;438.17404193096024;18578.071096445175;18601.255949761995;18996.715049274255;19137.712934305997;19483.610327793434;18042.097895105257;18451.815481845177;18710.15804288807;18774.155163017662;18802.05989700513;5720.914186287209;5759.568032397577;5948.40515948406;5961.254843144607;5964.671943043131;5839.9124013139835;5890.734916928748;5913.14259432382;5932.199153114339;5934.287885453751;5644.294463192101;5758.539316854642;5879.088741245114;5886.146508756227;5887.381824908387;5744.4829965303325;5747.2241247431475;5766.106253530709;5782.681952492611;5786.363500014974;5093.414257360414;5123.7438128093445;5146;5165.380154381498;5307.044731948247;11502.367369794658;12115.091368147425;21956.780432195632;22602.54794904109;22761.20335788256;2410.349205714465;2413.855168689884;2566.0762125634756;2951.4834903891733;3049.374878149996;9315.30135239853;9398.38910470824;9408.529573521297;13125.818676319082;13509.864901350958;1960.4412742368356;2021.7674967378646;2038.2458490358515;2061.2785525066256;2077.1483691686485;54947.72526137384;77134;78670;81118.59440702818;82567;10704.19718521114;10952.39761813092;10984.725381865517;11029.669109926715;11261.71845703864;15466.690666186612;15614.687706246039;15624.531264062096;15632.3747050119;15665.216739162996;7455.403567714569;7517.624118794039;7971.322437592754;8097.676092956333;8098.5545794981845;8328.625211865481;8341.082480927093;8415.873761893576;8437.620307086196;8473.067962524117;4121.5466298707115;4271.850485233002;4776;4783.162946484351;4807.351007613997;1919.4529559075597;1963;1988.9701654475195;2048.8014511510933;2054.6301665700316;1063.3035361838008;1064.7178497698117;1106.590561492237;1161.6050542815483;1197.6227488341144;18166;18603.34888278931;18865.622687546173;18890.24439022451;19169.61660766777;1083.4203701019917;1094.2996482251365;1100.5817789240198;1153.3829401270448;1160.3386069940052;10537.63118290856;10637.680869573926;10651.414172220602;10670.413127278074;10726.946365268279;571694;621763;630430;641400;647921;88759;90088;95734.52132739291;104592;105093.47453262837;1088.8257878739364;1131.5643477261149;1142.2118738070706;1144.3134119528218;1160.2632328471482;16285.430009950069;16453;16597.336106556086;16657.583560411087;16818;35847.64152358443;36312.818435907655;41237.79381103075;41736.79131604323;42026.789866051695;58318.4168158313;60139.39860601338;60605;60706.69646651739;61138.69430652818;8155.510669359857;8733.956330218309;8861.73870946794;8966.372353935161;9053;11727.706807329885;12809.42357593892;12986.675333116747;13213.933930330288;13216.801747973981;11359.432028398713;11405.486753096297;11638.592649257236;11696.298222106701;11811.409429528661;11436.313821170756;11478.655640330804;11824.52701891949;11916.927476526807;11991.580294689993;12193.146479746687;12309.56916507918;12385.133040687066;12478.688032799253;12601.43293551774;8213.219744124299;8648.221660050625;8797.736067917973;8872.64509419616;8903.554822258731;10934.835977460185;11773.705657358634;11909.940450297692;12094.516219351479;12238.632841014783 06:24:08 INFO - PROCESS | 28222 | |3;mootools.html;1388.6875453023065;1569.2938177819983;1586.3813112885973;1812;1927.4699457649135;8140.918590814097;8445.577721113943;8469.44948578342;8470.830583388328;8474.279686226679;8162.14297498763;8340.207680270365;8356.791080222998;8361.247487726103;8375.581220938959;2343.039353864916;2362.8464149830293;2366.881655917206;2367.1241640593003;2367.538330025646;2352.1414683640432;2429.2712186344115;2504.3113143885485;2506.624006399046;2516.1570873757223;2414.4808866093786;2430.6718592989987;2445.364205306624;2470.6047032474808;2472.8392654477493;2421.6609674645565;2458.864762438065;2469.6789417375808;2471.6910386201725;2474.183519438581;2355.564220619191;2378.6432035194684;2380.33350661815;2380.8571485710913;2382.094803974496;7096.112985876765;8077.192280771935;8573.914260857375;8631.395802293842;8635.827283454295;5173.689578625294;5306.151015837486;5344.973275133639;5346.171343441734;5346.4386239445075;3412.5904891412943;3419.12812232879;3508.3509550732942;3527.1005893496995;3542.5394698689265;1111.9833202501968;1125.859267591551;1170.953161873524;1177.823326501023;1191.612725864089;11545.595904143314;11900.285982841056;11918.404079795975;11928;11945.820812687816;4623.982723800758;4628.791704373311;4641.141388843075;4685.976570117127;4781.187198176319;10264.692059238234;10348.379097254188;10351.896481035245;10354.430506322225;10363.274570779973;5422.972885135549;5427.755750991215;5438.102713052381;5441.183822426668;5442.047641662693;4919.926201106986;4966.90066198674;4968.701877887338;4975.676581022222;4976.104301225814;3940.5468371137686;4010.3583426651594;4015.738976966488;4052;4054.918901621951;1185.8221266810046;1211.3216598704578;1214.4110106598293;1214.4959841665786;1217.2270608163703;900.1583519409373;995.5171741705267;1004.2016596805557;1014.2089170447063;1022.3610243597751;5715.114157305624;5765.077587585966;5771.942280577225;5907.379725128885;6019.398060193946;996.4519514267124;1007.5919252702668;1051.731808388856;1085.148158695436;1085.9782804344027;3665.6151104134215;3939.153082087365;4091.754494730326;4103.74835675122;4117.773522456294;10299;10384.584616615251;10661.040506354466;10773.084287835622;10777.137828973664;10458.372497650165;10597.046265835957;10613.257072004886;10636.149108071335;10666.626668066736;7887.84224315522;8272.8345433091;8296.792580185424;8297.792555186048;8302.626381812834;5812.128180772749;5896.17453556511;5901.468867801918;5956.166136740946;6074.210352654127;9462.574184161867;9537;9641.662541811003;9643.855342169732;9655;9440.291978101532;9514.619415223313;9702.078302561245;9754.853677194706;9801.509924503604;7256.310650488406;7312.41500679955;7368.59472729005;7380.077490313711;7391.445641576795;8281.337493000425;8317.750467485985;8340.082590915115;8345.207205315486;8358.414910956175;7130.073090498202;7162.46281528877;7257.963710181415;7289.805654672041;7335.77992660221;7468.551886886804;7487.962560187164;7499.700011999459;7534.284242996907;7551.056117985252;7019.929800701928;7088.751893683696;7101.289871013064;7111.964440177766;7162;5006.4743201963265;5213.921791173211;5553.6390134641115;5602.775888964396;5649.152627105967;4488.775561221991;5098.337216161875;5355.089634762022;5448.591355648263;5504.504594586507 06:24:08 INFO - PROCESS | 28222 | |4;prototype.html;333.4797715563721;333.83975691667996;339.65016033485506;349.9545059142311;352.5804292891461;6114.633122012677;6123.969380153098;6155.16905217796;6166.105914642374;6324.241091069078;6178.443940045395;6259.499240060795;6310.211223597051;6321.7155228014735;6323.462505687022;4770.284457331402;4771.165046116933;4773.711098003537;4779.737114458703;4782.617390608761;4533;4630.259158534635;4697.906041879178;4740.597049250818;4773.689710168828;4716.292556116576;4719.126961512131;4721.976390118045;4726.7400292983875;4731.3849199604;4463.933041004388;4706.2705280681375;4726.834560790356;4729.858104256878;4731.266653668687;3941.783201923893;3972.443857859902;3973.8609148679657;3988.4017397390335;3993.6805055595482;5892.793752218695;5910.1430292607765;5985.670788106652;5993.520518358564;6004.96997515014;5379.058664733656;5383.838484845461;5394.460553944574;5394.973025134888;5395.541378982752;6548.476121910284;6556.18047744032;6562;6568.408843204087;6568.86862262752;4436.290193569013;4441.511433742286;4441.64466842655;4443.244648409745;4444.088961762831;6701.3968742812895;6895.965520172417;6905.413039891615;6913.688884000232;6919.654017299165;4484.372187893698;4515.164694531457;4516.593506584423;4521.84173553924;4522.005158865044;4579.38178345919;4581.312803079498;4583.312503124492;4583.839565615254;4584.977075114603;5368.00691872005;5368.382635996911;5369.4630536946;5380.677159370451;5387.838364849061;6639.900401493981;6645.568038077509;6649.767258146038;6652.800415987528;6654.367835055662;1570.5680937742213;1604.2219523531078;1604.366275321265;1604.791377120967;1605.405999780089;1016.3241444439512;1068.9417971089072;1079.4386918802336;1083.3337497439177;1086.5979587552656;6206.472449841724;6324.557280990287;6390;6405.519586031066;6427.807165785034;6784.321567843176;6787.592744435349;6924.376806087476;6951.617661028591;6951.965240173767;6497.155369801895;6501.0573466847045;6504.089427480157;6506.41442270198;6512.772052978123;3665.52348194733;3705.7035437164964;3706.4440333950124;3706.5737440194184;3712.5173727415263;7027.754028608974;7238.167610724729;7266.890996635055;7271;7300.306470885257;7061.858762824715;7078.256783037707;7078.433725301964;7079.433645308363;7079.610621415769;7259.41924646027;7265.12818461788;7267.273272672796;7276.163241227221;7279.1265048194555;6876.518643694893;6878.3465570770695;6884.586924784328;6891.862162756616;6897.62063086515;6556.147700799056;6737.258901520927;6821.3519715626935;6897.620630865351;6903.0680858083515;7219.711211551479;7231.819204519929;7257.891131633135;7262.9273707262255;7298.160711518243;4574.81700731967;4610.700304480198;4614.10025045113;4616.16908956391;4619.769011549476;6854.828629284308;6888;6894.413974811997;6896.655167241718;6897.3447522485285;6501.382368674968;6600.735970561123;6630.370114839083;6650.667466626746;6661.134052573135;6669.6331701754925;6688.4983626229205;6698.966505167443;6699.330066993261;6704.932950670431;6552.213734351908;6558.672066396756;6564;6564.4420224281475;6582.3746744059235;6747.987801829765;6748.763793267212;6749.628770417674;6752.932470675427;6762.019507171531;6432.453241474527;6532.510061745293;6566.310537393696;6568.80293591193;6582 06:24:08 INFO - PROCESS | 28222 | |5;yui.html;864.3603733237406;865.1219012702112;893.5844832153051;924.4040681747999;938.2400255792807;15191.848081519182;15221.162836044014;15325.540233793005;15348.53954381369;15404.152771597557;15612.2974466149;16073.517794466185;16076.196190190502;16090.59773505663;16118.11350375729;767.2557619109483;910.2672348759246;922.478799478296;925.0379605210572;925.1257561604286;765.2959277464718;770.4914756260869;771.3212373111681;900.131373224838;917.7797328641145;954.5131982688844;956.995215023924;957.4398976598698;957.8228027814877;959.0505399654362;948.5968463403061;949.0130264524886;949.2453499467871;950.1875896108832;950.9286803489731;589.7405141737622;701.859628074382;705.1502938958594;705.8094314535098;706.2125729811223;14917;14919.179445130514;14934.402623895032;14944.178070206135;14995.175265360402;14133.575992720132;14751.557453276419;14850.777238341325;14856.405743770236;14888.851111488855;11987.460564274628;12045.217060891102;12046.939765301116;12096;12372.319522426264;4008.979955100235;4041.7979101045125;4066.4713587233764;4126.690498212646;4133.379993001044;55906.16140757892;55964.72017639967;56477.43522564763;56480;56716.716416418065;11025.944870275598;11448.828267575993;11578.942105289589;11665.183437159487;11710.473028713728;20579;20839.8958005209;20842.68735968962;20847.895760521405;20899.164033438796;8777.122287771299;8868.911310886937;9009.099090090938;9079.909200908038;9162.770930726785;4968.950310496921;5104.387473503203;5114.43741188469;5199.090159222121;5221.190715439113;3665.541807274091;3718.1448266898224;3718.6839118675216;3721.1999420124803;3722.739408241451;623.1551328304365;679.2765704524666;683.9794806155824;688.3013741052836;694.1843334082433;726.0742553244655;752.1989081628158;775.2286474957453;817.8936738223993;854.6752234150982;9794.412335259907;9942.453165075991;9986.700398988041;10027.097561219525;10167.034131757471;655.9770408035696;702.8699690557263;762.6987340000669;777.2188950105221;790.4940837863771;4492.663050271242;4615.769211539477;4663.580277775017;4671.883202919954;4682.274247491644;64754;65342.67328663326;65460.345396545425;65594.34405655978;65617;50924.236136457985;52908.73545632247;53443.19835202475;53843.19235211475;53950;48531.5146848527;48928.510714893106;50022.49977500179;50581;50722.23916641253;8851.60167792438;8978.461292322481;9050.909490905007;9132.497712625604;9323.393979391318;37979.43030854595;38242.80878595701;38288;39163.804180978914;39748;45952.77023614994;51233;51469.227961579854;51692.74153629208;51814.222786657476;11852.881471185177;11919.106067044833;11926.522939082339;12131.272123672608;12135.878641213829;12392.261163405892;13067.869321306665;13376.933115334361;13465.932670336586;13516.797248041485;12596.307203103917;12616.55842045524;12888.42002109926;13168.209907405586;13245.602631921058;11999.340036298088;12053;12116.970057545208;12781.297028663514;12793.29636869981;12370.505179792708;12447.875521244672;12673.556425525063;12687.746245074863;13024.869751302745;10147.84778228342;10156.949215253877;10374.792504149724;10695.144388448749;10726.195535335037;10087.39475631435;10139.340942838691;10302.845457317997;10309.432981186106;10345.793084138426 06:24:08 INFO - PROCESS | 28222 | __end_tp_report 06:24:08 INFO - PROCESS | 28222 | __start_cc_report 06:24:08 INFO - PROCESS | 28222 | _x_x_mozilla_cycle_collect,821 06:24:08 INFO - PROCESS | 28222 | __end_cc_report 06:24:08 INFO - PROCESS | 28222 | __startTimestamp1467033848121__endTimestamp 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | ------- Summary: start ------- 06:24:08 INFO - PROCESS | 28222 | Number of tests: 6 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | [#0] dojo.html Cycles:165 Average:5388.28 Median:5608.47 stddev:574.16 (10.2%) stddev-sans-first:550.17 06:24:08 INFO - PROCESS | 28222 | Values: 3220.7 3328.9 3333.2 3372.5 3385.5 5459.5 5513.5 5513.8 5525.7 5526.6 5452.3 5505.8 5508.8 5532.3 5552.5 4889.6 4982.5 5085.7 5132.8 5165.0 4830.6 4894.6 4927.1 4929.7 4937.4 4942.8 4983.4 5022.9 5054.0 5071.3 5033.5 5036.5 5050.9 5060.6 5082.9 4837.8 4939.2 4954.9 4965.4 5017.5 5232.5 5263.4 5263.9 5273.3 5296.5 5707.6 5755.5 5760.7 5764.7 5774.7 5764.5 5794.2 5822.9 5846.6 5856.7 5331.9 5361.6 5365.8 5369.3 5373.7 5731.9 5837.4 5841.2 5856.2 5861.4 5610.5 5684.3 5691.3 5721.5 5737.4 5793.7 5810.0 5812.6 5819.7 5822.4 5638.1 5733.1 5763.7 5779.3 5784.0 5768.2 5781.5 5786.2 5796.1 5819.9 4452.9 4456.2 4458.3 4458.9 4481.5 3960.8 3975.3 3985.4 4011.1 4039.1 5569.2 5594.8 5604.0 5609.3 5629.5 5836.9 5853.4 5853.5 5854.5 5862.1 5431.8 5517.4 5562.7 5565.5 5590.2 4853.6 4854.9 4859.3 4885.0 4887.4 5871.7 5887.3 5922.6 5925.3 5942.8 5635.9 5708.1 5821.5 5894.5 5896.0 5978.8 5981.4 5981.4 5983.4 5990.7 5617.9 5626.4 5628.0 5631.4 5638.3 5605.6 5751.7 5815.0 5820.6 5824.3 5617.7 5618.8 5618.9 5624.3 5639.0 5496.4 5608.5 5610.4 5613.4 5628.7 5526.9 5593.4 5616.5 5627.9 5630.0 5652.3 5675.7 5701.1 5705.2 5718.1 5519.8 5534.4 5568.6 5580.0 5582.3 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | [#1] ext.html Cycles:180 Average:53951.19 Median:34102.33 stddev:96404.37 (282.7%) stddev-sans-first:96591.81 06:24:08 INFO - PROCESS | 28222 | Values: 671.9 672.7 682.3 694.7 742.8 32739.8 33221.7 38782.8 39429.8 39485.8 42887.0 43233.0 43360.8 43455.8 43622.0 8188.5 8723.9 8991.3 8995.6 9020.0 8173.4 10726.7 10991.5 10997.8 11001.1 10708.1 10789.8 10793.5 10797.6 10798.7 10609.0 10732.3 10744.5 10753.1 10759.9 10429.9 10517.6 10543.4 10546.4 10900.7 43284.1 43737.0 43790.1 43824.0 43824.0 3968.2 4086.7 4127.5 4227.9 4695.2 29765.1 29774.9 30011.5 31020.7 31103.7 4312.4 4330.7 4341.7 4384.5 4469.0 298010.0 298579.0 299402.5 299600.0 299640.0 62853.7 62916.0 63222.0 63222.4 63233.4 67652.0 69354.3 70047.6 70669.6 70860.0 17785.1 17929.0 17952.7 17965.6 17966.4 13707.1 13753.4 14087.5 14426.3 14956.6 19843.4 20364.6 20541.2 20567.4 20612.7 7507.7 7591.3 7714.6 7718.3 7747.2 1084.7 1217.3 1226.7 1248.4 1251.9 32409.0 32924.8 32993.3 33517.2 34012.8 1257.9 1271.7 1308.5 1347.1 1361.1 17705.6 17908.6 17996.2 17999.7 18038.9 467060.0 471172.0 473216.0 474636.0 475631.0 61973.7 62993.4 63045.7 63104.4 63278.0 1359.8 1536.7 1572.4 1574.1 1625.7 30375.0 31687.4 31819.0 32007.0 32197.8 44840.0 45189.3 45261.5 45278.8 45283.8 296018.0 296395.0 300498.0 300515.0 301016.0 27917.6 30469.0 30774.5 30827.4 31197.7 49168.8 49291.8 50148.2 50300.0 50853.5 37677.0 40264.0 40756.0 40771.4 41202.6 39378.8 39763.2 40595.6 40947.6 41554.0 43227.6 43869.8 43905.6 43914.1 44291.6 34191.8 36657.8 36939.6 37222.3 37336.3 28261.2 28305.5 28560.3 28665.4 28768.0 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | [#2] jquery.html Cycles:180 Average:32519.67 Median:12016.96 stddev:102233.55 (850.7%) stddev-sans-first:102491.91 06:24:08 INFO - PROCESS | 28222 | Values: 410.1 412.6 428.4 431.7 438.2 18578.1 18601.3 18996.7 19137.7 19483.6 18042.1 18451.8 18710.2 18774.2 18802.1 5720.9 5759.6 5948.4 5961.3 5964.7 5839.9 5890.7 5913.1 5932.2 5934.3 5644.3 5758.5 5879.1 5886.1 5887.4 5744.5 5747.2 5766.1 5782.7 5786.4 5093.4 5123.7 5146.0 5165.4 5307.0 11502.4 12115.1 21956.8 22602.5 22761.2 2410.3 2413.9 2566.1 2951.5 3049.4 9315.3 9398.4 9408.5 13125.8 13509.9 1960.4 2021.8 2038.2 2061.3 2077.1 54947.7 77134.0 78670.0 81118.6 82567.0 10704.2 10952.4 10984.7 11029.7 11261.7 15466.7 15614.7 15624.5 15632.4 15665.2 7455.4 7517.6 7971.3 8097.7 8098.6 8328.6 8341.1 8415.9 8437.6 8473.1 4121.5 4271.9 4776.0 4783.2 4807.4 1919.5 1963.0 1989.0 2048.8 2054.6 1063.3 1064.7 1106.6 1161.6 1197.6 18166.0 18603.3 18865.6 18890.2 19169.6 1083.4 1094.3 1100.6 1153.4 1160.3 10537.6 10637.7 10651.4 10670.4 10726.9 571694.0 621763.0 630430.0 641400.0 647921.0 88759.0 90088.0 95734.5 104592.0 105093.5 1088.8 1131.6 1142.2 1144.3 1160.3 16285.4 16453.0 16597.3 16657.6 16818.0 35847.6 36312.8 41237.8 41736.8 42026.8 58318.4 60139.4 60605.0 60706.7 61138.7 8155.5 8734.0 8861.7 8966.4 9053.0 11727.7 12809.4 12986.7 13213.9 13216.8 11359.4 11405.5 11638.6 11696.3 11811.4 11436.3 11478.7 11824.5 11916.9 11991.6 12193.1 12309.6 12385.1 12478.7 12601.4 8213.2 8648.2 8797.7 8872.6 8903.6 10934.8 11773.7 11909.9 12094.5 12238.6 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | [#3] mootools.html Cycles:180 Average:5710.86 Median:4972.19 stddev:3127.69 (62.9%) stddev-sans-first:3119.59 06:24:08 INFO - PROCESS | 28222 | Values: 1388.7 1569.3 1586.4 1812.0 1927.5 8140.9 8445.6 8469.4 8470.8 8474.3 8162.1 8340.2 8356.8 8361.2 8375.6 2343.0 2362.8 2366.9 2367.1 2367.5 2352.1 2429.3 2504.3 2506.6 2516.2 2414.5 2430.7 2445.4 2470.6 2472.8 2421.7 2458.9 2469.7 2471.7 2474.2 2355.6 2378.6 2380.3 2380.9 2382.1 7096.1 8077.2 8573.9 8631.4 8635.8 5173.7 5306.2 5345.0 5346.2 5346.4 3412.6 3419.1 3508.4 3527.1 3542.5 1112.0 1125.9 1171.0 1177.8 1191.6 11545.6 11900.3 11918.4 11928.0 11945.8 4624.0 4628.8 4641.1 4686.0 4781.2 10264.7 10348.4 10351.9 10354.4 10363.3 5423.0 5427.8 5438.1 5441.2 5442.0 4919.9 4966.9 4968.7 4975.7 4976.1 3940.5 4010.4 4015.7 4052.0 4054.9 1185.8 1211.3 1214.4 1214.5 1217.2 900.2 995.5 1004.2 1014.2 1022.4 5715.1 5765.1 5771.9 5907.4 6019.4 996.5 1007.6 1051.7 1085.1 1086.0 3665.6 3939.2 4091.8 4103.7 4117.8 10299.0 10384.6 10661.0 10773.1 10777.1 10458.4 10597.0 10613.3 10636.1 10666.6 7887.8 8272.8 8296.8 8297.8 8302.6 5812.1 5896.2 5901.5 5956.2 6074.2 9462.6 9537.0 9641.7 9643.9 9655.0 9440.3 9514.6 9702.1 9754.9 9801.5 7256.3 7312.4 7368.6 7380.1 7391.4 8281.3 8317.8 8340.1 8345.2 8358.4 7130.1 7162.5 7258.0 7289.8 7335.8 7468.6 7488.0 7499.7 7534.3 7551.1 7019.9 7088.8 7101.3 7112.0 7162.0 5006.5 5213.9 5553.6 5602.8 5649.2 4488.8 5098.3 5355.1 5448.6 5504.5 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | [#4] prototype.html Cycles:180 Average:5532.96 Median:6324.40 stddev:1721.94 (27.2%) stddev-sans-first:1681.97 06:24:08 INFO - PROCESS | 28222 | Values: 333.5 333.8 339.7 350.0 352.6 6114.6 6124.0 6155.2 6166.1 6324.2 6178.4 6259.5 6310.2 6321.7 6323.5 4770.3 4771.2 4773.7 4779.7 4782.6 4533.0 4630.3 4697.9 4740.6 4773.7 4716.3 4719.1 4722.0 4726.7 4731.4 4463.9 4706.3 4726.8 4729.9 4731.3 3941.8 3972.4 3973.9 3988.4 3993.7 5892.8 5910.1 5985.7 5993.5 6005.0 5379.1 5383.8 5394.5 5395.0 5395.5 6548.5 6556.2 6562.0 6568.4 6568.9 4436.3 4441.5 4441.6 4443.2 4444.1 6701.4 6896.0 6905.4 6913.7 6919.7 4484.4 4515.2 4516.6 4521.8 4522.0 4579.4 4581.3 4583.3 4583.8 4585.0 5368.0 5368.4 5369.5 5380.7 5387.8 6639.9 6645.6 6649.8 6652.8 6654.4 1570.6 1604.2 1604.4 1604.8 1605.4 1016.3 1068.9 1079.4 1083.3 1086.6 6206.5 6324.6 6390.0 6405.5 6427.8 6784.3 6787.6 6924.4 6951.6 6952.0 6497.2 6501.1 6504.1 6506.4 6512.8 3665.5 3705.7 3706.4 3706.6 3712.5 7027.8 7238.2 7266.9 7271.0 7300.3 7061.9 7078.3 7078.4 7079.4 7079.6 7259.4 7265.1 7267.3 7276.2 7279.1 6876.5 6878.3 6884.6 6891.9 6897.6 6556.1 6737.3 6821.4 6897.6 6903.1 7219.7 7231.8 7257.9 7262.9 7298.2 4574.8 4610.7 4614.1 4616.2 4619.8 6854.8 6888.0 6894.4 6896.7 6897.3 6501.4 6600.7 6630.4 6650.7 6661.1 6669.6 6688.5 6699.0 6699.3 6704.9 6552.2 6558.7 6564.0 6564.4 6582.4 6748.0 6748.8 6749.6 6752.9 6762.0 6432.5 6532.5 6566.3 6568.8 6582.0 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - PROCESS | 28222 | [#5] yui.html Cycles:180 Average:15431.80 Median:4667.73 stddev:17687.35 (378.9%) stddev-sans-first:17703.14 06:24:08 INFO - PROCESS | 28222 | Values: 864.4 865.1 893.6 924.4 938.2 15191.8 15221.2 15325.5 15348.5 15404.2 15612.3 16073.5 16076.2 16090.6 16118.1 767.3 910.3 922.5 925.0 925.1 765.3 770.5 771.3 900.1 917.8 954.5 957.0 957.4 957.8 959.1 948.6 949.0 949.2 950.2 950.9 589.7 701.9 705.2 705.8 706.2 14917.0 14919.2 14934.4 14944.2 14995.2 14133.6 14751.6 14850.8 14856.4 14888.9 11987.5 12045.2 12046.9 12096.0 12372.3 4009.0 4041.8 4066.5 4126.7 4133.4 55906.2 55964.7 56477.4 56480.0 56716.7 11025.9 11448.8 11578.9 11665.2 11710.5 20579.0 20839.9 20842.7 20847.9 20899.2 8777.1 8868.9 9009.1 9079.9 9162.8 4969.0 5104.4 5114.4 5199.1 5221.2 3665.5 3718.1 3718.7 3721.2 3722.7 623.2 679.3 684.0 688.3 694.2 726.1 752.2 775.2 817.9 854.7 9794.4 9942.5 9986.7 10027.1 10167.0 656.0 702.9 762.7 777.2 790.5 4492.7 4615.8 4663.6 4671.9 4682.3 64754.0 65342.7 65460.3 65594.3 65617.0 50924.2 52908.7 53443.2 53843.2 53950.0 48531.5 48928.5 50022.5 50581.0 50722.2 8851.6 8978.5 9050.9 9132.5 9323.4 37979.4 38242.8 38288.0 39163.8 39748.0 45952.8 51233.0 51469.2 51692.7 51814.2 11852.9 11919.1 11926.5 12131.3 12135.9 12392.3 13067.9 13376.9 13465.9 13516.8 12596.3 12616.6 12888.4 13168.2 13245.6 11999.3 12053.0 12117.0 12781.3 12793.3 12370.5 12447.9 12673.6 12687.7 13024.9 10147.8 10156.9 10374.8 10695.1 10726.2 10087.4 10139.3 10302.8 10309.4 10345.8 06:24:08 INFO - PROCESS | 28222 | -------- Summary: end -------- 06:24:08 INFO - PROCESS | 28222 | 06:24:08 INFO - TEST-INFO | 28222: exit 0 06:24:08 INFO - TEST-OK | dromaeo_css | took 1110487ms 06:24:08 INFO - TEST-START | kraken 06:24:08 INFO - operating with platform_type : linux_ 06:24:08 INFO - Initialising browser for kraken test... 06:24:08 INFO - TEST-INFO | started process 28418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmping_Ud/profile http://localhost:56118/getInfo.html) 06:24:12 INFO - PROCESS | 28418 | __metrics Screen width/height:1600/1200 06:24:12 INFO - PROCESS | 28418 | colorDepth:24 06:24:12 INFO - PROCESS | 28418 | Browser inner width/height: 1024/697 06:24:12 INFO - PROCESS | 28418 | __metrics 06:24:13 ERROR - PROCESS | 28418 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:24:14 INFO - TEST-INFO | 28418: exit 0 06:24:14 INFO - Browser initialized. 06:24:14 INFO - Running cycle 1/1 for kraken test... 06:24:14 INFO - TEST-INFO | started process 28514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmping_Ud/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:26 INFO - PROCESS | 28514 | RSS: Main: 140107776 06:24:26 INFO - PROCESS | 28514 | 06:24:28 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56118/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:29 INFO - PROCESS | 28514 | RSS: Main: 198090752 06:24:29 INFO - PROCESS | 28514 | 06:24:31 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56118/tests/kraken/driver.html?testName=audio-dft) 06:24:32 INFO - PROCESS | 28514 | RSS: Main: 185749504 06:24:32 INFO - PROCESS | 28514 | 06:24:35 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56118/tests/kraken/driver.html?testName=audio-fft) 06:24:35 INFO - PROCESS | 28514 | RSS: Main: 274755584 06:24:35 INFO - PROCESS | 28514 | 06:24:38 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56118/tests/kraken/driver.html?testName=audio-oscillator) 06:24:38 INFO - PROCESS | 28514 | RSS: Main: 181370880 06:24:38 INFO - PROCESS | 28514 | 06:24:40 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56118/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:41 INFO - PROCESS | 28514 | RSS: Main: 179019776 06:24:41 INFO - PROCESS | 28514 | 06:24:44 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56118/tests/kraken/driver.html?testName=imaging-darkroom) 06:24:44 INFO - PROCESS | 28514 | RSS: Main: 213901312 06:24:44 INFO - PROCESS | 28514 | 06:24:48 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56118/tests/kraken/driver.html?testName=imaging-desaturate) 06:24:48 INFO - PROCESS | 28514 | RSS: Main: 213270528 06:24:48 INFO - PROCESS | 28514 | 06:24:51 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56118/tests/kraken/driver.html?testName=json-parse-financial) 06:24:52 INFO - PROCESS | 28514 | RSS: Main: 213422080 06:24:52 INFO - PROCESS | 28514 | 06:24:53 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56118/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:24:54 INFO - PROCESS | 28514 | RSS: Main: 193056768 06:24:54 INFO - PROCESS | 28514 | 06:24:56 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:24:56 INFO - PROCESS | 28514 | RSS: Main: 196591616 06:24:56 INFO - PROCESS | 28514 | 06:24:58 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:24:59 INFO - PROCESS | 28514 | RSS: Main: 209682432 06:24:59 INFO - PROCESS | 28514 | 06:25:01 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:02 INFO - PROCESS | 28514 | RSS: Main: 218341376 06:25:02 INFO - PROCESS | 28514 | 06:25:04 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:05 INFO - PROCESS | 28514 | RSS: Main: 215363584 06:25:05 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:56118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56118/tests/kraken/driver.html?testName=ai-astar) 06:25:07 INFO - PROCESS | 28514 | RSS: Main: 276205568 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | __start_tp_report 06:25:07 INFO - PROCESS | 28514 | _x_x_mozilla_page_load 06:25:07 INFO - PROCESS | 28514 | _x_x_mozilla_page_load_details 06:25:07 INFO - PROCESS | 28514 | |i|pagename|runs| 06:25:07 INFO - PROCESS | 28514 | |0;ai-astar;110;110;110;110;110;111;105;110;109;111 06:25:07 INFO - PROCESS | 28514 | |1;audio-beat-detection;153;127;157;178;133;151;164;127;172;126 06:25:07 INFO - PROCESS | 28514 | |2;audio-dft;162;161;164;161;161;160;161;160;160;159 06:25:07 INFO - PROCESS | 28514 | |3;audio-fft;75;76;77;170;76;73;76;77;161;76 06:25:07 INFO - PROCESS | 28514 | |4;audio-oscillator;92;92;151;92;92;92;157;93;98;147 06:25:07 INFO - PROCESS | 28514 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;116 06:25:07 INFO - PROCESS | 28514 | |6;imaging-darkroom;145;145;144;145;145;144;145;145;145;145 06:25:07 INFO - PROCESS | 28514 | |7;imaging-desaturate;94;95;94;94;95;94;94;94;94;95 06:25:07 INFO - PROCESS | 28514 | |8;json-parse-financial;53;55;55;53;54;54;54;76;52;54 06:25:07 INFO - PROCESS | 28514 | |9;json-stringify-tinderbox;58;60;58;59;58;58;59;58;59;59 06:25:07 INFO - PROCESS | 28514 | |10;stanford-crypto-aes;80;74;73;74;74;74;73;75;74;74 06:25:07 INFO - PROCESS | 28514 | |11;stanford-crypto-ccm;118;116;112;113;118;114;114;113;129;128 06:25:07 INFO - PROCESS | 28514 | |12;stanford-crypto-pbkdf2;160;159;158;165;161;160;165;168;162;161 06:25:07 INFO - PROCESS | 28514 | |13;stanford-crypto-sha256-iterative;68;66;68;67;66;66;66;65;65;65 06:25:07 INFO - PROCESS | 28514 | __end_tp_report 06:25:07 INFO - PROCESS | 28514 | __start_cc_report 06:25:07 INFO - PROCESS | 28514 | _x_x_mozilla_cycle_collect,1569 06:25:07 INFO - PROCESS | 28514 | __end_cc_report 06:25:07 INFO - PROCESS | 28514 | __startTimestamp1467033907481__endTimestamp 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | ------- Summary: start ------- 06:25:07 INFO - PROCESS | 28514 | Number of tests: 14 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.71 (1.6%) stddev-sans-first:1.81 06:25:07 INFO - PROCESS | 28514 | Values: 110.0 110.0 110.0 110.0 110.0 111.0 105.0 110.0 109.0 111.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:155.00 stddev:19.53 (12.6%) stddev-sans-first:20.65 06:25:07 INFO - PROCESS | 28514 | Values: 153.0 127.0 157.0 178.0 133.0 151.0 164.0 127.0 172.0 126.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.39 06:25:07 INFO - PROCESS | 28514 | Values: 162.0 161.0 164.0 161.0 161.0 160.0 161.0 160.0 160.0 159.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:37.92 (49.9%) stddev-sans-first:39.61 06:25:07 INFO - PROCESS | 28514 | Values: 75.0 76.0 77.0 170.0 76.0 73.0 76.0 77.0 161.0 76.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.00 stddev:28.50 (31.0%) stddev-sans-first:29.42 06:25:07 INFO - PROCESS | 28514 | Values: 92.0 92.0 151.0 92.0 92.0 92.0 157.0 93.0 98.0 147.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:25:07 INFO - PROCESS | 28514 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:25:07 INFO - PROCESS | 28514 | Values: 145.0 145.0 144.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:25:07 INFO - PROCESS | 28514 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:7.09 (13.1%) stddev-sans-first:7.43 06:25:07 INFO - PROCESS | 28514 | Values: 53.0 55.0 55.0 53.0 54.0 54.0 54.0 76.0 52.0 54.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 06:25:07 INFO - PROCESS | 28514 | Values: 58.0 60.0 58.0 59.0 58.0 58.0 59.0 58.0 59.0 59.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.01 (2.7%) stddev-sans-first:0.60 06:25:07 INFO - PROCESS | 28514 | Values: 80.0 74.0 73.0 74.0 74.0 74.0 73.0 75.0 74.0 74.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:117.00 stddev:6.15 (5.3%) stddev-sans-first:6.52 06:25:07 INFO - PROCESS | 28514 | Values: 118.0 116.0 112.0 113.0 118.0 114.0 114.0 113.0 129.0 128.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:161.50 stddev:3.14 (1.9%) stddev-sans-first:3.26 06:25:07 INFO - PROCESS | 28514 | Values: 160.0 159.0 158.0 165.0 161.0 160.0 165.0 168.0 162.0 161.0 06:25:07 INFO - PROCESS | 28514 | 06:25:07 INFO - PROCESS | 28514 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.00 06:25:07 INFO - PROCESS | 28514 | Values: 68.0 66.0 68.0 67.0 66.0 66.0 66.0 65.0 65.0 65.0 06:25:07 INFO - PROCESS | 28514 | -------- Summary: end -------- 06:25:07 INFO - PROCESS | 28514 | 06:25:08 INFO - TEST-INFO | 28514: exit 0 06:25:08 INFO - TEST-OK | kraken | took 59578ms 06:25:08 INFO - SUITE-END | took 1170s 06:25:08 INFO - Completed test suite (00:19:30) 06:25:08 INFO - javascript benchmark 06:25:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3220.6779322067787, 3328.9167770805725, 3333.2333563280445, 3372.460406334987, 3385.4583266677323, 5459.481349271818, 5513.50378465938, 5513.751881165347, 5525.668459892404, 5526.640768350055, 5452.345718513784, 5505.779768809253, 5508.807191748289, 5532.2531458253125, 5552.472515111068, 4889.633277504184, 4982.526659967298, 5085.745712714368, 5132.794688212467, 5164.974175129138, 4830.637702172334, 4894.583960363356, 4927.063857866994, 4929.728864912428, 4937.407511098673, 4942.752862356868, 4983.426905905831, 5022.899542009158, 5054.039732450822, 5071.264666623338, 5033.471485494026, 5036.496350364971, 5050.898982020339, 5060.620453465968, 5082.923756143661, 4837.806487740486, 4939.234418665113, 4954.87612809679, 4965.428975667808, 5017.49825017499, 5232.502912223333, 5263.44733802949, 5263.947360526384, 5273.314469119028, 5296.496832800878, 5707.62900411476, 5755.539556835443, 5760.711964401805, 5764.654120752768, 5774.740136693859, 5764.538836893039, 5794.217780599607, 5822.9417705822825, 5846.649201047951, 5856.7071646417935, 5331.920021199685, 5361.5978801589645, 5365.812196573102, 5369.301990741218, 5373.731313434313, 5731.885362292731, 5837.445442682938, 5841.153032810219, 5856.180134781049, 5861.443162899518, 5610.5231055360755, 5684.261046063985, 5691.345495268097, 5721.456461636138, 5737.3975732548315, 5793.710314484259, 5809.970950145223, 5812.622179558315, 5819.6508209507565, 5822.446867547576, 5638.126090455986, 5733.111367738007, 5763.711814409263, 5779.2775903012125, 5784.0, 5768.192453056576, 5781.508571771446, 5786.189933409326, 5796.101604251347, 5819.88360232793, 4452.888677783081, 4456.197884380777, 4458.308962110878, 4458.866234012985, 4481.5070342262325, 3960.7821569813937, 3975.34406822871, 3985.362342025262, 4011.13760541485, 4039.091204478969, 5569.192467092249, 5594.832155035356, 5604.0, 5609.326880774252, 5629.521490673257, 5836.9124463133085, 5853.443922827325, 5853.473187413153, 5854.473097421167, 5862.091375836752, 5431.755570999315, 5517.393086760453, 5562.694051827189, 5565.526930210896, 5590.189422533791, 4853.563179313879, 4854.902901942012, 4859.2954021667365, 4885.0, 4887.3890763654545, 5871.6770577618645, 5887.322957859901, 5922.585419020714, 5925.34821169671, 5942.7920022799, 5635.8591035224445, 5708.058170401837, 5821.534277257894, 5894.469497745224, 5896.027155519463, 5978.760849565969, 5981.3719559445635, 5981.371955944737, 5983.371745966785, 5990.730417131327, 5617.887642247214, 5626.43735626434, 5627.971860140673, 5631.380548139619, 5638.323401191719, 5605.635633683797, 5751.654900705971, 5815.0405183146, 5820.563457740602, 5824.271966004249, 5617.719114044363, 5618.803341883178, 5618.915716264341, 5624.268845050117, 5639.0, 5496.367917689517, 5608.46719561641, 5610.438956104357, 5613.438656134354, 5628.690422026828, 5526.917096243479, 5593.440655934374, 5616.522595579421, 5627.943720562742, 5630.0, 5652.349979752381, 5675.687837168995, 5701.116326969326, 5705.172749951317, 5718.113692377522, 5519.834404967857, 5534.446555344433, 5568.610197286151, 5580.0, 5582.27430434041], "value": 5352.55005426431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.9260881303059, 672.6838385958599, 682.259748173232, 694.7360003198784, 742.8031571633518, 32739.836300818493, 33221.66778332216, 38782.80608596957, 39429.8028509857, 39485.80257098718, 42887.0, 43233.0, 43360.783196084056, 43455.78272108635, 43622.0, 8188.508689478621, 8723.869141962876, 8991.3256505762, 8995.640174393016, 9019.954900225523, 8173.386995975296, 10726.731831704192, 10991.450427478634, 10997.835032474519, 11001.064909482704, 10708.143348532138, 10789.784204315909, 10793.460326983619, 10797.5680972761, 10798.67603971878, 10609.045185933264, 10732.302400343953, 10744.516496757664, 10753.139748820115, 10759.946200269027, 10429.895701042968, 10517.579296828118, 10543.36739795607, 10546.36721796687, 10900.672979810619, 43284.134317313474, 43737.0, 43790.12419751587, 43824.0, 43824.0, 3968.1666849961543, 4086.7139300248996, 4127.463429754142, 4227.852025179104, 4695.248760198352, 29765.065270757546, 29774.851125744233, 30011.549826752616, 31020.689793102232, 31103.688963110304, 4312.417823593806, 4330.696851220416, 4341.674374421931, 4384.539623339535, 4468.955310446887, 298010.0, 298579.0, 299402.50298748584, 299600.0, 299640.0, 62853.68573157105, 62916.0, 63222.0, 63222.36777632165, 63233.36766632367, 67652.0, 69354.3064569358, 70047.64976175189, 70669.64665176744, 70860.0, 17785.110744462727, 17929.0, 17952.730709039115, 17965.550861228312, 17966.371177008743, 13707.109037912503, 13753.449862005607, 14087.506937257147, 14426.278686065654, 14956.551303460914, 19843.40469785909, 20364.592708145756, 20541.178352866016, 20567.38297851067, 20612.69080963787, 7507.662155203029, 7591.278828511283, 7714.5756983366455, 7718.3053525183, 7747.225277472207, 1084.7450849050467, 1217.3304682424632, 1226.687194765347, 1248.4132457744845, 1251.9170917156594, 32409.0, 32924.835375822964, 32993.3401331972, 33517.16207094793, 34012.82993585016, 1257.867923867999, 1271.713864380507, 1308.5485507499898, 1347.1243691600341, 1361.0608680010762, 17705.557361066076, 17908.641827163385, 17996.190171442315, 17999.73000404995, 18038.90980545089, 467060.0, 471172.0, 473216.0, 474636.0, 475631.0, 61973.690131549054, 62993.370066298754, 63045.68477157585, 63104.36895630985, 63278.0, 1359.8368195816565, 1536.7464368379092, 1572.4182052640597, 1574.087029522874, 1625.7236269834157, 30375.0, 31687.366252674357, 31819.0, 32007.0, 32197.839010805732, 44840.0, 45189.32216016828, 45261.54738452574, 45278.773606131756, 45283.773581131885, 296018.0, 296395.0, 300498.0, 300515.0, 301016.0, 27917.58123628188, 30469.0, 30774.538381924736, 30827.383452330378, 31197.688023119477, 49168.75415622899, 49291.753541232065, 50148.24777628265, 50300.0, 50853.49146508487, 37677.0, 40264.0, 40756.0, 40771.38842917418, 41202.58797411987, 39378.80310598428, 39763.204735905696, 40595.59404405918, 40947.590524094376, 41554.0, 43227.567724322354, 43869.78065109654, 43905.56094439015, 43914.12171756483, 44291.55708442874, 34191.82904085464, 36657.816710916275, 36939.63060369469, 37222.25555488929, 37336.25327493489, 28261.17193554133, 28305.50068833387, 28560.285992849513, 28665.42669146647, 28768.0], "value": 20875.0775756612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.0568692008381, 412.57092623671383, 428.38098947021547, 431.69781153192736, 438.17404193096024, 18578.071096445175, 18601.255949761995, 18996.715049274255, 19137.712934305997, 19483.610327793434, 18042.097895105257, 18451.815481845177, 18710.15804288807, 18774.155163017662, 18802.05989700513, 5720.914186287209, 5759.568032397577, 5948.40515948406, 5961.254843144607, 5964.671943043131, 5839.9124013139835, 5890.734916928748, 5913.14259432382, 5932.199153114339, 5934.287885453751, 5644.294463192101, 5758.539316854642, 5879.088741245114, 5886.146508756227, 5887.381824908387, 5744.4829965303325, 5747.2241247431475, 5766.106253530709, 5782.681952492611, 5786.363500014974, 5093.414257360414, 5123.7438128093445, 5146.0, 5165.380154381498, 5307.044731948247, 11502.367369794658, 12115.091368147425, 21956.780432195632, 22602.54794904109, 22761.20335788256, 2410.349205714465, 2413.855168689884, 2566.0762125634756, 2951.4834903891733, 3049.374878149996, 9315.30135239853, 9398.38910470824, 9408.529573521297, 13125.818676319082, 13509.864901350958, 1960.4412742368356, 2021.7674967378646, 2038.2458490358515, 2061.2785525066256, 2077.1483691686485, 54947.72526137384, 77134.0, 78670.0, 81118.59440702818, 82567.0, 10704.19718521114, 10952.39761813092, 10984.725381865517, 11029.669109926715, 11261.71845703864, 15466.690666186612, 15614.687706246039, 15624.531264062096, 15632.3747050119, 15665.216739162996, 7455.403567714569, 7517.624118794039, 7971.322437592754, 8097.676092956333, 8098.5545794981845, 8328.625211865481, 8341.082480927093, 8415.873761893576, 8437.620307086196, 8473.067962524117, 4121.5466298707115, 4271.850485233002, 4776.0, 4783.162946484351, 4807.351007613997, 1919.4529559075597, 1963.0, 1988.9701654475195, 2048.8014511510933, 2054.6301665700316, 1063.3035361838008, 1064.7178497698117, 1106.590561492237, 1161.6050542815483, 1197.6227488341144, 18166.0, 18603.34888278931, 18865.622687546173, 18890.24439022451, 19169.61660766777, 1083.4203701019917, 1094.2996482251365, 1100.5817789240198, 1153.3829401270448, 1160.3386069940052, 10537.63118290856, 10637.680869573926, 10651.414172220602, 10670.413127278074, 10726.946365268279, 571694.0, 621763.0, 630430.0, 641400.0, 647921.0, 88759.0, 90088.0, 95734.52132739291, 104592.0, 105093.47453262837, 1088.8257878739364, 1131.5643477261149, 1142.2118738070706, 1144.3134119528218, 1160.2632328471482, 16285.430009950069, 16453.0, 16597.336106556086, 16657.583560411087, 16818.0, 35847.64152358443, 36312.818435907655, 41237.79381103075, 41736.79131604323, 42026.789866051695, 58318.4168158313, 60139.39860601338, 60605.0, 60706.69646651739, 61138.69430652818, 8155.510669359857, 8733.956330218309, 8861.73870946794, 8966.372353935161, 9053.0, 11727.706807329885, 12809.42357593892, 12986.675333116747, 13213.933930330288, 13216.801747973981, 11359.432028398713, 11405.486753096297, 11638.592649257236, 11696.298222106701, 11811.409429528661, 11436.313821170756, 11478.655640330804, 11824.52701891949, 11916.927476526807, 11991.580294689993, 12193.146479746687, 12309.56916507918, 12385.133040687066, 12478.688032799253, 12601.43293551774, 8213.219744124299, 8648.221660050625, 8797.736067917973, 8872.64509419616, 8903.554822258731, 10934.835977460185, 11773.705657358634, 11909.940450297692, 12094.516219351479, 12238.632841014783], "value": 9371.898351266304, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.6875453023065, 1569.2938177819983, 1586.3813112885973, 1812.0, 1927.4699457649135, 8140.918590814097, 8445.577721113943, 8469.44948578342, 8470.830583388328, 8474.279686226679, 8162.14297498763, 8340.207680270365, 8356.791080222998, 8361.247487726103, 8375.581220938959, 2343.039353864916, 2362.8464149830293, 2366.881655917206, 2367.1241640593003, 2367.538330025646, 2352.1414683640432, 2429.2712186344115, 2504.3113143885485, 2506.624006399046, 2516.1570873757223, 2414.4808866093786, 2430.6718592989987, 2445.364205306624, 2470.6047032474808, 2472.8392654477493, 2421.6609674645565, 2458.864762438065, 2469.6789417375808, 2471.6910386201725, 2474.183519438581, 2355.564220619191, 2378.6432035194684, 2380.33350661815, 2380.8571485710913, 2382.094803974496, 7096.112985876765, 8077.192280771935, 8573.914260857375, 8631.395802293842, 8635.827283454295, 5173.689578625294, 5306.151015837486, 5344.973275133639, 5346.171343441734, 5346.4386239445075, 3412.5904891412943, 3419.12812232879, 3508.3509550732942, 3527.1005893496995, 3542.5394698689265, 1111.9833202501968, 1125.859267591551, 1170.953161873524, 1177.823326501023, 1191.612725864089, 11545.595904143314, 11900.285982841056, 11918.404079795975, 11928.0, 11945.820812687816, 4623.982723800758, 4628.791704373311, 4641.141388843075, 4685.976570117127, 4781.187198176319, 10264.692059238234, 10348.379097254188, 10351.896481035245, 10354.430506322225, 10363.274570779973, 5422.972885135549, 5427.755750991215, 5438.102713052381, 5441.183822426668, 5442.047641662693, 4919.926201106986, 4966.90066198674, 4968.701877887338, 4975.676581022222, 4976.104301225814, 3940.5468371137686, 4010.3583426651594, 4015.738976966488, 4052.0, 4054.918901621951, 1185.8221266810046, 1211.3216598704578, 1214.4110106598293, 1214.4959841665786, 1217.2270608163703, 900.1583519409373, 995.5171741705267, 1004.2016596805557, 1014.2089170447063, 1022.3610243597751, 5715.114157305624, 5765.077587585966, 5771.942280577225, 5907.379725128885, 6019.398060193946, 996.4519514267124, 1007.5919252702668, 1051.731808388856, 1085.148158695436, 1085.9782804344027, 3665.6151104134215, 3939.153082087365, 4091.754494730326, 4103.74835675122, 4117.773522456294, 10299.0, 10384.584616615251, 10661.040506354466, 10773.084287835622, 10777.137828973664, 10458.372497650165, 10597.046265835957, 10613.257072004886, 10636.149108071335, 10666.626668066736, 7887.84224315522, 8272.8345433091, 8296.792580185424, 8297.792555186048, 8302.626381812834, 5812.128180772749, 5896.17453556511, 5901.468867801918, 5956.166136740946, 6074.210352654127, 9462.574184161867, 9537.0, 9641.662541811003, 9643.855342169732, 9655.0, 9440.291978101532, 9514.619415223313, 9702.078302561245, 9754.853677194706, 9801.509924503604, 7256.310650488406, 7312.41500679955, 7368.59472729005, 7380.077490313711, 7391.445641576795, 8281.337493000425, 8317.750467485985, 8340.082590915115, 8345.207205315486, 8358.414910956175, 7130.073090498202, 7162.46281528877, 7257.963710181415, 7289.805654672041, 7335.77992660221, 7468.551886886804, 7487.962560187164, 7499.700011999459, 7534.284242996907, 7551.056117985252, 7019.929800701928, 7088.751893683696, 7101.289871013064, 7111.964440177766, 7162.0, 5006.4743201963265, 5213.921791173211, 5553.6390134641115, 5602.775888964396, 5649.152627105967, 4488.775561221991, 5098.337216161875, 5355.089634762022, 5448.591355648263, 5504.504594586507], "value": 4642.810640895701, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.4797715563721, 333.83975691667996, 339.65016033485506, 349.9545059142311, 352.5804292891461, 6114.633122012677, 6123.969380153098, 6155.16905217796, 6166.105914642374, 6324.241091069078, 6178.443940045395, 6259.499240060795, 6310.211223597051, 6321.7155228014735, 6323.462505687022, 4770.284457331402, 4771.165046116933, 4773.711098003537, 4779.737114458703, 4782.617390608761, 4533.0, 4630.259158534635, 4697.906041879178, 4740.597049250818, 4773.689710168828, 4716.292556116576, 4719.126961512131, 4721.976390118045, 4726.7400292983875, 4731.3849199604, 4463.933041004388, 4706.2705280681375, 4726.834560790356, 4729.858104256878, 4731.266653668687, 3941.783201923893, 3972.443857859902, 3973.8609148679657, 3988.4017397390335, 3993.6805055595482, 5892.793752218695, 5910.1430292607765, 5985.670788106652, 5993.520518358564, 6004.96997515014, 5379.058664733656, 5383.838484845461, 5394.460553944574, 5394.973025134888, 5395.541378982752, 6548.476121910284, 6556.18047744032, 6562.0, 6568.408843204087, 6568.86862262752, 4436.290193569013, 4441.511433742286, 4441.64466842655, 4443.244648409745, 4444.088961762831, 6701.3968742812895, 6895.965520172417, 6905.413039891615, 6913.688884000232, 6919.654017299165, 4484.372187893698, 4515.164694531457, 4516.593506584423, 4521.84173553924, 4522.005158865044, 4579.38178345919, 4581.312803079498, 4583.312503124492, 4583.839565615254, 4584.977075114603, 5368.00691872005, 5368.382635996911, 5369.4630536946, 5380.677159370451, 5387.838364849061, 6639.900401493981, 6645.568038077509, 6649.767258146038, 6652.800415987528, 6654.367835055662, 1570.5680937742213, 1604.2219523531078, 1604.366275321265, 1604.791377120967, 1605.405999780089, 1016.3241444439512, 1068.9417971089072, 1079.4386918802336, 1083.3337497439177, 1086.5979587552656, 6206.472449841724, 6324.557280990287, 6390.0, 6405.519586031066, 6427.807165785034, 6784.321567843176, 6787.592744435349, 6924.376806087476, 6951.617661028591, 6951.965240173767, 6497.155369801895, 6501.0573466847045, 6504.089427480157, 6506.41442270198, 6512.772052978123, 3665.52348194733, 3705.7035437164964, 3706.4440333950124, 3706.5737440194184, 3712.5173727415263, 7027.754028608974, 7238.167610724729, 7266.890996635055, 7271.0, 7300.306470885257, 7061.858762824715, 7078.256783037707, 7078.433725301964, 7079.433645308363, 7079.610621415769, 7259.41924646027, 7265.12818461788, 7267.273272672796, 7276.163241227221, 7279.1265048194555, 6876.518643694893, 6878.3465570770695, 6884.586924784328, 6891.862162756616, 6897.62063086515, 6556.147700799056, 6737.258901520927, 6821.3519715626935, 6897.620630865351, 6903.0680858083515, 7219.711211551479, 7231.819204519929, 7257.891131633135, 7262.9273707262255, 7298.160711518243, 4574.81700731967, 4610.700304480198, 4614.10025045113, 4616.16908956391, 4619.769011549476, 6854.828629284308, 6888.0, 6894.413974811997, 6896.655167241718, 6897.3447522485285, 6501.382368674968, 6600.735970561123, 6630.370114839083, 6650.667466626746, 6661.134052573135, 6669.6331701754925, 6688.4983626229205, 6698.966505167443, 6699.330066993261, 6704.932950670431, 6552.213734351908, 6558.672066396756, 6564.0, 6564.4420224281475, 6582.3746744059235, 6747.987801829765, 6748.763793267212, 6749.628770417674, 6752.932470675427, 6762.019507171531, 6432.453241474527, 6532.510061745293, 6566.310537393696, 6568.80293591193, 6582.0], "value": 4965.392728382843, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.3603733237406, 865.1219012702112, 893.5844832153051, 924.4040681747999, 938.2400255792807, 15191.848081519182, 15221.162836044014, 15325.540233793005, 15348.53954381369, 15404.152771597557, 15612.2974466149, 16073.517794466185, 16076.196190190502, 16090.59773505663, 16118.11350375729, 767.2557619109483, 910.2672348759246, 922.478799478296, 925.0379605210572, 925.1257561604286, 765.2959277464718, 770.4914756260869, 771.3212373111681, 900.131373224838, 917.7797328641145, 954.5131982688844, 956.995215023924, 957.4398976598698, 957.8228027814877, 959.0505399654362, 948.5968463403061, 949.0130264524886, 949.2453499467871, 950.1875896108832, 950.9286803489731, 589.7405141737622, 701.859628074382, 705.1502938958594, 705.8094314535098, 706.2125729811223, 14917.0, 14919.179445130514, 14934.402623895032, 14944.178070206135, 14995.175265360402, 14133.575992720132, 14751.557453276419, 14850.777238341325, 14856.405743770236, 14888.851111488855, 11987.460564274628, 12045.217060891102, 12046.939765301116, 12096.0, 12372.319522426264, 4008.979955100235, 4041.7979101045125, 4066.4713587233764, 4126.690498212646, 4133.379993001044, 55906.16140757892, 55964.72017639967, 56477.43522564763, 56480.0, 56716.716416418065, 11025.944870275598, 11448.828267575993, 11578.942105289589, 11665.183437159487, 11710.473028713728, 20579.0, 20839.8958005209, 20842.68735968962, 20847.895760521405, 20899.164033438796, 8777.122287771299, 8868.911310886937, 9009.099090090938, 9079.909200908038, 9162.770930726785, 4968.950310496921, 5104.387473503203, 5114.43741188469, 5199.090159222121, 5221.190715439113, 3665.541807274091, 3718.1448266898224, 3718.6839118675216, 3721.1999420124803, 3722.739408241451, 623.1551328304365, 679.2765704524666, 683.9794806155824, 688.3013741052836, 694.1843334082433, 726.0742553244655, 752.1989081628158, 775.2286474957453, 817.8936738223993, 854.6752234150982, 9794.412335259907, 9942.453165075991, 9986.700398988041, 10027.097561219525, 10167.034131757471, 655.9770408035696, 702.8699690557263, 762.6987340000669, 777.2188950105221, 790.4940837863771, 4492.663050271242, 4615.769211539477, 4663.580277775017, 4671.883202919954, 4682.274247491644, 64754.0, 65342.67328663326, 65460.345396545425, 65594.34405655978, 65617.0, 50924.236136457985, 52908.73545632247, 53443.19835202475, 53843.19235211475, 53950.0, 48531.5146848527, 48928.510714893106, 50022.49977500179, 50581.0, 50722.23916641253, 8851.60167792438, 8978.461292322481, 9050.909490905007, 9132.497712625604, 9323.393979391318, 37979.43030854595, 38242.80878595701, 38288.0, 39163.804180978914, 39748.0, 45952.77023614994, 51233.0, 51469.227961579854, 51692.74153629208, 51814.222786657476, 11852.881471185177, 11919.106067044833, 11926.522939082339, 12131.272123672608, 12135.878641213829, 12392.261163405892, 13067.869321306665, 13376.933115334361, 13465.932670336586, 13516.797248041485, 12596.307203103917, 12616.55842045524, 12888.42002109926, 13168.209907405586, 13245.602631921058, 11999.340036298088, 12053.0, 12116.970057545208, 12781.297028663514, 12793.29636869981, 12370.505179792708, 12447.875521244672, 12673.556425525063, 12687.746245074863, 13024.869751302745, 10147.84778228342, 10156.949215253877, 10374.792504149724, 10695.144388448749, 10726.195535335037, 10087.39475631435, 10139.340942838691, 10302.845457317997, 10309.432981186106, 10345.793084138426], "value": 7110.986420726664, "unit": "score"}], "name": "dromaeo_css", "value": 7455.102325626868, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 105.0, 110.0, 109.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 157.0, 178.0, 133.0, 151.0, 164.0, 127.0, 172.0, 126.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 170.0, 76.0, 73.0, 76.0, 77.0, 161.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 151.0, 92.0, 92.0, 92.0, 157.0, 93.0, 98.0, 147.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 144.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0], "value": 144.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 53.0, 54.0, 54.0, 54.0, 76.0, 52.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 59.0, 58.0, 58.0, 59.0, 58.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 73.0, 74.0, 74.0, 74.0, 73.0, 75.0, 74.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 112.0, 113.0, 118.0, 114.0, 114.0, 113.0, 129.0, 128.0], "value": 117.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 158.0, 165.0, 161.0, 160.0, 165.0, 168.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1514.0, "alertThreshold": 2.0}]} 06:25:08 INFO - Return code: 0 06:25:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:25:08 ERROR - # TBPL SUCCESS # 06:25:08 INFO - Running post-action listener: _resource_record_post_action 06:25:08 INFO - Running post-run listener: _resource_record_post_run 06:25:09 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 471789568; Read time: 8; Write time: 450640 06:25:09 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 250146816; Read time: 0; Write time: 332652 06:25:09 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221642752; Read time: 8; Write time: 117988 06:25:09 INFO - Running post-run listener: _upload_blobber_files 06:25:09 INFO - Blob upload gear active. 06:25:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:09 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:25:09 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:25:09 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:25:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:25:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:10 INFO - (blobuploader) - INFO - Done attempting. 06:25:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:25:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:25:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:11 INFO - (blobuploader) - INFO - Done attempting. 06:25:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:11 INFO - Return code: 0 06:25:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/64718b9fe41a7bc6e76f0f304e2274dcda5692daa8e165ae81a02d4b5ca96d14434fbb533dffe9bf3bcab6160218fd1cda6df455b358be4b47ddf5cdad367cc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/276356d7c5523d24a6208c1847088bec84a602a1452bbae695fdcba8f795facaebe6fa804f34e4ba9857523e7179f2003ca6cd3466374005220f7293c2f45793"} 06:25:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:11 INFO - Contents: 06:25:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/64718b9fe41a7bc6e76f0f304e2274dcda5692daa8e165ae81a02d4b5ca96d14434fbb533dffe9bf3bcab6160218fd1cda6df455b358be4b47ddf5cdad367cc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/276356d7c5523d24a6208c1847088bec84a602a1452bbae695fdcba8f795facaebe6fa804f34e4ba9857523e7179f2003ca6cd3466374005220f7293c2f45793"} 06:25:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:11 INFO - Copying logs to upload dir... 06:25:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.025017 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-27 06:25:10.538681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:10.542691) ========= 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=db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071 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/64718b9fe41a7bc6e76f0f304e2274dcda5692daa8e165ae81a02d4b5ca96d14434fbb533dffe9bf3bcab6160218fd1cda6df455b358be4b47ddf5cdad367cc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/276356d7c5523d24a6208c1847088bec84a602a1452bbae695fdcba8f795facaebe6fa804f34e4ba9857523e7179f2003ca6cd3466374005220f7293c2f45793"} 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.011153 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/64718b9fe41a7bc6e76f0f304e2274dcda5692daa8e165ae81a02d4b5ca96d14434fbb533dffe9bf3bcab6160218fd1cda6df455b358be4b47ddf5cdad367cc3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/276356d7c5523d24a6208c1847088bec84a602a1452bbae695fdcba8f795facaebe6fa804f34e4ba9857523e7179f2003ca6cd3466374005220f7293c2f45793"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:10.568124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:10.568476) ========= 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=db0483c52d987ecb441a263b000001ad-1467032688.20674-744858071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004677 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:10.650215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:25:10.650564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:25:10.650857) ========= ========= Total master_lag: 0.22 =========