builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1467054966.09 results: success (0) buildid: 20160627094317 builduid: 59e32d1fac0b4cb482da14c713334a08 revision: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.094945) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.095499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.095843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.111605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.112027) ========= 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=ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 12:16:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-27 12:16:06 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.203210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.203648) ========= 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=ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016555 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:06.254063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 12:16:06.254469) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 --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 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 --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=ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 12:16:06,769 truncating revision to first 12 chars 2016-06-27 12:16:06,770 Setting DEBUG logging. 2016-06-27 12:16:06,770 attempt 1/10 2016-06-27 12:16:06,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/00a6e2ca6e9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 12:16:08,048 unpacking tar archive at: mozilla-beta-00a6e2ca6e9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.582152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 12:16:07.850606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:07.851008) ========= script_repo_revision: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:07.851458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:07.851747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 12:16:07.863881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-27 12:16:07.864306) ========= /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=ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:08 INFO - MultiFileLogger online at 20160627 12:16:08 in /builds/slave/test 12:16:08 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 12:16:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:08 INFO - {'append_to_log': False, 12:16:08 INFO - 'base_work_dir': '/builds/slave/test', 12:16:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:16:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:08 INFO - 'branch': 'Mozilla-Beta', 12:16:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:08 INFO - 'config_files': ('talos/linux_config.py',), 12:16:08 INFO - 'default_actions': ('clobber', 12:16:08 INFO - 'read-buildbot-config', 12:16:08 INFO - 'download-and-extract', 12:16:08 INFO - 'populate-webroot', 12:16:08 INFO - 'create-virtualenv', 12:16:08 INFO - 'install', 12:16:08 INFO - 'run-tests'), 12:16:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:08 INFO - 'download_minidump_stackwalk': True, 12:16:08 INFO - 'download_symbols': 'ondemand', 12:16:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:08 INFO - 'installer_path': 'installer.exe', 12:16:08 INFO - 'log_level': 'info', 12:16:08 INFO - 'log_name': 'talos', 12:16:08 INFO - 'log_to_console': True, 12:16:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:08 INFO - 'opt_config_files': (), 12:16:08 INFO - 'pip_index': False, 12:16:08 INFO - 'sps_profile': False, 12:16:08 INFO - 'sps_profile_interval': 0, 12:16:08 INFO - 'suite': 'dromaeojs-e10s', 12:16:08 INFO - 'system_bits': '32', 12:16:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:08 INFO - 'title': 'talos-linux64-ix-035', 12:16:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:08 INFO - 'use_talos_json': True, 12:16:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:08 INFO - 'work_dir': 'build'} 12:16:08 INFO - ##### 12:16:08 INFO - ##### Running clobber step. 12:16:08 INFO - ##### 12:16:08 INFO - Running pre-action listener: _resource_record_pre_action 12:16:08 INFO - Running main action method: clobber 12:16:08 INFO - rmtree: /builds/slave/test/build 12:16:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:08 INFO - Running post-action listener: _resource_record_post_action 12:16:08 INFO - ##### 12:16:08 INFO - ##### Running read-buildbot-config step. 12:16:08 INFO - ##### 12:16:08 INFO - Running pre-action listener: _resource_record_pre_action 12:16:08 INFO - Running main action method: read_buildbot_config 12:16:08 INFO - Using buildbot properties: 12:16:08 INFO - { 12:16:08 INFO - "project": "", 12:16:08 INFO - "product": "firefox", 12:16:08 INFO - "script_repo_revision": "production", 12:16:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:16:08 INFO - "repository": "", 12:16:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 12:16:08 INFO - "buildid": "20160627094317", 12:16:08 INFO - "pgo_build": "True", 12:16:08 INFO - "basedir": "/builds/slave/test", 12:16:08 INFO - "buildnumber": 62, 12:16:08 INFO - "slavename": "talos-linux64-ix-035", 12:16:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:16:08 INFO - "platform": "ubuntu64_hw", 12:16:08 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:16:08 INFO - "branch": "mozilla-beta", 12:16:08 INFO - "repo_path": "releases/mozilla-beta", 12:16:08 INFO - "revision": "00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47", 12:16:08 INFO - "stage_platform": "linux64-pgo", 12:16:08 INFO - "builduid": "59e32d1fac0b4cb482da14c713334a08", 12:16:08 INFO - "slavebuilddir": "test" 12:16:08 INFO - } 12:16:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 12:16:08 INFO - Running post-action listener: _resource_record_post_action 12:16:08 INFO - ##### 12:16:08 INFO - ##### Running download-and-extract step. 12:16:08 INFO - ##### 12:16:08 INFO - Running pre-action listener: _resource_record_pre_action 12:16:08 INFO - Running main action method: download_and_extract 12:16:08 INFO - mkdir: /builds/slave/test/build/tests 12:16: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')]} 12:16:08 INFO - https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:09 INFO - Downloaded 1327 bytes. 12:16:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:16:09 INFO - Using the following test package requirements: 12:16:09 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:16:09 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:09 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 12:16:09 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'jsshell-linux-x86_64.zip'], 12:16:09 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:09 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:16:09 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 12:16:09 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 12:16:09 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:09 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:16:09 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:09 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:09 INFO - https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:16:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:16:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:10 INFO - Downloaded 24235710 bytes. 12:16:10 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'] 12:16:10 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 12:16:11 INFO - Return code: 0 12:16:11 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 12:16: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')]} 12:16:11 INFO - https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:16:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:16:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:13 INFO - Downloaded 24235710 bytes. 12:16:13 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'] 12:16:13 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 12:16:14 INFO - Return code: 0 12:16:14 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')]} 12:16:14 INFO - https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:15 INFO - Downloaded 10840145 bytes. 12:16:15 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'] 12:16:15 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 12:16:15 INFO - Return code: 0 12:16: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')]} 12:16:15 INFO - https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4a73pTTQLqHwmdQHMlENw/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 12:16:17 INFO - Downloaded 56020254 bytes. 12:16:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:16:17 INFO - mkdir: /builds/slave/test/properties 12:16:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:17 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:17 INFO - Contents: 12:16:17 INFO - build_url:https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:16:17 INFO - Running post-action listener: _resource_record_post_action 12:16:17 INFO - Running post-action listener: set_extra_try_arguments 12:16:17 INFO - ##### 12:16:17 INFO - ##### Running populate-webroot step. 12:16:17 INFO - ##### 12:16:17 INFO - Running pre-action listener: _resource_record_pre_action 12:16:17 INFO - Running main action method: populate_webroot 12:16:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:17 INFO - '--tppagecycles', 12:16:17 INFO - '7'], 12:16:17 INFO - 'tests': ['tsvgm']}}, 12:16:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:16:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:16:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:16:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['damp', 'tps']}, 12:16:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'tests': ['damp', 'tps']}, 12:16:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['dromaeo_dom']}, 12:16:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['a11yr', 12:16:17 INFO - 'ts_paint', 12:16:17 INFO - 'tpaint', 12:16:17 INFO - 'sessionrestore', 12:16:17 INFO - 'sessionrestore_no_auto_restore', 12:16:17 INFO - 'tabpaint']}, 12:16:17 INFO - 'other-e10s': {'tests': ['a11yr', 12:16:17 INFO - 'ts_paint', 12:16:17 INFO - 'tpaint', 12:16:17 INFO - 'sessionrestore', 12:16:17 INFO - 'sessionrestore_no_auto_restore', 12:16:17 INFO - 'tabpaint']}, 12:16:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:16:17 INFO - 'ts_paint', 12:16:17 INFO - 'tpaint', 12:16:17 INFO - 'sessionrestore', 12:16:17 INFO - 'sessionrestore_no_auto_restore', 12:16:17 INFO - 'tabpaint']}, 12:16:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:16:17 INFO - 'ts_paint', 12:16:17 INFO - 'tpaint', 12:16:17 INFO - 'sessionrestore', 12:16:17 INFO - 'sessionrestore_no_auto_restore', 12:16:17 INFO - 'tabpaint']}, 12:16:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['a11yr', 12:16:17 INFO - 'ts_paint', 12:16:17 INFO - 'tpaint', 12:16:17 INFO - 'sessionrestore', 12:16:17 INFO - 'sessionrestore_no_auto_restore', 12:16:17 INFO - 'tabpaint']}, 12:16:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['a11yr', 12:16:17 INFO - 'ts_paint', 12:16:17 INFO - 'tpaint', 12:16:17 INFO - 'sessionrestore', 12:16:17 INFO - 'sessionrestore_no_auto_restore', 12:16:17 INFO - 'tabpaint']}, 12:16:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['tsvgx', 12:16:17 INFO - 'tsvgr_opacity', 12:16:17 INFO - 'tart', 12:16:17 INFO - 'tscrollx', 12:16:17 INFO - 'cart']}, 12:16:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:16:17 INFO - 'tsvgr_opacity', 12:16:17 INFO - 'tart', 12:16:17 INFO - 'tscrollx', 12:16:17 INFO - 'cart']}, 12:16:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'talos_options': ['--disable-e10s'], 12:16:17 INFO - 'tests': ['tp5o']}, 12:16:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'tests': ['tp5o']}, 12:16:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'talos_options': ['--disable-e10s', 12:16:17 INFO - '--xperf_path', 12:16:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:17 INFO - 'tests': ['tp5n']}, 12:16:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:17 INFO - 'talos_options': ['--xperf_path', 12:16:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:17 INFO - 'tests': ['tp5n']}}, 12:16:17 INFO - 'talos.zip': {'path': '', 12:16:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:17 INFO - Running post-action listener: _resource_record_post_action 12:16:17 INFO - ##### 12:16:17 INFO - ##### Running create-virtualenv step. 12:16:17 INFO - ##### 12:16:17 INFO - Running pre-action listener: _resource_record_pre_action 12:16:17 INFO - Running main action method: create_virtualenv 12:16:17 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:17 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 12:16:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:17 INFO - Using real prefix '/usr' 12:16:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:18 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:20 INFO - Installing pip.................done. 12:16:20 INFO - Return code: 0 12:16:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:16:20 INFO - Using env: {'DISPLAY': ':0', 12:16:20 INFO - 'HOME': '/home/cltbld', 12:16:20 INFO - 'LANG': 'en_US.UTF-8', 12:16:20 INFO - 'LANGUAGE': 'en_US:en', 12:16:20 INFO - 'LOGNAME': 'cltbld', 12:16:20 INFO - 'MAIL': '/var/mail/cltbld', 12:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:20 INFO - 'MOZ_NO_REMOTE': '1', 12:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:20 INFO - 'NO_EM_RESTART': '1', 12:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:20 INFO - 'PWD': '/builds/slave/test', 12:16:20 INFO - 'SHELL': '/bin/bash', 12:16:20 INFO - 'SHLVL': '1', 12:16:20 INFO - 'TERM': 'linux', 12:16:20 INFO - 'TMOUT': '86400', 12:16:20 INFO - 'USER': 'cltbld', 12:16:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:20 INFO - '_': '/tools/buildbot/bin/python'} 12:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:20 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 12:16:20 INFO - Cleaning up... 12:16:20 INFO - Return code: 0 12:16:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:16:20 INFO - Using env: {'DISPLAY': ':0', 12:16:20 INFO - 'HOME': '/home/cltbld', 12:16:20 INFO - 'LANG': 'en_US.UTF-8', 12:16:20 INFO - 'LANGUAGE': 'en_US:en', 12:16:20 INFO - 'LOGNAME': 'cltbld', 12:16:20 INFO - 'MAIL': '/var/mail/cltbld', 12:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:20 INFO - 'MOZ_NO_REMOTE': '1', 12:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:20 INFO - 'NO_EM_RESTART': '1', 12:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:20 INFO - 'PWD': '/builds/slave/test', 12:16:20 INFO - 'SHELL': '/bin/bash', 12:16:20 INFO - 'SHLVL': '1', 12:16:20 INFO - 'TERM': 'linux', 12:16:20 INFO - 'TMOUT': '86400', 12:16:20 INFO - 'USER': 'cltbld', 12:16:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:20 INFO - '_': '/tools/buildbot/bin/python'} 12:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:20 INFO - Downloading/unpacking psutil>=0.7.1 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:22 INFO - Installing collected packages: psutil 12:16:22 INFO - Running setup.py install for psutil 12:16:22 INFO - building 'psutil._psutil_linux' extension 12:16:22 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 12:16:23 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 12:16:23 INFO - building 'psutil._psutil_posix' extension 12:16:23 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 12:16:23 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 12:16:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:23 INFO - Successfully installed psutil 12:16:23 INFO - Cleaning up... 12:16:23 INFO - Return code: 0 12:16:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16:23 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')]} 12:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:23 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')]} 12:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:23 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 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:23 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 12:16:23 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 12:16:23 INFO - Using env: {'DISPLAY': ':0', 12:16:23 INFO - 'HOME': '/home/cltbld', 12:16:23 INFO - 'LANG': 'en_US.UTF-8', 12:16:23 INFO - 'LANGUAGE': 'en_US:en', 12:16:23 INFO - 'LOGNAME': 'cltbld', 12:16:23 INFO - 'MAIL': '/var/mail/cltbld', 12:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:23 INFO - 'MOZ_NO_REMOTE': '1', 12:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:23 INFO - 'NO_EM_RESTART': '1', 12:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:23 INFO - 'PWD': '/builds/slave/test', 12:16:23 INFO - 'SHELL': '/bin/bash', 12:16:23 INFO - 'SHLVL': '1', 12:16:23 INFO - 'TERM': 'linux', 12:16:23 INFO - 'TMOUT': '86400', 12:16:23 INFO - 'USER': 'cltbld', 12:16:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:23 INFO - '_': '/tools/buildbot/bin/python'} 12:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:25 INFO - Installing collected packages: mozsystemmonitor 12:16:25 INFO - Running setup.py install for mozsystemmonitor 12:16:25 INFO - Successfully installed mozsystemmonitor 12:16:25 INFO - Cleaning up... 12:16:25 INFO - Return code: 0 12:16:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:25 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 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:25 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 12:16:25 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 12:16:25 INFO - Using env: {'DISPLAY': ':0', 12:16:25 INFO - 'HOME': '/home/cltbld', 12:16:25 INFO - 'LANG': 'en_US.UTF-8', 12:16:25 INFO - 'LANGUAGE': 'en_US:en', 12:16:25 INFO - 'LOGNAME': 'cltbld', 12:16:25 INFO - 'MAIL': '/var/mail/cltbld', 12:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:25 INFO - 'MOZ_NO_REMOTE': '1', 12:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:25 INFO - 'NO_EM_RESTART': '1', 12:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:25 INFO - 'PWD': '/builds/slave/test', 12:16:25 INFO - 'SHELL': '/bin/bash', 12:16:25 INFO - 'SHLVL': '1', 12:16:25 INFO - 'TERM': 'linux', 12:16:25 INFO - 'TMOUT': '86400', 12:16:25 INFO - 'USER': 'cltbld', 12:16:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:25 INFO - '_': '/tools/buildbot/bin/python'} 12:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:25 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 12:16:25 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 12:16:25 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 12:16:25 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 12:16:25 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 12:16:25 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 12:16:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 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 12:16:28 INFO - Downloading docopt-0.6.1.tar.gz 12:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:28 INFO - Running setup.py install for blobuploader 12:16:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:28 INFO - Running setup.py install for requests 12:16:29 INFO - Running setup.py install for docopt 12:16:29 INFO - Successfully installed blobuploader requests docopt 12:16:29 INFO - Cleaning up... 12:16:29 INFO - Return code: 0 12:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:29 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')]} 12:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:29 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')]} 12:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:29 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 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:29 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 12:16:29 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 12:16:29 INFO - Using env: {'DISPLAY': ':0', 12:16:29 INFO - 'HOME': '/home/cltbld', 12:16:29 INFO - 'LANG': 'en_US.UTF-8', 12:16:29 INFO - 'LANGUAGE': 'en_US:en', 12:16:29 INFO - 'LOGNAME': 'cltbld', 12:16:29 INFO - 'MAIL': '/var/mail/cltbld', 12:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:29 INFO - 'MOZ_NO_REMOTE': '1', 12:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:29 INFO - 'NO_EM_RESTART': '1', 12:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:29 INFO - 'PWD': '/builds/slave/test', 12:16:29 INFO - 'SHELL': '/bin/bash', 12:16:29 INFO - 'SHLVL': '1', 12:16:29 INFO - 'TERM': 'linux', 12:16:29 INFO - 'TMOUT': '86400', 12:16:29 INFO - 'USER': 'cltbld', 12:16:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:29 INFO - '_': '/tools/buildbot/bin/python'} 12:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:29 INFO - Running setup.py (path:/tmp/pip-GlzRH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:29 INFO - Running setup.py (path:/tmp/pip-zMkatW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:29 INFO - Running setup.py (path:/tmp/pip-euWpOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:29 INFO - Running setup.py (path:/tmp/pip-PXQVEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:29 INFO - Running setup.py (path:/tmp/pip-XtAH14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:29 INFO - Running setup.py (path:/tmp/pip-nFZyat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:30 INFO - Running setup.py (path:/tmp/pip-SSNQYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:30 INFO - Running setup.py (path:/tmp/pip-dRNuRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:30 INFO - Running setup.py (path:/tmp/pip-nPHzdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:30 INFO - Running setup.py (path:/tmp/pip-05Q1Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:30 INFO - Running setup.py (path:/tmp/pip-4NhUyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:30 INFO - Running setup.py (path:/tmp/pip-hWQzxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:30 INFO - Running setup.py (path:/tmp/pip-RX_Nkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:30 INFO - Running setup.py (path:/tmp/pip-ZNwMW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:30 INFO - Running setup.py (path:/tmp/pip-AU_rep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:30 INFO - Running setup.py (path:/tmp/pip-e1E9iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:30 INFO - Running setup.py (path:/tmp/pip-KzGRDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:30 INFO - Running setup.py install for manifestparser 12:16:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:30 INFO - Running setup.py install for mozcrash 12:16:31 INFO - Running setup.py install for mozdebug 12:16:31 INFO - Running setup.py install for mozdevice 12:16:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Running setup.py install for mozfile 12:16:31 INFO - Running setup.py install for mozhttpd 12:16:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Running setup.py install for mozinfo 12:16:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Running setup.py install for mozInstall 12:16:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Running setup.py install for mozleak 12:16:31 INFO - Running setup.py install for mozlog 12:16:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Running setup.py install for moznetwork 12:16:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:31 INFO - Running setup.py install for mozprocess 12:16:32 INFO - Running setup.py install for mozprofile 12:16:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:32 INFO - Running setup.py install for mozrunner 12:16:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:32 INFO - Running setup.py install for mozscreenshot 12:16:32 INFO - Running setup.py install for moztest 12:16:32 INFO - Running setup.py install for mozversion 12:16:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:32 INFO - Cleaning up... 12:16:32 INFO - Return code: 0 12:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:32 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')]} 12:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:32 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')]} 12:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:32 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 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:32 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 12:16:32 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 12:16:32 INFO - Using env: {'DISPLAY': ':0', 12:16:32 INFO - 'HOME': '/home/cltbld', 12:16:32 INFO - 'LANG': 'en_US.UTF-8', 12:16:32 INFO - 'LANGUAGE': 'en_US:en', 12:16:32 INFO - 'LOGNAME': 'cltbld', 12:16:32 INFO - 'MAIL': '/var/mail/cltbld', 12:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:32 INFO - 'MOZ_NO_REMOTE': '1', 12:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:32 INFO - 'NO_EM_RESTART': '1', 12:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:32 INFO - 'PWD': '/builds/slave/test', 12:16:32 INFO - 'SHELL': '/bin/bash', 12:16:32 INFO - 'SHLVL': '1', 12:16:32 INFO - 'TERM': 'linux', 12:16:32 INFO - 'TMOUT': '86400', 12:16:32 INFO - 'USER': 'cltbld', 12:16:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:32 INFO - '_': '/tools/buildbot/bin/python'} 12:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:32 INFO - Running setup.py (path:/tmp/pip-ZX0zW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:32 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)) 12:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:32 INFO - Running setup.py (path:/tmp/pip-Fqjl0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:33 INFO - Running setup.py (path:/tmp/pip-Kuyhqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:33 INFO - Running setup.py (path:/tmp/pip-HXmpms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:33 INFO - Running setup.py (path:/tmp/pip-ETpTsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:33 INFO - Running setup.py (path:/tmp/pip-AbJoxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:33 INFO - Running setup.py (path:/tmp/pip-k8VXME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:33 INFO - Running setup.py (path:/tmp/pip-_KxPH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:33 INFO - Running setup.py (path:/tmp/pip-E0YM5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:33 INFO - Running setup.py (path:/tmp/pip-4h2z_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:33 INFO - Running setup.py (path:/tmp/pip-DBwnU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:33 INFO - Running setup.py (path:/tmp/pip-cPf9Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:33 INFO - Running setup.py (path:/tmp/pip-MpVdb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:33 INFO - Running setup.py (path:/tmp/pip-TKQGI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:33 INFO - Running setup.py (path:/tmp/pip-cqqzeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:33 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)) 12:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:33 INFO - Running setup.py (path:/tmp/pip-y4J5qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:34 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)) 12:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:34 INFO - Running setup.py (path:/tmp/pip-6fP3w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:34 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)) 12:16:34 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)) 12:16:34 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)) 12:16:34 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)) 12:16:34 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)) 12:16:34 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)) 12:16:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:35 INFO - Downloading blessings-1.6.tar.gz 12:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:36 INFO - Installing collected packages: blessings 12:16:36 INFO - Running setup.py install for blessings 12:16:36 INFO - Successfully installed blessings 12:16:36 INFO - Cleaning up... 12:16:36 INFO - Return code: 0 12:16:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:36 INFO - Reading from file tmpfile_stdout 12:16:36 INFO - Current package versions: 12:16:36 INFO - argparse == 1.2.1 12:16:36 INFO - blessings == 1.6 12:16:36 INFO - blobuploader == 1.2.4 12:16:36 INFO - docopt == 0.6.1 12:16:36 INFO - manifestparser == 1.1 12:16:36 INFO - mozInstall == 1.12 12:16:36 INFO - mozcrash == 0.17 12:16:36 INFO - mozdebug == 0.1 12:16:36 INFO - mozdevice == 0.48 12:16:36 INFO - mozfile == 1.2 12:16:36 INFO - mozhttpd == 0.7 12:16:36 INFO - mozinfo == 0.9 12:16:36 INFO - mozleak == 0.1 12:16:36 INFO - mozlog == 3.1 12:16:36 INFO - moznetwork == 0.27 12:16:36 INFO - mozprocess == 0.22 12:16:36 INFO - mozprofile == 0.28 12:16:36 INFO - mozrunner == 6.11 12:16:36 INFO - mozscreenshot == 0.1 12:16:36 INFO - mozsystemmonitor == 0.0 12:16:36 INFO - moztest == 0.7 12:16:36 INFO - mozversion == 1.4 12:16:36 INFO - psutil == 3.1.1 12:16:36 INFO - requests == 1.2.3 12:16:36 INFO - wsgiref == 0.1.2 12:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:36 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 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:36 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 12:16:36 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 12:16:36 INFO - Using env: {'DISPLAY': ':0', 12:16:36 INFO - 'HOME': '/home/cltbld', 12:16:36 INFO - 'LANG': 'en_US.UTF-8', 12:16:36 INFO - 'LANGUAGE': 'en_US:en', 12:16:36 INFO - 'LOGNAME': 'cltbld', 12:16:36 INFO - 'MAIL': '/var/mail/cltbld', 12:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:36 INFO - 'MOZ_NO_REMOTE': '1', 12:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:36 INFO - 'NO_EM_RESTART': '1', 12:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:36 INFO - 'PWD': '/builds/slave/test', 12:16:36 INFO - 'SHELL': '/bin/bash', 12:16:36 INFO - 'SHLVL': '1', 12:16:36 INFO - 'TERM': 'linux', 12:16:36 INFO - 'TMOUT': '86400', 12:16:36 INFO - 'USER': 'cltbld', 12:16:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:36 INFO - '_': '/tools/buildbot/bin/python'} 12:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 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)) 12:16:36 INFO - Cleaning up... 12:16:36 INFO - Return code: 0 12:16:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:16:36 INFO - Using env: {'DISPLAY': ':0', 12:16:36 INFO - 'HOME': '/home/cltbld', 12:16:36 INFO - 'LANG': 'en_US.UTF-8', 12:16:36 INFO - 'LANGUAGE': 'en_US:en', 12:16:36 INFO - 'LOGNAME': 'cltbld', 12:16:36 INFO - 'MAIL': '/var/mail/cltbld', 12:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:36 INFO - 'MOZ_NO_REMOTE': '1', 12:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:36 INFO - 'NO_EM_RESTART': '1', 12:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:36 INFO - 'PWD': '/builds/slave/test', 12:16:36 INFO - 'SHELL': '/bin/bash', 12:16:36 INFO - 'SHLVL': '1', 12:16:36 INFO - 'TERM': 'linux', 12:16:36 INFO - 'TMOUT': '86400', 12:16:36 INFO - 'USER': 'cltbld', 12:16:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:36 INFO - '_': '/tools/buildbot/bin/python'} 12:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:36 INFO - Downloading/unpacking jsonschema 12:16:36 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 12:16:36 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 12:16:36 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 12:16:36 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 12:16:36 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 12:16:36 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 12:16:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:16:38 INFO - Downloading/unpacking functools32 (from jsonschema) 12:16:38 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 12:16:38 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 12:16:38 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 12:16:38 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 12:16:38 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 12:16:38 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 12:16:38 INFO - Downloading functools32-3.2.3-2.tar.gz 12:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:16:39 INFO - warning: no files found matching '*.txt' 12:16:39 INFO - no previously-included directories found matching 'build' 12:16:39 INFO - no previously-included directories found matching 'dist' 12:16:39 INFO - no previously-included directories found matching '.git*' 12:16:39 INFO - Installing collected packages: jsonschema, functools32 12:16:39 INFO - Running setup.py install for functools32 12:16:39 INFO - warning: no files found matching '*.txt' 12:16:39 INFO - no previously-included directories found matching 'build' 12:16:39 INFO - no previously-included directories found matching 'dist' 12:16:39 INFO - no previously-included directories found matching '.git*' 12:16:39 INFO - Successfully installed jsonschema functools32 12:16:39 INFO - Cleaning up... 12:16:39 INFO - Return code: 0 12:16:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:39 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 0x7fb344838f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', '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 12:16:39 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 12:16:39 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 12:16:39 INFO - Using env: {'DISPLAY': ':0', 12:16:39 INFO - 'HOME': '/home/cltbld', 12:16:39 INFO - 'LANG': 'en_US.UTF-8', 12:16:39 INFO - 'LANGUAGE': 'en_US:en', 12:16:39 INFO - 'LOGNAME': 'cltbld', 12:16:39 INFO - 'MAIL': '/var/mail/cltbld', 12:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:39 INFO - 'MOZ_NO_REMOTE': '1', 12:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:39 INFO - 'NO_EM_RESTART': '1', 12:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:39 INFO - 'PWD': '/builds/slave/test', 12:16:39 INFO - 'SHELL': '/bin/bash', 12:16:39 INFO - 'SHLVL': '1', 12:16:39 INFO - 'TERM': 'linux', 12:16:39 INFO - 'TMOUT': '86400', 12:16:39 INFO - 'USER': 'cltbld', 12:16:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:39 INFO - '_': '/tools/buildbot/bin/python'} 12:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:39 INFO - Downloading/unpacking flake8 12:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:16:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:16:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:42 INFO - no previously-included directories found matching 'docs/_build' 12:16:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:16:42 INFO - Running setup.py install for pep8 12:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:42 INFO - no previously-included directories found matching 'docs/_build' 12:16:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:16:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:16:42 INFO - Cleaning up... 12:16:42 INFO - Return code: 0 12:16:42 INFO - Running post-action listener: _resource_record_post_action 12:16:42 INFO - Running post-action listener: _start_resource_monitoring 12:16:42 INFO - Starting resource monitoring. 12:16:42 INFO - ##### 12:16:42 INFO - ##### Running install step. 12:16:42 INFO - ##### 12:16:42 INFO - Running pre-action listener: _resource_record_pre_action 12:16:42 INFO - Running main action method: install 12:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:42 INFO - Reading from file tmpfile_stdout 12:16:42 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:42 INFO - Reading from file tmpfile_stdout 12:16:42 INFO - Output received: 12:16:42 INFO - Usage: mozinstall [options] installer 12:16:42 INFO - Options: 12:16:42 INFO - -h, --help show this help message and exit 12:16:42 INFO - -d DEST, --destination=DEST 12:16:42 INFO - Directory to install application into. [default: 12:16:42 INFO - "/builds/slave/test"] 12:16:42 INFO - --app=APP Application being installed. [default: firefox] 12:16:42 INFO - mkdir: /builds/slave/test/build/application 12:16:42 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'] 12:16:42 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 12:16:55 INFO - Reading from file tmpfile_stdout 12:16:55 INFO - Output received: 12:16:55 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:55 INFO - Running post-action listener: _resource_record_post_action 12:16:55 INFO - ##### 12:16:55 INFO - ##### Running run-tests step. 12:16:55 INFO - ##### 12:16:55 INFO - Running pre-action listener: _resource_record_pre_action 12:16:55 INFO - Running main action method: run_tests 12:16:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:55 INFO - Python 2.7.3 12:16:55 INFO - Return code: 0 12:16:55 INFO - grabbing minidump binary from tooltool 12:16:55 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')]} 12:16:55 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 0x272d410>, '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 0x272e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:55 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 12:16:55 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 12:16:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:56 INFO - Return code: 0 12:16:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:16:56 INFO - Return code: 0 12:16:56 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/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:16:56 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/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 12:16:56 INFO - Using env: {'DISPLAY': ':0', 12:16:56 INFO - 'HOME': '/home/cltbld', 12:16:56 INFO - 'LANG': 'en_US.UTF-8', 12:16:56 INFO - 'LANGUAGE': 'en_US:en', 12:16:56 INFO - 'LOGNAME': 'cltbld', 12:16:56 INFO - 'MAIL': '/var/mail/cltbld', 12:16:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:56 INFO - 'MOZ_NO_REMOTE': '1', 12:16:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:56 INFO - 'NO_EM_RESTART': '1', 12:16:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:56 INFO - 'PWD': '/builds/slave/test', 12:16:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:56 INFO - 'SHELL': '/bin/bash', 12:16:56 INFO - 'SHLVL': '1', 12:16:56 INFO - 'TERM': 'linux', 12:16:56 INFO - 'TMOUT': '86400', 12:16:56 INFO - 'USER': 'cltbld', 12:16:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914', 12:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:56 INFO - '_': '/tools/buildbot/bin/python'} 12:16:56 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/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:16:57 INFO - mozversion application_buildid: 20160627094317 12:16:57 INFO - mozversion application_changeset: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 12:16:57 INFO - mozversion application_display_name: Firefox 12:16:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:57 INFO - mozversion application_name: Firefox 12:16:57 INFO - mozversion application_remotingname: firefox 12:16:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:16:57 INFO - mozversion application_vendor: Mozilla 12:16:57 INFO - mozversion application_version: 48.0 12:16:57 INFO - mozversion platform_buildid: 20160627094317 12:16:57 INFO - mozversion platform_changeset: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 12:16:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:16:57 INFO - mozversion platform_version: 48.0 12:16:57 INFO - using testdate: 1467055017 12:16:57 INFO - actual date: 1467055017 12:16:57 INFO - starting webserver on 'localhost:37664' 12:16:57 INFO - SUITE-START | Running 2 tests 12:16:57 INFO - TEST-START | dromaeo_css 12:16:57 INFO - operating with platform_type : linux_ 12:16:57 INFO - Initialising browser for dromaeo_css test... 12:16:57 INFO - TEST-INFO | started process 2324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmyc4OY/profile http://localhost:37664/getInfo.html) 12:17:00 INFO - PROCESS | 2324 | 12:17:00 INFO - PROCESS | 2324 | (process:2475): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:17:01 INFO - PROCESS | 2324 | __metrics Screen width/height:1600/1200 12:17:01 INFO - PROCESS | 2324 | colorDepth:24 12:17:01 INFO - PROCESS | 2324 | Browser inner width/height: 1024/697 12:17:01 INFO - PROCESS | 2324 | __metrics 12:17:01 ERROR - PROCESS | 2324 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 12:17:02 INFO - TEST-INFO | 2324: exit 0 12:17:02 INFO - Browser initialized. 12:17:02 INFO - Running cycle 1/1 for dromaeo_css test... 12:17:02 INFO - TEST-INFO | started process 2545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmyc4OY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:04 INFO - PROCESS | 2545 | 12:17:04 INFO - PROCESS | 2545 | (process:2613): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:17:14 INFO - PROCESS | 2545 | RSS: Main: 150491136 12:17:14 INFO - PROCESS | 2545 | 12:18:03 INFO - PROCESS | 2545 | 1467055083919 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] 12:20:11 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37664/tests/dromaeo/cssquery-ext.html) 12:20:12 INFO - PROCESS | 2545 | RSS: Main: 154894336 12:20:12 INFO - PROCESS | 2545 | 12:23:14 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-ext.html (next: http://localhost:37664/tests/dromaeo/cssquery-jquery.html) 12:23:14 INFO - PROCESS | 2545 | RSS: Main: 152571904 12:23:14 INFO - PROCESS | 2545 | 12:26:16 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37664/tests/dromaeo/cssquery-mootools.html) 12:26:17 INFO - PROCESS | 2545 | RSS: Main: 152272896 12:26:17 INFO - PROCESS | 2545 | 12:29:18 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37664/tests/dromaeo/cssquery-prototype.html) 12:29:19 INFO - PROCESS | 2545 | RSS: Main: 153354240 12:29:19 INFO - PROCESS | 2545 | 12:32:21 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37664/tests/dromaeo/cssquery-yui.html) 12:32:22 INFO - PROCESS | 2545 | RSS: Main: 152616960 12:32:22 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-yui.html (next: http://localhost:37664/tests/dromaeo/cssquery-dojo.html) 12:35:24 INFO - PROCESS | 2545 | RSS: Main: 155504640 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | __start_tp_report 12:35:24 INFO - PROCESS | 2545 | _x_x_mozilla_page_load 12:35:24 INFO - PROCESS | 2545 | _x_x_mozilla_page_load_details 12:35:24 INFO - PROCESS | 2545 | |i|pagename|runs| 12:35:24 INFO - PROCESS | 2545 | |0;dojo.html;3309.7683162178646;3383.983080084602;3397.1337308986203;3404.4042292598797;3419.179396944734;5597.9160312595295;5607.046802043652;5634.802781902634;5639.971800141004;5673.886522269558;5562.638428502145;5599.7480113394895;5641.492265696086;5644.943550564493;5651.632643878145;5050.570701490368;5141.665791723544;5148.073346797575;5153.510416510426;5183.611229157828;5081.364829396325;5122.667026643275;5236;5261.500157485052;5261.86845328866;5117.283580298761;5141.280220769096;5145.716985565792;5214.556762675177;5229.60777941654;5187.584993200554;5194.220866869962;5196.662216955886;5209.192575150858;5232.215167724834;5000.74996250186;5041.470645582198;5130.153524668425;5163.0190263849745;5176.7929282828645;5490.203920431555;5493.615446918718;5569.248151499536;5573.498385145356;5602.635828671123;6044.335123136451;6071.332153463116;6081.6351018939;6101.938980610182;6102.908456373158;5840.766369345221;6055.636661800262;6133.386661333876;6142.0786881967615;6152.938470615326;5610.13042978339;5683.062294721325;5684.261046064026;5684.516816070639;5711.543076553908;6126.264848218242;6162.22972128484;6180.505559555315;6182.814515564541;6186.072089186568;5810.62230954995;5958.553108516879;5960.940390596125;5969.761209551656;6039.758409663565;6075.665838378844;6076.939230607726;6078.452939235402;6080.635161890301;6112;6010.9699451502465;6017.699115044318;6049.153118563405;6051.455369016721;6070.119832624333;5743.253377060955;5994.610350327302;6024.367441418675;6047.274327080779;6061.424164704346;4585.656075794262;4607.479531754513;4626.1441633297945;4630.236011058138;4649.279361698942;4111.684261036499;4140.772257525865;4150.128473020639;4164.479440069991;4167.4790651168605;5597.972010139923;5802.1296805479515;5819.418058194146;5864.530837532987;5909.852253693692;5999.520038396918;6073.119397687311;6077.665728384893;6103.6948152592195;6118.632882027093;5640.915386269209;5741.540676745851;5775.451332123442;5776.075827867521;5778.3643799182055;5122.590192784568;5151.7681704323395;5165.457626949116;5180.352455943007;5204.479552044765;6349.936500634934;6351.904721429182;6383.585066970632;6395.968020159869;6410.519211059189;5863.296404431496;6038.818835434944;6126.999999999911;6131.080337949344;6133.141360209664;6247.843803904939;6281.497480201481;6282.905756413566;6292.276388215414;6293.056041593614;5898.970505147447;5900.232969714081;5902.085176797603;5929.9110513341475;5948.851278718067;5861.120831875252;5987.221661184019;6008.128821320972;6083.239595050619;6137.836677219377;5946.821595352147;5957.672328022;5959.046552551571;5964.850878728066;5968.641881487125;5853.619514731528;5932.525397968238;5936.13925980739;5939.2575928009;5949.970250148722;5555.972220138873;5814.215080964016;5848.619839710405;5856.238688970407;5903.586748927705;5981.162637230704;5998.130271110752;6004.039353703386;6026.608270462406;6038.124471951454;5795.420457954171;5876.970615146897;5889.411058894077;5899.705014749331;5903.291605007426 12:35:24 INFO - PROCESS | 2545 | |1;ext.html;659.47242206235;678.4843518925616;698.3540225291604;735.959522226278;745.0351794426219;38385.61614383855;39166.60833391665;39233.215335693305;39237.803810980906;39296.80351598238;42952.57047429525;43137.78431107848;43466.130677386514;43482;43563.346549801776;8895.421797583153;9020.954895225515;9054.773630659252;9079.319051071163;9083.273338132967;8777.868331975025;8839.646414143426;8846.734597962071;8850.203481686647;8879.067697891725;9123.498207598579;9159.313051521129;9212.216961558275;9253.583588738524;9259.907400925971;9120.726378208632;9145.131212534798;9164.816703665956;9180.219681327095;9180.265578753684;8933.062028487046;9076.455412675261;9077.863832042525;9079;9099.909000909973;43253;43706.12587748227;43766.56233437688;43811.342829857575;43850.561494384965;3511.455724362728;3625.438057101127;3676.724245681558;3721.1627383838418;3738.719596030309;30419;30610.23474413135;30677;30924.536131958037;31885.521717174262;4544.182047231497;4563.0873825235085;4642.094791515656;4677.368555245032;4712.78792454337;214588;215877;216009;216086;216357;61756;62344;62753.68623156855;62862.37137628657;62895.6855215721;70147;70778;70831.64584177046;70836.29163708296;70940;18323.81676183221;18489.90755046216;18492.815071849378;18540.16569254387;18550.44348669542;14040.859591403956;14083.929580352238;14091.154530728189;14124.788128178085;14146.434142634385;19954.50113747139;20365.79634203639;20435.693464598044;20518.487037824172;21093.78906210949;7739.34215591681;7915.802104947423;8081.717139900193;8086.959565202136;8133.75598732039;1048.5596049659162;1055.7591363771448;1129.949147293009;1154.284343706907;1173.8239264110452;32527.674723252938;32833.343333133205;33475.33049338999;33579.496307555404;33714.15714607154;1175.077564112168;1243.8258643789877;1247.4386526063308;1262.659082047842;1333.8866196373417;17624.735628965576;17644.647107058045;17689.292428302724;17738.201780919888;17739.73390399145;524235;534875;554865;560617;564097;58126.41873581295;59249.70375148096;59285.40714592885;59303.70348148232;59557.70221148953;1504.8946573739952;1511.9697606047816;1541.8612324890814;1543.7452820284752;1569.050724311775;30265.546016810207;30866.84566577153;31112.92766568321;31601.683983159874;31876.203094921886;54564;55305.17042244289;55335.723321383135;55408;55620.721896390256;450309;453606;456808;456898;459020;31238.375232495677;31822.36355272928;32313.192170194994;32368.514472282463;32412.189695257806;49814.25278620751;50318.49681503284;50458.49541504685;50518.242226365895;51155.744221278655;42134.578654213066;42634.57365426306;42724;42971;43473.130537389705;41075;41156.382654259614;41410.37884431676;42037.6879271643;42705.57294427016;42001.159976800904;42762.358564622176;42879.57120428756;43074.78462607667;43292.134157316046;35288;35611.28777424385;36086.35709718699;36920.81539592392;36931.63068369282;28383.70565046022;28394.89017042688;28650.283742906595;28676;28900 12:35:24 INFO - PROCESS | 2545 | |2;jquery.html;441.8203396930196;446.5792033027014;448.14851781614925;448.39466719928123;452.889042184665;18936.90531547342;19004.14481348339;19563.804361956376;20150.59698806023;20172.59654806903;18462.723059154123;18749;18752.343667971625;20627.38117856463;20629.174833006662;5678.545716342683;5693.686847223401;5939.168516407706;5942.1680964664765;5943;5812.680302583356;5844.415558444164;5852.12218167274;5866.149408335788;5871.794487192949;5661.1508273758855;5854.795082172125;5865.384134665841;5887.470127688507;5897.3218079920925;5805.854853628651;5822.09757487588;5825.592208545382;5847.44449277318;5854.151148083547;5282.7622756976025;5314.734263286859;5323.44103869092;5340.652857564285;5346.518813306782;23349.182778602666;23608.055677772867;23717.16989905345;24162.87918560396;24195.274141775775;2417.2748175547267;2653.044903834618;2708.674959004912;2907.4766542022426;2958.955615665767;14921.552353429415;15081.321340539702;15234.390624375123;15305.846941530554;15623.218839058116;1985.2555291765589;1999.3701983875033;2052.9076191571266;2068.1520576563535;2134.0503475953205;72785;74055.25944740592;75543.62228188879;75659.99999999945;76469;11177.66467005991;11259.49332280033;11326.320420774615;11419.828702569468;11538.19232653723;16155.676886462204;16171.191440428167;16286.348546058025;16303.918480407521;16343.18284085791;8791.604377803014;8976.237019853386;8977.371583989057;9077.046910074347;9173;8631.223189912938;8668.523231222343;8726.25826804716;8759.255463285564;8875.689350872817;7083;7119.181294151239;7185.56886586796;7214.314640109181;7251.129864416198;2085.1034055356345;2180.258712037915;2196.242296407737;2217.390217690116;2231.5648448552374;982.40564458503;1071.0949247885524;1087.7552550676035;1116.7040734205443;1172.6188988578747;18183.727244091086;18845.05774711259;19877.30429434963;20386.388408347775;20531.692024619642;1092.1481244629201;1106.4799544214368;1117.9049780768562;1121.4224674292745;1200.0579545057087;11313.83029254562;11644.88355116455;11749.177557571058;11761.117916156323;11769.764604707858;550565;553556;561336;564001;564707;76180.23819761732;79456;81385.59307203426;81393;85615.57192213999;1109.290054365207;1118.116687816632;1155.3876445483907;1160.4023927677254;1164.4061528620296;16640;16741.33034678648;16871.156442177595;16941.15294235308;17280.22238999223;28045;39209.803950980066;39510;39703;42092;59241;59730.40269597249;59756.70121649364;59844.10233846409;60095.699521502116;8828.293736501193;8871.645134194818;9148.130927561871;9200.309976751903;9307.953460232655;11672.182947193614;13119.081664283409;13218.801717974431;13290.069695121249;13357.465701371837;10550.419726915094;10738.409387483764;12067.637970860887;12323;12325.876741232472;10843.295185812896;11488.712782180179;11803.409829508662;12121.090918181348;12127.090468214743;11987.760244794881;12415.503379864704;12455.065870059601;12469.314187719763;12488.625341239778;8735.43219690718;8872.556372181494;8998.235150012322;9002.009778924183;9042.683506077256;11662.358570278717;12037.277763334228;12049.036077113986;12056.939715301367;12192.451339689913 12:35:24 INFO - PROCESS | 2545 | |3;mootools.html;1559.2749371542234;1568.1140155811966;1746.2229307957964;1850.1396850464532;1886.3114963038495;7362.447816413764;8439.873401898976;8663.220310172092;8868.733937981862;8884.955575222115;8527.14728527147;8533.658653653847;8542.14578542147;8645.87031194531;8659.567021648923;2336.4275752440635;2366.857988520694;2369.1944738788807;2374.2639781667654;2378.1319818266293;2384.582698027847;2394.0423830467867;2445.951080978379;2451.0685939343025;2452.5953217719057;2409.409694624819;2419.4314336130997;2435.4520232947534;2450.15469662966;2465.4329504214043;2414.843035202715;2419.5644783938883;2423.987880060597;2426.1023421334044;2449.8162637802056;2387.057112440576;2392.2823153054187;2402.039184326266;2403.0507949359903;2407.915722949706;8897.154770296811;8908.599113039929;8922.464652120894;8922.910770892273;8984.326175536795;5402.243685883979;5513.228148059235;5515.641483303612;5538.6399884007415;5547.611667183299;3438.948415773765;3464.116650254194;3480.3387356402454;3501.8074005929666;3528.153243221608;1109.351029647657;1161.9419029048513;1164.9592264270796;1190.9523619055228;1192.8031874740657;11472.827907581393;11490;11529.077673786078;11540.30758154505;11629.3022418656;4626.83806066786;4731.503192164842;4746.335513028179;4766.666333356632;4796.736179510161;9989.950050249703;10024.546440766047;10044.246681498917;10046.04562566555;10103.545340459697;5431.37539182999;5433.157860531624;5474.42518535556;5493.340799104053;5494.642848214853;4977.8257760978195;5009.24861270805;5157.535821776059;5180;5187.351581052369;3915.6084391561185;3930.862419815293;3961.1087505311652;4018.799060046986;4022.255882661717;1192.0999645267768;1197.2935967779051;1198.8381568488317;1204.6747378207835;1224.412282104577;984.3404918704485;988.7577543501889;1037.7094413564214;1113.4822307626991;1122.4107343644653;6077.665728384981;6092.817215483543;6102.176206212193;6140.600860944024;6186.350433204539;489.51782494243145;493.58292243054564;503.9067772462033;507.6091409614576;512.1881817319515;4423.60187583119;4452.844150454718;4480.193565158303;4481.148581769454;4502.842400515966;10732.195085368628;10800.729981750519;11140.442977851075;11171.720706982227;11187.216894817448;10910.345379277269;10914.781704365869;10990;10990.890091099147;10999;8091.474054186459;8273.793155171048;8298.377621678399;8342.499450033018;8466.40735148546;6222.844428889314;6385.233771947396;6441.098246245436;6444.8388790280615;6476.12572302752;9799.167070798776;9872.753181170528;10081;10083.193344532274;10138.580598716038;9910.504474776088;9924.156446701822;10163.593456261668;10390.324628899098;10393.480325983519;7620.276073772982;7897.368210543028;7908.920910791048;7994.760157195061;8165.673373065249;8397;8482.066972633129;8504.829903401773;8529.402941794015;8571.742847714579;7488.812779680552;7589.1651918290045;7593.696252150073;7695.92304076952;7824.100228473799;7624.046994125734;7639.885401718868;7661.118971318369;7751.147373788766;7759.185285544936;6939.410150137295;6976.232614412512;6990.475714321345;6999.30006999296;7003.964980175067;5414.539764120094;5453.372862120907;5456.345238571397;5553.722313884209;5599.832005039855;5433.701146436984;5539.058360078716;5604.075327571069;5609.1305847593685;5613.74738136793 12:35:24 INFO - PROCESS | 2545 | |4;prototype.html;354.3285474026719;364.9270145970806;368.32228699193496;370.64047873562635;371.263042859923;6435.292117867042;6458.677066146697;6540.149780528531;6632.20413550374;6695.430888374494;6439.613623182612;6586.8682626347445;6592.077109204715;6605.372489613491;6613.735450581983;5024.296598476216;5024.422191447976;5024.5226703463295;5027.874303142423;5055.292259083732;5041.949580504184;5042.672226305297;5043.016611760708;5047.394312682483;5051.898962020758;4960.88380114475;4978.377702787152;4990.925136122961;4991;5003.574696150813;4751.287306903958;4894.5105489451125;4997.425296090942;5000.674956127858;5008.574271186935;4244.257254980366;4247.065645557972;4256.212600668886;4259.5740425957465;4263.658907287409;6216.316205217422;6229.2836323822885;6258.1551490548645;6277.278113017016;6315.778947736853;5776.422357764232;5784.363719990798;5787.88424231513;5789.681567513785;5790.623609465371;6894.9655251723925;6905.585664860125;6925.861482770317;6940.861182776367;6944.6180460074675;4554.977225113853;4636;4753.667243292936;4794.2808578713475;4807.543283388072;7152.4278057755255;7261.818454538626;7279.89080163798;7286;7345.522541034816;4841.927371089437;4851.442084160296;4853.611711063107;4857.344258525054;4872.3909511311085;4937.851864444073;4938.160512712848;4944.283078953532;4945.4807245238735;4953.479884612064;5724.198612194296;5731.197632331477;5735.139729040678;5736.971315143398;5738.340090889601;6849.623270720158;6960.512764106566;6984.61584612841;6997.580145191203;6999.685014174374;1720.8279172082691;1730.7749992500894;1737.2963949600432;1738.8435040846384;1740.477856643002;1098.4452851310198;1117.541807858774;1121.3328069798456;1132.6998345438465;1135.250734515216;6628.635425051572;6651.16860392451;6728.865422691617;6729.05793188954;6730.192376914802;7114.893276600855;7120.181179164462;7131.679074441558;7142.607156606437;7142.821429464201;6632.104665870046;6691.26396096429;6700.095487109275;6701.32986701326;6708.932910670928;3850.5186851643543;3867.2652196082654;3868.303705333011;3868.458415821787;3884.2425726982965;7398.815029624195;7563.432742544332;7721.227877212346;7726.729564465217;7736.690532378754;7358.4547245078065;7430.294122058396;7440.069991251094;7441.888371674321;7454.589997550187;7653.387728981668;7677.577733224614;7685.807854803675;7686.423518236154;7687.077550693953;7172.354488096096;7294.978702981481;7300.16048154469;7303.488755787044;7304.379127774198;7054.717811287491;7082.327178917994;7099.82250443743;7104.076470058859;7126.964365178141;7601.353884919623;7646.923530764843;7656.464047516621;7660.425468089804;7662.655180516778;4845;4892.437369702529;4900.411950565955;4925.6305777066145;4933.679310844927;7000.719971201095;7229;7235.891461628185;7253.673584688807;7257.455690823103;7037.472189585699;7051.365377116084;7056.400205982343;7059.611721355374;7070.505064645426;6987.965060174666;7061.329173728487;7063.5408698436495;7064.717411303491;7090.539114957512;6947.3747362737595;6951.756688515878;6952.44380449573;6958.8956165658565;6959.826004349932;7004.649767511706;7110.431165506644;7121.893171602534;7125.572465652078;7127.465440092117;6703.564268322543;6946.2011868635755;6974.128233970754;7014.368706816411;7019.6841142147705 12:35:24 INFO - PROCESS | 2545 | |5;yui.html;812.5612169428509;866.3978534918231;868.1101870582653;877.8310546343446;878.7012415778634;14974.700505989887;15114.697706045872;15126.621834454116;15133.697326053487;15172.620684482894;14407;14461.060031097997;14486.42054317826;14489.058211216263;14532.709345813077;847.5380917400001;897.4256475855458;906.1301150895149;910.9134632209963;930.8277968575801;887.1217494680252;911.3165126155384;911.4485736129612;913.9451632902014;916.1205242966727;937.7139972308444;970.0735797313583;970.8446648536236;970.9077637624414;973.7224890906093;929.3169520402532;957.5020989085706;957.6504575829772;962;964.2527041542791;681.5025031726817;702.3994484715546;708.7838209346147;709.0392518137952;713.2617740638466;15958.202089895458;16036.599085022968;16069;16071.678566428605;16132.274047667766;14336.354864031144;14430.062045966979;14486.637834054127;14683;14688.118712877262;11315.717107072307;11331.09351251906;11447.542098316057;11468.71328216793;11619.302841829433;3991.860284890044;4008.5590585035625;4076.735012224196;4084.979575102135;4182.330827067654;54690;55387;55387.446125539034;58472.70763646197;58958;10385.532651030571;10389.94805025985;10442.2168337375;10573.682789516326;10656.254062215725;16721.16394180286;16909.7463538047;16917.154142292835;17465.7380139298;18232.817671823377;8764.56177191138;8837.955810220908;8963.775905602412;8989.865152022725;9046.638134474679;4550.704204226715;4704.482506924235;4713.764311784397;4770.570648641569;5104.897902041938;3719.1631882826146;3773.754705944105;3782.394816829294;3789.4315852621776;3798.772073675588;703.4548225125569;704.3414407528977;708.5111273221461;713.5825542057954;715.3275920634587;687.71116131225;772.3975299266468;799.3844739550514;805.5448671500584;853.8761879527434;9726.319157658896;10184.490775461198;10232.64185753495;10322.277440579088;10365.844512332322;595.6098755315276;658.7760161545098;769.3575864153495;781.4295564238138;787.7321710618418;4643.164230438553;4804.855854324376;4828.830990915301;4833.613310935117;4865.513448655106;62228.688856556335;63029;63267;68929;70058.2994170062;56640.716796415756;56969.7151514248;57913.4208657908;59132.40867591269;60749.39250607526;48540.757296214;49822.75088624606;51493.485065149616;51528.22707659388;53534;10210.336328138646;10298.639547615798;10521.473926303808;10750.838737418788;10766.461676915966;38034.239315214094;38467;38483.42274865935;39659.40510892281;39918.80040599778;46456.7677161612;47534;51273;51602.74198628983;52229;10776.67669969902;10986.285891417032;12698.936505317415;12858.292793896051;13195.274259915797;13824.654383640489;14073.415216717589;14648.926755366156;14737.410503579737;14801.259937003322;13654.726905462034;13891.097078689852;13942.651433714238;13964.441422342992;14049.157050576998;12522.123451358682;12751.872481275439;12921.806172907602;13288.667783305495;13499.987500937665;12089.15375923677;12446.626601201979;12670.556530521388;13318.866811331764;13552.79670804919;10877.401742904216;10907.618233361794;11179.832302515306;11527.135464840338;11888.723298559364;11757.529698812294;12051.517939282681;12073.034157267222;12090.697732556757;12366.381680916098 12:35:24 INFO - PROCESS | 2545 | __end_tp_report 12:35:24 INFO - PROCESS | 2545 | __start_cc_report 12:35:24 INFO - PROCESS | 2545 | _x_x_mozilla_cycle_collect,328 12:35:24 INFO - PROCESS | 2545 | __end_cc_report 12:35:24 INFO - PROCESS | 2545 | __startTimestamp1467056124582__endTimestamp 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | ------- Summary: start ------- 12:35:24 INFO - PROCESS | 2545 | Number of tests: 6 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | [#0] dojo.html Cycles:165 Average:5629.51 Median:5861.12 stddev:630.78 (10.8%) stddev-sans-first:605.89 12:35:24 INFO - PROCESS | 2545 | Values: 3309.8 3384.0 3397.1 3404.4 3419.2 5597.9 5607.0 5634.8 5640.0 5673.9 5562.6 5599.7 5641.5 5644.9 5651.6 5050.6 5141.7 5148.1 5153.5 5183.6 5081.4 5122.7 5236.0 5261.5 5261.9 5117.3 5141.3 5145.7 5214.6 5229.6 5187.6 5194.2 5196.7 5209.2 5232.2 5000.7 5041.5 5130.2 5163.0 5176.8 5490.2 5493.6 5569.2 5573.5 5602.6 6044.3 6071.3 6081.6 6101.9 6102.9 5840.8 6055.6 6133.4 6142.1 6152.9 5610.1 5683.1 5684.3 5684.5 5711.5 6126.3 6162.2 6180.5 6182.8 6186.1 5810.6 5958.6 5960.9 5969.8 6039.8 6075.7 6076.9 6078.5 6080.6 6112.0 6011.0 6017.7 6049.2 6051.5 6070.1 5743.3 5994.6 6024.4 6047.3 6061.4 4585.7 4607.5 4626.1 4630.2 4649.3 4111.7 4140.8 4150.1 4164.5 4167.5 5598.0 5802.1 5819.4 5864.5 5909.9 5999.5 6073.1 6077.7 6103.7 6118.6 5640.9 5741.5 5775.5 5776.1 5778.4 5122.6 5151.8 5165.5 5180.4 5204.5 6349.9 6351.9 6383.6 6396.0 6410.5 5863.3 6038.8 6127.0 6131.1 6133.1 6247.8 6281.5 6282.9 6292.3 6293.1 5899.0 5900.2 5902.1 5929.9 5948.9 5861.1 5987.2 6008.1 6083.2 6137.8 5946.8 5957.7 5959.0 5964.9 5968.6 5853.6 5932.5 5936.1 5939.3 5950.0 5556.0 5814.2 5848.6 5856.2 5903.6 5981.2 5998.1 6004.0 6026.6 6038.1 5795.4 5877.0 5889.4 5899.7 5903.3 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | [#1] ext.html Cycles:180 Average:58310.50 Median:42916.07 stddev:114388.07 (266.5%) stddev-sans-first:114627.06 12:35:24 INFO - PROCESS | 2545 | Values: 659.5 678.5 698.4 736.0 745.0 38385.6 39166.6 39233.2 39237.8 39296.8 42952.6 43137.8 43466.1 43482.0 43563.3 8895.4 9021.0 9054.8 9079.3 9083.3 8777.9 8839.6 8846.7 8850.2 8879.1 9123.5 9159.3 9212.2 9253.6 9259.9 9120.7 9145.1 9164.8 9180.2 9180.3 8933.1 9076.5 9077.9 9079.0 9099.9 43253.0 43706.1 43766.6 43811.3 43850.6 3511.5 3625.4 3676.7 3721.2 3738.7 30419.0 30610.2 30677.0 30924.5 31885.5 4544.2 4563.1 4642.1 4677.4 4712.8 214588.0 215877.0 216009.0 216086.0 216357.0 61756.0 62344.0 62753.7 62862.4 62895.7 70147.0 70778.0 70831.6 70836.3 70940.0 18323.8 18489.9 18492.8 18540.2 18550.4 14040.9 14083.9 14091.2 14124.8 14146.4 19954.5 20365.8 20435.7 20518.5 21093.8 7739.3 7915.8 8081.7 8087.0 8133.8 1048.6 1055.8 1129.9 1154.3 1173.8 32527.7 32833.3 33475.3 33579.5 33714.2 1175.1 1243.8 1247.4 1262.7 1333.9 17624.7 17644.6 17689.3 17738.2 17739.7 524235.0 534875.0 554865.0 560617.0 564097.0 58126.4 59249.7 59285.4 59303.7 59557.7 1504.9 1512.0 1541.9 1543.7 1569.1 30265.5 30866.8 31112.9 31601.7 31876.2 54564.0 55305.2 55335.7 55408.0 55620.7 450309.0 453606.0 456808.0 456898.0 459020.0 31238.4 31822.4 32313.2 32368.5 32412.2 49814.3 50318.5 50458.5 50518.2 51155.7 42134.6 42634.6 42724.0 42971.0 43473.1 41075.0 41156.4 41410.4 42037.7 42705.6 42001.2 42762.4 42879.6 43074.8 43292.1 35288.0 35611.3 36086.4 36920.8 36931.6 28383.7 28394.9 28650.3 28676.0 28900.0 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | [#2] jquery.html Cycles:180 Average:30795.90 Median:23662.61 stddev:91450.44 (386.5%) stddev-sans-first:91678.58 12:35:24 INFO - PROCESS | 2545 | Values: 441.8 446.6 448.1 448.4 452.9 18936.9 19004.1 19563.8 20150.6 20172.6 18462.7 18749.0 18752.3 20627.4 20629.2 5678.5 5693.7 5939.2 5942.2 5943.0 5812.7 5844.4 5852.1 5866.1 5871.8 5661.2 5854.8 5865.4 5887.5 5897.3 5805.9 5822.1 5825.6 5847.4 5854.2 5282.8 5314.7 5323.4 5340.7 5346.5 23349.2 23608.1 23717.2 24162.9 24195.3 2417.3 2653.0 2708.7 2907.5 2959.0 14921.6 15081.3 15234.4 15305.8 15623.2 1985.3 1999.4 2052.9 2068.2 2134.1 72785.0 74055.3 75543.6 75660.0 76469.0 11177.7 11259.5 11326.3 11419.8 11538.2 16155.7 16171.2 16286.3 16303.9 16343.2 8791.6 8976.2 8977.4 9077.0 9173.0 8631.2 8668.5 8726.3 8759.3 8875.7 7083.0 7119.2 7185.6 7214.3 7251.1 2085.1 2180.3 2196.2 2217.4 2231.6 982.4 1071.1 1087.8 1116.7 1172.6 18183.7 18845.1 19877.3 20386.4 20531.7 1092.1 1106.5 1117.9 1121.4 1200.1 11313.8 11644.9 11749.2 11761.1 11769.8 550565.0 553556.0 561336.0 564001.0 564707.0 76180.2 79456.0 81385.6 81393.0 85615.6 1109.3 1118.1 1155.4 1160.4 1164.4 16640.0 16741.3 16871.2 16941.2 17280.2 28045.0 39209.8 39510.0 39703.0 42092.0 59241.0 59730.4 59756.7 59844.1 60095.7 8828.3 8871.6 9148.1 9200.3 9308.0 11672.2 13119.1 13218.8 13290.1 13357.5 10550.4 10738.4 12067.6 12323.0 12325.9 10843.3 11488.7 11803.4 12121.1 12127.1 11987.8 12415.5 12455.1 12469.3 12488.6 8735.4 8872.6 8998.2 9002.0 9042.7 11662.4 12037.3 12049.0 12056.9 12192.5 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | [#3] mootools.html Cycles:180 Average:5851.35 Median:4993.54 stddev:3226.67 (64.6%) stddev-sans-first:3219.60 12:35:24 INFO - PROCESS | 2545 | Values: 1559.3 1568.1 1746.2 1850.1 1886.3 7362.4 8439.9 8663.2 8868.7 8885.0 8527.1 8533.7 8542.1 8645.9 8659.6 2336.4 2366.9 2369.2 2374.3 2378.1 2384.6 2394.0 2446.0 2451.1 2452.6 2409.4 2419.4 2435.5 2450.2 2465.4 2414.8 2419.6 2424.0 2426.1 2449.8 2387.1 2392.3 2402.0 2403.1 2407.9 8897.2 8908.6 8922.5 8922.9 8984.3 5402.2 5513.2 5515.6 5538.6 5547.6 3438.9 3464.1 3480.3 3501.8 3528.2 1109.4 1161.9 1165.0 1191.0 1192.8 11472.8 11490.0 11529.1 11540.3 11629.3 4626.8 4731.5 4746.3 4766.7 4796.7 9990.0 10024.5 10044.2 10046.0 10103.5 5431.4 5433.2 5474.4 5493.3 5494.6 4977.8 5009.2 5157.5 5180.0 5187.4 3915.6 3930.9 3961.1 4018.8 4022.3 1192.1 1197.3 1198.8 1204.7 1224.4 984.3 988.8 1037.7 1113.5 1122.4 6077.7 6092.8 6102.2 6140.6 6186.4 489.5 493.6 503.9 507.6 512.2 4423.6 4452.8 4480.2 4481.1 4502.8 10732.2 10800.7 11140.4 11171.7 11187.2 10910.3 10914.8 10990.0 10990.9 10999.0 8091.5 8273.8 8298.4 8342.5 8466.4 6222.8 6385.2 6441.1 6444.8 6476.1 9799.2 9872.8 10081.0 10083.2 10138.6 9910.5 9924.2 10163.6 10390.3 10393.5 7620.3 7897.4 7908.9 7994.8 8165.7 8397.0 8482.1 8504.8 8529.4 8571.7 7488.8 7589.2 7593.7 7695.9 7824.1 7624.0 7639.9 7661.1 7751.1 7759.2 6939.4 6976.2 6990.5 6999.3 7004.0 5414.5 5453.4 5456.3 5553.7 5599.8 5433.7 5539.1 5604.1 5609.1 5613.7 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | [#4] prototype.html Cycles:180 Average:5842.55 Median:6641.69 stddev:1799.70 (27.1%) stddev-sans-first:1756.97 12:35:24 INFO - PROCESS | 2545 | Values: 354.3 364.9 368.3 370.6 371.3 6435.3 6458.7 6540.1 6632.2 6695.4 6439.6 6586.9 6592.1 6605.4 6613.7 5024.3 5024.4 5024.5 5027.9 5055.3 5041.9 5042.7 5043.0 5047.4 5051.9 4960.9 4978.4 4990.9 4991.0 5003.6 4751.3 4894.5 4997.4 5000.7 5008.6 4244.3 4247.1 4256.2 4259.6 4263.7 6216.3 6229.3 6258.2 6277.3 6315.8 5776.4 5784.4 5787.9 5789.7 5790.6 6895.0 6905.6 6925.9 6940.9 6944.6 4555.0 4636.0 4753.7 4794.3 4807.5 7152.4 7261.8 7279.9 7286.0 7345.5 4841.9 4851.4 4853.6 4857.3 4872.4 4937.9 4938.2 4944.3 4945.5 4953.5 5724.2 5731.2 5735.1 5737.0 5738.3 6849.6 6960.5 6984.6 6997.6 6999.7 1720.8 1730.8 1737.3 1738.8 1740.5 1098.4 1117.5 1121.3 1132.7 1135.3 6628.6 6651.2 6728.9 6729.1 6730.2 7114.9 7120.2 7131.7 7142.6 7142.8 6632.1 6691.3 6700.1 6701.3 6708.9 3850.5 3867.3 3868.3 3868.5 3884.2 7398.8 7563.4 7721.2 7726.7 7736.7 7358.5 7430.3 7440.1 7441.9 7454.6 7653.4 7677.6 7685.8 7686.4 7687.1 7172.4 7295.0 7300.2 7303.5 7304.4 7054.7 7082.3 7099.8 7104.1 7127.0 7601.4 7646.9 7656.5 7660.4 7662.7 4845.0 4892.4 4900.4 4925.6 4933.7 7000.7 7229.0 7235.9 7253.7 7257.5 7037.5 7051.4 7056.4 7059.6 7070.5 6988.0 7061.3 7063.5 7064.7 7090.5 6947.4 6951.8 6952.4 6958.9 6959.8 7004.6 7110.4 7121.9 7125.6 7127.5 6703.6 6946.2 6974.1 7014.4 7019.7 12:35:24 INFO - PROCESS | 2545 | 12:35:24 INFO - PROCESS | 2545 | [#5] yui.html Cycles:180 Average:15652.53 Median:4042.65 stddev:18051.67 (446.5%) stddev-sans-first:18067.91 12:35:24 INFO - PROCESS | 2545 | Values: 812.6 866.4 868.1 877.8 878.7 14974.7 15114.7 15126.6 15133.7 15172.6 14407.0 14461.1 14486.4 14489.1 14532.7 847.5 897.4 906.1 910.9 930.8 887.1 911.3 911.4 913.9 916.1 937.7 970.1 970.8 970.9 973.7 929.3 957.5 957.7 962.0 964.3 681.5 702.4 708.8 709.0 713.3 15958.2 16036.6 16069.0 16071.7 16132.3 14336.4 14430.1 14486.6 14683.0 14688.1 11315.7 11331.1 11447.5 11468.7 11619.3 3991.9 4008.6 4076.7 4085.0 4182.3 54690.0 55387.0 55387.4 58472.7 58958.0 10385.5 10389.9 10442.2 10573.7 10656.3 16721.2 16909.7 16917.2 17465.7 18232.8 8764.6 8838.0 8963.8 8989.9 9046.6 4550.7 4704.5 4713.8 4770.6 5104.9 3719.2 3773.8 3782.4 3789.4 3798.8 703.5 704.3 708.5 713.6 715.3 687.7 772.4 799.4 805.5 853.9 9726.3 10184.5 10232.6 10322.3 10365.8 595.6 658.8 769.4 781.4 787.7 4643.2 4804.9 4828.8 4833.6 4865.5 62228.7 63029.0 63267.0 68929.0 70058.3 56640.7 56969.7 57913.4 59132.4 60749.4 48540.8 49822.8 51493.5 51528.2 53534.0 10210.3 10298.6 10521.5 10750.8 10766.5 38034.2 38467.0 38483.4 39659.4 39918.8 46456.8 47534.0 51273.0 51602.7 52229.0 10776.7 10986.3 12698.9 12858.3 13195.3 13824.7 14073.4 14648.9 14737.4 14801.3 13654.7 13891.1 13942.7 13964.4 14049.2 12522.1 12751.9 12921.8 13288.7 13500.0 12089.2 12446.6 12670.6 13318.9 13552.8 10877.4 10907.6 11179.8 11527.1 11888.7 11757.5 12051.5 12073.0 12090.7 12366.4 12:35:24 INFO - PROCESS | 2545 | -------- Summary: end -------- 12:35:24 INFO - PROCESS | 2545 | 12:35:25 INFO - TEST-INFO | 2545: exit 0 12:35:25 INFO - TEST-OK | dromaeo_css | took 1108118ms 12:35:25 INFO - TEST-START | kraken 12:35:25 INFO - operating with platform_type : linux_ 12:35:25 INFO - Initialising browser for kraken test... 12:35:25 INFO - TEST-INFO | started process 2889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpadU8f5/profile http://localhost:37664/getInfo.html) 12:35:28 INFO - PROCESS | 2889 | 12:35:28 INFO - PROCESS | 2889 | (process:2970): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:35:29 INFO - PROCESS | 2889 | __metrics Screen width/height:1600/1200 12:35:29 INFO - PROCESS | 2889 | colorDepth:24 12:35:29 INFO - PROCESS | 2889 | Browser inner width/height: 1024/697 12:35:29 INFO - PROCESS | 2889 | __metrics 12:35:29 ERROR - PROCESS | 2889 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 12:35:30 INFO - TEST-INFO | 2889: exit 0 12:35:30 INFO - Browser initialized. 12:35:30 INFO - Running cycle 1/1 for kraken test... 12:35:30 INFO - TEST-INFO | started process 3020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpadU8f5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:32 INFO - PROCESS | 3020 | 12:35:32 INFO - PROCESS | 3020 | (process:3087): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:35:42 INFO - PROCESS | 3020 | RSS: Main: 151109632 12:35:42 INFO - PROCESS | 3020 | 12:35:45 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:45 INFO - PROCESS | 3020 | RSS: Main: 155983872 12:35:45 INFO - PROCESS | 3020 | 12:35:48 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-dft) 12:35:49 INFO - PROCESS | 3020 | RSS: Main: 156164096 12:35:49 INFO - PROCESS | 3020 | 12:35:52 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-fft) 12:35:52 INFO - PROCESS | 3020 | RSS: Main: 156860416 12:35:52 INFO - PROCESS | 3020 | 12:35:54 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-oscillator) 12:35:55 INFO - PROCESS | 3020 | RSS: Main: 156864512 12:35:55 INFO - PROCESS | 3020 | 12:35:57 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:58 INFO - PROCESS | 3020 | RSS: Main: 156254208 12:35:58 INFO - PROCESS | 3020 | 12:36:01 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37664/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:01 INFO - PROCESS | 3020 | RSS: Main: 156479488 12:36:01 INFO - PROCESS | 3020 | 12:36:05 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37664/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:05 INFO - PROCESS | 3020 | RSS: Main: 156332032 12:36:05 INFO - PROCESS | 3020 | 12:36:08 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37664/tests/kraken/driver.html?testName=json-parse-financial) 12:36:09 INFO - PROCESS | 3020 | RSS: Main: 156553216 12:36:09 INFO - PROCESS | 3020 | 12:36:10 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:11 INFO - PROCESS | 3020 | RSS: Main: 156024832 12:36:11 INFO - PROCESS | 3020 | 12:36:12 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:13 INFO - PROCESS | 3020 | RSS: Main: 156676096 12:36:13 INFO - PROCESS | 3020 | 12:36:15 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:16 INFO - PROCESS | 3020 | RSS: Main: 156426240 12:36:16 INFO - PROCESS | 3020 | 12:36:18 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:19 INFO - PROCESS | 3020 | RSS: Main: 157028352 12:36:19 INFO - PROCESS | 3020 | 12:36:21 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:22 INFO - PROCESS | 3020 | RSS: Main: 156659712 12:36:22 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37664/tests/kraken/driver.html?testName=ai-astar) 12:36:24 INFO - PROCESS | 3020 | RSS: Main: 157925376 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | __start_tp_report 12:36:24 INFO - PROCESS | 3020 | _x_x_mozilla_page_load 12:36:24 INFO - PROCESS | 3020 | _x_x_mozilla_page_load_details 12:36:24 INFO - PROCESS | 3020 | |i|pagename|runs| 12:36:24 INFO - PROCESS | 3020 | |0;ai-astar;108;112;104;110;111;112;101;110;111;109 12:36:24 INFO - PROCESS | 3020 | |1;audio-beat-detection;156;127;168;178;135;157;154;135;186;134 12:36:24 INFO - PROCESS | 3020 | |2;audio-dft;162;163;162;163;161;162;162;164;162;162 12:36:24 INFO - PROCESS | 3020 | |3;audio-fft;75;74;76;177;78;76;76;75;164;75 12:36:24 INFO - PROCESS | 3020 | |4;audio-oscillator;93;92;154;92;92;92;149;92;93;151 12:36:24 INFO - PROCESS | 3020 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;117;117;117 12:36:24 INFO - PROCESS | 3020 | |6;imaging-darkroom;147;146;146;146;147;147;147;147;146;149 12:36:24 INFO - PROCESS | 3020 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;95;95 12:36:24 INFO - PROCESS | 3020 | |8;json-parse-financial;56;56;55;56;58;60;56;74;54;54 12:36:24 INFO - PROCESS | 3020 | |9;json-stringify-tinderbox;61;61;62;60;60;60;62;60;58;59 12:36:24 INFO - PROCESS | 3020 | |10;stanford-crypto-aes;79;72;73;73;81;74;75;72;74;73 12:36:24 INFO - PROCESS | 3020 | |11;stanford-crypto-ccm;117;115;118;115;117;117;114;114;138;132 12:36:24 INFO - PROCESS | 3020 | |12;stanford-crypto-pbkdf2;162;163;166;160;158;156;153;160;158;155 12:36:24 INFO - PROCESS | 3020 | |13;stanford-crypto-sha256-iterative;66;67;65;65;65;66;64;65;65;62 12:36:24 INFO - PROCESS | 3020 | __end_tp_report 12:36:24 INFO - PROCESS | 3020 | __start_cc_report 12:36:24 INFO - PROCESS | 3020 | _x_x_mozilla_cycle_collect,846 12:36:24 INFO - PROCESS | 3020 | __end_cc_report 12:36:24 INFO - PROCESS | 3020 | __startTimestamp1467056184492__endTimestamp 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | ------- Summary: start ------- 12:36:24 INFO - PROCESS | 3020 | Number of tests: 14 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.61 (3.3%) stddev-sans-first:3.82 12:36:24 INFO - PROCESS | 3020 | Values: 108.0 112.0 104.0 110.0 111.0 112.0 101.0 110.0 111.0 109.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:156.50 stddev:20.14 (12.9%) stddev-sans-first:21.33 12:36:24 INFO - PROCESS | 3020 | Values: 156.0 127.0 168.0 178.0 135.0 157.0 154.0 135.0 186.0 134.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:36:24 INFO - PROCESS | 3020 | Values: 162.0 163.0 162.0 163.0 161.0 162.0 162.0 164.0 162.0 162.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.50 stddev:40.13 (53.2%) stddev-sans-first:41.94 12:36:24 INFO - PROCESS | 3020 | Values: 75.0 74.0 76.0 177.0 78.0 76.0 76.0 75.0 164.0 75.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.55 (31.0%) stddev-sans-first:29.61 12:36:24 INFO - PROCESS | 3020 | Values: 93.0 92.0 154.0 92.0 92.0 92.0 149.0 92.0 93.0 151.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:36:24 INFO - PROCESS | 3020 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:36:24 INFO - PROCESS | 3020 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 149.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:36:24 INFO - PROCESS | 3020 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.00 stddev:5.93 (10.6%) stddev-sans-first:6.25 12:36:24 INFO - PROCESS | 3020 | Values: 56.0 56.0 55.0 56.0 58.0 60.0 56.0 74.0 54.0 54.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:1.25 (2.1%) stddev-sans-first:1.30 12:36:24 INFO - PROCESS | 3020 | Values: 61.0 61.0 62.0 60.0 60.0 60.0 62.0 60.0 58.0 59.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:3.03 (4.1%) stddev-sans-first:2.76 12:36:24 INFO - PROCESS | 3020 | Values: 79.0 72.0 73.0 73.0 81.0 74.0 75.0 72.0 74.0 73.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:117.00 stddev:8.30 (7.1%) stddev-sans-first:8.75 12:36:24 INFO - PROCESS | 3020 | Values: 117.0 115.0 118.0 115.0 117.0 117.0 114.0 114.0 138.0 132.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.00 stddev:3.93 (2.5%) stddev-sans-first:4.02 12:36:24 INFO - PROCESS | 3020 | Values: 162.0 163.0 166.0 160.0 158.0 156.0 153.0 160.0 158.0 155.0 12:36:24 INFO - PROCESS | 3020 | 12:36:24 INFO - PROCESS | 3020 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 12:36:24 INFO - PROCESS | 3020 | Values: 66.0 67.0 65.0 65.0 65.0 66.0 64.0 65.0 65.0 62.0 12:36:24 INFO - PROCESS | 3020 | -------- Summary: end -------- 12:36:24 INFO - PROCESS | 3020 | 12:36:25 INFO - TEST-INFO | 3020: exit 0 12:36:25 INFO - TEST-OK | kraken | took 60093ms 12:36:25 INFO - SUITE-END | took 1168s 12:36:25 INFO - Completed test suite (00:19:28) 12:36:25 INFO - javascript benchmark 12:36:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.7683162178646, 3383.983080084602, 3397.1337308986203, 3404.4042292598797, 3419.179396944734, 5597.9160312595295, 5607.046802043652, 5634.802781902634, 5639.971800141004, 5673.886522269558, 5562.638428502145, 5599.7480113394895, 5641.492265696086, 5644.943550564493, 5651.632643878145, 5050.570701490368, 5141.665791723544, 5148.073346797575, 5153.510416510426, 5183.611229157828, 5081.364829396325, 5122.667026643275, 5236.0, 5261.500157485052, 5261.86845328866, 5117.283580298761, 5141.280220769096, 5145.716985565792, 5214.556762675177, 5229.60777941654, 5187.584993200554, 5194.220866869962, 5196.662216955886, 5209.192575150858, 5232.215167724834, 5000.74996250186, 5041.470645582198, 5130.153524668425, 5163.0190263849745, 5176.7929282828645, 5490.203920431555, 5493.615446918718, 5569.248151499536, 5573.498385145356, 5602.635828671123, 6044.335123136451, 6071.332153463116, 6081.6351018939, 6101.938980610182, 6102.908456373158, 5840.766369345221, 6055.636661800262, 6133.386661333876, 6142.0786881967615, 6152.938470615326, 5610.13042978339, 5683.062294721325, 5684.261046064026, 5684.516816070639, 5711.543076553908, 6126.264848218242, 6162.22972128484, 6180.505559555315, 6182.814515564541, 6186.072089186568, 5810.62230954995, 5958.553108516879, 5960.940390596125, 5969.761209551656, 6039.758409663565, 6075.665838378844, 6076.939230607726, 6078.452939235402, 6080.635161890301, 6112.0, 6010.9699451502465, 6017.699115044318, 6049.153118563405, 6051.455369016721, 6070.119832624333, 5743.253377060955, 5994.610350327302, 6024.367441418675, 6047.274327080779, 6061.424164704346, 4585.656075794262, 4607.479531754513, 4626.1441633297945, 4630.236011058138, 4649.279361698942, 4111.684261036499, 4140.772257525865, 4150.128473020639, 4164.479440069991, 4167.4790651168605, 5597.972010139923, 5802.1296805479515, 5819.418058194146, 5864.530837532987, 5909.852253693692, 5999.520038396918, 6073.119397687311, 6077.665728384893, 6103.6948152592195, 6118.632882027093, 5640.915386269209, 5741.540676745851, 5775.451332123442, 5776.075827867521, 5778.3643799182055, 5122.590192784568, 5151.7681704323395, 5165.457626949116, 5180.352455943007, 5204.479552044765, 6349.936500634934, 6351.904721429182, 6383.585066970632, 6395.968020159869, 6410.519211059189, 5863.296404431496, 6038.818835434944, 6126.999999999911, 6131.080337949344, 6133.141360209664, 6247.843803904939, 6281.497480201481, 6282.905756413566, 6292.276388215414, 6293.056041593614, 5898.970505147447, 5900.232969714081, 5902.085176797603, 5929.9110513341475, 5948.851278718067, 5861.120831875252, 5987.221661184019, 6008.128821320972, 6083.239595050619, 6137.836677219377, 5946.821595352147, 5957.672328022, 5959.046552551571, 5964.850878728066, 5968.641881487125, 5853.619514731528, 5932.525397968238, 5936.13925980739, 5939.2575928009, 5949.970250148722, 5555.972220138873, 5814.215080964016, 5848.619839710405, 5856.238688970407, 5903.586748927705, 5981.162637230704, 5998.130271110752, 6004.039353703386, 6026.608270462406, 6038.124471951454, 5795.420457954171, 5876.970615146897, 5889.411058894077, 5899.705014749331, 5903.291605007426], "value": 5588.228672369836, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.47242206235, 678.4843518925616, 698.3540225291604, 735.959522226278, 745.0351794426219, 38385.61614383855, 39166.60833391665, 39233.215335693305, 39237.803810980906, 39296.80351598238, 42952.57047429525, 43137.78431107848, 43466.130677386514, 43482.0, 43563.346549801776, 8895.421797583153, 9020.954895225515, 9054.773630659252, 9079.319051071163, 9083.273338132967, 8777.868331975025, 8839.646414143426, 8846.734597962071, 8850.203481686647, 8879.067697891725, 9123.498207598579, 9159.313051521129, 9212.216961558275, 9253.583588738524, 9259.907400925971, 9120.726378208632, 9145.131212534798, 9164.816703665956, 9180.219681327095, 9180.265578753684, 8933.062028487046, 9076.455412675261, 9077.863832042525, 9079.0, 9099.909000909973, 43253.0, 43706.12587748227, 43766.56233437688, 43811.342829857575, 43850.561494384965, 3511.455724362728, 3625.438057101127, 3676.724245681558, 3721.1627383838418, 3738.719596030309, 30419.0, 30610.23474413135, 30677.0, 30924.536131958037, 31885.521717174262, 4544.182047231497, 4563.0873825235085, 4642.094791515656, 4677.368555245032, 4712.78792454337, 214588.0, 215877.0, 216009.0, 216086.0, 216357.0, 61756.0, 62344.0, 62753.68623156855, 62862.37137628657, 62895.6855215721, 70147.0, 70778.0, 70831.64584177046, 70836.29163708296, 70940.0, 18323.81676183221, 18489.90755046216, 18492.815071849378, 18540.16569254387, 18550.44348669542, 14040.859591403956, 14083.929580352238, 14091.154530728189, 14124.788128178085, 14146.434142634385, 19954.50113747139, 20365.79634203639, 20435.693464598044, 20518.487037824172, 21093.78906210949, 7739.34215591681, 7915.802104947423, 8081.717139900193, 8086.959565202136, 8133.75598732039, 1048.5596049659162, 1055.7591363771448, 1129.949147293009, 1154.284343706907, 1173.8239264110452, 32527.674723252938, 32833.343333133205, 33475.33049338999, 33579.496307555404, 33714.15714607154, 1175.077564112168, 1243.8258643789877, 1247.4386526063308, 1262.659082047842, 1333.8866196373417, 17624.735628965576, 17644.647107058045, 17689.292428302724, 17738.201780919888, 17739.73390399145, 524235.0, 534875.0, 554865.0, 560617.0, 564097.0, 58126.41873581295, 59249.70375148096, 59285.40714592885, 59303.70348148232, 59557.70221148953, 1504.8946573739952, 1511.9697606047816, 1541.8612324890814, 1543.7452820284752, 1569.050724311775, 30265.546016810207, 30866.84566577153, 31112.92766568321, 31601.683983159874, 31876.203094921886, 54564.0, 55305.17042244289, 55335.723321383135, 55408.0, 55620.721896390256, 450309.0, 453606.0, 456808.0, 456898.0, 459020.0, 31238.375232495677, 31822.36355272928, 32313.192170194994, 32368.514472282463, 32412.189695257806, 49814.25278620751, 50318.49681503284, 50458.49541504685, 50518.242226365895, 51155.744221278655, 42134.578654213066, 42634.57365426306, 42724.0, 42971.0, 43473.130537389705, 41075.0, 41156.382654259614, 41410.37884431676, 42037.6879271643, 42705.57294427016, 42001.159976800904, 42762.358564622176, 42879.57120428756, 43074.78462607667, 43292.134157316046, 35288.0, 35611.28777424385, 36086.35709718699, 36920.81539592392, 36931.63068369282, 28383.70565046022, 28394.89017042688, 28650.283742906595, 28676.0, 28900.0], "value": 20784.524920510317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.8203396930196, 446.5792033027014, 448.14851781614925, 448.39466719928123, 452.889042184665, 18936.90531547342, 19004.14481348339, 19563.804361956376, 20150.59698806023, 20172.59654806903, 18462.723059154123, 18749.0, 18752.343667971625, 20627.38117856463, 20629.174833006662, 5678.545716342683, 5693.686847223401, 5939.168516407706, 5942.1680964664765, 5943.0, 5812.680302583356, 5844.415558444164, 5852.12218167274, 5866.149408335788, 5871.794487192949, 5661.1508273758855, 5854.795082172125, 5865.384134665841, 5887.470127688507, 5897.3218079920925, 5805.854853628651, 5822.09757487588, 5825.592208545382, 5847.44449277318, 5854.151148083547, 5282.7622756976025, 5314.734263286859, 5323.44103869092, 5340.652857564285, 5346.518813306782, 23349.182778602666, 23608.055677772867, 23717.16989905345, 24162.87918560396, 24195.274141775775, 2417.2748175547267, 2653.044903834618, 2708.674959004912, 2907.4766542022426, 2958.955615665767, 14921.552353429415, 15081.321340539702, 15234.390624375123, 15305.846941530554, 15623.218839058116, 1985.2555291765589, 1999.3701983875033, 2052.9076191571266, 2068.1520576563535, 2134.0503475953205, 72785.0, 74055.25944740592, 75543.62228188879, 75659.99999999945, 76469.0, 11177.66467005991, 11259.49332280033, 11326.320420774615, 11419.828702569468, 11538.19232653723, 16155.676886462204, 16171.191440428167, 16286.348546058025, 16303.918480407521, 16343.18284085791, 8791.604377803014, 8976.237019853386, 8977.371583989057, 9077.046910074347, 9173.0, 8631.223189912938, 8668.523231222343, 8726.25826804716, 8759.255463285564, 8875.689350872817, 7083.0, 7119.181294151239, 7185.56886586796, 7214.314640109181, 7251.129864416198, 2085.1034055356345, 2180.258712037915, 2196.242296407737, 2217.390217690116, 2231.5648448552374, 982.40564458503, 1071.0949247885524, 1087.7552550676035, 1116.7040734205443, 1172.6188988578747, 18183.727244091086, 18845.05774711259, 19877.30429434963, 20386.388408347775, 20531.692024619642, 1092.1481244629201, 1106.4799544214368, 1117.9049780768562, 1121.4224674292745, 1200.0579545057087, 11313.83029254562, 11644.88355116455, 11749.177557571058, 11761.117916156323, 11769.764604707858, 550565.0, 553556.0, 561336.0, 564001.0, 564707.0, 76180.23819761732, 79456.0, 81385.59307203426, 81393.0, 85615.57192213999, 1109.290054365207, 1118.116687816632, 1155.3876445483907, 1160.4023927677254, 1164.4061528620296, 16640.0, 16741.33034678648, 16871.156442177595, 16941.15294235308, 17280.22238999223, 28045.0, 39209.803950980066, 39510.0, 39703.0, 42092.0, 59241.0, 59730.40269597249, 59756.70121649364, 59844.10233846409, 60095.699521502116, 8828.293736501193, 8871.645134194818, 9148.130927561871, 9200.309976751903, 9307.953460232655, 11672.182947193614, 13119.081664283409, 13218.801717974431, 13290.069695121249, 13357.465701371837, 10550.419726915094, 10738.409387483764, 12067.637970860887, 12323.0, 12325.876741232472, 10843.295185812896, 11488.712782180179, 11803.409829508662, 12121.090918181348, 12127.090468214743, 11987.760244794881, 12415.503379864704, 12455.065870059601, 12469.314187719763, 12488.625341239778, 8735.43219690718, 8872.556372181494, 8998.235150012322, 9002.009778924183, 9042.683506077256, 11662.358570278717, 12037.277763334228, 12049.036077113986, 12056.939715301367, 12192.451339689913], "value": 9761.734018642688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.2749371542234, 1568.1140155811966, 1746.2229307957964, 1850.1396850464532, 1886.3114963038495, 7362.447816413764, 8439.873401898976, 8663.220310172092, 8868.733937981862, 8884.955575222115, 8527.14728527147, 8533.658653653847, 8542.14578542147, 8645.87031194531, 8659.567021648923, 2336.4275752440635, 2366.857988520694, 2369.1944738788807, 2374.2639781667654, 2378.1319818266293, 2384.582698027847, 2394.0423830467867, 2445.951080978379, 2451.0685939343025, 2452.5953217719057, 2409.409694624819, 2419.4314336130997, 2435.4520232947534, 2450.15469662966, 2465.4329504214043, 2414.843035202715, 2419.5644783938883, 2423.987880060597, 2426.1023421334044, 2449.8162637802056, 2387.057112440576, 2392.2823153054187, 2402.039184326266, 2403.0507949359903, 2407.915722949706, 8897.154770296811, 8908.599113039929, 8922.464652120894, 8922.910770892273, 8984.326175536795, 5402.243685883979, 5513.228148059235, 5515.641483303612, 5538.6399884007415, 5547.611667183299, 3438.948415773765, 3464.116650254194, 3480.3387356402454, 3501.8074005929666, 3528.153243221608, 1109.351029647657, 1161.9419029048513, 1164.9592264270796, 1190.9523619055228, 1192.8031874740657, 11472.827907581393, 11490.0, 11529.077673786078, 11540.30758154505, 11629.3022418656, 4626.83806066786, 4731.503192164842, 4746.335513028179, 4766.666333356632, 4796.736179510161, 9989.950050249703, 10024.546440766047, 10044.246681498917, 10046.04562566555, 10103.545340459697, 5431.37539182999, 5433.157860531624, 5474.42518535556, 5493.340799104053, 5494.642848214853, 4977.8257760978195, 5009.24861270805, 5157.535821776059, 5180.0, 5187.351581052369, 3915.6084391561185, 3930.862419815293, 3961.1087505311652, 4018.799060046986, 4022.255882661717, 1192.0999645267768, 1197.2935967779051, 1198.8381568488317, 1204.6747378207835, 1224.412282104577, 984.3404918704485, 988.7577543501889, 1037.7094413564214, 1113.4822307626991, 1122.4107343644653, 6077.665728384981, 6092.817215483543, 6102.176206212193, 6140.600860944024, 6186.350433204539, 489.51782494243145, 493.58292243054564, 503.9067772462033, 507.6091409614576, 512.1881817319515, 4423.60187583119, 4452.844150454718, 4480.193565158303, 4481.148581769454, 4502.842400515966, 10732.195085368628, 10800.729981750519, 11140.442977851075, 11171.720706982227, 11187.216894817448, 10910.345379277269, 10914.781704365869, 10990.0, 10990.890091099147, 10999.0, 8091.474054186459, 8273.793155171048, 8298.377621678399, 8342.499450033018, 8466.40735148546, 6222.844428889314, 6385.233771947396, 6441.098246245436, 6444.8388790280615, 6476.12572302752, 9799.167070798776, 9872.753181170528, 10081.0, 10083.193344532274, 10138.580598716038, 9910.504474776088, 9924.156446701822, 10163.593456261668, 10390.324628899098, 10393.480325983519, 7620.276073772982, 7897.368210543028, 7908.920910791048, 7994.760157195061, 8165.673373065249, 8397.0, 8482.066972633129, 8504.829903401773, 8529.402941794015, 8571.742847714579, 7488.812779680552, 7589.1651918290045, 7593.696252150073, 7695.92304076952, 7824.100228473799, 7624.046994125734, 7639.885401718868, 7661.118971318369, 7751.147373788766, 7759.185285544936, 6939.410150137295, 6976.232614412512, 6990.475714321345, 6999.30006999296, 7003.964980175067, 5414.539764120094, 5453.372862120907, 5456.345238571397, 5553.722313884209, 5599.832005039855, 5433.701146436984, 5539.058360078716, 5604.075327571069, 5609.1305847593685, 5613.74738136793], "value": 4661.481440436793, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.3285474026719, 364.9270145970806, 368.32228699193496, 370.64047873562635, 371.263042859923, 6435.292117867042, 6458.677066146697, 6540.149780528531, 6632.20413550374, 6695.430888374494, 6439.613623182612, 6586.8682626347445, 6592.077109204715, 6605.372489613491, 6613.735450581983, 5024.296598476216, 5024.422191447976, 5024.5226703463295, 5027.874303142423, 5055.292259083732, 5041.949580504184, 5042.672226305297, 5043.016611760708, 5047.394312682483, 5051.898962020758, 4960.88380114475, 4978.377702787152, 4990.925136122961, 4991.0, 5003.574696150813, 4751.287306903958, 4894.5105489451125, 4997.425296090942, 5000.674956127858, 5008.574271186935, 4244.257254980366, 4247.065645557972, 4256.212600668886, 4259.5740425957465, 4263.658907287409, 6216.316205217422, 6229.2836323822885, 6258.1551490548645, 6277.278113017016, 6315.778947736853, 5776.422357764232, 5784.363719990798, 5787.88424231513, 5789.681567513785, 5790.623609465371, 6894.9655251723925, 6905.585664860125, 6925.861482770317, 6940.861182776367, 6944.6180460074675, 4554.977225113853, 4636.0, 4753.667243292936, 4794.2808578713475, 4807.543283388072, 7152.4278057755255, 7261.818454538626, 7279.89080163798, 7286.0, 7345.522541034816, 4841.927371089437, 4851.442084160296, 4853.611711063107, 4857.344258525054, 4872.3909511311085, 4937.851864444073, 4938.160512712848, 4944.283078953532, 4945.4807245238735, 4953.479884612064, 5724.198612194296, 5731.197632331477, 5735.139729040678, 5736.971315143398, 5738.340090889601, 6849.623270720158, 6960.512764106566, 6984.61584612841, 6997.580145191203, 6999.685014174374, 1720.8279172082691, 1730.7749992500894, 1737.2963949600432, 1738.8435040846384, 1740.477856643002, 1098.4452851310198, 1117.541807858774, 1121.3328069798456, 1132.6998345438465, 1135.250734515216, 6628.635425051572, 6651.16860392451, 6728.865422691617, 6729.05793188954, 6730.192376914802, 7114.893276600855, 7120.181179164462, 7131.679074441558, 7142.607156606437, 7142.821429464201, 6632.104665870046, 6691.26396096429, 6700.095487109275, 6701.32986701326, 6708.932910670928, 3850.5186851643543, 3867.2652196082654, 3868.303705333011, 3868.458415821787, 3884.2425726982965, 7398.815029624195, 7563.432742544332, 7721.227877212346, 7726.729564465217, 7736.690532378754, 7358.4547245078065, 7430.294122058396, 7440.069991251094, 7441.888371674321, 7454.589997550187, 7653.387728981668, 7677.577733224614, 7685.807854803675, 7686.423518236154, 7687.077550693953, 7172.354488096096, 7294.978702981481, 7300.16048154469, 7303.488755787044, 7304.379127774198, 7054.717811287491, 7082.327178917994, 7099.82250443743, 7104.076470058859, 7126.964365178141, 7601.353884919623, 7646.923530764843, 7656.464047516621, 7660.425468089804, 7662.655180516778, 4845.0, 4892.437369702529, 4900.411950565955, 4925.6305777066145, 4933.679310844927, 7000.719971201095, 7229.0, 7235.891461628185, 7253.673584688807, 7257.455690823103, 7037.472189585699, 7051.365377116084, 7056.400205982343, 7059.611721355374, 7070.505064645426, 6987.965060174666, 7061.329173728487, 7063.5408698436495, 7064.717411303491, 7090.539114957512, 6947.3747362737595, 6951.756688515878, 6952.44380449573, 6958.8956165658565, 6959.826004349932, 7004.649767511706, 7110.431165506644, 7121.893171602534, 7125.572465652078, 7127.465440092117, 6703.564268322543, 6946.2011868635755, 6974.128233970754, 7014.368706816411, 7019.6841142147705], "value": 5251.349317229389, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.5612169428509, 866.3978534918231, 868.1101870582653, 877.8310546343446, 878.7012415778634, 14974.700505989887, 15114.697706045872, 15126.621834454116, 15133.697326053487, 15172.620684482894, 14407.0, 14461.060031097997, 14486.42054317826, 14489.058211216263, 14532.709345813077, 847.5380917400001, 897.4256475855458, 906.1301150895149, 910.9134632209963, 930.8277968575801, 887.1217494680252, 911.3165126155384, 911.4485736129612, 913.9451632902014, 916.1205242966727, 937.7139972308444, 970.0735797313583, 970.8446648536236, 970.9077637624414, 973.7224890906093, 929.3169520402532, 957.5020989085706, 957.6504575829772, 962.0, 964.2527041542791, 681.5025031726817, 702.3994484715546, 708.7838209346147, 709.0392518137952, 713.2617740638466, 15958.202089895458, 16036.599085022968, 16069.0, 16071.678566428605, 16132.274047667766, 14336.354864031144, 14430.062045966979, 14486.637834054127, 14683.0, 14688.118712877262, 11315.717107072307, 11331.09351251906, 11447.542098316057, 11468.71328216793, 11619.302841829433, 3991.860284890044, 4008.5590585035625, 4076.735012224196, 4084.979575102135, 4182.330827067654, 54690.0, 55387.0, 55387.446125539034, 58472.70763646197, 58958.0, 10385.532651030571, 10389.94805025985, 10442.2168337375, 10573.682789516326, 10656.254062215725, 16721.16394180286, 16909.7463538047, 16917.154142292835, 17465.7380139298, 18232.817671823377, 8764.56177191138, 8837.955810220908, 8963.775905602412, 8989.865152022725, 9046.638134474679, 4550.704204226715, 4704.482506924235, 4713.764311784397, 4770.570648641569, 5104.897902041938, 3719.1631882826146, 3773.754705944105, 3782.394816829294, 3789.4315852621776, 3798.772073675588, 703.4548225125569, 704.3414407528977, 708.5111273221461, 713.5825542057954, 715.3275920634587, 687.71116131225, 772.3975299266468, 799.3844739550514, 805.5448671500584, 853.8761879527434, 9726.319157658896, 10184.490775461198, 10232.64185753495, 10322.277440579088, 10365.844512332322, 595.6098755315276, 658.7760161545098, 769.3575864153495, 781.4295564238138, 787.7321710618418, 4643.164230438553, 4804.855854324376, 4828.830990915301, 4833.613310935117, 4865.513448655106, 62228.688856556335, 63029.0, 63267.0, 68929.0, 70058.2994170062, 56640.716796415756, 56969.7151514248, 57913.4208657908, 59132.40867591269, 60749.39250607526, 48540.757296214, 49822.75088624606, 51493.485065149616, 51528.22707659388, 53534.0, 10210.336328138646, 10298.639547615798, 10521.473926303808, 10750.838737418788, 10766.461676915966, 38034.239315214094, 38467.0, 38483.42274865935, 39659.40510892281, 39918.80040599778, 46456.7677161612, 47534.0, 51273.0, 51602.74198628983, 52229.0, 10776.67669969902, 10986.285891417032, 12698.936505317415, 12858.292793896051, 13195.274259915797, 13824.654383640489, 14073.415216717589, 14648.926755366156, 14737.410503579737, 14801.259937003322, 13654.726905462034, 13891.097078689852, 13942.651433714238, 13964.441422342992, 14049.157050576998, 12522.123451358682, 12751.872481275439, 12921.806172907602, 13288.667783305495, 13499.987500937665, 12089.15375923677, 12446.626601201979, 12670.556530521388, 13318.866811331764, 13552.79670804919, 10877.401742904216, 10907.618233361794, 11179.832302515306, 11527.135464840338, 11888.723298559364, 11757.529698812294, 12051.517939282681, 12073.034157267222, 12090.697732556757, 12366.381680916098], "value": 7207.232357256719, "unit": "score"}], "name": "dromaeo_css", "value": 7647.576908575353, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 104.0, 110.0, 111.0, 112.0, 101.0, 110.0, 111.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 168.0, 178.0, 135.0, 157.0, 154.0, 135.0, 186.0, 134.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 161.0, 162.0, 162.0, 164.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 177.0, 78.0, 76.0, 76.0, 75.0, 164.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 154.0, 92.0, 92.0, 92.0, 149.0, 92.0, 93.0, 151.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 149.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 58.0, 60.0, 56.0, 74.0, 54.0, 54.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 60.0, 60.0, 60.0, 62.0, 60.0, 58.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 73.0, 73.0, 81.0, 74.0, 75.0, 72.0, 74.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 118.0, 115.0, 117.0, 117.0, 114.0, 114.0, 138.0, 132.0], "value": 119.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 160.0, 158.0, 156.0, 153.0, 160.0, 158.0, 155.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 62.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1524.6, "alertThreshold": 2.0}]} 12:36:25 INFO - Return code: 0 12:36:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:36:25 ERROR - # TBPL SUCCESS # 12:36:25 INFO - Running post-action listener: _resource_record_post_action 12:36:25 INFO - Running post-run listener: _resource_record_post_run 12:36:26 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 464760832; Read time: 0; Write time: 392712 12:36:26 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 241881088; Read time: 0; Write time: 272664 12:36:26 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 222515200; Read time: 0; Write time: 120028 12:36:26 INFO - Running post-run listener: _upload_blobber_files 12:36:26 INFO - Blob upload gear active. 12:36:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:36:26 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 12:36:26 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'] 12:36:26 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 12:36:27 INFO - (blobuploader) - INFO - Open directory for files ... 12:36:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:36:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:28 INFO - (blobuploader) - INFO - Done attempting. 12:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:36:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:29 INFO - (blobuploader) - INFO - Done attempting. 12:36:29 INFO - (blobuploader) - INFO - Iteration through files over. 12:36:29 INFO - Return code: 0 12:36:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:36:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:36:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ed0bfd397c5d08d9cf1d51d54de6e691793c03024cce912606bf0367cb48e9a1f1d9e44b8bd1fa0ae0a0996308ac8e30ef368fdc131dfc986ca2dbfff2a955b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1d2ed972a9b80afa3480d378fbfc8b6bf35e94923fee7644f5472143f6fcfa22ce15224cba6b6c7d1797ff14299a831d4463285a461e6a349ee303470cbc4f6"} 12:36:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:36:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:36:29 INFO - Contents: 12:36:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ed0bfd397c5d08d9cf1d51d54de6e691793c03024cce912606bf0367cb48e9a1f1d9e44b8bd1fa0ae0a0996308ac8e30ef368fdc131dfc986ca2dbfff2a955b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1d2ed972a9b80afa3480d378fbfc8b6bf35e94923fee7644f5472143f6fcfa22ce15224cba6b6c7d1797ff14299a831d4463285a461e6a349ee303470cbc4f6"} 12:36:29 INFO - Running post-run listener: copy_logs_to_upload_dir 12:36:29 INFO - Copying logs to upload dir... 12:36:29 INFO - mkdir: /builds/slave/test/build/upload/logs 12:36:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1220.843025 ========= master_lag: 1.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-27 12:36:29.930407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 12:36:29.933980) ========= 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=ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914 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/8ed0bfd397c5d08d9cf1d51d54de6e691793c03024cce912606bf0367cb48e9a1f1d9e44b8bd1fa0ae0a0996308ac8e30ef368fdc131dfc986ca2dbfff2a955b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1d2ed972a9b80afa3480d378fbfc8b6bf35e94923fee7644f5472143f6fcfa22ce15224cba6b6c7d1797ff14299a831d4463285a461e6a349ee303470cbc4f6"} build_url:https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/W4a73pTTQLqHwmdQHMlENw/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/8ed0bfd397c5d08d9cf1d51d54de6e691793c03024cce912606bf0367cb48e9a1f1d9e44b8bd1fa0ae0a0996308ac8e30ef368fdc131dfc986ca2dbfff2a955b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1d2ed972a9b80afa3480d378fbfc8b6bf35e94923fee7644f5472143f6fcfa22ce15224cba6b6c7d1797ff14299a831d4463285a461e6a349ee303470cbc4f6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 12:36:29.959436) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:36:29.959776) ========= 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=ed14279e38b05397cf4aa391000001a4-1467054965.857309-688502914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:36:30.010174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 12:36:30.010490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 12:36:30.010819) ========= ========= Total master_lag: 1.35 =========