builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1468202821.46 results: success (0) buildid: 20160710161526 builduid: 1ed77665a647452ea159b502af30e6fe revision: fa7a42657c48de78ba1a0fefd43d1c6ed233e97a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.464475) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.464973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.465260) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.531613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.532016) ========= 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=fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-10 19:07:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-10 19:07:01 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107903 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.659767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.660087) ========= 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=fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018908 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:01.710974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-10 19:07:01.711288) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fa7a42657c48de78ba1a0fefd43d1c6ed233e97a --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 fa7a42657c48de78ba1a0fefd43d1c6ed233e97a --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=fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-10 19:07:01,846 truncating revision to first 12 chars 2016-07-10 19:07:01,846 Setting DEBUG logging. 2016-07-10 19:07:01,846 attempt 1/10 2016-07-10 19:07:01,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fa7a42657c48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-10 19:07:02,566 unpacking tar archive at: mozilla-beta-fa7a42657c48/testing/mozharness/ program finished with exit code 0 elapsedTime=1.074058 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-10 19:07:02.800869) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:02.801189) ========= script_repo_revision: fa7a42657c48de78ba1a0fefd43d1c6ed233e97a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:02.801654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:02.801979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 19:07:02.810886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-10 19:07:02.811185) ========= /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=fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:03 INFO - MultiFileLogger online at 20160710 19:07:03 in /builds/slave/test 19:07:03 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 19:07:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:03 INFO - {'append_to_log': False, 19:07:03 INFO - 'base_work_dir': '/builds/slave/test', 19:07:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:07:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:03 INFO - 'branch': 'Mozilla-Beta', 19:07:03 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:03 INFO - 'config_files': ('talos/linux_config.py',), 19:07:03 INFO - 'default_actions': ('clobber', 19:07:03 INFO - 'read-buildbot-config', 19:07:03 INFO - 'download-and-extract', 19:07:03 INFO - 'populate-webroot', 19:07:03 INFO - 'create-virtualenv', 19:07:03 INFO - 'install', 19:07:03 INFO - 'run-tests'), 19:07:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:03 INFO - 'download_minidump_stackwalk': True, 19:07:03 INFO - 'download_symbols': 'ondemand', 19:07:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:03 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:03 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:03 INFO - 'installer_path': 'installer.exe', 19:07:03 INFO - 'log_level': 'info', 19:07:03 INFO - 'log_name': 'talos', 19:07:03 INFO - 'log_to_console': True, 19:07:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:03 INFO - 'opt_config_files': (), 19:07:03 INFO - 'pip_index': False, 19:07:03 INFO - 'sps_profile': False, 19:07:03 INFO - 'sps_profile_interval': 0, 19:07:03 INFO - 'suite': 'dromaeojs-e10s', 19:07:03 INFO - 'system_bits': '32', 19:07:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:03 INFO - 'title': 'talos-linux64-ix-048', 19:07:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:03 INFO - 'use_talos_json': True, 19:07:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:03 INFO - 'work_dir': 'build'} 19:07:03 INFO - ##### 19:07:03 INFO - ##### Running clobber step. 19:07:03 INFO - ##### 19:07:03 INFO - Running pre-action listener: _resource_record_pre_action 19:07:03 INFO - Running main action method: clobber 19:07:03 INFO - rmtree: /builds/slave/test/build 19:07:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:03 INFO - Running post-action listener: _resource_record_post_action 19:07:03 INFO - ##### 19:07:03 INFO - ##### Running read-buildbot-config step. 19:07:03 INFO - ##### 19:07:03 INFO - Running pre-action listener: _resource_record_pre_action 19:07:03 INFO - Running main action method: read_buildbot_config 19:07:03 INFO - Using buildbot properties: 19:07:03 INFO - { 19:07:03 INFO - "project": "", 19:07:03 INFO - "product": "firefox", 19:07:03 INFO - "script_repo_revision": "production", 19:07:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:07:03 INFO - "repository": "", 19:07:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 19:07:03 INFO - "buildid": "20160710161526", 19:07:03 INFO - "pgo_build": "True", 19:07:03 INFO - "basedir": "/builds/slave/test", 19:07:03 INFO - "buildnumber": 91, 19:07:03 INFO - "slavename": "talos-linux64-ix-048", 19:07:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:07:03 INFO - "platform": "ubuntu64_hw", 19:07:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:07:03 INFO - "branch": "mozilla-beta", 19:07:03 INFO - "repo_path": "releases/mozilla-beta", 19:07:03 INFO - "revision": "fa7a42657c48de78ba1a0fefd43d1c6ed233e97a", 19:07:03 INFO - "stage_platform": "linux64-pgo", 19:07:03 INFO - "builduid": "1ed77665a647452ea159b502af30e6fe", 19:07:03 INFO - "slavebuilddir": "test" 19:07:03 INFO - } 19:07:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 19:07:03 INFO - Running post-action listener: _resource_record_post_action 19:07:03 INFO - ##### 19:07:03 INFO - ##### Running download-and-extract step. 19:07:03 INFO - ##### 19:07:03 INFO - Running pre-action listener: _resource_record_pre_action 19:07:03 INFO - Running main action method: download_and_extract 19:07:03 INFO - mkdir: /builds/slave/test/build/tests 19:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:03 INFO - https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:13 INFO - Downloaded 1327 bytes. 19:07:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:07:13 INFO - Using the following test package requirements: 19:07:13 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:07:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:13 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 19:07:13 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'jsshell-linux-x86_64.zip'], 19:07:13 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:13 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:07:13 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 19:07:13 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 19:07:13 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:07:13 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:13 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:13 INFO - https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:22 INFO - Downloaded 24239137 bytes. 19:07:22 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'] 19:07:22 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 19:07:24 INFO - Return code: 0 19:07:24 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 19:07: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')]} 19:07:24 INFO - https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:07:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:07:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:25 INFO - Downloaded 24239137 bytes. 19:07: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'] 19:07: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 19:07:26 INFO - Return code: 0 19:07: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')]} 19:07:26 INFO - https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:27 INFO - Downloaded 10840145 bytes. 19:07:27 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'] 19:07:27 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 19:07:28 INFO - Return code: 0 19:07:28 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')]} 19:07:28 INFO - https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JVlk31x-QqK3lEB95WkTIA/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 19:07:29 INFO - Downloaded 56014495 bytes. 19:07:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:07:29 INFO - mkdir: /builds/slave/test/properties 19:07:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:07:29 INFO - Writing to file /builds/slave/test/properties/build_url 19:07:29 INFO - Contents: 19:07:29 INFO - build_url:https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:07:30 INFO - Running post-action listener: _resource_record_post_action 19:07:30 INFO - Running post-action listener: set_extra_try_arguments 19:07:30 INFO - ##### 19:07:30 INFO - ##### Running populate-webroot step. 19:07:30 INFO - ##### 19:07:30 INFO - Running pre-action listener: _resource_record_pre_action 19:07:30 INFO - Running main action method: populate_webroot 19:07:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:30 INFO - '--tppagecycles', 19:07:30 INFO - '7'], 19:07:30 INFO - 'tests': ['tsvgm']}}, 19:07:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:07:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:07:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:07:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['damp', 'tps']}, 19:07:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'tests': ['damp', 'tps']}, 19:07:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['dromaeo_dom']}, 19:07:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['a11yr', 19:07:30 INFO - 'ts_paint', 19:07:30 INFO - 'tpaint', 19:07:30 INFO - 'sessionrestore', 19:07:30 INFO - 'sessionrestore_no_auto_restore', 19:07:30 INFO - 'tabpaint']}, 19:07:30 INFO - 'other-e10s': {'tests': ['a11yr', 19:07:30 INFO - 'ts_paint', 19:07:30 INFO - 'tpaint', 19:07:30 INFO - 'sessionrestore', 19:07:30 INFO - 'sessionrestore_no_auto_restore', 19:07:30 INFO - 'tabpaint']}, 19:07:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:07:30 INFO - 'ts_paint', 19:07:30 INFO - 'tpaint', 19:07:30 INFO - 'sessionrestore', 19:07:30 INFO - 'sessionrestore_no_auto_restore', 19:07:30 INFO - 'tabpaint']}, 19:07:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:07:30 INFO - 'ts_paint', 19:07:30 INFO - 'tpaint', 19:07:30 INFO - 'sessionrestore', 19:07:30 INFO - 'sessionrestore_no_auto_restore', 19:07:30 INFO - 'tabpaint']}, 19:07:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['a11yr', 19:07:30 INFO - 'ts_paint', 19:07:30 INFO - 'tpaint', 19:07:30 INFO - 'sessionrestore', 19:07:30 INFO - 'sessionrestore_no_auto_restore', 19:07:30 INFO - 'tabpaint']}, 19:07:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['a11yr', 19:07:30 INFO - 'ts_paint', 19:07:30 INFO - 'tpaint', 19:07:30 INFO - 'sessionrestore', 19:07:30 INFO - 'sessionrestore_no_auto_restore', 19:07:30 INFO - 'tabpaint']}, 19:07:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['tsvgx', 19:07:30 INFO - 'tsvgr_opacity', 19:07:30 INFO - 'tart', 19:07:30 INFO - 'tscrollx', 19:07:30 INFO - 'cart']}, 19:07:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:07:30 INFO - 'tsvgr_opacity', 19:07:30 INFO - 'tart', 19:07:30 INFO - 'tscrollx', 19:07:30 INFO - 'cart']}, 19:07:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'talos_options': ['--disable-e10s'], 19:07:30 INFO - 'tests': ['tp5o']}, 19:07:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'tests': ['tp5o']}, 19:07:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'talos_options': ['--disable-e10s', 19:07:30 INFO - '--xperf_path', 19:07:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:30 INFO - 'tests': ['tp5n']}, 19:07:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:30 INFO - 'talos_options': ['--xperf_path', 19:07:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:30 INFO - 'tests': ['tp5n']}}, 19:07:30 INFO - 'talos.zip': {'path': '', 19:07:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:30 INFO - Running post-action listener: _resource_record_post_action 19:07:30 INFO - ##### 19:07:30 INFO - ##### Running create-virtualenv step. 19:07:30 INFO - ##### 19:07:30 INFO - Running pre-action listener: _resource_record_pre_action 19:07:30 INFO - Running main action method: create_virtualenv 19:07:30 INFO - Creating virtualenv /builds/slave/test/build/venv 19:07:30 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 19:07:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:07:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:30 INFO - Using real prefix '/usr' 19:07:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:07:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:32 INFO - Installing pip.................done. 19:07:32 INFO - Return code: 0 19:07:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07:32 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 19:07:32 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 19:07:32 INFO - Using env: {'DISPLAY': ':0', 19:07:32 INFO - 'HOME': '/home/cltbld', 19:07:32 INFO - 'LANG': 'en_US.UTF-8', 19:07:32 INFO - 'LANGUAGE': 'en_US:en', 19:07:32 INFO - 'LOGNAME': 'cltbld', 19:07:32 INFO - 'MAIL': '/var/mail/cltbld', 19:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:32 INFO - 'MOZ_NO_REMOTE': '1', 19:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:32 INFO - 'NO_EM_RESTART': '1', 19:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:32 INFO - 'PWD': '/builds/slave/test', 19:07:32 INFO - 'SHELL': '/bin/bash', 19:07:32 INFO - 'SHLVL': '1', 19:07:32 INFO - 'TERM': 'linux', 19:07:32 INFO - 'TMOUT': '86400', 19:07:32 INFO - 'USER': 'cltbld', 19:07:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:32 INFO - '_': '/tools/buildbot/bin/python'} 19:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:32 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 19:07:32 INFO - Cleaning up... 19:07:32 INFO - Return code: 0 19:07:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07:32 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 19:07:32 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 19:07:32 INFO - Using env: {'DISPLAY': ':0', 19:07:32 INFO - 'HOME': '/home/cltbld', 19:07:32 INFO - 'LANG': 'en_US.UTF-8', 19:07:32 INFO - 'LANGUAGE': 'en_US:en', 19:07:32 INFO - 'LOGNAME': 'cltbld', 19:07:32 INFO - 'MAIL': '/var/mail/cltbld', 19:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:32 INFO - 'MOZ_NO_REMOTE': '1', 19:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:32 INFO - 'NO_EM_RESTART': '1', 19:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:32 INFO - 'PWD': '/builds/slave/test', 19:07:32 INFO - 'SHELL': '/bin/bash', 19:07:32 INFO - 'SHLVL': '1', 19:07:32 INFO - 'TERM': 'linux', 19:07:32 INFO - 'TMOUT': '86400', 19:07:32 INFO - 'USER': 'cltbld', 19:07:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:32 INFO - '_': '/tools/buildbot/bin/python'} 19:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:33 INFO - Downloading/unpacking psutil>=0.7.1 19:07:33 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 19:07:33 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 19:07:33 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 19:07:33 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 19:07:33 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 19:07:33 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 19:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:35 INFO - Installing collected packages: psutil 19:07:35 INFO - Running setup.py install for psutil 19:07:35 INFO - building 'psutil._psutil_linux' extension 19:07:35 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 19:07:35 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 19:07:35 INFO - building 'psutil._psutil_posix' extension 19:07:35 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 19:07:35 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 19:07:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:35 INFO - Successfully installed psutil 19:07:35 INFO - Cleaning up... 19:07:35 INFO - Return code: 0 19:07:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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', '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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:07: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 mozsystemmonitor==0.0.0 19:07:35 INFO - Using env: {'DISPLAY': ':0', 19:07:35 INFO - 'HOME': '/home/cltbld', 19:07:35 INFO - 'LANG': 'en_US.UTF-8', 19:07:35 INFO - 'LANGUAGE': 'en_US:en', 19:07:35 INFO - 'LOGNAME': 'cltbld', 19:07:35 INFO - 'MAIL': '/var/mail/cltbld', 19:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:35 INFO - 'MOZ_NO_REMOTE': '1', 19:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:35 INFO - 'NO_EM_RESTART': '1', 19:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:35 INFO - 'PWD': '/builds/slave/test', 19:07:35 INFO - 'SHELL': '/bin/bash', 19:07:35 INFO - 'SHLVL': '1', 19:07:35 INFO - 'TERM': 'linux', 19:07:35 INFO - 'TMOUT': '86400', 19:07:35 INFO - 'USER': 'cltbld', 19:07:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:35 INFO - '_': '/tools/buildbot/bin/python'} 19:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:07:35 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 19:07:35 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 19:07:35 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 19:07:35 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 19:07:35 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 19:07:35 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 19:07:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:07:37 INFO - Installing collected packages: mozsystemmonitor 19:07:37 INFO - Running setup.py install for mozsystemmonitor 19:07:38 INFO - Successfully installed mozsystemmonitor 19:07:38 INFO - Cleaning up... 19:07:38 INFO - Return code: 0 19:07:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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', '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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:07: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 blobuploader==1.2.4 19:07:38 INFO - Using env: {'DISPLAY': ':0', 19:07:38 INFO - 'HOME': '/home/cltbld', 19:07:38 INFO - 'LANG': 'en_US.UTF-8', 19:07:38 INFO - 'LANGUAGE': 'en_US:en', 19:07:38 INFO - 'LOGNAME': 'cltbld', 19:07:38 INFO - 'MAIL': '/var/mail/cltbld', 19:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:38 INFO - 'MOZ_NO_REMOTE': '1', 19:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:38 INFO - 'NO_EM_RESTART': '1', 19:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:38 INFO - 'PWD': '/builds/slave/test', 19:07:38 INFO - 'SHELL': '/bin/bash', 19:07:38 INFO - 'SHLVL': '1', 19:07:38 INFO - 'TERM': 'linux', 19:07:38 INFO - 'TMOUT': '86400', 19:07:38 INFO - 'USER': 'cltbld', 19:07:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:38 INFO - '_': '/tools/buildbot/bin/python'} 19:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:38 INFO - Downloading/unpacking blobuploader==1.2.4 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:40 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:07:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 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 19:07:40 INFO - Downloading docopt-0.6.1.tar.gz 19:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:07:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:07:40 INFO - Running setup.py install for blobuploader 19:07:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:07:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:07:41 INFO - Running setup.py install for requests 19:07:41 INFO - Running setup.py install for docopt 19:07:41 INFO - Successfully installed blobuploader requests docopt 19:07:41 INFO - Cleaning up... 19:07:41 INFO - Return code: 0 19:07:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:41 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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07:41 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 19:07:41 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 19:07:41 INFO - Using env: {'DISPLAY': ':0', 19:07:41 INFO - 'HOME': '/home/cltbld', 19:07:41 INFO - 'LANG': 'en_US.UTF-8', 19:07:41 INFO - 'LANGUAGE': 'en_US:en', 19:07:41 INFO - 'LOGNAME': 'cltbld', 19:07:41 INFO - 'MAIL': '/var/mail/cltbld', 19:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:41 INFO - 'MOZ_NO_REMOTE': '1', 19:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:41 INFO - 'NO_EM_RESTART': '1', 19:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:41 INFO - 'PWD': '/builds/slave/test', 19:07:41 INFO - 'SHELL': '/bin/bash', 19:07:41 INFO - 'SHLVL': '1', 19:07:41 INFO - 'TERM': 'linux', 19:07:41 INFO - 'TMOUT': '86400', 19:07:41 INFO - 'USER': 'cltbld', 19:07:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:41 INFO - '_': '/tools/buildbot/bin/python'} 19:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:41 INFO - Running setup.py (path:/tmp/pip-297Z9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:41 INFO - Running setup.py (path:/tmp/pip-mFjtSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:41 INFO - Running setup.py (path:/tmp/pip-Bssp76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:41 INFO - Running setup.py (path:/tmp/pip-VRB2lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:42 INFO - Running setup.py (path:/tmp/pip-HrFWYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:42 INFO - Running setup.py (path:/tmp/pip-pMdKeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:42 INFO - Running setup.py (path:/tmp/pip-YCP42I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:42 INFO - Running setup.py (path:/tmp/pip-15b7rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:42 INFO - Running setup.py (path:/tmp/pip-JN7v9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:42 INFO - Running setup.py (path:/tmp/pip-qaG2Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:42 INFO - Running setup.py (path:/tmp/pip-raszyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:42 INFO - Running setup.py (path:/tmp/pip-x3laT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:42 INFO - Running setup.py (path:/tmp/pip-4SOptl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:42 INFO - Running setup.py (path:/tmp/pip-SNqEO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:42 INFO - Running setup.py (path:/tmp/pip-EYDDNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:42 INFO - Running setup.py (path:/tmp/pip-EH0ROh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:42 INFO - Running setup.py (path:/tmp/pip-0mZYKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:07:42 INFO - Running setup.py install for manifestparser 19:07:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Running setup.py install for mozcrash 19:07:43 INFO - Running setup.py install for mozdebug 19:07:43 INFO - Running setup.py install for mozdevice 19:07:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Running setup.py install for mozfile 19:07:43 INFO - Running setup.py install for mozhttpd 19:07:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Running setup.py install for mozinfo 19:07:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Running setup.py install for mozInstall 19:07:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Running setup.py install for mozleak 19:07:43 INFO - Running setup.py install for mozlog 19:07:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:07:43 INFO - Running setup.py install for moznetwork 19:07:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:07:44 INFO - Running setup.py install for mozprocess 19:07:44 INFO - Running setup.py install for mozprofile 19:07:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:07:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:07:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:07:44 INFO - Running setup.py install for mozrunner 19:07:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:07:44 INFO - Running setup.py install for mozscreenshot 19:07:44 INFO - Running setup.py install for moztest 19:07:44 INFO - Running setup.py install for mozversion 19:07:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:07:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:44 INFO - Cleaning up... 19:07:44 INFO - Return code: 0 19:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:44 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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07:44 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 19:07:44 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 19:07:44 INFO - Using env: {'DISPLAY': ':0', 19:07:44 INFO - 'HOME': '/home/cltbld', 19:07:44 INFO - 'LANG': 'en_US.UTF-8', 19:07:44 INFO - 'LANGUAGE': 'en_US:en', 19:07:44 INFO - 'LOGNAME': 'cltbld', 19:07:44 INFO - 'MAIL': '/var/mail/cltbld', 19:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:44 INFO - 'MOZ_NO_REMOTE': '1', 19:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:44 INFO - 'NO_EM_RESTART': '1', 19:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:44 INFO - 'PWD': '/builds/slave/test', 19:07:44 INFO - 'SHELL': '/bin/bash', 19:07:44 INFO - 'SHLVL': '1', 19:07:44 INFO - 'TERM': 'linux', 19:07:44 INFO - 'TMOUT': '86400', 19:07:44 INFO - 'USER': 'cltbld', 19:07:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:44 INFO - '_': '/tools/buildbot/bin/python'} 19:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:44 INFO - Running setup.py (path:/tmp/pip-ADXVsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:45 INFO - Running setup.py (path:/tmp/pip-yj0Bw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:45 INFO - Running setup.py (path:/tmp/pip-vnAUF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:45 INFO - Running setup.py (path:/tmp/pip-RPft4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:45 INFO - Running setup.py (path:/tmp/pip-JxOGBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:45 INFO - Running setup.py (path:/tmp/pip-OKpztA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:45 INFO - Running setup.py (path:/tmp/pip-dQlDky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:45 INFO - Running setup.py (path:/tmp/pip-VMb_nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:45 INFO - Running setup.py (path:/tmp/pip-o6VY_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:45 INFO - Running setup.py (path:/tmp/pip-ms3OWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:45 INFO - Running setup.py (path:/tmp/pip-ej0C8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:45 INFO - Running setup.py (path:/tmp/pip-4ZoFdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:45 INFO - Running setup.py (path:/tmp/pip-nbbPCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:45 INFO - Running setup.py (path:/tmp/pip-SLo7UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:45 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)) 19:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:45 INFO - Running setup.py (path:/tmp/pip-qPyE8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:46 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)) 19:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:46 INFO - Running setup.py (path:/tmp/pip-WABV4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:46 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)) 19:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:46 INFO - Running setup.py (path:/tmp/pip-DCkIp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:46 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)) 19:07:46 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)) 19:07:46 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)) 19:07:46 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)) 19:07:46 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)) 19:07:46 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)) 19:07:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:07:46 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 19:07:46 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 19:07:46 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 19:07:46 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 19:07:46 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 19:07:46 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 19:07:48 INFO - Downloading blessings-1.6.tar.gz 19:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:48 INFO - Installing collected packages: blessings 19:07:48 INFO - Running setup.py install for blessings 19:07:48 INFO - Successfully installed blessings 19:07:48 INFO - Cleaning up... 19:07:48 INFO - Return code: 0 19:07:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:48 INFO - Reading from file tmpfile_stdout 19:07:48 INFO - Current package versions: 19:07:48 INFO - argparse == 1.2.1 19:07:48 INFO - blessings == 1.6 19:07:48 INFO - blobuploader == 1.2.4 19:07:48 INFO - docopt == 0.6.1 19:07:48 INFO - manifestparser == 1.1 19:07:48 INFO - mozInstall == 1.12 19:07:48 INFO - mozcrash == 0.17 19:07:48 INFO - mozdebug == 0.1 19:07:48 INFO - mozdevice == 0.48 19:07:48 INFO - mozfile == 1.2 19:07:48 INFO - mozhttpd == 0.7 19:07:48 INFO - mozinfo == 0.9 19:07:48 INFO - mozleak == 0.1 19:07:48 INFO - mozlog == 3.1 19:07:48 INFO - moznetwork == 0.27 19:07:48 INFO - mozprocess == 0.22 19:07:48 INFO - mozprofile == 0.28 19:07:48 INFO - mozrunner == 6.11 19:07:48 INFO - mozscreenshot == 0.1 19:07:48 INFO - mozsystemmonitor == 0.0 19:07:48 INFO - moztest == 0.7 19:07:48 INFO - mozversion == 1.4 19:07:48 INFO - psutil == 3.1.1 19:07:48 INFO - requests == 1.2.3 19:07:48 INFO - wsgiref == 0.1.2 19:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:48 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')]} 19:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:48 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')]} 19:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:48 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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07:48 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 19:07:48 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 19:07:48 INFO - Using env: {'DISPLAY': ':0', 19:07:48 INFO - 'HOME': '/home/cltbld', 19:07:48 INFO - 'LANG': 'en_US.UTF-8', 19:07:48 INFO - 'LANGUAGE': 'en_US:en', 19:07:48 INFO - 'LOGNAME': 'cltbld', 19:07:48 INFO - 'MAIL': '/var/mail/cltbld', 19:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:48 INFO - 'MOZ_NO_REMOTE': '1', 19:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:48 INFO - 'NO_EM_RESTART': '1', 19:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:48 INFO - 'PWD': '/builds/slave/test', 19:07:48 INFO - 'SHELL': '/bin/bash', 19:07:48 INFO - 'SHLVL': '1', 19:07:48 INFO - 'TERM': 'linux', 19:07:48 INFO - 'TMOUT': '86400', 19:07:48 INFO - 'USER': 'cltbld', 19:07:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:48 INFO - '_': '/tools/buildbot/bin/python'} 19:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 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)) 19:07:48 INFO - Cleaning up... 19:07:48 INFO - Return code: 0 19:07:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:07:48 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')]} 19:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:48 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')]} 19:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:48 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 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07:48 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 19:07:48 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 19:07:48 INFO - Using env: {'DISPLAY': ':0', 19:07:48 INFO - 'HOME': '/home/cltbld', 19:07:48 INFO - 'LANG': 'en_US.UTF-8', 19:07:48 INFO - 'LANGUAGE': 'en_US:en', 19:07:48 INFO - 'LOGNAME': 'cltbld', 19:07:48 INFO - 'MAIL': '/var/mail/cltbld', 19:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:48 INFO - 'MOZ_NO_REMOTE': '1', 19:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:48 INFO - 'NO_EM_RESTART': '1', 19:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:48 INFO - 'PWD': '/builds/slave/test', 19:07:48 INFO - 'SHELL': '/bin/bash', 19:07:48 INFO - 'SHLVL': '1', 19:07:48 INFO - 'TERM': 'linux', 19:07:48 INFO - 'TMOUT': '86400', 19:07:48 INFO - 'USER': 'cltbld', 19:07:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:48 INFO - '_': '/tools/buildbot/bin/python'} 19:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:48 INFO - Downloading/unpacking jsonschema 19:07:48 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 19:07:48 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 19:07:48 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 19:07:48 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 19:07:48 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 19:07:48 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 19:07:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:50 INFO - Downloading/unpacking functools32 (from jsonschema) 19:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:51 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:51 INFO - warning: no files found matching '*.txt' 19:07:51 INFO - no previously-included directories found matching 'build' 19:07:51 INFO - no previously-included directories found matching 'dist' 19:07:51 INFO - no previously-included directories found matching '.git*' 19:07:51 INFO - Installing collected packages: jsonschema, functools32 19:07:51 INFO - Running setup.py install for functools32 19:07:51 INFO - warning: no files found matching '*.txt' 19:07:51 INFO - no previously-included directories found matching 'build' 19:07:51 INFO - no previously-included directories found matching 'dist' 19:07:51 INFO - no previously-included directories found matching '.git*' 19:07:51 INFO - Successfully installed jsonschema functools32 19:07:51 INFO - Cleaning up... 19:07:51 INFO - Return code: 0 19:07:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac6da81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, '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': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', '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 19:07: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', 'flake8'] in /builds/slave/test/build 19:07: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 flake8 19:07:51 INFO - Using env: {'DISPLAY': ':0', 19:07:51 INFO - 'HOME': '/home/cltbld', 19:07:51 INFO - 'LANG': 'en_US.UTF-8', 19:07:51 INFO - 'LANGUAGE': 'en_US:en', 19:07:51 INFO - 'LOGNAME': 'cltbld', 19:07:51 INFO - 'MAIL': '/var/mail/cltbld', 19:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:51 INFO - 'MOZ_NO_REMOTE': '1', 19:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:51 INFO - 'NO_EM_RESTART': '1', 19:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:51 INFO - 'PWD': '/builds/slave/test', 19:07:51 INFO - 'SHELL': '/bin/bash', 19:07:51 INFO - 'SHLVL': '1', 19:07:51 INFO - 'TERM': 'linux', 19:07:51 INFO - 'TMOUT': '86400', 19:07:51 INFO - 'USER': 'cltbld', 19:07:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:51 INFO - '_': '/tools/buildbot/bin/python'} 19:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:51 INFO - Downloading/unpacking flake8 19:07:51 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 19:07:51 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 19:07:51 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 19:07:51 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 19:07:51 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 19:07:51 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 19:07:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:07:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:07:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:07:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:54 INFO - no previously-included directories found matching 'docs/_build' 19:07:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:07:54 INFO - Running setup.py install for pep8 19:07:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:54 INFO - no previously-included directories found matching 'docs/_build' 19:07:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:07:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:07:54 INFO - Cleaning up... 19:07:54 INFO - Return code: 0 19:07:54 INFO - Running post-action listener: _resource_record_post_action 19:07:54 INFO - Running post-action listener: _start_resource_monitoring 19:07:54 INFO - Starting resource monitoring. 19:07:54 INFO - ##### 19:07:54 INFO - ##### Running install step. 19:07:54 INFO - ##### 19:07:54 INFO - Running pre-action listener: _resource_record_pre_action 19:07:54 INFO - Running main action method: install 19:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:54 INFO - Reading from file tmpfile_stdout 19:07:54 INFO - Detecting whether we're running mozinstall >=1.0... 19:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:07:54 INFO - Reading from file tmpfile_stdout 19:07:54 INFO - Output received: 19:07:54 INFO - Usage: mozinstall [options] installer 19:07:54 INFO - Options: 19:07:54 INFO - -h, --help show this help message and exit 19:07:54 INFO - -d DEST, --destination=DEST 19:07:54 INFO - Directory to install application into. [default: 19:07:54 INFO - "/builds/slave/test"] 19:07:54 INFO - --app=APP Application being installed. [default: firefox] 19:07:54 INFO - mkdir: /builds/slave/test/build/application 19:07:54 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'] 19:07:54 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 19:08:07 INFO - Reading from file tmpfile_stdout 19:08:07 INFO - Output received: 19:08:07 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:07 INFO - Running post-action listener: _resource_record_post_action 19:08:07 INFO - ##### 19:08:07 INFO - ##### Running run-tests step. 19:08:07 INFO - ##### 19:08:07 INFO - Running pre-action listener: _resource_record_pre_action 19:08:07 INFO - Running main action method: run_tests 19:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:07 INFO - Python 2.7.3 19:08:07 INFO - Return code: 0 19:08:07 INFO - grabbing minidump binary from tooltool 19:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:07 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 0x1807410>, '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 0x1808310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18087a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:07 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 19:08:07 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 19:08:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:08 INFO - Return code: 0 19:08:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:08:08 INFO - Return code: 0 19:08:08 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/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 19:08:08 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/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 19:08:08 INFO - Using env: {'DISPLAY': ':0', 19:08:08 INFO - 'HOME': '/home/cltbld', 19:08:08 INFO - 'LANG': 'en_US.UTF-8', 19:08:08 INFO - 'LANGUAGE': 'en_US:en', 19:08:08 INFO - 'LOGNAME': 'cltbld', 19:08:08 INFO - 'MAIL': '/var/mail/cltbld', 19:08:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:08 INFO - 'MOZ_NO_REMOTE': '1', 19:08:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:08 INFO - 'NO_EM_RESTART': '1', 19:08:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:08 INFO - 'PWD': '/builds/slave/test', 19:08:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:08 INFO - 'SHELL': '/bin/bash', 19:08:08 INFO - 'SHLVL': '1', 19:08:08 INFO - 'TERM': 'linux', 19:08:08 INFO - 'TMOUT': '86400', 19:08:08 INFO - 'USER': 'cltbld', 19:08:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520', 19:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:08 INFO - '_': '/tools/buildbot/bin/python'} 19:08:08 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/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 19:08:09 INFO - mozversion application_buildid: 20160710161526 19:08:09 INFO - mozversion application_changeset: fa7a42657c48de78ba1a0fefd43d1c6ed233e97a 19:08:09 INFO - mozversion application_display_name: Firefox 19:08:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:09 INFO - mozversion application_name: Firefox 19:08:09 INFO - mozversion application_remotingname: firefox 19:08:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:08:09 INFO - mozversion application_vendor: Mozilla 19:08:09 INFO - mozversion application_version: 48.0 19:08:09 INFO - mozversion platform_buildid: 20160710161526 19:08:09 INFO - mozversion platform_changeset: fa7a42657c48de78ba1a0fefd43d1c6ed233e97a 19:08:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:08:09 INFO - mozversion platform_version: 48.0 19:08:09 INFO - using testdate: 1468202889 19:08:09 INFO - actual date: 1468202889 19:08:09 INFO - starting webserver on 'localhost:42917' 19:08:09 INFO - SUITE-START | Running 2 tests 19:08:09 INFO - TEST-START | dromaeo_css 19:08:09 INFO - operating with platform_type : linux_ 19:08:09 INFO - Initialising browser for dromaeo_css test... 19:08:09 INFO - TEST-INFO | started process 12313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVcpLN/profile http://localhost:42917/getInfo.html) 19:08:13 INFO - PROCESS | 12313 | 19:08:13 INFO - PROCESS | 12313 | (process:12391): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:08:14 INFO - PROCESS | 12313 | __metrics Screen width/height:1600/1200 19:08:14 INFO - PROCESS | 12313 | colorDepth:24 19:08:14 INFO - PROCESS | 12313 | Browser inner width/height: 1024/697 19:08:14 INFO - PROCESS | 12313 | __metrics 19:08:14 ERROR - PROCESS | 12313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:08:15 INFO - TEST-INFO | 12313: exit 0 19:08:15 INFO - Browser initialized. 19:08:15 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:15 INFO - TEST-INFO | started process 12441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVcpLN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:17 INFO - PROCESS | 12441 | 19:08:17 INFO - PROCESS | 12441 | (process:12508): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:08:27 INFO - PROCESS | 12441 | RSS: Main: 150982656 19:08:27 INFO - PROCESS | 12441 | 19:09:17 INFO - PROCESS | 12441 | 1468202957160 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] 19:11:24 INFO - PROCESS | 12441 | Cycle 1(1): loaded http://localhost:42917/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42917/tests/dromaeo/cssquery-ext.html) 19:11:25 INFO - PROCESS | 12441 | RSS: Main: 154529792 19:11:25 INFO - PROCESS | 12441 | 19:14:27 INFO - PROCESS | 12441 | Cycle 1(1): loaded http://localhost:42917/tests/dromaeo/cssquery-ext.html (next: http://localhost:42917/tests/dromaeo/cssquery-jquery.html) 19:14:27 INFO - PROCESS | 12441 | RSS: Main: 152596480 19:14:27 INFO - PROCESS | 12441 | 19:17:29 INFO - PROCESS | 12441 | Cycle 1(1): loaded http://localhost:42917/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42917/tests/dromaeo/cssquery-mootools.html) 19:17:30 INFO - PROCESS | 12441 | RSS: Main: 152817664 19:17:30 INFO - PROCESS | 12441 | 19:20:31 INFO - PROCESS | 12441 | Cycle 1(1): loaded http://localhost:42917/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42917/tests/dromaeo/cssquery-prototype.html) 19:20:32 INFO - PROCESS | 12441 | RSS: Main: 153763840 19:20:32 INFO - PROCESS | 12441 | 19:23:34 INFO - PROCESS | 12441 | Cycle 1(1): loaded http://localhost:42917/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42917/tests/dromaeo/cssquery-yui.html) 19:23:35 INFO - PROCESS | 12441 | RSS: Main: 152403968 19:23:35 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | Cycle 1(1): loaded http://localhost:42917/tests/dromaeo/cssquery-yui.html (next: http://localhost:42917/tests/dromaeo/cssquery-dojo.html) 19:26:37 INFO - PROCESS | 12441 | RSS: Main: 156049408 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | __start_tp_report 19:26:37 INFO - PROCESS | 12441 | _x_x_mozilla_page_load 19:26:37 INFO - PROCESS | 12441 | _x_x_mozilla_page_load_details 19:26:37 INFO - PROCESS | 12441 | |i|pagename|runs| 19:26:37 INFO - PROCESS | 12441 | |0;dojo.html;3306.768526203166;3308.9503657445157;3327.883524076657;3357.714594259488;3360.6135294441133;5718.485336319731;5762.106873434614;5765.682887441194;5769.192313076167;5779.162021506879;5729.770809167639;5790.797322093727;5800.564957628174;5806.941930580693;5809.01246788046;5165.922511162326;5214.478552144793;5245.291885595453;5278.498542638463;5323.494268044529;5126.692398456086;5186.611004174702;5383.865403364908;5384;5386.73066346683;5147.38231412231;5185.24813901984;5218.921716174261;5226.92159617606;5259.289995850569;5288.841334759944;5329.253904453399;5339.038972984861;5348.91976620351;5357.276767636397;5023.397192336906;5093.083245015896;5234.581233501311;5265.104932161542;5292.047431462335;5548.472895074961;5570.6657600543695;5593.860153496195;5633.802816901389;5639.605227634067;6066.726997285133;6091.908621370683;6101.481374083208;6105.847353816146;6108.725107370179;6046.848828779316;6074.514038876923;6114.358196333998;6151.0773383992755;6186.041163619646;5718.942810571883;5723.627964182315;5723.885522289531;5762.250907382056;5768.278965129359;6235.719392627343;6246.500279977682;6247.500199983991;6249.125122482856;6280.748770049238;5879.088741245114;5968.432998865101;6001.309849367379;6058.878822423527;6096.116063170815;5936.8812623748145;5940.34656187819;5957.493613042853;5961.225040744675;5986.49114825236;5863.0325996211;5874.853128671732;5918.526517878559;5921.96365636012;5943.257092863392;5888.4700376966275;6115.057807494094;6205.47253483459;6217.626942383471;6219.409156130251;4631.861044168681;4658.277966915133;4658.58072773452;4679.742614156254;4685.320628508847;4044.676425885922;4161.729487583298;4164.75011499311;4169.770662613585;4178.12259425524;5701.971490142523;5722.399148089474;5772.163036359704;5812.360640329561;5820.417958204146;6087.9391206087375;6127.42900967125;6158.507319414436;6163;6172.290186628506;5644.379118296984;5808.651480911159;5809.070548712186;5817.335078900266;5824.417558244142;5199.922001169985;5221.086309895753;5259.8422047338645;5272.182811664198;5288.365396152486;6408.070829729663;6432.581882177644;6442.516811239176;6442.613443193423;6446.7421303148285;6082;6125.938740612537;6183.505319574333;6196.628202307876;6217.720202590985;6103.450689437972;6246.219222597176;6404.423601875854;6450.709718062604;6462.256840463407;6026.427489388501;6043.36544662804;6049.909251361145;6050.183225264533;6059.303180134341;5999.5500337473995;6148.600340977822;6155.446009859134;6160.260768707783;6162.106494558354;5902.675352855634;5940.702964851826;5963.344032156372;5978.671173085522;6003.879922401615;5934;5988.910166347596;5991.3409524953095;6022.7289771959495;6045.727942242697;5455.372632147195;5649.406812284651;5745.253117094751;5822.854428639318;5841.94158058414;5984.431479009487;5988.401159883977;6004.279486461653;6048.667323297085;6071.7571297147615;5887.735051922759;5891.49922256613;5899.115132729953;5902.2622172228475;5927.733252003756 19:26:37 INFO - PROCESS | 12441 | |1;ext.html;608.8721368512612;660.4551245222692;665.2150462454302;671.1208317104594;684.1448189762793;39264.411033834476;40653.390199147034;40824.79587602062;40843;40871.59128408715;43331.78334108325;43510.564894351046;43762;43856.56143438564;44040;8904.91095089049;9031.864522032174;9059;9061.95469022654;9091;8848.2478989286;8900.732978010637;8918.55407229636;8923.553822308892;8925.732228033137;9026.548672566378;9165.083491650848;9170.312226582999;9208.079192080806;9226.169644731974;9100.590473428678;9165.816683666322;9168.037356077615;9214.815703685956;9221.400608960395;9097.499637519933;9199.908000919972;9221.723348299562;9227.307951903635;9243.722688319362;44204.77897610491;44327.778361108314;44603.55396446026;44633.55366446327;44687;3706.5181526401666;3776.847922236672;4075.8981025474304;4148.668106551469;4313.1158112586845;33026.6697333026;33103.33793324144;33844.83077584621;34652;34986;4099.446574712406;4128.91742165158;4142.875713728593;4143.9171216575805;4265.765382903939;320348;320761.3961930199;321250;322297;322318;39974.40038399426;41183.7940810294;41296.58703412987;63456;64759.67620161963;38421.423678644845;38439.07804609758;38600.227995439935;38694.419583706265;38737.80631096826;16622.66754664924;16627.750583741254;16696.833031669772;16699.248533816008;16741.6651666966;14011.719765604834;14030.088044277089;14048.227347495986;14069.788953165711;14075.71848563023;9393.060693930689;9399;9428.245740340757;9544.665936692183;9572;3626.3653860574295;3670.3209906167444;3694.2057457646733;3717.925641487155;3787.2046870157574;1068.5725709716176;1068.9144868410508;1107.1585594947899;1147.9381572045825;1170.8770579089244;33086.83456582702;34064.65935340664;35274.11814704653;37660.77090271008;38424.23151536954;1208.1784386617185;1282.3908643394313;1296.3129541343103;1299.7790375636164;1312.7308901675133;17389.478315650296;17524.91237543804;17559.297628094988;17595.91202044007;17677.116144192994;506880;527423;563501;574001;900236;59783;60725.69637151786;60937.39062609406;61059.38940610537;61154;1473.4990103364694;1524.1083965879864;1533.8389469105807;1549.5041586692375;1553.9611509712347;31683.36633267368;32147.35705285928;32402.51396229011;32675.183120422178;32938.67061329356;56129.43870561242;56937.43062569487;57023;57131.71434142803;57241;422855;426956;428731;429548;429863;30860;31129.377412451173;31637.8418107908;31678;31761.523577145897;51823.48176518187;51844.22233666423;52371.21443178432;52987.4701252998;53391.46608533865;42960.570394296905;43752.56247437612;44013.33979990367;44734.55265447304;44934;41460.58539414567;41911.58088419077;42710.57289427066;42753.358699620156;43619;44737;44798.328025079;45050.54949450595;45109;45740;36820.07949801276;37059.8147009274;37376;38734.2253154941;38809.80595097006;29579.852100739357;29816.403671926873;30076.24809379783;30351.696483034888;30367.392652147275 19:26:37 INFO - PROCESS | 12441 | |2;jquery.html;430.8685850815502;438.63154949842124;438.67099675243566;444.1738366638053;445.2408643263237;18729.531761705963;18978.90510547449;19485.220591176352;20386;20423.693644595307;19537.90231048846;19941.202351905908;19963.10166042528;19989.500262493446;20082;5516.227728118067;5735.483806457418;5756.424357564252;5771.336296325913;5781.046127388976;5585.74864131113;5706.572007099484;5706.800261990831;5879.823605291826;5896.97051514744;5861.17943487912;5863.560232982522;5864;5888.882222355551;5890.88218235635;6041.788537401192;6054.878902421927;6089.391060893898;6101.9389806102035;6122.663253521055;5914.053751399755;5933.228680271537;5934.703264836784;5936.762529498815;5964.254468191476;13744.931275343659;14048.789268160986;14049.43802247909;14189.36147873348;16665.91667041657;2326.895289711967;2334.5330933813134;2373.133806160756;2391.7608239176116;2489.4772097859473;10778.353298802018;10785.83821242682;10957.56169753209;12861.614151575468;14177.43290268388;2034.3083351660507;2109.6308146074375;2131.1049359269145;2164.9134034638596;2172.1420039084474;81380.59309703473;83551.16448835495;84342;84421.15578844195;84655;11030.50362733679;11302.304654301755;11385.430728463709;11456.4844581994;11649;16267.349306027627;16317.34730610786;16372.918135409247;16373.508794735939;16413;8614.526201058876;8940.642374304955;8955.596998135099;9077.77305567366;9141.634334626673;8831.60257788401;8855.73432797017;8909.064548222474;8923.73228803137;8978.10218978097;4990.800367985313;5054.115529782347;5063.5695965843315;5064.290999260106;5081.18701007837;1886.820752028555;1985.5036240939764;2083.5728675621463;2101.2540548105508;2102.0960986775835;995.9053889880595;1006.9647562335283;1055.6674647486018;1081.4808891732014;1092.748667806409;17655;18085.276588936296;18611.25554977813;19067.427977160707;19109.904450477658;1037.9273450858518;1045.2160879340495;1047.858539097212;1062.3997441445558;1101.2401443004462;10217.795644087077;10441;10535.525901334458;10564.841527377095;10667.83998240027;533568;541098;545607;556092;556296;88630.55684721535;89030.55484722664;90237.54881225553;90631;94113.52943235377;1099.7580532282884;1101.9063379612662;1129.717570607348;1139.584051821096;1149.5804031528432;16393.344266229695;16476.42332518356;16653.3338666452;16725.832741672428;16883.577910552336;38047;38246.61753382542;39522.80238598904;39788.80105599453;39812.80093599513;54976.17535737047;55147;55485.61285967883;55835;56157.71921140368;8496.447730897471;8668.393212475066;8669.91330086691;8760;8889.555522223993;12551;12893.613191604267;12937.805932911202;13363.599092027254;13406.865931340562;5696.971515142398;8937.419067760835;9429.774129363414;11740;12063.21589096706;10314.381137131797;11762.411879405825;11788.292702437539;11798.41007949582;12218;11877.762444750884;11878.227915185485;11928.403579821148;12127.211731237441;12307.56923507673;9134.771630709285;9181.770455738393;9212.078966367046;9217.400868943498;9360.812783744152;10314.742131446774;11814.586489472827;11939.641810745692;12013.75972480563;12022.699432514257 19:26:37 INFO - PROCESS | 12441 | |3;mootools.html;1594.0834020438247;1598.608340956465;1825.543614096476;1911.0731295321775;1933.8549608779344;7534.6232688365635;8312.958435207816;8401.663933442662;8595.097514760946;8651.74044778657;8251.876221856663;8283.585820708971;8312.501249925008;8346.582670866448;8405.453645513053;2418.935668305944;2435.902563897442;2437.902483900642;2445.8532488050687;2446.388402899275;2310.0644239083113;2387.2122199674154;2397.3287479505766;2399.688040554734;2410.915617953372;2355.0815182079004;2380.143148466551;2392.545416370893;2409.204962362416;2412.3245491262473;2381.7975472084895;2389.51015041916;2391.1630929174735;2398.520295940819;2398.580248456522;2345.3784747042046;2363.4564050268364;2370.028288401747;2371.1345358944036;2380.523895220963;8299.211574900375;8317.750467485985;8334.66661333546;8343.374246931444;8364.749057528285;5331.466853314676;5408;5410.91883621746;5426.21319908615;5435.0488664483555;3489.3719130556487;3525.8589656413715;3566.322398744256;3579.4630805379143;3615.5299811024397;1169.4620474581702;1193.7194759231575;1196.658952198628;1203.422357268516;1210.2435977514053;12328.938355308255;12333;12366.381680915918;12380.690482737913;12395.690107747378;4697.8355757548325;4732.621390288768;4820.855374338706;4850.902981940341;4872.561469467694;10418.322809017542;10456.843147352796;10460.633877814393;10472.581096756197;10486.423246721504;5380.569554435636;5381.300430943952;5408.323959505062;5408.702521361284;5427.240186373911;4883.926741098886;4923.286123512143;4979.676321039121;4990.750462476862;4995.100881841231;3956.802159891994;3981.5421226558738;4013.7190396672536;4075.65356944663;4146.9436616205585;1223.1988047828686;1225.6323103069044;1231.0459393969745;1234.8147777833397;1246.507629486348;939.2251392600995;995.2585323933715;1039.7556574205055;1078.2775540387959;1080.4921686807188;5930.22907022093;5973.641581505123;5985.521158307325;6123.295820980644;6144.754209831646;1009.2380252909154;1040.4069680282319;1053.5680371047833;1071.276888100529;1079.02348374721;4098.7950602469755;4117.855875044359;4119.382092686121;4122.546519882811;4137.54487006429;10291.176705863512;10388.584456621802;10668.359898406121;10690.893091069145;10695.78608427827;10626.787464250672;10654.893451065545;10701.090407315465;10709.839352409721;10725.14198864089;8284.834303313779;8287.95856020716;8362.414630975894;8449;8471.95764021176;5889.764409423575;5919.6744179070565;5947.345791962967;5956.821295361146;6144.416280453529;9352.906470935204;9430.245580353692;9552.474613896302;9574.904250957401;9675.225981921289;9486.33595648298;9747.074027967332;9853.458059806779;9860;9999.050090241415;7455.142658594331;7592.582407967394;7647.349975252166;7759.262870027338;7785.610719463891;8302.6678932842;8315.79420983966;8317.126701696236;8337;8374.706885258987;7422.146453157956;7688.384929205538;7693.4614576979075;7762.88355674654;7773.339266162213;7438.293362130589;7465.216152303929;7494.5503269803985;7576.2423757626;7585.544867307979;6895.379415852597;6945.236024037453;6959.721611135498;6963.6170010647875;7018.508704390848;4989.426215985208;5110.48895110486;5177.326947496801;5184.818531351385;5271.868203294948;5181.766820493011;5229.241759944863;5286.762095705625;5290.68255904647;5319.38827034896 19:26:37 INFO - PROCESS | 12441 | |4;prototype.html;362.3387318144387;364.39692309228235;367.35345791407116;372.7539823716348;374.4476896577548;6520.282768895429;6588.176477940257;6605.042268871017;6622.072909792633;6646.169228846395;6623.105880706104;6682.899756503656;6734.3939045485895;6751.223609284933;6765.289644587309;5070.543651071403;5070.594352451813;5108.106081435743;5118.590512758989;5118.9744051279695;5100.489951004888;5109.514596113363;5122.410922743877;5124.6412751107255;5137.897242055175;5026.9497305027035;5064.063148317555;5069.670471419365;5078.314427552288;5093.821716239932;4926.088673595378;5017.122003649347;5042.546170844642;5067.543921047105;5074.467180945984;4331.285337919271;4344.326629372453;4357.346398040288;4362.8909277268;4368.803403846835;6399.840003999937;6403.711832967528;6410.0705397717065;6413.134226879405;6442.065900444456;5658.122990936411;5746.367899531048;5770.249867517238;5823.767049318022;5827.970860145714;6988.755393561251;7030.543014704028;7040.823979400556;7042.542234754725;7058.082449281612;4753.049390121955;4754.714717116949;4757.191277482836;4791.520847915215;4803.543663351976;7297.087864016998;7334.229905859915;7362.079740032443;7366.631668416558;7386.372158366546;4833.879153021203;4994.150994330972;4999.175136102575;5001.124803159505;5029.572486338702;5052.216906379517;5072.010957863181;5072.568831649277;5083.593312535062;5090.872728181751;5884.205632239678;5894.6757928314355;5900.881982360329;5902.144189092557;5904.763809447574;7116.786496405116;7134.964325178341;7162.570245785269;7164.892526612105;7166.032585600981;1749.868759843017;1786.6873297172942;1788.6780379531808;1790.149678902511;1791.0596936608385;1113.9832902506469;1137.7895089408487;1149.7930372532858;1163.0985985860857;1183.2249876331016;6796.422304104207;6799.388055075067;6810.557313774589;6826.590404575742;6830.146231721035;7300.196978332379;7304.6486400016165;7314.48798584094;7320.67056982437;7331.596762178131;6780.593164410151;6782.321767823179;6799.524033317719;6805.863882722417;6813.284605116491;3895.039561323802;3909.2181563687377;3950.940735888964;3954.347532657137;3954.7429417088374;7523.736669216661;7578.696852125963;7591.127020392615;7595.658195381221;7603;7396.667149978264;7415.555066696015;7417.851642967111;7424;7428.814279642944;7565.2812982766545;7576.166621671612;7579.886301705479;7580.1661817200065;7597.620118994028;7137;7258.637068146677;7272.200057993511;7272.818179545554;7292.124945006421;7248.60132692707;7280.563166209832;7280.563166210044;7332.853342933218;7344.596047217455;7750.92249077502;7756.0304961879765;7757.65090570937;7759.68961241544;7769.067711874612;4820.783064762024;4833.661643684908;4835.975820120877;4850.781714822912;4863.610911127031;7093.077899872984;7367.1527774304495;7373.741919032808;7384.298491643285;7397.889031664637;7049.506534542533;7115.181754098345;7121.857562848818;7149.9285007149265;7150.96424517874;7072.787816365517;7097.680604372712;7115.928840711734;7126.180489243803;7133.037039999741;6760.628165450751;6783.321667833177;6790.5925644461495;6806.18325800907;6823.590584564942;7075.610841403773;7187.604681742345;7190.676419561028;7219.6751146199595;7224.494285399972;6809.863802724017;6919.411849992605;6930.549514281555;6940.583564985915;7025.437964962688 19:26:37 INFO - PROCESS | 12441 | |5;yui.html;734.1777209525333;744.3338212299992;852.1138016462879;861.9957749222157;875.4440930009445;15308.234588270583;15373.923130384346;15417.69164616707;15482;15487.303071361788;14274.714505709879;14292.213928233943;14377.78433323501;14401.711965760705;14418.134911905267;727.5670975769409;889.2130464538865;900.720776559267;912.2063804490103;915.5330781301551;880.828238493494;890.185480285538;890.470170248701;891.2201823404521;894.0210469535848;970.1947383671571;978.0952618827556;979.1579241852002;979.8138353712772;980.01998001998;966.3815158298695;971.1890571372912;971.5967873332559;973.0366936732619;974.3228456222893;712.6045045000022;712.975045873392;713.9393151582121;714.3356678289189;716.2586722741937;14664.046836955671;14687.192204428753;14709.632259193499;14723.411063557445;14764.483243086548;15247.313870875838;15497.22513874313;15685.215739212994;15750.369985200578;15871;12058.879411205951;12190.952720313815;12222;12238.204516706475;12423.62729118128;4016.4176194451934;4025.134596061861;4078.3474644057105;4089.3252613319064;4166.729162604421;55989;56117.71941140309;57421.71289143527;58987.82024359531;59095;12124.69688257783;12213.267203967791;12227.572034978733;12376.566820161252;12415.44130514129;22176.1129554816;22237.555248894932;22306;22425.887870560542;22656;8726.91273087261;8727.127287271349;9008.819823603491;9102.362834601514;9132.954335228282;4835.8065677372515;4841.201201801663;4852.733099679481;4897.706137631682;5028.044671512401;3630.9636903630626;3688.7602305850032;3697.131174174067;3702.241040586673;3710.3135919854913;577.4369989260438;630.7193298982;640.5132099604334;640.7885397818709;642.1908395421709;728.1407938632359;775.3215936055951;813.5606772342868;823.7133835994459;829.1956801902145;9660.903390966141;10562.788744225227;10682.412467314218;10752.301100428604;10793.622223222306;644.7195469970578;692.2005084127841;811.6388207247718;819.1194465949128;835.8746188071716;4604.447466303998;4646.4888862225125;4721.598664113589;4803.759812009385;4812.133815913169;67319.66340168366;68585;68911.3108868905;69453.65273173602;69563.3043669567;61042.69478652578;61310;61671.6916415415;62537.37462625316;63135.05297420542;53650.73174634102;55049.44950550523;55067.449325507034;55327.72336138374;55902.72048639731;9375.859362109437;9537.904620953701;9619.038096190325;9629.662961796303;9653.951730241304;39924.401133982436;40800.59199407968;41175.58824411718;41812;41909.371359429024;45462.54537454715;48738.26892596685;48781;48911.75544122399;49662;12735.80896286538;13038.47846086184;13084.476620935056;13132;13159.88141008025;12231.204971676812;12246.326452045223;13851.16892986424;14219.64450888736;14821.777673334693;12711.80932285998;12822.551210707581;13013.21920684762;13271.469141234242;13411.195328280335;13011.089223754625;13128.343582821011;13401.664958375728;13629.795553066513;13639.318034098056;13032.087753857139;13217.801732974205;13258.403371848482;13472.86527134716;13844.169349839041;10527.842082368923;10590.947045264724;10750.946245269037;10897.618583349862;11233.38216398106;10515.684529464128;11074.390908499787;11152.832707509231;11239.60661376848;11250.943745281222 19:26:37 INFO - PROCESS | 12441 | __end_tp_report 19:26:37 INFO - PROCESS | 12441 | __start_cc_report 19:26:37 INFO - PROCESS | 12441 | _x_x_mozilla_cycle_collect,327 19:26:37 INFO - PROCESS | 12441 | __end_cc_report 19:26:37 INFO - PROCESS | 12441 | __startTimestamp1468203997739__endTimestamp 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | ------- Summary: start ------- 19:26:37 INFO - PROCESS | 12441 | Number of tests: 6 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | [#0] dojo.html Cycles:165 Average:5677.29 Median:5879.09 stddev:639.71 (10.9%) stddev-sans-first:614.05 19:26:37 INFO - PROCESS | 12441 | Values: 3306.8 3309.0 3327.9 3357.7 3360.6 5718.5 5762.1 5765.7 5769.2 5779.2 5729.8 5790.8 5800.6 5806.9 5809.0 5165.9 5214.5 5245.3 5278.5 5323.5 5126.7 5186.6 5383.9 5384.0 5386.7 5147.4 5185.2 5218.9 5226.9 5259.3 5288.8 5329.3 5339.0 5348.9 5357.3 5023.4 5093.1 5234.6 5265.1 5292.0 5548.5 5570.7 5593.9 5633.8 5639.6 6066.7 6091.9 6101.5 6105.8 6108.7 6046.8 6074.5 6114.4 6151.1 6186.0 5718.9 5723.6 5723.9 5762.3 5768.3 6235.7 6246.5 6247.5 6249.1 6280.7 5879.1 5968.4 6001.3 6058.9 6096.1 5936.9 5940.3 5957.5 5961.2 5986.5 5863.0 5874.9 5918.5 5922.0 5943.3 5888.5 6115.1 6205.5 6217.6 6219.4 4631.9 4658.3 4658.6 4679.7 4685.3 4044.7 4161.7 4164.8 4169.8 4178.1 5702.0 5722.4 5772.2 5812.4 5820.4 6087.9 6127.4 6158.5 6163.0 6172.3 5644.4 5808.7 5809.1 5817.3 5824.4 5199.9 5221.1 5259.8 5272.2 5288.4 6408.1 6432.6 6442.5 6442.6 6446.7 6082.0 6125.9 6183.5 6196.6 6217.7 6103.5 6246.2 6404.4 6450.7 6462.3 6026.4 6043.4 6049.9 6050.2 6059.3 5999.6 6148.6 6155.4 6160.3 6162.1 5902.7 5940.7 5963.3 5978.7 6003.9 5934.0 5988.9 5991.3 6022.7 6045.7 5455.4 5649.4 5745.3 5822.9 5841.9 5984.4 5988.4 6004.3 6048.7 6071.8 5887.7 5891.5 5899.1 5902.3 5927.7 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | [#1] ext.html Cycles:180 Average:61205.64 Median:22804.63 stddev:127616.77 (559.6%) stddev-sans-first:127893.67 19:26:37 INFO - PROCESS | 12441 | Values: 608.9 660.5 665.2 671.1 684.1 39264.4 40653.4 40824.8 40843.0 40871.6 43331.8 43510.6 43762.0 43856.6 44040.0 8904.9 9031.9 9059.0 9062.0 9091.0 8848.2 8900.7 8918.6 8923.6 8925.7 9026.5 9165.1 9170.3 9208.1 9226.2 9100.6 9165.8 9168.0 9214.8 9221.4 9097.5 9199.9 9221.7 9227.3 9243.7 44204.8 44327.8 44603.6 44633.6 44687.0 3706.5 3776.8 4075.9 4148.7 4313.1 33026.7 33103.3 33844.8 34652.0 34986.0 4099.4 4128.9 4142.9 4143.9 4265.8 320348.0 320761.4 321250.0 322297.0 322318.0 39974.4 41183.8 41296.6 63456.0 64759.7 38421.4 38439.1 38600.2 38694.4 38737.8 16622.7 16627.8 16696.8 16699.2 16741.7 14011.7 14030.1 14048.2 14069.8 14075.7 9393.1 9399.0 9428.2 9544.7 9572.0 3626.4 3670.3 3694.2 3717.9 3787.2 1068.6 1068.9 1107.2 1147.9 1170.9 33086.8 34064.7 35274.1 37660.8 38424.2 1208.2 1282.4 1296.3 1299.8 1312.7 17389.5 17524.9 17559.3 17595.9 17677.1 506880.0 527423.0 563501.0 574001.0 900236.0 59783.0 60725.7 60937.4 61059.4 61154.0 1473.5 1524.1 1533.8 1549.5 1554.0 31683.4 32147.4 32402.5 32675.2 32938.7 56129.4 56937.4 57023.0 57131.7 57241.0 422855.0 426956.0 428731.0 429548.0 429863.0 30860.0 31129.4 31637.8 31678.0 31761.5 51823.5 51844.2 52371.2 52987.5 53391.5 42960.6 43752.6 44013.3 44734.6 44934.0 41460.6 41911.6 42710.6 42753.4 43619.0 44737.0 44798.3 45050.5 45109.0 45740.0 36820.1 37059.8 37376.0 38734.2 38809.8 29579.9 29816.4 30076.2 30351.7 30367.4 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | [#2] jquery.html Cycles:180 Average:30356.32 Median:2249.52 stddev:89831.10 (3993.3%) stddev-sans-first:90054.99 19:26:37 INFO - PROCESS | 12441 | Values: 430.9 438.6 438.7 444.2 445.2 18729.5 18978.9 19485.2 20386.0 20423.7 19537.9 19941.2 19963.1 19989.5 20082.0 5516.2 5735.5 5756.4 5771.3 5781.0 5585.7 5706.6 5706.8 5879.8 5897.0 5861.2 5863.6 5864.0 5888.9 5890.9 6041.8 6054.9 6089.4 6101.9 6122.7 5914.1 5933.2 5934.7 5936.8 5964.3 13744.9 14048.8 14049.4 14189.4 16665.9 2326.9 2334.5 2373.1 2391.8 2489.5 10778.4 10785.8 10957.6 12861.6 14177.4 2034.3 2109.6 2131.1 2164.9 2172.1 81380.6 83551.2 84342.0 84421.2 84655.0 11030.5 11302.3 11385.4 11456.5 11649.0 16267.3 16317.3 16372.9 16373.5 16413.0 8614.5 8940.6 8955.6 9077.8 9141.6 8831.6 8855.7 8909.1 8923.7 8978.1 4990.8 5054.1 5063.6 5064.3 5081.2 1886.8 1985.5 2083.6 2101.3 2102.1 995.9 1007.0 1055.7 1081.5 1092.7 17655.0 18085.3 18611.3 19067.4 19109.9 1037.9 1045.2 1047.9 1062.4 1101.2 10217.8 10441.0 10535.5 10564.8 10667.8 533568.0 541098.0 545607.0 556092.0 556296.0 88630.6 89030.6 90237.5 90631.0 94113.5 1099.8 1101.9 1129.7 1139.6 1149.6 16393.3 16476.4 16653.3 16725.8 16883.6 38047.0 38246.6 39522.8 39788.8 39812.8 54976.2 55147.0 55485.6 55835.0 56157.7 8496.4 8668.4 8669.9 8760.0 8889.6 12551.0 12893.6 12937.8 13363.6 13406.9 5697.0 8937.4 9429.8 11740.0 12063.2 10314.4 11762.4 11788.3 11798.4 12218.0 11877.8 11878.2 11928.4 12127.2 12307.6 9134.8 9181.8 9212.1 9217.4 9360.8 10314.7 11814.6 11939.6 12013.8 12022.7 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | [#3] mootools.html Cycles:180 Average:5769.72 Median:4984.55 stddev:3170.49 (63.6%) stddev-sans-first:3163.86 19:26:37 INFO - PROCESS | 12441 | Values: 1594.1 1598.6 1825.5 1911.1 1933.9 7534.6 8313.0 8401.7 8595.1 8651.7 8251.9 8283.6 8312.5 8346.6 8405.5 2418.9 2435.9 2437.9 2445.9 2446.4 2310.1 2387.2 2397.3 2399.7 2410.9 2355.1 2380.1 2392.5 2409.2 2412.3 2381.8 2389.5 2391.2 2398.5 2398.6 2345.4 2363.5 2370.0 2371.1 2380.5 8299.2 8317.8 8334.7 8343.4 8364.7 5331.5 5408.0 5410.9 5426.2 5435.0 3489.4 3525.9 3566.3 3579.5 3615.5 1169.5 1193.7 1196.7 1203.4 1210.2 12328.9 12333.0 12366.4 12380.7 12395.7 4697.8 4732.6 4820.9 4850.9 4872.6 10418.3 10456.8 10460.6 10472.6 10486.4 5380.6 5381.3 5408.3 5408.7 5427.2 4883.9 4923.3 4979.7 4990.8 4995.1 3956.8 3981.5 4013.7 4075.7 4146.9 1223.2 1225.6 1231.0 1234.8 1246.5 939.2 995.3 1039.8 1078.3 1080.5 5930.2 5973.6 5985.5 6123.3 6144.8 1009.2 1040.4 1053.6 1071.3 1079.0 4098.8 4117.9 4119.4 4122.5 4137.5 10291.2 10388.6 10668.4 10690.9 10695.8 10626.8 10654.9 10701.1 10709.8 10725.1 8284.8 8288.0 8362.4 8449.0 8472.0 5889.8 5919.7 5947.3 5956.8 6144.4 9352.9 9430.2 9552.5 9574.9 9675.2 9486.3 9747.1 9853.5 9860.0 9999.1 7455.1 7592.6 7647.3 7759.3 7785.6 8302.7 8315.8 8317.1 8337.0 8374.7 7422.1 7688.4 7693.5 7762.9 7773.3 7438.3 7465.2 7494.6 7576.2 7585.5 6895.4 6945.2 6959.7 6963.6 7018.5 4989.4 5110.5 5177.3 5184.8 5271.9 5181.8 5229.2 5286.8 5290.7 5319.4 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | [#4] prototype.html Cycles:180 Average:5908.75 Median:6772.94 stddev:1805.58 (26.7%) stddev-sans-first:1762.00 19:26:37 INFO - PROCESS | 12441 | Values: 362.3 364.4 367.4 372.8 374.4 6520.3 6588.2 6605.0 6622.1 6646.2 6623.1 6682.9 6734.4 6751.2 6765.3 5070.5 5070.6 5108.1 5118.6 5119.0 5100.5 5109.5 5122.4 5124.6 5137.9 5026.9 5064.1 5069.7 5078.3 5093.8 4926.1 5017.1 5042.5 5067.5 5074.5 4331.3 4344.3 4357.3 4362.9 4368.8 6399.8 6403.7 6410.1 6413.1 6442.1 5658.1 5746.4 5770.2 5823.8 5828.0 6988.8 7030.5 7040.8 7042.5 7058.1 4753.0 4754.7 4757.2 4791.5 4803.5 7297.1 7334.2 7362.1 7366.6 7386.4 4833.9 4994.2 4999.2 5001.1 5029.6 5052.2 5072.0 5072.6 5083.6 5090.9 5884.2 5894.7 5900.9 5902.1 5904.8 7116.8 7135.0 7162.6 7164.9 7166.0 1749.9 1786.7 1788.7 1790.1 1791.1 1114.0 1137.8 1149.8 1163.1 1183.2 6796.4 6799.4 6810.6 6826.6 6830.1 7300.2 7304.6 7314.5 7320.7 7331.6 6780.6 6782.3 6799.5 6805.9 6813.3 3895.0 3909.2 3950.9 3954.3 3954.7 7523.7 7578.7 7591.1 7595.7 7603.0 7396.7 7415.6 7417.9 7424.0 7428.8 7565.3 7576.2 7579.9 7580.2 7597.6 7137.0 7258.6 7272.2 7272.8 7292.1 7248.6 7280.6 7280.6 7332.9 7344.6 7750.9 7756.0 7757.7 7759.7 7769.1 4820.8 4833.7 4836.0 4850.8 4863.6 7093.1 7367.2 7373.7 7384.3 7397.9 7049.5 7115.2 7121.9 7149.9 7151.0 7072.8 7097.7 7115.9 7126.2 7133.0 6760.6 6783.3 6790.6 6806.2 6823.6 7075.6 7187.6 7190.7 7219.7 7224.5 6809.9 6919.4 6930.5 6940.6 7025.4 19:26:37 INFO - PROCESS | 12441 | 19:26:37 INFO - PROCESS | 12441 | [#5] yui.html Cycles:180 Average:16153.10 Median:4625.47 stddev:18852.77 (407.6%) stddev-sans-first:18870.09 19:26:37 INFO - PROCESS | 12441 | Values: 734.2 744.3 852.1 862.0 875.4 15308.2 15373.9 15417.7 15482.0 15487.3 14274.7 14292.2 14377.8 14401.7 14418.1 727.6 889.2 900.7 912.2 915.5 880.8 890.2 890.5 891.2 894.0 970.2 978.1 979.2 979.8 980.0 966.4 971.2 971.6 973.0 974.3 712.6 713.0 713.9 714.3 716.3 14664.0 14687.2 14709.6 14723.4 14764.5 15247.3 15497.2 15685.2 15750.4 15871.0 12058.9 12191.0 12222.0 12238.2 12423.6 4016.4 4025.1 4078.3 4089.3 4166.7 55989.0 56117.7 57421.7 58987.8 59095.0 12124.7 12213.3 12227.6 12376.6 12415.4 22176.1 22237.6 22306.0 22425.9 22656.0 8726.9 8727.1 9008.8 9102.4 9133.0 4835.8 4841.2 4852.7 4897.7 5028.0 3631.0 3688.8 3697.1 3702.2 3710.3 577.4 630.7 640.5 640.8 642.2 728.1 775.3 813.6 823.7 829.2 9660.9 10562.8 10682.4 10752.3 10793.6 644.7 692.2 811.6 819.1 835.9 4604.4 4646.5 4721.6 4803.8 4812.1 67319.7 68585.0 68911.3 69453.7 69563.3 61042.7 61310.0 61671.7 62537.4 63135.1 53650.7 55049.4 55067.4 55327.7 55902.7 9375.9 9537.9 9619.0 9629.7 9654.0 39924.4 40800.6 41175.6 41812.0 41909.4 45462.5 48738.3 48781.0 48911.8 49662.0 12735.8 13038.5 13084.5 13132.0 13159.9 12231.2 12246.3 13851.2 14219.6 14821.8 12711.8 12822.6 13013.2 13271.5 13411.2 13011.1 13128.3 13401.7 13629.8 13639.3 13032.1 13217.8 13258.4 13472.9 13844.2 10527.8 10590.9 10750.9 10897.6 11233.4 10515.7 11074.4 11152.8 11239.6 11250.9 19:26:37 INFO - PROCESS | 12441 | -------- Summary: end -------- 19:26:37 INFO - PROCESS | 12441 | 19:26:38 INFO - TEST-INFO | 12441: exit 0 19:26:38 INFO - TEST-OK | dromaeo_css | took 1109276ms 19:26:38 INFO - TEST-START | kraken 19:26:38 INFO - operating with platform_type : linux_ 19:26:38 INFO - Initialising browser for kraken test... 19:26:38 INFO - TEST-INFO | started process 12681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFqYW7_/profile http://localhost:42917/getInfo.html) 19:26:42 INFO - PROCESS | 12681 | 19:26:42 INFO - PROCESS | 12681 | (process:12758): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:26:42 INFO - PROCESS | 12681 | __metrics Screen width/height:1600/1200 19:26:42 INFO - PROCESS | 12681 | colorDepth:24 19:26:42 INFO - PROCESS | 12681 | Browser inner width/height: 1024/697 19:26:42 INFO - PROCESS | 12681 | __metrics 19:26:43 ERROR - PROCESS | 12681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:26:44 INFO - TEST-INFO | 12681: exit 0 19:26:44 INFO - Browser initialized. 19:26:44 INFO - Running cycle 1/1 for kraken test... 19:26:44 INFO - TEST-INFO | started process 12808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFqYW7_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:46 INFO - PROCESS | 12808 | 19:26:46 INFO - PROCESS | 12808 | (process:12876): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:26:56 INFO - PROCESS | 12808 | RSS: Main: 150646784 19:26:56 INFO - PROCESS | 12808 | 19:26:58 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42917/tests/kraken/driver.html?testName=audio-beat-detection) 19:26:59 INFO - PROCESS | 12808 | RSS: Main: 156454912 19:26:59 INFO - PROCESS | 12808 | 19:27:02 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42917/tests/kraken/driver.html?testName=audio-dft) 19:27:02 INFO - PROCESS | 12808 | RSS: Main: 156282880 19:27:02 INFO - PROCESS | 12808 | 19:27:05 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42917/tests/kraken/driver.html?testName=audio-fft) 19:27:06 INFO - PROCESS | 12808 | RSS: Main: 156368896 19:27:06 INFO - PROCESS | 12808 | 19:27:08 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42917/tests/kraken/driver.html?testName=audio-oscillator) 19:27:08 INFO - PROCESS | 12808 | RSS: Main: 155955200 19:27:08 INFO - PROCESS | 12808 | 19:27:11 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42917/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:11 INFO - PROCESS | 12808 | RSS: Main: 156610560 19:27:11 INFO - PROCESS | 12808 | 19:27:14 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42917/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:15 INFO - PROCESS | 12808 | RSS: Main: 156803072 19:27:15 INFO - PROCESS | 12808 | 19:27:18 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42917/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:19 INFO - PROCESS | 12808 | RSS: Main: 156868608 19:27:19 INFO - PROCESS | 12808 | 19:27:21 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42917/tests/kraken/driver.html?testName=json-parse-financial) 19:27:22 INFO - PROCESS | 12808 | RSS: Main: 156549120 19:27:22 INFO - PROCESS | 12808 | 19:27:24 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42917/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:24 INFO - PROCESS | 12808 | RSS: Main: 156782592 19:27:24 INFO - PROCESS | 12808 | 19:27:26 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:27 INFO - PROCESS | 12808 | RSS: Main: 156266496 19:27:27 INFO - PROCESS | 12808 | 19:27:29 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:27:29 INFO - PROCESS | 12808 | RSS: Main: 156545024 19:27:29 INFO - PROCESS | 12808 | 19:27:32 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:32 INFO - PROCESS | 12808 | RSS: Main: 157057024 19:27:32 INFO - PROCESS | 12808 | 19:27:35 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:36 INFO - PROCESS | 12808 | RSS: Main: 157224960 19:27:36 INFO - PROCESS | 12808 | 19:27:37 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:42917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42917/tests/kraken/driver.html?testName=ai-astar) 19:27:37 INFO - PROCESS | 12808 | RSS: Main: 158248960 19:27:37 INFO - PROCESS | 12808 | 19:27:37 INFO - PROCESS | 12808 | __start_tp_report 19:27:37 INFO - PROCESS | 12808 | _x_x_mozilla_page_load 19:27:37 INFO - PROCESS | 12808 | _x_x_mozilla_page_load_details 19:27:37 INFO - PROCESS | 12808 | |i|pagename|runs| 19:27:37 INFO - PROCESS | 12808 | |0;ai-astar;109;111;105;111;115;111;103;111;114;111 19:27:37 INFO - PROCESS | 12808 | |1;audio-beat-detection;159;127;150;174;128;150;154;127;185;129 19:27:37 INFO - PROCESS | 12808 | |2;audio-dft;161;161;163;161;161;161;164;160;159;161 19:27:37 INFO - PROCESS | 12808 | |3;audio-fft;75;74;76;168;74;76;76;75;171;75 19:27:37 INFO - PROCESS | 12808 | |4;audio-oscillator;93;93;145;92;92;93;147;92;91;161 19:27:37 INFO - PROCESS | 12808 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;117;117;118 19:27:37 INFO - PROCESS | 12808 | |6;imaging-darkroom;146;147;146;146;145;147;147;147;146;147 19:27:37 INFO - PROCESS | 12808 | |7;imaging-desaturate;95;95;95;96;96;96;95;97;95;96 19:27:37 INFO - PROCESS | 12808 | |8;json-parse-financial;57;57;53;56;56;56;54;82;53;52 19:27:37 INFO - PROCESS | 12808 | |9;json-stringify-tinderbox;57;58;58;57;58;57;58;57;57;58 19:27:37 INFO - PROCESS | 12808 | |10;stanford-crypto-aes;74;72;88;74;75;76;76;75;75;74 19:27:37 INFO - PROCESS | 12808 | |11;stanford-crypto-ccm;116;116;120;112;119;126;121;119;127;129 19:27:37 INFO - PROCESS | 12808 | |12;stanford-crypto-pbkdf2;159;156;160;159;158;157;158;159;166;155 19:27:37 INFO - PROCESS | 12808 | |13;stanford-crypto-sha256-iterative;64;67;69;67;76;64;66;67;64;67 19:27:37 INFO - PROCESS | 12808 | __end_tp_report 19:27:37 INFO - PROCESS | 12808 | __start_cc_report 19:27:37 INFO - PROCESS | 12808 | _x_x_mozilla_cycle_collect,858 19:27:37 INFO - PROCESS | 12808 | __end_cc_report 19:27:37 INFO - PROCESS | 12808 | __startTimestamp1468204057991__endTimestamp 19:27:37 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | ------- Summary: start ------- 19:27:38 INFO - PROCESS | 12808 | Number of tests: 14 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.67 (3.3%) stddev-sans-first:3.87 19:27:38 INFO - PROCESS | 12808 | Values: 109.0 111.0 105.0 111.0 115.0 111.0 103.0 111.0 114.0 111.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:152.00 stddev:20.69 (13.6%) stddev-sans-first:21.58 19:27:38 INFO - PROCESS | 12808 | Values: 159.0 127.0 150.0 174.0 128.0 150.0 154.0 127.0 185.0 129.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 19:27:38 INFO - PROCESS | 12808 | Values: 161.0 161.0 163.0 161.0 161.0 161.0 164.0 160.0 159.0 161.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.81 (53.1%) stddev-sans-first:41.62 19:27:38 INFO - PROCESS | 12808 | Values: 75.0 74.0 76.0 168.0 74.0 76.0 76.0 75.0 171.0 75.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.66 (31.2%) stddev-sans-first:29.74 19:27:38 INFO - PROCESS | 12808 | Values: 93.0 93.0 145.0 92.0 92.0 93.0 147.0 92.0 91.0 161.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:27:38 INFO - PROCESS | 12808 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 19:27:38 INFO - PROCESS | 12808 | Values: 146.0 147.0 146.0 146.0 145.0 147.0 147.0 147.0 146.0 147.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 19:27:38 INFO - PROCESS | 12808 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 97.0 95.0 96.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:8.76 (15.6%) stddev-sans-first:9.29 19:27:38 INFO - PROCESS | 12808 | Values: 57.0 57.0 53.0 56.0 56.0 56.0 54.0 82.0 53.0 52.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 19:27:38 INFO - PROCESS | 12808 | Values: 57.0 58.0 58.0 57.0 58.0 57.0 58.0 57.0 57.0 58.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:4.41 (5.9%) stddev-sans-first:4.62 19:27:38 INFO - PROCESS | 12808 | Values: 74.0 72.0 88.0 74.0 75.0 76.0 76.0 75.0 75.0 74.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.50 stddev:5.40 (4.5%) stddev-sans-first:5.48 19:27:38 INFO - PROCESS | 12808 | Values: 116.0 116.0 120.0 112.0 119.0 126.0 121.0 119.0 127.0 129.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:2.98 (1.9%) stddev-sans-first:3.16 19:27:38 INFO - PROCESS | 12808 | Values: 159.0 156.0 160.0 159.0 158.0 157.0 158.0 159.0 166.0 155.0 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - PROCESS | 12808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:3.54 (5.3%) stddev-sans-first:3.57 19:27:38 INFO - PROCESS | 12808 | Values: 64.0 67.0 69.0 67.0 76.0 64.0 66.0 67.0 64.0 67.0 19:27:38 INFO - PROCESS | 12808 | -------- Summary: end -------- 19:27:38 INFO - PROCESS | 12808 | 19:27:38 INFO - TEST-INFO | 12808: exit 0 19:27:38 INFO - TEST-OK | kraken | took 60441ms 19:27:38 INFO - SUITE-END | took 1169s 19:27:39 INFO - Completed test suite (00:19:30) 19:27:39 INFO - javascript benchmark 19:27:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.768526203166, 3308.9503657445157, 3327.883524076657, 3357.714594259488, 3360.6135294441133, 5718.485336319731, 5762.106873434614, 5765.682887441194, 5769.192313076167, 5779.162021506879, 5729.770809167639, 5790.797322093727, 5800.564957628174, 5806.941930580693, 5809.01246788046, 5165.922511162326, 5214.478552144793, 5245.291885595453, 5278.498542638463, 5323.494268044529, 5126.692398456086, 5186.611004174702, 5383.865403364908, 5384.0, 5386.73066346683, 5147.38231412231, 5185.24813901984, 5218.921716174261, 5226.92159617606, 5259.289995850569, 5288.841334759944, 5329.253904453399, 5339.038972984861, 5348.91976620351, 5357.276767636397, 5023.397192336906, 5093.083245015896, 5234.581233501311, 5265.104932161542, 5292.047431462335, 5548.472895074961, 5570.6657600543695, 5593.860153496195, 5633.802816901389, 5639.605227634067, 6066.726997285133, 6091.908621370683, 6101.481374083208, 6105.847353816146, 6108.725107370179, 6046.848828779316, 6074.514038876923, 6114.358196333998, 6151.0773383992755, 6186.041163619646, 5718.942810571883, 5723.627964182315, 5723.885522289531, 5762.250907382056, 5768.278965129359, 6235.719392627343, 6246.500279977682, 6247.500199983991, 6249.125122482856, 6280.748770049238, 5879.088741245114, 5968.432998865101, 6001.309849367379, 6058.878822423527, 6096.116063170815, 5936.8812623748145, 5940.34656187819, 5957.493613042853, 5961.225040744675, 5986.49114825236, 5863.0325996211, 5874.853128671732, 5918.526517878559, 5921.96365636012, 5943.257092863392, 5888.4700376966275, 6115.057807494094, 6205.47253483459, 6217.626942383471, 6219.409156130251, 4631.861044168681, 4658.277966915133, 4658.58072773452, 4679.742614156254, 4685.320628508847, 4044.676425885922, 4161.729487583298, 4164.75011499311, 4169.770662613585, 4178.12259425524, 5701.971490142523, 5722.399148089474, 5772.163036359704, 5812.360640329561, 5820.417958204146, 6087.9391206087375, 6127.42900967125, 6158.507319414436, 6163.0, 6172.290186628506, 5644.379118296984, 5808.651480911159, 5809.070548712186, 5817.335078900266, 5824.417558244142, 5199.922001169985, 5221.086309895753, 5259.8422047338645, 5272.182811664198, 5288.365396152486, 6408.070829729663, 6432.581882177644, 6442.516811239176, 6442.613443193423, 6446.7421303148285, 6082.0, 6125.938740612537, 6183.505319574333, 6196.628202307876, 6217.720202590985, 6103.450689437972, 6246.219222597176, 6404.423601875854, 6450.709718062604, 6462.256840463407, 6026.427489388501, 6043.36544662804, 6049.909251361145, 6050.183225264533, 6059.303180134341, 5999.5500337473995, 6148.600340977822, 6155.446009859134, 6160.260768707783, 6162.106494558354, 5902.675352855634, 5940.702964851826, 5963.344032156372, 5978.671173085522, 6003.879922401615, 5934.0, 5988.910166347596, 5991.3409524953095, 6022.7289771959495, 6045.727942242697, 5455.372632147195, 5649.406812284651, 5745.253117094751, 5822.854428639318, 5841.94158058414, 5984.431479009487, 5988.401159883977, 6004.279486461653, 6048.667323297085, 6071.7571297147615, 5887.735051922759, 5891.49922256613, 5899.115132729953, 5902.2622172228475, 5927.733252003756], "value": 5634.55995488976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.8721368512612, 660.4551245222692, 665.2150462454302, 671.1208317104594, 684.1448189762793, 39264.411033834476, 40653.390199147034, 40824.79587602062, 40843.0, 40871.59128408715, 43331.78334108325, 43510.564894351046, 43762.0, 43856.56143438564, 44040.0, 8904.91095089049, 9031.864522032174, 9059.0, 9061.95469022654, 9091.0, 8848.2478989286, 8900.732978010637, 8918.55407229636, 8923.553822308892, 8925.732228033137, 9026.548672566378, 9165.083491650848, 9170.312226582999, 9208.079192080806, 9226.169644731974, 9100.590473428678, 9165.816683666322, 9168.037356077615, 9214.815703685956, 9221.400608960395, 9097.499637519933, 9199.908000919972, 9221.723348299562, 9227.307951903635, 9243.722688319362, 44204.77897610491, 44327.778361108314, 44603.55396446026, 44633.55366446327, 44687.0, 3706.5181526401666, 3776.847922236672, 4075.8981025474304, 4148.668106551469, 4313.1158112586845, 33026.6697333026, 33103.33793324144, 33844.83077584621, 34652.0, 34986.0, 4099.446574712406, 4128.91742165158, 4142.875713728593, 4143.9171216575805, 4265.765382903939, 320348.0, 320761.3961930199, 321250.0, 322297.0, 322318.0, 39974.40038399426, 41183.7940810294, 41296.58703412987, 63456.0, 64759.67620161963, 38421.423678644845, 38439.07804609758, 38600.227995439935, 38694.419583706265, 38737.80631096826, 16622.66754664924, 16627.750583741254, 16696.833031669772, 16699.248533816008, 16741.6651666966, 14011.719765604834, 14030.088044277089, 14048.227347495986, 14069.788953165711, 14075.71848563023, 9393.060693930689, 9399.0, 9428.245740340757, 9544.665936692183, 9572.0, 3626.3653860574295, 3670.3209906167444, 3694.2057457646733, 3717.925641487155, 3787.2046870157574, 1068.5725709716176, 1068.9144868410508, 1107.1585594947899, 1147.9381572045825, 1170.8770579089244, 33086.83456582702, 34064.65935340664, 35274.11814704653, 37660.77090271008, 38424.23151536954, 1208.1784386617185, 1282.3908643394313, 1296.3129541343103, 1299.7790375636164, 1312.7308901675133, 17389.478315650296, 17524.91237543804, 17559.297628094988, 17595.91202044007, 17677.116144192994, 506880.0, 527423.0, 563501.0, 574001.0, 900236.0, 59783.0, 60725.69637151786, 60937.39062609406, 61059.38940610537, 61154.0, 1473.4990103364694, 1524.1083965879864, 1533.8389469105807, 1549.5041586692375, 1553.9611509712347, 31683.36633267368, 32147.35705285928, 32402.51396229011, 32675.183120422178, 32938.67061329356, 56129.43870561242, 56937.43062569487, 57023.0, 57131.71434142803, 57241.0, 422855.0, 426956.0, 428731.0, 429548.0, 429863.0, 30860.0, 31129.377412451173, 31637.8418107908, 31678.0, 31761.523577145897, 51823.48176518187, 51844.22233666423, 52371.21443178432, 52987.4701252998, 53391.46608533865, 42960.570394296905, 43752.56247437612, 44013.33979990367, 44734.55265447304, 44934.0, 41460.58539414567, 41911.58088419077, 42710.57289427066, 42753.358699620156, 43619.0, 44737.0, 44798.328025079, 45050.54949450595, 45109.0, 45740.0, 36820.07949801276, 37059.8147009274, 37376.0, 38734.2253154941, 38809.80595097006, 29579.852100739357, 29816.403671926873, 30076.24809379783, 30351.696483034888, 30367.392652147275], "value": 19913.825760963744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.8685850815502, 438.63154949842124, 438.67099675243566, 444.1738366638053, 445.2408643263237, 18729.531761705963, 18978.90510547449, 19485.220591176352, 20386.0, 20423.693644595307, 19537.90231048846, 19941.202351905908, 19963.10166042528, 19989.500262493446, 20082.0, 5516.227728118067, 5735.483806457418, 5756.424357564252, 5771.336296325913, 5781.046127388976, 5585.74864131113, 5706.572007099484, 5706.800261990831, 5879.823605291826, 5896.97051514744, 5861.17943487912, 5863.560232982522, 5864.0, 5888.882222355551, 5890.88218235635, 6041.788537401192, 6054.878902421927, 6089.391060893898, 6101.9389806102035, 6122.663253521055, 5914.053751399755, 5933.228680271537, 5934.703264836784, 5936.762529498815, 5964.254468191476, 13744.931275343659, 14048.789268160986, 14049.43802247909, 14189.36147873348, 16665.91667041657, 2326.895289711967, 2334.5330933813134, 2373.133806160756, 2391.7608239176116, 2489.4772097859473, 10778.353298802018, 10785.83821242682, 10957.56169753209, 12861.614151575468, 14177.43290268388, 2034.3083351660507, 2109.6308146074375, 2131.1049359269145, 2164.9134034638596, 2172.1420039084474, 81380.59309703473, 83551.16448835495, 84342.0, 84421.15578844195, 84655.0, 11030.50362733679, 11302.304654301755, 11385.430728463709, 11456.4844581994, 11649.0, 16267.349306027627, 16317.34730610786, 16372.918135409247, 16373.508794735939, 16413.0, 8614.526201058876, 8940.642374304955, 8955.596998135099, 9077.77305567366, 9141.634334626673, 8831.60257788401, 8855.73432797017, 8909.064548222474, 8923.73228803137, 8978.10218978097, 4990.800367985313, 5054.115529782347, 5063.5695965843315, 5064.290999260106, 5081.18701007837, 1886.820752028555, 1985.5036240939764, 2083.5728675621463, 2101.2540548105508, 2102.0960986775835, 995.9053889880595, 1006.9647562335283, 1055.6674647486018, 1081.4808891732014, 1092.748667806409, 17655.0, 18085.276588936296, 18611.25554977813, 19067.427977160707, 19109.904450477658, 1037.9273450858518, 1045.2160879340495, 1047.858539097212, 1062.3997441445558, 1101.2401443004462, 10217.795644087077, 10441.0, 10535.525901334458, 10564.841527377095, 10667.83998240027, 533568.0, 541098.0, 545607.0, 556092.0, 556296.0, 88630.55684721535, 89030.55484722664, 90237.54881225553, 90631.0, 94113.52943235377, 1099.7580532282884, 1101.9063379612662, 1129.717570607348, 1139.584051821096, 1149.5804031528432, 16393.344266229695, 16476.42332518356, 16653.3338666452, 16725.832741672428, 16883.577910552336, 38047.0, 38246.61753382542, 39522.80238598904, 39788.80105599453, 39812.80093599513, 54976.17535737047, 55147.0, 55485.61285967883, 55835.0, 56157.71921140368, 8496.447730897471, 8668.393212475066, 8669.91330086691, 8760.0, 8889.555522223993, 12551.0, 12893.613191604267, 12937.805932911202, 13363.599092027254, 13406.865931340562, 5696.971515142398, 8937.419067760835, 9429.774129363414, 11740.0, 12063.21589096706, 10314.381137131797, 11762.411879405825, 11788.292702437539, 11798.41007949582, 12218.0, 11877.762444750884, 11878.227915185485, 11928.403579821148, 12127.211731237441, 12307.56923507673, 9134.771630709285, 9181.770455738393, 9212.078966367046, 9217.400868943498, 9360.812783744152, 10314.742131446774, 11814.586489472827, 11939.641810745692, 12013.75972480563, 12022.699432514257], "value": 9362.564510776916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1594.0834020438247, 1598.608340956465, 1825.543614096476, 1911.0731295321775, 1933.8549608779344, 7534.6232688365635, 8312.958435207816, 8401.663933442662, 8595.097514760946, 8651.74044778657, 8251.876221856663, 8283.585820708971, 8312.501249925008, 8346.582670866448, 8405.453645513053, 2418.935668305944, 2435.902563897442, 2437.902483900642, 2445.8532488050687, 2446.388402899275, 2310.0644239083113, 2387.2122199674154, 2397.3287479505766, 2399.688040554734, 2410.915617953372, 2355.0815182079004, 2380.143148466551, 2392.545416370893, 2409.204962362416, 2412.3245491262473, 2381.7975472084895, 2389.51015041916, 2391.1630929174735, 2398.520295940819, 2398.580248456522, 2345.3784747042046, 2363.4564050268364, 2370.028288401747, 2371.1345358944036, 2380.523895220963, 8299.211574900375, 8317.750467485985, 8334.66661333546, 8343.374246931444, 8364.749057528285, 5331.466853314676, 5408.0, 5410.91883621746, 5426.21319908615, 5435.0488664483555, 3489.3719130556487, 3525.8589656413715, 3566.322398744256, 3579.4630805379143, 3615.5299811024397, 1169.4620474581702, 1193.7194759231575, 1196.658952198628, 1203.422357268516, 1210.2435977514053, 12328.938355308255, 12333.0, 12366.381680915918, 12380.690482737913, 12395.690107747378, 4697.8355757548325, 4732.621390288768, 4820.855374338706, 4850.902981940341, 4872.561469467694, 10418.322809017542, 10456.843147352796, 10460.633877814393, 10472.581096756197, 10486.423246721504, 5380.569554435636, 5381.300430943952, 5408.323959505062, 5408.702521361284, 5427.240186373911, 4883.926741098886, 4923.286123512143, 4979.676321039121, 4990.750462476862, 4995.100881841231, 3956.802159891994, 3981.5421226558738, 4013.7190396672536, 4075.65356944663, 4146.9436616205585, 1223.1988047828686, 1225.6323103069044, 1231.0459393969745, 1234.8147777833397, 1246.507629486348, 939.2251392600995, 995.2585323933715, 1039.7556574205055, 1078.2775540387959, 1080.4921686807188, 5930.22907022093, 5973.641581505123, 5985.521158307325, 6123.295820980644, 6144.754209831646, 1009.2380252909154, 1040.4069680282319, 1053.5680371047833, 1071.276888100529, 1079.02348374721, 4098.7950602469755, 4117.855875044359, 4119.382092686121, 4122.546519882811, 4137.54487006429, 10291.176705863512, 10388.584456621802, 10668.359898406121, 10690.893091069145, 10695.78608427827, 10626.787464250672, 10654.893451065545, 10701.090407315465, 10709.839352409721, 10725.14198864089, 8284.834303313779, 8287.95856020716, 8362.414630975894, 8449.0, 8471.95764021176, 5889.764409423575, 5919.6744179070565, 5947.345791962967, 5956.821295361146, 6144.416280453529, 9352.906470935204, 9430.245580353692, 9552.474613896302, 9574.904250957401, 9675.225981921289, 9486.33595648298, 9747.074027967332, 9853.458059806779, 9860.0, 9999.050090241415, 7455.142658594331, 7592.582407967394, 7647.349975252166, 7759.262870027338, 7785.610719463891, 8302.6678932842, 8315.79420983966, 8317.126701696236, 8337.0, 8374.706885258987, 7422.146453157956, 7688.384929205538, 7693.4614576979075, 7762.88355674654, 7773.339266162213, 7438.293362130589, 7465.216152303929, 7494.5503269803985, 7576.2423757626, 7585.544867307979, 6895.379415852597, 6945.236024037453, 6959.721611135498, 6963.6170010647875, 7018.508704390848, 4989.426215985208, 5110.48895110486, 5177.326947496801, 5184.818531351385, 5271.868203294948, 5181.766820493011, 5229.241759944863, 5286.762095705625, 5290.68255904647, 5319.38827034896], "value": 4692.097658304014, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.3387318144387, 364.39692309228235, 367.35345791407116, 372.7539823716348, 374.4476896577548, 6520.282768895429, 6588.176477940257, 6605.042268871017, 6622.072909792633, 6646.169228846395, 6623.105880706104, 6682.899756503656, 6734.3939045485895, 6751.223609284933, 6765.289644587309, 5070.543651071403, 5070.594352451813, 5108.106081435743, 5118.590512758989, 5118.9744051279695, 5100.489951004888, 5109.514596113363, 5122.410922743877, 5124.6412751107255, 5137.897242055175, 5026.9497305027035, 5064.063148317555, 5069.670471419365, 5078.314427552288, 5093.821716239932, 4926.088673595378, 5017.122003649347, 5042.546170844642, 5067.543921047105, 5074.467180945984, 4331.285337919271, 4344.326629372453, 4357.346398040288, 4362.8909277268, 4368.803403846835, 6399.840003999937, 6403.711832967528, 6410.0705397717065, 6413.134226879405, 6442.065900444456, 5658.122990936411, 5746.367899531048, 5770.249867517238, 5823.767049318022, 5827.970860145714, 6988.755393561251, 7030.543014704028, 7040.823979400556, 7042.542234754725, 7058.082449281612, 4753.049390121955, 4754.714717116949, 4757.191277482836, 4791.520847915215, 4803.543663351976, 7297.087864016998, 7334.229905859915, 7362.079740032443, 7366.631668416558, 7386.372158366546, 4833.879153021203, 4994.150994330972, 4999.175136102575, 5001.124803159505, 5029.572486338702, 5052.216906379517, 5072.010957863181, 5072.568831649277, 5083.593312535062, 5090.872728181751, 5884.205632239678, 5894.6757928314355, 5900.881982360329, 5902.144189092557, 5904.763809447574, 7116.786496405116, 7134.964325178341, 7162.570245785269, 7164.892526612105, 7166.032585600981, 1749.868759843017, 1786.6873297172942, 1788.6780379531808, 1790.149678902511, 1791.0596936608385, 1113.9832902506469, 1137.7895089408487, 1149.7930372532858, 1163.0985985860857, 1183.2249876331016, 6796.422304104207, 6799.388055075067, 6810.557313774589, 6826.590404575742, 6830.146231721035, 7300.196978332379, 7304.6486400016165, 7314.48798584094, 7320.67056982437, 7331.596762178131, 6780.593164410151, 6782.321767823179, 6799.524033317719, 6805.863882722417, 6813.284605116491, 3895.039561323802, 3909.2181563687377, 3950.940735888964, 3954.347532657137, 3954.7429417088374, 7523.736669216661, 7578.696852125963, 7591.127020392615, 7595.658195381221, 7603.0, 7396.667149978264, 7415.555066696015, 7417.851642967111, 7424.0, 7428.814279642944, 7565.2812982766545, 7576.166621671612, 7579.886301705479, 7580.1661817200065, 7597.620118994028, 7137.0, 7258.637068146677, 7272.200057993511, 7272.818179545554, 7292.124945006421, 7248.60132692707, 7280.563166209832, 7280.563166210044, 7332.853342933218, 7344.596047217455, 7750.92249077502, 7756.0304961879765, 7757.65090570937, 7759.68961241544, 7769.067711874612, 4820.783064762024, 4833.661643684908, 4835.975820120877, 4850.781714822912, 4863.610911127031, 7093.077899872984, 7367.1527774304495, 7373.741919032808, 7384.298491643285, 7397.889031664637, 7049.506534542533, 7115.181754098345, 7121.857562848818, 7149.9285007149265, 7150.96424517874, 7072.787816365517, 7097.680604372712, 7115.928840711734, 7126.180489243803, 7133.037039999741, 6760.628165450751, 6783.321667833177, 6790.5925644461495, 6806.18325800907, 6823.590584564942, 7075.610841403773, 7187.604681742345, 7190.676419561028, 7219.6751146199595, 7224.494285399972, 6809.863802724017, 6919.411849992605, 6930.549514281555, 6940.583564985915, 7025.437964962688], "value": 5316.336806894099, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.1777209525333, 744.3338212299992, 852.1138016462879, 861.9957749222157, 875.4440930009445, 15308.234588270583, 15373.923130384346, 15417.69164616707, 15482.0, 15487.303071361788, 14274.714505709879, 14292.213928233943, 14377.78433323501, 14401.711965760705, 14418.134911905267, 727.5670975769409, 889.2130464538865, 900.720776559267, 912.2063804490103, 915.5330781301551, 880.828238493494, 890.185480285538, 890.470170248701, 891.2201823404521, 894.0210469535848, 970.1947383671571, 978.0952618827556, 979.1579241852002, 979.8138353712772, 980.01998001998, 966.3815158298695, 971.1890571372912, 971.5967873332559, 973.0366936732619, 974.3228456222893, 712.6045045000022, 712.975045873392, 713.9393151582121, 714.3356678289189, 716.2586722741937, 14664.046836955671, 14687.192204428753, 14709.632259193499, 14723.411063557445, 14764.483243086548, 15247.313870875838, 15497.22513874313, 15685.215739212994, 15750.369985200578, 15871.0, 12058.879411205951, 12190.952720313815, 12222.0, 12238.204516706475, 12423.62729118128, 4016.4176194451934, 4025.134596061861, 4078.3474644057105, 4089.3252613319064, 4166.729162604421, 55989.0, 56117.71941140309, 57421.71289143527, 58987.82024359531, 59095.0, 12124.69688257783, 12213.267203967791, 12227.572034978733, 12376.566820161252, 12415.44130514129, 22176.1129554816, 22237.555248894932, 22306.0, 22425.887870560542, 22656.0, 8726.91273087261, 8727.127287271349, 9008.819823603491, 9102.362834601514, 9132.954335228282, 4835.8065677372515, 4841.201201801663, 4852.733099679481, 4897.706137631682, 5028.044671512401, 3630.9636903630626, 3688.7602305850032, 3697.131174174067, 3702.241040586673, 3710.3135919854913, 577.4369989260438, 630.7193298982, 640.5132099604334, 640.7885397818709, 642.1908395421709, 728.1407938632359, 775.3215936055951, 813.5606772342868, 823.7133835994459, 829.1956801902145, 9660.903390966141, 10562.788744225227, 10682.412467314218, 10752.301100428604, 10793.622223222306, 644.7195469970578, 692.2005084127841, 811.6388207247718, 819.1194465949128, 835.8746188071716, 4604.447466303998, 4646.4888862225125, 4721.598664113589, 4803.759812009385, 4812.133815913169, 67319.66340168366, 68585.0, 68911.3108868905, 69453.65273173602, 69563.3043669567, 61042.69478652578, 61310.0, 61671.6916415415, 62537.37462625316, 63135.05297420542, 53650.73174634102, 55049.44950550523, 55067.449325507034, 55327.72336138374, 55902.72048639731, 9375.859362109437, 9537.904620953701, 9619.038096190325, 9629.662961796303, 9653.951730241304, 39924.401133982436, 40800.59199407968, 41175.58824411718, 41812.0, 41909.371359429024, 45462.54537454715, 48738.26892596685, 48781.0, 48911.75544122399, 49662.0, 12735.80896286538, 13038.47846086184, 13084.476620935056, 13132.0, 13159.88141008025, 12231.204971676812, 12246.326452045223, 13851.16892986424, 14219.64450888736, 14821.777673334693, 12711.80932285998, 12822.551210707581, 13013.21920684762, 13271.469141234242, 13411.195328280335, 13011.089223754625, 13128.343582821011, 13401.664958375728, 13629.795553066513, 13639.318034098056, 13032.087753857139, 13217.801732974205, 13258.403371848482, 13472.86527134716, 13844.169349839041, 10527.842082368923, 10590.947045264724, 10750.946245269037, 10897.618583349862, 11233.38216398106, 10515.684529464128, 11074.390908499787, 11152.832707509231, 11239.60661376848, 11250.943745281222], "value": 7286.86582677751, "unit": "score"}], "name": "dromaeo_css", "value": 7588.587175475831, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 111.0, 115.0, 111.0, 103.0, 111.0, 114.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 150.0, 174.0, 128.0, 150.0, 154.0, 127.0, 185.0, 129.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 161.0, 161.0, 164.0, 160.0, 159.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 168.0, 74.0, 76.0, 76.0, 75.0, 171.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 92.0, 92.0, 93.0, 147.0, 92.0, 91.0, 161.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 53.0, 56.0, 56.0, 56.0, 54.0, 82.0, 53.0, 52.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0, 57.0, 57.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 88.0, 74.0, 75.0, 76.0, 76.0, 75.0, 75.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 120.0, 112.0, 119.0, 126.0, 121.0, 119.0, 127.0, 129.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 160.0, 159.0, 158.0, 157.0, 158.0, 159.0, 166.0, 155.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 69.0, 67.0, 76.0, 64.0, 66.0, 67.0, 64.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1520.1999999999998, "alertThreshold": 2.0}]} 19:27:39 INFO - Return code: 0 19:27:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:27:39 ERROR - # TBPL SUCCESS # 19:27:39 INFO - Running post-action listener: _resource_record_post_action 19:27:39 INFO - Running post-run listener: _resource_record_post_run 19:27:40 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 24576; Write bytes: 463085568; Read time: 20; Write time: 497688 19:27:40 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 242118656; Read time: 0; Write time: 292664 19:27:40 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 220286976; Read time: 0; Write time: 205024 19:27:40 INFO - Running post-run listener: _upload_blobber_files 19:27:40 INFO - Blob upload gear active. 19:27:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:27:40 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 19:27:40 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'] 19:27:40 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 19:27:40 INFO - (blobuploader) - INFO - Open directory for files ... 19:27:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:27:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:27:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:41 INFO - (blobuploader) - INFO - Done attempting. 19:27:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:27:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:27:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:42 INFO - (blobuploader) - INFO - Done attempting. 19:27:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:27:42 INFO - Return code: 0 19:27:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:27:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:27:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd1a3acdc7e5900ac70ec5a2979a94fae97f3c5a852aac9886e257419dc4a41fe887fc9c1827b007f22e49791f73da0a468002a16e0da5300f9201dfe7b62617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f56e1a9133fdeba6f22203e6ed77b7e3a01c0ae6e5ab35134e71a0a4c0722817045fc0faa333d73f6003cbcd636ee17f1a00aa6e459992dfc397f1090207ebb6"} 19:27:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:27:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:27:42 INFO - Contents: 19:27:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd1a3acdc7e5900ac70ec5a2979a94fae97f3c5a852aac9886e257419dc4a41fe887fc9c1827b007f22e49791f73da0a468002a16e0da5300f9201dfe7b62617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f56e1a9133fdeba6f22203e6ed77b7e3a01c0ae6e5ab35134e71a0a4c0722817045fc0faa333d73f6003cbcd636ee17f1a00aa6e459992dfc397f1090207ebb6"} 19:27:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:27:42 INFO - Copying logs to upload dir... 19:27:42 INFO - mkdir: /builds/slave/test/build/upload/logs 19:27:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.798420 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-10 19:27:42.614677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 19:27:42.617979) ========= 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=fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520 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/fd1a3acdc7e5900ac70ec5a2979a94fae97f3c5a852aac9886e257419dc4a41fe887fc9c1827b007f22e49791f73da0a468002a16e0da5300f9201dfe7b62617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f56e1a9133fdeba6f22203e6ed77b7e3a01c0ae6e5ab35134e71a0a4c0722817045fc0faa333d73f6003cbcd636ee17f1a00aa6e459992dfc397f1090207ebb6"} build_url:https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/JVlk31x-QqK3lEB95WkTIA/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/fd1a3acdc7e5900ac70ec5a2979a94fae97f3c5a852aac9886e257419dc4a41fe887fc9c1827b007f22e49791f73da0a468002a16e0da5300f9201dfe7b62617", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f56e1a9133fdeba6f22203e6ed77b7e3a01c0ae6e5ab35134e71a0a4c0722817045fc0faa333d73f6003cbcd636ee17f1a00aa6e459992dfc397f1090207ebb6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 19:27:42.643356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 19:27:42.643700) ========= 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=fa44defc139c4ba8574fe040000001db-1468201791.165682-101743520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 19:27:42.728899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 19:27:42.729211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 19:27:42.729513) ========= ========= Total master_lag: 0.17 =========