builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0363 starttime: 1464626149.08 results: success (0) buildid: 20160530064349 builduid: 2ffdc8a934f44a749eb2490bfaed357e revision: f84a95dce3aaaec51ccaf98398eed74f41e30245 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.084191) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.084693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.085010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.115505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.115957) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3TLMtuJZlk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-30 09:35:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-05-30 09:35:49 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.227997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.228378) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3TLMtuJZlk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025171 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:49.277826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 09:35:49.278221) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f84a95dce3aaaec51ccaf98398eed74f41e30245 --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 f84a95dce3aaaec51ccaf98398eed74f41e30245 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3TLMtuJZlk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-30 09:35:49,363 truncating revision to first 12 chars 2016-05-30 09:35:49,363 Setting DEBUG logging. 2016-05-30 09:35:49,363 attempt 1/10 2016-05-30 09:35:49,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f84a95dce3aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 09:35:50,542 unpacking tar archive at: fx-team-f84a95dce3aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.454877 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 09:35:50.766428) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:50.768540) ========= script_repo_revision: f84a95dce3aaaec51ccaf98398eed74f41e30245 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:50.769182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:50.769582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 09:35:50.787949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-30 09:35:50.788528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3TLMtuJZlk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:35:50 INFO - MultiFileLogger online at 20160530 09:35:50 in /builds/slave/test 09:35:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:35:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:50 INFO - {'append_to_log': False, 09:35:50 INFO - 'base_work_dir': '/builds/slave/test', 09:35:50 INFO - 'blob_upload_branch': 'Fx-Team', 09:35:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:50 INFO - 'branch': 'Fx-Team', 09:35:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:50 INFO - 'config_files': ('talos/mac_config.py',), 09:35:50 INFO - 'default_actions': ('clobber', 09:35:50 INFO - 'read-buildbot-config', 09:35:50 INFO - 'download-and-extract', 09:35:50 INFO - 'populate-webroot', 09:35:50 INFO - 'create-virtualenv', 09:35:50 INFO - 'install', 09:35:50 INFO - 'run-tests'), 09:35:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:50 INFO - 'download_minidump_stackwalk': True, 09:35:50 INFO - 'download_symbols': 'ondemand', 09:35:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:50 INFO - 'installer_path': 'installer.exe', 09:35:50 INFO - 'log_level': 'info', 09:35:50 INFO - 'log_name': 'talos', 09:35:50 INFO - 'log_to_console': True, 09:35:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:35:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:35:50 INFO - 'opt_config_files': (), 09:35:50 INFO - 'pip_index': False, 09:35:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:35:50 INFO - 'cmd': ('bash', 09:35:50 INFO - '-c', 09:35:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:35:50 INFO - 'enabled': True, 09:35:50 INFO - 'halt_on_failure': False, 09:35:50 INFO - 'name': 'check_screen_resolution'},), 09:35:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:35:50 INFO - 'cmd': ('bash', 09:35:50 INFO - '-c', 09:35:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:35:50 INFO - 'enabled': True, 09:35:50 INFO - 'halt_on_failure': False, 09:35:50 INFO - 'name': 'check_screen_resolution'},), 09:35:50 INFO - 'run_cmd_checks_enabled': True, 09:35:50 INFO - 'sps_profile': False, 09:35:50 INFO - 'sps_profile_interval': 0, 09:35:50 INFO - 'suite': 'dromaeojs-e10s', 09:35:50 INFO - 'system_bits': '32', 09:35:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:50 INFO - 'title': 't-yosemite-r7-0363', 09:35:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:50 INFO - 'use_talos_json': True, 09:35:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:50 INFO - 'work_dir': 'build'} 09:35:50 INFO - ##### 09:35:50 INFO - ##### Running clobber step. 09:35:50 INFO - ##### 09:35:50 INFO - Running pre-action listener: _resource_record_pre_action 09:35:50 INFO - Running main action method: clobber 09:35:50 INFO - rmtree: /builds/slave/test/build 09:35:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:52 INFO - Running post-action listener: _resource_record_post_action 09:35:52 INFO - ##### 09:35:52 INFO - ##### Finished clobber step (success) 09:35:52 INFO - ##### 09:35:52 INFO - ##### 09:35:52 INFO - ##### Running read-buildbot-config step. 09:35:52 INFO - ##### 09:35:52 INFO - Running pre-action listener: _resource_record_pre_action 09:35:52 INFO - Running main action method: read_buildbot_config 09:35:52 INFO - Using buildbot properties: 09:35:52 INFO - { 09:35:52 INFO - "project": "", 09:35:52 INFO - "product": "firefox", 09:35:52 INFO - "script_repo_revision": "production", 09:35:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:35:52 INFO - "repository": "", 09:35:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:35:52 INFO - "buildid": "20160530064349", 09:35:52 INFO - "pgo_build": "False", 09:35:52 INFO - "basedir": "/builds/slave/test", 09:35:52 INFO - "buildnumber": 689, 09:35:52 INFO - "slavename": "t-yosemite-r7-0363", 09:35:52 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:35:52 INFO - "platform": "yosemite_r7", 09:35:52 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:35:52 INFO - "branch": "fx-team", 09:35:52 INFO - "repo_path": "integration/fx-team", 09:35:52 INFO - "revision": "f84a95dce3aaaec51ccaf98398eed74f41e30245", 09:35:52 INFO - "stage_platform": "macosx64", 09:35:52 INFO - "builduid": "2ffdc8a934f44a749eb2490bfaed357e", 09:35:52 INFO - "slavebuilddir": "test" 09:35:52 INFO - } 09:35:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 09:35:52 INFO - Running post-action listener: _resource_record_post_action 09:35:52 INFO - ##### 09:35:52 INFO - ##### Finished read-buildbot-config step (success) 09:35:52 INFO - ##### 09:35:52 INFO - ##### 09:35:52 INFO - ##### Running download-and-extract step. 09:35:52 INFO - ##### 09:35:52 INFO - Running pre-action listener: _resource_record_pre_action 09:35:52 INFO - Running main action method: download_and_extract 09:35:52 INFO - mkdir: /builds/slave/test/build/tests 09:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:52 INFO - https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:35:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 09:35:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 09:35:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 09:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 09:35:53 INFO - Downloaded 1199 bytes. 09:35:53 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 09:35:53 INFO - Using the following test package requirements: 09:35:53 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 09:35:53 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 09:35:53 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 09:35:53 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'jsshell-mac.zip'], 09:35:53 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 09:35:53 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 09:35:53 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 09:35:53 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 09:35:53 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 09:35:53 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:35:53 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 09:35:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:53 INFO - https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:35:55 INFO - Downloaded 18684808 bytes. 09:35:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:35:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:35:58 INFO - Return code: 0 09:35:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:35:58 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')]} 09:35:58 INFO - https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:35:59 INFO - Downloaded 18684808 bytes. 09:35:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:35:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:36:02 INFO - Return code: 0 09:36:02 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')]} 09:36:02 INFO - https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:36:04 INFO - Downloaded 10834055 bytes. 09:36:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:36:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:36:04 INFO - Return code: 0 09:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:04 INFO - https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:36:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:36:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:36:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 09:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 09:36:07 INFO - Downloaded 110902122 bytes. 09:36:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:36:07 INFO - mkdir: /builds/slave/test/properties 09:36:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:07 INFO - Contents: 09:36:07 INFO - build_url:https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:36:08 INFO - Running post-action listener: _resource_record_post_action 09:36:08 INFO - Running post-action listener: set_extra_try_arguments 09:36:08 INFO - ##### 09:36:08 INFO - ##### Finished download-and-extract step (success) 09:36:08 INFO - ##### 09:36:08 INFO - ##### 09:36:08 INFO - ##### Running populate-webroot step. 09:36:08 INFO - ##### 09:36:08 INFO - Running pre-action listener: _resource_record_pre_action 09:36:08 INFO - Running main action method: populate_webroot 09:36:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:08 INFO - '--tppagecycles', 09:36:08 INFO - '7'], 09:36:08 INFO - 'tests': ['tsvgm']}}, 09:36:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:36:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:36:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['damp', 'tps']}, 09:36:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'tests': ['damp', 'tps']}, 09:36:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['dromaeo_dom']}, 09:36:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['a11yr', 09:36:08 INFO - 'ts_paint', 09:36:08 INFO - 'tpaint', 09:36:08 INFO - 'sessionrestore', 09:36:08 INFO - 'sessionrestore_no_auto_restore', 09:36:08 INFO - 'tabpaint']}, 09:36:08 INFO - 'other-e10s': {'tests': ['a11yr', 09:36:08 INFO - 'ts_paint', 09:36:08 INFO - 'tpaint', 09:36:08 INFO - 'sessionrestore', 09:36:08 INFO - 'sessionrestore_no_auto_restore', 09:36:08 INFO - 'tabpaint']}, 09:36:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:36:08 INFO - 'ts_paint', 09:36:08 INFO - 'tpaint', 09:36:08 INFO - 'sessionrestore', 09:36:08 INFO - 'sessionrestore_no_auto_restore', 09:36:08 INFO - 'tabpaint']}, 09:36:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:36:08 INFO - 'ts_paint', 09:36:08 INFO - 'tpaint', 09:36:08 INFO - 'sessionrestore', 09:36:08 INFO - 'sessionrestore_no_auto_restore', 09:36:08 INFO - 'tabpaint']}, 09:36:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['a11yr', 09:36:08 INFO - 'ts_paint', 09:36:08 INFO - 'tpaint', 09:36:08 INFO - 'sessionrestore', 09:36:08 INFO - 'sessionrestore_no_auto_restore', 09:36:08 INFO - 'tabpaint']}, 09:36:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['a11yr', 09:36:08 INFO - 'ts_paint', 09:36:08 INFO - 'tpaint', 09:36:08 INFO - 'sessionrestore', 09:36:08 INFO - 'sessionrestore_no_auto_restore', 09:36:08 INFO - 'tabpaint']}, 09:36:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['tsvgx', 09:36:08 INFO - 'tsvgr_opacity', 09:36:08 INFO - 'tart', 09:36:08 INFO - 'tscrollx', 09:36:08 INFO - 'cart']}, 09:36:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:36:08 INFO - 'tsvgr_opacity', 09:36:08 INFO - 'tart', 09:36:08 INFO - 'tscrollx', 09:36:08 INFO - 'cart']}, 09:36:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'talos_options': ['--disable-e10s'], 09:36:08 INFO - 'tests': ['tp5o']}, 09:36:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'tests': ['tp5o']}, 09:36:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'talos_options': ['--disable-e10s', 09:36:08 INFO - '--xperf_path', 09:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:08 INFO - 'tests': ['tp5n']}, 09:36:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:08 INFO - 'talos_options': ['--xperf_path', 09:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:08 INFO - 'tests': ['tp5n']}}, 09:36:08 INFO - 'talos.zip': {'path': '', 09:36:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:08 INFO - Running post-action listener: _resource_record_post_action 09:36:08 INFO - ##### 09:36:08 INFO - ##### Finished populate-webroot step (success) 09:36:08 INFO - ##### 09:36:08 INFO - ##### 09:36:08 INFO - ##### Running create-virtualenv step. 09:36:08 INFO - ##### 09:36:08 INFO - Running pre-action listener: _resource_record_pre_action 09:36:08 INFO - Running main action method: create_virtualenv 09:36:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:08 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 09:36:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:08 INFO - Using real prefix '/tools/python27' 09:36:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:12 INFO - Installing pip.................done. 09:36:12 INFO - Return code: 0 09:36:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:12 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 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:12 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 09:36:12 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 09:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:12 INFO - 'HOME': '/Users/cltbld', 09:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:12 INFO - 'LOGNAME': 'cltbld', 09:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:12 INFO - 'MOZ_NO_REMOTE': '1', 09:36:12 INFO - 'NO_EM_RESTART': '1', 09:36:12 INFO - 'PAGER': '/bin/cat', 09:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:12 INFO - 'PWD': '/builds/slave/test', 09:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:12 INFO - 'SHELL': '/bin/bash', 09:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:12 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:12 INFO - 'USER': 'cltbld', 09:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:12 INFO - 'XPC_FLAGS': '0x0', 09:36:12 INFO - 'XPC_SERVICE_NAME': '0', 09:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:12 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 09:36:12 INFO - Cleaning up... 09:36:12 INFO - Return code: 0 09:36:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:12 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:12 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>=3.1.1'] in /builds/slave/test/build 09:36:12 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>=3.1.1 09:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:12 INFO - 'HOME': '/Users/cltbld', 09:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:12 INFO - 'LOGNAME': 'cltbld', 09:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:12 INFO - 'MOZ_NO_REMOTE': '1', 09:36:12 INFO - 'NO_EM_RESTART': '1', 09:36:12 INFO - 'PAGER': '/bin/cat', 09:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:12 INFO - 'PWD': '/builds/slave/test', 09:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:12 INFO - 'SHELL': '/bin/bash', 09:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:12 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:12 INFO - 'USER': 'cltbld', 09:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:12 INFO - 'XPC_FLAGS': '0x0', 09:36:12 INFO - 'XPC_SERVICE_NAME': '0', 09:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:12 INFO - Downloading/unpacking psutil>=3.1.1 09:36:12 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 09:36:12 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 09:36:12 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 09:36:12 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 09:36:12 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 09:36:12 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 09:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:15 INFO - Installing collected packages: psutil 09:36:15 INFO - Running setup.py install for psutil 09:36:15 INFO - building 'psutil._psutil_osx' extension 09:36:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:36:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:36:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:36:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:36:16 INFO - building 'psutil._psutil_posix' extension 09:36:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:36:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:36:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:36:16 INFO - ^ 09:36:16 INFO - 1 warning generated. 09:36:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:36:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:16 INFO - Successfully installed psutil 09:36:16 INFO - Cleaning up... 09:36:16 INFO - Return code: 0 09:36:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:36:16 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')]} 09:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:16 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')]} 09:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:16 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:16 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.3'] in /builds/slave/test/build 09:36:16 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.3 09:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:16 INFO - 'HOME': '/Users/cltbld', 09:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:16 INFO - 'LOGNAME': 'cltbld', 09:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:16 INFO - 'MOZ_NO_REMOTE': '1', 09:36:16 INFO - 'NO_EM_RESTART': '1', 09:36:16 INFO - 'PAGER': '/bin/cat', 09:36:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:16 INFO - 'PWD': '/builds/slave/test', 09:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:16 INFO - 'SHELL': '/bin/bash', 09:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:16 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:16 INFO - 'USER': 'cltbld', 09:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:16 INFO - 'XPC_FLAGS': '0x0', 09:36:16 INFO - 'XPC_SERVICE_NAME': '0', 09:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:36:19 INFO - Installing collected packages: mozsystemmonitor 09:36:19 INFO - Running setup.py install for mozsystemmonitor 09:36:19 INFO - Successfully installed mozsystemmonitor 09:36:19 INFO - Cleaning up... 09:36:19 INFO - Return code: 0 09:36:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:19 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 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:19 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 09:36:19 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 09:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:19 INFO - 'HOME': '/Users/cltbld', 09:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:19 INFO - 'LOGNAME': 'cltbld', 09:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:19 INFO - 'MOZ_NO_REMOTE': '1', 09:36:19 INFO - 'NO_EM_RESTART': '1', 09:36:19 INFO - 'PAGER': '/bin/cat', 09:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:19 INFO - 'PWD': '/builds/slave/test', 09:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:19 INFO - 'SHELL': '/bin/bash', 09:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:19 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:19 INFO - 'USER': 'cltbld', 09:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:19 INFO - 'XPC_FLAGS': '0x0', 09:36:19 INFO - 'XPC_SERVICE_NAME': '0', 09:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:19 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:19 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 09:36:19 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 09:36:19 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 09:36:19 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 09:36:19 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 09:36:19 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 09:36:22 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:23 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 09:36:23 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 09:36:23 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 09:36:23 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 09:36:23 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 09:36:23 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 09:36:23 INFO - Downloading docopt-0.6.1.tar.gz 09:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:23 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:23 INFO - Running setup.py install for blobuploader 09:36:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:23 INFO - Running setup.py install for requests 09:36:24 INFO - Running setup.py install for docopt 09:36:24 INFO - Successfully installed blobuploader requests docopt 09:36:24 INFO - Cleaning up... 09:36:24 INFO - Return code: 0 09:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:24 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 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:24 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 09:36:24 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 09:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:24 INFO - 'HOME': '/Users/cltbld', 09:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:24 INFO - 'LOGNAME': 'cltbld', 09:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:24 INFO - 'MOZ_NO_REMOTE': '1', 09:36:24 INFO - 'NO_EM_RESTART': '1', 09:36:24 INFO - 'PAGER': '/bin/cat', 09:36:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:24 INFO - 'PWD': '/builds/slave/test', 09:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:24 INFO - 'SHELL': '/bin/bash', 09:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:24 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:24 INFO - 'USER': 'cltbld', 09:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:24 INFO - 'XPC_FLAGS': '0x0', 09:36:24 INFO - 'XPC_SERVICE_NAME': '0', 09:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-m2Gi0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-mJEGBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-KhLqwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Py4Xou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ZGOfgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-JHszeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-OtxDPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-PvNOXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-8if5zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-30hhEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-QCGyks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-MJnK_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:26 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-KnlNkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:26 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-WJrqVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:26 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-uSQR2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:26 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-PIndQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:26 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-CXRKCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:26 INFO - Running setup.py install for manifestparser 09:36:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Running setup.py install for mozcrash 09:36:26 INFO - Running setup.py install for mozdebug 09:36:26 INFO - Running setup.py install for mozdevice 09:36:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Running setup.py install for mozfile 09:36:27 INFO - Running setup.py install for mozhttpd 09:36:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Running setup.py install for mozinfo 09:36:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Running setup.py install for mozInstall 09:36:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:27 INFO - Running setup.py install for mozleak 09:36:27 INFO - Running setup.py install for mozlog 09:36:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:28 INFO - Running setup.py install for moznetwork 09:36:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:28 INFO - Running setup.py install for mozprocess 09:36:28 INFO - Running setup.py install for mozprofile 09:36:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:28 INFO - Running setup.py install for mozrunner 09:36:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:28 INFO - Running setup.py install for mozscreenshot 09:36:28 INFO - Running setup.py install for moztest 09:36:28 INFO - Running setup.py install for mozversion 09:36:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:29 INFO - Cleaning up... 09:36:29 INFO - Return code: 0 09:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:29 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 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:29 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 09:36:29 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 09:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:29 INFO - 'HOME': '/Users/cltbld', 09:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:29 INFO - 'LOGNAME': 'cltbld', 09:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:29 INFO - 'MOZ_NO_REMOTE': '1', 09:36:29 INFO - 'NO_EM_RESTART': '1', 09:36:29 INFO - 'PAGER': '/bin/cat', 09:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:29 INFO - 'PWD': '/builds/slave/test', 09:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:29 INFO - 'SHELL': '/bin/bash', 09:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:29 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:29 INFO - 'USER': 'cltbld', 09:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:29 INFO - 'XPC_FLAGS': '0x0', 09:36:29 INFO - 'XPC_SERVICE_NAME': '0', 09:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-FQHu_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:29 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)) 09:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-NLf0Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:29 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)) 09:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-TX_Lzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:29 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)) 09:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-jEKdxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:29 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)) 09:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-uf7cGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:29 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)) 09:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-6LL6bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-tVWkXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-B7WTtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-vO4Twe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-RAd1xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-N90AgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-E0dhDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-o1SwKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-vbULqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-xbM5Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:30 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)) 09:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-hXV15d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:31 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)) 09:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:31 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-QsrCPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:31 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)) 09:36:31 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)) 09:36:31 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)) 09:36:31 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)) 09:36:31 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)) 09:36:31 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)) 09:36:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36:33 INFO - Downloading blessings-1.6.tar.gz 09:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:33 INFO - Installing collected packages: blessings 09:36:33 INFO - Running setup.py install for blessings 09:36:33 INFO - Successfully installed blessings 09:36:33 INFO - Cleaning up... 09:36:33 INFO - Return code: 0 09:36:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:34 INFO - Reading from file tmpfile_stdout 09:36:34 INFO - Current package versions: 09:36:34 INFO - blessings == 1.6 09:36:34 INFO - blobuploader == 1.2.4 09:36:34 INFO - docopt == 0.6.1 09:36:34 INFO - manifestparser == 1.1 09:36:34 INFO - mozInstall == 1.12 09:36:34 INFO - mozcrash == 0.17 09:36:34 INFO - mozdebug == 0.1 09:36:34 INFO - mozdevice == 0.48 09:36:34 INFO - mozfile == 1.2 09:36:34 INFO - mozhttpd == 0.7 09:36:34 INFO - mozinfo == 0.9 09:36:34 INFO - mozleak == 0.1 09:36:34 INFO - mozlog == 3.2 09:36:34 INFO - moznetwork == 0.27 09:36:34 INFO - mozprocess == 0.22 09:36:34 INFO - mozprofile == 0.28 09:36:34 INFO - mozrunner == 6.11 09:36:34 INFO - mozscreenshot == 0.1 09:36:34 INFO - mozsystemmonitor == 0.3 09:36:34 INFO - moztest == 0.7 09:36:34 INFO - mozversion == 1.4 09:36:34 INFO - psutil == 3.1.1 09:36:34 INFO - requests == 1.2.3 09:36:34 INFO - wsgiref == 0.1.2 09:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:34 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')]} 09:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:34 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')]} 09:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:34 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 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:34 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 09:36:34 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 09:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:34 INFO - 'HOME': '/Users/cltbld', 09:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:34 INFO - 'LOGNAME': 'cltbld', 09:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:34 INFO - 'MOZ_NO_REMOTE': '1', 09:36:34 INFO - 'NO_EM_RESTART': '1', 09:36:34 INFO - 'PAGER': '/bin/cat', 09:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:34 INFO - 'PWD': '/builds/slave/test', 09:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:34 INFO - 'SHELL': '/bin/bash', 09:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:34 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:34 INFO - 'USER': 'cltbld', 09:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:34 INFO - 'XPC_FLAGS': '0x0', 09:36:34 INFO - 'XPC_SERVICE_NAME': '0', 09:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 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)) 09:36:34 INFO - Cleaning up... 09:36:34 INFO - Return code: 0 09:36:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36:34 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')]} 09:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:34 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')]} 09:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:34 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 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:34 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 09:36:34 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 09:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:34 INFO - 'HOME': '/Users/cltbld', 09:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:34 INFO - 'LOGNAME': 'cltbld', 09:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:34 INFO - 'MOZ_NO_REMOTE': '1', 09:36:34 INFO - 'NO_EM_RESTART': '1', 09:36:34 INFO - 'PAGER': '/bin/cat', 09:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:34 INFO - 'PWD': '/builds/slave/test', 09:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:34 INFO - 'SHELL': '/bin/bash', 09:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:34 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:34 INFO - 'USER': 'cltbld', 09:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:34 INFO - 'XPC_FLAGS': '0x0', 09:36:34 INFO - 'XPC_SERVICE_NAME': '0', 09:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:34 INFO - Downloading/unpacking jsonschema 09:36:34 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 09:36:34 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 09:36:34 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 09:36:34 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 09:36:34 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 09:36:34 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 09:36:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:37 INFO - Downloading/unpacking functools32 (from jsonschema) 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:37 INFO - warning: no files found matching '*.txt' 09:36:37 INFO - no previously-included directories found matching 'build' 09:36:37 INFO - no previously-included directories found matching 'dist' 09:36:37 INFO - no previously-included directories found matching '.git*' 09:36:37 INFO - Installing collected packages: jsonschema, functools32 09:36:37 INFO - Running setup.py install for functools32 09:36:37 INFO - warning: no files found matching '*.txt' 09:36:37 INFO - no previously-included directories found matching 'build' 09:36:37 INFO - no previously-included directories found matching 'dist' 09:36:37 INFO - no previously-included directories found matching '.git*' 09:36:37 INFO - Successfully installed jsonschema functools32 09:36:37 INFO - Cleaning up... 09:36:37 INFO - Return code: 0 09:36:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:36:37 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')]} 09:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:37 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')]} 09:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:37 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 0x106894a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10689a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a3859efa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:37 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 09:36:37 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 09:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:37 INFO - 'HOME': '/Users/cltbld', 09:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:37 INFO - 'LOGNAME': 'cltbld', 09:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:37 INFO - 'MOZ_NO_REMOTE': '1', 09:36:37 INFO - 'NO_EM_RESTART': '1', 09:36:37 INFO - 'PAGER': '/bin/cat', 09:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:37 INFO - 'PWD': '/builds/slave/test', 09:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:37 INFO - 'SHELL': '/bin/bash', 09:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:36:37 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:37 INFO - 'USER': 'cltbld', 09:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:37 INFO - 'XPC_FLAGS': '0x0', 09:36:37 INFO - 'XPC_SERVICE_NAME': '0', 09:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:38 INFO - Downloading/unpacking flake8 09:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:36:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:36:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:36:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:36:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:36:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:36:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:36:41 INFO - no previously-included directories found matching 'docs/_build' 09:36:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:36:41 INFO - Running setup.py install for pep8 09:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:36:42 INFO - no previously-included directories found matching 'docs/_build' 09:36:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:36:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:36:42 INFO - Cleaning up... 09:36:42 INFO - Return code: 0 09:36:42 INFO - Running post-action listener: _resource_record_post_action 09:36:42 INFO - Running post-action listener: _start_resource_monitoring 09:36:42 INFO - Starting resource monitoring. 09:36:42 INFO - ##### 09:36:42 INFO - ##### Finished create-virtualenv step (success) 09:36:42 INFO - ##### 09:36:42 INFO - ##### 09:36:42 INFO - ##### Running install step. 09:36:42 INFO - ##### 09:36:42 INFO - Running pre-action listener: _resource_record_pre_action 09:36:42 INFO - Running main action method: install 09:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:42 INFO - Reading from file tmpfile_stdout 09:36:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:42 INFO - Reading from file tmpfile_stdout 09:36:42 INFO - Output received: 09:36:42 INFO - Usage: mozinstall [options] installer 09:36:42 INFO - Options: 09:36:42 INFO - -h, --help show this help message and exit 09:36:42 INFO - -d DEST, --destination=DEST 09:36:42 INFO - Directory to install application into. [default: 09:36:42 INFO - "/builds/slave/test"] 09:36:42 INFO - --app=APP Application being installed. [default: firefox] 09:36:42 INFO - mkdir: /builds/slave/test/build/application 09:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:37:16 INFO - Reading from file tmpfile_stdout 09:37:16 INFO - Output received: 09:37:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:37:16 INFO - Running post-action listener: _resource_record_post_action 09:37:16 INFO - ##### 09:37:16 INFO - ##### Finished install step (success) 09:37:16 INFO - ##### 09:37:16 INFO - ##### 09:37:16 INFO - ##### Running run-tests step. 09:37:16 INFO - ##### 09:37:16 INFO - Running pre-action listener: _resource_record_pre_action 09:37:16 INFO - Running main action method: run_tests 09:37:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:37:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:37:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:37:16 INFO - 2016-05-30 09:37:16.542 screenresolution[1654:7483] starting screenresolution argv=screenresolution get 09:37:16 INFO - 2016-05-30 09:37:16.545 screenresolution[1654:7483] Display 0: 1600x1200x32@60 09:37:16 INFO - 2016-05-30 09:37:16.552 screenresolution[1655:7492] starting screenresolution argv=screenresolution list 09:37:16 INFO - Available Modes on Display 0 09:37:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:37:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:37:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:37:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:37:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:37:16 INFO - Intel Iris: 09:37:16 INFO - Chipset Model: Intel Iris 09:37:16 INFO - Type: GPU 09:37:16 INFO - Bus: Built-In 09:37:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:37:16 INFO - Vendor: Intel (0x8086) 09:37:16 INFO - Device ID: 0x0a2e 09:37:16 INFO - Revision ID: 0x0009 09:37:16 INFO - Displays: 09:37:16 INFO - Display: 09:37:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:37:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:37:16 INFO - Display Serial Number: 1600x1200 60 09:37:16 INFO - Main Display: Yes 09:37:16 INFO - Mirror: Off 09:37:16 INFO - Online: Yes 09:37:16 INFO - Rotation: Supported 09:37:16 INFO - Return code: 0 09:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:16 INFO - Python 2.7.3 09:37:16 INFO - Return code: 0 09:37:16 INFO - grabbing minidump binary from tooltool 09:37:16 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')]} 09:37:16 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/macosx64/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 0x106738d30>, '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 0x10655cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10672fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:16 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:37:16 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:37:16 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:37:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:16 INFO - Return code: 0 09:37:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:37:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:37:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:37:18 INFO - Return code: 0 09:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--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 09:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0363 --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 09:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TLMtuJZlk/Render', 09:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:18 INFO - 'HOME': '/Users/cltbld', 09:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:18 INFO - 'LOGNAME': 'cltbld', 09:37:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:18 INFO - 'MOZ_NO_REMOTE': '1', 09:37:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:18 INFO - 'NO_EM_RESTART': '1', 09:37:18 INFO - 'PAGER': '/bin/cat', 09:37:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:18 INFO - 'PWD': '/builds/slave/test', 09:37:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:18 INFO - 'SHELL': '/bin/bash', 09:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners', 09:37:18 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 09:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:18 INFO - 'USER': 'cltbld', 09:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:18 INFO - 'XPC_FLAGS': '0x0', 09:37:18 INFO - 'XPC_SERVICE_NAME': '0', 09:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--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 09:37:18 INFO - mozversion application_buildid: 20160530064349 09:37:18 INFO - mozversion application_changeset: f84a95dce3aaaec51ccaf98398eed74f41e30245 09:37:18 INFO - mozversion application_display_name: Nightly 09:37:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:18 INFO - mozversion application_name: Firefox 09:37:18 INFO - mozversion application_remotingname: firefox 09:37:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:37:18 INFO - mozversion application_vendor: Mozilla 09:37:18 INFO - mozversion application_version: 49.0a1 09:37:18 INFO - mozversion platform_buildid: 20160530064349 09:37:18 INFO - mozversion platform_changeset: f84a95dce3aaaec51ccaf98398eed74f41e30245 09:37:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:37:18 INFO - mozversion platform_version: 49.0a1 09:37:18 INFO - using testdate: 1464626238 09:37:18 INFO - actual date: 1464626238 09:37:18 INFO - starting webserver on 'localhost:49273' 09:37:18 INFO - SUITE-START | Running 2 tests 09:37:18 INFO - TEST-START | dromaeo_css 09:37:18 INFO - operating with platform_type : mac_ 09:37:18 INFO - Initialising browser for dromaeo_css test... 09:37:18 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpMDWFeM/profile http://localhost:49273/getInfo.html) 09:37:21 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 09:37:21 INFO - PROCESS | 1673 | colorDepth:24 09:37:21 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 09:37:21 INFO - PROCESS | 1673 | __metrics 09:37:21 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:37:22 INFO - TEST-INFO | 1673: exit 0 09:37:22 INFO - Browser initialized. 09:37:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:22 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpMDWFeM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:34 INFO - PROCESS | 1679 | RSS: Main: 252895232 09:37:34 INFO - PROCESS | 1679 | 09:38:24 INFO - PROCESS | 1679 | 1464626304007 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] 09:40:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 09:40:36 INFO - PROCESS | 1679 | RSS: Main: 266911744 09:40:36 INFO - PROCESS | 1679 | 09:43:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 09:43:39 INFO - PROCESS | 1679 | RSS: Main: 278335488 09:43:39 INFO - PROCESS | 1679 | 09:46:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 09:46:42 INFO - PROCESS | 1679 | RSS: Main: 280428544 09:46:42 INFO - PROCESS | 1679 | 09:49:44 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 09:49:44 INFO - PROCESS | 1679 | RSS: Main: 281673728 09:49:44 INFO - PROCESS | 1679 | 09:52:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 09:52:48 INFO - PROCESS | 1679 | RSS: Main: 285548544 09:52:48 INFO - PROCESS | 1679 | 09:55:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 09:55:51 INFO - PROCESS | 1679 | RSS: Main: 285691904 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | __start_tp_report 09:55:51 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 09:55:51 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 09:55:51 INFO - PROCESS | 1679 | |i|pagename|runs| 09:55:51 INFO - PROCESS | 1679 | |0;dojo.html;3044.6346438427386;3445.8966231013046;3467.9306413871714;3507.368673638744;3509.3332266869293;5720.685362305072;5851.6196447230905;5861.325947516037;5875.559333050022;5914.615549989258;5784.2769653793275;5892.469677729004;5900.763969441217;5953.642781433106;6041.335453100167;4286.807093680776;5249.580033597303;5301.734913254341;5316.3354580677515;5317.8404647860625;5282.366116066078;5408.945910540883;5419.485148910847;5479;5493.945060549383;4677.251639737643;4689.460712018127;4846.224604063368;5176.301199338079;5193.922091168635;4336.891577710551;5225.346831646044;5225.686458812445;5242.423333433319;5261.473852614746;5222.686638801646;5289.127293996486;5291.1534154535475;5291.523762861322;5294.232336311214;4293.24868148076;5592.944070559323;5594.720263986825;5664.6601203927485;5675.290588676416;6156.168917196166;6173.197484327054;6174.259088909314;6183.907241391383;6200.286966998763;6213.974694175501;6235.781747638811;6240.344763799826;6252.499800015988;6281.403266689657;5766.423357664242;5885.058390657474;5912.438318359749;5930;5979.4917432018765;6297.939445961025;6323.9051414228825;6356.300806911236;6374.012028135647;6402.839929001812;6114.419130182626;6199.16311297969;6214.627122372672;6228.5017198624;6242.906356404657;6152.969235153885;6155.0151975683675;6169.81490555284;6221.3156552779155;6243.219597550306;6068.120122582201;6132.17215675878;6134.00801433197;6194.4115309045565;6204.627722336674;6171.47542458896;6197.101420294122;6198.969005154945;6217.191765070603;6232.875342493125;4896.804127834846;4969.9563091750415;4980.5019498049905;5013.724245166551;5023.296738456619;4448.933266001012;4457.331400289918;4457.398251236106;4491.191585514639;4496.4154659894;5754.56840736938;5897.5871688982215;5937.643741375531;5938.851528711817;5944.762209511658;6128.720082208443;6145.569810113249;6158.476529494954;6159.168512250879;6233.812985610439;5953.493953014043;5968.970155149196;5986;5990.311114221833;5994.28068631767;5378.542823860016;5484.2596249506605;5498.230247765316;5500.064988951888;5500.50495455403;5986.16193732869;6249.78125765596;6365.4589359904;6435.678216089083;6527.249366322933;6074.088886667036;6234.2830574484515;6256.249250090018;6266.843328916813;6271.4669253114;5802.82591522255;6202.81391558254;6422.389872962061;6504.15445992018;6510.934890651033;5095.898082038412;6148.385161483816;6172.722227499684;6213.875722485615;6239.4696450800375;6191.690415479298;6197.721102550487;6207.410296021871;6213.627182369072;6241.625502469867;5999.130126131774;6042.697865106815;6060.2424696912885;6088.26940767093;6170.598911070945;6107.816765497042;6135.570510064253;6141.07883817431;6147.708981114016;6173.59871608344;5938.970305148447;6051.727672254847;6062.848428789315;6087.05650624154;6098;5642.887142257214;6099.128199784669;6132.509399248139;6134.662593557218;6167.599106058092;6104.084387341934;6125.9698039450395;6130.826205142237;6139.938600613937;6150.538709596709 09:55:51 INFO - PROCESS | 1679 | |1;ext.html;509.9311592934953;516.460298987558;528.2841749429523;553.689933637163;569.641126090563;35310.2937941241;41441.58558414415;41536.16927661453;41537;41552.96117597058;36098;38718.80640596793;41083.58916410835;41671;41748.791256043754;9423.952880235589;9635.084666956627;9646.951765241163;9650.324477286593;9669.70990870275;9368.016358282384;9428.434293942351;9453.101955314234;9454.196393306578;9465.242780577537;8093.231143041431;9478.478683672396;9501.144896959273;9516.048395160498;9559.617615295414;9399.24806015517;9431.905680943171;9446.433214007147;9460.385074970105;9512.28657850664;9420.764480887965;9532.18976387008;9538.809223815484;9552.713418597385;9601.663941762075;37964.62035379638;38066;38293.42559861604;38318.61681383178;38448.423273650915;3371.1723458362994;3472.4444088945647;3588.74878758487;4063.7968101595097;4107.240160570274;31501.52747708786;32251.19372015695;32437.513437298225;32471.35057298841;32849.17877053069;3236.5792446981977;3317;3346.2136397946465;3437.432823584106;3444.844981975817;503882;504831;505635;507466;508655.91344086453;31602.841985790383;32640;63160;63592.68203658952;63936.36063639397;36686;36794.816025920234;36811.63188368136;36946.8152659235;37056.073598159724;15057.096574205363;15083.396664133312;15232.314545845464;15232.466863659718;15252.542423727084;12679.492820287269;12697.238165710087;12746.617601471971;12838.29389383593;12854.421551030226;7768.10666773317;8022.99712535933;8034.116247212802;8072.950516432944;8100.675972961133;3306.7354611631013;3332.083676988799;3334.049795808183;3336.299377130781;3351.2292172799903;1033.4677641014882;1063.3301020357126;1063.6011495689118;1130.6438471881331;1176.4647085576041;30530.38939221203;30884;31318.530222046687;31798;31849.885254016463;1107.1640911112058;1114.7380365614074;1128.6444769897455;1140.1733743036232;1194.892459678633;16017.279222435018;16118.597035074217;16153.757693634605;16295.940763850549;16398.508044758677;698853;710105;713804;714386;715139.4243028752;59984.10023849646;60510.69744651249;60826;60936.69531652402;61081.38918610757;1431.1484666623342;1432.7349440353569;1486.2271618758184;1490.180400779567;1495.9326830292664;30396.240093997825;30486.542701859933;30631;30880.53679194769;31150.68849311478;52950.94098118093;53881;54737.726311369785;54778;54797;572373;655467;655503;656109;658487.3680684285;27413.86293068522;27425.040123596376;27550.5867411993;27765.44469110647;27807.887684492394;48635;49246;49648.75175624243;50279.74860125676;50360.24459633182;39907.00232494211;39926.2014759709;40731;40970;41946.37080443735;39564.80217598894;39627.2074558513;40020.999475013356;40375;40464.59535404608;38759.6124038756;38966.6103338963;39669.80165099156;39812.601873980886;41834.95412614587;33561;34077.569915910775;35147.648523514436;36351;36439.45340819943;26070.60894086628;26096.739032609432;26152.476950460503;26237.73762262353;26557.937682492484 09:55:51 INFO - PROCESS | 1679 | |2;jquery.html;330.9525352260096;382.6384067056631;385.7087898636529;402.9536603290619;406.4269380173955;16766.329346826144;17191.742123868153;18473.667424151823;20784.856832874204;20856.791432085654;19838.702419463683;20012.599748005032;20017.89901555414;20272.189112435484;20846.89576552119;5762.279715035621;5785.595008349417;6006.8498287542725;6065.181200537915;6074.392560743934;5873.647581145124;5894.823155305347;5956.047032474805;5969.940300596982;5970.313413957385;4748.643851711118;4895.36360273164;5650.237217975562;5876;5884.323302820188;5387.380451248117;5863.413658634145;5908.763649454017;5946.583739138262;5953.613015154023;5704.942950570483;5715.542756579505;5814.418558144194;5818.330891947396;5827.941720582782;12529.624111276677;15647.765283520755;19618.11718472672;24859;25336.859841307;2058.886761228132;2165.740111186652;2207.404000919759;2234.966475502869;2314.5139520700673;9949;10141.543630536644;10202.030807073315;10362.792744145076;10407.427591482465;1857.934972275964;1875.6998880179106;1982.4449154236836;2056.228914157191;2128.6806978953127;118066.40966795111;126433.83915402097;127161;128664;129615;9388.263171313329;11541.596044138414;11710;11721.589744358907;11793.646190614296;14505.709885802225;14618.48835290781;14631.853681463263;14643.633909152357;14681.706365872837;8510;8587.098354672795;8596.613152408157;8638;8673.783155421039;6990.860182796418;8468.280196183394;8491.19333663301;8493.405461617627;8590.613422396007;4477.977610111994;4600.42494688164;4609.055143695535;4621.145088158634;4626.560476754703;1561.7110834495654;1926.1139875657354;1938.1375287996989;1956.8923709195847;1962.4308950404509;936.3632729743839;978.4471773447979;1042.9061384475433;1069.3637285814928;1080.7892460970193;14891.553253402415;16776.496705098867;19349.742266752615;19768.604627907647;20420.591588168452;961.7595601099725;965.4834663455018;992.1764935103846;1008.8537162111453;1014.1379827146866;10115.544800483996;10430.68707938763;10613.575456981634;11299.322040677585;11424.086073114297;599610;607669;609844;621297;623453;80338;124520.37739811424;135565;146123.2693836524;147102;1024.4416792847917;1042.4943902207424;1072.8873468285717;1074.790415868898;1081.848541204232;16000.679986399973;16872.156392180095;18554.44336669902;18802.52993675169;18931.33740319082;56254;56386.59033524195;56468.7176564131;56934;57290.5678402953;59643;64301;83618;83731;85644.14355856362;6970.616616086164;8201.097879233399;8297.377696672653;8308.70919517814;8506.447080939719;9197.080291971017;11012;12176.57381991626;13062.020348473712;13198.670033248862;9130.908690913006;10452.68641940743;11035.282706624044;11380.601678941197;11466.598669046543;11257;11327.943360283145;11332.206745528063;11364.31814091124;11404.315741055563;9811.969743176864;11366.488508017324;11476.770464590494;11586.594469193875;11684.12369072306;7847.293743563107;8299.792505187177;8391.95804020976;8416.87374689368;8489.872651910102;11212.04697600713;11444.94277528607;11585;11602.07183425341;11689.298642081503 09:55:51 INFO - PROCESS | 1679 | |3;mootools.html;1376.642073061004;1537.715522628314;1762.2774662388424;1928.4985903665042;1940.4275738657095;7859.960700196505;8030.558319292437;8419.28436082933;8938.508382038994;8938.687145949893;7609.885851712229;8543.530105844176;8696.434731742433;8740.694075707352;8763.386562940597;2355.2816391000697;2368.5499755046485;2373.6320870265135;2375.3467796355967;2390.7011623547055;2362.787349138577;2377.524495100978;2402.9639555406684;2405.9518809623796;2416.3838221253554;2368.1829768729845;2383.2373640435067;2385.7017872765905;2402.5555272274596;2414.311921102486;2349.6123139682018;2361.669366288721;2362.11420717231;2363.3618922890896;2378.357843382277;2326.127702111708;2338.953220935589;2354.917577884783;2356.2577787996725;2361.409647588103;8703.869441958375;8704.56477176145;8708.912910870873;8731.956340218321;8800.47197168172;5261.842144735664;5394.757235924393;5416.458354164592;5420.6747595144025;5438.129899216106;3555.928881422357;3607.2424790793966;3670.6512881276235;3670.834812433447;3681.5029970953847;1069.8823129455754;1083.7615724540667;1095.446799366323;1097.961571345007;1100.1803656276045;11537.942310288396;11695.590654327143;11709.946104850604;11711.945924866717;11723.589674361356;4227.450431443954;4604.309353596987;4620.8151673933335;4651.2557990722;4815.012922350909;9816.263780216512;9819.9018009819;9820.901790982141;9822.607095716092;9823.557939892722;4402.669799765031;5265.4997775211295;5292.285541451854;5328.333958255218;5332.146856502941;4083;4122.237386083584;4355.324924636687;4841.2496063110275;4858.878528036827;3891.3384724596885;3913.25648126855;3981.761094334291;4007.499062617173;4062.898427539335;1290.535407253388;1301.7006088599676;1308.874368043501;1315.6645055510783;1319.5843309357522;858.5878778186506;969.772103555678;980.5440470181258;981.816910622698;1026.5996261458038;4729.787159577759;6030;6070.150178974947;6094.542909281733;6097.207363042776;411.7467757329221;445.72365133616717;455.45345585297775;459.7953362191014;987.3088837813559;3536.7877927324444;4041.4544036555276;4049.392591111357;4093.099518106012;4113.095119073799;8293.709720159766;10590.682279531626;10695.35827850316;10766.192535559865;10794.892051079389;10635.0960168385;10651.467426628638;10682.51928663212;10706.518206680563;10746.677599672023;6769.763058292936;7846.607669616496;8188.14024527428;8214.301784348278;8255.917440825635;6035.155078289131;6053.424924632153;6090.695465226632;6114.541409394402;6146;9752.707418777449;9991.800163996824;10004.749881253027;10023.148032417035;10026.749331266778;9884.950575247078;10087.243456740627;10268.486575671037;10279.794404112026;10292.022257885488;6972;7359.264073592812;7510.8497830042;7616.9238307616215;7649.120351159688;8351.290140337896;8373.665053397795;8393.118722534291;8413.915860841313;8468.110848360833;5857.853553661193;7267.927320726725;7427.071616047994;7508.249175082448;7517.285857843496;7110.4667149965;7248.96375518119;7277.890831637424;7306.086739157606;7310.678934199886;6711.832204194934;6778.288279730755;6800.52396332252;6816.591004539743;6825.2833452486775;4691.94431252979;4928.408590969107;4987.326710894128;5019.071471777733;5083.186690129562;4443.555644435531;5021.72380519075;5031.74841257943;5130.102232109441;5150.356205474316 09:55:51 INFO - PROCESS | 1679 | |4;prototype.html;255.66890876315173;311.1071225582577;317.2845233997336;318.1981406854726;319.79373304218797;4893.853184404469;5425.810096646618;5513.842093160431;5527.861803454905;5545.944540554593;5372.811951581695;5401.4868587484225;5410.862709229852;5432.945670543293;5446;3902.7853468059175;3996.820143093568;4106.32245679464;4116;4122.876313710593;3833.3741387149753;3911.6088391160943;4055.371417430288;4125.23683118624;4127.484064491939;3301.3589128696944;4053.8243909266275;4082.795575305277;4085.5097388313443;4085.6313135099776;3265.7877237979574;3317.8672853085845;3911.432842237874;4077.8980525486804;4079.8776036718946;2898.4927637663322;3468.8439020243895;3488.372093023255;3492.89521314361;3502;4927.334809800667;5165.302684137631;5183.352080989876;5207.817726379559;5215.400228973679;4334.826606935719;4638.397008388888;4667.183242932473;4691.695039822401;4723.173444647173;4996.300517927493;5412.4858138477175;5667.744951477193;5680.7727690892725;5688.947544704243;3282.868685252587;3452.602950660681;3858.151206734514;3870.5678898807623;3894.805259737002;5565.998120338338;5633.464820842013;5867.970660146715;5941.732622032019;5965.28416590012;3207.566978457925;3492.6158122606494;3879.573246942834;3880.8641697541016;3935.685145188378;3524.277523107808;3979.224051309967;3981.8606348777653;3985.860494882665;3993.6206060424215;3826.1443200047956;4474.172278128557;4631.698939568917;4659.394278743742;4699.812007519729;5507.218854478463;5529.778808847682;5783.681897495594;5798.652080875161;5872.442117998783;1251.7997120460682;1328.714326419805;1347.6819869823887;1349.6693310139078;1362.9591112266648;814.4583851738528;819.848113400673;833.5623797506237;842.8074274900946;885.7918389178537;4679.298105284234;5312.601554883399;5333.5199832015305;5349.277847490539;5359.464053594609;5113.642045056885;5144.459831717691;5868.530517558585;5891.941080589225;5920.259967504062;4324.303285069312;4404.96057720172;4958.7024778513405;5166.715830629351;5193.4027586828;2891;3047.9695203048127;3073.200967748357;3076.5846610707717;3076.876924922978;5399.325084364455;5413.783448662089;5609.691466969356;5624.971875140598;6032.969835150796;4983.9252411213865;5284.524392804666;5432.348118225838;6037.215162028996;6041.622955569546;5150.8969820604125;5273.417974607679;5718.456746609066;5781.126645147761;5976.983912734846;4959.668955590867;5571.66570005801;5894.4064611570775;5895.67573783446;5897.439743224387;5157.510036546522;5244.082285599929;5574.554035677055;5926.407359264212;6010.213565453736;5270.945810837771;5941.6127662763565;6219.626822390671;6256.436920676979;6311.495080393649;3695.6304369562827;3789.242151569642;3893.5133108361456;3932.6067393260446;3942.2312649033165;4902.681325713817;5877.471027607365;5899.646021238739;5914.822555323347;5915.467607915309;5692.829215123553;5698.202251684685;5752.654840709571;5755.395683453345;5786.971065144648;4984.40187177541;5269.78920843162;5304.602154838325;5579.6652200868075;5742.454466825645;5214.113600687816;5322.28149199853;5326.334208223972;5429.728513574384;5622.887542249214;4670.9766451167525;5628.240187574625;5727.799527016535;5779.2486976694445;5791.7683292667825;4984.675996060245;5159.535641792257;5630.60585758993;5637.830865074055;5666.603337766317 09:55:51 INFO - PROCESS | 1679 | |5;yui.html;739.157360608906;800.76777734457;814.1288820961573;814.706705585989;818.664347617477;12343.321117338543;13463.59609211724;14026;14209.579042095786;14788.926055369735;11199.328040317587;13625.318734063281;13634.181949083062;13640.113392629471;13667.3166341683;607.6661727508122;875.2735229759317;876.7983363826323;891.928645708345;893.5264309915755;875.5665945357025;893.4326702543899;900.9279257659372;901.1619194149439;906.229704750963;944.3719926249037;955.9617615295415;968.9854652180223;972.2270794718181;972.810301991112;955.2310390135938;958.2765012415582;959.7024922274118;961.9326647134739;965.2663975378728;700.5866538742116;703.0614130136274;715.0704084689883;717.9928200717978;719.6977269546803;14152.29238538069;14325.641858953506;14351.569452916428;14366.928165359212;14474.348654310581;13536.93231533846;13599.184048957095;13664.385102670403;13750.931245343809;13861.861381386158;10324.896751032544;11057.281276716987;11292.604758833484;11389.544418223344;11740.647780566596;3791.1848952475075;3797.050737315671;3801.7909015004166;3881.844726210948;3928.8821335359985;81711;82287.17712822855;82538;82663.17336826675;84527.57736211341;10476.114855140802;10777.407242601575;10787.83818242727;10825.56697732082;11024.118070554336;16226.350945962266;19723.605527889362;19778;20246.886421246974;21207.57584848325;6968.825779355455;7970.840583188304;7998.640061197144;8066.435349525477;8178.877316840252;4407.581279778416;4488.573585509372;4492.887677808081;4516.480604730433;4519.638428925678;3282.8686852526107;3400.2179498715436;3424.400729872262;3458.602260739997;3485;659.7822718502882;707.773512476013;711.8327193109615;726.989095163573;732.0848938826467;553.2696840171017;614.031612724319;659.6932426421737;669.819148829823;669.9330066993261;8826.42628229163;9139.223166030963;9283.48940808262;9384.82689663792;9385.249180065579;619.9535034872403;621.6332363905318;635.8491131052809;660.9405153536205;718.2422544215798;4225.9788701056295;4307.547707490731;4413.3159360299205;4420.955790442119;4573.108243892476;76886.61556692181;101469.47795783069;102207.48896255619;102574;103138;85018;88133.59332033501;88390;88672.5566372177;89053;78612;79164.60417697874;79419;79455.41089178184;79623.40753184789;8674.392792504717;8713.91286087131;8723.127687231226;8756.912430875609;8873.822523549621;35026;37282.813585932985;47988.5201147998;48582;49742.751286243336;60515;60622.69688651529;61889;63025.05462417976;66234.34414139685;11100.333979961228;11282.605108821152;11651.650450486499;11680.883191167979;11790.882091178979;12049.939750301193;12139.271643701406;12205.145639805129;12523.812142817682;12729.872701272869;11041.889581104086;11192.944035279772;11749.882501175221;12037.398130093285;12164.756704865677;9694.6122155113;11542.538298467967;11567.942160289145;12212.938935305267;12252.632421027383;11311;11436.370999595103;11576.826347604625;11640.76718465609;11672.066234701033;10354.223433242387;10527.631532896312;10547.841782373118;10549.093592009895;10656.84014739795;9005.594748236475;9178.54107294646;10000.449975251431;10842.457877105955;11014.1739369546 09:55:51 INFO - PROCESS | 1679 | __end_tp_report 09:55:51 INFO - PROCESS | 1679 | __start_cc_report 09:55:51 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,418 09:55:51 INFO - PROCESS | 1679 | __end_cc_report 09:55:51 INFO - PROCESS | 1679 | __startTimestamp1464627351225__endTimestamp 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | ------- Summary: start ------- 09:55:51 INFO - PROCESS | 1679 | Number of tests: 6 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5760.01 Median:6051.73 stddev:665.14 (11.0%) stddev-sans-first:632.15 09:55:51 INFO - PROCESS | 1679 | Values: 3044.6 3445.9 3467.9 3507.4 3509.3 5720.7 5851.6 5861.3 5875.6 5914.6 5784.3 5892.5 5900.8 5953.6 6041.3 4286.8 5249.6 5301.7 5316.3 5317.8 5282.4 5408.9 5419.5 5479.0 5493.9 4677.3 4689.5 4846.2 5176.3 5193.9 4336.9 5225.3 5225.7 5242.4 5261.5 5222.7 5289.1 5291.2 5291.5 5294.2 4293.2 5592.9 5594.7 5664.7 5675.3 6156.2 6173.2 6174.3 6183.9 6200.3 6214.0 6235.8 6240.3 6252.5 6281.4 5766.4 5885.1 5912.4 5930.0 5979.5 6297.9 6323.9 6356.3 6374.0 6402.8 6114.4 6199.2 6214.6 6228.5 6242.9 6153.0 6155.0 6169.8 6221.3 6243.2 6068.1 6132.2 6134.0 6194.4 6204.6 6171.5 6197.1 6199.0 6217.2 6232.9 4896.8 4970.0 4980.5 5013.7 5023.3 4448.9 4457.3 4457.4 4491.2 4496.4 5754.6 5897.6 5937.6 5938.9 5944.8 6128.7 6145.6 6158.5 6159.2 6233.8 5953.5 5969.0 5986.0 5990.3 5994.3 5378.5 5484.3 5498.2 5500.1 5500.5 5986.2 6249.8 6365.5 6435.7 6527.2 6074.1 6234.3 6256.2 6266.8 6271.5 5802.8 6202.8 6422.4 6504.2 6510.9 5095.9 6148.4 6172.7 6213.9 6239.5 6191.7 6197.7 6207.4 6213.6 6241.6 5999.1 6042.7 6060.2 6088.3 6170.6 6107.8 6135.6 6141.1 6147.7 6173.6 5939.0 6051.7 6062.8 6087.1 6098.0 5642.9 6099.1 6132.5 6134.7 6167.6 6104.1 6126.0 6130.8 6139.9 6150.5 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:73461.92 Median:39596.00 stddev:167674.61 (423.5%) stddev-sans-first:168055.51 09:55:51 INFO - PROCESS | 1679 | Values: 509.9 516.5 528.3 553.7 569.6 35310.3 41441.6 41536.2 41537.0 41553.0 36098.0 38718.8 41083.6 41671.0 41748.8 9424.0 9635.1 9647.0 9650.3 9669.7 9368.0 9428.4 9453.1 9454.2 9465.2 8093.2 9478.5 9501.1 9516.0 9559.6 9399.2 9431.9 9446.4 9460.4 9512.3 9420.8 9532.2 9538.8 9552.7 9601.7 37964.6 38066.0 38293.4 38318.6 38448.4 3371.2 3472.4 3588.7 4063.8 4107.2 31501.5 32251.2 32437.5 32471.4 32849.2 3236.6 3317.0 3346.2 3437.4 3444.8 503882.0 504831.0 505635.0 507466.0 508655.9 31602.8 32640.0 63160.0 63592.7 63936.4 36686.0 36794.8 36811.6 36946.8 37056.1 15057.1 15083.4 15232.3 15232.5 15252.5 12679.5 12697.2 12746.6 12838.3 12854.4 7768.1 8023.0 8034.1 8073.0 8100.7 3306.7 3332.1 3334.0 3336.3 3351.2 1033.5 1063.3 1063.6 1130.6 1176.5 30530.4 30884.0 31318.5 31798.0 31849.9 1107.2 1114.7 1128.6 1140.2 1194.9 16017.3 16118.6 16153.8 16295.9 16398.5 698853.0 710105.0 713804.0 714386.0 715139.4 59984.1 60510.7 60826.0 60936.7 61081.4 1431.1 1432.7 1486.2 1490.2 1495.9 30396.2 30486.5 30631.0 30880.5 31150.7 52950.9 53881.0 54737.7 54778.0 54797.0 572373.0 655467.0 655503.0 656109.0 658487.4 27413.9 27425.0 27550.6 27765.4 27807.9 48635.0 49246.0 49648.8 50279.7 50360.2 39907.0 39926.2 40731.0 40970.0 41946.4 39564.8 39627.2 40021.0 40375.0 40464.6 38759.6 38966.6 39669.8 39812.6 41835.0 33561.0 34077.6 35147.6 36351.0 36439.5 26070.6 26096.7 26152.5 26237.7 26557.9 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:35311.87 Median:20851.84 stddev:102384.69 (491.0%) stddev-sans-first:102638.21 09:55:51 INFO - PROCESS | 1679 | Values: 331.0 382.6 385.7 403.0 406.4 16766.3 17191.7 18473.7 20784.9 20856.8 19838.7 20012.6 20017.9 20272.2 20846.9 5762.3 5785.6 6006.8 6065.2 6074.4 5873.6 5894.8 5956.0 5969.9 5970.3 4748.6 4895.4 5650.2 5876.0 5884.3 5387.4 5863.4 5908.8 5946.6 5953.6 5704.9 5715.5 5814.4 5818.3 5827.9 12529.6 15647.8 19618.1 24859.0 25336.9 2058.9 2165.7 2207.4 2235.0 2314.5 9949.0 10141.5 10202.0 10362.8 10407.4 1857.9 1875.7 1982.4 2056.2 2128.7 118066.4 126433.8 127161.0 128664.0 129615.0 9388.3 11541.6 11710.0 11721.6 11793.6 14505.7 14618.5 14631.9 14643.6 14681.7 8510.0 8587.1 8596.6 8638.0 8673.8 6990.9 8468.3 8491.2 8493.4 8590.6 4478.0 4600.4 4609.1 4621.1 4626.6 1561.7 1926.1 1938.1 1956.9 1962.4 936.4 978.4 1042.9 1069.4 1080.8 14891.6 16776.5 19349.7 19768.6 20420.6 961.8 965.5 992.2 1008.9 1014.1 10115.5 10430.7 10613.6 11299.3 11424.1 599610.0 607669.0 609844.0 621297.0 623453.0 80338.0 124520.4 135565.0 146123.3 147102.0 1024.4 1042.5 1072.9 1074.8 1081.8 16000.7 16872.2 18554.4 18802.5 18931.3 56254.0 56386.6 56468.7 56934.0 57290.6 59643.0 64301.0 83618.0 83731.0 85644.1 6970.6 8201.1 8297.4 8308.7 8506.4 9197.1 11012.0 12176.6 13062.0 13198.7 9130.9 10452.7 11035.3 11380.6 11466.6 11257.0 11327.9 11332.2 11364.3 11404.3 9812.0 11366.5 11476.8 11586.6 11684.1 7847.3 8299.8 8392.0 8416.9 8489.9 11212.0 11444.9 11585.0 11602.1 11689.3 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5649.98 Median:4710.87 stddev:3168.23 (67.3%) stddev-sans-first:3160.84 09:55:51 INFO - PROCESS | 1679 | Values: 1376.6 1537.7 1762.3 1928.5 1940.4 7860.0 8030.6 8419.3 8938.5 8938.7 7609.9 8543.5 8696.4 8740.7 8763.4 2355.3 2368.5 2373.6 2375.3 2390.7 2362.8 2377.5 2403.0 2406.0 2416.4 2368.2 2383.2 2385.7 2402.6 2414.3 2349.6 2361.7 2362.1 2363.4 2378.4 2326.1 2339.0 2354.9 2356.3 2361.4 8703.9 8704.6 8708.9 8732.0 8800.5 5261.8 5394.8 5416.5 5420.7 5438.1 3555.9 3607.2 3670.7 3670.8 3681.5 1069.9 1083.8 1095.4 1098.0 1100.2 11537.9 11695.6 11709.9 11711.9 11723.6 4227.5 4604.3 4620.8 4651.3 4815.0 9816.3 9819.9 9820.9 9822.6 9823.6 4402.7 5265.5 5292.3 5328.3 5332.1 4083.0 4122.2 4355.3 4841.2 4858.9 3891.3 3913.3 3981.8 4007.5 4062.9 1290.5 1301.7 1308.9 1315.7 1319.6 858.6 969.8 980.5 981.8 1026.6 4729.8 6030.0 6070.2 6094.5 6097.2 411.7 445.7 455.5 459.8 987.3 3536.8 4041.5 4049.4 4093.1 4113.1 8293.7 10590.7 10695.4 10766.2 10794.9 10635.1 10651.5 10682.5 10706.5 10746.7 6769.8 7846.6 8188.1 8214.3 8255.9 6035.2 6053.4 6090.7 6114.5 6146.0 9752.7 9991.8 10004.7 10023.1 10026.7 9885.0 10087.2 10268.5 10279.8 10292.0 6972.0 7359.3 7510.8 7616.9 7649.1 8351.3 8373.7 8393.1 8413.9 8468.1 5857.9 7267.9 7427.1 7508.2 7517.3 7110.5 7249.0 7277.9 7306.1 7310.7 6711.8 6778.3 6800.5 6816.6 6825.3 4691.9 4928.4 4987.3 5019.1 5083.2 4443.6 5021.7 5031.7 5130.1 5150.4 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:4566.23 Median:5188.38 stddev:1426.33 (27.5%) stddev-sans-first:1393.16 09:55:51 INFO - PROCESS | 1679 | Values: 255.7 311.1 317.3 318.2 319.8 4893.9 5425.8 5513.8 5527.9 5545.9 5372.8 5401.5 5410.9 5432.9 5446.0 3902.8 3996.8 4106.3 4116.0 4122.9 3833.4 3911.6 4055.4 4125.2 4127.5 3301.4 4053.8 4082.8 4085.5 4085.6 3265.8 3317.9 3911.4 4077.9 4079.9 2898.5 3468.8 3488.4 3492.9 3502.0 4927.3 5165.3 5183.4 5207.8 5215.4 4334.8 4638.4 4667.2 4691.7 4723.2 4996.3 5412.5 5667.7 5680.8 5688.9 3282.9 3452.6 3858.2 3870.6 3894.8 5566.0 5633.5 5868.0 5941.7 5965.3 3207.6 3492.6 3879.6 3880.9 3935.7 3524.3 3979.2 3981.9 3985.9 3993.6 3826.1 4474.2 4631.7 4659.4 4699.8 5507.2 5529.8 5783.7 5798.7 5872.4 1251.8 1328.7 1347.7 1349.7 1363.0 814.5 819.8 833.6 842.8 885.8 4679.3 5312.6 5333.5 5349.3 5359.5 5113.6 5144.5 5868.5 5891.9 5920.3 4324.3 4405.0 4958.7 5166.7 5193.4 2891.0 3048.0 3073.2 3076.6 3076.9 5399.3 5413.8 5609.7 5625.0 6033.0 4983.9 5284.5 5432.3 6037.2 6041.6 5150.9 5273.4 5718.5 5781.1 5977.0 4959.7 5571.7 5894.4 5895.7 5897.4 5157.5 5244.1 5574.6 5926.4 6010.2 5270.9 5941.6 6219.6 6256.4 6311.5 3695.6 3789.2 3893.5 3932.6 3942.2 4902.7 5877.5 5899.6 5914.8 5915.5 5692.8 5698.2 5752.7 5755.4 5787.0 4984.4 5269.8 5304.6 5579.7 5742.5 5214.1 5322.3 5326.3 5429.7 5622.9 4671.0 5628.2 5727.8 5779.2 5791.8 4984.7 5159.5 5630.6 5637.8 5666.6 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:18823.58 Median:4518.06 stddev:26991.69 (597.4%) stddev-sans-first:27033.26 09:55:51 INFO - PROCESS | 1679 | Values: 739.2 800.8 814.1 814.7 818.7 12343.3 13463.6 14026.0 14209.6 14788.9 11199.3 13625.3 13634.2 13640.1 13667.3 607.7 875.3 876.8 891.9 893.5 875.6 893.4 900.9 901.2 906.2 944.4 956.0 969.0 972.2 972.8 955.2 958.3 959.7 961.9 965.3 700.6 703.1 715.1 718.0 719.7 14152.3 14325.6 14351.6 14366.9 14474.3 13536.9 13599.2 13664.4 13750.9 13861.9 10324.9 11057.3 11292.6 11389.5 11740.6 3791.2 3797.1 3801.8 3881.8 3928.9 81711.0 82287.2 82538.0 82663.2 84527.6 10476.1 10777.4 10787.8 10825.6 11024.1 16226.4 19723.6 19778.0 20246.9 21207.6 6968.8 7970.8 7998.6 8066.4 8178.9 4407.6 4488.6 4492.9 4516.5 4519.6 3282.9 3400.2 3424.4 3458.6 3485.0 659.8 707.8 711.8 727.0 732.1 553.3 614.0 659.7 669.8 669.9 8826.4 9139.2 9283.5 9384.8 9385.2 620.0 621.6 635.8 660.9 718.2 4226.0 4307.5 4413.3 4421.0 4573.1 76886.6 101469.5 102207.5 102574.0 103138.0 85018.0 88133.6 88390.0 88672.6 89053.0 78612.0 79164.6 79419.0 79455.4 79623.4 8674.4 8713.9 8723.1 8756.9 8873.8 35026.0 37282.8 47988.5 48582.0 49742.8 60515.0 60622.7 61889.0 63025.1 66234.3 11100.3 11282.6 11651.7 11680.9 11790.9 12049.9 12139.3 12205.1 12523.8 12729.9 11041.9 11192.9 11749.9 12037.4 12164.8 9694.6 11542.5 11567.9 12212.9 12252.6 11311.0 11436.4 11576.8 11640.8 11672.1 10354.2 10527.6 10547.8 10549.1 10656.8 9005.6 9178.5 10000.4 10842.5 11014.2 09:55:51 INFO - PROCESS | 1679 | -------- Summary: end -------- 09:55:51 INFO - PROCESS | 1679 | 09:55:51 INFO - TEST-INFO | 1679: exit 0 09:55:51 INFO - TEST-OK | dromaeo_css | took 1113518ms 09:55:51 INFO - TEST-START | kraken 09:55:51 INFO - operating with platform_type : mac_ 09:55:51 INFO - Initialising browser for kraken test... 09:55:51 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpIDf1K9/profile http://localhost:49273/getInfo.html) 09:55:54 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 09:55:54 INFO - PROCESS | 1687 | colorDepth:24 09:55:54 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 09:55:54 INFO - PROCESS | 1687 | __metrics 09:55:54 ERROR - PROCESS | 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:55:55 INFO - TEST-INFO | 1687: exit 0 09:55:55 INFO - Browser initialized. 09:55:55 INFO - Running cycle 1/1 for kraken test... 09:55:55 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpIDf1K9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:07 INFO - PROCESS | 1689 | RSS: Main: 252477440 09:56:07 INFO - PROCESS | 1689 | 09:56:09 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:10 INFO - PROCESS | 1689 | RSS: Main: 265392128 09:56:10 INFO - PROCESS | 1689 | 09:56:13 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 09:56:14 INFO - PROCESS | 1689 | RSS: Main: 269373440 09:56:14 INFO - PROCESS | 1689 | 09:56:17 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 09:56:18 INFO - PROCESS | 1689 | RSS: Main: 269979648 09:56:18 INFO - PROCESS | 1689 | 09:56:20 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 09:56:20 INFO - PROCESS | 1689 | RSS: Main: 270815232 09:56:20 INFO - PROCESS | 1689 | 09:56:22 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:56:23 INFO - PROCESS | 1689 | RSS: Main: 271474688 09:56:23 INFO - PROCESS | 1689 | 09:56:26 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 09:56:26 INFO - PROCESS | 1689 | RSS: Main: 272117760 09:56:26 INFO - PROCESS | 1689 | 09:56:29 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:30 INFO - PROCESS | 1689 | RSS: Main: 272416768 09:56:30 INFO - PROCESS | 1689 | 09:56:33 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 09:56:34 INFO - PROCESS | 1689 | RSS: Main: 272764928 09:56:34 INFO - PROCESS | 1689 | 09:56:35 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:36 INFO - PROCESS | 1689 | RSS: Main: 271990784 09:56:36 INFO - PROCESS | 1689 | 09:56:38 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:38 INFO - PROCESS | 1689 | RSS: Main: 271994880 09:56:38 INFO - PROCESS | 1689 | 09:56:41 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:42 INFO - PROCESS | 1689 | RSS: Main: 272355328 09:56:42 INFO - PROCESS | 1689 | 09:56:44 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:45 INFO - PROCESS | 1689 | RSS: Main: 272412672 09:56:45 INFO - PROCESS | 1689 | 09:56:48 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:49 INFO - PROCESS | 1689 | RSS: Main: 272740352 09:56:49 INFO - PROCESS | 1689 | 09:56:50 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 09:56:51 INFO - PROCESS | 1689 | RSS: Main: 273461248 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | __start_tp_report 09:56:51 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 09:56:51 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 09:56:51 INFO - PROCESS | 1689 | |i|pagename|runs| 09:56:51 INFO - PROCESS | 1689 | |0;ai-astar;127;154;168;115;117;116;116;116;97;106 09:56:51 INFO - PROCESS | 1689 | |1;audio-beat-detection;155;120;145;165;128;141;136;121;169;121 09:56:51 INFO - PROCESS | 1689 | |2;audio-dft;198;201;198;210;227;188;196;197;197;196 09:56:51 INFO - PROCESS | 1689 | |3;audio-fft;72;80;75;139;68;81;82;85;146;58 09:56:51 INFO - PROCESS | 1689 | |4;audio-oscillator;71;72;124;71;71;77;115;72;74;116 09:56:51 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;89;86;89;87;91;86;89;99;135;132 09:56:51 INFO - PROCESS | 1689 | |6;imaging-darkroom;98;98;93;151;96;99;97;97;92;156 09:56:51 INFO - PROCESS | 1689 | |7;imaging-desaturate;146;143;87;148;146;104;105;92;95;90 09:56:51 INFO - PROCESS | 1689 | |8;json-parse-financial;56;58;58;56;59;58;56;59;64;72 09:56:51 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;68;73;70;70;74;75;65;69;68;70 09:56:51 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;88;107;109;109;76;108;111;110;151;84 09:56:51 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;149;146;140;142;143;144;133;141;153;152 09:56:51 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;157;199;228;230;165;166;226;165;151;215 09:56:51 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;66;78;64;64;60;86;82;86;64;75 09:56:51 INFO - PROCESS | 1689 | __end_tp_report 09:56:51 INFO - PROCESS | 1689 | __start_cc_report 09:56:51 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,1060 09:56:51 INFO - PROCESS | 1689 | __end_cc_report 09:56:51 INFO - PROCESS | 1689 | __startTimestamp1464627411220__endTimestamp 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | ------- Summary: start ------- 09:56:51 INFO - PROCESS | 1689 | Number of tests: 14 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:123.20 Median:122.00 stddev:21.64 (17.7%) stddev-sans-first:22.91 09:56:51 INFO - PROCESS | 1689 | Values: 127.0 154.0 168.0 115.0 117.0 116.0 116.0 116.0 97.0 106.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:143.00 stddev:18.25 (12.8%) stddev-sans-first:18.55 09:56:51 INFO - PROCESS | 1689 | Values: 155.0 120.0 145.0 165.0 128.0 141.0 136.0 121.0 169.0 121.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:200.80 Median:198.00 stddev:10.67 (5.4%) stddev-sans-first:11.27 09:56:51 INFO - PROCESS | 1689 | Values: 198.0 201.0 198.0 210.0 227.0 188.0 196.0 197.0 197.0 196.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:88.60 Median:77.50 stddev:29.52 (38.1%) stddev-sans-first:30.70 09:56:51 INFO - PROCESS | 1689 | Values: 72.0 80.0 75.0 139.0 68.0 81.0 82.0 85.0 146.0 58.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:71.50 stddev:22.30 (31.2%) stddev-sans-first:22.96 09:56:51 INFO - PROCESS | 1689 | Values: 71.0 72.0 124.0 71.0 71.0 77.0 115.0 72.0 74.0 116.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:89.00 stddev:18.93 (21.3%) stddev-sans-first:19.78 09:56:51 INFO - PROCESS | 1689 | Values: 89.0 86.0 89.0 87.0 91.0 86.0 89.0 99.0 135.0 132.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:97.00 stddev:24.27 (25.0%) stddev-sans-first:25.48 09:56:51 INFO - PROCESS | 1689 | Values: 98.0 98.0 93.0 151.0 96.0 99.0 97.0 97.0 92.0 156.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:115.60 Median:117.50 stddev:26.56 (22.6%) stddev-sans-first:25.80 09:56:51 INFO - PROCESS | 1689 | Values: 146.0 143.0 87.0 148.0 146.0 104.0 105.0 92.0 95.0 90.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:58.50 stddev:4.95 (8.5%) stddev-sans-first:5.07 09:56:51 INFO - PROCESS | 1689 | Values: 56.0 58.0 58.0 56.0 59.0 58.0 56.0 59.0 64.0 72.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:3.05 (4.4%) stddev-sans-first:3.13 09:56:51 INFO - PROCESS | 1689 | Values: 68.0 73.0 70.0 70.0 74.0 75.0 65.0 69.0 68.0 70.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:105.30 Median:131.00 stddev:20.53 (15.7%) stddev-sans-first:20.80 09:56:51 INFO - PROCESS | 1689 | Values: 88.0 107.0 109.0 109.0 76.0 108.0 111.0 110.0 151.0 84.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:145.00 stddev:6.00 (4.1%) stddev-sans-first:6.12 09:56:51 INFO - PROCESS | 1689 | Values: 149.0 146.0 140.0 142.0 143.0 144.0 133.0 141.0 153.0 152.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.20 Median:207.00 stddev:32.46 (15.7%) stddev-sans-first:32.13 09:56:51 INFO - PROCESS | 1689 | Values: 157.0 199.0 228.0 230.0 165.0 166.0 226.0 165.0 151.0 215.0 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:76.50 stddev:10.04 (13.1%) stddev-sans-first:10.37 09:56:51 INFO - PROCESS | 1689 | Values: 66.0 78.0 64.0 64.0 60.0 86.0 82.0 86.0 64.0 75.0 09:56:51 INFO - PROCESS | 1689 | -------- Summary: end -------- 09:56:51 INFO - PROCESS | 1689 | 09:56:51 INFO - TEST-INFO | 1689: exit 0 09:56:51 INFO - TEST-OK | kraken | took 60231ms 09:56:51 INFO - SUITE-END | took 1173s 09:56:52 INFO - Completed test suite (00:19:34) 09:56:52 INFO - javascript benchmark 09:56:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7191.57987036053, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3044.6346438427386, 3445.8966231013046, 3467.9306413871714, 3507.368673638744, 3509.3332266869293, 5720.685362305072, 5851.6196447230905, 5861.325947516037, 5875.559333050022, 5914.615549989258, 5784.2769653793275, 5892.469677729004, 5900.763969441217, 5953.642781433106, 6041.335453100167, 4286.807093680776, 5249.580033597303, 5301.734913254341, 5316.3354580677515, 5317.8404647860625, 5282.366116066078, 5408.945910540883, 5419.485148910847, 5479.0, 5493.945060549383, 4677.251639737643, 4689.460712018127, 4846.224604063368, 5176.301199338079, 5193.922091168635, 4336.891577710551, 5225.346831646044, 5225.686458812445, 5242.423333433319, 5261.473852614746, 5222.686638801646, 5289.127293996486, 5291.1534154535475, 5291.523762861322, 5294.232336311214, 4293.24868148076, 5592.944070559323, 5594.720263986825, 5664.6601203927485, 5675.290588676416, 6156.168917196166, 6173.197484327054, 6174.259088909314, 6183.907241391383, 6200.286966998763, 6213.974694175501, 6235.781747638811, 6240.344763799826, 6252.499800015988, 6281.403266689657, 5766.423357664242, 5885.058390657474, 5912.438318359749, 5930.0, 5979.4917432018765, 6297.939445961025, 6323.9051414228825, 6356.300806911236, 6374.012028135647, 6402.839929001812, 6114.419130182626, 6199.16311297969, 6214.627122372672, 6228.5017198624, 6242.906356404657, 6152.969235153885, 6155.0151975683675, 6169.81490555284, 6221.3156552779155, 6243.219597550306, 6068.120122582201, 6132.17215675878, 6134.00801433197, 6194.4115309045565, 6204.627722336674, 6171.47542458896, 6197.101420294122, 6198.969005154945, 6217.191765070603, 6232.875342493125, 4896.804127834846, 4969.9563091750415, 4980.5019498049905, 5013.724245166551, 5023.296738456619, 4448.933266001012, 4457.331400289918, 4457.398251236106, 4491.191585514639, 4496.4154659894, 5754.56840736938, 5897.5871688982215, 5937.643741375531, 5938.851528711817, 5944.762209511658, 6128.720082208443, 6145.569810113249, 6158.476529494954, 6159.168512250879, 6233.812985610439, 5953.493953014043, 5968.970155149196, 5986.0, 5990.311114221833, 5994.28068631767, 5378.542823860016, 5484.2596249506605, 5498.230247765316, 5500.064988951888, 5500.50495455403, 5986.16193732869, 6249.78125765596, 6365.4589359904, 6435.678216089083, 6527.249366322933, 6074.088886667036, 6234.2830574484515, 6256.249250090018, 6266.843328916813, 6271.4669253114, 5802.82591522255, 6202.81391558254, 6422.389872962061, 6504.15445992018, 6510.934890651033, 5095.898082038412, 6148.385161483816, 6172.722227499684, 6213.875722485615, 6239.4696450800375, 6191.690415479298, 6197.721102550487, 6207.410296021871, 6213.627182369072, 6241.625502469867, 5999.130126131774, 6042.697865106815, 6060.2424696912885, 6088.26940767093, 6170.598911070945, 6107.816765497042, 6135.570510064253, 6141.07883817431, 6147.708981114016, 6173.59871608344, 5938.970305148447, 6051.727672254847, 6062.848428789315, 6087.05650624154, 6098.0, 5642.887142257214, 6099.128199784669, 6132.509399248139, 6134.662593557218, 6167.599106058092, 6104.084387341934, 6125.9698039450395, 6130.826205142237, 6139.938600613937, 6150.538709596709], "value": 5717.8735399759025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.9311592934953, 516.460298987558, 528.2841749429523, 553.689933637163, 569.641126090563, 35310.2937941241, 41441.58558414415, 41536.16927661453, 41537.0, 41552.96117597058, 36098.0, 38718.80640596793, 41083.58916410835, 41671.0, 41748.791256043754, 9423.952880235589, 9635.084666956627, 9646.951765241163, 9650.324477286593, 9669.70990870275, 9368.016358282384, 9428.434293942351, 9453.101955314234, 9454.196393306578, 9465.242780577537, 8093.231143041431, 9478.478683672396, 9501.144896959273, 9516.048395160498, 9559.617615295414, 9399.24806015517, 9431.905680943171, 9446.433214007147, 9460.385074970105, 9512.28657850664, 9420.764480887965, 9532.18976387008, 9538.809223815484, 9552.713418597385, 9601.663941762075, 37964.62035379638, 38066.0, 38293.42559861604, 38318.61681383178, 38448.423273650915, 3371.1723458362994, 3472.4444088945647, 3588.74878758487, 4063.7968101595097, 4107.240160570274, 31501.52747708786, 32251.19372015695, 32437.513437298225, 32471.35057298841, 32849.17877053069, 3236.5792446981977, 3317.0, 3346.2136397946465, 3437.432823584106, 3444.844981975817, 503882.0, 504831.0, 505635.0, 507466.0, 508655.91344086453, 31602.841985790383, 32640.0, 63160.0, 63592.68203658952, 63936.36063639397, 36686.0, 36794.816025920234, 36811.63188368136, 36946.8152659235, 37056.073598159724, 15057.096574205363, 15083.396664133312, 15232.314545845464, 15232.466863659718, 15252.542423727084, 12679.492820287269, 12697.238165710087, 12746.617601471971, 12838.29389383593, 12854.421551030226, 7768.10666773317, 8022.99712535933, 8034.116247212802, 8072.950516432944, 8100.675972961133, 3306.7354611631013, 3332.083676988799, 3334.049795808183, 3336.299377130781, 3351.2292172799903, 1033.4677641014882, 1063.3301020357126, 1063.6011495689118, 1130.6438471881331, 1176.4647085576041, 30530.38939221203, 30884.0, 31318.530222046687, 31798.0, 31849.885254016463, 1107.1640911112058, 1114.7380365614074, 1128.6444769897455, 1140.1733743036232, 1194.892459678633, 16017.279222435018, 16118.597035074217, 16153.757693634605, 16295.940763850549, 16398.508044758677, 698853.0, 710105.0, 713804.0, 714386.0, 715139.4243028752, 59984.10023849646, 60510.69744651249, 60826.0, 60936.69531652402, 61081.38918610757, 1431.1484666623342, 1432.7349440353569, 1486.2271618758184, 1490.180400779567, 1495.9326830292664, 30396.240093997825, 30486.542701859933, 30631.0, 30880.53679194769, 31150.68849311478, 52950.94098118093, 53881.0, 54737.726311369785, 54778.0, 54797.0, 572373.0, 655467.0, 655503.0, 656109.0, 658487.3680684285, 27413.86293068522, 27425.040123596376, 27550.5867411993, 27765.44469110647, 27807.887684492394, 48635.0, 49246.0, 49648.75175624243, 50279.74860125676, 50360.24459633182, 39907.00232494211, 39926.2014759709, 40731.0, 40970.0, 41946.37080443735, 39564.80217598894, 39627.2074558513, 40020.999475013356, 40375.0, 40464.59535404608, 38759.6124038756, 38966.6103338963, 39669.80165099156, 39812.601873980886, 41834.95412614587, 33561.0, 34077.569915910775, 35147.648523514436, 36351.0, 36439.45340819943, 26070.60894086628, 26096.739032609432, 26152.476950460503, 26237.73762262353, 26557.937682492484], "value": 19241.366944996054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.9525352260096, 382.6384067056631, 385.7087898636529, 402.9536603290619, 406.4269380173955, 16766.329346826144, 17191.742123868153, 18473.667424151823, 20784.856832874204, 20856.791432085654, 19838.702419463683, 20012.599748005032, 20017.89901555414, 20272.189112435484, 20846.89576552119, 5762.279715035621, 5785.595008349417, 6006.8498287542725, 6065.181200537915, 6074.392560743934, 5873.647581145124, 5894.823155305347, 5956.047032474805, 5969.940300596982, 5970.313413957385, 4748.643851711118, 4895.36360273164, 5650.237217975562, 5876.0, 5884.323302820188, 5387.380451248117, 5863.413658634145, 5908.763649454017, 5946.583739138262, 5953.613015154023, 5704.942950570483, 5715.542756579505, 5814.418558144194, 5818.330891947396, 5827.941720582782, 12529.624111276677, 15647.765283520755, 19618.11718472672, 24859.0, 25336.859841307, 2058.886761228132, 2165.740111186652, 2207.404000919759, 2234.966475502869, 2314.5139520700673, 9949.0, 10141.543630536644, 10202.030807073315, 10362.792744145076, 10407.427591482465, 1857.934972275964, 1875.6998880179106, 1982.4449154236836, 2056.228914157191, 2128.6806978953127, 118066.40966795111, 126433.83915402097, 127161.0, 128664.0, 129615.0, 9388.263171313329, 11541.596044138414, 11710.0, 11721.589744358907, 11793.646190614296, 14505.709885802225, 14618.48835290781, 14631.853681463263, 14643.633909152357, 14681.706365872837, 8510.0, 8587.098354672795, 8596.613152408157, 8638.0, 8673.783155421039, 6990.860182796418, 8468.280196183394, 8491.19333663301, 8493.405461617627, 8590.613422396007, 4477.977610111994, 4600.42494688164, 4609.055143695535, 4621.145088158634, 4626.560476754703, 1561.7110834495654, 1926.1139875657354, 1938.1375287996989, 1956.8923709195847, 1962.4308950404509, 936.3632729743839, 978.4471773447979, 1042.9061384475433, 1069.3637285814928, 1080.7892460970193, 14891.553253402415, 16776.496705098867, 19349.742266752615, 19768.604627907647, 20420.591588168452, 961.7595601099725, 965.4834663455018, 992.1764935103846, 1008.8537162111453, 1014.1379827146866, 10115.544800483996, 10430.68707938763, 10613.575456981634, 11299.322040677585, 11424.086073114297, 599610.0, 607669.0, 609844.0, 621297.0, 623453.0, 80338.0, 124520.37739811424, 135565.0, 146123.2693836524, 147102.0, 1024.4416792847917, 1042.4943902207424, 1072.8873468285717, 1074.790415868898, 1081.848541204232, 16000.679986399973, 16872.156392180095, 18554.44336669902, 18802.52993675169, 18931.33740319082, 56254.0, 56386.59033524195, 56468.7176564131, 56934.0, 57290.5678402953, 59643.0, 64301.0, 83618.0, 83731.0, 85644.14355856362, 6970.616616086164, 8201.097879233399, 8297.377696672653, 8308.70919517814, 8506.447080939719, 9197.080291971017, 11012.0, 12176.57381991626, 13062.020348473712, 13198.670033248862, 9130.908690913006, 10452.68641940743, 11035.282706624044, 11380.601678941197, 11466.598669046543, 11257.0, 11327.943360283145, 11332.206745528063, 11364.31814091124, 11404.315741055563, 9811.969743176864, 11366.488508017324, 11476.770464590494, 11586.594469193875, 11684.12369072306, 7847.293743563107, 8299.792505187177, 8391.95804020976, 8416.87374689368, 8489.872651910102, 11212.04697600713, 11444.94277528607, 11585.0, 11602.07183425341, 11689.298642081503], "value": 9494.652731102422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.642073061004, 1537.715522628314, 1762.2774662388424, 1928.4985903665042, 1940.4275738657095, 7859.960700196505, 8030.558319292437, 8419.28436082933, 8938.508382038994, 8938.687145949893, 7609.885851712229, 8543.530105844176, 8696.434731742433, 8740.694075707352, 8763.386562940597, 2355.2816391000697, 2368.5499755046485, 2373.6320870265135, 2375.3467796355967, 2390.7011623547055, 2362.787349138577, 2377.524495100978, 2402.9639555406684, 2405.9518809623796, 2416.3838221253554, 2368.1829768729845, 2383.2373640435067, 2385.7017872765905, 2402.5555272274596, 2414.311921102486, 2349.6123139682018, 2361.669366288721, 2362.11420717231, 2363.3618922890896, 2378.357843382277, 2326.127702111708, 2338.953220935589, 2354.917577884783, 2356.2577787996725, 2361.409647588103, 8703.869441958375, 8704.56477176145, 8708.912910870873, 8731.956340218321, 8800.47197168172, 5261.842144735664, 5394.757235924393, 5416.458354164592, 5420.6747595144025, 5438.129899216106, 3555.928881422357, 3607.2424790793966, 3670.6512881276235, 3670.834812433447, 3681.5029970953847, 1069.8823129455754, 1083.7615724540667, 1095.446799366323, 1097.961571345007, 1100.1803656276045, 11537.942310288396, 11695.590654327143, 11709.946104850604, 11711.945924866717, 11723.589674361356, 4227.450431443954, 4604.309353596987, 4620.8151673933335, 4651.2557990722, 4815.012922350909, 9816.263780216512, 9819.9018009819, 9820.901790982141, 9822.607095716092, 9823.557939892722, 4402.669799765031, 5265.4997775211295, 5292.285541451854, 5328.333958255218, 5332.146856502941, 4083.0, 4122.237386083584, 4355.324924636687, 4841.2496063110275, 4858.878528036827, 3891.3384724596885, 3913.25648126855, 3981.761094334291, 4007.499062617173, 4062.898427539335, 1290.535407253388, 1301.7006088599676, 1308.874368043501, 1315.6645055510783, 1319.5843309357522, 858.5878778186506, 969.772103555678, 980.5440470181258, 981.816910622698, 1026.5996261458038, 4729.787159577759, 6030.0, 6070.150178974947, 6094.542909281733, 6097.207363042776, 411.7467757329221, 445.72365133616717, 455.45345585297775, 459.7953362191014, 987.3088837813559, 3536.7877927324444, 4041.4544036555276, 4049.392591111357, 4093.099518106012, 4113.095119073799, 8293.709720159766, 10590.682279531626, 10695.35827850316, 10766.192535559865, 10794.892051079389, 10635.0960168385, 10651.467426628638, 10682.51928663212, 10706.518206680563, 10746.677599672023, 6769.763058292936, 7846.607669616496, 8188.14024527428, 8214.301784348278, 8255.917440825635, 6035.155078289131, 6053.424924632153, 6090.695465226632, 6114.541409394402, 6146.0, 9752.707418777449, 9991.800163996824, 10004.749881253027, 10023.148032417035, 10026.749331266778, 9884.950575247078, 10087.243456740627, 10268.486575671037, 10279.794404112026, 10292.022257885488, 6972.0, 7359.264073592812, 7510.8497830042, 7616.9238307616215, 7649.120351159688, 8351.290140337896, 8373.665053397795, 8393.118722534291, 8413.915860841313, 8468.110848360833, 5857.853553661193, 7267.927320726725, 7427.071616047994, 7508.249175082448, 7517.285857843496, 7110.4667149965, 7248.96375518119, 7277.890831637424, 7306.086739157606, 7310.678934199886, 6711.832204194934, 6778.288279730755, 6800.52396332252, 6816.591004539743, 6825.2833452486775, 4691.94431252979, 4928.408590969107, 4987.326710894128, 5019.071471777733, 5083.186690129562, 4443.555644435531, 5021.72380519075, 5031.74841257943, 5130.102232109441, 5150.356205474316], "value": 4515.3859078952755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.66890876315173, 311.1071225582577, 317.2845233997336, 318.1981406854726, 319.79373304218797, 4893.853184404469, 5425.810096646618, 5513.842093160431, 5527.861803454905, 5545.944540554593, 5372.811951581695, 5401.4868587484225, 5410.862709229852, 5432.945670543293, 5446.0, 3902.7853468059175, 3996.820143093568, 4106.32245679464, 4116.0, 4122.876313710593, 3833.3741387149753, 3911.6088391160943, 4055.371417430288, 4125.23683118624, 4127.484064491939, 3301.3589128696944, 4053.8243909266275, 4082.795575305277, 4085.5097388313443, 4085.6313135099776, 3265.7877237979574, 3317.8672853085845, 3911.432842237874, 4077.8980525486804, 4079.8776036718946, 2898.4927637663322, 3468.8439020243895, 3488.372093023255, 3492.89521314361, 3502.0, 4927.334809800667, 5165.302684137631, 5183.352080989876, 5207.817726379559, 5215.400228973679, 4334.826606935719, 4638.397008388888, 4667.183242932473, 4691.695039822401, 4723.173444647173, 4996.300517927493, 5412.4858138477175, 5667.744951477193, 5680.7727690892725, 5688.947544704243, 3282.868685252587, 3452.602950660681, 3858.151206734514, 3870.5678898807623, 3894.805259737002, 5565.998120338338, 5633.464820842013, 5867.970660146715, 5941.732622032019, 5965.28416590012, 3207.566978457925, 3492.6158122606494, 3879.573246942834, 3880.8641697541016, 3935.685145188378, 3524.277523107808, 3979.224051309967, 3981.8606348777653, 3985.860494882665, 3993.6206060424215, 3826.1443200047956, 4474.172278128557, 4631.698939568917, 4659.394278743742, 4699.812007519729, 5507.218854478463, 5529.778808847682, 5783.681897495594, 5798.652080875161, 5872.442117998783, 1251.7997120460682, 1328.714326419805, 1347.6819869823887, 1349.6693310139078, 1362.9591112266648, 814.4583851738528, 819.848113400673, 833.5623797506237, 842.8074274900946, 885.7918389178537, 4679.298105284234, 5312.601554883399, 5333.5199832015305, 5349.277847490539, 5359.464053594609, 5113.642045056885, 5144.459831717691, 5868.530517558585, 5891.941080589225, 5920.259967504062, 4324.303285069312, 4404.96057720172, 4958.7024778513405, 5166.715830629351, 5193.4027586828, 2891.0, 3047.9695203048127, 3073.200967748357, 3076.5846610707717, 3076.876924922978, 5399.325084364455, 5413.783448662089, 5609.691466969356, 5624.971875140598, 6032.969835150796, 4983.9252411213865, 5284.524392804666, 5432.348118225838, 6037.215162028996, 6041.622955569546, 5150.8969820604125, 5273.417974607679, 5718.456746609066, 5781.126645147761, 5976.983912734846, 4959.668955590867, 5571.66570005801, 5894.4064611570775, 5895.67573783446, 5897.439743224387, 5157.510036546522, 5244.082285599929, 5574.554035677055, 5926.407359264212, 6010.213565453736, 5270.945810837771, 5941.6127662763565, 6219.626822390671, 6256.436920676979, 6311.495080393649, 3695.6304369562827, 3789.242151569642, 3893.5133108361456, 3932.6067393260446, 3942.2312649033165, 4902.681325713817, 5877.471027607365, 5899.646021238739, 5914.822555323347, 5915.467607915309, 5692.829215123553, 5698.202251684685, 5752.654840709571, 5755.395683453345, 5786.971065144648, 4984.40187177541, 5269.78920843162, 5304.602154838325, 5579.6652200868075, 5742.454466825645, 5214.113600687816, 5322.28149199853, 5326.334208223972, 5429.728513574384, 5622.887542249214, 4670.9766451167525, 5628.240187574625, 5727.799527016535, 5779.2486976694445, 5791.7683292667825, 4984.675996060245, 5159.535641792257, 5630.60585758993, 5637.830865074055, 5666.603337766317], "value": 4106.660302137115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.157360608906, 800.76777734457, 814.1288820961573, 814.706705585989, 818.664347617477, 12343.321117338543, 13463.59609211724, 14026.0, 14209.579042095786, 14788.926055369735, 11199.328040317587, 13625.318734063281, 13634.181949083062, 13640.113392629471, 13667.3166341683, 607.6661727508122, 875.2735229759317, 876.7983363826323, 891.928645708345, 893.5264309915755, 875.5665945357025, 893.4326702543899, 900.9279257659372, 901.1619194149439, 906.229704750963, 944.3719926249037, 955.9617615295415, 968.9854652180223, 972.2270794718181, 972.810301991112, 955.2310390135938, 958.2765012415582, 959.7024922274118, 961.9326647134739, 965.2663975378728, 700.5866538742116, 703.0614130136274, 715.0704084689883, 717.9928200717978, 719.6977269546803, 14152.29238538069, 14325.641858953506, 14351.569452916428, 14366.928165359212, 14474.348654310581, 13536.93231533846, 13599.184048957095, 13664.385102670403, 13750.931245343809, 13861.861381386158, 10324.896751032544, 11057.281276716987, 11292.604758833484, 11389.544418223344, 11740.647780566596, 3791.1848952475075, 3797.050737315671, 3801.7909015004166, 3881.844726210948, 3928.8821335359985, 81711.0, 82287.17712822855, 82538.0, 82663.17336826675, 84527.57736211341, 10476.114855140802, 10777.407242601575, 10787.83818242727, 10825.56697732082, 11024.118070554336, 16226.350945962266, 19723.605527889362, 19778.0, 20246.886421246974, 21207.57584848325, 6968.825779355455, 7970.840583188304, 7998.640061197144, 8066.435349525477, 8178.877316840252, 4407.581279778416, 4488.573585509372, 4492.887677808081, 4516.480604730433, 4519.638428925678, 3282.8686852526107, 3400.2179498715436, 3424.400729872262, 3458.602260739997, 3485.0, 659.7822718502882, 707.773512476013, 711.8327193109615, 726.989095163573, 732.0848938826467, 553.2696840171017, 614.031612724319, 659.6932426421737, 669.819148829823, 669.9330066993261, 8826.42628229163, 9139.223166030963, 9283.48940808262, 9384.82689663792, 9385.249180065579, 619.9535034872403, 621.6332363905318, 635.8491131052809, 660.9405153536205, 718.2422544215798, 4225.9788701056295, 4307.547707490731, 4413.3159360299205, 4420.955790442119, 4573.108243892476, 76886.61556692181, 101469.47795783069, 102207.48896255619, 102574.0, 103138.0, 85018.0, 88133.59332033501, 88390.0, 88672.5566372177, 89053.0, 78612.0, 79164.60417697874, 79419.0, 79455.41089178184, 79623.40753184789, 8674.392792504717, 8713.91286087131, 8723.127687231226, 8756.912430875609, 8873.822523549621, 35026.0, 37282.813585932985, 47988.5201147998, 48582.0, 49742.751286243336, 60515.0, 60622.69688651529, 61889.0, 63025.05462417976, 66234.34414139685, 11100.333979961228, 11282.605108821152, 11651.650450486499, 11680.883191167979, 11790.882091178979, 12049.939750301193, 12139.271643701406, 12205.145639805129, 12523.812142817682, 12729.872701272869, 11041.889581104086, 11192.944035279772, 11749.882501175221, 12037.398130093285, 12164.756704865677, 9694.6122155113, 11542.538298467967, 11567.942160289145, 12212.938935305267, 12252.632421027383, 11311.0, 11436.370999595103, 11576.826347604625, 11640.76718465609, 11672.066234701033, 10354.223433242387, 10527.631532896312, 10547.841782373118, 10549.093592009895, 10656.84014739795, 9005.594748236475, 9178.54107294646, 10000.449975251431, 10842.457877105955, 11014.1739369546], "value": 7141.14702228511, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 154.0, 168.0, 115.0, 117.0, 116.0, 116.0, 116.0, 97.0, 106.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 145.0, 165.0, 128.0, 141.0, 136.0, 121.0, 169.0, 121.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 201.0, 198.0, 210.0, 227.0, 188.0, 196.0, 197.0, 197.0, 196.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 75.0, 139.0, 68.0, 81.0, 82.0, 85.0, 146.0, 58.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 124.0, 71.0, 71.0, 77.0, 115.0, 72.0, 74.0, 116.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 91.0, 86.0, 89.0, 99.0, 135.0, 132.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 93.0, 151.0, 96.0, 99.0, 97.0, 97.0, 92.0, 156.0], "value": 107.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 87.0, 148.0, 146.0, 104.0, 105.0, 92.0, 95.0, 90.0], "value": 115.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 56.0, 59.0, 58.0, 56.0, 59.0, 64.0, 72.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 70.0, 70.0, 74.0, 75.0, 65.0, 69.0, 68.0, 70.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 107.0, 109.0, 109.0, 76.0, 108.0, 111.0, 110.0, 151.0, 84.0], "value": 105.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 140.0, 142.0, 143.0, 144.0, 133.0, 141.0, 153.0, 152.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 199.0, 228.0, 230.0, 165.0, 166.0, 226.0, 165.0, 151.0, 215.0], "value": 190.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 64.0, 64.0, 60.0, 86.0, 82.0, 86.0, 64.0, 75.0], "value": 72.5, "unit": "score"}]}]} 09:56:52 INFO - Return code: 0 09:56:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:56:52 ERROR - # TBPL SUCCESS # 09:56:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:52 INFO - 2016-05-30 09:56:52.570 screenresolution[1694:10267] starting screenresolution argv=screenresolution get 09:56:52 INFO - 2016-05-30 09:56:52.573 screenresolution[1694:10267] Display 0: 1600x1200x32@60 09:56:52 INFO - 2016-05-30 09:56:52.579 screenresolution[1695:10270] starting screenresolution argv=screenresolution list 09:56:52 INFO - Available Modes on Display 0 09:56:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:52 INFO - Intel Iris: 09:56:52 INFO - Chipset Model: Intel Iris 09:56:52 INFO - Type: GPU 09:56:52 INFO - Bus: Built-In 09:56:52 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:52 INFO - Vendor: Intel (0x8086) 09:56:52 INFO - Device ID: 0x0a2e 09:56:52 INFO - Revision ID: 0x0009 09:56:52 INFO - Displays: 09:56:52 INFO - Display: 09:56:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:52 INFO - Display Serial Number: 1600x1200 60 09:56:52 INFO - Main Display: Yes 09:56:52 INFO - Mirror: Off 09:56:52 INFO - Online: Yes 09:56:52 INFO - Rotation: Supported 09:56:52 INFO - Return code: 0 09:56:52 INFO - Running post-action listener: _resource_record_post_action 09:56:52 INFO - ##### 09:56:52 INFO - ##### Finished run-tests step (success) 09:56:52 INFO - ##### 09:56:52 INFO - Running post-run listener: _resource_record_post_run 09:56:52 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 36800000; Write bytes: 700024832; Read time: 247; Write time: 1959 09:56:52 INFO - TinderboxPrint: CPU usage
54.5% 09:56:52 INFO - TinderboxPrint: I/O read bytes / time
36,800,000 / 247 09:56:52 INFO - TinderboxPrint: I/O write bytes / time
700,024,832 / 1,959 09:56:52 INFO - TinderboxPrint: CPU idle
2,200.6 (45.4%) 09:56:52 INFO - TinderboxPrint: CPU system
978.5 (20.2%) 09:56:52 INFO - TinderboxPrint: CPU user
1,662.6 (34.3%) 09:56:52 INFO - TinderboxPrint: Swap in / out
435,277,824 / 0 09:56:52 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395121152; Write bytes: 389756928; Read time: 29616; Write time: 813 09:56:52 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 34964992; Write bytes: 296914944; Read time: 229; Write time: 1110 09:56:53 INFO - Running post-run listener: _upload_blobber_files 09:56:53 INFO - Blob upload gear active. 09:56:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:53 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 09:56:53 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:56:53 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:56:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:54 INFO - (blobuploader) - INFO - Done attempting. 09:56:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:56:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:56 INFO - (blobuploader) - INFO - Done attempting. 09:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:58 INFO - (blobuploader) - INFO - Done attempting. 09:56:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:58 INFO - Return code: 0 09:56:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301958bae437907a05a65330e020f233b2c1c624ea405138a1c97d21dcbf6dd47301badd138b30b35e6f6028bcb7b1b631b49d876f7255bcb140d96dc5d9cf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca069e7fc086d4db1a2412029a6b12a98435dc2b262b15c841cb9260f39848a3ef14b64cf3790e808dd886d3c0a1c454b73bc720c3e669dd7a9c1d9a0866e4c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbeab1eae002895ae92a3a6a110748ef521d04774f7c887e29804afa334b243e852a075b4c4280b4437c6b93e61233d730b7b6e30b1983dd136098ea3314816e"} 09:56:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:58 INFO - Contents: 09:56:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301958bae437907a05a65330e020f233b2c1c624ea405138a1c97d21dcbf6dd47301badd138b30b35e6f6028bcb7b1b631b49d876f7255bcb140d96dc5d9cf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca069e7fc086d4db1a2412029a6b12a98435dc2b262b15c841cb9260f39848a3ef14b64cf3790e808dd886d3c0a1c454b73bc720c3e669dd7a9c1d9a0866e4c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbeab1eae002895ae92a3a6a110748ef521d04774f7c887e29804afa334b243e852a075b4c4280b4437c6b93e61233d730b7b6e30b1983dd136098ea3314816e"} 09:56:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:58 INFO - Copying logs to upload dir... 09:56:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.597351 ========= master_lag: 1.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-30 09:56:59.810201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 09:56:59.814261) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3TLMtuJZlk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301958bae437907a05a65330e020f233b2c1c624ea405138a1c97d21dcbf6dd47301badd138b30b35e6f6028bcb7b1b631b49d876f7255bcb140d96dc5d9cf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca069e7fc086d4db1a2412029a6b12a98435dc2b262b15c841cb9260f39848a3ef14b64cf3790e808dd886d3c0a1c454b73bc720c3e669dd7a9c1d9a0866e4c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbeab1eae002895ae92a3a6a110748ef521d04774f7c887e29804afa334b243e852a075b4c4280b4437c6b93e61233d730b7b6e30b1983dd136098ea3314816e"} build_url:https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/IFYYvlB0SfSawQby68z1uw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301958bae437907a05a65330e020f233b2c1c624ea405138a1c97d21dcbf6dd47301badd138b30b35e6f6028bcb7b1b631b49d876f7255bcb140d96dc5d9cf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca069e7fc086d4db1a2412029a6b12a98435dc2b262b15c841cb9260f39848a3ef14b64cf3790e808dd886d3c0a1c454b73bc720c3e669dd7a9c1d9a0866e4c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbeab1eae002895ae92a3a6a110748ef521d04774f7c887e29804afa334b243e852a075b4c4280b4437c6b93e61233d730b7b6e30b1983dd136098ea3314816e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 09:56:59.849806) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:56:59.850199) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3TLMtuJZlk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.f2E9jGmPUT/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005095 ========= master_lag: 0.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 09:57:00.244740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 09:57:00.245046) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 09:57:00.245483) ========= ========= Total master_lag: 1.92 =========