builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1468358301.99 results: success (0) buildid: 20160712111926 builduid: 7cfe0ed0ac3d494b83fa1eed0f2e3808 revision: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:21.992179) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:21.992696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:21.993028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.009684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.010177) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 14:18:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-07-12 14:18:22 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.126432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.127161) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015335 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.178282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.178666) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 --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 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 --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=4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 14:18:22,251 truncating revision to first 12 chars 2016-07-12 14:18:22,251 Setting DEBUG logging. 2016-07-12 14:18:22,251 attempt 1/10 2016-07-12 14:18:22,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1748a233dae0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 14:18:22,558 unpacking tar archive at: mozilla-beta-1748a233dae0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650016 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.845666) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.846549) ========= script_repo_revision: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.847467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.848179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 14:18:22.860301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-12 14:18:22.860622) ========= /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=4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:18:23 INFO - MultiFileLogger online at 20160712 14:18:23 in /builds/slave/test 14:18:23 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 14:18:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:18:23 INFO - {'append_to_log': False, 14:18:23 INFO - 'base_work_dir': '/builds/slave/test', 14:18:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:18:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:18:23 INFO - 'branch': 'Mozilla-Beta', 14:18:23 INFO - 'buildbot_json_path': 'buildprops.json', 14:18:23 INFO - 'config_files': ('talos/linux_config.py',), 14:18:23 INFO - 'default_actions': ('clobber', 14:18:23 INFO - 'read-buildbot-config', 14:18:23 INFO - 'download-and-extract', 14:18:23 INFO - 'populate-webroot', 14:18:23 INFO - 'create-virtualenv', 14:18:23 INFO - 'install', 14:18:23 INFO - 'run-tests'), 14:18:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:18:23 INFO - 'download_minidump_stackwalk': True, 14:18:23 INFO - 'download_symbols': 'ondemand', 14:18:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:18:23 INFO - 'tooltool.py': '/tools/tooltool.py', 14:18:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:18:23 INFO - '/tools/misc-python/virtualenv.py')}, 14:18:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:18:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:18:23 INFO - 'installer_path': 'installer.exe', 14:18:23 INFO - 'log_level': 'info', 14:18:23 INFO - 'log_name': 'talos', 14:18:23 INFO - 'log_to_console': True, 14:18:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:18:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:18:23 INFO - 'opt_config_files': (), 14:18:23 INFO - 'pip_index': False, 14:18:23 INFO - 'sps_profile': False, 14:18:23 INFO - 'sps_profile_interval': 0, 14:18:23 INFO - 'suite': 'dromaeojs-e10s', 14:18:23 INFO - 'system_bits': '32', 14:18:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:18:23 INFO - 'title': 'talos-linux64-ix-030', 14:18:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:18:23 INFO - 'use_talos_json': True, 14:18:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:18:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:18:23 INFO - 'work_dir': 'build'} 14:18:23 INFO - ##### 14:18:23 INFO - ##### Running clobber step. 14:18:23 INFO - ##### 14:18:23 INFO - Running pre-action listener: _resource_record_pre_action 14:18:23 INFO - Running main action method: clobber 14:18:23 INFO - rmtree: /builds/slave/test/build 14:18:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:23 INFO - Running post-action listener: _resource_record_post_action 14:18:23 INFO - ##### 14:18:23 INFO - ##### Running read-buildbot-config step. 14:18:23 INFO - ##### 14:18:23 INFO - Running pre-action listener: _resource_record_pre_action 14:18:23 INFO - Running main action method: read_buildbot_config 14:18:23 INFO - Using buildbot properties: 14:18:23 INFO - { 14:18:23 INFO - "project": "", 14:18:23 INFO - "product": "firefox", 14:18:23 INFO - "script_repo_revision": "production", 14:18:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:18:23 INFO - "repository": "", 14:18:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 14:18:23 INFO - "buildid": "20160712111926", 14:18:23 INFO - "pgo_build": "True", 14:18:23 INFO - "basedir": "/builds/slave/test", 14:18:23 INFO - "buildnumber": 46, 14:18:23 INFO - "slavename": "talos-linux64-ix-030", 14:18:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:18:23 INFO - "platform": "ubuntu64_hw", 14:18:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:18:23 INFO - "branch": "mozilla-beta", 14:18:23 INFO - "repo_path": "releases/mozilla-beta", 14:18:23 INFO - "revision": "1748a233dae02d02e14bb64d378dc8cc3ae4a1b0", 14:18:23 INFO - "stage_platform": "linux64-pgo", 14:18:23 INFO - "builduid": "7cfe0ed0ac3d494b83fa1eed0f2e3808", 14:18:23 INFO - "slavebuilddir": "test" 14:18:23 INFO - } 14:18:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 14:18:23 INFO - Running post-action listener: _resource_record_post_action 14:18:23 INFO - ##### 14:18:23 INFO - ##### Running download-and-extract step. 14:18:23 INFO - ##### 14:18:23 INFO - Running pre-action listener: _resource_record_pre_action 14:18:23 INFO - Running main action method: download_and_extract 14:18:23 INFO - mkdir: /builds/slave/test/build/tests 14:18: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')]} 14:18:23 INFO - https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:24 INFO - Downloaded 1327 bytes. 14:18:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:18:24 INFO - Using the following test package requirements: 14:18:24 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:18:24 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:18:24 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 14:18:24 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'jsshell-linux-x86_64.zip'], 14:18:24 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:18:24 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:18:24 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 14:18:24 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 14:18:24 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:18:24 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:18:24 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:18:24 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:18:24 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')]} 14:18:24 INFO - https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:25 INFO - Downloaded 24236124 bytes. 14:18:25 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'] 14:18:25 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 14:18:26 INFO - Return code: 0 14:18:26 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 14:18:26 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')]} 14:18:26 INFO - https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:18:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:18:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:18:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:27 INFO - Downloaded 24236124 bytes. 14:18:27 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'] 14:18:27 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 14:18:29 INFO - Return code: 0 14:18: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')]} 14:18:29 INFO - https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:30 INFO - Downloaded 10840145 bytes. 14:18:30 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'] 14:18:30 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 14:18:31 INFO - Return code: 0 14:18:31 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')]} 14:18:31 INFO - https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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 14:18:32 INFO - Downloaded 56014233 bytes. 14:18:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:18:32 INFO - mkdir: /builds/slave/test/properties 14:18:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:32 INFO - Contents: 14:18:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:18:33 INFO - Running post-action listener: _resource_record_post_action 14:18:33 INFO - Running post-action listener: set_extra_try_arguments 14:18:33 INFO - ##### 14:18:33 INFO - ##### Running populate-webroot step. 14:18:33 INFO - ##### 14:18:33 INFO - Running pre-action listener: _resource_record_pre_action 14:18:33 INFO - Running main action method: populate_webroot 14:18:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:33 INFO - '--tppagecycles', 14:18:33 INFO - '7'], 14:18:33 INFO - 'tests': ['tsvgm']}}, 14:18:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:18:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:18:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['damp', 'tps']}, 14:18:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'tests': ['damp', 'tps']}, 14:18:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['dromaeo_dom']}, 14:18:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['a11yr', 14:18:33 INFO - 'ts_paint', 14:18:33 INFO - 'tpaint', 14:18:33 INFO - 'sessionrestore', 14:18:33 INFO - 'sessionrestore_no_auto_restore', 14:18:33 INFO - 'tabpaint']}, 14:18:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:18:33 INFO - 'ts_paint', 14:18:33 INFO - 'tpaint', 14:18:33 INFO - 'sessionrestore', 14:18:33 INFO - 'sessionrestore_no_auto_restore', 14:18:33 INFO - 'tabpaint']}, 14:18:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:18:33 INFO - 'ts_paint', 14:18:33 INFO - 'tpaint', 14:18:33 INFO - 'sessionrestore', 14:18:33 INFO - 'sessionrestore_no_auto_restore', 14:18:33 INFO - 'tabpaint']}, 14:18:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:18:33 INFO - 'ts_paint', 14:18:33 INFO - 'tpaint', 14:18:33 INFO - 'sessionrestore', 14:18:33 INFO - 'sessionrestore_no_auto_restore', 14:18:33 INFO - 'tabpaint']}, 14:18:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['a11yr', 14:18:33 INFO - 'ts_paint', 14:18:33 INFO - 'tpaint', 14:18:33 INFO - 'sessionrestore', 14:18:33 INFO - 'sessionrestore_no_auto_restore', 14:18:33 INFO - 'tabpaint']}, 14:18:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['a11yr', 14:18:33 INFO - 'ts_paint', 14:18:33 INFO - 'tpaint', 14:18:33 INFO - 'sessionrestore', 14:18:33 INFO - 'sessionrestore_no_auto_restore', 14:18:33 INFO - 'tabpaint']}, 14:18:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['tsvgx', 14:18:33 INFO - 'tsvgr_opacity', 14:18:33 INFO - 'tart', 14:18:33 INFO - 'tscrollx', 14:18:33 INFO - 'cart']}, 14:18:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:18:33 INFO - 'tsvgr_opacity', 14:18:33 INFO - 'tart', 14:18:33 INFO - 'tscrollx', 14:18:33 INFO - 'cart']}, 14:18:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'talos_options': ['--disable-e10s'], 14:18:33 INFO - 'tests': ['tp5o']}, 14:18:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'tests': ['tp5o']}, 14:18:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'talos_options': ['--disable-e10s', 14:18:33 INFO - '--xperf_path', 14:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:33 INFO - 'tests': ['tp5n']}, 14:18:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:33 INFO - 'talos_options': ['--xperf_path', 14:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:33 INFO - 'tests': ['tp5n']}}, 14:18:33 INFO - 'talos.zip': {'path': '', 14:18:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:33 INFO - Running post-action listener: _resource_record_post_action 14:18:33 INFO - ##### 14:18:33 INFO - ##### Running create-virtualenv step. 14:18:33 INFO - ##### 14:18:33 INFO - Running pre-action listener: _resource_record_pre_action 14:18:33 INFO - Running main action method: create_virtualenv 14:18:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:33 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 14:18:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:33 INFO - Using real prefix '/usr' 14:18:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:35 INFO - Installing pip.................done. 14:18:35 INFO - Return code: 0 14:18:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:35 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 14:18:35 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 14:18:35 INFO - Using env: {'DISPLAY': ':0', 14:18:35 INFO - 'HOME': '/home/cltbld', 14:18:35 INFO - 'LANG': 'en_US.UTF-8', 14:18:35 INFO - 'LANGUAGE': 'en_US:en', 14:18:35 INFO - 'LOGNAME': 'cltbld', 14:18:35 INFO - 'MAIL': '/var/mail/cltbld', 14:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:35 INFO - 'MOZ_NO_REMOTE': '1', 14:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:35 INFO - 'NO_EM_RESTART': '1', 14:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:35 INFO - 'PWD': '/builds/slave/test', 14:18:35 INFO - 'SHELL': '/bin/bash', 14:18:35 INFO - 'SHLVL': '1', 14:18:35 INFO - 'TERM': 'linux', 14:18:35 INFO - 'TMOUT': '86400', 14:18:35 INFO - 'USER': 'cltbld', 14:18:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:35 INFO - '_': '/tools/buildbot/bin/python'} 14:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:35 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 14:18:35 INFO - Cleaning up... 14:18:35 INFO - Return code: 0 14:18:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:35 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 14:18:35 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 14:18:35 INFO - Using env: {'DISPLAY': ':0', 14:18:35 INFO - 'HOME': '/home/cltbld', 14:18:35 INFO - 'LANG': 'en_US.UTF-8', 14:18:35 INFO - 'LANGUAGE': 'en_US:en', 14:18:35 INFO - 'LOGNAME': 'cltbld', 14:18:35 INFO - 'MAIL': '/var/mail/cltbld', 14:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:35 INFO - 'MOZ_NO_REMOTE': '1', 14:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:35 INFO - 'NO_EM_RESTART': '1', 14:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:35 INFO - 'PWD': '/builds/slave/test', 14:18:35 INFO - 'SHELL': '/bin/bash', 14:18:35 INFO - 'SHLVL': '1', 14:18:35 INFO - 'TERM': 'linux', 14:18:35 INFO - 'TMOUT': '86400', 14:18:35 INFO - 'USER': 'cltbld', 14:18:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:35 INFO - '_': '/tools/buildbot/bin/python'} 14:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:36 INFO - Downloading/unpacking psutil>=0.7.1 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:38 INFO - Installing collected packages: psutil 14:18:38 INFO - Running setup.py install for psutil 14:18:38 INFO - building 'psutil._psutil_linux' extension 14:18:38 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 14:18:38 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 14:18:38 INFO - building 'psutil._psutil_posix' extension 14:18:38 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 14:18:38 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 14:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:38 INFO - Successfully installed psutil 14:18:38 INFO - Cleaning up... 14:18:38 INFO - Return code: 0 14:18:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:38 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:38 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 14:18:38 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 14:18:38 INFO - Using env: {'DISPLAY': ':0', 14:18:38 INFO - 'HOME': '/home/cltbld', 14:18:38 INFO - 'LANG': 'en_US.UTF-8', 14:18:38 INFO - 'LANGUAGE': 'en_US:en', 14:18:38 INFO - 'LOGNAME': 'cltbld', 14:18:38 INFO - 'MAIL': '/var/mail/cltbld', 14:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:38 INFO - 'MOZ_NO_REMOTE': '1', 14:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:38 INFO - 'NO_EM_RESTART': '1', 14:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:38 INFO - 'PWD': '/builds/slave/test', 14:18:38 INFO - 'SHELL': '/bin/bash', 14:18:38 INFO - 'SHLVL': '1', 14:18:38 INFO - 'TERM': 'linux', 14:18:38 INFO - 'TMOUT': '86400', 14:18:38 INFO - 'USER': 'cltbld', 14:18:38 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:38 INFO - '_': '/tools/buildbot/bin/python'} 14:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:18:40 INFO - Installing collected packages: mozsystemmonitor 14:18:40 INFO - Running setup.py install for mozsystemmonitor 14:18:40 INFO - Successfully installed mozsystemmonitor 14:18:40 INFO - Cleaning up... 14:18:41 INFO - Return code: 0 14:18:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:41 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:41 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 14:18:41 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 14:18:41 INFO - Using env: {'DISPLAY': ':0', 14:18:41 INFO - 'HOME': '/home/cltbld', 14:18:41 INFO - 'LANG': 'en_US.UTF-8', 14:18:41 INFO - 'LANGUAGE': 'en_US:en', 14:18:41 INFO - 'LOGNAME': 'cltbld', 14:18:41 INFO - 'MAIL': '/var/mail/cltbld', 14:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:41 INFO - 'MOZ_NO_REMOTE': '1', 14:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:41 INFO - 'NO_EM_RESTART': '1', 14:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:41 INFO - 'PWD': '/builds/slave/test', 14:18:41 INFO - 'SHELL': '/bin/bash', 14:18:41 INFO - 'SHLVL': '1', 14:18:41 INFO - 'TERM': 'linux', 14:18:41 INFO - 'TMOUT': '86400', 14:18:41 INFO - 'USER': 'cltbld', 14:18:41 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:41 INFO - '_': '/tools/buildbot/bin/python'} 14:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 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 14:18:43 INFO - Downloading docopt-0.6.1.tar.gz 14:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:43 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:43 INFO - Running setup.py install for blobuploader 14:18:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:44 INFO - Running setup.py install for requests 14:18:44 INFO - Running setup.py install for docopt 14:18:44 INFO - Successfully installed blobuploader requests docopt 14:18:44 INFO - Cleaning up... 14:18:44 INFO - Return code: 0 14:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:44 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')]} 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:44 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')]} 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:44 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:44 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 14:18:44 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 14:18:44 INFO - Using env: {'DISPLAY': ':0', 14:18:44 INFO - 'HOME': '/home/cltbld', 14:18:44 INFO - 'LANG': 'en_US.UTF-8', 14:18:44 INFO - 'LANGUAGE': 'en_US:en', 14:18:44 INFO - 'LOGNAME': 'cltbld', 14:18:44 INFO - 'MAIL': '/var/mail/cltbld', 14:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:44 INFO - 'MOZ_NO_REMOTE': '1', 14:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:44 INFO - 'NO_EM_RESTART': '1', 14:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:44 INFO - 'PWD': '/builds/slave/test', 14:18:44 INFO - 'SHELL': '/bin/bash', 14:18:44 INFO - 'SHLVL': '1', 14:18:44 INFO - 'TERM': 'linux', 14:18:44 INFO - 'TMOUT': '86400', 14:18:44 INFO - 'USER': 'cltbld', 14:18:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:44 INFO - '_': '/tools/buildbot/bin/python'} 14:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:44 INFO - Running setup.py (path:/tmp/pip-5dHUgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:44 INFO - Running setup.py (path:/tmp/pip-FD77oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:44 INFO - Running setup.py (path:/tmp/pip-2MksiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:44 INFO - Running setup.py (path:/tmp/pip-HUzM0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:45 INFO - Running setup.py (path:/tmp/pip-54bxQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:45 INFO - Running setup.py (path:/tmp/pip-hbn0A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:45 INFO - Running setup.py (path:/tmp/pip-zrtAK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:45 INFO - Running setup.py (path:/tmp/pip-KovJ54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:45 INFO - Running setup.py (path:/tmp/pip-G2K5B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:45 INFO - Running setup.py (path:/tmp/pip-F2JO_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:45 INFO - Running setup.py (path:/tmp/pip-Ks05c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:45 INFO - Running setup.py (path:/tmp/pip-4uBLJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:45 INFO - Running setup.py (path:/tmp/pip-lWdmj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:45 INFO - Running setup.py (path:/tmp/pip-ruGPG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:45 INFO - Running setup.py (path:/tmp/pip-1cPzcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:45 INFO - Running setup.py (path:/tmp/pip-2GD4NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:45 INFO - Running setup.py (path:/tmp/pip-SA8GUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:45 INFO - Running setup.py install for manifestparser 14:18:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Running setup.py install for mozcrash 14:18:46 INFO - Running setup.py install for mozdebug 14:18:46 INFO - Running setup.py install for mozdevice 14:18:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Running setup.py install for mozfile 14:18:46 INFO - Running setup.py install for mozhttpd 14:18:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Running setup.py install for mozinfo 14:18:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Running setup.py install for mozInstall 14:18:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Running setup.py install for mozleak 14:18:46 INFO - Running setup.py install for mozlog 14:18:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:46 INFO - Running setup.py install for moznetwork 14:18:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozprocess 14:18:47 INFO - Running setup.py install for mozprofile 14:18:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozrunner 14:18:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozscreenshot 14:18:47 INFO - Running setup.py install for moztest 14:18:47 INFO - Running setup.py install for mozversion 14:18:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:47 INFO - Cleaning up... 14:18:47 INFO - Return code: 0 14:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:47 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:47 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 14:18:47 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 14:18:47 INFO - Using env: {'DISPLAY': ':0', 14:18:47 INFO - 'HOME': '/home/cltbld', 14:18:47 INFO - 'LANG': 'en_US.UTF-8', 14:18:47 INFO - 'LANGUAGE': 'en_US:en', 14:18:47 INFO - 'LOGNAME': 'cltbld', 14:18:47 INFO - 'MAIL': '/var/mail/cltbld', 14:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:47 INFO - 'MOZ_NO_REMOTE': '1', 14:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:47 INFO - 'NO_EM_RESTART': '1', 14:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:47 INFO - 'PWD': '/builds/slave/test', 14:18:47 INFO - 'SHELL': '/bin/bash', 14:18:47 INFO - 'SHLVL': '1', 14:18:47 INFO - 'TERM': 'linux', 14:18:47 INFO - 'TMOUT': '86400', 14:18:47 INFO - 'USER': 'cltbld', 14:18:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:47 INFO - '_': '/tools/buildbot/bin/python'} 14:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:47 INFO - Running setup.py (path:/tmp/pip-GDB9jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:48 INFO - Running setup.py (path:/tmp/pip-j4pw6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:48 INFO - Running setup.py (path:/tmp/pip-8XD3_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:48 INFO - Running setup.py (path:/tmp/pip-yKrP5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:48 INFO - Running setup.py (path:/tmp/pip-TVfM9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:48 INFO - Running setup.py (path:/tmp/pip-9uLVPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:48 INFO - Running setup.py (path:/tmp/pip-5SrJP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:48 INFO - Running setup.py (path:/tmp/pip-0oJFlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:48 INFO - Running setup.py (path:/tmp/pip-DvC72j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:48 INFO - Running setup.py (path:/tmp/pip-kuL2Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:48 INFO - Running setup.py (path:/tmp/pip-fzbSlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:48 INFO - Running setup.py (path:/tmp/pip-Zj8XfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:48 INFO - Running setup.py (path:/tmp/pip-g2BRNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:48 INFO - Running setup.py (path:/tmp/pip-oqnRxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:48 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)) 14:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:48 INFO - Running setup.py (path:/tmp/pip-8wAcSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:49 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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:49 INFO - Running setup.py (path:/tmp/pip-eDOGxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:49 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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:49 INFO - Running setup.py (path:/tmp/pip-ctwN9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:49 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)) 14:18:49 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)) 14:18:49 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)) 14:18:49 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)) 14:18:49 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)) 14:18:49 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)) 14:18:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:49 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 14:18:49 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 14:18:49 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 14:18:49 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 14:18:49 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 14:18:49 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 14:18:51 INFO - Downloading blessings-1.6.tar.gz 14:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:51 INFO - Installing collected packages: blessings 14:18:51 INFO - Running setup.py install for blessings 14:18:51 INFO - Successfully installed blessings 14:18:51 INFO - Cleaning up... 14:18:51 INFO - Return code: 0 14:18:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:51 INFO - Reading from file tmpfile_stdout 14:18:51 INFO - Current package versions: 14:18:51 INFO - argparse == 1.2.1 14:18:51 INFO - blessings == 1.6 14:18:51 INFO - blobuploader == 1.2.4 14:18:51 INFO - docopt == 0.6.1 14:18:51 INFO - manifestparser == 1.1 14:18:51 INFO - mozInstall == 1.12 14:18:51 INFO - mozcrash == 0.17 14:18:51 INFO - mozdebug == 0.1 14:18:51 INFO - mozdevice == 0.48 14:18:51 INFO - mozfile == 1.2 14:18:51 INFO - mozhttpd == 0.7 14:18:51 INFO - mozinfo == 0.9 14:18:51 INFO - mozleak == 0.1 14:18:51 INFO - mozlog == 3.1 14:18:51 INFO - moznetwork == 0.27 14:18:51 INFO - mozprocess == 0.22 14:18:51 INFO - mozprofile == 0.28 14:18:51 INFO - mozrunner == 6.11 14:18:51 INFO - mozscreenshot == 0.1 14:18:51 INFO - mozsystemmonitor == 0.0 14:18:51 INFO - moztest == 0.7 14:18:51 INFO - mozversion == 1.4 14:18:51 INFO - psutil == 3.1.1 14:18:51 INFO - requests == 1.2.3 14:18:51 INFO - wsgiref == 0.1.2 14:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:51 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:51 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 14:18:51 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 14:18:51 INFO - Using env: {'DISPLAY': ':0', 14:18:51 INFO - 'HOME': '/home/cltbld', 14:18:51 INFO - 'LANG': 'en_US.UTF-8', 14:18:51 INFO - 'LANGUAGE': 'en_US:en', 14:18:51 INFO - 'LOGNAME': 'cltbld', 14:18:51 INFO - 'MAIL': '/var/mail/cltbld', 14:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:51 INFO - 'MOZ_NO_REMOTE': '1', 14:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:51 INFO - 'NO_EM_RESTART': '1', 14:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:51 INFO - 'PWD': '/builds/slave/test', 14:18:51 INFO - 'SHELL': '/bin/bash', 14:18:51 INFO - 'SHLVL': '1', 14:18:51 INFO - 'TERM': 'linux', 14:18:51 INFO - 'TMOUT': '86400', 14:18:51 INFO - 'USER': 'cltbld', 14:18:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:51 INFO - '_': '/tools/buildbot/bin/python'} 14:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 INFO - Cleaning up... 14:18:51 INFO - Return code: 0 14:18:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:51 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:51 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 14:18:51 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 14:18:51 INFO - Using env: {'DISPLAY': ':0', 14:18:51 INFO - 'HOME': '/home/cltbld', 14:18:51 INFO - 'LANG': 'en_US.UTF-8', 14:18:51 INFO - 'LANGUAGE': 'en_US:en', 14:18:51 INFO - 'LOGNAME': 'cltbld', 14:18:51 INFO - 'MAIL': '/var/mail/cltbld', 14:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:51 INFO - 'MOZ_NO_REMOTE': '1', 14:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:51 INFO - 'NO_EM_RESTART': '1', 14:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:51 INFO - 'PWD': '/builds/slave/test', 14:18:51 INFO - 'SHELL': '/bin/bash', 14:18:51 INFO - 'SHLVL': '1', 14:18:51 INFO - 'TERM': 'linux', 14:18:51 INFO - 'TMOUT': '86400', 14:18:51 INFO - 'USER': 'cltbld', 14:18:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:51 INFO - '_': '/tools/buildbot/bin/python'} 14:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:51 INFO - Downloading/unpacking jsonschema 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:53 INFO - Downloading/unpacking functools32 (from jsonschema) 14:18:53 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 14:18:53 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 14:18:53 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 14:18:53 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 14:18:53 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 14:18:53 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 14:18:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:54 INFO - warning: no files found matching '*.txt' 14:18:54 INFO - no previously-included directories found matching 'build' 14:18:54 INFO - no previously-included directories found matching 'dist' 14:18:54 INFO - no previously-included directories found matching '.git*' 14:18:54 INFO - Installing collected packages: jsonschema, functools32 14:18:54 INFO - Running setup.py install for functools32 14:18:54 INFO - warning: no files found matching '*.txt' 14:18:54 INFO - no previously-included directories found matching 'build' 14:18:54 INFO - no previously-included directories found matching 'dist' 14:18:54 INFO - no previously-included directories found matching '.git*' 14:18:54 INFO - Successfully installed jsonschema functools32 14:18:54 INFO - Cleaning up... 14:18:54 INFO - Return code: 0 14:18:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:18:54 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')]} 14:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:54 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')]} 14:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:54 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 0x7f4a956d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', '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 14:18:54 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 14:18:54 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 14:18:54 INFO - Using env: {'DISPLAY': ':0', 14:18:54 INFO - 'HOME': '/home/cltbld', 14:18:54 INFO - 'LANG': 'en_US.UTF-8', 14:18:54 INFO - 'LANGUAGE': 'en_US:en', 14:18:54 INFO - 'LOGNAME': 'cltbld', 14:18:54 INFO - 'MAIL': '/var/mail/cltbld', 14:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:54 INFO - 'MOZ_NO_REMOTE': '1', 14:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:54 INFO - 'NO_EM_RESTART': '1', 14:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:54 INFO - 'PWD': '/builds/slave/test', 14:18:54 INFO - 'SHELL': '/bin/bash', 14:18:54 INFO - 'SHLVL': '1', 14:18:54 INFO - 'TERM': 'linux', 14:18:54 INFO - 'TMOUT': '86400', 14:18:54 INFO - 'USER': 'cltbld', 14:18:54 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:54 INFO - '_': '/tools/buildbot/bin/python'} 14:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:54 INFO - Downloading/unpacking flake8 14:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:57 INFO - no previously-included directories found matching 'docs/_build' 14:18:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:57 INFO - Running setup.py install for pep8 14:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:57 INFO - no previously-included directories found matching 'docs/_build' 14:18:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:57 INFO - Cleaning up... 14:18:57 INFO - Return code: 0 14:18:57 INFO - Running post-action listener: _resource_record_post_action 14:18:57 INFO - Running post-action listener: _start_resource_monitoring 14:18:57 INFO - Starting resource monitoring. 14:18:57 INFO - ##### 14:18:57 INFO - ##### Running install step. 14:18:57 INFO - ##### 14:18:57 INFO - Running pre-action listener: _resource_record_pre_action 14:18:57 INFO - Running main action method: install 14:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:57 INFO - Reading from file tmpfile_stdout 14:18:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:57 INFO - Reading from file tmpfile_stdout 14:18:57 INFO - Output received: 14:18:57 INFO - Usage: mozinstall [options] installer 14:18:57 INFO - Options: 14:18:57 INFO - -h, --help show this help message and exit 14:18:57 INFO - -d DEST, --destination=DEST 14:18:57 INFO - Directory to install application into. [default: 14:18:57 INFO - "/builds/slave/test"] 14:18:57 INFO - --app=APP Application being installed. [default: firefox] 14:18:57 INFO - mkdir: /builds/slave/test/build/application 14:18:57 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'] 14:18:57 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 14:19:11 INFO - Reading from file tmpfile_stdout 14:19:11 INFO - Output received: 14:19:11 INFO - /builds/slave/test/build/application/firefox/firefox 14:19:11 INFO - Running post-action listener: _resource_record_post_action 14:19:11 INFO - ##### 14:19:11 INFO - ##### Running run-tests step. 14:19:11 INFO - ##### 14:19:11 INFO - Running pre-action listener: _resource_record_pre_action 14:19:11 INFO - Running main action method: run_tests 14:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:11 INFO - Python 2.7.3 14:19:11 INFO - Return code: 0 14:19:11 INFO - grabbing minidump binary from tooltool 14:19: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')]} 14:19:11 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 0x1610410>, '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 0x1611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16117a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:11 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 14:19:11 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 14:19:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:11 INFO - Return code: 0 14:19:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:19:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:19:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:19:12 INFO - Return code: 0 14:19:12 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/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 14:19:12 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/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 14:19:12 INFO - Using env: {'DISPLAY': ':0', 14:19:12 INFO - 'HOME': '/home/cltbld', 14:19:12 INFO - 'LANG': 'en_US.UTF-8', 14:19:12 INFO - 'LANGUAGE': 'en_US:en', 14:19:12 INFO - 'LOGNAME': 'cltbld', 14:19:12 INFO - 'MAIL': '/var/mail/cltbld', 14:19:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:12 INFO - 'MOZ_NO_REMOTE': '1', 14:19:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:12 INFO - 'NO_EM_RESTART': '1', 14:19:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:12 INFO - 'PWD': '/builds/slave/test', 14:19:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:12 INFO - 'SHELL': '/bin/bash', 14:19:12 INFO - 'SHLVL': '1', 14:19:12 INFO - 'TERM': 'linux', 14:19:12 INFO - 'TMOUT': '86400', 14:19:12 INFO - 'USER': 'cltbld', 14:19:12 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351', 14:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:12 INFO - '_': '/tools/buildbot/bin/python'} 14:19:12 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/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 14:19:12 INFO - mozversion application_buildid: 20160712111926 14:19:12 INFO - mozversion application_changeset: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 14:19:12 INFO - mozversion application_display_name: Firefox 14:19:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:12 INFO - mozversion application_name: Firefox 14:19:12 INFO - mozversion application_remotingname: firefox 14:19:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:19:12 INFO - mozversion application_vendor: Mozilla 14:19:12 INFO - mozversion application_version: 48.0 14:19:12 INFO - mozversion platform_buildid: 20160712111926 14:19:12 INFO - mozversion platform_changeset: 1748a233dae02d02e14bb64d378dc8cc3ae4a1b0 14:19:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:19:12 INFO - mozversion platform_version: 48.0 14:19:12 INFO - using testdate: 1468358352 14:19:12 INFO - actual date: 1468358352 14:19:12 INFO - starting webserver on 'localhost:49683' 14:19:12 INFO - SUITE-START | Running 2 tests 14:19:12 INFO - TEST-START | dromaeo_css 14:19:12 INFO - operating with platform_type : linux_ 14:19:12 INFO - Initialising browser for dromaeo_css test... 14:19:12 INFO - TEST-INFO | started process 22083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP4DdiT/profile http://localhost:49683/getInfo.html) 14:19:15 INFO - PROCESS | 22083 | 14:19:15 INFO - PROCESS | 22083 | (process:22161): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:19:16 INFO - PROCESS | 22083 | __metrics Screen width/height:1600/1200 14:19:16 INFO - PROCESS | 22083 | colorDepth:24 14:19:16 INFO - PROCESS | 22083 | Browser inner width/height: 1024/697 14:19:16 INFO - PROCESS | 22083 | __metrics 14:19:16 ERROR - PROCESS | 22083 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:19:17 INFO - TEST-INFO | 22083: exit 0 14:19:17 INFO - Browser initialized. 14:19:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:17 INFO - TEST-INFO | started process 22211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP4DdiT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:19 INFO - PROCESS | 22211 | 14:19:19 INFO - PROCESS | 22211 | (process:22279): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:19:29 INFO - PROCESS | 22211 | RSS: Main: 150937600 14:19:29 INFO - PROCESS | 22211 | 14:20:19 INFO - PROCESS | 22211 | 1468358419048 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] 14:22:26 INFO - PROCESS | 22211 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49683/tests/dromaeo/cssquery-ext.html) 14:22:27 INFO - PROCESS | 22211 | RSS: Main: 154423296 14:22:27 INFO - PROCESS | 22211 | 14:25:29 INFO - PROCESS | 22211 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-ext.html (next: http://localhost:49683/tests/dromaeo/cssquery-jquery.html) 14:25:30 INFO - PROCESS | 22211 | RSS: Main: 152719360 14:25:30 INFO - PROCESS | 22211 | 14:28:31 INFO - PROCESS | 22211 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49683/tests/dromaeo/cssquery-mootools.html) 14:28:32 INFO - PROCESS | 22211 | RSS: Main: 152207360 14:28:32 INFO - PROCESS | 22211 | 14:31:34 INFO - PROCESS | 22211 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49683/tests/dromaeo/cssquery-prototype.html) 14:31:34 INFO - PROCESS | 22211 | RSS: Main: 153690112 14:31:34 INFO - PROCESS | 22211 | 14:34:37 INFO - PROCESS | 22211 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49683/tests/dromaeo/cssquery-yui.html) 14:34:37 INFO - PROCESS | 22211 | RSS: Main: 152178688 14:34:37 INFO - PROCESS | 22211 | 14:37:39 INFO - PROCESS | 22211 | Cycle 1(1): loaded http://localhost:49683/tests/dromaeo/cssquery-yui.html (next: http://localhost:49683/tests/dromaeo/cssquery-dojo.html) 14:37:40 INFO - PROCESS | 22211 | RSS: Main: 156233728 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | __start_tp_report 14:37:40 INFO - PROCESS | 22211 | _x_x_mozilla_page_load 14:37:40 INFO - PROCESS | 22211 | _x_x_mozilla_page_load_details 14:37:40 INFO - PROCESS | 22211 | |i|pagename|runs| 14:37:40 INFO - PROCESS | 22211 | |0;dojo.html;3286.260591366942;3343.5820522434697;3354.0440974322314;3376.9831150844257;3379.2734562069136;5498.3127109111365;5515.503604675583;5528.7788488460465;5544.306961629796;5552.611317207797;5539.002979463695;5539.086050801623;5560.277163968689;5583.972080139603;5596.720163991805;5040;5050.292958985745;5101.438841727407;5114.565261952738;5125.333706618135;4991.276264941581;5008.3238762767105;5147.150720131174;5217.426083130853;5243.659162154467;5052;5085.1863701807715;5105.770240339194;5151.871203219931;5167.483251674821;5100.974495127538;5102.219290486693;5103.846884593449;5106.795728170869;5131.820386286499;4889.731064791435;4953.0341583391255;4976.278439626234;5025.346704928373;5041.873953151164;5325.973370133163;5335.626506144571;5388.326459192601;5389.649672771257;5402.594805389612;5884.823455296305;5891.263592050994;5892.734826932799;5894.263217097863;5896.587238893279;5934.6142500737315;5953.434423729782;5960.821175364746;5965.671888046156;6003.159557661931;5493.890122197534;5528.170774383834;5534.916976245359;5541.5843811714285;5553.805616803393;5869.941300587025;5969.343372229051;6017.217761690952;6017.909731354033;6024.457798798129;5634.352049514358;5751.396103409165;5759;5759.395263497357;5769.68266745333;5877.941220587825;5880.647161170344;5882.264716910387;5892.086726557391;5896.086106653475;5797.391273916178;5852.180694702745;5869.325027621878;5870.26621672291;5882.294124705063;5816.563757718188;5843.795467158629;5858.121281807677;5862.325832529314;5887.35239123696;4495.797689103998;4505.189065968158;4511.842085527056;4516.887077823015;4537.863864084083;3955.841766329372;4058.1680755445063;4069.6337329640473;4080.8775736727944;4122.6083522065355;5662.462066103713;5671.120976248688;5673.375928647845;5673.716314184274;5750.424957504216;5903.114532820111;6007;6008.939910600925;6017.217761690952;6023.608465449732;5492.47821456961;5727.541796656257;5763.308402991668;5808.419158084158;5812.709364531756;4969.0310389474425;5014.423341315795;5016.322796422509;5024.748762561857;5027.748612569357;6237.812865614039;6238.75044998195;6246.781362652286;6248.562600618004;6258.061290806416;5704.828855134353;5813.215215945793;5878.823635290948;5919.23050003514;5949.405059494016;6235.844103897439;6239.0953311770445;6259.405356491126;6263.342349053284;6330.746770129143;5895.115732640138;5897.616654917417;5908.793192238251;5911.054231322968;5934.080217566284;5842.211301474246;5928.466438020599;5982.521398288213;5983.521318294439;6042.697865106815;5686;5710.743016564347;5726.284214473191;5726.74229659658;5731.340895797037;5610.102383618601;5725.227094342211;5728.369879313355;5735.9139612905;5741.11012793001;5644.774209031592;5691.089425691869;5704.80033198836;5709.571782116275;5726.627769194989;5754.8273551791835;5758;5767.423257674199;5770.942290577208;5786.363500014911;5603.551715862803;5635.943640563706;5680.6591604503865;5685.573581981451;5690.516306113861 14:37:40 INFO - PROCESS | 22211 | |1;ext.html;596.8746563221723;658.6048370977414;668.1414382518465;695.2248243208824;709.1773542690477;37776.99999999996;39050.21899562007;39069;39247.80376098122;39382.60617393832;42270.57729422705;42658.78670606643;42729;42762;42772;8730.126987301282;8814.515201663906;8880.200781929625;8893.599788009522;8897;8595.871061934076;8745.081766414498;8759.51822649754;8782.209601135897;8814.955925220365;9053.773655658595;9067.319951003668;9086.045965173627;9098.135677110664;9107.36248462608;8953.104689531026;8953.6866209683;8991;9019.819603607924;9044.77388065297;8831.514266715329;8889.866652000224;8921.821563568757;8923.776905577348;8936.195742383217;42931.57068429338;43038;43283.56716432827;43328;43598.34602480965;3622.5290712207507;3796.7152463565344;3842.423636454554;4122.154958233555;4470.731756094645;32811.343773124405;32984.175395615304;33063.17342066443;33131.17172070693;33179;4417.558244175589;4582;4625.468071171825;4641.907161856778;4648.511906249829;303309;304970;305212;306242;306255;62015.37984620186;62180.689096554226;62277.06584401237;62513.687431562554;62567.374326256155;65504.344956550776;65640.67179664166;65869.34130658727;66140.33859661342;69738;19371.806281937283;19583.608327833364;19714.21143154258;19763.40709778709;19783.10976006083;15013.324400401789;15155.166465844264;15168.620784480476;15171;15185.6203594911;21034;21209.78790212109;21351.67972480414;21533.46166345854;21567.568648627253;7721.806954826062;7801.726939557088;7982.600869956479;8032.759017229492;8059.113497515269;1119.6696974392573;1154.261272785418;1155.7350484880246;1167.6672148437824;1203.6750077479032;33450.665493345245;33697;33754.324913501594;33788.32423351568;34102.48846267308;1134.0474001838331;1223.0582451512287;1253.4422182128865;1255.32212605194;1266.5313833881523;17329.56676083108;17683.646327073388;17722.20250088749;17769.022703751158;17921.910390447963;479154;512707;519845;520803;548253;57499.42500574941;58518.4148158513;58576.41423585795;58643.70678146582;58657;1575.4800915697792;1575.8109026916843;1596.2497626115708;1609.0265389439455;1688.5609741467306;32483;32605.124261595927;33055.50416743799;33248.83375583107;33610.327793444485;53265.13572024961;53990;54012.729936350064;54081.72959135179;54160.187597186865;437962;438383;443539;444980;444987;30803;30873.691263087083;31205.37589248157;31572.36855262928;31736;48015;48916;49280;49407.75296123496;49581.50418495913;41461.79269103635;41756.58243417648;42201.36697949472;42663.36004959866;43122.568774311854;41129.588704113776;41621.58378416177;41938;42050.57949420466;42669.57330426656;41979.58020419879;42241.57758422376;42254.366184507875;43185.7840710807;43383.56616433795;37388.6261137396;37493.81253093717;37634.8118259407;37828.43257351087;38170;28968.7103128966;29309.85345073261;29395.412091758473;29416;29788.255293617833 14:37:40 INFO - PROCESS | 22211 | |2;jquery.html;414.31844615607326;424.23425716581573;433.28075394844564;437.7089235658289;444.85542198785384;18418.539536511595;19234.519137021565;19253.614927701437;19675.901620491913;20454.181832726674;12956.287404192766;13374.398152083155;15809.841901581009;20505.179792808307;20582.279620213296;5304.310439642851;5468.234447177399;5531.2809334786425;5559.305086864142;5988.431099045605;5942.881142377149;5987.161797348353;6005.159277701126;6017.037274036134;6020.157177995085;5393.514583687467;5605.243292155568;5983.790567330145;5986.610870293439;5989.371116032819;5396.83809485716;5397.946020539784;5420.566354691615;5420.728963551806;5422;5243.292155559027;5307.310049693554;5309.309789727349;5326.520613144836;5467.17992301158;14325.856741432557;14539.200343981076;14757.335919883632;14793.11241325524;14808.777868331876;2272.749997500274;2413.1071503543626;2594.8572828494425;2894.6092277542684;3171.1596426946876;10189.694309170736;10231.744206394826;10425.374477531372;10636.840447393295;10755.139588832875;1984.3253293880007;2049.0574335805545;2117.7035215069905;2133.9359819205292;2191.9671204931938;73426.63286683586;80827.59586202032;82553.58723206406;83369.16630833675;85138.57430712807;11419.714507137389;11592.304461732323;11782.82171782832;11878.88121118795;12091;16516.42192523256;16524.75212871808;16666.58333541671;16713;16771.413000544922;8877.156670116457;8941.418807777474;8994.370394072352;8996.235319997873;9054.275657947348;8599.291223264776;8688.478691278544;8743.737687869374;8758.343124265706;8800.515971621495;5077.162268225775;5083.364579427572;5099.184130539096;5230.529252367229;5255.211718242294;2139.679048142791;2153.332466935255;2187.8468507204343;2193.8683678979314;2208.2271205078414;960.3757557587624;1093.7101668057971;1098.6374496416163;1128.136975213962;1190.3215167354524;18610.906945465456;18849.434516964513;18900.71648925267;19222.903885480762;19551.902240488707;1075.2634743333024;1097.4951522299673;1141.058626633031;1141.8572678415198;1196.5572738086964;10391.948040259751;10921.890781092246;10965.232433729563;11052.723681908017;11100.278481898651;484840;486210;491752;498008;498579;74609;87586.56206718925;87602;90619;92377;1101.4052411697594;1117.6926345254958;1154.0709728668335;1154.3477934966718;1179.8053321201905;17276.972841499864;17370.21834017447;17666.5583360417;17683.557911052325;17789.644207116045;40267;40300.1939961205;41319.58680413278;41842;42210.57789422067;58249.4175058244;61608.69195653993;61996.690016549626;62106.68946655238;62136;8959.910400895908;8964.506952117436;9046.63813447481;9065.73079768846;9107.590158442754;11782.705432364259;13198.20810751358;13448.058635895393;13485.190888546718;13669.248191349572;10871.728206794893;11148.163887708291;11163.553457861595;11271.549138034386;11297.604583839526;11415.714607134889;11486.770264594828;11654.89329291048;11810.940945295219;12011.279323240633;10888;11122.332660040423;11218.83171752408;11366.147538934447;11469.197156198987;8518.48889066658;8766.561671916252;8825.306468928824;9050.456972581665;9134.680286189952;8828.42615230008;10915.201475188018;11545.249558778652;11649.068074554185;11751.588694395656 14:37:40 INFO - PROCESS | 22211 | |3;mootools.html;1593.1078595986246;1594.2108656215175;1852.5461261990815;1942.1939894943598;1954.1499447740225;7542.0949486061745;8416.200460956215;8450.197231263028;8623.22390984812;8659.35054870884;8409.495430274188;8435.62039708213;8534.658613655447;8538.530380829052;8557.48655080694;2350.7061617297836;2383.2731017039796;2385.7733515316017;2386;2389.3190440724397;2366.0772298803395;2379.8691071991034;2417.709874815016;2419.1532963462823;2425.2118061629953;2300.424893776556;2300.52839167971;2337.1586228957563;2338.333574931145;2343.8124950003958;2397.85612863227;2398.268528098929;2408.5784987627185;2412.7225369082603;2437.7805997460136;2347.8473899196497;2368.1829768729763;2380.642903564462;2390.5696974544576;2394.7964423024064;8663.090375510606;8728.389012769108;8730.257928076058;8731.301495880378;8769.429987050886;5342.1452567589;5390.434004429518;5391.191321301797;5424.213489044106;5434.673919564799;3409.130671678731;3449.5170676105367;3479.1823921378455;3540.628234035415;3550.4851796489625;1081.1620993729844;1109.3842917180962;1118.0273162348728;1128.7742451509648;1135.6593022093339;12430.75138497234;12446.875531244663;12456.937715311547;12462.127651064338;12466.314352710597;4675.08835777027;4718.905621887543;4740.834070807505;4817.975910120427;4844.539768721966;10551.525181366856;10566.682999510027;10576.894231057744;10581.259311848096;10590.57637694499;5409.350877894678;5442.156465747816;5457.345118585716;5459.836204913859;5473.890522189534;4646.4191976003;4757.286407038902;4762.261849413347;4793.089313030513;4964;3823.4647149399107;3858.054776579756;3876.6898648108086;3904.6290602393296;3913.2760439318818;1169.257521473853;1171.262104873924;1180.5926955200441;1186.6321440353518;1206.6078524479578;982.2289502740315;987.9555420005973;994.3089552760762;997.2022382094295;1019.607451131305;5602.4957753802355;5817.563682723812;5843.29880414353;5846.356900740915;5944.613600115978;460.4796579864731;464.47978264343476;468.57359802579487;470.6799376423996;472.11478477854024;3763.172102137525;3776.8866933992026;3786.3373909565717;3814.1036856338737;3822.0444888777806;10224.897751022394;10394.272400931863;10850.457477126112;10920.235583509078;10927.125829933586;10185.287029907984;10369.274150809371;10388.844167337496;10401;10429.895701043044;7924.247196516321;8117.4317797754775;8157.877631835528;8216.301614362726;8226.712065077694;5499.4225606310765;5504.091824848855;5557.083081291703;5614.354349249726;5621.747021383966;9547.093026162504;9665.516724163623;9750.268729845147;9788;9793.167580755715;9281.303902207226;9360.297977651839;9423.481708506099;9621.807563848824;9644.324897257406;7583.544987300779;7751.457397982087;7757.456978011711;7790.493617914817;7932.6430310635005;8258.83482330338;8273.793155171168;8289.33685305162;8316.209960053786;8316.209960053786;7527.661255243636;7757.185495522889;7757.806054848674;7772.37820974332;7821.6089195541135;7510.061242344707;7570.697172113054;7574.886376704464;7674.309312161932;7677.500962437647;6464.482841372773;6498.805035848932;6548.967255163694;6556.672166391566;6568.80293591193;4700.788464519036;4796.688215265996;4866.1727506323305;4869.196582563837;4877.170880950176;4857.587105096107;4902.460729319843;4933.802647894044;5010.123228435083;5020.397552293748 14:37:40 INFO - PROCESS | 22211 | |4;prototype.html;361.1512944580238;367.81609195402297;368.18079772506167;368.4473290064904;368.655307287686;6321.620702757832;6322.367763223675;6403.135576697145;6404.327545607714;6534.477241820655;6352.301246862841;6367.076773867786;6408.615483071019;6424.3575642435735;6425.357464253572;4724.078804633098;4815.494373090827;4826.9034619307595;4835.492273311304;4837.274408838667;4843.975780121094;4861.611071114302;4877.02459508098;4878.780454879521;4880.194767863299;4810.711357318554;4813.807447702087;4825.324454576362;4826.32431459596;4828.203346447849;4818.638602104821;4818.927716084261;4821.4696383397795;4822.469528351896;4831.347768051303;4222.176675548239;4227.450431443924;4229.069604686964;4229.936550951738;4232.470941132358;6071.1803906472505;6076.210092687967;6202.3797620238065;6205.627662340229;6215.533834962396;5634.605577609569;5650.491455769001;5658.801941932013;5665.745041473144;5669.8582535436535;6809.3190680932;6810;6811.965940170317;6818.28408017156;6819.590824550493;4700.848292168406;4703.764811759398;4710.717356958559;4714.787834547419;4717.693349932278;7090.539114957563;7139.357457828821;7153.535020223669;7157;7158.749443769443;4686.601638860735;4767.6662633615315;4771.475137734847;4780.545848144421;4813.470518242991;4825;4864.95135048645;4866.8783280417565;4873.634477414208;4875.878103047452;5589.469000444951;5632.577556683265;5644;5749.511291540266;5752.36723960364;6849.897251541231;6858.417034552019;7000.474964377692;7007.544509606859;7011.824704382431;1763.7530745695612;1786.437272259234;1788.9821101788816;1789.042862068787;1790.444962061765;1189.9643010709692;1199.0168062189096;1201.0931746531487;1204.9518019279305;1205.7166565857017;6762.830929226809;6763.830904227335;6777.118974533378;6782.287859774751;6793.694283757242;7127.607981561064;7134.536255143399;7136.750213742494;7147.2852714728115;7147.82130446743;6740.258571557125;6741.764038258638;6748.223954245324;6762.087118239073;6837.589744615339;3751.15598990225;3791.431285307226;3850.8459661613783;3856.8842934712;3860.613938606117;7551.565202611486;7552.773416797505;7559.811004724816;7564.735234266775;7565.43259255558;7204.603746793977;7205.423566114699;7238.565686058748;7255.927440725525;7257.92742072583;7510.023696919475;7522.097348318128;7529.774106776806;7535.849283014309;7537.660805263777;6944.652767361511;7058.505904586629;7109.075820143556;7115.288471152843;7120.821979450555;6941.409980151744;6963.825904352431;6972.616506092214;7000.334968178015;7003.859922801617;7482.476226664299;7519.285667861544;7530.359919406693;7535.095788505414;7541.6229188539255;4917.680350777188;4940.777665005012;4943.530364615356;4948.604111671129;4949.1586430306215;6993.195782484876;7099.609521476368;7100.431965442649;7164.211936687065;7198.172210195685;6862.3480769328835;6880.346367095118;6885.173779146535;6886.173659160932;6891.75878844238;6871.4502839773695;6884.449244060564;6897.62063086515;6897.689603967733;6914.861702765816;6758.155230596176;6779.864402712017;6789.388954994074;6799.864002720017;6800.183977922681;6783.59298442095;6906.827329316607;6920.9653951729915;6922.376986071277;6927.134108236471;6797.6941037654415;6812.659367031728;6830.521863469509;6830.93169068303;6842.55523390978 14:37:40 INFO - PROCESS | 22211 | |5;yui.html;801.8957535520385;836.9455985360951;859.9570021498928;937.2642475656611;948.8576713492979;14974.101553906774;15158.393664253417;15178.089314641129;15227.314770835312;15263.16052617107;14485.420583176687;14498.202598857086;14532.346044427999;14534.127952322842;14606;737.4763917618498;912.4251721415499;922.3773952582014;922.4603606889943;922.7785331520454;914.7758799094231;915.0712027292303;922.0594993107027;924.8797656304671;933.3046880074354;974.1184228273388;974.4835237324229;975.7804493988831;977.081543349253;977.4282045003681;967.4147140979746;968.1818863060703;970.7039352997368;975.6926568131016;976.4775844922967;705.28765946394;707.6178863413751;710.2471380336859;711.6228398948514;712.0636363182399;14227.430902763877;14295.428182872673;14320.57038288853;14322.64193395163;14363.281835908267;15012.324445399983;15217.6195595111;15282.388704451809;15411;15447.845521544754;11704.648860534198;11806.291622502677;11864.703382415422;12011.459484323226;12148;4079.286124928126;4095.7747323897174;4120.7321524101135;4261.21167583998;4267.4025636410925;54911;55532.72233638806;55763.16355254674;57066.14400783992;57166.7141664289;11765.52937882475;11936.880631193577;12049.638510844688;12057;12211.389430528438;21562.56874862494;21632.35102946914;21690.24084157047;21762.673559896615;21795.128194872028;8746.344024198082;8769.868451973225;8831.116888311246;8847.955760221157;8907.821843563092;4659.906801863944;4801.831935882227;4802.903941921142;4863.246196839425;4957.876053098701;3592.191756854687;3661.377565813818;3664.6518580734787;3666.395044817629;3666.431703086026;626.5864529410567;637.0348921384107;637.37537213531;641.2113100885844;659.7492952677952;693.0539813155007;730.6931088942657;828.4159667434444;846.0524212881612;848.4230723108345;10308.896911030944;10695.679129626124;10726.946365268124;10784.191185661106;10809.547721204975;844.1474111147785;856.2978357746713;858.7981824271292;864.2208586516573;869.8477766390856;4634.536546345338;4780.354652121989;4851.442084160367;4879.829205977774;5018.397792264878;68005.65997170082;68693;68773.31226687769;68939.65530172316;69050;55195.72402137964;58234;59894.70052649709;60306;60896;52391.47608523866;52581.737091314295;53128.93742125136;53608.731956339965;53855.730721346925;9787.755306117118;9878.654247101316;9937.509678257391;9977.10206081456;10045.397276163454;36467.817660911525;38197.80901095477;39179.804100979316;39746.60253397545;40929.59070409377;51619.74190129175;51954.74022629863;52156.21765673442;52456.21315680192;52692.20961685501;13287.468501260228;13469.12450690702;13617.750313185434;13619.114757540729;13728.794068088788;14447.711045778815;14464.927675361556;14739.26303684833;14799.482018129314;15406.537803865902;12876.420561074587;13014.804777928528;14336.283185840875;14390.928045359706;15136.924315378794;13963.232022238468;14003.789943150658;14118.50585229512;14286.857131428553;14317;11836.76326473483;12420.316882571546;12520.812187817008;12677.619671409873;13010.479580816662;10347.689569312932;11114;11445.713857153638;11529.481173347052;11887.82168267494;11560.710982225512;11598.768024639628;11671.533138674358;11831.881681183078;11842.703932401759 14:37:40 INFO - PROCESS | 22211 | __end_tp_report 14:37:40 INFO - PROCESS | 22211 | __start_cc_report 14:37:40 INFO - PROCESS | 22211 | _x_x_mozilla_cycle_collect,324 14:37:40 INFO - PROCESS | 22211 | __end_cc_report 14:37:40 INFO - PROCESS | 22211 | __startTimestamp1468359460181__endTimestamp 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | ------- Summary: start ------- 14:37:40 INFO - PROCESS | 22211 | Number of tests: 6 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | [#0] dojo.html Cycles:165 Average:5505.03 Median:5709.57 stddev:608.67 (10.7%) stddev-sans-first:585.12 14:37:40 INFO - PROCESS | 22211 | Values: 3286.3 3343.6 3354.0 3377.0 3379.3 5498.3 5515.5 5528.8 5544.3 5552.6 5539.0 5539.1 5560.3 5584.0 5596.7 5040.0 5050.3 5101.4 5114.6 5125.3 4991.3 5008.3 5147.2 5217.4 5243.7 5052.0 5085.2 5105.8 5151.9 5167.5 5101.0 5102.2 5103.8 5106.8 5131.8 4889.7 4953.0 4976.3 5025.3 5041.9 5326.0 5335.6 5388.3 5389.6 5402.6 5884.8 5891.3 5892.7 5894.3 5896.6 5934.6 5953.4 5960.8 5965.7 6003.2 5493.9 5528.2 5534.9 5541.6 5553.8 5869.9 5969.3 6017.2 6017.9 6024.5 5634.4 5751.4 5759.0 5759.4 5769.7 5877.9 5880.6 5882.3 5892.1 5896.1 5797.4 5852.2 5869.3 5870.3 5882.3 5816.6 5843.8 5858.1 5862.3 5887.4 4495.8 4505.2 4511.8 4516.9 4537.9 3955.8 4058.2 4069.6 4080.9 4122.6 5662.5 5671.1 5673.4 5673.7 5750.4 5903.1 6007.0 6008.9 6017.2 6023.6 5492.5 5727.5 5763.3 5808.4 5812.7 4969.0 5014.4 5016.3 5024.7 5027.7 6237.8 6238.8 6246.8 6248.6 6258.1 5704.8 5813.2 5878.8 5919.2 5949.4 6235.8 6239.1 6259.4 6263.3 6330.7 5895.1 5897.6 5908.8 5911.1 5934.1 5842.2 5928.5 5982.5 5983.5 6042.7 5686.0 5710.7 5726.3 5726.7 5731.3 5610.1 5725.2 5728.4 5735.9 5741.1 5644.8 5691.1 5704.8 5709.6 5726.6 5754.8 5758.0 5767.4 5770.9 5786.4 5603.6 5635.9 5680.7 5685.6 5690.5 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | [#1] ext.html Cycles:180 Average:59518.10 Median:42661.07 stddev:113837.37 (266.8%) stddev-sans-first:114070.75 14:37:40 INFO - PROCESS | 22211 | Values: 596.9 658.6 668.1 695.2 709.2 37777.0 39050.2 39069.0 39247.8 39382.6 42270.6 42658.8 42729.0 42762.0 42772.0 8730.1 8814.5 8880.2 8893.6 8897.0 8595.9 8745.1 8759.5 8782.2 8815.0 9053.8 9067.3 9086.0 9098.1 9107.4 8953.1 8953.7 8991.0 9019.8 9044.8 8831.5 8889.9 8921.8 8923.8 8936.2 42931.6 43038.0 43283.6 43328.0 43598.3 3622.5 3796.7 3842.4 4122.2 4470.7 32811.3 32984.2 33063.2 33131.2 33179.0 4417.6 4582.0 4625.5 4641.9 4648.5 303309.0 304970.0 305212.0 306242.0 306255.0 62015.4 62180.7 62277.1 62513.7 62567.4 65504.3 65640.7 65869.3 66140.3 69738.0 19371.8 19583.6 19714.2 19763.4 19783.1 15013.3 15155.2 15168.6 15171.0 15185.6 21034.0 21209.8 21351.7 21533.5 21567.6 7721.8 7801.7 7982.6 8032.8 8059.1 1119.7 1154.3 1155.7 1167.7 1203.7 33450.7 33697.0 33754.3 33788.3 34102.5 1134.0 1223.1 1253.4 1255.3 1266.5 17329.6 17683.6 17722.2 17769.0 17921.9 479154.0 512707.0 519845.0 520803.0 548253.0 57499.4 58518.4 58576.4 58643.7 58657.0 1575.5 1575.8 1596.2 1609.0 1688.6 32483.0 32605.1 33055.5 33248.8 33610.3 53265.1 53990.0 54012.7 54081.7 54160.2 437962.0 438383.0 443539.0 444980.0 444987.0 30803.0 30873.7 31205.4 31572.4 31736.0 48015.0 48916.0 49280.0 49407.8 49581.5 41461.8 41756.6 42201.4 42663.4 43122.6 41129.6 41621.6 41938.0 42050.6 42669.6 41979.6 42241.6 42254.4 43185.8 43383.6 37388.6 37493.8 37634.8 37828.4 38170.0 28968.7 29309.9 29395.4 29416.0 29788.3 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | [#2] jquery.html Cycles:180 Average:28793.72 Median:2192.92 stddev:81035.67 (3695.3%) stddev-sans-first:81234.98 14:37:40 INFO - PROCESS | 22211 | Values: 414.3 424.2 433.3 437.7 444.9 18418.5 19234.5 19253.6 19675.9 20454.2 12956.3 13374.4 15809.8 20505.2 20582.3 5304.3 5468.2 5531.3 5559.3 5988.4 5942.9 5987.2 6005.2 6017.0 6020.2 5393.5 5605.2 5983.8 5986.6 5989.4 5396.8 5397.9 5420.6 5420.7 5422.0 5243.3 5307.3 5309.3 5326.5 5467.2 14325.9 14539.2 14757.3 14793.1 14808.8 2272.7 2413.1 2594.9 2894.6 3171.2 10189.7 10231.7 10425.4 10636.8 10755.1 1984.3 2049.1 2117.7 2133.9 2192.0 73426.6 80827.6 82553.6 83369.2 85138.6 11419.7 11592.3 11782.8 11878.9 12091.0 16516.4 16524.8 16666.6 16713.0 16771.4 8877.2 8941.4 8994.4 8996.2 9054.3 8599.3 8688.5 8743.7 8758.3 8800.5 5077.2 5083.4 5099.2 5230.5 5255.2 2139.7 2153.3 2187.8 2193.9 2208.2 960.4 1093.7 1098.6 1128.1 1190.3 18610.9 18849.4 18900.7 19222.9 19551.9 1075.3 1097.5 1141.1 1141.9 1196.6 10391.9 10921.9 10965.2 11052.7 11100.3 484840.0 486210.0 491752.0 498008.0 498579.0 74609.0 87586.6 87602.0 90619.0 92377.0 1101.4 1117.7 1154.1 1154.3 1179.8 17277.0 17370.2 17666.6 17683.6 17789.6 40267.0 40300.2 41319.6 41842.0 42210.6 58249.4 61608.7 61996.7 62106.7 62136.0 8959.9 8964.5 9046.6 9065.7 9107.6 11782.7 13198.2 13448.1 13485.2 13669.2 10871.7 11148.2 11163.6 11271.5 11297.6 11415.7 11486.8 11654.9 11810.9 12011.3 10888.0 11122.3 11218.8 11366.1 11469.2 8518.5 8766.6 8825.3 9050.5 9134.7 8828.4 10915.2 11545.2 11649.1 11751.6 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | [#3] mootools.html Cycles:180 Average:5692.67 Median:4831.26 stddev:3223.73 (66.7%) stddev-sans-first:3218.06 14:37:40 INFO - PROCESS | 22211 | Values: 1593.1 1594.2 1852.5 1942.2 1954.1 7542.1 8416.2 8450.2 8623.2 8659.4 8409.5 8435.6 8534.7 8538.5 8557.5 2350.7 2383.3 2385.8 2386.0 2389.3 2366.1 2379.9 2417.7 2419.2 2425.2 2300.4 2300.5 2337.2 2338.3 2343.8 2397.9 2398.3 2408.6 2412.7 2437.8 2347.8 2368.2 2380.6 2390.6 2394.8 8663.1 8728.4 8730.3 8731.3 8769.4 5342.1 5390.4 5391.2 5424.2 5434.7 3409.1 3449.5 3479.2 3540.6 3550.5 1081.2 1109.4 1118.0 1128.8 1135.7 12430.8 12446.9 12456.9 12462.1 12466.3 4675.1 4718.9 4740.8 4818.0 4844.5 10551.5 10566.7 10576.9 10581.3 10590.6 5409.4 5442.2 5457.3 5459.8 5473.9 4646.4 4757.3 4762.3 4793.1 4964.0 3823.5 3858.1 3876.7 3904.6 3913.3 1169.3 1171.3 1180.6 1186.6 1206.6 982.2 988.0 994.3 997.2 1019.6 5602.5 5817.6 5843.3 5846.4 5944.6 460.5 464.5 468.6 470.7 472.1 3763.2 3776.9 3786.3 3814.1 3822.0 10224.9 10394.3 10850.5 10920.2 10927.1 10185.3 10369.3 10388.8 10401.0 10429.9 7924.2 8117.4 8157.9 8216.3 8226.7 5499.4 5504.1 5557.1 5614.4 5621.7 9547.1 9665.5 9750.3 9788.0 9793.2 9281.3 9360.3 9423.5 9621.8 9644.3 7583.5 7751.5 7757.5 7790.5 7932.6 8258.8 8273.8 8289.3 8316.2 8316.2 7527.7 7757.2 7757.8 7772.4 7821.6 7510.1 7570.7 7574.9 7674.3 7677.5 6464.5 6498.8 6549.0 6556.7 6568.8 4700.8 4796.7 4866.2 4869.2 4877.2 4857.6 4902.5 4933.8 5010.1 5020.4 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | [#4] prototype.html Cycles:180 Average:5753.45 Median:6741.01 stddev:1759.86 (26.1%) stddev-sans-first:1717.63 14:37:40 INFO - PROCESS | 22211 | Values: 361.2 367.8 368.2 368.4 368.7 6321.6 6322.4 6403.1 6404.3 6534.5 6352.3 6367.1 6408.6 6424.4 6425.4 4724.1 4815.5 4826.9 4835.5 4837.3 4844.0 4861.6 4877.0 4878.8 4880.2 4810.7 4813.8 4825.3 4826.3 4828.2 4818.6 4818.9 4821.5 4822.5 4831.3 4222.2 4227.5 4229.1 4229.9 4232.5 6071.2 6076.2 6202.4 6205.6 6215.5 5634.6 5650.5 5658.8 5665.7 5669.9 6809.3 6810.0 6812.0 6818.3 6819.6 4700.8 4703.8 4710.7 4714.8 4717.7 7090.5 7139.4 7153.5 7157.0 7158.7 4686.6 4767.7 4771.5 4780.5 4813.5 4825.0 4865.0 4866.9 4873.6 4875.9 5589.5 5632.6 5644.0 5749.5 5752.4 6849.9 6858.4 7000.5 7007.5 7011.8 1763.8 1786.4 1789.0 1789.0 1790.4 1190.0 1199.0 1201.1 1205.0 1205.7 6762.8 6763.8 6777.1 6782.3 6793.7 7127.6 7134.5 7136.8 7147.3 7147.8 6740.3 6741.8 6748.2 6762.1 6837.6 3751.2 3791.4 3850.8 3856.9 3860.6 7551.6 7552.8 7559.8 7564.7 7565.4 7204.6 7205.4 7238.6 7255.9 7257.9 7510.0 7522.1 7529.8 7535.8 7537.7 6944.7 7058.5 7109.1 7115.3 7120.8 6941.4 6963.8 6972.6 7000.3 7003.9 7482.5 7519.3 7530.4 7535.1 7541.6 4917.7 4940.8 4943.5 4948.6 4949.2 6993.2 7099.6 7100.4 7164.2 7198.2 6862.3 6880.3 6885.2 6886.2 6891.8 6871.5 6884.4 6897.6 6897.7 6914.9 6758.2 6779.9 6789.4 6799.9 6800.2 6783.6 6906.8 6921.0 6922.4 6927.1 6797.7 6812.7 6830.5 6830.9 6842.6 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - PROCESS | 22211 | [#5] yui.html Cycles:180 Average:16086.62 Median:4450.97 stddev:18543.09 (416.6%) stddev-sans-first:18559.58 14:37:40 INFO - PROCESS | 22211 | Values: 801.9 836.9 860.0 937.3 948.9 14974.1 15158.4 15178.1 15227.3 15263.2 14485.4 14498.2 14532.3 14534.1 14606.0 737.5 912.4 922.4 922.5 922.8 914.8 915.1 922.1 924.9 933.3 974.1 974.5 975.8 977.1 977.4 967.4 968.2 970.7 975.7 976.5 705.3 707.6 710.2 711.6 712.1 14227.4 14295.4 14320.6 14322.6 14363.3 15012.3 15217.6 15282.4 15411.0 15447.8 11704.6 11806.3 11864.7 12011.5 12148.0 4079.3 4095.8 4120.7 4261.2 4267.4 54911.0 55532.7 55763.2 57066.1 57166.7 11765.5 11936.9 12049.6 12057.0 12211.4 21562.6 21632.4 21690.2 21762.7 21795.1 8746.3 8769.9 8831.1 8848.0 8907.8 4659.9 4801.8 4802.9 4863.2 4957.9 3592.2 3661.4 3664.7 3666.4 3666.4 626.6 637.0 637.4 641.2 659.7 693.1 730.7 828.4 846.1 848.4 10308.9 10695.7 10726.9 10784.2 10809.5 844.1 856.3 858.8 864.2 869.8 4634.5 4780.4 4851.4 4879.8 5018.4 68005.7 68693.0 68773.3 68939.7 69050.0 55195.7 58234.0 59894.7 60306.0 60896.0 52391.5 52581.7 53128.9 53608.7 53855.7 9787.8 9878.7 9937.5 9977.1 10045.4 36467.8 38197.8 39179.8 39746.6 40929.6 51619.7 51954.7 52156.2 52456.2 52692.2 13287.5 13469.1 13617.8 13619.1 13728.8 14447.7 14464.9 14739.3 14799.5 15406.5 12876.4 13014.8 14336.3 14390.9 15136.9 13963.2 14003.8 14118.5 14286.9 14317.0 11836.8 12420.3 12520.8 12677.6 13010.5 10347.7 11114.0 11445.7 11529.5 11887.8 11560.7 11598.8 11671.5 11831.9 11842.7 14:37:40 INFO - PROCESS | 22211 | -------- Summary: end -------- 14:37:40 INFO - PROCESS | 22211 | 14:37:40 INFO - TEST-INFO | 22211: exit 0 14:37:40 INFO - TEST-OK | dromaeo_css | took 1108624ms 14:37:40 INFO - TEST-START | kraken 14:37:40 INFO - operating with platform_type : linux_ 14:37:40 INFO - Initialising browser for kraken test... 14:37:40 INFO - TEST-INFO | started process 22454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf2M06Y/profile http://localhost:49683/getInfo.html) 14:37:44 INFO - PROCESS | 22454 | 14:37:44 INFO - PROCESS | 22454 | (process:22532): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:37:44 INFO - PROCESS | 22454 | __metrics Screen width/height:1600/1200 14:37:44 INFO - PROCESS | 22454 | colorDepth:24 14:37:44 INFO - PROCESS | 22454 | Browser inner width/height: 1024/697 14:37:44 INFO - PROCESS | 22454 | __metrics 14:37:45 ERROR - PROCESS | 22454 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:37:46 INFO - TEST-INFO | 22454: exit 0 14:37:46 INFO - Browser initialized. 14:37:46 INFO - Running cycle 1/1 for kraken test... 14:37:46 INFO - TEST-INFO | started process 22582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf2M06Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:48 INFO - PROCESS | 22582 | 14:37:48 INFO - PROCESS | 22582 | (process:22648): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:37:58 INFO - PROCESS | 22582 | RSS: Main: 150548480 14:37:58 INFO - PROCESS | 22582 | 14:38:00 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:01 INFO - PROCESS | 22582 | RSS: Main: 156377088 14:38:01 INFO - PROCESS | 22582 | 14:38:04 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-dft) 14:38:04 INFO - PROCESS | 22582 | RSS: Main: 156192768 14:38:04 INFO - PROCESS | 22582 | 14:38:07 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-fft) 14:38:08 INFO - PROCESS | 22582 | RSS: Main: 156868608 14:38:08 INFO - PROCESS | 22582 | 14:38:10 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49683/tests/kraken/driver.html?testName=audio-oscillator) 14:38:10 INFO - PROCESS | 22582 | RSS: Main: 156360704 14:38:10 INFO - PROCESS | 22582 | 14:38:13 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:13 INFO - PROCESS | 22582 | RSS: Main: 156725248 14:38:13 INFO - PROCESS | 22582 | 14:38:16 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:17 INFO - PROCESS | 22582 | RSS: Main: 156602368 14:38:17 INFO - PROCESS | 22582 | 14:38:20 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49683/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:21 INFO - PROCESS | 22582 | RSS: Main: 156946432 14:38:21 INFO - PROCESS | 22582 | 14:38:23 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49683/tests/kraken/driver.html?testName=json-parse-financial) 14:38:24 INFO - PROCESS | 22582 | RSS: Main: 157036544 14:38:24 INFO - PROCESS | 22582 | 14:38:26 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:26 INFO - PROCESS | 22582 | RSS: Main: 156811264 14:38:26 INFO - PROCESS | 22582 | 14:38:28 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:29 INFO - PROCESS | 22582 | RSS: Main: 156610560 14:38:29 INFO - PROCESS | 22582 | 14:38:31 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:31 INFO - PROCESS | 22582 | RSS: Main: 156975104 14:38:31 INFO - PROCESS | 22582 | 14:38:34 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:34 INFO - PROCESS | 22582 | RSS: Main: 157519872 14:38:34 INFO - PROCESS | 22582 | 14:38:37 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:38 INFO - PROCESS | 22582 | RSS: Main: 157188096 14:38:38 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | Cycle 1(1): loaded http://localhost:49683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49683/tests/kraken/driver.html?testName=ai-astar) 14:38:39 INFO - PROCESS | 22582 | RSS: Main: 158703616 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | __start_tp_report 14:38:39 INFO - PROCESS | 22582 | _x_x_mozilla_page_load 14:38:39 INFO - PROCESS | 22582 | _x_x_mozilla_page_load_details 14:38:39 INFO - PROCESS | 22582 | |i|pagename|runs| 14:38:39 INFO - PROCESS | 22582 | |0;ai-astar;109;110;104;110;110;110;100;108;110;108 14:38:39 INFO - PROCESS | 22582 | |1;audio-beat-detection;159;128;153;186;131;159;154;133;178;127 14:38:39 INFO - PROCESS | 22582 | |2;audio-dft;164;162;163;161;162;163;162;161;162;162 14:38:39 INFO - PROCESS | 22582 | |3;audio-fft;75;76;73;181;77;77;73;86;162;74 14:38:39 INFO - PROCESS | 22582 | |4;audio-oscillator;93;92;151;91;93;92;151;92;91;138 14:38:39 INFO - PROCESS | 22582 | |5;imaging-gaussian-blur;117;118;117;118;117;121;117;116;117;117 14:38:39 INFO - PROCESS | 22582 | |6;imaging-darkroom;146;147;146;147;145;147;146;148;146;147 14:38:39 INFO - PROCESS | 22582 | |7;imaging-desaturate;95;95;95;97;95;99;99;95;96;94 14:38:39 INFO - PROCESS | 22582 | |8;json-parse-financial;56;55;55;54;55;55;57;78;53;55 14:38:39 INFO - PROCESS | 22582 | |9;json-stringify-tinderbox;58;60;58;58;59;58;58;58;59;59 14:38:39 INFO - PROCESS | 22582 | |10;stanford-crypto-aes;72;72;72;83;73;81;74;74;74;73 14:38:39 INFO - PROCESS | 22582 | |11;stanford-crypto-ccm;115;113;122;115;115;117;117;126;132;127 14:38:39 INFO - PROCESS | 22582 | |12;stanford-crypto-pbkdf2;162;162;161;162;161;166;165;160;160;156 14:38:39 INFO - PROCESS | 22582 | |13;stanford-crypto-sha256-iterative;67;69;70;66;68;67;69;70;66;67 14:38:39 INFO - PROCESS | 22582 | __end_tp_report 14:38:39 INFO - PROCESS | 22582 | __start_cc_report 14:38:39 INFO - PROCESS | 22582 | _x_x_mozilla_cycle_collect,821 14:38:39 INFO - PROCESS | 22582 | __end_cc_report 14:38:39 INFO - PROCESS | 22582 | __startTimestamp1468359519973__endTimestamp 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | ------- Summary: start ------- 14:38:39 INFO - PROCESS | 22582 | Number of tests: 14 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:3.35 (3.0%) stddev-sans-first:3.53 14:38:39 INFO - PROCESS | 22582 | Values: 109.0 110.0 104.0 110.0 110.0 110.0 100.0 108.0 110.0 108.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:156.50 stddev:20.88 (13.3%) stddev-sans-first:21.93 14:38:39 INFO - PROCESS | 22582 | Values: 159.0 128.0 153.0 186.0 131.0 159.0 154.0 133.0 178.0 127.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 14:38:39 INFO - PROCESS | 22582 | Values: 164.0 162.0 163.0 161.0 162.0 163.0 162.0 161.0 162.0 162.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:40.53 (53.7%) stddev-sans-first:42.31 14:38:39 INFO - PROCESS | 22582 | Values: 75.0 76.0 73.0 181.0 77.0 77.0 73.0 86.0 162.0 74.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:92.00 stddev:26.65 (29.0%) stddev-sans-first:27.68 14:38:39 INFO - PROCESS | 22582 | Values: 93.0 92.0 151.0 91.0 93.0 92.0 151.0 92.0 91.0 138.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 14:38:39 INFO - PROCESS | 22582 | Values: 117.0 118.0 117.0 118.0 117.0 121.0 117.0 116.0 117.0 117.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 14:38:39 INFO - PROCESS | 22582 | Values: 146.0 147.0 146.0 147.0 145.0 147.0 146.0 148.0 146.0 147.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.50 stddev:1.76 (1.8%) stddev-sans-first:1.83 14:38:39 INFO - PROCESS | 22582 | Values: 95.0 95.0 95.0 97.0 95.0 99.0 99.0 95.0 96.0 94.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.00 stddev:7.35 (13.4%) stddev-sans-first:7.78 14:38:39 INFO - PROCESS | 22582 | Values: 56.0 55.0 55.0 54.0 55.0 55.0 57.0 78.0 53.0 55.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 14:38:39 INFO - PROCESS | 22582 | Values: 58.0 60.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 59.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.00 stddev:3.91 (5.3%) stddev-sans-first:4.01 14:38:39 INFO - PROCESS | 22582 | Values: 72.0 72.0 72.0 83.0 73.0 81.0 74.0 74.0 74.0 73.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:119.50 stddev:6.45 (5.4%) stddev-sans-first:6.60 14:38:39 INFO - PROCESS | 22582 | Values: 115.0 113.0 122.0 115.0 115.0 117.0 117.0 126.0 132.0 127.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 14:38:39 INFO - PROCESS | 22582 | Values: 162.0 162.0 161.0 162.0 161.0 166.0 165.0 160.0 160.0 156.0 14:38:39 INFO - PROCESS | 22582 | 14:38:39 INFO - PROCESS | 22582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.52 (2.2%) stddev-sans-first:1.58 14:38:39 INFO - PROCESS | 22582 | Values: 67.0 69.0 70.0 66.0 68.0 67.0 69.0 70.0 66.0 67.0 14:38:39 INFO - PROCESS | 22582 | -------- Summary: end -------- 14:38:39 INFO - PROCESS | 22582 | 14:38:40 INFO - TEST-INFO | 22582: exit 0 14:38:40 INFO - TEST-OK | kraken | took 60006ms 14:38:40 INFO - SUITE-END | took 1168s 14:38:41 INFO - Completed test suite (00:19:28) 14:38:41 INFO - javascript benchmark 14:38:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.260591366942, 3343.5820522434697, 3354.0440974322314, 3376.9831150844257, 3379.2734562069136, 5498.3127109111365, 5515.503604675583, 5528.7788488460465, 5544.306961629796, 5552.611317207797, 5539.002979463695, 5539.086050801623, 5560.277163968689, 5583.972080139603, 5596.720163991805, 5040.0, 5050.292958985745, 5101.438841727407, 5114.565261952738, 5125.333706618135, 4991.276264941581, 5008.3238762767105, 5147.150720131174, 5217.426083130853, 5243.659162154467, 5052.0, 5085.1863701807715, 5105.770240339194, 5151.871203219931, 5167.483251674821, 5100.974495127538, 5102.219290486693, 5103.846884593449, 5106.795728170869, 5131.820386286499, 4889.731064791435, 4953.0341583391255, 4976.278439626234, 5025.346704928373, 5041.873953151164, 5325.973370133163, 5335.626506144571, 5388.326459192601, 5389.649672771257, 5402.594805389612, 5884.823455296305, 5891.263592050994, 5892.734826932799, 5894.263217097863, 5896.587238893279, 5934.6142500737315, 5953.434423729782, 5960.821175364746, 5965.671888046156, 6003.159557661931, 5493.890122197534, 5528.170774383834, 5534.916976245359, 5541.5843811714285, 5553.805616803393, 5869.941300587025, 5969.343372229051, 6017.217761690952, 6017.909731354033, 6024.457798798129, 5634.352049514358, 5751.396103409165, 5759.0, 5759.395263497357, 5769.68266745333, 5877.941220587825, 5880.647161170344, 5882.264716910387, 5892.086726557391, 5896.086106653475, 5797.391273916178, 5852.180694702745, 5869.325027621878, 5870.26621672291, 5882.294124705063, 5816.563757718188, 5843.795467158629, 5858.121281807677, 5862.325832529314, 5887.35239123696, 4495.797689103998, 4505.189065968158, 4511.842085527056, 4516.887077823015, 4537.863864084083, 3955.841766329372, 4058.1680755445063, 4069.6337329640473, 4080.8775736727944, 4122.6083522065355, 5662.462066103713, 5671.120976248688, 5673.375928647845, 5673.716314184274, 5750.424957504216, 5903.114532820111, 6007.0, 6008.939910600925, 6017.217761690952, 6023.608465449732, 5492.47821456961, 5727.541796656257, 5763.308402991668, 5808.419158084158, 5812.709364531756, 4969.0310389474425, 5014.423341315795, 5016.322796422509, 5024.748762561857, 5027.748612569357, 6237.812865614039, 6238.75044998195, 6246.781362652286, 6248.562600618004, 6258.061290806416, 5704.828855134353, 5813.215215945793, 5878.823635290948, 5919.23050003514, 5949.405059494016, 6235.844103897439, 6239.0953311770445, 6259.405356491126, 6263.342349053284, 6330.746770129143, 5895.115732640138, 5897.616654917417, 5908.793192238251, 5911.054231322968, 5934.080217566284, 5842.211301474246, 5928.466438020599, 5982.521398288213, 5983.521318294439, 6042.697865106815, 5686.0, 5710.743016564347, 5726.284214473191, 5726.74229659658, 5731.340895797037, 5610.102383618601, 5725.227094342211, 5728.369879313355, 5735.9139612905, 5741.11012793001, 5644.774209031592, 5691.089425691869, 5704.80033198836, 5709.571782116275, 5726.627769194989, 5754.8273551791835, 5758.0, 5767.423257674199, 5770.942290577208, 5786.363500014911, 5603.551715862803, 5635.943640563706, 5680.6591604503865, 5685.573581981451, 5690.516306113861], "value": 5465.8144160219545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.8746563221723, 658.6048370977414, 668.1414382518465, 695.2248243208824, 709.1773542690477, 37776.99999999996, 39050.21899562007, 39069.0, 39247.80376098122, 39382.60617393832, 42270.57729422705, 42658.78670606643, 42729.0, 42762.0, 42772.0, 8730.126987301282, 8814.515201663906, 8880.200781929625, 8893.599788009522, 8897.0, 8595.871061934076, 8745.081766414498, 8759.51822649754, 8782.209601135897, 8814.955925220365, 9053.773655658595, 9067.319951003668, 9086.045965173627, 9098.135677110664, 9107.36248462608, 8953.104689531026, 8953.6866209683, 8991.0, 9019.819603607924, 9044.77388065297, 8831.514266715329, 8889.866652000224, 8921.821563568757, 8923.776905577348, 8936.195742383217, 42931.57068429338, 43038.0, 43283.56716432827, 43328.0, 43598.34602480965, 3622.5290712207507, 3796.7152463565344, 3842.423636454554, 4122.154958233555, 4470.731756094645, 32811.343773124405, 32984.175395615304, 33063.17342066443, 33131.17172070693, 33179.0, 4417.558244175589, 4582.0, 4625.468071171825, 4641.907161856778, 4648.511906249829, 303309.0, 304970.0, 305212.0, 306242.0, 306255.0, 62015.37984620186, 62180.689096554226, 62277.06584401237, 62513.687431562554, 62567.374326256155, 65504.344956550776, 65640.67179664166, 65869.34130658727, 66140.33859661342, 69738.0, 19371.806281937283, 19583.608327833364, 19714.21143154258, 19763.40709778709, 19783.10976006083, 15013.324400401789, 15155.166465844264, 15168.620784480476, 15171.0, 15185.6203594911, 21034.0, 21209.78790212109, 21351.67972480414, 21533.46166345854, 21567.568648627253, 7721.806954826062, 7801.726939557088, 7982.600869956479, 8032.759017229492, 8059.113497515269, 1119.6696974392573, 1154.261272785418, 1155.7350484880246, 1167.6672148437824, 1203.6750077479032, 33450.665493345245, 33697.0, 33754.324913501594, 33788.32423351568, 34102.48846267308, 1134.0474001838331, 1223.0582451512287, 1253.4422182128865, 1255.32212605194, 1266.5313833881523, 17329.56676083108, 17683.646327073388, 17722.20250088749, 17769.022703751158, 17921.910390447963, 479154.0, 512707.0, 519845.0, 520803.0, 548253.0, 57499.42500574941, 58518.4148158513, 58576.41423585795, 58643.70678146582, 58657.0, 1575.4800915697792, 1575.8109026916843, 1596.2497626115708, 1609.0265389439455, 1688.5609741467306, 32483.0, 32605.124261595927, 33055.50416743799, 33248.83375583107, 33610.327793444485, 53265.13572024961, 53990.0, 54012.729936350064, 54081.72959135179, 54160.187597186865, 437962.0, 438383.0, 443539.0, 444980.0, 444987.0, 30803.0, 30873.691263087083, 31205.37589248157, 31572.36855262928, 31736.0, 48015.0, 48916.0, 49280.0, 49407.75296123496, 49581.50418495913, 41461.79269103635, 41756.58243417648, 42201.36697949472, 42663.36004959866, 43122.568774311854, 41129.588704113776, 41621.58378416177, 41938.0, 42050.57949420466, 42669.57330426656, 41979.58020419879, 42241.57758422376, 42254.366184507875, 43185.7840710807, 43383.56616433795, 37388.6261137396, 37493.81253093717, 37634.8118259407, 37828.43257351087, 38170.0, 28968.7103128966, 29309.85345073261, 29395.412091758473, 29416.0, 29788.255293617833], "value": 21040.474625706833, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.31844615607326, 424.23425716581573, 433.28075394844564, 437.7089235658289, 444.85542198785384, 18418.539536511595, 19234.519137021565, 19253.614927701437, 19675.901620491913, 20454.181832726674, 12956.287404192766, 13374.398152083155, 15809.841901581009, 20505.179792808307, 20582.279620213296, 5304.310439642851, 5468.234447177399, 5531.2809334786425, 5559.305086864142, 5988.431099045605, 5942.881142377149, 5987.161797348353, 6005.159277701126, 6017.037274036134, 6020.157177995085, 5393.514583687467, 5605.243292155568, 5983.790567330145, 5986.610870293439, 5989.371116032819, 5396.83809485716, 5397.946020539784, 5420.566354691615, 5420.728963551806, 5422.0, 5243.292155559027, 5307.310049693554, 5309.309789727349, 5326.520613144836, 5467.17992301158, 14325.856741432557, 14539.200343981076, 14757.335919883632, 14793.11241325524, 14808.777868331876, 2272.749997500274, 2413.1071503543626, 2594.8572828494425, 2894.6092277542684, 3171.1596426946876, 10189.694309170736, 10231.744206394826, 10425.374477531372, 10636.840447393295, 10755.139588832875, 1984.3253293880007, 2049.0574335805545, 2117.7035215069905, 2133.9359819205292, 2191.9671204931938, 73426.63286683586, 80827.59586202032, 82553.58723206406, 83369.16630833675, 85138.57430712807, 11419.714507137389, 11592.304461732323, 11782.82171782832, 11878.88121118795, 12091.0, 16516.42192523256, 16524.75212871808, 16666.58333541671, 16713.0, 16771.413000544922, 8877.156670116457, 8941.418807777474, 8994.370394072352, 8996.235319997873, 9054.275657947348, 8599.291223264776, 8688.478691278544, 8743.737687869374, 8758.343124265706, 8800.515971621495, 5077.162268225775, 5083.364579427572, 5099.184130539096, 5230.529252367229, 5255.211718242294, 2139.679048142791, 2153.332466935255, 2187.8468507204343, 2193.8683678979314, 2208.2271205078414, 960.3757557587624, 1093.7101668057971, 1098.6374496416163, 1128.136975213962, 1190.3215167354524, 18610.906945465456, 18849.434516964513, 18900.71648925267, 19222.903885480762, 19551.902240488707, 1075.2634743333024, 1097.4951522299673, 1141.058626633031, 1141.8572678415198, 1196.5572738086964, 10391.948040259751, 10921.890781092246, 10965.232433729563, 11052.723681908017, 11100.278481898651, 484840.0, 486210.0, 491752.0, 498008.0, 498579.0, 74609.0, 87586.56206718925, 87602.0, 90619.0, 92377.0, 1101.4052411697594, 1117.6926345254958, 1154.0709728668335, 1154.3477934966718, 1179.8053321201905, 17276.972841499864, 17370.21834017447, 17666.5583360417, 17683.557911052325, 17789.644207116045, 40267.0, 40300.1939961205, 41319.58680413278, 41842.0, 42210.57789422067, 58249.4175058244, 61608.69195653993, 61996.690016549626, 62106.68946655238, 62136.0, 8959.910400895908, 8964.506952117436, 9046.63813447481, 9065.73079768846, 9107.590158442754, 11782.705432364259, 13198.20810751358, 13448.058635895393, 13485.190888546718, 13669.248191349572, 10871.728206794893, 11148.163887708291, 11163.553457861595, 11271.549138034386, 11297.604583839526, 11415.714607134889, 11486.770264594828, 11654.89329291048, 11810.940945295219, 12011.279323240633, 10888.0, 11122.332660040423, 11218.83171752408, 11366.147538934447, 11469.197156198987, 8518.48889066658, 8766.561671916252, 8825.306468928824, 9050.456972581665, 9134.680286189952, 8828.42615230008, 10915.201475188018, 11545.249558778652, 11649.068074554185, 11751.588694395656], "value": 9340.395102705865, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1593.1078595986246, 1594.2108656215175, 1852.5461261990815, 1942.1939894943598, 1954.1499447740225, 7542.0949486061745, 8416.200460956215, 8450.197231263028, 8623.22390984812, 8659.35054870884, 8409.495430274188, 8435.62039708213, 8534.658613655447, 8538.530380829052, 8557.48655080694, 2350.7061617297836, 2383.2731017039796, 2385.7733515316017, 2386.0, 2389.3190440724397, 2366.0772298803395, 2379.8691071991034, 2417.709874815016, 2419.1532963462823, 2425.2118061629953, 2300.424893776556, 2300.52839167971, 2337.1586228957563, 2338.333574931145, 2343.8124950003958, 2397.85612863227, 2398.268528098929, 2408.5784987627185, 2412.7225369082603, 2437.7805997460136, 2347.8473899196497, 2368.1829768729763, 2380.642903564462, 2390.5696974544576, 2394.7964423024064, 8663.090375510606, 8728.389012769108, 8730.257928076058, 8731.301495880378, 8769.429987050886, 5342.1452567589, 5390.434004429518, 5391.191321301797, 5424.213489044106, 5434.673919564799, 3409.130671678731, 3449.5170676105367, 3479.1823921378455, 3540.628234035415, 3550.4851796489625, 1081.1620993729844, 1109.3842917180962, 1118.0273162348728, 1128.7742451509648, 1135.6593022093339, 12430.75138497234, 12446.875531244663, 12456.937715311547, 12462.127651064338, 12466.314352710597, 4675.08835777027, 4718.905621887543, 4740.834070807505, 4817.975910120427, 4844.539768721966, 10551.525181366856, 10566.682999510027, 10576.894231057744, 10581.259311848096, 10590.57637694499, 5409.350877894678, 5442.156465747816, 5457.345118585716, 5459.836204913859, 5473.890522189534, 4646.4191976003, 4757.286407038902, 4762.261849413347, 4793.089313030513, 4964.0, 3823.4647149399107, 3858.054776579756, 3876.6898648108086, 3904.6290602393296, 3913.2760439318818, 1169.257521473853, 1171.262104873924, 1180.5926955200441, 1186.6321440353518, 1206.6078524479578, 982.2289502740315, 987.9555420005973, 994.3089552760762, 997.2022382094295, 1019.607451131305, 5602.4957753802355, 5817.563682723812, 5843.29880414353, 5846.356900740915, 5944.613600115978, 460.4796579864731, 464.47978264343476, 468.57359802579487, 470.6799376423996, 472.11478477854024, 3763.172102137525, 3776.8866933992026, 3786.3373909565717, 3814.1036856338737, 3822.0444888777806, 10224.897751022394, 10394.272400931863, 10850.457477126112, 10920.235583509078, 10927.125829933586, 10185.287029907984, 10369.274150809371, 10388.844167337496, 10401.0, 10429.895701043044, 7924.247196516321, 8117.4317797754775, 8157.877631835528, 8216.301614362726, 8226.712065077694, 5499.4225606310765, 5504.091824848855, 5557.083081291703, 5614.354349249726, 5621.747021383966, 9547.093026162504, 9665.516724163623, 9750.268729845147, 9788.0, 9793.167580755715, 9281.303902207226, 9360.297977651839, 9423.481708506099, 9621.807563848824, 9644.324897257406, 7583.544987300779, 7751.457397982087, 7757.456978011711, 7790.493617914817, 7932.6430310635005, 8258.83482330338, 8273.793155171168, 8289.33685305162, 8316.209960053786, 8316.209960053786, 7527.661255243636, 7757.185495522889, 7757.806054848674, 7772.37820974332, 7821.6089195541135, 7510.061242344707, 7570.697172113054, 7574.886376704464, 7674.309312161932, 7677.500962437647, 6464.482841372773, 6498.805035848932, 6548.967255163694, 6556.672166391566, 6568.80293591193, 4700.788464519036, 4796.688215265996, 4866.1727506323305, 4869.196582563837, 4877.170880950176, 4857.587105096107, 4902.460729319843, 4933.802647894044, 5010.123228435083, 5020.397552293748], "value": 4513.985418773273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1512944580238, 367.81609195402297, 368.18079772506167, 368.4473290064904, 368.655307287686, 6321.620702757832, 6322.367763223675, 6403.135576697145, 6404.327545607714, 6534.477241820655, 6352.301246862841, 6367.076773867786, 6408.615483071019, 6424.3575642435735, 6425.357464253572, 4724.078804633098, 4815.494373090827, 4826.9034619307595, 4835.492273311304, 4837.274408838667, 4843.975780121094, 4861.611071114302, 4877.02459508098, 4878.780454879521, 4880.194767863299, 4810.711357318554, 4813.807447702087, 4825.324454576362, 4826.32431459596, 4828.203346447849, 4818.638602104821, 4818.927716084261, 4821.4696383397795, 4822.469528351896, 4831.347768051303, 4222.176675548239, 4227.450431443924, 4229.069604686964, 4229.936550951738, 4232.470941132358, 6071.1803906472505, 6076.210092687967, 6202.3797620238065, 6205.627662340229, 6215.533834962396, 5634.605577609569, 5650.491455769001, 5658.801941932013, 5665.745041473144, 5669.8582535436535, 6809.3190680932, 6810.0, 6811.965940170317, 6818.28408017156, 6819.590824550493, 4700.848292168406, 4703.764811759398, 4710.717356958559, 4714.787834547419, 4717.693349932278, 7090.539114957563, 7139.357457828821, 7153.535020223669, 7157.0, 7158.749443769443, 4686.601638860735, 4767.6662633615315, 4771.475137734847, 4780.545848144421, 4813.470518242991, 4825.0, 4864.95135048645, 4866.8783280417565, 4873.634477414208, 4875.878103047452, 5589.469000444951, 5632.577556683265, 5644.0, 5749.511291540266, 5752.36723960364, 6849.897251541231, 6858.417034552019, 7000.474964377692, 7007.544509606859, 7011.824704382431, 1763.7530745695612, 1786.437272259234, 1788.9821101788816, 1789.042862068787, 1790.444962061765, 1189.9643010709692, 1199.0168062189096, 1201.0931746531487, 1204.9518019279305, 1205.7166565857017, 6762.830929226809, 6763.830904227335, 6777.118974533378, 6782.287859774751, 6793.694283757242, 7127.607981561064, 7134.536255143399, 7136.750213742494, 7147.2852714728115, 7147.82130446743, 6740.258571557125, 6741.764038258638, 6748.223954245324, 6762.087118239073, 6837.589744615339, 3751.15598990225, 3791.431285307226, 3850.8459661613783, 3856.8842934712, 3860.613938606117, 7551.565202611486, 7552.773416797505, 7559.811004724816, 7564.735234266775, 7565.43259255558, 7204.603746793977, 7205.423566114699, 7238.565686058748, 7255.927440725525, 7257.92742072583, 7510.023696919475, 7522.097348318128, 7529.774106776806, 7535.849283014309, 7537.660805263777, 6944.652767361511, 7058.505904586629, 7109.075820143556, 7115.288471152843, 7120.821979450555, 6941.409980151744, 6963.825904352431, 6972.616506092214, 7000.334968178015, 7003.859922801617, 7482.476226664299, 7519.285667861544, 7530.359919406693, 7535.095788505414, 7541.6229188539255, 4917.680350777188, 4940.777665005012, 4943.530364615356, 4948.604111671129, 4949.1586430306215, 6993.195782484876, 7099.609521476368, 7100.431965442649, 7164.211936687065, 7198.172210195685, 6862.3480769328835, 6880.346367095118, 6885.173779146535, 6886.173659160932, 6891.75878844238, 6871.4502839773695, 6884.449244060564, 6897.62063086515, 6897.689603967733, 6914.861702765816, 6758.155230596176, 6779.864402712017, 6789.388954994074, 6799.864002720017, 6800.183977922681, 6783.59298442095, 6906.827329316607, 6920.9653951729915, 6922.376986071277, 6927.134108236471, 6797.6941037654415, 6812.659367031728, 6830.521863469509, 6830.93169068303, 6842.55523390978], "value": 5187.542691324334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.8957535520385, 836.9455985360951, 859.9570021498928, 937.2642475656611, 948.8576713492979, 14974.101553906774, 15158.393664253417, 15178.089314641129, 15227.314770835312, 15263.16052617107, 14485.420583176687, 14498.202598857086, 14532.346044427999, 14534.127952322842, 14606.0, 737.4763917618498, 912.4251721415499, 922.3773952582014, 922.4603606889943, 922.7785331520454, 914.7758799094231, 915.0712027292303, 922.0594993107027, 924.8797656304671, 933.3046880074354, 974.1184228273388, 974.4835237324229, 975.7804493988831, 977.081543349253, 977.4282045003681, 967.4147140979746, 968.1818863060703, 970.7039352997368, 975.6926568131016, 976.4775844922967, 705.28765946394, 707.6178863413751, 710.2471380336859, 711.6228398948514, 712.0636363182399, 14227.430902763877, 14295.428182872673, 14320.57038288853, 14322.64193395163, 14363.281835908267, 15012.324445399983, 15217.6195595111, 15282.388704451809, 15411.0, 15447.845521544754, 11704.648860534198, 11806.291622502677, 11864.703382415422, 12011.459484323226, 12148.0, 4079.286124928126, 4095.7747323897174, 4120.7321524101135, 4261.21167583998, 4267.4025636410925, 54911.0, 55532.72233638806, 55763.16355254674, 57066.14400783992, 57166.7141664289, 11765.52937882475, 11936.880631193577, 12049.638510844688, 12057.0, 12211.389430528438, 21562.56874862494, 21632.35102946914, 21690.24084157047, 21762.673559896615, 21795.128194872028, 8746.344024198082, 8769.868451973225, 8831.116888311246, 8847.955760221157, 8907.821843563092, 4659.906801863944, 4801.831935882227, 4802.903941921142, 4863.246196839425, 4957.876053098701, 3592.191756854687, 3661.377565813818, 3664.6518580734787, 3666.395044817629, 3666.431703086026, 626.5864529410567, 637.0348921384107, 637.37537213531, 641.2113100885844, 659.7492952677952, 693.0539813155007, 730.6931088942657, 828.4159667434444, 846.0524212881612, 848.4230723108345, 10308.896911030944, 10695.679129626124, 10726.946365268124, 10784.191185661106, 10809.547721204975, 844.1474111147785, 856.2978357746713, 858.7981824271292, 864.2208586516573, 869.8477766390856, 4634.536546345338, 4780.354652121989, 4851.442084160367, 4879.829205977774, 5018.397792264878, 68005.65997170082, 68693.0, 68773.31226687769, 68939.65530172316, 69050.0, 55195.72402137964, 58234.0, 59894.70052649709, 60306.0, 60896.0, 52391.47608523866, 52581.737091314295, 53128.93742125136, 53608.731956339965, 53855.730721346925, 9787.755306117118, 9878.654247101316, 9937.509678257391, 9977.10206081456, 10045.397276163454, 36467.817660911525, 38197.80901095477, 39179.804100979316, 39746.60253397545, 40929.59070409377, 51619.74190129175, 51954.74022629863, 52156.21765673442, 52456.21315680192, 52692.20961685501, 13287.468501260228, 13469.12450690702, 13617.750313185434, 13619.114757540729, 13728.794068088788, 14447.711045778815, 14464.927675361556, 14739.26303684833, 14799.482018129314, 15406.537803865902, 12876.420561074587, 13014.804777928528, 14336.283185840875, 14390.928045359706, 15136.924315378794, 13963.232022238468, 14003.789943150658, 14118.50585229512, 14286.857131428553, 14317.0, 11836.76326473483, 12420.316882571546, 12520.812187817008, 12677.619671409873, 13010.479580816662, 10347.689569312932, 11114.0, 11445.713857153638, 11529.481173347052, 11887.82168267494, 11560.710982225512, 11598.768024639628, 11671.533138674358, 11831.881681183078, 11842.703932401759], "value": 7364.519962170963, "unit": "score"}], "name": "dromaeo_css", "value": 7550.291469202431, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 104.0, 110.0, 110.0, 110.0, 100.0, 108.0, 110.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 153.0, 186.0, 131.0, 159.0, 154.0, 133.0, 178.0, 127.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 181.0, 77.0, 77.0, 73.0, 86.0, 162.0, 74.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 151.0, 91.0, 93.0, 92.0, 151.0, 92.0, 91.0, 138.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 121.0, 117.0, 116.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 148.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 99.0, 99.0, 95.0, 96.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 55.0, 55.0, 57.0, 78.0, 53.0, 55.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 83.0, 73.0, 81.0, 74.0, 74.0, 74.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 122.0, 115.0, 115.0, 117.0, 117.0, 126.0, 132.0, 127.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 166.0, 165.0, 160.0, 160.0, 156.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 66.0, 68.0, 67.0, 69.0, 70.0, 66.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1524.6000000000001, "alertThreshold": 2.0}]} 14:38:41 INFO - Return code: 0 14:38:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:38:41 ERROR - # TBPL SUCCESS # 14:38:41 INFO - Running post-action listener: _resource_record_post_action 14:38:41 INFO - Running post-run listener: _resource_record_post_run 14:38:42 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 465121280; Read time: 12; Write time: 374404 14:38:42 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242094080; Read time: 0; Write time: 251056 14:38:42 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223027200; Read time: 12; Write time: 123348 14:38:42 INFO - Running post-run listener: _upload_blobber_files 14:38:42 INFO - Blob upload gear active. 14:38:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:42 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 14:38:42 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'] 14:38:42 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 14:38:42 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:38:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:43 INFO - (blobuploader) - INFO - Done attempting. 14:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:44 INFO - (blobuploader) - INFO - Done attempting. 14:38:44 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:44 INFO - Return code: 0 14:38:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93445a912faf7dd6718154cbfa70e451111e933629e0d3422958f473c53b7c912e4859c88f251a18bab39052de003c171cf8bfb36988e1605d989a32a0ae0b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5acf08a6966c3e659b12492d9a22e270466de2745dbe7288231b301c0f3e089f414669695207e1dad6b7d3cd698e37f37ab7a40ed8426387ad90a835cfa1fefa"} 14:38:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:44 INFO - Contents: 14:38:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93445a912faf7dd6718154cbfa70e451111e933629e0d3422958f473c53b7c912e4859c88f251a18bab39052de003c171cf8bfb36988e1605d989a32a0ae0b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5acf08a6966c3e659b12492d9a22e270466de2745dbe7288231b301c0f3e089f414669695207e1dad6b7d3cd698e37f37ab7a40ed8426387ad90a835cfa1fefa"} 14:38:44 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:44 INFO - Copying logs to upload dir... 14:38:44 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.468179 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-12 14:38:44.360636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 14:38:44.363776) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351 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/93445a912faf7dd6718154cbfa70e451111e933629e0d3422958f473c53b7c912e4859c88f251a18bab39052de003c171cf8bfb36988e1605d989a32a0ae0b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5acf08a6966c3e659b12492d9a22e270466de2745dbe7288231b301c0f3e089f414669695207e1dad6b7d3cd698e37f37ab7a40ed8426387ad90a835cfa1fefa"} build_url:https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011623 build_url: 'https://queue.taskcluster.net/v1/task/Z5ymuanKTe6lt1JXAJwuWw/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/93445a912faf7dd6718154cbfa70e451111e933629e0d3422958f473c53b7c912e4859c88f251a18bab39052de003c171cf8bfb36988e1605d989a32a0ae0b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5acf08a6966c3e659b12492d9a22e270466de2745dbe7288231b301c0f3e089f414669695207e1dad6b7d3cd698e37f37ab7a40ed8426387ad90a835cfa1fefa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 14:38:44.390209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:38:44.390573) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468358301.267269-1050755351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:38:44.477571) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 14:38:44.478358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 14:38:44.479060) ========= ========= Total master_lag: 0.20 =========