builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1467032687.97 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.968399) ========= 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.968860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.969134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.983681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:47.983997) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111 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% 102M=0s 2016-06-27 06:04:49 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.083503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.083840) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014262 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.133291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.133682) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 06:04:49,138 truncating revision to first 12 chars 2016-06-27 06:04:49,138 Setting DEBUG logging. 2016-06-27 06:04:49,138 attempt 1/10 2016-06-27 06:04:49,138 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,442 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.868373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.868708) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.869124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.869408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:04:48.878118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-27 06:04:48.878515) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111 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-e10s --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-e10s', 06:04:49 INFO - 'system_bits': '32', 06:04:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:49 INFO - 'title': 'talos-linux64-ix-041', 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-e10s", 06:04:50 INFO - "repository": "", 06:04:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 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": 15, 06:04:50 INFO - "slavename": "talos-linux64-ix-041", 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:55 INFO - Downloaded 24228390 bytes. 06:04:55 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:55 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:58 INFO - Downloaded 10840145 bytes. 06:04:58 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:58 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:58 INFO - Return code: 0 06:04:58 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:58 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:58 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:58 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:58 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:58 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:59 INFO - Downloaded 56007799 bytes. 06:04:59 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:59 INFO - mkdir: /builds/slave/test/properties 06:04:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:04:59 INFO - Writing to file /builds/slave/test/properties/build_url 06:04:59 INFO - Contents: 06:04:59 INFO - build_url:https://queue.taskcluster.net/v1/task/FC3x1KwxRJugeVxSVPd7ww/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:05:00 INFO - Running post-action listener: _resource_record_post_action 06:05:00 INFO - Running post-action listener: set_extra_try_arguments 06:05:00 INFO - ##### 06:05:00 INFO - ##### Running populate-webroot step. 06:05:00 INFO - ##### 06:05:00 INFO - Running pre-action listener: _resource_record_pre_action 06:05:00 INFO - Running main action method: populate_webroot 06:05:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:05:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:05:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:05:00 INFO - '--tppagecycles', 06:05:00 INFO - '7'], 06:05:00 INFO - 'tests': ['tsvgm']}}, 06:05:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:05:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:05:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:05:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:05:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['damp', 'tps']}, 06:05:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'tests': ['damp', 'tps']}, 06:05:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['dromaeo_dom']}, 06:05:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:05:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['a11yr', 06:05:00 INFO - 'ts_paint', 06:05:00 INFO - 'tpaint', 06:05:00 INFO - 'sessionrestore', 06:05:00 INFO - 'sessionrestore_no_auto_restore', 06:05:00 INFO - 'tabpaint']}, 06:05:00 INFO - 'other-e10s': {'tests': ['a11yr', 06:05:00 INFO - 'ts_paint', 06:05:00 INFO - 'tpaint', 06:05:00 INFO - 'sessionrestore', 06:05:00 INFO - 'sessionrestore_no_auto_restore', 06:05:00 INFO - 'tabpaint']}, 06:05:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:05:00 INFO - 'ts_paint', 06:05:00 INFO - 'tpaint', 06:05:00 INFO - 'sessionrestore', 06:05:00 INFO - 'sessionrestore_no_auto_restore', 06:05:00 INFO - 'tabpaint']}, 06:05:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:05:00 INFO - 'ts_paint', 06:05:00 INFO - 'tpaint', 06:05:00 INFO - 'sessionrestore', 06:05:00 INFO - 'sessionrestore_no_auto_restore', 06:05:00 INFO - 'tabpaint']}, 06:05:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['a11yr', 06:05:00 INFO - 'ts_paint', 06:05:00 INFO - 'tpaint', 06:05:00 INFO - 'sessionrestore', 06:05:00 INFO - 'sessionrestore_no_auto_restore', 06:05:00 INFO - 'tabpaint']}, 06:05:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['a11yr', 06:05:00 INFO - 'ts_paint', 06:05:00 INFO - 'tpaint', 06:05:00 INFO - 'sessionrestore', 06:05:00 INFO - 'sessionrestore_no_auto_restore', 06:05:00 INFO - 'tabpaint']}, 06:05:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['tsvgx', 06:05:00 INFO - 'tsvgr_opacity', 06:05:00 INFO - 'tart', 06:05:00 INFO - 'tscrollx', 06:05:00 INFO - 'cart']}, 06:05:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:05:00 INFO - 'tsvgr_opacity', 06:05:00 INFO - 'tart', 06:05:00 INFO - 'tscrollx', 06:05:00 INFO - 'cart']}, 06:05:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'talos_options': ['--disable-e10s'], 06:05:00 INFO - 'tests': ['tp5o']}, 06:05:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'tests': ['tp5o']}, 06:05:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'talos_options': ['--disable-e10s', 06:05:00 INFO - '--xperf_path', 06:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:00 INFO - 'tests': ['tp5n']}, 06:05:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:00 INFO - 'talos_options': ['--xperf_path', 06:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:00 INFO - 'tests': ['tp5n']}}, 06:05:00 INFO - 'talos.zip': {'path': '', 06:05:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:05:00 INFO - Running post-action listener: _resource_record_post_action 06:05:00 INFO - ##### 06:05:00 INFO - ##### Running create-virtualenv step. 06:05:00 INFO - ##### 06:05:00 INFO - Running pre-action listener: _resource_record_pre_action 06:05:00 INFO - Running main action method: create_virtualenv 06:05:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:05:00 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:05:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:05:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:05:00 INFO - Using real prefix '/usr' 06:05:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:05:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:03 INFO - Installing pip.................done. 06:05:03 INFO - Return code: 0 06:05:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:05:03 INFO - Using env: {'DISPLAY': ':0', 06:05:03 INFO - 'HOME': '/home/cltbld', 06:05:03 INFO - 'LANG': 'en_US.UTF-8', 06:05:03 INFO - 'LANGUAGE': 'en_US:en', 06:05:03 INFO - 'LOGNAME': 'cltbld', 06:05:03 INFO - 'MAIL': '/var/mail/cltbld', 06:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:03 INFO - 'MOZ_NO_REMOTE': '1', 06:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:03 INFO - 'NO_EM_RESTART': '1', 06:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:03 INFO - 'PWD': '/builds/slave/test', 06:05:03 INFO - 'SHELL': '/bin/bash', 06:05:03 INFO - 'SHLVL': '1', 06:05:03 INFO - 'TERM': 'linux', 06:05:03 INFO - 'TMOUT': '86400', 06:05:03 INFO - 'USER': 'cltbld', 06:05:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:03 INFO - '_': '/tools/buildbot/bin/python'} 06:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:03 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:03 INFO - Cleaning up... 06:05:03 INFO - Return code: 0 06:05:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:05:03 INFO - Using env: {'DISPLAY': ':0', 06:05:03 INFO - 'HOME': '/home/cltbld', 06:05:03 INFO - 'LANG': 'en_US.UTF-8', 06:05:03 INFO - 'LANGUAGE': 'en_US:en', 06:05:03 INFO - 'LOGNAME': 'cltbld', 06:05:03 INFO - 'MAIL': '/var/mail/cltbld', 06:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:03 INFO - 'MOZ_NO_REMOTE': '1', 06:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:03 INFO - 'NO_EM_RESTART': '1', 06:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:03 INFO - 'PWD': '/builds/slave/test', 06:05:03 INFO - 'SHELL': '/bin/bash', 06:05:03 INFO - 'SHLVL': '1', 06:05:03 INFO - 'TERM': 'linux', 06:05:03 INFO - 'TMOUT': '86400', 06:05:03 INFO - 'USER': 'cltbld', 06:05:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:03 INFO - '_': '/tools/buildbot/bin/python'} 06:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:03 INFO - Downloading/unpacking psutil>=0.7.1 06:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:05 INFO - Installing collected packages: psutil 06:05:05 INFO - Running setup.py install for psutil 06:05:05 INFO - building 'psutil._psutil_linux' extension 06:05:05 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:05 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:05 INFO - building 'psutil._psutil_posix' extension 06:05:05 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:05 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:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:06 INFO - Successfully installed psutil 06:05:06 INFO - Cleaning up... 06:05:06 INFO - Return code: 0 06:05:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:05:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:06 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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:06 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:06 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:06 INFO - Using env: {'DISPLAY': ':0', 06:05:06 INFO - 'HOME': '/home/cltbld', 06:05:06 INFO - 'LANG': 'en_US.UTF-8', 06:05:06 INFO - 'LANGUAGE': 'en_US:en', 06:05:06 INFO - 'LOGNAME': 'cltbld', 06:05:06 INFO - 'MAIL': '/var/mail/cltbld', 06:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:06 INFO - 'MOZ_NO_REMOTE': '1', 06:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:06 INFO - 'NO_EM_RESTART': '1', 06:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:06 INFO - 'PWD': '/builds/slave/test', 06:05:06 INFO - 'SHELL': '/bin/bash', 06:05:06 INFO - 'SHLVL': '1', 06:05:06 INFO - 'TERM': 'linux', 06:05:06 INFO - 'TMOUT': '86400', 06:05:06 INFO - 'USER': 'cltbld', 06:05:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:06 INFO - '_': '/tools/buildbot/bin/python'} 06:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:08 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:08 INFO - Installing collected packages: mozsystemmonitor 06:05:08 INFO - Running setup.py install for mozsystemmonitor 06:05:08 INFO - Successfully installed mozsystemmonitor 06:05:08 INFO - Cleaning up... 06:05:08 INFO - Return code: 0 06:05:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05:08 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:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:08 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:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:08 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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:08 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:08 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:08 INFO - Using env: {'DISPLAY': ':0', 06:05:08 INFO - 'HOME': '/home/cltbld', 06:05:08 INFO - 'LANG': 'en_US.UTF-8', 06:05:08 INFO - 'LANGUAGE': 'en_US:en', 06:05:08 INFO - 'LOGNAME': 'cltbld', 06:05:08 INFO - 'MAIL': '/var/mail/cltbld', 06:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:08 INFO - 'MOZ_NO_REMOTE': '1', 06:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:08 INFO - 'NO_EM_RESTART': '1', 06:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:08 INFO - 'PWD': '/builds/slave/test', 06:05:08 INFO - 'SHELL': '/bin/bash', 06:05:08 INFO - 'SHLVL': '1', 06:05:08 INFO - 'TERM': 'linux', 06:05:08 INFO - 'TMOUT': '86400', 06:05:08 INFO - 'USER': 'cltbld', 06:05:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:08 INFO - '_': '/tools/buildbot/bin/python'} 06:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05:10 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:10 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 - 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:10 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:10 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:10 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05:10 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:10 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 - 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:10 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:10 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:10 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:11 INFO - Downloading docopt-0.6.1.tar.gz 06:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:11 INFO - Running setup.py install for blobuploader 06:05:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:11 INFO - Running setup.py install for requests 06:05:11 INFO - Running setup.py install for docopt 06:05:11 INFO - Successfully installed blobuploader requests docopt 06:05:11 INFO - Cleaning up... 06:05:11 INFO - Return code: 0 06:05:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:11 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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 06:05:11 INFO - 'HOME': '/home/cltbld', 06:05:11 INFO - 'LANG': 'en_US.UTF-8', 06:05:11 INFO - 'LANGUAGE': 'en_US:en', 06:05:11 INFO - 'LOGNAME': 'cltbld', 06:05:11 INFO - 'MAIL': '/var/mail/cltbld', 06:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:11 INFO - 'MOZ_NO_REMOTE': '1', 06:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:11 INFO - 'NO_EM_RESTART': '1', 06:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:11 INFO - 'PWD': '/builds/slave/test', 06:05:11 INFO - 'SHELL': '/bin/bash', 06:05:11 INFO - 'SHLVL': '1', 06:05:11 INFO - 'TERM': 'linux', 06:05:11 INFO - 'TMOUT': '86400', 06:05:11 INFO - 'USER': 'cltbld', 06:05:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:11 INFO - '_': '/tools/buildbot/bin/python'} 06:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:12 INFO - Running setup.py (path:/tmp/pip-k0JEQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:12 INFO - Running setup.py (path:/tmp/pip-2QEbsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:12 INFO - Running setup.py (path:/tmp/pip-B33EaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:12 INFO - Running setup.py (path:/tmp/pip-pmg1Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:12 INFO - Running setup.py (path:/tmp/pip-giZCwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:12 INFO - Running setup.py (path:/tmp/pip-eZa1EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:12 INFO - Running setup.py (path:/tmp/pip-fZaYEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:12 INFO - Running setup.py (path:/tmp/pip-1WDbBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:12 INFO - Running setup.py (path:/tmp/pip-3eYuIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:12 INFO - Running setup.py (path:/tmp/pip-qrQpbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:12 INFO - Running setup.py (path:/tmp/pip-DJGs57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:12 INFO - Running setup.py (path:/tmp/pip-a7Hppm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:12 INFO - Running setup.py (path:/tmp/pip-sl4O0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:13 INFO - Running setup.py (path:/tmp/pip-OWiWXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:13 INFO - Running setup.py (path:/tmp/pip-iE17Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:13 INFO - Running setup.py (path:/tmp/pip-Z9Xzm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:13 INFO - Running setup.py (path:/tmp/pip-pSN2ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:13 INFO - Running setup.py install for manifestparser 06:05:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Running setup.py install for mozcrash 06:05:13 INFO - Running setup.py install for mozdebug 06:05:13 INFO - Running setup.py install for mozdevice 06:05:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Running setup.py install for mozfile 06:05:13 INFO - Running setup.py install for mozhttpd 06:05:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:13 INFO - Running setup.py install for mozinfo 06:05:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Running setup.py install for mozInstall 06:05:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Running setup.py install for mozleak 06:05:14 INFO - Running setup.py install for mozlog 06:05:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Running setup.py install for moznetwork 06:05:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Running setup.py install for mozprocess 06:05:14 INFO - Running setup.py install for mozprofile 06:05:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Running setup.py install for mozrunner 06:05:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:14 INFO - Running setup.py install for mozscreenshot 06:05:14 INFO - Running setup.py install for moztest 06:05:14 INFO - Running setup.py install for mozversion 06:05:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:15 INFO - Cleaning up... 06:05:15 INFO - Return code: 0 06:05:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:15 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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 06:05:15 INFO - 'HOME': '/home/cltbld', 06:05:15 INFO - 'LANG': 'en_US.UTF-8', 06:05:15 INFO - 'LANGUAGE': 'en_US:en', 06:05:15 INFO - 'LOGNAME': 'cltbld', 06:05:15 INFO - 'MAIL': '/var/mail/cltbld', 06:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:15 INFO - 'MOZ_NO_REMOTE': '1', 06:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:15 INFO - 'NO_EM_RESTART': '1', 06:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:15 INFO - 'PWD': '/builds/slave/test', 06:05:15 INFO - 'SHELL': '/bin/bash', 06:05:15 INFO - 'SHLVL': '1', 06:05:15 INFO - 'TERM': 'linux', 06:05:15 INFO - 'TMOUT': '86400', 06:05:15 INFO - 'USER': 'cltbld', 06:05:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:15 INFO - '_': '/tools/buildbot/bin/python'} 06:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:15 INFO - Running setup.py (path:/tmp/pip-G7H4xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:15 INFO - Running setup.py (path:/tmp/pip-ijhq5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:15 INFO - Running setup.py (path:/tmp/pip-KbPgK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:15 INFO - Running setup.py (path:/tmp/pip-OBM1X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:15 INFO - Running setup.py (path:/tmp/pip-Jf8D6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:15 INFO - Running setup.py (path:/tmp/pip-DjHipD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:15 INFO - Running setup.py (path:/tmp/pip-kEpAGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:15 INFO - Running setup.py (path:/tmp/pip-oTgRuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:15 INFO - Running setup.py (path:/tmp/pip-dogWNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:15 INFO - Running setup.py (path:/tmp/pip-kOixFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:16 INFO - Running setup.py (path:/tmp/pip-U5uaWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:16 INFO - Running setup.py (path:/tmp/pip-xE_rAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:16 INFO - Running setup.py (path:/tmp/pip-Bd5v6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:16 INFO - Running setup.py (path:/tmp/pip-meiIgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:16 INFO - Running setup.py (path:/tmp/pip-UNx9mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:16 INFO - Running setup.py (path:/tmp/pip-3lyJ2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:16 INFO - Running setup.py (path:/tmp/pip-T36QCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:16 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:16 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:16 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:16 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:16 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:16 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:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:16 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:16 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:16 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:16 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:16 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:16 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 - Downloading blessings-1.6.tar.gz 06:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:05:18 INFO - Installing collected packages: blessings 06:05:18 INFO - Running setup.py install for blessings 06:05:18 INFO - Successfully installed blessings 06:05:18 INFO - Cleaning up... 06:05:18 INFO - Return code: 0 06:05:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:18 INFO - Reading from file tmpfile_stdout 06:05:18 INFO - Current package versions: 06:05:18 INFO - argparse == 1.2.1 06:05:18 INFO - blessings == 1.6 06:05:18 INFO - blobuploader == 1.2.4 06:05:18 INFO - docopt == 0.6.1 06:05:18 INFO - manifestparser == 1.1 06:05:18 INFO - mozInstall == 1.12 06:05:18 INFO - mozcrash == 0.17 06:05:18 INFO - mozdebug == 0.1 06:05:18 INFO - mozdevice == 0.48 06:05:18 INFO - mozfile == 1.2 06:05:18 INFO - mozhttpd == 0.7 06:05:18 INFO - mozinfo == 0.9 06:05:18 INFO - mozleak == 0.1 06:05:18 INFO - mozlog == 3.1 06:05:18 INFO - moznetwork == 0.27 06:05:18 INFO - mozprocess == 0.22 06:05:18 INFO - mozprofile == 0.28 06:05:18 INFO - mozrunner == 6.11 06:05:18 INFO - mozscreenshot == 0.1 06:05:18 INFO - mozsystemmonitor == 0.0 06:05:18 INFO - moztest == 0.7 06:05:18 INFO - mozversion == 1.4 06:05:18 INFO - psutil == 3.1.1 06:05:18 INFO - requests == 1.2.3 06:05:18 INFO - wsgiref == 0.1.2 06:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:18 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:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:18 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:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:18 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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:18 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:18 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:18 INFO - Using env: {'DISPLAY': ':0', 06:05:18 INFO - 'HOME': '/home/cltbld', 06:05:18 INFO - 'LANG': 'en_US.UTF-8', 06:05:18 INFO - 'LANGUAGE': 'en_US:en', 06:05:18 INFO - 'LOGNAME': 'cltbld', 06:05:18 INFO - 'MAIL': '/var/mail/cltbld', 06:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:18 INFO - 'MOZ_NO_REMOTE': '1', 06:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:18 INFO - 'NO_EM_RESTART': '1', 06:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:18 INFO - 'PWD': '/builds/slave/test', 06:05:18 INFO - 'SHELL': '/bin/bash', 06:05:18 INFO - 'SHLVL': '1', 06:05:18 INFO - 'TERM': 'linux', 06:05:18 INFO - 'TMOUT': '86400', 06:05:18 INFO - 'USER': 'cltbld', 06:05:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:18 INFO - '_': '/tools/buildbot/bin/python'} 06:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Cleaning up... 06:05:19 INFO - Return code: 0 06:05:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:19 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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 06:05:19 INFO - 'HOME': '/home/cltbld', 06:05:19 INFO - 'LANG': 'en_US.UTF-8', 06:05:19 INFO - 'LANGUAGE': 'en_US:en', 06:05:19 INFO - 'LOGNAME': 'cltbld', 06:05:19 INFO - 'MAIL': '/var/mail/cltbld', 06:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:19 INFO - 'MOZ_NO_REMOTE': '1', 06:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:19 INFO - 'NO_EM_RESTART': '1', 06:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:19 INFO - 'PWD': '/builds/slave/test', 06:05:19 INFO - 'SHELL': '/bin/bash', 06:05:19 INFO - 'SHLVL': '1', 06:05:19 INFO - 'TERM': 'linux', 06:05:19 INFO - 'TMOUT': '86400', 06:05:19 INFO - 'USER': 'cltbld', 06:05:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:19 INFO - '_': '/tools/buildbot/bin/python'} 06:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:19 INFO - Downloading/unpacking jsonschema 06:05:19 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:19 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:19 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:19 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:19 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:19 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:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:21 INFO - Downloading/unpacking functools32 (from jsonschema) 06:05:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:21 INFO - warning: no files found matching '*.txt' 06:05:21 INFO - no previously-included directories found matching 'build' 06:05:21 INFO - no previously-included directories found matching 'dist' 06:05:21 INFO - no previously-included directories found matching '.git*' 06:05:21 INFO - Installing collected packages: jsonschema, functools32 06:05:21 INFO - Running setup.py install for functools32 06:05:21 INFO - warning: no files found matching '*.txt' 06:05:21 INFO - no previously-included directories found matching 'build' 06:05:21 INFO - no previously-included directories found matching 'dist' 06:05:21 INFO - no previously-included directories found matching '.git*' 06:05:21 INFO - Successfully installed jsonschema functools32 06:05:21 INFO - Cleaning up... 06:05:21 INFO - Return code: 0 06:05:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:21 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 0x7f765ddeff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', '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:21 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:21 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:21 INFO - Using env: {'DISPLAY': ':0', 06:05:21 INFO - 'HOME': '/home/cltbld', 06:05:21 INFO - 'LANG': 'en_US.UTF-8', 06:05:21 INFO - 'LANGUAGE': 'en_US:en', 06:05:21 INFO - 'LOGNAME': 'cltbld', 06:05:21 INFO - 'MAIL': '/var/mail/cltbld', 06:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:21 INFO - 'MOZ_NO_REMOTE': '1', 06:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:21 INFO - 'NO_EM_RESTART': '1', 06:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:21 INFO - 'PWD': '/builds/slave/test', 06:05:21 INFO - 'SHELL': '/bin/bash', 06:05:21 INFO - 'SHLVL': '1', 06:05:21 INFO - 'TERM': 'linux', 06:05:21 INFO - 'TMOUT': '86400', 06:05:21 INFO - 'USER': 'cltbld', 06:05:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:21 INFO - '_': '/tools/buildbot/bin/python'} 06:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:21 INFO - Downloading/unpacking flake8 06:05:21 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:21 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:21 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:21 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:21 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:21 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 flake8-2.5.0-py2.py3-none-any.whl 06:05:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (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 - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:05:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (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:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:05:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:24 INFO - no previously-included directories found matching 'docs/_build' 06:05:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:05:24 INFO - Running setup.py install for pep8 06:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:24 INFO - no previously-included directories found matching 'docs/_build' 06:05:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:05:24 INFO - Cleaning up... 06:05:24 INFO - Return code: 0 06:05:24 INFO - Running post-action listener: _resource_record_post_action 06:05:24 INFO - Running post-action listener: _start_resource_monitoring 06:05:24 INFO - Starting resource monitoring. 06:05:24 INFO - ##### 06:05:24 INFO - ##### Running install step. 06:05:24 INFO - ##### 06:05:24 INFO - Running pre-action listener: _resource_record_pre_action 06:05:24 INFO - Running main action method: install 06:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:24 INFO - Reading from file tmpfile_stdout 06:05:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:25 INFO - Reading from file tmpfile_stdout 06:05:25 INFO - Output received: 06:05:25 INFO - Usage: mozinstall [options] installer 06:05:25 INFO - Options: 06:05:25 INFO - -h, --help show this help message and exit 06:05:25 INFO - -d DEST, --destination=DEST 06:05:25 INFO - Directory to install application into. [default: 06:05:25 INFO - "/builds/slave/test"] 06:05:25 INFO - --app=APP Application being installed. [default: firefox] 06:05:25 INFO - mkdir: /builds/slave/test/build/application 06:05:25 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:25 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:38 INFO - Reading from file tmpfile_stdout 06:05:38 INFO - Output received: 06:05:38 INFO - /builds/slave/test/build/application/firefox/firefox 06:05:38 INFO - Running post-action listener: _resource_record_post_action 06:05:38 INFO - ##### 06:05:38 INFO - ##### Running run-tests step. 06:05:38 INFO - ##### 06:05:38 INFO - Running pre-action listener: _resource_record_pre_action 06:05:38 INFO - Running main action method: run_tests 06:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:38 INFO - Python 2.7.3 06:05:38 INFO - Return code: 0 06:05:38 INFO - grabbing minidump binary from tooltool 06:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:38 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 0x25ee410>, '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 0x25ef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ef7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:38 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:38 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:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:38 INFO - Return code: 0 06:05:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:05:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:05:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:05:39 INFO - Return code: 0 06:05:39 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-e10s', '--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-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:05:39 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-e10s --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-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:05:39 INFO - Using env: {'DISPLAY': ':0', 06:05:39 INFO - 'HOME': '/home/cltbld', 06:05:39 INFO - 'LANG': 'en_US.UTF-8', 06:05:39 INFO - 'LANGUAGE': 'en_US:en', 06:05:39 INFO - 'LOGNAME': 'cltbld', 06:05:39 INFO - 'MAIL': '/var/mail/cltbld', 06:05:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:39 INFO - 'MOZ_NO_REMOTE': '1', 06:05:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:39 INFO - 'NO_EM_RESTART': '1', 06:05:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:39 INFO - 'PWD': '/builds/slave/test', 06:05:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:39 INFO - 'SHELL': '/bin/bash', 06:05:39 INFO - 'SHLVL': '1', 06:05:39 INFO - 'TERM': 'linux', 06:05:39 INFO - 'TMOUT': '86400', 06:05:39 INFO - 'USER': 'cltbld', 06:05:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111', 06:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:39 INFO - '_': '/tools/buildbot/bin/python'} 06:05:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--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-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:05:39 INFO - mozversion application_buildid: 20160624143557 06:05:39 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:05:39 INFO - mozversion application_display_name: Firefox 06:05:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:39 INFO - mozversion application_name: Firefox 06:05:39 INFO - mozversion application_remotingname: firefox 06:05:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:05:39 INFO - mozversion application_vendor: Mozilla 06:05:39 INFO - mozversion application_version: 48.0 06:05:39 INFO - mozversion platform_buildid: 20160624143557 06:05:39 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 06:05:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:05:39 INFO - mozversion platform_version: 48.0 06:05:39 INFO - using testdate: 1467032739 06:05:39 INFO - actual date: 1467032739 06:05:39 INFO - starting webserver on 'localhost:43273' 06:05:39 INFO - SUITE-START | Running 2 tests 06:05:39 INFO - TEST-START | dromaeo_css 06:05:39 INFO - operating with platform_type : linux_ 06:05:39 INFO - Initialising browser for dromaeo_css test... 06:05:39 INFO - TEST-INFO | started process 13220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpssAzXV/profile http://localhost:43273/getInfo.html) 06:05:43 INFO - PROCESS | 13220 | 06:05:43 INFO - PROCESS | 13220 | (process:13296): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:05:44 INFO - PROCESS | 13220 | __metrics Screen width/height:1600/1200 06:05:44 INFO - PROCESS | 13220 | colorDepth:24 06:05:44 INFO - PROCESS | 13220 | Browser inner width/height: 1024/697 06:05:44 INFO - PROCESS | 13220 | __metrics 06:05:44 ERROR - PROCESS | 13220 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:05:45 INFO - TEST-INFO | 13220: exit 0 06:05:45 INFO - Browser initialized. 06:05:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:45 INFO - TEST-INFO | started process 13346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpssAzXV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:47 INFO - PROCESS | 13346 | 06:05:47 INFO - PROCESS | 13346 | (process:13411): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:05:57 INFO - PROCESS | 13346 | RSS: Main: 150114304 06:05:57 INFO - PROCESS | 13346 | 06:06:46 INFO - PROCESS | 13346 | 1467032806891 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:54 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:43273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43273/tests/dromaeo/cssquery-ext.html) 06:08:55 INFO - PROCESS | 13346 | RSS: Main: 155353088 06:08:55 INFO - PROCESS | 13346 | 06:11:57 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:43273/tests/dromaeo/cssquery-ext.html (next: http://localhost:43273/tests/dromaeo/cssquery-jquery.html) 06:11:57 INFO - PROCESS | 13346 | RSS: Main: 152469504 06:11:57 INFO - PROCESS | 13346 | 06:14:59 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:43273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43273/tests/dromaeo/cssquery-mootools.html) 06:15:00 INFO - PROCESS | 13346 | RSS: Main: 151867392 06:15:00 INFO - PROCESS | 13346 | 06:18:01 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:43273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43273/tests/dromaeo/cssquery-prototype.html) 06:18:02 INFO - PROCESS | 13346 | RSS: Main: 153513984 06:18:02 INFO - PROCESS | 13346 | 06:21:04 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:43273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43273/tests/dromaeo/cssquery-yui.html) 06:21:05 INFO - PROCESS | 13346 | RSS: Main: 151588864 06:21:05 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:43273/tests/dromaeo/cssquery-yui.html (next: http://localhost:43273/tests/dromaeo/cssquery-dojo.html) 06:24:07 INFO - PROCESS | 13346 | RSS: Main: 155246592 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | __start_tp_report 06:24:07 INFO - PROCESS | 13346 | _x_x_mozilla_page_load 06:24:07 INFO - PROCESS | 13346 | _x_x_mozilla_page_load_details 06:24:07 INFO - PROCESS | 13346 | |i|pagename|runs| 06:24:07 INFO - PROCESS | 13346 | |0;dojo.html;3277.0824169232615;3332.083676988829;3349.715274201692;3390.9152271193216;3393.7115345195657;5515.448455154493;5522.530584900283;5527.281453411056;5532.612717109804;5532.944670553294;5511.035568775468;5525.4474552544825;5578.30271216098;5583.888322233553;5588.972055139719;5027.547520723143;5057.620678449112;5067.1385864402955;5077.822276220333;5131.025105229995;4968.254761785725;5032.6477146599755;5078.365204349457;5135.512126347991;5182.792688292464;5073.1122053640465;5115.053715062707;5163.896722065557;5173;5178.6116041297055;5089.440161582223;5100.566451851579;5115.795368185268;5117;5138.948610513884;4913.434954980187;4956.4547899731;5023.070731914608;5052.9242061369105;5108.4125325587665;5267.26258323835;5324.41431442541;5330.786768529254;5339.893202135974;5401.972990135064;5816.1275808628625;5823.38854420284;5831.154482599999;5834.795782147647;5844.970775146139;5791.131330300446;5901.409859014064;5910.852228694274;5996.520278377763;6023.156758053876;5529.529989950899;5542.501174894279;5558.749856256478;5559.138333558305;5570.275864137677;5966.284045914431;6006.609570377911;6019.69901504923;6032.3967603239325;6035.155078289043;5618.297712785902;5771.5671324649975;5820.214271073435;5830.2129212555765;5881.647101173943;5865.94134058654;5894.115882617556;5903.3801450847905;5904.409559044061;5904.822855314347;5854.151148083504;5854.151148083589;5854.619449735754;5859.501942334864;5864.882702346014;5753.223314852441;5887.61730487517;5928.881422371528;5941.821745347646;5974.074018527135;4495.415595972568;4496.6177874881005;4527.049319642846;4527.909441811145;4557.931631025537;4037.6366127048705;4070.715049946475;4081.551029386765;4094.8976275592754;4111.342185250345;5608.4111168326735;5646.068398714248;5689.6586204827845;5692.260006199251;5730.828075157752;5940.198073260054;5946.405359464019;5963.5825492216;5980.162777211194;5984.7606095756555;5624.943750562442;5699.572532060112;5721.313442386857;5726.685032323262;5728.742206600713;5069.569086627678;5083.415407228216;5083.517065878736;5087;5114.130597798383;6148.077788331697;6178.196834411498;6192.938070619236;6196.783112591038;6208.068789681493;5751.884962300815;5911.201987731602;5926.644401335933;5989.431004054521;5992.64044157352;6113.537117903944;6115.909724157069;6121.148138557471;6122.316751643488;6128.567224186975;5791.044477661138;5793.594448388572;5801.912971305349;5804.361520232856;5873.03094989339;5703.201551782837;5893.2044174035955;5967.582269241111;6033.5173186145885;6042.0936859469675;5752.942470575241;5756.079027355603;5757.683327417032;5759.0785474325585;5779.826605201851;5695.943040569541;5742.885142297047;5746.396628353963;5747.8563035924435;5763.164341170423;5416.539594134385;5676;5707.914381284201;5712.428757124254;5745.597808153556;5815.680137592473;5831.562632802472;5838.970805145947;5843.532517398513;5866.472017518444;5603.971980140073;5734.913976290442;5736.827895163152;5737.971310143423;5740.253767010429 06:24:07 INFO - PROCESS | 13346 | |1;ext.html;657.3951964192942;675.3853992866491;685.3249549194046;731.2285538756616;746.6042997211476;39265.411018834704;39977.40033899486;40258.39612405816;40376.79811600941;40401.59598404015;42153.15693686132;42803.14393712124;42828.143437131235;42904.785476072655;42979;8830.293576513879;9009.144131307516;9009.189172974431;9016.639334426614;9033.051529589397;8717.738467845944;8800.251978581797;8805.20753132218;8809.251213646849;8823.470591764482;9064.728058158233;9197.21823644991;9213.2168765655;9224.769380765467;9231;9088.636454541811;9126.45241285525;9179.586918588613;9190.172884440366;9190.586423610954;9119.179273865384;9202.033786452394;9215;9218.308626852946;9244.815103697889;43652.56347436517;44027.33958990618;44183.33724994128;44215;44307.55692443067;3984.123492831601;4034.798260086984;4123.092919557693;4412.470503539564;4722.693024953367;32322.6767732322;32821.507677384856;33010.17474563155;33168;33695.83152084248;4378.934315985231;4410.6030457259;4443.204686285845;4464.575865292824;4493.752843593634;320601;321554;322999;323858;324769;61843;62263;62650.686746565974;62662.373376266565;62836.68581657154;65411;69688;70785;70805.64597176982;70990;18237.45287641373;18279;18387.72418413725;18394.356197533023;18442.26230950747;14077.296135193199;14161.575152745434;14171.78742318866;14177.574672759834;14208.502702405367;20189.293374731813;20242.898785506273;20263;20378.79621203769;20429;8014.559199243981;8090.312323452455;8147.551884646283;8248.54632995179;8307.335413166933;1054.3515737821185;1102.8290614954694;1120.815065514181;1121.1311233793874;1167.7606090751376;34430.13924651904;35117.64882351195;35257.82371088128;37604.24791504209;39041.609583903795;1204.5964601858475;1233.5620854596668;1256.4974010395915;1286.4018231522386;1311.5737385349798;16550.916739423792;16555.91722041382;16596.004239745653;16815;16874.74687879683;506748;513128;840082;856247;866298;63853;65034.34965650378;65106;65213;65425.67287163534;1539.5227479481396;1554.8211955625022;1557.540525544967;1570.583795294248;1683.6632673465356;32902.506462402605;33115.50326745053;33513;33910.83044584761;34342.65657343494;53911.730441349115;54570.18144727753;54664.180037298676;54703.72648136734;54795.726021369635;439439;440778;441966;442141;442785;31401.37197256088;31571.842140790068;31684.524732128575;31708.20729481689;31920.52119218167;48934.26598600952;49580.25629615487;49946.75026624989;50501.49498505115;51077.74461127671;41293.58706412897;42807.57192428036;42935;43147.56852431561;43266.35100473432;41036.58963410328;41107;41694.16611667689;42345.576544235395;42675.35986960136;43136.35295470508;43648;44060.33909491296;44205.336919945585;44516;36648.52497660001;37349.62650373462;37363.2527349446;37612.62387376201;38465;28795.28011799722;29297.7070229295;29511.967081152055;29593.112206633836;29805.850970745007 06:24:07 INFO - PROCESS | 13346 | |2;jquery.html;418.69435312222095;419.2934904685603;422.1156676762184;426.7588812321038;433.7939478747595;18826.34107806227;19359.806401935977;19565.902170489164;19601.901990490045;20115.396538103843;12375.44310506027;12857.614271571845;12919.741605167914;19895.900520497376;20089;5355.357357117151;5482.725863706819;5492.670439773607;5494.697791621459;5512.310961129859;5439.728013599324;5938.52491800657;5944.078667806497;5963.731632076545;5970.850728731773;5856.150858125569;5860.501857342131;5862.443067908542;5894.410558944092;5907.172995780594;5496.367917689477;5526.834194974157;5531.225628412026;5557.305336832896;5562.9443705562835;5358.4641535846495;5396;5399.892002159974;5401.70290634015;5408.296921400193;19990.500237494034;24264.878675606684;24587;24900.875495622586;24947.87526062376;2492.1651246832334;2530.607755797854;2533.5819589767666;2603.4669931740814;2607.4524349886547;10475.895241047569;10691.78616427675;10920.235583509157;10950.123990080774;11199;2022.3932820153896;2132.818710409617;2162.978370216309;2165.3936897668677;2197.099189332366;79482;80675.5966220171;80739;81799;83511;11644.475998580085;11759.412029398496;11833.585824496102;11963.222390544586;12039.578614748618;16658.916705416395;16687.249073791707;16739.748903766453;16791.160441977852;16820.158992050594;8938.329625278;9015.504147271831;9016.413933094327;9018.774530636656;9106.726798196065;8617;8874.689385871463;8890.377673562789;8905.243054340324;8936.553172341357;5084.847454576368;5118.897622047538;5134.229865520202;5165.225216217597;5240.663630774205;1919.3666090190204;1979.5051237190703;2015.2543558883308;2069;2107.589020141058;1023.7645341571331;1078.9676309710721;1124.8818874018275;1151.0791366906442;1203.6328919679581;19038.80961190398;19976.800231997786;20111.497212569804;20127.194912203642;20139.49651258701;1070.9250352475408;1074.6131392698621;1083.7019819549687;1105.4362275239685;1126.4480404601686;10864.402457864735;11057.22599418033;11155.609553665583;11188.944055279835;11197.832032519518;375276;379806;381055;518799;519251;95662.9999999986;97020.51489742506;98539;99962.50018750005;101105.49447252716;1179.0744265751343;1193.5524178433088;1201.333260040686;1202.1705023533734;1223.253815172744;18114.818851811313;18115.55599810767;18285.26858925628;18288.90855545714;18347.266109355478;40177.59822401738;40773;40849.59150408458;40927.59072409238;42326.788366057976;58860.411395885494;59126.704366479615;59127.70436147792;59551.702241488514;59726;9020.233280170996;9027.864582031143;9049.366544341832;9076.500792456214;9269.490178040272;9861.211103111877;13195.406206720912;13323.600291991255;13494.392752326365;13630.795538066739;11547.4803633835;11622.82565761531;11832.17174797756;11914.642560723192;11965.820512692491;11583.131265155316;11642.476088575864;11777.352245626573;11850.229735067192;12033.338166400932;11763.941180294043;12089.879101209228;12170.756584868075;12339.75320493603;12775.425105870445;9009.684661036832;9039.322050846082;9056.27549796028;12566.246025238515;13630.454781808616;12829.87170128324;12927.741445171232;13033.15284506504;13301.933490332873;13643.249621270925 06:24:07 INFO - PROCESS | 13346 | |3;mootools.html;1615.5961009747564;1623.5941014746313;1853.2586965213914;1948.454432758828;1958.7551556055494;7219.747308844191;8084.514929104258;8206.261436470724;8256.711015114479;8277.379196560267;8178.550179740112;8420.494770313786;8434.620442080106;8550.95724521378;8678.132186781319;2436.5979613363775;2452.9509409811794;2460.372604985726;2468.5926822074334;2473.468204336067;2427.283951234381;2463.556559819232;2483.4163971466783;2483.913063042794;2488.738682438345;2440.2679196241147;2445.205308274818;2448.3634255093625;2450.019992003195;2453.8405003674793;2450.901963921441;2481.0944005438064;2482.466269751994;2490.3898544856447;2499.575072237724;2443.5357282116343;2487.601983682602;2500.6999160100904;2501.387160145776;2511.598144296922;8644.135586441369;8676.436031657986;8680.739577812676;8700.912990870074;8701;5367.060764366221;5432.75552600134;5501.9174712379345;5511.035568775448;5511.173324001392;3622.492851000862;3652.908677283089;3714.7771133732062;3806.7906265155407;3809.8857034289017;1161.3960740414936;1166.8716441191461;1174.2426135142784;1191.2316555821533;1201.1051766433975;12035.09736769737;12035.39823008846;12040.999999999913;12065.879341206652;12103.515859365614;4582.358469814229;4603.4475862896;4634.83778067766;4670.065986802653;4713.057388522309;9557.665481708107;9562.521873906277;9570.521473926276;9597.28020398459;9604.183644390165;5336.279602253724;5368.32895888014;5369.140937449989;5381.273528073738;5395.406505284415;4703.764811759467;4842.539958703917;4910.042541704333;4914.33656456381;5002.824901128516;3896.9610303897166;3944.3886197639413;3944.585818489017;3971.185906889081;4009.1179940413062;1189.6312143235625;1191.4281145050425;1195.1693572966878;1198.9460474278503;1245.3835351501066;1044.6604853422668;1047.0367262118868;1057.8836328003913;1068.9251752377415;1075.1130317488103;5774.249347584787;5909.2908850938165;5909.911351329733;6036.3360030396625;6038.607490513103;1095.4686976816238;1115.6151127860876;1144.4792619358338;1187.4359679152506;1207.9154459187948;4072.9389059164137;4152.501699796044;4168.6039826216465;4224.4508213931995;4224.471941007374;10517.631882884216;10804.945975270073;10822.40476773785;10869.565217391215;10922.617708380327;10686.14510839131;10693.679189624323;10748.570057197781;10758.892411075945;10761.730956726144;8348.415610907177;8371.037330707046;8432.283255923192;8456.112108228548;8462.069172391031;5848.678322692293;5873.295204575478;5916;5934.228550288435;6020.54845886569;9226.40028398152;9295;9301.116393942564;9353.906460935303;9439.103285187895;9247.491387973727;9502.287328450531;9682.9031709682;9817.656382026595;9864.753381165528;7179.569225846466;7300.817479563053;7330.926690733025;7741.612919353897;7797.92202077972;7996.24035716606;8011.679532818622;8023;8043.557604331818;8118.715844945635;7092.397146242627;7333.853322933404;7340.302671246223;7376.151742549461;7465.253474652492;7145.21402645719;7168.677409516688;7255.818604534928;7273.054502914587;7361.30067643573;6717.966410168114;6801.2178599461695;6823.69293381809;6826.692798823966;6840.692168852314;5121.257417674491;5123.436421993652;5134.768935397841;5252.868678283074;5268.947310526845;5127.077126117335;5149.201873709581;5307.150855863043;5351.785928562814;5352.518273355417 06:24:07 INFO - PROCESS | 13346 | |4;prototype.html;351.4815646920792;352.9470579413088;359.4320972862876;362.7315786318125;366.4210547335211;6402.583832050925;6434.935650643504;6499.480041596673;6538.313477084903;6583.144191255136;6496;6508.9674551627295;6533.118029066075;6535;6548.246951600568;4919.532644398794;4964.5531902128805;4969.975150124263;4972.726500042496;4980.103581355354;4975.975120124394;4982.57648099912;4984.87537811554;4990.75046247688;4992;4934.185859333224;4938.876528086791;4939.8024079036795;4953.331300274471;4959.826406075788;4695.3661255730385;4819.180739274332;4933.975330123362;4941.654084214107;4943.802247910079;4178.247915375231;4181.581841815794;4183.518895327046;4190.413342132104;4194.098268872177;6199.752009919598;6206.224221972254;6209.503239740855;6219.471344935686;6226.657533835637;5640.238567793336;5645.096784514458;5645.491905728504;5650.378458369576;5651.378348381675;6800.217974932896;6807.795766127024;6812.080369150151;6816;6824.4199243064395;4584.541545845422;4605.562471565196;4655.092257009885;4660.790264438108;4671.813127474897;7094.645267736644;7150.642467876637;7160.570365778018;7167.211606723308;7181.210066892638;4726.125666751662;4736.478987311462;4745.667803253808;4760.166970780169;4762.9523704763205;4825.131476334223;4828.830990915301;4830.154722923475;4833.782479788418;4837.05677392912;5619.971900140473;5626.662400255916;5632.070708333079;5634.971825140848;5635.408282130399;6732.259451460335;6885.483588730765;6895.034695142684;6898.862022759517;6912.135983002125;1669.3906724045637;1678.0686718871143;1678.4125556055526;1689.5184872311331;1702.8978261304114;1074.2802322443981;1075.0754351257913;1095.775366049958;1100.0869278498988;1108.817045187535;6543.280239173687;6665.433438157811;6670.83322916931;6675.566088204251;6677;6971.965140174369;7019;7026.297370263035;7027.61348125858;7035.824104397431;6640.335966403418;6642.103316052271;6647.634380109141;6652.833679157963;6654.86690266192;3763.6048214937587;3806.352920003606;3813.3136035513876;3813.4470501777087;3814.4278358246484;7174.282571742784;7349.669264883093;7352.11774587053;7354.338109570057;7363.521371110968;7103.650306441863;7117.679704413314;7132.251113633098;7158.713651453988;7170.820729481805;7264.237255088246;7292.854142917112;7325.084364454443;7328;7338.926610733824;7014.438844892295;7026.8945965809535;7036.964815175891;7043.542169758949;7049.224585295716;6811.795646130624;7084.433245340463;7093.858122837618;7103.538270012433;7105.32499412555;7502.287282708352;7512.5492470451945;7521.435892307989;7534;7537.585432801029;4699.295105734031;4739.834105806281;4748.501407352178;4765.571098601143;4772.5227477252;7133.2153463117975;7145.4640901931525;7145.4998150128995;7149.928500715135;7158.8926166108595;6766.763163289262;6878.518503704692;6917;6939.722411103499;6943.097397338313;6863.519553631198;6874.175098988154;6886.965565172142;6914.654267286716;6943.895841562482;6748.021536877223;6792.252852186157;6794.626295553594;6803.795886123424;6806.421454176252;6841.3842754152365;6976.267491913479;6982.057422247932;6998.16022077354;7003.439724822104;6632.1098486931;6822.795316140524;6829.180498340231;6830.351116643911;6832.555883867532 06:24:07 INFO - PROCESS | 13346 | |5;yui.html;925.504854902627;933.36531158812;953.6185525789688;966.9951650241748;980.8822941247051;15127.697446051072;15132.697346053072;15167.54497365078;15265.771013434793;15635.218239088043;14483.34824932878;14521.346539405726;14533.418663253457;14541.78187327191;14575.489857854976;743.2233316184573;899.698600968673;933;936.69089200564;937.976550586234;924.089771574998;929.6746138851415;930.2279108340061;932.8367535681263;934.7990182110844;979.8530220466952;982.6560703753664;982.8181786369508;984.2765567308023;986.4771671014338;968.2157452463528;973.3235401396032;974.3569244298765;978.0757184460688;981.2983716642599;714.9821254468628;715.2882881532908;718.6909628859588;719.0149495191569;722.5303552690741;15248.085114893142;15255.771163432557;15295.923520382437;15369.462068827537;15385.769213461806;15291.694166116728;15347.923260383739;15450.99568528042;15550.76673849893;15571.766423503657;12299.631011069681;12304.876951230463;12420.192687475284;12429.627111186588;12432.813507797391;4049.7975101245115;4051.6353528182312;4086.4891888513935;4132.772697501636;4178.582141785797;56821.71589142028;58650.70674646642;58816.70591647057;58867.11699324471;59247;11412.087033037336;11668.299902005907;11767.823482647767;11846.052315814713;12091;20604.072816723285;20626.484337891372;20646;20678.483037924172;20680.48298792542;8891.288696904232;8920;9009.954950225338;9218.677346292847;9233.399829011092;5051.949480505222;5078.644494885397;5104.515071068243;5171.456997015334;5325.440828713007;3302.7522935779434;3350.5141754445467;3358.9832050840077;3360.1767566946255;3477.9304413912087;691.6126968897333;703.7044441334651;707.734599525178;711.8611870685166;713.875071862422;742.6806473216569;747.0512449189499;749.6439191384158;752.3943225703252;759.3735168486021;9483.620655173854;9595.465802442772;9637;9720.854187187198;9957.30298879086;642.1491523731075;673.1484671890063;683.3781259054236;707.5613119865613;753.88691696246;4454.354118652842;4520.0507893342765;4523.5024147343765;4587.7017993830295;4590.219662657356;67815;68812.65593672;69356;69454;69716.30283697098;58378.12432813511;58774;58801.41198588045;60081.09878351741;60238;52816.735916319405;53071.46928530742;53157.2026419604;53656.46343536593;53732.731336343066;8690.217880390795;8700;8835.381523293308;8918.821623567623;9057.686635437693;39446.21107577775;39609.40585891157;39964.800175998935;40055;41396.58603414048;47275;50094.24858627196;52371.21443178432;53829.46170538245;54122;13182.406791694206;13220.338983050617;13346.466141354626;13378.799318010042;13503.59489215325;13875.861241387456;14431.927840360731;14503.809161984347;14587.708245834812;14939.402423902922;13270.800937985745;13392.933035334761;13827.861721382658;14336.21150836714;14568.271586420424;13712.65718357049;13713.862861371259;13847;13898.23559704226;13948.511802086878;13387.531436399679;13519.797203042159;13837.169769813843;13882.375293112036;14294.213818239681;11291.153163512934;11341;11416.657500275005;11628.244164129304;12007.639770806889;11668;11718.121140914294;11756.412179391167;11766;11941.701457463632 06:24:07 INFO - PROCESS | 13346 | __end_tp_report 06:24:07 INFO - PROCESS | 13346 | __start_cc_report 06:24:07 INFO - PROCESS | 13346 | _x_x_mozilla_cycle_collect,327 06:24:07 INFO - PROCESS | 13346 | __end_cc_report 06:24:07 INFO - PROCESS | 13346 | __startTimestamp1467033847632__endTimestamp 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | ------- Summary: start ------- 06:24:07 INFO - PROCESS | 13346 | Number of tests: 6 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | [#0] dojo.html Cycles:165 Average:5503.64 Median:5730.83 stddev:598.47 (10.4%) stddev-sans-first:574.26 06:24:07 INFO - PROCESS | 13346 | Values: 3277.1 3332.1 3349.7 3390.9 3393.7 5515.4 5522.5 5527.3 5532.6 5532.9 5511.0 5525.4 5578.3 5583.9 5589.0 5027.5 5057.6 5067.1 5077.8 5131.0 4968.3 5032.6 5078.4 5135.5 5182.8 5073.1 5115.1 5163.9 5173.0 5178.6 5089.4 5100.6 5115.8 5117.0 5138.9 4913.4 4956.5 5023.1 5052.9 5108.4 5267.3 5324.4 5330.8 5339.9 5402.0 5816.1 5823.4 5831.2 5834.8 5845.0 5791.1 5901.4 5910.9 5996.5 6023.2 5529.5 5542.5 5558.7 5559.1 5570.3 5966.3 6006.6 6019.7 6032.4 6035.2 5618.3 5771.6 5820.2 5830.2 5881.6 5865.9 5894.1 5903.4 5904.4 5904.8 5854.2 5854.2 5854.6 5859.5 5864.9 5753.2 5887.6 5928.9 5941.8 5974.1 4495.4 4496.6 4527.0 4527.9 4557.9 4037.6 4070.7 4081.6 4094.9 4111.3 5608.4 5646.1 5689.7 5692.3 5730.8 5940.2 5946.4 5963.6 5980.2 5984.8 5624.9 5699.6 5721.3 5726.7 5728.7 5069.6 5083.4 5083.5 5087.0 5114.1 6148.1 6178.2 6192.9 6196.8 6208.1 5751.9 5911.2 5926.6 5989.4 5992.6 6113.5 6115.9 6121.1 6122.3 6128.6 5791.0 5793.6 5801.9 5804.4 5873.0 5703.2 5893.2 5967.6 6033.5 6042.1 5752.9 5756.1 5757.7 5759.1 5779.8 5695.9 5742.9 5746.4 5747.9 5763.2 5416.5 5676.0 5707.9 5712.4 5745.6 5815.7 5831.6 5839.0 5843.5 5866.5 5604.0 5734.9 5736.8 5738.0 5740.3 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | [#1] ext.html Cycles:180 Average:65974.28 Median:43057.68 stddev:142021.05 (329.8%) stddev-sans-first:142334.79 06:24:07 INFO - PROCESS | 13346 | Values: 657.4 675.4 685.3 731.2 746.6 39265.4 39977.4 40258.4 40376.8 40401.6 42153.2 42803.1 42828.1 42904.8 42979.0 8830.3 9009.1 9009.2 9016.6 9033.1 8717.7 8800.3 8805.2 8809.3 8823.5 9064.7 9197.2 9213.2 9224.8 9231.0 9088.6 9126.5 9179.6 9190.2 9190.6 9119.2 9202.0 9215.0 9218.3 9244.8 43652.6 44027.3 44183.3 44215.0 44307.6 3984.1 4034.8 4123.1 4412.5 4722.7 32322.7 32821.5 33010.2 33168.0 33695.8 4378.9 4410.6 4443.2 4464.6 4493.8 320601.0 321554.0 322999.0 323858.0 324769.0 61843.0 62263.0 62650.7 62662.4 62836.7 65411.0 69688.0 70785.0 70805.6 70990.0 18237.5 18279.0 18387.7 18394.4 18442.3 14077.3 14161.6 14171.8 14177.6 14208.5 20189.3 20242.9 20263.0 20378.8 20429.0 8014.6 8090.3 8147.6 8248.5 8307.3 1054.4 1102.8 1120.8 1121.1 1167.8 34430.1 35117.6 35257.8 37604.2 39041.6 1204.6 1233.6 1256.5 1286.4 1311.6 16550.9 16555.9 16596.0 16815.0 16874.7 506748.0 513128.0 840082.0 856247.0 866298.0 63853.0 65034.3 65106.0 65213.0 65425.7 1539.5 1554.8 1557.5 1570.6 1683.7 32902.5 33115.5 33513.0 33910.8 34342.7 53911.7 54570.2 54664.2 54703.7 54795.7 439439.0 440778.0 441966.0 442141.0 442785.0 31401.4 31571.8 31684.5 31708.2 31920.5 48934.3 49580.3 49946.8 50501.5 51077.7 41293.6 42807.6 42935.0 43147.6 43266.4 41036.6 41107.0 41694.2 42345.6 42675.4 43136.4 43648.0 44060.3 44205.3 44516.0 36648.5 37349.6 37363.3 37612.6 38465.0 28795.3 29297.7 29512.0 29593.1 29805.9 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | [#2] jquery.html Cycles:180 Average:27927.16 Median:2164.19 stddev:73071.48 (3376.4%) stddev-sans-first:73247.27 06:24:07 INFO - PROCESS | 13346 | Values: 418.7 419.3 422.1 426.8 433.8 18826.3 19359.8 19565.9 19601.9 20115.4 12375.4 12857.6 12919.7 19895.9 20089.0 5355.4 5482.7 5492.7 5494.7 5512.3 5439.7 5938.5 5944.1 5963.7 5970.9 5856.2 5860.5 5862.4 5894.4 5907.2 5496.4 5526.8 5531.2 5557.3 5562.9 5358.5 5396.0 5399.9 5401.7 5408.3 19990.5 24264.9 24587.0 24900.9 24947.9 2492.2 2530.6 2533.6 2603.5 2607.5 10475.9 10691.8 10920.2 10950.1 11199.0 2022.4 2132.8 2163.0 2165.4 2197.1 79482.0 80675.6 80739.0 81799.0 83511.0 11644.5 11759.4 11833.6 11963.2 12039.6 16658.9 16687.2 16739.7 16791.2 16820.2 8938.3 9015.5 9016.4 9018.8 9106.7 8617.0 8874.7 8890.4 8905.2 8936.6 5084.8 5118.9 5134.2 5165.2 5240.7 1919.4 1979.5 2015.3 2069.0 2107.6 1023.8 1079.0 1124.9 1151.1 1203.6 19038.8 19976.8 20111.5 20127.2 20139.5 1070.9 1074.6 1083.7 1105.4 1126.4 10864.4 11057.2 11155.6 11188.9 11197.8 375276.0 379806.0 381055.0 518799.0 519251.0 95663.0 97020.5 98539.0 99962.5 101105.5 1179.1 1193.6 1201.3 1202.2 1223.3 18114.8 18115.6 18285.3 18288.9 18347.3 40177.6 40773.0 40849.6 40927.6 42326.8 58860.4 59126.7 59127.7 59551.7 59726.0 9020.2 9027.9 9049.4 9076.5 9269.5 9861.2 13195.4 13323.6 13494.4 13630.8 11547.5 11622.8 11832.2 11914.6 11965.8 11583.1 11642.5 11777.4 11850.2 12033.3 11763.9 12089.9 12170.8 12339.8 12775.4 9009.7 9039.3 9056.3 12566.2 13630.5 12829.9 12927.7 13033.2 13301.9 13643.2 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | [#3] mootools.html Cycles:180 Average:5715.22 Median:5122.35 stddev:3089.44 (60.3%) stddev-sans-first:3082.74 06:24:07 INFO - PROCESS | 13346 | Values: 1615.6 1623.6 1853.3 1948.5 1958.8 7219.7 8084.5 8206.3 8256.7 8277.4 8178.6 8420.5 8434.6 8551.0 8678.1 2436.6 2453.0 2460.4 2468.6 2473.5 2427.3 2463.6 2483.4 2483.9 2488.7 2440.3 2445.2 2448.4 2450.0 2453.8 2450.9 2481.1 2482.5 2490.4 2499.6 2443.5 2487.6 2500.7 2501.4 2511.6 8644.1 8676.4 8680.7 8700.9 8701.0 5367.1 5432.8 5501.9 5511.0 5511.2 3622.5 3652.9 3714.8 3806.8 3809.9 1161.4 1166.9 1174.2 1191.2 1201.1 12035.1 12035.4 12041.0 12065.9 12103.5 4582.4 4603.4 4634.8 4670.1 4713.1 9557.7 9562.5 9570.5 9597.3 9604.2 5336.3 5368.3 5369.1 5381.3 5395.4 4703.8 4842.5 4910.0 4914.3 5002.8 3897.0 3944.4 3944.6 3971.2 4009.1 1189.6 1191.4 1195.2 1198.9 1245.4 1044.7 1047.0 1057.9 1068.9 1075.1 5774.2 5909.3 5909.9 6036.3 6038.6 1095.5 1115.6 1144.5 1187.4 1207.9 4072.9 4152.5 4168.6 4224.5 4224.5 10517.6 10804.9 10822.4 10869.6 10922.6 10686.1 10693.7 10748.6 10758.9 10761.7 8348.4 8371.0 8432.3 8456.1 8462.1 5848.7 5873.3 5916.0 5934.2 6020.5 9226.4 9295.0 9301.1 9353.9 9439.1 9247.5 9502.3 9682.9 9817.7 9864.8 7179.6 7300.8 7330.9 7741.6 7797.9 7996.2 8011.7 8023.0 8043.6 8118.7 7092.4 7333.9 7340.3 7376.2 7465.3 7145.2 7168.7 7255.8 7273.1 7361.3 6718.0 6801.2 6823.7 6826.7 6840.7 5121.3 5123.4 5134.8 5252.9 5268.9 5127.1 5149.2 5307.2 5351.8 5352.5 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | [#4] prototype.html Cycles:180 Average:5730.88 Median:6607.63 stddev:1758.68 (26.6%) stddev-sans-first:1716.64 06:24:07 INFO - PROCESS | 13346 | Values: 351.5 352.9 359.4 362.7 366.4 6402.6 6434.9 6499.5 6538.3 6583.1 6496.0 6509.0 6533.1 6535.0 6548.2 4919.5 4964.6 4970.0 4972.7 4980.1 4976.0 4982.6 4984.9 4990.8 4992.0 4934.2 4938.9 4939.8 4953.3 4959.8 4695.4 4819.2 4934.0 4941.7 4943.8 4178.2 4181.6 4183.5 4190.4 4194.1 6199.8 6206.2 6209.5 6219.5 6226.7 5640.2 5645.1 5645.5 5650.4 5651.4 6800.2 6807.8 6812.1 6816.0 6824.4 4584.5 4605.6 4655.1 4660.8 4671.8 7094.6 7150.6 7160.6 7167.2 7181.2 4726.1 4736.5 4745.7 4760.2 4763.0 4825.1 4828.8 4830.2 4833.8 4837.1 5620.0 5626.7 5632.1 5635.0 5635.4 6732.3 6885.5 6895.0 6898.9 6912.1 1669.4 1678.1 1678.4 1689.5 1702.9 1074.3 1075.1 1095.8 1100.1 1108.8 6543.3 6665.4 6670.8 6675.6 6677.0 6972.0 7019.0 7026.3 7027.6 7035.8 6640.3 6642.1 6647.6 6652.8 6654.9 3763.6 3806.4 3813.3 3813.4 3814.4 7174.3 7349.7 7352.1 7354.3 7363.5 7103.7 7117.7 7132.3 7158.7 7170.8 7264.2 7292.9 7325.1 7328.0 7338.9 7014.4 7026.9 7037.0 7043.5 7049.2 6811.8 7084.4 7093.9 7103.5 7105.3 7502.3 7512.5 7521.4 7534.0 7537.6 4699.3 4739.8 4748.5 4765.6 4772.5 7133.2 7145.5 7145.5 7149.9 7158.9 6766.8 6878.5 6917.0 6939.7 6943.1 6863.5 6874.2 6887.0 6914.7 6943.9 6748.0 6792.3 6794.6 6803.8 6806.4 6841.4 6976.3 6982.1 6998.2 7003.4 6632.1 6822.8 6829.2 6830.4 6832.6 06:24:07 INFO - PROCESS | 13346 | 06:24:07 INFO - PROCESS | 13346 | [#5] yui.html Cycles:180 Average:16164.68 Median:48684.62 stddev:18764.41 (38.5%) stddev-sans-first:18782.16 06:24:07 INFO - PROCESS | 13346 | Values: 925.5 933.4 953.6 967.0 980.9 15127.7 15132.7 15167.5 15265.8 15635.2 14483.3 14521.3 14533.4 14541.8 14575.5 743.2 899.7 933.0 936.7 938.0 924.1 929.7 930.2 932.8 934.8 979.9 982.7 982.8 984.3 986.5 968.2 973.3 974.4 978.1 981.3 715.0 715.3 718.7 719.0 722.5 15248.1 15255.8 15295.9 15369.5 15385.8 15291.7 15347.9 15451.0 15550.8 15571.8 12299.6 12304.9 12420.2 12429.6 12432.8 4049.8 4051.6 4086.5 4132.8 4178.6 56821.7 58650.7 58816.7 58867.1 59247.0 11412.1 11668.3 11767.8 11846.1 12091.0 20604.1 20626.5 20646.0 20678.5 20680.5 8891.3 8920.0 9010.0 9218.7 9233.4 5051.9 5078.6 5104.5 5171.5 5325.4 3302.8 3350.5 3359.0 3360.2 3477.9 691.6 703.7 707.7 711.9 713.9 742.7 747.1 749.6 752.4 759.4 9483.6 9595.5 9637.0 9720.9 9957.3 642.1 673.1 683.4 707.6 753.9 4454.4 4520.1 4523.5 4587.7 4590.2 67815.0 68812.7 69356.0 69454.0 69716.3 58378.1 58774.0 58801.4 60081.1 60238.0 52816.7 53071.5 53157.2 53656.5 53732.7 8690.2 8700.0 8835.4 8918.8 9057.7 39446.2 39609.4 39964.8 40055.0 41396.6 47275.0 50094.2 52371.2 53829.5 54122.0 13182.4 13220.3 13346.5 13378.8 13503.6 13875.9 14431.9 14503.8 14587.7 14939.4 13270.8 13392.9 13827.9 14336.2 14568.3 13712.7 13713.9 13847.0 13898.2 13948.5 13387.5 13519.8 13837.2 13882.4 14294.2 11291.2 11341.0 11416.7 11628.2 12007.6 11668.0 11718.1 11756.4 11766.0 11941.7 06:24:07 INFO - PROCESS | 13346 | -------- Summary: end -------- 06:24:07 INFO - PROCESS | 13346 | 06:24:08 INFO - TEST-INFO | 13346: exit 0 06:24:08 INFO - TEST-OK | dromaeo_css | took 1108838ms 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 13584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb4t4oW/profile http://localhost:43273/getInfo.html) 06:24:12 INFO - PROCESS | 13584 | 06:24:12 INFO - PROCESS | 13584 | (process:13662): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:24:12 INFO - PROCESS | 13584 | __metrics Screen width/height:1600/1200 06:24:12 INFO - PROCESS | 13584 | colorDepth:24 06:24:12 INFO - PROCESS | 13584 | Browser inner width/height: 1024/697 06:24:12 INFO - PROCESS | 13584 | __metrics 06:24:13 ERROR - PROCESS | 13584 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:24:14 INFO - TEST-INFO | 13584: 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 13712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb4t4oW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:16 INFO - PROCESS | 13712 | 06:24:16 INFO - PROCESS | 13712 | (process:13782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:24:26 INFO - PROCESS | 13712 | RSS: Main: 150671360 06:24:26 INFO - PROCESS | 13712 | 06:24:28 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43273/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:29 INFO - PROCESS | 13712 | RSS: Main: 155873280 06:24:29 INFO - PROCESS | 13712 | 06:24:32 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43273/tests/kraken/driver.html?testName=audio-dft) 06:24:32 INFO - PROCESS | 13712 | RSS: Main: 155869184 06:24:32 INFO - PROCESS | 13712 | 06:24:35 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43273/tests/kraken/driver.html?testName=audio-fft) 06:24:36 INFO - PROCESS | 13712 | RSS: Main: 156151808 06:24:36 INFO - PROCESS | 13712 | 06:24:38 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43273/tests/kraken/driver.html?testName=audio-oscillator) 06:24:38 INFO - PROCESS | 13712 | RSS: Main: 156389376 06:24:38 INFO - PROCESS | 13712 | 06:24:41 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:41 INFO - PROCESS | 13712 | RSS: Main: 156045312 06:24:41 INFO - PROCESS | 13712 | 06:24:44 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43273/tests/kraken/driver.html?testName=imaging-darkroom) 06:24:45 INFO - PROCESS | 13712 | RSS: Main: 156393472 06:24:45 INFO - PROCESS | 13712 | 06:24:48 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43273/tests/kraken/driver.html?testName=imaging-desaturate) 06:24:49 INFO - PROCESS | 13712 | RSS: Main: 156536832 06:24:49 INFO - PROCESS | 13712 | 06:24:52 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43273/tests/kraken/driver.html?testName=json-parse-financial) 06:24:52 INFO - PROCESS | 13712 | RSS: Main: 156655616 06:24:52 INFO - PROCESS | 13712 | 06:24:54 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:24:54 INFO - PROCESS | 13712 | RSS: Main: 156135424 06:24:54 INFO - PROCESS | 13712 | 06:24:56 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:24:57 INFO - PROCESS | 13712 | RSS: Main: 156979200 06:24:57 INFO - PROCESS | 13712 | 06:24:59 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:24:59 INFO - PROCESS | 13712 | RSS: Main: 156680192 06:24:59 INFO - PROCESS | 13712 | 06:25:02 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:02 INFO - PROCESS | 13712 | RSS: Main: 157659136 06:25:02 INFO - PROCESS | 13712 | 06:25:05 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:06 INFO - PROCESS | 13712 | RSS: Main: 157265920 06:25:06 INFO - PROCESS | 13712 | 06:25:07 INFO - PROCESS | 13712 | Cycle 1(1): loaded http://localhost:43273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43273/tests/kraken/driver.html?testName=ai-astar) 06:25:08 INFO - PROCESS | 13712 | RSS: Main: 158867456 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | __start_tp_report 06:25:08 INFO - PROCESS | 13712 | _x_x_mozilla_page_load 06:25:08 INFO - PROCESS | 13712 | _x_x_mozilla_page_load_details 06:25:08 INFO - PROCESS | 13712 | |i|pagename|runs| 06:25:08 INFO - PROCESS | 13712 | |0;ai-astar;108;111;103;109;112;117;100;110;110;112 06:25:08 INFO - PROCESS | 13712 | |1;audio-beat-detection;159;127;158;175;128;168;159;128;177;133 06:25:08 INFO - PROCESS | 13712 | |2;audio-dft;163;162;166;163;161;164;165;163;164;162 06:25:08 INFO - PROCESS | 13712 | |3;audio-fft;76;74;76;172;73;76;76;77;172;77 06:25:08 INFO - PROCESS | 13712 | |4;audio-oscillator;93;94;147;92;92;92;149;93;92;158 06:25:08 INFO - PROCESS | 13712 | |5;imaging-gaussian-blur;118;117;118;117;117;117;118;117;117;117 06:25:08 INFO - PROCESS | 13712 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;146;146 06:25:08 INFO - PROCESS | 13712 | |7;imaging-desaturate;94;95;95;95;96;94;95;95;95;95 06:25:08 INFO - PROCESS | 13712 | |8;json-parse-financial;54;55;56;56;56;60;57;83;58;54 06:25:08 INFO - PROCESS | 13712 | |9;json-stringify-tinderbox;59;59;59;58;58;59;60;59;59;59 06:25:08 INFO - PROCESS | 13712 | |10;stanford-crypto-aes;74;73;74;74;76;76;75;77;76;74 06:25:08 INFO - PROCESS | 13712 | |11;stanford-crypto-ccm;118;124;112;116;116;113;129;115;127;127 06:25:08 INFO - PROCESS | 13712 | |12;stanford-crypto-pbkdf2;165;159;160;162;160;164;161;161;167;158 06:25:08 INFO - PROCESS | 13712 | |13;stanford-crypto-sha256-iterative;68;67;68;68;69;72;68;66;71;66 06:25:08 INFO - PROCESS | 13712 | __end_tp_report 06:25:08 INFO - PROCESS | 13712 | __start_cc_report 06:25:08 INFO - PROCESS | 13712 | _x_x_mozilla_cycle_collect,859 06:25:08 INFO - PROCESS | 13712 | __end_cc_report 06:25:08 INFO - PROCESS | 13712 | __startTimestamp1467033908202__endTimestamp 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | ------- Summary: start ------- 06:25:08 INFO - PROCESS | 13712 | Number of tests: 14 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:4.78 (4.3%) stddev-sans-first:5.05 06:25:08 INFO - PROCESS | 13712 | Values: 108.0 111.0 103.0 109.0 112.0 117.0 100.0 110.0 110.0 112.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:159.00 stddev:20.21 (12.7%) stddev-sans-first:21.24 06:25:08 INFO - PROCESS | 13712 | Values: 159.0 127.0 158.0 175.0 128.0 168.0 159.0 128.0 177.0 133.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 06:25:08 INFO - PROCESS | 13712 | Values: 163.0 162.0 166.0 163.0 161.0 164.0 165.0 163.0 164.0 162.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:40.65 (53.5%) stddev-sans-first:42.54 06:25:08 INFO - PROCESS | 13712 | Values: 76.0 74.0 76.0 172.0 73.0 76.0 76.0 77.0 172.0 77.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.00 stddev:28.53 (31.0%) stddev-sans-first:29.57 06:25:08 INFO - PROCESS | 13712 | Values: 93.0 94.0 147.0 92.0 92.0 92.0 149.0 93.0 92.0 158.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:25:08 INFO - PROCESS | 13712 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:25:08 INFO - PROCESS | 13712 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 06:25:08 INFO - PROCESS | 13712 | Values: 94.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:56.50 stddev:8.66 (15.3%) stddev-sans-first:9.00 06:25:08 INFO - PROCESS | 13712 | Values: 54.0 55.0 56.0 56.0 56.0 60.0 57.0 83.0 58.0 54.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 06:25:08 INFO - PROCESS | 13712 | Values: 59.0 59.0 59.0 58.0 58.0 59.0 60.0 59.0 59.0 59.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.50 stddev:1.29 (1.7%) stddev-sans-first:1.32 06:25:08 INFO - PROCESS | 13712 | Values: 74.0 73.0 74.0 74.0 76.0 76.0 75.0 77.0 76.0 74.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:121.00 stddev:6.40 (5.3%) stddev-sans-first:6.75 06:25:08 INFO - PROCESS | 13712 | Values: 118.0 124.0 112.0 116.0 116.0 113.0 129.0 115.0 127.0 127.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.50 stddev:2.83 (1.8%) stddev-sans-first:2.74 06:25:08 INFO - PROCESS | 13712 | Values: 165.0 159.0 160.0 162.0 160.0 164.0 161.0 161.0 167.0 158.0 06:25:08 INFO - PROCESS | 13712 | 06:25:08 INFO - PROCESS | 13712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.95 (2.9%) stddev-sans-first:2.06 06:25:08 INFO - PROCESS | 13712 | Values: 68.0 67.0 68.0 68.0 69.0 72.0 68.0 66.0 71.0 66.0 06:25:08 INFO - PROCESS | 13712 | -------- Summary: end -------- 06:25:08 INFO - PROCESS | 13712 | 06:25:09 INFO - TEST-INFO | 13712: exit 0 06:25:09 INFO - TEST-OK | kraken | took 60825ms 06:25:09 INFO - SUITE-END | took 1169s 06:25:09 INFO - Completed test suite (00:19:29) 06:25:09 INFO - javascript benchmark 06:25:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.0824169232615, 3332.083676988829, 3349.715274201692, 3390.9152271193216, 3393.7115345195657, 5515.448455154493, 5522.530584900283, 5527.281453411056, 5532.612717109804, 5532.944670553294, 5511.035568775468, 5525.4474552544825, 5578.30271216098, 5583.888322233553, 5588.972055139719, 5027.547520723143, 5057.620678449112, 5067.1385864402955, 5077.822276220333, 5131.025105229995, 4968.254761785725, 5032.6477146599755, 5078.365204349457, 5135.512126347991, 5182.792688292464, 5073.1122053640465, 5115.053715062707, 5163.896722065557, 5173.0, 5178.6116041297055, 5089.440161582223, 5100.566451851579, 5115.795368185268, 5117.0, 5138.948610513884, 4913.434954980187, 4956.4547899731, 5023.070731914608, 5052.9242061369105, 5108.4125325587665, 5267.26258323835, 5324.41431442541, 5330.786768529254, 5339.893202135974, 5401.972990135064, 5816.1275808628625, 5823.38854420284, 5831.154482599999, 5834.795782147647, 5844.970775146139, 5791.131330300446, 5901.409859014064, 5910.852228694274, 5996.520278377763, 6023.156758053876, 5529.529989950899, 5542.501174894279, 5558.749856256478, 5559.138333558305, 5570.275864137677, 5966.284045914431, 6006.609570377911, 6019.69901504923, 6032.3967603239325, 6035.155078289043, 5618.297712785902, 5771.5671324649975, 5820.214271073435, 5830.2129212555765, 5881.647101173943, 5865.94134058654, 5894.115882617556, 5903.3801450847905, 5904.409559044061, 5904.822855314347, 5854.151148083504, 5854.151148083589, 5854.619449735754, 5859.501942334864, 5864.882702346014, 5753.223314852441, 5887.61730487517, 5928.881422371528, 5941.821745347646, 5974.074018527135, 4495.415595972568, 4496.6177874881005, 4527.049319642846, 4527.909441811145, 4557.931631025537, 4037.6366127048705, 4070.715049946475, 4081.551029386765, 4094.8976275592754, 4111.342185250345, 5608.4111168326735, 5646.068398714248, 5689.6586204827845, 5692.260006199251, 5730.828075157752, 5940.198073260054, 5946.405359464019, 5963.5825492216, 5980.162777211194, 5984.7606095756555, 5624.943750562442, 5699.572532060112, 5721.313442386857, 5726.685032323262, 5728.742206600713, 5069.569086627678, 5083.415407228216, 5083.517065878736, 5087.0, 5114.130597798383, 6148.077788331697, 6178.196834411498, 6192.938070619236, 6196.783112591038, 6208.068789681493, 5751.884962300815, 5911.201987731602, 5926.644401335933, 5989.431004054521, 5992.64044157352, 6113.537117903944, 6115.909724157069, 6121.148138557471, 6122.316751643488, 6128.567224186975, 5791.044477661138, 5793.594448388572, 5801.912971305349, 5804.361520232856, 5873.03094989339, 5703.201551782837, 5893.2044174035955, 5967.582269241111, 6033.5173186145885, 6042.0936859469675, 5752.942470575241, 5756.079027355603, 5757.683327417032, 5759.0785474325585, 5779.826605201851, 5695.943040569541, 5742.885142297047, 5746.396628353963, 5747.8563035924435, 5763.164341170423, 5416.539594134385, 5676.0, 5707.914381284201, 5712.428757124254, 5745.597808153556, 5815.680137592473, 5831.562632802472, 5838.970805145947, 5843.532517398513, 5866.472017518444, 5603.971980140073, 5734.913976290442, 5736.827895163152, 5737.971310143423, 5740.253767010429], "value": 5465.589521367198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.3951964192942, 675.3853992866491, 685.3249549194046, 731.2285538756616, 746.6042997211476, 39265.411018834704, 39977.40033899486, 40258.39612405816, 40376.79811600941, 40401.59598404015, 42153.15693686132, 42803.14393712124, 42828.143437131235, 42904.785476072655, 42979.0, 8830.293576513879, 9009.144131307516, 9009.189172974431, 9016.639334426614, 9033.051529589397, 8717.738467845944, 8800.251978581797, 8805.20753132218, 8809.251213646849, 8823.470591764482, 9064.728058158233, 9197.21823644991, 9213.2168765655, 9224.769380765467, 9231.0, 9088.636454541811, 9126.45241285525, 9179.586918588613, 9190.172884440366, 9190.586423610954, 9119.179273865384, 9202.033786452394, 9215.0, 9218.308626852946, 9244.815103697889, 43652.56347436517, 44027.33958990618, 44183.33724994128, 44215.0, 44307.55692443067, 3984.123492831601, 4034.798260086984, 4123.092919557693, 4412.470503539564, 4722.693024953367, 32322.6767732322, 32821.507677384856, 33010.17474563155, 33168.0, 33695.83152084248, 4378.934315985231, 4410.6030457259, 4443.204686285845, 4464.575865292824, 4493.752843593634, 320601.0, 321554.0, 322999.0, 323858.0, 324769.0, 61843.0, 62263.0, 62650.686746565974, 62662.373376266565, 62836.68581657154, 65411.0, 69688.0, 70785.0, 70805.64597176982, 70990.0, 18237.45287641373, 18279.0, 18387.72418413725, 18394.356197533023, 18442.26230950747, 14077.296135193199, 14161.575152745434, 14171.78742318866, 14177.574672759834, 14208.502702405367, 20189.293374731813, 20242.898785506273, 20263.0, 20378.79621203769, 20429.0, 8014.559199243981, 8090.312323452455, 8147.551884646283, 8248.54632995179, 8307.335413166933, 1054.3515737821185, 1102.8290614954694, 1120.815065514181, 1121.1311233793874, 1167.7606090751376, 34430.13924651904, 35117.64882351195, 35257.82371088128, 37604.24791504209, 39041.609583903795, 1204.5964601858475, 1233.5620854596668, 1256.4974010395915, 1286.4018231522386, 1311.5737385349798, 16550.916739423792, 16555.91722041382, 16596.004239745653, 16815.0, 16874.74687879683, 506748.0, 513128.0, 840082.0, 856247.0, 866298.0, 63853.0, 65034.34965650378, 65106.0, 65213.0, 65425.67287163534, 1539.5227479481396, 1554.8211955625022, 1557.540525544967, 1570.583795294248, 1683.6632673465356, 32902.506462402605, 33115.50326745053, 33513.0, 33910.83044584761, 34342.65657343494, 53911.730441349115, 54570.18144727753, 54664.180037298676, 54703.72648136734, 54795.726021369635, 439439.0, 440778.0, 441966.0, 442141.0, 442785.0, 31401.37197256088, 31571.842140790068, 31684.524732128575, 31708.20729481689, 31920.52119218167, 48934.26598600952, 49580.25629615487, 49946.75026624989, 50501.49498505115, 51077.74461127671, 41293.58706412897, 42807.57192428036, 42935.0, 43147.56852431561, 43266.35100473432, 41036.58963410328, 41107.0, 41694.16611667689, 42345.576544235395, 42675.35986960136, 43136.35295470508, 43648.0, 44060.33909491296, 44205.336919945585, 44516.0, 36648.52497660001, 37349.62650373462, 37363.2527349446, 37612.62387376201, 38465.0, 28795.28011799722, 29297.7070229295, 29511.967081152055, 29593.112206633836, 29805.850970745007], "value": 21438.47808494372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.69435312222095, 419.2934904685603, 422.1156676762184, 426.7588812321038, 433.7939478747595, 18826.34107806227, 19359.806401935977, 19565.902170489164, 19601.901990490045, 20115.396538103843, 12375.44310506027, 12857.614271571845, 12919.741605167914, 19895.900520497376, 20089.0, 5355.357357117151, 5482.725863706819, 5492.670439773607, 5494.697791621459, 5512.310961129859, 5439.728013599324, 5938.52491800657, 5944.078667806497, 5963.731632076545, 5970.850728731773, 5856.150858125569, 5860.501857342131, 5862.443067908542, 5894.410558944092, 5907.172995780594, 5496.367917689477, 5526.834194974157, 5531.225628412026, 5557.305336832896, 5562.9443705562835, 5358.4641535846495, 5396.0, 5399.892002159974, 5401.70290634015, 5408.296921400193, 19990.500237494034, 24264.878675606684, 24587.0, 24900.875495622586, 24947.87526062376, 2492.1651246832334, 2530.607755797854, 2533.5819589767666, 2603.4669931740814, 2607.4524349886547, 10475.895241047569, 10691.78616427675, 10920.235583509157, 10950.123990080774, 11199.0, 2022.3932820153896, 2132.818710409617, 2162.978370216309, 2165.3936897668677, 2197.099189332366, 79482.0, 80675.5966220171, 80739.0, 81799.0, 83511.0, 11644.475998580085, 11759.412029398496, 11833.585824496102, 11963.222390544586, 12039.578614748618, 16658.916705416395, 16687.249073791707, 16739.748903766453, 16791.160441977852, 16820.158992050594, 8938.329625278, 9015.504147271831, 9016.413933094327, 9018.774530636656, 9106.726798196065, 8617.0, 8874.689385871463, 8890.377673562789, 8905.243054340324, 8936.553172341357, 5084.847454576368, 5118.897622047538, 5134.229865520202, 5165.225216217597, 5240.663630774205, 1919.3666090190204, 1979.5051237190703, 2015.2543558883308, 2069.0, 2107.589020141058, 1023.7645341571331, 1078.9676309710721, 1124.8818874018275, 1151.0791366906442, 1203.6328919679581, 19038.80961190398, 19976.800231997786, 20111.497212569804, 20127.194912203642, 20139.49651258701, 1070.9250352475408, 1074.6131392698621, 1083.7019819549687, 1105.4362275239685, 1126.4480404601686, 10864.402457864735, 11057.22599418033, 11155.609553665583, 11188.944055279835, 11197.832032519518, 375276.0, 379806.0, 381055.0, 518799.0, 519251.0, 95662.9999999986, 97020.51489742506, 98539.0, 99962.50018750005, 101105.49447252716, 1179.0744265751343, 1193.5524178433088, 1201.333260040686, 1202.1705023533734, 1223.253815172744, 18114.818851811313, 18115.55599810767, 18285.26858925628, 18288.90855545714, 18347.266109355478, 40177.59822401738, 40773.0, 40849.59150408458, 40927.59072409238, 42326.788366057976, 58860.411395885494, 59126.704366479615, 59127.70436147792, 59551.702241488514, 59726.0, 9020.233280170996, 9027.864582031143, 9049.366544341832, 9076.500792456214, 9269.490178040272, 9861.211103111877, 13195.406206720912, 13323.600291991255, 13494.392752326365, 13630.795538066739, 11547.4803633835, 11622.82565761531, 11832.17174797756, 11914.642560723192, 11965.820512692491, 11583.131265155316, 11642.476088575864, 11777.352245626573, 11850.229735067192, 12033.338166400932, 11763.941180294043, 12089.879101209228, 12170.756584868075, 12339.75320493603, 12775.425105870445, 9009.684661036832, 9039.322050846082, 9056.27549796028, 12566.246025238515, 13630.454781808616, 12829.87170128324, 12927.741445171232, 13033.15284506504, 13301.933490332873, 13643.249621270925], "value": 9599.579791371025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1615.5961009747564, 1623.5941014746313, 1853.2586965213914, 1948.454432758828, 1958.7551556055494, 7219.747308844191, 8084.514929104258, 8206.261436470724, 8256.711015114479, 8277.379196560267, 8178.550179740112, 8420.494770313786, 8434.620442080106, 8550.95724521378, 8678.132186781319, 2436.5979613363775, 2452.9509409811794, 2460.372604985726, 2468.5926822074334, 2473.468204336067, 2427.283951234381, 2463.556559819232, 2483.4163971466783, 2483.913063042794, 2488.738682438345, 2440.2679196241147, 2445.205308274818, 2448.3634255093625, 2450.019992003195, 2453.8405003674793, 2450.901963921441, 2481.0944005438064, 2482.466269751994, 2490.3898544856447, 2499.575072237724, 2443.5357282116343, 2487.601983682602, 2500.6999160100904, 2501.387160145776, 2511.598144296922, 8644.135586441369, 8676.436031657986, 8680.739577812676, 8700.912990870074, 8701.0, 5367.060764366221, 5432.75552600134, 5501.9174712379345, 5511.035568775448, 5511.173324001392, 3622.492851000862, 3652.908677283089, 3714.7771133732062, 3806.7906265155407, 3809.8857034289017, 1161.3960740414936, 1166.8716441191461, 1174.2426135142784, 1191.2316555821533, 1201.1051766433975, 12035.09736769737, 12035.39823008846, 12040.999999999913, 12065.879341206652, 12103.515859365614, 4582.358469814229, 4603.4475862896, 4634.83778067766, 4670.065986802653, 4713.057388522309, 9557.665481708107, 9562.521873906277, 9570.521473926276, 9597.28020398459, 9604.183644390165, 5336.279602253724, 5368.32895888014, 5369.140937449989, 5381.273528073738, 5395.406505284415, 4703.764811759467, 4842.539958703917, 4910.042541704333, 4914.33656456381, 5002.824901128516, 3896.9610303897166, 3944.3886197639413, 3944.585818489017, 3971.185906889081, 4009.1179940413062, 1189.6312143235625, 1191.4281145050425, 1195.1693572966878, 1198.9460474278503, 1245.3835351501066, 1044.6604853422668, 1047.0367262118868, 1057.8836328003913, 1068.9251752377415, 1075.1130317488103, 5774.249347584787, 5909.2908850938165, 5909.911351329733, 6036.3360030396625, 6038.607490513103, 1095.4686976816238, 1115.6151127860876, 1144.4792619358338, 1187.4359679152506, 1207.9154459187948, 4072.9389059164137, 4152.501699796044, 4168.6039826216465, 4224.4508213931995, 4224.471941007374, 10517.631882884216, 10804.945975270073, 10822.40476773785, 10869.565217391215, 10922.617708380327, 10686.14510839131, 10693.679189624323, 10748.570057197781, 10758.892411075945, 10761.730956726144, 8348.415610907177, 8371.037330707046, 8432.283255923192, 8456.112108228548, 8462.069172391031, 5848.678322692293, 5873.295204575478, 5916.0, 5934.228550288435, 6020.54845886569, 9226.40028398152, 9295.0, 9301.116393942564, 9353.906460935303, 9439.103285187895, 9247.491387973727, 9502.287328450531, 9682.9031709682, 9817.656382026595, 9864.753381165528, 7179.569225846466, 7300.817479563053, 7330.926690733025, 7741.612919353897, 7797.92202077972, 7996.24035716606, 8011.679532818622, 8023.0, 8043.557604331818, 8118.715844945635, 7092.397146242627, 7333.853322933404, 7340.302671246223, 7376.151742549461, 7465.253474652492, 7145.21402645719, 7168.677409516688, 7255.818604534928, 7273.054502914587, 7361.30067643573, 6717.966410168114, 6801.2178599461695, 6823.69293381809, 6826.692798823966, 6840.692168852314, 5121.257417674491, 5123.436421993652, 5134.768935397841, 5252.868678283074, 5268.947310526845, 5127.077126117335, 5149.201873709581, 5307.150855863043, 5351.785928562814, 5352.518273355417], "value": 4688.006085947509, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4815646920792, 352.9470579413088, 359.4320972862876, 362.7315786318125, 366.4210547335211, 6402.583832050925, 6434.935650643504, 6499.480041596673, 6538.313477084903, 6583.144191255136, 6496.0, 6508.9674551627295, 6533.118029066075, 6535.0, 6548.246951600568, 4919.532644398794, 4964.5531902128805, 4969.975150124263, 4972.726500042496, 4980.103581355354, 4975.975120124394, 4982.57648099912, 4984.87537811554, 4990.75046247688, 4992.0, 4934.185859333224, 4938.876528086791, 4939.8024079036795, 4953.331300274471, 4959.826406075788, 4695.3661255730385, 4819.180739274332, 4933.975330123362, 4941.654084214107, 4943.802247910079, 4178.247915375231, 4181.581841815794, 4183.518895327046, 4190.413342132104, 4194.098268872177, 6199.752009919598, 6206.224221972254, 6209.503239740855, 6219.471344935686, 6226.657533835637, 5640.238567793336, 5645.096784514458, 5645.491905728504, 5650.378458369576, 5651.378348381675, 6800.217974932896, 6807.795766127024, 6812.080369150151, 6816.0, 6824.4199243064395, 4584.541545845422, 4605.562471565196, 4655.092257009885, 4660.790264438108, 4671.813127474897, 7094.645267736644, 7150.642467876637, 7160.570365778018, 7167.211606723308, 7181.210066892638, 4726.125666751662, 4736.478987311462, 4745.667803253808, 4760.166970780169, 4762.9523704763205, 4825.131476334223, 4828.830990915301, 4830.154722923475, 4833.782479788418, 4837.05677392912, 5619.971900140473, 5626.662400255916, 5632.070708333079, 5634.971825140848, 5635.408282130399, 6732.259451460335, 6885.483588730765, 6895.034695142684, 6898.862022759517, 6912.135983002125, 1669.3906724045637, 1678.0686718871143, 1678.4125556055526, 1689.5184872311331, 1702.8978261304114, 1074.2802322443981, 1075.0754351257913, 1095.775366049958, 1100.0869278498988, 1108.817045187535, 6543.280239173687, 6665.433438157811, 6670.83322916931, 6675.566088204251, 6677.0, 6971.965140174369, 7019.0, 7026.297370263035, 7027.61348125858, 7035.824104397431, 6640.335966403418, 6642.103316052271, 6647.634380109141, 6652.833679157963, 6654.86690266192, 3763.6048214937587, 3806.352920003606, 3813.3136035513876, 3813.4470501777087, 3814.4278358246484, 7174.282571742784, 7349.669264883093, 7352.11774587053, 7354.338109570057, 7363.521371110968, 7103.650306441863, 7117.679704413314, 7132.251113633098, 7158.713651453988, 7170.820729481805, 7264.237255088246, 7292.854142917112, 7325.084364454443, 7328.0, 7338.926610733824, 7014.438844892295, 7026.8945965809535, 7036.964815175891, 7043.542169758949, 7049.224585295716, 6811.795646130624, 7084.433245340463, 7093.858122837618, 7103.538270012433, 7105.32499412555, 7502.287282708352, 7512.5492470451945, 7521.435892307989, 7534.0, 7537.585432801029, 4699.295105734031, 4739.834105806281, 4748.501407352178, 4765.571098601143, 4772.5227477252, 7133.2153463117975, 7145.4640901931525, 7145.4998150128995, 7149.928500715135, 7158.8926166108595, 6766.763163289262, 6878.518503704692, 6917.0, 6939.722411103499, 6943.097397338313, 6863.519553631198, 6874.175098988154, 6886.965565172142, 6914.654267286716, 6943.895841562482, 6748.021536877223, 6792.252852186157, 6794.626295553594, 6803.795886123424, 6806.421454176252, 6841.3842754152365, 6976.267491913479, 6982.057422247932, 6998.16022077354, 7003.439724822104, 6632.1098486931, 6822.795316140524, 6829.180498340231, 6830.351116643911, 6832.555883867532], "value": 5150.7110217621075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [925.504854902627, 933.36531158812, 953.6185525789688, 966.9951650241748, 980.8822941247051, 15127.697446051072, 15132.697346053072, 15167.54497365078, 15265.771013434793, 15635.218239088043, 14483.34824932878, 14521.346539405726, 14533.418663253457, 14541.78187327191, 14575.489857854976, 743.2233316184573, 899.698600968673, 933.0, 936.69089200564, 937.976550586234, 924.089771574998, 929.6746138851415, 930.2279108340061, 932.8367535681263, 934.7990182110844, 979.8530220466952, 982.6560703753664, 982.8181786369508, 984.2765567308023, 986.4771671014338, 968.2157452463528, 973.3235401396032, 974.3569244298765, 978.0757184460688, 981.2983716642599, 714.9821254468628, 715.2882881532908, 718.6909628859588, 719.0149495191569, 722.5303552690741, 15248.085114893142, 15255.771163432557, 15295.923520382437, 15369.462068827537, 15385.769213461806, 15291.694166116728, 15347.923260383739, 15450.99568528042, 15550.76673849893, 15571.766423503657, 12299.631011069681, 12304.876951230463, 12420.192687475284, 12429.627111186588, 12432.813507797391, 4049.7975101245115, 4051.6353528182312, 4086.4891888513935, 4132.772697501636, 4178.582141785797, 56821.71589142028, 58650.70674646642, 58816.70591647057, 58867.11699324471, 59247.0, 11412.087033037336, 11668.299902005907, 11767.823482647767, 11846.052315814713, 12091.0, 20604.072816723285, 20626.484337891372, 20646.0, 20678.483037924172, 20680.48298792542, 8891.288696904232, 8920.0, 9009.954950225338, 9218.677346292847, 9233.399829011092, 5051.949480505222, 5078.644494885397, 5104.515071068243, 5171.456997015334, 5325.440828713007, 3302.7522935779434, 3350.5141754445467, 3358.9832050840077, 3360.1767566946255, 3477.9304413912087, 691.6126968897333, 703.7044441334651, 707.734599525178, 711.8611870685166, 713.875071862422, 742.6806473216569, 747.0512449189499, 749.6439191384158, 752.3943225703252, 759.3735168486021, 9483.620655173854, 9595.465802442772, 9637.0, 9720.854187187198, 9957.30298879086, 642.1491523731075, 673.1484671890063, 683.3781259054236, 707.5613119865613, 753.88691696246, 4454.354118652842, 4520.0507893342765, 4523.5024147343765, 4587.7017993830295, 4590.219662657356, 67815.0, 68812.65593672, 69356.0, 69454.0, 69716.30283697098, 58378.12432813511, 58774.0, 58801.41198588045, 60081.09878351741, 60238.0, 52816.735916319405, 53071.46928530742, 53157.2026419604, 53656.46343536593, 53732.731336343066, 8690.217880390795, 8700.0, 8835.381523293308, 8918.821623567623, 9057.686635437693, 39446.21107577775, 39609.40585891157, 39964.800175998935, 40055.0, 41396.58603414048, 47275.0, 50094.24858627196, 52371.21443178432, 53829.46170538245, 54122.0, 13182.406791694206, 13220.338983050617, 13346.466141354626, 13378.799318010042, 13503.59489215325, 13875.861241387456, 14431.927840360731, 14503.809161984347, 14587.708245834812, 14939.402423902922, 13270.800937985745, 13392.933035334761, 13827.861721382658, 14336.21150836714, 14568.271586420424, 13712.65718357049, 13713.862861371259, 13847.0, 13898.23559704226, 13948.511802086878, 13387.531436399679, 13519.797203042159, 13837.169769813843, 13882.375293112036, 14294.213818239681, 11291.153163512934, 11341.0, 11416.657500275005, 11628.244164129304, 12007.639770806889, 11668.0, 11718.121140914294, 11756.412179391167, 11766.0, 11941.701457463632], "value": 7336.874832591669, "unit": "score"}], "name": "dromaeo_css", "value": 7642.726175683495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 103.0, 109.0, 112.0, 117.0, 100.0, 110.0, 110.0, 112.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 158.0, 175.0, 128.0, 168.0, 159.0, 128.0, 177.0, 133.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 166.0, 163.0, 161.0, 164.0, 165.0, 163.0, 164.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 172.0, 73.0, 76.0, 76.0, 77.0, 172.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 147.0, 92.0, 92.0, 92.0, 149.0, 93.0, 92.0, 158.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 56.0, 56.0, 60.0, 57.0, 83.0, 58.0, 54.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 76.0, 76.0, 75.0, 77.0, 76.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 124.0, 112.0, 116.0, 116.0, 113.0, 129.0, 115.0, 127.0, 127.0], "value": 119.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 160.0, 162.0, 160.0, 164.0, 161.0, 161.0, 167.0, 158.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 69.0, 72.0, 68.0, 66.0, 71.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1529.5000000000002, "alertThreshold": 2.0}]} 06:25:09 INFO - Return code: 0 06:25:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:25:09 ERROR - # TBPL SUCCESS # 06:25:09 INFO - Running post-action listener: _resource_record_post_action 06:25:09 INFO - Running post-run listener: _resource_record_post_run 06:25:10 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 469794816; Read time: 4; Write time: 338936 06:25:10 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 249782272; Read time: 0; Write time: 213488 06:25:10 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219475968; Read time: 4; Write time: 125448 06:25:10 INFO - Running post-run listener: _upload_blobber_files 06:25:10 INFO - Blob upload gear active. 06:25:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:10 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:10 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:10 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-e10s_errorsummary.log ... 06:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.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 - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:25:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:12 INFO - (blobuploader) - INFO - Done attempting. 06:25:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:12 INFO - Return code: 0 06:25:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cfb19f0d5a820ebfe1adbd4faf41315df2efffd453cc9bf27f1a34b9ef388ac8157c445ee9552bbfeae0d5f46db26ff1d7588af6203c26698e60f2907acea059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6af6f6e59a2fc85c5f880dd7da88e4b0e8588dc8a2dff6c64bb7f5651db83b764a17a5869da75291148149b699deeb35c5f11ebe5eb522268235b2a3a08d40aa"} 06:25:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:12 INFO - Contents: 06:25:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cfb19f0d5a820ebfe1adbd4faf41315df2efffd453cc9bf27f1a34b9ef388ac8157c445ee9552bbfeae0d5f46db26ff1d7588af6203c26698e60f2907acea059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6af6f6e59a2fc85c5f880dd7da88e4b0e8588dc8a2dff6c64bb7f5651db83b764a17a5869da75291148149b699deeb35c5f11ebe5eb522268235b2a3a08d40aa"} 06:25:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:12 INFO - Copying logs to upload dir... 06:25:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.701762 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-27 06:25:11.614036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:11.621741) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cfb19f0d5a820ebfe1adbd4faf41315df2efffd453cc9bf27f1a34b9ef388ac8157c445ee9552bbfeae0d5f46db26ff1d7588af6203c26698e60f2907acea059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6af6f6e59a2fc85c5f880dd7da88e4b0e8588dc8a2dff6c64bb7f5651db83b764a17a5869da75291148149b699deeb35c5f11ebe5eb522268235b2a3a08d40aa"} 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.011175 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cfb19f0d5a820ebfe1adbd4faf41315df2efffd453cc9bf27f1a34b9ef388ac8157c445ee9552bbfeae0d5f46db26ff1d7588af6203c26698e60f2907acea059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6af6f6e59a2fc85c5f880dd7da88e4b0e8588dc8a2dff6c64bb7f5651db83b764a17a5869da75291148149b699deeb35c5f11ebe5eb522268235b2a3a08d40aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:11.649641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:11.649994) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467032687.971217-1427002111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:25:11.922834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:25:11.923149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:25:11.923521) ========= ========= Total master_lag: 0.38 =========