builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1462972510.67 results: success (0) buildid: 20160511051212 builduid: 224fb36552b844f8a31774e7d4540102 revision: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.665412) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.665925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.666226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.683092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.683403) ========= 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=32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 06:15:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-05-11 06:15:10 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.778709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.779244) ========= 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=32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015212 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.830616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:10.831244) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cf323be5c58b28d8719401ebb0ef63f1d71d000 --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 8cf323be5c58b28d8719401ebb0ef63f1d71d000 --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=32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 06:15:10,975 truncating revision to first 12 chars 2016-05-11 06:15:10,975 Setting DEBUG logging. 2016-05-11 06:15:10,975 attempt 1/10 2016-05-11 06:15:10,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cf323be5c58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 06:15:11,228 unpacking tar archive at: fx-team-8cf323be5c58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:11.427489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:11.427860) ========= script_repo_revision: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:11.428263) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:11.428564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 06:15:11.439110) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-11 06:15:11.439534) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:15:11 INFO - MultiFileLogger online at 20160511 06:15:11 in /builds/slave/test 06:15:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:15:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:15:11 INFO - {'append_to_log': False, 06:15:11 INFO - 'base_work_dir': '/builds/slave/test', 06:15:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:15:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:15:11 INFO - 'branch': 'Fx-Team-Non-PGO', 06:15:11 INFO - 'buildbot_json_path': 'buildprops.json', 06:15:11 INFO - 'config_files': ('talos/linux_config.py',), 06:15:11 INFO - 'default_actions': ('clobber', 06:15:11 INFO - 'read-buildbot-config', 06:15:11 INFO - 'download-and-extract', 06:15:11 INFO - 'populate-webroot', 06:15:11 INFO - 'create-virtualenv', 06:15:11 INFO - 'install', 06:15:11 INFO - 'run-tests'), 06:15:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:15:11 INFO - 'download_minidump_stackwalk': True, 06:15:11 INFO - 'download_symbols': 'ondemand', 06:15:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:15:11 INFO - 'tooltool.py': '/tools/tooltool.py', 06:15:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:15:11 INFO - '/tools/misc-python/virtualenv.py')}, 06:15:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:15:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:15:11 INFO - 'installer_path': 'installer.exe', 06:15:11 INFO - 'log_level': 'info', 06:15:11 INFO - 'log_name': 'talos', 06:15:11 INFO - 'log_to_console': True, 06:15:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:15:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:15:11 INFO - 'opt_config_files': (), 06:15:11 INFO - 'pip_index': False, 06:15:11 INFO - 'sps_profile': False, 06:15:11 INFO - 'sps_profile_interval': 0, 06:15:11 INFO - 'suite': 'dromaeojs-e10s', 06:15:11 INFO - 'system_bits': '32', 06:15:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:15:11 INFO - 'title': 'talos-linux64-ix-008', 06:15:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:15:11 INFO - 'use_talos_json': True, 06:15:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:15:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:15:11 INFO - 'work_dir': 'build'} 06:15:11 INFO - ##### 06:15:11 INFO - ##### Running clobber step. 06:15:11 INFO - ##### 06:15:11 INFO - Running pre-action listener: _resource_record_pre_action 06:15:11 INFO - Running main action method: clobber 06:15:11 INFO - rmtree: /builds/slave/test/build 06:15:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:15:12 INFO - Running post-action listener: _resource_record_post_action 06:15:12 INFO - ##### 06:15:12 INFO - ##### Finished clobber step (success) 06:15:12 INFO - ##### 06:15:12 INFO - ##### 06:15:12 INFO - ##### Running read-buildbot-config step. 06:15:12 INFO - ##### 06:15:12 INFO - Running pre-action listener: _resource_record_pre_action 06:15:12 INFO - Running main action method: read_buildbot_config 06:15:12 INFO - Using buildbot properties: 06:15:12 INFO - { 06:15:12 INFO - "project": "", 06:15:12 INFO - "product": "firefox", 06:15:12 INFO - "script_repo_revision": "production", 06:15:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:15:12 INFO - "repository": "", 06:15:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:15:12 INFO - "buildid": "20160511051212", 06:15:12 INFO - "pgo_build": "False", 06:15:12 INFO - "basedir": "/builds/slave/test", 06:15:12 INFO - "buildnumber": 1280, 06:15:12 INFO - "slavename": "talos-linux64-ix-008", 06:15:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:15:12 INFO - "platform": "ubuntu64_hw", 06:15:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:15:12 INFO - "branch": "fx-team", 06:15:12 INFO - "repo_path": "integration/fx-team", 06:15:12 INFO - "revision": "8cf323be5c58b28d8719401ebb0ef63f1d71d000", 06:15:12 INFO - "stage_platform": "linux64", 06:15:12 INFO - "builduid": "224fb36552b844f8a31774e7d4540102", 06:15:12 INFO - "slavebuilddir": "test" 06:15:12 INFO - } 06:15:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:15:12 INFO - Running post-action listener: _resource_record_post_action 06:15:12 INFO - ##### 06:15:12 INFO - ##### Finished read-buildbot-config step (success) 06:15:12 INFO - ##### 06:15:12 INFO - ##### 06:15:12 INFO - ##### Running download-and-extract step. 06:15:12 INFO - ##### 06:15:12 INFO - Running pre-action listener: _resource_record_pre_action 06:15:12 INFO - Running main action method: download_and_extract 06:15:12 INFO - mkdir: /builds/slave/test/build/tests 06:15:12 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')]} 06:15:12 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:15:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:15:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:15:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:15:13 INFO - Downloaded 1361 bytes. 06:15:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:15:13 INFO - Using the following test package requirements: 06:15:13 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:15:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:15:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:15:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'jsshell-linux-x86_64.zip'], 06:15:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:15:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:15:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:15:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:15:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:15:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:15:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:13 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:15:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:15:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:15:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:15:14 INFO - Downloaded 22329022 bytes. 06:15:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:15:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:15:15 INFO - Return code: 0 06:15:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:15: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')]} 06:15:15 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:15:16 INFO - Downloaded 22329022 bytes. 06:15:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:15:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:15:18 INFO - Return code: 0 06:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:18 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:15:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:15:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:15:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:15:19 INFO - Downloaded 10840152 bytes. 06:15:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:15:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:15:19 INFO - Return code: 0 06:15:19 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')]} 06:15:19 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:15:20 INFO - Downloaded 54683548 bytes. 06:15:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:15:20 INFO - mkdir: /builds/slave/test/properties 06:15:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:20 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:20 INFO - Contents: 06:15:20 INFO - build_url:https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:15:21 INFO - Running post-action listener: _resource_record_post_action 06:15:21 INFO - Running post-action listener: set_extra_try_arguments 06:15:21 INFO - ##### 06:15:21 INFO - ##### Finished download-and-extract step (success) 06:15:21 INFO - ##### 06:15:21 INFO - ##### 06:15:21 INFO - ##### Running populate-webroot step. 06:15:21 INFO - ##### 06:15:21 INFO - Running pre-action listener: _resource_record_pre_action 06:15:21 INFO - Running main action method: populate_webroot 06:15:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:15:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:15:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:15:21 INFO - '--tppagecycles', 06:15:21 INFO - '7'], 06:15:21 INFO - 'tests': ['tsvgm']}}, 06:15:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:15:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:15:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['damp', 'tps']}, 06:15:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'tests': ['damp', 'tps']}, 06:15:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['dromaeo_dom']}, 06:15:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tsvgx', 06:15:21 INFO - 'tsvgr_opacity', 06:15:21 INFO - 'tart', 06:15:21 INFO - 'tscrollx', 06:15:21 INFO - 'cart']}, 06:15:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:21 INFO - 'tsvgr_opacity', 06:15:21 INFO - 'tart', 06:15:21 INFO - 'tscrollx', 06:15:21 INFO - 'cart']}, 06:15:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tp5o']}, 06:15:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'tests': ['tp5o']}, 06:15:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s', 06:15:21 INFO - '--xperf_path', 06:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:21 INFO - 'tests': ['tp5n']}, 06:15:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--xperf_path', 06:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:21 INFO - 'tests': ['tp5n']}}, 06:15:21 INFO - 'talos.zip': {'path': '', 06:15:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:15:21 INFO - Running post-action listener: _resource_record_post_action 06:15:21 INFO - ##### 06:15:21 INFO - ##### Finished populate-webroot step (success) 06:15:21 INFO - ##### 06:15:21 INFO - ##### 06:15:21 INFO - ##### Running create-virtualenv step. 06:15:21 INFO - ##### 06:15:21 INFO - Running pre-action listener: _resource_record_pre_action 06:15:21 INFO - Running main action method: create_virtualenv 06:15:21 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:21 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 06:15:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:15:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:21 INFO - Using real prefix '/usr' 06:15:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:22 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:24 INFO - Installing pip.................done. 06:15:24 INFO - Return code: 0 06:15:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:24 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 06:15:24 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 06:15:24 INFO - Using env: {'DISPLAY': ':0', 06:15:24 INFO - 'HOME': '/home/cltbld', 06:15:24 INFO - 'LANG': 'en_US.UTF-8', 06:15:24 INFO - 'LANGUAGE': 'en_US:en', 06:15:24 INFO - 'LOGNAME': 'cltbld', 06:15:24 INFO - 'MAIL': '/var/mail/cltbld', 06:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:24 INFO - 'MOZ_NO_REMOTE': '1', 06:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:24 INFO - 'NO_EM_RESTART': '1', 06:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:24 INFO - 'PWD': '/builds/slave/test', 06:15:24 INFO - 'SHELL': '/bin/bash', 06:15:24 INFO - 'SHLVL': '1', 06:15:24 INFO - 'TERM': 'linux', 06:15:24 INFO - 'TMOUT': '86400', 06:15:24 INFO - 'USER': 'cltbld', 06:15:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:24 INFO - '_': '/tools/buildbot/bin/python'} 06:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:24 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 06:15:24 INFO - Cleaning up... 06:15:24 INFO - Return code: 0 06:15:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:24 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 06:15:24 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 06:15:24 INFO - Using env: {'DISPLAY': ':0', 06:15:24 INFO - 'HOME': '/home/cltbld', 06:15:24 INFO - 'LANG': 'en_US.UTF-8', 06:15:24 INFO - 'LANGUAGE': 'en_US:en', 06:15:24 INFO - 'LOGNAME': 'cltbld', 06:15:24 INFO - 'MAIL': '/var/mail/cltbld', 06:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:24 INFO - 'MOZ_NO_REMOTE': '1', 06:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:24 INFO - 'NO_EM_RESTART': '1', 06:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:24 INFO - 'PWD': '/builds/slave/test', 06:15:24 INFO - 'SHELL': '/bin/bash', 06:15:24 INFO - 'SHLVL': '1', 06:15:24 INFO - 'TERM': 'linux', 06:15:24 INFO - 'TMOUT': '86400', 06:15:24 INFO - 'USER': 'cltbld', 06:15:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:24 INFO - '_': '/tools/buildbot/bin/python'} 06:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:24 INFO - Downloading/unpacking psutil>=0.7.1 06:15:24 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 06:15:24 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 06:15:24 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 06:15:24 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 06:15:24 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 06:15:24 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 06:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:15:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:26 INFO - Installing collected packages: psutil 06:15:26 INFO - Running setup.py install for psutil 06:15:26 INFO - building 'psutil._psutil_linux' extension 06:15:26 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 06:15:26 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 06:15:26 INFO - building 'psutil._psutil_posix' extension 06:15:26 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 06:15:26 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 06:15:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:26 INFO - Successfully installed psutil 06:15:26 INFO - Cleaning up... 06:15:26 INFO - Return code: 0 06:15:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:26 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:26 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 06:15:26 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 06:15:26 INFO - Using env: {'DISPLAY': ':0', 06:15:26 INFO - 'HOME': '/home/cltbld', 06:15:26 INFO - 'LANG': 'en_US.UTF-8', 06:15:26 INFO - 'LANGUAGE': 'en_US:en', 06:15:26 INFO - 'LOGNAME': 'cltbld', 06:15:26 INFO - 'MAIL': '/var/mail/cltbld', 06:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:26 INFO - 'MOZ_NO_REMOTE': '1', 06:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:26 INFO - 'NO_EM_RESTART': '1', 06:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:26 INFO - 'PWD': '/builds/slave/test', 06:15:26 INFO - 'SHELL': '/bin/bash', 06:15:26 INFO - 'SHLVL': '1', 06:15:26 INFO - 'TERM': 'linux', 06:15:26 INFO - 'TMOUT': '86400', 06:15:26 INFO - 'USER': 'cltbld', 06:15:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:26 INFO - '_': '/tools/buildbot/bin/python'} 06:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:15:27 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 06:15:27 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 06:15:27 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 06:15:27 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 06:15:27 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 06:15:27 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 06:15:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:15:29 INFO - Installing collected packages: mozsystemmonitor 06:15:29 INFO - Running setup.py install for mozsystemmonitor 06:15:29 INFO - Successfully installed mozsystemmonitor 06:15:29 INFO - Cleaning up... 06:15:29 INFO - Return code: 0 06:15:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:29 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:29 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 06:15:29 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 06:15:29 INFO - Using env: {'DISPLAY': ':0', 06:15:29 INFO - 'HOME': '/home/cltbld', 06:15:29 INFO - 'LANG': 'en_US.UTF-8', 06:15:29 INFO - 'LANGUAGE': 'en_US:en', 06:15:29 INFO - 'LOGNAME': 'cltbld', 06:15:29 INFO - 'MAIL': '/var/mail/cltbld', 06:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:29 INFO - 'MOZ_NO_REMOTE': '1', 06:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:29 INFO - 'NO_EM_RESTART': '1', 06:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:29 INFO - 'PWD': '/builds/slave/test', 06:15:29 INFO - 'SHELL': '/bin/bash', 06:15:29 INFO - 'SHLVL': '1', 06:15:29 INFO - 'TERM': 'linux', 06:15:29 INFO - 'TMOUT': '86400', 06:15:29 INFO - 'USER': 'cltbld', 06:15:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:29 INFO - '_': '/tools/buildbot/bin/python'} 06:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:29 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:29 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 06:15:29 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 06:15:29 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 06:15:29 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 06:15:29 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 06:15:29 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 06:15:31 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:32 INFO - Downloading docopt-0.6.1.tar.gz 06:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:32 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:32 INFO - Running setup.py install for blobuploader 06:15:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:32 INFO - Running setup.py install for requests 06:15:32 INFO - Running setup.py install for docopt 06:15:32 INFO - Successfully installed blobuploader requests docopt 06:15:32 INFO - Cleaning up... 06:15:32 INFO - Return code: 0 06:15:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:32 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:32 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 06:15:32 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 06:15:32 INFO - Using env: {'DISPLAY': ':0', 06:15:32 INFO - 'HOME': '/home/cltbld', 06:15:32 INFO - 'LANG': 'en_US.UTF-8', 06:15:32 INFO - 'LANGUAGE': 'en_US:en', 06:15:32 INFO - 'LOGNAME': 'cltbld', 06:15:32 INFO - 'MAIL': '/var/mail/cltbld', 06:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:32 INFO - 'MOZ_NO_REMOTE': '1', 06:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:32 INFO - 'NO_EM_RESTART': '1', 06:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:32 INFO - 'PWD': '/builds/slave/test', 06:15:32 INFO - 'SHELL': '/bin/bash', 06:15:32 INFO - 'SHLVL': '1', 06:15:32 INFO - 'TERM': 'linux', 06:15:32 INFO - 'TMOUT': '86400', 06:15:32 INFO - 'USER': 'cltbld', 06:15:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:32 INFO - '_': '/tools/buildbot/bin/python'} 06:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:32 INFO - Running setup.py (path:/tmp/pip-zoxs7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:33 INFO - Running setup.py (path:/tmp/pip-bdP3IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:33 INFO - Running setup.py (path:/tmp/pip-i5ZG5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:33 INFO - Running setup.py (path:/tmp/pip-0B2EPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:33 INFO - Running setup.py (path:/tmp/pip-VDjBKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:33 INFO - Running setup.py (path:/tmp/pip-RVR1Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:33 INFO - Running setup.py (path:/tmp/pip-_qwFiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:33 INFO - Running setup.py (path:/tmp/pip-7Kih4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:33 INFO - Running setup.py (path:/tmp/pip-dZXRkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:33 INFO - Running setup.py (path:/tmp/pip-U7Dgxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:33 INFO - Running setup.py (path:/tmp/pip-OCTDsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:33 INFO - Running setup.py (path:/tmp/pip-hydoqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:33 INFO - Running setup.py (path:/tmp/pip-AezDia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:33 INFO - Running setup.py (path:/tmp/pip-0FyxZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:33 INFO - Running setup.py (path:/tmp/pip-biIcPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:34 INFO - Running setup.py (path:/tmp/pip-yqKy0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:34 INFO - Running setup.py (path:/tmp/pip-BHJ36H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:34 INFO - Running setup.py install for manifestparser 06:15:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozcrash 06:15:34 INFO - Running setup.py install for mozdebug 06:15:34 INFO - Running setup.py install for mozdevice 06:15:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozfile 06:15:34 INFO - Running setup.py install for mozhttpd 06:15:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozinfo 06:15:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozInstall 06:15:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:34 INFO - Running setup.py install for mozleak 06:15:35 INFO - Running setup.py install for mozlog 06:15:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for moznetwork 06:15:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for mozprocess 06:15:35 INFO - Running setup.py install for mozprofile 06:15:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for mozrunner 06:15:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Running setup.py install for mozscreenshot 06:15:35 INFO - Running setup.py install for moztest 06:15:35 INFO - Running setup.py install for mozversion 06:15:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:35 INFO - Cleaning up... 06:15:35 INFO - Return code: 0 06:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:35 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:35 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 06:15:35 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 06:15:35 INFO - Using env: {'DISPLAY': ':0', 06:15:35 INFO - 'HOME': '/home/cltbld', 06:15:35 INFO - 'LANG': 'en_US.UTF-8', 06:15:35 INFO - 'LANGUAGE': 'en_US:en', 06:15:35 INFO - 'LOGNAME': 'cltbld', 06:15:35 INFO - 'MAIL': '/var/mail/cltbld', 06:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:35 INFO - 'MOZ_NO_REMOTE': '1', 06:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:35 INFO - 'NO_EM_RESTART': '1', 06:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:35 INFO - 'PWD': '/builds/slave/test', 06:15:35 INFO - 'SHELL': '/bin/bash', 06:15:35 INFO - 'SHLVL': '1', 06:15:35 INFO - 'TERM': 'linux', 06:15:35 INFO - 'TMOUT': '86400', 06:15:35 INFO - 'USER': 'cltbld', 06:15:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:35 INFO - '_': '/tools/buildbot/bin/python'} 06:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:36 INFO - Running setup.py (path:/tmp/pip-y2kdsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:36 INFO - Running setup.py (path:/tmp/pip-wsuR_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:36 INFO - Running setup.py (path:/tmp/pip-aod63y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:36 INFO - Running setup.py (path:/tmp/pip-GLrdHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:36 INFO - Running setup.py (path:/tmp/pip-t08k9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:36 INFO - Running setup.py (path:/tmp/pip-9zdGHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:36 INFO - Running setup.py (path:/tmp/pip-XDduyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:36 INFO - Running setup.py (path:/tmp/pip-c1i7RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:36 INFO - Running setup.py (path:/tmp/pip-c3u77T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:36 INFO - Running setup.py (path:/tmp/pip-i1SfcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:36 INFO - Running setup.py (path:/tmp/pip-crfhoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:36 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)) 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:36 INFO - Running setup.py (path:/tmp/pip-L4mfY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:37 INFO - Running setup.py (path:/tmp/pip-NZA7rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:37 INFO - Running setup.py (path:/tmp/pip-wU7vRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:37 INFO - Running setup.py (path:/tmp/pip-TaZFOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:37 INFO - Running setup.py (path:/tmp/pip-aMdnth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:37 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)) 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:37 INFO - Running setup.py (path:/tmp/pip-PhFCsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 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)) 06:15:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:39 INFO - Downloading blessings-1.6.tar.gz 06:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:39 INFO - Installing collected packages: blessings 06:15:39 INFO - Running setup.py install for blessings 06:15:39 INFO - Successfully installed blessings 06:15:39 INFO - Cleaning up... 06:15:39 INFO - Return code: 0 06:15:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:39 INFO - Reading from file tmpfile_stdout 06:15:39 INFO - Current package versions: 06:15:39 INFO - argparse == 1.2.1 06:15:39 INFO - blessings == 1.6 06:15:39 INFO - blobuploader == 1.2.4 06:15:39 INFO - docopt == 0.6.1 06:15:39 INFO - manifestparser == 1.1 06:15:39 INFO - mozInstall == 1.12 06:15:39 INFO - mozcrash == 0.17 06:15:39 INFO - mozdebug == 0.1 06:15:39 INFO - mozdevice == 0.48 06:15:39 INFO - mozfile == 1.2 06:15:39 INFO - mozhttpd == 0.7 06:15:39 INFO - mozinfo == 0.9 06:15:39 INFO - mozleak == 0.1 06:15:39 INFO - mozlog == 3.1 06:15:39 INFO - moznetwork == 0.27 06:15:39 INFO - mozprocess == 0.22 06:15:39 INFO - mozprofile == 0.28 06:15:39 INFO - mozrunner == 6.11 06:15:39 INFO - mozscreenshot == 0.1 06:15:39 INFO - mozsystemmonitor == 0.0 06:15:39 INFO - moztest == 0.7 06:15:39 INFO - mozversion == 1.4 06:15:39 INFO - psutil == 3.1.1 06:15:39 INFO - requests == 1.2.3 06:15:39 INFO - wsgiref == 0.1.2 06:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:39 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:39 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 06:15:39 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 06:15:39 INFO - Using env: {'DISPLAY': ':0', 06:15:39 INFO - 'HOME': '/home/cltbld', 06:15:39 INFO - 'LANG': 'en_US.UTF-8', 06:15:39 INFO - 'LANGUAGE': 'en_US:en', 06:15:39 INFO - 'LOGNAME': 'cltbld', 06:15:39 INFO - 'MAIL': '/var/mail/cltbld', 06:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:39 INFO - 'MOZ_NO_REMOTE': '1', 06:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:39 INFO - 'NO_EM_RESTART': '1', 06:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:39 INFO - 'PWD': '/builds/slave/test', 06:15:39 INFO - 'SHELL': '/bin/bash', 06:15:39 INFO - 'SHLVL': '1', 06:15:39 INFO - 'TERM': 'linux', 06:15:39 INFO - 'TMOUT': '86400', 06:15:39 INFO - 'USER': 'cltbld', 06:15:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:39 INFO - '_': '/tools/buildbot/bin/python'} 06:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 INFO - Cleaning up... 06:15:40 INFO - Return code: 0 06:15:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:40 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:40 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 06:15:40 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 06:15:40 INFO - Using env: {'DISPLAY': ':0', 06:15:40 INFO - 'HOME': '/home/cltbld', 06:15:40 INFO - 'LANG': 'en_US.UTF-8', 06:15:40 INFO - 'LANGUAGE': 'en_US:en', 06:15:40 INFO - 'LOGNAME': 'cltbld', 06:15:40 INFO - 'MAIL': '/var/mail/cltbld', 06:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:40 INFO - 'MOZ_NO_REMOTE': '1', 06:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:40 INFO - 'NO_EM_RESTART': '1', 06:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:40 INFO - 'PWD': '/builds/slave/test', 06:15:40 INFO - 'SHELL': '/bin/bash', 06:15:40 INFO - 'SHLVL': '1', 06:15:40 INFO - 'TERM': 'linux', 06:15:40 INFO - 'TMOUT': '86400', 06:15:40 INFO - 'USER': 'cltbld', 06:15:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:40 INFO - '_': '/tools/buildbot/bin/python'} 06:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:40 INFO - Downloading/unpacking jsonschema 06:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:42 INFO - Downloading/unpacking functools32 (from jsonschema) 06:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:42 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:42 INFO - warning: no files found matching '*.txt' 06:15:42 INFO - no previously-included directories found matching 'build' 06:15:42 INFO - no previously-included directories found matching 'dist' 06:15:42 INFO - no previously-included directories found matching '.git*' 06:15:42 INFO - Installing collected packages: jsonschema, functools32 06:15:42 INFO - Running setup.py install for functools32 06:15:42 INFO - warning: no files found matching '*.txt' 06:15:42 INFO - no previously-included directories found matching 'build' 06:15:42 INFO - no previously-included directories found matching 'dist' 06:15:42 INFO - no previously-included directories found matching '.git*' 06:15:42 INFO - Successfully installed jsonschema functools32 06:15:42 INFO - Cleaning up... 06:15:42 INFO - Return code: 0 06:15:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:15:42 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')]} 06:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:42 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')]} 06:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:42 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 0x7f4d6d3daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, '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': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', '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 06:15:42 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 06:15:42 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 06:15:42 INFO - Using env: {'DISPLAY': ':0', 06:15:42 INFO - 'HOME': '/home/cltbld', 06:15:42 INFO - 'LANG': 'en_US.UTF-8', 06:15:42 INFO - 'LANGUAGE': 'en_US:en', 06:15:42 INFO - 'LOGNAME': 'cltbld', 06:15:42 INFO - 'MAIL': '/var/mail/cltbld', 06:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:42 INFO - 'MOZ_NO_REMOTE': '1', 06:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:42 INFO - 'NO_EM_RESTART': '1', 06:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:42 INFO - 'PWD': '/builds/slave/test', 06:15:42 INFO - 'SHELL': '/bin/bash', 06:15:42 INFO - 'SHLVL': '1', 06:15:42 INFO - 'TERM': 'linux', 06:15:42 INFO - 'TMOUT': '86400', 06:15:42 INFO - 'USER': 'cltbld', 06:15:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:42 INFO - '_': '/tools/buildbot/bin/python'} 06:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:42 INFO - Downloading/unpacking flake8 06:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:15:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:15:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:15:45 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 06:15:45 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 06:15:45 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 06:15:45 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 06:15:45 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 06:15:45 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 06:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:45 INFO - no previously-included directories found matching 'docs/_build' 06:15:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:15:45 INFO - Running setup.py install for pep8 06:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:45 INFO - no previously-included directories found matching 'docs/_build' 06:15:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:15:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:15:45 INFO - Cleaning up... 06:15:45 INFO - Return code: 0 06:15:45 INFO - Running post-action listener: _resource_record_post_action 06:15:45 INFO - Running post-action listener: _start_resource_monitoring 06:15:45 INFO - Starting resource monitoring. 06:15:45 INFO - ##### 06:15:45 INFO - ##### Finished create-virtualenv step (success) 06:15:45 INFO - ##### 06:15:45 INFO - ##### 06:15:45 INFO - ##### Running install step. 06:15:45 INFO - ##### 06:15:45 INFO - Running pre-action listener: _resource_record_pre_action 06:15:45 INFO - Running main action method: install 06:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:45 INFO - Reading from file tmpfile_stdout 06:15:45 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:45 INFO - Reading from file tmpfile_stdout 06:15:45 INFO - Output received: 06:15:45 INFO - Usage: mozinstall [options] installer 06:15:45 INFO - Options: 06:15:45 INFO - -h, --help show this help message and exit 06:15:45 INFO - -d DEST, --destination=DEST 06:15:45 INFO - Directory to install application into. [default: 06:15:45 INFO - "/builds/slave/test"] 06:15:45 INFO - --app=APP Application being installed. [default: firefox] 06:15:45 INFO - mkdir: /builds/slave/test/build/application 06:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:16:01 INFO - Reading from file tmpfile_stdout 06:16:01 INFO - Output received: 06:16:01 INFO - /builds/slave/test/build/application/firefox/firefox 06:16:01 INFO - Running post-action listener: _resource_record_post_action 06:16:01 INFO - ##### 06:16:01 INFO - ##### Finished install step (success) 06:16:01 INFO - ##### 06:16:01 INFO - ##### 06:16:01 INFO - ##### Running run-tests step. 06:16:01 INFO - ##### 06:16:01 INFO - Running pre-action listener: _resource_record_pre_action 06:16:01 INFO - Running main action method: run_tests 06:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:16:01 INFO - Python 2.7.3 06:16:01 INFO - Return code: 0 06:16:01 INFO - grabbing minidump binary from tooltool 06:16:01 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')]} 06:16:01 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16059c0>, '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 0x16068c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1606d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:16:01 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 06:16:01 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 06:16:01 INFO - Calling ['/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'] with output_timeout 600 06:16:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:16:01 INFO - Return code: 0 06:16:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:16:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:16:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:16:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:16:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:16:02 INFO - Return code: 0 06:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:16:02 INFO - Using env: {'DISPLAY': ':0', 06:16:02 INFO - 'HOME': '/home/cltbld', 06:16:02 INFO - 'LANG': 'en_US.UTF-8', 06:16:02 INFO - 'LANGUAGE': 'en_US:en', 06:16:02 INFO - 'LOGNAME': 'cltbld', 06:16:02 INFO - 'MAIL': '/var/mail/cltbld', 06:16:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:02 INFO - 'MOZ_NO_REMOTE': '1', 06:16:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:02 INFO - 'NO_EM_RESTART': '1', 06:16:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:02 INFO - 'PWD': '/builds/slave/test', 06:16:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:02 INFO - 'SHELL': '/bin/bash', 06:16:02 INFO - 'SHLVL': '1', 06:16:02 INFO - 'TERM': 'linux', 06:16:02 INFO - 'TMOUT': '86400', 06:16:02 INFO - 'USER': 'cltbld', 06:16:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242', 06:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:02 INFO - '_': '/tools/buildbot/bin/python'} 06:16:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:16:02 INFO - mozversion application_buildid: 20160511051212 06:16:02 INFO - mozversion application_changeset: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 06:16:02 INFO - mozversion application_display_name: Nightly 06:16:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:02 INFO - mozversion application_name: Firefox 06:16:02 INFO - mozversion application_remotingname: firefox 06:16:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:16:02 INFO - mozversion application_vendor: Mozilla 06:16:02 INFO - mozversion application_version: 49.0a1 06:16:02 INFO - mozversion platform_buildid: 20160511051212 06:16:02 INFO - mozversion platform_changeset: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 06:16:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:16:02 INFO - mozversion platform_version: 49.0a1 06:16:02 INFO - using testdate: 1462972562 06:16:02 INFO - actual date: 1462972562 06:16:02 INFO - starting webserver on 'localhost:56841' 06:16:02 INFO - SUITE-START | Running 2 tests 06:16:02 INFO - TEST-START | dromaeo_css 06:16:02 INFO - operating with platform_type : linux_ 06:16:02 INFO - Initialising browser for dromaeo_css test... 06:16:02 INFO - TEST-INFO | started process 29509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO7Wika/profile http://localhost:56841/getInfo.html) 06:16:07 INFO - PROCESS | 29509 | 06:16:07 INFO - PROCESS | 29509 | (process:29577): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:16:07 INFO - PROCESS | 29509 | __metrics Screen width/height:1600/1200 06:16:07 INFO - PROCESS | 29509 | colorDepth:24 06:16:07 INFO - PROCESS | 29509 | Browser inner width/height: 1024/697 06:16:07 INFO - PROCESS | 29509 | __metrics 06:16:08 ERROR - PROCESS | 29509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 06:16:09 INFO - TEST-INFO | 29509: exit 0 06:16:09 INFO - Browser initialized. 06:16:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:16:09 INFO - TEST-INFO | started process 29628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO7Wika/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:11 INFO - PROCESS | 29628 | 06:16:11 INFO - PROCESS | 29628 | (process:29688): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:16:21 INFO - PROCESS | 29628 | RSS: Main: 164405248 06:16:21 INFO - PROCESS | 29628 | 06:17:11 INFO - PROCESS | 29628 | 1462972631137 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] 06:19:23 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:56841/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56841/tests/dromaeo/cssquery-ext.html) 06:19:24 INFO - PROCESS | 29628 | RSS: Main: 167108608 06:19:24 INFO - PROCESS | 29628 | 06:22:26 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:56841/tests/dromaeo/cssquery-ext.html (next: http://localhost:56841/tests/dromaeo/cssquery-jquery.html) 06:22:27 INFO - PROCESS | 29628 | RSS: Main: 165969920 06:22:27 INFO - PROCESS | 29628 | 06:25:29 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:56841/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56841/tests/dromaeo/cssquery-mootools.html) 06:25:29 INFO - PROCESS | 29628 | RSS: Main: 167989248 06:25:29 INFO - PROCESS | 29628 | 06:28:31 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:56841/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56841/tests/dromaeo/cssquery-prototype.html) 06:28:32 INFO - PROCESS | 29628 | RSS: Main: 164511744 06:28:32 INFO - PROCESS | 29628 | 06:31:35 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:56841/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56841/tests/dromaeo/cssquery-yui.html) 06:31:35 INFO - PROCESS | 29628 | RSS: Main: 165851136 06:31:35 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:56841/tests/dromaeo/cssquery-yui.html (next: http://localhost:56841/tests/dromaeo/cssquery-dojo.html) 06:34:38 INFO - PROCESS | 29628 | RSS: Main: 167383040 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | __start_tp_report 06:34:38 INFO - PROCESS | 29628 | _x_x_mozilla_page_load 06:34:38 INFO - PROCESS | 29628 | _x_x_mozilla_page_load_details 06:34:38 INFO - PROCESS | 29628 | |i|pagename|runs| 06:34:38 INFO - PROCESS | 29628 | |0;dojo.html;2646.603009548568;2709.7561219490244;2713.6336594559734;2716.5789302658095;2729.65879265092;4720.976395118024;4751.928721069183;4773.379460670112;4861;4886.68236564623;4688.71867687939;4742.454617718963;4757.6193904487645;4803.3995750531185;4819.469858315591;4284.271673815451;4369.650427965755;4452.643788496913;4477.082198149388;4483.5964763171305;651.5400851429183;4286.592773686511;4350.042990542076;4404.581564751344;4447.35513350564;4433.800478978437;4451.109778044404;4479.932801007987;4480.977595112036;4488.506264310923;4450.10997800438;4459.888502787424;4466.620337271336;4476.395686582335;4504.054148628792;4310.504292006397;4310.52584215736;4312.892177695583;4391.165678521071;4407.691461597689;4564.748938808364;4638.141943740419;4658.394408726844;4661.906761864744;4666.160091183586;5072.239164125411;5107.693538387672;5116.053530096944;5121;5166.509181627739;5092.159793634046;5157.252198431206;5161.66449180802;5173.120569503193;5225.399079105876;4813.3983252093485;4818.132736107465;4828.46886842447;4851.345068415719;4883.926741098886;5269.683818970874;5283.471652834686;5302.125149350391;5349;5374.785008599612;5071.923921141186;5084.516970887834;5091.7963281469065;5099.745012749348;5104.515071068243;5190.662606930538;5192.428832828386;5194.896102077937;5212.661177023481;5231.24146998683;4944.90110197794;5037.471065538139;5059.316992206079;5094.1849304111165;5115.2071428928575;5075.8984820303385;5080.77136528857;5085.491450854959;5097.490250974873;5159.303494028333;4296.4414626098405;4376.037271800199;4392.1874453226255;4401.537838526909;4440.289553671461;3777.8866634001024;3787.3561494545993;3813.406883319314;3832.674222691047;3857.4792403025795;4318.892027699333;4365.628921541705;4391.231534481453;4440.977795111004;4463.553644635511;5243.659162154524;5257.973710131425;5264.078786212397;5265.842024739264;5319.069162896478;4275.679324050709;4341.956580434218;4382.298832186835;4391.934120988188;4412.139632771643;4628.4445866496235;4649.604783593432;4658.417697787777;4662.580367766917;4687.226607609774;4762.570809147526;4768.4754676986195;4811.446683631427;4832.154372984784;4866.659333846667;5153.974230128825;5197.8440646780655;5207.218917162456;5228.895422091461;5238.214267859851;4856;4884.4382895966;4887.144749668865;4894.583960363409;4942.481039490802;5123.641345105807;5137.691738495702;5148.871278218075;5157.742112894265;5161.896762064813;5249.527542521191;5276.208568714724;5280.102382594891;5282.8943421132135;5315.893682126413;5103.92344114846;5111.565516931102;5125.2568377585785;5135.563477104488;5162.148245539444;4987;5081.415637201769;5091.567216786467;5100.872478187926;5112.897742045213;4998.475160108282;5015.648904576645;5020.723860187579;5049.772760225872;5099.949000509948;5093.694378337312;5160.225966104964;5171.069207542679;5173.379194496684;5186.870328241824;4757.952420475889;4908.828191013297;4942.92585611209;4945.332380128781;5003.899922001467 06:34:38 INFO - PROCESS | 29628 | |1;ext.html;562.3504851896062;589.3634874335718;609.0772479693264;626.3611116661006;638.6168299020591;35331.29337413253;39247.21505569891;39478.802605987;39487;39499.60500394995;38760.41859372105;39326;39534;39797;39807.80096099523;7802.141764405925;7982.161873003338;7984.960075199616;7989.880151797699;7998.040235171788;7885.014373203349;7909.604519774017;7984.840303193932;7987.640556174986;8002.559859207741;7954.880676789853;7966.482178658398;8017.238362355567;8027.518348899055;8028.759137225892;7920.762377128666;7944.0467143942515;7968.163342849004;7980.2817746402525;7995.240452157036;7804.921950780533;7818.6090695465;7870.606469676493;7883.36933045355;7890.723824666109;30587.23531911698;37806.81096594499;37976;38135.427968580494;38170.80914595437;3237.5791147150953;3256;3277.246233366315;3360.24394511233;3381.7801842880135;27929.162125136278;28518.28704282389;28685.85657071722;30013.849930750424;32275.19312017218;3138.59198304219;3185.8725650973934;3196.53650220719;3300.290437555913;3309.751768617339;237547;246293;247200;247445.9999999982;247704;30702.232444188627;31719.841400792848;31725.841370792998;31735.206619834687;59828.40171598228;37017.81491092581;37022.44466333007;37099.25801483955;37252.62747372492;37255.62744372576;13203.273819939803;13206.603801885958;13208.075434719669;13228.933855330853;13245.403956821967;10417.635382761568;10528.894711052944;10586.629467968738;10803.973622506006;10817.242793004414;8589.78525536854;8607.65569377218;8631.309495240366;8668.479891206547;8712.303015758724;3378.172347774762;3404;3419.5383623210546;3425.2122011937395;3466.618671946084;861.801785589318;951.7953639967441;975.3124047546463;976.1751320134617;1008.8234558952154;28127;28356.291092722848;29152.562711559345;29234.269143271587;29275.560866587017;990.2276224544867;991.3457118301886;1025.0723095598496;1091.912646988239;1099.378850949211;15100.622484437758;15485.148316842682;15487.148206848731;15540.689186216212;15915.442959496593;353294;353334;358227.0443238888;359389;360603;49167.26249106266;50424.747876260386;50659.24011139836;50857.49142508602;50929;1258.6979125009932;1265.1144199060695;1285.2673975833873;1306.725587626609;1307.2809954524973;27412.72587274102;28016.159515214575;28432.43135137327;28561;28807.27981800388;42474;42985.3552196711;43132.78433607812;43177.56822431736;43306.13387732291;291001;294324;295323;295428;296134;26216.606750899133;26707.7329226713;26720;26736.732632674204;26757.464850702487;40836.183276333715;42291.788541057096;42312.36531451969;43259;43537.56462435462;36355.63644363522;36656.45015324719;36846;36886.26227475489;36995.630043700294;35737.64262357447;36211;36219.63780362268;36624.81687591545;37051;32542.51186232161;36420.27159456849;37581.24837503289;37595.436068458446;38271.234575308896;32430;33339.33321333608;33534.32931341311;33820;33963.15092122717;25581.23256302314;25759.484810303315;25908.352291192117;26082.86958565195;26276.868615657564 06:34:38 INFO - PROCESS | 29628 | |2;jquery.html;387.5736689641394;388.58033324010074;391.4832421204012;396.4984294866993;409.9549049604543;16070.83929160708;17294.406951282188;17316.393926212586;17403.91298043511;17461.3015479381;13853.93073034636;16016.519504414886;16786.244618992143;16806.15969201541;16966.660666786687;5071.1632580624155;5243.6853788772605;5267.736613169345;5269.446708095652;5269.841904742864;4959.528844759742;5143.5113664201845;5147.047796157704;5186.818461353853;5213.035588416155;5146.665466744668;5154.587632989352;5182.041322355358;5185.118529849916;5204.713740744258;4956.603471722254;5131.589472842164;5157.819476318329;5161.638685292031;5178.559822415118;4480.19356515827;4507.5717806808625;4516.616087632555;4550.522195169526;4559.794809233593;20182.091805868626;20205.797942020537;20438.89780551088;20974.475638109016;21017.68473472899;2044.5195379085903;2102.6005059038885;2111.5565731196466;2331.265651319829;2422.200673777649;13237.271950042743;13595.060694016382;13660.726785464236;13760.724785504233;13973.650658733512;1800.3878681248307;1817.6273863857878;1824.352354914013;1839.3102586530051;1856.8514518838595;66818.66590667015;69228.6538567309;69883;70986.29013709849;71462.64268678676;9675.806483870283;9840.803183936281;9985.999999999854;9999.700008999742;10048.246381521416;13838.584842454742;13877.791833122512;13886.097403668931;13943.58169254924;14154.858451415354;6414;6715.227748808852;7182.066331376887;7197.784066478014;7229.132504099542;6884.277150899084;6961.338672826073;7029.859402811915;7150.606716630531;7185.137783466018;5983.282006159202;6143.56995010345;6299.937000629935;6311.463525600284;6373.681315934185;1690.191495100231;1717.5362652084118;1719.3693648717483;1733.1680793219325;1794.1567463292492;874.580201503282;898.1333013641867;901.8511945529045;972.844344904826;1048.5858086056119;16497.257623406975;17471.737923931152;17565.20956556958;17746.20142093609;18008.549786255448;857.6055014693186;928.331601247101;929.1080562659787;933.9766505837408;1008.3596915958419;9358.11097945694;9404.811903761887;9489.003654616305;9630.036996300314;9681;379955;420272;426600;438031;440161;83212;87363.56318218369;87781.56109219413;87947.56026219956;88342.11657883467;925.1812146250617;947.7677968897526;949.0983565612696;965.2133511188359;975.9707208783606;15521.534353969399;15618.687626247638;15651.765223521885;15694.21528923572;15996.920015399848;35731.821340893126;36852.447213291285;37077.99999999892;37129.25741485101;37508.812455938634;47747;50651;51714.74142629413;53204.73397632987;53408.1988770161;7668.194839541768;7678.308952194329;7762.61186940662;7806.960965195138;7972.123066462568;10905.672829815117;10966.670999870017;11296.661100167008;11359.54561817518;11518.481668325114;10053.19574434029;10203.59185632596;10333.431661258403;10399.428031458343;10569;4587.931181032354;6737.921932490778;8933.865992009994;10492.685219443123;10581.36511809294;10474;10612.893871061191;10680.679579612624;10805.621803237163;10806.837897431702;7813.492123011986;7903.407244456804;7957.482763620346;8024.197580241929;8086.3126634234395;8164.7550573482895;9733.9026609733;9877.506124693593;10514.526846291783;10695.89304106949 06:34:38 INFO - PROCESS | 29628 | |3;mootools.html;1549.2950707428122;1559.2281820498852;1780.786305643323;1889.3859495663912;1909.4271718484451;6812.046313516112;7374.225706300828;7630.4658673892845;8212;8219.54792486413;7448.739294124707;7711.768646940587;7762.96118519408;7768.68925242991;7784.377249820015;2174.1738139506965;2209.436593668612;2210.9005094770773;2213.4908970936694;2214.723159605049;2185.25701261571;2193.3858519614455;2196.2971849008322;2218.3566765638025;2221.311393468022;2150.8817015064164;2152.967705484419;2157.514559224178;2160.7299087614047;2187.2344679362177;2039.7144399783895;2050.2209160519055;2050.589882023594;2053.404512691318;2060;2057.763357213925;2091.7908209179113;2134.6691262854283;2157.600843843894;2157.8273738100916;7630.923690763132;7691.576963267018;7761.22387761225;7765.611719414007;7765.611719414063;4731.455882573479;4784.593309568656;4827.831025914112;4855.101806165835;4856.708597484162;2807.8174918630225;2870.3111253299267;2900.2459360566195;2922.8976985805607;2925.093221101465;877.578762194144;906.4380084347681;913.109718024927;918.0773322810533;927.1238679447924;10394.376337419779;10407.063364297173;10420;10468.214883883664;10512.526936287886;4378.8905277367685;4381.990760683878;4445.711028783118;4574.794134263966;4616.884577885513;8282.627281772335;8294.958525207456;8314.667413303521;8315;8331.66673333072;4680.5085466025575;4711.199096153662;4722.268048452495;4728.527147285244;4730.905381892343;3687.9631203688155;4245.27830268855;4382.517923028464;4384.473863136444;4409.845655402046;3483.7387195959896;3540.13266749648;3548.4499902514635;3561.056320075182;3616.6744992950235;1029.4749677664445;1050.2963014780116;1050.8686414198226;1055.1664185293685;1078.4176544665793;822.9795054132832;845.3617518773286;888.3515034025198;928.7445952363154;935.8081593273363;5533.3083364579425;5560;5565.916511252334;5632.774689012475;5666.263385759825;921.5622579274791;939.2110627073155;965.0976337124811;990.094063931509;996.7757254617798;3673.200131935386;3760.816067317635;3811.2377524495214;3828.559715632738;3881.262560113569;9314.34799564024;9887.950560247153;9894.109530142321;9976.900230997597;10000.299979001546;9631.229501639851;9808.509574521246;9854.704358869245;9913.752156196153;9941.751456213507;7463.179050304462;7601.049868766404;7603.391728661693;7636.427267954926;7675.692972281158;5323.30796996388;5452.536534394462;5529.30883639545;5541.418151094238;5573.21974923503;8380.497170169809;8585.012723536624;8689.782755431164;8716.43343182691;8732.039475657799;8758.299336053227;8882.467051976902;8885.555722213734;8977.955110224408;9111.635534578543;5934.169216309807;6799.728010879708;6951.27011663768;7039.6832142552685;7095.680694368869;7766.417518686008;7794.376449884109;7846.136924938138;7868.685252590061;7887.211278872067;6991.405730512964;7154.284571542804;7195.13658361;7271.563706177646;7290.9635451822405;6785.932140678728;6869.725210991504;6926.8614627708175;6951.548149370275;6993.0908981832035;6556.311587283267;6651.0023496475915;6733;6764.830879227862;6783.491238157059;4701.365315682339;4794.113089078532;4826;4835.492273311252;4872.196087645499;4856.927146092882;4900.8774780630765;4914.852554423373;4954.752262386794;4968.428630707371 06:34:38 INFO - PROCESS | 29628 | |4;prototype.html;302.4269010225624;309.92561785171563;317.99682003179964;327.4433463112708;328.88507958022296;4817.915968906994;4882.340883980662;4981.950180498194;5010.198368261079;5029.999999999995;4932.704037757737;4942.110420124376;4952.504749525055;4953.588227355204;4967.254911763237;3918.04008018036;3930.567637559866;3932.193900250456;3939.8621048263317;3946.5461471930807;3634.436662317345;3953.268645300614;3953.5255769307723;3953.8023098845088;3955.683545316382;3800.429935509668;3817.503724515823;3827.655511004009;3829.138443850139;3834;3822.9044273893096;3828.540575130988;3838.9232215355537;3845.9807700961596;3867.7292589518743;3396.6073909696906;3413.8975830725117;3425.9143521411916;3434.86649405698;3438.157651375429;4701;4768.284757286435;4778.331033655291;4819.662623616348;4879.682485728868;4384.846530371454;4387.561243875587;4403.581659742319;4405.537418571036;4412.8156562501445;5161.716105614228;5170.327857378555;5173.715445650488;5173.784160722227;5209.244659524347;3611.422172452395;3662.01765932587;3686.7972261525606;3712.6472985066644;3726.29200451916;5413.160960051159;5432.266644003088;5434.782608695687;5449.8827740313145;5458.153986132195;3753.155540003477;3764.6235376462682;3771.849585876334;3773.0570155278924;3781.1303400217553;3799.677027452642;3808.676262517717;3810.5998870118237;3815.828287727059;3816.542014958223;4187.204431158131;4401.22978478765;4439.711418757771;4453.643708503312;4457.910841783211;5301.4168441472175;5302.568306557285;5304.787808487695;5308.805518758249;5312.601554883322;1266.322517453158;1316.7037416581193;1346.3537501999094;1348.2719331561043;1353.9526116585873;845.7758693946109;853.7396094191207;857.2284943550854;861.4099341950783;872.1496540872726;4030.375291829771;4042.1406153169874;4059.289624315733;4084.7133153056693;4101.159262351211;4689.343491911135;4702.553257440538;4711.411073615798;4744.572988431058;4763.309320148559;3942.5466071401584;4039.8688367257214;4076.2255171517318;4080.224757296104;4106.219818234586;2533.6959564852336;2685.3485106659264;2892.840893750864;2916.3729798093086;2922.0211229238016;5060.3927528696795;5070.366204224472;5090.669106508065;5106.846794596168;5118.744062796845;5377.166539186433;5524.66851988882;5526.253955715927;5550.389457159709;5558.221848941152;5044.949550504448;5066.771995260222;5068.974655126701;5081.18701007837;5083.237514372874;5379.35447746273;5398.865028374165;5413.675179489243;5428.945710542844;5440.374356949002;5066.417362003417;5279.076161671615;5308.867278318073;5319.813806516753;5337.092694242066;4999.775010124626;5021.171506701354;5027.321311622884;5041.017001684636;5075.502726695559;3786.261678972574;3828.578856325746;3835.328817456878;3842.4044273137706;3846.2692088503095;5214.426413094632;5329.1206950852675;5351.277577526984;5375.489328513785;5407.648502847303;5079.780852595424;5162.225666150108;5176.948230517797;5178.042062218502;5188.377394712507;5086.872828179326;5091;5120.02719483297;5121.436641969306;5127.4872512748425;4931.556159945622;5071.315372424676;5088.7201203932655;5129.538081646713;5136.691798492103;5233.712145831863;5246.790128394821;5251.921221181609;5258.1849813279005;5271.367435907716;5112.514311140436;5129.512696293846;5139.794408223629;5148.279240906201;5156.639035267645 06:34:38 INFO - PROCESS | 29628 | |5;yui.html;707.2079271216238;775.9379249660028;785.7407055671628;819.5164852736884;832.4880198677815;12768.42542085606;13039.999999999987;13088.803667944989;13131.606051818437;13192.604221873347;14037.78943315851;14058.734713875749;14120;14148.504802331894;14193.361298741556;654.7348323928817;844.6283635200523;875.2735229759285;884.0452311503593;886.0297973718767;858.4076986879033;859.3855393393723;861.0399404663817;862.2886118951858;864.1315477944656;913.1735779119907;913.4930113786845;915.4598786715836;915.771057235691;917.5870858113842;899.7345782994032;899.9910000899972;904.2810965282616;905.7826121730803;906.3338446242007;672.2269390201259;672.6737532296833;673.8719643267764;674.4739103499278;675.3651567526558;12453.813192802116;12455.377231138407;12463.314517701523;12474.43865026076;12499.312537810416;12133.817992730028;12591.181573197713;12623.431945562472;12743.235405875677;12758.68103297425;10062.144717699004;10636.46817659114;10646.840297395545;10702.839457408145;11136.220464567483;3357.429237029686;3377.983110084434;3403.4554471284478;3414.197663549064;3419.6409377015552;45060;45062.774686126686;45113;45618.77190614059;45868;10091.142252908438;10121;10125.898741012496;10262.281640285257;10482.10902073317;17372.218250178772;17407.65184696299;17600.383986560664;17621.823781762276;17630.2066407012;6634.203895532567;6724.562903411263;6905.136857892763;6929.930700692928;6937.479689023344;3635.517811364837;3638.290533346025;3672.779633222015;3685.870994515179;3759.285735710206;2830.6037154798346;2934.7652187824924;2954.852257387122;2960.8223506589675;2994.2364697002126;528.5269683633204;529.2616799564586;532.7469452010341;536.804066515719;540.95672346213;594.1533315026071;614.7909710698384;616.4852348289229;616.6485103490967;620.5314987184647;8162.14297498766;8189.385796065319;8218.301444377175;8233.46482478637;8249;527.3724268121;537.247853005795;543.3859738495554;549.9862503437366;635.3487675132933;3916.4321173429694;3920.725549211585;3972.6424621784176;3999.1601763629383;4093.467849179647;48209;49416.752916235186;50602.49397506051;50628.49371506238;50648.49351506438;43750.562494375285;44665.330020049725;46292;46301.30548041782;46967.76516117398;38891.416628750594;41122.38316425256;42377.57622423736;43042;43217.35173972393;7892.802679933047;8162.224588664068;8224.218699223564;8386;8644.22202001823;29421.85289073541;29449.85275073611;29486.705132948395;30407.391852163277;30715.69284307218;36751.26497470089;36897.07757305982;36976.81511592425;37046.44430333601;37265.44101838529;10623.89376106229;10746.408947507962;10844.728881778019;11006.889931100586;11066.778664426505;11907.166498345032;12063.276203427822;12331.136820422484;12439.129260951646;12977.156484828456;11070.169737269576;11229.606963756229;11318.26431281964;11466.82799758021;12323.69190770238;10725.088367488539;11024.559017639205;11071.335719856834;12084.154109212272;12091.637250882135;10578.312409693654;10862.891371086187;10904.945475272572;11301.378424186749;11657.825132622847;7708.730194443167;7725.129573664248;7805;8075.515469071875;8263;8105.311048560939;8146.796330091558;8189.549574773445;8330.791730206793;8459.746207613782 06:34:38 INFO - PROCESS | 29628 | __end_tp_report 06:34:38 INFO - PROCESS | 29628 | __start_cc_report 06:34:38 INFO - PROCESS | 29628 | _x_x_mozilla_cycle_collect,403 06:34:38 INFO - PROCESS | 29628 | __end_cc_report 06:34:38 INFO - PROCESS | 29628 | __startTimestamp1462973678671__endTimestamp 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | ------- Summary: start ------- 06:34:38 INFO - PROCESS | 29628 | Number of tests: 6 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | [#0] dojo.html Cycles:165 Average:4746.29 Median:4887.14 stddev:607.20 (12.4%) stddev-sans-first:586.30 06:34:38 INFO - PROCESS | 29628 | Values: 2646.6 2709.8 2713.6 2716.6 2729.7 4721.0 4751.9 4773.4 4861.0 4886.7 4688.7 4742.5 4757.6 4803.4 4819.5 4284.3 4369.7 4452.6 4477.1 4483.6 651.5 4286.6 4350.0 4404.6 4447.4 4433.8 4451.1 4479.9 4481.0 4488.5 4450.1 4459.9 4466.6 4476.4 4504.1 4310.5 4310.5 4312.9 4391.2 4407.7 4564.7 4638.1 4658.4 4661.9 4666.2 5072.2 5107.7 5116.1 5121.0 5166.5 5092.2 5157.3 5161.7 5173.1 5225.4 4813.4 4818.1 4828.5 4851.3 4883.9 5269.7 5283.5 5302.1 5349.0 5374.8 5071.9 5084.5 5091.8 5099.7 5104.5 5190.7 5192.4 5194.9 5212.7 5231.2 4944.9 5037.5 5059.3 5094.2 5115.2 5075.9 5080.8 5085.5 5097.5 5159.3 4296.4 4376.0 4392.2 4401.5 4440.3 3777.9 3787.4 3813.4 3832.7 3857.5 4318.9 4365.6 4391.2 4441.0 4463.6 5243.7 5258.0 5264.1 5265.8 5319.1 4275.7 4342.0 4382.3 4391.9 4412.1 4628.4 4649.6 4658.4 4662.6 4687.2 4762.6 4768.5 4811.4 4832.2 4866.7 5154.0 5197.8 5207.2 5228.9 5238.2 4856.0 4884.4 4887.1 4894.6 4942.5 5123.6 5137.7 5148.9 5157.7 5161.9 5249.5 5276.2 5280.1 5282.9 5315.9 5103.9 5111.6 5125.3 5135.6 5162.1 4987.0 5081.4 5091.6 5100.9 5112.9 4998.5 5015.6 5020.7 5049.8 5099.9 5093.7 5160.2 5171.1 5173.4 5186.9 4758.0 4908.8 4942.9 4945.3 5003.9 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | [#1] ext.html Cycles:180 Average:44584.84 Median:359996.00 stddev:79483.22 (22.1%) stddev-sans-first:79637.46 06:34:38 INFO - PROCESS | 29628 | Values: 562.4 589.4 609.1 626.4 638.6 35331.3 39247.2 39478.8 39487.0 39499.6 38760.4 39326.0 39534.0 39797.0 39807.8 7802.1 7982.2 7985.0 7989.9 7998.0 7885.0 7909.6 7984.8 7987.6 8002.6 7954.9 7966.5 8017.2 8027.5 8028.8 7920.8 7944.0 7968.2 7980.3 7995.2 7804.9 7818.6 7870.6 7883.4 7890.7 30587.2 37806.8 37976.0 38135.4 38170.8 3237.6 3256.0 3277.2 3360.2 3381.8 27929.2 28518.3 28685.9 30013.8 32275.2 3138.6 3185.9 3196.5 3300.3 3309.8 237547.0 246293.0 247200.0 247446.0 247704.0 30702.2 31719.8 31725.8 31735.2 59828.4 37017.8 37022.4 37099.3 37252.6 37255.6 13203.3 13206.6 13208.1 13228.9 13245.4 10417.6 10528.9 10586.6 10804.0 10817.2 8589.8 8607.7 8631.3 8668.5 8712.3 3378.2 3404.0 3419.5 3425.2 3466.6 861.8 951.8 975.3 976.2 1008.8 28127.0 28356.3 29152.6 29234.3 29275.6 990.2 991.3 1025.1 1091.9 1099.4 15100.6 15485.1 15487.1 15540.7 15915.4 353294.0 353334.0 358227.0 359389.0 360603.0 49167.3 50424.7 50659.2 50857.5 50929.0 1258.7 1265.1 1285.3 1306.7 1307.3 27412.7 28016.2 28432.4 28561.0 28807.3 42474.0 42985.4 43132.8 43177.6 43306.1 291001.0 294324.0 295323.0 295428.0 296134.0 26216.6 26707.7 26720.0 26736.7 26757.5 40836.2 42291.8 42312.4 43259.0 43537.6 36355.6 36656.5 36846.0 36886.3 36995.6 35737.6 36211.0 36219.6 36624.8 37051.0 32542.5 36420.3 37581.2 37595.4 38271.2 32430.0 33339.3 33534.3 33820.0 33963.2 25581.2 25759.5 25908.4 26082.9 26276.9 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | [#2] jquery.html Cycles:180 Average:25558.12 Median:4555.16 stddev:69643.03 (1528.9%) stddev-sans-first:69812.75 06:34:38 INFO - PROCESS | 29628 | Values: 387.6 388.6 391.5 396.5 410.0 16070.8 17294.4 17316.4 17403.9 17461.3 13853.9 16016.5 16786.2 16806.2 16966.7 5071.2 5243.7 5267.7 5269.4 5269.8 4959.5 5143.5 5147.0 5186.8 5213.0 5146.7 5154.6 5182.0 5185.1 5204.7 4956.6 5131.6 5157.8 5161.6 5178.6 4480.2 4507.6 4516.6 4550.5 4559.8 20182.1 20205.8 20438.9 20974.5 21017.7 2044.5 2102.6 2111.6 2331.3 2422.2 13237.3 13595.1 13660.7 13760.7 13973.7 1800.4 1817.6 1824.4 1839.3 1856.9 66818.7 69228.7 69883.0 70986.3 71462.6 9675.8 9840.8 9986.0 9999.7 10048.2 13838.6 13877.8 13886.1 13943.6 14154.9 6414.0 6715.2 7182.1 7197.8 7229.1 6884.3 6961.3 7029.9 7150.6 7185.1 5983.3 6143.6 6299.9 6311.5 6373.7 1690.2 1717.5 1719.4 1733.2 1794.2 874.6 898.1 901.9 972.8 1048.6 16497.3 17471.7 17565.2 17746.2 18008.5 857.6 928.3 929.1 934.0 1008.4 9358.1 9404.8 9489.0 9630.0 9681.0 379955.0 420272.0 426600.0 438031.0 440161.0 83212.0 87363.6 87781.6 87947.6 88342.1 925.2 947.8 949.1 965.2 976.0 15521.5 15618.7 15651.8 15694.2 15996.9 35731.8 36852.4 37078.0 37129.3 37508.8 47747.0 50651.0 51714.7 53204.7 53408.2 7668.2 7678.3 7762.6 7807.0 7972.1 10905.7 10966.7 11296.7 11359.5 11518.5 10053.2 10203.6 10333.4 10399.4 10569.0 4587.9 6737.9 8933.9 10492.7 10581.4 10474.0 10612.9 10680.7 10805.6 10806.8 7813.5 7903.4 7957.5 8024.2 8086.3 8164.8 9733.9 9877.5 10514.5 10695.9 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | [#3] mootools.html Cycles:180 Average:5208.93 Median:5550.71 stddev:2856.61 (51.5%) stddev-sans-first:2851.39 06:34:38 INFO - PROCESS | 29628 | Values: 1549.3 1559.2 1780.8 1889.4 1909.4 6812.0 7374.2 7630.5 8212.0 8219.5 7448.7 7711.8 7763.0 7768.7 7784.4 2174.2 2209.4 2210.9 2213.5 2214.7 2185.3 2193.4 2196.3 2218.4 2221.3 2150.9 2153.0 2157.5 2160.7 2187.2 2039.7 2050.2 2050.6 2053.4 2060.0 2057.8 2091.8 2134.7 2157.6 2157.8 7630.9 7691.6 7761.2 7765.6 7765.6 4731.5 4784.6 4827.8 4855.1 4856.7 2807.8 2870.3 2900.2 2922.9 2925.1 877.6 906.4 913.1 918.1 927.1 10394.4 10407.1 10420.0 10468.2 10512.5 4378.9 4382.0 4445.7 4574.8 4616.9 8282.6 8295.0 8314.7 8315.0 8331.7 4680.5 4711.2 4722.3 4728.5 4730.9 3688.0 4245.3 4382.5 4384.5 4409.8 3483.7 3540.1 3548.4 3561.1 3616.7 1029.5 1050.3 1050.9 1055.2 1078.4 823.0 845.4 888.4 928.7 935.8 5533.3 5560.0 5565.9 5632.8 5666.3 921.6 939.2 965.1 990.1 996.8 3673.2 3760.8 3811.2 3828.6 3881.3 9314.3 9888.0 9894.1 9976.9 10000.3 9631.2 9808.5 9854.7 9913.8 9941.8 7463.2 7601.0 7603.4 7636.4 7675.7 5323.3 5452.5 5529.3 5541.4 5573.2 8380.5 8585.0 8689.8 8716.4 8732.0 8758.3 8882.5 8885.6 8978.0 9111.6 5934.2 6799.7 6951.3 7039.7 7095.7 7766.4 7794.4 7846.1 7868.7 7887.2 6991.4 7154.3 7195.1 7271.6 7291.0 6785.9 6869.7 6926.9 6951.5 6993.1 6556.3 6651.0 6733.0 6764.8 6783.5 4701.4 4794.1 4826.0 4835.5 4872.2 4856.9 4900.9 4914.9 4954.8 4968.4 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | [#4] prototype.html Cycles:180 Average:4276.38 Median:4881.01 stddev:1251.36 (25.6%) stddev-sans-first:1218.80 06:34:38 INFO - PROCESS | 29628 | Values: 302.4 309.9 318.0 327.4 328.9 4817.9 4882.3 4982.0 5010.2 5030.0 4932.7 4942.1 4952.5 4953.6 4967.3 3918.0 3930.6 3932.2 3939.9 3946.5 3634.4 3953.3 3953.5 3953.8 3955.7 3800.4 3817.5 3827.7 3829.1 3834.0 3822.9 3828.5 3838.9 3846.0 3867.7 3396.6 3413.9 3425.9 3434.9 3438.2 4701.0 4768.3 4778.3 4819.7 4879.7 4384.8 4387.6 4403.6 4405.5 4412.8 5161.7 5170.3 5173.7 5173.8 5209.2 3611.4 3662.0 3686.8 3712.6 3726.3 5413.2 5432.3 5434.8 5449.9 5458.2 3753.2 3764.6 3771.8 3773.1 3781.1 3799.7 3808.7 3810.6 3815.8 3816.5 4187.2 4401.2 4439.7 4453.6 4457.9 5301.4 5302.6 5304.8 5308.8 5312.6 1266.3 1316.7 1346.4 1348.3 1354.0 845.8 853.7 857.2 861.4 872.1 4030.4 4042.1 4059.3 4084.7 4101.2 4689.3 4702.6 4711.4 4744.6 4763.3 3942.5 4039.9 4076.2 4080.2 4106.2 2533.7 2685.3 2892.8 2916.4 2922.0 5060.4 5070.4 5090.7 5106.8 5118.7 5377.2 5524.7 5526.3 5550.4 5558.2 5044.9 5066.8 5069.0 5081.2 5083.2 5379.4 5398.9 5413.7 5428.9 5440.4 5066.4 5279.1 5308.9 5319.8 5337.1 4999.8 5021.2 5027.3 5041.0 5075.5 3786.3 3828.6 3835.3 3842.4 3846.3 5214.4 5329.1 5351.3 5375.5 5407.6 5079.8 5162.2 5176.9 5178.0 5188.4 5086.9 5091.0 5120.0 5121.4 5127.5 4931.6 5071.3 5088.7 5129.5 5136.7 5233.7 5246.8 5251.9 5258.2 5271.4 5112.5 5129.5 5139.8 5148.3 5156.6 06:34:38 INFO - PROCESS | 29628 | 06:34:38 INFO - PROCESS | 29628 | [#5] yui.html Cycles:180 Average:12702.59 Median:22607.93 stddev:14038.68 (62.1%) stddev-sans-first:14049.16 06:34:38 INFO - PROCESS | 29628 | Values: 707.2 775.9 785.7 819.5 832.5 12768.4 13040.0 13088.8 13131.6 13192.6 14037.8 14058.7 14120.0 14148.5 14193.4 654.7 844.6 875.3 884.0 886.0 858.4 859.4 861.0 862.3 864.1 913.2 913.5 915.5 915.8 917.6 899.7 900.0 904.3 905.8 906.3 672.2 672.7 673.9 674.5 675.4 12453.8 12455.4 12463.3 12474.4 12499.3 12133.8 12591.2 12623.4 12743.2 12758.7 10062.1 10636.5 10646.8 10702.8 11136.2 3357.4 3378.0 3403.5 3414.2 3419.6 45060.0 45062.8 45113.0 45618.8 45868.0 10091.1 10121.0 10125.9 10262.3 10482.1 17372.2 17407.7 17600.4 17621.8 17630.2 6634.2 6724.6 6905.1 6929.9 6937.5 3635.5 3638.3 3672.8 3685.9 3759.3 2830.6 2934.8 2954.9 2960.8 2994.2 528.5 529.3 532.7 536.8 541.0 594.2 614.8 616.5 616.6 620.5 8162.1 8189.4 8218.3 8233.5 8249.0 527.4 537.2 543.4 550.0 635.3 3916.4 3920.7 3972.6 3999.2 4093.5 48209.0 49416.8 50602.5 50628.5 50648.5 43750.6 44665.3 46292.0 46301.3 46967.8 38891.4 41122.4 42377.6 43042.0 43217.4 7892.8 8162.2 8224.2 8386.0 8644.2 29421.9 29449.9 29486.7 30407.4 30715.7 36751.3 36897.1 36976.8 37046.4 37265.4 10623.9 10746.4 10844.7 11006.9 11066.8 11907.2 12063.3 12331.1 12439.1 12977.2 11070.2 11229.6 11318.3 11466.8 12323.7 10725.1 11024.6 11071.3 12084.2 12091.6 10578.3 10862.9 10904.9 11301.4 11657.8 7708.7 7725.1 7805.0 8075.5 8263.0 8105.3 8146.8 8189.5 8330.8 8459.7 06:34:38 INFO - PROCESS | 29628 | -------- Summary: end -------- 06:34:38 INFO - PROCESS | 29628 | 06:34:39 INFO - TEST-INFO | 29628: exit 0 06:34:39 INFO - TEST-OK | dromaeo_css | took 1116606ms 06:34:39 INFO - TEST-START | kraken 06:34:39 INFO - operating with platform_type : linux_ 06:34:39 INFO - Initialising browser for kraken test... 06:34:39 INFO - TEST-INFO | started process 29869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyHCCK/profile http://localhost:56841/getInfo.html) 06:34:43 INFO - PROCESS | 29869 | 06:34:43 INFO - PROCESS | 29869 | (process:29935): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:34:44 INFO - PROCESS | 29869 | __metrics Screen width/height:1600/1200 06:34:44 INFO - PROCESS | 29869 | colorDepth:24 06:34:44 INFO - PROCESS | 29869 | Browser inner width/height: 1024/697 06:34:44 INFO - PROCESS | 29869 | __metrics 06:34:44 ERROR - PROCESS | 29869 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 06:34:45 INFO - TEST-INFO | 29869: exit 0 06:34:45 INFO - Browser initialized. 06:34:45 INFO - Running cycle 1/1 for kraken test... 06:34:45 INFO - TEST-INFO | started process 29986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyHCCK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:47 INFO - PROCESS | 29986 | 06:34:47 INFO - PROCESS | 29986 | (process:30047): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:34:57 INFO - PROCESS | 29986 | RSS: Main: 164151296 06:34:57 INFO - PROCESS | 29986 | 06:35:00 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56841/tests/kraken/driver.html?testName=audio-beat-detection) 06:35:01 INFO - PROCESS | 29986 | RSS: Main: 167514112 06:35:01 INFO - PROCESS | 29986 | 06:35:04 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56841/tests/kraken/driver.html?testName=audio-dft) 06:35:04 INFO - PROCESS | 29986 | RSS: Main: 167772160 06:35:05 INFO - PROCESS | 29986 | 06:35:07 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56841/tests/kraken/driver.html?testName=audio-fft) 06:35:08 INFO - PROCESS | 29986 | RSS: Main: 163966976 06:35:08 INFO - PROCESS | 29986 | 06:35:10 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56841/tests/kraken/driver.html?testName=audio-oscillator) 06:35:11 INFO - PROCESS | 29986 | RSS: Main: 164130816 06:35:11 INFO - PROCESS | 29986 | 06:35:13 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56841/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:35:14 INFO - PROCESS | 29986 | RSS: Main: 164274176 06:35:14 INFO - PROCESS | 29986 | 06:35:17 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56841/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:18 INFO - PROCESS | 29986 | RSS: Main: 165089280 06:35:18 INFO - PROCESS | 29986 | 06:35:21 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56841/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:22 INFO - PROCESS | 29986 | RSS: Main: 163139584 06:35:22 INFO - PROCESS | 29986 | 06:35:25 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56841/tests/kraken/driver.html?testName=json-parse-financial) 06:35:26 INFO - PROCESS | 29986 | RSS: Main: 163717120 06:35:26 INFO - PROCESS | 29986 | 06:35:27 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56841/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:28 INFO - PROCESS | 29986 | RSS: Main: 164077568 06:35:28 INFO - PROCESS | 29986 | 06:35:30 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:31 INFO - PROCESS | 29986 | RSS: Main: 163995648 06:35:31 INFO - PROCESS | 29986 | 06:35:33 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:34 INFO - PROCESS | 29986 | RSS: Main: 164335616 06:35:34 INFO - PROCESS | 29986 | 06:35:37 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:37 INFO - PROCESS | 29986 | RSS: Main: 164220928 06:35:37 INFO - PROCESS | 29986 | 06:35:40 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:41 INFO - PROCESS | 29986 | RSS: Main: 164175872 06:35:41 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:56841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56841/tests/kraken/driver.html?testName=ai-astar) 06:35:43 INFO - PROCESS | 29986 | RSS: Main: 166875136 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | __start_tp_report 06:35:43 INFO - PROCESS | 29986 | _x_x_mozilla_page_load 06:35:43 INFO - PROCESS | 29986 | _x_x_mozilla_page_load_details 06:35:43 INFO - PROCESS | 29986 | |i|pagename|runs| 06:35:43 INFO - PROCESS | 29986 | |0;ai-astar;112;116;107;114;115;114;107;115;115;113 06:35:43 INFO - PROCESS | 29986 | |1;audio-beat-detection;164;132;167;224;134;164;162;144;197;145 06:35:43 INFO - PROCESS | 29986 | |2;audio-dft;166;164;173;172;162;161;162;164;162;162 06:35:43 INFO - PROCESS | 29986 | |3;audio-fft;75;75;77;169;78;78;75;75;161;77 06:35:43 INFO - PROCESS | 29986 | |4;audio-oscillator;94;94;175;93;93;94;142;93;92;146 06:35:43 INFO - PROCESS | 29986 | |5;imaging-gaussian-blur;118;118;118;118;117;118;118;118;118;119 06:35:43 INFO - PROCESS | 29986 | |6;imaging-darkroom;149;148;147;149;147;147;149;148;148;148 06:35:43 INFO - PROCESS | 29986 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 06:35:43 INFO - PROCESS | 29986 | |8;json-parse-financial;68;69;68;68;68;67;69;67;68;67 06:35:43 INFO - PROCESS | 29986 | |9;json-stringify-tinderbox;64;65;65;64;64;65;64;64;65;65 06:35:43 INFO - PROCESS | 29986 | |10;stanford-crypto-aes;82;85;84;82;82;83;83;82;136;82 06:35:43 INFO - PROCESS | 29986 | |11;stanford-crypto-ccm;142;137;149;133;132;137;131;135;155;134 06:35:43 INFO - PROCESS | 29986 | |12;stanford-crypto-pbkdf2;175;180;181;175;174;177;177;180;180;174 06:35:43 INFO - PROCESS | 29986 | |13;stanford-crypto-sha256-iterative;71;71;73;69;72;70;70;68;68;70 06:35:43 INFO - PROCESS | 29986 | __end_tp_report 06:35:43 INFO - PROCESS | 29986 | __start_cc_report 06:35:43 INFO - PROCESS | 29986 | _x_x_mozilla_cycle_collect,932 06:35:43 INFO - PROCESS | 29986 | __end_cc_report 06:35:43 INFO - PROCESS | 29986 | __startTimestamp1462973743345__endTimestamp 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | ------- Summary: start ------- 06:35:43 INFO - PROCESS | 29986 | Number of tests: 14 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.50 stddev:3.26 (2.8%) stddev-sans-first:3.44 06:35:43 INFO - PROCESS | 29986 | Values: 112.0 116.0 107.0 114.0 115.0 114.0 107.0 115.0 115.0 113.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#1] audio-beat-detection Cycles:10 Average:163.30 Median:164.00 stddev:28.64 (17.5%) stddev-sans-first:30.38 06:35:43 INFO - PROCESS | 29986 | Values: 164.0 132.0 167.0 224.0 134.0 164.0 162.0 144.0 197.0 145.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:4.32 (2.6%) stddev-sans-first:4.56 06:35:43 INFO - PROCESS | 29986 | Values: 166.0 164.0 173.0 172.0 162.0 161.0 162.0 164.0 162.0 162.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.49 (49.3%) stddev-sans-first:39.13 06:35:43 INFO - PROCESS | 29986 | Values: 75.0 75.0 77.0 169.0 78.0 78.0 75.0 75.0 161.0 77.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:93.00 stddev:30.69 (33.0%) stddev-sans-first:31.89 06:35:43 INFO - PROCESS | 29986 | Values: 94.0 94.0 175.0 93.0 93.0 94.0 142.0 93.0 92.0 146.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:35:43 INFO - PROCESS | 29986 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 119.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 06:35:43 INFO - PROCESS | 29986 | Values: 149.0 148.0 147.0 149.0 147.0 147.0 149.0 148.0 148.0 148.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:35:43 INFO - PROCESS | 29986 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 06:35:43 INFO - PROCESS | 29986 | Values: 68.0 69.0 68.0 68.0 68.0 67.0 69.0 67.0 68.0 67.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 06:35:43 INFO - PROCESS | 29986 | Values: 64.0 65.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:82.50 stddev:16.86 (20.4%) stddev-sans-first:17.74 06:35:43 INFO - PROCESS | 29986 | Values: 82.0 85.0 84.0 82.0 82.0 83.0 83.0 82.0 136.0 82.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.00 stddev:7.89 (5.8%) stddev-sans-first:8.27 06:35:43 INFO - PROCESS | 29986 | Values: 142.0 137.0 149.0 133.0 132.0 137.0 131.0 135.0 155.0 134.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:178.50 stddev:2.75 (1.5%) stddev-sans-first:2.79 06:35:43 INFO - PROCESS | 29986 | Values: 175.0 180.0 181.0 175.0 174.0 177.0 177.0 180.0 180.0 174.0 06:35:43 INFO - PROCESS | 29986 | 06:35:43 INFO - PROCESS | 29986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.62 (2.3%) stddev-sans-first:1.69 06:35:43 INFO - PROCESS | 29986 | Values: 71.0 71.0 73.0 69.0 72.0 70.0 70.0 68.0 68.0 70.0 06:35:43 INFO - PROCESS | 29986 | -------- Summary: end -------- 06:35:43 INFO - PROCESS | 29986 | 06:35:44 INFO - TEST-INFO | 29986: exit 0 06:35:44 INFO - TEST-OK | kraken | took 64868ms 06:35:44 INFO - SUITE-END | took 1181s 06:35:44 INFO - Completed test suite (00:19:41) 06:35:44 INFO - javascript benchmark 06:35:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.603009548568, 2709.7561219490244, 2713.6336594559734, 2716.5789302658095, 2729.65879265092, 4720.976395118024, 4751.928721069183, 4773.379460670112, 4861.0, 4886.68236564623, 4688.71867687939, 4742.454617718963, 4757.6193904487645, 4803.3995750531185, 4819.469858315591, 4284.271673815451, 4369.650427965755, 4452.643788496913, 4477.082198149388, 4483.5964763171305, 651.5400851429183, 4286.592773686511, 4350.042990542076, 4404.581564751344, 4447.35513350564, 4433.800478978437, 4451.109778044404, 4479.932801007987, 4480.977595112036, 4488.506264310923, 4450.10997800438, 4459.888502787424, 4466.620337271336, 4476.395686582335, 4504.054148628792, 4310.504292006397, 4310.52584215736, 4312.892177695583, 4391.165678521071, 4407.691461597689, 4564.748938808364, 4638.141943740419, 4658.394408726844, 4661.906761864744, 4666.160091183586, 5072.239164125411, 5107.693538387672, 5116.053530096944, 5121.0, 5166.509181627739, 5092.159793634046, 5157.252198431206, 5161.66449180802, 5173.120569503193, 5225.399079105876, 4813.3983252093485, 4818.132736107465, 4828.46886842447, 4851.345068415719, 4883.926741098886, 5269.683818970874, 5283.471652834686, 5302.125149350391, 5349.0, 5374.785008599612, 5071.923921141186, 5084.516970887834, 5091.7963281469065, 5099.745012749348, 5104.515071068243, 5190.662606930538, 5192.428832828386, 5194.896102077937, 5212.661177023481, 5231.24146998683, 4944.90110197794, 5037.471065538139, 5059.316992206079, 5094.1849304111165, 5115.2071428928575, 5075.8984820303385, 5080.77136528857, 5085.491450854959, 5097.490250974873, 5159.303494028333, 4296.4414626098405, 4376.037271800199, 4392.1874453226255, 4401.537838526909, 4440.289553671461, 3777.8866634001024, 3787.3561494545993, 3813.406883319314, 3832.674222691047, 3857.4792403025795, 4318.892027699333, 4365.628921541705, 4391.231534481453, 4440.977795111004, 4463.553644635511, 5243.659162154524, 5257.973710131425, 5264.078786212397, 5265.842024739264, 5319.069162896478, 4275.679324050709, 4341.956580434218, 4382.298832186835, 4391.934120988188, 4412.139632771643, 4628.4445866496235, 4649.604783593432, 4658.417697787777, 4662.580367766917, 4687.226607609774, 4762.570809147526, 4768.4754676986195, 4811.446683631427, 4832.154372984784, 4866.659333846667, 5153.974230128825, 5197.8440646780655, 5207.218917162456, 5228.895422091461, 5238.214267859851, 4856.0, 4884.4382895966, 4887.144749668865, 4894.583960363409, 4942.481039490802, 5123.641345105807, 5137.691738495702, 5148.871278218075, 5157.742112894265, 5161.896762064813, 5249.527542521191, 5276.208568714724, 5280.102382594891, 5282.8943421132135, 5315.893682126413, 5103.92344114846, 5111.565516931102, 5125.2568377585785, 5135.563477104488, 5162.148245539444, 4987.0, 5081.415637201769, 5091.567216786467, 5100.872478187926, 5112.897742045213, 4998.475160108282, 5015.648904576645, 5020.723860187579, 5049.772760225872, 5099.949000509948, 5093.694378337312, 5160.225966104964, 5171.069207542679, 5173.379194496684, 5186.870328241824, 4757.952420475889, 4908.828191013297, 4942.92585611209, 4945.332380128781, 5003.899922001467], "value": 4708.52560725434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.3504851896062, 589.3634874335718, 609.0772479693264, 626.3611116661006, 638.6168299020591, 35331.29337413253, 39247.21505569891, 39478.802605987, 39487.0, 39499.60500394995, 38760.41859372105, 39326.0, 39534.0, 39797.0, 39807.80096099523, 7802.141764405925, 7982.161873003338, 7984.960075199616, 7989.880151797699, 7998.040235171788, 7885.014373203349, 7909.604519774017, 7984.840303193932, 7987.640556174986, 8002.559859207741, 7954.880676789853, 7966.482178658398, 8017.238362355567, 8027.518348899055, 8028.759137225892, 7920.762377128666, 7944.0467143942515, 7968.163342849004, 7980.2817746402525, 7995.240452157036, 7804.921950780533, 7818.6090695465, 7870.606469676493, 7883.36933045355, 7890.723824666109, 30587.23531911698, 37806.81096594499, 37976.0, 38135.427968580494, 38170.80914595437, 3237.5791147150953, 3256.0, 3277.246233366315, 3360.24394511233, 3381.7801842880135, 27929.162125136278, 28518.28704282389, 28685.85657071722, 30013.849930750424, 32275.19312017218, 3138.59198304219, 3185.8725650973934, 3196.53650220719, 3300.290437555913, 3309.751768617339, 237547.0, 246293.0, 247200.0, 247445.9999999982, 247704.0, 30702.232444188627, 31719.841400792848, 31725.841370792998, 31735.206619834687, 59828.40171598228, 37017.81491092581, 37022.44466333007, 37099.25801483955, 37252.62747372492, 37255.62744372576, 13203.273819939803, 13206.603801885958, 13208.075434719669, 13228.933855330853, 13245.403956821967, 10417.635382761568, 10528.894711052944, 10586.629467968738, 10803.973622506006, 10817.242793004414, 8589.78525536854, 8607.65569377218, 8631.309495240366, 8668.479891206547, 8712.303015758724, 3378.172347774762, 3404.0, 3419.5383623210546, 3425.2122011937395, 3466.618671946084, 861.801785589318, 951.7953639967441, 975.3124047546463, 976.1751320134617, 1008.8234558952154, 28127.0, 28356.291092722848, 29152.562711559345, 29234.269143271587, 29275.560866587017, 990.2276224544867, 991.3457118301886, 1025.0723095598496, 1091.912646988239, 1099.378850949211, 15100.622484437758, 15485.148316842682, 15487.148206848731, 15540.689186216212, 15915.442959496593, 353294.0, 353334.0, 358227.0443238888, 359389.0, 360603.0, 49167.26249106266, 50424.747876260386, 50659.24011139836, 50857.49142508602, 50929.0, 1258.6979125009932, 1265.1144199060695, 1285.2673975833873, 1306.725587626609, 1307.2809954524973, 27412.72587274102, 28016.159515214575, 28432.43135137327, 28561.0, 28807.27981800388, 42474.0, 42985.3552196711, 43132.78433607812, 43177.56822431736, 43306.13387732291, 291001.0, 294324.0, 295323.0, 295428.0, 296134.0, 26216.606750899133, 26707.7329226713, 26720.0, 26736.732632674204, 26757.464850702487, 40836.183276333715, 42291.788541057096, 42312.36531451969, 43259.0, 43537.56462435462, 36355.63644363522, 36656.45015324719, 36846.0, 36886.26227475489, 36995.630043700294, 35737.64262357447, 36211.0, 36219.63780362268, 36624.81687591545, 37051.0, 32542.51186232161, 36420.27159456849, 37581.24837503289, 37595.436068458446, 38271.234575308896, 32430.0, 33339.33321333608, 33534.32931341311, 33820.0, 33963.15092122717, 25581.23256302314, 25759.484810303315, 25908.352291192117, 26082.86958565195, 26276.868615657564], "value": 16593.093929313753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.5736689641394, 388.58033324010074, 391.4832421204012, 396.4984294866993, 409.9549049604543, 16070.83929160708, 17294.406951282188, 17316.393926212586, 17403.91298043511, 17461.3015479381, 13853.93073034636, 16016.519504414886, 16786.244618992143, 16806.15969201541, 16966.660666786687, 5071.1632580624155, 5243.6853788772605, 5267.736613169345, 5269.446708095652, 5269.841904742864, 4959.528844759742, 5143.5113664201845, 5147.047796157704, 5186.818461353853, 5213.035588416155, 5146.665466744668, 5154.587632989352, 5182.041322355358, 5185.118529849916, 5204.713740744258, 4956.603471722254, 5131.589472842164, 5157.819476318329, 5161.638685292031, 5178.559822415118, 4480.19356515827, 4507.5717806808625, 4516.616087632555, 4550.522195169526, 4559.794809233593, 20182.091805868626, 20205.797942020537, 20438.89780551088, 20974.475638109016, 21017.68473472899, 2044.5195379085903, 2102.6005059038885, 2111.5565731196466, 2331.265651319829, 2422.200673777649, 13237.271950042743, 13595.060694016382, 13660.726785464236, 13760.724785504233, 13973.650658733512, 1800.3878681248307, 1817.6273863857878, 1824.352354914013, 1839.3102586530051, 1856.8514518838595, 66818.66590667015, 69228.6538567309, 69883.0, 70986.29013709849, 71462.64268678676, 9675.806483870283, 9840.803183936281, 9985.999999999854, 9999.700008999742, 10048.246381521416, 13838.584842454742, 13877.791833122512, 13886.097403668931, 13943.58169254924, 14154.858451415354, 6414.0, 6715.227748808852, 7182.066331376887, 7197.784066478014, 7229.132504099542, 6884.277150899084, 6961.338672826073, 7029.859402811915, 7150.606716630531, 7185.137783466018, 5983.282006159202, 6143.56995010345, 6299.937000629935, 6311.463525600284, 6373.681315934185, 1690.191495100231, 1717.5362652084118, 1719.3693648717483, 1733.1680793219325, 1794.1567463292492, 874.580201503282, 898.1333013641867, 901.8511945529045, 972.844344904826, 1048.5858086056119, 16497.257623406975, 17471.737923931152, 17565.20956556958, 17746.20142093609, 18008.549786255448, 857.6055014693186, 928.331601247101, 929.1080562659787, 933.9766505837408, 1008.3596915958419, 9358.11097945694, 9404.811903761887, 9489.003654616305, 9630.036996300314, 9681.0, 379955.0, 420272.0, 426600.0, 438031.0, 440161.0, 83212.0, 87363.56318218369, 87781.56109219413, 87947.56026219956, 88342.11657883467, 925.1812146250617, 947.7677968897526, 949.0983565612696, 965.2133511188359, 975.9707208783606, 15521.534353969399, 15618.687626247638, 15651.765223521885, 15694.21528923572, 15996.920015399848, 35731.821340893126, 36852.447213291285, 37077.99999999892, 37129.25741485101, 37508.812455938634, 47747.0, 50651.0, 51714.74142629413, 53204.73397632987, 53408.1988770161, 7668.194839541768, 7678.308952194329, 7762.61186940662, 7806.960965195138, 7972.123066462568, 10905.672829815117, 10966.670999870017, 11296.661100167008, 11359.54561817518, 11518.481668325114, 10053.19574434029, 10203.59185632596, 10333.431661258403, 10399.428031458343, 10569.0, 4587.931181032354, 6737.921932490778, 8933.865992009994, 10492.685219443123, 10581.36511809294, 10474.0, 10612.893871061191, 10680.679579612624, 10805.621803237163, 10806.837897431702, 7813.492123011986, 7903.407244456804, 7957.482763620346, 8024.197580241929, 8086.3126634234395, 8164.7550573482895, 9733.9026609733, 9877.506124693593, 10514.526846291783, 10695.89304106949], "value": 8398.930531741144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.2950707428122, 1559.2281820498852, 1780.786305643323, 1889.3859495663912, 1909.4271718484451, 6812.046313516112, 7374.225706300828, 7630.4658673892845, 8212.0, 8219.54792486413, 7448.739294124707, 7711.768646940587, 7762.96118519408, 7768.68925242991, 7784.377249820015, 2174.1738139506965, 2209.436593668612, 2210.9005094770773, 2213.4908970936694, 2214.723159605049, 2185.25701261571, 2193.3858519614455, 2196.2971849008322, 2218.3566765638025, 2221.311393468022, 2150.8817015064164, 2152.967705484419, 2157.514559224178, 2160.7299087614047, 2187.2344679362177, 2039.7144399783895, 2050.2209160519055, 2050.589882023594, 2053.404512691318, 2060.0, 2057.763357213925, 2091.7908209179113, 2134.6691262854283, 2157.600843843894, 2157.8273738100916, 7630.923690763132, 7691.576963267018, 7761.22387761225, 7765.611719414007, 7765.611719414063, 4731.455882573479, 4784.593309568656, 4827.831025914112, 4855.101806165835, 4856.708597484162, 2807.8174918630225, 2870.3111253299267, 2900.2459360566195, 2922.8976985805607, 2925.093221101465, 877.578762194144, 906.4380084347681, 913.109718024927, 918.0773322810533, 927.1238679447924, 10394.376337419779, 10407.063364297173, 10420.0, 10468.214883883664, 10512.526936287886, 4378.8905277367685, 4381.990760683878, 4445.711028783118, 4574.794134263966, 4616.884577885513, 8282.627281772335, 8294.958525207456, 8314.667413303521, 8315.0, 8331.66673333072, 4680.5085466025575, 4711.199096153662, 4722.268048452495, 4728.527147285244, 4730.905381892343, 3687.9631203688155, 4245.27830268855, 4382.517923028464, 4384.473863136444, 4409.845655402046, 3483.7387195959896, 3540.13266749648, 3548.4499902514635, 3561.056320075182, 3616.6744992950235, 1029.4749677664445, 1050.2963014780116, 1050.8686414198226, 1055.1664185293685, 1078.4176544665793, 822.9795054132832, 845.3617518773286, 888.3515034025198, 928.7445952363154, 935.8081593273363, 5533.3083364579425, 5560.0, 5565.916511252334, 5632.774689012475, 5666.263385759825, 921.5622579274791, 939.2110627073155, 965.0976337124811, 990.094063931509, 996.7757254617798, 3673.200131935386, 3760.816067317635, 3811.2377524495214, 3828.559715632738, 3881.262560113569, 9314.34799564024, 9887.950560247153, 9894.109530142321, 9976.900230997597, 10000.299979001546, 9631.229501639851, 9808.509574521246, 9854.704358869245, 9913.752156196153, 9941.751456213507, 7463.179050304462, 7601.049868766404, 7603.391728661693, 7636.427267954926, 7675.692972281158, 5323.30796996388, 5452.536534394462, 5529.30883639545, 5541.418151094238, 5573.21974923503, 8380.497170169809, 8585.012723536624, 8689.782755431164, 8716.43343182691, 8732.039475657799, 8758.299336053227, 8882.467051976902, 8885.555722213734, 8977.955110224408, 9111.635534578543, 5934.169216309807, 6799.728010879708, 6951.27011663768, 7039.6832142552685, 7095.680694368869, 7766.417518686008, 7794.376449884109, 7846.136924938138, 7868.685252590061, 7887.211278872067, 6991.405730512964, 7154.284571542804, 7195.13658361, 7271.563706177646, 7290.9635451822405, 6785.932140678728, 6869.725210991504, 6926.8614627708175, 6951.548149370275, 6993.0908981832035, 6556.311587283267, 6651.0023496475915, 6733.0, 6764.830879227862, 6783.491238157059, 4701.365315682339, 4794.113089078532, 4826.0, 4835.492273311252, 4872.196087645499, 4856.927146092882, 4900.8774780630765, 4914.852554423373, 4954.752262386794, 4968.428630707371], "value": 4213.078060166606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.4269010225624, 309.92561785171563, 317.99682003179964, 327.4433463112708, 328.88507958022296, 4817.915968906994, 4882.340883980662, 4981.950180498194, 5010.198368261079, 5029.999999999995, 4932.704037757737, 4942.110420124376, 4952.504749525055, 4953.588227355204, 4967.254911763237, 3918.04008018036, 3930.567637559866, 3932.193900250456, 3939.8621048263317, 3946.5461471930807, 3634.436662317345, 3953.268645300614, 3953.5255769307723, 3953.8023098845088, 3955.683545316382, 3800.429935509668, 3817.503724515823, 3827.655511004009, 3829.138443850139, 3834.0, 3822.9044273893096, 3828.540575130988, 3838.9232215355537, 3845.9807700961596, 3867.7292589518743, 3396.6073909696906, 3413.8975830725117, 3425.9143521411916, 3434.86649405698, 3438.157651375429, 4701.0, 4768.284757286435, 4778.331033655291, 4819.662623616348, 4879.682485728868, 4384.846530371454, 4387.561243875587, 4403.581659742319, 4405.537418571036, 4412.8156562501445, 5161.716105614228, 5170.327857378555, 5173.715445650488, 5173.784160722227, 5209.244659524347, 3611.422172452395, 3662.01765932587, 3686.7972261525606, 3712.6472985066644, 3726.29200451916, 5413.160960051159, 5432.266644003088, 5434.782608695687, 5449.8827740313145, 5458.153986132195, 3753.155540003477, 3764.6235376462682, 3771.849585876334, 3773.0570155278924, 3781.1303400217553, 3799.677027452642, 3808.676262517717, 3810.5998870118237, 3815.828287727059, 3816.542014958223, 4187.204431158131, 4401.22978478765, 4439.711418757771, 4453.643708503312, 4457.910841783211, 5301.4168441472175, 5302.568306557285, 5304.787808487695, 5308.805518758249, 5312.601554883322, 1266.322517453158, 1316.7037416581193, 1346.3537501999094, 1348.2719331561043, 1353.9526116585873, 845.7758693946109, 853.7396094191207, 857.2284943550854, 861.4099341950783, 872.1496540872726, 4030.375291829771, 4042.1406153169874, 4059.289624315733, 4084.7133153056693, 4101.159262351211, 4689.343491911135, 4702.553257440538, 4711.411073615798, 4744.572988431058, 4763.309320148559, 3942.5466071401584, 4039.8688367257214, 4076.2255171517318, 4080.224757296104, 4106.219818234586, 2533.6959564852336, 2685.3485106659264, 2892.840893750864, 2916.3729798093086, 2922.0211229238016, 5060.3927528696795, 5070.366204224472, 5090.669106508065, 5106.846794596168, 5118.744062796845, 5377.166539186433, 5524.66851988882, 5526.253955715927, 5550.389457159709, 5558.221848941152, 5044.949550504448, 5066.771995260222, 5068.974655126701, 5081.18701007837, 5083.237514372874, 5379.35447746273, 5398.865028374165, 5413.675179489243, 5428.945710542844, 5440.374356949002, 5066.417362003417, 5279.076161671615, 5308.867278318073, 5319.813806516753, 5337.092694242066, 4999.775010124626, 5021.171506701354, 5027.321311622884, 5041.017001684636, 5075.502726695559, 3786.261678972574, 3828.578856325746, 3835.328817456878, 3842.4044273137706, 3846.2692088503095, 5214.426413094632, 5329.1206950852675, 5351.277577526984, 5375.489328513785, 5407.648502847303, 5079.780852595424, 5162.225666150108, 5176.948230517797, 5178.042062218502, 5188.377394712507, 5086.872828179326, 5091.0, 5120.02719483297, 5121.436641969306, 5127.4872512748425, 4931.556159945622, 5071.315372424676, 5088.7201203932655, 5129.538081646713, 5136.691798492103, 5233.712145831863, 5246.790128394821, 5251.921221181609, 5258.1849813279005, 5271.367435907716, 5112.514311140436, 5129.512696293846, 5139.794408223629, 5148.279240906201, 5156.639035267645], "value": 3882.669682027912, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2079271216238, 775.9379249660028, 785.7407055671628, 819.5164852736884, 832.4880198677815, 12768.42542085606, 13039.999999999987, 13088.803667944989, 13131.606051818437, 13192.604221873347, 14037.78943315851, 14058.734713875749, 14120.0, 14148.504802331894, 14193.361298741556, 654.7348323928817, 844.6283635200523, 875.2735229759285, 884.0452311503593, 886.0297973718767, 858.4076986879033, 859.3855393393723, 861.0399404663817, 862.2886118951858, 864.1315477944656, 913.1735779119907, 913.4930113786845, 915.4598786715836, 915.771057235691, 917.5870858113842, 899.7345782994032, 899.9910000899972, 904.2810965282616, 905.7826121730803, 906.3338446242007, 672.2269390201259, 672.6737532296833, 673.8719643267764, 674.4739103499278, 675.3651567526558, 12453.813192802116, 12455.377231138407, 12463.314517701523, 12474.43865026076, 12499.312537810416, 12133.817992730028, 12591.181573197713, 12623.431945562472, 12743.235405875677, 12758.68103297425, 10062.144717699004, 10636.46817659114, 10646.840297395545, 10702.839457408145, 11136.220464567483, 3357.429237029686, 3377.983110084434, 3403.4554471284478, 3414.197663549064, 3419.6409377015552, 45060.0, 45062.774686126686, 45113.0, 45618.77190614059, 45868.0, 10091.142252908438, 10121.0, 10125.898741012496, 10262.281640285257, 10482.10902073317, 17372.218250178772, 17407.65184696299, 17600.383986560664, 17621.823781762276, 17630.2066407012, 6634.203895532567, 6724.562903411263, 6905.136857892763, 6929.930700692928, 6937.479689023344, 3635.517811364837, 3638.290533346025, 3672.779633222015, 3685.870994515179, 3759.285735710206, 2830.6037154798346, 2934.7652187824924, 2954.852257387122, 2960.8223506589675, 2994.2364697002126, 528.5269683633204, 529.2616799564586, 532.7469452010341, 536.804066515719, 540.95672346213, 594.1533315026071, 614.7909710698384, 616.4852348289229, 616.6485103490967, 620.5314987184647, 8162.14297498766, 8189.385796065319, 8218.301444377175, 8233.46482478637, 8249.0, 527.3724268121, 537.247853005795, 543.3859738495554, 549.9862503437366, 635.3487675132933, 3916.4321173429694, 3920.725549211585, 3972.6424621784176, 3999.1601763629383, 4093.467849179647, 48209.0, 49416.752916235186, 50602.49397506051, 50628.49371506238, 50648.49351506438, 43750.562494375285, 44665.330020049725, 46292.0, 46301.30548041782, 46967.76516117398, 38891.416628750594, 41122.38316425256, 42377.57622423736, 43042.0, 43217.35173972393, 7892.802679933047, 8162.224588664068, 8224.218699223564, 8386.0, 8644.22202001823, 29421.85289073541, 29449.85275073611, 29486.705132948395, 30407.391852163277, 30715.69284307218, 36751.26497470089, 36897.07757305982, 36976.81511592425, 37046.44430333601, 37265.44101838529, 10623.89376106229, 10746.408947507962, 10844.728881778019, 11006.889931100586, 11066.778664426505, 11907.166498345032, 12063.276203427822, 12331.136820422484, 12439.129260951646, 12977.156484828456, 11070.169737269576, 11229.606963756229, 11318.26431281964, 11466.82799758021, 12323.69190770238, 10725.088367488539, 11024.559017639205, 11071.335719856834, 12084.154109212272, 12091.637250882135, 10578.312409693654, 10862.891371086187, 10904.945475272572, 11301.378424186749, 11657.825132622847, 7708.730194443167, 7725.129573664248, 7805.0, 8075.515469071875, 8263.0, 8105.311048560939, 8146.796330091558, 8189.549574773445, 8330.791730206793, 8459.746207613782], "value": 6036.900609427633, "unit": "score"}], "name": "dromaeo_css", "value": 6337.7876573871645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 107.0, 114.0, 115.0, 114.0, 107.0, 115.0, 115.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 167.0, 224.0, 134.0, 164.0, 162.0, 144.0, 197.0, 145.0], "value": 163.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 173.0, 172.0, 162.0, 161.0, 162.0, 164.0, 162.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 169.0, 78.0, 78.0, 75.0, 75.0, 161.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 175.0, 93.0, 93.0, 94.0, 142.0, 93.0, 92.0, 146.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 147.0, 147.0, 149.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 67.0, 69.0, 67.0, 68.0, 67.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 84.0, 82.0, 82.0, 83.0, 83.0, 82.0, 136.0, 82.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 149.0, 133.0, 132.0, 137.0, 131.0, 135.0, 155.0, 134.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 180.0, 181.0, 175.0, 174.0, 177.0, 177.0, 180.0, 180.0, 174.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 69.0, 72.0, 70.0, 70.0, 68.0, 68.0, 70.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1614.0, "alertThreshold": 2.0}]} 06:35:44 INFO - Return code: 0 06:35:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:35:44 ERROR - # TBPL SUCCESS # 06:35:44 INFO - Running post-action listener: _resource_record_post_action 06:35:44 INFO - ##### 06:35:44 INFO - ##### Finished run-tests step (success) 06:35:44 INFO - ##### 06:35:44 INFO - Running post-run listener: _resource_record_post_run 06:35:45 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531062784; Read time: 12; Write time: 479456 06:35:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234868736; Read time: 0; Write time: 251440 06:35:45 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296194048; Read time: 12; Write time: 228016 06:35:45 INFO - Running post-run listener: _upload_blobber_files 06:35:45 INFO - Blob upload gear active. 06:35:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:45 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 06:35:45 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'] 06:35:45 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 06:35:46 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:46 INFO - (blobuploader) - INFO - Done attempting. 06:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:47 INFO - (blobuploader) - INFO - Done attempting. 06:35:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:47 INFO - Return code: 0 06:35:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12f805e44a009a99c40f60ef2c9e817eff55a29401855c10f5dcde4ed0d435c50113c30ac5a3c8aba96de664b88ad3426d7149919658fdb5c3f0c6ee0c740291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2329c13b73f4f7eb424f76ac7f70c8ca946cb6507b832b1d23a50d9896ed2aa72527494d8b12bf8e1d8a83d5c0f699e457ba8d727792476dc790339d23b6cd3"} 06:35:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:47 INFO - Contents: 06:35:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12f805e44a009a99c40f60ef2c9e817eff55a29401855c10f5dcde4ed0d435c50113c30ac5a3c8aba96de664b88ad3426d7149919658fdb5c3f0c6ee0c740291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2329c13b73f4f7eb424f76ac7f70c8ca946cb6507b832b1d23a50d9896ed2aa72527494d8b12bf8e1d8a83d5c0f699e457ba8d727792476dc790339d23b6cd3"} 06:35:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:47 INFO - Copying logs to upload dir... 06:35:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.283747 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-11 06:35:47.738556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 06:35:47.741835) ========= 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=32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12f805e44a009a99c40f60ef2c9e817eff55a29401855c10f5dcde4ed0d435c50113c30ac5a3c8aba96de664b88ad3426d7149919658fdb5c3f0c6ee0c740291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2329c13b73f4f7eb424f76ac7f70c8ca946cb6507b832b1d23a50d9896ed2aa72527494d8b12bf8e1d8a83d5c0f699e457ba8d727792476dc790339d23b6cd3"} build_url:https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12f805e44a009a99c40f60ef2c9e817eff55a29401855c10f5dcde4ed0d435c50113c30ac5a3c8aba96de664b88ad3426d7149919658fdb5c3f0c6ee0c740291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2329c13b73f4f7eb424f76ac7f70c8ca946cb6507b832b1d23a50d9896ed2aa72527494d8b12bf8e1d8a83d5c0f699e457ba8d727792476dc790339d23b6cd3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 06:35:47.766071) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:35:47.766387) ========= 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=32c5991c409366f7fec8a718000001d2-1462972510.65430-1988745242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:35:47.853795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 06:35:47.854096) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 06:35:47.854389) ========= ========= Total master_lag: 0.18 =========