builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1460698693.54 results: success (0) buildid: 20160414215149 builduid: d8d203294c2d41b1b362ff58f5d8ddc1 revision: 54b5c7592f7337ccb28a288633c0997b752c85e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.538334) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.538856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.539253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.558405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.558953) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 22:38:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-04-14 22:38:14 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.706581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.706948) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019567 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.758980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:13.759360) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 54b5c7592f7337ccb28a288633c0997b752c85e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 54b5c7592f7337ccb28a288633c0997b752c85e2 --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=78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 22:38:14,219 truncating revision to first 12 chars 2016-04-14 22:38:14,219 Setting DEBUG logging. 2016-04-14 22:38:14,219 attempt 1/10 2016-04-14 22:38:14,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/54b5c7592f73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 22:38:14,495 unpacking tar archive at: fx-team-54b5c7592f73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:14.352888) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:14.353232) ========= script_repo_revision: 54b5c7592f7337ccb28a288633c0997b752c85e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:14.353755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:14.354100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 22:38:14.365400) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-14 22:38:14.365727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:38:14 INFO - MultiFileLogger online at 20160414 22:38:14 in /builds/slave/test 22:38:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:38:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:38:14 INFO - {'append_to_log': False, 22:38:14 INFO - 'base_work_dir': '/builds/slave/test', 22:38:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:38:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:38:14 INFO - 'branch': 'Fx-Team-Non-PGO', 22:38:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:38:14 INFO - 'config_files': ('talos/linux_config.py',), 22:38:14 INFO - 'default_actions': ('clobber', 22:38:14 INFO - 'read-buildbot-config', 22:38:14 INFO - 'download-and-extract', 22:38:14 INFO - 'populate-webroot', 22:38:14 INFO - 'create-virtualenv', 22:38:14 INFO - 'install', 22:38:14 INFO - 'run-tests'), 22:38:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:38:14 INFO - 'download_minidump_stackwalk': True, 22:38:14 INFO - 'download_symbols': 'ondemand', 22:38:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:38:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:38:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:38:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:38:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:38:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:38:14 INFO - 'installer_path': 'installer.exe', 22:38:14 INFO - 'log_level': 'info', 22:38:14 INFO - 'log_name': 'talos', 22:38:14 INFO - 'log_to_console': True, 22:38:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:38:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:38:14 INFO - 'opt_config_files': (), 22:38:14 INFO - 'pip_index': False, 22:38:14 INFO - 'sps_profile': False, 22:38:14 INFO - 'sps_profile_interval': 0, 22:38:14 INFO - 'suite': 'dromaeojs-e10s', 22:38:14 INFO - 'system_bits': '32', 22:38:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:38:14 INFO - 'title': 'talos-linux64-ix-019', 22:38:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:38:14 INFO - 'use_talos_json': True, 22:38:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:38:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:38:14 INFO - 'work_dir': 'build'} 22:38:14 INFO - ##### 22:38:14 INFO - ##### Running clobber step. 22:38:14 INFO - ##### 22:38:14 INFO - Running pre-action listener: _resource_record_pre_action 22:38:14 INFO - Running main action method: clobber 22:38:14 INFO - rmtree: /builds/slave/test/build 22:38:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:38:15 INFO - Running post-action listener: _resource_record_post_action 22:38:15 INFO - ##### 22:38:15 INFO - ##### Running read-buildbot-config step. 22:38:15 INFO - ##### 22:38:15 INFO - Running pre-action listener: _resource_record_pre_action 22:38:15 INFO - Running main action method: read_buildbot_config 22:38:15 INFO - Using buildbot properties: 22:38:15 INFO - { 22:38:15 INFO - "project": "", 22:38:15 INFO - "product": "firefox", 22:38:15 INFO - "script_repo_revision": "production", 22:38:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:38:15 INFO - "repository": "", 22:38:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:38:15 INFO - "buildid": "20160414215149", 22:38:15 INFO - "pgo_build": "False", 22:38:15 INFO - "basedir": "/builds/slave/test", 22:38:15 INFO - "buildnumber": 1150, 22:38:15 INFO - "slavename": "talos-linux64-ix-019", 22:38:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:38:15 INFO - "platform": "ubuntu64_hw", 22:38:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:38:15 INFO - "branch": "fx-team", 22:38:15 INFO - "repo_path": "integration/fx-team", 22:38:15 INFO - "revision": "54b5c7592f7337ccb28a288633c0997b752c85e2", 22:38:15 INFO - "stage_platform": "linux64", 22:38:15 INFO - "builduid": "d8d203294c2d41b1b362ff58f5d8ddc1", 22:38:15 INFO - "slavebuilddir": "test" 22:38:15 INFO - } 22:38:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:38:15 INFO - Running post-action listener: _resource_record_post_action 22:38:15 INFO - ##### 22:38:15 INFO - ##### Running download-and-extract step. 22:38:15 INFO - ##### 22:38:15 INFO - Running pre-action listener: _resource_record_pre_action 22:38:15 INFO - Running main action method: download_and_extract 22:38:15 INFO - mkdir: /builds/slave/test/build/tests 22:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:15 INFO - https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:38:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:38:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:38:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:38:21 INFO - Downloaded 1361 bytes. 22:38:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:38:21 INFO - Using the following test package requirements: 22:38:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:38:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:38:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:38:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'jsshell-linux-x86_64.zip'], 22:38:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:38:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:38:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:38:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:38:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:38:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:38:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:38: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')]} 22:38:21 INFO - https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:38:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:38:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:38:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:38:25 INFO - Downloaded 22202881 bytes. 22:38:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:38:26 INFO - Return code: 0 22:38:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:26 INFO - https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:38:28 INFO - Downloaded 22202881 bytes. 22:38:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:38:29 INFO - Return code: 0 22:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:29 INFO - https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:38:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:38:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:38:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:38:30 INFO - Downloaded 10841076 bytes. 22:38:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:38:31 INFO - Return code: 0 22:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:31 INFO - https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:38:33 INFO - Downloaded 54445247 bytes. 22:38:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:38:33 INFO - mkdir: /builds/slave/test/properties 22:38:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:38:33 INFO - Writing to file /builds/slave/test/properties/build_url 22:38:33 INFO - Contents: 22:38:33 INFO - build_url:https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:38:34 INFO - Running post-action listener: _resource_record_post_action 22:38:34 INFO - Running post-action listener: set_extra_try_arguments 22:38:34 INFO - ##### 22:38:34 INFO - ##### Running populate-webroot step. 22:38:34 INFO - ##### 22:38:34 INFO - Running pre-action listener: _resource_record_pre_action 22:38:34 INFO - Running main action method: populate_webroot 22:38:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:38:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:38:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:38:34 INFO - '--tppagecycles', 22:38:34 INFO - '7'], 22:38:34 INFO - 'tests': ['tsvgm']}}, 22:38:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:38:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:38:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:38:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:38:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['damp', 'tps']}, 22:38:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'tests': ['damp', 'tps']}, 22:38:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['dromaeo_dom']}, 22:38:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:38:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['a11yr', 22:38:34 INFO - 'ts_paint', 22:38:34 INFO - 'tpaint', 22:38:34 INFO - 'sessionrestore', 22:38:34 INFO - 'sessionrestore_no_auto_restore', 22:38:34 INFO - 'tabpaint']}, 22:38:34 INFO - 'other-e10s': {'tests': ['a11yr', 22:38:34 INFO - 'ts_paint', 22:38:34 INFO - 'tpaint', 22:38:34 INFO - 'sessionrestore', 22:38:34 INFO - 'sessionrestore_no_auto_restore', 22:38:34 INFO - 'tabpaint']}, 22:38:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:38:34 INFO - 'ts_paint', 22:38:34 INFO - 'tpaint', 22:38:34 INFO - 'sessionrestore', 22:38:34 INFO - 'sessionrestore_no_auto_restore', 22:38:34 INFO - 'tabpaint']}, 22:38:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:38:34 INFO - 'ts_paint', 22:38:34 INFO - 'tpaint', 22:38:34 INFO - 'sessionrestore', 22:38:34 INFO - 'sessionrestore_no_auto_restore', 22:38:34 INFO - 'tabpaint']}, 22:38:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['a11yr', 22:38:34 INFO - 'ts_paint', 22:38:34 INFO - 'tpaint', 22:38:34 INFO - 'sessionrestore', 22:38:34 INFO - 'sessionrestore_no_auto_restore', 22:38:34 INFO - 'tabpaint']}, 22:38:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['a11yr', 22:38:34 INFO - 'ts_paint', 22:38:34 INFO - 'tpaint', 22:38:34 INFO - 'sessionrestore', 22:38:34 INFO - 'sessionrestore_no_auto_restore', 22:38:34 INFO - 'tabpaint']}, 22:38:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['tsvgx', 22:38:34 INFO - 'tsvgr_opacity', 22:38:34 INFO - 'tart', 22:38:34 INFO - 'tscrollx', 22:38:34 INFO - 'cart']}, 22:38:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:38:34 INFO - 'tsvgr_opacity', 22:38:34 INFO - 'tart', 22:38:34 INFO - 'tscrollx', 22:38:34 INFO - 'cart']}, 22:38:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'talos_options': ['--disable-e10s'], 22:38:34 INFO - 'tests': ['tp5o']}, 22:38:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'tests': ['tp5o']}, 22:38:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'talos_options': ['--disable-e10s', 22:38:34 INFO - '--xperf_path', 22:38:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:34 INFO - 'tests': ['tp5n']}, 22:38:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:34 INFO - 'talos_options': ['--xperf_path', 22:38:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:34 INFO - 'tests': ['tp5n']}}, 22:38:34 INFO - 'talos.zip': {'path': '', 22:38:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:38:34 INFO - Running post-action listener: _resource_record_post_action 22:38:34 INFO - ##### 22:38:34 INFO - ##### Running create-virtualenv step. 22:38:34 INFO - ##### 22:38:34 INFO - Running pre-action listener: _resource_record_pre_action 22:38:34 INFO - Running main action method: create_virtualenv 22:38:34 INFO - Creating virtualenv /builds/slave/test/build/venv 22:38:34 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 22:38:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:38:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:38:34 INFO - Using real prefix '/usr' 22:38:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:38:34 INFO - Installing distribute.............................................................................................................................................................................................done. 22:38:36 INFO - Installing pip.................done. 22:38:36 INFO - Return code: 0 22:38:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38: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', 'pip>=1.5'] in /builds/slave/test/build 22:38: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 pip>=1.5 22:38:36 INFO - Using env: {'DISPLAY': ':0', 22:38:36 INFO - 'HOME': '/home/cltbld', 22:38:36 INFO - 'LANG': 'en_US.UTF-8', 22:38:36 INFO - 'LANGUAGE': 'en_US:en', 22:38:36 INFO - 'LOGNAME': 'cltbld', 22:38:36 INFO - 'MAIL': '/var/mail/cltbld', 22:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:36 INFO - 'MOZ_NO_REMOTE': '1', 22:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:36 INFO - 'NO_EM_RESTART': '1', 22:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:36 INFO - 'PWD': '/builds/slave/test', 22:38:36 INFO - 'SHELL': '/bin/bash', 22:38:36 INFO - 'SHLVL': '1', 22:38:36 INFO - 'TERM': 'linux', 22:38:36 INFO - 'TMOUT': '86400', 22:38:36 INFO - 'USER': 'cltbld', 22:38:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:36 INFO - '_': '/tools/buildbot/bin/python'} 22:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:36 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 22:38:36 INFO - Cleaning up... 22:38:36 INFO - Return code: 0 22:38:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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', '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 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38: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', 'psutil>=0.7.1'] in /builds/slave/test/build 22:38: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 psutil>=0.7.1 22:38:36 INFO - Using env: {'DISPLAY': ':0', 22:38:36 INFO - 'HOME': '/home/cltbld', 22:38:36 INFO - 'LANG': 'en_US.UTF-8', 22:38:36 INFO - 'LANGUAGE': 'en_US:en', 22:38:36 INFO - 'LOGNAME': 'cltbld', 22:38:36 INFO - 'MAIL': '/var/mail/cltbld', 22:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:36 INFO - 'MOZ_NO_REMOTE': '1', 22:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:36 INFO - 'NO_EM_RESTART': '1', 22:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:36 INFO - 'PWD': '/builds/slave/test', 22:38:36 INFO - 'SHELL': '/bin/bash', 22:38:36 INFO - 'SHLVL': '1', 22:38:36 INFO - 'TERM': 'linux', 22:38:36 INFO - 'TMOUT': '86400', 22:38:36 INFO - 'USER': 'cltbld', 22:38:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:36 INFO - '_': '/tools/buildbot/bin/python'} 22:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:37 INFO - Downloading/unpacking psutil>=0.7.1 22:38:37 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 22:38:37 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 22:38:37 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 22:38:37 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 22:38:37 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 22:38:37 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 22:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:38:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:39 INFO - Installing collected packages: psutil 22:38:39 INFO - Running setup.py install for psutil 22:38:39 INFO - building 'psutil._psutil_linux' extension 22:38:39 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 22:38:39 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 22:38:39 INFO - building 'psutil._psutil_posix' extension 22:38:39 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 22:38:39 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 22:38:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:39 INFO - Successfully installed psutil 22:38:39 INFO - Cleaning up... 22:38:39 INFO - Return code: 0 22:38:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:38:39 INFO - Using env: {'DISPLAY': ':0', 22:38:39 INFO - 'HOME': '/home/cltbld', 22:38:39 INFO - 'LANG': 'en_US.UTF-8', 22:38:39 INFO - 'LANGUAGE': 'en_US:en', 22:38:39 INFO - 'LOGNAME': 'cltbld', 22:38:39 INFO - 'MAIL': '/var/mail/cltbld', 22:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:39 INFO - 'MOZ_NO_REMOTE': '1', 22:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:39 INFO - 'NO_EM_RESTART': '1', 22:38:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:39 INFO - 'PWD': '/builds/slave/test', 22:38:39 INFO - 'SHELL': '/bin/bash', 22:38:39 INFO - 'SHLVL': '1', 22:38:39 INFO - 'TERM': 'linux', 22:38:39 INFO - 'TMOUT': '86400', 22:38:39 INFO - 'USER': 'cltbld', 22:38:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:39 INFO - '_': '/tools/buildbot/bin/python'} 22:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:38:41 INFO - Installing collected packages: mozsystemmonitor 22:38:41 INFO - Running setup.py install for mozsystemmonitor 22:38:41 INFO - Successfully installed mozsystemmonitor 22:38:41 INFO - Cleaning up... 22:38:41 INFO - Return code: 0 22:38:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:38:41 INFO - Using env: {'DISPLAY': ':0', 22:38:41 INFO - 'HOME': '/home/cltbld', 22:38:41 INFO - 'LANG': 'en_US.UTF-8', 22:38:41 INFO - 'LANGUAGE': 'en_US:en', 22:38:41 INFO - 'LOGNAME': 'cltbld', 22:38:41 INFO - 'MAIL': '/var/mail/cltbld', 22:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:41 INFO - 'MOZ_NO_REMOTE': '1', 22:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:41 INFO - 'NO_EM_RESTART': '1', 22:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:41 INFO - 'PWD': '/builds/slave/test', 22:38:41 INFO - 'SHELL': '/bin/bash', 22:38:41 INFO - 'SHLVL': '1', 22:38:41 INFO - 'TERM': 'linux', 22:38:41 INFO - 'TMOUT': '86400', 22:38:41 INFO - 'USER': 'cltbld', 22:38:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:41 INFO - '_': '/tools/buildbot/bin/python'} 22:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:42 INFO - Downloading/unpacking blobuploader==1.2.4 22:38:42 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 22:38:42 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 22:38:42 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 22:38:42 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 22:38:42 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 22:38:42 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 22:38:44 INFO - Downloading blobuploader-1.2.4.tar.gz 22:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:38:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:38:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 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 22:38:44 INFO - Downloading docopt-0.6.1.tar.gz 22:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:38:44 INFO - Installing collected packages: blobuploader, requests, docopt 22:38:44 INFO - Running setup.py install for blobuploader 22:38:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:38:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:38:44 INFO - Running setup.py install for requests 22:38:45 INFO - Running setup.py install for docopt 22:38:45 INFO - Successfully installed blobuploader requests docopt 22:38:45 INFO - Cleaning up... 22:38:45 INFO - Return code: 0 22:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:45 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 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38:45 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 22:38:45 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 22:38:45 INFO - Using env: {'DISPLAY': ':0', 22:38:45 INFO - 'HOME': '/home/cltbld', 22:38:45 INFO - 'LANG': 'en_US.UTF-8', 22:38:45 INFO - 'LANGUAGE': 'en_US:en', 22:38:45 INFO - 'LOGNAME': 'cltbld', 22:38:45 INFO - 'MAIL': '/var/mail/cltbld', 22:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:45 INFO - 'MOZ_NO_REMOTE': '1', 22:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:45 INFO - 'NO_EM_RESTART': '1', 22:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:45 INFO - 'PWD': '/builds/slave/test', 22:38:45 INFO - 'SHELL': '/bin/bash', 22:38:45 INFO - 'SHLVL': '1', 22:38:45 INFO - 'TERM': 'linux', 22:38:45 INFO - 'TMOUT': '86400', 22:38:45 INFO - 'USER': 'cltbld', 22:38:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:45 INFO - '_': '/tools/buildbot/bin/python'} 22:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:38:45 INFO - Running setup.py (path:/tmp/pip-l1SaqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:38:45 INFO - Running setup.py (path:/tmp/pip-4dMcb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:38:45 INFO - Running setup.py (path:/tmp/pip-dnojv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:38:45 INFO - Running setup.py (path:/tmp/pip-mPAcux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:38:45 INFO - Running setup.py (path:/tmp/pip-mIMk1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:38:45 INFO - Running setup.py (path:/tmp/pip-cpzBYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:38:46 INFO - Running setup.py (path:/tmp/pip-tRUOTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:38:46 INFO - Running setup.py (path:/tmp/pip-UqasP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:38:46 INFO - Running setup.py (path:/tmp/pip-sqrQZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:38:46 INFO - Running setup.py (path:/tmp/pip-eULBMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:38:46 INFO - Running setup.py (path:/tmp/pip-BUBLVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:38:46 INFO - Running setup.py (path:/tmp/pip-IRQCta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:38:46 INFO - Running setup.py (path:/tmp/pip-oqFOZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:38:46 INFO - Running setup.py (path:/tmp/pip-D_pm6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:46 INFO - Running setup.py (path:/tmp/pip-JJXh2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:38:46 INFO - Running setup.py (path:/tmp/pip-jmBiCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:38:46 INFO - Running setup.py (path:/tmp/pip-lO0ZFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:38:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:38:46 INFO - Running setup.py install for manifestparser 22:38:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:38:46 INFO - Running setup.py install for mozcrash 22:38:47 INFO - Running setup.py install for mozdebug 22:38:47 INFO - Running setup.py install for mozdevice 22:38:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Running setup.py install for mozfile 22:38:47 INFO - Running setup.py install for mozhttpd 22:38:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Running setup.py install for mozinfo 22:38:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Running setup.py install for mozInstall 22:38:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Running setup.py install for mozleak 22:38:47 INFO - Running setup.py install for mozlog 22:38:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Running setup.py install for moznetwork 22:38:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:38:47 INFO - Running setup.py install for mozprocess 22:38:48 INFO - Running setup.py install for mozprofile 22:38:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:38:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:38:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:38:48 INFO - Running setup.py install for mozrunner 22:38:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:38:48 INFO - Running setup.py install for mozscreenshot 22:38:48 INFO - Running setup.py install for moztest 22:38:48 INFO - Running setup.py install for mozversion 22:38:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:38:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:38:48 INFO - Cleaning up... 22:38:48 INFO - Return code: 0 22:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:48 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 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38:48 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 22:38:48 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 22:38:48 INFO - Using env: {'DISPLAY': ':0', 22:38:48 INFO - 'HOME': '/home/cltbld', 22:38:48 INFO - 'LANG': 'en_US.UTF-8', 22:38:48 INFO - 'LANGUAGE': 'en_US:en', 22:38:48 INFO - 'LOGNAME': 'cltbld', 22:38:48 INFO - 'MAIL': '/var/mail/cltbld', 22:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:48 INFO - 'MOZ_NO_REMOTE': '1', 22:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:48 INFO - 'NO_EM_RESTART': '1', 22:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:48 INFO - 'PWD': '/builds/slave/test', 22:38:48 INFO - 'SHELL': '/bin/bash', 22:38:48 INFO - 'SHLVL': '1', 22:38:48 INFO - 'TERM': 'linux', 22:38:48 INFO - 'TMOUT': '86400', 22:38:48 INFO - 'USER': 'cltbld', 22:38:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:48 INFO - '_': '/tools/buildbot/bin/python'} 22:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:38:48 INFO - Running setup.py (path:/tmp/pip-jG8CTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:38:48 INFO - Running setup.py (path:/tmp/pip-nJRlcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:38:48 INFO - Running setup.py (path:/tmp/pip-k2bgr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:38:49 INFO - Running setup.py (path:/tmp/pip-Diglcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:38:49 INFO - Running setup.py (path:/tmp/pip-p_heqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:38:49 INFO - Running setup.py (path:/tmp/pip-WqVqL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:38:49 INFO - Running setup.py (path:/tmp/pip-kFr3FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:38:49 INFO - Running setup.py (path:/tmp/pip-Jet_sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:38:49 INFO - Running setup.py (path:/tmp/pip-KaEA1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:38:49 INFO - Running setup.py (path:/tmp/pip-AWCFG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:38:49 INFO - Running setup.py (path:/tmp/pip-olQAF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:38:49 INFO - Running setup.py (path:/tmp/pip-DX9eA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:38:49 INFO - Running setup.py (path:/tmp/pip-e2Birp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:38:49 INFO - Running setup.py (path:/tmp/pip-SLcRkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:38:49 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)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:49 INFO - Running setup.py (path:/tmp/pip-DK10HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:38:49 INFO - Running setup.py (path:/tmp/pip-LL5Jbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:38:50 INFO - Running setup.py (path:/tmp/pip-J_7Q7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:38:50 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)) 22:38:50 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)) 22:38:50 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)) 22:38:50 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)) 22:38:50 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)) 22:38:50 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)) 22:38:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:51 INFO - Downloading blessings-1.6.tar.gz 22:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:38:52 INFO - Installing collected packages: blessings 22:38:52 INFO - Running setup.py install for blessings 22:38:52 INFO - Successfully installed blessings 22:38:52 INFO - Cleaning up... 22:38:52 INFO - Return code: 0 22:38:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:38:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:38:52 INFO - Reading from file tmpfile_stdout 22:38:52 INFO - Current package versions: 22:38:52 INFO - argparse == 1.2.1 22:38:52 INFO - blessings == 1.6 22:38:52 INFO - blobuploader == 1.2.4 22:38:52 INFO - docopt == 0.6.1 22:38:52 INFO - manifestparser == 1.1 22:38:52 INFO - mozInstall == 1.12 22:38:52 INFO - mozcrash == 0.17 22:38:52 INFO - mozdebug == 0.1 22:38:52 INFO - mozdevice == 0.48 22:38:52 INFO - mozfile == 1.2 22:38:52 INFO - mozhttpd == 0.7 22:38:52 INFO - mozinfo == 0.9 22:38:52 INFO - mozleak == 0.1 22:38:52 INFO - mozlog == 3.1 22:38:52 INFO - moznetwork == 0.27 22:38:52 INFO - mozprocess == 0.22 22:38:52 INFO - mozprofile == 0.28 22:38:52 INFO - mozrunner == 6.11 22:38:52 INFO - mozscreenshot == 0.1 22:38:52 INFO - mozsystemmonitor == 0.0 22:38:52 INFO - moztest == 0.7 22:38:52 INFO - mozversion == 1.4 22:38:52 INFO - psutil == 3.1.1 22:38:52 INFO - requests == 1.2.3 22:38:52 INFO - wsgiref == 0.1.2 22:38:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:38:52 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')]} 22:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:52 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')]} 22:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:52 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 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38:52 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 22:38:52 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 22:38:52 INFO - Using env: {'DISPLAY': ':0', 22:38:52 INFO - 'HOME': '/home/cltbld', 22:38:52 INFO - 'LANG': 'en_US.UTF-8', 22:38:52 INFO - 'LANGUAGE': 'en_US:en', 22:38:52 INFO - 'LOGNAME': 'cltbld', 22:38:52 INFO - 'MAIL': '/var/mail/cltbld', 22:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:52 INFO - 'MOZ_NO_REMOTE': '1', 22:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:52 INFO - 'NO_EM_RESTART': '1', 22:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:52 INFO - 'PWD': '/builds/slave/test', 22:38:52 INFO - 'SHELL': '/bin/bash', 22:38:52 INFO - 'SHLVL': '1', 22:38:52 INFO - 'TERM': 'linux', 22:38:52 INFO - 'TMOUT': '86400', 22:38:52 INFO - 'USER': 'cltbld', 22:38:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:52 INFO - '_': '/tools/buildbot/bin/python'} 22:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 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)) 22:38:52 INFO - Cleaning up... 22:38:52 INFO - Return code: 0 22:38:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:38:52 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')]} 22:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:52 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')]} 22:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:52 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 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38:52 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 22:38:52 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 22:38:52 INFO - Using env: {'DISPLAY': ':0', 22:38:52 INFO - 'HOME': '/home/cltbld', 22:38:52 INFO - 'LANG': 'en_US.UTF-8', 22:38:52 INFO - 'LANGUAGE': 'en_US:en', 22:38:52 INFO - 'LOGNAME': 'cltbld', 22:38:52 INFO - 'MAIL': '/var/mail/cltbld', 22:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:52 INFO - 'MOZ_NO_REMOTE': '1', 22:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:52 INFO - 'NO_EM_RESTART': '1', 22:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:52 INFO - 'PWD': '/builds/slave/test', 22:38:52 INFO - 'SHELL': '/bin/bash', 22:38:52 INFO - 'SHLVL': '1', 22:38:52 INFO - 'TERM': 'linux', 22:38:52 INFO - 'TMOUT': '86400', 22:38:52 INFO - 'USER': 'cltbld', 22:38:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:52 INFO - '_': '/tools/buildbot/bin/python'} 22:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:52 INFO - Downloading/unpacking jsonschema 22:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:38:54 INFO - Downloading/unpacking functools32 (from jsonschema) 22:38: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 22:38: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 22:38: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 22:38: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 22:38: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 22:38: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 22:38:54 INFO - Downloading functools32-3.2.3-2.tar.gz 22:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:38:55 INFO - warning: no files found matching '*.txt' 22:38:55 INFO - no previously-included directories found matching 'build' 22:38:55 INFO - no previously-included directories found matching 'dist' 22:38:55 INFO - no previously-included directories found matching '.git*' 22:38:55 INFO - Installing collected packages: jsonschema, functools32 22:38:55 INFO - Running setup.py install for functools32 22:38:55 INFO - warning: no files found matching '*.txt' 22:38:55 INFO - no previously-included directories found matching 'build' 22:38:55 INFO - no previously-included directories found matching 'dist' 22:38:55 INFO - no previously-included directories found matching '.git*' 22:38:55 INFO - Successfully installed jsonschema functools32 22:38:55 INFO - Cleaning up... 22:38:55 INFO - Return code: 0 22:38:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 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 0x7f3393d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', '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 22:38:55 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 22:38:55 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 22:38:55 INFO - Using env: {'DISPLAY': ':0', 22:38:55 INFO - 'HOME': '/home/cltbld', 22:38:55 INFO - 'LANG': 'en_US.UTF-8', 22:38:55 INFO - 'LANGUAGE': 'en_US:en', 22:38:55 INFO - 'LOGNAME': 'cltbld', 22:38:55 INFO - 'MAIL': '/var/mail/cltbld', 22:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:55 INFO - 'MOZ_NO_REMOTE': '1', 22:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:55 INFO - 'NO_EM_RESTART': '1', 22:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:55 INFO - 'PWD': '/builds/slave/test', 22:38:55 INFO - 'SHELL': '/bin/bash', 22:38:55 INFO - 'SHLVL': '1', 22:38:55 INFO - 'TERM': 'linux', 22:38:55 INFO - 'TMOUT': '86400', 22:38:55 INFO - 'USER': 'cltbld', 22:38:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:55 INFO - '_': '/tools/buildbot/bin/python'} 22:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:55 INFO - Downloading/unpacking flake8 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:38:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:38:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 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 22:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:38:58 INFO - no previously-included directories found matching 'docs/_build' 22:38:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:38:58 INFO - Running setup.py install for pep8 22:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:38:58 INFO - no previously-included directories found matching 'docs/_build' 22:38:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:38:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:38:58 INFO - Cleaning up... 22:38:58 INFO - Return code: 0 22:38:58 INFO - Running post-action listener: _resource_record_post_action 22:38:58 INFO - Running post-action listener: _start_resource_monitoring 22:38:58 INFO - Starting resource monitoring. 22:38:58 INFO - ##### 22:38:58 INFO - ##### Running install step. 22:38:58 INFO - ##### 22:38:58 INFO - Running pre-action listener: _resource_record_pre_action 22:38:58 INFO - Running main action method: install 22:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:38:58 INFO - Reading from file tmpfile_stdout 22:38:58 INFO - Detecting whether we're running mozinstall >=1.0... 22:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:38:58 INFO - Reading from file tmpfile_stdout 22:38:58 INFO - Output received: 22:38:58 INFO - Usage: mozinstall [options] installer 22:38:58 INFO - Options: 22:38:58 INFO - -h, --help show this help message and exit 22:38:58 INFO - -d DEST, --destination=DEST 22:38:58 INFO - Directory to install application into. [default: 22:38:58 INFO - "/builds/slave/test"] 22:38:58 INFO - --app=APP Application being installed. [default: firefox] 22:38:58 INFO - mkdir: /builds/slave/test/build/application 22:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:39:14 INFO - Reading from file tmpfile_stdout 22:39:14 INFO - Output received: 22:39:14 INFO - /builds/slave/test/build/application/firefox/firefox 22:39:14 INFO - Running post-action listener: _resource_record_post_action 22:39:14 INFO - ##### 22:39:14 INFO - ##### Running run-tests step. 22:39:14 INFO - ##### 22:39:14 INFO - Running pre-action listener: _resource_record_pre_action 22:39:14 INFO - Running main action method: run_tests 22:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:39:14 INFO - Python 2.7.3 22:39:14 INFO - Return code: 0 22:39:14 INFO - grabbing minidump binary from tooltool 22:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:14 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 0x26e8410>, '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 0x26e9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:39:14 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 22:39:14 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 22:39:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:39:14 INFO - Return code: 0 22:39:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:39:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:39:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:39:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:39:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:39:15 INFO - Return code: 0 22:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 22:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 22:39:15 INFO - Using env: {'DISPLAY': ':0', 22:39:15 INFO - 'HOME': '/home/cltbld', 22:39:15 INFO - 'LANG': 'en_US.UTF-8', 22:39:15 INFO - 'LANGUAGE': 'en_US:en', 22:39:15 INFO - 'LOGNAME': 'cltbld', 22:39:15 INFO - 'MAIL': '/var/mail/cltbld', 22:39:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:39:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:15 INFO - 'MOZ_NO_REMOTE': '1', 22:39:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:15 INFO - 'NO_EM_RESTART': '1', 22:39:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:15 INFO - 'PWD': '/builds/slave/test', 22:39:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:39:15 INFO - 'SHELL': '/bin/bash', 22:39:15 INFO - 'SHLVL': '1', 22:39:15 INFO - 'TERM': 'linux', 22:39:15 INFO - 'TMOUT': '86400', 22:39:15 INFO - 'USER': 'cltbld', 22:39:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505', 22:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:15 INFO - '_': '/tools/buildbot/bin/python'} 22:39:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 22:39:15 INFO - mozversion application_buildid: 20160414215149 22:39:15 INFO - mozversion application_changeset: 54b5c7592f7337ccb28a288633c0997b752c85e2 22:39:15 INFO - mozversion application_display_name: Nightly 22:39:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:39:15 INFO - mozversion application_name: Firefox 22:39:15 INFO - mozversion application_remotingname: firefox 22:39:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:39:15 INFO - mozversion application_vendor: Mozilla 22:39:15 INFO - mozversion application_version: 48.0a1 22:39:15 INFO - mozversion platform_buildid: 20160414215149 22:39:15 INFO - mozversion platform_changeset: 54b5c7592f7337ccb28a288633c0997b752c85e2 22:39:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:39:15 INFO - mozversion platform_version: 48.0a1 22:39:15 INFO - using testdate: 1460698755 22:39:15 INFO - actual date: 1460698755 22:39:15 INFO - starting webserver on 'localhost:46974' 22:39:15 INFO - SUITE-START | Running 2 tests 22:39:15 INFO - TEST-START | dromaeo_css 22:39:15 INFO - operating with platform_type : linux_ 22:39:15 INFO - Initialising browser for dromaeo_css test... 22:39:15 INFO - TEST-INFO | started process 15690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbdf6Di/profile http://localhost:46974/getInfo.html) 22:39:19 INFO - PROCESS | 15690 | 22:39:19 INFO - PROCESS | 15690 | (process:15756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:39:19 INFO - PROCESS | 15690 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:39:20 INFO - PROCESS | 15690 | __metrics Screen width/height:1600/1200 22:39:20 INFO - PROCESS | 15690 | colorDepth:24 22:39:20 INFO - PROCESS | 15690 | Browser inner width/height: 1024/697 22:39:20 INFO - PROCESS | 15690 | __metrics 22:39:21 ERROR - PROCESS | 15690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:39:22 INFO - TEST-INFO | 15690: exit 0 22:39:22 INFO - Browser initialized. 22:39:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:39:22 INFO - TEST-INFO | started process 15807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbdf6Di/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:39:24 INFO - PROCESS | 15807 | 22:39:24 INFO - PROCESS | 15807 | (process:15866): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:39:34 INFO - PROCESS | 15807 | RSS: Main: 164638720 22:39:34 INFO - PROCESS | 15807 | 22:40:23 INFO - PROCESS | 15807 | 1460698823957 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] 22:42:35 INFO - PROCESS | 15807 | Cycle 1(1): loaded http://localhost:46974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46974/tests/dromaeo/cssquery-ext.html) 22:42:36 INFO - PROCESS | 15807 | RSS: Main: 169205760 22:42:36 INFO - PROCESS | 15807 | 22:45:38 INFO - PROCESS | 15807 | Cycle 1(1): loaded http://localhost:46974/tests/dromaeo/cssquery-ext.html (next: http://localhost:46974/tests/dromaeo/cssquery-jquery.html) 22:45:39 INFO - PROCESS | 15807 | RSS: Main: 165089280 22:45:39 INFO - PROCESS | 15807 | 22:48:41 INFO - PROCESS | 15807 | Cycle 1(1): loaded http://localhost:46974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46974/tests/dromaeo/cssquery-mootools.html) 22:48:41 INFO - PROCESS | 15807 | RSS: Main: 165830656 22:48:41 INFO - PROCESS | 15807 | 22:51:43 INFO - PROCESS | 15807 | Cycle 1(1): loaded http://localhost:46974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46974/tests/dromaeo/cssquery-prototype.html) 22:51:44 INFO - PROCESS | 15807 | RSS: Main: 163913728 22:51:44 INFO - PROCESS | 15807 | 22:54:46 INFO - PROCESS | 15807 | Cycle 1(1): loaded http://localhost:46974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46974/tests/dromaeo/cssquery-yui.html) 22:54:47 INFO - PROCESS | 15807 | RSS: Main: 165089280 22:54:47 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | Cycle 1(1): loaded http://localhost:46974/tests/dromaeo/cssquery-yui.html (next: http://localhost:46974/tests/dromaeo/cssquery-dojo.html) 22:57:50 INFO - PROCESS | 15807 | RSS: Main: 167133184 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | __start_tp_report 22:57:50 INFO - PROCESS | 15807 | _x_x_mozilla_page_load 22:57:50 INFO - PROCESS | 15807 | _x_x_mozilla_page_load_details 22:57:50 INFO - PROCESS | 15807 | |i|pagename|runs| 22:57:50 INFO - PROCESS | 15807 | |0;dojo.html;2585.844849309042;2604.9739502604975;2637.77578905793;2647.2587675450854;2650.112212408845;4783.665143439956;4800.687955282909;4803.7357945313;4807.951920480794;4847.466778654345;4717.033008233312;4780.378550788401;4799.928001079987;4846.4911184325665;4863.148948933931;4322.113966636847;4362.934555981663;4367.213901497729;4376.212281789277;4380.102079073798;627.9899741415892;4094.9269506675378;4283.785810709452;4335;4366.061296821183;4344.891377715567;4387.254166791621;4389.934150987738;4397.758123303217;4415.602595766364;4377.934330985037;4391.429114215163;4394.736315821061;4397.159586395914;4440.444944381952;4350.086481838817;4398.538153493901;4410.360497727812;4422.204003279408;4442.644588432918;4624.907501849944;4640.83757068501;4650.162970665279;4659.5573420525;4670.696404733681;5005.74971251436;5076.44159142494;5112.309838171836;5132.717700526469;5134.435212126663;5139.922901156486;5148.665336753099;5154.819581314673;5156.278121063054;5197.48025197481;4757.785899634525;4765.332853400527;4800.903981920342;4807.11068452334;4845.9030819383415;5158.123119069767;5267.473252674778;5272.762725677354;5315.255864179018;5339.172428273546;5053.570446512014;5066.518680725325;5076.543111120017;5081.390233172043;5114.43741188469;5142.5628821549835;5151.97424012885;5161;5173.586113111018;5218.034663587248;5023.372078490189;5048.167052436307;5104.642675012714;5181.740912954413;5196.45437229093;5094.057599344059;5099.69401835891;5100.158473851847;5107.361579802525;5117.797317630354;4324.048709283952;4329.199098166786;4329.458817647794;4367.6287515561535;4385.7149285296355;3667.8349474273723;3672.4674922136674;3684.8526058957877;3785.7917814520465;3814.5994670559194;4486.865394038119;4510.188166130062;4516.187086324428;4533.206688829442;4559.840405585788;5164.04465173944;5167.534921857051;5175.534201921845;5184.144616138295;5185.637005409661;4376.277914144194;4520.819167233274;4535.183666939916;4597.839075632403;4617.8383756568355;4614.676972611952;4634.351190833286;4636.211843986531;4636.721796692209;4678.298255261738;4873.366462359942;4882.243252295829;4889.511048895082;4910.656254062182;4937.703737775745;5110.029094472038;5160.690358578498;5200.375954885438;5229.686218826882;5244.947550524598;4844.539768721966;4883.218685010382;4893.21708526634;4902.509749025069;4934.457209706858;4938.407391113089;5103.974480127576;5114.488551144856;5120.718360490208;5128.8461346159675;5160.896782064263;5210.192420174879;5223.216517522402;5242.68543887368;5277.2875661785165;5011.398632164018;5012.448630650552;5019.196928491424;5025.84922452327;5034.270030845581;4868.245421959602;4970.527799859007;4979.302897594413;4989.476105008922;4995.425526064404;4850.738807910039;4893;4934.777934992862;4984.775685094107;5002.049610573979;5039.571636410799;5058;5060.746962651926;5067.366579177603;5116.1046816806165;4842.6368022397755;4919.901601968012;4944.307796908508;4965.354503914468;5016.698998060128 22:57:50 INFO - PROCESS | 15807 | |1;ext.html;566.4505429733157;587.0929414055284;606.6420811721084;613.3988691082742;637.1080487317757;32644.183895402628;33558.49662255068;33723.15692107699;33779.32441351171;33875.661243387556;33751;34050.65949340506;34245.486317705196;34265.65734342656;34292;7643.9235607643905;7806.843863122735;7844.803879902991;7869.842603147934;7871.8425631487335;7703.114141873672;7801.258880406381;7823.530588164728;7835.1381348051955;7838.294553490185;7834.412419068564;7905.090914544843;7912.485688430263;7914.28771410573;7914.445988780788;7729.111152217482;7767.844643107134;7805.687772489094;7826.452148349618;7828.647710853025;7713.961430192813;7751.263629955145;7829.334506566948;7861.135275119732;7861.449698521106;29897.850510747525;34694.82652586721;35241;35344.64655353465;35446.29107417863;2936.6476022877177;2958.5118455454826;2970.212893583202;2979.2551862034493;3063.172943305295;23828.16601418942;24261;24318.27045188647;24412.145574904793;24491.510169796682;3208.598925134358;3255.4465740824116;3262.885798997024;3361.5461912641726;3379.4761811919193;152679.23660381738;153397;154984.22507887502;155352;155535;31542.21144471361;31751.364972700416;31768.682313176574;31801.8409907949;31816.840915795274;32704.83647581747;58764.7061764697;60645;60753.69623151945;60801.39198608046;14596.635084122981;14764.335604897591;14764.40942362315;14779.63050923714;14783.334749936279;10566.788664226673;10592.046715795615;10595.152387808957;10605.151587873106;10629;17854.642907141784;17978.5505362367;18014.729779053323;18142.365017224598;18782.90608546976;6977.267386924402;6995.755148569878;7093.32613401726;7269.382102521239;7288.6720097595735;946.8579713043099;1019.3832731197518;1048.4390850894736;1079.2822772855964;1094.6497120921229;26855;27446.5883011755;27546.44907101887;27683.446331073264;27791.30521736932;1012.2104758288547;1026.5944951744168;1094.4582431696201;1104.9447527623586;1167.048855183023;14699;15133.470328538448;15141.242937853063;15361.231938403034;15379.692406151815;345403;346560;348424;350190;353083;47192.29211561829;48427.515724843004;48520;48567.271490926956;48821.26768098411;1239.5847391123893;1243.0801207106856;1284.4990453723055;1286.8391451068617;1301.5965050834461;25548.872255638602;27603.30991725223;28148.296292592848;28264.717352827032;28493.145205643865;41700.58299416967;41765.16469670529;41908.58091419169;42235.3664695036;42239.788801055794;304481;305075;305599;306274;306443;25364.11225607095;25783.226503204933;25795.226143215732;25832.354191145372;38152.236955261294;39006.80496597499;39210.803945980086;39776.624571296554;40056.1988760229;40233.79883100566;34584;34719.82640086783;34788.130296742784;35120.47319290161;35512.64487355093;33658.32683346368;33906.321873561894;33913.32173356568;34044.65955340415;34212.65787342095;31004.68995310018;34060.489092664124;34386.656133438344;37885.81057094697;37959.05102372463;30044.849775750983;31509.212269693442;31855.6814431862;31906;31913.202169945936;22413.887930560242;22498.550028999656;22503.774962250824;22825.771742282366;22861.42846428786 22:57:50 INFO - PROCESS | 15807 | |2;jquery.html;365.7293602733977;366.9376206044974;368.8672078051901;384.4751913637883;388.27780328588835;15530.689386212283;16291.75562366564;17636.559086022855;17706.734398984026;17717.202725877334;15260.84739152611;16129.274182661778;16791.412300569482;16849.07330096844;16871.40950066748;5069.340985671866;5216.8174113906025;5246.842594722164;5253.185756207794;5257.658252213613;3611.4763359312883;5174.4825517448335;5676.318841738997;6078.726457309432;6083.634981901078;5957.2851257849115;5967.940320596804;5983.790567330123;5990.6106103103375;6042.788502402417;5701.800436984707;5861.179434879099;5883.61756485827;5887.4406931341455;5896.970515147418;5218.269442278084;5219.791208351661;5244.868878278074;5260.368755749335;5327.280817089721;20485.180592776273;20543.38369848907;20654.07056682438;20830.687539686918;20854.58290834175;1915.329634627883;2017.384697667211;2036.7046778217223;2165.2962787094098;2271.3980795089315;13354.065215434923;13529.255890925995;13556.322183890767;13615.52345667897;13824.86175138256;1617.7573363995496;1724.3447489953737;1739.9739003914951;1801.4235444657716;1869.3457289948544;67925.3207467924;68810.65594672045;70420.99999999949;70508;71030.28969710288;9338.813223735624;9461.574229159703;9847.606095756233;9853.211743060538;9870.654527091518;12997.740045199233;13036.152650077714;13036.217826930415;13077.084604077814;13107.344632768323;7057.18842333128;7068.540544864567;7172.641367931687;7192.100987376578;7312.926870731225;6842.144731908512;6942.652867356612;7056.294370563005;7116.790145675248;7174.282571742784;6075.665838378844;6187.752489900354;6197.101420294122;6217.222847144107;6253.218347706536;1593.9282732277075;1694.1359906447553;1740.2342969093559;1893.308942236074;1903.3814010446383;826.3595713322103;901.3420203251663;959.8512230604267;968.4383057826444;1013.4020927652573;16630.417935372203;16864.32542698303;17110.144492775562;17178.828211717722;17201.397951071653;918.4122161816442;922.847730124522;937.2080591899834;941.9529023548795;984.8768903887014;9625.56684949179;9787.412755234567;9788.412695238309;9800.607975680892;10037.34757240777;360314;360834;373004;373875;376426;68139.31860681428;68547.31452685509;69266.307336927;71149;79408;968.7578105473632;980.3284749946167;984.9655262065793;990.9405435673883;992.1318846009741;14983.850161498245;15036.924815376291;15157.014794038352;15284.541463756104;15448.382064717285;30631;31409.52885706762;32670;32971.17572060718;33145.50281745727;42627.3605895918;42933.14133717371;43789.78105109454;43868;44105.55894441014;5837.445442682938;5894.587378883437;7173.210946795744;7208.603526806076;7416.7033318666645;11070.169737269576;11315.264507806965;11378.08975281959;11628.360440175871;11705.356205408443;9981.681782108182;10371.481425928825;10389.792204156025;10420.583176672848;10444.164466842481;10052.346597471142;10114.393136411838;10233.84649230277;10343.224258180817;10686.145108391154;10243;10542.57829686804;10684.038436540748;10779.137668986305;10820.945895270474;7320.304571065741;7364.631768411451;7405.888911666437;7434.8884766729625;7711.190325015793;10049.19606431469;10625.203109766644;10656.307340022873;10816.278733698891;10970.670879873616 22:57:50 INFO - PROCESS | 15807 | |3;mootools.html;1451.6080658222281;1487.9628009299768;1621.8053833539977;1763.497403240077;1804.1971322761376;6997.51017428779;7554.773356799298;7610.16288208298;7880.881786773203;7913.4856234344725;7662.6551805168765;7763.378929685626;7790.18203088676;7818.100918394386;7826.373890088794;2180.3349978256624;2198.6372248578964;2199.285232299509;2204.4378683435702;2207.9116835326568;2202.6365649667864;2203.03066650674;2207.7902599253043;2220.2451166603432;2223.8999245033933;2165.8808765517892;2190.5837890800776;2193.5064610462678;2201.0755482697227;2227.12028748645;2180.6292930201826;2185.7158569385956;2189.179057853305;2189.4854709143337;2190.671399290103;2158.870467771939;2176.684380764796;2181.2474696229774;2187.55155193185;2200.2409168836725;7904.723334683258;7905.762827115196;7925.841483170362;7926.6036698165435;7974.521528708238;4472.306792447176;4540.682152249344;4584.518625544337;4598.88502787433;4645.65157613177;2914.1985953862645;2948.837813920255;3002.24943764059;3014.171102946685;3044.9238769030953;1009.7677534167109;1019.3527110284948;1022.4734261855151;1051.9947400263027;1054.6150655010865;10488.160947124288;10596.523156457977;10609.310394824235;10616.57533698651;10642.255042147053;4121.855735049319;4133.545310015896;4365.825366985348;4388.034632380871;4417.602415782595;9065.637374505079;9092.954535227414;9139.862902056475;9141.3601047926;9208.815823683488;4723.48041715411;4744.786484608201;4766.475687674353;4782.904341913142;4787.688800227974;3741.1769410729594;4212.199682060399;4319.3952846601505;4320.416743739618;4360.7601581913295;3600.171960449059;3705.5368078990127;3734.925301493955;3755.3052685253315;3785.6592906638534;1220.1154163231763;1239.535174309634;1240.0637518673343;1246.0343233993547;1257.2142410993129;869.9608517616596;875.9386842920934;887.121749468022;900.3967341880956;908.3051465628799;5336.17289320156;5372.62391632582;5400.675959442446;5516.420775818481;5535.640183388067;421.3111562595179;439.4353256066004;446.5199910096659;447.61057879644267;449.17800425221765;3967.067739081371;3967.166894952092;3970.4242884781543;4011.5186177658866;4014.1770936957855;9353.532323383804;9677.854832177523;9710.126088652056;9733.805323893483;9776.51117444125;9598.904010959941;9654.517274136266;9669.468179250069;9678.806423871483;9709.36889102206;6986.091808064919;7045.577265364094;7048.154221493453;7080.221175670672;7330.193678695339;5662.122371032497;5696.316442026818;5716.314042314949;5730.255066841284;5899.351071382231;8790.42862213954;8825.602847871733;8934.374593778373;8951.73144805657;8973.147550982647;8642.178992995656;8955.970063442788;8997.820043599222;9047.095290470901;9106.089391060841;6143.324234334309;6613.933860661332;6832.521723479507;6859.485538584527;6965.442764578923;7139.964300178466;7175.246599107228;7232.168300645282;7243.311885370881;7273.672684729094;6452.645104519296;6653.068570400244;6778.152730908637;6832.59004459734;6899.413549848319;6734.6632668367365;6783.118194634666;6854.828629284308;6889.931100688929;6898.172219333512;6142.447179753844;6477.740890364333;6586.077949087227;6602.702878370581;6644.4020038196795;4488.730676159441;4587.885302867455;4643.048175124159;4682.719036857799;4962.181240095344;4788;4807.254875494304;4868.464468908346;4958.107540642574;5044.646874718735 22:57:50 INFO - PROCESS | 15807 | |4;prototype.html;317.2006543510354;320.04466666999;326.7875880677559;329.4711987260447;334.0846081736044;5383.892322153554;5396.271503347047;5413.106837371839;5413.133898576224;5445.618806683534;5285.418603953562;5328.413874473805;5329.706866122362;5333.38666053403;5342.332208473941;3981.9601803981877;4036.5156181258144;4165.812538435777;4167.5832416758385;4178.97910510447;4147.523034850986;4182.20538097762;4186.853460128896;4191.434156388879;4192.4759405074365;4147.543770185277;4152.584741525853;4154.771487568182;4157.605027522396;4176.206520761061;4070.816813243396;4119.423280740699;4142.689298302625;4145.79271036447;4167.374893765929;3649.671529562352;3656.597774244831;3667.8166091695307;3676.1361080146144;3686.686631636314;5077.695338279715;5087.109755792721;5115.923261151049;5117.8464646060675;5118.590512759008;4709.976450117728;4756.548127927841;4792.429639918283;4818.518148185189;4818.807247710088;5607.439256074401;5633.971830140823;5640.37955824863;5644.238027866227;5662.716864156776;4026;4037.1723796621623;4038.838446462138;4047.959520404788;4048.0689441428635;5816.796412125597;5918.964181268304;5945.435183657589;5950.553708471882;5961.225040744719;4142.150859073882;4145.523264824584;4147.896302592399;4156.916861662749;4166.687498437629;4199.202151591249;4201.495820501559;4223.408722778813;4234.047339348622;4240.512341080754;4695.460022097503;4785.306130611042;4791.880202994883;4793.424789025339;4816.95183048165;5634.32388113429;5656.349519805275;5661.716914154275;5663.773449062074;5677.205191273225;1443.7906503556926;1457.9271036448347;1460.8247010358612;1468.7649976004002;1469.5591322603177;944.3483996042709;977.5503268496429;994.2344394815951;1017.5115944346755;1032.0917592518535;4897;4936.48166942473;4938.160512712848;4955.008998200375;4981.37732783402;5791.362950075489;5796.82609521715;5813.331466881278;5827.329857066492;5839.941600584025;4815.277708343707;4960.280759289883;4962.280469331927;4974.104661160954;4986.6010719143105;3106.7669924755733;3109.689031096872;3128.6402063762503;3129.6244450666068;3134.2477805326557;5374.946250537523;5440.6735595864375;5455.208994695747;5458.317710286215;5458.727063646802;5751.482366587027;5974.790882319098;5979.970100149471;5980.684249465111;5981;5442;5462.7268636568015;5477;5488.4785945335125;5489.176623506506;5647;5751.827445176651;5760.868478662922;5803.65178089316;5966.403359664172;5746.195532625352;5766.509846663081;5815.76736930518;5841.415858414124;5864.149698293638;5525.751341189576;5530.5022547970875;5538.307711536058;5543.9168412474655;5555.666660000413;3835.232953409385;4037.9798101009305;4060.512738471284;4070.816813243352;4072.75563466193;5833;5843.1235314703135;5854.658136745165;5872.1778950947755;5878.970605146947;5521.585881058856;5649.971750141387;5658.066419040977;5666.773329066791;5684.118961560965;5539.584531160099;5607.243022191952;5607.934492446422;5611.905678392674;5613.943860561342;5304.204369344475;5525.364583072837;5541.667499950016;5541.889162216652;5564.610477266552;5539.14143307788;5733.018830208185;5758.913616295675;5763.33721622002;5767.913481297868;5580.5535557156145;5585.636933599303;5585.748641311069;5591.776328946959;5623.943760562342 22:57:50 INFO - PROCESS | 15807 | |5;yui.html;654.2378129479157;696.2098018748725;761.337636256457;776.3672606825437;798.3812545277409;11801.645950621474;11860;11907.940460297708;11911.76176476472;12017.519299228032;11456.31262124273;11564.363959982198;11579.594714184985;11588.826167607493;11626.651200463999;626.1671976271571;760.6501009535621;779.1740754799902;790.2453157234827;792.3621484704811;776.1462391369505;777.0869228656335;787.0633945604741;788.996055019727;790.3716545346434;816.1512027491402;823.8064054947083;824.4146655874306;830.3066939105854;831.4221615976899;811.2617518058568;811.8903947967037;814.7840822182097;819.086718309087;819.5369616166847;605.0379895965392;605.1044454207753;606.5693357716027;608.4827896288164;614.913912052313;12040.638780836589;12131.272123672608;12173.573924912585;12198.817017744741;12217.144799864012;12655.11414200997;12988.350582470934;13040.347982600832;13148.342582870819;13285.933570332087;10112.342697724624;10203.489825508768;10280.537375818032;10368.948155259252;10531.15750739939;3326.617438994522;3336.916577085568;3358.7313014958745;3372.0558243691808;3405.625381208065;44773.776131119135;44885.77557112226;45230.32154517685;45341.31988020182;45618;10142;10223.28437009417;10274.589016439259;10344.5344959477;10429.739256518647;18181.272749089887;18324.633507329778;18374.81625183758;18478.260869565067;18857.811421885606;6715.496337774686;6805.149356330458;6810.829729256809;6883.242843287235;6983.930160698328;3668.743187976816;3757.8496860125288;3792.4311353297226;3805.8477660893254;3870.9806450968126;2853.3865218977603;2965.273507990513;2969.747571456407;2977.419403216352;2988.2678743707497;495.2942057567951;509.38364578859256;518.388301803875;522.8771238758889;533.8211699080852;618.904069869171;627.2817623820699;628.3936001758325;629.9748010079637;630.700417301778;7519.962400187964;7618.847623047508;7686.654100565488;7918.920810791934;8007.359411247203;494.0982706560541;529.8039725301663;565.7454145634399;640.5836206465741;667.2626747444004;3609.9458508122398;3666.834992425347;3741.3639681254253;3743.494628225155;3763.6800871926193;50347;50531.74734126306;51571;52351;52405.47594524006;43636.345454817565;43766.56233437625;44473.33290000653;45162.32256516155;45482.31776523355;41007.38488922668;41151;41670;41866.79066604708;42337.78831105825;7242.058532390755;7273.599952002479;7277.9272207277245;7279.4540409470565;7414.66634001482;27572.862135689193;28356.858215708788;28363;28789;28896.7110328894;34192;34982;36964.6303536972;37359.6264037367;37561.24877502489;9090.545472726206;9134.132257435533;9142.634294628406;9172.954135229282;9416.293777966817;10203;11786.76426471483;11830.822537662114;12463.376831158586;13007.56576664096;10632.255742098288;10876.456177191267;11348.716282093013;11909.702257443632;12280.754384912074;10795.730106747395;11022.118230541377;11288.548458061585;11397.202195846212;11420.885791142315;11271.605493807678;11662.300261983968;11677.649670509898;12028;12120;9482.38364506305;10018.599256029676;10428.478576071318;10487.213458990758;10634.787304254027;9010.27917766564;9162.450252984841;9307.813843723223;10011.599536018477;10011.983223487176 22:57:50 INFO - PROCESS | 15807 | __end_tp_report 22:57:50 INFO - PROCESS | 15807 | __start_cc_report 22:57:50 INFO - PROCESS | 15807 | _x_x_mozilla_cycle_collect,357 22:57:50 INFO - PROCESS | 15807 | __end_cc_report 22:57:50 INFO - PROCESS | 15807 | __startTimestamp1460699870437__endTimestamp 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | ------- Summary: start ------- 22:57:50 INFO - PROCESS | 15807 | Number of tests: 6 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | [#0] dojo.html Cycles:165 Average:4724.33 Median:4893.00 stddev:608.30 (12.4%) stddev-sans-first:586.58 22:57:50 INFO - PROCESS | 15807 | Values: 2585.8 2605.0 2637.8 2647.3 2650.1 4783.7 4800.7 4803.7 4808.0 4847.5 4717.0 4780.4 4799.9 4846.5 4863.1 4322.1 4362.9 4367.2 4376.2 4380.1 628.0 4094.9 4283.8 4335.0 4366.1 4344.9 4387.3 4389.9 4397.8 4415.6 4377.9 4391.4 4394.7 4397.2 4440.4 4350.1 4398.5 4410.4 4422.2 4442.6 4624.9 4640.8 4650.2 4659.6 4670.7 5005.7 5076.4 5112.3 5132.7 5134.4 5139.9 5148.7 5154.8 5156.3 5197.5 4757.8 4765.3 4800.9 4807.1 4845.9 5158.1 5267.5 5272.8 5315.3 5339.2 5053.6 5066.5 5076.5 5081.4 5114.4 5142.6 5152.0 5161.0 5173.6 5218.0 5023.4 5048.2 5104.6 5181.7 5196.5 5094.1 5099.7 5100.2 5107.4 5117.8 4324.0 4329.2 4329.5 4367.6 4385.7 3667.8 3672.5 3684.9 3785.8 3814.6 4486.9 4510.2 4516.2 4533.2 4559.8 5164.0 5167.5 5175.5 5184.1 5185.6 4376.3 4520.8 4535.2 4597.8 4617.8 4614.7 4634.4 4636.2 4636.7 4678.3 4873.4 4882.2 4889.5 4910.7 4937.7 5110.0 5160.7 5200.4 5229.7 5244.9 4844.5 4883.2 4893.2 4902.5 4934.5 4938.4 5104.0 5114.5 5120.7 5128.8 5160.9 5210.2 5223.2 5242.7 5277.3 5011.4 5012.4 5019.2 5025.8 5034.3 4868.2 4970.5 4979.3 4989.5 4995.4 4850.7 4893.0 4934.8 4984.8 5002.0 5039.6 5058.0 5060.7 5067.4 5116.1 4842.6 4919.9 4944.3 4965.4 5016.7 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | [#1] ext.html Cycles:180 Average:41875.72 Median:18460.02 stddev:74418.06 (403.1%) stddev-sans-first:74562.19 22:57:50 INFO - PROCESS | 15807 | Values: 566.5 587.1 606.6 613.4 637.1 32644.2 33558.5 33723.2 33779.3 33875.7 33751.0 34050.7 34245.5 34265.7 34292.0 7643.9 7806.8 7844.8 7869.8 7871.8 7703.1 7801.3 7823.5 7835.1 7838.3 7834.4 7905.1 7912.5 7914.3 7914.4 7729.1 7767.8 7805.7 7826.5 7828.6 7714.0 7751.3 7829.3 7861.1 7861.4 29897.9 34694.8 35241.0 35344.6 35446.3 2936.6 2958.5 2970.2 2979.3 3063.2 23828.2 24261.0 24318.3 24412.1 24491.5 3208.6 3255.4 3262.9 3361.5 3379.5 152679.2 153397.0 154984.2 155352.0 155535.0 31542.2 31751.4 31768.7 31801.8 31816.8 32704.8 58764.7 60645.0 60753.7 60801.4 14596.6 14764.3 14764.4 14779.6 14783.3 10566.8 10592.0 10595.2 10605.2 10629.0 17854.6 17978.6 18014.7 18142.4 18782.9 6977.3 6995.8 7093.3 7269.4 7288.7 946.9 1019.4 1048.4 1079.3 1094.6 26855.0 27446.6 27546.4 27683.4 27791.3 1012.2 1026.6 1094.5 1104.9 1167.0 14699.0 15133.5 15141.2 15361.2 15379.7 345403.0 346560.0 348424.0 350190.0 353083.0 47192.3 48427.5 48520.0 48567.3 48821.3 1239.6 1243.1 1284.5 1286.8 1301.6 25548.9 27603.3 28148.3 28264.7 28493.1 41700.6 41765.2 41908.6 42235.4 42239.8 304481.0 305075.0 305599.0 306274.0 306443.0 25364.1 25783.2 25795.2 25832.4 38152.2 39006.8 39210.8 39776.6 40056.2 40233.8 34584.0 34719.8 34788.1 35120.5 35512.6 33658.3 33906.3 33913.3 34044.7 34212.7 31004.7 34060.5 34386.7 37885.8 37959.1 30044.8 31509.2 31855.7 31906.0 31913.2 22413.9 22498.6 22503.8 22825.8 22861.4 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | [#2] jquery.html Cycles:180 Average:23392.35 Median:386.38 stddev:60801.17 (15736.3%) stddev-sans-first:60947.16 22:57:50 INFO - PROCESS | 15807 | Values: 365.7 366.9 368.9 384.5 388.3 15530.7 16291.8 17636.6 17706.7 17717.2 15260.8 16129.3 16791.4 16849.1 16871.4 5069.3 5216.8 5246.8 5253.2 5257.7 3611.5 5174.5 5676.3 6078.7 6083.6 5957.3 5967.9 5983.8 5990.6 6042.8 5701.8 5861.2 5883.6 5887.4 5897.0 5218.3 5219.8 5244.9 5260.4 5327.3 20485.2 20543.4 20654.1 20830.7 20854.6 1915.3 2017.4 2036.7 2165.3 2271.4 13354.1 13529.3 13556.3 13615.5 13824.9 1617.8 1724.3 1740.0 1801.4 1869.3 67925.3 68810.7 70421.0 70508.0 71030.3 9338.8 9461.6 9847.6 9853.2 9870.7 12997.7 13036.2 13036.2 13077.1 13107.3 7057.2 7068.5 7172.6 7192.1 7312.9 6842.1 6942.7 7056.3 7116.8 7174.3 6075.7 6187.8 6197.1 6217.2 6253.2 1593.9 1694.1 1740.2 1893.3 1903.4 826.4 901.3 959.9 968.4 1013.4 16630.4 16864.3 17110.1 17178.8 17201.4 918.4 922.8 937.2 942.0 984.9 9625.6 9787.4 9788.4 9800.6 10037.3 360314.0 360834.0 373004.0 373875.0 376426.0 68139.3 68547.3 69266.3 71149.0 79408.0 968.8 980.3 985.0 990.9 992.1 14983.9 15036.9 15157.0 15284.5 15448.4 30631.0 31409.5 32670.0 32971.2 33145.5 42627.4 42933.1 43789.8 43868.0 44105.6 5837.4 5894.6 7173.2 7208.6 7416.7 11070.2 11315.3 11378.1 11628.4 11705.4 9981.7 10371.5 10389.8 10420.6 10444.2 10052.3 10114.4 10233.8 10343.2 10686.1 10243.0 10542.6 10684.0 10779.1 10820.9 7320.3 7364.6 7405.9 7434.9 7711.2 10049.2 10625.2 10656.3 10816.3 10970.7 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | [#3] mootools.html Cycles:180 Average:5184.48 Median:4837.86 stddev:2859.19 (59.1%) stddev-sans-first:2853.45 22:57:50 INFO - PROCESS | 15807 | Values: 1451.6 1488.0 1621.8 1763.5 1804.2 6997.5 7554.8 7610.2 7880.9 7913.5 7662.7 7763.4 7790.2 7818.1 7826.4 2180.3 2198.6 2199.3 2204.4 2207.9 2202.6 2203.0 2207.8 2220.2 2223.9 2165.9 2190.6 2193.5 2201.1 2227.1 2180.6 2185.7 2189.2 2189.5 2190.7 2158.9 2176.7 2181.2 2187.6 2200.2 7904.7 7905.8 7925.8 7926.6 7974.5 4472.3 4540.7 4584.5 4598.9 4645.7 2914.2 2948.8 3002.2 3014.2 3044.9 1009.8 1019.4 1022.5 1052.0 1054.6 10488.2 10596.5 10609.3 10616.6 10642.3 4121.9 4133.5 4365.8 4388.0 4417.6 9065.6 9093.0 9139.9 9141.4 9208.8 4723.5 4744.8 4766.5 4782.9 4787.7 3741.2 4212.2 4319.4 4320.4 4360.8 3600.2 3705.5 3734.9 3755.3 3785.7 1220.1 1239.5 1240.1 1246.0 1257.2 870.0 875.9 887.1 900.4 908.3 5336.2 5372.6 5400.7 5516.4 5535.6 421.3 439.4 446.5 447.6 449.2 3967.1 3967.2 3970.4 4011.5 4014.2 9353.5 9677.9 9710.1 9733.8 9776.5 9598.9 9654.5 9669.5 9678.8 9709.4 6986.1 7045.6 7048.2 7080.2 7330.2 5662.1 5696.3 5716.3 5730.3 5899.4 8790.4 8825.6 8934.4 8951.7 8973.1 8642.2 8956.0 8997.8 9047.1 9106.1 6143.3 6613.9 6832.5 6859.5 6965.4 7140.0 7175.2 7232.2 7243.3 7273.7 6452.6 6653.1 6778.2 6832.6 6899.4 6734.7 6783.1 6854.8 6889.9 6898.2 6142.4 6477.7 6586.1 6602.7 6644.4 4488.7 4587.9 4643.0 4682.7 4962.2 4788.0 4807.3 4868.5 4958.1 5044.6 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | [#4] prototype.html Cycles:180 Average:4687.12 Median:5331.55 stddev:1364.24 (25.6%) stddev-sans-first:1328.05 22:57:50 INFO - PROCESS | 15807 | Values: 317.2 320.0 326.8 329.5 334.1 5383.9 5396.3 5413.1 5413.1 5445.6 5285.4 5328.4 5329.7 5333.4 5342.3 3982.0 4036.5 4165.8 4167.6 4179.0 4147.5 4182.2 4186.9 4191.4 4192.5 4147.5 4152.6 4154.8 4157.6 4176.2 4070.8 4119.4 4142.7 4145.8 4167.4 3649.7 3656.6 3667.8 3676.1 3686.7 5077.7 5087.1 5115.9 5117.8 5118.6 4710.0 4756.5 4792.4 4818.5 4818.8 5607.4 5634.0 5640.4 5644.2 5662.7 4026.0 4037.2 4038.8 4048.0 4048.1 5816.8 5919.0 5945.4 5950.6 5961.2 4142.2 4145.5 4147.9 4156.9 4166.7 4199.2 4201.5 4223.4 4234.0 4240.5 4695.5 4785.3 4791.9 4793.4 4817.0 5634.3 5656.3 5661.7 5663.8 5677.2 1443.8 1457.9 1460.8 1468.8 1469.6 944.3 977.6 994.2 1017.5 1032.1 4897.0 4936.5 4938.2 4955.0 4981.4 5791.4 5796.8 5813.3 5827.3 5839.9 4815.3 4960.3 4962.3 4974.1 4986.6 3106.8 3109.7 3128.6 3129.6 3134.2 5374.9 5440.7 5455.2 5458.3 5458.7 5751.5 5974.8 5980.0 5980.7 5981.0 5442.0 5462.7 5477.0 5488.5 5489.2 5647.0 5751.8 5760.9 5803.7 5966.4 5746.2 5766.5 5815.8 5841.4 5864.1 5525.8 5530.5 5538.3 5543.9 5555.7 3835.2 4038.0 4060.5 4070.8 4072.8 5833.0 5843.1 5854.7 5872.2 5879.0 5521.6 5650.0 5658.1 5666.8 5684.1 5539.6 5607.2 5607.9 5611.9 5613.9 5304.2 5525.4 5541.7 5541.9 5564.6 5539.1 5733.0 5758.9 5763.3 5767.9 5580.6 5585.6 5585.7 5591.8 5623.9 22:57:50 INFO - PROCESS | 15807 | 22:57:50 INFO - PROCESS | 15807 | [#5] yui.html Cycles:180 Average:12556.27 Median:22439.18 stddev:13999.13 (62.4%) stddev-sans-first:14009.86 22:57:50 INFO - PROCESS | 15807 | Values: 654.2 696.2 761.3 776.4 798.4 11801.6 11860.0 11907.9 11911.8 12017.5 11456.3 11564.4 11579.6 11588.8 11626.7 626.2 760.7 779.2 790.2 792.4 776.1 777.1 787.1 789.0 790.4 816.2 823.8 824.4 830.3 831.4 811.3 811.9 814.8 819.1 819.5 605.0 605.1 606.6 608.5 614.9 12040.6 12131.3 12173.6 12198.8 12217.1 12655.1 12988.4 13040.3 13148.3 13285.9 10112.3 10203.5 10280.5 10368.9 10531.2 3326.6 3336.9 3358.7 3372.1 3405.6 44773.8 44885.8 45230.3 45341.3 45618.0 10142.0 10223.3 10274.6 10344.5 10429.7 18181.3 18324.6 18374.8 18478.3 18857.8 6715.5 6805.1 6810.8 6883.2 6983.9 3668.7 3757.8 3792.4 3805.8 3871.0 2853.4 2965.3 2969.7 2977.4 2988.3 495.3 509.4 518.4 522.9 533.8 618.9 627.3 628.4 630.0 630.7 7520.0 7618.8 7686.7 7918.9 8007.4 494.1 529.8 565.7 640.6 667.3 3609.9 3666.8 3741.4 3743.5 3763.7 50347.0 50531.7 51571.0 52351.0 52405.5 43636.3 43766.6 44473.3 45162.3 45482.3 41007.4 41151.0 41670.0 41866.8 42337.8 7242.1 7273.6 7277.9 7279.5 7414.7 27572.9 28356.9 28363.0 28789.0 28896.7 34192.0 34982.0 36964.6 37359.6 37561.2 9090.5 9134.1 9142.6 9173.0 9416.3 10203.0 11786.8 11830.8 12463.4 13007.6 10632.3 10876.5 11348.7 11909.7 12280.8 10795.7 11022.1 11288.5 11397.2 11420.9 11271.6 11662.3 11677.6 12028.0 12120.0 9482.4 10018.6 10428.5 10487.2 10634.8 9010.3 9162.5 9307.8 10011.6 10012.0 22:57:50 INFO - PROCESS | 15807 | -------- Summary: end -------- 22:57:50 INFO - PROCESS | 15807 | 22:57:51 INFO - TEST-INFO | 15807: exit 0 22:57:51 INFO - TEST-OK | dromaeo_css | took 1115594ms 22:57:51 INFO - TEST-START | kraken 22:57:51 INFO - operating with platform_type : linux_ 22:57:51 INFO - Initialising browser for kraken test... 22:57:51 INFO - TEST-INFO | started process 16041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0devCr/profile http://localhost:46974/getInfo.html) 22:57:55 INFO - PROCESS | 16041 | 22:57:55 INFO - PROCESS | 16041 | (process:16106): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:57:55 INFO - PROCESS | 16041 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:57:56 INFO - PROCESS | 16041 | __metrics Screen width/height:1600/1200 22:57:56 INFO - PROCESS | 16041 | colorDepth:24 22:57:56 INFO - PROCESS | 16041 | Browser inner width/height: 1024/697 22:57:56 INFO - PROCESS | 16041 | __metrics 22:57:56 ERROR - PROCESS | 16041 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:57:57 INFO - TEST-INFO | 16041: exit 0 22:57:57 INFO - Browser initialized. 22:57:57 INFO - Running cycle 1/1 for kraken test... 22:57:57 INFO - TEST-INFO | started process 16157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0devCr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:57:59 INFO - PROCESS | 16157 | 22:57:59 INFO - PROCESS | 16157 | (process:16216): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:58:09 INFO - PROCESS | 16157 | RSS: Main: 164466688 22:58:09 INFO - PROCESS | 16157 | 22:58:12 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46974/tests/kraken/driver.html?testName=audio-beat-detection) 22:58:13 INFO - PROCESS | 16157 | RSS: Main: 168767488 22:58:13 INFO - PROCESS | 16157 | 22:58:16 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46974/tests/kraken/driver.html?testName=audio-dft) 22:58:16 INFO - PROCESS | 16157 | RSS: Main: 172240896 22:58:16 INFO - PROCESS | 16157 | 22:58:19 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46974/tests/kraken/driver.html?testName=audio-fft) 22:58:20 INFO - PROCESS | 16157 | RSS: Main: 163405824 22:58:20 INFO - PROCESS | 16157 | 22:58:22 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46974/tests/kraken/driver.html?testName=audio-oscillator) 22:58:23 INFO - PROCESS | 16157 | RSS: Main: 164220928 22:58:23 INFO - PROCESS | 16157 | 22:58:25 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:58:26 INFO - PROCESS | 16157 | RSS: Main: 164179968 22:58:26 INFO - PROCESS | 16157 | 22:58:29 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46974/tests/kraken/driver.html?testName=imaging-darkroom) 22:58:29 INFO - PROCESS | 16157 | RSS: Main: 164425728 22:58:29 INFO - PROCESS | 16157 | 22:58:33 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46974/tests/kraken/driver.html?testName=imaging-desaturate) 22:58:34 INFO - PROCESS | 16157 | RSS: Main: 164564992 22:58:34 INFO - PROCESS | 16157 | 22:58:36 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46974/tests/kraken/driver.html?testName=json-parse-financial) 22:58:37 INFO - PROCESS | 16157 | RSS: Main: 164892672 22:58:37 INFO - PROCESS | 16157 | 22:58:39 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:58:39 INFO - PROCESS | 16157 | RSS: Main: 164974592 22:58:39 INFO - PROCESS | 16157 | 22:58:41 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:58:42 INFO - PROCESS | 16157 | RSS: Main: 165064704 22:58:42 INFO - PROCESS | 16157 | 22:58:44 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:58:45 INFO - PROCESS | 16157 | RSS: Main: 165392384 22:58:45 INFO - PROCESS | 16157 | 22:58:48 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:58:48 INFO - PROCESS | 16157 | RSS: Main: 165642240 22:58:48 INFO - PROCESS | 16157 | 22:58:51 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:58:52 INFO - PROCESS | 16157 | RSS: Main: 165343232 22:58:52 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | Cycle 1(1): loaded http://localhost:46974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46974/tests/kraken/driver.html?testName=ai-astar) 22:58:54 INFO - PROCESS | 16157 | RSS: Main: 166817792 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | __start_tp_report 22:58:54 INFO - PROCESS | 16157 | _x_x_mozilla_page_load 22:58:54 INFO - PROCESS | 16157 | _x_x_mozilla_page_load_details 22:58:54 INFO - PROCESS | 16157 | |i|pagename|runs| 22:58:54 INFO - PROCESS | 16157 | |0;ai-astar;120;108;114;113;113;124;115;113;113;113 22:58:54 INFO - PROCESS | 16157 | |1;audio-beat-detection;163;132;162;196;133;159;161;137;184;135 22:58:54 INFO - PROCESS | 16157 | |2;audio-dft;165;164;165;176;165;163;163;164;168;164 22:58:54 INFO - PROCESS | 16157 | |3;audio-fft;75;74;78;162;76;76;75;75;167;78 22:58:54 INFO - PROCESS | 16157 | |4;audio-oscillator;95;94;149;95;95;94;138;94;95;141 22:58:54 INFO - PROCESS | 16157 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;119;123;118 22:58:54 INFO - PROCESS | 16157 | |6;imaging-darkroom;147;148;148;148;147;150;148;147;147;147 22:58:54 INFO - PROCESS | 16157 | |7;imaging-desaturate;96;96;95;96;96;96;95;96;96;97 22:58:54 INFO - PROCESS | 16157 | |8;json-parse-financial;68;68;67;68;69;68;68;85;65;75 22:58:54 INFO - PROCESS | 16157 | |9;json-stringify-tinderbox;65;65;64;65;64;64;64;67;65;66 22:58:54 INFO - PROCESS | 16157 | |10;stanford-crypto-aes;87;84;85;86;88;87;85;87;86;85 22:58:54 INFO - PROCESS | 16157 | |11;stanford-crypto-ccm;150;150;142;141;139;145;141;141;174;142 22:58:54 INFO - PROCESS | 16157 | |12;stanford-crypto-pbkdf2;181;173;178;179;177;173;173;173;173;179 22:58:54 INFO - PROCESS | 16157 | |13;stanford-crypto-sha256-iterative;80;74;75;72;78;74;75;72;72;74 22:58:54 INFO - PROCESS | 16157 | __end_tp_report 22:58:54 INFO - PROCESS | 16157 | __start_cc_report 22:58:54 INFO - PROCESS | 16157 | _x_x_mozilla_cycle_collect,905 22:58:54 INFO - PROCESS | 16157 | __end_cc_report 22:58:54 INFO - PROCESS | 16157 | __startTimestamp1460699934536__endTimestamp 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | ------- Summary: start ------- 22:58:54 INFO - PROCESS | 16157 | Number of tests: 14 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#0] ai-astar Cycles:10 Average:114.60 Median:113.50 stddev:4.40 (3.9%) stddev-sans-first:4.21 22:58:54 INFO - PROCESS | 16157 | Values: 120.0 108.0 114.0 113.0 113.0 124.0 115.0 113.0 113.0 113.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:161.50 stddev:22.13 (13.7%) stddev-sans-first:23.34 22:58:54 INFO - PROCESS | 16157 | Values: 163.0 132.0 162.0 196.0 133.0 159.0 161.0 137.0 184.0 135.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.00 stddev:3.89 (2.4%) stddev-sans-first:4.12 22:58:54 INFO - PROCESS | 16157 | Values: 165.0 164.0 165.0 176.0 165.0 163.0 163.0 164.0 168.0 164.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.50 stddev:37.41 (49.5%) stddev-sans-first:39.07 22:58:54 INFO - PROCESS | 16157 | Values: 75.0 74.0 78.0 162.0 76.0 76.0 75.0 75.0 167.0 78.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.50 stddev:23.39 (24.8%) stddev-sans-first:24.25 22:58:54 INFO - PROCESS | 16157 | Values: 95.0 94.0 149.0 95.0 95.0 94.0 138.0 94.0 95.0 141.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.77 (1.5%) stddev-sans-first:1.87 22:58:54 INFO - PROCESS | 16157 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 119.0 123.0 118.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 22:58:54 INFO - PROCESS | 16157 | Values: 147.0 148.0 148.0 148.0 147.0 150.0 148.0 147.0 147.0 147.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:58:54 INFO - PROCESS | 16157 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#8] json-parse-financial Cycles:10 Average:70.10 Median:68.00 stddev:5.82 (8.6%) stddev-sans-first:6.12 22:58:54 INFO - PROCESS | 16157 | Values: 68.0 68.0 67.0 68.0 69.0 68.0 68.0 85.0 65.0 75.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 22:58:54 INFO - PROCESS | 16157 | Values: 65.0 65.0 64.0 65.0 64.0 64.0 64.0 67.0 65.0 66.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.27 22:58:54 INFO - PROCESS | 16157 | Values: 87.0 84.0 85.0 86.0 88.0 87.0 85.0 87.0 86.0 85.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:143.50 stddev:10.38 (7.2%) stddev-sans-first:10.94 22:58:54 INFO - PROCESS | 16157 | Values: 150.0 150.0 142.0 141.0 139.0 145.0 141.0 141.0 174.0 142.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:177.50 stddev:3.21 (1.8%) stddev-sans-first:2.83 22:58:54 INFO - PROCESS | 16157 | Values: 181.0 173.0 178.0 179.0 177.0 173.0 173.0 173.0 173.0 179.0 22:58:54 INFO - PROCESS | 16157 | 22:58:54 INFO - PROCESS | 16157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:74.50 stddev:2.63 (3.5%) stddev-sans-first:1.94 22:58:54 INFO - PROCESS | 16157 | Values: 80.0 74.0 75.0 72.0 78.0 74.0 75.0 72.0 72.0 74.0 22:58:54 INFO - PROCESS | 16157 | -------- Summary: end -------- 22:58:54 INFO - PROCESS | 16157 | 22:58:55 INFO - TEST-INFO | 16157: exit 0 22:58:55 INFO - TEST-OK | kraken | took 64448ms 22:58:55 INFO - SUITE-END | took 1180s 22:58:55 INFO - Completed test suite (00:19:40) 22:58:55 INFO - javascript benchmark 22:58:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.844849309042, 2604.9739502604975, 2637.77578905793, 2647.2587675450854, 2650.112212408845, 4783.665143439956, 4800.687955282909, 4803.7357945313, 4807.951920480794, 4847.466778654345, 4717.033008233312, 4780.378550788401, 4799.928001079987, 4846.4911184325665, 4863.148948933931, 4322.113966636847, 4362.934555981663, 4367.213901497729, 4376.212281789277, 4380.102079073798, 627.9899741415892, 4094.9269506675378, 4283.785810709452, 4335.0, 4366.061296821183, 4344.891377715567, 4387.254166791621, 4389.934150987738, 4397.758123303217, 4415.602595766364, 4377.934330985037, 4391.429114215163, 4394.736315821061, 4397.159586395914, 4440.444944381952, 4350.086481838817, 4398.538153493901, 4410.360497727812, 4422.204003279408, 4442.644588432918, 4624.907501849944, 4640.83757068501, 4650.162970665279, 4659.5573420525, 4670.696404733681, 5005.74971251436, 5076.44159142494, 5112.309838171836, 5132.717700526469, 5134.435212126663, 5139.922901156486, 5148.665336753099, 5154.819581314673, 5156.278121063054, 5197.48025197481, 4757.785899634525, 4765.332853400527, 4800.903981920342, 4807.11068452334, 4845.9030819383415, 5158.123119069767, 5267.473252674778, 5272.762725677354, 5315.255864179018, 5339.172428273546, 5053.570446512014, 5066.518680725325, 5076.543111120017, 5081.390233172043, 5114.43741188469, 5142.5628821549835, 5151.97424012885, 5161.0, 5173.586113111018, 5218.034663587248, 5023.372078490189, 5048.167052436307, 5104.642675012714, 5181.740912954413, 5196.45437229093, 5094.057599344059, 5099.69401835891, 5100.158473851847, 5107.361579802525, 5117.797317630354, 4324.048709283952, 4329.199098166786, 4329.458817647794, 4367.6287515561535, 4385.7149285296355, 3667.8349474273723, 3672.4674922136674, 3684.8526058957877, 3785.7917814520465, 3814.5994670559194, 4486.865394038119, 4510.188166130062, 4516.187086324428, 4533.206688829442, 4559.840405585788, 5164.04465173944, 5167.534921857051, 5175.534201921845, 5184.144616138295, 5185.637005409661, 4376.277914144194, 4520.819167233274, 4535.183666939916, 4597.839075632403, 4617.8383756568355, 4614.676972611952, 4634.351190833286, 4636.211843986531, 4636.721796692209, 4678.298255261738, 4873.366462359942, 4882.243252295829, 4889.511048895082, 4910.656254062182, 4937.703737775745, 5110.029094472038, 5160.690358578498, 5200.375954885438, 5229.686218826882, 5244.947550524598, 4844.539768721966, 4883.218685010382, 4893.21708526634, 4902.509749025069, 4934.457209706858, 4938.407391113089, 5103.974480127576, 5114.488551144856, 5120.718360490208, 5128.8461346159675, 5160.896782064263, 5210.192420174879, 5223.216517522402, 5242.68543887368, 5277.2875661785165, 5011.398632164018, 5012.448630650552, 5019.196928491424, 5025.84922452327, 5034.270030845581, 4868.245421959602, 4970.527799859007, 4979.302897594413, 4989.476105008922, 4995.425526064404, 4850.738807910039, 4893.0, 4934.777934992862, 4984.775685094107, 5002.049610573979, 5039.571636410799, 5058.0, 5060.746962651926, 5067.366579177603, 5116.1046816806165, 4842.6368022397755, 4919.901601968012, 4944.307796908508, 4965.354503914468, 5016.698998060128], "value": 4685.068025365982, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4505429733157, 587.0929414055284, 606.6420811721084, 613.3988691082742, 637.1080487317757, 32644.183895402628, 33558.49662255068, 33723.15692107699, 33779.32441351171, 33875.661243387556, 33751.0, 34050.65949340506, 34245.486317705196, 34265.65734342656, 34292.0, 7643.9235607643905, 7806.843863122735, 7844.803879902991, 7869.842603147934, 7871.8425631487335, 7703.114141873672, 7801.258880406381, 7823.530588164728, 7835.1381348051955, 7838.294553490185, 7834.412419068564, 7905.090914544843, 7912.485688430263, 7914.28771410573, 7914.445988780788, 7729.111152217482, 7767.844643107134, 7805.687772489094, 7826.452148349618, 7828.647710853025, 7713.961430192813, 7751.263629955145, 7829.334506566948, 7861.135275119732, 7861.449698521106, 29897.850510747525, 34694.82652586721, 35241.0, 35344.64655353465, 35446.29107417863, 2936.6476022877177, 2958.5118455454826, 2970.212893583202, 2979.2551862034493, 3063.172943305295, 23828.16601418942, 24261.0, 24318.27045188647, 24412.145574904793, 24491.510169796682, 3208.598925134358, 3255.4465740824116, 3262.885798997024, 3361.5461912641726, 3379.4761811919193, 152679.23660381738, 153397.0, 154984.22507887502, 155352.0, 155535.0, 31542.21144471361, 31751.364972700416, 31768.682313176574, 31801.8409907949, 31816.840915795274, 32704.83647581747, 58764.7061764697, 60645.0, 60753.69623151945, 60801.39198608046, 14596.635084122981, 14764.335604897591, 14764.40942362315, 14779.63050923714, 14783.334749936279, 10566.788664226673, 10592.046715795615, 10595.152387808957, 10605.151587873106, 10629.0, 17854.642907141784, 17978.5505362367, 18014.729779053323, 18142.365017224598, 18782.90608546976, 6977.267386924402, 6995.755148569878, 7093.32613401726, 7269.382102521239, 7288.6720097595735, 946.8579713043099, 1019.3832731197518, 1048.4390850894736, 1079.2822772855964, 1094.6497120921229, 26855.0, 27446.5883011755, 27546.44907101887, 27683.446331073264, 27791.30521736932, 1012.2104758288547, 1026.5944951744168, 1094.4582431696201, 1104.9447527623586, 1167.048855183023, 14699.0, 15133.470328538448, 15141.242937853063, 15361.231938403034, 15379.692406151815, 345403.0, 346560.0, 348424.0, 350190.0, 353083.0, 47192.29211561829, 48427.515724843004, 48520.0, 48567.271490926956, 48821.26768098411, 1239.5847391123893, 1243.0801207106856, 1284.4990453723055, 1286.8391451068617, 1301.5965050834461, 25548.872255638602, 27603.30991725223, 28148.296292592848, 28264.717352827032, 28493.145205643865, 41700.58299416967, 41765.16469670529, 41908.58091419169, 42235.3664695036, 42239.788801055794, 304481.0, 305075.0, 305599.0, 306274.0, 306443.0, 25364.11225607095, 25783.226503204933, 25795.226143215732, 25832.354191145372, 38152.236955261294, 39006.80496597499, 39210.803945980086, 39776.624571296554, 40056.1988760229, 40233.79883100566, 34584.0, 34719.82640086783, 34788.130296742784, 35120.47319290161, 35512.64487355093, 33658.32683346368, 33906.321873561894, 33913.32173356568, 34044.65955340415, 34212.65787342095, 31004.68995310018, 34060.489092664124, 34386.656133438344, 37885.81057094697, 37959.05102372463, 30044.849775750983, 31509.212269693442, 31855.6814431862, 31906.0, 31913.202169945936, 22413.887930560242, 22498.550028999656, 22503.774962250824, 22825.771742282366, 22861.42846428786], "value": 16700.129957037065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7293602733977, 366.9376206044974, 368.8672078051901, 384.4751913637883, 388.27780328588835, 15530.689386212283, 16291.75562366564, 17636.559086022855, 17706.734398984026, 17717.202725877334, 15260.84739152611, 16129.274182661778, 16791.412300569482, 16849.07330096844, 16871.40950066748, 5069.340985671866, 5216.8174113906025, 5246.842594722164, 5253.185756207794, 5257.658252213613, 3611.4763359312883, 5174.4825517448335, 5676.318841738997, 6078.726457309432, 6083.634981901078, 5957.2851257849115, 5967.940320596804, 5983.790567330123, 5990.6106103103375, 6042.788502402417, 5701.800436984707, 5861.179434879099, 5883.61756485827, 5887.4406931341455, 5896.970515147418, 5218.269442278084, 5219.791208351661, 5244.868878278074, 5260.368755749335, 5327.280817089721, 20485.180592776273, 20543.38369848907, 20654.07056682438, 20830.687539686918, 20854.58290834175, 1915.329634627883, 2017.384697667211, 2036.7046778217223, 2165.2962787094098, 2271.3980795089315, 13354.065215434923, 13529.255890925995, 13556.322183890767, 13615.52345667897, 13824.86175138256, 1617.7573363995496, 1724.3447489953737, 1739.9739003914951, 1801.4235444657716, 1869.3457289948544, 67925.3207467924, 68810.65594672045, 70420.99999999949, 70508.0, 71030.28969710288, 9338.813223735624, 9461.574229159703, 9847.606095756233, 9853.211743060538, 9870.654527091518, 12997.740045199233, 13036.152650077714, 13036.217826930415, 13077.084604077814, 13107.344632768323, 7057.18842333128, 7068.540544864567, 7172.641367931687, 7192.100987376578, 7312.926870731225, 6842.144731908512, 6942.652867356612, 7056.294370563005, 7116.790145675248, 7174.282571742784, 6075.665838378844, 6187.752489900354, 6197.101420294122, 6217.222847144107, 6253.218347706536, 1593.9282732277075, 1694.1359906447553, 1740.2342969093559, 1893.308942236074, 1903.3814010446383, 826.3595713322103, 901.3420203251663, 959.8512230604267, 968.4383057826444, 1013.4020927652573, 16630.417935372203, 16864.32542698303, 17110.144492775562, 17178.828211717722, 17201.397951071653, 918.4122161816442, 922.847730124522, 937.2080591899834, 941.9529023548795, 984.8768903887014, 9625.56684949179, 9787.412755234567, 9788.412695238309, 9800.607975680892, 10037.34757240777, 360314.0, 360834.0, 373004.0, 373875.0, 376426.0, 68139.31860681428, 68547.31452685509, 69266.307336927, 71149.0, 79408.0, 968.7578105473632, 980.3284749946167, 984.9655262065793, 990.9405435673883, 992.1318846009741, 14983.850161498245, 15036.924815376291, 15157.014794038352, 15284.541463756104, 15448.382064717285, 30631.0, 31409.52885706762, 32670.0, 32971.17572060718, 33145.50281745727, 42627.3605895918, 42933.14133717371, 43789.78105109454, 43868.0, 44105.55894441014, 5837.445442682938, 5894.587378883437, 7173.210946795744, 7208.603526806076, 7416.7033318666645, 11070.169737269576, 11315.264507806965, 11378.08975281959, 11628.360440175871, 11705.356205408443, 9981.681782108182, 10371.481425928825, 10389.792204156025, 10420.583176672848, 10444.164466842481, 10052.346597471142, 10114.393136411838, 10233.84649230277, 10343.224258180817, 10686.145108391154, 10243.0, 10542.57829686804, 10684.038436540748, 10779.137668986305, 10820.945895270474, 7320.304571065741, 7364.631768411451, 7405.888911666437, 7434.8884766729625, 7711.190325015793, 10049.19606431469, 10625.203109766644, 10656.307340022873, 10816.278733698891, 10970.670879873616], "value": 8340.203063343712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.6080658222281, 1487.9628009299768, 1621.8053833539977, 1763.497403240077, 1804.1971322761376, 6997.51017428779, 7554.773356799298, 7610.16288208298, 7880.881786773203, 7913.4856234344725, 7662.6551805168765, 7763.378929685626, 7790.18203088676, 7818.100918394386, 7826.373890088794, 2180.3349978256624, 2198.6372248578964, 2199.285232299509, 2204.4378683435702, 2207.9116835326568, 2202.6365649667864, 2203.03066650674, 2207.7902599253043, 2220.2451166603432, 2223.8999245033933, 2165.8808765517892, 2190.5837890800776, 2193.5064610462678, 2201.0755482697227, 2227.12028748645, 2180.6292930201826, 2185.7158569385956, 2189.179057853305, 2189.4854709143337, 2190.671399290103, 2158.870467771939, 2176.684380764796, 2181.2474696229774, 2187.55155193185, 2200.2409168836725, 7904.723334683258, 7905.762827115196, 7925.841483170362, 7926.6036698165435, 7974.521528708238, 4472.306792447176, 4540.682152249344, 4584.518625544337, 4598.88502787433, 4645.65157613177, 2914.1985953862645, 2948.837813920255, 3002.24943764059, 3014.171102946685, 3044.9238769030953, 1009.7677534167109, 1019.3527110284948, 1022.4734261855151, 1051.9947400263027, 1054.6150655010865, 10488.160947124288, 10596.523156457977, 10609.310394824235, 10616.57533698651, 10642.255042147053, 4121.855735049319, 4133.545310015896, 4365.825366985348, 4388.034632380871, 4417.602415782595, 9065.637374505079, 9092.954535227414, 9139.862902056475, 9141.3601047926, 9208.815823683488, 4723.48041715411, 4744.786484608201, 4766.475687674353, 4782.904341913142, 4787.688800227974, 3741.1769410729594, 4212.199682060399, 4319.3952846601505, 4320.416743739618, 4360.7601581913295, 3600.171960449059, 3705.5368078990127, 3734.925301493955, 3755.3052685253315, 3785.6592906638534, 1220.1154163231763, 1239.535174309634, 1240.0637518673343, 1246.0343233993547, 1257.2142410993129, 869.9608517616596, 875.9386842920934, 887.121749468022, 900.3967341880956, 908.3051465628799, 5336.17289320156, 5372.62391632582, 5400.675959442446, 5516.420775818481, 5535.640183388067, 421.3111562595179, 439.4353256066004, 446.5199910096659, 447.61057879644267, 449.17800425221765, 3967.067739081371, 3967.166894952092, 3970.4242884781543, 4011.5186177658866, 4014.1770936957855, 9353.532323383804, 9677.854832177523, 9710.126088652056, 9733.805323893483, 9776.51117444125, 9598.904010959941, 9654.517274136266, 9669.468179250069, 9678.806423871483, 9709.36889102206, 6986.091808064919, 7045.577265364094, 7048.154221493453, 7080.221175670672, 7330.193678695339, 5662.122371032497, 5696.316442026818, 5716.314042314949, 5730.255066841284, 5899.351071382231, 8790.42862213954, 8825.602847871733, 8934.374593778373, 8951.73144805657, 8973.147550982647, 8642.178992995656, 8955.970063442788, 8997.820043599222, 9047.095290470901, 9106.089391060841, 6143.324234334309, 6613.933860661332, 6832.521723479507, 6859.485538584527, 6965.442764578923, 7139.964300178466, 7175.246599107228, 7232.168300645282, 7243.311885370881, 7273.672684729094, 6452.645104519296, 6653.068570400244, 6778.152730908637, 6832.59004459734, 6899.413549848319, 6734.6632668367365, 6783.118194634666, 6854.828629284308, 6889.931100688929, 6898.172219333512, 6142.447179753844, 6477.740890364333, 6586.077949087227, 6602.702878370581, 6644.4020038196795, 4488.730676159441, 4587.885302867455, 4643.048175124159, 4682.719036857799, 4962.181240095344, 4788.0, 4807.254875494304, 4868.464468908346, 4958.107540642574, 5044.646874718735], "value": 4148.643132323632, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2006543510354, 320.04466666999, 326.7875880677559, 329.4711987260447, 334.0846081736044, 5383.892322153554, 5396.271503347047, 5413.106837371839, 5413.133898576224, 5445.618806683534, 5285.418603953562, 5328.413874473805, 5329.706866122362, 5333.38666053403, 5342.332208473941, 3981.9601803981877, 4036.5156181258144, 4165.812538435777, 4167.5832416758385, 4178.97910510447, 4147.523034850986, 4182.20538097762, 4186.853460128896, 4191.434156388879, 4192.4759405074365, 4147.543770185277, 4152.584741525853, 4154.771487568182, 4157.605027522396, 4176.206520761061, 4070.816813243396, 4119.423280740699, 4142.689298302625, 4145.79271036447, 4167.374893765929, 3649.671529562352, 3656.597774244831, 3667.8166091695307, 3676.1361080146144, 3686.686631636314, 5077.695338279715, 5087.109755792721, 5115.923261151049, 5117.8464646060675, 5118.590512759008, 4709.976450117728, 4756.548127927841, 4792.429639918283, 4818.518148185189, 4818.807247710088, 5607.439256074401, 5633.971830140823, 5640.37955824863, 5644.238027866227, 5662.716864156776, 4026.0, 4037.1723796621623, 4038.838446462138, 4047.959520404788, 4048.0689441428635, 5816.796412125597, 5918.964181268304, 5945.435183657589, 5950.553708471882, 5961.225040744719, 4142.150859073882, 4145.523264824584, 4147.896302592399, 4156.916861662749, 4166.687498437629, 4199.202151591249, 4201.495820501559, 4223.408722778813, 4234.047339348622, 4240.512341080754, 4695.460022097503, 4785.306130611042, 4791.880202994883, 4793.424789025339, 4816.95183048165, 5634.32388113429, 5656.349519805275, 5661.716914154275, 5663.773449062074, 5677.205191273225, 1443.7906503556926, 1457.9271036448347, 1460.8247010358612, 1468.7649976004002, 1469.5591322603177, 944.3483996042709, 977.5503268496429, 994.2344394815951, 1017.5115944346755, 1032.0917592518535, 4897.0, 4936.48166942473, 4938.160512712848, 4955.008998200375, 4981.37732783402, 5791.362950075489, 5796.82609521715, 5813.331466881278, 5827.329857066492, 5839.941600584025, 4815.277708343707, 4960.280759289883, 4962.280469331927, 4974.104661160954, 4986.6010719143105, 3106.7669924755733, 3109.689031096872, 3128.6402063762503, 3129.6244450666068, 3134.2477805326557, 5374.946250537523, 5440.6735595864375, 5455.208994695747, 5458.317710286215, 5458.727063646802, 5751.482366587027, 5974.790882319098, 5979.970100149471, 5980.684249465111, 5981.0, 5442.0, 5462.7268636568015, 5477.0, 5488.4785945335125, 5489.176623506506, 5647.0, 5751.827445176651, 5760.868478662922, 5803.65178089316, 5966.403359664172, 5746.195532625352, 5766.509846663081, 5815.76736930518, 5841.415858414124, 5864.149698293638, 5525.751341189576, 5530.5022547970875, 5538.307711536058, 5543.9168412474655, 5555.666660000413, 3835.232953409385, 4037.9798101009305, 4060.512738471284, 4070.816813243352, 4072.75563466193, 5833.0, 5843.1235314703135, 5854.658136745165, 5872.1778950947755, 5878.970605146947, 5521.585881058856, 5649.971750141387, 5658.066419040977, 5666.773329066791, 5684.118961560965, 5539.584531160099, 5607.243022191952, 5607.934492446422, 5611.905678392674, 5613.943860561342, 5304.204369344475, 5525.364583072837, 5541.667499950016, 5541.889162216652, 5564.610477266552, 5539.14143307788, 5733.018830208185, 5758.913616295675, 5763.33721622002, 5767.913481297868, 5580.5535557156145, 5585.636933599303, 5585.748641311069, 5591.776328946959, 5623.943760562342], "value": 4254.484592538644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.2378129479157, 696.2098018748725, 761.337636256457, 776.3672606825437, 798.3812545277409, 11801.645950621474, 11860.0, 11907.940460297708, 11911.76176476472, 12017.519299228032, 11456.31262124273, 11564.363959982198, 11579.594714184985, 11588.826167607493, 11626.651200463999, 626.1671976271571, 760.6501009535621, 779.1740754799902, 790.2453157234827, 792.3621484704811, 776.1462391369505, 777.0869228656335, 787.0633945604741, 788.996055019727, 790.3716545346434, 816.1512027491402, 823.8064054947083, 824.4146655874306, 830.3066939105854, 831.4221615976899, 811.2617518058568, 811.8903947967037, 814.7840822182097, 819.086718309087, 819.5369616166847, 605.0379895965392, 605.1044454207753, 606.5693357716027, 608.4827896288164, 614.913912052313, 12040.638780836589, 12131.272123672608, 12173.573924912585, 12198.817017744741, 12217.144799864012, 12655.11414200997, 12988.350582470934, 13040.347982600832, 13148.342582870819, 13285.933570332087, 10112.342697724624, 10203.489825508768, 10280.537375818032, 10368.948155259252, 10531.15750739939, 3326.617438994522, 3336.916577085568, 3358.7313014958745, 3372.0558243691808, 3405.625381208065, 44773.776131119135, 44885.77557112226, 45230.32154517685, 45341.31988020182, 45618.0, 10142.0, 10223.28437009417, 10274.589016439259, 10344.5344959477, 10429.739256518647, 18181.272749089887, 18324.633507329778, 18374.81625183758, 18478.260869565067, 18857.811421885606, 6715.496337774686, 6805.149356330458, 6810.829729256809, 6883.242843287235, 6983.930160698328, 3668.743187976816, 3757.8496860125288, 3792.4311353297226, 3805.8477660893254, 3870.9806450968126, 2853.3865218977603, 2965.273507990513, 2969.747571456407, 2977.419403216352, 2988.2678743707497, 495.2942057567951, 509.38364578859256, 518.388301803875, 522.8771238758889, 533.8211699080852, 618.904069869171, 627.2817623820699, 628.3936001758325, 629.9748010079637, 630.700417301778, 7519.962400187964, 7618.847623047508, 7686.654100565488, 7918.920810791934, 8007.359411247203, 494.0982706560541, 529.8039725301663, 565.7454145634399, 640.5836206465741, 667.2626747444004, 3609.9458508122398, 3666.834992425347, 3741.3639681254253, 3743.494628225155, 3763.6800871926193, 50347.0, 50531.74734126306, 51571.0, 52351.0, 52405.47594524006, 43636.345454817565, 43766.56233437625, 44473.33290000653, 45162.32256516155, 45482.31776523355, 41007.38488922668, 41151.0, 41670.0, 41866.79066604708, 42337.78831105825, 7242.058532390755, 7273.599952002479, 7277.9272207277245, 7279.4540409470565, 7414.66634001482, 27572.862135689193, 28356.858215708788, 28363.0, 28789.0, 28896.7110328894, 34192.0, 34982.0, 36964.6303536972, 37359.6264037367, 37561.24877502489, 9090.545472726206, 9134.132257435533, 9142.634294628406, 9172.954135229282, 9416.293777966817, 10203.0, 11786.76426471483, 11830.822537662114, 12463.376831158586, 13007.56576664096, 10632.255742098288, 10876.456177191267, 11348.716282093013, 11909.702257443632, 12280.754384912074, 10795.730106747395, 11022.118230541377, 11288.548458061585, 11397.202195846212, 11420.885791142315, 11271.605493807678, 11662.300261983968, 11677.649670509898, 12028.0, 12120.0, 9482.38364506305, 10018.599256029676, 10428.478576071318, 10487.213458990758, 10634.787304254027, 9010.27917766564, 9162.450252984841, 9307.813843723223, 10011.599536018477, 10011.983223487176], "value": 5892.515564016302, "unit": "score"}], "name": "dromaeo_css", "value": 6386.82324990033, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 108.0, 114.0, 113.0, 113.0, 124.0, 115.0, 113.0, 113.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 162.0, 196.0, 133.0, 159.0, 161.0, 137.0, 184.0, 135.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 176.0, 165.0, 163.0, 163.0, 164.0, 168.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 162.0, 76.0, 76.0, 75.0, 75.0, 167.0, 78.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 149.0, 95.0, 95.0, 94.0, 138.0, 94.0, 95.0, 141.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 119.0, 123.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 150.0, 148.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 85.0, 65.0, 75.0], "value": 70.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 67.0, 65.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 86.0, 88.0, 87.0, 85.0, 87.0, 86.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 142.0, 141.0, 139.0, 145.0, 141.0, 141.0, 174.0, 142.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 173.0, 178.0, 179.0, 177.0, 173.0, 173.0, 173.0, 173.0, 179.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 75.0, 72.0, 78.0, 74.0, 75.0, 72.0, 72.0, 74.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1619.0, "alertThreshold": 2.0}]} 22:58:55 INFO - Return code: 0 22:58:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:58:55 ERROR - # TBPL SUCCESS # 22:58:55 INFO - Running post-action listener: _resource_record_post_action 22:58:55 INFO - Running post-run listener: _resource_record_post_run 22:58:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 528338944; Read time: 8; Write time: 519600 22:58:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 186892288; Read time: 0; Write time: 219252 22:58:56 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294400000; Read time: 8; Write time: 284920 22:58:56 INFO - Running post-run listener: _upload_blobber_files 22:58:56 INFO - Blob upload gear active. 22:58:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:58:56 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 22:58:56 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:58:56 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:58:57 INFO - (blobuploader) - INFO - Open directory for files ... 22:58:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:58:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:58 INFO - (blobuploader) - INFO - Done attempting. 22:58:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:58:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:58 INFO - (blobuploader) - INFO - Done attempting. 22:58:58 INFO - (blobuploader) - INFO - Iteration through files over. 22:58:58 INFO - Return code: 0 22:58:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:58:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:58:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19b0b10485b937887eb17ab258e36a73aaed5d7c890699193a96e9f544e939329e12f304da7f3f892afc0fc24679886aaca506fd47b6be59b016dc815280a927", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0324e2983389dbae4bd10ff11ffb7da841088752184b5411b44344207798d6d112172b25b3dbd0ca06ab162e54e4fc7b9688ae3bbd8ded4586b15fb3d0add567"} 22:58:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:58:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:58:58 INFO - Contents: 22:58:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19b0b10485b937887eb17ab258e36a73aaed5d7c890699193a96e9f544e939329e12f304da7f3f892afc0fc24679886aaca506fd47b6be59b016dc815280a927", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0324e2983389dbae4bd10ff11ffb7da841088752184b5411b44344207798d6d112172b25b3dbd0ca06ab162e54e4fc7b9688ae3bbd8ded4586b15fb3d0add567"} 22:58:58 INFO - Running post-run listener: copy_logs_to_upload_dir 22:58:58 INFO - Copying logs to upload dir... 22:58:58 INFO - mkdir: /builds/slave/test/build/upload/logs 22:58:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.144022 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-14 22:58:58.532932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 22:58:58.537048) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505 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/Fx-Team-Non-PGO/sha512/19b0b10485b937887eb17ab258e36a73aaed5d7c890699193a96e9f544e939329e12f304da7f3f892afc0fc24679886aaca506fd47b6be59b016dc815280a927", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0324e2983389dbae4bd10ff11ffb7da841088752184b5411b44344207798d6d112172b25b3dbd0ca06ab162e54e4fc7b9688ae3bbd8ded4586b15fb3d0add567"} build_url:https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/UHlv4ktDT0aPSNDjTZrUYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19b0b10485b937887eb17ab258e36a73aaed5d7c890699193a96e9f544e939329e12f304da7f3f892afc0fc24679886aaca506fd47b6be59b016dc815280a927", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0324e2983389dbae4bd10ff11ffb7da841088752184b5411b44344207798d6d112172b25b3dbd0ca06ab162e54e4fc7b9688ae3bbd8ded4586b15fb3d0add567"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 22:58:58.562878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:58:58.563308) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460698219.317271-1433486505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:58:58.647720) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 22:58:58.648073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 22:58:58.648390) ========= ========= Total master_lag: 0.18 =========