builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1461188713.58 results: success (0) buildid: 20160420141601 builduid: a8228298e7954969b9f5414c4af5c937 revision: be1fd1c7e43f3969243b8c768d5dbe6de17f4f7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.581062) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.581527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.581811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.604553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.604897) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 14:45: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% 43.2M=0s 2016-04-20 14:45:14 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.723086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.723435) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017815 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.772721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:13.773083) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be1fd1c7e43f3969243b8c768d5dbe6de17f4f7c --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 be1fd1c7e43f3969243b8c768d5dbe6de17f4f7c --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=fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 14:45:14,145 truncating revision to first 12 chars 2016-04-20 14:45:14,145 Setting DEBUG logging. 2016-04-20 14:45:14,145 attempt 1/10 2016-04-20 14:45:14,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be1fd1c7e43f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 14:45:14,566 unpacking tar archive at: fx-team-be1fd1c7e43f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:14.482100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:14.482410) ========= script_repo_revision: be1fd1c7e43f3969243b8c768d5dbe6de17f4f7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:14.482814) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:14.483108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:45:14.493120) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-04-20 14:45:14.493445) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:45:14 INFO - MultiFileLogger online at 20160420 14:45:14 in /builds/slave/test 14:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:45:14 INFO - {'append_to_log': False, 14:45:14 INFO - 'base_work_dir': '/builds/slave/test', 14:45:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:45:14 INFO - 'branch': 'Fx-Team-Non-PGO', 14:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:45:14 INFO - 'config_files': ('talos/linux_config.py',), 14:45:14 INFO - 'default_actions': ('clobber', 14:45:14 INFO - 'read-buildbot-config', 14:45:14 INFO - 'download-and-extract', 14:45:14 INFO - 'populate-webroot', 14:45:14 INFO - 'create-virtualenv', 14:45:14 INFO - 'install', 14:45:14 INFO - 'run-tests'), 14:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:45:14 INFO - 'download_minidump_stackwalk': True, 14:45:14 INFO - 'download_symbols': 'ondemand', 14:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:45:14 INFO - 'installer_path': 'installer.exe', 14:45:14 INFO - 'log_level': 'info', 14:45:14 INFO - 'log_name': 'talos', 14:45:14 INFO - 'log_to_console': True, 14:45:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:45:14 INFO - 'opt_config_files': (), 14:45:14 INFO - 'pip_index': False, 14:45:14 INFO - 'sps_profile': False, 14:45:14 INFO - 'sps_profile_interval': 0, 14:45:14 INFO - 'suite': 'dromaeojs', 14:45:14 INFO - 'system_bits': '32', 14:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:45:14 INFO - 'title': 'talos-linux64-ix-014', 14:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:45:14 INFO - 'use_talos_json': True, 14:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:45:14 INFO - 'work_dir': 'build'} 14:45:14 INFO - ##### 14:45:14 INFO - ##### Running clobber step. 14:45:14 INFO - ##### 14:45:14 INFO - Running pre-action listener: _resource_record_pre_action 14:45:14 INFO - Running main action method: clobber 14:45:14 INFO - rmtree: /builds/slave/test/build 14:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:45:15 INFO - Running post-action listener: _resource_record_post_action 14:45:15 INFO - ##### 14:45:15 INFO - ##### Running read-buildbot-config step. 14:45:15 INFO - ##### 14:45:15 INFO - Running pre-action listener: _resource_record_pre_action 14:45:15 INFO - Running main action method: read_buildbot_config 14:45:15 INFO - Using buildbot properties: 14:45:15 INFO - { 14:45:15 INFO - "project": "", 14:45:15 INFO - "product": "firefox", 14:45:15 INFO - "script_repo_revision": "production", 14:45:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:45:15 INFO - "repository": "", 14:45:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:45:15 INFO - "buildid": "20160420141601", 14:45:15 INFO - "pgo_build": "False", 14:45:15 INFO - "basedir": "/builds/slave/test", 14:45:15 INFO - "buildnumber": 1691, 14:45:15 INFO - "slavename": "talos-linux64-ix-014", 14:45:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:45:15 INFO - "platform": "ubuntu64_hw", 14:45:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:45:15 INFO - "branch": "fx-team", 14:45:15 INFO - "repo_path": "integration/fx-team", 14:45:15 INFO - "revision": "be1fd1c7e43f3969243b8c768d5dbe6de17f4f7c", 14:45:15 INFO - "stage_platform": "linux64", 14:45:15 INFO - "builduid": "a8228298e7954969b9f5414c4af5c937", 14:45:15 INFO - "slavebuilddir": "test" 14:45:15 INFO - } 14:45:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:45:15 INFO - Running post-action listener: _resource_record_post_action 14:45:15 INFO - ##### 14:45:15 INFO - ##### Running download-and-extract step. 14:45:15 INFO - ##### 14:45:15 INFO - Running pre-action listener: _resource_record_pre_action 14:45:15 INFO - Running main action method: download_and_extract 14:45:15 INFO - mkdir: /builds/slave/test/build/tests 14:45: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')]} 14:45:15 INFO - https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:45:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:45:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:45:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:28 INFO - Downloaded 1361 bytes. 14:45:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:45:28 INFO - Using the following test package requirements: 14:45:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:45:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:45:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:45:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'jsshell-linux-x86_64.zip'], 14:45:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:45:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:45:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:45:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:45:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:45:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:45:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:45:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:45:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:45:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:32 INFO - Downloaded 22267803 bytes. 14:45:32 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'] 14:45:32 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 14:45:33 INFO - Return code: 0 14:45:33 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 14:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:33 INFO - https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:45:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:45:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:45:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:37 INFO - Downloaded 22267803 bytes. 14:45:37 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'] 14:45:37 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 14:45:39 INFO - Return code: 0 14:45: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')]} 14:45:39 INFO - https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:40 INFO - Downloaded 10845952 bytes. 14:45:40 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'] 14:45:40 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 14:45:40 INFO - Return code: 0 14:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:40 INFO - https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 14:46:12 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:46:12 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 14:46:12 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 14:46:12 INFO - Server: 10.26.75.40 14:46:12 INFO - Address: 10.26.75.40#53 14:46:12 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 14:46:12 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 14:46:12 INFO - Address: 10.26.48.46 14:46:12 INFO - Return code: 0 14:46:12 INFO - retry: attempt #1 caught exception: 14:46:12 INFO - retry: Failed, sleeping 30 seconds before retrying 14:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdBvXVCnRBum2vzPXvPYRg/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 #2 14:46:45 INFO - Downloaded 54658163 bytes. 14:46:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:46:45 INFO - mkdir: /builds/slave/test/properties 14:46:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:46:45 INFO - Writing to file /builds/slave/test/properties/build_url 14:46:45 INFO - Contents: 14:46:45 INFO - build_url:https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:46:46 INFO - Running post-action listener: _resource_record_post_action 14:46:46 INFO - Running post-action listener: set_extra_try_arguments 14:46:46 INFO - ##### 14:46:46 INFO - ##### Running populate-webroot step. 14:46:46 INFO - ##### 14:46:46 INFO - Running pre-action listener: _resource_record_pre_action 14:46:46 INFO - Running main action method: populate_webroot 14:46:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:46:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:46:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:46:46 INFO - '--tppagecycles', 14:46:46 INFO - '7'], 14:46:46 INFO - 'tests': ['tsvgm']}}, 14:46:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:46:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:46:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:46:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:46:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:46:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:46:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['damp', 'tps']}, 14:46:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'tests': ['damp', 'tps']}, 14:46:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['dromaeo_dom']}, 14:46:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:46:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['a11yr', 14:46:46 INFO - 'ts_paint', 14:46:46 INFO - 'tpaint', 14:46:46 INFO - 'sessionrestore', 14:46:46 INFO - 'sessionrestore_no_auto_restore', 14:46:46 INFO - 'tabpaint']}, 14:46:46 INFO - 'other-e10s': {'tests': ['a11yr', 14:46:46 INFO - 'ts_paint', 14:46:46 INFO - 'tpaint', 14:46:46 INFO - 'sessionrestore', 14:46:46 INFO - 'sessionrestore_no_auto_restore', 14:46:46 INFO - 'tabpaint']}, 14:46:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:46:46 INFO - 'ts_paint', 14:46:46 INFO - 'tpaint', 14:46:46 INFO - 'sessionrestore', 14:46:46 INFO - 'sessionrestore_no_auto_restore', 14:46:46 INFO - 'tabpaint']}, 14:46:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:46:46 INFO - 'ts_paint', 14:46:46 INFO - 'tpaint', 14:46:46 INFO - 'sessionrestore', 14:46:46 INFO - 'sessionrestore_no_auto_restore', 14:46:46 INFO - 'tabpaint']}, 14:46:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['a11yr', 14:46:46 INFO - 'ts_paint', 14:46:46 INFO - 'tpaint', 14:46:46 INFO - 'sessionrestore', 14:46:46 INFO - 'sessionrestore_no_auto_restore', 14:46:46 INFO - 'tabpaint']}, 14:46:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['a11yr', 14:46:46 INFO - 'ts_paint', 14:46:46 INFO - 'tpaint', 14:46:46 INFO - 'sessionrestore', 14:46:46 INFO - 'sessionrestore_no_auto_restore', 14:46:46 INFO - 'tabpaint']}, 14:46:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['tsvgx', 14:46:46 INFO - 'tsvgr_opacity', 14:46:46 INFO - 'tart', 14:46:46 INFO - 'tscrollx', 14:46:46 INFO - 'cart']}, 14:46:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:46:46 INFO - 'tsvgr_opacity', 14:46:46 INFO - 'tart', 14:46:46 INFO - 'tscrollx', 14:46:46 INFO - 'cart']}, 14:46:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'talos_options': ['--disable-e10s'], 14:46:46 INFO - 'tests': ['tp5o']}, 14:46:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'tests': ['tp5o']}, 14:46:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'talos_options': ['--disable-e10s', 14:46:46 INFO - '--xperf_path', 14:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:46:46 INFO - 'tests': ['tp5n']}, 14:46:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:46:46 INFO - 'talos_options': ['--xperf_path', 14:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:46:46 INFO - 'tests': ['tp5n']}}, 14:46:46 INFO - 'talos.zip': {'path': '', 14:46:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:46:46 INFO - Running post-action listener: _resource_record_post_action 14:46:46 INFO - ##### 14:46:46 INFO - ##### Running create-virtualenv step. 14:46:46 INFO - ##### 14:46:46 INFO - Running pre-action listener: _resource_record_pre_action 14:46:46 INFO - Running main action method: create_virtualenv 14:46:46 INFO - Creating virtualenv /builds/slave/test/build/venv 14:46:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:46:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:46:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:46:46 INFO - Using real prefix '/usr' 14:46:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 14:46:48 INFO - Installing pip.................done. 14:46:48 INFO - Return code: 0 14:46:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:46: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')]} 14:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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')]} 14:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:46:48 INFO - Using env: {'DISPLAY': ':0', 14:46:48 INFO - 'HOME': '/home/cltbld', 14:46:48 INFO - 'LANG': 'en_US.UTF-8', 14:46:48 INFO - 'LANGUAGE': 'en_US:en', 14:46:48 INFO - 'LOGNAME': 'cltbld', 14:46:48 INFO - 'MAIL': '/var/mail/cltbld', 14:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:48 INFO - 'MOZ_NO_REMOTE': '1', 14:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:48 INFO - 'NO_EM_RESTART': '1', 14:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:48 INFO - 'PWD': '/builds/slave/test', 14:46:48 INFO - 'SHELL': '/bin/bash', 14:46:48 INFO - 'SHLVL': '1', 14:46:48 INFO - 'TERM': 'linux', 14:46:48 INFO - 'TMOUT': '86400', 14:46:48 INFO - 'USER': 'cltbld', 14:46:48 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:48 INFO - '_': '/tools/buildbot/bin/python'} 14:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:46:48 INFO - Cleaning up... 14:46:48 INFO - Return code: 0 14:46:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:46: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')]} 14:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46: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')]} 14:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:46:48 INFO - Using env: {'DISPLAY': ':0', 14:46:48 INFO - 'HOME': '/home/cltbld', 14:46:48 INFO - 'LANG': 'en_US.UTF-8', 14:46:48 INFO - 'LANGUAGE': 'en_US:en', 14:46:48 INFO - 'LOGNAME': 'cltbld', 14:46:48 INFO - 'MAIL': '/var/mail/cltbld', 14:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:48 INFO - 'MOZ_NO_REMOTE': '1', 14:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:48 INFO - 'NO_EM_RESTART': '1', 14:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:48 INFO - 'PWD': '/builds/slave/test', 14:46:48 INFO - 'SHELL': '/bin/bash', 14:46:48 INFO - 'SHLVL': '1', 14:46:48 INFO - 'TERM': 'linux', 14:46:48 INFO - 'TMOUT': '86400', 14:46:48 INFO - 'USER': 'cltbld', 14:46:48 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:48 INFO - '_': '/tools/buildbot/bin/python'} 14:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:49 INFO - Downloading/unpacking psutil>=0.7.1 14:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:46:51 INFO - Installing collected packages: psutil 14:46:51 INFO - Running setup.py install for psutil 14:46:51 INFO - building 'psutil._psutil_linux' extension 14:46:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:46:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:46:51 INFO - building 'psutil._psutil_posix' extension 14:46:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:46:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:46:51 INFO - Successfully installed psutil 14:46:51 INFO - Cleaning up... 14:46:51 INFO - Return code: 0 14:46:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:46:51 INFO - Using env: {'DISPLAY': ':0', 14:46:51 INFO - 'HOME': '/home/cltbld', 14:46:51 INFO - 'LANG': 'en_US.UTF-8', 14:46:51 INFO - 'LANGUAGE': 'en_US:en', 14:46:51 INFO - 'LOGNAME': 'cltbld', 14:46:51 INFO - 'MAIL': '/var/mail/cltbld', 14:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:51 INFO - 'MOZ_NO_REMOTE': '1', 14:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:51 INFO - 'NO_EM_RESTART': '1', 14:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:51 INFO - 'PWD': '/builds/slave/test', 14:46:51 INFO - 'SHELL': '/bin/bash', 14:46:51 INFO - 'SHLVL': '1', 14:46:51 INFO - 'TERM': 'linux', 14:46:51 INFO - 'TMOUT': '86400', 14:46:51 INFO - 'USER': 'cltbld', 14:46:51 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:51 INFO - '_': '/tools/buildbot/bin/python'} 14:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:46:53 INFO - Installing collected packages: mozsystemmonitor 14:46:53 INFO - Running setup.py install for mozsystemmonitor 14:46:53 INFO - Successfully installed mozsystemmonitor 14:46:53 INFO - Cleaning up... 14:46:53 INFO - Return code: 0 14:46:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:53 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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:46:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:46:53 INFO - Using env: {'DISPLAY': ':0', 14:46:53 INFO - 'HOME': '/home/cltbld', 14:46:53 INFO - 'LANG': 'en_US.UTF-8', 14:46:53 INFO - 'LANGUAGE': 'en_US:en', 14:46:53 INFO - 'LOGNAME': 'cltbld', 14:46:53 INFO - 'MAIL': '/var/mail/cltbld', 14:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:53 INFO - 'MOZ_NO_REMOTE': '1', 14:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:53 INFO - 'NO_EM_RESTART': '1', 14:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:53 INFO - 'PWD': '/builds/slave/test', 14:46:53 INFO - 'SHELL': '/bin/bash', 14:46:53 INFO - 'SHLVL': '1', 14:46:53 INFO - 'TERM': 'linux', 14:46:53 INFO - 'TMOUT': '86400', 14:46:53 INFO - 'USER': 'cltbld', 14:46:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:53 INFO - '_': '/tools/buildbot/bin/python'} 14:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:46:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:46:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:46:56 INFO - Downloading docopt-0.6.1.tar.gz 14:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:46:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:46:56 INFO - Running setup.py install for blobuploader 14:46:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:46:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:46:56 INFO - Running setup.py install for requests 14:46:57 INFO - Running setup.py install for docopt 14:46:57 INFO - Successfully installed blobuploader requests docopt 14:46:57 INFO - Cleaning up... 14:46:57 INFO - Return code: 0 14:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:46:57 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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:46:57 INFO - Using env: {'DISPLAY': ':0', 14:46:57 INFO - 'HOME': '/home/cltbld', 14:46:57 INFO - 'LANG': 'en_US.UTF-8', 14:46:57 INFO - 'LANGUAGE': 'en_US:en', 14:46:57 INFO - 'LOGNAME': 'cltbld', 14:46:57 INFO - 'MAIL': '/var/mail/cltbld', 14:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:46:57 INFO - 'MOZ_NO_REMOTE': '1', 14:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:46:57 INFO - 'NO_EM_RESTART': '1', 14:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:46:57 INFO - 'PWD': '/builds/slave/test', 14:46:57 INFO - 'SHELL': '/bin/bash', 14:46:57 INFO - 'SHLVL': '1', 14:46:57 INFO - 'TERM': 'linux', 14:46:57 INFO - 'TMOUT': '86400', 14:46:57 INFO - 'USER': 'cltbld', 14:46:57 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:46:57 INFO - '_': '/tools/buildbot/bin/python'} 14:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:46:57 INFO - Running setup.py (path:/tmp/pip-Dn_4iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:46:57 INFO - Running setup.py (path:/tmp/pip-BIzshh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:46:57 INFO - Running setup.py (path:/tmp/pip-PYNTFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:46:57 INFO - Running setup.py (path:/tmp/pip-5x3nfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:46:57 INFO - Running setup.py (path:/tmp/pip-r3MoWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:46:57 INFO - Running setup.py (path:/tmp/pip-OvUV33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:46:57 INFO - Running setup.py (path:/tmp/pip-zZAaO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:46:58 INFO - Running setup.py (path:/tmp/pip-DA0XWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:46:58 INFO - Running setup.py (path:/tmp/pip-BayhxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:46:58 INFO - Running setup.py (path:/tmp/pip-kIDqur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:46:58 INFO - Running setup.py (path:/tmp/pip-QK_IM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:46:58 INFO - Running setup.py (path:/tmp/pip-ATziLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:46:58 INFO - Running setup.py (path:/tmp/pip-brcwQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:46:58 INFO - Running setup.py (path:/tmp/pip-MBs5oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:58 INFO - Running setup.py (path:/tmp/pip-XIDQlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:46:58 INFO - Running setup.py (path:/tmp/pip-B2n0jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:46:58 INFO - Running setup.py (path:/tmp/pip-rZfyG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:46:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:46:58 INFO - Running setup.py install for manifestparser 14:46:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:46:58 INFO - Running setup.py install for mozcrash 14:46:58 INFO - Running setup.py install for mozdebug 14:46:59 INFO - Running setup.py install for mozdevice 14:46:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Running setup.py install for mozfile 14:46:59 INFO - Running setup.py install for mozhttpd 14:46:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Running setup.py install for mozinfo 14:46:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Running setup.py install for mozInstall 14:46:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Running setup.py install for mozleak 14:46:59 INFO - Running setup.py install for mozlog 14:46:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Running setup.py install for moznetwork 14:46:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:46:59 INFO - Running setup.py install for mozprocess 14:46:59 INFO - Running setup.py install for mozprofile 14:47:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:47:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:47:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:47:00 INFO - Running setup.py install for mozrunner 14:47:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:47:00 INFO - Running setup.py install for mozscreenshot 14:47:00 INFO - Running setup.py install for moztest 14:47:00 INFO - Running setup.py install for mozversion 14:47:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:47:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:47:00 INFO - Cleaning up... 14:47:00 INFO - Return code: 0 14:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:00 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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:47:00 INFO - Using env: {'DISPLAY': ':0', 14:47:00 INFO - 'HOME': '/home/cltbld', 14:47:00 INFO - 'LANG': 'en_US.UTF-8', 14:47:00 INFO - 'LANGUAGE': 'en_US:en', 14:47:00 INFO - 'LOGNAME': 'cltbld', 14:47:00 INFO - 'MAIL': '/var/mail/cltbld', 14:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:00 INFO - 'MOZ_NO_REMOTE': '1', 14:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:00 INFO - 'NO_EM_RESTART': '1', 14:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:00 INFO - 'PWD': '/builds/slave/test', 14:47:00 INFO - 'SHELL': '/bin/bash', 14:47:00 INFO - 'SHLVL': '1', 14:47:00 INFO - 'TERM': 'linux', 14:47:00 INFO - 'TMOUT': '86400', 14:47:00 INFO - 'USER': 'cltbld', 14:47:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:00 INFO - '_': '/tools/buildbot/bin/python'} 14:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:00 INFO - Running setup.py (path:/tmp/pip-5tkMHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:00 INFO - Running setup.py (path:/tmp/pip-AlS9US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:00 INFO - Running setup.py (path:/tmp/pip-CnlrGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:00 INFO - Running setup.py (path:/tmp/pip-oNc775-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:01 INFO - Running setup.py (path:/tmp/pip-A4GSIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:01 INFO - Running setup.py (path:/tmp/pip-LDYwVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:01 INFO - Running setup.py (path:/tmp/pip-Eu4RYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:01 INFO - Running setup.py (path:/tmp/pip-yIgkmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:01 INFO - Running setup.py (path:/tmp/pip-tvQzQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:01 INFO - Running setup.py (path:/tmp/pip-568SN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:01 INFO - Running setup.py (path:/tmp/pip-OGph39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:01 INFO - Running setup.py (path:/tmp/pip-89v7G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:01 INFO - Running setup.py (path:/tmp/pip-uR7paN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:01 INFO - Running setup.py (path:/tmp/pip-EBpFqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:01 INFO - Running setup.py (path:/tmp/pip-Bb0SZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:01 INFO - Running setup.py (path:/tmp/pip-LNwGss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:01 INFO - Running setup.py (path:/tmp/pip-68mq2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:47:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:03 INFO - Downloading blessings-1.6.tar.gz 14:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:47:03 INFO - Installing collected packages: blessings 14:47:03 INFO - Running setup.py install for blessings 14:47:04 INFO - Successfully installed blessings 14:47:04 INFO - Cleaning up... 14:47:04 INFO - Return code: 0 14:47:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:47:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:04 INFO - Reading from file tmpfile_stdout 14:47:04 INFO - Current package versions: 14:47:04 INFO - argparse == 1.2.1 14:47:04 INFO - blessings == 1.6 14:47:04 INFO - blobuploader == 1.2.4 14:47:04 INFO - docopt == 0.6.1 14:47:04 INFO - manifestparser == 1.1 14:47:04 INFO - mozInstall == 1.12 14:47:04 INFO - mozcrash == 0.17 14:47:04 INFO - mozdebug == 0.1 14:47:04 INFO - mozdevice == 0.48 14:47:04 INFO - mozfile == 1.2 14:47:04 INFO - mozhttpd == 0.7 14:47:04 INFO - mozinfo == 0.9 14:47:04 INFO - mozleak == 0.1 14:47:04 INFO - mozlog == 3.1 14:47:04 INFO - moznetwork == 0.27 14:47:04 INFO - mozprocess == 0.22 14:47:04 INFO - mozprofile == 0.28 14:47:04 INFO - mozrunner == 6.11 14:47:04 INFO - mozscreenshot == 0.1 14:47:04 INFO - mozsystemmonitor == 0.0 14:47:04 INFO - moztest == 0.7 14:47:04 INFO - mozversion == 1.4 14:47:04 INFO - psutil == 3.1.1 14:47:04 INFO - requests == 1.2.3 14:47:04 INFO - wsgiref == 0.1.2 14:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:47:04 INFO - Using env: {'DISPLAY': ':0', 14:47:04 INFO - 'HOME': '/home/cltbld', 14:47:04 INFO - 'LANG': 'en_US.UTF-8', 14:47:04 INFO - 'LANGUAGE': 'en_US:en', 14:47:04 INFO - 'LOGNAME': 'cltbld', 14:47:04 INFO - 'MAIL': '/var/mail/cltbld', 14:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:04 INFO - 'MOZ_NO_REMOTE': '1', 14:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:04 INFO - 'NO_EM_RESTART': '1', 14:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:04 INFO - 'PWD': '/builds/slave/test', 14:47:04 INFO - 'SHELL': '/bin/bash', 14:47:04 INFO - 'SHLVL': '1', 14:47:04 INFO - 'TERM': 'linux', 14:47:04 INFO - 'TMOUT': '86400', 14:47:04 INFO - 'USER': 'cltbld', 14:47:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:04 INFO - '_': '/tools/buildbot/bin/python'} 14:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:47:04 INFO - Cleaning up... 14:47:04 INFO - Return code: 0 14:47:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:04 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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:47:04 INFO - Using env: {'DISPLAY': ':0', 14:47:04 INFO - 'HOME': '/home/cltbld', 14:47:04 INFO - 'LANG': 'en_US.UTF-8', 14:47:04 INFO - 'LANGUAGE': 'en_US:en', 14:47:04 INFO - 'LOGNAME': 'cltbld', 14:47:04 INFO - 'MAIL': '/var/mail/cltbld', 14:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:04 INFO - 'MOZ_NO_REMOTE': '1', 14:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:04 INFO - 'NO_EM_RESTART': '1', 14:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:04 INFO - 'PWD': '/builds/slave/test', 14:47:04 INFO - 'SHELL': '/bin/bash', 14:47:04 INFO - 'SHLVL': '1', 14:47:04 INFO - 'TERM': 'linux', 14:47:04 INFO - 'TMOUT': '86400', 14:47:04 INFO - 'USER': 'cltbld', 14:47:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:04 INFO - '_': '/tools/buildbot/bin/python'} 14:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:04 INFO - Downloading/unpacking jsonschema 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:47:06 INFO - Downloading/unpacking functools32 (from jsonschema) 14:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:47:06 INFO - warning: no files found matching '*.txt' 14:47:06 INFO - no previously-included directories found matching 'build' 14:47:06 INFO - no previously-included directories found matching 'dist' 14:47:06 INFO - no previously-included directories found matching '.git*' 14:47:06 INFO - Installing collected packages: jsonschema, functools32 14:47:06 INFO - Running setup.py install for functools32 14:47:07 INFO - warning: no files found matching '*.txt' 14:47:07 INFO - no previously-included directories found matching 'build' 14:47:07 INFO - no previously-included directories found matching 'dist' 14:47:07 INFO - no previously-included directories found matching '.git*' 14:47:07 INFO - Successfully installed jsonschema functools32 14:47:07 INFO - Cleaning up... 14:47:07 INFO - Return code: 0 14:47:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:07 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 0x7f3f9e57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:47:07 INFO - Using env: {'DISPLAY': ':0', 14:47:07 INFO - 'HOME': '/home/cltbld', 14:47:07 INFO - 'LANG': 'en_US.UTF-8', 14:47:07 INFO - 'LANGUAGE': 'en_US:en', 14:47:07 INFO - 'LOGNAME': 'cltbld', 14:47:07 INFO - 'MAIL': '/var/mail/cltbld', 14:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:07 INFO - 'MOZ_NO_REMOTE': '1', 14:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:07 INFO - 'NO_EM_RESTART': '1', 14:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:07 INFO - 'PWD': '/builds/slave/test', 14:47:07 INFO - 'SHELL': '/bin/bash', 14:47:07 INFO - 'SHLVL': '1', 14:47:07 INFO - 'TERM': 'linux', 14:47:07 INFO - 'TMOUT': '86400', 14:47:07 INFO - 'USER': 'cltbld', 14:47:07 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:07 INFO - '_': '/tools/buildbot/bin/python'} 14:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:07 INFO - Downloading/unpacking flake8 14:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:47:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:47:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:47:09 INFO - no previously-included directories found matching 'docs/_build' 14:47:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:47:10 INFO - Running setup.py install for pep8 14:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:47:10 INFO - no previously-included directories found matching 'docs/_build' 14:47:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:47:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:47:10 INFO - Cleaning up... 14:47:10 INFO - Return code: 0 14:47:10 INFO - Running post-action listener: _resource_record_post_action 14:47:10 INFO - Running post-action listener: _start_resource_monitoring 14:47:10 INFO - Starting resource monitoring. 14:47:10 INFO - ##### 14:47:10 INFO - ##### Running install step. 14:47:10 INFO - ##### 14:47:10 INFO - Running pre-action listener: _resource_record_pre_action 14:47:10 INFO - Running main action method: install 14:47:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:10 INFO - Reading from file tmpfile_stdout 14:47:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:47:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:47:10 INFO - Reading from file tmpfile_stdout 14:47:10 INFO - Output received: 14:47:10 INFO - Usage: mozinstall [options] installer 14:47:10 INFO - Options: 14:47:10 INFO - -h, --help show this help message and exit 14:47:10 INFO - -d DEST, --destination=DEST 14:47:10 INFO - Directory to install application into. [default: 14:47:10 INFO - "/builds/slave/test"] 14:47:10 INFO - --app=APP Application being installed. [default: firefox] 14:47:10 INFO - mkdir: /builds/slave/test/build/application 14:47:10 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'] 14:47:10 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 14:47:26 INFO - Reading from file tmpfile_stdout 14:47:26 INFO - Output received: 14:47:26 INFO - /builds/slave/test/build/application/firefox/firefox 14:47:26 INFO - Running post-action listener: _resource_record_post_action 14:47:26 INFO - ##### 14:47:26 INFO - ##### Running run-tests step. 14:47:26 INFO - ##### 14:47:26 INFO - Running pre-action listener: _resource_record_pre_action 14:47:26 INFO - Running main action method: run_tests 14:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:47:26 INFO - Python 2.7.3 14:47:26 INFO - Return code: 0 14:47:26 INFO - grabbing minidump binary from tooltool 14:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:26 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 0x1ee9410>, '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 0x1eea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eea7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:47:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:47:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:47:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:47:26 INFO - Return code: 0 14:47:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:47:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:47:27 INFO - Return code: 0 14:47:27 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:47:27 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:47:27 INFO - Using env: {'DISPLAY': ':0', 14:47:27 INFO - 'HOME': '/home/cltbld', 14:47:27 INFO - 'LANG': 'en_US.UTF-8', 14:47:27 INFO - 'LANGUAGE': 'en_US:en', 14:47:27 INFO - 'LOGNAME': 'cltbld', 14:47:27 INFO - 'MAIL': '/var/mail/cltbld', 14:47:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:47:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:27 INFO - 'MOZ_NO_REMOTE': '1', 14:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:27 INFO - 'NO_EM_RESTART': '1', 14:47:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:27 INFO - 'PWD': '/builds/slave/test', 14:47:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:47:27 INFO - 'SHELL': '/bin/bash', 14:47:27 INFO - 'SHLVL': '1', 14:47:27 INFO - 'TERM': 'linux', 14:47:27 INFO - 'TMOUT': '86400', 14:47:27 INFO - 'USER': 'cltbld', 14:47:27 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691', 14:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:27 INFO - '_': '/tools/buildbot/bin/python'} 14:47:27 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:47:27 INFO - mozversion application_buildid: 20160420141601 14:47:27 INFO - mozversion application_changeset: be1fd1c7e43f3969243b8c768d5dbe6de17f4f7c 14:47:27 INFO - mozversion application_display_name: Nightly 14:47:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:47:27 INFO - mozversion application_name: Firefox 14:47:27 INFO - mozversion application_remotingname: firefox 14:47:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:47:27 INFO - mozversion application_vendor: Mozilla 14:47:27 INFO - mozversion application_version: 48.0a1 14:47:27 INFO - mozversion platform_buildid: 20160420141601 14:47:27 INFO - mozversion platform_changeset: be1fd1c7e43f3969243b8c768d5dbe6de17f4f7c 14:47:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:47:27 INFO - mozversion platform_version: 48.0a1 14:47:27 INFO - using testdate: 1461188847 14:47:27 INFO - actual date: 1461188847 14:47:27 INFO - starting webserver on 'localhost:44250' 14:47:27 INFO - SUITE-START | Running 2 tests 14:47:27 INFO - TEST-START | dromaeo_css 14:47:27 INFO - operating with platform_type : linux_ 14:47:27 INFO - Initialising browser for dromaeo_css test... 14:47:27 INFO - TEST-INFO | started process 15199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOEabIl/profile http://localhost:44250/getInfo.html) 14:47:31 INFO - PROCESS | 15199 | __metrics Screen width/height:1600/1200 14:47:31 INFO - PROCESS | 15199 | colorDepth:24 14:47:31 INFO - PROCESS | 15199 | Browser inner width/height: 1024/697 14:47:31 INFO - PROCESS | 15199 | __metrics 14:47:32 ERROR - PROCESS | 15199 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:47:33 INFO - TEST-INFO | 15199: exit 0 14:47:33 INFO - Browser initialized. 14:47:33 INFO - Running cycle 1/1 for dromaeo_css test... 14:47:33 INFO - TEST-INFO | started process 15282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOEabIl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:45 INFO - PROCESS | 15282 | RSS: Main: 155394048 14:47:45 INFO - PROCESS | 15282 | 14:48:37 INFO - PROCESS | 15282 | 1461188917008 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:50:48 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44250/tests/dromaeo/cssquery-ext.html) 14:50:49 INFO - PROCESS | 15282 | RSS: Main: 264916992 14:50:49 INFO - PROCESS | 15282 | 14:53:52 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44250/tests/dromaeo/cssquery-ext.html (next: http://localhost:44250/tests/dromaeo/cssquery-jquery.html) 14:53:52 INFO - PROCESS | 15282 | RSS: Main: 232562688 14:53:52 INFO - PROCESS | 15282 | 14:56:54 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44250/tests/dromaeo/cssquery-mootools.html) 14:56:55 INFO - PROCESS | 15282 | RSS: Main: 233795584 14:56:55 INFO - PROCESS | 15282 | 14:59:57 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44250/tests/dromaeo/cssquery-prototype.html) 14:59:58 INFO - PROCESS | 15282 | RSS: Main: 225124352 14:59:58 INFO - PROCESS | 15282 | 15:03:01 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44250/tests/dromaeo/cssquery-yui.html) 15:03:01 INFO - PROCESS | 15282 | RSS: Main: 214089728 15:03:01 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44250/tests/dromaeo/cssquery-yui.html (next: http://localhost:44250/tests/dromaeo/cssquery-dojo.html) 15:06:04 INFO - PROCESS | 15282 | RSS: Main: 268767232 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | __start_tp_report 15:06:04 INFO - PROCESS | 15282 | _x_x_mozilla_page_load 15:06:04 INFO - PROCESS | 15282 | _x_x_mozilla_page_load_details 15:06:04 INFO - PROCESS | 15282 | |i|pagename|runs| 15:06:04 INFO - PROCESS | 15282 | |0;dojo.html;2601.349662584354;2620.8689565521745;2657.0700254910785;2662.3477248074214;2667.746564076413;4570.474395444525;4654.813807447698;4660.930086048712;4668.929966050508;4700.482946875845;4677.204875171221;4730.148573256813;4731.57415832575;4749.311349854269;4765.332853400518;4207.978960105195;4251.91496170078;4263.403123562712;4314.805833737473;4433.623142032931;4358.912821743564;4384.736915785047;4401.295792673173;4410.823567057314;4437.267850804614;4167.91664166715;4237.703360764748;4263.5736426357425;4339.7396156230725;4348.434703488526;4256;4295.119500502389;4295.785210739482;4296.74219546825;4343.913121737579;4222.282212023963;4226.873193804191;4229.450171477688;4256.276433006366;4263.722858014219;4389.670774691879;4548.499665036877;4599.218132917378;4679.789409476582;4694.81220751173;5003.524665156804;5007.474215207423;5009.073321435546;5009.098362294785;5037.748112594356;4979.4771548987555;4995.350604421438;5005.6496045276845;5007.148784706608;5069.670471419383;4605.98668292975;4702;4790.377250957354;4796.016816552598;4797.112534181188;5132.101882170605;5141.2288156776785;5142.742862856842;5167.276581278624;5170.68975861442;4924.655274130848;4926.827561035347;4927.679700819435;4930.33440485537;4972.030454061423;4932.136876046678;4965.82619608312;5013.473585273494;5059.266406371055;5073.441921388644;4958.553730164303;4960.578350840146;4968.031233909425;4971.37857767779;5017.498250174954;4919.434265059493;4922.187839006524;4941.407031156285;4963.851084467472;4973.900521989613;3800.809959502014;3849.172427928009;3850.5186851643543;3854.807259637007;3930.7248492605245;3455.049861288166;3496.737744669109;3500.649935006479;3515.5254040704176;3532.982335088308;4366.737995720267;4368.27923392643;4368.27923392643;4409.559044095565;4413.668974826836;4900.044491324229;5051.747412629354;5057.115004874132;5125.56432703217;5133.255677926754;4326.480822301344;4343.804528796211;4346.500152482505;4349.978250108729;4388.363687265329;4478.888027799331;4483.865484035484;4486.0803535275845;4491.214037543416;4532.728036317765;4618.168729628699;4631.745254010994;4722.291656251589;4738.668293219442;4740.549647783455;5015.473375295687;5035.0685123252315;5038.093143234253;5043.873903152304;5089.05852417304;4763.618910487222;4770.284457331428;4770.856874293777;4775.785089671042;4814.518548145157;4806.855794326036;4936.03747269279;4967.329410529533;5033.697978121324;5042.495750425075;5013.674111182761;5028.4971502850885;5031.52200540948;5032.547070763649;5074.543291103819;4889.144399730104;4890.168671325954;4893.657443978887;4900.117978763857;4951.331570237971;4679.4852566217005;4803.495632958489;4883;4890.877728056827;4892.363992680928;4771.093492236464;4798.976005119952;4802.831900883452;4809;4851.51484851512;4901.215805471107;4906.288588154626;4911.361523001987;4913;4963.205887058053;4612.100640375094;4691.788869500812;4831.661783675109;4920.114379411741;4921.532454416824 15:06:04 INFO - PROCESS | 15282 | |1;ext.html;576.3285772075532;592.650336301582;603.8460192650873;615.5783288447412;616.8889599872027;33875.153121171985;33902.49146262805;34415.483767743506;34443;34603.48094778577;36138.63861361392;36711;36752;36755.26489470209;36859.26281474376;7005.54463959841;7692.576908270057;7833.138354780969;7909.1299957004685;9577.664781732641;9750.707478775648;9900.653477128302;9902.752431189207;9908;9909.653162139326;9930.751731206741;10048.196144308475;10051.195904327673;10054.447005414699;10055.798884022315;9883.90116098837;9931;9949.75125621858;9951.502424878727;9989.10098091168;9817.410955342702;9902.504874756305;9908.35595686278;9919.851202231972;10227.232957528215;35193.120171995906;35425.64574354249;35453.11367215814;35563.46654800154;35602;3294.621118571371;3299.1752061984503;3371.3088816792497;3732.4774531565604;3987.2623564640635;29134.12597622075;29336.413271734447;29408.8529557353;29421;29893.103206903827;3461.7749846259912;3481.6866482016485;3526.748004458406;3629.0502350511115;3677.5035370224946;200682;202913;202973;203125.9843700787;203146;50552;51512.742436288325;51607.48392516102;51632;51632.74183629058;54479.45520544744;54852.72573637106;54865.72567137139;55030.72484637551;55089;13328.200307981358;13461.596152115451;13462.528811491748;13468.259245741383;13474.124181928339;9856.408615482951;10491.947540262403;10807.189460790472;10822.404767737693;10843.132549396028;17697.557561061076;17762.91118544425;17767.111644417728;17777.733334;17793.46619601388;7082.964585177041;7125.25184855593;7205.71177152908;7279.41764658826;7327.633618319062;888.6401007591936;922.3082687984012;927.2813569483569;952.4380615436926;996.7657600463886;26747.732522674913;27996.8600157002;28361.574576381372;28450.57324140098;28685.426291474054;1010.5149528226492;1014.5840205515703;1014.6854475112739;1018.4551265073299;1117.2402766119117;14421.42314307437;14896.255187240811;14956.551303460914;15162.620934476727;15240.466583669519;361248;364963;366672;366709;367748;49492.75253623709;50397.74801125971;50398.74800625973;50414.495855041714;50611.24083138756;1084.5715942202785;1183.5798291606357;1265.860755316933;1274.7004453953314;1370.3011464153153;24373.51252974895;25656.74343256618;26238.73761262363;26270.737292627593;26290.474190516466;35777;35793.64206357903;36127;36218.4567231497;36265;230471;232757;232853;233953;233999;21977.34067977963;22811;24536;25404.110856119947;25593.23220303394;35839;35989.82005090063;36425.635743642226;36433.45349819702;36803;33260.83369583137;33893.83053084719;34015.319693606485;34929.65070349264;35041;34066;34471.82764086164;34574.82712586421;34726.30547388987;34837.47743783896;34996.65003349934;35327.646723533464;35360.82319588386;35971.82014089913;37269.440958386185;26980.595291071044;28127.859360703067;28810.40056359713;31098.59043356393;31117.71553111866;21277.68083478718;21846.67229991583;21875.59368469435;21960.560788784453;22123.33629991103 15:06:04 INFO - PROCESS | 15282 | |2;jquery.html;380.211062046254;382.27368000798464;391.90986073203163;393.37846202999265;395.0912900329243;16016.679666406679;16232.350705971776;16283.674326513463;16298.918505407471;16299.91850040748;16149.43476978306;16467.176641167953;17178.570535736613;17197.14014299283;17197.742033869472;5133.255677926699;5279.683219006853;5308;5312.2828418163635;5319.946800531984;3690.4279836625365;5492.588055895804;6044.848878778022;6049.788257410992;6051.152838602599;5984.940150598503;6002.279726432834;6021.488173505258;6023.939760602404;6417.6149431034055;6720.361565651256;6731.225909020427;6749.966250168767;6762.7150841340235;6774.898376524331;3958.5249770027494;6258.49932005443;6652.06871038055;6697.296783837675;6704.396604305636;21925.342239732832;21953.231636892633;21987.670184947237;22161.778382216293;22526.88736556323;2034.2778313698573;2131.3392848217104;2180.9890950545305;2207.381933058746;2250.8762018089;13119.409626566827;13813.654658633513;14398.92800536001;14653.780193297109;14669.119852808759;1776.9289228430848;1935.4677463697456;1984.2063174730079;1985.54332503525;2013.2651582172548;84587;87521.12478875193;87865.56067219622;88030.55984720035;89194.5540272301;15191.544253672408;16032.358705651643;16495.422660206834;16559.6688066238;16603.16984150812;30194.82954289812;30234.84882575573;30536.69463305383;30571.541426878615;30600.54099188514;8101.230383113595;8436.704715335056;8519.829603407898;8604.612792424356;8634.179752923463;6850.9314906850295;6854.897176542356;6949.166100068024;6953.096097507393;6987.650617469106;8113.391495637851;8195.95902020498;8336.458130221516;8389.622466989;8479.321654267767;2642.471505698868;3332.650071742432;3428.7428442866385;3439.2949445363643;3485.1809824691177;791.2799352589232;800.4984423676012;849.524266410812;913.7761248494029;920.9907900920905;15611.141387223812;15798.222301850386;16447.83552164463;17072.317107315568;17084;874.2699845628971;893.1515060692368;905.343625871238;928.832810094176;941.1717688434134;9104.544772761335;9177.678781242625;9653;9982.700518984297;10095.646652367132;442571.7428257213;451659;457067;457605;457703;76190;80919;82085;82977.37344064568;83408;965.3821554205314;972.231936769958;979.3976704326788;1030.6598822388594;1057.0222544146634;15330.77003844921;15385.384584616937;15429.922850385676;15540.844591554393;15828.920855395649;32812.343753124325;34305.48541771826;34558.481622776184;35215.647843521234;35317.470237945934;48955.26567101567;49499;49544.256836146764;49825.750871245415;49835;6587.4071333580205;6834.179898412222;6906.482013849082;6973.8256543584785;7094.787156385317;9735.853962190715;11497.482613282255;11659.18385712992;11834.349110798988;11862.940685296518;7162;9600.711978640651;10068.496575171359;10283.84574231402;10347.223958203014;9945.254105941938;10260.384376937407;10283.12593429567;10285.485725713834;10345.224108191765;9903.207743380368;10211.948940255252;10514.631987880693;10564.781395906946;10625.574977001143;7682.423818213544;7757.806054848674;7908.762737117896;7920.960395197987;8025.5585942773705;8877.644894204159;9812.85280720804;9888.950555247178;10313.74215644615;10520.789584208425 15:06:04 INFO - PROCESS | 15282 | |3;mootools.html;1285.6335944255877;1418.8510206428327;1455.1269238456928;1578.1872335747084;1767.6729804986087;7265.709371625136;7611.8097047573765;7628.656710448029;7629.465937384385;7633.885491717621;7393.112826460832;7536.8115797104965;7539.585322807244;7551.395888328934;7553.962230188855;1905.7808352039553;1975.733276007742;1976.041619814389;2178.096090122597;2206.249875042485;2207.0509680837235;2288.5766133265315;2293.20884294918;2298.586254474194;2299.827512936528;2172.674098885172;2179.967300490494;2183.770704076065;2192.375173075674;2219.966700499494;1877.9061046947734;2135.9679604805783;2171.7393912730417;2181.792729690677;2184.552166805817;2223.5997520446313;2237.228156286095;2252.7409347925036;2254.1546919905036;2254.8083412909923;7407.777766667009;7487.363574096208;7487.7753667389525;7495.175530691619;7519.2104828992715;4430.401895744066;4575.107853968478;4588.564086411786;4604.217283061887;4610.354550362952;2717.648147877484;2995.1164406500134;2996.2509372656837;3000.6249218847643;3022.1386904732267;899;918.9954050229773;931.9720408387759;934.145257089762;940.5814412586402;10198.286119971604;10213.438260895648;10228.07947284748;10236.078752912199;10247.333923294962;4089.509258888893;4208.36874468826;4266.0827921996915;4374.147041326974;4426.889327766831;8878.245349145265;8888.688895888612;8891.777705557413;8907.51008694515;8908;4596.97701511497;4612.308153776893;4615.423072115986;4628.166929952641;4636.930446043312;3668.908277293089;4111.280525907954;4225.19721252961;4226.915461690811;4248.341507066348;3573.2312505310038;3597.6762091411897;3704.9259014819554;3730.962690373116;3739.3082279778328;1222.370479203211;1238.8885000350012;1244.8817362350562;1253.5487224599137;1256.133268045046;722.7073035420663;735.6836560279131;771.4368510987011;891.3893982621925;914.3873604684877;5277.20841873722;5347.144456886879;5456.863578410572;5463.399026107125;5578.581606379537;883.9381243313035;886.2953951608487;925.8102089071724;941.9293552983416;945.8723072385278;3689.94465083024;3697.926041479155;3741.6071312511795;3799.9430008549894;3857.286402015636;8963;9384.436933783994;9431.339806213498;9438.150566449052;9529.475878826592;9456.33805633599;9602.183814375716;9609.375390599589;9611.855822162674;9618.951905240569;6876.071730316343;7144.428445724329;7158.749443769443;7196.496245262886;7209.423246140296;5296.761645726028;5511.450685449251;5627.831165065055;5640.266765320482;5729.255196824386;8641.092685267957;8715.782105447415;8816.691415800417;8914.465132092095;9033.819323613623;8882.733517994471;9037.367384283038;9072.410293330913;9110.954445227731;9155.176034156957;5886.705664716661;6296.905546416716;6438.581492202992;6501.284858665637;6642.269350371359;7466.701331946661;7483.88774168377;7535.208803075818;7537.397008239437;7546.320831125225;6666.066750654815;6743.393094621508;6814.557053791487;6904.723811047502;6916.654167291716;6773.796786096425;6779.35596118368;6809.4211991979255;6841.042254084333;6899.551529150589;6166.845828854314;6286.277078136073;6362.968185159045;6371.840703982438;6381;4628;4665.710673974771;4724.4094488188975;4758.547937945889;4782.641301902441;4691.202495575829;4751.952480475151;4770.308305295782;4791.4729379767505;4882.462929077869 15:06:04 INFO - PROCESS | 15282 | |4;prototype.html;308.63735111244284;311.7194524927564;313.5359667691816;314.959055322808;315.2166865339632;5104.795808167673;5107.7956881724685;5135.460776618457;5138.588912886969;5144.536991670749;5042.0924233638025;5042.16804227303;5063.316452278941;5065.898682026357;5079.415867175276;3747.681447076995;3809.2381523695235;3921.8431262749455;3970.8610198643055;3995.5205375354853;3955.782431966241;3965.3655415133585;3977.4630424892703;3983.1635356575007;3984.621460961204;3750.6999440044733;3924.2151569686034;3932.2725295820223;3940.704447166474;3957.861474848381;3823.5985221551755;3939.3500072488005;3942.310095733264;3964.167524819791;3969.2260009298343;3469.9826500867334;3470.7917524948584;3495.8776442824633;3500.7724497907557;3512.5609298837644;4820.734859582722;4824.638152138568;4835.758212089417;4835.85492435224;4839.782209800567;4256.723312984677;4441.777911104432;4462.456399852085;4499.325101234808;4539.205639013159;5272.815451459181;5273.789048438058;5276.337953544659;5306.70813105279;5308.177232528964;3743.9625603743884;3747.3254814133447;3748.9625103748886;3750.1187221003042;3755.2114056048263;5274.26160337553;5501.697406642633;5550.333959924795;5588.832335029955;5596.781850436016;3813.809309534512;3815.7901315427916;3829.291581057513;3831.2912111259507;3850.9229815403537;3873.341531939521;3879.262940041383;3880.941785873214;3887.9805600971813;3904.5509766376663;4183.226103170923;4428.645708343325;4451.666125040635;4452.510223875371;4461.598456138963;5254.238135470336;5316.494932981361;5318.308619879391;5348.491893270133;5372.785088596491;1338.645259006364;1351.1622793867864;1352.3981828086603;1362.7070179911366;1362.8432730235952;861.7845538615346;889.8620713789373;901.1844280925773;912.6121398405651;917.775145089444;4646.3495110684535;4661.300804879295;4679.344891715163;4692.577668009895;4697.577218050324;5407.324084489439;5428.565714742811;5430.8913821723345;5448.536874365724;5462.0987537056735;4505.5719706627815;4653.464851542049;4662.272570546201;4676.368690226844;4779.737114458738;2938.30949726814;2960.304328482805;2962.4223276460884;2965.303153758865;2965.4069186162424;5267.104592219332;5272.182811664198;5272.630915835932;5287.365516138011;5304.151335786256;5477.452254774491;5676.233708449389;5708.65748055118;5718.513926316226;5735.885282294331;5204.42751297357;5235.659682120726;5248.868778280574;5265.894682106413;5279.709615971158;5415.458454154553;5523.33719953592;5549.835564129912;5566.109422492382;5574.9442505574425;5446.891062178814;5484.122540393678;5486.214511986716;5488.5334746545395;5490.231367608458;5262.868428289324;5273.78904843802;5274.12976858814;5288.629795914249;5299.655522391032;3789.5452545694693;3864.246471937945;3878.864239751595;3882.22355528901;3892.4939757831303;5507.5593952484505;5541.3904470507405;5541.612087153861;5558.305211848519;5559.11054231321;5337.946620533745;5357.276767636475;5357.303550538405;5376.489233522809;5388.865278368072;5030.522100400456;5351.902859913631;5358.338914936382;5362.222477740628;5366.490183432567;5031.899362012812;5261.579073674174;5269.130593452038;5269.947300526946;5304.177852432879;5173.40505841818;5295.808443100272;5305.442928492453;5311.681299122065;5319.654222475527;5195.6622819516615;5216.739163041757;5231.293775340432;5246.6065045121;5255.3168088148295 15:06:04 INFO - PROCESS | 15282 | |5;yui.html;658.660789693308;707.4305184326615;729.0740759235771;742.4988133010216;765.5291995422815;11608.709782255448;11974.40127993599;12023.098267629919;12150;12201.328926909027;11368.147388945841;11425.485853136608;11429.314241145516;11441.942790286037;11445;636.7389370358154;790.0992868130336;809.9352051835868;828.2959484438239;830.2361827119034;816.9550674712889;817.4073796497552;817.480899628737;819.1276290750361;820.0487434575894;854.8931383577053;855.3627547477138;855.80744332525;855.8630619100945;857.1342943626919;661.3849120318102;831.9916800831975;853.9658413663446;857.9227869491775;858.6007506509441;620.509797260164;621.3755176048043;625.2840497630187;626.5426238845623;626.5520153090562;11340.886591134065;11411.372374519398;11443.713907152305;11459.083273338196;11464.885351146466;12239.20445171061;12339.62981110568;12683.936580317131;12703.555375561904;12947.287899165542;9438.95280523593;9445.858312125323;9535.618575256982;9620.855687164629;9710.805783884354;3286.1291757684235;3289.555909952174;3309.3712194683176;3400.9032560038504;3404.5233667286598;48111;48175.759121204166;48234.27648585274;48269;48449.273260901115;9391.248700103975;9640.614375424904;9652.565634546463;9662.613495460244;9955.701328960144;15877.364905403654;15884.364625414853;15889.443869464514;15900.76148857768;16046.438374657064;6957.65211739411;6982.930170698228;7030.929690703129;7193.928060719326;7199.388052015533;3744.9063773405883;3877.3602355611574;3898.902527436837;3917.745346552465;3932.174243408859;2748.189284161177;2813.5357665984884;2820.379516506406;2830.7027762084685;2833.2208642623445;482.399412731152;500.88980424306595;502.1689104532005;537.2666310486159;561.7022977821761;549.5658429840461;594.3076316091791;621.9720112594944;642.7975187815823;644.4364151120757;7526.441010056607;7721.3868733426125;7723.729669461542;7824.726134585262;7948.165442628557;520.5341219608505;561.4273441090065;561.9044762390404;581.4970050905936;584.9675323054812;3560.964390356115;3732.8880133596035;3753;3758.530183727034;3777.9244415112094;57052.71473642605;57975.71012144912;57977.71011145002;58017.709911450176;58119.70940145357;49042;49581;49914;50327.496725033016;50559.49440505621;45479.545204548194;45819.541804581524;46184;46590.30114548217;46848;6846.486513511407;6877.89683154763;7026.086608740831;7038.577685338896;7198.388137008413;29764.70235297706;29788.85105574545;30679.233019173807;31073;31410.371792564478;40088.39867401933;41344.586554134075;41809.372859406525;42827.85860707014;42833.143337133704;9491.620335186515;9706.964277692605;10431.193116824927;10541.578336866747;10666.946665266623;11681.824772628248;11754.177207595387;12217.205881617667;12327.137100402886;12616.747665046463;11089.667309980714;11200.159988000769;11334.206605537533;11530.654080377602;11712.238704484182;11440.48517816717;11460.312381257152;11643;11668.416579171177;11944.402779860799;10737.624183153552;11248.662540123809;11377.146713996317;11511.136664750009;11550.306981581132;9588.232941364813;9769.169620582046;9781.510924453607;9828.312018158946;9988.650397236062;9108.362414630912;9233.58448869789;9732;9893.901060989298;10013.499325033865 15:06:04 INFO - PROCESS | 15282 | __end_tp_report 15:06:04 INFO - PROCESS | 15282 | __start_cc_report 15:06:04 INFO - PROCESS | 15282 | _x_x_mozilla_cycle_collect,993 15:06:04 INFO - PROCESS | 15282 | __end_cc_report 15:06:04 INFO - PROCESS | 15282 | __startTimestamp1461189964630__endTimestamp 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | ------- Summary: start ------- 15:06:04 INFO - PROCESS | 15282 | Number of tests: 6 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | [#0] dojo.html Cycles:165 Average:4614.88 Median:4770.86 stddev:511.08 (10.7%) stddev-sans-first:487.63 15:06:04 INFO - PROCESS | 15282 | Values: 2601.3 2620.9 2657.1 2662.3 2667.7 4570.5 4654.8 4660.9 4668.9 4700.5 4677.2 4730.1 4731.6 4749.3 4765.3 4208.0 4251.9 4263.4 4314.8 4433.6 4358.9 4384.7 4401.3 4410.8 4437.3 4167.9 4237.7 4263.6 4339.7 4348.4 4256.0 4295.1 4295.8 4296.7 4343.9 4222.3 4226.9 4229.5 4256.3 4263.7 4389.7 4548.5 4599.2 4679.8 4694.8 5003.5 5007.5 5009.1 5009.1 5037.7 4979.5 4995.4 5005.6 5007.1 5069.7 4606.0 4702.0 4790.4 4796.0 4797.1 5132.1 5141.2 5142.7 5167.3 5170.7 4924.7 4926.8 4927.7 4930.3 4972.0 4932.1 4965.8 5013.5 5059.3 5073.4 4958.6 4960.6 4968.0 4971.4 5017.5 4919.4 4922.2 4941.4 4963.9 4973.9 3800.8 3849.2 3850.5 3854.8 3930.7 3455.0 3496.7 3500.6 3515.5 3533.0 4366.7 4368.3 4368.3 4409.6 4413.7 4900.0 5051.7 5057.1 5125.6 5133.3 4326.5 4343.8 4346.5 4350.0 4388.4 4478.9 4483.9 4486.1 4491.2 4532.7 4618.2 4631.7 4722.3 4738.7 4740.5 5015.5 5035.1 5038.1 5043.9 5089.1 4763.6 4770.3 4770.9 4775.8 4814.5 4806.9 4936.0 4967.3 5033.7 5042.5 5013.7 5028.5 5031.5 5032.5 5074.5 4889.1 4890.2 4893.7 4900.1 4951.3 4679.5 4803.5 4883.0 4890.9 4892.4 4771.1 4799.0 4802.8 4809.0 4851.5 4901.2 4906.3 4911.4 4913.0 4963.2 4612.1 4691.8 4831.7 4920.1 4921.5 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | [#1] ext.html Cycles:180 Average:42265.17 Median:19159.58 stddev:72527.44 (378.5%) stddev-sans-first:72663.35 15:06:04 INFO - PROCESS | 15282 | Values: 576.3 592.7 603.8 615.6 616.9 33875.2 33902.5 34415.5 34443.0 34603.5 36138.6 36711.0 36752.0 36755.3 36859.3 7005.5 7692.6 7833.1 7909.1 9577.7 9750.7 9900.7 9902.8 9908.0 9909.7 9930.8 10048.2 10051.2 10054.4 10055.8 9883.9 9931.0 9949.8 9951.5 9989.1 9817.4 9902.5 9908.4 9919.9 10227.2 35193.1 35425.6 35453.1 35563.5 35602.0 3294.6 3299.2 3371.3 3732.5 3987.3 29134.1 29336.4 29408.9 29421.0 29893.1 3461.8 3481.7 3526.7 3629.1 3677.5 200682.0 202913.0 202973.0 203126.0 203146.0 50552.0 51512.7 51607.5 51632.0 51632.7 54479.5 54852.7 54865.7 55030.7 55089.0 13328.2 13461.6 13462.5 13468.3 13474.1 9856.4 10491.9 10807.2 10822.4 10843.1 17697.6 17762.9 17767.1 17777.7 17793.5 7083.0 7125.3 7205.7 7279.4 7327.6 888.6 922.3 927.3 952.4 996.8 26747.7 27996.9 28361.6 28450.6 28685.4 1010.5 1014.6 1014.7 1018.5 1117.2 14421.4 14896.3 14956.6 15162.6 15240.5 361248.0 364963.0 366672.0 366709.0 367748.0 49492.8 50397.7 50398.7 50414.5 50611.2 1084.6 1183.6 1265.9 1274.7 1370.3 24373.5 25656.7 26238.7 26270.7 26290.5 35777.0 35793.6 36127.0 36218.5 36265.0 230471.0 232757.0 232853.0 233953.0 233999.0 21977.3 22811.0 24536.0 25404.1 25593.2 35839.0 35989.8 36425.6 36433.5 36803.0 33260.8 33893.8 34015.3 34929.7 35041.0 34066.0 34471.8 34574.8 34726.3 34837.5 34996.7 35327.6 35360.8 35971.8 37269.4 26980.6 28127.9 28810.4 31098.6 31117.7 21277.7 21846.7 21875.6 21960.6 22123.3 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | [#2] jquery.html Cycles:180 Average:27586.61 Median:457654.00 stddev:74756.07 (16.3%) stddev-sans-first:74937.87 15:06:04 INFO - PROCESS | 15282 | Values: 380.2 382.3 391.9 393.4 395.1 16016.7 16232.4 16283.7 16298.9 16299.9 16149.4 16467.2 17178.6 17197.1 17197.7 5133.3 5279.7 5308.0 5312.3 5319.9 3690.4 5492.6 6044.8 6049.8 6051.2 5984.9 6002.3 6021.5 6023.9 6417.6 6720.4 6731.2 6750.0 6762.7 6774.9 3958.5 6258.5 6652.1 6697.3 6704.4 21925.3 21953.2 21987.7 22161.8 22526.9 2034.3 2131.3 2181.0 2207.4 2250.9 13119.4 13813.7 14398.9 14653.8 14669.1 1776.9 1935.5 1984.2 1985.5 2013.3 84587.0 87521.1 87865.6 88030.6 89194.6 15191.5 16032.4 16495.4 16559.7 16603.2 30194.8 30234.8 30536.7 30571.5 30600.5 8101.2 8436.7 8519.8 8604.6 8634.2 6850.9 6854.9 6949.2 6953.1 6987.7 8113.4 8196.0 8336.5 8389.6 8479.3 2642.5 3332.7 3428.7 3439.3 3485.2 791.3 800.5 849.5 913.8 921.0 15611.1 15798.2 16447.8 17072.3 17084.0 874.3 893.2 905.3 928.8 941.2 9104.5 9177.7 9653.0 9982.7 10095.6 442571.7 451659.0 457067.0 457605.0 457703.0 76190.0 80919.0 82085.0 82977.4 83408.0 965.4 972.2 979.4 1030.7 1057.0 15330.8 15385.4 15429.9 15540.8 15828.9 32812.3 34305.5 34558.5 35215.6 35317.5 48955.3 49499.0 49544.3 49825.8 49835.0 6587.4 6834.2 6906.5 6973.8 7094.8 9735.9 11497.5 11659.2 11834.3 11862.9 7162.0 9600.7 10068.5 10283.8 10347.2 9945.3 10260.4 10283.1 10285.5 10345.2 9903.2 10211.9 10514.6 10564.8 10625.6 7682.4 7757.8 7908.8 7921.0 8025.6 8877.6 9812.9 9889.0 10313.7 10520.8 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | [#3] mootools.html Cycles:180 Average:5112.80 Median:5545.02 stddev:2798.13 (50.5%) stddev-sans-first:2791.20 15:06:04 INFO - PROCESS | 15282 | Values: 1285.6 1418.9 1455.1 1578.2 1767.7 7265.7 7611.8 7628.7 7629.5 7633.9 7393.1 7536.8 7539.6 7551.4 7554.0 1905.8 1975.7 1976.0 2178.1 2206.2 2207.1 2288.6 2293.2 2298.6 2299.8 2172.7 2180.0 2183.8 2192.4 2220.0 1877.9 2136.0 2171.7 2181.8 2184.6 2223.6 2237.2 2252.7 2254.2 2254.8 7407.8 7487.4 7487.8 7495.2 7519.2 4430.4 4575.1 4588.6 4604.2 4610.4 2717.6 2995.1 2996.3 3000.6 3022.1 899.0 919.0 932.0 934.1 940.6 10198.3 10213.4 10228.1 10236.1 10247.3 4089.5 4208.4 4266.1 4374.1 4426.9 8878.2 8888.7 8891.8 8907.5 8908.0 4597.0 4612.3 4615.4 4628.2 4636.9 3668.9 4111.3 4225.2 4226.9 4248.3 3573.2 3597.7 3704.9 3731.0 3739.3 1222.4 1238.9 1244.9 1253.5 1256.1 722.7 735.7 771.4 891.4 914.4 5277.2 5347.1 5456.9 5463.4 5578.6 883.9 886.3 925.8 941.9 945.9 3689.9 3697.9 3741.6 3799.9 3857.3 8963.0 9384.4 9431.3 9438.2 9529.5 9456.3 9602.2 9609.4 9611.9 9619.0 6876.1 7144.4 7158.7 7196.5 7209.4 5296.8 5511.5 5627.8 5640.3 5729.3 8641.1 8715.8 8816.7 8914.5 9033.8 8882.7 9037.4 9072.4 9111.0 9155.2 5886.7 6296.9 6438.6 6501.3 6642.3 7466.7 7483.9 7535.2 7537.4 7546.3 6666.1 6743.4 6814.6 6904.7 6916.7 6773.8 6779.4 6809.4 6841.0 6899.6 6166.8 6286.3 6363.0 6371.8 6381.0 4628.0 4665.7 4724.4 4758.5 4782.6 4691.2 4752.0 4770.3 4791.5 4882.5 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | [#4] prototype.html Cycles:180 Average:4421.37 Median:5072.66 stddev:1296.44 (25.6%) stddev-sans-first:1262.79 15:06:04 INFO - PROCESS | 15282 | Values: 308.6 311.7 313.5 315.0 315.2 5104.8 5107.8 5135.5 5138.6 5144.5 5042.1 5042.2 5063.3 5065.9 5079.4 3747.7 3809.2 3921.8 3970.9 3995.5 3955.8 3965.4 3977.5 3983.2 3984.6 3750.7 3924.2 3932.3 3940.7 3957.9 3823.6 3939.4 3942.3 3964.2 3969.2 3470.0 3470.8 3495.9 3500.8 3512.6 4820.7 4824.6 4835.8 4835.9 4839.8 4256.7 4441.8 4462.5 4499.3 4539.2 5272.8 5273.8 5276.3 5306.7 5308.2 3744.0 3747.3 3749.0 3750.1 3755.2 5274.3 5501.7 5550.3 5588.8 5596.8 3813.8 3815.8 3829.3 3831.3 3850.9 3873.3 3879.3 3880.9 3888.0 3904.6 4183.2 4428.6 4451.7 4452.5 4461.6 5254.2 5316.5 5318.3 5348.5 5372.8 1338.6 1351.2 1352.4 1362.7 1362.8 861.8 889.9 901.2 912.6 917.8 4646.3 4661.3 4679.3 4692.6 4697.6 5407.3 5428.6 5430.9 5448.5 5462.1 4505.6 4653.5 4662.3 4676.4 4779.7 2938.3 2960.3 2962.4 2965.3 2965.4 5267.1 5272.2 5272.6 5287.4 5304.2 5477.5 5676.2 5708.7 5718.5 5735.9 5204.4 5235.7 5248.9 5265.9 5279.7 5415.5 5523.3 5549.8 5566.1 5574.9 5446.9 5484.1 5486.2 5488.5 5490.2 5262.9 5273.8 5274.1 5288.6 5299.7 3789.5 3864.2 3878.9 3882.2 3892.5 5507.6 5541.4 5541.6 5558.3 5559.1 5337.9 5357.3 5357.3 5376.5 5388.9 5030.5 5351.9 5358.3 5362.2 5366.5 5031.9 5261.6 5269.1 5269.9 5304.2 5173.4 5295.8 5305.4 5311.7 5319.7 5195.7 5216.7 5231.3 5246.6 5255.3 15:06:04 INFO - PROCESS | 15282 | 15:06:04 INFO - PROCESS | 15282 | [#5] yui.html Cycles:180 Average:13190.06 Median:49311.50 stddev:15637.85 (31.7%) stddev-sans-first:15653.40 15:06:04 INFO - PROCESS | 15282 | Values: 658.7 707.4 729.1 742.5 765.5 11608.7 11974.4 12023.1 12150.0 12201.3 11368.1 11425.5 11429.3 11441.9 11445.0 636.7 790.1 809.9 828.3 830.2 817.0 817.4 817.5 819.1 820.0 854.9 855.4 855.8 855.9 857.1 661.4 832.0 854.0 857.9 858.6 620.5 621.4 625.3 626.5 626.6 11340.9 11411.4 11443.7 11459.1 11464.9 12239.2 12339.6 12683.9 12703.6 12947.3 9439.0 9445.9 9535.6 9620.9 9710.8 3286.1 3289.6 3309.4 3400.9 3404.5 48111.0 48175.8 48234.3 48269.0 48449.3 9391.2 9640.6 9652.6 9662.6 9955.7 15877.4 15884.4 15889.4 15900.8 16046.4 6957.7 6982.9 7030.9 7193.9 7199.4 3744.9 3877.4 3898.9 3917.7 3932.2 2748.2 2813.5 2820.4 2830.7 2833.2 482.4 500.9 502.2 537.3 561.7 549.6 594.3 622.0 642.8 644.4 7526.4 7721.4 7723.7 7824.7 7948.2 520.5 561.4 561.9 581.5 585.0 3561.0 3732.9 3753.0 3758.5 3777.9 57052.7 57975.7 57977.7 58017.7 58119.7 49042.0 49581.0 49914.0 50327.5 50559.5 45479.5 45819.5 46184.0 46590.3 46848.0 6846.5 6877.9 7026.1 7038.6 7198.4 29764.7 29788.9 30679.2 31073.0 31410.4 40088.4 41344.6 41809.4 42827.9 42833.1 9491.6 9707.0 10431.2 10541.6 10666.9 11681.8 11754.2 12217.2 12327.1 12616.7 11089.7 11200.2 11334.2 11530.7 11712.2 11440.5 11460.3 11643.0 11668.4 11944.4 10737.6 11248.7 11377.1 11511.1 11550.3 9588.2 9769.2 9781.5 9828.3 9988.7 9108.4 9233.6 9732.0 9893.9 10013.5 15:06:04 INFO - PROCESS | 15282 | -------- Summary: end -------- 15:06:04 INFO - PROCESS | 15282 | 15:06:05 INFO - TEST-INFO | 15282: exit 0 15:06:05 INFO - TEST-OK | dromaeo_css | took 1117923ms 15:06:05 INFO - TEST-START | kraken 15:06:05 INFO - operating with platform_type : linux_ 15:06:05 INFO - Initialising browser for kraken test... 15:06:05 INFO - TEST-INFO | started process 15456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWhZLbq/profile http://localhost:44250/getInfo.html) 15:06:09 INFO - PROCESS | 15456 | __metrics Screen width/height:1600/1200 15:06:09 INFO - PROCESS | 15456 | colorDepth:24 15:06:09 INFO - PROCESS | 15456 | Browser inner width/height: 1024/697 15:06:09 INFO - PROCESS | 15456 | __metrics 15:06:10 ERROR - PROCESS | 15456 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:06:11 INFO - TEST-INFO | 15456: exit 0 15:06:11 INFO - Browser initialized. 15:06:11 INFO - Running cycle 1/1 for kraken test... 15:06:11 INFO - TEST-INFO | started process 15539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWhZLbq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:23 INFO - PROCESS | 15539 | RSS: Main: 155299840 15:06:23 INFO - PROCESS | 15539 | 15:06:25 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44250/tests/kraken/driver.html?testName=audio-beat-detection) 15:06:26 INFO - PROCESS | 15539 | RSS: Main: 210444288 15:06:26 INFO - PROCESS | 15539 | 15:06:29 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44250/tests/kraken/driver.html?testName=audio-dft) 15:06:30 INFO - PROCESS | 15539 | RSS: Main: 195502080 15:06:30 INFO - PROCESS | 15539 | 15:06:33 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44250/tests/kraken/driver.html?testName=audio-fft) 15:06:34 INFO - PROCESS | 15539 | RSS: Main: 266862592 15:06:34 INFO - PROCESS | 15539 | 15:06:36 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44250/tests/kraken/driver.html?testName=audio-oscillator) 15:06:36 INFO - PROCESS | 15539 | RSS: Main: 174514176 15:06:36 INFO - PROCESS | 15539 | 15:06:39 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:06:39 INFO - PROCESS | 15539 | RSS: Main: 178745344 15:06:39 INFO - PROCESS | 15539 | 15:06:42 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44250/tests/kraken/driver.html?testName=imaging-darkroom) 15:06:43 INFO - PROCESS | 15539 | RSS: Main: 214872064 15:06:43 INFO - PROCESS | 15539 | 15:06:46 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44250/tests/kraken/driver.html?testName=imaging-desaturate) 15:06:47 INFO - PROCESS | 15539 | RSS: Main: 215801856 15:06:47 INFO - PROCESS | 15539 | 15:06:50 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44250/tests/kraken/driver.html?testName=json-parse-financial) 15:06:50 INFO - PROCESS | 15539 | RSS: Main: 215609344 15:06:50 INFO - PROCESS | 15539 | 15:06:52 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:06:53 INFO - PROCESS | 15539 | RSS: Main: 202063872 15:06:53 INFO - PROCESS | 15539 | 15:06:55 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:06:55 INFO - PROCESS | 15539 | RSS: Main: 205103104 15:06:55 INFO - PROCESS | 15539 | 15:06:57 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:06:58 INFO - PROCESS | 15539 | RSS: Main: 218726400 15:06:58 INFO - PROCESS | 15539 | 15:07:01 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:07:01 INFO - PROCESS | 15539 | RSS: Main: 225112064 15:07:01 INFO - PROCESS | 15539 | 15:07:04 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:07:05 INFO - PROCESS | 15539 | RSS: Main: 220123136 15:07:05 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | Cycle 1(1): loaded http://localhost:44250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44250/tests/kraken/driver.html?testName=ai-astar) 15:07:07 INFO - PROCESS | 15539 | RSS: Main: 283492352 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | __start_tp_report 15:07:07 INFO - PROCESS | 15539 | _x_x_mozilla_page_load 15:07:07 INFO - PROCESS | 15539 | _x_x_mozilla_page_load_details 15:07:07 INFO - PROCESS | 15539 | |i|pagename|runs| 15:07:07 INFO - PROCESS | 15539 | |0;ai-astar;112;113;107;113;113;114;101;112;113;113 15:07:07 INFO - PROCESS | 15539 | |1;audio-beat-detection;158;131;154;188;143;161;164;132;189;132 15:07:07 INFO - PROCESS | 15539 | |2;audio-dft;164;162;161;162;162;162;162;161;160;163 15:07:07 INFO - PROCESS | 15539 | |3;audio-fft;75;75;108;102;75;74;74;119;106;76 15:07:07 INFO - PROCESS | 15539 | |4;audio-oscillator;94;95;139;94;94;94;147;96;95;141 15:07:07 INFO - PROCESS | 15539 | |5;imaging-gaussian-blur;117;116;117;116;116;116;117;116;116;116 15:07:07 INFO - PROCESS | 15539 | |6;imaging-darkroom;146;147;147;146;150;146;146;146;146;146 15:07:07 INFO - PROCESS | 15539 | |7;imaging-desaturate;96;95;95;97;95;95;95;96;96;95 15:07:07 INFO - PROCESS | 15539 | |8;json-parse-financial;65;65;63;65;63;64;64;81;62;60 15:07:07 INFO - PROCESS | 15539 | |9;json-stringify-tinderbox;64;65;65;65;65;65;66;65;65;65 15:07:07 INFO - PROCESS | 15539 | |10;stanford-crypto-aes;80;80;78;78;80;82;79;79;80;80 15:07:07 INFO - PROCESS | 15539 | |11;stanford-crypto-ccm;144;132;132;144;134;131;133;130;173;136 15:07:07 INFO - PROCESS | 15539 | |12;stanford-crypto-pbkdf2;175;172;176;171;173;178;169;181;173;170 15:07:07 INFO - PROCESS | 15539 | |13;stanford-crypto-sha256-iterative;70;74;72;73;75;71;73;82;70;72 15:07:07 INFO - PROCESS | 15539 | __end_tp_report 15:07:07 INFO - PROCESS | 15539 | __start_cc_report 15:07:07 INFO - PROCESS | 15539 | _x_x_mozilla_cycle_collect,1915 15:07:07 INFO - PROCESS | 15539 | __end_cc_report 15:07:07 INFO - PROCESS | 15539 | __startTimestamp1461190027494__endTimestamp 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | ------- Summary: start ------- 15:07:07 INFO - PROCESS | 15539 | Number of tests: 14 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:4.04 (3.6%) stddev-sans-first:4.27 15:07:07 INFO - PROCESS | 15539 | Values: 112.0 113.0 107.0 113.0 113.0 114.0 101.0 112.0 113.0 113.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:159.50 stddev:21.47 (13.5%) stddev-sans-first:22.75 15:07:07 INFO - PROCESS | 15539 | Values: 158.0 131.0 154.0 188.0 143.0 161.0 164.0 132.0 189.0 132.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 15:07:07 INFO - PROCESS | 15539 | Values: 164.0 162.0 161.0 162.0 162.0 162.0 162.0 161.0 160.0 163.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#3] audio-fft Cycles:10 Average:88.40 Median:74.50 stddev:18.02 (24.2%) stddev-sans-first:18.45 15:07:07 INFO - PROCESS | 15539 | Values: 75.0 75.0 108.0 102.0 75.0 74.0 74.0 119.0 106.0 76.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:94.00 stddev:23.16 (24.6%) stddev-sans-first:23.93 15:07:07 INFO - PROCESS | 15539 | Values: 94.0 95.0 139.0 94.0 94.0 94.0 147.0 96.0 95.0 141.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:07:07 INFO - PROCESS | 15539 | Values: 117.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 116.0 116.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:1.26 (0.9%) stddev-sans-first:1.32 15:07:07 INFO - PROCESS | 15539 | Values: 146.0 147.0 147.0 146.0 150.0 146.0 146.0 146.0 146.0 146.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 15:07:07 INFO - PROCESS | 15539 | Values: 96.0 95.0 95.0 97.0 95.0 95.0 95.0 96.0 96.0 95.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.50 stddev:5.77 (8.9%) stddev-sans-first:6.12 15:07:07 INFO - PROCESS | 15539 | Values: 65.0 65.0 63.0 65.0 63.0 64.0 64.0 81.0 62.0 60.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 15:07:07 INFO - PROCESS | 15539 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:80.00 stddev:1.17 (1.5%) stddev-sans-first:1.24 15:07:07 INFO - PROCESS | 15539 | Values: 80.0 80.0 78.0 78.0 80.0 82.0 79.0 79.0 80.0 80.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:135.00 stddev:12.99 (9.6%) stddev-sans-first:13.65 15:07:07 INFO - PROCESS | 15539 | Values: 144.0 132.0 132.0 144.0 134.0 131.0 133.0 130.0 173.0 136.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:3.74 (2.1%) stddev-sans-first:3.94 15:07:07 INFO - PROCESS | 15539 | Values: 175.0 172.0 176.0 171.0 173.0 178.0 169.0 181.0 173.0 170.0 15:07:07 INFO - PROCESS | 15539 | 15:07:07 INFO - PROCESS | 15539 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:3.49 (4.8%) stddev-sans-first:3.50 15:07:07 INFO - PROCESS | 15539 | Values: 70.0 74.0 72.0 73.0 75.0 71.0 73.0 82.0 70.0 72.0 15:07:07 INFO - PROCESS | 15539 | -------- Summary: end -------- 15:07:07 INFO - PROCESS | 15539 | 15:07:08 INFO - TEST-INFO | 15539: exit 0 15:07:08 INFO - TEST-OK | kraken | took 63038ms 15:07:08 INFO - SUITE-END | took 1180s 15:07:08 INFO - Completed test suite (00:19:41) 15:07:08 INFO - javascript benchmark 15:07:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.349662584354, 2620.8689565521745, 2657.0700254910785, 2662.3477248074214, 2667.746564076413, 4570.474395444525, 4654.813807447698, 4660.930086048712, 4668.929966050508, 4700.482946875845, 4677.204875171221, 4730.148573256813, 4731.57415832575, 4749.311349854269, 4765.332853400518, 4207.978960105195, 4251.91496170078, 4263.403123562712, 4314.805833737473, 4433.623142032931, 4358.912821743564, 4384.736915785047, 4401.295792673173, 4410.823567057314, 4437.267850804614, 4167.91664166715, 4237.703360764748, 4263.5736426357425, 4339.7396156230725, 4348.434703488526, 4256.0, 4295.119500502389, 4295.785210739482, 4296.74219546825, 4343.913121737579, 4222.282212023963, 4226.873193804191, 4229.450171477688, 4256.276433006366, 4263.722858014219, 4389.670774691879, 4548.499665036877, 4599.218132917378, 4679.789409476582, 4694.81220751173, 5003.524665156804, 5007.474215207423, 5009.073321435546, 5009.098362294785, 5037.748112594356, 4979.4771548987555, 4995.350604421438, 5005.6496045276845, 5007.148784706608, 5069.670471419383, 4605.98668292975, 4702.0, 4790.377250957354, 4796.016816552598, 4797.112534181188, 5132.101882170605, 5141.2288156776785, 5142.742862856842, 5167.276581278624, 5170.68975861442, 4924.655274130848, 4926.827561035347, 4927.679700819435, 4930.33440485537, 4972.030454061423, 4932.136876046678, 4965.82619608312, 5013.473585273494, 5059.266406371055, 5073.441921388644, 4958.553730164303, 4960.578350840146, 4968.031233909425, 4971.37857767779, 5017.498250174954, 4919.434265059493, 4922.187839006524, 4941.407031156285, 4963.851084467472, 4973.900521989613, 3800.809959502014, 3849.172427928009, 3850.5186851643543, 3854.807259637007, 3930.7248492605245, 3455.049861288166, 3496.737744669109, 3500.649935006479, 3515.5254040704176, 3532.982335088308, 4366.737995720267, 4368.27923392643, 4368.27923392643, 4409.559044095565, 4413.668974826836, 4900.044491324229, 5051.747412629354, 5057.115004874132, 5125.56432703217, 5133.255677926754, 4326.480822301344, 4343.804528796211, 4346.500152482505, 4349.978250108729, 4388.363687265329, 4478.888027799331, 4483.865484035484, 4486.0803535275845, 4491.214037543416, 4532.728036317765, 4618.168729628699, 4631.745254010994, 4722.291656251589, 4738.668293219442, 4740.549647783455, 5015.473375295687, 5035.0685123252315, 5038.093143234253, 5043.873903152304, 5089.05852417304, 4763.618910487222, 4770.284457331428, 4770.856874293777, 4775.785089671042, 4814.518548145157, 4806.855794326036, 4936.03747269279, 4967.329410529533, 5033.697978121324, 5042.495750425075, 5013.674111182761, 5028.4971502850885, 5031.52200540948, 5032.547070763649, 5074.543291103819, 4889.144399730104, 4890.168671325954, 4893.657443978887, 4900.117978763857, 4951.331570237971, 4679.4852566217005, 4803.495632958489, 4883.0, 4890.877728056827, 4892.363992680928, 4771.093492236464, 4798.976005119952, 4802.831900883452, 4809.0, 4851.51484851512, 4901.215805471107, 4906.288588154626, 4911.361523001987, 4913.0, 4963.205887058053, 4612.100640375094, 4691.788869500812, 4831.661783675109, 4920.114379411741, 4921.532454416824], "value": 4580.949988153828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3285772075532, 592.650336301582, 603.8460192650873, 615.5783288447412, 616.8889599872027, 33875.153121171985, 33902.49146262805, 34415.483767743506, 34443.0, 34603.48094778577, 36138.63861361392, 36711.0, 36752.0, 36755.26489470209, 36859.26281474376, 7005.54463959841, 7692.576908270057, 7833.138354780969, 7909.1299957004685, 9577.664781732641, 9750.707478775648, 9900.653477128302, 9902.752431189207, 9908.0, 9909.653162139326, 9930.751731206741, 10048.196144308475, 10051.195904327673, 10054.447005414699, 10055.798884022315, 9883.90116098837, 9931.0, 9949.75125621858, 9951.502424878727, 9989.10098091168, 9817.410955342702, 9902.504874756305, 9908.35595686278, 9919.851202231972, 10227.232957528215, 35193.120171995906, 35425.64574354249, 35453.11367215814, 35563.46654800154, 35602.0, 3294.621118571371, 3299.1752061984503, 3371.3088816792497, 3732.4774531565604, 3987.2623564640635, 29134.12597622075, 29336.413271734447, 29408.8529557353, 29421.0, 29893.103206903827, 3461.7749846259912, 3481.6866482016485, 3526.748004458406, 3629.0502350511115, 3677.5035370224946, 200682.0, 202913.0, 202973.0, 203125.9843700787, 203146.0, 50552.0, 51512.742436288325, 51607.48392516102, 51632.0, 51632.74183629058, 54479.45520544744, 54852.72573637106, 54865.72567137139, 55030.72484637551, 55089.0, 13328.200307981358, 13461.596152115451, 13462.528811491748, 13468.259245741383, 13474.124181928339, 9856.408615482951, 10491.947540262403, 10807.189460790472, 10822.404767737693, 10843.132549396028, 17697.557561061076, 17762.91118544425, 17767.111644417728, 17777.733334, 17793.46619601388, 7082.964585177041, 7125.25184855593, 7205.71177152908, 7279.41764658826, 7327.633618319062, 888.6401007591936, 922.3082687984012, 927.2813569483569, 952.4380615436926, 996.7657600463886, 26747.732522674913, 27996.8600157002, 28361.574576381372, 28450.57324140098, 28685.426291474054, 1010.5149528226492, 1014.5840205515703, 1014.6854475112739, 1018.4551265073299, 1117.2402766119117, 14421.42314307437, 14896.255187240811, 14956.551303460914, 15162.620934476727, 15240.466583669519, 361248.0, 364963.0, 366672.0, 366709.0, 367748.0, 49492.75253623709, 50397.74801125971, 50398.74800625973, 50414.495855041714, 50611.24083138756, 1084.5715942202785, 1183.5798291606357, 1265.860755316933, 1274.7004453953314, 1370.3011464153153, 24373.51252974895, 25656.74343256618, 26238.73761262363, 26270.737292627593, 26290.474190516466, 35777.0, 35793.64206357903, 36127.0, 36218.4567231497, 36265.0, 230471.0, 232757.0, 232853.0, 233953.0, 233999.0, 21977.34067977963, 22811.0, 24536.0, 25404.110856119947, 25593.23220303394, 35839.0, 35989.82005090063, 36425.635743642226, 36433.45349819702, 36803.0, 33260.83369583137, 33893.83053084719, 34015.319693606485, 34929.65070349264, 35041.0, 34066.0, 34471.82764086164, 34574.82712586421, 34726.30547388987, 34837.47743783896, 34996.65003349934, 35327.646723533464, 35360.82319588386, 35971.82014089913, 37269.440958386185, 26980.595291071044, 28127.859360703067, 28810.40056359713, 31098.59043356393, 31117.71553111866, 21277.68083478718, 21846.67229991583, 21875.59368469435, 21960.560788784453, 22123.33629991103], "value": 17311.46321328452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.211062046254, 382.27368000798464, 391.90986073203163, 393.37846202999265, 395.0912900329243, 16016.679666406679, 16232.350705971776, 16283.674326513463, 16298.918505407471, 16299.91850040748, 16149.43476978306, 16467.176641167953, 17178.570535736613, 17197.14014299283, 17197.742033869472, 5133.255677926699, 5279.683219006853, 5308.0, 5312.2828418163635, 5319.946800531984, 3690.4279836625365, 5492.588055895804, 6044.848878778022, 6049.788257410992, 6051.152838602599, 5984.940150598503, 6002.279726432834, 6021.488173505258, 6023.939760602404, 6417.6149431034055, 6720.361565651256, 6731.225909020427, 6749.966250168767, 6762.7150841340235, 6774.898376524331, 3958.5249770027494, 6258.49932005443, 6652.06871038055, 6697.296783837675, 6704.396604305636, 21925.342239732832, 21953.231636892633, 21987.670184947237, 22161.778382216293, 22526.88736556323, 2034.2778313698573, 2131.3392848217104, 2180.9890950545305, 2207.381933058746, 2250.8762018089, 13119.409626566827, 13813.654658633513, 14398.92800536001, 14653.780193297109, 14669.119852808759, 1776.9289228430848, 1935.4677463697456, 1984.2063174730079, 1985.54332503525, 2013.2651582172548, 84587.0, 87521.12478875193, 87865.56067219622, 88030.55984720035, 89194.5540272301, 15191.544253672408, 16032.358705651643, 16495.422660206834, 16559.6688066238, 16603.16984150812, 30194.82954289812, 30234.84882575573, 30536.69463305383, 30571.541426878615, 30600.54099188514, 8101.230383113595, 8436.704715335056, 8519.829603407898, 8604.612792424356, 8634.179752923463, 6850.9314906850295, 6854.897176542356, 6949.166100068024, 6953.096097507393, 6987.650617469106, 8113.391495637851, 8195.95902020498, 8336.458130221516, 8389.622466989, 8479.321654267767, 2642.471505698868, 3332.650071742432, 3428.7428442866385, 3439.2949445363643, 3485.1809824691177, 791.2799352589232, 800.4984423676012, 849.524266410812, 913.7761248494029, 920.9907900920905, 15611.141387223812, 15798.222301850386, 16447.83552164463, 17072.317107315568, 17084.0, 874.2699845628971, 893.1515060692368, 905.343625871238, 928.832810094176, 941.1717688434134, 9104.544772761335, 9177.678781242625, 9653.0, 9982.700518984297, 10095.646652367132, 442571.7428257213, 451659.0, 457067.0, 457605.0, 457703.0, 76190.0, 80919.0, 82085.0, 82977.37344064568, 83408.0, 965.3821554205314, 972.231936769958, 979.3976704326788, 1030.6598822388594, 1057.0222544146634, 15330.77003844921, 15385.384584616937, 15429.922850385676, 15540.844591554393, 15828.920855395649, 32812.343753124325, 34305.48541771826, 34558.481622776184, 35215.647843521234, 35317.470237945934, 48955.26567101567, 49499.0, 49544.256836146764, 49825.750871245415, 49835.0, 6587.4071333580205, 6834.179898412222, 6906.482013849082, 6973.8256543584785, 7094.787156385317, 9735.853962190715, 11497.482613282255, 11659.18385712992, 11834.349110798988, 11862.940685296518, 7162.0, 9600.711978640651, 10068.496575171359, 10283.84574231402, 10347.223958203014, 9945.254105941938, 10260.384376937407, 10283.12593429567, 10285.485725713834, 10345.224108191765, 9903.207743380368, 10211.948940255252, 10514.631987880693, 10564.781395906946, 10625.574977001143, 7682.423818213544, 7757.806054848674, 7908.762737117896, 7920.960395197987, 8025.5585942773705, 8877.644894204159, 9812.85280720804, 9888.950555247178, 10313.74215644615, 10520.789584208425], "value": 9199.48589583475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.6335944255877, 1418.8510206428327, 1455.1269238456928, 1578.1872335747084, 1767.6729804986087, 7265.709371625136, 7611.8097047573765, 7628.656710448029, 7629.465937384385, 7633.885491717621, 7393.112826460832, 7536.8115797104965, 7539.585322807244, 7551.395888328934, 7553.962230188855, 1905.7808352039553, 1975.733276007742, 1976.041619814389, 2178.096090122597, 2206.249875042485, 2207.0509680837235, 2288.5766133265315, 2293.20884294918, 2298.586254474194, 2299.827512936528, 2172.674098885172, 2179.967300490494, 2183.770704076065, 2192.375173075674, 2219.966700499494, 1877.9061046947734, 2135.9679604805783, 2171.7393912730417, 2181.792729690677, 2184.552166805817, 2223.5997520446313, 2237.228156286095, 2252.7409347925036, 2254.1546919905036, 2254.8083412909923, 7407.777766667009, 7487.363574096208, 7487.7753667389525, 7495.175530691619, 7519.2104828992715, 4430.401895744066, 4575.107853968478, 4588.564086411786, 4604.217283061887, 4610.354550362952, 2717.648147877484, 2995.1164406500134, 2996.2509372656837, 3000.6249218847643, 3022.1386904732267, 899.0, 918.9954050229773, 931.9720408387759, 934.145257089762, 940.5814412586402, 10198.286119971604, 10213.438260895648, 10228.07947284748, 10236.078752912199, 10247.333923294962, 4089.509258888893, 4208.36874468826, 4266.0827921996915, 4374.147041326974, 4426.889327766831, 8878.245349145265, 8888.688895888612, 8891.777705557413, 8907.51008694515, 8908.0, 4596.97701511497, 4612.308153776893, 4615.423072115986, 4628.166929952641, 4636.930446043312, 3668.908277293089, 4111.280525907954, 4225.19721252961, 4226.915461690811, 4248.341507066348, 3573.2312505310038, 3597.6762091411897, 3704.9259014819554, 3730.962690373116, 3739.3082279778328, 1222.370479203211, 1238.8885000350012, 1244.8817362350562, 1253.5487224599137, 1256.133268045046, 722.7073035420663, 735.6836560279131, 771.4368510987011, 891.3893982621925, 914.3873604684877, 5277.20841873722, 5347.144456886879, 5456.863578410572, 5463.399026107125, 5578.581606379537, 883.9381243313035, 886.2953951608487, 925.8102089071724, 941.9293552983416, 945.8723072385278, 3689.94465083024, 3697.926041479155, 3741.6071312511795, 3799.9430008549894, 3857.286402015636, 8963.0, 9384.436933783994, 9431.339806213498, 9438.150566449052, 9529.475878826592, 9456.33805633599, 9602.183814375716, 9609.375390599589, 9611.855822162674, 9618.951905240569, 6876.071730316343, 7144.428445724329, 7158.749443769443, 7196.496245262886, 7209.423246140296, 5296.761645726028, 5511.450685449251, 5627.831165065055, 5640.266765320482, 5729.255196824386, 8641.092685267957, 8715.782105447415, 8816.691415800417, 8914.465132092095, 9033.819323613623, 8882.733517994471, 9037.367384283038, 9072.410293330913, 9110.954445227731, 9155.176034156957, 5886.705664716661, 6296.905546416716, 6438.581492202992, 6501.284858665637, 6642.269350371359, 7466.701331946661, 7483.88774168377, 7535.208803075818, 7537.397008239437, 7546.320831125225, 6666.066750654815, 6743.393094621508, 6814.557053791487, 6904.723811047502, 6916.654167291716, 6773.796786096425, 6779.35596118368, 6809.4211991979255, 6841.042254084333, 6899.551529150589, 6166.845828854314, 6286.277078136073, 6362.968185159045, 6371.840703982438, 6381.0, 4628.0, 4665.710673974771, 4724.4094488188975, 4758.547937945889, 4782.641301902441, 4691.202495575829, 4751.952480475151, 4770.308305295782, 4791.4729379767505, 4882.462929077869], "value": 4147.232480097087, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.63735111244284, 311.7194524927564, 313.5359667691816, 314.959055322808, 315.2166865339632, 5104.795808167673, 5107.7956881724685, 5135.460776618457, 5138.588912886969, 5144.536991670749, 5042.0924233638025, 5042.16804227303, 5063.316452278941, 5065.898682026357, 5079.415867175276, 3747.681447076995, 3809.2381523695235, 3921.8431262749455, 3970.8610198643055, 3995.5205375354853, 3955.782431966241, 3965.3655415133585, 3977.4630424892703, 3983.1635356575007, 3984.621460961204, 3750.6999440044733, 3924.2151569686034, 3932.2725295820223, 3940.704447166474, 3957.861474848381, 3823.5985221551755, 3939.3500072488005, 3942.310095733264, 3964.167524819791, 3969.2260009298343, 3469.9826500867334, 3470.7917524948584, 3495.8776442824633, 3500.7724497907557, 3512.5609298837644, 4820.734859582722, 4824.638152138568, 4835.758212089417, 4835.85492435224, 4839.782209800567, 4256.723312984677, 4441.777911104432, 4462.456399852085, 4499.325101234808, 4539.205639013159, 5272.815451459181, 5273.789048438058, 5276.337953544659, 5306.70813105279, 5308.177232528964, 3743.9625603743884, 3747.3254814133447, 3748.9625103748886, 3750.1187221003042, 3755.2114056048263, 5274.26160337553, 5501.697406642633, 5550.333959924795, 5588.832335029955, 5596.781850436016, 3813.809309534512, 3815.7901315427916, 3829.291581057513, 3831.2912111259507, 3850.9229815403537, 3873.341531939521, 3879.262940041383, 3880.941785873214, 3887.9805600971813, 3904.5509766376663, 4183.226103170923, 4428.645708343325, 4451.666125040635, 4452.510223875371, 4461.598456138963, 5254.238135470336, 5316.494932981361, 5318.308619879391, 5348.491893270133, 5372.785088596491, 1338.645259006364, 1351.1622793867864, 1352.3981828086603, 1362.7070179911366, 1362.8432730235952, 861.7845538615346, 889.8620713789373, 901.1844280925773, 912.6121398405651, 917.775145089444, 4646.3495110684535, 4661.300804879295, 4679.344891715163, 4692.577668009895, 4697.577218050324, 5407.324084489439, 5428.565714742811, 5430.8913821723345, 5448.536874365724, 5462.0987537056735, 4505.5719706627815, 4653.464851542049, 4662.272570546201, 4676.368690226844, 4779.737114458738, 2938.30949726814, 2960.304328482805, 2962.4223276460884, 2965.303153758865, 2965.4069186162424, 5267.104592219332, 5272.182811664198, 5272.630915835932, 5287.365516138011, 5304.151335786256, 5477.452254774491, 5676.233708449389, 5708.65748055118, 5718.513926316226, 5735.885282294331, 5204.42751297357, 5235.659682120726, 5248.868778280574, 5265.894682106413, 5279.709615971158, 5415.458454154553, 5523.33719953592, 5549.835564129912, 5566.109422492382, 5574.9442505574425, 5446.891062178814, 5484.122540393678, 5486.214511986716, 5488.5334746545395, 5490.231367608458, 5262.868428289324, 5273.78904843802, 5274.12976858814, 5288.629795914249, 5299.655522391032, 3789.5452545694693, 3864.246471937945, 3878.864239751595, 3882.22355528901, 3892.4939757831303, 5507.5593952484505, 5541.3904470507405, 5541.612087153861, 5558.305211848519, 5559.11054231321, 5337.946620533745, 5357.276767636475, 5357.303550538405, 5376.489233522809, 5388.865278368072, 5030.522100400456, 5351.902859913631, 5358.338914936382, 5362.222477740628, 5366.490183432567, 5031.899362012812, 5261.579073674174, 5269.130593452038, 5269.947300526946, 5304.177852432879, 5173.40505841818, 5295.808443100272, 5305.442928492453, 5311.681299122065, 5319.654222475527, 5195.6622819516615, 5216.739163041757, 5231.293775340432, 5246.6065045121, 5255.3168088148295], "value": 4008.9177861435787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.660789693308, 707.4305184326615, 729.0740759235771, 742.4988133010216, 765.5291995422815, 11608.709782255448, 11974.40127993599, 12023.098267629919, 12150.0, 12201.328926909027, 11368.147388945841, 11425.485853136608, 11429.314241145516, 11441.942790286037, 11445.0, 636.7389370358154, 790.0992868130336, 809.9352051835868, 828.2959484438239, 830.2361827119034, 816.9550674712889, 817.4073796497552, 817.480899628737, 819.1276290750361, 820.0487434575894, 854.8931383577053, 855.3627547477138, 855.80744332525, 855.8630619100945, 857.1342943626919, 661.3849120318102, 831.9916800831975, 853.9658413663446, 857.9227869491775, 858.6007506509441, 620.509797260164, 621.3755176048043, 625.2840497630187, 626.5426238845623, 626.5520153090562, 11340.886591134065, 11411.372374519398, 11443.713907152305, 11459.083273338196, 11464.885351146466, 12239.20445171061, 12339.62981110568, 12683.936580317131, 12703.555375561904, 12947.287899165542, 9438.95280523593, 9445.858312125323, 9535.618575256982, 9620.855687164629, 9710.805783884354, 3286.1291757684235, 3289.555909952174, 3309.3712194683176, 3400.9032560038504, 3404.5233667286598, 48111.0, 48175.759121204166, 48234.27648585274, 48269.0, 48449.273260901115, 9391.248700103975, 9640.614375424904, 9652.565634546463, 9662.613495460244, 9955.701328960144, 15877.364905403654, 15884.364625414853, 15889.443869464514, 15900.76148857768, 16046.438374657064, 6957.65211739411, 6982.930170698228, 7030.929690703129, 7193.928060719326, 7199.388052015533, 3744.9063773405883, 3877.3602355611574, 3898.902527436837, 3917.745346552465, 3932.174243408859, 2748.189284161177, 2813.5357665984884, 2820.379516506406, 2830.7027762084685, 2833.2208642623445, 482.399412731152, 500.88980424306595, 502.1689104532005, 537.2666310486159, 561.7022977821761, 549.5658429840461, 594.3076316091791, 621.9720112594944, 642.7975187815823, 644.4364151120757, 7526.441010056607, 7721.3868733426125, 7723.729669461542, 7824.726134585262, 7948.165442628557, 520.5341219608505, 561.4273441090065, 561.9044762390404, 581.4970050905936, 584.9675323054812, 3560.964390356115, 3732.8880133596035, 3753.0, 3758.530183727034, 3777.9244415112094, 57052.71473642605, 57975.71012144912, 57977.71011145002, 58017.709911450176, 58119.70940145357, 49042.0, 49581.0, 49914.0, 50327.496725033016, 50559.49440505621, 45479.545204548194, 45819.541804581524, 46184.0, 46590.30114548217, 46848.0, 6846.486513511407, 6877.89683154763, 7026.086608740831, 7038.577685338896, 7198.388137008413, 29764.70235297706, 29788.85105574545, 30679.233019173807, 31073.0, 31410.371792564478, 40088.39867401933, 41344.586554134075, 41809.372859406525, 42827.85860707014, 42833.143337133704, 9491.620335186515, 9706.964277692605, 10431.193116824927, 10541.578336866747, 10666.946665266623, 11681.824772628248, 11754.177207595387, 12217.205881617667, 12327.137100402886, 12616.747665046463, 11089.667309980714, 11200.159988000769, 11334.206605537533, 11530.654080377602, 11712.238704484182, 11440.48517816717, 11460.312381257152, 11643.0, 11668.416579171177, 11944.402779860799, 10737.624183153552, 11248.662540123809, 11377.146713996317, 11511.136664750009, 11550.306981581132, 9588.232941364813, 9769.169620582046, 9781.510924453607, 9828.312018158946, 9988.650397236062, 9108.362414630912, 9233.58448869789, 9732.0, 9893.901060989298, 10013.499325033865], "value": 5949.041305951092, "unit": "score"}], "name": "dromaeo_css", "value": 6452.417337202138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 113.0, 113.0, 114.0, 101.0, 112.0, 113.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 154.0, 188.0, 143.0, 161.0, 164.0, 132.0, 189.0, 132.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 160.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 108.0, 102.0, 75.0, 74.0, 74.0, 119.0, 106.0, 76.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 139.0, 94.0, 94.0, 94.0, 147.0, 96.0, 95.0, 141.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 150.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 65.0, 63.0, 64.0, 64.0, 81.0, 62.0, 60.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 78.0, 80.0, 82.0, 79.0, 79.0, 80.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 132.0, 132.0, 144.0, 134.0, 131.0, 133.0, 130.0, 173.0, 136.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 176.0, 171.0, 173.0, 178.0, 169.0, 181.0, 173.0, 170.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 72.0, 73.0, 75.0, 71.0, 73.0, 82.0, 70.0, 72.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1579.6, "alertThreshold": 2.0}]} 15:07:08 INFO - Return code: 0 15:07:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:07:08 ERROR - # TBPL SUCCESS # 15:07:08 INFO - Running post-action listener: _resource_record_post_action 15:07:08 INFO - Running post-run listener: _resource_record_post_run 15:07:09 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 348618752; Read time: 16; Write time: 267868 15:07:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 69271552; Read time: 0; Write time: 41100 15:07:09 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278482944; Read time: 16; Write time: 226684 15:07:09 INFO - Running post-run listener: _upload_blobber_files 15:07:09 INFO - Blob upload gear active. 15:07:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:07:09 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 15:07:09 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'] 15:07:09 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 15:07:10 INFO - (blobuploader) - INFO - Open directory for files ... 15:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:11 INFO - (blobuploader) - INFO - Done attempting. 15:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:11 INFO - (blobuploader) - INFO - Done attempting. 15:07:11 INFO - (blobuploader) - INFO - Iteration through files over. 15:07:11 INFO - Return code: 0 15:07:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:07:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:07:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13cd5a20ef0d33967331bc432eba590e7e168d24b1a32be7e0502ebfdcb99c06793ba206c6a9299fdcce7f90453e3954671a4fc71be52b2fe7e60adf9889c07d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3ca66e7e85b9bee31d3dd1d0284ee69bb1776a56e99851d8cff98f812b2b25785d57ac3d6bcc5a8fef7629d753754e13d34ee195ab2e2b051ad5470bc4cdfa"} 15:07:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:07:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:07:11 INFO - Contents: 15:07:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13cd5a20ef0d33967331bc432eba590e7e168d24b1a32be7e0502ebfdcb99c06793ba206c6a9299fdcce7f90453e3954671a4fc71be52b2fe7e60adf9889c07d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3ca66e7e85b9bee31d3dd1d0284ee69bb1776a56e99851d8cff98f812b2b25785d57ac3d6bcc5a8fef7629d753754e13d34ee195ab2e2b051ad5470bc4cdfa"} 15:07:11 INFO - Running post-run listener: copy_logs_to_upload_dir 15:07:11 INFO - Copying logs to upload dir... 15:07:11 INFO - mkdir: /builds/slave/test/build/upload/logs 15:07:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.202861 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-04-20 15:07:11.717514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:07:11.721629) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13cd5a20ef0d33967331bc432eba590e7e168d24b1a32be7e0502ebfdcb99c06793ba206c6a9299fdcce7f90453e3954671a4fc71be52b2fe7e60adf9889c07d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3ca66e7e85b9bee31d3dd1d0284ee69bb1776a56e99851d8cff98f812b2b25785d57ac3d6bcc5a8fef7629d753754e13d34ee195ab2e2b051ad5470bc4cdfa"} build_url:https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/MdBvXVCnRBum2vzPXvPYRg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/13cd5a20ef0d33967331bc432eba590e7e168d24b1a32be7e0502ebfdcb99c06793ba206c6a9299fdcce7f90453e3954671a4fc71be52b2fe7e60adf9889c07d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3ca66e7e85b9bee31d3dd1d0284ee69bb1776a56e99851d8cff98f812b2b25785d57ac3d6bcc5a8fef7629d753754e13d34ee195ab2e2b051ad5470bc4cdfa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:07:11.748674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:07:11.749049) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461188324.167357-1123392691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:07:11.833062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:07:11.833396) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:07:11.833689) ========= ========= Total master_lag: 0.17 =========