builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1466732595.51 results: success (0) buildid: 20160623153657 builduid: 46d2a3a5549d444bbfa748bec8b2d166 revision: b449af6b87414aa2ed035aaaa5043642e9a4ac06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.506784) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.507429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.507764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.522795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.523110) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 18:43:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.0M=0s 2016-06-23 18:43:15 (57.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122326 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.663344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.664320) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016235 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:15.716274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 18:43:15.716685) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b449af6b87414aa2ed035aaaa5043642e9a4ac06 --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 b449af6b87414aa2ed035aaaa5043642e9a4ac06 --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=9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 18:43:15,722 truncating revision to first 12 chars 2016-06-23 18:43:15,722 Setting DEBUG logging. 2016-06-23 18:43:15,722 attempt 1/10 2016-06-23 18:43:15,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b449af6b8741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 18:43:16,962 unpacking tar archive at: mozilla-beta-b449af6b8741/testing/mozharness/ program finished with exit code 0 elapsedTime=1.593391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 18:43:17.326991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:17.327465) ========= script_repo_revision: b449af6b87414aa2ed035aaaa5043642e9a4ac06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:17.327977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:17.328377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 18:43:17.339175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-23 18:43:17.339622) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:43:17 INFO - MultiFileLogger online at 20160623 18:43:17 in /builds/slave/test 18:43:17 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 18:43:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:43:17 INFO - {'append_to_log': False, 18:43:17 INFO - 'base_work_dir': '/builds/slave/test', 18:43:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:43:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:43:17 INFO - 'branch': 'Mozilla-Beta', 18:43:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:43:17 INFO - 'config_files': ('talos/linux_config.py',), 18:43:17 INFO - 'default_actions': ('clobber', 18:43:17 INFO - 'read-buildbot-config', 18:43:17 INFO - 'download-and-extract', 18:43:17 INFO - 'populate-webroot', 18:43:17 INFO - 'create-virtualenv', 18:43:17 INFO - 'install', 18:43:17 INFO - 'run-tests'), 18:43:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:43:17 INFO - 'download_minidump_stackwalk': True, 18:43:17 INFO - 'download_symbols': 'ondemand', 18:43:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:43:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:43:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:43:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:43:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:43:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:43:17 INFO - 'installer_path': 'installer.exe', 18:43:17 INFO - 'log_level': 'info', 18:43:17 INFO - 'log_name': 'talos', 18:43:17 INFO - 'log_to_console': True, 18:43:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:43:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:43:17 INFO - 'opt_config_files': (), 18:43:17 INFO - 'pip_index': False, 18:43:17 INFO - 'sps_profile': False, 18:43:17 INFO - 'sps_profile_interval': 0, 18:43:17 INFO - 'suite': 'dromaeojs-e10s', 18:43:17 INFO - 'system_bits': '32', 18:43:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:43:17 INFO - 'title': 'talos-linux64-ix-022', 18:43:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:43:17 INFO - 'use_talos_json': True, 18:43:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:43:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:43:17 INFO - 'work_dir': 'build'} 18:43:17 INFO - ##### 18:43:17 INFO - ##### Running clobber step. 18:43:17 INFO - ##### 18:43:17 INFO - Running pre-action listener: _resource_record_pre_action 18:43:17 INFO - Running main action method: clobber 18:43:17 INFO - rmtree: /builds/slave/test/build 18:43:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:43:17 INFO - Running post-action listener: _resource_record_post_action 18:43:17 INFO - ##### 18:43:17 INFO - ##### Running read-buildbot-config step. 18:43:17 INFO - ##### 18:43:17 INFO - Running pre-action listener: _resource_record_pre_action 18:43:17 INFO - Running main action method: read_buildbot_config 18:43:17 INFO - Using buildbot properties: 18:43:17 INFO - { 18:43:17 INFO - "project": "", 18:43:17 INFO - "product": "firefox", 18:43:17 INFO - "script_repo_revision": "production", 18:43:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:43:17 INFO - "repository": "", 18:43:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 18:43:17 INFO - "buildid": "20160623153657", 18:43:17 INFO - "pgo_build": "True", 18:43:17 INFO - "basedir": "/builds/slave/test", 18:43:17 INFO - "buildnumber": 57, 18:43:17 INFO - "slavename": "talos-linux64-ix-022", 18:43:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:43:17 INFO - "platform": "ubuntu64_hw", 18:43:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:43:17 INFO - "branch": "mozilla-beta", 18:43:17 INFO - "repo_path": "releases/mozilla-beta", 18:43:17 INFO - "revision": "b449af6b87414aa2ed035aaaa5043642e9a4ac06", 18:43:17 INFO - "stage_platform": "linux64-pgo", 18:43:17 INFO - "builduid": "46d2a3a5549d444bbfa748bec8b2d166", 18:43:17 INFO - "slavebuilddir": "test" 18:43:17 INFO - } 18:43:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 18:43:17 INFO - Running post-action listener: _resource_record_post_action 18:43:17 INFO - ##### 18:43:17 INFO - ##### Running download-and-extract step. 18:43:17 INFO - ##### 18:43:17 INFO - Running pre-action listener: _resource_record_pre_action 18:43:17 INFO - Running main action method: download_and_extract 18:43:17 INFO - mkdir: /builds/slave/test/build/tests 18:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:17 INFO - https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:43:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 18:43:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 18:43:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:18 INFO - Downloaded 1327 bytes. 18:43:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 18:43:18 INFO - Using the following test package requirements: 18:43:18 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 18:43:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:43:18 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 18:43:18 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'jsshell-linux-x86_64.zip'], 18:43:18 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:43:18 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 18:43:18 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 18:43:18 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 18:43:18 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:43:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 18:43:18 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:43:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:18 INFO - https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:20 INFO - Downloaded 24229415 bytes. 18:43:20 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'] 18:43:20 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 18:43:21 INFO - Return code: 0 18:43:21 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 18:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:21 INFO - https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:43:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:43:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 18:43:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:23 INFO - Downloaded 24229415 bytes. 18:43:23 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'] 18:43:23 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 18:43:25 INFO - Return code: 0 18:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:25 INFO - https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 18:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 18:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:26 INFO - Downloaded 10840145 bytes. 18:43:26 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'] 18:43:26 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 18:43:27 INFO - Return code: 0 18:43:27 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')]} 18:43:27 INFO - https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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 18:43:29 INFO - Downloaded 55994747 bytes. 18:43:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:43:29 INFO - mkdir: /builds/slave/test/properties 18:43:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:43:29 INFO - Writing to file /builds/slave/test/properties/build_url 18:43:29 INFO - Contents: 18:43:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 18:43:30 INFO - Running post-action listener: _resource_record_post_action 18:43:30 INFO - Running post-action listener: set_extra_try_arguments 18:43:30 INFO - ##### 18:43:30 INFO - ##### Running populate-webroot step. 18:43:30 INFO - ##### 18:43:30 INFO - Running pre-action listener: _resource_record_pre_action 18:43:30 INFO - Running main action method: populate_webroot 18:43:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:43:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:43:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:43:30 INFO - '--tppagecycles', 18:43:30 INFO - '7'], 18:43:30 INFO - 'tests': ['tsvgm']}}, 18:43:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:43:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:43:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:43:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:43:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['damp', 'tps']}, 18:43:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'tests': ['damp', 'tps']}, 18:43:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['dromaeo_dom']}, 18:43:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:43:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['a11yr', 18:43:30 INFO - 'ts_paint', 18:43:30 INFO - 'tpaint', 18:43:30 INFO - 'sessionrestore', 18:43:30 INFO - 'sessionrestore_no_auto_restore', 18:43:30 INFO - 'tabpaint']}, 18:43:30 INFO - 'other-e10s': {'tests': ['a11yr', 18:43:30 INFO - 'ts_paint', 18:43:30 INFO - 'tpaint', 18:43:30 INFO - 'sessionrestore', 18:43:30 INFO - 'sessionrestore_no_auto_restore', 18:43:30 INFO - 'tabpaint']}, 18:43:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:43:30 INFO - 'ts_paint', 18:43:30 INFO - 'tpaint', 18:43:30 INFO - 'sessionrestore', 18:43:30 INFO - 'sessionrestore_no_auto_restore', 18:43:30 INFO - 'tabpaint']}, 18:43:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:43:30 INFO - 'ts_paint', 18:43:30 INFO - 'tpaint', 18:43:30 INFO - 'sessionrestore', 18:43:30 INFO - 'sessionrestore_no_auto_restore', 18:43:30 INFO - 'tabpaint']}, 18:43:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['a11yr', 18:43:30 INFO - 'ts_paint', 18:43:30 INFO - 'tpaint', 18:43:30 INFO - 'sessionrestore', 18:43:30 INFO - 'sessionrestore_no_auto_restore', 18:43:30 INFO - 'tabpaint']}, 18:43:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['a11yr', 18:43:30 INFO - 'ts_paint', 18:43:30 INFO - 'tpaint', 18:43:30 INFO - 'sessionrestore', 18:43:30 INFO - 'sessionrestore_no_auto_restore', 18:43:30 INFO - 'tabpaint']}, 18:43:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['tsvgx', 18:43:30 INFO - 'tsvgr_opacity', 18:43:30 INFO - 'tart', 18:43:30 INFO - 'tscrollx', 18:43:30 INFO - 'cart']}, 18:43:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:43:30 INFO - 'tsvgr_opacity', 18:43:30 INFO - 'tart', 18:43:30 INFO - 'tscrollx', 18:43:30 INFO - 'cart']}, 18:43:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'talos_options': ['--disable-e10s'], 18:43:30 INFO - 'tests': ['tp5o']}, 18:43:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'tests': ['tp5o']}, 18:43:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'talos_options': ['--disable-e10s', 18:43:30 INFO - '--xperf_path', 18:43:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:30 INFO - 'tests': ['tp5n']}, 18:43:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:30 INFO - 'talos_options': ['--xperf_path', 18:43:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:30 INFO - 'tests': ['tp5n']}}, 18:43:30 INFO - 'talos.zip': {'path': '', 18:43:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:43:30 INFO - Running post-action listener: _resource_record_post_action 18:43:30 INFO - ##### 18:43:30 INFO - ##### Running create-virtualenv step. 18:43:30 INFO - ##### 18:43:30 INFO - Running pre-action listener: _resource_record_pre_action 18:43:30 INFO - Running main action method: create_virtualenv 18:43:30 INFO - Creating virtualenv /builds/slave/test/build/venv 18:43: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 18:43:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:43:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:43:30 INFO - Using real prefix '/usr' 18:43:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:43:30 INFO - Installing distribute.............................................................................................................................................................................................done. 18:43:32 INFO - Installing pip.................done. 18:43:32 INFO - Return code: 0 18:43:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43: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 18:43: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 18:43:32 INFO - Using env: {'DISPLAY': ':0', 18:43:32 INFO - 'HOME': '/home/cltbld', 18:43:32 INFO - 'LANG': 'en_US.UTF-8', 18:43:32 INFO - 'LANGUAGE': 'en_US:en', 18:43:32 INFO - 'LOGNAME': 'cltbld', 18:43:32 INFO - 'MAIL': '/var/mail/cltbld', 18:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:32 INFO - 'MOZ_NO_REMOTE': '1', 18:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:32 INFO - 'NO_EM_RESTART': '1', 18:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:32 INFO - 'PWD': '/builds/slave/test', 18:43:32 INFO - 'SHELL': '/bin/bash', 18:43:32 INFO - 'SHLVL': '1', 18:43:32 INFO - 'TERM': 'linux', 18:43:32 INFO - 'TMOUT': '86400', 18:43:32 INFO - 'USER': 'cltbld', 18:43:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:32 INFO - '_': '/tools/buildbot/bin/python'} 18:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43: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 18:43:32 INFO - Cleaning up... 18:43:32 INFO - Return code: 0 18:43:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43: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 18:43: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 18:43:32 INFO - Using env: {'DISPLAY': ':0', 18:43:32 INFO - 'HOME': '/home/cltbld', 18:43:32 INFO - 'LANG': 'en_US.UTF-8', 18:43:32 INFO - 'LANGUAGE': 'en_US:en', 18:43:32 INFO - 'LOGNAME': 'cltbld', 18:43:32 INFO - 'MAIL': '/var/mail/cltbld', 18:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:32 INFO - 'MOZ_NO_REMOTE': '1', 18:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:32 INFO - 'NO_EM_RESTART': '1', 18:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:32 INFO - 'PWD': '/builds/slave/test', 18:43:32 INFO - 'SHELL': '/bin/bash', 18:43:32 INFO - 'SHLVL': '1', 18:43:32 INFO - 'TERM': 'linux', 18:43:32 INFO - 'TMOUT': '86400', 18:43:32 INFO - 'USER': 'cltbld', 18:43:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:32 INFO - '_': '/tools/buildbot/bin/python'} 18:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:33 INFO - Downloading/unpacking psutil>=0.7.1 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:43:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:35 INFO - Installing collected packages: psutil 18:43:35 INFO - Running setup.py install for psutil 18:43:35 INFO - building 'psutil._psutil_linux' extension 18:43: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 18:43: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 18:43:35 INFO - building 'psutil._psutil_posix' extension 18:43: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 18:43: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 18:43:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:36 INFO - Successfully installed psutil 18:43:36 INFO - Cleaning up... 18:43:36 INFO - Return code: 0 18:43:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:43:36 INFO - Using env: {'DISPLAY': ':0', 18:43:36 INFO - 'HOME': '/home/cltbld', 18:43:36 INFO - 'LANG': 'en_US.UTF-8', 18:43:36 INFO - 'LANGUAGE': 'en_US:en', 18:43:36 INFO - 'LOGNAME': 'cltbld', 18:43:36 INFO - 'MAIL': '/var/mail/cltbld', 18:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:36 INFO - 'MOZ_NO_REMOTE': '1', 18:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:36 INFO - 'NO_EM_RESTART': '1', 18:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:36 INFO - 'PWD': '/builds/slave/test', 18:43:36 INFO - 'SHELL': '/bin/bash', 18:43:36 INFO - 'SHLVL': '1', 18:43:36 INFO - 'TERM': 'linux', 18:43:36 INFO - 'TMOUT': '86400', 18:43:36 INFO - 'USER': 'cltbld', 18:43:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:36 INFO - '_': '/tools/buildbot/bin/python'} 18:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:43:38 INFO - Installing collected packages: mozsystemmonitor 18:43:38 INFO - Running setup.py install for mozsystemmonitor 18:43:38 INFO - Successfully installed mozsystemmonitor 18:43:38 INFO - Cleaning up... 18:43:38 INFO - Return code: 0 18:43:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43: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 18:43: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 18:43:38 INFO - Using env: {'DISPLAY': ':0', 18:43:38 INFO - 'HOME': '/home/cltbld', 18:43:38 INFO - 'LANG': 'en_US.UTF-8', 18:43:38 INFO - 'LANGUAGE': 'en_US:en', 18:43:38 INFO - 'LOGNAME': 'cltbld', 18:43:38 INFO - 'MAIL': '/var/mail/cltbld', 18:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:38 INFO - 'MOZ_NO_REMOTE': '1', 18:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:38 INFO - 'NO_EM_RESTART': '1', 18:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:38 INFO - 'PWD': '/builds/slave/test', 18:43:38 INFO - 'SHELL': '/bin/bash', 18:43:38 INFO - 'SHLVL': '1', 18:43:38 INFO - 'TERM': 'linux', 18:43:38 INFO - 'TMOUT': '86400', 18:43:38 INFO - 'USER': 'cltbld', 18:43:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:38 INFO - '_': '/tools/buildbot/bin/python'} 18:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:38 INFO - Downloading/unpacking blobuploader==1.2.4 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:40 INFO - Downloading blobuploader-1.2.4.tar.gz 18:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:43:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:43:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:41 INFO - Downloading docopt-0.6.1.tar.gz 18:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:43:41 INFO - Installing collected packages: blobuploader, requests, docopt 18:43:41 INFO - Running setup.py install for blobuploader 18:43:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:43:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:43:41 INFO - Running setup.py install for requests 18:43:41 INFO - Running setup.py install for docopt 18:43:41 INFO - Successfully installed blobuploader requests docopt 18:43:41 INFO - Cleaning up... 18:43:41 INFO - Return code: 0 18:43:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43: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 18:43: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 18:43:41 INFO - Using env: {'DISPLAY': ':0', 18:43:41 INFO - 'HOME': '/home/cltbld', 18:43:41 INFO - 'LANG': 'en_US.UTF-8', 18:43:41 INFO - 'LANGUAGE': 'en_US:en', 18:43:41 INFO - 'LOGNAME': 'cltbld', 18:43:41 INFO - 'MAIL': '/var/mail/cltbld', 18:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:41 INFO - 'MOZ_NO_REMOTE': '1', 18:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:41 INFO - 'NO_EM_RESTART': '1', 18:43:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:41 INFO - 'PWD': '/builds/slave/test', 18:43:41 INFO - 'SHELL': '/bin/bash', 18:43:41 INFO - 'SHLVL': '1', 18:43:41 INFO - 'TERM': 'linux', 18:43:41 INFO - 'TMOUT': '86400', 18:43:41 INFO - 'USER': 'cltbld', 18:43:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:41 INFO - '_': '/tools/buildbot/bin/python'} 18:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:42 INFO - Running setup.py (path:/tmp/pip-tsUINC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:42 INFO - Running setup.py (path:/tmp/pip-UOFknC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:42 INFO - Running setup.py (path:/tmp/pip-UsLliH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:42 INFO - Running setup.py (path:/tmp/pip-IoDaU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:42 INFO - Running setup.py (path:/tmp/pip-mKXKWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:42 INFO - Running setup.py (path:/tmp/pip-cdpnsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:42 INFO - Running setup.py (path:/tmp/pip-sGjhKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:42 INFO - Running setup.py (path:/tmp/pip-CR2HY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:42 INFO - Running setup.py (path:/tmp/pip-50wGmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:42 INFO - Running setup.py (path:/tmp/pip-W4ofCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:42 INFO - Running setup.py (path:/tmp/pip-jAqAv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:42 INFO - Running setup.py (path:/tmp/pip-IRlT_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:43 INFO - Running setup.py (path:/tmp/pip-h9_JpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:43 INFO - Running setup.py (path:/tmp/pip-n9VyK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:43 INFO - Running setup.py (path:/tmp/pip-HMBNuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:43 INFO - Running setup.py (path:/tmp/pip-fMEPQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:43 INFO - Running setup.py (path:/tmp/pip-moL6UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:43:43 INFO - Running setup.py install for manifestparser 18:43:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozcrash 18:43:43 INFO - Running setup.py install for mozdebug 18:43:43 INFO - Running setup.py install for mozdevice 18:43:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozfile 18:43:43 INFO - Running setup.py install for mozhttpd 18:43:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozinfo 18:43:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Running setup.py install for mozInstall 18:43:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Running setup.py install for mozleak 18:43:44 INFO - Running setup.py install for mozlog 18:43:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Running setup.py install for moznetwork 18:43:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Running setup.py install for mozprocess 18:43:44 INFO - Running setup.py install for mozprofile 18:43:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Running setup.py install for mozrunner 18:43:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Running setup.py install for mozscreenshot 18:43:44 INFO - Running setup.py install for moztest 18:43:45 INFO - Running setup.py install for mozversion 18:43:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:43:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:43:45 INFO - Cleaning up... 18:43:45 INFO - Return code: 0 18:43:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:45 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')]} 18:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:45 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')]} 18:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:45 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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43:45 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 18:43:45 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 18:43:45 INFO - Using env: {'DISPLAY': ':0', 18:43:45 INFO - 'HOME': '/home/cltbld', 18:43:45 INFO - 'LANG': 'en_US.UTF-8', 18:43:45 INFO - 'LANGUAGE': 'en_US:en', 18:43:45 INFO - 'LOGNAME': 'cltbld', 18:43:45 INFO - 'MAIL': '/var/mail/cltbld', 18:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:45 INFO - 'MOZ_NO_REMOTE': '1', 18:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:45 INFO - 'NO_EM_RESTART': '1', 18:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:45 INFO - 'PWD': '/builds/slave/test', 18:43:45 INFO - 'SHELL': '/bin/bash', 18:43:45 INFO - 'SHLVL': '1', 18:43:45 INFO - 'TERM': 'linux', 18:43:45 INFO - 'TMOUT': '86400', 18:43:45 INFO - 'USER': 'cltbld', 18:43:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:45 INFO - '_': '/tools/buildbot/bin/python'} 18:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:45 INFO - Running setup.py (path:/tmp/pip-ZftaKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:45 INFO - Running setup.py (path:/tmp/pip-US3tMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:45 INFO - Running setup.py (path:/tmp/pip-K4Etpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:45 INFO - Running setup.py (path:/tmp/pip-xA5tDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:45 INFO - Running setup.py (path:/tmp/pip-xeAd4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:45 INFO - Running setup.py (path:/tmp/pip-QIDfO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:45 INFO - Running setup.py (path:/tmp/pip-7Qu91B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:45 INFO - Running setup.py (path:/tmp/pip-fE9qDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43: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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:45 INFO - Running setup.py (path:/tmp/pip-3VfZ8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:46 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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:46 INFO - Running setup.py (path:/tmp/pip-0imaWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:46 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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:46 INFO - Running setup.py (path:/tmp/pip-XQkZ4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:46 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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:46 INFO - Running setup.py (path:/tmp/pip-2EA_LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:46 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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:46 INFO - Running setup.py (path:/tmp/pip-9zaIdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:46 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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:46 INFO - Running setup.py (path:/tmp/pip-HrjRQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:46 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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:46 INFO - Running setup.py (path:/tmp/pip-7XU_vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43: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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:46 INFO - Running setup.py (path:/tmp/pip-CKxK78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43: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)) 18:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:46 INFO - Running setup.py (path:/tmp/pip-fMnc6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43: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)) 18:43: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)) 18:43: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)) 18:43: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)) 18:43: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)) 18:43: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)) 18:43:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:48 INFO - Downloading blessings-1.6.tar.gz 18:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:43:48 INFO - Installing collected packages: blessings 18:43:48 INFO - Running setup.py install for blessings 18:43:48 INFO - Successfully installed blessings 18:43:48 INFO - Cleaning up... 18:43:48 INFO - Return code: 0 18:43:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:48 INFO - Reading from file tmpfile_stdout 18:43:48 INFO - Current package versions: 18:43:48 INFO - argparse == 1.2.1 18:43:48 INFO - blessings == 1.6 18:43:48 INFO - blobuploader == 1.2.4 18:43:48 INFO - docopt == 0.6.1 18:43:48 INFO - manifestparser == 1.1 18:43:48 INFO - mozInstall == 1.12 18:43:48 INFO - mozcrash == 0.17 18:43:48 INFO - mozdebug == 0.1 18:43:48 INFO - mozdevice == 0.48 18:43:48 INFO - mozfile == 1.2 18:43:48 INFO - mozhttpd == 0.7 18:43:48 INFO - mozinfo == 0.9 18:43:48 INFO - mozleak == 0.1 18:43:48 INFO - mozlog == 3.1 18:43:48 INFO - moznetwork == 0.27 18:43:48 INFO - mozprocess == 0.22 18:43:48 INFO - mozprofile == 0.28 18:43:48 INFO - mozrunner == 6.11 18:43:48 INFO - mozscreenshot == 0.1 18:43:48 INFO - mozsystemmonitor == 0.0 18:43:48 INFO - moztest == 0.7 18:43:48 INFO - mozversion == 1.4 18:43:48 INFO - psutil == 3.1.1 18:43:48 INFO - requests == 1.2.3 18:43:48 INFO - wsgiref == 0.1.2 18:43:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43: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 18:43: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 18:43:48 INFO - Using env: {'DISPLAY': ':0', 18:43:48 INFO - 'HOME': '/home/cltbld', 18:43:48 INFO - 'LANG': 'en_US.UTF-8', 18:43:48 INFO - 'LANGUAGE': 'en_US:en', 18:43:48 INFO - 'LOGNAME': 'cltbld', 18:43:48 INFO - 'MAIL': '/var/mail/cltbld', 18:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:48 INFO - 'MOZ_NO_REMOTE': '1', 18:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:48 INFO - 'NO_EM_RESTART': '1', 18:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:48 INFO - 'PWD': '/builds/slave/test', 18:43:48 INFO - 'SHELL': '/bin/bash', 18:43:48 INFO - 'SHLVL': '1', 18:43:48 INFO - 'TERM': 'linux', 18:43:48 INFO - 'TMOUT': '86400', 18:43:48 INFO - 'USER': 'cltbld', 18:43:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:48 INFO - '_': '/tools/buildbot/bin/python'} 18:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 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)) 18:43:49 INFO - Cleaning up... 18:43:49 INFO - Return code: 0 18:43:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:43:49 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')]} 18:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:49 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')]} 18:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:49 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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43:49 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 18:43:49 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 18:43:49 INFO - Using env: {'DISPLAY': ':0', 18:43:49 INFO - 'HOME': '/home/cltbld', 18:43:49 INFO - 'LANG': 'en_US.UTF-8', 18:43:49 INFO - 'LANGUAGE': 'en_US:en', 18:43:49 INFO - 'LOGNAME': 'cltbld', 18:43:49 INFO - 'MAIL': '/var/mail/cltbld', 18:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:49 INFO - 'MOZ_NO_REMOTE': '1', 18:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:49 INFO - 'NO_EM_RESTART': '1', 18:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:49 INFO - 'PWD': '/builds/slave/test', 18:43:49 INFO - 'SHELL': '/bin/bash', 18:43:49 INFO - 'SHLVL': '1', 18:43:49 INFO - 'TERM': 'linux', 18:43:49 INFO - 'TMOUT': '86400', 18:43:49 INFO - 'USER': 'cltbld', 18:43:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:49 INFO - '_': '/tools/buildbot/bin/python'} 18:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:49 INFO - Downloading/unpacking jsonschema 18:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:43:51 INFO - Downloading/unpacking functools32 (from jsonschema) 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:51 INFO - Downloading functools32-3.2.3-2.tar.gz 18:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:43:51 INFO - warning: no files found matching '*.txt' 18:43:51 INFO - no previously-included directories found matching 'build' 18:43:51 INFO - no previously-included directories found matching 'dist' 18:43:51 INFO - no previously-included directories found matching '.git*' 18:43:51 INFO - Installing collected packages: jsonschema, functools32 18:43:51 INFO - Running setup.py install for functools32 18:43:51 INFO - warning: no files found matching '*.txt' 18:43:51 INFO - no previously-included directories found matching 'build' 18:43:51 INFO - no previously-included directories found matching 'dist' 18:43:51 INFO - no previously-included directories found matching '.git*' 18:43:51 INFO - Successfully installed jsonschema functools32 18:43:51 INFO - Cleaning up... 18:43:51 INFO - Return code: 0 18:43:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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 0x7f51ebe2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', '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 18:43: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 18:43: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 18:43:51 INFO - Using env: {'DISPLAY': ':0', 18:43:51 INFO - 'HOME': '/home/cltbld', 18:43:51 INFO - 'LANG': 'en_US.UTF-8', 18:43:51 INFO - 'LANGUAGE': 'en_US:en', 18:43:51 INFO - 'LOGNAME': 'cltbld', 18:43:51 INFO - 'MAIL': '/var/mail/cltbld', 18:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:51 INFO - 'MOZ_NO_REMOTE': '1', 18:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:51 INFO - 'NO_EM_RESTART': '1', 18:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:51 INFO - 'PWD': '/builds/slave/test', 18:43:51 INFO - 'SHELL': '/bin/bash', 18:43:51 INFO - 'SHLVL': '1', 18:43:51 INFO - 'TERM': 'linux', 18:43:51 INFO - 'TMOUT': '86400', 18:43:51 INFO - 'USER': 'cltbld', 18:43:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:51 INFO - '_': '/tools/buildbot/bin/python'} 18:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:51 INFO - Downloading/unpacking flake8 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:43:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:43:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:43:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:43:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:43:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:43:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:43:54 INFO - no previously-included directories found matching 'docs/_build' 18:43:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:43:54 INFO - Running setup.py install for pep8 18:43:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:43:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:43:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:43:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:43:54 INFO - no previously-included directories found matching 'docs/_build' 18:43:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:43:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:43:54 INFO - Cleaning up... 18:43:54 INFO - Return code: 0 18:43:54 INFO - Running post-action listener: _resource_record_post_action 18:43:54 INFO - Running post-action listener: _start_resource_monitoring 18:43:54 INFO - Starting resource monitoring. 18:43:54 INFO - ##### 18:43:54 INFO - ##### Running install step. 18:43:54 INFO - ##### 18:43:54 INFO - Running pre-action listener: _resource_record_pre_action 18:43:54 INFO - Running main action method: install 18:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:55 INFO - Reading from file tmpfile_stdout 18:43:55 INFO - Detecting whether we're running mozinstall >=1.0... 18:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:43:55 INFO - Reading from file tmpfile_stdout 18:43:55 INFO - Output received: 18:43:55 INFO - Usage: mozinstall [options] installer 18:43:55 INFO - Options: 18:43:55 INFO - -h, --help show this help message and exit 18:43:55 INFO - -d DEST, --destination=DEST 18:43:55 INFO - Directory to install application into. [default: 18:43:55 INFO - "/builds/slave/test"] 18:43:55 INFO - --app=APP Application being installed. [default: firefox] 18:43:55 INFO - mkdir: /builds/slave/test/build/application 18:43:55 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'] 18:43:55 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 18:44:08 INFO - Reading from file tmpfile_stdout 18:44:08 INFO - Output received: 18:44:08 INFO - /builds/slave/test/build/application/firefox/firefox 18:44:08 INFO - Running post-action listener: _resource_record_post_action 18:44:08 INFO - ##### 18:44:08 INFO - ##### Running run-tests step. 18:44:08 INFO - ##### 18:44:08 INFO - Running pre-action listener: _resource_record_pre_action 18:44:08 INFO - Running main action method: run_tests 18:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:44:08 INFO - Python 2.7.3 18:44:08 INFO - Return code: 0 18:44:08 INFO - grabbing minidump binary from tooltool 18:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:08 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 0x2d09410>, '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 0x2d0a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:44:08 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 18:44:08 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 18:44:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:44:08 INFO - Return code: 0 18:44:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:44:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:44:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:44:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:44:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:44:09 INFO - Return code: 0 18:44:09 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/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 18:44:09 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/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 18:44:09 INFO - Using env: {'DISPLAY': ':0', 18:44:09 INFO - 'HOME': '/home/cltbld', 18:44:09 INFO - 'LANG': 'en_US.UTF-8', 18:44:09 INFO - 'LANGUAGE': 'en_US:en', 18:44:09 INFO - 'LOGNAME': 'cltbld', 18:44:09 INFO - 'MAIL': '/var/mail/cltbld', 18:44:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:44:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:09 INFO - 'MOZ_NO_REMOTE': '1', 18:44:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:09 INFO - 'NO_EM_RESTART': '1', 18:44:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:09 INFO - 'PWD': '/builds/slave/test', 18:44:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:44:09 INFO - 'SHELL': '/bin/bash', 18:44:09 INFO - 'SHLVL': '1', 18:44:09 INFO - 'TERM': 'linux', 18:44:09 INFO - 'TMOUT': '86400', 18:44:09 INFO - 'USER': 'cltbld', 18:44:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640', 18:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:09 INFO - '_': '/tools/buildbot/bin/python'} 18:44:09 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/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 18:44:09 INFO - mozversion application_buildid: 20160623153657 18:44:09 INFO - mozversion application_changeset: b449af6b87414aa2ed035aaaa5043642e9a4ac06 18:44:09 INFO - mozversion application_display_name: Firefox 18:44:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:44:09 INFO - mozversion application_name: Firefox 18:44:09 INFO - mozversion application_remotingname: firefox 18:44:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:44:09 INFO - mozversion application_vendor: Mozilla 18:44:09 INFO - mozversion application_version: 48.0 18:44:09 INFO - mozversion platform_buildid: 20160623153657 18:44:09 INFO - mozversion platform_changeset: b449af6b87414aa2ed035aaaa5043642e9a4ac06 18:44:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:44:09 INFO - mozversion platform_version: 48.0 18:44:09 INFO - using testdate: 1466732649 18:44:09 INFO - actual date: 1466732649 18:44:09 INFO - starting webserver on 'localhost:42378' 18:44:09 INFO - SUITE-START | Running 2 tests 18:44:09 INFO - TEST-START | dromaeo_css 18:44:09 INFO - operating with platform_type : linux_ 18:44:09 INFO - Initialising browser for dromaeo_css test... 18:44:09 INFO - TEST-INFO | started process 7108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0B_cwl/profile http://localhost:42378/getInfo.html) 18:44:13 INFO - PROCESS | 7108 | 18:44:13 INFO - PROCESS | 7108 | (process:7187): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:44:14 INFO - PROCESS | 7108 | __metrics Screen width/height:1600/1200 18:44:14 INFO - PROCESS | 7108 | colorDepth:24 18:44:14 INFO - PROCESS | 7108 | Browser inner width/height: 1024/697 18:44:14 INFO - PROCESS | 7108 | __metrics 18:44:15 ERROR - PROCESS | 7108 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 18:44:15 INFO - TEST-INFO | 7108: exit 0 18:44:15 INFO - Browser initialized. 18:44:15 INFO - Running cycle 1/1 for dromaeo_css test... 18:44:15 INFO - TEST-INFO | started process 7237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0B_cwl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:17 INFO - PROCESS | 7237 | 18:44:17 INFO - PROCESS | 7237 | (process:7306): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:44:27 INFO - PROCESS | 7237 | RSS: Main: 150802432 18:44:27 INFO - PROCESS | 7237 | 18:45:17 INFO - PROCESS | 7237 | 1466732717302 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] 18:47:24 INFO - PROCESS | 7237 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42378/tests/dromaeo/cssquery-ext.html) 18:47:25 INFO - PROCESS | 7237 | RSS: Main: 154386432 18:47:25 INFO - PROCESS | 7237 | 18:50:27 INFO - PROCESS | 7237 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-ext.html (next: http://localhost:42378/tests/dromaeo/cssquery-jquery.html) 18:50:28 INFO - PROCESS | 7237 | RSS: Main: 152444928 18:50:28 INFO - PROCESS | 7237 | 18:53:30 INFO - PROCESS | 7237 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42378/tests/dromaeo/cssquery-mootools.html) 18:53:30 INFO - PROCESS | 7237 | RSS: Main: 152567808 18:53:30 INFO - PROCESS | 7237 | 18:56:32 INFO - PROCESS | 7237 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42378/tests/dromaeo/cssquery-prototype.html) 18:56:32 INFO - PROCESS | 7237 | RSS: Main: 153153536 18:56:32 INFO - PROCESS | 7237 | 18:59:35 INFO - PROCESS | 7237 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42378/tests/dromaeo/cssquery-yui.html) 18:59:35 INFO - PROCESS | 7237 | RSS: Main: 152182784 18:59:35 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | Cycle 1(1): loaded http://localhost:42378/tests/dromaeo/cssquery-yui.html (next: http://localhost:42378/tests/dromaeo/cssquery-dojo.html) 19:02:38 INFO - PROCESS | 7237 | RSS: Main: 156045312 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | __start_tp_report 19:02:38 INFO - PROCESS | 7237 | _x_x_mozilla_page_load 19:02:38 INFO - PROCESS | 7237 | _x_x_mozilla_page_load_details 19:02:38 INFO - PROCESS | 7237 | |i|pagename|runs| 19:02:38 INFO - PROCESS | 7237 | |0;dojo.html;3324.335132973405;3357.4963755436697;3366.4108780963334;3384.779989300697;3401.7448691348154;5733.369329373771;5766.250387449626;5789.131630255464;5810.448007439291;5818.854528636781;5754.568407369443;5787.739551720172;5792.768289268435;5793.449622285887;5799.623024503404;5197.506236907507;5241.816536421226;5288.8413347599635;5305.098133317326;5334.066538355792;5165.328507294046;5218.034663587229;5385.165299378583;5391.514763671269;5393.541548968323;5205.947940520603;5259.053370393328;5290.1006828839;5313.096773548486;5313.096773548486;5211.270422140903;5249.790008399659;5279;5290.814821481268;5312.256284120226;4987.800487980477;5030;5202.76587553561;5216.426193118754;5244.082285600005;5563;5593.021221286299;5626.493615574577;5655.179998900177;5699.373068962411;6122.173506576644;6161.507079433634;6166.105914642397;6166.814995550096;6180.721867515973;5975.820725378246;6073.939260607382;6140.785072522485;6238.064290356483;6242.250929888397;5824.446677565625;5825.533957283407;5827.067669172954;5833.474987251126;5840.561957853178;6356.332585078592;6361;6362.936370636235;6364.968175159187;6371.267304259976;5839.474447299764;5879.323877754027;5902.055671092605;5927.288725352985;6093.146959425684;6083.817485475354;6087.208662873798;6102.847428814315;6104.145419641254;6109.236345456818;5983.820485385445;6029.487493563096;6075.088736689444;6076.361981991916;6091.939080609137;5885.529157667376;6008.729607167688;6113.597930965863;6133.946794548733;6134.344744984476;4637.675362724577;4664.253719404879;4665.883352916137;4681.555252251031;4688.578027977498;4098.118904435561;4167.8958026049595;4173.874783756492;4183.581641835792;4195.49654041517;5700.144978253295;5735.684537350402;5863.2670916135485;5920.763169473259;5963.910541341883;6217.129601855744;6220.626762394271;6230.034344676583;6237.09562113491;6237.781677641261;5748.281464816898;5881.088431293157;5900.557458190653;5917.615355001911;5942.940570594325;5297.947020529822;5322.946770532245;5325.920111198335;5345.732713364394;5360.276362690986;6449.226092868886;6466.967665161644;6470.158879345655;6474.482041436674;6497.902531462032;6117.724702388314;6137.285055221507;6175.783847565403;6177.660228687286;6189.071639254148;6406.5515413920575;6477.578957367756;6482.708278127401;6485.675716214265;6490;5996.700164991646;6055.1220073090035;6064.514838812973;6065.059915713072;6072.05883088122;5977.731002104829;6048.60684055535;6144;6175.6912154393;6196.845078873064;5917.053271476543;5986.640801551746;5993.820185394445;6005.669688167192;6020.729067191899;5904.0553511437965;5915.112733090071;5929.940700593112;5942.168096466412;5959.553033522589;5659.688717120598;5789.218455508452;5855;5872.295324560909;5901.3213480448585;5992.370801065999;6081.179040829608;6085.300190478151;6085.4523092921845;6085.995810691186;5872.119182122716;5930.258717660293;5944.078667806497;5962.07587823888;5972.701364931823 19:02:38 INFO - PROCESS | 7237 | |1;ext.html;651.5927545284197;676.80034389855;684.8801459744543;728.5737843361633;729.715410989714;31819.840900795494;32731.345373092554;39731.60268397311;39986.200275994466;40241.19517609646;42182.156356872845;42603.78698106505;42629.78685106578;42692.57307426925;42745.78627106868;8935.731928042153;9075.41009834362;9083.182513573776;9092.045335239804;9105.863412048791;8949.552522373888;9031.142041506046;9075.410098343587;9076.591553380114;9078.409903356294;9203.17171454569;9265.258779297674;9277.768055798626;9302;9304.209142222886;9205.033471485465;9254.768630784218;9261.861072083924;9266.258699304039;9270.165685088374;9089.318301127376;9173.08269173084;9207.355485116044;9251.76870578241;9260.814783704356;42713.57286427127;43201;43265.78367108176;43539;43628.345574816405;3605.4952306677087;3727.6645101940953;3757.3612485877466;3900.9272450076173;4280.229558679468;32073.839630801696;32642.6735732642;32895.506567401266;34387.82806085954;34871.30257394838;4193.454850869368;4219.303814870543;4227.698715723714;4311.1593239318345;4343.283358245917;304869;305708;306890;309809;310009.99999999773;39645.40531892024;40581.59418405778;64650.35349646537;64952.67523662446;65061.349386506474;37849.053773655876;37869.621303787164;37976.8101159498;37980.24039519194;38021.619783801805;17213;17389.043602601727;17413.825861741472;17431.912840435718;17437.7384339235;13364.2649654268;13449.462021519226;13458.125221860744;13472.528461503996;13509.66225844342;9248.630054797733;9286.767830804283;9347.298952578583;9347.298952578583;9355.25157987373;3671.4676371926457;3690.8892733218045;3750.9437358439645;3763.6800871926193;3776.8489260429824;1144.6680462665734;1188.928664280146;1192.284629222477;1239.3741160713962;1239.5599562155305;32734;33089.50365744516;33307.16732081669;33551.32897342039;34439.31121377558;1210.9455074521668;1235.765204611121;1259.8614152443224;1262.1228246368685;1284.537566476068;16413.42553010639;17237.913810431117;17310.307587696352;17316.480505584852;17436.302547898194;448464;561467;564044;566050;568774;59170;60035.69982150061;60161.69919150464;60235.397646023855;60494.697526512966;1548.07115730563;1588.658438435765;1598.5364244369234;1602.8557429831371;1614.0315810513832;32589;34234.31531369408;34917.650823492455;34945;34992.47511287282;56872;57783.71108144432;57841.710791445774;57871.4212857866;58329.12506312324;398176;403829;407553;409074;409381;46938.530614694784;47015.529844701116;47654.80862978453;47834.521654783006;48290.27564586464;50755.23867141922;51894.74052629713;52059.2191117126;52089.739551302;52800.73599632131;42073.579264206965;42459;42759.57240427556;42789.35815962825;43950;41396.58603414048;41578;41810;42631;43315;44767.55232447634;45195;45772.7711361441;47236.29145562751;48418.757906210245;41580;41655.58344416517;42653.14693706046;44267.33598995953;45022.77488612536;36252.4562131563;36786.26427471382;36800.63199368079;37110.6288937118;37207.81396093002 19:02:38 INFO - PROCESS | 7237 | |2;jquery.html;423.27831048063047;435.10802854148994;437.37892193085816;442.3520180471776;450.889532064644;18699.532511687197;18898;19521.804781952193;21480.140794368246;21547.892260538676;19102.14040368183;19612.94064123268;19874.304399346027;19934.302299419523;19934.50163745907;5371.140617501201;5574.358948720908;5585.441455854423;5592.6085174037835;5601.831945041656;5288.233206185101;5475.561955043587;5566.582506312023;5839.9124013139835;5991.670458124801;5963.3738457462;5963.671998040106;5977.133315669225;6022.698865056752;6031;5806.158107074471;5980.581359304829;5988.461038506555;6004.399560043982;6024.0662697282;5432.864178395532;5461.0716178249795;5461.2354270402175;5481.150421684645;5488.643238189545;13719.45122195111;23846.76153238463;24710.258692239262;24837.87581062101;24906;2365.3968238099174;2498.6002239641753;2529.380301826064;3041.9239519012203;3126.9218269543444;10287.89712102877;10395.32430392022;10566.260361774679;10642.840357394645;10784.676459706221;2017.5863947890648;2061.7732049474544;2097.9370618881458;2123.203798575534;2167.696522486853;78580;83428.58285708593;85773.57113214518;85842;86988.5650571743;11608.477618507188;11914.285142891455;11942.761144777229;11994.220375675553;12019.338936358585;16955.83044169567;17093;17208.65582688339;17209.053502057257;17245.741313880302;8299.792505187297;8722.433041852259;8763.649454021896;8771.122887711306;8907.73276801697;8418.368622353348;8422.905022347179;8429.32565394767;8459.111793261618;8543.871841922377;5164.1995490699;5197.948020519822;5201.505856943584;5227.242049902743;5231.372235331708;2114.3551216879;2119.311223852254;2149.10812013016;2202.2072054060527;2208.4699672078905;1001.3491230700104;1033.3180101133216;1057.154276578734;1091.6074591517877;1154.6882341767675;18988;19234.71147932782;19426.805731942783;19748.210071597263;20087.598248034956;1091.8143915534379;1097.2703152403562;1098.6047719396322;1137.2721458266717;1148.7989601819816;10881.455927203608;11106.278091924;11181.161412894066;11258.380789056517;11337.716557086138;517527;518189;520310;522520;546979;92040;92256.53871730732;96159.51920240354;96244;99589.50205249072;1112.1380929779486;1140.3044143072718;1172.5602898912907;1174.7356844709873;1195.9940200298943;17152.399666011628;17284.481465556055;17436.82563174352;17624.206910688794;17644.647107058045;36117.27765444624;38375.232495350494;40047.799761001006;40223.99440013906;40415;56728.71635641796;58750;58819.41180588139;59043.40956590379;59096.704516478865;8873.511956842436;8957.820843582962;9026.09042023517;9127.634894604142;9182.403143795633;13518.053736238762;13527.729445411234;13537.864621354054;13592.252426116658;13775.931120344334;11257.831132532854;11281.71795705114;11613.187076904873;11726.296422214695;11818.409079545816;11665.708357291136;11731.178817483036;11824.881751182722;11829.526818927146;12244.69388265265;11875.821862671894;12021.579244726392;12600.684982875502;12896.290704010995;12896.548620798227;9152.313576481658;9254.167124958785;9472.52637368115;9547.188488978236;9552.42685438876;12747.470303563632;12822.67943301425;12843.871561284268;12893.548725794552;13002.674933126747 19:02:38 INFO - PROCESS | 7237 | |3;mootools.html;1599.8240193578708;1601.8077830660322;1823.2798044772314;1919.9424017279487;1950.6586347389202;8444.408891377607;8615.913840861589;8632.56837158142;8692.391532592721;8833.95583022084;8744.606492707828;8791.516466594334;8819;8890;8895.510746908918;2500.5499010178114;2529.3929456930387;2529.7217306096313;2530.8101892358054;2532.1643857527065;2480.7891329237036;2567.4351642638685;2572;2581.8838152283097;2583.8062145339177;2414.4929564791414;2428.86641234732;2486.2292689266296;2487.7263501014872;2487.9129230476847;2498.375406148463;2498.837575557583;2508.234988328559;2530.2788705218923;2532.4428625702317;2537.936551586207;2542.5931850903767;2544.122277814151;2564.794816414701;2602.531544322021;8880.8667869982;8898.154675305836;8923.553822308859;8930.821383572293;8945.552722363856;5593.105103183511;5661.60368774186;5678.0915053591225;5715.514181294595;5720.485156335908;3302.2239773653173;3351.7151042161445;3441.380551500729;3660.1764602964386;3686.4838922550866;1082.118073769875;1130.8860772139435;1138.6640940922448;1149.5459293579072;1187.6733898177984;11885.108616853771;11953;12013.699657508545;12040.337781422106;12059.819102713467;4592.3800286961505;4686.882827929329;4690.906181876343;4693.413323334583;4745.7423782697615;9602.567884445216;9663.758406039764;9673.951630241803;9677.467739274267;9694.563744631509;5472.20653005312;5476.616636835383;5512.200730893998;5515.669059856422;5523.7238138092935;5069.7465126744255;5145.176771716508;5232.450592687789;5238.057149713012;5250.7637156328055;4024.959750402517;4059.2287465381482;4071.491063617048;4087.97956010224;4173.000685564393;1239.4050855589367;1256.7360854220533;1257.044646068994;1263.696712788924;1297.3707751740399;875.4790899414838;926.9953650231706;995.1988649137514;1032.8192566300868;1036.3315661398506;6110.7250173741395;6174.135621013062;6233.376662333731;6248.562600617913;6260.686965651699;478.4545617995488;481.04032455251996;485.9368282123301;493.331535769035;498.5787009976564;3938.330483817758;4054.3310353791885;4074.0425999890003;4076.1236334188293;4101.446304748881;10660.307080039773;11067.280626759235;11135.220534562664;11154;11177.944110279397;10920.945395272973;10937.781244375226;10964;10984.890151098387;11019.283746556448;7983.2415920487465;8179.509229446371;8180.141085186089;8193.426460147852;8280.171982801672;5510.669359838423;5763.193152958673;5812.94187058124;5881.529477641693;5887.470127688529;9075.27397808187;9428.764280893032;9432.151106400457;9635.903640963781;9677.564509597225;9480.288978326515;9633.277504187354;9735.02649735049;9739.756506087404;9745.366551174151;7643.541387516544;7875;7898.605069746375;8023.6790528378215;8163.83672326562;8341.708040218564;8345.874811877948;8378.078411374865;8401.915980840113;8406.579671016303;7618.657160427683;7701;7703.460757746904;7866.174051724715;7913.881291780743;7475.252474752481;7546;7562.584057876869;7582.279683430065;7701.4608977371045;7148.606826624377;7153.713851446092;7167.211606723361;7197.784066478014;7206.4234861209925;5165.483451654804;5195.480451954774;5257.921131183112;5288.524032837063;5342.43904390049;5296.549793267615;5332.5467335276935;5390.541803946709;5411.972940135274;5432.837014889402 19:02:38 INFO - PROCESS | 7237 | |4;prototype.html;363.7290218787004;365.16559661174205;366.58575809335446;369.4495202148797;370.6849178198532;6390.4887608991285;6391.073294372313;6426.453751431128;6440.871182576358;6453.709583068761;6381.712822922968;6391.584547004441;6395.840103997402;6410.102585638015;6413.038044293358;4609.953900460994;4745.335653008581;4886.315915771795;4896.46138924718;4901.117798796233;4862.197737373329;4871.318015477836;4885.462599114095;4890.73100979446;4902.926456103161;4871.025794841046;4882.292067650189;4889.633277504184;4900.264960255954;4901.681390709592;4892.608591312686;4895.31465594817;4899.681520701143;4902.779374928119;4928.901421971541;4321.178975994551;4326.0266440051055;4331.133773245332;4332.328489084197;4334.45819272591;6095.207623008981;6119.357467465941;6183;6206.813795586139;6215.720292586844;5690.516306113986;5724.427557244284;5728.054870946289;5730.914036289459;5732.31212254528;6688.163979502562;6732.427743641796;6782.8304292392595;6814.386705196556;6826.488013399015;4781.426228852525;4786.736729479877;4787.066522028206;4793.257045158006;4807.855764327076;7057.258987806258;7070.469714771361;7077.3984211342095;7082.610456424894;7088.999999999948;4598.287265473857;4732.503087175865;4783.378160839138;4805.1590971579835;4915.508449155127;4834.854954351375;4856.271559266138;4861.1006963711825;4864.927026094611;4876.512348765095;5619.719014049281;5629.690367029771;5634.774609015675;5637.633553818989;5642.520385767174;6835.418989385858;6849.863002739918;6852.794416167523;6872.553284036521;6930.341617546325;1691.9492415227562;1722.956926076858;1724.5085150731982;1725.387487441965;1726.2749645149067;1083.978320433587;1115.6764538283808;1133.4106264742288;1135.28477059452;1149.2472430557998;6666.266710661824;6682.365175308338;6692.163479565054;6700.262971073178;6723.327667233238;6991.23096459389;7044.859102818017;7053.083099197174;7059.682314295869;7066.116735408074;6747.628880411527;6754.12196414463;6755.324467553303;6760.628165450948;6761.4590832733265;3792.6586607205486;3809.8857034289017;3817;3828.310904037244;3831.7509361891944;7422.591757453284;7443.069616297963;7444.962775186089;7445.069366329209;7448.702051917971;7010.964945175241;7238.420926325882;7272.890906636405;7273.345398914017;7275.89086163708;7349.081364829396;7355.889661655079;7362.631868406558;7459.888101678479;7462.850742985219;7087.751928682472;7110.431165506644;7119.9644001781735;7139.678714457966;7152.570845749064;7009.9649501752165;7011.123609548807;7014.68433920485;7015.298470152944;7016.929830701628;7338.70645174187;7427.368673662583;7475.925240747523;7493.138289096823;7497.9250207497225;4785.330053792542;4807.399075115611;4832.1543729846435;4834.081524510332;4848.32123502717;7100.254473280231;7104.467164962752;7108.822279443055;7111;7135.036770035978;6825.55633883796;6827.419669328163;6845.178578570603;6848.417884479676;6856.4514838813775;6647.434968027578;6732.663366831737;6734;6755.121834161528;6764.8985265222045;6687.732490700318;6709.530332876652;6710.66446677674;6712.194536655437;6712.865742685217;6916.827079323057;6928.792136235921;6940.826479338057;6949.791506254821;6954.582725036514;6744.865102698017;6763.93236067633;6766.05275261454;6776.7628133015105;6785.423239024541 19:02:38 INFO - PROCESS | 7237 | |5;yui.html;800.6837299266788;817.3052905030723;845.4082142500251;847.8558645030348;871.2811930157621;13914.652133696663;14234.857651423483;14295.714085718279;14355.210463424508;14370.712585748292;12892.80660790089;12903.290319032449;12908.096433249677;12927.806082908764;12937.288449135294;903.4669544968484;944.4805357053593;944.527736131934;946.1106559833735;947.6162154327509;943.8442656961593;944.3531181140906;946.9384490008161;948.0993056596227;948.6869333120088;982.990170098297;983.1201075037836;985.6106837799065;990.3414229537349;991.6529214774844;973.9756506087334;977.6773664690635;978.681928373278;982.6855406269997;984.5717113055844;720.0603212807284;720.6396801599201;721.6896734404204;723.95656260624;724.7789424225609;14555.199464029474;14589.124652520777;14595.41618335276;14598.34307456167;14639.780403293958;12389;12684;12691.365431728376;12772.872271277261;13051;10530.157587393067;10663.626773062906;10684.305520141166;11479.540818367339;11496.712582185428;3527.188746588299;3534.9116272093147;3577.5170352002406;3615.9700362593235;3703.4259689748133;60703.39296607021;60712;61889;62111;62362;10058.29591928558;10063.798724025479;10555.894441055645;10573.894261057445;11287.943560282147;18973.90513047426;19019.714704279446;19109.426717198505;19121.61756764857;19216.231350746093;7652.234776522303;7687.192844751333;7727.806804829812;7855.528668279807;8134.064582572962;4504;4512;4551.908961820745;4576.473705523841;4672.182368085571;3529.1000794797164;3576.0523461282783;3595.0832537702718;3596.82015899204;3605.7115430765475;673.7338751193349;682.7849227493324;703.711478293897;728.2680905689748;734.8787450070679;620.9379062093844;678.6776281266458;697.769735987123;728.8068661804626;796.2276591706036;8980.55097245135;10023.799524009624;10117.949410252902;10295.07344339013;10458.529366178387;642.5791106825037;645.3739872323838;653.7581094994787;723.6273319240595;725.4377857160637;4387.363832244307;4483.14820184164;4483.170613436525;4506.324051392317;4623.4451865775645;66753;67627.32372676309;67864.6606766963;68178;68352.6582367095;58019.709901450224;59005.40994589999;59537.70231148817;59703.70148149232;59915;51733.482665172865;52389.214161787604;52557.737211313695;53619.73190134102;53633.463665363626;8933.106689331014;9005.819883602422;9011.143941325563;9031.774205644911;9047.773805654648;38113;38820;39162;39498.40752388774;39616.40575391314;46327;46548.06903861972;49617.751911240215;50353.74823125861;51060;10916.454177290945;10939.671809845717;11077.612283570037;11089.778204436028;11095.889041109485;12321.568745093879;12583.182093163916;12723.872761272269;12851.485940562272;12861.485540578646;11430.371329576954;11764.764704706029;11857.873502017295;11916.225445346025;12213;11470.139739519736;11739.589114381297;11872.76254474923;11980.820287695866;12295.07786915967;11796;11850.509491696432;11863.288202707865;11872.287662740264;12134.75730485403;9955.402675839472;10122.544485498023;10132.290739648153;10160.796784064425;10167.339122956984;9937.453440060866;10107.292489525662;10182.083612474913;10223.488825558543;10247.7438064049 19:02:38 INFO - PROCESS | 7237 | __end_tp_report 19:02:38 INFO - PROCESS | 7237 | __start_cc_report 19:02:38 INFO - PROCESS | 7237 | _x_x_mozilla_cycle_collect,334 19:02:38 INFO - PROCESS | 7237 | __end_cc_report 19:02:38 INFO - PROCESS | 7237 | __startTimestamp1466733758290__endTimestamp 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | ------- Summary: start ------- 19:02:38 INFO - PROCESS | 7237 | Number of tests: 6 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | [#0] dojo.html Cycles:165 Average:5713.50 Median:5915.11 stddev:648.74 (11.0%) stddev-sans-first:623.07 19:02:38 INFO - PROCESS | 7237 | Values: 3324.3 3357.5 3366.4 3384.8 3401.7 5733.4 5766.3 5789.1 5810.4 5818.9 5754.6 5787.7 5792.8 5793.4 5799.6 5197.5 5241.8 5288.8 5305.1 5334.1 5165.3 5218.0 5385.2 5391.5 5393.5 5205.9 5259.1 5290.1 5313.1 5313.1 5211.3 5249.8 5279.0 5290.8 5312.3 4987.8 5030.0 5202.8 5216.4 5244.1 5563.0 5593.0 5626.5 5655.2 5699.4 6122.2 6161.5 6166.1 6166.8 6180.7 5975.8 6073.9 6140.8 6238.1 6242.3 5824.4 5825.5 5827.1 5833.5 5840.6 6356.3 6361.0 6362.9 6365.0 6371.3 5839.5 5879.3 5902.1 5927.3 6093.1 6083.8 6087.2 6102.8 6104.1 6109.2 5983.8 6029.5 6075.1 6076.4 6091.9 5885.5 6008.7 6113.6 6133.9 6134.3 4637.7 4664.3 4665.9 4681.6 4688.6 4098.1 4167.9 4173.9 4183.6 4195.5 5700.1 5735.7 5863.3 5920.8 5963.9 6217.1 6220.6 6230.0 6237.1 6237.8 5748.3 5881.1 5900.6 5917.6 5942.9 5297.9 5322.9 5325.9 5345.7 5360.3 6449.2 6467.0 6470.2 6474.5 6497.9 6117.7 6137.3 6175.8 6177.7 6189.1 6406.6 6477.6 6482.7 6485.7 6490.0 5996.7 6055.1 6064.5 6065.1 6072.1 5977.7 6048.6 6144.0 6175.7 6196.8 5917.1 5986.6 5993.8 6005.7 6020.7 5904.1 5915.1 5929.9 5942.2 5959.6 5659.7 5789.2 5855.0 5872.3 5901.3 5992.4 6081.2 6085.3 6085.5 6086.0 5872.1 5930.3 5944.1 5962.1 5972.7 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | [#1] ext.html Cycles:180 Average:58878.47 Median:23343.35 stddev:113996.39 (488.3%) stddev-sans-first:114232.35 19:02:38 INFO - PROCESS | 7237 | Values: 651.6 676.8 684.9 728.6 729.7 31819.8 32731.3 39731.6 39986.2 40241.2 42182.2 42603.8 42629.8 42692.6 42745.8 8935.7 9075.4 9083.2 9092.0 9105.9 8949.6 9031.1 9075.4 9076.6 9078.4 9203.2 9265.3 9277.8 9302.0 9304.2 9205.0 9254.8 9261.9 9266.3 9270.2 9089.3 9173.1 9207.4 9251.8 9260.8 42713.6 43201.0 43265.8 43539.0 43628.3 3605.5 3727.7 3757.4 3900.9 4280.2 32073.8 32642.7 32895.5 34387.8 34871.3 4193.5 4219.3 4227.7 4311.2 4343.3 304869.0 305708.0 306890.0 309809.0 310010.0 39645.4 40581.6 64650.4 64952.7 65061.3 37849.1 37869.6 37976.8 37980.2 38021.6 17213.0 17389.0 17413.8 17431.9 17437.7 13364.3 13449.5 13458.1 13472.5 13509.7 9248.6 9286.8 9347.3 9347.3 9355.3 3671.5 3690.9 3750.9 3763.7 3776.8 1144.7 1188.9 1192.3 1239.4 1239.6 32734.0 33089.5 33307.2 33551.3 34439.3 1210.9 1235.8 1259.9 1262.1 1284.5 16413.4 17237.9 17310.3 17316.5 17436.3 448464.0 561467.0 564044.0 566050.0 568774.0 59170.0 60035.7 60161.7 60235.4 60494.7 1548.1 1588.7 1598.5 1602.9 1614.0 32589.0 34234.3 34917.7 34945.0 34992.5 56872.0 57783.7 57841.7 57871.4 58329.1 398176.0 403829.0 407553.0 409074.0 409381.0 46938.5 47015.5 47654.8 47834.5 48290.3 50755.2 51894.7 52059.2 52089.7 52800.7 42073.6 42459.0 42759.6 42789.4 43950.0 41396.6 41578.0 41810.0 42631.0 43315.0 44767.6 45195.0 45772.8 47236.3 48418.8 41580.0 41655.6 42653.1 44267.3 45022.8 36252.5 36786.3 36800.6 37110.6 37207.8 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | [#2] jquery.html Cycles:180 Average:30394.89 Median:2286.93 stddev:86471.71 (3781.1%) stddev-sans-first:86685.00 19:02:38 INFO - PROCESS | 7237 | Values: 423.3 435.1 437.4 442.4 450.9 18699.5 18898.0 19521.8 21480.1 21547.9 19102.1 19612.9 19874.3 19934.3 19934.5 5371.1 5574.4 5585.4 5592.6 5601.8 5288.2 5475.6 5566.6 5839.9 5991.7 5963.4 5963.7 5977.1 6022.7 6031.0 5806.2 5980.6 5988.5 6004.4 6024.1 5432.9 5461.1 5461.2 5481.2 5488.6 13719.5 23846.8 24710.3 24837.9 24906.0 2365.4 2498.6 2529.4 3041.9 3126.9 10287.9 10395.3 10566.3 10642.8 10784.7 2017.6 2061.8 2097.9 2123.2 2167.7 78580.0 83428.6 85773.6 85842.0 86988.6 11608.5 11914.3 11942.8 11994.2 12019.3 16955.8 17093.0 17208.7 17209.1 17245.7 8299.8 8722.4 8763.6 8771.1 8907.7 8418.4 8422.9 8429.3 8459.1 8543.9 5164.2 5197.9 5201.5 5227.2 5231.4 2114.4 2119.3 2149.1 2202.2 2208.5 1001.3 1033.3 1057.2 1091.6 1154.7 18988.0 19234.7 19426.8 19748.2 20087.6 1091.8 1097.3 1098.6 1137.3 1148.8 10881.5 11106.3 11181.2 11258.4 11337.7 517527.0 518189.0 520310.0 522520.0 546979.0 92040.0 92256.5 96159.5 96244.0 99589.5 1112.1 1140.3 1172.6 1174.7 1196.0 17152.4 17284.5 17436.8 17624.2 17644.6 36117.3 38375.2 40047.8 40224.0 40415.0 56728.7 58750.0 58819.4 59043.4 59096.7 8873.5 8957.8 9026.1 9127.6 9182.4 13518.1 13527.7 13537.9 13592.3 13775.9 11257.8 11281.7 11613.2 11726.3 11818.4 11665.7 11731.2 11824.9 11829.5 12244.7 11875.8 12021.6 12600.7 12896.3 12896.5 9152.3 9254.2 9472.5 9547.2 9552.4 12747.5 12822.7 12843.9 12893.5 13002.7 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | [#3] mootools.html Cycles:180 Average:5823.56 Median:5292.54 stddev:3197.01 (60.4%) stddev-sans-first:3190.22 19:02:38 INFO - PROCESS | 7237 | Values: 1599.8 1601.8 1823.3 1919.9 1950.7 8444.4 8615.9 8632.6 8692.4 8834.0 8744.6 8791.5 8819.0 8890.0 8895.5 2500.5 2529.4 2529.7 2530.8 2532.2 2480.8 2567.4 2572.0 2581.9 2583.8 2414.5 2428.9 2486.2 2487.7 2487.9 2498.4 2498.8 2508.2 2530.3 2532.4 2537.9 2542.6 2544.1 2564.8 2602.5 8880.9 8898.2 8923.6 8930.8 8945.6 5593.1 5661.6 5678.1 5715.5 5720.5 3302.2 3351.7 3441.4 3660.2 3686.5 1082.1 1130.9 1138.7 1149.5 1187.7 11885.1 11953.0 12013.7 12040.3 12059.8 4592.4 4686.9 4690.9 4693.4 4745.7 9602.6 9663.8 9674.0 9677.5 9694.6 5472.2 5476.6 5512.2 5515.7 5523.7 5069.7 5145.2 5232.5 5238.1 5250.8 4025.0 4059.2 4071.5 4088.0 4173.0 1239.4 1256.7 1257.0 1263.7 1297.4 875.5 927.0 995.2 1032.8 1036.3 6110.7 6174.1 6233.4 6248.6 6260.7 478.5 481.0 485.9 493.3 498.6 3938.3 4054.3 4074.0 4076.1 4101.4 10660.3 11067.3 11135.2 11154.0 11177.9 10920.9 10937.8 10964.0 10984.9 11019.3 7983.2 8179.5 8180.1 8193.4 8280.2 5510.7 5763.2 5812.9 5881.5 5887.5 9075.3 9428.8 9432.2 9635.9 9677.6 9480.3 9633.3 9735.0 9739.8 9745.4 7643.5 7875.0 7898.6 8023.7 8163.8 8341.7 8345.9 8378.1 8401.9 8406.6 7618.7 7701.0 7703.5 7866.2 7913.9 7475.3 7546.0 7562.6 7582.3 7701.5 7148.6 7153.7 7167.2 7197.8 7206.4 5165.5 5195.5 5257.9 5288.5 5342.4 5296.5 5332.5 5390.5 5412.0 5432.8 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | [#4] prototype.html Cycles:180 Average:5731.77 Median:6656.85 stddev:1746.41 (26.2%) stddev-sans-first:1704.20 19:02:38 INFO - PROCESS | 7237 | Values: 363.7 365.2 366.6 369.4 370.7 6390.5 6391.1 6426.5 6440.9 6453.7 6381.7 6391.6 6395.8 6410.1 6413.0 4610.0 4745.3 4886.3 4896.5 4901.1 4862.2 4871.3 4885.5 4890.7 4902.9 4871.0 4882.3 4889.6 4900.3 4901.7 4892.6 4895.3 4899.7 4902.8 4928.9 4321.2 4326.0 4331.1 4332.3 4334.5 6095.2 6119.4 6183.0 6206.8 6215.7 5690.5 5724.4 5728.1 5730.9 5732.3 6688.2 6732.4 6782.8 6814.4 6826.5 4781.4 4786.7 4787.1 4793.3 4807.9 7057.3 7070.5 7077.4 7082.6 7089.0 4598.3 4732.5 4783.4 4805.2 4915.5 4834.9 4856.3 4861.1 4864.9 4876.5 5619.7 5629.7 5634.8 5637.6 5642.5 6835.4 6849.9 6852.8 6872.6 6930.3 1691.9 1723.0 1724.5 1725.4 1726.3 1084.0 1115.7 1133.4 1135.3 1149.2 6666.3 6682.4 6692.2 6700.3 6723.3 6991.2 7044.9 7053.1 7059.7 7066.1 6747.6 6754.1 6755.3 6760.6 6761.5 3792.7 3809.9 3817.0 3828.3 3831.8 7422.6 7443.1 7445.0 7445.1 7448.7 7011.0 7238.4 7272.9 7273.3 7275.9 7349.1 7355.9 7362.6 7459.9 7462.9 7087.8 7110.4 7120.0 7139.7 7152.6 7010.0 7011.1 7014.7 7015.3 7016.9 7338.7 7427.4 7475.9 7493.1 7497.9 4785.3 4807.4 4832.2 4834.1 4848.3 7100.3 7104.5 7108.8 7111.0 7135.0 6825.6 6827.4 6845.2 6848.4 6856.5 6647.4 6732.7 6734.0 6755.1 6764.9 6687.7 6709.5 6710.7 6712.2 6712.9 6916.8 6928.8 6940.8 6949.8 6954.6 6744.9 6763.9 6766.1 6776.8 6785.4 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - PROCESS | 7237 | [#5] yui.html Cycles:180 Average:15396.03 Median:4505.16 stddev:18772.77 (416.7%) stddev-sans-first:18793.44 19:02:38 INFO - PROCESS | 7237 | Values: 800.7 817.3 845.4 847.9 871.3 13914.7 14234.9 14295.7 14355.2 14370.7 12892.8 12903.3 12908.1 12927.8 12937.3 903.5 944.5 944.5 946.1 947.6 943.8 944.4 946.9 948.1 948.7 983.0 983.1 985.6 990.3 991.7 974.0 977.7 978.7 982.7 984.6 720.1 720.6 721.7 724.0 724.8 14555.2 14589.1 14595.4 14598.3 14639.8 12389.0 12684.0 12691.4 12772.9 13051.0 10530.2 10663.6 10684.3 11479.5 11496.7 3527.2 3534.9 3577.5 3616.0 3703.4 60703.4 60712.0 61889.0 62111.0 62362.0 10058.3 10063.8 10555.9 10573.9 11287.9 18973.9 19019.7 19109.4 19121.6 19216.2 7652.2 7687.2 7727.8 7855.5 8134.1 4504.0 4512.0 4551.9 4576.5 4672.2 3529.1 3576.1 3595.1 3596.8 3605.7 673.7 682.8 703.7 728.3 734.9 620.9 678.7 697.8 728.8 796.2 8980.6 10023.8 10117.9 10295.1 10458.5 642.6 645.4 653.8 723.6 725.4 4387.4 4483.1 4483.2 4506.3 4623.4 66753.0 67627.3 67864.7 68178.0 68352.7 58019.7 59005.4 59537.7 59703.7 59915.0 51733.5 52389.2 52557.7 53619.7 53633.5 8933.1 9005.8 9011.1 9031.8 9047.8 38113.0 38820.0 39162.0 39498.4 39616.4 46327.0 46548.1 49617.8 50353.7 51060.0 10916.5 10939.7 11077.6 11089.8 11095.9 12321.6 12583.2 12723.9 12851.5 12861.5 11430.4 11764.8 11857.9 11916.2 12213.0 11470.1 11739.6 11872.8 11980.8 12295.1 11796.0 11850.5 11863.3 11872.3 12134.8 9955.4 10122.5 10132.3 10160.8 10167.3 9937.5 10107.3 10182.1 10223.5 10247.7 19:02:38 INFO - PROCESS | 7237 | -------- Summary: end -------- 19:02:38 INFO - PROCESS | 7237 | 19:02:38 INFO - TEST-INFO | 7237: exit 0 19:02:38 INFO - TEST-OK | dromaeo_css | took 1109479ms 19:02:38 INFO - TEST-START | kraken 19:02:38 INFO - operating with platform_type : linux_ 19:02:38 INFO - Initialising browser for kraken test... 19:02:38 INFO - TEST-INFO | started process 7479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXww_g/profile http://localhost:42378/getInfo.html) 19:02:42 INFO - PROCESS | 7479 | 19:02:42 INFO - PROCESS | 7479 | (process:7555): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:02:43 INFO - PROCESS | 7479 | __metrics Screen width/height:1600/1200 19:02:43 INFO - PROCESS | 7479 | colorDepth:24 19:02:43 INFO - PROCESS | 7479 | Browser inner width/height: 1024/697 19:02:43 INFO - PROCESS | 7479 | __metrics 19:02:44 ERROR - PROCESS | 7479 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:02:45 INFO - TEST-INFO | 7479: exit 0 19:02:45 INFO - Browser initialized. 19:02:45 INFO - Running cycle 1/1 for kraken test... 19:02:45 INFO - TEST-INFO | started process 7605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXww_g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:46 INFO - PROCESS | 7605 | 19:02:46 INFO - PROCESS | 7605 | (process:7672): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:02:56 INFO - PROCESS | 7605 | RSS: Main: 151019520 19:02:56 INFO - PROCESS | 7605 | 19:02:59 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-beat-detection) 19:03:00 INFO - PROCESS | 7605 | RSS: Main: 156299264 19:03:00 INFO - PROCESS | 7605 | 19:03:02 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-dft) 19:03:03 INFO - PROCESS | 7605 | RSS: Main: 156246016 19:03:03 INFO - PROCESS | 7605 | 19:03:06 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-fft) 19:03:06 INFO - PROCESS | 7605 | RSS: Main: 156463104 19:03:06 INFO - PROCESS | 7605 | 19:03:08 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42378/tests/kraken/driver.html?testName=audio-oscillator) 19:03:09 INFO - PROCESS | 7605 | RSS: Main: 156971008 19:03:09 INFO - PROCESS | 7605 | 19:03:11 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:03:12 INFO - PROCESS | 7605 | RSS: Main: 155840512 19:03:12 INFO - PROCESS | 7605 | 19:03:15 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42378/tests/kraken/driver.html?testName=imaging-darkroom) 19:03:16 INFO - PROCESS | 7605 | RSS: Main: 156921856 19:03:16 INFO - PROCESS | 7605 | 19:03:19 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42378/tests/kraken/driver.html?testName=imaging-desaturate) 19:03:20 INFO - PROCESS | 7605 | RSS: Main: 156741632 19:03:20 INFO - PROCESS | 7605 | 19:03:22 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42378/tests/kraken/driver.html?testName=json-parse-financial) 19:03:23 INFO - PROCESS | 7605 | RSS: Main: 156442624 19:03:23 INFO - PROCESS | 7605 | 19:03:24 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:03:25 INFO - PROCESS | 7605 | RSS: Main: 156057600 19:03:25 INFO - PROCESS | 7605 | 19:03:27 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:03:27 INFO - PROCESS | 7605 | RSS: Main: 156254208 19:03:27 INFO - PROCESS | 7605 | 19:03:29 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:03:30 INFO - PROCESS | 7605 | RSS: Main: 156647424 19:03:30 INFO - PROCESS | 7605 | 19:03:33 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:03:33 INFO - PROCESS | 7605 | RSS: Main: 157057024 19:03:33 INFO - PROCESS | 7605 | 19:03:36 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:03:36 INFO - PROCESS | 7605 | RSS: Main: 157052928 19:03:36 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | Cycle 1(1): loaded http://localhost:42378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42378/tests/kraken/driver.html?testName=ai-astar) 19:03:38 INFO - PROCESS | 7605 | RSS: Main: 158646272 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | __start_tp_report 19:03:38 INFO - PROCESS | 7605 | _x_x_mozilla_page_load 19:03:38 INFO - PROCESS | 7605 | _x_x_mozilla_page_load_details 19:03:38 INFO - PROCESS | 7605 | |i|pagename|runs| 19:03:38 INFO - PROCESS | 7605 | |0;ai-astar;108;113;103;108;110;114;99;109;111;110 19:03:38 INFO - PROCESS | 7605 | |1;audio-beat-detection;158;126;159;180;128;156;149;126;194;134 19:03:38 INFO - PROCESS | 7605 | |2;audio-dft;163;162;163;161;160;162;166;160;161;164 19:03:38 INFO - PROCESS | 7605 | |3;audio-fft;74;77;77;186;76;77;83;76;177;77 19:03:38 INFO - PROCESS | 7605 | |4;audio-oscillator;92;92;156;92;94;93;153;92;92;142 19:03:38 INFO - PROCESS | 7605 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;117;118 19:03:38 INFO - PROCESS | 7605 | |6;imaging-darkroom;147;148;147;146;147;147;146;146;146;146 19:03:38 INFO - PROCESS | 7605 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 19:03:38 INFO - PROCESS | 7605 | |8;json-parse-financial;54;56;56;54;57;61;56;79;56;55 19:03:38 INFO - PROCESS | 7605 | |9;json-stringify-tinderbox;60;61;60;60;60;60;64;59;59;64 19:03:38 INFO - PROCESS | 7605 | |10;stanford-crypto-aes;79;73;73;74;74;82;81;74;74;75 19:03:38 INFO - PROCESS | 7605 | |11;stanford-crypto-ccm;115;126;115;113;120;122;116;111;128;138 19:03:38 INFO - PROCESS | 7605 | |12;stanford-crypto-pbkdf2;157;160;159;164;164;158;161;163;160;158 19:03:38 INFO - PROCESS | 7605 | |13;stanford-crypto-sha256-iterative;70;68;67;65;68;65;65;64;68;66 19:03:38 INFO - PROCESS | 7605 | __end_tp_report 19:03:38 INFO - PROCESS | 7605 | __start_cc_report 19:03:38 INFO - PROCESS | 7605 | _x_x_mozilla_cycle_collect,834 19:03:38 INFO - PROCESS | 7605 | __end_cc_report 19:03:38 INFO - PROCESS | 7605 | __startTimestamp1466733818906__endTimestamp 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | ------- Summary: start ------- 19:03:38 INFO - PROCESS | 7605 | Number of tests: 14 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:4.50 (4.1%) stddev-sans-first:4.77 19:03:38 INFO - PROCESS | 7605 | Values: 108.0 113.0 103.0 108.0 110.0 114.0 99.0 109.0 111.0 110.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:157.00 stddev:23.33 (14.9%) stddev-sans-first:24.61 19:03:38 INFO - PROCESS | 7605 | Values: 158.0 126.0 159.0 180.0 128.0 156.0 149.0 126.0 194.0 134.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.87 (1.2%) stddev-sans-first:1.96 19:03:38 INFO - PROCESS | 7605 | Values: 163.0 162.0 163.0 161.0 160.0 162.0 166.0 160.0 161.0 164.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#3] audio-fft Cycles:10 Average:98.00 Median:77.00 stddev:44.12 (57.3%) stddev-sans-first:45.93 19:03:38 INFO - PROCESS | 7605 | Values: 74.0 77.0 77.0 186.0 76.0 77.0 83.0 76.0 177.0 77.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.19 (30.6%) stddev-sans-first:29.16 19:03:38 INFO - PROCESS | 7605 | Values: 92.0 92.0 156.0 92.0 94.0 93.0 153.0 92.0 92.0 142.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:03:38 INFO - PROCESS | 7605 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 19:03:38 INFO - PROCESS | 7605 | Values: 147.0 148.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:03:38 INFO - PROCESS | 7605 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:56.00 stddev:7.50 (13.4%) stddev-sans-first:7.79 19:03:38 INFO - PROCESS | 7605 | Values: 54.0 56.0 56.0 54.0 57.0 61.0 56.0 79.0 56.0 55.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.00 stddev:1.83 (3.0%) stddev-sans-first:1.92 19:03:38 INFO - PROCESS | 7605 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 64.0 59.0 59.0 64.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:74.50 stddev:3.41 (4.6%) stddev-sans-first:3.43 19:03:38 INFO - PROCESS | 7605 | Values: 79.0 73.0 73.0 74.0 74.0 82.0 81.0 74.0 74.0 75.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:121.00 stddev:8.32 (6.9%) stddev-sans-first:8.59 19:03:38 INFO - PROCESS | 7605 | Values: 115.0 126.0 115.0 113.0 120.0 122.0 116.0 111.0 128.0 138.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:2.55 (1.6%) stddev-sans-first:2.39 19:03:38 INFO - PROCESS | 7605 | Values: 157.0 160.0 159.0 164.0 164.0 158.0 161.0 163.0 160.0 158.0 19:03:38 INFO - PROCESS | 7605 | 19:03:38 INFO - PROCESS | 7605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:1.90 (2.8%) stddev-sans-first:1.56 19:03:38 INFO - PROCESS | 7605 | Values: 70.0 68.0 67.0 65.0 68.0 65.0 65.0 64.0 68.0 66.0 19:03:38 INFO - PROCESS | 7605 | -------- Summary: end -------- 19:03:38 INFO - PROCESS | 7605 | 19:03:39 INFO - TEST-INFO | 7605: exit 0 19:03:39 INFO - TEST-OK | kraken | took 60826ms 19:03:39 INFO - SUITE-END | took 1170s 19:03:40 INFO - Completed test suite (00:19:30) 19:03:40 INFO - javascript benchmark 19:03:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.335132973405, 3357.4963755436697, 3366.4108780963334, 3384.779989300697, 3401.7448691348154, 5733.369329373771, 5766.250387449626, 5789.131630255464, 5810.448007439291, 5818.854528636781, 5754.568407369443, 5787.739551720172, 5792.768289268435, 5793.449622285887, 5799.623024503404, 5197.506236907507, 5241.816536421226, 5288.8413347599635, 5305.098133317326, 5334.066538355792, 5165.328507294046, 5218.034663587229, 5385.165299378583, 5391.514763671269, 5393.541548968323, 5205.947940520603, 5259.053370393328, 5290.1006828839, 5313.096773548486, 5313.096773548486, 5211.270422140903, 5249.790008399659, 5279.0, 5290.814821481268, 5312.256284120226, 4987.800487980477, 5030.0, 5202.76587553561, 5216.426193118754, 5244.082285600005, 5563.0, 5593.021221286299, 5626.493615574577, 5655.179998900177, 5699.373068962411, 6122.173506576644, 6161.507079433634, 6166.105914642397, 6166.814995550096, 6180.721867515973, 5975.820725378246, 6073.939260607382, 6140.785072522485, 6238.064290356483, 6242.250929888397, 5824.446677565625, 5825.533957283407, 5827.067669172954, 5833.474987251126, 5840.561957853178, 6356.332585078592, 6361.0, 6362.936370636235, 6364.968175159187, 6371.267304259976, 5839.474447299764, 5879.323877754027, 5902.055671092605, 5927.288725352985, 6093.146959425684, 6083.817485475354, 6087.208662873798, 6102.847428814315, 6104.145419641254, 6109.236345456818, 5983.820485385445, 6029.487493563096, 6075.088736689444, 6076.361981991916, 6091.939080609137, 5885.529157667376, 6008.729607167688, 6113.597930965863, 6133.946794548733, 6134.344744984476, 4637.675362724577, 4664.253719404879, 4665.883352916137, 4681.555252251031, 4688.578027977498, 4098.118904435561, 4167.8958026049595, 4173.874783756492, 4183.581641835792, 4195.49654041517, 5700.144978253295, 5735.684537350402, 5863.2670916135485, 5920.763169473259, 5963.910541341883, 6217.129601855744, 6220.626762394271, 6230.034344676583, 6237.09562113491, 6237.781677641261, 5748.281464816898, 5881.088431293157, 5900.557458190653, 5917.615355001911, 5942.940570594325, 5297.947020529822, 5322.946770532245, 5325.920111198335, 5345.732713364394, 5360.276362690986, 6449.226092868886, 6466.967665161644, 6470.158879345655, 6474.482041436674, 6497.902531462032, 6117.724702388314, 6137.285055221507, 6175.783847565403, 6177.660228687286, 6189.071639254148, 6406.5515413920575, 6477.578957367756, 6482.708278127401, 6485.675716214265, 6490.0, 5996.700164991646, 6055.1220073090035, 6064.514838812973, 6065.059915713072, 6072.05883088122, 5977.731002104829, 6048.60684055535, 6144.0, 6175.6912154393, 6196.845078873064, 5917.053271476543, 5986.640801551746, 5993.820185394445, 6005.669688167192, 6020.729067191899, 5904.0553511437965, 5915.112733090071, 5929.940700593112, 5942.168096466412, 5959.553033522589, 5659.688717120598, 5789.218455508452, 5855.0, 5872.295324560909, 5901.3213480448585, 5992.370801065999, 6081.179040829608, 6085.300190478151, 6085.4523092921845, 6085.995810691186, 5872.119182122716, 5930.258717660293, 5944.078667806497, 5962.07587823888, 5972.701364931823], "value": 5669.96217913832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.5927545284197, 676.80034389855, 684.8801459744543, 728.5737843361633, 729.715410989714, 31819.840900795494, 32731.345373092554, 39731.60268397311, 39986.200275994466, 40241.19517609646, 42182.156356872845, 42603.78698106505, 42629.78685106578, 42692.57307426925, 42745.78627106868, 8935.731928042153, 9075.41009834362, 9083.182513573776, 9092.045335239804, 9105.863412048791, 8949.552522373888, 9031.142041506046, 9075.410098343587, 9076.591553380114, 9078.409903356294, 9203.17171454569, 9265.258779297674, 9277.768055798626, 9302.0, 9304.209142222886, 9205.033471485465, 9254.768630784218, 9261.861072083924, 9266.258699304039, 9270.165685088374, 9089.318301127376, 9173.08269173084, 9207.355485116044, 9251.76870578241, 9260.814783704356, 42713.57286427127, 43201.0, 43265.78367108176, 43539.0, 43628.345574816405, 3605.4952306677087, 3727.6645101940953, 3757.3612485877466, 3900.9272450076173, 4280.229558679468, 32073.839630801696, 32642.6735732642, 32895.506567401266, 34387.82806085954, 34871.30257394838, 4193.454850869368, 4219.303814870543, 4227.698715723714, 4311.1593239318345, 4343.283358245917, 304869.0, 305708.0, 306890.0, 309809.0, 310009.99999999773, 39645.40531892024, 40581.59418405778, 64650.35349646537, 64952.67523662446, 65061.349386506474, 37849.053773655876, 37869.621303787164, 37976.8101159498, 37980.24039519194, 38021.619783801805, 17213.0, 17389.043602601727, 17413.825861741472, 17431.912840435718, 17437.7384339235, 13364.2649654268, 13449.462021519226, 13458.125221860744, 13472.528461503996, 13509.66225844342, 9248.630054797733, 9286.767830804283, 9347.298952578583, 9347.298952578583, 9355.25157987373, 3671.4676371926457, 3690.8892733218045, 3750.9437358439645, 3763.6800871926193, 3776.8489260429824, 1144.6680462665734, 1188.928664280146, 1192.284629222477, 1239.3741160713962, 1239.5599562155305, 32734.0, 33089.50365744516, 33307.16732081669, 33551.32897342039, 34439.31121377558, 1210.9455074521668, 1235.765204611121, 1259.8614152443224, 1262.1228246368685, 1284.537566476068, 16413.42553010639, 17237.913810431117, 17310.307587696352, 17316.480505584852, 17436.302547898194, 448464.0, 561467.0, 564044.0, 566050.0, 568774.0, 59170.0, 60035.69982150061, 60161.69919150464, 60235.397646023855, 60494.697526512966, 1548.07115730563, 1588.658438435765, 1598.5364244369234, 1602.8557429831371, 1614.0315810513832, 32589.0, 34234.31531369408, 34917.650823492455, 34945.0, 34992.47511287282, 56872.0, 57783.71108144432, 57841.710791445774, 57871.4212857866, 58329.12506312324, 398176.0, 403829.0, 407553.0, 409074.0, 409381.0, 46938.530614694784, 47015.529844701116, 47654.80862978453, 47834.521654783006, 48290.27564586464, 50755.23867141922, 51894.74052629713, 52059.2191117126, 52089.739551302, 52800.73599632131, 42073.579264206965, 42459.0, 42759.57240427556, 42789.35815962825, 43950.0, 41396.58603414048, 41578.0, 41810.0, 42631.0, 43315.0, 44767.55232447634, 45195.0, 45772.7711361441, 47236.29145562751, 48418.757906210245, 41580.0, 41655.58344416517, 42653.14693706046, 44267.33598995953, 45022.77488612536, 36252.4562131563, 36786.26427471382, 36800.63199368079, 37110.6288937118, 37207.81396093002], "value": 20221.527081706234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.27831048063047, 435.10802854148994, 437.37892193085816, 442.3520180471776, 450.889532064644, 18699.532511687197, 18898.0, 19521.804781952193, 21480.140794368246, 21547.892260538676, 19102.14040368183, 19612.94064123268, 19874.304399346027, 19934.302299419523, 19934.50163745907, 5371.140617501201, 5574.358948720908, 5585.441455854423, 5592.6085174037835, 5601.831945041656, 5288.233206185101, 5475.561955043587, 5566.582506312023, 5839.9124013139835, 5991.670458124801, 5963.3738457462, 5963.671998040106, 5977.133315669225, 6022.698865056752, 6031.0, 5806.158107074471, 5980.581359304829, 5988.461038506555, 6004.399560043982, 6024.0662697282, 5432.864178395532, 5461.0716178249795, 5461.2354270402175, 5481.150421684645, 5488.643238189545, 13719.45122195111, 23846.76153238463, 24710.258692239262, 24837.87581062101, 24906.0, 2365.3968238099174, 2498.6002239641753, 2529.380301826064, 3041.9239519012203, 3126.9218269543444, 10287.89712102877, 10395.32430392022, 10566.260361774679, 10642.840357394645, 10784.676459706221, 2017.5863947890648, 2061.7732049474544, 2097.9370618881458, 2123.203798575534, 2167.696522486853, 78580.0, 83428.58285708593, 85773.57113214518, 85842.0, 86988.5650571743, 11608.477618507188, 11914.285142891455, 11942.761144777229, 11994.220375675553, 12019.338936358585, 16955.83044169567, 17093.0, 17208.65582688339, 17209.053502057257, 17245.741313880302, 8299.792505187297, 8722.433041852259, 8763.649454021896, 8771.122887711306, 8907.73276801697, 8418.368622353348, 8422.905022347179, 8429.32565394767, 8459.111793261618, 8543.871841922377, 5164.1995490699, 5197.948020519822, 5201.505856943584, 5227.242049902743, 5231.372235331708, 2114.3551216879, 2119.311223852254, 2149.10812013016, 2202.2072054060527, 2208.4699672078905, 1001.3491230700104, 1033.3180101133216, 1057.154276578734, 1091.6074591517877, 1154.6882341767675, 18988.0, 19234.71147932782, 19426.805731942783, 19748.210071597263, 20087.598248034956, 1091.8143915534379, 1097.2703152403562, 1098.6047719396322, 1137.2721458266717, 1148.7989601819816, 10881.455927203608, 11106.278091924, 11181.161412894066, 11258.380789056517, 11337.716557086138, 517527.0, 518189.0, 520310.0, 522520.0, 546979.0, 92040.0, 92256.53871730732, 96159.51920240354, 96244.0, 99589.50205249072, 1112.1380929779486, 1140.3044143072718, 1172.5602898912907, 1174.7356844709873, 1195.9940200298943, 17152.399666011628, 17284.481465556055, 17436.82563174352, 17624.206910688794, 17644.647107058045, 36117.27765444624, 38375.232495350494, 40047.799761001006, 40223.99440013906, 40415.0, 56728.71635641796, 58750.0, 58819.41180588139, 59043.40956590379, 59096.704516478865, 8873.511956842436, 8957.820843582962, 9026.09042023517, 9127.634894604142, 9182.403143795633, 13518.053736238762, 13527.729445411234, 13537.864621354054, 13592.252426116658, 13775.931120344334, 11257.831132532854, 11281.71795705114, 11613.187076904873, 11726.296422214695, 11818.409079545816, 11665.708357291136, 11731.178817483036, 11824.881751182722, 11829.526818927146, 12244.69388265265, 11875.821862671894, 12021.579244726392, 12600.684982875502, 12896.290704010995, 12896.548620798227, 9152.313576481658, 9254.167124958785, 9472.52637368115, 9547.188488978236, 9552.42685438876, 12747.470303563632, 12822.67943301425, 12843.871561284268, 12893.548725794552, 13002.674933126747], "value": 9674.109267414617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1599.8240193578708, 1601.8077830660322, 1823.2798044772314, 1919.9424017279487, 1950.6586347389202, 8444.408891377607, 8615.913840861589, 8632.56837158142, 8692.391532592721, 8833.95583022084, 8744.606492707828, 8791.516466594334, 8819.0, 8890.0, 8895.510746908918, 2500.5499010178114, 2529.3929456930387, 2529.7217306096313, 2530.8101892358054, 2532.1643857527065, 2480.7891329237036, 2567.4351642638685, 2572.0, 2581.8838152283097, 2583.8062145339177, 2414.4929564791414, 2428.86641234732, 2486.2292689266296, 2487.7263501014872, 2487.9129230476847, 2498.375406148463, 2498.837575557583, 2508.234988328559, 2530.2788705218923, 2532.4428625702317, 2537.936551586207, 2542.5931850903767, 2544.122277814151, 2564.794816414701, 2602.531544322021, 8880.8667869982, 8898.154675305836, 8923.553822308859, 8930.821383572293, 8945.552722363856, 5593.105103183511, 5661.60368774186, 5678.0915053591225, 5715.514181294595, 5720.485156335908, 3302.2239773653173, 3351.7151042161445, 3441.380551500729, 3660.1764602964386, 3686.4838922550866, 1082.118073769875, 1130.8860772139435, 1138.6640940922448, 1149.5459293579072, 1187.6733898177984, 11885.108616853771, 11953.0, 12013.699657508545, 12040.337781422106, 12059.819102713467, 4592.3800286961505, 4686.882827929329, 4690.906181876343, 4693.413323334583, 4745.7423782697615, 9602.567884445216, 9663.758406039764, 9673.951630241803, 9677.467739274267, 9694.563744631509, 5472.20653005312, 5476.616636835383, 5512.200730893998, 5515.669059856422, 5523.7238138092935, 5069.7465126744255, 5145.176771716508, 5232.450592687789, 5238.057149713012, 5250.7637156328055, 4024.959750402517, 4059.2287465381482, 4071.491063617048, 4087.97956010224, 4173.000685564393, 1239.4050855589367, 1256.7360854220533, 1257.044646068994, 1263.696712788924, 1297.3707751740399, 875.4790899414838, 926.9953650231706, 995.1988649137514, 1032.8192566300868, 1036.3315661398506, 6110.7250173741395, 6174.135621013062, 6233.376662333731, 6248.562600617913, 6260.686965651699, 478.4545617995488, 481.04032455251996, 485.9368282123301, 493.331535769035, 498.5787009976564, 3938.330483817758, 4054.3310353791885, 4074.0425999890003, 4076.1236334188293, 4101.446304748881, 10660.307080039773, 11067.280626759235, 11135.220534562664, 11154.0, 11177.944110279397, 10920.945395272973, 10937.781244375226, 10964.0, 10984.890151098387, 11019.283746556448, 7983.2415920487465, 8179.509229446371, 8180.141085186089, 8193.426460147852, 8280.171982801672, 5510.669359838423, 5763.193152958673, 5812.94187058124, 5881.529477641693, 5887.470127688529, 9075.27397808187, 9428.764280893032, 9432.151106400457, 9635.903640963781, 9677.564509597225, 9480.288978326515, 9633.277504187354, 9735.02649735049, 9739.756506087404, 9745.366551174151, 7643.541387516544, 7875.0, 7898.605069746375, 8023.6790528378215, 8163.83672326562, 8341.708040218564, 8345.874811877948, 8378.078411374865, 8401.915980840113, 8406.579671016303, 7618.657160427683, 7701.0, 7703.460757746904, 7866.174051724715, 7913.881291780743, 7475.252474752481, 7546.0, 7562.584057876869, 7582.279683430065, 7701.4608977371045, 7148.606826624377, 7153.713851446092, 7167.211606723361, 7197.784066478014, 7206.4234861209925, 5165.483451654804, 5195.480451954774, 5257.921131183112, 5288.524032837063, 5342.43904390049, 5296.549793267615, 5332.5467335276935, 5390.541803946709, 5411.972940135274, 5432.837014889402], "value": 4653.059749584144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.7290218787004, 365.16559661174205, 366.58575809335446, 369.4495202148797, 370.6849178198532, 6390.4887608991285, 6391.073294372313, 6426.453751431128, 6440.871182576358, 6453.709583068761, 6381.712822922968, 6391.584547004441, 6395.840103997402, 6410.102585638015, 6413.038044293358, 4609.953900460994, 4745.335653008581, 4886.315915771795, 4896.46138924718, 4901.117798796233, 4862.197737373329, 4871.318015477836, 4885.462599114095, 4890.73100979446, 4902.926456103161, 4871.025794841046, 4882.292067650189, 4889.633277504184, 4900.264960255954, 4901.681390709592, 4892.608591312686, 4895.31465594817, 4899.681520701143, 4902.779374928119, 4928.901421971541, 4321.178975994551, 4326.0266440051055, 4331.133773245332, 4332.328489084197, 4334.45819272591, 6095.207623008981, 6119.357467465941, 6183.0, 6206.813795586139, 6215.720292586844, 5690.516306113986, 5724.427557244284, 5728.054870946289, 5730.914036289459, 5732.31212254528, 6688.163979502562, 6732.427743641796, 6782.8304292392595, 6814.386705196556, 6826.488013399015, 4781.426228852525, 4786.736729479877, 4787.066522028206, 4793.257045158006, 4807.855764327076, 7057.258987806258, 7070.469714771361, 7077.3984211342095, 7082.610456424894, 7088.999999999948, 4598.287265473857, 4732.503087175865, 4783.378160839138, 4805.1590971579835, 4915.508449155127, 4834.854954351375, 4856.271559266138, 4861.1006963711825, 4864.927026094611, 4876.512348765095, 5619.719014049281, 5629.690367029771, 5634.774609015675, 5637.633553818989, 5642.520385767174, 6835.418989385858, 6849.863002739918, 6852.794416167523, 6872.553284036521, 6930.341617546325, 1691.9492415227562, 1722.956926076858, 1724.5085150731982, 1725.387487441965, 1726.2749645149067, 1083.978320433587, 1115.6764538283808, 1133.4106264742288, 1135.28477059452, 1149.2472430557998, 6666.266710661824, 6682.365175308338, 6692.163479565054, 6700.262971073178, 6723.327667233238, 6991.23096459389, 7044.859102818017, 7053.083099197174, 7059.682314295869, 7066.116735408074, 6747.628880411527, 6754.12196414463, 6755.324467553303, 6760.628165450948, 6761.4590832733265, 3792.6586607205486, 3809.8857034289017, 3817.0, 3828.310904037244, 3831.7509361891944, 7422.591757453284, 7443.069616297963, 7444.962775186089, 7445.069366329209, 7448.702051917971, 7010.964945175241, 7238.420926325882, 7272.890906636405, 7273.345398914017, 7275.89086163708, 7349.081364829396, 7355.889661655079, 7362.631868406558, 7459.888101678479, 7462.850742985219, 7087.751928682472, 7110.431165506644, 7119.9644001781735, 7139.678714457966, 7152.570845749064, 7009.9649501752165, 7011.123609548807, 7014.68433920485, 7015.298470152944, 7016.929830701628, 7338.70645174187, 7427.368673662583, 7475.925240747523, 7493.138289096823, 7497.9250207497225, 4785.330053792542, 4807.399075115611, 4832.1543729846435, 4834.081524510332, 4848.32123502717, 7100.254473280231, 7104.467164962752, 7108.822279443055, 7111.0, 7135.036770035978, 6825.55633883796, 6827.419669328163, 6845.178578570603, 6848.417884479676, 6856.4514838813775, 6647.434968027578, 6732.663366831737, 6734.0, 6755.121834161528, 6764.8985265222045, 6687.732490700318, 6709.530332876652, 6710.66446677674, 6712.194536655437, 6712.865742685217, 6916.827079323057, 6928.792136235921, 6940.826479338057, 6949.791506254821, 6954.582725036514, 6744.865102698017, 6763.93236067633, 6766.05275261454, 6776.7628133015105, 6785.423239024541], "value": 5162.444302905385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6837299266788, 817.3052905030723, 845.4082142500251, 847.8558645030348, 871.2811930157621, 13914.652133696663, 14234.857651423483, 14295.714085718279, 14355.210463424508, 14370.712585748292, 12892.80660790089, 12903.290319032449, 12908.096433249677, 12927.806082908764, 12937.288449135294, 903.4669544968484, 944.4805357053593, 944.527736131934, 946.1106559833735, 947.6162154327509, 943.8442656961593, 944.3531181140906, 946.9384490008161, 948.0993056596227, 948.6869333120088, 982.990170098297, 983.1201075037836, 985.6106837799065, 990.3414229537349, 991.6529214774844, 973.9756506087334, 977.6773664690635, 978.681928373278, 982.6855406269997, 984.5717113055844, 720.0603212807284, 720.6396801599201, 721.6896734404204, 723.95656260624, 724.7789424225609, 14555.199464029474, 14589.124652520777, 14595.41618335276, 14598.34307456167, 14639.780403293958, 12389.0, 12684.0, 12691.365431728376, 12772.872271277261, 13051.0, 10530.157587393067, 10663.626773062906, 10684.305520141166, 11479.540818367339, 11496.712582185428, 3527.188746588299, 3534.9116272093147, 3577.5170352002406, 3615.9700362593235, 3703.4259689748133, 60703.39296607021, 60712.0, 61889.0, 62111.0, 62362.0, 10058.29591928558, 10063.798724025479, 10555.894441055645, 10573.894261057445, 11287.943560282147, 18973.90513047426, 19019.714704279446, 19109.426717198505, 19121.61756764857, 19216.231350746093, 7652.234776522303, 7687.192844751333, 7727.806804829812, 7855.528668279807, 8134.064582572962, 4504.0, 4512.0, 4551.908961820745, 4576.473705523841, 4672.182368085571, 3529.1000794797164, 3576.0523461282783, 3595.0832537702718, 3596.82015899204, 3605.7115430765475, 673.7338751193349, 682.7849227493324, 703.711478293897, 728.2680905689748, 734.8787450070679, 620.9379062093844, 678.6776281266458, 697.769735987123, 728.8068661804626, 796.2276591706036, 8980.55097245135, 10023.799524009624, 10117.949410252902, 10295.07344339013, 10458.529366178387, 642.5791106825037, 645.3739872323838, 653.7581094994787, 723.6273319240595, 725.4377857160637, 4387.363832244307, 4483.14820184164, 4483.170613436525, 4506.324051392317, 4623.4451865775645, 66753.0, 67627.32372676309, 67864.6606766963, 68178.0, 68352.6582367095, 58019.709901450224, 59005.40994589999, 59537.70231148817, 59703.70148149232, 59915.0, 51733.482665172865, 52389.214161787604, 52557.737211313695, 53619.73190134102, 53633.463665363626, 8933.106689331014, 9005.819883602422, 9011.143941325563, 9031.774205644911, 9047.773805654648, 38113.0, 38820.0, 39162.0, 39498.40752388774, 39616.40575391314, 46327.0, 46548.06903861972, 49617.751911240215, 50353.74823125861, 51060.0, 10916.454177290945, 10939.671809845717, 11077.612283570037, 11089.778204436028, 11095.889041109485, 12321.568745093879, 12583.182093163916, 12723.872761272269, 12851.485940562272, 12861.485540578646, 11430.371329576954, 11764.764704706029, 11857.873502017295, 11916.225445346025, 12213.0, 11470.139739519736, 11739.589114381297, 11872.76254474923, 11980.820287695866, 12295.07786915967, 11796.0, 11850.509491696432, 11863.288202707865, 11872.287662740264, 12134.75730485403, 9955.402675839472, 10122.544485498023, 10132.290739648153, 10160.796784064425, 10167.339122956984, 9937.453440060866, 10107.292489525662, 10182.083612474913, 10223.488825558543, 10247.7438064049], "value": 6884.106769980851, "unit": "score"}], "name": "dromaeo_css", "value": 7537.848762124277, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 103.0, 108.0, 110.0, 114.0, 99.0, 109.0, 111.0, 110.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 159.0, 180.0, 128.0, 156.0, 149.0, 126.0, 194.0, 134.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 161.0, 160.0, 162.0, 166.0, 160.0, 161.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 186.0, 76.0, 77.0, 83.0, 76.0, 177.0, 77.0], "value": 98.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 156.0, 92.0, 94.0, 93.0, 153.0, 92.0, 92.0, 142.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 54.0, 57.0, 61.0, 56.0, 79.0, 56.0, 55.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 64.0, 59.0, 59.0, 64.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 73.0, 74.0, 74.0, 82.0, 81.0, 74.0, 74.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 126.0, 115.0, 113.0, 120.0, 122.0, 116.0, 111.0, 128.0, 138.0], "value": 120.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 159.0, 164.0, 164.0, 158.0, 161.0, 163.0, 160.0, 158.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 65.0, 68.0, 65.0, 65.0, 64.0, 68.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1530.9000000000003, "alertThreshold": 2.0}]} 19:03:40 INFO - Return code: 0 19:03:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:03:40 ERROR - # TBPL SUCCESS # 19:03:40 INFO - Running post-action listener: _resource_record_post_action 19:03:40 INFO - Running post-run listener: _resource_record_post_run 19:03:41 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 344064; Write bytes: 231735296; Read time: 92; Write time: 116976 19:03:41 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 13905920; Read time: 0; Write time: 3868 19:03:41 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 344064; Write bytes: 217829376; Read time: 92; Write time: 113108 19:03:41 INFO - Running post-run listener: _upload_blobber_files 19:03:41 INFO - Blob upload gear active. 19:03:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:03:41 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:03:41 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:03:41 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:03:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:42 INFO - (blobuploader) - INFO - Done attempting. 19:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:43 INFO - (blobuploader) - INFO - Done attempting. 19:03:43 INFO - (blobuploader) - INFO - Iteration through files over. 19:03:43 INFO - Return code: 0 19:03:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:03:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:03:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74972f34ba5f4920e815d3204ec3ac4b55188c0a5b2adaa66bbd11b6536762a661f2d52fca4d79a717f2bd218f287e217c2b3ebc929228e07eca2c41a800b2f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f345b264abebc3471962769bf8fc90c29db684a48688a4594d11e96ca6167d49e6293fb450dd0f66f5b2af60945f522f7cf8d016ed7ba5016a82bf1b7394b7"} 19:03:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:03:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:03:43 INFO - Contents: 19:03:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74972f34ba5f4920e815d3204ec3ac4b55188c0a5b2adaa66bbd11b6536762a661f2d52fca4d79a717f2bd218f287e217c2b3ebc929228e07eca2c41a800b2f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f345b264abebc3471962769bf8fc90c29db684a48688a4594d11e96ca6167d49e6293fb450dd0f66f5b2af60945f522f7cf8d016ed7ba5016a82bf1b7394b7"} 19:03:43 INFO - Running post-run listener: copy_logs_to_upload_dir 19:03:43 INFO - Copying logs to upload dir... 19:03:43 INFO - mkdir: /builds/slave/test/build/upload/logs 19:03:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.948267 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-23 19:03:43.310722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 19:03:43.314102) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640 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/74972f34ba5f4920e815d3204ec3ac4b55188c0a5b2adaa66bbd11b6536762a661f2d52fca4d79a717f2bd218f287e217c2b3ebc929228e07eca2c41a800b2f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f345b264abebc3471962769bf8fc90c29db684a48688a4594d11e96ca6167d49e6293fb450dd0f66f5b2af60945f522f7cf8d016ed7ba5016a82bf1b7394b7"} build_url:https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/ONa7BkPzTfaAKwKUDwIKbQ/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/74972f34ba5f4920e815d3204ec3ac4b55188c0a5b2adaa66bbd11b6536762a661f2d52fca4d79a717f2bd218f287e217c2b3ebc929228e07eca2c41a800b2f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f345b264abebc3471962769bf8fc90c29db684a48688a4594d11e96ca6167d49e6293fb450dd0f66f5b2af60945f522f7cf8d016ed7ba5016a82bf1b7394b7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 19:03:43.341086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 19:03:43.341489) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466732594.536967-1942768640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 19:03:43.427321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 19:03:43.427852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 19:03:43.428351) ========= ========= Total master_lag: 0.19 =========